2026-10-23T02:11:08.3565071Z Current runner version: '2.338.0'2026-10-23T02:11:08.3590040Z ##[group]Runner Image Provisioner2026-10-23T02:11:08.3591078Z Hosted Compute Agent2026-10-23T02:11:08.3591708Z Version: 20261012.6012026-10-23T02:11:08.3592350Z Commit: f3dc54e1fb89da6852db922499a0233137369e1d2026-10-23T02:11:08.3593185Z Build Date: 2026-10-12T17:48:21Z2026-10-23T02:11:08.3593935Z Worker ID: {b658250a-8234-4ef0-8348-7b4e23c5916d}2026-10-23T02:11:08.3594718Z Region: westus2026-10-23T02:11:08.3595305Z Cloud: Azure2026-10-23T02:11:08.3596206Z ##[endgroup]2026-10-23T02:11:08.3597857Z ##[group]Operating System2026-10-23T02:11:08.3598521Z Ubuntu2026-10-23T02:11:08.3599140Z 22.04.52026-10-23T02:11:08.3599717Z LTS2026-10-23T02:11:08.3600256Z ##[endgroup]2026-10-23T02:11:08.3600902Z ##[group]Runner Image2026-10-23T02:11:08.3601571Z Image: ubuntu-22.042026-10-23T02:11:08.3602201Z Version: 20261012.322.12026-10-23T02:11:08.3603541Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20261012.322/images/ubuntu/Ubuntu2204-Readme.md2026-10-23T02:11:08.3605228Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20261012.3222026-10-23T02:11:08.3606604Z ##[endgroup]2026-10-23T02:11:08.3610174Z ##[group]GITHUB_TOKEN Permissions2026-10-23T02:11:08.3612685Z Actions: write2026-10-23T02:11:08.3613424Z ArtifactMetadata: write2026-10-23T02:11:08.3614094Z Attestations: write2026-10-23T02:11:08.3614709Z Checks: write2026-10-23T02:11:08.3615379Z CodeQuality: write2026-10-23T02:11:08.3616228Z Contents: write2026-10-23T02:11:08.3616867Z CopilotRequests: write2026-10-23T02:11:08.3617521Z Deployments: write2026-10-23T02:11:08.3618094Z Discussions: write2026-10-23T02:11:08.3618756Z Drives: write2026-10-23T02:11:08.3619315Z Issues: write2026-10-23T02:11:08.3620041Z Metadata: read2026-10-23T02:11:08.3620736Z Models: read2026-10-23T02:11:08.3621288Z Packages: write2026-10-23T02:11:08.3621932Z Pages: write2026-10-23T02:11:08.3622500Z PullRequests: write2026-10-23T02:11:08.3623095Z RepositoryProjects: write2026-10-23T02:11:08.3623832Z SecurityEvents: write2026-10-23T02:11:08.3624426Z Statuses: write2026-10-23T02:11:08.3625051Z VulnerabilityAlerts: read2026-10-23T02:11:08.3625875Z ##[endgroup]2026-10-23T02:11:08.3627939Z Secret source: Actions2026-10-23T02:11:08.3629056Z Cache mode: write2026-10-23T02:11:08.3629777Z Prepare workflow directory2026-10-23T02:11:08.3961259Z Prepare all required actions2026-10-23T02:11:08.4017787Z Getting action download info2026-10-23T02:11:08.7738711Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-10-23T02:11:08.9212616Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-10-23T02:11:09.3450751Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-10-23T02:11:09.7133540Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-10-23T02:11:09.9609576Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (63ec080e4eea87fb8a9eae678ab9944ec2461251)2026-10-23T02:11:09.9614736Z ##[group] Inputs2026-10-23T02:11:09.9615275Z testName: TestOSPoolEP2026-10-23T02:11:09.9616492Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-23T02:11:09.9617428Z setupScript: 2026-10-23T02:11:09.9617862Z setupEnv: {}2026-10-23T02:11:09.9618284Z ##[endgroup]2026-10-23T02:11:09.9618971Z Complete job name: ospool-ep / Run OSPool EP test (cvmfs-bind, 25-testing) / Run Tests2026-10-23T02:11:10.0371066Z ##[group]Run actions/checkout@v52026-10-23T02:11:10.0371932Z with:2026-10-23T02:11:10.0372397Z repository: osg-htc/k8s-integration-tests2026-10-23T02:11:10.0376421Z token: ***2026-10-23T02:11:10.0376857Z ssh-strict: true2026-10-23T02:11:10.0377286Z ssh-user: git2026-10-23T02:11:10.0377735Z persist-credentials: true2026-10-23T02:11:10.0378218Z clean: true2026-10-23T02:11:10.0378933Z sparse-checkout-cone-mode: true2026-10-23T02:11:10.0379460Z fetch-depth: 12026-10-23T02:11:10.0379878Z fetch-tags: false2026-10-23T02:11:10.0380401Z show-progress: true2026-10-23T02:11:10.0381092Z lfs: false2026-10-23T02:11:10.0381687Z submodules: false2026-10-23T02:11:10.0382308Z set-safe-directory: true2026-10-23T02:11:10.0382942Z allow-unsafe-pr-checkout: false2026-10-23T02:11:10.0383890Z ##[endgroup]2026-10-23T02:11:10.1502369Z Syncing repository: osg-htc/k8s-integration-tests2026-10-23T02:11:10.1504855Z ##[group]Getting Git version info2026-10-23T02:11:10.1506472Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-23T02:11:10.1508103Z [command]/usr/bin/git version2026-10-23T02:11:10.1584350Z git version 2.55.02026-10-23T02:11:10.1617935Z ##[endgroup]2026-10-23T02:11:10.1633708Z Temporarily overriding HOME='/home/runner/work/_temp/0cd27877-ab21-45b8-814e-bb237fe68a64' before making global git config changes2026-10-23T02:11:10.1636550Z Adding repository directory to the temporary git global config as a safe directory2026-10-23T02:11:10.1642823Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-23T02:11:10.1690816Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-23T02:11:10.1696194Z ##[group]Initializing the repository2026-10-23T02:11:10.1712323Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-23T02:11:10.1832846Z hint: Using 'master' as the name for the initial branch. This default branch name2026-10-23T02:11:10.1835543Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-10-23T02:11:10.1837804Z hint: to use in all of your new repositories, which will suppress this warning,2026-10-23T02:11:10.1839256Z hint: call:2026-10-23T02:11:10.1840145Z hint:2026-10-23T02:11:10.1841230Z hint: git config --global init.defaultBranch <name>2026-10-23T02:11:10.1842261Z hint:2026-10-23T02:11:10.1843297Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-10-23T02:11:10.1844670Z hint: 'development'. The just-created branch can be renamed via this command:2026-10-23T02:11:10.1846101Z hint:2026-10-23T02:11:10.1847065Z hint: git branch -m <name>2026-10-23T02:11:10.1848701Z hint:2026-10-23T02:11:10.1850607Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-10-23T02:11:10.1853697Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-10-23T02:11:10.1858496Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-10-23T02:11:10.1932188Z ##[endgroup]2026-10-23T02:11:10.1933744Z ##[group]Disabling automatic garbage collection2026-10-23T02:11:10.1936920Z [command]/usr/bin/git config --local gc.auto 02026-10-23T02:11:10.1972740Z ##[endgroup]2026-10-23T02:11:10.1974187Z ##[group]Setting up auth2026-10-23T02:11:10.1980621Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-23T02:11:10.2021285Z [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-23T02:11:10.2492779Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-23T02:11:10.2536300Z [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-23T02:11:10.2797279Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-23T02:11:10.2838709Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-23T02:11:10.3101998Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-10-23T02:11:10.3150101Z ##[endgroup]2026-10-23T02:11:10.3151317Z ##[group]Fetching the repository2026-10-23T02:11:10.3160244Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +63ec080e4eea87fb8a9eae678ab9944ec2461251:refs/remotes/origin/main2026-10-23T02:11:10.7296065Z From https://github.com/osg-htc/k8s-integration-tests2026-10-23T02:11:10.7298499Z * [new ref] 63ec080e4eea87fb8a9eae678ab9944ec2461251 -> origin/main2026-10-23T02:11:10.7303584Z ##[endgroup]2026-10-23T02:11:10.7305305Z ##[group]Determining the checkout info2026-10-23T02:11:10.7307692Z ##[endgroup]2026-10-23T02:11:10.7313883Z [command]/usr/bin/git sparse-checkout disable2026-10-23T02:11:10.7369263Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-10-23T02:11:10.7408512Z ##[group]Checking out the ref2026-10-23T02:11:10.7413282Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-10-23T02:11:10.7521082Z Switched to a new branch 'main'2026-10-23T02:11:10.7524456Z branch 'main' set up to track 'origin/main'.2026-10-23T02:11:10.7595420Z ##[endgroup]2026-10-23T02:11:10.7598617Z [command]/usr/bin/git log -1 --format=%H2026-10-23T02:11:10.7610884Z 63ec080e4eea87fb8a9eae678ab9944ec24612512026-10-23T02:11:10.7858383Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-23T02:11:10.7859582Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-23T02:11:10.7860665Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-23T02:11:10.8274482Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-23T02:11:10.8275257Z env:2026-10-23T02:11:10.8276577Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-23T02:11:10.8277728Z SETUP_ENV_YAML: {}2026-10-23T02:11:10.8278226Z ##[endgroup]2026-10-23T02:11:11.8867139Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-23T02:11:11.8870058Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-10-23T02:11:11.8948239Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-23T02:11:11.8949929Z env:2026-10-23T02:11:11.8952081Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfs-bind"}2026-10-23T02:11:11.8954624Z ##[endgroup]2026-10-23T02:11:11.9180238Z ##[group]Run true2026-10-23T02:11:11.9181291Z [36;1mtrue[0m2026-10-23T02:11:11.9256075Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-23T02:11:11.9257574Z ##[endgroup]2026-10-23T02:11:11.9590130Z ##[group]Run medyagh/setup-minikube@latest2026-10-23T02:11:11.9591362Z with:2026-10-23T02:11:11.9592195Z start: true2026-10-23T02:11:11.9593054Z cache: true2026-10-23T02:11:11.9593964Z minikube-version: latest2026-10-23T02:11:11.9594987Z wait: all2026-10-23T02:11:11.9595965Z ##[endgroup]2026-10-23T02:11:12.0938278Z (node:2043) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-23T02:11:12.0942853Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-23T02:11:13.1914820Z [command]/usr/bin/chmod +x /home/runner/work/_temp/bfcecae9-1611-4b65-a575-88fdd967ccc22026-10-23T02:11:13.3738122Z [command]/home/runner/bin/minikube version --short2026-10-23T02:11:13.4203904Z v1.39.02026-10-23T02:11:13.6727336Z Cache hit for: kic-v1.39.0-x642026-10-23T02:11:13.6841149Z (node:2043) [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-23T02:11:13.6849186Z Cache hit for: preloaded-tarball-v1.39.0-x64-stable-docker2026-10-23T02:11:14.9520188Z Received 4194304 of 531630645 (0.8%), 4.0 MBs/sec2026-10-23T02:11:14.9730170Z Received 8388608 of 288577004 (2.9%), 8.0 MBs/sec2026-10-23T02:11:16.0275565Z Received 113246208 of 531630645 (21.3%), 52.0 MBs/sec2026-10-23T02:11:16.0276311Z Received 134217728 of 288577004 (46.5%), 62.2 MBs/sec2026-10-23T02:11:17.0296717Z Received 234881024 of 531630645 (44.2%), 72.8 MBs/sec2026-10-23T02:11:17.0297440Z Received 251658240 of 288577004 (87.2%), 78.5 MBs/sec2026-10-23T02:11:17.6923862Z Received 288577004 of 288577004 (100.0%), 74.0 MBs/sec2026-10-23T02:11:17.6926766Z Cache Size: ~275 MB (288577004 B)2026-10-23T02:11:17.7305000Z [command]/usr/bin/tar -xf /home/runner/work/_temp/543e66e1-ccc3-4f68-900d-51ee8dd1d53c/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-23T02:11:18.0293019Z Received 348127232 of 531630645 (65.5%), 81.4 MBs/sec2026-10-23T02:11:18.5354679Z Cache restored successfully2026-10-23T02:11:19.0296318Z Received 465567744 of 531630645 (87.6%), 87.4 MBs/sec2026-10-23T02:11:19.5307189Z Received 531630645 of 531630645 (100.0%), 90.9 MBs/sec2026-10-23T02:11:19.5308433Z Cache Size: ~507 MB (531630645 B)2026-10-23T02:11:19.5434418Z [command]/usr/bin/tar -xf /home/runner/work/_temp/f803381a-87f6-4fd8-8106-6f36d9178dc4/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-23T02:11:20.3876129Z Cache restored successfully2026-10-23T02:11:20.5132749Z [command]/home/runner/bin/minikube start --wait all2026-10-23T02:11:20.5700997Z * minikube v1.39.0 on Ubuntu 22.042026-10-23T02:11:21.1071026Z ! 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-23T02:11:21.1088327Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-10-23T02:11:21.1761782Z * Using Docker driver with root privileges2026-10-23T02:11:21.1772078Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-10-23T02:11:21.1778256Z * Pulling base image v0.0.51 ...2026-10-23T02:11:43.1929291Z * Preparing Kubernetes v1.37.0 on containerd 2.3.4 ...2026-10-23T02:11:51.5879569Z * Configuring CNI (Container Networking Interface) ...2026-10-23T02:11:57.4470703Z * Verifying Kubernetes components...2026-10-23T02:11:57.4789968Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-10-23T02:11:58.0781882Z * Enabled addons: storage-provisioner, default-storageclass2026-10-23T02:12:13.7649808Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-10-23T02:12:13.7794579Z [command]/home/runner/bin/minikube version --short2026-10-23T02:12:13.8327432Z v1.39.02026-10-23T02:12:13.8636304Z ##[group]Run actions/setup-go@v62026-10-23T02:12:13.8636629Z with:2026-10-23T02:12:13.8636874Z go-version: 1.262026-10-23T02:12:13.8637092Z cache: true2026-10-23T02:12:13.8637328Z cache-dependency-path: go.sum2026-10-23T02:12:13.8637589Z check-latest: false2026-10-23T02:12:13.8639997Z token: ***2026-10-23T02:12:13.8640210Z ##[endgroup]2026-10-23T02:12:13.9972503Z Setup go version spec 1.262026-10-23T02:12:14.0035199Z Found in cache @ /opt/hostedtoolcache/go/1.26.9/x642026-10-23T02:12:14.0038246Z Added go to the path2026-10-23T02:12:14.0042037Z Successfully set up Go version 1.262026-10-23T02:12:15.2577827Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOMODCACHE2026-10-23T02:12:15.2622245Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOCACHE2026-10-23T02:12:15.2653373Z /home/runner/go/pkg/mod2026-10-23T02:12:15.2680284Z /home/runner/.cache/go-build2026-10-23T02:12:15.5248118Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-23T02:12:16.8284804Z Received 4194304 of 249167808 (1.7%), 4.0 MBs/sec2026-10-23T02:12:17.8317086Z Received 130023424 of 249167808 (52.2%), 61.9 MBs/sec2026-10-23T02:12:18.9056273Z Received 249167808 of 249167808 (100.0%), 77.2 MBs/sec2026-10-23T02:12:18.9058353Z Cache Size: ~238 MB (249167808 B)2026-10-23T02:12:18.9175812Z [command]/usr/bin/tar -xf /home/runner/work/_temp/c3412af0-fa0f-4a23-bbcd-58b00d715ca9/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-23T02:12:22.1691103Z Cache restored successfully2026-10-23T02:12:22.2244804Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-23T02:12:22.2273397Z go version go1.26.9 linux/amd642026-10-23T02:12:22.2273725Z 2026-10-23T02:12:22.2274194Z ##[group]go env2026-10-23T02:12:22.2545259Z AR='ar'2026-10-23T02:12:22.2546335Z CC='gcc'2026-10-23T02:12:22.2546767Z CGO_CFLAGS='-O2 -g'2026-10-23T02:12:22.2547111Z CGO_CPPFLAGS=''2026-10-23T02:12:22.2547441Z CGO_CXXFLAGS='-O2 -g'2026-10-23T02:12:22.2547742Z CGO_ENABLED='1'2026-10-23T02:12:22.2547980Z CGO_FFLAGS='-O2 -g'2026-10-23T02:12:22.2548215Z CGO_LDFLAGS='-O2 -g'2026-10-23T02:12:22.2548454Z CXX='g++'2026-10-23T02:12:22.2548667Z GCCGO='gccgo'2026-10-23T02:12:22.2548890Z GO111MODULE=''2026-10-23T02:12:22.2549109Z GOAMD64='v1'2026-10-23T02:12:22.2549338Z GOARCH='amd64'2026-10-23T02:12:22.2549557Z GOAUTH='netrc'2026-10-23T02:12:22.2549770Z GOBIN=''2026-10-23T02:12:22.2550008Z GOCACHE='/home/runner/.cache/go-build'2026-10-23T02:12:22.2550321Z GOCACHEPROG=''2026-10-23T02:12:22.2550544Z GODEBUG=''2026-10-23T02:12:22.2550809Z GOENV='/home/runner/.config/go/env'2026-10-23T02:12:22.2551108Z GOEXE=''2026-10-23T02:12:22.2551333Z GOEXPERIMENT=''2026-10-23T02:12:22.2551569Z GOFIPS140='off'2026-10-23T02:12:22.2551793Z GOFLAGS=''2026-10-23T02:12:22.2552530Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build841813903=/tmp/go-build -gno-record-gcc-switches'2026-10-23T02:12:22.2553297Z GOHOSTARCH='amd64'2026-10-23T02:12:22.2553538Z GOHOSTOS='linux'2026-10-23T02:12:22.2553773Z GOINSECURE=''2026-10-23T02:12:22.2554157Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-10-23T02:12:22.2554639Z GOMODCACHE='/home/runner/go/pkg/mod'2026-10-23T02:12:22.2554939Z GONOPROXY=''2026-10-23T02:12:22.2555164Z GONOSUMDB=''2026-10-23T02:12:22.2555375Z GOOS='linux'2026-10-23T02:12:22.2555608Z GOPATH='/home/runner/go'2026-10-23T02:12:22.2556190Z GOPRIVATE=''2026-10-23T02:12:22.2556486Z GOPROXY='https://proxy.golang.org,direct'2026-10-23T02:12:22.2556881Z GOROOT='/opt/hostedtoolcache/go/1.26.9/x64'2026-10-23T02:12:22.2557216Z GOSUMDB='sum.golang.org'2026-10-23T02:12:22.2557483Z GOTELEMETRY='local'2026-10-23T02:12:22.2557783Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-10-23T02:12:22.2558133Z GOTMPDIR=''2026-10-23T02:12:22.2558630Z GOTOOLCHAIN='local'2026-10-23T02:12:22.2559007Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.9/x64/pkg/tool/linux_amd64'2026-10-23T02:12:22.2559422Z GOVCS=''2026-10-23T02:12:22.2559649Z GOVERSION='go1.26.9'2026-10-23T02:12:22.2559889Z GOWORK=''2026-10-23T02:12:22.2560120Z PKG_CONFIG='pkg-config'2026-10-23T02:12:22.2560273Z 2026-10-23T02:12:22.2560567Z ##[endgroup]2026-10-23T02:12:22.2746736Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-23T02:12:22.2747325Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-10-23T02:12:22.2819158Z shell: /usr/bin/bash -e {0}2026-10-23T02:12:22.2819437Z env:2026-10-23T02:12:22.2819647Z GOTOOLCHAIN: local2026-10-23T02:12:22.2819921Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-10-23T02:12:22.2820211Z OSPOOL_EP_CMTag: 25.x-el92026-10-23T02:12:22.2820491Z OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-23T02:12:22.2820759Z ##[endgroup]2026-10-23T02:12:31.4156224Z === RUN TestOSPoolEP2026-10-23T02:12:31.4157313Z === PAUSE TestOSPoolEP2026-10-23T02:12:31.4158291Z === CONT TestOSPoolEP2026-10-23T02:12:31.4160972Z TestOSPoolEP 2026-10-23T02:12:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:31.4263629Z TestOSPoolEP 2026-10-23T02:12:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q apply -f /tmp/TestOSPoolEP1477275840]2026-10-23T02:12:31.8080997Z TestOSPoolEP 2026-10-23T02:12:31Z logger.go:67: pod/idtoken-generator created2026-10-23T02:12:31.8172716Z TestOSPoolEP 2026-10-23T02:12:31Z logger.go:67: secret/pool-passwd created2026-10-23T02:12:31.8228367Z TestOSPoolEP 2026-10-23T02:12:31Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-23T02:12:31.8230461Z TestOSPoolEP 2026-10-23T02:12:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:31.8254011Z TestOSPoolEP 2026-10-23T02:12:31Z 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-23T02:12:41.8264444Z TestOSPoolEP 2026-10-23T02:12:41Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-23T02:12:41.8266674Z TestOSPoolEP 2026-10-23T02:12:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:41.8288788Z TestOSPoolEP 2026-10-23T02:12:41Z logger.go:67: Pod is now available2026-10-23T02:12:41.8291030Z TestOSPoolEP 2026-10-23T02:12:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-10-23T02:12:41.9896765Z TestOSPoolEP 2026-10-23T02:12:41Z logger.go:67: ***2026-10-23T02:12:41.9961471Z TestOSPoolEP 2026-10-23T02:12:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q apply -f /tmp/TestOSPoolEP2147353196]2026-10-23T02:12:42.2039818Z TestOSPoolEP 2026-10-23T02:12:42Z logger.go:67: secret/pool-token created2026-10-23T02:12:42.2079425Z TestOSPoolEP 2026-10-23T02:12:42Z retry.go:91: Wait for secret pool-token to be provisioned.2026-10-23T02:12:42.2080728Z TestOSPoolEP 2026-10-23T02:12:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:42.2108606Z TestOSPoolEP 2026-10-23T02:12:42Z logger.go:67: Secret is now available2026-10-23T02:12:42.2123282Z TestOSPoolEP 2026-10-23T02:12:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q apply -k /tmp/kustomize-template-2248789094]2026-10-23T02:12:42.6072565Z TestOSPoolEP 2026-10-23T02:12:42Z logger.go:67: serviceaccount/cvmfs-nodeplugin created2026-10-23T02:12:42.6153571Z TestOSPoolEP 2026-10-23T02:12:42Z logger.go:67: service/frontier-squid created2026-10-23T02:12:42.6278620Z TestOSPoolEP 2026-10-23T02:12:42Z logger.go:67: service/test-cm created2026-10-23T02:12:42.6358451Z TestOSPoolEP 2026-10-23T02:12:42Z logger.go:67: deployment.apps/cvmfs-nodeplugin created2026-10-23T02:12:42.6440747Z TestOSPoolEP 2026-10-23T02:12:42Z logger.go:67: deployment.apps/frontier-squid created2026-10-23T02:12:42.6640004Z TestOSPoolEP 2026-10-23T02:12:42Z logger.go:67: deployment.apps/ospool-ep created2026-10-23T02:12:42.6644052Z TestOSPoolEP 2026-10-23T02:12:42Z 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-23T02:12:42.6856433Z TestOSPoolEP 2026-10-23T02:12:42Z logger.go:67: deployment.apps/test-cm created2026-10-23T02:12:42.6925114Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-10-23T02:12:42.6935585Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:42.7078104Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:42Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-23T02:12:42.7110351Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:42.7112916Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:42Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-23T02:12:42.7115366Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:42.7123355Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:42Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-23T02:12:42.7126201Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:42.7130174Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:42Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-23T02:12:42.7133586Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:42.7144753Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12: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: NewReplicaSetCreated, message: Created new replica set "test-cm-5886f7986". Sleeping for 10s and will try again.2026-10-23T02:12:42.7151039Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12: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-23T02:12:42.7157323Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12: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: NewReplicaSetCreated, message: Created new replica set "ospool-ep-674fbdcc48". Sleeping for 10s and will try again.2026-10-23T02:12:42.7172988Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:42Z 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-23T02:12:52.7161043Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:52Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-23T02:12:52.7163721Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:52.7179593Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:52Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-23T02:12:52.7182534Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:52.7185038Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:52Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-23T02:12:52.7187897Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:52.7193236Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:52Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-23T02:12:52.7194720Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:52.7222278Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12: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-5886f7986" is progressing.. Sleeping for 10s and will try again.2026-10-23T02:12:52.7240444Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12: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-674fbdcc48" is progressing.. Sleeping for 10s and will try again.2026-10-23T02:12:52.7244818Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:52Z logger.go:67: Deployment is now available2026-10-23T02:12:52.7252927Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:52Z 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-23T02:13:02.7229254Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:02Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-23T02:13:02.7232629Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:02Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:02.7252061Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:02Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-23T02:13:02.7269906Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:02Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:02.7274045Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:02Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-23T02:13:02.7282383Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:02Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:02.7286710Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:02Z 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-23T02:13:02.7308227Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:02Z logger.go:67: Deployment is now available2026-10-23T02:13:02.7319907Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13: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-674fbdcc48" is progressing.. Sleeping for 10s and will try again.2026-10-23T02:13:12.7304013Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:12Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-23T02:13:12.7306753Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:12.7326592Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:12Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-23T02:13:12.7329469Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:12.7336742Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:12Z logger.go:67: Deployment is now available2026-10-23T02:13:12.7361587Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:12Z 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-23T02:13:22.7370958Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:22Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-23T02:13:22.7373718Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:22.7399496Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:22Z logger.go:67: Deployment is now available2026-10-23T02:13:22.7403139Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP2026-10-23T02:13:22.7405565Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-23T02:13:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:22.7430131Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-23T02:13:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q cp ../test-configs/ospool-ep/condor_status.sh test-cm-5886f7986-ppthz:/tmp/condor_status.sh]2026-10-23T02:13:22.9619448Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-23T02:13:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec test-cm-5886f7986-ppthz -- chmod +x /tmp/condor_status.sh]2026-10-23T02:13:23.1205150Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-23T02:13:23Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec test-cm-5886f7986-ppthz -- sh -c /tmp/condor_status.sh]2026-10-23T02:13:23.2963524Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-23T02:13:23Z logger.go:67: command terminated with exit code 12026-10-23T02:13:23.3012561Z test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-5886f7986-ppthz failed. Retrying in 10s.2026-10-23T02:13:33.3020105Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-23T02:13:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec test-cm-5886f7986-ppthz -- sh -c /tmp/condor_status.sh]2026-10-23T02:13:33.5097389Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-23T02:13:33Z logger.go:67: command terminated with exit code 12026-10-23T02:13:33.5139866Z test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-5886f7986-ppthz failed. Retrying in 10s.2026-10-23T02:13:43.5188516Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-23T02:13:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec test-cm-5886f7986-ppthz -- sh -c /tmp/condor_status.sh]2026-10-23T02:13:43.7416916Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity2026-10-23T02:13:43.7418828Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-23T02:13:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:43.7445837Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-23T02:13:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q cp ../test-configs/ospool-ep/has_singularity.sh test-cm-5886f7986-ppthz:/tmp/has_singularity.sh]2026-10-23T02:13:43.9777799Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-23T02:13:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec test-cm-5886f7986-ppthz -- chmod +x /tmp/has_singularity.sh]2026-10-23T02:13:44.1529639Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-23T02:13:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec test-cm-5886f7986-ppthz -- sh -c /tmp/has_singularity.sh]2026-10-23T02:13:44.3600236Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-10-23T02:13:44.3602232Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:13:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:44.3632350Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:13:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q cp ../test-configs/ospool-ep/has_cvmfs.sh test-cm-5886f7986-ppthz:/tmp/has_cvmfs.sh]2026-10-23T02:13:44.5799295Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:13:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec test-cm-5886f7986-ppthz -- chmod +x /tmp/has_cvmfs.sh]2026-10-23T02:13:44.7264021Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:13:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec test-cm-5886f7986-ppthz -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:13:44.9041463Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:13:44Z logger.go:67: command terminated with exit code 12026-10-23T02:13:44.9076357Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-ppthz failed. Retrying in 30s.2026-10-23T02:14:14.9079019Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:14:14Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec test-cm-5886f7986-ppthz -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:14:15.0731877Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:14:15Z logger.go:67: command terminated with exit code 12026-10-23T02:14:15.0763215Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-ppthz failed. Retrying in 30s.2026-10-23T02:14:45.0769991Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:14:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec test-cm-5886f7986-ppthz -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:14:45.2684842Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:14:45Z logger.go:67: command terminated with exit code 12026-10-23T02:14:45.2718681Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-ppthz failed. Retrying in 30s.2026-10-23T02:15:15.2721688Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:15:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec test-cm-5886f7986-ppthz -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:15:15.4182899Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:15:15Z logger.go:67: command terminated with exit code 12026-10-23T02:15:15.4215393Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-ppthz failed. Retrying in 30s.2026-10-23T02:15:45.4222472Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:15:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec test-cm-5886f7986-ppthz -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:15:45.5669223Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:15:45Z logger.go:67: command terminated with exit code 12026-10-23T02:15:45.5704114Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-ppthz failed. Retrying in 30s.2026-10-23T02:16:15.5746545Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:16:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec test-cm-5886f7986-ppthz -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:16:15.7233469Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:16:15Z logger.go:67: command terminated with exit code 12026-10-23T02:16:15.7265832Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-ppthz failed. Retrying in 30s.2026-10-23T02:16:45.7269436Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:16:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec test-cm-5886f7986-ppthz -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:16:45.8798040Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:16:45Z logger.go:67: command terminated with exit code 12026-10-23T02:16:45.8833670Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-ppthz failed. Retrying in 30s.2026-10-23T02:17:15.8879695Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:17:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec test-cm-5886f7986-ppthz -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:17:16.0409951Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:17:16Z logger.go:67: command terminated with exit code 12026-10-23T02:17:16.0440249Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-ppthz failed. Retrying in 30s.2026-10-23T02:17:46.0446088Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:17:46Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec test-cm-5886f7986-ppthz -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:17:46.2006023Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:17:46Z logger.go:67: command terminated with exit code 12026-10-23T02:17:46.2038870Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-ppthz failed. Retrying in 30s.2026-10-23T02:18:16.2046434Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:18:16Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q exec test-cm-5886f7986-ppthz -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:18:16.3542005Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:18:16Z logger.go:67: command terminated with exit code 12026-10-23T02:18:16.3577036Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-ppthz failed. Retrying in 30s.2026-10-23T02:18:46.3619378Z test_utils.go:105: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-ppthz did not succeed within {10 30000000000} retries2026-10-23T02:18:46.3623176Z TestOSPoolEP 2026-10-23T02:18:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:46.3716731Z TestOSPoolEP 2026-10-23T02:18:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:46.4903143Z TestOSPoolEP 2026-10-23T02:18:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:46.6186754Z TestOSPoolEP 2026-10-23T02:18:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:46.7515512Z TestOSPoolEP 2026-10-23T02:18:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:46.8860777Z TestOSPoolEP 2026-10-23T02:18:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:47.0025468Z TestOSPoolEP 2026-10-23T02:18:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:47.0057876Z === NAME TestOSPoolEP2026-10-23T02:18:47.0059000Z ospool_ep_test.go:72: ---2026-10-23T02:18:47.0059875Z Events for pod cvmfs-nodeplugin-5cd89c7cfd-tp829:2026-10-23T02:18:47.0061476Z 2026-10-23 02:12:42 +0000 UTC Normal Successfully assigned test-ospool-ep-sqeb9q/cvmfs-nodeplugin-5cd89c7cfd-tp829 to minikube2026-10-23T02:18:47.0063272Z 2026-10-23 02:12:43 +0000 UTC Normal Pulling image "opensciencegrid/cvmfs-nodeplugin:fresh"2026-10-23T02:18:47.0065384Z 2026-10-23 02:12:48 +0000 UTC Normal Successfully pulled image "opensciencegrid/cvmfs-nodeplugin:fresh" in 5.647s (5.647s including waiting). Image size: 155940803 bytes.2026-10-23T02:18:47.0067052Z 2026-10-23 02:12:48 +0000 UTC Normal Container created2026-10-23T02:18:47.0067867Z 2026-10-23 02:12:48 +0000 UTC Normal Container started2026-10-23T02:18:47.0068404Z 2026-10-23T02:18:47.0068749Z ---2026-10-23T02:18:47.0069705Z TestOSPoolEP 2026-10-23T02:18:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:47.0085545Z ospool_ep_test.go:72: ---2026-10-23T02:18:47.0086594Z Events for pod frontier-squid-65f85c968-4dmrc:2026-10-23T02:18:47.0088176Z 2026-10-23 02:12:42 +0000 UTC Normal Successfully assigned test-ospool-ep-sqeb9q/frontier-squid-65f85c968-4dmrc to minikube2026-10-23T02:18:47.0089846Z 2026-10-23 02:12:43 +0000 UTC Normal Pulling image "opensciencegrid/frontier-squid:fresh"2026-10-23T02:18:47.0093052Z 2026-10-23 02:13:01 +0000 UTC Normal Successfully pulled image "opensciencegrid/frontier-squid:fresh" in 12.662s (18.26s including waiting). Image size: 453187319 bytes.2026-10-23T02:18:47.0094729Z 2026-10-23 02:13:01 +0000 UTC Normal Container created2026-10-23T02:18:47.0095553Z 2026-10-23 02:13:01 +0000 UTC Normal Container started2026-10-23T02:18:47.0096319Z 2026-10-23T02:18:47.0096657Z ---2026-10-23T02:18:47.0097606Z TestOSPoolEP 2026-10-23T02:18:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:47.0112355Z ospool_ep_test.go:72: ---2026-10-23T02:18:47.0117409Z Events for pod idtoken-generator:2026-10-23T02:18:47.0118807Z 2026-10-23 02:12:31 +0000 UTC Normal Successfully assigned test-ospool-ep-sqeb9q/idtoken-generator to minikube2026-10-23T02:18:47.0120137Z 2026-10-23 02:12:32 +0000 UTC Normal Pulling image "htcondor/base"2026-10-23T02:18:47.0121881Z 2026-10-23 02:12:38 +0000 UTC Normal Successfully pulled image "htcondor/base" in 6.309s (6.309s including waiting). Image size: 196303183 bytes.2026-10-23T02:18:47.0123266Z 2026-10-23 02:12:38 +0000 UTC Normal Container created2026-10-23T02:18:47.0124160Z 2026-10-23 02:12:38 +0000 UTC Normal Container started2026-10-23T02:18:47.0124759Z 2026-10-23T02:18:47.0125327Z ---2026-10-23T02:18:47.0126505Z TestOSPoolEP 2026-10-23T02:18:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:47.0149345Z ospool_ep_test.go:72: ---2026-10-23T02:18:47.0150820Z Events for pod ospool-ep-674fbdcc48-z6b2w:2026-10-23T02:18:47.0153618Z 2026-10-23 02:12:42 +0000 UTC Normal Successfully assigned test-ospool-ep-sqeb9q/ospool-ep-674fbdcc48-z6b2w to minikube2026-10-23T02:18:47.0156072Z 2026-10-23 02:12:43 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-10-23T02:18:47.0158642Z 2026-10-23 02:13:04 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 3.137s (21.302s including waiting). Image size: 2893600 bytes.2026-10-23T02:18:47.0160625Z 2026-10-23 02:13:04 +0000 UTC Normal Container created2026-10-23T02:18:47.0162376Z 2026-10-23 02:13:04 +0000 UTC Normal Container started2026-10-23T02:18:47.0164150Z 2026-10-23 02:13:05 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-10-23T02:18:47.0168804Z 2026-10-23 02:13:19 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 13.405s (13.405s including waiting). Image size: 537408098 bytes.2026-10-23T02:18:47.0170932Z 2026-10-23 02:13:19 +0000 UTC Normal Container created2026-10-23T02:18:47.0172286Z 2026-10-23 02:13:19 +0000 UTC Normal Container started2026-10-23T02:18:47.0173267Z 2026-10-23T02:18:47.0173963Z ---2026-10-23T02:18:47.0175348Z TestOSPoolEP 2026-10-23T02:18:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:47.0180009Z ospool_ep_test.go:72: ---2026-10-23T02:18:47.0180994Z Events for pod test-cm-5886f7986-ppthz:2026-10-23T02:18:47.0182627Z 2026-10-23 02:12:42 +0000 UTC Normal Successfully assigned test-ospool-ep-sqeb9q/test-cm-5886f7986-ppthz to minikube2026-10-23T02:18:47.0184235Z 2026-10-23 02:12:43 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-10-23T02:18:47.0186573Z 2026-10-23 02:13:05 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 1.387s (22.688s including waiting). Image size: 196304120 bytes.2026-10-23T02:18:47.0188145Z 2026-10-23 02:13:05 +0000 UTC Normal Container created2026-10-23T02:18:47.0189078Z 2026-10-23 02:13:05 +0000 UTC Normal Container started2026-10-23T02:18:47.0189735Z 2026-10-23T02:18:47.0190171Z ---2026-10-23T02:18:47.0191275Z TestOSPoolEP 2026-10-23T02:18:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:47.0231015Z TestOSPoolEP 2026-10-23T02:18:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q delete -f /tmp/TestOSPoolEP3766980732]2026-10-23T02:18:47.1328233Z TestOSPoolEP 2026-10-23T02:18:47Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-sqeb9q namespace2026-10-23T02:18:47.1362006Z TestOSPoolEP 2026-10-23T02:18:47Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-sqeb9q namespace2026-10-23T02:18:48.7095984Z TestOSPoolEP 2026-10-23T02:18:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q delete -f /tmp/TestOSPoolEP3581822889]2026-10-23T02:18:48.8372779Z TestOSPoolEP 2026-10-23T02:18:48Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-sqeb9q namespace2026-10-23T02:18:48.8429263Z TestOSPoolEP 2026-10-23T02:18:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-sqeb9q delete -k /tmp/kustomize-template-2248789094]2026-10-23T02:18:48.9758554Z TestOSPoolEP 2026-10-23T02:18:48Z logger.go:67: serviceaccount "cvmfs-nodeplugin" deleted from test-ospool-ep-sqeb9q namespace2026-10-23T02:18:48.9853478Z TestOSPoolEP 2026-10-23T02:18:48Z logger.go:67: service "frontier-squid" deleted from test-ospool-ep-sqeb9q namespace2026-10-23T02:18:48.9963765Z TestOSPoolEP 2026-10-23T02:18:48Z logger.go:67: service "test-cm" deleted from test-ospool-ep-sqeb9q namespace2026-10-23T02:18:49.0040159Z TestOSPoolEP 2026-10-23T02:18:49Z logger.go:67: deployment.apps "cvmfs-nodeplugin" deleted from test-ospool-ep-sqeb9q namespace2026-10-23T02:18:49.0076690Z TestOSPoolEP 2026-10-23T02:18:49Z logger.go:67: deployment.apps "frontier-squid" deleted from test-ospool-ep-sqeb9q namespace2026-10-23T02:18:49.0147235Z TestOSPoolEP 2026-10-23T02:18:49Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-sqeb9q namespace2026-10-23T02:18:49.0237211Z TestOSPoolEP 2026-10-23T02:18:49Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-sqeb9q namespace2026-10-23T02:18:49.0647449Z --- FAIL: TestOSPoolEP (377.65s)2026-10-23T02:18:49.0648889Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (40.05s)2026-10-23T02:18:49.0650200Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP (21.00s)2026-10-23T02:18:49.0651519Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity (0.62s)2026-10-23T02:18:49.0653448Z --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (302.00s)2026-10-23T02:18:49.0654115Z FAIL2026-10-23T02:18:49.0682197Z FAIL github.com/osg-htc/k8s-integration-tests/test 377.666s2026-10-23T02:18:49.0840905Z FAIL2026-10-23T02:18:49.1854200Z ##[error]Process completed with exit code 1.2026-10-23T02:18:49.1952686Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-23T02:18:49.1954112Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-10-23T02:18:49.2058801Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-23T02:18:49.2059658Z env:2026-10-23T02:18:49.2060208Z GOTOOLCHAIN: local2026-10-23T02:18:49.2061099Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-23T02:18:49.2062217Z ##[endgroup]2026-10-23T02:18:49.2381084Z ##[group]Run actions/upload-artifact@v42026-10-23T02:18:49.2381660Z with:2026-10-23T02:18:49.2382367Z name: TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd72026-10-23T02:18:49.2383248Z path: /tmp/k8s-tests2026-10-23T02:18:49.2383665Z retention-days: 52026-10-23T02:18:49.2384056Z if-no-files-found: warn2026-10-23T02:18:49.2384496Z compression-level: 62026-10-23T02:18:49.2384905Z overwrite: false2026-10-23T02:18:49.2385306Z include-hidden-files: false2026-10-23T02:18:49.2385967Z env:2026-10-23T02:18:49.2386320Z GOTOOLCHAIN: local2026-10-23T02:18:49.2386698Z ##[endgroup]2026-10-23T02:18:49.4897376Z (node:16514) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-23T02:18:49.4906653Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-23T02:18:49.5068297Z With the provided path, there will be 10 files uploaded2026-10-23T02:18:49.5074906Z Artifact name is valid!2026-10-23T02:18:49.5077552Z Root directory input is valid!2026-10-23T02:18:49.8998887Z Beginning upload of artifact content to blob storage2026-10-23T02:18:49.9420466Z (node:16514) [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-23T02:18:50.2658129Z Uploaded bytes 159232026-10-23T02:18:50.3478542Z Finished uploading artifact content to blob storage!2026-10-23T02:18:50.3479908Z SHA256 digest of uploaded artifact zip is d443b22d3d88e5c7d59fada05d6b3125df960a1ca0ae93b771a97b70b697c3ca2026-10-23T02:18:50.3498830Z Finalizing artifact upload2026-10-23T02:18:51.1232608Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7.zip successfully finalized. Artifact ID 124742252632026-10-23T02:18:51.1237226Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7 has been successfully uploaded! Final size is 15923 bytes. Artifact ID is 124742252632026-10-23T02:18:51.1242001Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/39888173727/artifacts/124742252632026-10-23T02:18:51.1505579Z Post job cleanup.2026-10-23T02:18:51.2604470Z [command]/usr/bin/git version2026-10-23T02:18:51.2649221Z git version 2.55.02026-10-23T02:18:51.2697297Z Temporarily overriding HOME='/home/runner/work/_temp/2b34b4bb-60c1-4d7b-a30e-6d88dc162064' before making global git config changes2026-10-23T02:18:51.2699244Z Adding repository directory to the temporary git global config as a safe directory2026-10-23T02:18:51.2700990Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-23T02:18:51.2752977Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-23T02:18:51.2791097Z [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-23T02:18:51.3199083Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-23T02:18:51.3256341Z http.https://github.com/.extraheader2026-10-23T02:18:51.3286948Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-10-23T02:18:51.3415063Z [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-23T02:18:51.4172667Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-23T02:18:51.4268752Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-23T02:18:51.5004917Z Cleaning up orphan processes2026-10-23T02:18:51.6000030Z ##[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/