2026-10-12T02:51:29.1664368Z Current runner version: '2.337.0'2026-10-12T02:51:29.1689104Z ##[group]Runner Image Provisioner2026-10-12T02:51:29.1690107Z Hosted Compute Agent2026-10-12T02:51:29.1690726Z Version: 20261002.5962026-10-12T02:51:29.1691451Z Commit: c3d12f3313a95f25162a1503be624f3b0617f8c02026-10-12T02:51:29.1692551Z Build Date: 2026-10-02T22:28:27Z2026-10-12T02:51:29.1693357Z Worker ID: {9fefb732-8ba0-4bd2-88fe-f5f8985fb021}2026-10-12T02:51:29.1694213Z Region: westcentralus2026-10-12T02:51:29.1694831Z Cloud: Azure2026-10-12T02:51:29.1695430Z ##[endgroup]2026-10-12T02:51:29.1697103Z ##[group]Operating System2026-10-12T02:51:29.1697784Z Ubuntu2026-10-12T02:51:29.1698418Z 22.04.52026-10-12T02:51:29.1698964Z LTS2026-10-12T02:51:29.1699480Z ##[endgroup]2026-10-12T02:51:29.1700146Z ##[group]Runner Image2026-10-12T02:51:29.1700870Z Image: ubuntu-22.042026-10-12T02:51:29.1701514Z Version: 20261004.315.12026-10-12T02:51:29.1703092Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20261004.315/images/ubuntu/Ubuntu2204-Readme.md2026-10-12T02:51:29.1704809Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20261004.3152026-10-12T02:51:29.1705798Z ##[endgroup]2026-10-12T02:51:29.1709652Z ##[group]GITHUB_TOKEN Permissions2026-10-12T02:51:29.1712029Z Actions: write2026-10-12T02:51:29.1713007Z ArtifactMetadata: write2026-10-12T02:51:29.1713712Z Attestations: write2026-10-12T02:51:29.1714350Z Checks: write2026-10-12T02:51:29.1714961Z CodeQuality: write2026-10-12T02:51:29.1715544Z Contents: write2026-10-12T02:51:29.1716179Z CopilotRequests: write2026-10-12T02:51:29.1716817Z Deployments: write2026-10-12T02:51:29.1717400Z Discussions: write2026-10-12T02:51:29.1718063Z Drives: write2026-10-12T02:51:29.1718618Z Issues: write2026-10-12T02:51:29.1719388Z Metadata: read2026-10-12T02:51:29.1719951Z Models: read2026-10-12T02:51:29.1720483Z Packages: write2026-10-12T02:51:29.1721136Z Pages: write2026-10-12T02:51:29.1721721Z PullRequests: write2026-10-12T02:51:29.1722690Z RepositoryProjects: write2026-10-12T02:51:29.1723426Z SecurityEvents: write2026-10-12T02:51:29.1724024Z Statuses: write2026-10-12T02:51:29.1724694Z VulnerabilityAlerts: read2026-10-12T02:51:29.1725312Z ##[endgroup]2026-10-12T02:51:29.1727574Z Secret source: Actions2026-10-12T02:51:29.1728548Z Cache mode: write2026-10-12T02:51:29.1729305Z Prepare workflow directory2026-10-12T02:51:29.2120043Z Prepare all required actions2026-10-12T02:51:29.2167818Z Getting action download info2026-10-12T02:51:29.5367695Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-10-12T02:51:29.7034841Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-10-12T02:51:30.1941354Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-10-12T02:51:30.6927092Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-10-12T02:51:30.9672593Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (63ec080e4eea87fb8a9eae678ab9944ec2461251)2026-10-12T02:51:30.9679091Z ##[group] Inputs2026-10-12T02:51:30.9680128Z testName: TestOSPoolEP2026-10-12T02:51:30.9682033Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-12T02:51:30.9684293Z setupScript: 2026-10-12T02:51:30.9685223Z setupEnv: {}2026-10-12T02:51:30.9686127Z ##[endgroup]2026-10-12T02:51:30.9687570Z Complete job name: ospool-ep / Run OSPool EP test (cvmfs-bind, 25-testing) / Run Tests2026-10-12T02:51:31.0690532Z ##[group]Run actions/checkout@v52026-10-12T02:51:31.0691988Z with:2026-10-12T02:51:31.0693860Z repository: osg-htc/k8s-integration-tests2026-10-12T02:51:31.0704656Z token: ***2026-10-12T02:51:31.0705566Z ssh-strict: true2026-10-12T02:51:31.0706633Z ssh-user: git2026-10-12T02:51:31.0707623Z persist-credentials: true2026-10-12T02:51:31.0709337Z clean: true2026-10-12T02:51:31.0710875Z sparse-checkout-cone-mode: true2026-10-12T02:51:31.0712977Z fetch-depth: 12026-10-12T02:51:31.0714523Z fetch-tags: false2026-10-12T02:51:31.0715617Z show-progress: true2026-10-12T02:51:31.0716542Z lfs: false2026-10-12T02:51:31.0717634Z submodules: false2026-10-12T02:51:31.0719464Z set-safe-directory: true2026-10-12T02:51:31.0720714Z allow-unsafe-pr-checkout: false2026-10-12T02:51:31.0723736Z ##[endgroup]2026-10-12T02:51:31.1962169Z Syncing repository: osg-htc/k8s-integration-tests2026-10-12T02:51:31.1966458Z ##[group]Getting Git version info2026-10-12T02:51:31.1969441Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-12T02:51:31.1973834Z [command]/usr/bin/git version2026-10-12T02:51:31.2069852Z git version 2.55.02026-10-12T02:51:31.2097083Z ##[endgroup]2026-10-12T02:51:31.2113879Z Temporarily overriding HOME='/home/runner/work/_temp/a002fcdf-85ed-479c-bc69-8b1a3a09e99c' before making global git config changes2026-10-12T02:51:31.2118847Z Adding repository directory to the temporary git global config as a safe directory2026-10-12T02:51:31.2124120Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-12T02:51:31.2170379Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-12T02:51:31.2180096Z ##[group]Initializing the repository2026-10-12T02:51:31.2185121Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-12T02:51:31.2369848Z hint: Using 'master' as the name for the initial branch. This default branch name2026-10-12T02:51:31.2374154Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-10-12T02:51:31.2377831Z hint: to use in all of your new repositories, which will suppress this warning,2026-10-12T02:51:31.2381172Z hint: call:2026-10-12T02:51:31.2383245Z hint:2026-10-12T02:51:31.2385431Z hint: git config --global init.defaultBranch <name>2026-10-12T02:51:31.2387810Z hint:2026-10-12T02:51:31.2389986Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-10-12T02:51:31.2396560Z hint: 'development'. The just-created branch can be renamed via this command:2026-10-12T02:51:31.2399674Z hint:2026-10-12T02:51:31.2401553Z hint: git branch -m <name>2026-10-12T02:51:31.2404082Z hint:2026-10-12T02:51:31.2406741Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-10-12T02:51:31.2411284Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-10-12T02:51:31.2418975Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-10-12T02:51:31.2445501Z ##[endgroup]2026-10-12T02:51:31.2448953Z ##[group]Disabling automatic garbage collection2026-10-12T02:51:31.2451793Z [command]/usr/bin/git config --local gc.auto 02026-10-12T02:51:31.2498052Z ##[endgroup]2026-10-12T02:51:31.2499951Z ##[group]Setting up auth2026-10-12T02:51:31.2505846Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-12T02:51:31.2548040Z [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-12T02:51:31.3043603Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-12T02:51:31.3086610Z [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-12T02:51:31.3374008Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-12T02:51:31.3417255Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-12T02:51:31.3683006Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-10-12T02:51:31.3728360Z ##[endgroup]2026-10-12T02:51:31.3729975Z ##[group]Fetching the repository2026-10-12T02:51:31.3738269Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +63ec080e4eea87fb8a9eae678ab9944ec2461251:refs/remotes/origin/main2026-10-12T02:51:31.8150173Z From https://github.com/osg-htc/k8s-integration-tests2026-10-12T02:51:31.8152021Z * [new ref] 63ec080e4eea87fb8a9eae678ab9944ec2461251 -> origin/main2026-10-12T02:51:31.8156417Z ##[endgroup]2026-10-12T02:51:31.8157955Z ##[group]Determining the checkout info2026-10-12T02:51:31.8238248Z ##[endgroup]2026-10-12T02:51:31.8240706Z [command]/usr/bin/git sparse-checkout disable2026-10-12T02:51:31.8247245Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-10-12T02:51:31.8260088Z ##[group]Checking out the ref2026-10-12T02:51:31.8264103Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-10-12T02:51:31.8372782Z Switched to a new branch 'main'2026-10-12T02:51:31.8375686Z branch 'main' set up to track 'origin/main'.2026-10-12T02:51:31.8383769Z ##[endgroup]2026-10-12T02:51:31.8428843Z [command]/usr/bin/git log -1 --format=%H2026-10-12T02:51:31.8460910Z 63ec080e4eea87fb8a9eae678ab9944ec24612512026-10-12T02:51:31.8736151Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-12T02:51:31.8738459Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-12T02:51:31.8740638Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-12T02:51:31.9303275Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-12T02:51:31.9304609Z env:2026-10-12T02:51:31.9306194Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-12T02:51:31.9308106Z SETUP_ENV_YAML: {}2026-10-12T02:51:31.9308979Z ##[endgroup]2026-10-12T02:51:32.0269411Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-12T02:51:32.0271614Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-10-12T02:51:32.0351151Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-12T02:51:32.0352554Z env:2026-10-12T02:51:32.0354187Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfs-bind"}2026-10-12T02:51:32.0356094Z ##[endgroup]2026-10-12T02:51:32.0571305Z ##[group]Run true2026-10-12T02:51:32.0572197Z [36;1mtrue[0m2026-10-12T02:51:32.0652190Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-12T02:51:32.0653635Z ##[endgroup]2026-10-12T02:51:32.0959769Z ##[group]Run medyagh/setup-minikube@latest2026-10-12T02:51:32.0960859Z with:2026-10-12T02:51:32.0961610Z start: true2026-10-12T02:51:32.0962549Z cache: true2026-10-12T02:51:32.0963385Z minikube-version: latest2026-10-12T02:51:32.0964294Z wait: all2026-10-12T02:51:32.0965079Z ##[endgroup]2026-10-12T02:51:32.2390369Z (node:2191) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-12T02:51:32.2393514Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-12T02:51:33.6325255Z [command]/usr/bin/chmod +x /home/runner/work/_temp/ec489a8c-45bf-430c-98c6-037c8a17f9512026-10-12T02:51:33.8222083Z [command]/home/runner/bin/minikube version --short2026-10-12T02:51:33.8716847Z v1.39.02026-10-12T02:51:34.0765739Z Cache hit for: kic-v1.39.0-x642026-10-12T02:51:34.0893398Z Cache hit for: preloaded-tarball-v1.39.0-x64-stable-docker2026-10-12T02:51:34.0910381Z (node:2191) [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-12T02:51:35.2992055Z Received 41943040 of 531630645 (7.9%), 39.8 MBs/sec2026-10-12T02:51:35.3193283Z Received 25165824 of 288577004 (8.7%), 23.9 MBs/sec2026-10-12T02:51:36.3886803Z Received 134217728 of 531630645 (25.2%), 61.1 MBs/sec2026-10-12T02:51:36.3887887Z Received 134217728 of 288577004 (46.5%), 61.8 MBs/sec2026-10-12T02:51:37.3894676Z Received 264241152 of 531630645 (49.7%), 81.4 MBs/sec2026-10-12T02:51:37.3895729Z Received 268435456 of 288577004 (93.0%), 83.3 MBs/sec2026-10-12T02:51:37.6008525Z Received 288577004 of 288577004 (100.0%), 83.8 MBs/sec2026-10-12T02:51:37.6010132Z Cache Size: ~275 MB (288577004 B)2026-10-12T02:51:37.6047789Z [command]/usr/bin/tar -xf /home/runner/work/_temp/79967050-37a1-4ae9-b1ff-325fbb4ec258/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-12T02:51:38.4030279Z Received 377487360 of 531630645 (71.0%), 87.8 MBs/sec2026-10-12T02:51:38.5063455Z Cache restored successfully2026-10-12T02:51:39.3978688Z Received 527436341 of 531630645 (99.2%), 98.6 MBs/sec2026-10-12T02:51:39.5762921Z Received 531630645 of 531630645 (100.0%), 96.0 MBs/sec2026-10-12T02:51:39.5764454Z Cache Size: ~507 MB (531630645 B)2026-10-12T02:51:39.5801071Z [command]/usr/bin/tar -xf /home/runner/work/_temp/749170bc-58ba-40f8-8b03-d4f732aa4e62/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-12T02:51:40.4319906Z Cache restored successfully2026-10-12T02:51:40.5522546Z [command]/home/runner/bin/minikube start --wait all2026-10-12T02:51:40.6048372Z * minikube v1.39.0 on Ubuntu 22.042026-10-12T02:51:41.1419567Z ! 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-12T02:51:41.1423983Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-10-12T02:51:41.2017027Z * Using Docker driver with root privileges2026-10-12T02:51:41.2031801Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-10-12T02:51:41.2041254Z * Pulling base image v0.0.51 ...2026-10-12T02:52:03.3448899Z * Preparing Kubernetes v1.37.0 on containerd 2.3.4 ...2026-10-12T02:52:11.3628672Z * Configuring CNI (Container Networking Interface) ...2026-10-12T02:52:17.2836323Z * Verifying Kubernetes components...2026-10-12T02:52:17.3134874Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-10-12T02:52:17.9086861Z * Enabled addons: storage-provisioner, default-storageclass2026-10-12T02:52:37.8152194Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-10-12T02:52:37.8281411Z [command]/home/runner/bin/minikube version --short2026-10-12T02:52:37.8835256Z v1.39.02026-10-12T02:52:37.9367992Z ##[group]Run actions/setup-go@v62026-10-12T02:52:37.9368303Z with:2026-10-12T02:52:37.9368503Z go-version: 1.262026-10-12T02:52:37.9368716Z cache: true2026-10-12T02:52:37.9368934Z cache-dependency-path: go.sum2026-10-12T02:52:37.9369185Z check-latest: false2026-10-12T02:52:37.9371716Z token: ***2026-10-12T02:52:37.9371919Z ##[endgroup]2026-10-12T02:52:38.0762684Z Setup go version spec 1.262026-10-12T02:52:38.0825190Z Found in cache @ /opt/hostedtoolcache/go/1.26.8/x642026-10-12T02:52:38.0827910Z Added go to the path2026-10-12T02:52:38.0830949Z Successfully set up Go version 1.262026-10-12T02:52:39.5374525Z [command]/opt/hostedtoolcache/go/1.26.8/x64/bin/go env GOMODCACHE2026-10-12T02:52:39.5414718Z [command]/opt/hostedtoolcache/go/1.26.8/x64/bin/go env GOCACHE2026-10-12T02:52:39.5446886Z /home/runner/go/pkg/mod2026-10-12T02:52:39.5482217Z /home/runner/.cache/go-build2026-10-12T02:52:39.7509336Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.8-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-12T02:52:40.9730780Z Received 46137344 of 249179669 (18.5%), 44.0 MBs/sec2026-10-12T02:52:41.9725229Z Received 213909504 of 249179669 (85.8%), 101.9 MBs/sec2026-10-12T02:52:42.2170292Z Received 249179669 of 249179669 (100.0%), 105.9 MBs/sec2026-10-12T02:52:42.2172059Z Cache Size: ~238 MB (249179669 B)2026-10-12T02:52:42.2211679Z [command]/usr/bin/tar -xf /home/runner/work/_temp/a9459c0e-9028-49e8-a11f-eb64a1cfe3dc/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-12T02:52:45.4316590Z Cache restored successfully2026-10-12T02:52:45.4897512Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.8-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-12T02:52:45.4926990Z go version go1.26.8 linux/amd642026-10-12T02:52:45.4927322Z 2026-10-12T02:52:45.4927802Z ##[group]go env2026-10-12T02:52:45.5577125Z AR='ar'2026-10-12T02:52:45.5577545Z CC='gcc'2026-10-12T02:52:45.5577969Z CGO_CFLAGS='-O2 -g'2026-10-12T02:52:45.5578392Z CGO_CPPFLAGS=''2026-10-12T02:52:45.5578822Z CGO_CXXFLAGS='-O2 -g'2026-10-12T02:52:45.5579213Z CGO_ENABLED='1'2026-10-12T02:52:45.5579579Z CGO_FFLAGS='-O2 -g'2026-10-12T02:52:45.5580181Z CGO_LDFLAGS='-O2 -g'2026-10-12T02:52:45.5580557Z CXX='g++'2026-10-12T02:52:45.5580888Z GCCGO='gccgo'2026-10-12T02:52:45.5581233Z GO111MODULE=''2026-10-12T02:52:45.5581565Z GOAMD64='v1'2026-10-12T02:52:45.5581912Z GOARCH='amd64'2026-10-12T02:52:45.5582233Z GOAUTH='netrc'2026-10-12T02:52:45.5583091Z GOBIN=''2026-10-12T02:52:45.5583472Z GOCACHE='/home/runner/.cache/go-build'2026-10-12T02:52:45.5583960Z GOCACHEPROG=''2026-10-12T02:52:45.5584298Z GODEBUG=''2026-10-12T02:52:45.5584749Z GOENV='/home/runner/.config/go/env'2026-10-12T02:52:45.5585196Z GOEXE=''2026-10-12T02:52:45.5585527Z GOEXPERIMENT=''2026-10-12T02:52:45.5585876Z GOFIPS140='off'2026-10-12T02:52:45.5586212Z GOFLAGS=''2026-10-12T02:52:45.5587339Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build2654686474=/tmp/go-build -gno-record-gcc-switches'2026-10-12T02:52:45.5588491Z GOHOSTARCH='amd64'2026-10-12T02:52:45.5588861Z GOHOSTOS='linux'2026-10-12T02:52:45.5589210Z GOINSECURE=''2026-10-12T02:52:45.5589805Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-10-12T02:52:45.5590516Z GOMODCACHE='/home/runner/go/pkg/mod'2026-10-12T02:52:45.5590974Z GONOPROXY=''2026-10-12T02:52:45.5591302Z GONOSUMDB=''2026-10-12T02:52:45.5591626Z GOOS='linux'2026-10-12T02:52:45.5591973Z GOPATH='/home/runner/go'2026-10-12T02:52:45.5592638Z GOPRIVATE=''2026-10-12T02:52:45.5593097Z GOPROXY='https://proxy.golang.org,direct'2026-10-12T02:52:45.5593675Z GOROOT='/opt/hostedtoolcache/go/1.26.8/x64'2026-10-12T02:52:45.5594170Z GOSUMDB='sum.golang.org'2026-10-12T02:52:45.5594585Z GOTELEMETRY='local'2026-10-12T02:52:45.5595037Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-10-12T02:52:45.5595566Z GOTMPDIR=''2026-10-12T02:52:45.5596244Z GOTOOLCHAIN='local'2026-10-12T02:52:45.5596800Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.8/x64/pkg/tool/linux_amd64'2026-10-12T02:52:45.5597424Z GOVCS=''2026-10-12T02:52:45.5597765Z GOVERSION='go1.26.8'2026-10-12T02:52:45.5598136Z GOWORK=''2026-10-12T02:52:45.5598497Z PKG_CONFIG='pkg-config'2026-10-12T02:52:45.5598750Z 2026-10-12T02:52:45.5599258Z ##[endgroup]2026-10-12T02:52:45.5955927Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-12T02:52:45.5956453Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-10-12T02:52:45.6027079Z shell: /usr/bin/bash -e {0}2026-10-12T02:52:45.6027348Z env:2026-10-12T02:52:45.6027550Z GOTOOLCHAIN: local2026-10-12T02:52:45.6027814Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-10-12T02:52:45.6028155Z OSPOOL_EP_CMTag: 25.x-el92026-10-12T02:52:45.6028470Z OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-12T02:52:45.6028730Z ##[endgroup]2026-10-12T02:52:56.0567660Z === RUN TestOSPoolEP2026-10-12T02:52:56.0570566Z === PAUSE TestOSPoolEP2026-10-12T02:52:56.0571051Z === CONT TestOSPoolEP2026-10-12T02:52:56.0576203Z TestOSPoolEP 2026-10-12T02:52:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:52:56.0663951Z TestOSPoolEP 2026-10-12T02:52:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 apply -f /tmp/TestOSPoolEP1028524672]2026-10-12T02:52:56.3682465Z TestOSPoolEP 2026-10-12T02:52:56Z logger.go:67: pod/idtoken-generator created2026-10-12T02:52:56.3767405Z TestOSPoolEP 2026-10-12T02:52:56Z logger.go:67: secret/pool-passwd created2026-10-12T02:52:56.3793428Z TestOSPoolEP 2026-10-12T02:52:56Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-12T02:52:56.3796939Z TestOSPoolEP 2026-10-12T02:52:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:52:56.3832176Z TestOSPoolEP 2026-10-12T02:52:56Z retry.go:103: Wait for pod idtoken-generator to be provisioned. returned an error: Pod idtoken-generator is not available, reason: , message: . Sleeping for 10s and will try again.2026-10-12T02:53:06.3828505Z TestOSPoolEP 2026-10-12T02:53:06Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-12T02:53:06.3833126Z TestOSPoolEP 2026-10-12T02:53:06Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:06.3857182Z TestOSPoolEP 2026-10-12T02:53:06Z logger.go:67: Pod is now available2026-10-12T02:53:06.3858985Z TestOSPoolEP 2026-10-12T02:53:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-10-12T02:53:06.9489368Z TestOSPoolEP 2026-10-12T02:53:06Z logger.go:67: ***2026-10-12T02:53:06.9544030Z TestOSPoolEP 2026-10-12T02:53:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 apply -f /tmp/TestOSPoolEP3679532709]2026-10-12T02:53:07.0552170Z TestOSPoolEP 2026-10-12T02:53:07Z logger.go:67: secret/pool-token created2026-10-12T02:53:07.0584070Z TestOSPoolEP 2026-10-12T02:53:07Z retry.go:91: Wait for secret pool-token to be provisioned.2026-10-12T02:53:07.0585306Z TestOSPoolEP 2026-10-12T02:53:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:07.0602046Z TestOSPoolEP 2026-10-12T02:53:07Z logger.go:67: Secret is now available2026-10-12T02:53:07.0631042Z TestOSPoolEP 2026-10-12T02:53:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 apply -k /tmp/kustomize-template-3654598260]2026-10-12T02:53:07.2376725Z TestOSPoolEP 2026-10-12T02:53:07Z logger.go:67: serviceaccount/cvmfs-nodeplugin created2026-10-12T02:53:07.2447872Z TestOSPoolEP 2026-10-12T02:53:07Z logger.go:67: service/frontier-squid created2026-10-12T02:53:07.2551884Z TestOSPoolEP 2026-10-12T02:53:07Z logger.go:67: service/test-cm created2026-10-12T02:53:07.2635094Z TestOSPoolEP 2026-10-12T02:53:07Z logger.go:67: deployment.apps/cvmfs-nodeplugin created2026-10-12T02:53:07.2705177Z TestOSPoolEP 2026-10-12T02:53:07Z logger.go:67: deployment.apps/frontier-squid created2026-10-12T02:53:07.2964782Z TestOSPoolEP 2026-10-12T02:53:07Z 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-12T02:53:07.2969996Z TestOSPoolEP 2026-10-12T02:53:07Z logger.go:67: deployment.apps/ospool-ep created2026-10-12T02:53:07.3144219Z TestOSPoolEP 2026-10-12T02:53:07Z logger.go:67: deployment.apps/test-cm created2026-10-12T02:53:07.3188776Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-10-12T02:53:07.3191739Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:07.3254125Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:07Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-12T02:53:07.3275339Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:07.3280507Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:07Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-12T02:53:07.3286718Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:07.3289117Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:07Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-12T02:53:07.3291471Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:07.3294102Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:07Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-12T02:53:07.3296419Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:07.3346114Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:07Z 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-12T02:53:07.3356067Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:07Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-674fbdcc48". Sleeping for 10s and will try again.2026-10-12T02:53:07.3361674Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:07Z 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-12T02:53:07.3399913Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:07Z 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-12T02:53:17.3355758Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:17Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-12T02:53:17.3358420Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:17.3363192Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:17Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-12T02:53:17.3383255Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:17.3385632Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:17Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-12T02:53:17.3387769Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:17.3420904Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:17Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-12T02:53:17.3423471Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:17.3436685Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:17Z 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-12T02:53:17.3441725Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:17Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-674fbdcc48" is progressing.. Sleeping for 10s and will try again.2026-10-12T02:53:17.3445146Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:17Z logger.go:67: Deployment is now available2026-10-12T02:53:17.3451272Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:17Z 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-12T02:53:27.3415799Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:27Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-12T02:53:27.3417892Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:27.3442809Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:27Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-12T02:53:27.3445056Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:27.3448733Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:27Z 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-12T02:53:27.3462681Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:27Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-12T02:53:27.3465642Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:27.3469859Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:27Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-674fbdcc48" is progressing.. Sleeping for 10s and will try again.2026-10-12T02:53:27.3480372Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:27Z logger.go:67: Deployment is now available2026-10-12T02:53:37.3446458Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:37Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-12T02:53:37.3462786Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:37.3467057Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:37Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-12T02:53:37.3469725Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:37.3496545Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:37Z logger.go:67: Deployment is now available2026-10-12T02:53:37.3525208Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:37Z 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-12T02:53:47.3525850Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:47Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-12T02:53:47.3527845Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:47.3557265Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-12T02:53:47Z logger.go:67: Deployment is now available2026-10-12T02:53:47.3560035Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP2026-10-12T02:53:47.3563147Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-12T02:53:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:47.3596140Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-12T02:53:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 cp ../test-configs/ospool-ep/condor_status.sh test-cm-5886f7986-2ldlj:/tmp/condor_status.sh]2026-10-12T02:53:47.6971678Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-12T02:53:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 exec test-cm-5886f7986-2ldlj -- chmod +x /tmp/condor_status.sh]2026-10-12T02:53:47.8298432Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-12T02:53:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 exec test-cm-5886f7986-2ldlj -- sh -c /tmp/condor_status.sh]2026-10-12T02:53:47.9769480Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-12T02:53:47Z logger.go:67: command terminated with exit code 12026-10-12T02:53:47.9804988Z test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-5886f7986-2ldlj failed. Retrying in 10s.2026-10-12T02:53:57.9807661Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-12T02:53:57Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 exec test-cm-5886f7986-2ldlj -- sh -c /tmp/condor_status.sh]2026-10-12T02:53:58.1044588Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity2026-10-12T02:53:58.1046285Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-12T02:53:58Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:58.1074090Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-12T02:53:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 cp ../test-configs/ospool-ep/has_singularity.sh test-cm-5886f7986-2ldlj:/tmp/has_singularity.sh]2026-10-12T02:53:58.2429009Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-12T02:53:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 exec test-cm-5886f7986-2ldlj -- chmod +x /tmp/has_singularity.sh]2026-10-12T02:53:58.3556273Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-12T02:53:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 exec test-cm-5886f7986-2ldlj -- sh -c /tmp/has_singularity.sh]2026-10-12T02:53:58.4799951Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-10-12T02:53:58.4801653Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:53:58Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:53:58.4828407Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:53:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 cp ../test-configs/ospool-ep/has_cvmfs.sh test-cm-5886f7986-2ldlj:/tmp/has_cvmfs.sh]2026-10-12T02:53:58.6219196Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:53:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 exec test-cm-5886f7986-2ldlj -- chmod +x /tmp/has_cvmfs.sh]2026-10-12T02:53:58.7262961Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:53:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 exec test-cm-5886f7986-2ldlj -- sh -c /tmp/has_cvmfs.sh]2026-10-12T02:53:58.8497082Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:53:58Z logger.go:67: command terminated with exit code 12026-10-12T02:53:58.8525256Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-2ldlj failed. Retrying in 30s.2026-10-12T02:54:28.8535388Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:54:28Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 exec test-cm-5886f7986-2ldlj -- sh -c /tmp/has_cvmfs.sh]2026-10-12T02:54:28.9660868Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:54:28Z logger.go:67: command terminated with exit code 12026-10-12T02:54:28.9694465Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-2ldlj failed. Retrying in 30s.2026-10-12T02:54:58.9704991Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:54:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 exec test-cm-5886f7986-2ldlj -- sh -c /tmp/has_cvmfs.sh]2026-10-12T02:54:59.0826865Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:54:59Z logger.go:67: command terminated with exit code 12026-10-12T02:54:59.0854600Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-2ldlj failed. Retrying in 30s.2026-10-12T02:55:29.0866710Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:55:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 exec test-cm-5886f7986-2ldlj -- sh -c /tmp/has_cvmfs.sh]2026-10-12T02:55:29.1883811Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:55:29Z logger.go:67: command terminated with exit code 12026-10-12T02:55:29.1909230Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-2ldlj failed. Retrying in 30s.2026-10-12T02:55:59.1913777Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:55:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 exec test-cm-5886f7986-2ldlj -- sh -c /tmp/has_cvmfs.sh]2026-10-12T02:55:59.2929647Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:55:59Z logger.go:67: command terminated with exit code 12026-10-12T02:55:59.2955220Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-2ldlj failed. Retrying in 30s.2026-10-12T02:56:29.2986328Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:56:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 exec test-cm-5886f7986-2ldlj -- sh -c /tmp/has_cvmfs.sh]2026-10-12T02:56:29.4020027Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:56:29Z logger.go:67: command terminated with exit code 12026-10-12T02:56:29.4048592Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-2ldlj failed. Retrying in 30s.2026-10-12T02:56:59.4078168Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:56:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 exec test-cm-5886f7986-2ldlj -- sh -c /tmp/has_cvmfs.sh]2026-10-12T02:56:59.5116256Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:56:59Z logger.go:67: command terminated with exit code 12026-10-12T02:56:59.5140216Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-2ldlj failed. Retrying in 30s.2026-10-12T02:57:29.5166212Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:57:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 exec test-cm-5886f7986-2ldlj -- sh -c /tmp/has_cvmfs.sh]2026-10-12T02:57:29.6168591Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:57:29Z logger.go:67: command terminated with exit code 12026-10-12T02:57:29.6197817Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-2ldlj failed. Retrying in 30s.2026-10-12T02:57:59.6223647Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:57:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 exec test-cm-5886f7986-2ldlj -- sh -c /tmp/has_cvmfs.sh]2026-10-12T02:57:59.7205699Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:57:59Z logger.go:67: command terminated with exit code 12026-10-12T02:57:59.7232024Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-2ldlj failed. Retrying in 30s.2026-10-12T02:58:29.7253729Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:58:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 exec test-cm-5886f7986-2ldlj -- sh -c /tmp/has_cvmfs.sh]2026-10-12T02:58:29.8305617Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-12T02:58:29Z logger.go:67: command terminated with exit code 12026-10-12T02:58:29.8331038Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-2ldlj failed. Retrying in 30s.2026-10-12T02:58:59.8347994Z test_utils.go:105: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-2ldlj did not succeed within {10 30000000000} retries2026-10-12T02:58:59.8350376Z TestOSPoolEP 2026-10-12T02:58:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:58:59.8451603Z TestOSPoolEP 2026-10-12T02:58:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:58:59.9447950Z TestOSPoolEP 2026-10-12T02:58:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:59:00.0132722Z TestOSPoolEP 2026-10-12T02:59:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:59:00.0927322Z TestOSPoolEP 2026-10-12T02:59:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:59:00.1769141Z TestOSPoolEP 2026-10-12T02:59:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:59:00.2443044Z TestOSPoolEP 2026-10-12T02:59:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:59:00.2481944Z === NAME TestOSPoolEP2026-10-12T02:59:00.2487740Z ospool_ep_test.go:72: ---2026-10-12T02:59:00.2488749Z Events for pod cvmfs-nodeplugin-5cd89c7cfd-l7xl7:2026-10-12T02:59:00.2490261Z 2026-10-12 02:53:07 +0000 UTC Normal Successfully assigned test-ospool-ep-ypme84/cvmfs-nodeplugin-5cd89c7cfd-l7xl7 to minikube2026-10-12T02:59:00.2491748Z 2026-10-12 02:53:07 +0000 UTC Normal Pulling image "opensciencegrid/cvmfs-nodeplugin:fresh"2026-10-12T02:59:00.2493975Z 2026-10-12 02:53:13 +0000 UTC Normal Successfully pulled image "opensciencegrid/cvmfs-nodeplugin:fresh" in 5.624s (5.624s including waiting). Image size: 155940803 bytes.2026-10-12T02:59:00.2495707Z 2026-10-12 02:53:13 +0000 UTC Normal Container created2026-10-12T02:59:00.2496497Z 2026-10-12 02:53:13 +0000 UTC Normal Container started2026-10-12T02:59:00.2497002Z 2026-10-12T02:59:00.2497333Z ---2026-10-12T02:59:00.2498253Z TestOSPoolEP 2026-10-12T02:59:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:59:00.2518418Z ospool_ep_test.go:72: ---2026-10-12T02:59:00.2519878Z Events for pod frontier-squid-65f85c968-fq7wn:2026-10-12T02:59:00.2529678Z 2026-10-12 02:53:07 +0000 UTC Normal Successfully assigned test-ospool-ep-ypme84/frontier-squid-65f85c968-fq7wn to minikube2026-10-12T02:59:00.2531553Z 2026-10-12 02:53:07 +0000 UTC Normal Pulling image "opensciencegrid/frontier-squid:fresh"2026-10-12T02:59:00.2533947Z 2026-10-12 02:53:23 +0000 UTC Normal Successfully pulled image "opensciencegrid/frontier-squid:fresh" in 10.202s (15.793s including waiting). Image size: 453187319 bytes.2026-10-12T02:59:00.2535480Z 2026-10-12 02:53:23 +0000 UTC Normal Container created2026-10-12T02:59:00.2536352Z 2026-10-12 02:53:23 +0000 UTC Normal Container started2026-10-12T02:59:00.2536951Z 2026-10-12T02:59:00.2537353Z ---2026-10-12T02:59:00.2539797Z TestOSPoolEP 2026-10-12T02:59:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:59:00.2559075Z ospool_ep_test.go:72: ---2026-10-12T02:59:00.2564848Z Events for pod idtoken-generator:2026-10-12T02:59:00.2566093Z 2026-10-12 02:52:56 +0000 UTC Normal Successfully assigned test-ospool-ep-ypme84/idtoken-generator to minikube2026-10-12T02:59:00.2567021Z 2026-10-12 02:52:56 +0000 UTC Normal Pulling image "htcondor/base"2026-10-12T02:59:00.2568158Z 2026-10-12 02:53:02 +0000 UTC Normal Successfully pulled image "htcondor/base" in 6.162s (6.162s including waiting). Image size: 196303183 bytes.2026-10-12T02:59:00.2569085Z 2026-10-12 02:53:02 +0000 UTC Normal Container created2026-10-12T02:59:00.2569729Z 2026-10-12 02:53:03 +0000 UTC Normal Container started2026-10-12T02:59:00.2570358Z 2026-10-12T02:59:00.2571358Z ---2026-10-12T02:59:00.2573526Z TestOSPoolEP 2026-10-12T02:59:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:59:00.2598840Z ospool_ep_test.go:72: ---2026-10-12T02:59:00.2599601Z Events for pod ospool-ep-674fbdcc48-t6cdl:2026-10-12T02:59:00.2601087Z 2026-10-12 02:53:07 +0000 UTC Normal Successfully assigned test-ospool-ep-ypme84/ospool-ep-674fbdcc48-t6cdl to minikube2026-10-12T02:59:00.2602941Z 2026-10-12 02:53:07 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-10-12T02:59:00.2605015Z 2026-10-12 02:53:26 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 2.614s (18.334s including waiting). Image size: 2893600 bytes.2026-10-12T02:59:00.2607639Z 2026-10-12 02:53:26 +0000 UTC Normal Container created2026-10-12T02:59:00.2608996Z 2026-10-12 02:53:26 +0000 UTC Normal Container started2026-10-12T02:59:00.2610975Z 2026-10-12 02:53:26 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-10-12T02:59:00.2614315Z 2026-10-12 02:53:40 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 12.814s (13.594s including waiting). Image size: 550955439 bytes.2026-10-12T02:59:00.2616844Z 2026-10-12 02:53:40 +0000 UTC Normal Container created2026-10-12T02:59:00.2618154Z 2026-10-12 02:53:40 +0000 UTC Normal Container started2026-10-12T02:59:00.2619181Z 2026-10-12T02:59:00.2620298Z ---2026-10-12T02:59:00.2621747Z TestOSPoolEP 2026-10-12T02:59:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:59:00.2640498Z ospool_ep_test.go:72: ---2026-10-12T02:59:00.2641911Z Events for pod test-cm-5886f7986-2ldlj:2026-10-12T02:59:00.2643642Z 2026-10-12 02:53:07 +0000 UTC Normal Successfully assigned test-ospool-ep-ypme84/test-cm-5886f7986-2ldlj to minikube2026-10-12T02:59:00.2645113Z 2026-10-12 02:53:07 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-10-12T02:59:00.2647203Z 2026-10-12 02:53:27 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 1.429s (19.762s including waiting). Image size: 196304120 bytes.2026-10-12T02:59:00.2648657Z 2026-10-12 02:53:27 +0000 UTC Normal Container created2026-10-12T02:59:00.2649543Z 2026-10-12 02:53:27 +0000 UTC Normal Container started2026-10-12T02:59:00.2650104Z 2026-10-12T02:59:00.2650479Z ---2026-10-12T02:59:00.2651402Z TestOSPoolEP 2026-10-12T02:59:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-12T02:59:00.2702892Z TestOSPoolEP 2026-10-12T02:59:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 delete -f /tmp/TestOSPoolEP282300544]2026-10-12T02:59:00.3325920Z TestOSPoolEP 2026-10-12T02:59:00Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-ypme84 namespace2026-10-12T02:59:00.3435832Z TestOSPoolEP 2026-10-12T02:59:00Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-ypme84 namespace2026-10-12T02:59:01.5373713Z TestOSPoolEP 2026-10-12T02:59:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 delete -f /tmp/TestOSPoolEP177391537]2026-10-12T02:59:01.5965116Z TestOSPoolEP 2026-10-12T02:59:01Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-ypme84 namespace2026-10-12T02:59:01.6005915Z TestOSPoolEP 2026-10-12T02:59:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ypme84 delete -k /tmp/kustomize-template-3654598260]2026-10-12T02:59:01.6750518Z TestOSPoolEP 2026-10-12T02:59:01Z logger.go:67: serviceaccount "cvmfs-nodeplugin" deleted from test-ospool-ep-ypme84 namespace2026-10-12T02:59:01.6869369Z TestOSPoolEP 2026-10-12T02:59:01Z logger.go:67: service "frontier-squid" deleted from test-ospool-ep-ypme84 namespace2026-10-12T02:59:01.6953364Z TestOSPoolEP 2026-10-12T02:59:01Z logger.go:67: service "test-cm" deleted from test-ospool-ep-ypme84 namespace2026-10-12T02:59:01.6987530Z TestOSPoolEP 2026-10-12T02:59:01Z logger.go:67: deployment.apps "cvmfs-nodeplugin" deleted from test-ospool-ep-ypme84 namespace2026-10-12T02:59:01.7044974Z TestOSPoolEP 2026-10-12T02:59:01Z logger.go:67: deployment.apps "frontier-squid" deleted from test-ospool-ep-ypme84 namespace2026-10-12T02:59:01.7110284Z TestOSPoolEP 2026-10-12T02:59:01Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-ypme84 namespace2026-10-12T02:59:01.7187581Z TestOSPoolEP 2026-10-12T02:59:01Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-ypme84 namespace2026-10-12T02:59:01.7618371Z --- FAIL: TestOSPoolEP (365.70s)2026-10-12T02:59:01.7651943Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (40.04s)2026-10-12T02:59:01.7653425Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP (10.75s)2026-10-12T02:59:01.7654691Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity (0.38s)2026-10-12T02:59:01.7656877Z --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (301.35s)2026-10-12T02:59:01.7657635Z FAIL2026-10-12T02:59:01.7660844Z FAIL github.com/osg-htc/k8s-integration-tests/test 365.723s2026-10-12T02:59:01.7799395Z FAIL2026-10-12T02:59:01.9566411Z ##[error]Process completed with exit code 1.2026-10-12T02:59:01.9645367Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-12T02:59:01.9646742Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-10-12T02:59:01.9756512Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-12T02:59:01.9757617Z env:2026-10-12T02:59:01.9758024Z GOTOOLCHAIN: local2026-10-12T02:59:01.9758900Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-12T02:59:01.9759960Z ##[endgroup]2026-10-12T02:59:02.0061095Z ##[group]Run actions/upload-artifact@v42026-10-12T02:59:02.0061641Z with:2026-10-12T02:59:02.0062545Z name: TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd72026-10-12T02:59:02.0063402Z path: /tmp/k8s-tests2026-10-12T02:59:02.0063809Z retention-days: 52026-10-12T02:59:02.0064191Z if-no-files-found: warn2026-10-12T02:59:02.0064621Z compression-level: 62026-10-12T02:59:02.0065019Z overwrite: false2026-10-12T02:59:02.0065418Z include-hidden-files: false2026-10-12T02:59:02.0065837Z env:2026-10-12T02:59:02.0066185Z GOTOOLCHAIN: local2026-10-12T02:59:02.0066556Z ##[endgroup]2026-10-12T02:59:02.2753625Z (node:15956) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-12T02:59:02.2783486Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-12T02:59:02.3110756Z With the provided path, there will be 10 files uploaded2026-10-12T02:59:02.3112157Z Artifact name is valid!2026-10-12T02:59:02.3112944Z Root directory input is valid!2026-10-12T02:59:02.6627797Z Beginning upload of artifact content to blob storage2026-10-12T02:59:02.7253285Z (node:15956) [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-12T02:59:02.9716023Z Uploaded bytes 159702026-10-12T02:59:03.0311113Z Finished uploading artifact content to blob storage!2026-10-12T02:59:03.0312959Z SHA256 digest of uploaded artifact zip is f846e8cee9d8d6a1d75cc3a2bd53e1cc24b2da84f8d72caae93ca8426226d0462026-10-12T02:59:03.0314131Z Finalizing artifact upload2026-10-12T02:59:03.2957953Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7.zip successfully finalized. Artifact ID 117239622342026-10-12T02:59:03.2960327Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7 has been successfully uploaded! Final size is 15970 bytes. Artifact ID is 117239622342026-10-12T02:59:03.2966381Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/38197435473/artifacts/117239622342026-10-12T02:59:03.3186218Z Post job cleanup.2026-10-12T02:59:03.4296370Z [command]/usr/bin/git version2026-10-12T02:59:03.4351657Z git version 2.55.02026-10-12T02:59:03.4407333Z Temporarily overriding HOME='/home/runner/work/_temp/ca815f80-56c1-473e-89e8-64af09197153' before making global git config changes2026-10-12T02:59:03.4408752Z Adding repository directory to the temporary git global config as a safe directory2026-10-12T02:59:03.4412219Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-12T02:59:03.4463159Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-12T02:59:03.4518289Z [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-12T02:59:03.4908528Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-12T02:59:03.4946857Z http.https://github.com/.extraheader2026-10-12T02:59:03.4959337Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-10-12T02:59:03.5026789Z [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-12T02:59:03.5465887Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-12T02:59:03.5536676Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-12T02:59:03.6234028Z Cleaning up orphan processes2026-10-12T02:59:03.7566515Z ##[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/