2026-08-30T01:56:52.4479440Z Current runner version: '2.336.0'2026-08-30T01:56:52.4502714Z ##[group]Runner Image Provisioner2026-08-30T01:56:52.4503600Z Hosted Compute Agent2026-08-30T01:56:52.4504219Z Version: 20260819.5862026-08-30T01:56:52.4504845Z Commit: 3cc4a88dfa507ef76119ad1bb3eccc6378bb2b762026-08-30T01:56:52.4505528Z Build Date: 2026-08-18T23:20:18Z2026-08-30T01:56:52.4506227Z Worker ID: {3be8c17b-6d98-4c5f-9139-16dcce9de429}2026-08-30T01:56:52.4506912Z Azure Region: westus32026-08-30T01:56:52.4507515Z ##[endgroup]2026-08-30T01:56:52.4508992Z ##[group]Operating System2026-08-30T01:56:52.4509569Z Ubuntu2026-08-30T01:56:52.4510119Z 22.04.52026-08-30T01:56:52.4510604Z LTS2026-08-30T01:56:52.4511097Z ##[endgroup]2026-08-30T01:56:52.4511641Z ##[group]Runner Image2026-08-30T01:56:52.4512216Z Image: ubuntu-22.042026-08-30T01:56:52.4512779Z Version: 20260824.273.32026-08-30T01:56:52.4513983Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260824.273/images/ubuntu/Ubuntu2204-Readme.md2026-08-30T01:56:52.4515468Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260824.2732026-08-30T01:56:52.4516381Z ##[endgroup]2026-08-30T01:56:52.4519524Z ##[group]GITHUB_TOKEN Permissions2026-08-30T01:56:52.4521987Z Actions: write2026-08-30T01:56:52.4522890Z ArtifactMetadata: write2026-08-30T01:56:52.4523491Z Attestations: write2026-08-30T01:56:52.4524036Z Checks: write2026-08-30T01:56:52.4524567Z CodeQuality: write2026-08-30T01:56:52.4525114Z Contents: write2026-08-30T01:56:52.4525698Z CopilotRequests: write2026-08-30T01:56:52.4526264Z Deployments: write2026-08-30T01:56:52.4526802Z Discussions: write2026-08-30T01:56:52.4527329Z Drives: write2026-08-30T01:56:52.4527851Z Issues: write2026-08-30T01:56:52.4528377Z Metadata: read2026-08-30T01:56:52.4529198Z Models: read2026-08-30T01:56:52.4529696Z Packages: write2026-08-30T01:56:52.4530257Z Pages: write2026-08-30T01:56:52.4530888Z PullRequests: write2026-08-30T01:56:52.4531486Z RepositoryProjects: write2026-08-30T01:56:52.4532102Z SecurityEvents: write2026-08-30T01:56:52.4532628Z Statuses: write2026-08-30T01:56:52.4533227Z VulnerabilityAlerts: read2026-08-30T01:56:52.4533791Z ##[endgroup]2026-08-30T01:56:52.4535859Z Secret source: Actions2026-08-30T01:56:52.4536895Z Prepare workflow directory2026-08-30T01:56:52.4851104Z Prepare all required actions2026-08-30T01:56:52.4902345Z Getting action download info2026-08-30T01:56:52.8446381Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-30T01:56:53.0197855Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-30T01:56:53.6044157Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-30T01:56:54.4279697Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-30T01:56:54.7696900Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-30T01:56:54.7701377Z ##[group] Inputs2026-08-30T01:56:54.7701930Z testName: TestOSPoolEP2026-08-30T01:56:54.7702566Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-30T01:56:54.7703267Z setupScript: 2026-08-30T01:56:54.7703642Z setupEnv: {}2026-08-30T01:56:54.7703993Z ##[endgroup]2026-08-30T01:56:54.7704531Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-08-30T01:56:54.8312091Z ##[group]Run actions/checkout@v52026-08-30T01:56:54.8312772Z with:2026-08-30T01:56:54.8313212Z repository: osg-htc/k8s-integration-tests2026-08-30T01:56:54.8316126Z token: ***2026-08-30T01:56:54.8316541Z ssh-strict: true2026-08-30T01:56:54.8316926Z ssh-user: git2026-08-30T01:56:54.8317307Z persist-credentials: true2026-08-30T01:56:54.8317711Z clean: true2026-08-30T01:56:54.8318084Z sparse-checkout-cone-mode: true2026-08-30T01:56:54.8318926Z fetch-depth: 12026-08-30T01:56:54.8319289Z fetch-tags: false2026-08-30T01:56:54.8319646Z show-progress: true2026-08-30T01:56:54.8320070Z lfs: false2026-08-30T01:56:54.8320419Z submodules: false2026-08-30T01:56:54.8320813Z set-safe-directory: true2026-08-30T01:56:54.8321220Z allow-unsafe-pr-checkout: false2026-08-30T01:56:54.8321823Z ##[endgroup]2026-08-30T01:56:54.9340429Z Syncing repository: osg-htc/k8s-integration-tests2026-08-30T01:56:54.9342366Z ##[group]Getting Git version info2026-08-30T01:56:54.9343495Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-30T01:56:54.9344607Z [command]/usr/bin/git version2026-08-30T01:56:54.9382445Z git version 2.55.02026-08-30T01:56:54.9403142Z ##[endgroup]2026-08-30T01:56:54.9416491Z Temporarily overriding HOME='/home/runner/work/_temp/72e6e2ab-995e-421d-b40e-ef6afcdf9ab1' before making global git config changes2026-08-30T01:56:54.9421816Z Adding repository directory to the temporary git global config as a safe directory2026-08-30T01:56:54.9423221Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-30T01:56:54.9453953Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-30T01:56:54.9457970Z ##[group]Initializing the repository2026-08-30T01:56:54.9463545Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-30T01:56:54.9578898Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-30T01:56:54.9580161Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-30T01:56:54.9581548Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-30T01:56:54.9583724Z hint: call:2026-08-30T01:56:54.9584683Z hint:2026-08-30T01:56:54.9585572Z hint: git config --global init.defaultBranch <name>2026-08-30T01:56:54.9586579Z hint:2026-08-30T01:56:54.9587432Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-30T01:56:54.9588955Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-30T01:56:54.9590033Z hint:2026-08-30T01:56:54.9590848Z hint: git branch -m <name>2026-08-30T01:56:54.9591690Z hint:2026-08-30T01:56:54.9592698Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-30T01:56:54.9594126Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-30T01:56:54.9597560Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-08-30T01:56:54.9619572Z ##[endgroup]2026-08-30T01:56:54.9620900Z ##[group]Disabling automatic garbage collection2026-08-30T01:56:54.9623576Z [command]/usr/bin/git config --local gc.auto 02026-08-30T01:56:54.9651381Z ##[endgroup]2026-08-30T01:56:54.9652515Z ##[group]Setting up auth2026-08-30T01:56:54.9657527Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-30T01:56:54.9685982Z [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-30T01:56:54.9975870Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-30T01:56:55.0006237Z [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-30T01:56:55.0204049Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-30T01:56:55.0234132Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-30T01:56:55.0434376Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-30T01:56:55.0500500Z ##[endgroup]2026-08-30T01:56:55.0501563Z ##[group]Fetching the repository2026-08-30T01:56:55.0502940Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-30T01:56:55.5529463Z From https://github.com/osg-htc/k8s-integration-tests2026-08-30T01:56:55.5530392Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-30T01:56:55.5533463Z ##[endgroup]2026-08-30T01:56:55.5534292Z ##[group]Determining the checkout info2026-08-30T01:56:55.5536097Z ##[endgroup]2026-08-30T01:56:55.5541532Z [command]/usr/bin/git sparse-checkout disable2026-08-30T01:56:55.5790621Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-30T01:56:55.5817168Z ##[group]Checking out the ref2026-08-30T01:56:55.5820811Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-30T01:56:55.5883619Z Switched to a new branch 'main'2026-08-30T01:56:55.5884696Z branch 'main' set up to track 'origin/main'.2026-08-30T01:56:55.5890077Z ##[endgroup]2026-08-30T01:56:55.5922607Z [command]/usr/bin/git log -1 --format=%H2026-08-30T01:56:55.5944819Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-30T01:56:55.6149912Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-30T01:56:55.6150761Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-30T01:56:55.6151413Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-30T01:56:55.6839145Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-30T01:56:55.6839615Z env:2026-08-30T01:56:55.6840324Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-30T01:56:55.6840902Z SETUP_ENV_YAML: {}2026-08-30T01:56:55.6841305Z ##[endgroup]2026-08-30T01:56:55.8614450Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-30T01:56:55.8615181Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-30T01:56:55.8654660Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-30T01:56:55.8655097Z env:2026-08-30T01:56:55.8655667Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-30T01:56:55.8656223Z ##[endgroup]2026-08-30T01:56:55.8766312Z ##[group]Run true2026-08-30T01:56:55.8766688Z [36;1mtrue[0m2026-08-30T01:56:55.8798941Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-30T01:56:55.8799517Z ##[endgroup]2026-08-30T01:56:55.8938494Z ##[group]Run medyagh/setup-minikube@latest2026-08-30T01:56:55.8939082Z with:2026-08-30T01:56:55.8939388Z start: true2026-08-30T01:56:55.8939690Z cache: true2026-08-30T01:56:55.8940067Z minikube-version: latest2026-08-30T01:56:55.8940412Z wait: all2026-08-30T01:56:55.8940697Z ##[endgroup]2026-08-30T01:56:56.0207477Z (node:1642) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-30T01:56:56.0209172Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-30T01:56:56.9961329Z [command]/usr/bin/chmod +x /home/runner/work/_temp/49476e65-3557-4a7f-ab4a-7060b246402d2026-08-30T01:56:57.6881758Z [command]/home/runner/bin/minikube version --short2026-08-30T01:56:57.7453462Z v1.38.12026-08-30T01:56:57.9577994Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-30T01:56:57.9674154Z (node:1642) [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-30T01:56:57.9691580Z Cache hit for: kic-v1.38.1-x642026-08-30T01:56:59.1855761Z Received 62914560 of 224218830 (28.1%), 59.9 MBs/sec2026-08-30T01:57:00.2052092Z Received 224218830 of 224218830 (100.0%), 105.8 MBs/sec2026-08-30T01:57:00.2052969Z Cache Size: ~214 MB (224218830 B)2026-08-30T01:57:00.2085108Z [command]/usr/bin/tar -xf /home/runner/work/_temp/bc5561fd-67a0-4f89-be28-884eb692148c/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-30T01:57:00.7216329Z Cache restored successfully2026-08-30T01:57:04.1799480Z Received 88080384 of 544082637 (16.2%), 84.0 MBs/sec2026-08-30T01:57:05.1801143Z Received 268435456 of 544082637 (49.3%), 128.0 MBs/sec2026-08-30T01:57:06.1910287Z Received 520093696 of 544082637 (95.6%), 165.0 MBs/sec2026-08-30T01:57:06.3915708Z Received 544082637 of 544082637 (100.0%), 161.5 MBs/sec2026-08-30T01:57:06.3916518Z Cache Size: ~519 MB (544082637 B)2026-08-30T01:57:06.3950787Z [command]/usr/bin/tar -xf /home/runner/work/_temp/e40efc7a-af51-4d2e-bf45-7abd49307136/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-30T01:57:06.9669962Z Cache restored successfully2026-08-30T01:57:07.0362186Z [command]/home/runner/bin/minikube start --wait all2026-08-30T01:57:07.0786567Z * minikube v1.38.1 on Ubuntu 22.042026-08-30T01:57:09.4266903Z * Automatically selected the docker driver. Other choices: podman, ssh, none2026-08-30T01:57:09.4711389Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-30T01:57:09.4722677Z * Using Docker driver with root privileges2026-08-30T01:57:09.4802790Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-30T01:57:09.4813886Z * Pulling base image v0.0.50 ...2026-08-30T01:57:45.1720309Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-30T01:57:49.3264860Z * Verifying Kubernetes components...2026-08-30T01:57:49.3527551Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-30T01:57:49.8576284Z * Enabled addons: storage-provisioner, default-storageclass2026-08-30T01:58:30.5769742Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-30T01:58:30.5930443Z [command]/home/runner/bin/minikube version --short2026-08-30T01:58:30.6317619Z v1.38.12026-08-30T01:58:30.6556224Z ##[group]Run actions/setup-go@v62026-08-30T01:58:30.6556634Z with:2026-08-30T01:58:30.6556976Z go-version: 1.262026-08-30T01:58:30.6557319Z cache: true2026-08-30T01:58:30.6557654Z cache-dependency-path: go.sum2026-08-30T01:58:30.6558012Z check-latest: false2026-08-30T01:58:30.6560882Z token: ***2026-08-30T01:58:30.6561227Z ##[endgroup]2026-08-30T01:58:30.7871725Z Setup go version spec 1.262026-08-30T01:58:30.8931850Z Found in cache @ /opt/hostedtoolcache/go/1.26.7/x642026-08-30T01:58:30.8934043Z Added go to the path2026-08-30T01:58:30.8937787Z Successfully set up Go version 1.262026-08-30T01:58:31.0466421Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOMODCACHE2026-08-30T01:58:31.0505926Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOCACHE2026-08-30T01:58:31.0538985Z /home/runner/go/pkg/mod2026-08-30T01:58:31.0557136Z /home/runner/.cache/go-build2026-08-30T01:58:31.2814564Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-30T01:58:32.5523294Z Received 58720256 of 251715014 (23.3%), 55.9 MBs/sec2026-08-30T01:58:33.5528925Z Received 218103808 of 251715014 (86.6%), 103.9 MBs/sec2026-08-30T01:58:33.7685100Z Received 251715014 of 251715014 (100.0%), 108.2 MBs/sec2026-08-30T01:58:33.7685856Z Cache Size: ~240 MB (251715014 B)2026-08-30T01:58:33.7764087Z [command]/usr/bin/tar -xf /home/runner/work/_temp/33876155-c196-4f87-bf7d-2103f4c16799/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-30T01:58:35.6511802Z Cache restored successfully2026-08-30T01:58:35.6849082Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-30T01:58:35.6875663Z go version go1.26.7 linux/amd642026-08-30T01:58:35.6876079Z 2026-08-30T01:58:35.6876568Z ##[group]go env2026-08-30T01:58:35.7082749Z AR='ar'2026-08-30T01:58:35.7083206Z CC='gcc'2026-08-30T01:58:35.7083749Z CGO_CFLAGS='-O2 -g'2026-08-30T01:58:35.7084313Z CGO_CPPFLAGS=''2026-08-30T01:58:35.7084887Z CGO_CXXFLAGS='-O2 -g'2026-08-30T01:58:35.7085381Z CGO_ENABLED='1'2026-08-30T01:58:35.7085881Z CGO_FFLAGS='-O2 -g'2026-08-30T01:58:35.7086299Z CGO_LDFLAGS='-O2 -g'2026-08-30T01:58:35.7086801Z CXX='g++'2026-08-30T01:58:35.7087216Z GCCGO='gccgo'2026-08-30T01:58:35.7087742Z GO111MODULE=''2026-08-30T01:58:35.7088211Z GOAMD64='v1'2026-08-30T01:58:35.7088809Z GOARCH='amd64'2026-08-30T01:58:35.7089148Z GOAUTH='netrc'2026-08-30T01:58:35.7089473Z GOBIN=''2026-08-30T01:58:35.7089822Z GOCACHE='/home/runner/.cache/go-build'2026-08-30T01:58:35.7090277Z GOCACHEPROG=''2026-08-30T01:58:35.7090589Z GODEBUG=''2026-08-30T01:58:35.7090965Z GOENV='/home/runner/.config/go/env'2026-08-30T01:58:35.7091331Z GOEXE=''2026-08-30T01:58:35.7091682Z GOEXPERIMENT=''2026-08-30T01:58:35.7092001Z GOFIPS140='off'2026-08-30T01:58:35.7092349Z GOFLAGS=''2026-08-30T01:58:35.7093148Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build4242929334=/tmp/go-build -gno-record-gcc-switches'2026-08-30T01:58:35.7093942Z GOHOSTARCH='amd64'2026-08-30T01:58:35.7094324Z GOHOSTOS='linux'2026-08-30T01:58:35.7094611Z GOINSECURE=''2026-08-30T01:58:35.7095137Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-30T01:58:35.7095652Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-30T01:58:35.7096077Z GONOPROXY=''2026-08-30T01:58:35.7096375Z GONOSUMDB=''2026-08-30T01:58:35.7096726Z GOOS='linux'2026-08-30T01:58:35.7097048Z GOPATH='/home/runner/go'2026-08-30T01:58:35.7097417Z GOPRIVATE=''2026-08-30T01:58:35.7097803Z GOPROXY='https://proxy.golang.org,direct'2026-08-30T01:58:35.7098252Z GOROOT='/opt/hostedtoolcache/go/1.26.7/x64'2026-08-30T01:58:35.7098836Z GOSUMDB='sum.golang.org'2026-08-30T01:58:35.7099203Z GOTELEMETRY='local'2026-08-30T01:58:35.7099604Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-30T01:58:35.7100031Z GOTMPDIR=''2026-08-30T01:58:35.7100602Z GOTOOLCHAIN='local'2026-08-30T01:58:35.7101084Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.7/x64/pkg/tool/linux_amd64'2026-08-30T01:58:35.7101603Z GOVCS=''2026-08-30T01:58:35.7101918Z GOVERSION='go1.26.7'2026-08-30T01:58:35.7102273Z GOWORK=''2026-08-30T01:58:35.7102626Z PKG_CONFIG='pkg-config'2026-08-30T01:58:35.7102842Z 2026-08-30T01:58:35.7103284Z ##[endgroup]2026-08-30T01:58:35.7265058Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-30T01:58:35.7265781Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-30T01:58:35.7315457Z shell: /usr/bin/bash -e {0}2026-08-30T01:58:35.7316029Z env:2026-08-30T01:58:35.7316358Z GOTOOLCHAIN: local2026-08-30T01:58:35.7316775Z OSPOOL_EP_OSPoolEPTag: 25-release2026-08-30T01:58:35.7317155Z OSPOOL_EP_CMTag: 25.0-el92026-08-30T01:58:35.7317617Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-30T01:58:35.7317975Z ##[endgroup]2026-08-30T01:58:40.4205024Z === RUN TestOSPoolEP2026-08-30T01:58:40.4205615Z === PAUSE TestOSPoolEP2026-08-30T01:58:40.4206215Z === CONT TestOSPoolEP2026-08-30T01:58:40.4207118Z TestOSPoolEP 2026-08-30T01:58:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:58:40.4293344Z TestOSPoolEP 2026-08-30T01:58:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo apply -f /tmp/TestOSPoolEP2039265088]2026-08-30T01:58:40.6265973Z TestOSPoolEP 2026-08-30T01:58:40Z logger.go:67: pod/idtoken-generator created2026-08-30T01:58:40.6509052Z TestOSPoolEP 2026-08-30T01:58:40Z logger.go:67: secret/pool-passwd created2026-08-30T01:58:40.6544082Z TestOSPoolEP 2026-08-30T01:58:40Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-30T01:58:40.6575538Z TestOSPoolEP 2026-08-30T01:58:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:58:40.6678905Z TestOSPoolEP 2026-08-30T01:58:40Z 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-30T01:58:50.6688748Z TestOSPoolEP 2026-08-30T01:58:50Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-30T01:58:50.6694125Z TestOSPoolEP 2026-08-30T01:58:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:58:50.6724207Z TestOSPoolEP 2026-08-30T01:58:50Z 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-30T01:59:00.6725818Z TestOSPoolEP 2026-08-30T01:59:00Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-30T01:59:00.6727332Z TestOSPoolEP 2026-08-30T01:59:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:59:00.6753608Z TestOSPoolEP 2026-08-30T01:59:00Z logger.go:67: Pod is now available2026-08-30T01:59:00.6755374Z TestOSPoolEP 2026-08-30T01:59:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-30T01:59:00.7745061Z TestOSPoolEP 2026-08-30T01:59:00Z logger.go:67: ***2026-08-30T01:59:00.7767608Z TestOSPoolEP 2026-08-30T01:59:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo apply -f /tmp/TestOSPoolEP1866425827]2026-08-30T01:59:00.8650115Z TestOSPoolEP 2026-08-30T01:59:00Z logger.go:67: secret/pool-token created2026-08-30T01:59:00.8676697Z TestOSPoolEP 2026-08-30T01:59:00Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-30T01:59:00.8677968Z TestOSPoolEP 2026-08-30T01:59:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:59:00.8701568Z TestOSPoolEP 2026-08-30T01:59:00Z logger.go:67: Secret is now available2026-08-30T01:59:00.8715189Z TestOSPoolEP 2026-08-30T01:59:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo apply -k /tmp/kustomize-template-768427290]2026-08-30T01:59:00.9915021Z TestOSPoolEP 2026-08-30T01:59:00Z logger.go:67: service/test-cm created2026-08-30T01:59:01.0020309Z TestOSPoolEP 2026-08-30T01:59:01Z 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-30T01:59:01.0022220Z TestOSPoolEP 2026-08-30T01:59:01Z logger.go:67: deployment.apps/ospool-ep created2026-08-30T01:59:01.0115798Z TestOSPoolEP 2026-08-30T01:59:01Z logger.go:67: deployment.apps/test-cm created2026-08-30T01:59:01.0138952Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-30T01:59:01.0168109Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:59:01.0249321Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:01Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-30T01:59:01.0269397Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:59:01.0271147Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:01Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-30T01:59:01.0272928Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:59:01.0332315Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:01Z 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-30T01:59:01.0335956Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:01Z 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-54b7d49f85". Sleeping for 10s and will try again.2026-08-30T01:59:11.0352120Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:11Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-30T01:59:11.0353928Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:59:11.0355870Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:11Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-30T01:59:11.0357553Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:59:11.0373197Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:11Z 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-30T01:59:11.0378449Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:11Z 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: ReplicaSetUpdated, message: ReplicaSet "test-cm-54b7d49f85" is progressing.. Sleeping for 10s and will try again.2026-08-30T01:59:21.0380895Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:21Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-30T01:59:21.0383130Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:59:21.0384665Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:21Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-30T01:59:21.0385986Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:59:21.0410343Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:21Z logger.go:67: Deployment is now available2026-08-30T01:59:21.0412369Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:21Z 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-30T01:59:31.0420090Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:31Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-30T01:59:31.0421314Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:59:31.0449768Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:31Z 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-30T01:59:41.0466007Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:41Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-30T01:59:41.0468061Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:59:41.0493258Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-30T01:59:41Z logger.go:67: Deployment is now available2026-08-30T01:59:41.0506421Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-30T01:59:41.0507532Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-30T01:59:41.0508280Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-30T01:59:41.0509324Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-30T01:59:41.0510114Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-30T01:59:41.0510906Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-30T01:59:41.0511788Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-30T01:59:41.0512801Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-30T01:59:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:59:41.0513710Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-30T01:59:41.0514236Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-30T01:59:41.0515205Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T01:59:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:59:41.0516898Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-30T01:59:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:59:41.0532917Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-30T01:59:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:59:41.0535477Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T01:59:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:59:41.0537595Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-30T01:59:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T01:59:41.0548877Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-30T01:59:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)']2026-08-30T01:59:41.0573446Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T01:59:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-30T01:59:41.0582486Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-30T01:59:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_SINGULARITY]2026-08-30T01:59:41.1989215Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-30T01:59:41.1992831Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-x29rt failed. Retrying in 30s.2026-08-30T01:59:41.2006103Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-30T01:59:41.2007468Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)']' in pod test-cm-54b7d49f85-x29rt failed. Retrying in 10s.2026-08-30T01:59:41.2058171Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-30T01:59:41.2059889Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-x29rt failed. Retrying in 10s.2026-08-30T01:59:51.2009874Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-30T01:59:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)']2026-08-30T01:59:51.2062529Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-30T01:59:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_SINGULARITY]2026-08-30T01:59:51.3199937Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-x29rt failed. Retrying in 10s.2026-08-30T01:59:51.3208432Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-30T01:59:51.3210417Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)']' in pod test-cm-54b7d49f85-x29rt failed. Retrying in 10s.2026-08-30T02:00:01.3211650Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-30T02:00:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_SINGULARITY]2026-08-30T02:00:01.3215701Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-30T02:00:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)']2026-08-30T02:00:01.4375679Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-30T02:00:01Z logger.go:67: true2026-08-30T02:00:01.4391926Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-30T02:00:01Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-30T02:00:01.4396073Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-30T02:00:01Z logger.go:67: 2026-08-30T02:00:01.4397931Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-30T02:00:01Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-fm7gp LINUX X86_64 Unclaimed Idle 0.000 15987 0+00:00:002026-08-30T02:00:01.4399776Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-30T02:00:01Z logger.go:67: 2026-08-30T02:00:01.4401274Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-30T02:00:01Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-30T02:00:01.4402563Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-30T02:00:01Z logger.go:67: 2026-08-30T02:00:01.4403799Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-30T02:00:01Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-30T02:00:01.4404955Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-30T02:00:01Z logger.go:67: 2026-08-30T02:00:01.4406627Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-30T02:00:01Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-30T02:00:11.1996678Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:00:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-30T02:00:11.2968493Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:00:11Z logger.go:67: undefined2026-08-30T02:00:11.3010223Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-30T02:00:11.3011586Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-x29rt failed. Retrying in 30s.2026-08-30T02:00:41.3014265Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:00:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-30T02:00:41.3997494Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:00:41Z logger.go:67: undefined2026-08-30T02:00:41.4051661Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-x29rt failed. Retrying in 30s.2026-08-30T02:01:11.4053326Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:01:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-30T02:01:11.5037418Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:01:11Z logger.go:67: undefined2026-08-30T02:01:11.5072615Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-x29rt failed. Retrying in 30s.2026-08-30T02:01:41.5076313Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:01:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-30T02:01:41.6009505Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:01:41Z logger.go:67: undefined2026-08-30T02:01:41.6047660Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-x29rt failed. Retrying in 30s.2026-08-30T02:02:11.6054946Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:02:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-30T02:02:11.7043369Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:02:11Z logger.go:67: undefined2026-08-30T02:02:11.7077198Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-x29rt failed. Retrying in 30s.2026-08-30T02:02:41.7086129Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:02:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-30T02:02:41.8036782Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:02:41Z logger.go:67: undefined2026-08-30T02:02:41.8076920Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-x29rt failed. Retrying in 30s.2026-08-30T02:03:11.8081100Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:03:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-30T02:03:11.9031970Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:03:11Z logger.go:67: undefined2026-08-30T02:03:11.9070544Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-x29rt failed. Retrying in 30s.2026-08-30T02:03:41.9074615Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:03:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-30T02:03:42.0095772Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:03:42Z logger.go:67: undefined2026-08-30T02:03:42.0131037Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-x29rt failed. Retrying in 30s.2026-08-30T02:04:12.0138774Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:04:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-30T02:04:12.1143994Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:04:12Z logger.go:67: undefined2026-08-30T02:04:12.1181558Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-x29rt failed. Retrying in 30s.2026-08-30T02:04:42.1198051Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:04:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-30T02:04:42.2190862Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:04:42Z logger.go:67: undefined2026-08-30T02:04:42.2227635Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-x29rt failed. Retrying in 30s.2026-08-30T02:05:12.2230685Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:05:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo exec test-cm-54b7d49f85-x29rt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-fm7gp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-30T02:05:12.3309144Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-30T02:05:12Z logger.go:67: true2026-08-30T02:05:12.3347189Z TestOSPoolEP 2026-08-30T02:05:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T02:05:12.3415993Z TestOSPoolEP 2026-08-30T02:05:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T02:05:12.4103619Z TestOSPoolEP 2026-08-30T02:05:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T02:05:12.4856028Z TestOSPoolEP 2026-08-30T02:05:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T02:05:12.5513116Z TestOSPoolEP 2026-08-30T02:05:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T02:05:12.5540829Z === NAME TestOSPoolEP2026-08-30T02:05:12.5542101Z ospool_ep_test.go:101: ---2026-08-30T02:05:12.5542869Z Events for pod idtoken-generator:2026-08-30T02:05:12.5544130Z 2026-08-30 01:58:40 +0000 UTC Normal Successfully assigned test-ospool-ep-cvkabo/idtoken-generator to minikube2026-08-30T02:05:12.5545188Z 2026-08-30 01:58:47 +0000 UTC Normal Pulling image "htcondor/base"2026-08-30T02:05:12.5546988Z 2026-08-30 01:58:56 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.624s (8.624s including waiting). Image size: 522365028 bytes.2026-08-30T02:05:12.5548077Z 2026-08-30 01:58:56 +0000 UTC Normal Container created2026-08-30T02:05:12.5549102Z 2026-08-30 01:58:56 +0000 UTC Normal Container started2026-08-30T02:05:12.5549755Z 2026-08-30T02:05:12.5550261Z ---2026-08-30T02:05:12.5550977Z TestOSPoolEP 2026-08-30T02:05:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T02:05:12.5565103Z ospool_ep_test.go:101: ---2026-08-30T02:05:12.5566000Z Events for pod ospool-ep-6c7d796845-fm7gp:2026-08-30T02:05:12.5568363Z 2026-08-30 01:59:01 +0000 UTC Normal Successfully assigned test-ospool-ep-cvkabo/ospool-ep-6c7d796845-fm7gp to minikube2026-08-30T02:05:12.5570053Z 2026-08-30 01:59:01 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-30T02:05:12.5571780Z 2026-08-30 01:59:04 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 2.744s (2.744s including waiting). Image size: 5590942 bytes.2026-08-30T02:05:12.5572792Z 2026-08-30 01:59:04 +0000 UTC Normal Container created2026-08-30T02:05:12.5573737Z 2026-08-30 01:59:04 +0000 UTC Normal Container started2026-08-30T02:05:12.5574811Z 2026-08-30 01:59:04 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-08-30T02:05:12.5576845Z 2026-08-30 01:59:31 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 20.599s (26.649s including waiting). Image size: 1288097653 bytes.2026-08-30T02:05:12.5578277Z 2026-08-30 01:59:31 +0000 UTC Normal Container created2026-08-30T02:05:12.5579346Z 2026-08-30 01:59:31 +0000 UTC Normal Container started2026-08-30T02:05:12.5580145Z 2026-08-30T02:05:12.5580645Z ---2026-08-30T02:05:12.5581893Z TestOSPoolEP 2026-08-30T02:05:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T02:05:12.5590405Z ospool_ep_test.go:101: ---2026-08-30T02:05:12.5591320Z Events for pod test-cm-54b7d49f85-x29rt:2026-08-30T02:05:12.5592756Z 2026-08-30 01:59:01 +0000 UTC Normal Successfully assigned test-ospool-ep-cvkabo/test-cm-54b7d49f85-x29rt to minikube2026-08-30T02:05:12.5594086Z 2026-08-30 01:59:01 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-08-30T02:05:12.5595728Z 2026-08-30 01:59:10 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 6.742s (9.467s including waiting). Image size: 534362849 bytes.2026-08-30T02:05:12.5596942Z 2026-08-30 01:59:10 +0000 UTC Normal Container created2026-08-30T02:05:12.5597892Z 2026-08-30 01:59:11 +0000 UTC Normal Container started2026-08-30T02:05:12.5598409Z 2026-08-30T02:05:12.5599215Z ---2026-08-30T02:05:12.5600097Z TestOSPoolEP 2026-08-30T02:05:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-30T02:05:12.5630579Z TestOSPoolEP 2026-08-30T02:05:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo delete -f /tmp/TestOSPoolEP1451123431]2026-08-30T02:05:12.6191026Z TestOSPoolEP 2026-08-30T02:05:12Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-cvkabo namespace2026-08-30T02:05:12.6270411Z TestOSPoolEP 2026-08-30T02:05:12Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-cvkabo namespace2026-08-30T02:05:14.0573284Z TestOSPoolEP 2026-08-30T02:05:14Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo delete -f /tmp/TestOSPoolEP1391496432]2026-08-30T02:05:14.1071845Z TestOSPoolEP 2026-08-30T02:05:14Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-cvkabo namespace2026-08-30T02:05:14.1098906Z TestOSPoolEP 2026-08-30T02:05:14Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-cvkabo delete -k /tmp/kustomize-template-768427290]2026-08-30T02:05:14.1768805Z TestOSPoolEP 2026-08-30T02:05:14Z logger.go:67: service "test-cm" deleted from test-ospool-ep-cvkabo namespace2026-08-30T02:05:14.1818158Z TestOSPoolEP 2026-08-30T02:05:14Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-cvkabo namespace2026-08-30T02:05:14.1852896Z TestOSPoolEP 2026-08-30T02:05:14Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-cvkabo namespace2026-08-30T02:05:14.1952133Z --- PASS: TestOSPoolEP (62.49s)2026-08-30T02:05:14.1954665Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (40.04s)2026-08-30T02:05:14.1955840Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.39s)2026-08-30T02:05:14.1969733Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.39s)2026-08-30T02:05:14.1970842Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (331.29s)2026-08-30T02:05:14.1971895Z PASS2026-08-30T02:05:14.1989640Z ok github.com/osg-htc/k8s-integration-tests/test 393.790s2026-08-30T02:05:14.2740079Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-30T02:05:14.2741149Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-30T02:05:14.2801326Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-30T02:05:14.2801927Z env:2026-08-30T02:05:14.2802492Z GOTOOLCHAIN: local2026-08-30T02:05:14.2803160Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-30T02:05:14.2803990Z ##[endgroup]2026-08-30T02:05:14.2989949Z 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-30T02:05:14.2991459Z ##[group]Run actions/upload-artifact@v42026-08-30T02:05:14.2991858Z with:2026-08-30T02:05:14.2992409Z name: TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce72322026-08-30T02:05:14.2992981Z path: /tmp/k8s-tests2026-08-30T02:05:14.2993507Z retention-days: 52026-08-30T02:05:14.2993931Z if-no-files-found: warn2026-08-30T02:05:14.2994454Z compression-level: 62026-08-30T02:05:14.2994898Z overwrite: false2026-08-30T02:05:14.2995249Z include-hidden-files: false2026-08-30T02:05:14.2995677Z env:2026-08-30T02:05:14.2995979Z GOTOOLCHAIN: local2026-08-30T02:05:14.2996360Z ##[endgroup]2026-08-30T02:05:14.4974544Z (node:17412) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-30T02:05:14.4975953Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-30T02:05:14.5076890Z With the provided path, there will be 6 files uploaded2026-08-30T02:05:14.5082085Z Artifact name is valid!2026-08-30T02:05:14.5082944Z Root directory input is valid!2026-08-30T02:05:14.8596794Z Beginning upload of artifact content to blob storage2026-08-30T02:05:14.8871886Z (node:17412) [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-30T02:05:15.1889099Z Uploaded bytes 141152026-08-30T02:05:15.2591829Z Finished uploading artifact content to blob storage!2026-08-30T02:05:15.2593085Z SHA256 digest of uploaded artifact zip is 16e6add2dcf3f02e87cd5287f6f2b10a0f93bc9dbfcf003547464da44fa261862026-08-30T02:05:15.2594268Z Finalizing artifact upload2026-08-30T02:05:15.5123176Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232.zip successfully finalized. Artifact ID 97247784862026-08-30T02:05:15.5124663Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232 has been successfully uploaded! Final size is 14115 bytes. Artifact ID is 97247784862026-08-30T02:05:15.5130751Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/33286821905/artifacts/97247784862026-08-30T02:05:15.5285964Z Post job cleanup.2026-08-30T02:05:15.6516982Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOMODCACHE2026-08-30T02:05:15.6561392Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOCACHE2026-08-30T02:05:15.6586846Z /home/runner/go/pkg/mod2026-08-30T02:05:15.6609573Z /home/runner/.cache/go-build2026-08-30T02:05:15.6617557Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-30T02:05:15.6761415Z Post job cleanup.2026-08-30T02:05:15.7670463Z [command]/usr/bin/git version2026-08-30T02:05:15.7721268Z git version 2.55.02026-08-30T02:05:15.7766015Z Temporarily overriding HOME='/home/runner/work/_temp/22b0bb37-1f65-4e73-a65b-833b25df1d95' before making global git config changes2026-08-30T02:05:15.7767776Z Adding repository directory to the temporary git global config as a safe directory2026-08-30T02:05:15.7772593Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-30T02:05:15.7819187Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-30T02:05:15.7888162Z [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-30T02:05:15.8124463Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-30T02:05:15.8144712Z http.https://github.com/.extraheader2026-08-30T02:05:15.8158033Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-30T02:05:15.8189050Z [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-30T02:05:15.8397497Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-30T02:05:15.8425298Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-30T02:05:15.8789884Z Cleaning up orphan processes2026-08-30T02:05:15.9539819Z ##[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/