2026-10-14T02:21:00.4438914Z Current runner version: '2.337.0'2026-10-14T02:21:00.4475952Z ##[group]Runner Image Provisioner2026-10-14T02:21:00.4477381Z Hosted Compute Agent2026-10-14T02:21:00.4478420Z Version: 20261002.5962026-10-14T02:21:00.4480041Z Commit: c3d12f3313a95f25162a1503be624f3b0617f8c02026-10-14T02:21:00.4481477Z Build Date: 2026-10-02T22:28:27Z2026-10-14T02:21:00.4482939Z Worker ID: {cfa862ae-627a-4623-9024-7e1b3acb8ec9}2026-10-14T02:21:00.4484317Z Region: eastus2026-10-14T02:21:00.4485381Z Cloud: Azure2026-10-14T02:21:00.4486572Z ##[endgroup]2026-10-14T02:21:00.4488858Z ##[group]Operating System2026-10-14T02:21:00.4490417Z Ubuntu2026-10-14T02:21:00.4491431Z 22.04.52026-10-14T02:21:00.4492357Z LTS2026-10-14T02:21:00.4493396Z ##[endgroup]2026-10-14T02:21:00.4494500Z ##[group]Runner Image2026-10-14T02:21:00.4495744Z Image: ubuntu-22.042026-10-14T02:21:00.4496881Z Version: 20261004.315.12026-10-14T02:21:00.4499347Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20261004.315/images/ubuntu/Ubuntu2204-Readme.md2026-10-14T02:21:00.4502491Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20261004.3152026-10-14T02:21:00.4504862Z ##[endgroup]2026-10-14T02:21:00.4510837Z ##[group]GITHUB_TOKEN Permissions2026-10-14T02:21:00.4514453Z Actions: write2026-10-14T02:21:00.4515605Z ArtifactMetadata: write2026-10-14T02:21:00.4516921Z Attestations: write2026-10-14T02:21:00.4517905Z Checks: write2026-10-14T02:21:00.4518806Z CodeQuality: write2026-10-14T02:21:00.4520184Z Contents: write2026-10-14T02:21:00.4521152Z CopilotRequests: write2026-10-14T02:21:00.4522369Z Deployments: write2026-10-14T02:21:00.4523444Z Discussions: write2026-10-14T02:21:00.4524432Z Drives: write2026-10-14T02:21:00.4525452Z Issues: write2026-10-14T02:21:00.4526584Z Metadata: read2026-10-14T02:21:00.4527707Z Models: read2026-10-14T02:21:00.4528663Z Packages: write2026-10-14T02:21:00.4529594Z Pages: write2026-10-14T02:21:00.4530914Z PullRequests: write2026-10-14T02:21:00.4532033Z RepositoryProjects: write2026-10-14T02:21:00.4533302Z SecurityEvents: write2026-10-14T02:21:00.4534487Z Statuses: write2026-10-14T02:21:00.4535486Z VulnerabilityAlerts: read2026-10-14T02:21:00.4536593Z ##[endgroup]2026-10-14T02:21:00.4540029Z Secret source: Actions2026-10-14T02:21:00.4541668Z Cache mode: write2026-10-14T02:21:00.4542897Z Prepare workflow directory2026-10-14T02:21:00.5015223Z Prepare all required actions2026-10-14T02:21:00.5094719Z Getting action download info2026-10-14T02:21:00.7345645Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-10-14T02:21:00.8652039Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-10-14T02:21:01.0218383Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-10-14T02:21:01.1940324Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-10-14T02:21:01.4688683Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (63ec080e4eea87fb8a9eae678ab9944ec2461251)2026-10-14T02:21:01.4695429Z ##[group] Inputs2026-10-14T02:21:01.4696371Z testName: TestOSPoolEP2026-10-14T02:21:01.4698134Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-14T02:21:01.4700297Z setupScript: 2026-10-14T02:21:01.4701112Z setupEnv: {}2026-10-14T02:21:01.4701911Z ##[endgroup]2026-10-14T02:21:01.4703244Z Complete job name: ospool-ep / Run OSPool EP test (cvmfs-bind, 25-release) / Run Tests2026-10-14T02:21:01.5624683Z ##[group]Run actions/checkout@v52026-10-14T02:21:01.5626112Z with:2026-10-14T02:21:01.5626977Z repository: osg-htc/k8s-integration-tests2026-10-14T02:21:01.5636089Z token: ***2026-10-14T02:21:01.5636922Z ssh-strict: true2026-10-14T02:21:01.5637733Z ssh-user: git2026-10-14T02:21:01.5638573Z persist-credentials: true2026-10-14T02:21:01.5639498Z clean: true2026-10-14T02:21:01.5640797Z sparse-checkout-cone-mode: true2026-10-14T02:21:01.5641799Z fetch-depth: 12026-10-14T02:21:01.5642614Z fetch-tags: false2026-10-14T02:21:01.5643454Z show-progress: true2026-10-14T02:21:01.5644294Z lfs: false2026-10-14T02:21:01.5645061Z submodules: false2026-10-14T02:21:01.5645914Z set-safe-directory: true2026-10-14T02:21:01.5646875Z allow-unsafe-pr-checkout: false2026-10-14T02:21:01.5648470Z ##[endgroup]2026-10-14T02:21:01.6748354Z Syncing repository: osg-htc/k8s-integration-tests2026-10-14T02:21:01.6752722Z ##[group]Getting Git version info2026-10-14T02:21:01.6755439Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-14T02:21:01.6759139Z [command]/usr/bin/git version2026-10-14T02:21:01.6793298Z git version 2.55.02026-10-14T02:21:01.6822325Z ##[endgroup]2026-10-14T02:21:01.6837854Z Temporarily overriding HOME='/home/runner/work/_temp/87eebeab-0d8c-4f0b-bb82-4a390cd51037' before making global git config changes2026-10-14T02:21:01.6842011Z Adding repository directory to the temporary git global config as a safe directory2026-10-14T02:21:01.6846351Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-14T02:21:01.6888789Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-14T02:21:01.6898967Z ##[group]Initializing the repository2026-10-14T02:21:01.6901998Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-14T02:21:01.7025493Z hint: Using 'master' as the name for the initial branch. This default branch name2026-10-14T02:21:01.7028464Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-10-14T02:21:01.7031397Z hint: to use in all of your new repositories, which will suppress this warning,2026-10-14T02:21:01.7033663Z hint: call:2026-10-14T02:21:01.7035073Z hint:2026-10-14T02:21:01.7036774Z hint: git config --global init.defaultBranch <name>2026-10-14T02:21:01.7039019Z hint:2026-10-14T02:21:01.7041534Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-10-14T02:21:01.7044781Z hint: 'development'. The just-created branch can be renamed via this command:2026-10-14T02:21:01.7047057Z hint:2026-10-14T02:21:01.7048289Z hint: git branch -m <name>2026-10-14T02:21:01.7049963Z hint:2026-10-14T02:21:01.7051952Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-10-14T02:21:01.7055934Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-10-14T02:21:01.7062285Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-10-14T02:21:01.7089104Z ##[endgroup]2026-10-14T02:21:01.7091630Z ##[group]Disabling automatic garbage collection2026-10-14T02:21:01.7093791Z [command]/usr/bin/git config --local gc.auto 02026-10-14T02:21:01.7138686Z ##[endgroup]2026-10-14T02:21:01.7140700Z ##[group]Setting up auth2026-10-14T02:21:01.7146405Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-14T02:21:01.7188581Z [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-14T02:21:01.7600634Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-14T02:21:01.7651687Z [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-14T02:21:01.7952243Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-14T02:21:01.8004590Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-14T02:21:01.8294808Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-10-14T02:21:01.8339923Z ##[endgroup]2026-10-14T02:21:01.8342206Z ##[group]Fetching the repository2026-10-14T02:21:01.8350590Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +63ec080e4eea87fb8a9eae678ab9944ec2461251:refs/remotes/origin/main2026-10-14T02:21:02.0665915Z From https://github.com/osg-htc/k8s-integration-tests2026-10-14T02:21:02.0667878Z * [new ref] 63ec080e4eea87fb8a9eae678ab9944ec2461251 -> origin/main2026-10-14T02:21:02.0673364Z ##[endgroup]2026-10-14T02:21:02.0675079Z ##[group]Determining the checkout info2026-10-14T02:21:02.0676646Z ##[endgroup]2026-10-14T02:21:02.0680947Z [command]/usr/bin/git sparse-checkout disable2026-10-14T02:21:02.0738548Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-10-14T02:21:02.0776444Z ##[group]Checking out the ref2026-10-14T02:21:02.0782634Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-10-14T02:21:02.0905408Z Switched to a new branch 'main'2026-10-14T02:21:02.0908447Z branch 'main' set up to track 'origin/main'.2026-10-14T02:21:02.0916579Z ##[endgroup]2026-10-14T02:21:02.0961482Z [command]/usr/bin/git log -1 --format=%H2026-10-14T02:21:02.0993134Z 63ec080e4eea87fb8a9eae678ab9944ec24612512026-10-14T02:21:02.1350397Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-14T02:21:02.1352706Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-14T02:21:02.1354900Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-14T02:21:02.1974702Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-14T02:21:02.1976069Z env:2026-10-14T02:21:02.1977705Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-14T02:21:02.1979915Z SETUP_ENV_YAML: {}2026-10-14T02:21:02.1980851Z ##[endgroup]2026-10-14T02:21:03.2583308Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-14T02:21:03.2584022Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-10-14T02:21:03.2656323Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-14T02:21:03.2656723Z env:2026-10-14T02:21:03.2657222Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfs-bind"}2026-10-14T02:21:03.2657946Z ##[endgroup]2026-10-14T02:21:03.2818472Z ##[group]Run true2026-10-14T02:21:03.2818784Z [36;1mtrue[0m2026-10-14T02:21:03.2889152Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-14T02:21:03.2889557Z ##[endgroup]2026-10-14T02:21:03.3078666Z ##[group]Run medyagh/setup-minikube@latest2026-10-14T02:21:03.3079035Z with:2026-10-14T02:21:03.3079300Z start: true2026-10-14T02:21:03.3079539Z cache: true2026-10-14T02:21:03.3080016Z minikube-version: latest2026-10-14T02:21:03.3080319Z wait: all2026-10-14T02:21:03.3080547Z ##[endgroup]2026-10-14T02:21:03.4460685Z (node:2046) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-14T02:21:03.4462237Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-14T02:21:04.3031022Z [command]/usr/bin/chmod +x /home/runner/work/_temp/c413dc6c-8441-48ff-9e9c-35b09ef8b4252026-10-14T02:21:04.4758879Z [command]/home/runner/bin/minikube version --short2026-10-14T02:21:04.5337461Z v1.39.02026-10-14T02:21:04.6068848Z Cache hit for: kic-v1.39.0-x642026-10-14T02:21:04.6181788Z (node:2046) [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-14T02:21:04.6190120Z Cache hit for: preloaded-tarball-v1.39.0-x64-stable-docker2026-10-14T02:21:05.7304568Z Received 134217728 of 288577004 (46.5%), 119.6 MBs/sec2026-10-14T02:21:05.7305353Z Received 92274688 of 531630645 (17.4%), 83.7 MBs/sec2026-10-14T02:21:06.7317457Z Received 268435456 of 288577004 (93.0%), 123.6 MBs/sec2026-10-14T02:21:06.7318627Z Received 230686720 of 531630645 (43.4%), 107.2 MBs/sec2026-10-14T02:21:06.8526598Z Received 288577004 of 288577004 (100.0%), 125.6 MBs/sec2026-10-14T02:21:06.8527858Z Cache Size: ~275 MB (288577004 B)2026-10-14T02:21:06.9683846Z [command]/usr/bin/tar -xf /home/runner/work/_temp/12b530c9-2bfe-4df2-9507-4f8a261a1991/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-14T02:21:07.7891037Z Received 402653184 of 531630645 (75.7%), 123.5 MBs/sec2026-10-14T02:21:08.0442274Z Cache restored successfully2026-10-14T02:21:08.4794862Z Received 531630645 of 531630645 (100.0%), 133.4 MBs/sec2026-10-14T02:21:08.4796242Z Cache Size: ~507 MB (531630645 B)2026-10-14T02:21:08.4834267Z [command]/usr/bin/tar -xf /home/runner/work/_temp/ce0cd7e3-6f0c-4eb3-85b8-3352fc066e89/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-14T02:21:09.5781467Z Cache restored successfully2026-10-14T02:21:09.6964454Z [command]/home/runner/bin/minikube start --wait all2026-10-14T02:21:09.8581413Z * minikube v1.39.0 on Ubuntu 22.042026-10-14T02:21:10.9950186Z ! 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-14T02:21:10.9962576Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-10-14T02:21:11.2716458Z * Using Docker driver with root privileges2026-10-14T02:21:11.2726633Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-10-14T02:21:11.2733021Z * Pulling base image v0.0.51 ...2026-10-14T02:21:32.9972745Z * Preparing Kubernetes v1.37.0 on containerd 2.3.4 ...2026-10-14T02:21:41.4074058Z * Configuring CNI (Container Networking Interface) ...2026-10-14T02:21:47.2940789Z * Verifying Kubernetes components...2026-10-14T02:21:47.3252939Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-10-14T02:21:47.9629233Z * Enabled addons: default-storageclass, storage-provisioner2026-10-14T02:22:05.5404615Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-10-14T02:22:05.5562220Z [command]/home/runner/bin/minikube version --short2026-10-14T02:22:05.6103529Z v1.39.02026-10-14T02:22:05.6614515Z ##[group]Run actions/setup-go@v62026-10-14T02:22:05.6614813Z with:2026-10-14T02:22:05.6615019Z go-version: 1.262026-10-14T02:22:05.6615230Z cache: true2026-10-14T02:22:05.6615463Z cache-dependency-path: go.sum2026-10-14T02:22:05.6615720Z check-latest: false2026-10-14T02:22:05.6618198Z token: ***2026-10-14T02:22:05.6618432Z ##[endgroup]2026-10-14T02:22:05.8044436Z Setup go version spec 1.262026-10-14T02:22:05.9377756Z Found in cache @ /opt/hostedtoolcache/go/1.26.8/x642026-10-14T02:22:05.9378962Z Added go to the path2026-10-14T02:22:05.9384473Z Successfully set up Go version 1.262026-10-14T02:22:07.1717902Z [command]/opt/hostedtoolcache/go/1.26.8/x64/bin/go env GOMODCACHE2026-10-14T02:22:07.1756144Z [command]/opt/hostedtoolcache/go/1.26.8/x64/bin/go env GOCACHE2026-10-14T02:22:07.1791287Z /home/runner/go/pkg/mod2026-10-14T02:22:07.1815093Z /home/runner/.cache/go-build2026-10-14T02:22:07.2528120Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.8-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-14T02:22:08.3888291Z Received 134217728 of 249179669 (53.9%), 119.1 MBs/sec2026-10-14T02:22:09.1201817Z Received 249179669 of 249179669 (100.0%), 131.6 MBs/sec2026-10-14T02:22:09.1203279Z Cache Size: ~238 MB (249179669 B)2026-10-14T02:22:09.1274099Z [command]/usr/bin/tar -xf /home/runner/work/_temp/cafcfeea-51a6-4dee-a780-bd813dd7de91/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-14T02:22:12.4181018Z Cache restored successfully2026-10-14T02:22:12.4797201Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.8-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-14T02:22:12.4824096Z go version go1.26.8 linux/amd642026-10-14T02:22:12.4824329Z 2026-10-14T02:22:12.4824656Z ##[group]go env2026-10-14T02:22:12.5841283Z AR='ar'2026-10-14T02:22:12.5841735Z CC='gcc'2026-10-14T02:22:12.5842086Z CGO_CFLAGS='-O2 -g'2026-10-14T02:22:12.5842554Z CGO_CPPFLAGS=''2026-10-14T02:22:12.5842955Z CGO_CXXFLAGS='-O2 -g'2026-10-14T02:22:12.5843456Z CGO_ENABLED='1'2026-10-14T02:22:12.5843831Z CGO_FFLAGS='-O2 -g'2026-10-14T02:22:12.5844214Z CGO_LDFLAGS='-O2 -g'2026-10-14T02:22:12.5844649Z CXX='g++'2026-10-14T02:22:12.5844997Z GCCGO='gccgo'2026-10-14T02:22:12.5845345Z GO111MODULE=''2026-10-14T02:22:12.5845721Z GOAMD64='v1'2026-10-14T02:22:12.5846055Z GOARCH='amd64'2026-10-14T02:22:12.5846403Z GOAUTH='netrc'2026-10-14T02:22:12.5846767Z GOBIN=''2026-10-14T02:22:12.5847169Z GOCACHE='/home/runner/.cache/go-build'2026-10-14T02:22:12.5847653Z GOCACHEPROG=''2026-10-14T02:22:12.5848016Z GODEBUG=''2026-10-14T02:22:12.5848386Z GOENV='/home/runner/.config/go/env'2026-10-14T02:22:12.5848827Z GOEXE=''2026-10-14T02:22:12.5849188Z GOEXPERIMENT=''2026-10-14T02:22:12.5849559Z GOFIPS140='off'2026-10-14T02:22:12.5850244Z GOFLAGS=''2026-10-14T02:22:12.5851410Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build1809103556=/tmp/go-build -gno-record-gcc-switches'2026-10-14T02:22:12.5852563Z GOHOSTARCH='amd64'2026-10-14T02:22:12.5852938Z GOHOSTOS='linux'2026-10-14T02:22:12.5853299Z GOINSECURE=''2026-10-14T02:22:12.5853932Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-10-14T02:22:12.5854707Z GOMODCACHE='/home/runner/go/pkg/mod'2026-10-14T02:22:12.5855188Z GONOPROXY=''2026-10-14T02:22:12.5855551Z GONOSUMDB=''2026-10-14T02:22:12.5855889Z GOOS='linux'2026-10-14T02:22:12.5856270Z GOPATH='/home/runner/go'2026-10-14T02:22:12.5856689Z GOPRIVATE=''2026-10-14T02:22:12.5857140Z GOPROXY='https://proxy.golang.org,direct'2026-10-14T02:22:12.5857727Z GOROOT='/opt/hostedtoolcache/go/1.26.8/x64'2026-10-14T02:22:12.5858235Z GOSUMDB='sum.golang.org'2026-10-14T02:22:12.5858654Z GOTELEMETRY='local'2026-10-14T02:22:12.5859119Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-10-14T02:22:12.5859825Z GOTMPDIR=''2026-10-14T02:22:12.5860197Z GOTOOLCHAIN='local'2026-10-14T02:22:12.5861136Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.8/x64/pkg/tool/linux_amd64'2026-10-14T02:22:12.5861759Z GOVCS=''2026-10-14T02:22:12.5862104Z GOVERSION='go1.26.8'2026-10-14T02:22:12.5862473Z GOWORK=''2026-10-14T02:22:12.5862818Z PKG_CONFIG='pkg-config'2026-10-14T02:22:12.5863074Z 2026-10-14T02:22:12.5863589Z ##[endgroup]2026-10-14T02:22:12.6147061Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-14T02:22:12.6147583Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-10-14T02:22:12.6221567Z shell: /usr/bin/bash -e {0}2026-10-14T02:22:12.6221841Z env:2026-10-14T02:22:12.6222042Z GOTOOLCHAIN: local2026-10-14T02:22:12.6222301Z OSPOOL_EP_OSPoolEPTag: 25-release2026-10-14T02:22:12.6222582Z OSPOOL_EP_CMTag: 25.0-el92026-10-14T02:22:12.6222850Z OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-14T02:22:12.6223110Z ##[endgroup]2026-10-14T02:22:21.6141118Z === RUN TestOSPoolEP2026-10-14T02:22:21.6143558Z === PAUSE TestOSPoolEP2026-10-14T02:22:21.6144038Z === CONT TestOSPoolEP2026-10-14T02:22:21.6145137Z TestOSPoolEP 2026-10-14T02:22:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:22:21.6242179Z TestOSPoolEP 2026-10-14T02:22:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn apply -f /tmp/TestOSPoolEP2970415254]2026-10-14T02:22:21.9192802Z TestOSPoolEP 2026-10-14T02:22:21Z logger.go:67: pod/idtoken-generator created2026-10-14T02:22:21.9270656Z TestOSPoolEP 2026-10-14T02:22:21Z logger.go:67: secret/pool-passwd created2026-10-14T02:22:21.9337907Z TestOSPoolEP 2026-10-14T02:22:21Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-14T02:22:21.9340161Z TestOSPoolEP 2026-10-14T02:22:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:22:21.9381354Z TestOSPoolEP 2026-10-14T02:22:21Z 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-14T02:22:31.9393043Z TestOSPoolEP 2026-10-14T02:22:31Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-14T02:22:31.9394443Z TestOSPoolEP 2026-10-14T02:22:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:22:31.9472782Z TestOSPoolEP 2026-10-14T02:22:31Z logger.go:67: Pod is now available2026-10-14T02:22:31.9475246Z TestOSPoolEP 2026-10-14T02:22:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-10-14T02:22:32.4794198Z TestOSPoolEP 2026-10-14T02:22:32Z logger.go:67: ***2026-10-14T02:22:32.4852330Z TestOSPoolEP 2026-10-14T02:22:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn apply -f /tmp/TestOSPoolEP2341687213]2026-10-14T02:22:32.5888893Z TestOSPoolEP 2026-10-14T02:22:32Z logger.go:67: secret/pool-token created2026-10-14T02:22:32.5919919Z TestOSPoolEP 2026-10-14T02:22:32Z retry.go:91: Wait for secret pool-token to be provisioned.2026-10-14T02:22:32.5921297Z TestOSPoolEP 2026-10-14T02:22:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:22:32.5943438Z TestOSPoolEP 2026-10-14T02:22:32Z logger.go:67: Secret is now available2026-10-14T02:22:32.5976246Z TestOSPoolEP 2026-10-14T02:22:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn apply -k /tmp/kustomize-template-2567205378]2026-10-14T02:22:32.7945585Z TestOSPoolEP 2026-10-14T02:22:32Z logger.go:67: serviceaccount/cvmfs-nodeplugin created2026-10-14T02:22:32.8043510Z TestOSPoolEP 2026-10-14T02:22:32Z logger.go:67: service/frontier-squid created2026-10-14T02:22:32.8211736Z TestOSPoolEP 2026-10-14T02:22:32Z logger.go:67: service/test-cm created2026-10-14T02:22:32.8352757Z TestOSPoolEP 2026-10-14T02:22:32Z logger.go:67: deployment.apps/cvmfs-nodeplugin created2026-10-14T02:22:32.8476736Z TestOSPoolEP 2026-10-14T02:22:32Z logger.go:67: deployment.apps/frontier-squid created2026-10-14T02:22:32.8647244Z TestOSPoolEP 2026-10-14T02:22:32Z 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-14T02:22:32.8655803Z TestOSPoolEP 2026-10-14T02:22:32Z logger.go:67: deployment.apps/ospool-ep created2026-10-14T02:22:32.8982589Z TestOSPoolEP 2026-10-14T02:22:32Z logger.go:67: deployment.apps/test-cm created2026-10-14T02:22:32.9056632Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-10-14T02:22:32.9058341Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:22:32.9287014Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:32Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-14T02:22:32.9296137Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:32Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-14T02:22:32.9304140Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:22:32.9311862Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:22:32.9314789Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:32Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-14T02:22:32.9319925Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:22:32.9322427Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:32Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-14T02:22:32.9324636Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:22:32.9402478Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:32Z 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-7f9d786cd6". Sleeping for 10s and will try again.2026-10-14T02:22:32.9435246Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:32Z 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-14T02:22:32.9439135Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:32Z 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-cc75b66b9". Sleeping for 10s and will try again.2026-10-14T02:22:32.9444267Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:32Z 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-14T02:22:42.9403813Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:42Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-14T02:22:42.9417011Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:22:42.9452884Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:42Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-14T02:22:42.9455866Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:22:42.9459129Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:42Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-14T02:22:42.9462801Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:22:42.9472397Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:42Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-14T02:22:42.9475633Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:22:42.9481511Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:42Z 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-7f9d786cd6" is progressing.. Sleeping for 10s and will try again.2026-10-14T02:22:42.9518314Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:42Z logger.go:67: Deployment is now available2026-10-14T02:22:42.9527876Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:42Z 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-cc75b66b9" is progressing.. Sleeping for 10s and will try again.2026-10-14T02:22:42.9536474Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:42Z 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-14T02:22:52.9474863Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:52Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-14T02:22:52.9476131Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:22:52.9504343Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:52Z 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-7f9d786cd6" is progressing.. Sleeping for 10s and will try again.2026-10-14T02:22:52.9545375Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:52Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-14T02:22:52.9547231Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:52Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-14T02:22:52.9549128Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:22:52.9551763Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:22:52.9567666Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:52Z logger.go:67: Deployment is now available2026-10-14T02:22:52.9580322Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:22:52Z 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-cc75b66b9" is progressing.. Sleeping for 10s and will try again.2026-10-14T02:23:02.9507225Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:23:02Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-14T02:23:02.9509245Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:23:02Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:23:02.9533675Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:23:02Z logger.go:67: Deployment is now available2026-10-14T02:23:02.9585410Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:23:02Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-14T02:23:02.9587321Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:23:02Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:23:02.9618086Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:23:02Z 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-cc75b66b9" is progressing.. Sleeping for 10s and will try again.2026-10-14T02:23:12.9628755Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:23:12Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-14T02:23:12.9631606Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:23:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:23:12.9657429Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-14T02:23:12Z logger.go:67: Deployment is now available2026-10-14T02:23:12.9659385Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP2026-10-14T02:23:12.9671146Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-14T02:23:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:23:12.9692565Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-14T02:23:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn cp ../test-configs/ospool-ep/condor_status.sh test-cm-7f9d786cd6-sppf7:/tmp/condor_status.sh]2026-10-14T02:23:13.3193141Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-14T02:23:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn exec test-cm-7f9d786cd6-sppf7 -- chmod +x /tmp/condor_status.sh]2026-10-14T02:23:13.4612683Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-14T02:23:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn exec test-cm-7f9d786cd6-sppf7 -- sh -c /tmp/condor_status.sh]2026-10-14T02:23:13.6252303Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-14T02:23:13Z logger.go:67: command terminated with exit code 12026-10-14T02:23:13.6269231Z test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-7f9d786cd6-sppf7 failed. Retrying in 10s.2026-10-14T02:23:23.6279140Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-14T02:23:23Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn exec test-cm-7f9d786cd6-sppf7 -- sh -c /tmp/condor_status.sh]2026-10-14T02:23:23.7772702Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity2026-10-14T02:23:23.7780187Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-14T02:23:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:23:23.7817494Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-14T02:23:23Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn cp ../test-configs/ospool-ep/has_singularity.sh test-cm-7f9d786cd6-sppf7:/tmp/has_singularity.sh]2026-10-14T02:23:23.9792374Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-14T02:23:23Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn exec test-cm-7f9d786cd6-sppf7 -- chmod +x /tmp/has_singularity.sh]2026-10-14T02:23:24.0847664Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-14T02:23:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn exec test-cm-7f9d786cd6-sppf7 -- sh -c /tmp/has_singularity.sh]2026-10-14T02:23:24.2190208Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-10-14T02:23:24.2192294Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:23:24Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:23:24.2235816Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:23:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn cp ../test-configs/ospool-ep/has_cvmfs.sh test-cm-7f9d786cd6-sppf7:/tmp/has_cvmfs.sh]2026-10-14T02:23:24.3713239Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:23:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn exec test-cm-7f9d786cd6-sppf7 -- chmod +x /tmp/has_cvmfs.sh]2026-10-14T02:23:24.4723754Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:23:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn exec test-cm-7f9d786cd6-sppf7 -- sh -c /tmp/has_cvmfs.sh]2026-10-14T02:23:24.5912974Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:23:24Z logger.go:67: command terminated with exit code 12026-10-14T02:23:24.5947042Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-sppf7 failed. Retrying in 30s.2026-10-14T02:23:54.5955125Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:23:54Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn exec test-cm-7f9d786cd6-sppf7 -- sh -c /tmp/has_cvmfs.sh]2026-10-14T02:23:54.7091573Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:23:54Z logger.go:67: command terminated with exit code 12026-10-14T02:23:54.7117247Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-sppf7 failed. Retrying in 30s.2026-10-14T02:24:24.7125408Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:24:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn exec test-cm-7f9d786cd6-sppf7 -- sh -c /tmp/has_cvmfs.sh]2026-10-14T02:24:24.8341396Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:24:24Z logger.go:67: command terminated with exit code 12026-10-14T02:24:24.8345224Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-sppf7 failed. Retrying in 30s.2026-10-14T02:24:54.8346701Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:24:54Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn exec test-cm-7f9d786cd6-sppf7 -- sh -c /tmp/has_cvmfs.sh]2026-10-14T02:24:54.9414111Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:24:54Z logger.go:67: command terminated with exit code 12026-10-14T02:24:54.9443209Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-sppf7 failed. Retrying in 30s.2026-10-14T02:25:24.9463258Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:25:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn exec test-cm-7f9d786cd6-sppf7 -- sh -c /tmp/has_cvmfs.sh]2026-10-14T02:25:25.0474440Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:25:25Z logger.go:67: command terminated with exit code 12026-10-14T02:25:25.0500977Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-sppf7 failed. Retrying in 30s.2026-10-14T02:25:55.0528632Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:25:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn exec test-cm-7f9d786cd6-sppf7 -- sh -c /tmp/has_cvmfs.sh]2026-10-14T02:25:55.1533126Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:25:55Z logger.go:67: command terminated with exit code 12026-10-14T02:25:55.1559562Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-sppf7 failed. Retrying in 30s.2026-10-14T02:26:25.1568024Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:26:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn exec test-cm-7f9d786cd6-sppf7 -- sh -c /tmp/has_cvmfs.sh]2026-10-14T02:26:25.2597864Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:26:25Z logger.go:67: command terminated with exit code 12026-10-14T02:26:25.2625750Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-sppf7 failed. Retrying in 30s.2026-10-14T02:26:55.2641262Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:26:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn exec test-cm-7f9d786cd6-sppf7 -- sh -c /tmp/has_cvmfs.sh]2026-10-14T02:26:55.3645664Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:26:55Z logger.go:67: command terminated with exit code 12026-10-14T02:26:55.3672571Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-sppf7 failed. Retrying in 30s.2026-10-14T02:27:25.3677597Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:27:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn exec test-cm-7f9d786cd6-sppf7 -- sh -c /tmp/has_cvmfs.sh]2026-10-14T02:27:25.4684277Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:27:25Z logger.go:67: command terminated with exit code 12026-10-14T02:27:25.4710955Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-sppf7 failed. Retrying in 30s.2026-10-14T02:27:55.4728810Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:27:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn exec test-cm-7f9d786cd6-sppf7 -- sh -c /tmp/has_cvmfs.sh]2026-10-14T02:27:55.5763311Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-14T02:27:55Z logger.go:67: command terminated with exit code 12026-10-14T02:27:55.5791809Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-sppf7 failed. Retrying in 30s.2026-10-14T02:28:25.5823495Z test_utils.go:105: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-sppf7 did not succeed within {10 30000000000} retries2026-10-14T02:28:25.5825331Z TestOSPoolEP 2026-10-14T02:28:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:28:25.5920277Z TestOSPoolEP 2026-10-14T02:28:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:28:25.6894843Z TestOSPoolEP 2026-10-14T02:28:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:28:25.7560201Z TestOSPoolEP 2026-10-14T02:28:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:28:25.8252701Z TestOSPoolEP 2026-10-14T02:28:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:28:25.9155194Z TestOSPoolEP 2026-10-14T02:28:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:28:25.9847810Z TestOSPoolEP 2026-10-14T02:28:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:28:25.9876528Z === NAME TestOSPoolEP2026-10-14T02:28:25.9877084Z ospool_ep_test.go:72: ---2026-10-14T02:28:25.9877812Z Events for pod cvmfs-nodeplugin-5cd89c7cfd-q94pn:2026-10-14T02:28:25.9879331Z 2026-10-14 02:22:32 +0000 UTC Normal Successfully assigned test-ospool-ep-hcvofn/cvmfs-nodeplugin-5cd89c7cfd-q94pn to minikube2026-10-14T02:28:25.9881050Z 2026-10-14 02:22:33 +0000 UTC Normal Pulling image "opensciencegrid/cvmfs-nodeplugin:fresh"2026-10-14T02:28:25.9883066Z 2026-10-14 02:22:39 +0000 UTC Normal Successfully pulled image "opensciencegrid/cvmfs-nodeplugin:fresh" in 5.751s (5.751s including waiting). Image size: 155940803 bytes.2026-10-14T02:28:25.9884539Z 2026-10-14 02:22:39 +0000 UTC Normal Container created2026-10-14T02:28:25.9885361Z 2026-10-14 02:22:39 +0000 UTC Normal Container started2026-10-14T02:28:25.9886286Z 2026-10-14T02:28:25.9886622Z ---2026-10-14T02:28:25.9887503Z TestOSPoolEP 2026-10-14T02:28:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:28:25.9904402Z ospool_ep_test.go:72: ---2026-10-14T02:28:25.9905339Z Events for pod frontier-squid-65f85c968-szgm6:2026-10-14T02:28:25.9906756Z 2026-10-14 02:22:32 +0000 UTC Normal Successfully assigned test-ospool-ep-hcvofn/frontier-squid-65f85c968-szgm6 to minikube2026-10-14T02:28:25.9908215Z 2026-10-14 02:22:33 +0000 UTC Normal Pulling image "opensciencegrid/frontier-squid:fresh"2026-10-14T02:28:25.9910612Z 2026-10-14 02:22:52 +0000 UTC Normal Successfully pulled image "opensciencegrid/frontier-squid:fresh" in 11.627s (19.226s including waiting). Image size: 453187319 bytes.2026-10-14T02:28:25.9912366Z 2026-10-14 02:22:52 +0000 UTC Normal Container created2026-10-14T02:28:25.9913173Z 2026-10-14 02:22:52 +0000 UTC Normal Container started2026-10-14T02:28:25.9913681Z 2026-10-14T02:28:25.9914012Z ---2026-10-14T02:28:25.9914897Z TestOSPoolEP 2026-10-14T02:28:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:28:25.9937590Z ospool_ep_test.go:72: ---2026-10-14T02:28:25.9938302Z Events for pod idtoken-generator:2026-10-14T02:28:25.9940017Z 2026-10-14 02:22:21 +0000 UTC Normal Successfully assigned test-ospool-ep-hcvofn/idtoken-generator to minikube2026-10-14T02:28:25.9941432Z 2026-10-14 02:22:22 +0000 UTC Normal Pulling image "htcondor/base"2026-10-14T02:28:25.9943191Z 2026-10-14 02:22:27 +0000 UTC Normal Successfully pulled image "htcondor/base" in 5.044s (5.044s including waiting). Image size: 196303183 bytes.2026-10-14T02:28:25.9944597Z 2026-10-14 02:22:27 +0000 UTC Normal Container created2026-10-14T02:28:25.9945552Z 2026-10-14 02:22:27 +0000 UTC Normal Container started2026-10-14T02:28:25.9946124Z 2026-10-14T02:28:25.9946502Z ---2026-10-14T02:28:25.9947501Z TestOSPoolEP 2026-10-14T02:28:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:28:25.9966397Z ospool_ep_test.go:72: ---2026-10-14T02:28:25.9967322Z Events for pod ospool-ep-cc75b66b9-ltmfr:2026-10-14T02:28:25.9969120Z 2026-10-14 02:22:32 +0000 UTC Normal Successfully assigned test-ospool-ep-hcvofn/ospool-ep-cc75b66b9-ltmfr to minikube2026-10-14T02:28:25.9970925Z 2026-10-14 02:22:33 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-10-14T02:28:25.9973231Z 2026-10-14 02:22:40 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.855s (7.604s including waiting). Image size: 2893600 bytes.2026-10-14T02:28:25.9974634Z 2026-10-14 02:22:40 +0000 UTC Normal Container created2026-10-14T02:28:25.9975374Z 2026-10-14 02:22:41 +0000 UTC Normal Container started2026-10-14T02:28:25.9976141Z 2026-10-14 02:22:41 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-10-14T02:28:25.9980846Z 2026-10-14 02:23:09 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 12.666s (27.855s including waiting). Image size: 528828146 bytes.2026-10-14T02:28:25.9983421Z 2026-10-14 02:23:09 +0000 UTC Normal Container created2026-10-14T02:28:25.9984338Z 2026-10-14 02:23:09 +0000 UTC Normal Container started2026-10-14T02:28:25.9984664Z 2026-10-14T02:28:25.9985075Z ---2026-10-14T02:28:25.9985655Z TestOSPoolEP 2026-10-14T02:28:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:28:25.9992420Z ospool_ep_test.go:72: ---2026-10-14T02:28:25.9993074Z Events for pod test-cm-7f9d786cd6-sppf7:2026-10-14T02:28:25.9994426Z 2026-10-14 02:22:32 +0000 UTC Normal Successfully assigned test-ospool-ep-hcvofn/test-cm-7f9d786cd6-sppf7 to minikube2026-10-14T02:28:25.9995442Z 2026-10-14 02:22:33 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-10-14T02:28:25.9996718Z 2026-10-14 02:22:56 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 4.38s (23.545s including waiting). Image size: 198153089 bytes.2026-10-14T02:28:25.9997715Z 2026-10-14 02:22:56 +0000 UTC Normal Container created2026-10-14T02:28:26.0004279Z 2026-10-14 02:22:57 +0000 UTC Normal Container started2026-10-14T02:28:26.0004866Z 2026-10-14T02:28:26.0005291Z ---2026-10-14T02:28:26.0005930Z TestOSPoolEP 2026-10-14T02:28:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-14T02:28:26.0036153Z TestOSPoolEP 2026-10-14T02:28:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn delete -f /tmp/TestOSPoolEP1502915608]2026-10-14T02:28:26.0698169Z TestOSPoolEP 2026-10-14T02:28:26Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-hcvofn namespace2026-10-14T02:28:26.0751873Z TestOSPoolEP 2026-10-14T02:28:26Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-hcvofn namespace2026-10-14T02:28:27.7934561Z TestOSPoolEP 2026-10-14T02:28:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn delete -f /tmp/TestOSPoolEP3322219596]2026-10-14T02:28:27.8618448Z TestOSPoolEP 2026-10-14T02:28:27Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-hcvofn namespace2026-10-14T02:28:27.8668985Z TestOSPoolEP 2026-10-14T02:28:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-hcvofn delete -k /tmp/kustomize-template-2567205378]2026-10-14T02:28:27.9498256Z TestOSPoolEP 2026-10-14T02:28:27Z logger.go:67: serviceaccount "cvmfs-nodeplugin" deleted from test-ospool-ep-hcvofn namespace2026-10-14T02:28:27.9584842Z TestOSPoolEP 2026-10-14T02:28:27Z logger.go:67: service "frontier-squid" deleted from test-ospool-ep-hcvofn namespace2026-10-14T02:28:27.9706699Z TestOSPoolEP 2026-10-14T02:28:27Z logger.go:67: service "test-cm" deleted from test-ospool-ep-hcvofn namespace2026-10-14T02:28:27.9736337Z TestOSPoolEP 2026-10-14T02:28:27Z logger.go:67: deployment.apps "cvmfs-nodeplugin" deleted from test-ospool-ep-hcvofn namespace2026-10-14T02:28:27.9777456Z TestOSPoolEP 2026-10-14T02:28:27Z logger.go:67: deployment.apps "frontier-squid" deleted from test-ospool-ep-hcvofn namespace2026-10-14T02:28:27.9831849Z TestOSPoolEP 2026-10-14T02:28:27Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-hcvofn namespace2026-10-14T02:28:27.9886004Z TestOSPoolEP 2026-10-14T02:28:27Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-hcvofn namespace2026-10-14T02:28:28.0235649Z --- FAIL: TestOSPoolEP (366.41s)2026-10-14T02:28:28.0237267Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (40.06s)2026-10-14T02:28:28.0238331Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP (10.81s)2026-10-14T02:28:28.0239374Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity (0.44s)2026-10-14T02:28:28.0240904Z --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (301.36s)2026-10-14T02:28:28.0241539Z FAIL2026-10-14T02:28:28.0281737Z FAIL github.com/osg-htc/k8s-integration-tests/test 366.428s2026-10-14T02:28:28.0424749Z FAIL2026-10-14T02:28:28.2225269Z ##[error]Process completed with exit code 1.2026-10-14T02:28:28.2297789Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-14T02:28:28.2298439Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-10-14T02:28:28.2377308Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-14T02:28:28.2377672Z env:2026-10-14T02:28:28.2377880Z GOTOOLCHAIN: local2026-10-14T02:28:28.2378341Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-14T02:28:28.2379061Z ##[endgroup]2026-10-14T02:28:28.2925831Z ##[group]Run actions/upload-artifact@v42026-10-14T02:28:28.2926327Z with:2026-10-14T02:28:28.2926935Z name: TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f02026-10-14T02:28:28.2927671Z path: /tmp/k8s-tests2026-10-14T02:28:28.2928035Z retention-days: 52026-10-14T02:28:28.2928381Z if-no-files-found: warn2026-10-14T02:28:28.2928762Z compression-level: 62026-10-14T02:28:28.2929118Z overwrite: false2026-10-14T02:28:28.2929471Z include-hidden-files: false2026-10-14T02:28:28.2930096Z env:2026-10-14T02:28:28.2930403Z GOTOOLCHAIN: local2026-10-14T02:28:28.2930740Z ##[endgroup]2026-10-14T02:28:28.5325708Z (node:15921) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-14T02:28:28.5335097Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-14T02:28:28.5531305Z With the provided path, there will be 10 files uploaded2026-10-14T02:28:28.5533492Z Artifact name is valid!2026-10-14T02:28:28.5534411Z Root directory input is valid!2026-10-14T02:28:28.7697853Z Beginning upload of artifact content to blob storage2026-10-14T02:28:28.8167610Z (node:15921) [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-14T02:28:28.8369916Z Uploaded bytes 159442026-10-14T02:28:28.8515031Z Finished uploading artifact content to blob storage!2026-10-14T02:28:28.8516410Z SHA256 digest of uploaded artifact zip is 88fc254f599cd092e33ccaa4e81a0a76dcfb31a8f59ca85418f1d993117513fd2026-10-14T02:28:28.8518234Z Finalizing artifact upload2026-10-14T02:28:29.0512068Z Artifact TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f0.zip successfully finalized. Artifact ID 118654048212026-10-14T02:28:29.0514311Z Artifact TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f0 has been successfully uploaded! Final size is 15944 bytes. Artifact ID is 118654048212026-10-14T02:28:29.0516209Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/38500554840/artifacts/118654048212026-10-14T02:28:29.0793916Z Post job cleanup.2026-10-14T02:28:29.1848431Z [command]/usr/bin/git version2026-10-14T02:28:29.1904186Z git version 2.55.02026-10-14T02:28:29.1961253Z Temporarily overriding HOME='/home/runner/work/_temp/c68bdad7-4ecc-4062-9ce0-cba9f0e72c76' before making global git config changes2026-10-14T02:28:29.1962978Z Adding repository directory to the temporary git global config as a safe directory2026-10-14T02:28:29.1964504Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-14T02:28:29.2014200Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-14T02:28:29.2102001Z [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-14T02:28:29.2474380Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-14T02:28:29.2518379Z http.https://github.com/.extraheader2026-10-14T02:28:29.2563206Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-10-14T02:28:29.2594099Z [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-14T02:28:29.3088336Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-14T02:28:29.3186873Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-14T02:28:29.3894048Z Cleaning up orphan processes2026-10-14T02:28:29.4882763Z ##[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/