2026-10-22T02:06:14.0967309Z Current runner version: '2.338.0'2026-10-22T02:06:14.1005714Z ##[group]Runner Image Provisioner2026-10-22T02:06:14.1007279Z Hosted Compute Agent2026-10-22T02:06:14.1008382Z Version: 20261015.6102026-10-22T02:06:14.1009442Z Commit: 267fdb4e8bbec4ab5ea31367f3a00d5c480c76562026-10-22T02:06:14.1011108Z Build Date: 2026-10-14T17:06:54Z2026-10-22T02:06:14.1012367Z Worker ID: {3f8673d7-c042-4508-a47b-d7195e5d23e9}2026-10-22T02:06:14.1013716Z Region: eastus2026-10-22T02:06:14.1014655Z Cloud: Azure2026-10-22T02:06:14.1015534Z ##[endgroup]2026-10-22T02:06:14.1018085Z ##[group]Operating System2026-10-22T02:06:14.1019181Z Ubuntu2026-10-22T02:06:14.1020502Z 22.04.52026-10-22T02:06:14.1021495Z LTS2026-10-22T02:06:14.1022523Z ##[endgroup]2026-10-22T02:06:14.1023565Z ##[group]Runner Image2026-10-22T02:06:14.1024593Z Image: ubuntu-22.042026-10-22T02:06:14.1025652Z Version: 20261018.327.12026-10-22T02:06:14.1027870Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20261018.327/images/ubuntu/Ubuntu2204-Readme.md2026-10-22T02:06:14.1031674Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20261018.3272026-10-22T02:06:14.1033405Z ##[endgroup]2026-10-22T02:06:14.1039113Z ##[group]GITHUB_TOKEN Permissions2026-10-22T02:06:14.1042868Z Actions: write2026-10-22T02:06:14.1043916Z ArtifactMetadata: write2026-10-22T02:06:14.1045006Z Attestations: write2026-10-22T02:06:14.1046151Z Checks: write2026-10-22T02:06:14.1047092Z CodeQuality: write2026-10-22T02:06:14.1048265Z Contents: write2026-10-22T02:06:14.1049311Z CopilotRequests: write2026-10-22T02:06:14.1050605Z Deployments: write2026-10-22T02:06:14.1051694Z Discussions: write2026-10-22T02:06:14.1052683Z Drives: write2026-10-22T02:06:14.1053724Z Issues: write2026-10-22T02:06:14.1054814Z Metadata: read2026-10-22T02:06:14.1055759Z Models: read2026-10-22T02:06:14.1056889Z Packages: write2026-10-22T02:06:14.1057888Z Pages: write2026-10-22T02:06:14.1058919Z PullRequests: write2026-10-22T02:06:14.1060205Z RepositoryProjects: write2026-10-22T02:06:14.1061374Z SecurityEvents: write2026-10-22T02:06:14.1062515Z Statuses: write2026-10-22T02:06:14.1063494Z VulnerabilityAlerts: read2026-10-22T02:06:14.1064627Z ##[endgroup]2026-10-22T02:06:14.1067932Z Secret source: Actions2026-10-22T02:06:14.1070137Z Cache mode: write2026-10-22T02:06:14.1071812Z Prepare workflow directory2026-10-22T02:06:14.1556723Z Prepare all required actions2026-10-22T02:06:14.1629015Z Getting action download info2026-10-22T02:06:14.3705318Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-10-22T02:06:14.5465062Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-10-22T02:06:14.7070286Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-10-22T02:06:14.8852236Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-10-22T02:06:15.1506373Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (63ec080e4eea87fb8a9eae678ab9944ec2461251)2026-10-22T02:06:15.1512377Z ##[group] Inputs2026-10-22T02:06:15.1513114Z testName: TestOSPoolEP2026-10-22T02:06:15.1514574Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-22T02:06:15.1516175Z setupScript: 2026-10-22T02:06:15.1516769Z setupEnv: {}2026-10-22T02:06:15.1517345Z ##[endgroup]2026-10-22T02:06:15.1518410Z Complete job name: ospool-ep / Run OSPool EP test (cvmfs-bind, 25-testing) / Run Tests2026-10-22T02:06:15.2359892Z ##[group]Run actions/checkout@v52026-10-22T02:06:15.2361049Z with:2026-10-22T02:06:15.2361681Z repository: osg-htc/k8s-integration-tests2026-10-22T02:06:15.2371025Z token: ***2026-10-22T02:06:15.2371604Z ssh-strict: true2026-10-22T02:06:15.2372190Z ssh-user: git2026-10-22T02:06:15.2372798Z persist-credentials: true2026-10-22T02:06:15.2373472Z clean: true2026-10-22T02:06:15.2374370Z sparse-checkout-cone-mode: true2026-10-22T02:06:15.2375118Z fetch-depth: 12026-10-22T02:06:15.2375686Z fetch-tags: false2026-10-22T02:06:15.2376296Z show-progress: true2026-10-22T02:06:15.2376898Z lfs: false2026-10-22T02:06:15.2377429Z submodules: false2026-10-22T02:06:15.2378044Z set-safe-directory: true2026-10-22T02:06:15.2378756Z allow-unsafe-pr-checkout: false2026-10-22T02:06:15.2380005Z ##[endgroup]2026-10-22T02:06:15.3456018Z Syncing repository: osg-htc/k8s-integration-tests2026-10-22T02:06:15.3458707Z ##[group]Getting Git version info2026-10-22T02:06:15.3460871Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-22T02:06:15.3462925Z [command]/usr/bin/git version2026-10-22T02:06:15.3517625Z git version 2.55.02026-10-22T02:06:15.3542626Z ##[endgroup]2026-10-22T02:06:15.3560709Z Temporarily overriding HOME='/home/runner/work/_temp/bb5bf8f6-5a17-4560-a633-5158aaa6ce3e' before making global git config changes2026-10-22T02:06:15.3565156Z Adding repository directory to the temporary git global config as a safe directory2026-10-22T02:06:15.3569253Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-22T02:06:15.3608150Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-22T02:06:15.3618149Z ##[group]Initializing the repository2026-10-22T02:06:15.3620897Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-22T02:06:15.3754964Z hint: Using 'master' as the name for the initial branch. This default branch name2026-10-22T02:06:15.3758118Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-10-22T02:06:15.3761326Z hint: to use in all of your new repositories, which will suppress this warning,2026-10-22T02:06:15.3763737Z hint: call:2026-10-22T02:06:15.3765030Z hint:2026-10-22T02:06:15.3766311Z hint: git config --global init.defaultBranch <name>2026-10-22T02:06:15.3768033Z hint:2026-10-22T02:06:15.3769945Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-10-22T02:06:15.3772297Z hint: 'development'. The just-created branch can be renamed via this command:2026-10-22T02:06:15.3773497Z hint:2026-10-22T02:06:15.3774042Z hint: git branch -m <name>2026-10-22T02:06:15.3774689Z hint:2026-10-22T02:06:15.3775621Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-10-22T02:06:15.3777548Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-10-22T02:06:15.3781662Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-10-22T02:06:15.3830444Z ##[endgroup]2026-10-22T02:06:15.3832695Z ##[group]Disabling automatic garbage collection2026-10-22T02:06:15.3834727Z [command]/usr/bin/git config --local gc.auto 02026-10-22T02:06:15.3903551Z ##[endgroup]2026-10-22T02:06:15.3905345Z ##[group]Setting up auth2026-10-22T02:06:15.3911903Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-22T02:06:15.3950007Z [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-22T02:06:15.4375699Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-22T02:06:15.4425988Z [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-22T02:06:15.4697724Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-22T02:06:15.4739534Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-22T02:06:15.5023082Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-10-22T02:06:15.5076802Z ##[endgroup]2026-10-22T02:06:15.5078348Z ##[group]Fetching the repository2026-10-22T02:06:15.5091365Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +63ec080e4eea87fb8a9eae678ab9944ec2461251:refs/remotes/origin/main2026-10-22T02:06:15.7296299Z From https://github.com/osg-htc/k8s-integration-tests2026-10-22T02:06:15.7298674Z * [new ref] 63ec080e4eea87fb8a9eae678ab9944ec2461251 -> origin/main2026-10-22T02:06:15.7303404Z ##[endgroup]2026-10-22T02:06:15.7311068Z ##[group]Determining the checkout info2026-10-22T02:06:15.7313424Z ##[endgroup]2026-10-22T02:06:15.7314880Z [command]/usr/bin/git sparse-checkout disable2026-10-22T02:06:15.7364559Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-10-22T02:06:15.7402730Z ##[group]Checking out the ref2026-10-22T02:06:15.7405858Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-10-22T02:06:15.7512528Z Switched to a new branch 'main'2026-10-22T02:06:15.7515282Z branch 'main' set up to track 'origin/main'.2026-10-22T02:06:15.7523097Z ##[endgroup]2026-10-22T02:06:15.7567535Z [command]/usr/bin/git log -1 --format=%H2026-10-22T02:06:15.7601823Z 63ec080e4eea87fb8a9eae678ab9944ec24612512026-10-22T02:06:15.7947339Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-22T02:06:15.7949532Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-22T02:06:15.7951775Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-22T02:06:15.7994913Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-22T02:06:15.7996162Z env:2026-10-22T02:06:15.7997669Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-22T02:06:15.7999448Z SETUP_ENV_YAML: {}2026-10-22T02:06:15.8000662Z ##[endgroup]2026-10-22T02:06:16.4301719Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-22T02:06:16.4303176Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-10-22T02:06:16.4340856Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-22T02:06:16.4341854Z env:2026-10-22T02:06:16.4342996Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfs-bind"}2026-10-22T02:06:16.4344233Z ##[endgroup]2026-10-22T02:06:16.4494386Z ##[group]Run true2026-10-22T02:06:16.4495222Z [36;1mtrue[0m2026-10-22T02:06:16.4530107Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-22T02:06:16.4531104Z ##[endgroup]2026-10-22T02:06:16.4736308Z ##[group]Run medyagh/setup-minikube@latest2026-10-22T02:06:16.4737220Z with:2026-10-22T02:06:16.4737975Z start: true2026-10-22T02:06:16.4738697Z cache: true2026-10-22T02:06:16.4739440Z minikube-version: latest2026-10-22T02:06:16.4740532Z wait: all2026-10-22T02:06:16.4741256Z ##[endgroup]2026-10-22T02:06:16.6048512Z (node:2220) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-22T02:06:16.6056613Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-22T02:06:17.4969851Z [command]/usr/bin/chmod +x /home/runner/work/_temp/300526cb-4b35-44ca-b09f-e27b03896cd32026-10-22T02:06:17.6760726Z [command]/home/runner/bin/minikube version --short2026-10-22T02:06:17.7214530Z v1.39.02026-10-22T02:06:17.8004648Z Cache hit for: kic-v1.39.0-x642026-10-22T02:06:17.8011598Z Cache hit for: preloaded-tarball-v1.39.0-x64-stable-docker2026-10-22T02:06:17.8136010Z (node:2220) [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-22T02:06:18.8665152Z Received 121634816 of 531630645 (22.9%), 113.6 MBs/sec2026-10-22T02:06:18.8666157Z Received 75497472 of 288577004 (26.2%), 71.9 MBs/sec2026-10-22T02:06:19.9867732Z Received 268435456 of 531630645 (50.5%), 119.3 MBs/sec2026-10-22T02:06:19.9868385Z Received 167772160 of 288577004 (58.1%), 75.3 MBs/sec2026-10-22T02:06:20.9475624Z Received 288577004 of 288577004 (100.0%), 89.2 MBs/sec2026-10-22T02:06:20.9478756Z Cache Size: ~275 MB (288577004 B)2026-10-22T02:06:21.0577184Z Received 402653184 of 531630645 (75.7%), 119.4 MBs/sec2026-10-22T02:06:21.0605124Z [command]/usr/bin/tar -xf /home/runner/work/_temp/3ee370cc-18e9-4ba8-b435-a86dbd774335/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-22T02:06:21.8460873Z Received 531630645 of 531630645 (100.0%), 126.6 MBs/sec2026-10-22T02:06:21.8461781Z Cache Size: ~507 MB (531630645 B)2026-10-22T02:06:21.8570000Z [command]/usr/bin/tar -xf /home/runner/work/_temp/103f08b1-7b79-4ffb-aa76-463d232ec01c/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-22T02:06:22.0051237Z Cache restored successfully2026-10-22T02:06:22.7370617Z Cache restored successfully2026-10-22T02:06:22.8580961Z [command]/home/runner/bin/minikube start --wait all2026-10-22T02:06:22.9076249Z * minikube v1.39.0 on Ubuntu 22.042026-10-22T02:06:24.9753144Z ! 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-22T02:06:24.9758231Z * Automatically selected the docker driver. Other choices: podman, ssh, none2026-10-22T02:06:25.0380769Z * Using Docker driver with root privileges2026-10-22T02:06:25.0391528Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-10-22T02:06:25.0399849Z * Pulling base image v0.0.51 ...2026-10-22T02:06:43.9860042Z * Preparing Kubernetes v1.37.0 on containerd 2.3.4 ...2026-10-22T02:06:51.6703548Z * Configuring CNI (Container Networking Interface) ...2026-10-22T02:06:57.6175458Z * Verifying Kubernetes components...2026-10-22T02:06:57.6552659Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-10-22T02:06:58.2612042Z * Enabled addons: storage-provisioner, default-storageclass2026-10-22T02:07:16.1353996Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-10-22T02:07:16.1532147Z [command]/home/runner/bin/minikube version --short2026-10-22T02:07:16.2097988Z v1.39.02026-10-22T02:07:16.2545281Z ##[group]Run actions/setup-go@v62026-10-22T02:07:16.2545582Z with:2026-10-22T02:07:16.2545789Z go-version: 1.262026-10-22T02:07:16.2546002Z cache: true2026-10-22T02:07:16.2546227Z cache-dependency-path: go.sum2026-10-22T02:07:16.2546489Z check-latest: false2026-10-22T02:07:16.2549228Z token: ***2026-10-22T02:07:16.2549454Z ##[endgroup]2026-10-22T02:07:16.3865844Z Setup go version spec 1.262026-10-22T02:07:16.3967259Z Found in cache @ /opt/hostedtoolcache/go/1.26.9/x642026-10-22T02:07:16.3969926Z Added go to the path2026-10-22T02:07:16.3973817Z Successfully set up Go version 1.262026-10-22T02:07:16.8373312Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOMODCACHE2026-10-22T02:07:16.8449448Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOCACHE2026-10-22T02:07:16.8477965Z /home/runner/go/pkg/mod2026-10-22T02:07:16.8501314Z /home/runner/.cache/go-build2026-10-22T02:07:16.9332221Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-22T02:07:18.0021578Z Received 176160768 of 249167808 (70.7%), 164.7 MBs/sec2026-10-22T02:07:18.3153241Z Received 249167808 of 249167808 (100.0%), 178.1 MBs/sec2026-10-22T02:07:18.3155320Z Cache Size: ~238 MB (249167808 B)2026-10-22T02:07:18.3237132Z [command]/usr/bin/tar -xf /home/runner/work/_temp/be21b938-b352-470f-a8fe-d1526ab7a55e/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-22T02:07:21.5713937Z Cache restored successfully2026-10-22T02:07:21.6268897Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-22T02:07:21.6292572Z go version go1.26.9 linux/amd642026-10-22T02:07:21.6292791Z 2026-10-22T02:07:21.6293111Z ##[group]go env2026-10-22T02:07:21.6586096Z AR='ar'2026-10-22T02:07:21.6586392Z CC='gcc'2026-10-22T02:07:21.6586650Z CGO_CFLAGS='-O2 -g'2026-10-22T02:07:21.6586944Z CGO_CPPFLAGS=''2026-10-22T02:07:21.6587325Z CGO_CXXFLAGS='-O2 -g'2026-10-22T02:07:21.6587736Z CGO_ENABLED='1'2026-10-22T02:07:21.6588174Z CGO_FFLAGS='-O2 -g'2026-10-22T02:07:21.6588472Z CGO_LDFLAGS='-O2 -g'2026-10-22T02:07:21.6588754Z CXX='g++'2026-10-22T02:07:21.6588985Z GCCGO='gccgo'2026-10-22T02:07:21.6589240Z GO111MODULE=''2026-10-22T02:07:21.6589981Z GOAMD64='v1'2026-10-22T02:07:21.6590396Z GOARCH='amd64'2026-10-22T02:07:21.6590804Z GOAUTH='netrc'2026-10-22T02:07:21.6591043Z GOBIN=''2026-10-22T02:07:21.6591297Z GOCACHE='/home/runner/.cache/go-build'2026-10-22T02:07:21.6591655Z GOCACHEPROG=''2026-10-22T02:07:21.6591900Z GODEBUG=''2026-10-22T02:07:21.6592160Z GOENV='/home/runner/.config/go/env'2026-10-22T02:07:21.6592459Z GOEXE=''2026-10-22T02:07:21.6592696Z GOEXPERIMENT=''2026-10-22T02:07:21.6592939Z GOFIPS140='off'2026-10-22T02:07:21.6593176Z GOFLAGS=''2026-10-22T02:07:21.6593942Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build2532516326=/tmp/go-build -gno-record-gcc-switches'2026-10-22T02:07:21.6594880Z GOHOSTARCH='amd64'2026-10-22T02:07:21.6595136Z GOHOSTOS='linux'2026-10-22T02:07:21.6595382Z GOINSECURE=''2026-10-22T02:07:21.6595781Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-10-22T02:07:21.6596274Z GOMODCACHE='/home/runner/go/pkg/mod'2026-10-22T02:07:21.6596916Z GONOPROXY=''2026-10-22T02:07:21.6597157Z GONOSUMDB=''2026-10-22T02:07:21.6597391Z GOOS='linux'2026-10-22T02:07:21.6597638Z GOPATH='/home/runner/go'2026-10-22T02:07:21.6597983Z GOPRIVATE=''2026-10-22T02:07:21.6598363Z GOPROXY='https://proxy.golang.org,direct'2026-10-22T02:07:21.6598750Z GOROOT='/opt/hostedtoolcache/go/1.26.9/x64'2026-10-22T02:07:21.6599085Z GOSUMDB='sum.golang.org'2026-10-22T02:07:21.6599380Z GOTELEMETRY='local'2026-10-22T02:07:21.6600037Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-10-22T02:07:21.6600375Z GOTMPDIR=''2026-10-22T02:07:21.6600584Z GOTOOLCHAIN='local'2026-10-22T02:07:21.6601198Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.9/x64/pkg/tool/linux_amd64'2026-10-22T02:07:21.6601585Z GOVCS=''2026-10-22T02:07:21.6601798Z GOVERSION='go1.26.9'2026-10-22T02:07:21.6602019Z GOWORK=''2026-10-22T02:07:21.6602239Z PKG_CONFIG='pkg-config'2026-10-22T02:07:21.6602394Z 2026-10-22T02:07:21.6602723Z ##[endgroup]2026-10-22T02:07:21.6881947Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-22T02:07:21.6882490Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-10-22T02:07:21.6918132Z shell: /usr/bin/bash -e {0}2026-10-22T02:07:21.6918403Z env:2026-10-22T02:07:21.6918601Z GOTOOLCHAIN: local2026-10-22T02:07:21.6918860Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-10-22T02:07:21.6919139Z OSPOOL_EP_CMTag: 25.x-el92026-10-22T02:07:21.6919401Z OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-22T02:07:21.6919951Z ##[endgroup]2026-10-22T02:07:28.7060091Z === RUN TestOSPoolEP2026-10-22T02:07:28.7063058Z === PAUSE TestOSPoolEP2026-10-22T02:07:28.7063551Z === CONT TestOSPoolEP2026-10-22T02:07:28.7064739Z TestOSPoolEP 2026-10-22T02:07:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:28.7458163Z TestOSPoolEP 2026-10-22T02:07:28Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl apply -f /tmp/TestOSPoolEP2644767837]2026-10-22T02:07:29.2075500Z TestOSPoolEP 2026-10-22T02:07:29Z logger.go:67: pod/idtoken-generator created2026-10-22T02:07:29.2171140Z TestOSPoolEP 2026-10-22T02:07:29Z logger.go:67: secret/pool-passwd created2026-10-22T02:07:29.2240257Z TestOSPoolEP 2026-10-22T02:07:29Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-22T02:07:29.2250809Z TestOSPoolEP 2026-10-22T02:07:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:29.2269477Z TestOSPoolEP 2026-10-22T02:07:29Z 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-22T02:07:39.2280971Z TestOSPoolEP 2026-10-22T02:07:39Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-22T02:07:39.2282401Z TestOSPoolEP 2026-10-22T02:07:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:39.2308602Z TestOSPoolEP 2026-10-22T02:07:39Z logger.go:67: Pod is now available2026-10-22T02:07:39.2310801Z TestOSPoolEP 2026-10-22T02:07:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-10-22T02:07:39.7370146Z TestOSPoolEP 2026-10-22T02:07:39Z logger.go:67: ***2026-10-22T02:07:39.7437932Z TestOSPoolEP 2026-10-22T02:07:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl apply -f /tmp/TestOSPoolEP2895973979]2026-10-22T02:07:39.9516542Z TestOSPoolEP 2026-10-22T02:07:39Z logger.go:67: secret/pool-token created2026-10-22T02:07:39.9571539Z TestOSPoolEP 2026-10-22T02:07:39Z retry.go:91: Wait for secret pool-token to be provisioned.2026-10-22T02:07:39.9572885Z TestOSPoolEP 2026-10-22T02:07:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:39.9585780Z TestOSPoolEP 2026-10-22T02:07:39Z logger.go:67: Secret is now available2026-10-22T02:07:39.9609010Z TestOSPoolEP 2026-10-22T02:07:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl apply -k /tmp/kustomize-template-2629933076]2026-10-22T02:07:40.3801474Z TestOSPoolEP 2026-10-22T02:07:40Z logger.go:67: serviceaccount/cvmfs-nodeplugin created2026-10-22T02:07:40.3893883Z TestOSPoolEP 2026-10-22T02:07:40Z logger.go:67: service/frontier-squid created2026-10-22T02:07:40.3998021Z TestOSPoolEP 2026-10-22T02:07:40Z logger.go:67: service/test-cm created2026-10-22T02:07:40.4075694Z TestOSPoolEP 2026-10-22T02:07:40Z logger.go:67: deployment.apps/cvmfs-nodeplugin created2026-10-22T02:07:40.4143077Z TestOSPoolEP 2026-10-22T02:07:40Z logger.go:67: deployment.apps/frontier-squid created2026-10-22T02:07:40.4443476Z TestOSPoolEP 2026-10-22T02:07:40Z 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-22T02:07:40.4448564Z TestOSPoolEP 2026-10-22T02:07:40Z logger.go:67: deployment.apps/ospool-ep created2026-10-22T02:07:40.4685567Z TestOSPoolEP 2026-10-22T02:07:40Z logger.go:67: deployment.apps/test-cm created2026-10-22T02:07:40.4738091Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-10-22T02:07:40.4767391Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:40.4848627Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:40Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-22T02:07:40.4854088Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:40.4872871Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:40Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-22T02:07:40.4875432Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:40.4877283Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:40Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-22T02:07:40.4879120Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:40.4882762Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:40Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-22T02:07:40.4885159Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:40.4961960Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:40Z 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-22T02:07:40.4966201Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:40Z 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-22T02:07:40.4969322Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:40Z 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-22T02:07:40.4978559Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:40Z 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-5886f7986". Sleeping for 10s and will try again.2026-10-22T02:07:50.4968614Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:50Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-22T02:07:50.4970488Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:50.4983403Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:50Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-22T02:07:50.5001187Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:50.5059326Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:50Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-22T02:07:50.5061834Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:50.5064180Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:50Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-22T02:07:50.5066281Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:50.5070714Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:50Z 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-22T02:07:50.5076003Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:50Z 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-22T02:07:50.5091632Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:50Z 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-22T02:07:50.5095789Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:50Z logger.go:67: Deployment is now available2026-10-22T02:08:00.5064392Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:00Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-22T02:08:00.5072241Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:00.5074193Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:00Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-22T02:08:00.5075868Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:00.5095824Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:00Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-22T02:08:00.5097760Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:00.5101681Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:00Z 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-22T02:08:00.5105606Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:00Z logger.go:67: Deployment is now available2026-10-22T02:08:00.5120291Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:00Z logger.go:67: Deployment is now available2026-10-22T02:08:10.5105943Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:10Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-22T02:08:10.5108363Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:10.5136526Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:10Z 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-22T02:08:20.5145340Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:20Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-22T02:08:20.5147145Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:20Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:20.5177711Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:20Z logger.go:67: Deployment is now available2026-10-22T02:08:20.5183795Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP2026-10-22T02:08:20.5185951Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-22T02:08:20Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:20.5211396Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-22T02:08:20Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl cp ../test-configs/ospool-ep/condor_status.sh test-cm-5886f7986-x9lwj:/tmp/condor_status.sh]2026-10-22T02:08:21.0298047Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-22T02:08:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl exec test-cm-5886f7986-x9lwj -- chmod +x /tmp/condor_status.sh]2026-10-22T02:08:21.2395956Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-22T02:08:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl exec test-cm-5886f7986-x9lwj -- sh -c /tmp/condor_status.sh]2026-10-22T02:08:21.4258964Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-22T02:08:21Z logger.go:67: command terminated with exit code 12026-10-22T02:08:21.4297644Z test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-5886f7986-x9lwj failed. Retrying in 10s.2026-10-22T02:08:31.4303419Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-22T02:08:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl exec test-cm-5886f7986-x9lwj -- sh -c /tmp/condor_status.sh]2026-10-22T02:08:31.5991933Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity2026-10-22T02:08:31.5993543Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-22T02:08:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:31.6024191Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-22T02:08:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl cp ../test-configs/ospool-ep/has_singularity.sh test-cm-5886f7986-x9lwj:/tmp/has_singularity.sh]2026-10-22T02:08:31.7865561Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-22T02:08:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl exec test-cm-5886f7986-x9lwj -- chmod +x /tmp/has_singularity.sh]2026-10-22T02:08:31.9763907Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-22T02:08:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl exec test-cm-5886f7986-x9lwj -- sh -c /tmp/has_singularity.sh]2026-10-22T02:08:32.1718185Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-10-22T02:08:32.1719988Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:08:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:32.1748796Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:08:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl cp ../test-configs/ospool-ep/has_cvmfs.sh test-cm-5886f7986-x9lwj:/tmp/has_cvmfs.sh]2026-10-22T02:08:32.3814688Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:08:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl exec test-cm-5886f7986-x9lwj -- chmod +x /tmp/has_cvmfs.sh]2026-10-22T02:08:32.5597001Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:08:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl exec test-cm-5886f7986-x9lwj -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:08:32.7532538Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:08:32Z logger.go:67: command terminated with exit code 12026-10-22T02:08:32.7566986Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-x9lwj failed. Retrying in 30s.2026-10-22T02:09:02.7573796Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:09:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl exec test-cm-5886f7986-x9lwj -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:09:02.9285500Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:09:02Z logger.go:67: command terminated with exit code 12026-10-22T02:09:02.9324635Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-x9lwj failed. Retrying in 30s.2026-10-22T02:09:32.9334872Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:09:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl exec test-cm-5886f7986-x9lwj -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:09:33.1152372Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:09:33Z logger.go:67: command terminated with exit code 12026-10-22T02:09:33.1186710Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-x9lwj failed. Retrying in 30s.2026-10-22T02:10:03.1191450Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:10:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl exec test-cm-5886f7986-x9lwj -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:10:03.2752246Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:10:03Z logger.go:67: command terminated with exit code 12026-10-22T02:10:03.2785154Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-x9lwj failed. Retrying in 30s.2026-10-22T02:10:33.2795827Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:10:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl exec test-cm-5886f7986-x9lwj -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:10:33.4312739Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:10:33Z logger.go:67: command terminated with exit code 12026-10-22T02:10:33.4356032Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-x9lwj failed. Retrying in 30s.2026-10-22T02:11:03.4393312Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:11:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl exec test-cm-5886f7986-x9lwj -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:11:03.5906622Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:11:03Z logger.go:67: command terminated with exit code 12026-10-22T02:11:03.5944670Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-x9lwj failed. Retrying in 30s.2026-10-22T02:11:33.5995764Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:11:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl exec test-cm-5886f7986-x9lwj -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:11:33.7565157Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:11:33Z logger.go:67: command terminated with exit code 12026-10-22T02:11:33.7599097Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-x9lwj failed. Retrying in 30s.2026-10-22T02:12:03.7603847Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:12:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl exec test-cm-5886f7986-x9lwj -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:12:03.9161395Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:12:03Z logger.go:67: command terminated with exit code 12026-10-22T02:12:03.9199999Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-x9lwj failed. Retrying in 30s.2026-10-22T02:12:33.9206804Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:12:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl exec test-cm-5886f7986-x9lwj -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:12:34.0724871Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:12:34Z logger.go:67: command terminated with exit code 12026-10-22T02:12:34.0760523Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-x9lwj failed. Retrying in 30s.2026-10-22T02:13:04.0808890Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:13:04Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl exec test-cm-5886f7986-x9lwj -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:13:04.2329395Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:13:04Z logger.go:67: command terminated with exit code 12026-10-22T02:13:04.2366013Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-x9lwj failed. Retrying in 30s.2026-10-22T02:13:34.2394358Z test_utils.go:105: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-x9lwj did not succeed within {10 30000000000} retries2026-10-22T02:13:34.2421547Z TestOSPoolEP 2026-10-22T02:13:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:34.2516054Z TestOSPoolEP 2026-10-22T02:13:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:34.4264146Z TestOSPoolEP 2026-10-22T02:13:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:34.5462009Z TestOSPoolEP 2026-10-22T02:13:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:34.6576271Z TestOSPoolEP 2026-10-22T02:13:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:34.7942518Z TestOSPoolEP 2026-10-22T02:13:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:34.9390243Z TestOSPoolEP 2026-10-22T02:13:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:34.9424128Z === NAME TestOSPoolEP2026-10-22T02:13:34.9427839Z ospool_ep_test.go:72: ---2026-10-22T02:13:34.9428600Z Events for pod cvmfs-nodeplugin-5cd89c7cfd-gqwrk:2026-10-22T02:13:34.9430417Z 2026-10-22 02:07:40 +0000 UTC Normal Successfully assigned test-ospool-ep-plzepl/cvmfs-nodeplugin-5cd89c7cfd-gqwrk to minikube2026-10-22T02:13:34.9431958Z 2026-10-22 02:07:40 +0000 UTC Normal Pulling image "opensciencegrid/cvmfs-nodeplugin:fresh"2026-10-22T02:13:34.9439109Z 2026-10-22 02:07:45 +0000 UTC Normal Successfully pulled image "opensciencegrid/cvmfs-nodeplugin:fresh" in 4.984s (4.984s including waiting). Image size: 155940803 bytes.2026-10-22T02:13:34.9440882Z 2026-10-22 02:07:45 +0000 UTC Normal Container created2026-10-22T02:13:34.9441698Z 2026-10-22 02:07:45 +0000 UTC Normal Container started2026-10-22T02:13:34.9442230Z 2026-10-22T02:13:34.9442603Z ---2026-10-22T02:13:34.9443521Z TestOSPoolEP 2026-10-22T02:13:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:34.9461549Z ospool_ep_test.go:72: ---2026-10-22T02:13:34.9471238Z Events for pod frontier-squid-65f85c968-9gbsj:2026-10-22T02:13:34.9473054Z 2026-10-22 02:07:40 +0000 UTC Normal Successfully assigned test-ospool-ep-plzepl/frontier-squid-65f85c968-9gbsj to minikube2026-10-22T02:13:34.9474574Z 2026-10-22 02:07:40 +0000 UTC Normal Pulling image "opensciencegrid/frontier-squid:fresh"2026-10-22T02:13:34.9476522Z 2026-10-22 02:07:57 +0000 UTC Normal Successfully pulled image "opensciencegrid/frontier-squid:fresh" in 11.299s (16.212s including waiting). Image size: 453187319 bytes.2026-10-22T02:13:34.9478255Z 2026-10-22 02:07:57 +0000 UTC Normal Container created2026-10-22T02:13:34.9479052Z 2026-10-22 02:07:57 +0000 UTC Normal Container started2026-10-22T02:13:34.9479573Z 2026-10-22T02:13:34.9480247Z ---2026-10-22T02:13:34.9481169Z TestOSPoolEP 2026-10-22T02:13:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:34.9503280Z ospool_ep_test.go:72: ---2026-10-22T02:13:34.9504563Z Events for pod idtoken-generator:2026-10-22T02:13:34.9506006Z 2026-10-22 02:07:29 +0000 UTC Normal Successfully assigned test-ospool-ep-plzepl/idtoken-generator to minikube2026-10-22T02:13:34.9507424Z 2026-10-22 02:07:29 +0000 UTC Normal Pulling image "htcondor/base"2026-10-22T02:13:34.9514078Z 2026-10-22 02:07:34 +0000 UTC Normal Successfully pulled image "htcondor/base" in 5.206s (5.206s including waiting). Image size: 196303183 bytes.2026-10-22T02:13:34.9515368Z 2026-10-22 02:07:34 +0000 UTC Normal Container created2026-10-22T02:13:34.9516163Z 2026-10-22 02:07:34 +0000 UTC Normal Container started2026-10-22T02:13:34.9516692Z 2026-10-22T02:13:34.9517072Z ---2026-10-22T02:13:34.9521010Z TestOSPoolEP 2026-10-22T02:13:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:34.9524392Z ospool_ep_test.go:72: ---2026-10-22T02:13:34.9527848Z Events for pod ospool-ep-674fbdcc48-lkjxx:2026-10-22T02:13:34.9534066Z 2026-10-22 02:07:40 +0000 UTC Normal Successfully assigned test-ospool-ep-plzepl/ospool-ep-674fbdcc48-lkjxx to minikube2026-10-22T02:13:34.9535585Z 2026-10-22 02:07:40 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-10-22T02:13:34.9537564Z 2026-10-22 02:07:59 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.974s (18.164s including waiting). Image size: 2893600 bytes.2026-10-22T02:13:34.9538983Z 2026-10-22 02:07:59 +0000 UTC Normal Container created2026-10-22T02:13:34.9540096Z 2026-10-22 02:07:59 +0000 UTC Normal Container started2026-10-22T02:13:34.9542207Z 2026-10-22 02:08:00 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-10-22T02:13:34.9555386Z 2026-10-22 02:08:11 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 10.972s (10.972s including waiting). Image size: 537408098 bytes.2026-10-22T02:13:34.9557332Z 2026-10-22 02:08:11 +0000 UTC Normal Container created2026-10-22T02:13:34.9558140Z 2026-10-22 02:08:11 +0000 UTC Normal Container started2026-10-22T02:13:34.9558868Z 2026-10-22T02:13:34.9559222Z ---2026-10-22T02:13:34.9561065Z TestOSPoolEP 2026-10-22T02:13:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:34.9562793Z ospool_ep_test.go:72: ---2026-10-22T02:13:34.9563932Z Events for pod test-cm-5886f7986-x9lwj:2026-10-22T02:13:34.9567189Z 2026-10-22 02:07:40 +0000 UTC Normal Successfully assigned test-ospool-ep-plzepl/test-cm-5886f7986-x9lwj to minikube2026-10-22T02:13:34.9568779Z 2026-10-22 02:07:40 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-10-22T02:13:34.9576385Z 2026-10-22 02:08:00 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 940ms (19.072s including waiting). Image size: 196304120 bytes.2026-10-22T02:13:34.9577889Z 2026-10-22 02:08:00 +0000 UTC Normal Container created2026-10-22T02:13:34.9578814Z 2026-10-22 02:08:00 +0000 UTC Normal Container started2026-10-22T02:13:34.9579224Z 2026-10-22T02:13:34.9579798Z ---2026-10-22T02:13:34.9580696Z TestOSPoolEP 2026-10-22T02:13:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:34.9615024Z TestOSPoolEP 2026-10-22T02:13:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl delete -f /tmp/TestOSPoolEP2994197892]2026-10-22T02:13:35.0691386Z TestOSPoolEP 2026-10-22T02:13:35Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-plzepl namespace2026-10-22T02:13:35.0748358Z TestOSPoolEP 2026-10-22T02:13:35Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-plzepl namespace2026-10-22T02:13:35.8594916Z TestOSPoolEP 2026-10-22T02:13:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl delete -f /tmp/TestOSPoolEP2817452043]2026-10-22T02:13:35.9639865Z TestOSPoolEP 2026-10-22T02:13:35Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-plzepl namespace2026-10-22T02:13:35.9696304Z TestOSPoolEP 2026-10-22T02:13:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-plzepl delete -k /tmp/kustomize-template-2629933076]2026-10-22T02:13:36.1152459Z TestOSPoolEP 2026-10-22T02:13:36Z logger.go:67: serviceaccount "cvmfs-nodeplugin" deleted from test-ospool-ep-plzepl namespace2026-10-22T02:13:36.1263371Z TestOSPoolEP 2026-10-22T02:13:36Z logger.go:67: service "frontier-squid" deleted from test-ospool-ep-plzepl namespace2026-10-22T02:13:36.1349010Z TestOSPoolEP 2026-10-22T02:13:36Z logger.go:67: service "test-cm" deleted from test-ospool-ep-plzepl namespace2026-10-22T02:13:36.1410603Z TestOSPoolEP 2026-10-22T02:13:36Z logger.go:67: deployment.apps "cvmfs-nodeplugin" deleted from test-ospool-ep-plzepl namespace2026-10-22T02:13:36.1458242Z TestOSPoolEP 2026-10-22T02:13:36Z logger.go:67: deployment.apps "frontier-squid" deleted from test-ospool-ep-plzepl namespace2026-10-22T02:13:36.1519840Z TestOSPoolEP 2026-10-22T02:13:36Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-plzepl namespace2026-10-22T02:13:36.1594054Z TestOSPoolEP 2026-10-22T02:13:36Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-plzepl namespace2026-10-22T02:13:36.1943375Z --- FAIL: TestOSPoolEP (367.49s)2026-10-22T02:13:36.1973005Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (40.04s)2026-10-22T02:13:36.1991369Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP (11.08s)2026-10-22T02:13:36.1995218Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity (0.57s)2026-10-22T02:13:36.1998336Z --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (302.07s)2026-10-22T02:13:36.1999473Z FAIL2026-10-22T02:13:36.2011101Z FAIL github.com/osg-htc/k8s-integration-tests/test 367.508s2026-10-22T02:13:36.2133162Z FAIL2026-10-22T02:13:36.3810863Z ##[error]Process completed with exit code 1.2026-10-22T02:13:36.3882811Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-22T02:13:36.3883507Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-10-22T02:13:36.3921304Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-22T02:13:36.3921662Z env:2026-10-22T02:13:36.3921889Z GOTOOLCHAIN: local2026-10-22T02:13:36.3922349Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-22T02:13:36.3922874Z ##[endgroup]2026-10-22T02:13:36.4134373Z ##[group]Run actions/upload-artifact@v42026-10-22T02:13:36.4134717Z with:2026-10-22T02:13:36.4135121Z name: TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd72026-10-22T02:13:36.4135594Z path: /tmp/k8s-tests2026-10-22T02:13:36.4135839Z retention-days: 52026-10-22T02:13:36.4136065Z if-no-files-found: warn2026-10-22T02:13:36.4136312Z compression-level: 62026-10-22T02:13:36.4136537Z overwrite: false2026-10-22T02:13:36.4136769Z include-hidden-files: false2026-10-22T02:13:36.4137004Z env:2026-10-22T02:13:36.4137199Z GOTOOLCHAIN: local2026-10-22T02:13:36.4137416Z ##[endgroup]2026-10-22T02:13:36.6070974Z (node:15982) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-22T02:13:36.6075833Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-22T02:13:36.6480265Z With the provided path, there will be 10 files uploaded2026-10-22T02:13:36.6510548Z Artifact name is valid!2026-10-22T02:13:36.6540674Z Root directory input is valid!2026-10-22T02:13:36.8488134Z Beginning upload of artifact content to blob storage2026-10-22T02:13:36.8851539Z (node:15982) [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-22T02:13:36.9350857Z Uploaded bytes 159222026-10-22T02:13:36.9527751Z Finished uploading artifact content to blob storage!2026-10-22T02:13:36.9528936Z SHA256 digest of uploaded artifact zip is ef1d640a1fe7d050d3780dba1087c74e3aec624213d32d5f4b8b85aca7a080d02026-10-22T02:13:36.9530344Z Finalizing artifact upload2026-10-22T02:13:37.4049830Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7.zip successfully finalized. Artifact ID 123965239442026-10-22T02:13:37.4051698Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7 has been successfully uploaded! Final size is 15922 bytes. Artifact ID is 123965239442026-10-22T02:13:37.4057007Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/39709501354/artifacts/123965239442026-10-22T02:13:37.4278679Z Post job cleanup.2026-10-22T02:13:37.5219825Z [command]/usr/bin/git version2026-10-22T02:13:37.5270520Z git version 2.55.02026-10-22T02:13:37.5312177Z Temporarily overriding HOME='/home/runner/work/_temp/305ee028-c252-4e90-bec6-2e301666b018' before making global git config changes2026-10-22T02:13:37.5313569Z Adding repository directory to the temporary git global config as a safe directory2026-10-22T02:13:37.5318455Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-22T02:13:37.5362406Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-22T02:13:37.5403844Z [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-22T02:13:37.5772975Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-22T02:13:37.5793367Z http.https://github.com/.extraheader2026-10-22T02:13:37.5806477Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-10-22T02:13:37.5848641Z [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-22T02:13:37.6149296Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-22T02:13:37.6199477Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-22T02:13:37.6709320Z Cleaning up orphan processes2026-10-22T02:13:37.7645701Z ##[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/