All Test Logs

2026-08-29T04:28:10.4732557Z Current runner version: '2.336.0'2026-08-29T04:28:10.4768543Z ##[group]Runner Image Provisioner2026-08-29T04:28:10.4769843Z Hosted Compute Agent2026-08-29T04:28:10.4770767Z Version: 20260819.5862026-08-29T04:28:10.4772040Z Commit: 3cc4a88dfa507ef76119ad1bb3eccc6378bb2b762026-08-29T04:28:10.4773218Z Build Date: 2026-08-18T23:20:18Z2026-08-29T04:28:10.4774371Z Worker ID: {6360f32b-64ea-42ab-a936-0b5ed39cd10a}2026-08-29T04:28:10.4775519Z Azure Region: eastus22026-08-29T04:28:10.4776630Z ##[endgroup]2026-08-29T04:28:10.4779601Z ##[group]Operating System2026-08-29T04:28:10.4780622Z Ubuntu2026-08-29T04:28:10.4781621Z 22.04.52026-08-29T04:28:10.4782431Z LTS2026-08-29T04:28:10.4783194Z ##[endgroup]2026-08-29T04:28:10.4784190Z ##[group]Runner Image2026-08-29T04:28:10.4785169Z Image: ubuntu-22.042026-08-29T04:28:10.4786213Z Version: 20260824.273.32026-08-29T04:28:10.4788449Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260824.273/images/ubuntu/Ubuntu2204-Readme.md2026-08-29T04:28:10.4791272Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260824.2732026-08-29T04:28:10.4792845Z ##[endgroup]2026-08-29T04:28:10.4799028Z ##[group]GITHUB_TOKEN Permissions2026-08-29T04:28:10.4802715Z Actions: write2026-08-29T04:28:10.4803689Z ArtifactMetadata: write2026-08-29T04:28:10.4804659Z Attestations: write2026-08-29T04:28:10.4805675Z Checks: write2026-08-29T04:28:10.4806558Z CodeQuality: write2026-08-29T04:28:10.4807654Z Contents: write2026-08-29T04:28:10.4808761Z CopilotRequests: write2026-08-29T04:28:10.4809686Z Deployments: write2026-08-29T04:28:10.4810736Z Discussions: write2026-08-29T04:28:10.4811651Z Drives: write2026-08-29T04:28:10.4812585Z Issues: write2026-08-29T04:28:10.4813461Z Metadata: read2026-08-29T04:28:10.4814489Z Models: read2026-08-29T04:28:10.4815494Z Packages: write2026-08-29T04:28:10.4816383Z Pages: write2026-08-29T04:28:10.4817608Z PullRequests: write2026-08-29T04:28:10.4818653Z RepositoryProjects: write2026-08-29T04:28:10.4819661Z SecurityEvents: write2026-08-29T04:28:10.4820719Z Statuses: write2026-08-29T04:28:10.4821667Z VulnerabilityAlerts: read2026-08-29T04:28:10.4822693Z ##[endgroup]2026-08-29T04:28:10.4825696Z Secret source: Actions2026-08-29T04:28:10.4827742Z Prepare workflow directory2026-08-29T04:28:10.5291296Z Prepare all required actions2026-08-29T04:28:10.5358156Z Getting action download info2026-08-29T04:28:10.7155816Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-29T04:28:10.8189836Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-29T04:28:11.0026367Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-29T04:28:11.1889999Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-29T04:28:11.4539830Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-29T04:28:11.4546162Z ##[group] Inputs2026-08-29T04:28:11.4546999Z   testName: TestOSPoolEP2026-08-29T04:28:11.4548716Z   testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-29T04:28:11.4550440Z   setupScript: 2026-08-29T04:28:11.4551165Z   setupEnv: {}2026-08-29T04:28:11.4551869Z ##[endgroup]2026-08-29T04:28:11.4553030Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-08-29T04:28:11.5396820Z ##[group]Run actions/checkout@v52026-08-29T04:28:11.5398336Z with:2026-08-29T04:28:11.5399095Z   repository: osg-htc/k8s-integration-tests2026-08-29T04:28:11.5407553Z   token: ***2026-08-29T04:28:11.5408247Z   ssh-strict: true2026-08-29T04:28:11.5408967Z   ssh-user: git2026-08-29T04:28:11.5409712Z   persist-credentials: true2026-08-29T04:28:11.5410528Z   clean: true2026-08-29T04:28:11.5411271Z   sparse-checkout-cone-mode: true2026-08-29T04:28:11.5412433Z   fetch-depth: 12026-08-29T04:28:11.5413137Z   fetch-tags: false2026-08-29T04:28:11.5413872Z   show-progress: true2026-08-29T04:28:11.5414595Z   lfs: false2026-08-29T04:28:11.5415255Z   submodules: false2026-08-29T04:28:11.5415978Z   set-safe-directory: true2026-08-29T04:28:11.5416798Z   allow-unsafe-pr-checkout: false2026-08-29T04:28:11.5418198Z ##[endgroup]2026-08-29T04:28:11.6531441Z Syncing repository: osg-htc/k8s-integration-tests2026-08-29T04:28:11.6533900Z ##[group]Getting Git version info2026-08-29T04:28:11.6535384Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-29T04:28:11.6537279Z [command]/usr/bin/git version2026-08-29T04:28:11.6571649Z git version 2.55.02026-08-29T04:28:11.6594476Z ##[endgroup]2026-08-29T04:28:11.6610193Z Temporarily overriding HOME='/home/runner/work/_temp/54ec5ae4-b87e-4ce1-8a61-72632047787c' before making global git config changes2026-08-29T04:28:11.6614176Z Adding repository directory to the temporary git global config as a safe directory2026-08-29T04:28:11.6618133Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-29T04:28:11.6657096Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-29T04:28:11.6661148Z ##[group]Initializing the repository2026-08-29T04:28:11.6666049Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-29T04:28:11.6750916Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-29T04:28:11.6753782Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-29T04:28:11.6756691Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-29T04:28:11.6758930Z hint: call:2026-08-29T04:28:11.6759909Z hint:2026-08-29T04:28:11.6761076Z hint: 	git config --global init.defaultBranch <name>2026-08-29T04:28:11.6762582Z hint:2026-08-29T04:28:11.6763987Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-29T04:28:11.6766328Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-29T04:28:11.6768028Z hint:2026-08-29T04:28:11.6768685Z hint: 	git branch -m <name>2026-08-29T04:28:11.6769437Z hint:2026-08-29T04:28:11.6770448Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-29T04:28:11.6772388Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-29T04:28:11.6775492Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-08-29T04:28:11.6812419Z ##[endgroup]2026-08-29T04:28:11.6813865Z ##[group]Disabling automatic garbage collection2026-08-29T04:28:11.6815719Z [command]/usr/bin/git config --local gc.auto 02026-08-29T04:28:11.6854651Z ##[endgroup]2026-08-29T04:28:11.6855787Z ##[group]Setting up auth2026-08-29T04:28:11.6862648Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-29T04:28:11.6901558Z [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-29T04:28:11.7289164Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-29T04:28:11.7328995Z [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-29T04:28:11.7635232Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-29T04:28:11.7678898Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-29T04:28:11.7966950Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-29T04:28:11.8026745Z ##[endgroup]2026-08-29T04:28:11.8028851Z ##[group]Fetching the repository2026-08-29T04:28:11.8038888Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-29T04:28:12.0578103Z From https://github.com/osg-htc/k8s-integration-tests2026-08-29T04:28:12.0579175Z  * [new ref]         ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-29T04:28:12.0582853Z ##[endgroup]2026-08-29T04:28:12.0583690Z ##[group]Determining the checkout info2026-08-29T04:28:12.0586636Z ##[endgroup]2026-08-29T04:28:12.0596017Z [command]/usr/bin/git sparse-checkout disable2026-08-29T04:28:12.0647680Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-29T04:28:12.0685503Z ##[group]Checking out the ref2026-08-29T04:28:12.0689360Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-29T04:28:12.0794390Z Switched to a new branch 'main'2026-08-29T04:28:12.0798034Z branch 'main' set up to track 'origin/main'.2026-08-29T04:28:12.0804615Z ##[endgroup]2026-08-29T04:28:12.0859151Z [command]/usr/bin/git log -1 --format=%H2026-08-29T04:28:12.0892039Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-29T04:28:12.1236868Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-29T04:28:12.1238409Z echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-29T04:28:12.1239528Z echo "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-29T04:28:12.1549300Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-29T04:28:12.1550111Z env:2026-08-29T04:28:12.1551042Z   TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-29T04:28:12.1552052Z   SETUP_ENV_YAML: {}2026-08-29T04:28:12.1552687Z ##[endgroup]2026-08-29T04:28:13.1774753Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-29T04:28:13.1775418Z echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-29T04:28:13.1852626Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-29T04:28:13.1852971Z env:2026-08-29T04:28:13.1853419Z   TEST_ENV: {  "OSPOOL_EP_OSPoolEPTag": "25-release",  "OSPOOL_EP_CMTag": "25.0-el9",  "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-29T04:28:13.1853922Z ##[endgroup]2026-08-29T04:28:13.2009010Z ##[group]Run true2026-08-29T04:28:13.2009252Z true2026-08-29T04:28:13.2078654Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-29T04:28:13.2079023Z ##[endgroup]2026-08-29T04:28:13.2251918Z ##[group]Run medyagh/setup-minikube@latest2026-08-29T04:28:13.2252227Z with:2026-08-29T04:28:13.2252429Z   start: true2026-08-29T04:28:13.2252624Z   cache: true2026-08-29T04:28:13.2252860Z   minikube-version: latest2026-08-29T04:28:13.2253125Z   wait: all2026-08-29T04:28:13.2253322Z ##[endgroup]2026-08-29T04:28:13.3591440Z (node:1822) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-29T04:28:13.3592573Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-29T04:28:14.1382604Z [command]/usr/bin/chmod +x /home/runner/work/_temp/70d79bb9-7e28-4a35-99cd-9a8720ae09d72026-08-29T04:28:14.3158852Z [command]/home/runner/bin/minikube version --short2026-08-29T04:28:14.3760323Z v1.38.12026-08-29T04:28:14.4505455Z Cache hit for: kic-v1.38.1-x642026-08-29T04:28:14.4604467Z (node:1822) [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-29T04:28:14.4608538Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-29T04:28:15.4838237Z Received 134217728 of 544082637 (24.7%), 127.9 MBs/sec2026-08-29T04:28:15.6007185Z Received 134217728 of 224218830 (59.9%), 116.6 MBs/sec2026-08-29T04:28:16.2136063Z Received 224218830 of 224218830 (100.0%), 124.6 MBs/sec2026-08-29T04:28:16.2137224Z Cache Size: ~214 MB (224218830 B)2026-08-29T04:28:16.2651348Z [command]/usr/bin/tar -xf /home/runner/work/_temp/7dbb2e58-3a95-4ef0-a7b1-6d156aa9cc8a/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-29T04:28:16.4885409Z Received 268435456 of 544082637 (49.3%), 127.6 MBs/sec2026-08-29T04:28:17.0676480Z Cache restored successfully2026-08-29T04:28:17.5837043Z Received 536870912 of 544082637 (98.7%), 165.1 MBs/sec2026-08-29T04:28:17.6352631Z Received 544082637 of 544082637 (100.0%), 164.6 MBs/sec2026-08-29T04:28:17.6353837Z Cache Size: ~519 MB (544082637 B)2026-08-29T04:28:17.6469565Z [command]/usr/bin/tar -xf /home/runner/work/_temp/07dea385-ede1-49fe-945d-af1f94cbba79/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-29T04:28:18.4829981Z Cache restored successfully2026-08-29T04:28:18.6107487Z [command]/home/runner/bin/minikube start --wait all2026-08-29T04:28:18.6679231Z * minikube v1.38.1 on Ubuntu 22.042026-08-29T04:28:21.8744810Z * Automatically selected the docker driver. Other choices: podman, ssh, none2026-08-29T04:28:21.9310016Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-29T04:28:21.9316915Z * Using Docker driver with root privileges2026-08-29T04:28:21.9325531Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-29T04:28:21.9332109Z * Pulling base image v0.0.50 ...2026-08-29T04:28:53.7549435Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-29T04:28:58.4198801Z * Verifying Kubernetes components...2026-08-29T04:28:58.4531983Z   - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-29T04:28:59.1163781Z * Enabled addons: storage-provisioner, default-storageclass2026-08-29T04:29:34.7373603Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-29T04:29:34.7528768Z [command]/home/runner/bin/minikube version --short2026-08-29T04:29:34.8093548Z v1.38.12026-08-29T04:29:34.8494369Z ##[group]Run actions/setup-go@v62026-08-29T04:29:34.8494666Z with:2026-08-29T04:29:34.8494885Z   go-version: 1.262026-08-29T04:29:34.8495109Z   cache: true2026-08-29T04:29:34.8495358Z   cache-dependency-path: go.sum2026-08-29T04:29:34.8495638Z   check-latest: false2026-08-29T04:29:34.8498594Z   token: ***2026-08-29T04:29:34.8498819Z ##[endgroup]2026-08-29T04:29:34.9902185Z Setup go version spec 1.262026-08-29T04:29:34.9965438Z Found in cache @ /opt/hostedtoolcache/go/1.26.7/x642026-08-29T04:29:34.9968347Z Added go to the path2026-08-29T04:29:34.9972521Z Successfully set up Go version 1.262026-08-29T04:29:35.6445815Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOMODCACHE2026-08-29T04:29:35.6484392Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOCACHE2026-08-29T04:29:35.6517696Z /home/runner/go/pkg/mod2026-08-29T04:29:35.6546611Z /home/runner/.cache/go-build2026-08-29T04:29:35.7309832Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-29T04:29:36.8007195Z Received 184549376 of 251715014 (73.3%), 174.4 MBs/sec2026-08-29T04:29:37.0374286Z Received 251715014 of 251715014 (100.0%), 192.5 MBs/sec2026-08-29T04:29:37.0376124Z Cache Size: ~240 MB (251715014 B)2026-08-29T04:29:37.0446114Z [command]/usr/bin/tar -xf /home/runner/work/_temp/5109afcc-aaac-4dcb-9f11-536778b74753/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-29T04:29:40.1139598Z Cache restored successfully2026-08-29T04:29:40.1756441Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-29T04:29:40.1782672Z go version go1.26.7 linux/amd642026-08-29T04:29:40.1782916Z 2026-08-29T04:29:40.1783270Z ##[group]go env2026-08-29T04:29:40.2181259Z AR='ar'2026-08-29T04:29:40.2182212Z CC='gcc'2026-08-29T04:29:40.2182590Z CGO_CFLAGS='-O2 -g'2026-08-29T04:29:40.2183011Z CGO_CPPFLAGS=''2026-08-29T04:29:40.2183399Z CGO_CXXFLAGS='-O2 -g'2026-08-29T04:29:40.2183774Z CGO_ENABLED='1'2026-08-29T04:29:40.2184125Z CGO_FFLAGS='-O2 -g'2026-08-29T04:29:40.2184368Z CGO_LDFLAGS='-O2 -g'2026-08-29T04:29:40.2184615Z CXX='g++'2026-08-29T04:29:40.2184834Z GCCGO='gccgo'2026-08-29T04:29:40.2185083Z GO111MODULE=''2026-08-29T04:29:40.2185313Z GOAMD64='v1'2026-08-29T04:29:40.2185532Z GOARCH='amd64'2026-08-29T04:29:40.2185740Z GOAUTH='netrc'2026-08-29T04:29:40.2185953Z GOBIN=''2026-08-29T04:29:40.2186195Z GOCACHE='/home/runner/.cache/go-build'2026-08-29T04:29:40.2186523Z GOCACHEPROG=''2026-08-29T04:29:40.2186751Z GODEBUG=''2026-08-29T04:29:40.2186992Z GOENV='/home/runner/.config/go/env'2026-08-29T04:29:40.2187546Z GOEXE=''2026-08-29T04:29:40.2187768Z GOEXPERIMENT=''2026-08-29T04:29:40.2188002Z GOFIPS140='off'2026-08-29T04:29:40.2188215Z GOFLAGS=''2026-08-29T04:29:40.2188924Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build271922203=/tmp/go-build -gno-record-gcc-switches'2026-08-29T04:29:40.2189591Z GOHOSTARCH='amd64'2026-08-29T04:29:40.2189834Z GOHOSTOS='linux'2026-08-29T04:29:40.2190060Z GOINSECURE=''2026-08-29T04:29:40.2190439Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-29T04:29:40.2190887Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-29T04:29:40.2191186Z GONOPROXY=''2026-08-29T04:29:40.2191404Z GONOSUMDB=''2026-08-29T04:29:40.2191621Z GOOS='linux'2026-08-29T04:29:40.2191842Z GOPATH='/home/runner/go'2026-08-29T04:29:40.2192097Z GOPRIVATE=''2026-08-29T04:29:40.2192399Z GOPROXY='https://proxy.golang.org,direct'2026-08-29T04:29:40.2192750Z GOROOT='/opt/hostedtoolcache/go/1.26.7/x64'2026-08-29T04:29:40.2193075Z GOSUMDB='sum.golang.org'2026-08-29T04:29:40.2193337Z GOTELEMETRY='local'2026-08-29T04:29:40.2193628Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-29T04:29:40.2193962Z GOTMPDIR=''2026-08-29T04:29:40.2194180Z GOTOOLCHAIN='local'2026-08-29T04:29:40.2194822Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.7/x64/pkg/tool/linux_amd64'2026-08-29T04:29:40.2195203Z GOVCS=''2026-08-29T04:29:40.2195429Z GOVERSION='go1.26.7'2026-08-29T04:29:40.2195657Z GOWORK=''2026-08-29T04:29:40.2195897Z PKG_CONFIG='pkg-config'2026-08-29T04:29:40.2196055Z 2026-08-29T04:29:40.2196395Z ##[endgroup]2026-08-29T04:29:40.2470964Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-29T04:29:40.2471490Z go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-29T04:29:40.2548453Z shell: /usr/bin/bash -e {0}2026-08-29T04:29:40.2548734Z env:2026-08-29T04:29:40.2548948Z   GOTOOLCHAIN: local2026-08-29T04:29:40.2549210Z   OSPOOL_EP_OSPoolEPTag: 25-release2026-08-29T04:29:40.2549518Z   OSPOOL_EP_CMTag: 25.0-el92026-08-29T04:29:40.2549791Z   OSPOOL_EP_CvmfsType: cvmfsexec2026-08-29T04:29:40.2550060Z ##[endgroup]2026-08-29T04:29:46.0825498Z === RUN   TestOSPoolEP2026-08-29T04:29:46.0826048Z === PAUSE TestOSPoolEP2026-08-29T04:29:46.0826467Z === CONT  TestOSPoolEP2026-08-29T04:29:46.0828682Z TestOSPoolEP 2026-08-29T04:29:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:29:46.1285917Z TestOSPoolEP 2026-08-29T04:29:46Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums apply -f /tmp/TestOSPoolEP2532569697]2026-08-29T04:29:46.8791293Z TestOSPoolEP 2026-08-29T04:29:46Z logger.go:67: pod/idtoken-generator created2026-08-29T04:29:46.9362378Z TestOSPoolEP 2026-08-29T04:29:46Z logger.go:67: secret/pool-passwd created2026-08-29T04:29:46.9413263Z TestOSPoolEP 2026-08-29T04:29:46Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-29T04:29:46.9414966Z TestOSPoolEP 2026-08-29T04:29:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:29:46.9807598Z TestOSPoolEP 2026-08-29T04:29:46Z 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-29T04:29:56.9808689Z TestOSPoolEP 2026-08-29T04:29:56Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-29T04:29:56.9809605Z TestOSPoolEP 2026-08-29T04:29:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:29:56.9837873Z TestOSPoolEP 2026-08-29T04:29:56Z 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-29T04:30:06.9840326Z TestOSPoolEP 2026-08-29T04:30:06Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-29T04:30:06.9842232Z TestOSPoolEP 2026-08-29T04:30:06Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:06.9868908Z TestOSPoolEP 2026-08-29T04:30:06Z logger.go:67: Pod is now available2026-08-29T04:30:06.9870285Z TestOSPoolEP 2026-08-29T04:30:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-29T04:30:07.4720624Z TestOSPoolEP 2026-08-29T04:30:07Z logger.go:67: ***2026-08-29T04:30:07.4782094Z TestOSPoolEP 2026-08-29T04:30:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums apply -f /tmp/TestOSPoolEP1113739532]2026-08-29T04:30:07.5743211Z TestOSPoolEP 2026-08-29T04:30:07Z logger.go:67: secret/pool-token created2026-08-29T04:30:07.5778408Z TestOSPoolEP 2026-08-29T04:30:07Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-29T04:30:07.5780892Z TestOSPoolEP 2026-08-29T04:30:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:07.5797805Z TestOSPoolEP 2026-08-29T04:30:07Z logger.go:67: Secret is now available2026-08-29T04:30:07.5824992Z TestOSPoolEP 2026-08-29T04:30:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums apply -k /tmp/kustomize-template-125928751]2026-08-29T04:30:07.7542105Z TestOSPoolEP 2026-08-29T04:30:07Z logger.go:67: service/test-cm created2026-08-29T04:30:07.7628331Z TestOSPoolEP 2026-08-29T04:30:07Z 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-29T04:30:07.7629823Z TestOSPoolEP 2026-08-29T04:30:07Z logger.go:67: deployment.apps/ospool-ep created2026-08-29T04:30:07.7738355Z TestOSPoolEP 2026-08-29T04:30:07Z logger.go:67: deployment.apps/test-cm created2026-08-29T04:30:07.7787745Z === RUN   TestOSPoolEP/Confirm_deployments_become_ready.2026-08-29T04:30:07.7789500Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:07.7842809Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:07Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-29T04:30:07.7844866Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:07.7858478Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:07Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-29T04:30:07.7860557Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:07.7921667Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:07Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available, missing 'Progressing' condition. Sleeping for 10s and will try again.2026-08-29T04:30:07.7958552Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:07Z 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-6c7d796845". Sleeping for 10s and will try again.2026-08-29T04:30:17.7927736Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:17Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-29T04:30:17.7930305Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:17.7949943Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:17Z logger.go:67: Deployment is now available2026-08-29T04:30:17.7971104Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:17Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-29T04:30:17.7972505Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:17.7993121Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:17Z 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-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-08-29T04:30:27.8010201Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:27Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-29T04:30:27.8012595Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:27.8043835Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:27Z 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-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-08-29T04:30:37.8054416Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:37Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-29T04:30:37.8056288Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:37.8108336Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:37Z logger.go:67: Deployment is now available2026-08-29T04:30:37.8110619Z === RUN   TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-29T04:30:37.8115769Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-29T04:30:37.8116839Z === RUN   TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-29T04:30:37.8117894Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-29T04:30:37.8118747Z === RUN   TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-29T04:30:37.8119486Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-29T04:30:37.8120213Z === CONT  TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-29T04:30:37.8120922Z === CONT  TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-29T04:30:37.8122465Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:30:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:37.8125167Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:30:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:37.8147056Z === CONT  TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-29T04:30:37.8149025Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-29T04:30:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:37.8151124Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:30:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:37.8162973Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-29T04:30:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:37.8177684Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:30:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:30:37.8183998Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:30:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:37.8198007Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-29T04:30:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_SINGULARITY]2026-08-29T04:30:37.8285291Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:30:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)']2026-08-29T04:30:38.0188180Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-zh4tl failed. Retrying in 10s.2026-08-29T04:30:38.0261483Z === NAME  TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-29T04:30:38.0264687Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zh4tl failed. Retrying in 30s.2026-08-29T04:30:38.0326198Z === NAME  TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-29T04:30:38.0328690Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)']' in pod test-cm-54b7d49f85-zh4tl failed. Retrying in 10s.2026-08-29T04:30:48.0204990Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-29T04:30:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_SINGULARITY]2026-08-29T04:30:48.0327770Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:30:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)']2026-08-29T04:30:48.1683199Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)']' in pod test-cm-54b7d49f85-zh4tl failed. Retrying in 10s.2026-08-29T04:30:48.1695704Z === NAME  TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-29T04:30:48.1697881Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-zh4tl failed. Retrying in 10s.2026-08-29T04:30:58.1684785Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:30:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)']2026-08-29T04:30:58.1700061Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-29T04:30:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_SINGULARITY]2026-08-29T04:30:58.3001320Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-29T04:30:58Z logger.go:67: true2026-08-29T04:30:58.3015387Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:30:58Z logger.go:67: Name                                                    OpSys      Arch     State     Activity LoadAv Mem     ActvtyTime2026-08-29T04:30:58.3017753Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:30:58Z logger.go:67: 2026-08-29T04:30:58.3020316Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:30:58Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-8tb4m LINUX      X86_64   Unclaimed Idle      0.000  15988  0+00:00:002026-08-29T04:30:58.3023555Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:30:58Z logger.go:67: 2026-08-29T04:30:58.3025867Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:30:58Z logger.go:67:                Total Owner Claimed Unclaimed Matched Preempting  Drain Backfill BkIdle2026-08-29T04:30:58.3028403Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:30:58Z logger.go:67: 2026-08-29T04:30:58.3030327Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:30:58Z logger.go:67:   X86_64/LINUX     1     0       0         1       0          0      0        0      02026-08-29T04:30:58.3032628Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:30:58Z logger.go:67: 2026-08-29T04:30:58.3036249Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:30:58Z logger.go:67:          Total     1     0       0         1       0          0      0        0      02026-08-29T04:31:08.0266795Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:31:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:31:08.1424964Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:31:08Z logger.go:67: undefined2026-08-29T04:31:08.1477823Z === NAME  TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-29T04:31:08.1479199Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zh4tl failed. Retrying in 30s.2026-08-29T04:31:38.1488779Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:31:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:31:38.2601487Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:31:38Z logger.go:67: undefined2026-08-29T04:31:38.2655977Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zh4tl failed. Retrying in 30s.2026-08-29T04:32:08.2665213Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:32:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:32:08.3784287Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:32:08Z logger.go:67: undefined2026-08-29T04:32:08.3845838Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zh4tl failed. Retrying in 30s.2026-08-29T04:32:38.3850145Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:32:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:32:38.4931568Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:32:38Z logger.go:67: undefined2026-08-29T04:32:38.5009315Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zh4tl failed. Retrying in 30s.2026-08-29T04:33:08.5010883Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:33:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:33:08.6098101Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:33:08Z logger.go:67: undefined2026-08-29T04:33:08.6151468Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zh4tl failed. Retrying in 30s.2026-08-29T04:33:38.6154545Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:33:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:33:38.7257562Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:33:38Z logger.go:67: undefined2026-08-29T04:33:38.7313617Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zh4tl failed. Retrying in 30s.2026-08-29T04:34:08.7334145Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:34:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:34:08.8528899Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:34:08Z logger.go:67: undefined2026-08-29T04:34:08.8594639Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zh4tl failed. Retrying in 30s.2026-08-29T04:34:38.8596245Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:34:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:34:38.9707806Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:34:38Z logger.go:67: undefined2026-08-29T04:34:38.9762943Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zh4tl failed. Retrying in 30s.2026-08-29T04:35:08.9775250Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:35:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:35:09.0933660Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:35:09Z logger.go:67: undefined2026-08-29T04:35:09.0984480Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zh4tl failed. Retrying in 30s.2026-08-29T04:35:39.1012363Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:35:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:35:39.2209597Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:35:39Z logger.go:67: undefined2026-08-29T04:35:39.2256114Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zh4tl failed. Retrying in 30s.2026-08-29T04:36:09.2283846Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:36:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums exec test-cm-54b7d49f85-zh4tl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8tb4m",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:36:09.3572020Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:36:09Z logger.go:67: true2026-08-29T04:36:09.3629171Z TestOSPoolEP 2026-08-29T04:36:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:36:09.3719228Z TestOSPoolEP 2026-08-29T04:36:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:36:09.4633141Z TestOSPoolEP 2026-08-29T04:36:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:36:09.5678135Z TestOSPoolEP 2026-08-29T04:36:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:36:09.6380497Z TestOSPoolEP 2026-08-29T04:36:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:36:09.6418244Z === NAME  TestOSPoolEP2026-08-29T04:36:09.6418930Z     ospool_ep_test.go:101: ---2026-08-29T04:36:09.6419535Z         Events for pod idtoken-generator:2026-08-29T04:36:09.6423512Z         2026-08-29 04:29:46 +0000 UTC	Normal	Successfully assigned test-ospool-ep-ha1ums/idtoken-generator to minikube2026-08-29T04:36:09.6424930Z         2026-08-29 04:29:48 +0000 UTC	Normal	Pulling image "htcondor/base"2026-08-29T04:36:09.6426733Z         2026-08-29 04:29:56 +0000 UTC	Normal	Successfully pulled image "htcondor/base" in 8.115s (8.115s including waiting). Image size: 522365028 bytes.2026-08-29T04:36:09.6428328Z         2026-08-29 04:29:56 +0000 UTC	Normal	Container created2026-08-29T04:36:09.6429235Z         2026-08-29 04:29:56 +0000 UTC	Normal	Container started2026-08-29T04:36:09.6429760Z         2026-08-29T04:36:09.6430112Z         ---2026-08-29T04:36:09.6431194Z TestOSPoolEP 2026-08-29T04:36:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:36:09.6453174Z     ospool_ep_test.go:101: ---2026-08-29T04:36:09.6454599Z         Events for pod ospool-ep-6c7d796845-8tb4m:2026-08-29T04:36:09.6456384Z         2026-08-29 04:30:07 +0000 UTC	Normal	Successfully assigned test-ospool-ep-ha1ums/ospool-ep-6c7d796845-8tb4m to minikube2026-08-29T04:36:09.6458515Z         2026-08-29 04:30:08 +0000 UTC	Normal	Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-29T04:36:09.6460580Z         2026-08-29 04:30:11 +0000 UTC	Normal	Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 3.512s (3.512s including waiting). Image size: 5590942 bytes.2026-08-29T04:36:09.6462723Z         2026-08-29 04:30:11 +0000 UTC	Normal	Container created2026-08-29T04:36:09.6463341Z         2026-08-29 04:30:11 +0000 UTC	Normal	Container started2026-08-29T04:36:09.6464500Z         2026-08-29 04:30:12 +0000 UTC	Normal	Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-08-29T04:36:09.6466298Z         2026-08-29 04:30:30 +0000 UTC	Normal	Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 13.657s (18.188s including waiting). Image size: 1288097653 bytes.2026-08-29T04:36:09.6467474Z         2026-08-29 04:30:30 +0000 UTC	Normal	Container created2026-08-29T04:36:09.6468231Z         2026-08-29 04:30:30 +0000 UTC	Normal	Container started2026-08-29T04:36:09.6468744Z         2026-08-29T04:36:09.6469093Z         ---2026-08-29T04:36:09.6470041Z TestOSPoolEP 2026-08-29T04:36:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:36:09.6479937Z     ospool_ep_test.go:101: ---2026-08-29T04:36:09.6480888Z         Events for pod test-cm-54b7d49f85-zh4tl:2026-08-29T04:36:09.6482309Z         2026-08-29 04:30:07 +0000 UTC	Normal	Successfully assigned test-ospool-ep-ha1ums/test-cm-54b7d49f85-zh4tl to minikube2026-08-29T04:36:09.6494026Z         2026-08-29 04:30:08 +0000 UTC	Normal	Pulling image "htcondor/cm:25.0-el9"2026-08-29T04:36:09.6498699Z         2026-08-29 04:30:17 +0000 UTC	Normal	Successfully pulled image "htcondor/cm:25.0-el9" in 5.267s (8.763s including waiting). Image size: 534362849 bytes.2026-08-29T04:36:09.6503335Z         2026-08-29 04:30:17 +0000 UTC	Normal	Container created2026-08-29T04:36:09.6504293Z         2026-08-29 04:30:17 +0000 UTC	Normal	Container started2026-08-29T04:36:09.6504837Z         2026-08-29T04:36:09.6507857Z         ---2026-08-29T04:36:09.6508975Z TestOSPoolEP 2026-08-29T04:36:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:36:09.6523688Z TestOSPoolEP 2026-08-29T04:36:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums delete -f /tmp/TestOSPoolEP1350552384]2026-08-29T04:36:09.7131176Z TestOSPoolEP 2026-08-29T04:36:09Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-ha1ums namespace2026-08-29T04:36:09.7169578Z TestOSPoolEP 2026-08-29T04:36:09Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-ha1ums namespace2026-08-29T04:36:10.8511801Z TestOSPoolEP 2026-08-29T04:36:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums delete -f /tmp/TestOSPoolEP863265462]2026-08-29T04:36:10.9225567Z TestOSPoolEP 2026-08-29T04:36:10Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-ha1ums namespace2026-08-29T04:36:10.9280658Z TestOSPoolEP 2026-08-29T04:36:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ha1ums delete -k /tmp/kustomize-template-125928751]2026-08-29T04:36:11.0119463Z TestOSPoolEP 2026-08-29T04:36:11Z logger.go:67: service "test-cm" deleted from test-ospool-ep-ha1ums namespace2026-08-29T04:36:11.0172448Z TestOSPoolEP 2026-08-29T04:36:11Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-ha1ums namespace2026-08-29T04:36:11.0214131Z TestOSPoolEP 2026-08-29T04:36:11Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-ha1ums namespace2026-08-29T04:36:11.0348313Z --- PASS: TestOSPoolEP (53.40s)2026-08-29T04:36:11.0354962Z     --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.03s)2026-08-29T04:36:11.0355991Z     --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.50s)2026-08-29T04:36:11.0358174Z     --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.50s)2026-08-29T04:36:11.0359945Z     --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (331.55s)2026-08-29T04:36:11.0362204Z PASS2026-08-29T04:36:11.0393903Z ok  	github.com/osg-htc/k8s-integration-tests/test	384.972s2026-08-29T04:36:11.1487737Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-29T04:36:11.1488432Z echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-29T04:36:11.1569107Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-29T04:36:11.1569475Z env:2026-08-29T04:36:11.1569698Z   GOTOOLCHAIN: local2026-08-29T04:36:11.1570164Z   TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-29T04:36:11.1570641Z ##[endgroup]2026-08-29T04:36:11.1774897Z 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-29T04:36:11.1776224Z ##[group]Run actions/upload-artifact@v42026-08-29T04:36:11.1776543Z with:2026-08-29T04:36:11.1776941Z   name: TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce72322026-08-29T04:36:11.1777678Z   path: /tmp/k8s-tests2026-08-29T04:36:11.1777923Z   retention-days: 52026-08-29T04:36:11.1778167Z   if-no-files-found: warn2026-08-29T04:36:11.1778418Z   compression-level: 62026-08-29T04:36:11.1778656Z   overwrite: false2026-08-29T04:36:11.1778888Z   include-hidden-files: false2026-08-29T04:36:11.1779149Z env:2026-08-29T04:36:11.1779351Z   GOTOOLCHAIN: local2026-08-29T04:36:11.1779581Z ##[endgroup]2026-08-29T04:36:11.4080522Z (node:17554) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-29T04:36:11.4082433Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-29T04:36:11.4312466Z With the provided path, there will be 6 files uploaded2026-08-29T04:36:11.4313342Z Artifact name is valid!2026-08-29T04:36:11.4313767Z Root directory input is valid!2026-08-29T04:36:11.6316653Z Beginning upload of artifact content to blob storage2026-08-29T04:36:11.6598780Z (node:17554) [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-29T04:36:11.7090163Z Uploaded bytes 140082026-08-29T04:36:11.7293191Z Finished uploading artifact content to blob storage!2026-08-29T04:36:11.7295759Z SHA256 digest of uploaded artifact zip is cd92acac7e486ba2f564b6cfa69bc8092137ddb11ecae0ac3d62229ff4a41cd92026-08-29T04:36:11.7297210Z Finalizing artifact upload2026-08-29T04:36:11.9284377Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232.zip successfully finalized. Artifact ID 97094073872026-08-29T04:36:11.9286798Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232 has been successfully uploaded! Final size is 14008 bytes. Artifact ID is 97094073872026-08-29T04:36:11.9291044Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/33233886885/artifacts/97094073872026-08-29T04:36:11.9602991Z Post job cleanup.2026-08-29T04:36:12.1016124Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOMODCACHE2026-08-29T04:36:12.1064563Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOCACHE2026-08-29T04:36:12.1103802Z /home/runner/go/pkg/mod2026-08-29T04:36:12.1137847Z /home/runner/.cache/go-build2026-08-29T04:36:12.1143513Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-29T04:36:12.1320130Z Post job cleanup.2026-08-29T04:36:12.2360664Z [command]/usr/bin/git version2026-08-29T04:36:12.2405475Z git version 2.55.02026-08-29T04:36:12.2448538Z Temporarily overriding HOME='/home/runner/work/_temp/6ffa37b3-280c-4866-bb2e-1f5eebd9e4ae' before making global git config changes2026-08-29T04:36:12.2450270Z Adding repository directory to the temporary git global config as a safe directory2026-08-29T04:36:12.2454989Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-29T04:36:12.2501152Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-29T04:36:12.2541498Z [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-29T04:36:12.2859851Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-29T04:36:12.2893248Z http.https://github.com/.extraheader2026-08-29T04:36:12.2905620Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-29T04:36:12.2950596Z [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-29T04:36:12.3256405Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-29T04:36:12.3303301Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-29T04:36:12.3771971Z Cleaning up orphan processes2026-08-29T04:36:12.4546683Z ##[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/