2026-10-24T02:10:02.9708986Z Current runner version: '2.338.0'2026-10-24T02:10:02.9734055Z ##[group]Runner Image Provisioner2026-10-24T02:10:02.9735001Z Hosted Compute Agent2026-10-24T02:10:02.9735976Z Version: 20261012.6012026-10-24T02:10:02.9736729Z Commit: f3dc54e1fb89da6852db922499a0233137369e1d2026-10-24T02:10:02.9737530Z Build Date: 2026-10-12T17:48:21Z2026-10-24T02:10:02.9738278Z Worker ID: {1b03d013-92a2-40bf-ad4d-74e67817d1b3}2026-10-24T02:10:02.9739012Z Region: westus2026-10-24T02:10:02.9739645Z Cloud: Azure2026-10-24T02:10:02.9740210Z ##[endgroup]2026-10-24T02:10:02.9741681Z ##[group]Operating System2026-10-24T02:10:02.9742503Z Ubuntu2026-10-24T02:10:02.9743056Z 22.04.52026-10-24T02:10:02.9743653Z LTS2026-10-24T02:10:02.9744260Z ##[endgroup]2026-10-24T02:10:02.9744814Z ##[group]Runner Image2026-10-24T02:10:02.9745743Z Image: ubuntu-22.042026-10-24T02:10:02.9746342Z Version: 20261012.322.12026-10-24T02:10:02.9747715Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20261012.322/images/ubuntu/Ubuntu2204-Readme.md2026-10-24T02:10:02.9749367Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20261012.3222026-10-24T02:10:02.9750433Z ##[endgroup]2026-10-24T02:10:02.9753491Z ##[group]GITHUB_TOKEN Permissions2026-10-24T02:10:02.9756455Z Actions: write2026-10-24T02:10:02.9757162Z ArtifactMetadata: write2026-10-24T02:10:02.9757909Z Attestations: write2026-10-24T02:10:02.9758510Z Checks: write2026-10-24T02:10:02.9759079Z CodeQuality: write2026-10-24T02:10:02.9759734Z Contents: write2026-10-24T02:10:02.9760313Z CopilotRequests: write2026-10-24T02:10:02.9760978Z Deployments: write2026-10-24T02:10:02.9761582Z Discussions: write2026-10-24T02:10:02.9762172Z Drives: write2026-10-24T02:10:02.9762790Z Issues: write2026-10-24T02:10:02.9763502Z Metadata: read2026-10-24T02:10:02.9764119Z Models: read2026-10-24T02:10:02.9764710Z Packages: write2026-10-24T02:10:02.9765606Z Pages: write2026-10-24T02:10:02.9766331Z PullRequests: write2026-10-24T02:10:02.9766988Z RepositoryProjects: write2026-10-24T02:10:02.9767651Z SecurityEvents: write2026-10-24T02:10:02.9768390Z Statuses: write2026-10-24T02:10:02.9769057Z VulnerabilityAlerts: read2026-10-24T02:10:02.9769862Z ##[endgroup]2026-10-24T02:10:02.9772007Z Secret source: Actions2026-10-24T02:10:02.9773147Z Cache mode: write2026-10-24T02:10:02.9773983Z Prepare workflow directory2026-10-24T02:10:03.0115048Z Prepare all required actions2026-10-24T02:10:03.0165001Z Getting action download info2026-10-24T02:10:03.4030678Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-10-24T02:10:03.5212329Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-10-24T02:10:03.8514597Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-10-24T02:10:04.2517267Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-10-24T02:10:04.4976232Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (63ec080e4eea87fb8a9eae678ab9944ec2461251)2026-10-24T02:10:04.4981259Z ##[group] Inputs2026-10-24T02:10:04.4981801Z testName: TestOSPoolEP2026-10-24T02:10:04.4982687Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-24T02:10:04.4983605Z setupScript: 2026-10-24T02:10:04.4984033Z setupEnv: {}2026-10-24T02:10:04.4984468Z ##[endgroup]2026-10-24T02:10:04.4985155Z Complete job name: ospool-ep / Run OSPool EP test (cvmfs-bind, 25-testing) / Run Tests2026-10-24T02:10:04.5743477Z ##[group]Run actions/checkout@v52026-10-24T02:10:04.5744352Z with:2026-10-24T02:10:04.5744817Z repository: osg-htc/k8s-integration-tests2026-10-24T02:10:04.5748921Z token: ***2026-10-24T02:10:04.5749352Z ssh-strict: true2026-10-24T02:10:04.5750077Z ssh-user: git2026-10-24T02:10:04.5750522Z persist-credentials: true2026-10-24T02:10:04.5750988Z clean: true2026-10-24T02:10:04.5751685Z sparse-checkout-cone-mode: true2026-10-24T02:10:04.5752196Z fetch-depth: 12026-10-24T02:10:04.5752610Z fetch-tags: false2026-10-24T02:10:04.5753037Z show-progress: true2026-10-24T02:10:04.5753470Z lfs: false2026-10-24T02:10:04.5753863Z submodules: false2026-10-24T02:10:04.5754293Z set-safe-directory: true2026-10-24T02:10:04.5754783Z allow-unsafe-pr-checkout: false2026-10-24T02:10:04.5755977Z ##[endgroup]2026-10-24T02:10:04.6818855Z Syncing repository: osg-htc/k8s-integration-tests2026-10-24T02:10:04.6821592Z ##[group]Getting Git version info2026-10-24T02:10:04.6823066Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-24T02:10:04.6824987Z [command]/usr/bin/git version2026-10-24T02:10:04.6926514Z git version 2.55.02026-10-24T02:10:04.6940446Z ##[endgroup]2026-10-24T02:10:04.6957929Z Temporarily overriding HOME='/home/runner/work/_temp/56d147b8-0f4b-4c85-82b6-b395954ae5e6' before making global git config changes2026-10-24T02:10:04.6960441Z Adding repository directory to the temporary git global config as a safe directory2026-10-24T02:10:04.6966678Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-24T02:10:04.7016802Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-24T02:10:04.7022360Z ##[group]Initializing the repository2026-10-24T02:10:04.7027872Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-24T02:10:04.7182488Z hint: Using 'master' as the name for the initial branch. This default branch name2026-10-24T02:10:04.7184525Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-10-24T02:10:04.7186793Z hint: to use in all of your new repositories, which will suppress this warning,2026-10-24T02:10:04.7188409Z hint: call:2026-10-24T02:10:04.7189453Z hint:2026-10-24T02:10:04.7190628Z hint: git config --global init.defaultBranch <name>2026-10-24T02:10:04.7191889Z hint:2026-10-24T02:10:04.7193049Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-10-24T02:10:04.7196238Z hint: 'development'. The just-created branch can be renamed via this command:2026-10-24T02:10:04.7197803Z hint:2026-10-24T02:10:04.7198731Z hint: git branch -m <name>2026-10-24T02:10:04.7199912Z hint:2026-10-24T02:10:04.7200946Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-10-24T02:10:04.7202976Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-10-24T02:10:04.7207119Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-10-24T02:10:04.7240448Z ##[endgroup]2026-10-24T02:10:04.7241835Z ##[group]Disabling automatic garbage collection2026-10-24T02:10:04.7245594Z [command]/usr/bin/git config --local gc.auto 02026-10-24T02:10:04.7281607Z ##[endgroup]2026-10-24T02:10:04.7283001Z ##[group]Setting up auth2026-10-24T02:10:04.7289901Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-24T02:10:04.7329693Z [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-10-24T02:10:04.7825086Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-24T02:10:04.7867632Z [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-10-24T02:10:04.8135964Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-24T02:10:04.8176747Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-24T02:10:04.8437766Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-10-24T02:10:04.8485867Z ##[endgroup]2026-10-24T02:10:04.8486766Z ##[group]Fetching the repository2026-10-24T02:10:04.8494629Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +63ec080e4eea87fb8a9eae678ab9944ec2461251:refs/remotes/origin/main2026-10-24T02:10:05.3276975Z From https://github.com/osg-htc/k8s-integration-tests2026-10-24T02:10:05.3278657Z * [new ref] 63ec080e4eea87fb8a9eae678ab9944ec2461251 -> origin/main2026-10-24T02:10:05.3281875Z ##[endgroup]2026-10-24T02:10:05.3282971Z ##[group]Determining the checkout info2026-10-24T02:10:05.3284766Z ##[endgroup]2026-10-24T02:10:05.3290995Z [command]/usr/bin/git sparse-checkout disable2026-10-24T02:10:05.3346194Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-10-24T02:10:05.3382365Z ##[group]Checking out the ref2026-10-24T02:10:05.3386204Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-10-24T02:10:05.3516723Z Switched to a new branch 'main'2026-10-24T02:10:05.3526867Z branch 'main' set up to track 'origin/main'.2026-10-24T02:10:05.3530423Z ##[endgroup]2026-10-24T02:10:05.3653060Z [command]/usr/bin/git log -1 --format=%H2026-10-24T02:10:05.3655077Z 63ec080e4eea87fb8a9eae678ab9944ec24612512026-10-24T02:10:05.3882798Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-24T02:10:05.3885083Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-24T02:10:05.3887622Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-24T02:10:05.4439843Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-24T02:10:05.4441019Z env:2026-10-24T02:10:05.4442497Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-24T02:10:05.4444404Z SETUP_ENV_YAML: {}2026-10-24T02:10:05.4445052Z ##[endgroup]2026-10-24T02:10:06.7837568Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-24T02:10:06.7838311Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-10-24T02:10:06.7914769Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-24T02:10:06.7915206Z env:2026-10-24T02:10:06.7916006Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfs-bind"}2026-10-24T02:10:06.7916816Z ##[endgroup]2026-10-24T02:10:06.8079332Z ##[group]Run true2026-10-24T02:10:06.8079637Z [36;1mtrue[0m2026-10-24T02:10:06.8148819Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-24T02:10:06.8149232Z ##[endgroup]2026-10-24T02:10:06.8343761Z ##[group]Run medyagh/setup-minikube@latest2026-10-24T02:10:06.8344126Z with:2026-10-24T02:10:06.8344374Z start: true2026-10-24T02:10:06.8344607Z cache: true2026-10-24T02:10:06.8344873Z minikube-version: latest2026-10-24T02:10:06.8345161Z wait: all2026-10-24T02:10:06.8345590Z ##[endgroup]2026-10-24T02:10:06.9640216Z (node:2170) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-24T02:10:06.9641615Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-24T02:10:08.7598858Z [command]/usr/bin/chmod +x /home/runner/work/_temp/e5d1d496-a684-484b-b2be-cccd07d15e452026-10-24T02:10:08.9460096Z [command]/home/runner/bin/minikube version --short2026-10-24T02:10:09.0010910Z v1.39.02026-10-24T02:10:09.2497333Z Cache hit for: preloaded-tarball-v1.39.0-x64-stable-docker2026-10-24T02:10:09.2505123Z Cache hit for: kic-v1.39.0-x642026-10-24T02:10:09.2609978Z (node:2170) [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-10-24T02:10:10.5376744Z Received 8388608 of 531630645 (1.6%), 8.0 MBs/sec2026-10-24T02:10:10.5509069Z Received 4194304 of 288577004 (1.5%), 4.0 MBs/sec2026-10-24T02:10:11.5331491Z Received 117440512 of 531630645 (22.1%), 56.0 MBs/sec2026-10-24T02:10:11.5516726Z Received 125829120 of 288577004 (43.6%), 60.0 MBs/sec2026-10-24T02:10:12.5396625Z Received 205520896 of 531630645 (38.7%), 65.2 MBs/sec2026-10-24T02:10:12.5533558Z Received 226492416 of 288577004 (78.5%), 71.9 MBs/sec2026-10-24T02:10:13.2591776Z Received 288577004 of 288577004 (100.0%), 74.3 MBs/sec2026-10-24T02:10:13.2616108Z Cache Size: ~275 MB (288577004 B)2026-10-24T02:10:13.3110203Z [command]/usr/bin/tar -xf /home/runner/work/_temp/41d8e285-aafc-4654-98ba-5081effcbd81/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-24T02:10:13.5468328Z Received 318767104 of 531630645 (60.0%), 75.7 MBs/sec2026-10-24T02:10:14.1839019Z Cache restored successfully2026-10-24T02:10:14.5501632Z Received 440401920 of 531630645 (82.8%), 83.7 MBs/sec2026-10-24T02:10:15.1098220Z Received 531630645 of 531630645 (100.0%), 90.9 MBs/sec2026-10-24T02:10:15.1099213Z Cache Size: ~507 MB (531630645 B)2026-10-24T02:10:15.1173859Z [command]/usr/bin/tar -xf /home/runner/work/_temp/1a7ae518-f0eb-475b-bdc5-de7be94ac610/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-24T02:10:16.0161945Z Cache restored successfully2026-10-24T02:10:16.1368115Z [command]/home/runner/bin/minikube start --wait all2026-10-24T02:10:16.1857574Z * minikube v1.39.0 on Ubuntu 22.042026-10-24T02:10:16.8140054Z ! The minimum required version for podman is "4.9.0". your version is "3.4.4". minikube might not work. use at your own risk. To install latest version please see https://podman.io/getting-started/installation.html2026-10-24T02:10:16.8188748Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-10-24T02:10:16.8842298Z * Using Docker driver with root privileges2026-10-24T02:10:16.8851057Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-10-24T02:10:16.8857303Z * Pulling base image v0.0.51 ...2026-10-24T02:10:38.8106152Z * Preparing Kubernetes v1.37.0 on containerd 2.3.4 ...2026-10-24T02:10:46.1864105Z * Configuring CNI (Container Networking Interface) ...2026-10-24T02:10:52.0619071Z * Verifying Kubernetes components...2026-10-24T02:10:52.0863321Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-10-24T02:10:52.6853504Z * Enabled addons: storage-provisioner, default-storageclass2026-10-24T02:11:14.8026703Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-10-24T02:11:14.8167165Z [command]/home/runner/bin/minikube version --short2026-10-24T02:11:14.8671543Z v1.39.02026-10-24T02:11:14.9058844Z ##[group]Run actions/setup-go@v62026-10-24T02:11:14.9059130Z with:2026-10-24T02:11:14.9059354Z go-version: 1.262026-10-24T02:11:14.9059571Z cache: true2026-10-24T02:11:14.9059802Z cache-dependency-path: go.sum2026-10-24T02:11:14.9060072Z check-latest: false2026-10-24T02:11:14.9062468Z token: ***2026-10-24T02:11:14.9062677Z ##[endgroup]2026-10-24T02:11:15.0430713Z Setup go version spec 1.262026-10-24T02:11:15.0791896Z Found in cache @ /opt/hostedtoolcache/go/1.26.9/x642026-10-24T02:11:15.0794283Z Added go to the path2026-10-24T02:11:15.0797921Z Successfully set up Go version 1.262026-10-24T02:11:17.5197427Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOMODCACHE2026-10-24T02:11:17.5235994Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOCACHE2026-10-24T02:11:17.5270404Z /home/runner/go/pkg/mod2026-10-24T02:11:17.5294592Z /home/runner/.cache/go-build2026-10-24T02:11:17.7770770Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-24T02:11:19.0715989Z Received 0 of 249167808 (0.0%), 0.0 MBs/sec2026-10-24T02:11:20.0730633Z Received 117440512 of 249167808 (47.1%), 55.8 MBs/sec2026-10-24T02:11:21.0733752Z Received 205520896 of 249167808 (82.5%), 65.2 MBs/sec2026-10-24T02:11:21.5788479Z Received 249167808 of 249167808 (100.0%), 67.7 MBs/sec2026-10-24T02:11:21.5790468Z Cache Size: ~238 MB (249167808 B)2026-10-24T02:11:21.5855778Z [command]/usr/bin/tar -xf /home/runner/work/_temp/814f20cf-a153-4e44-b2b5-6877013f19da/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-24T02:11:24.7864759Z Cache restored successfully2026-10-24T02:11:24.8419249Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-24T02:11:24.8449365Z go version go1.26.9 linux/amd642026-10-24T02:11:24.8449703Z 2026-10-24T02:11:24.8450180Z ##[group]go env2026-10-24T02:11:24.9053370Z AR='ar'2026-10-24T02:11:24.9053800Z CC='gcc'2026-10-24T02:11:24.9054258Z CGO_CFLAGS='-O2 -g'2026-10-24T02:11:24.9054694Z CGO_CPPFLAGS=''2026-10-24T02:11:24.9055090Z CGO_CXXFLAGS='-O2 -g'2026-10-24T02:11:24.9055767Z CGO_ENABLED='1'2026-10-24T02:11:24.9056140Z CGO_FFLAGS='-O2 -g'2026-10-24T02:11:24.9056510Z CGO_LDFLAGS='-O2 -g'2026-10-24T02:11:24.9056871Z CXX='g++'2026-10-24T02:11:24.9057215Z GCCGO='gccgo'2026-10-24T02:11:24.9057560Z GO111MODULE=''2026-10-24T02:11:24.9057907Z GOAMD64='v1'2026-10-24T02:11:24.9058266Z GOARCH='amd64'2026-10-24T02:11:24.9058615Z GOAUTH='netrc'2026-10-24T02:11:24.9058949Z GOBIN=''2026-10-24T02:11:24.9059347Z GOCACHE='/home/runner/.cache/go-build'2026-10-24T02:11:24.9059838Z GOCACHEPROG=''2026-10-24T02:11:24.9060191Z GODEBUG=''2026-10-24T02:11:24.9060584Z GOENV='/home/runner/.config/go/env'2026-10-24T02:11:24.9061047Z GOEXE=''2026-10-24T02:11:24.9061385Z GOEXPERIMENT=''2026-10-24T02:11:24.9061773Z GOFIPS140='off'2026-10-24T02:11:24.9062130Z GOFLAGS=''2026-10-24T02:11:24.9063265Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build4157091339=/tmp/go-build -gno-record-gcc-switches'2026-10-24T02:11:24.9064420Z GOHOSTARCH='amd64'2026-10-24T02:11:24.9064797Z GOHOSTOS='linux'2026-10-24T02:11:24.9065141Z GOINSECURE=''2026-10-24T02:11:24.9066028Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-10-24T02:11:24.9066758Z GOMODCACHE='/home/runner/go/pkg/mod'2026-10-24T02:11:24.9067218Z GONOPROXY=''2026-10-24T02:11:24.9067552Z GONOSUMDB=''2026-10-24T02:11:24.9067887Z GOOS='linux'2026-10-24T02:11:24.9068226Z GOPATH='/home/runner/go'2026-10-24T02:11:24.9068632Z GOPRIVATE=''2026-10-24T02:11:24.9069068Z GOPROXY='https://proxy.golang.org,direct'2026-10-24T02:11:24.9069638Z GOROOT='/opt/hostedtoolcache/go/1.26.9/x64'2026-10-24T02:11:24.9070168Z GOSUMDB='sum.golang.org'2026-10-24T02:11:24.9070586Z GOTELEMETRY='local'2026-10-24T02:11:24.9071468Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-10-24T02:11:24.9072007Z GOTMPDIR=''2026-10-24T02:11:24.9072375Z GOTOOLCHAIN='local'2026-10-24T02:11:24.9072933Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.9/x64/pkg/tool/linux_amd64'2026-10-24T02:11:24.9073567Z GOVCS=''2026-10-24T02:11:24.9073911Z GOVERSION='go1.26.9'2026-10-24T02:11:24.9074287Z GOWORK=''2026-10-24T02:11:24.9074635Z PKG_CONFIG='pkg-config'2026-10-24T02:11:24.9074872Z 2026-10-24T02:11:24.9075674Z ##[endgroup]2026-10-24T02:11:24.9339272Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-24T02:11:24.9339824Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-10-24T02:11:24.9410377Z shell: /usr/bin/bash -e {0}2026-10-24T02:11:24.9410655Z env:2026-10-24T02:11:24.9410856Z GOTOOLCHAIN: local2026-10-24T02:11:24.9411117Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-10-24T02:11:24.9411401Z OSPOOL_EP_CMTag: 25.x-el92026-10-24T02:11:24.9411662Z OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-24T02:11:24.9411923Z ##[endgroup]2026-10-24T02:11:37.4004137Z === RUN TestOSPoolEP2026-10-24T02:11:37.4004986Z === PAUSE TestOSPoolEP2026-10-24T02:11:37.4006471Z === CONT TestOSPoolEP2026-10-24T02:11:37.4009512Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:37.4103818Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui apply -f /tmp/TestOSPoolEP632487313]2026-10-24T02:11:37.9148170Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: pod/idtoken-generator created2026-10-24T02:11:37.9277751Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: secret/pool-passwd created2026-10-24T02:11:37.9326023Z TestOSPoolEP 2026-10-24T02:11:37Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-24T02:11:37.9327402Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:37.9347743Z TestOSPoolEP 2026-10-24T02:11:37Z 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-10-24T02:11:47.9357102Z TestOSPoolEP 2026-10-24T02:11:47Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-24T02:11:47.9358488Z TestOSPoolEP 2026-10-24T02:11:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:47.9382939Z TestOSPoolEP 2026-10-24T02:11:47Z logger.go:67: Pod is now available2026-10-24T02:11:47.9385172Z TestOSPoolEP 2026-10-24T02:11:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-10-24T02:11:48.8358642Z TestOSPoolEP 2026-10-24T02:11:48Z logger.go:67: ***2026-10-24T02:11:48.8426641Z TestOSPoolEP 2026-10-24T02:11:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui apply -f /tmp/TestOSPoolEP1938794500]2026-10-24T02:11:49.0442547Z TestOSPoolEP 2026-10-24T02:11:49Z logger.go:67: secret/pool-token created2026-10-24T02:11:49.0482359Z TestOSPoolEP 2026-10-24T02:11:49Z retry.go:91: Wait for secret pool-token to be provisioned.2026-10-24T02:11:49.0483582Z TestOSPoolEP 2026-10-24T02:11:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:49.0506493Z TestOSPoolEP 2026-10-24T02:11:49Z logger.go:67: Secret is now available2026-10-24T02:11:49.0542291Z TestOSPoolEP 2026-10-24T02:11:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui apply -k /tmp/kustomize-template-3867634950]2026-10-24T02:11:49.4703190Z TestOSPoolEP 2026-10-24T02:11:49Z logger.go:67: serviceaccount/cvmfs-nodeplugin created2026-10-24T02:11:49.4789158Z TestOSPoolEP 2026-10-24T02:11:49Z logger.go:67: service/frontier-squid created2026-10-24T02:11:49.4883578Z TestOSPoolEP 2026-10-24T02:11:49Z logger.go:67: service/test-cm created2026-10-24T02:11:49.4956099Z TestOSPoolEP 2026-10-24T02:11:49Z logger.go:67: deployment.apps/cvmfs-nodeplugin created2026-10-24T02:11:49.5035381Z TestOSPoolEP 2026-10-24T02:11:49Z logger.go:67: deployment.apps/frontier-squid created2026-10-24T02:11:49.5195032Z TestOSPoolEP 2026-10-24T02:11:49Z logger.go:67: Warning: spec.template.spec.containers[0].env[6]: hides previous definition of "OSG_SQUID_LOCATION", which may be dropped when using apply2026-10-24T02:11:49.5200757Z TestOSPoolEP 2026-10-24T02:11:49Z logger.go:67: deployment.apps/ospool-ep created2026-10-24T02:11:49.5527398Z TestOSPoolEP 2026-10-24T02:11:49Z logger.go:67: deployment.apps/test-cm created2026-10-24T02:11:49.5529586Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-10-24T02:11:49.5532058Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:49.5579092Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:49Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-24T02:11:49.5581990Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:49.5584730Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:49Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-24T02:11:49.5587627Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:49.5590445Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:49Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-24T02:11:49.5592942Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:49.5601214Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:49Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-24T02:11:49.5603698Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:49.5648757Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:49Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-674fbdcc48". Sleeping for 10s and will try again.2026-10-24T02:11:49.5723680Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:49Z 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-10-24T02:11:49.5731574Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:49Z retry.go:103: Wait for deployment frontier-squid to be provisioned. returned an error: Deployment frontier-squid is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "frontier-squid-65f85c968" is progressing.. Sleeping for 10s and will try again.2026-10-24T02:11:49.5738847Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:49Z retry.go:103: Wait for deployment cvmfs-nodeplugin to be provisioned. returned an error: Deployment cvmfs-nodeplugin is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "cvmfs-nodeplugin-5cd89c7cfd" is progressing.. Sleeping for 10s and will try again.2026-10-24T02:11:59.5669588Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:59Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-24T02:11:59.5671637Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:59.5691886Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:59Z 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-674fbdcc48" is progressing.. Sleeping for 10s and will try again.2026-10-24T02:11:59.5748938Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:59Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-24T02:11:59.5767366Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:59.5771551Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:59Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-24T02:11:59.5775259Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:59.5779507Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:59Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-24T02:11:59.5783013Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:59.5791916Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:59Z 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-5886f7986" is progressing.. Sleeping for 10s and will try again.2026-10-24T02:11:59.5798154Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:59Z retry.go:103: Wait for deployment frontier-squid to be provisioned. returned an error: Deployment frontier-squid is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "frontier-squid-65f85c968" is progressing.. Sleeping for 10s and will try again.2026-10-24T02:11:59.5802417Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:59Z logger.go:67: Deployment is now available2026-10-24T02:12:09.5709089Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:09Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-24T02:12:09.5712132Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:12:09.5752411Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:09Z 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-674fbdcc48" is progressing.. Sleeping for 10s and will try again.2026-10-24T02:12:09.5779936Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:09Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-24T02:12:09.5797106Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:09Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-24T02:12:09.5799098Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:12:09.5807551Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:12:09.5818399Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:09Z 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-5886f7986" is progressing.. Sleeping for 10s and will try again.2026-10-24T02:12:09.5828114Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:09Z logger.go:67: Deployment is now available2026-10-24T02:12:19.5771778Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:19Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-24T02:12:19.5773721Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:12:19.5805541Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:19Z 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-674fbdcc48" is progressing.. Sleeping for 10s and will try again.2026-10-24T02:12:19.5825206Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:19Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-24T02:12:19.5827346Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:12:19.5880403Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:19Z logger.go:67: Deployment is now available2026-10-24T02:12:29.5809951Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:29Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-24T02:12:29.5812323Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:12:29.5839443Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:29Z logger.go:67: Deployment is now available2026-10-24T02:12:29.5842387Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP2026-10-24T02:12:29.5844097Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-24T02:12:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:12:29.5871952Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-24T02:12:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui cp ../test-configs/ospool-ep/condor_status.sh test-cm-5886f7986-wtgwz:/tmp/condor_status.sh]2026-10-24T02:12:30.0208174Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-24T02:12:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui exec test-cm-5886f7986-wtgwz -- chmod +x /tmp/condor_status.sh]2026-10-24T02:12:30.2164120Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-24T02:12:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui exec test-cm-5886f7986-wtgwz -- sh -c /tmp/condor_status.sh]2026-10-24T02:12:30.4494250Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-24T02:12:30Z logger.go:67: command terminated with exit code 12026-10-24T02:12:30.4542054Z test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-5886f7986-wtgwz failed. Retrying in 10s.2026-10-24T02:12:40.4569371Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-24T02:12:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui exec test-cm-5886f7986-wtgwz -- sh -c /tmp/condor_status.sh]2026-10-24T02:12:40.6694877Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity2026-10-24T02:12:40.6702850Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-24T02:12:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:12:40.6726434Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-24T02:12:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui cp ../test-configs/ospool-ep/has_singularity.sh test-cm-5886f7986-wtgwz:/tmp/has_singularity.sh]2026-10-24T02:12:40.9021965Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-24T02:12:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui exec test-cm-5886f7986-wtgwz -- chmod +x /tmp/has_singularity.sh]2026-10-24T02:12:41.0965743Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-24T02:12:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui exec test-cm-5886f7986-wtgwz -- sh -c /tmp/has_singularity.sh]2026-10-24T02:12:41.2847515Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-10-24T02:12:41.2849328Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:12:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:12:41.2874902Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:12:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui cp ../test-configs/ospool-ep/has_cvmfs.sh test-cm-5886f7986-wtgwz:/tmp/has_cvmfs.sh]2026-10-24T02:12:41.5493887Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:12:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui exec test-cm-5886f7986-wtgwz -- chmod +x /tmp/has_cvmfs.sh]2026-10-24T02:12:41.7236274Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:12:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui exec test-cm-5886f7986-wtgwz -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:12:41.9062296Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:12:41Z logger.go:67: command terminated with exit code 12026-10-24T02:12:41.9098697Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-wtgwz failed. Retrying in 30s.2026-10-24T02:13:11.9105187Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:13:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui exec test-cm-5886f7986-wtgwz -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:13:12.0835487Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:13:12Z logger.go:67: command terminated with exit code 12026-10-24T02:13:12.0868890Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-wtgwz failed. Retrying in 30s.2026-10-24T02:13:42.0879034Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:13:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui exec test-cm-5886f7986-wtgwz -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:13:42.2408452Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:13:42Z logger.go:67: command terminated with exit code 12026-10-24T02:13:42.2433282Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-wtgwz failed. Retrying in 30s.2026-10-24T02:14:12.2440313Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:14:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui exec test-cm-5886f7986-wtgwz -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:14:12.4132248Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:14:12Z logger.go:67: command terminated with exit code 12026-10-24T02:14:12.4175779Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-wtgwz failed. Retrying in 30s.2026-10-24T02:14:42.4180153Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:14:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui exec test-cm-5886f7986-wtgwz -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:14:42.5674372Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:14:42Z logger.go:67: command terminated with exit code 12026-10-24T02:14:42.5707247Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-wtgwz failed. Retrying in 30s.2026-10-24T02:15:12.5714201Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:15:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui exec test-cm-5886f7986-wtgwz -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:15:12.7199012Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:15:12Z logger.go:67: command terminated with exit code 12026-10-24T02:15:12.7240018Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-wtgwz failed. Retrying in 30s.2026-10-24T02:15:42.7279103Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:15:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui exec test-cm-5886f7986-wtgwz -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:15:42.8839417Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:15:42Z logger.go:67: command terminated with exit code 12026-10-24T02:15:42.8873995Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-wtgwz failed. Retrying in 30s.2026-10-24T02:16:12.8925884Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:16:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui exec test-cm-5886f7986-wtgwz -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:16:13.0428032Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:16:13Z logger.go:67: command terminated with exit code 12026-10-24T02:16:13.0461627Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-wtgwz failed. Retrying in 30s.2026-10-24T02:16:43.0465986Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:16:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui exec test-cm-5886f7986-wtgwz -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:16:43.1935194Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:16:43Z logger.go:67: command terminated with exit code 12026-10-24T02:16:43.1969200Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-wtgwz failed. Retrying in 30s.2026-10-24T02:17:13.2024058Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:17:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui exec test-cm-5886f7986-wtgwz -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:17:13.3543726Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:17:13Z logger.go:67: command terminated with exit code 12026-10-24T02:17:13.3577011Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-wtgwz failed. Retrying in 30s.2026-10-24T02:17:43.3629886Z test_utils.go:105: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-wtgwz did not succeed within {10 30000000000} retries2026-10-24T02:17:43.3631785Z TestOSPoolEP 2026-10-24T02:17:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:43.3709045Z TestOSPoolEP 2026-10-24T02:17:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:43.5504855Z TestOSPoolEP 2026-10-24T02:17:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:43.6665704Z TestOSPoolEP 2026-10-24T02:17:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:43.7902164Z TestOSPoolEP 2026-10-24T02:17:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:43.9281408Z TestOSPoolEP 2026-10-24T02:17:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:44.0398738Z TestOSPoolEP 2026-10-24T02:17:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:44.0426856Z === NAME TestOSPoolEP2026-10-24T02:17:44.0427786Z ospool_ep_test.go:72: ---2026-10-24T02:17:44.0428652Z Events for pod cvmfs-nodeplugin-5cd89c7cfd-chdsr:2026-10-24T02:17:44.0430418Z 2026-10-24 02:11:49 +0000 UTC Normal Successfully assigned test-ospool-ep-7qazui/cvmfs-nodeplugin-5cd89c7cfd-chdsr to minikube2026-10-24T02:17:44.0432184Z 2026-10-24 02:11:49 +0000 UTC Normal Pulling image "opensciencegrid/cvmfs-nodeplugin:fresh"2026-10-24T02:17:44.0434294Z 2026-10-24 02:11:55 +0000 UTC Normal Successfully pulled image "opensciencegrid/cvmfs-nodeplugin:fresh" in 5.578s (5.578s including waiting). Image size: 155940803 bytes.2026-10-24T02:17:44.0435924Z 2026-10-24 02:11:55 +0000 UTC Normal Container created2026-10-24T02:17:44.0436686Z 2026-10-24 02:11:55 +0000 UTC Normal Container started2026-10-24T02:17:44.0437291Z 2026-10-24T02:17:44.0437703Z ---2026-10-24T02:17:44.0438463Z TestOSPoolEP 2026-10-24T02:17:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:44.0454217Z ospool_ep_test.go:72: ---2026-10-24T02:17:44.0455112Z Events for pod frontier-squid-65f85c968-r4pfp:2026-10-24T02:17:44.0456906Z 2026-10-24 02:11:49 +0000 UTC Normal Successfully assigned test-ospool-ep-7qazui/frontier-squid-65f85c968-r4pfp to minikube2026-10-24T02:17:44.0458623Z 2026-10-24 02:11:49 +0000 UTC Normal Pulling image "opensciencegrid/frontier-squid:fresh"2026-10-24T02:17:44.0460836Z 2026-10-24 02:12:06 +0000 UTC Normal Successfully pulled image "opensciencegrid/frontier-squid:fresh" in 10.834s (16.342s including waiting). Image size: 453187319 bytes.2026-10-24T02:17:44.0462332Z 2026-10-24 02:12:06 +0000 UTC Normal Container created2026-10-24T02:17:44.0463008Z 2026-10-24 02:12:06 +0000 UTC Normal Container started2026-10-24T02:17:44.0463356Z 2026-10-24T02:17:44.0463592Z ---2026-10-24T02:17:44.0464176Z TestOSPoolEP 2026-10-24T02:17:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:44.0482567Z ospool_ep_test.go:72: ---2026-10-24T02:17:44.0483563Z Events for pod idtoken-generator:2026-10-24T02:17:44.0485030Z 2026-10-24 02:11:37 +0000 UTC Normal Successfully assigned test-ospool-ep-7qazui/idtoken-generator to minikube2026-10-24T02:17:44.0486770Z 2026-10-24 02:11:38 +0000 UTC Normal Pulling image "htcondor/base"2026-10-24T02:17:44.0488567Z 2026-10-24 02:11:44 +0000 UTC Normal Successfully pulled image "htcondor/base" in 6.327s (6.327s including waiting). Image size: 196303183 bytes.2026-10-24T02:17:44.0490183Z 2026-10-24 02:11:44 +0000 UTC Normal Container created2026-10-24T02:17:44.0491431Z 2026-10-24 02:11:44 +0000 UTC Normal Container started2026-10-24T02:17:44.0492356Z 2026-10-24T02:17:44.0492864Z ---2026-10-24T02:17:44.0493987Z TestOSPoolEP 2026-10-24T02:17:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:44.0506431Z ospool_ep_test.go:72: ---2026-10-24T02:17:44.0507514Z Events for pod ospool-ep-674fbdcc48-mzw5k:2026-10-24T02:17:44.0509060Z 2026-10-24 02:11:49 +0000 UTC Normal Successfully assigned test-ospool-ep-7qazui/ospool-ep-674fbdcc48-mzw5k to minikube2026-10-24T02:17:44.0510698Z 2026-10-24 02:11:50 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-10-24T02:17:44.0513006Z 2026-10-24 02:12:09 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 2.861s (19.188s including waiting). Image size: 2893600 bytes.2026-10-24T02:17:44.0514565Z 2026-10-24 02:12:09 +0000 UTC Normal Container created2026-10-24T02:17:44.0515700Z 2026-10-24 02:12:09 +0000 UTC Normal Container started2026-10-24T02:17:44.0517389Z 2026-10-24 02:12:10 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-10-24T02:17:44.0519778Z 2026-10-24 02:12:24 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 14.011s (14.162s including waiting). Image size: 537408098 bytes.2026-10-24T02:17:44.0521385Z 2026-10-24 02:12:24 +0000 UTC Normal Container created2026-10-24T02:17:44.0522306Z 2026-10-24 02:12:24 +0000 UTC Normal Container started2026-10-24T02:17:44.0522949Z 2026-10-24T02:17:44.0523416Z ---2026-10-24T02:17:44.0524474Z TestOSPoolEP 2026-10-24T02:17:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:44.0536224Z ospool_ep_test.go:72: ---2026-10-24T02:17:44.0537186Z Events for pod test-cm-5886f7986-wtgwz:2026-10-24T02:17:44.0538907Z 2026-10-24 02:11:49 +0000 UTC Normal Successfully assigned test-ospool-ep-7qazui/test-cm-5886f7986-wtgwz to minikube2026-10-24T02:17:44.0540365Z 2026-10-24 02:11:50 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-10-24T02:17:44.0542270Z 2026-10-24 02:12:10 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 1.583s (20.733s including waiting). Image size: 196304120 bytes.2026-10-24T02:17:44.0543695Z 2026-10-24 02:12:10 +0000 UTC Normal Container created2026-10-24T02:17:44.0544652Z 2026-10-24 02:12:10 +0000 UTC Normal Container started2026-10-24T02:17:44.0545509Z 2026-10-24T02:17:44.0546014Z ---2026-10-24T02:17:44.0547057Z TestOSPoolEP 2026-10-24T02:17:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:44.0575488Z TestOSPoolEP 2026-10-24T02:17:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui delete -f /tmp/TestOSPoolEP3711774767]2026-10-24T02:17:44.1630348Z TestOSPoolEP 2026-10-24T02:17:44Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-7qazui namespace2026-10-24T02:17:44.1687020Z TestOSPoolEP 2026-10-24T02:17:44Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-7qazui namespace2026-10-24T02:17:44.8232103Z TestOSPoolEP 2026-10-24T02:17:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui delete -f /tmp/TestOSPoolEP4198100497]2026-10-24T02:17:44.9199050Z TestOSPoolEP 2026-10-24T02:17:44Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-7qazui namespace2026-10-24T02:17:44.9271895Z TestOSPoolEP 2026-10-24T02:17:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7qazui delete -k /tmp/kustomize-template-3867634950]2026-10-24T02:17:45.0734561Z TestOSPoolEP 2026-10-24T02:17:45Z logger.go:67: serviceaccount "cvmfs-nodeplugin" deleted from test-ospool-ep-7qazui namespace2026-10-24T02:17:45.0830666Z TestOSPoolEP 2026-10-24T02:17:45Z logger.go:67: service "frontier-squid" deleted from test-ospool-ep-7qazui namespace2026-10-24T02:17:45.0946129Z TestOSPoolEP 2026-10-24T02:17:45Z logger.go:67: service "test-cm" deleted from test-ospool-ep-7qazui namespace2026-10-24T02:17:45.1007996Z TestOSPoolEP 2026-10-24T02:17:45Z logger.go:67: deployment.apps "cvmfs-nodeplugin" deleted from test-ospool-ep-7qazui namespace2026-10-24T02:17:45.1057148Z TestOSPoolEP 2026-10-24T02:17:45Z logger.go:67: deployment.apps "frontier-squid" deleted from test-ospool-ep-7qazui namespace2026-10-24T02:17:45.1207666Z TestOSPoolEP 2026-10-24T02:17:45Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-7qazui namespace2026-10-24T02:17:45.1292111Z TestOSPoolEP 2026-10-24T02:17:45Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-7qazui namespace2026-10-24T02:17:45.1631227Z --- FAIL: TestOSPoolEP (367.76s)2026-10-24T02:17:45.1632314Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (40.03s)2026-10-24T02:17:45.1633382Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP (11.08s)2026-10-24T02:17:45.1634852Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity (0.62s)2026-10-24T02:17:45.1636250Z --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (302.08s)2026-10-24T02:17:45.1636982Z FAIL2026-10-24T02:17:45.1674860Z FAIL github.com/osg-htc/k8s-integration-tests/test 367.781s2026-10-24T02:17:45.1858695Z FAIL2026-10-24T02:17:45.3003856Z ##[error]Process completed with exit code 1.2026-10-24T02:17:45.3091592Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-24T02:17:45.3092282Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-10-24T02:17:45.3212852Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-24T02:17:45.3213411Z env:2026-10-24T02:17:45.3213716Z GOTOOLCHAIN: local2026-10-24T02:17:45.3214439Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-24T02:17:45.3215217Z ##[endgroup]2026-10-24T02:17:45.3521094Z ##[group]Run actions/upload-artifact@v42026-10-24T02:17:45.3521655Z with:2026-10-24T02:17:45.3522348Z name: TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd72026-10-24T02:17:45.3523210Z path: /tmp/k8s-tests2026-10-24T02:17:45.3523545Z retention-days: 52026-10-24T02:17:45.3523787Z if-no-files-found: warn2026-10-24T02:17:45.3524172Z compression-level: 62026-10-24T02:17:45.3524496Z overwrite: false2026-10-24T02:17:45.3524791Z include-hidden-files: false2026-10-24T02:17:45.3525224Z env:2026-10-24T02:17:45.3525735Z GOTOOLCHAIN: local2026-10-24T02:17:45.3526118Z ##[endgroup]2026-10-24T02:17:45.6176550Z (node:15891) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-24T02:17:45.6177864Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-24T02:17:45.6379807Z With the provided path, there will be 10 files uploaded2026-10-24T02:17:45.6386068Z Artifact name is valid!2026-10-24T02:17:45.6388291Z Root directory input is valid!2026-10-24T02:17:46.0370751Z Beginning upload of artifact content to blob storage2026-10-24T02:17:46.0791040Z (node:15891) [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-10-24T02:17:46.4375971Z Uploaded bytes 159882026-10-24T02:17:46.5249672Z Finished uploading artifact content to blob storage!2026-10-24T02:17:46.5252526Z SHA256 digest of uploaded artifact zip is 0ccb0f5681139fa84ec449d69c7027f670c9a8716044fb3d132580ee615aa0f32026-10-24T02:17:46.5259196Z Finalizing artifact upload2026-10-24T02:17:46.9870170Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7.zip successfully finalized. Artifact ID 125439682052026-10-24T02:17:46.9872709Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7 has been successfully uploaded! Final size is 15988 bytes. Artifact ID is 125439682052026-10-24T02:17:46.9877740Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/40053022520/artifacts/125439682052026-10-24T02:17:47.0098518Z Post job cleanup.2026-10-24T02:17:47.1093296Z [command]/usr/bin/git version2026-10-24T02:17:47.1180087Z git version 2.55.02026-10-24T02:17:47.1222997Z Temporarily overriding HOME='/home/runner/work/_temp/7ae94eaa-9c04-49e5-9e4e-65a6b24060c7' before making global git config changes2026-10-24T02:17:47.1226991Z Adding repository directory to the temporary git global config as a safe directory2026-10-24T02:17:47.1237098Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-24T02:17:47.1277741Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-24T02:17:47.1323990Z [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-10-24T02:17:47.1798044Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-24T02:17:47.1833216Z http.https://github.com/.extraheader2026-10-24T02:17:47.1849324Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-10-24T02:17:47.1905756Z [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-10-24T02:17:47.2427861Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-24T02:17:47.2510874Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-24T02:17:47.3066633Z Cleaning up orphan processes2026-10-24T02:17:47.4079109Z ##[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/