2026-08-07T02:05:52.1660711Z Current runner version: '2.336.0'2026-08-07T02:05:52.1698021Z ##[group]Runner Image Provisioner2026-08-07T02:05:52.1699646Z Hosted Compute Agent2026-08-07T02:05:52.1700796Z Version: 20260707.5632026-08-07T02:05:52.1701990Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-08-07T02:05:52.1703385Z Build Date: 2026-07-07T19:33:50Z2026-08-07T02:05:52.1704686Z Worker ID: {e3625cfb-2971-45bd-bfdb-411bdb43596e}2026-08-07T02:05:52.1706338Z Azure Region: eastus2026-08-07T02:05:52.1707383Z ##[endgroup]2026-08-07T02:05:52.1710104Z ##[group]Operating System2026-08-07T02:05:52.1711336Z Ubuntu2026-08-07T02:05:52.1712237Z 22.04.52026-08-07T02:05:52.1713239Z LTS2026-08-07T02:05:52.1714307Z ##[endgroup]2026-08-07T02:05:52.1715254Z ##[group]Runner Image2026-08-07T02:05:52.1716674Z Image: ubuntu-22.042026-08-07T02:05:52.1717681Z Version: 20260720.234.22026-08-07T02:05:52.1720002Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-08-07T02:05:52.1722904Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-08-07T02:05:52.1724697Z ##[endgroup]2026-08-07T02:05:52.1727741Z ##[group]GITHUB_TOKEN Permissions2026-08-07T02:05:52.1730957Z Contents: read2026-08-07T02:05:52.1732012Z Metadata: read2026-08-07T02:05:52.1733305Z Packages: read2026-08-07T02:05:52.1734261Z ##[endgroup]2026-08-07T02:05:52.1737900Z Secret source: Actions2026-08-07T02:05:52.1740113Z Prepare workflow directory2026-08-07T02:05:52.2239614Z Prepare all required actions2026-08-07T02:05:52.2312337Z Getting action download info2026-08-07T02:05:52.4247947Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-07T02:05:52.6243998Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-07T02:05:52.7426731Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-07T02:05:52.9084838Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-07T02:05:53.2367693Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-07T02:05:53.2373904Z ##[group] Inputs2026-08-07T02:05:53.2374847Z testName: TestOSPoolEP2026-08-07T02:05:53.2376844Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-07T02:05:53.2378777Z setupScript: 2026-08-07T02:05:53.2379571Z setupEnv: {}2026-08-07T02:05:53.2380349Z ##[endgroup]2026-08-07T02:05:53.2381682Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-testing) / Run Tests2026-08-07T02:05:53.3305531Z ##[group]Run actions/checkout@v52026-08-07T02:05:53.3307381Z with:2026-08-07T02:05:53.3308294Z repository: mwestphall/k8s-integration-tests2026-08-07T02:05:53.3317190Z token: ***2026-08-07T02:05:53.3317989Z ssh-strict: true2026-08-07T02:05:53.3318827Z ssh-user: git2026-08-07T02:05:53.3319667Z persist-credentials: true2026-08-07T02:05:53.3320599Z clean: true2026-08-07T02:05:53.3321422Z sparse-checkout-cone-mode: true2026-08-07T02:05:53.3322414Z fetch-depth: 12026-08-07T02:05:53.3323209Z fetch-tags: false2026-08-07T02:05:53.3324027Z show-progress: true2026-08-07T02:05:53.3324860Z lfs: false2026-08-07T02:05:53.3325627Z submodules: false2026-08-07T02:05:53.3326604Z set-safe-directory: true2026-08-07T02:05:53.3327561Z allow-unsafe-pr-checkout: false2026-08-07T02:05:53.3328853Z ##[endgroup]2026-08-07T02:05:53.4382256Z Syncing repository: mwestphall/k8s-integration-tests2026-08-07T02:05:53.4386501Z ##[group]Getting Git version info2026-08-07T02:05:53.4389006Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-07T02:05:53.4391651Z [command]/usr/bin/git version2026-08-07T02:05:53.4490032Z git version 2.54.02026-08-07T02:05:53.4521424Z ##[endgroup]2026-08-07T02:05:53.4538160Z Temporarily overriding HOME='/home/runner/work/_temp/5ade42ff-3463-4dba-a85c-7aac44566329' before making global git config changes2026-08-07T02:05:53.4544929Z Adding repository directory to the temporary git global config as a safe directory2026-08-07T02:05:53.4549560Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-07T02:05:53.4587131Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-07T02:05:53.4591839Z ##[group]Initializing the repository2026-08-07T02:05:53.4597887Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-07T02:05:53.4710667Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-07T02:05:53.4714130Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-07T02:05:53.4717761Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-07T02:05:53.4720568Z hint: call:2026-08-07T02:05:53.4722034Z hint:2026-08-07T02:05:53.4723848Z hint: git config --global init.defaultBranch <name>2026-08-07T02:05:53.4726434Z hint:2026-08-07T02:05:53.4728645Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-07T02:05:53.4730782Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-07T02:05:53.4732869Z hint:2026-08-07T02:05:53.4734527Z hint: git branch -m <name>2026-08-07T02:05:53.4736418Z hint:2026-08-07T02:05:53.4738703Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-07T02:05:53.4742943Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-07T02:05:53.4750145Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-07T02:05:53.4766858Z ##[endgroup]2026-08-07T02:05:53.4769333Z ##[group]Disabling automatic garbage collection2026-08-07T02:05:53.4771193Z [command]/usr/bin/git config --local gc.auto 02026-08-07T02:05:53.4808105Z ##[endgroup]2026-08-07T02:05:53.4810352Z ##[group]Setting up auth2026-08-07T02:05:53.4815715Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-07T02:05:53.4857450Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :"2026-08-07T02:05:53.5252682Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-07T02:05:53.5296993Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :"2026-08-07T02:05:53.5542750Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-07T02:05:53.5582957Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-07T02:05:53.5830032Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-07T02:05:53.5868913Z ##[endgroup]2026-08-07T02:05:53.5878407Z ##[group]Fetching the repository2026-08-07T02:05:53.5881097Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-07T02:05:53.7851033Z From https://github.com/mwestphall/k8s-integration-tests2026-08-07T02:05:53.7852970Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-07T02:05:53.7878640Z ##[endgroup]2026-08-07T02:05:53.7880500Z ##[group]Determining the checkout info2026-08-07T02:05:53.7882148Z ##[endgroup]2026-08-07T02:05:53.7885848Z [command]/usr/bin/git sparse-checkout disable2026-08-07T02:05:53.7932899Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-07T02:05:53.7965071Z ##[group]Checking out the ref2026-08-07T02:05:53.7968986Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-07T02:05:53.8062652Z Switched to a new branch 'main'2026-08-07T02:05:53.8065782Z branch 'main' set up to track 'origin/main'.2026-08-07T02:05:53.8072574Z ##[endgroup]2026-08-07T02:05:53.8111367Z [command]/usr/bin/git log -1 --format=%H2026-08-07T02:05:53.8139114Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-07T02:05:53.8400108Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-07T02:05:53.8402901Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-07T02:05:53.8405004Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-07T02:05:53.8534958Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-07T02:05:53.8536458Z env:2026-08-07T02:05:53.8537988Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-07T02:05:53.8539784Z SETUP_ENV_YAML: {}2026-08-07T02:05:53.8540570Z ##[endgroup]2026-08-07T02:05:54.4811992Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-07T02:05:54.4812928Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-07T02:05:54.4872783Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-07T02:05:54.4873363Z env:2026-08-07T02:05:54.4874035Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-07T02:05:54.4874770Z ##[endgroup]2026-08-07T02:05:54.5021754Z ##[group]Run true2026-08-07T02:05:54.5022161Z [36;1mtrue[0m2026-08-07T02:05:54.5080254Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-07T02:05:54.5080775Z ##[endgroup]2026-08-07T02:05:54.5254985Z ##[group]Run medyagh/setup-minikube@latest2026-08-07T02:05:54.5255529Z with:2026-08-07T02:05:54.5255829Z start: true2026-08-07T02:05:54.5256413Z cache: true2026-08-07T02:05:54.5256755Z minikube-version: latest2026-08-07T02:05:54.5257099Z wait: all2026-08-07T02:05:54.5257393Z ##[endgroup]2026-08-07T02:05:54.6517503Z (node:2052) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-07T02:05:54.6518540Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-07T02:05:55.4131123Z [command]/usr/bin/chmod +x /home/runner/work/_temp/3fa9296e-bcff-4ae2-9026-23959ac4149b2026-08-07T02:05:55.5720988Z [command]/home/runner/bin/minikube version --short2026-08-07T02:05:55.6142765Z v1.38.12026-08-07T02:05:55.6667273Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-07T02:05:55.6773433Z (node:2052) [DEP0169] DeprecationWarning: `url.parse()` behavior is not standardized and prone to errors that have security implications. Use the WHATWG URL API instead. CVEs are not issued for `url.parse()` vulnerabilities.2026-08-07T02:05:55.6781289Z Cache hit for: kic-v1.38.1-x642026-08-07T02:05:56.7632351Z Received 134217728 of 224218863 (59.9%), 120.8 MBs/sec2026-08-07T02:05:56.7636152Z Received 113246208 of 544082657 (20.8%), 103.4 MBs/sec2026-08-07T02:05:57.3324733Z Received 224218863 of 224218863 (100.0%), 131.2 MBs/sec2026-08-07T02:05:57.3326241Z Cache Size: ~214 MB (224218863 B)2026-08-07T02:05:57.4062584Z [command]/usr/bin/tar -xf /home/runner/work/_temp/52eb55f8-85ca-4bc4-90eb-69cca398610d/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-07T02:05:57.7777726Z Received 272629760 of 544082657 (50.1%), 126.5 MBs/sec2026-08-07T02:05:58.1650685Z Cache restored successfully2026-08-07T02:05:58.8316788Z Received 536870912 of 544082657 (98.7%), 164.5 MBs/sec2026-08-07T02:05:58.8753745Z Received 544082657 of 544082657 (100.0%), 164.4 MBs/sec2026-08-07T02:05:58.8755162Z Cache Size: ~519 MB (544082657 B)2026-08-07T02:05:58.8873480Z [command]/usr/bin/tar -xf /home/runner/work/_temp/13eb3469-6a48-4d06-bf0a-79c1d7edab2e/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-07T02:05:59.6750864Z Cache restored successfully2026-08-07T02:05:59.7929073Z [command]/home/runner/bin/minikube start --wait all2026-08-07T02:05:59.8325493Z * minikube v1.38.1 on Ubuntu 22.042026-08-07T02:05:59.9812571Z ! The minimum required version for podman is "4.9.0". your version is "3.4.4". minikube might not work. use at your own risk. To install latest version please see https://podman.io/getting-started/installation.html2026-08-07T02:06:00.3406568Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-07T02:06:00.4018007Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-07T02:06:00.4029113Z * Using Docker driver with root privileges2026-08-07T02:06:00.4044529Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-07T02:06:00.4055537Z * Pulling base image v0.0.50 ...2026-08-07T02:06:28.6917326Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-07T02:06:33.8658902Z * Verifying Kubernetes components...2026-08-07T02:06:33.8980096Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-07T02:06:34.6607667Z * Enabled addons: storage-provisioner, default-storageclass2026-08-07T02:07:14.4650115Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-07T02:07:14.4792401Z [command]/home/runner/bin/minikube version --short2026-08-07T02:07:14.5185429Z v1.38.12026-08-07T02:07:14.5511554Z ##[group]Run actions/setup-go@v62026-08-07T02:07:14.5511852Z with:2026-08-07T02:07:14.5512048Z go-version: 1.262026-08-07T02:07:14.5512249Z cache: true2026-08-07T02:07:14.5512467Z cache-dependency-path: go.sum2026-08-07T02:07:14.5512732Z check-latest: false2026-08-07T02:07:14.5515068Z token: ***2026-08-07T02:07:14.5515275Z ##[endgroup]2026-08-07T02:07:14.6795075Z Setup go version spec 1.262026-08-07T02:07:14.6856929Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-07T02:07:14.6859322Z Added go to the path2026-08-07T02:07:14.6862682Z Successfully set up Go version 1.262026-08-07T02:07:15.4019197Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-07T02:07:15.4059174Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-07T02:07:15.4089007Z /home/runner/go/pkg/mod2026-08-07T02:07:15.4112066Z /home/runner/.cache/go-build2026-08-07T02:07:15.5048586Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-07T02:07:16.5681504Z Received 130023424 of 251839808 (51.6%), 123.9 MBs/sec2026-08-07T02:07:17.4232916Z Received 251839808 of 251839808 (100.0%), 129.3 MBs/sec2026-08-07T02:07:17.4234404Z Cache Size: ~240 MB (251839808 B)2026-08-07T02:07:17.4301309Z [command]/usr/bin/tar -xf /home/runner/work/_temp/23906dd9-7a78-40ac-8839-f32f784ff275/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-07T02:07:20.4539479Z Cache restored successfully2026-08-07T02:07:20.5118138Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-07T02:07:20.5148410Z go version go1.26.5 linux/amd642026-08-07T02:07:20.5149017Z 2026-08-07T02:07:20.5149659Z ##[group]go env2026-08-07T02:07:20.5405202Z AR='ar'2026-08-07T02:07:20.5405608Z CC='gcc'2026-08-07T02:07:20.5406492Z CGO_CFLAGS='-O2 -g'2026-08-07T02:07:20.5407100Z CGO_CPPFLAGS=''2026-08-07T02:07:20.5407363Z CGO_CXXFLAGS='-O2 -g'2026-08-07T02:07:20.5407678Z CGO_ENABLED='1'2026-08-07T02:07:20.5407956Z CGO_FFLAGS='-O2 -g'2026-08-07T02:07:20.5408204Z CGO_LDFLAGS='-O2 -g'2026-08-07T02:07:20.5408757Z CXX='g++'2026-08-07T02:07:20.5408982Z GCCGO='gccgo'2026-08-07T02:07:20.5409238Z GO111MODULE=''2026-08-07T02:07:20.5409465Z GOAMD64='v1'2026-08-07T02:07:20.5409686Z GOARCH='amd64'2026-08-07T02:07:20.5409906Z GOAUTH='netrc'2026-08-07T02:07:20.5410122Z GOBIN=''2026-08-07T02:07:20.5410362Z GOCACHE='/home/runner/.cache/go-build'2026-08-07T02:07:20.5410681Z GOCACHEPROG=''2026-08-07T02:07:20.5410911Z GODEBUG=''2026-08-07T02:07:20.5411148Z GOENV='/home/runner/.config/go/env'2026-08-07T02:07:20.5411437Z GOEXE=''2026-08-07T02:07:20.5411651Z GOEXPERIMENT=''2026-08-07T02:07:20.5411895Z GOFIPS140='off'2026-08-07T02:07:20.5412122Z GOFLAGS=''2026-08-07T02:07:20.5467673Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build2179777587=/tmp/go-build -gno-record-gcc-switches'2026-08-07T02:07:20.5468750Z GOHOSTARCH='amd64'2026-08-07T02:07:20.5469099Z GOHOSTOS='linux'2026-08-07T02:07:20.5469444Z GOINSECURE=''2026-08-07T02:07:20.5470048Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-07T02:07:20.5470754Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-07T02:07:20.5471158Z GONOPROXY=''2026-08-07T02:07:20.5471486Z GONOSUMDB=''2026-08-07T02:07:20.5471828Z GOOS='linux'2026-08-07T02:07:20.5472153Z GOPATH='/home/runner/go'2026-08-07T02:07:20.5472522Z GOPRIVATE=''2026-08-07T02:07:20.5472911Z GOPROXY='https://proxy.golang.org,direct'2026-08-07T02:07:20.5473448Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-07T02:07:20.5473955Z GOSUMDB='sum.golang.org'2026-08-07T02:07:20.5474355Z GOTELEMETRY='local'2026-08-07T02:07:20.5474813Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-07T02:07:20.5475359Z GOTMPDIR=''2026-08-07T02:07:20.5475721Z GOTOOLCHAIN='local'2026-08-07T02:07:20.5477233Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-07T02:07:20.5477910Z GOVCS=''2026-08-07T02:07:20.5478256Z GOVERSION='go1.26.5'2026-08-07T02:07:20.5478621Z GOWORK=''2026-08-07T02:07:20.5478991Z PKG_CONFIG='pkg-config'2026-08-07T02:07:20.5479236Z 2026-08-07T02:07:20.5479719Z ##[endgroup]2026-08-07T02:07:20.5614117Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-07T02:07:20.5614655Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-07T02:07:20.5671663Z shell: /usr/bin/bash -e {0}2026-08-07T02:07:20.5671922Z env:2026-08-07T02:07:20.5672115Z GOTOOLCHAIN: local2026-08-07T02:07:20.5672361Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-08-07T02:07:20.5672636Z OSPOOL_EP_CMTag: 25.x-el92026-08-07T02:07:20.5672888Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-07T02:07:20.5673142Z ##[endgroup]2026-08-07T02:07:27.1497191Z === RUN TestOSPoolEP2026-08-07T02:07:27.1497842Z === PAUSE TestOSPoolEP2026-08-07T02:07:27.1498368Z === CONT TestOSPoolEP2026-08-07T02:07:27.1500850Z TestOSPoolEP 2026-08-07T02:07:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:07:27.1627756Z TestOSPoolEP 2026-08-07T02:07:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 apply -f /tmp/TestOSPoolEP4084253612]2026-08-07T02:07:27.9760261Z TestOSPoolEP 2026-08-07T02:07:27Z logger.go:67: pod/idtoken-generator created2026-08-07T02:07:27.9920762Z TestOSPoolEP 2026-08-07T02:07:27Z logger.go:67: secret/pool-passwd created2026-08-07T02:07:27.9985877Z TestOSPoolEP 2026-08-07T02:07:27Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-07T02:07:27.9987508Z TestOSPoolEP 2026-08-07T02:07:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:07:28.0012137Z TestOSPoolEP 2026-08-07T02:07:28Z retry.go:103: Wait for pod idtoken-generator to be provisioned. returned an error: Pod idtoken-generator is not available, reason: , message: . Sleeping for 10s and will try again.2026-08-07T02:07:38.0019780Z TestOSPoolEP 2026-08-07T02:07:38Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-07T02:07:38.0023877Z TestOSPoolEP 2026-08-07T02:07:38Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:07:38.0043429Z TestOSPoolEP 2026-08-07T02:07:38Z logger.go:67: Pod is now available2026-08-07T02:07:38.0045332Z TestOSPoolEP 2026-08-07T02:07:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-07T02:07:38.6957397Z TestOSPoolEP 2026-08-07T02:07:38Z logger.go:67: ***2026-08-07T02:07:38.7023525Z TestOSPoolEP 2026-08-07T02:07:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 apply -f /tmp/TestOSPoolEP2137025788]2026-08-07T02:07:38.9434727Z TestOSPoolEP 2026-08-07T02:07:38Z logger.go:67: secret/pool-token created2026-08-07T02:07:38.9483483Z TestOSPoolEP 2026-08-07T02:07:38Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-07T02:07:38.9485242Z TestOSPoolEP 2026-08-07T02:07:38Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:07:38.9512469Z TestOSPoolEP 2026-08-07T02:07:38Z logger.go:67: Secret is now available2026-08-07T02:07:38.9536773Z TestOSPoolEP 2026-08-07T02:07:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 apply -k /tmp/kustomize-template-2525748161]2026-08-07T02:07:39.2678949Z TestOSPoolEP 2026-08-07T02:07:39Z logger.go:67: service/test-cm created2026-08-07T02:07:39.2779866Z TestOSPoolEP 2026-08-07T02:07:39Z logger.go:67: Warning: spec.template.spec.containers[0].env[8]: hides previous definition of "OSG_SQUID_LOCATION", which may be dropped when using apply2026-08-07T02:07:39.2784592Z TestOSPoolEP 2026-08-07T02:07:39Z logger.go:67: deployment.apps/ospool-ep created2026-08-07T02:07:39.2899361Z TestOSPoolEP 2026-08-07T02:07:39Z logger.go:67: deployment.apps/test-cm created2026-08-07T02:07:39.2950767Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-07T02:07:39.2954022Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-07T02:07:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:07:39.3081954Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-07T02:07:39Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-07T02:07:39.3084195Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-07T02:07:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:07:39.3087473Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-07T02:07:39Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-07T02:07:39.3090163Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-07T02:07:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:07:39.3118732Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-07T02:07:39Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "test-cm-5bb545475c". Sleeping for 10s and will try again.2026-08-07T02:07:39.3123964Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-07T02:07:39Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-65c844ddbb". Sleeping for 10s and will try again.2026-08-07T02:07:49.3137219Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-07T02:07:49Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-07T02:07:49.3138851Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-07T02:07:49Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-07T02:07:49.3140512Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-07T02:07:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:07:49.3142133Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-07T02:07:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:07:49.3159547Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-07T02:07:49Z logger.go:67: Deployment is now available2026-08-07T02:07:49.3165494Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-07T02:07:49Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-65c844ddbb" is progressing.. Sleeping for 10s and will try again.2026-08-07T02:07:59.3183325Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-07T02:07:59Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-07T02:07:59.3185249Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-07T02:07:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:07:59.3268017Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-07T02:07:59Z logger.go:67: Deployment is now available2026-08-07T02:07:59.3269318Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-07T02:07:59.3270441Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-07T02:07:59.3271520Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-07T02:07:59.3272315Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-07T02:07:59.3273003Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-07T02:07:59.3273644Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-07T02:07:59.3274675Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-07T02:07:59.3276291Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-07T02:07:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:07:59.3277565Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-07T02:07:59.3278905Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:07:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:07:59.3280219Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-07T02:07:59.3281616Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-07T02:07:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:07:59.3283657Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-07T02:07:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:07:59.3285618Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-07T02:07:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:07:59.3289443Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:07:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:07:59.3308702Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:07:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-07T02:07:59.3317087Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-07T02:07:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)']2026-08-07T02:07:59.3349842Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-07T02:07:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_SINGULARITY]2026-08-07T02:07:59.6609844Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-4nd6k failed. Retrying in 10s.2026-08-07T02:07:59.6667613Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-07T02:07:59.6669723Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)']' in pod test-cm-5bb545475c-4nd6k failed. Retrying in 10s.2026-08-07T02:07:59.6678756Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-07T02:07:59.6682286Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-4nd6k failed. Retrying in 30s.2026-08-07T02:08:09.6618386Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-07T02:08:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_SINGULARITY]2026-08-07T02:08:09.6681793Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-07T02:08:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)']2026-08-07T02:08:09.9332687Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-07T02:08:09.9337423Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)']' in pod test-cm-5bb545475c-4nd6k failed. Retrying in 10s.2026-08-07T02:08:09.9346655Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-07T02:08:09.9348862Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-4nd6k failed. Retrying in 10s.2026-08-07T02:08:19.9355554Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-07T02:08:19Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_SINGULARITY]2026-08-07T02:08:19.9360537Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-07T02:08:19Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)']2026-08-07T02:08:20.1135758Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-07T02:08:20Z logger.go:67: true2026-08-07T02:08:20.1152510Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-07T02:08:20Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-07T02:08:20.1153974Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-07T02:08:20Z logger.go:67: 2026-08-07T02:08:20.1155189Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-07T02:08:20Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-65c844ddbb-94hkz LINUX X86_64 Unclaimed Idle 0.000 15995 0+00:00:002026-08-07T02:08:20.1156567Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-07T02:08:20Z logger.go:67: 2026-08-07T02:08:20.1167030Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-07T02:08:20Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-07T02:08:20.1178256Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-07T02:08:20Z logger.go:67: 2026-08-07T02:08:20.1180622Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-07T02:08:20Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-07T02:08:20.1181988Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-07T02:08:20Z logger.go:67: 2026-08-07T02:08:20.1182847Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-07T02:08:20Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-07T02:08:29.6685059Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:08:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-07T02:08:29.8305996Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:08:29Z logger.go:67: undefined2026-08-07T02:08:29.8359028Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-07T02:08:29.8360350Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-4nd6k failed. Retrying in 30s.2026-08-07T02:08:59.8363341Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:08:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-07T02:09:00.0673504Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:09:00Z logger.go:67: undefined2026-08-07T02:09:00.0753264Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-4nd6k failed. Retrying in 30s.2026-08-07T02:09:30.0757958Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:09:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-07T02:09:30.2206051Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:09:30Z logger.go:67: undefined2026-08-07T02:09:30.2265712Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-4nd6k failed. Retrying in 30s.2026-08-07T02:10:00.2271413Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:10:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-07T02:10:00.3952225Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:10:00Z logger.go:67: undefined2026-08-07T02:10:00.4011342Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-4nd6k failed. Retrying in 30s.2026-08-07T02:10:30.4043922Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:10:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-07T02:10:30.5504163Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:10:30Z logger.go:67: undefined2026-08-07T02:10:30.5563390Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-4nd6k failed. Retrying in 30s.2026-08-07T02:11:00.5600659Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:11:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-07T02:11:00.7052584Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:11:00Z logger.go:67: undefined2026-08-07T02:11:00.7107330Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-4nd6k failed. Retrying in 30s.2026-08-07T02:11:30.7139911Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:11:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-07T02:11:30.8712881Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:11:30Z logger.go:67: undefined2026-08-07T02:11:30.8768985Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-4nd6k failed. Retrying in 30s.2026-08-07T02:12:00.8773081Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:12:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-07T02:12:01.0205929Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:12:01Z logger.go:67: undefined2026-08-07T02:12:01.0272210Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-4nd6k failed. Retrying in 30s.2026-08-07T02:12:31.0274084Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:12:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-07T02:12:31.1770292Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:12:31Z logger.go:67: undefined2026-08-07T02:12:31.1826694Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-4nd6k failed. Retrying in 30s.2026-08-07T02:13:01.1851140Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:13:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-07T02:13:01.3338602Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:13:01Z logger.go:67: undefined2026-08-07T02:13:01.3399913Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-4nd6k failed. Retrying in 30s.2026-08-07T02:13:31.3415819Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:13:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 exec test-cm-5bb545475c-4nd6k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-94hkz",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-07T02:13:31.4888868Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-07T02:13:31Z logger.go:67: true2026-08-07T02:13:31.4961574Z TestOSPoolEP 2026-08-07T02:13:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:13:31.5030755Z TestOSPoolEP 2026-08-07T02:13:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:13:31.7177285Z TestOSPoolEP 2026-08-07T02:13:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:13:31.8439530Z TestOSPoolEP 2026-08-07T02:13:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:13:31.9477074Z TestOSPoolEP 2026-08-07T02:13:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:13:31.9504838Z === NAME TestOSPoolEP2026-08-07T02:13:31.9505427Z ospool_ep_test.go:101: ---2026-08-07T02:13:31.9507075Z Events for pod idtoken-generator:2026-08-07T02:13:31.9508525Z 2026-08-07 02:07:27 +0000 UTC Normal Successfully assigned test-ospool-ep-5368z2/idtoken-generator to minikube2026-08-07T02:13:31.9509801Z 2026-08-07 02:07:28 +0000 UTC Normal Pulling image "htcondor/base"2026-08-07T02:13:31.9511390Z 2026-08-07 02:07:37 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.292s (8.292s including waiting). Image size: 560910730 bytes.2026-08-07T02:13:31.9512192Z 2026-08-07 02:07:37 +0000 UTC Normal Container created2026-08-07T02:13:31.9512886Z 2026-08-07 02:07:37 +0000 UTC Normal Container started2026-08-07T02:13:31.9513224Z 2026-08-07T02:13:31.9513428Z ---2026-08-07T02:13:31.9513995Z TestOSPoolEP 2026-08-07T02:13:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:13:31.9526872Z ospool_ep_test.go:101: ---2026-08-07T02:13:31.9527684Z Events for pod ospool-ep-65c844ddbb-94hkz:2026-08-07T02:13:31.9529381Z 2026-08-07 02:07:39 +0000 UTC Normal Successfully assigned test-ospool-ep-5368z2/ospool-ep-65c844ddbb-94hkz to minikube2026-08-07T02:13:31.9531015Z 2026-08-07 02:07:39 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-07T02:13:31.9532365Z 2026-08-07 02:07:41 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.428s (1.428s including waiting). Image size: 5590942 bytes.2026-08-07T02:13:31.9533899Z 2026-08-07 02:07:41 +0000 UTC Normal Container created2026-08-07T02:13:31.9534761Z 2026-08-07 02:07:41 +0000 UTC Normal Container started2026-08-07T02:13:31.9536301Z 2026-08-07 02:07:41 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-08-07T02:13:31.9538239Z 2026-08-07 02:07:54 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 13.033s (13.033s including waiting). Image size: 1259139928 bytes.2026-08-07T02:13:31.9539344Z 2026-08-07 02:07:54 +0000 UTC Normal Container created2026-08-07T02:13:31.9539836Z 2026-08-07 02:07:54 +0000 UTC Normal Container started2026-08-07T02:13:31.9540353Z 2026-08-07T02:13:31.9540574Z ---2026-08-07T02:13:31.9541166Z TestOSPoolEP 2026-08-07T02:13:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:13:31.9549238Z ospool_ep_test.go:101: ---2026-08-07T02:13:31.9550109Z Events for pod test-cm-5bb545475c-4nd6k:2026-08-07T02:13:31.9551529Z 2026-08-07 02:07:39 +0000 UTC Normal Successfully assigned test-ospool-ep-5368z2/test-cm-5bb545475c-4nd6k to minikube2026-08-07T02:13:31.9552909Z 2026-08-07 02:07:39 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-08-07T02:13:31.9554880Z 2026-08-07 02:07:41 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 257ms (1.655s including waiting). Image size: 560910756 bytes.2026-08-07T02:13:31.9557022Z 2026-08-07 02:07:41 +0000 UTC Normal Container created2026-08-07T02:13:31.9557881Z 2026-08-07 02:07:41 +0000 UTC Normal Container started2026-08-07T02:13:31.9558408Z 2026-08-07T02:13:31.9558751Z ---2026-08-07T02:13:31.9559697Z TestOSPoolEP 2026-08-07T02:13:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-07T02:13:31.9591996Z TestOSPoolEP 2026-08-07T02:13:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 delete -f /tmp/TestOSPoolEP3958997361]2026-08-07T02:13:32.0527366Z TestOSPoolEP 2026-08-07T02:13:32Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-5368z2 namespace2026-08-07T02:13:32.0579134Z TestOSPoolEP 2026-08-07T02:13:32Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-5368z2 namespace2026-08-07T02:13:33.6255528Z TestOSPoolEP 2026-08-07T02:13:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 delete -f /tmp/TestOSPoolEP1669038494]2026-08-07T02:13:33.7115300Z TestOSPoolEP 2026-08-07T02:13:33Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-5368z2 namespace2026-08-07T02:13:33.7154494Z TestOSPoolEP 2026-08-07T02:13:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5368z2 delete -k /tmp/kustomize-template-2525748161]2026-08-07T02:13:33.8244570Z TestOSPoolEP 2026-08-07T02:13:33Z logger.go:67: service "test-cm" deleted from test-ospool-ep-5368z2 namespace2026-08-07T02:13:33.8291252Z TestOSPoolEP 2026-08-07T02:13:33Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-5368z2 namespace2026-08-07T02:13:33.8337764Z TestOSPoolEP 2026-08-07T02:13:33Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-5368z2 namespace2026-08-07T02:13:33.8420830Z --- PASS: TestOSPoolEP (34.52s)2026-08-07T02:13:33.8433914Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (20.03s)2026-08-07T02:13:33.8434972Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.80s)2026-08-07T02:13:33.8437054Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.80s)2026-08-07T02:13:33.8438203Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (332.17s)2026-08-07T02:13:33.8439118Z PASS2026-08-07T02:13:33.8454116Z ok github.com/osg-htc/k8s-integration-tests/test 366.708s2026-08-07T02:13:33.9601094Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-07T02:13:33.9601763Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-07T02:13:33.9668938Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-07T02:13:33.9669313Z env:2026-08-07T02:13:33.9669516Z GOTOOLCHAIN: local2026-08-07T02:13:33.9670092Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-07T02:13:33.9670607Z ##[endgroup]2026-08-07T02:13:33.9940551Z Node 20 is being deprecated. This workflow is running with Node 24 by default. If you need to temporarily use Node 20, you can set the ACTIONS_ALLOW_USE_UNSECURE_NODE_VERSION=true environment variable. For more information see: https://github.blog/changelog/2025-09-19-deprecation-of-node-20-on-github-actions-runners/2026-08-07T02:13:33.9942507Z ##[group]Run actions/upload-artifact@v42026-08-07T02:13:33.9943042Z with:2026-08-07T02:13:33.9943512Z name: TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe52026-08-07T02:13:33.9943994Z path: /tmp/k8s-tests2026-08-07T02:13:33.9944280Z retention-days: 52026-08-07T02:13:33.9944595Z if-no-files-found: warn2026-08-07T02:13:33.9945040Z compression-level: 62026-08-07T02:13:33.9945314Z overwrite: false2026-08-07T02:13:33.9945681Z include-hidden-files: false2026-08-07T02:13:33.9946163Z env:2026-08-07T02:13:33.9946527Z GOTOOLCHAIN: local2026-08-07T02:13:33.9947009Z ##[endgroup]2026-08-07T02:13:34.2380295Z (node:18052) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-07T02:13:34.2385026Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-07T02:13:34.2497260Z With the provided path, there will be 6 files uploaded2026-08-07T02:13:34.2499021Z Artifact name is valid!2026-08-07T02:13:34.2499856Z Root directory input is valid!2026-08-07T02:13:34.4125232Z Beginning upload of artifact content to blob storage2026-08-07T02:13:34.4572814Z (node:18052) [DEP0169] DeprecationWarning: `url.parse()` behavior is not standardized and prone to errors that have security implications. Use the WHATWG URL API instead. CVEs are not issued for `url.parse()` vulnerabilities.2026-08-07T02:13:34.5191244Z Uploaded bytes 141042026-08-07T02:13:34.5367772Z Finished uploading artifact content to blob storage!2026-08-07T02:13:34.5368850Z SHA256 digest of uploaded artifact zip is 06f0cac589d54daf283874d1542aaf6abca1542a918b72a8c02af763b613b19d2026-08-07T02:13:34.5370458Z Finalizing artifact upload2026-08-07T02:13:34.6848955Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5.zip successfully finalized. Artifact ID 89796313582026-08-07T02:13:34.6851750Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5 has been successfully uploaded! Final size is 14104 bytes. Artifact ID is 89796313582026-08-07T02:13:34.6859359Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/31140135689/artifacts/89796313582026-08-07T02:13:34.7061184Z Post job cleanup.2026-08-07T02:13:34.8402365Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-07T02:13:34.8458578Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-07T02:13:34.8524894Z /home/runner/go/pkg/mod2026-08-07T02:13:34.8533575Z /home/runner/.cache/go-build2026-08-07T02:13:34.8561971Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-07T02:13:34.8760112Z Post job cleanup.2026-08-07T02:13:34.9699858Z [command]/usr/bin/git version2026-08-07T02:13:34.9749130Z git version 2.54.02026-08-07T02:13:34.9794214Z Temporarily overriding HOME='/home/runner/work/_temp/43a77c35-6d16-42b9-8752-2427fbf2d4bb' before making global git config changes2026-08-07T02:13:34.9795529Z Adding repository directory to the temporary git global config as a safe directory2026-08-07T02:13:34.9801342Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-07T02:13:34.9848432Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-07T02:13:34.9904292Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :"2026-08-07T02:13:35.0266886Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-07T02:13:35.0300049Z http.https://github.com/.extraheader2026-08-07T02:13:35.0341018Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-07T02:13:35.0413232Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :"2026-08-07T02:13:35.0787886Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-07T02:13:35.0843595Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-07T02:13:35.1331131Z Cleaning up orphan processes2026-08-07T02:13:35.2117679Z ##[warning]Node.js 20 is deprecated. The following actions target Node.js 20 but are being forced to run on Node.js 24: actions/upload-artifact@v4. For more information see: https://github.blog/changelog/2025-09-19-deprecation-of-node-20-on-github-actions-runners/