2026-10-25T01:56:25.9307346Z Current runner version: '2.338.0'2026-10-25T01:56:25.9334214Z ##[group]Runner Image Provisioner2026-10-25T01:56:25.9335083Z Hosted Compute Agent2026-10-25T01:56:25.9335795Z Version: 20261021.6182026-10-25T01:56:25.9336474Z Commit: 21505ad2541d5be6135ed84fc33697146cf75b8e2026-10-25T01:56:25.9337228Z Build Date: 2026-10-21T00:45:21Z2026-10-25T01:56:25.9338065Z Worker ID: {78b5f349-7e6d-435c-ba88-e1010cd5fa05}2026-10-25T01:56:25.9338800Z Region: eastus2026-10-25T01:56:25.9339421Z Cloud: Azure2026-10-25T01:56:25.9340221Z ##[endgroup]2026-10-25T01:56:25.9341832Z ##[group]Operating System2026-10-25T01:56:25.9342606Z Ubuntu2026-10-25T01:56:25.9343150Z 22.04.52026-10-25T01:56:25.9343667Z LTS2026-10-25T01:56:25.9344334Z ##[endgroup]2026-10-25T01:56:25.9344925Z ##[group]Runner Image2026-10-25T01:56:25.9345682Z Image: ubuntu-22.042026-10-25T01:56:25.9346296Z Version: 20261012.322.12026-10-25T01:56:25.9347674Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20261012.322/images/ubuntu/Ubuntu2204-Readme.md2026-10-25T01:56:25.9349285Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20261012.3222026-10-25T01:56:25.9351199Z ##[endgroup]2026-10-25T01:56:25.9354369Z ##[group]GITHUB_TOKEN Permissions2026-10-25T01:56:25.9357160Z Actions: write2026-10-25T01:56:25.9357932Z ArtifactMetadata: write2026-10-25T01:56:25.9358588Z Attestations: write2026-10-25T01:56:25.9359327Z Checks: write2026-10-25T01:56:25.9360279Z CodeQuality: write2026-10-25T01:56:25.9360992Z Contents: write2026-10-25T01:56:25.9361596Z CopilotRequests: write2026-10-25T01:56:25.9362210Z Deployments: write2026-10-25T01:56:25.9362975Z Discussions: write2026-10-25T01:56:25.9363719Z Drives: write2026-10-25T01:56:25.9364334Z Issues: write2026-10-25T01:56:25.9365036Z Metadata: read2026-10-25T01:56:25.9365701Z Models: read2026-10-25T01:56:25.9366289Z Packages: write2026-10-25T01:56:25.9366877Z Pages: write2026-10-25T01:56:25.9367507Z PullRequests: write2026-10-25T01:56:25.9368364Z RepositoryProjects: write2026-10-25T01:56:25.9369133Z SecurityEvents: write2026-10-25T01:56:25.9370222Z Statuses: write2026-10-25T01:56:25.9370927Z VulnerabilityAlerts: read2026-10-25T01:56:25.9371612Z ##[endgroup]2026-10-25T01:56:25.9374274Z Secret source: Actions2026-10-25T01:56:25.9375423Z Cache mode: write2026-10-25T01:56:25.9376459Z Prepare workflow directory2026-10-25T01:56:25.9723673Z Prepare all required actions2026-10-25T01:56:25.9773265Z Getting action download info2026-10-25T01:56:26.2337882Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-10-25T01:56:26.4377317Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-10-25T01:56:26.5661386Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-10-25T01:56:26.7187059Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-10-25T01:56:26.9875350Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (63ec080e4eea87fb8a9eae678ab9944ec2461251)2026-10-25T01:56:26.9881405Z ##[group] Inputs2026-10-25T01:56:26.9882067Z testName: TestOSPoolEP2026-10-25T01:56:26.9883463Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-25T01:56:26.9885007Z setupScript: 2026-10-25T01:56:26.9885566Z setupEnv: {}2026-10-25T01:56:26.9886093Z ##[endgroup]2026-10-25T01:56:26.9887102Z Complete job name: ospool-ep / Run OSPool EP test (cvmfs-bind, 25-testing) / Run Tests2026-10-25T01:56:27.0741633Z ##[group]Run actions/checkout@v52026-10-25T01:56:27.0742719Z with:2026-10-25T01:56:27.0743282Z repository: osg-htc/k8s-integration-tests2026-10-25T01:56:27.0751354Z token: ***2026-10-25T01:56:27.0751876Z ssh-strict: true2026-10-25T01:56:27.0752409Z ssh-user: git2026-10-25T01:56:27.0752978Z persist-credentials: true2026-10-25T01:56:27.0753592Z clean: true2026-10-25T01:56:27.0754436Z sparse-checkout-cone-mode: true2026-10-25T01:56:27.0755121Z fetch-depth: 12026-10-25T01:56:27.0755639Z fetch-tags: false2026-10-25T01:56:27.0756193Z show-progress: true2026-10-25T01:56:27.0756741Z lfs: false2026-10-25T01:56:27.0757238Z submodules: false2026-10-25T01:56:27.0757797Z set-safe-directory: true2026-10-25T01:56:27.0758461Z allow-unsafe-pr-checkout: false2026-10-25T01:56:27.0759472Z ##[endgroup]2026-10-25T01:56:27.1858216Z Syncing repository: osg-htc/k8s-integration-tests2026-10-25T01:56:27.1861066Z ##[group]Getting Git version info2026-10-25T01:56:27.1862513Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-25T01:56:27.1864243Z [command]/usr/bin/git version2026-10-25T01:56:27.1931814Z git version 2.55.02026-10-25T01:56:27.1956155Z ##[endgroup]2026-10-25T01:56:27.1986090Z Temporarily overriding HOME='/home/runner/work/_temp/815d65fb-0579-4f90-a174-92bc2c988048' before making global git config changes2026-10-25T01:56:27.1991063Z Adding repository directory to the temporary git global config as a safe directory2026-10-25T01:56:27.1995408Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-25T01:56:27.2056365Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-25T01:56:27.2060790Z ##[group]Initializing the repository2026-10-25T01:56:27.2064609Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-25T01:56:27.2224545Z hint: Using 'master' as the name for the initial branch. This default branch name2026-10-25T01:56:27.2227442Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-10-25T01:56:27.2230650Z hint: to use in all of your new repositories, which will suppress this warning,2026-10-25T01:56:27.2232590Z hint: call:2026-10-25T01:56:27.2233373Z hint:2026-10-25T01:56:27.2234531Z hint: git config --global init.defaultBranch <name>2026-10-25T01:56:27.2236252Z hint:2026-10-25T01:56:27.2237767Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-10-25T01:56:27.2240517Z hint: 'development'. The just-created branch can be renamed via this command:2026-10-25T01:56:27.2242372Z hint:2026-10-25T01:56:27.2243172Z hint: git branch -m <name>2026-10-25T01:56:27.2244464Z hint:2026-10-25T01:56:27.2246087Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-10-25T01:56:27.2249634Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-10-25T01:56:27.2294956Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-10-25T01:56:27.2299676Z ##[endgroup]2026-10-25T01:56:27.2302486Z ##[group]Disabling automatic garbage collection2026-10-25T01:56:27.2304782Z [command]/usr/bin/git config --local gc.auto 02026-10-25T01:56:27.2345122Z ##[endgroup]2026-10-25T01:56:27.2346697Z ##[group]Setting up auth2026-10-25T01:56:27.2352706Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-25T01:56:27.2413825Z [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-25T01:56:27.2865739Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-25T01:56:27.2908804Z [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-25T01:56:27.3208738Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-25T01:56:27.3233877Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-25T01:56:27.3532908Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-10-25T01:56:27.3584980Z ##[endgroup]2026-10-25T01:56:27.3587188Z ##[group]Fetching the repository2026-10-25T01:56:27.3597853Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +63ec080e4eea87fb8a9eae678ab9944ec2461251:refs/remotes/origin/main2026-10-25T01:56:27.5633930Z From https://github.com/osg-htc/k8s-integration-tests2026-10-25T01:56:27.5635681Z * [new ref] 63ec080e4eea87fb8a9eae678ab9944ec2461251 -> origin/main2026-10-25T01:56:27.5640459Z ##[endgroup]2026-10-25T01:56:27.5642582Z ##[group]Determining the checkout info2026-10-25T01:56:27.5650280Z ##[endgroup]2026-10-25T01:56:27.5651205Z [command]/usr/bin/git sparse-checkout disable2026-10-25T01:56:27.5701782Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-10-25T01:56:27.5739184Z ##[group]Checking out the ref2026-10-25T01:56:27.5745300Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-10-25T01:56:27.5853258Z Switched to a new branch 'main'2026-10-25T01:56:27.5856705Z branch 'main' set up to track 'origin/main'.2026-10-25T01:56:27.5865512Z ##[endgroup]2026-10-25T01:56:27.5909986Z [command]/usr/bin/git log -1 --format=%H2026-10-25T01:56:27.5941729Z 63ec080e4eea87fb8a9eae678ab9944ec24612512026-10-25T01:56:27.6275241Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-25T01:56:27.6276768Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-25T01:56:27.6278169Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-25T01:56:27.6740182Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-25T01:56:27.6741204Z env:2026-10-25T01:56:27.6742289Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-25T01:56:27.6743511Z SETUP_ENV_YAML: {}2026-10-25T01:56:27.6744252Z ##[endgroup]2026-10-25T01:56:28.7869569Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-25T01:56:28.7870738Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-10-25T01:56:28.7945612Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-25T01:56:28.7946135Z env:2026-10-25T01:56:28.7946766Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfs-bind"}2026-10-25T01:56:28.7947449Z ##[endgroup]2026-10-25T01:56:28.8116240Z ##[group]Run true2026-10-25T01:56:28.8116641Z [36;1mtrue[0m2026-10-25T01:56:28.8193055Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-25T01:56:28.8193552Z ##[endgroup]2026-10-25T01:56:28.8399398Z ##[group]Run medyagh/setup-minikube@latest2026-10-25T01:56:28.8400057Z with:2026-10-25T01:56:28.8400396Z start: true2026-10-25T01:56:28.8400708Z cache: true2026-10-25T01:56:28.8401051Z minikube-version: latest2026-10-25T01:56:28.8401428Z wait: all2026-10-25T01:56:28.8401738Z ##[endgroup]2026-10-25T01:56:28.9802448Z (node:2023) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-25T01:56:28.9804117Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-25T01:56:29.8451898Z [command]/usr/bin/chmod +x /home/runner/work/_temp/ed46d243-3ea3-4107-b9be-ffe1f4b05d782026-10-25T01:56:30.0225504Z [command]/home/runner/bin/minikube version --short2026-10-25T01:56:30.0719408Z v1.39.02026-10-25T01:56:30.1471766Z Cache hit for: kic-v1.39.0-x642026-10-25T01:56:30.1480860Z Cache hit for: preloaded-tarball-v1.39.0-x64-stable-docker2026-10-25T01:56:30.1599543Z (node:2023) [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-25T01:56:31.1852942Z Received 117440512 of 531630645 (22.1%), 111.7 MBs/sec2026-10-25T01:56:31.3098125Z Received 134217728 of 288577004 (46.5%), 115.5 MBs/sec2026-10-25T01:56:32.1970803Z Received 247463936 of 531630645 (46.5%), 117.1 MBs/sec2026-10-25T01:56:32.3256863Z Received 264241152 of 288577004 (91.6%), 118.6 MBs/sec2026-10-25T01:56:32.6145513Z Received 288577004 of 288577004 (100.0%), 114.1 MBs/sec2026-10-25T01:56:32.6147104Z Cache Size: ~275 MB (288577004 B)2026-10-25T01:56:32.7350986Z [command]/usr/bin/tar -xf /home/runner/work/_temp/5c1a86fe-bad6-4737-8787-6cdb2e479872/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-25T01:56:33.1975508Z Received 402653184 of 531630645 (75.7%), 127.4 MBs/sec2026-10-25T01:56:33.6360314Z Cache restored successfully2026-10-25T01:56:33.7890050Z Received 531630645 of 531630645 (100.0%), 140.6 MBs/sec2026-10-25T01:56:33.7891281Z Cache Size: ~507 MB (531630645 B)2026-10-25T01:56:33.8017774Z [command]/usr/bin/tar -xf /home/runner/work/_temp/17c33885-3b52-4331-8078-da5e0fd124da/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-25T01:56:34.6754392Z Cache restored successfully2026-10-25T01:56:35.8298947Z [command]/home/runner/bin/minikube start --wait all2026-10-25T01:56:36.0737878Z * minikube v1.39.0 on Ubuntu 22.042026-10-25T01:56:38.3389235Z ! 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-25T01:56:38.3422293Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-10-25T01:56:38.4143440Z * Using Docker driver with root privileges2026-10-25T01:56:38.4153413Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-10-25T01:56:38.4161331Z * Pulling base image v0.0.51 ...2026-10-25T01:56:58.6738076Z * Preparing Kubernetes v1.37.0 on containerd 2.3.4 ...2026-10-25T01:57:06.6056738Z * Configuring CNI (Container Networking Interface) ...2026-10-25T01:57:11.9465709Z * Verifying Kubernetes components...2026-10-25T01:57:11.9739334Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-10-25T01:57:12.5454509Z * Enabled addons: storage-provisioner, default-storageclass2026-10-25T01:57:40.0802202Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-10-25T01:57:40.0960656Z [command]/home/runner/bin/minikube version --short2026-10-25T01:57:40.1485776Z v1.39.02026-10-25T01:57:40.1850761Z ##[group]Run actions/setup-go@v62026-10-25T01:57:40.1851091Z with:2026-10-25T01:57:40.1851300Z go-version: 1.262026-10-25T01:57:40.1851512Z cache: true2026-10-25T01:57:40.1851745Z cache-dependency-path: go.sum2026-10-25T01:57:40.1852008Z check-latest: false2026-10-25T01:57:40.1854409Z token: ***2026-10-25T01:57:40.1854623Z ##[endgroup]2026-10-25T01:57:40.3245812Z Setup go version spec 1.262026-10-25T01:57:40.4041074Z Found in cache @ /opt/hostedtoolcache/go/1.26.9/x642026-10-25T01:57:40.4041670Z Added go to the path2026-10-25T01:57:40.4042062Z Successfully set up Go version 1.262026-10-25T01:57:41.5034330Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOMODCACHE2026-10-25T01:57:41.5078688Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOCACHE2026-10-25T01:57:41.5111412Z /home/runner/go/pkg/mod2026-10-25T01:57:41.5142662Z /home/runner/.cache/go-build2026-10-25T01:57:41.5821616Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-25T01:57:42.6282426Z Received 167772160 of 249167808 (67.3%), 160.0 MBs/sec2026-10-25T01:57:43.1357696Z Received 249167808 of 249167808 (100.0%), 157.6 MBs/sec2026-10-25T01:57:43.1359272Z Cache Size: ~238 MB (249167808 B)2026-10-25T01:57:43.1434519Z [command]/usr/bin/tar -xf /home/runner/work/_temp/9e3ee45f-babb-42f5-8d34-8f01f59f22a9/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-25T01:57:46.3891355Z Cache restored successfully2026-10-25T01:57:46.4452776Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-25T01:57:46.4480865Z go version go1.26.9 linux/amd642026-10-25T01:57:46.4481090Z 2026-10-25T01:57:46.4481424Z ##[group]go env2026-10-25T01:57:46.5342719Z AR='ar'2026-10-25T01:57:46.5343151Z CC='gcc'2026-10-25T01:57:46.5343524Z CGO_CFLAGS='-O2 -g'2026-10-25T01:57:46.5344188Z CGO_CPPFLAGS=''2026-10-25T01:57:46.5344693Z CGO_CXXFLAGS='-O2 -g'2026-10-25T01:57:46.5345119Z CGO_ENABLED='1'2026-10-25T01:57:46.5345563Z CGO_FFLAGS='-O2 -g'2026-10-25T01:57:46.5345909Z CGO_LDFLAGS='-O2 -g'2026-10-25T01:57:46.5346290Z CXX='g++'2026-10-25T01:57:46.5346621Z GCCGO='gccgo'2026-10-25T01:57:46.5346999Z GO111MODULE=''2026-10-25T01:57:46.5347396Z GOAMD64='v1'2026-10-25T01:57:46.5347773Z GOARCH='amd64'2026-10-25T01:57:46.5348373Z GOAUTH='netrc'2026-10-25T01:57:46.5348786Z GOBIN=''2026-10-25T01:57:46.5349133Z GOCACHE='/home/runner/.cache/go-build'2026-10-25T01:57:46.5351201Z GOCACHEPROG=''2026-10-25T01:57:46.5351929Z GODEBUG=''2026-10-25T01:57:46.5352362Z GOENV='/home/runner/.config/go/env'2026-10-25T01:57:46.5352836Z GOEXE=''2026-10-25T01:57:46.5353198Z GOEXPERIMENT=''2026-10-25T01:57:46.5353643Z GOFIPS140='off'2026-10-25T01:57:46.5354018Z GOFLAGS=''2026-10-25T01:57:46.5355551Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build2477263813=/tmp/go-build -gno-record-gcc-switches'2026-10-25T01:57:46.5357083Z GOHOSTARCH='amd64'2026-10-25T01:57:46.5357423Z GOHOSTOS='linux'2026-10-25T01:57:46.5357646Z GOINSECURE=''2026-10-25T01:57:46.5358011Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-10-25T01:57:46.5358462Z GOMODCACHE='/home/runner/go/pkg/mod'2026-10-25T01:57:46.5358759Z GONOPROXY=''2026-10-25T01:57:46.5358969Z GONOSUMDB=''2026-10-25T01:57:46.5359164Z GOOS='linux'2026-10-25T01:57:46.5359410Z GOPATH='/home/runner/go'2026-10-25T01:57:46.5359654Z GOPRIVATE=''2026-10-25T01:57:46.5360275Z GOPROXY='https://proxy.golang.org,direct'2026-10-25T01:57:46.5360637Z GOROOT='/opt/hostedtoolcache/go/1.26.9/x64'2026-10-25T01:57:46.5360959Z GOSUMDB='sum.golang.org'2026-10-25T01:57:46.5361207Z GOTELEMETRY='local'2026-10-25T01:57:46.5361583Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-10-25T01:57:46.5362120Z GOTMPDIR=''2026-10-25T01:57:46.5362450Z GOTOOLCHAIN='local'2026-10-25T01:57:46.5363336Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.9/x64/pkg/tool/linux_amd64'2026-10-25T01:57:46.5363921Z GOVCS=''2026-10-25T01:57:46.5364332Z GOVERSION='go1.26.9'2026-10-25T01:57:46.5364560Z GOWORK=''2026-10-25T01:57:46.5364782Z PKG_CONFIG='pkg-config'2026-10-25T01:57:46.5364932Z 2026-10-25T01:57:46.5365401Z ##[endgroup]2026-10-25T01:57:46.5643575Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-25T01:57:46.5644108Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-10-25T01:57:46.5717002Z shell: /usr/bin/bash -e {0}2026-10-25T01:57:46.5717270Z env:2026-10-25T01:57:46.5717473Z GOTOOLCHAIN: local2026-10-25T01:57:46.5717726Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-10-25T01:57:46.5718004Z OSPOOL_EP_CMTag: 25.x-el92026-10-25T01:57:46.5718254Z OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-25T01:57:46.5718520Z ##[endgroup]2026-10-25T01:57:54.2755046Z === RUN TestOSPoolEP2026-10-25T01:57:54.2755578Z === PAUSE TestOSPoolEP2026-10-25T01:57:54.2755962Z === CONT TestOSPoolEP2026-10-25T01:57:54.2761848Z TestOSPoolEP 2026-10-25T01:57:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:57:54.3178818Z TestOSPoolEP 2026-10-25T01:57:54Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 apply -f /tmp/TestOSPoolEP347690192]2026-10-25T01:57:55.7201922Z TestOSPoolEP 2026-10-25T01:57:55Z logger.go:67: pod/idtoken-generator created2026-10-25T01:57:55.8836223Z TestOSPoolEP 2026-10-25T01:57:55Z logger.go:67: secret/pool-passwd created2026-10-25T01:57:55.8898864Z TestOSPoolEP 2026-10-25T01:57:55Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-25T01:57:55.8910828Z TestOSPoolEP 2026-10-25T01:57:55Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:57:55.8944252Z TestOSPoolEP 2026-10-25T01:57:55Z 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-25T01:58:05.8953125Z TestOSPoolEP 2026-10-25T01:58:05Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-25T01:58:05.8954082Z TestOSPoolEP 2026-10-25T01:58:05Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:05.8980339Z TestOSPoolEP 2026-10-25T01:58:05Z logger.go:67: Pod is now available2026-10-25T01:58:05.8982012Z TestOSPoolEP 2026-10-25T01:58:05Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-10-25T01:58:06.5584155Z TestOSPoolEP 2026-10-25T01:58:06Z logger.go:67: ***2026-10-25T01:58:06.5648279Z TestOSPoolEP 2026-10-25T01:58:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 apply -f /tmp/TestOSPoolEP1752880648]2026-10-25T01:58:06.8307492Z TestOSPoolEP 2026-10-25T01:58:06Z logger.go:67: secret/pool-token created2026-10-25T01:58:06.8347794Z TestOSPoolEP 2026-10-25T01:58:06Z retry.go:91: Wait for secret pool-token to be provisioned.2026-10-25T01:58:06.8349210Z TestOSPoolEP 2026-10-25T01:58:06Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:06.8370783Z TestOSPoolEP 2026-10-25T01:58:06Z logger.go:67: Secret is now available2026-10-25T01:58:06.8393669Z TestOSPoolEP 2026-10-25T01:58:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 apply -k /tmp/kustomize-template-3070630109]2026-10-25T01:58:07.3040997Z TestOSPoolEP 2026-10-25T01:58:07Z logger.go:67: serviceaccount/cvmfs-nodeplugin created2026-10-25T01:58:07.3119802Z TestOSPoolEP 2026-10-25T01:58:07Z logger.go:67: service/frontier-squid created2026-10-25T01:58:07.3221827Z TestOSPoolEP 2026-10-25T01:58:07Z logger.go:67: service/test-cm created2026-10-25T01:58:07.3302711Z TestOSPoolEP 2026-10-25T01:58:07Z logger.go:67: deployment.apps/cvmfs-nodeplugin created2026-10-25T01:58:07.3410187Z TestOSPoolEP 2026-10-25T01:58:07Z logger.go:67: deployment.apps/frontier-squid created2026-10-25T01:58:07.3603610Z TestOSPoolEP 2026-10-25T01:58: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-25T01:58:07.3606380Z TestOSPoolEP 2026-10-25T01:58:07Z logger.go:67: deployment.apps/ospool-ep created2026-10-25T01:58:07.3794684Z TestOSPoolEP 2026-10-25T01:58:07Z logger.go:67: deployment.apps/test-cm created2026-10-25T01:58:07.3867322Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-10-25T01:58:07.3896268Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:07.3976684Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:07Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-25T01:58:07.3983300Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:07.4000057Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:07Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-25T01:58:07.4003342Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:07.4009194Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:07Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-25T01:58:07.4011596Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:07.4013737Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:07Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-25T01:58:07.4016096Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:07.4195099Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58: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-25T01:58:07.4200451Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58: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-25T01:58:07.4205616Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58: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-25T01:58:07.4214457Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58: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-25T01:58:17.4213158Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:17Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-25T01:58:17.4239014Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:17.4241711Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:17Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-25T01:58:17.4243859Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:17.4245950Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:17Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-25T01:58:17.4248032Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:17.4250258Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:17Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-25T01:58:17.4252982Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:17.4283991Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58: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-25T01:58:17.4287740Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:17Z logger.go:67: Deployment is now available2026-10-25T01:58:17.4306687Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58: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-25T01:58:17.4321608Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58: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-25T01:58:27.4305679Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:27Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-25T01:58:27.4307805Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:27.4312178Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:27Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-25T01:58:27.4314748Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:27.4329247Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:27Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-25T01:58:27.4331939Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:27.4343518Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58: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-25T01:58:27.4352617Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:27Z logger.go:67: Deployment is now available2026-10-25T01:58:27.4357385Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:27Z logger.go:67: Deployment is now available2026-10-25T01:58:37.4395324Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:37Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-25T01:58:37.4397375Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:37.4405082Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58: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-25T01:58:47.4435588Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:47Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-25T01:58:47.4437522Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:47.4460922Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:47Z logger.go:67: Deployment is now available2026-10-25T01:58:47.4465590Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP2026-10-25T01:58:47.4476320Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-25T01:58:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:47.4504432Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-25T01:58:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 cp ../test-configs/ospool-ep/condor_status.sh test-cm-5886f7986-zdksx:/tmp/condor_status.sh]2026-10-25T01:58:47.9391821Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-25T01:58:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 exec test-cm-5886f7986-zdksx -- chmod +x /tmp/condor_status.sh]2026-10-25T01:58:48.0982292Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-25T01:58:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 exec test-cm-5886f7986-zdksx -- sh -c /tmp/condor_status.sh]2026-10-25T01:58:48.2963724Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-25T01:58:48Z logger.go:67: command terminated with exit code 12026-10-25T01:58:48.2991086Z test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-5886f7986-zdksx failed. Retrying in 10s.2026-10-25T01:58:58.3003692Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-25T01:58:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 exec test-cm-5886f7986-zdksx -- sh -c /tmp/condor_status.sh]2026-10-25T01:58:58.4724148Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity2026-10-25T01:58:58.4725252Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-25T01:58:58Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:58.4756669Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-25T01:58:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 cp ../test-configs/ospool-ep/has_singularity.sh test-cm-5886f7986-zdksx:/tmp/has_singularity.sh]2026-10-25T01:58:58.6725524Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-25T01:58:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 exec test-cm-5886f7986-zdksx -- chmod +x /tmp/has_singularity.sh]2026-10-25T01:58:58.8241977Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-25T01:58:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 exec test-cm-5886f7986-zdksx -- sh -c /tmp/has_singularity.sh]2026-10-25T01:58:59.0407989Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-10-25T01:58:59.0409659Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T01:58:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:59.0437685Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T01:58:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 cp ../test-configs/ospool-ep/has_cvmfs.sh test-cm-5886f7986-zdksx:/tmp/has_cvmfs.sh]2026-10-25T01:58:59.2508879Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T01:58:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 exec test-cm-5886f7986-zdksx -- chmod +x /tmp/has_cvmfs.sh]2026-10-25T01:58:59.4063084Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T01:58:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 exec test-cm-5886f7986-zdksx -- sh -c /tmp/has_cvmfs.sh]2026-10-25T01:58:59.5851289Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T01:58:59Z logger.go:67: command terminated with exit code 12026-10-25T01:58:59.5897568Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-zdksx failed. Retrying in 30s.2026-10-25T01:59:29.5908938Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T01:59:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 exec test-cm-5886f7986-zdksx -- sh -c /tmp/has_cvmfs.sh]2026-10-25T01:59:29.7690502Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T01:59:29Z logger.go:67: command terminated with exit code 12026-10-25T01:59:29.7726789Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-zdksx failed. Retrying in 30s.2026-10-25T01:59:59.7734566Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T01:59:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 exec test-cm-5886f7986-zdksx -- sh -c /tmp/has_cvmfs.sh]2026-10-25T01:59:59.9353822Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T01:59:59Z logger.go:67: command terminated with exit code 12026-10-25T01:59:59.9377690Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-zdksx failed. Retrying in 30s.2026-10-25T02:00:29.9384146Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:00:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 exec test-cm-5886f7986-zdksx -- sh -c /tmp/has_cvmfs.sh]2026-10-25T02:00:30.0898709Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:00:30Z logger.go:67: command terminated with exit code 12026-10-25T02:00:30.0931837Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-zdksx failed. Retrying in 30s.2026-10-25T02:01:00.0936458Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:01:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 exec test-cm-5886f7986-zdksx -- sh -c /tmp/has_cvmfs.sh]2026-10-25T02:01:00.2484542Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:01:00Z logger.go:67: command terminated with exit code 12026-10-25T02:01:00.2518339Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-zdksx failed. Retrying in 30s.2026-10-25T02:01:30.2562332Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:01:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 exec test-cm-5886f7986-zdksx -- sh -c /tmp/has_cvmfs.sh]2026-10-25T02:01:30.4112416Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:01:30Z logger.go:67: command terminated with exit code 12026-10-25T02:01:30.4137637Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-zdksx failed. Retrying in 30s.2026-10-25T02:02:00.4195464Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:02:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 exec test-cm-5886f7986-zdksx -- sh -c /tmp/has_cvmfs.sh]2026-10-25T02:02:00.5809519Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:02:00Z logger.go:67: command terminated with exit code 12026-10-25T02:02:00.5848451Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-zdksx failed. Retrying in 30s.2026-10-25T02:02:30.5904437Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:02:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 exec test-cm-5886f7986-zdksx -- sh -c /tmp/has_cvmfs.sh]2026-10-25T02:02:30.7460410Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:02:30Z logger.go:67: command terminated with exit code 12026-10-25T02:02:30.7493829Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-zdksx failed. Retrying in 30s.2026-10-25T02:03:00.7498784Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:03:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 exec test-cm-5886f7986-zdksx -- sh -c /tmp/has_cvmfs.sh]2026-10-25T02:03:00.8990489Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:03:00Z logger.go:67: command terminated with exit code 12026-10-25T02:03:00.9026575Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-zdksx failed. Retrying in 30s.2026-10-25T02:03:30.9086283Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:03:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 exec test-cm-5886f7986-zdksx -- sh -c /tmp/has_cvmfs.sh]2026-10-25T02:03:31.0639073Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:03:31Z logger.go:67: command terminated with exit code 12026-10-25T02:03:31.0677660Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-zdksx failed. Retrying in 30s.2026-10-25T02:04:01.0742941Z test_utils.go:105: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-zdksx did not succeed within {10 30000000000} retries2026-10-25T02:04:01.0745280Z TestOSPoolEP 2026-10-25T02:04:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:01.0846769Z TestOSPoolEP 2026-10-25T02:04:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:01.2426686Z TestOSPoolEP 2026-10-25T02:04:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:01.3656388Z TestOSPoolEP 2026-10-25T02:04:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:01.5063677Z TestOSPoolEP 2026-10-25T02:04:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:01.6437972Z TestOSPoolEP 2026-10-25T02:04:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:01.7880567Z TestOSPoolEP 2026-10-25T02:04:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:01.7917092Z === NAME TestOSPoolEP2026-10-25T02:04:01.7917877Z ospool_ep_test.go:72: ---2026-10-25T02:04:01.7918984Z Events for pod cvmfs-nodeplugin-5cd89c7cfd-gkjg8:2026-10-25T02:04:01.7921253Z 2026-10-25 01:58:07 +0000 UTC Normal Successfully assigned test-ospool-ep-fq7vt8/cvmfs-nodeplugin-5cd89c7cfd-gkjg8 to minikube2026-10-25T02:04:01.7923500Z 2026-10-25 01:58:07 +0000 UTC Normal Pulling image "opensciencegrid/cvmfs-nodeplugin:fresh"2026-10-25T02:04:01.7931965Z 2026-10-25 01:58:12 +0000 UTC Normal Successfully pulled image "opensciencegrid/cvmfs-nodeplugin:fresh" in 5.045s (5.045s including waiting). Image size: 155940803 bytes.2026-10-25T02:04:01.7933633Z 2026-10-25 01:58:12 +0000 UTC Normal Container created2026-10-25T02:04:01.7934570Z 2026-10-25 01:58:12 +0000 UTC Normal Container started2026-10-25T02:04:01.7935150Z 2026-10-25T02:04:01.7935543Z ---2026-10-25T02:04:01.7936615Z TestOSPoolEP 2026-10-25T02:04:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:01.7948107Z ospool_ep_test.go:72: ---2026-10-25T02:04:01.7949046Z Events for pod frontier-squid-65f85c968-bggnj:2026-10-25T02:04:01.7951108Z 2026-10-25 01:58:07 +0000 UTC Normal Successfully assigned test-ospool-ep-fq7vt8/frontier-squid-65f85c968-bggnj to minikube2026-10-25T02:04:01.7952790Z 2026-10-25 01:58:07 +0000 UTC Normal Pulling image "opensciencegrid/frontier-squid:fresh"2026-10-25T02:04:01.7955045Z 2026-10-25 01:58:23 +0000 UTC Normal Successfully pulled image "opensciencegrid/frontier-squid:fresh" in 10.971s (15.958s including waiting). Image size: 453187319 bytes.2026-10-25T02:04:01.7956573Z 2026-10-25 01:58:23 +0000 UTC Normal Container created2026-10-25T02:04:01.7957079Z 2026-10-25 01:58:23 +0000 UTC Normal Container started2026-10-25T02:04:01.7957402Z 2026-10-25T02:04:01.7957621Z ---2026-10-25T02:04:01.7958193Z TestOSPoolEP 2026-10-25T02:04:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:01.7975241Z ospool_ep_test.go:72: ---2026-10-25T02:04:01.7976056Z Events for pod idtoken-generator:2026-10-25T02:04:01.7978590Z 2026-10-25 01:57:55 +0000 UTC Normal Successfully assigned test-ospool-ep-fq7vt8/idtoken-generator to minikube2026-10-25T02:04:01.7980207Z 2026-10-25 01:57:56 +0000 UTC Normal Pulling image "htcondor/base"2026-10-25T02:04:01.7982338Z 2026-10-25 01:58:01 +0000 UTC Normal Successfully pulled image "htcondor/base" in 5.497s (5.497s including waiting). Image size: 196303183 bytes.2026-10-25T02:04:01.7983752Z 2026-10-25 01:58:01 +0000 UTC Normal Container created2026-10-25T02:04:01.7984629Z 2026-10-25 01:58:01 +0000 UTC Normal Container started2026-10-25T02:04:01.7985186Z 2026-10-25T02:04:01.7985548Z ---2026-10-25T02:04:01.7986608Z TestOSPoolEP 2026-10-25T02:04:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:01.8010782Z ospool_ep_test.go:72: ---2026-10-25T02:04:01.8011674Z Events for pod ospool-ep-674fbdcc48-vsj4s:2026-10-25T02:04:01.8013228Z 2026-10-25 01:58:07 +0000 UTC Normal Successfully assigned test-ospool-ep-fq7vt8/ospool-ep-674fbdcc48-vsj4s to minikube2026-10-25T02:04:01.8014921Z 2026-10-25 01:58:07 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-10-25T02:04:01.8017138Z 2026-10-25 01:58:25 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.872s (17.808s including waiting). Image size: 2893600 bytes.2026-10-25T02:04:01.8018775Z 2026-10-25 01:58:25 +0000 UTC Normal Container created2026-10-25T02:04:01.8020010Z 2026-10-25 01:58:25 +0000 UTC Normal Container started2026-10-25T02:04:01.8021454Z 2026-10-25 01:58:27 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-10-25T02:04:01.8023912Z 2026-10-25 01:58:38 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 11.314s (11.314s including waiting). Image size: 537408098 bytes.2026-10-25T02:04:01.8025627Z 2026-10-25 01:58:38 +0000 UTC Normal Container created2026-10-25T02:04:01.8026587Z 2026-10-25 01:58:38 +0000 UTC Normal Container started2026-10-25T02:04:01.8027204Z 2026-10-25T02:04:01.8027620Z ---2026-10-25T02:04:01.8028988Z TestOSPoolEP 2026-10-25T02:04:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:01.8046571Z ospool_ep_test.go:72: ---2026-10-25T02:04:01.8047493Z Events for pod test-cm-5886f7986-zdksx:2026-10-25T02:04:01.8050096Z 2026-10-25 01:58:07 +0000 UTC Normal Successfully assigned test-ospool-ep-fq7vt8/test-cm-5886f7986-zdksx to minikube2026-10-25T02:04:01.8051789Z 2026-10-25 01:58:07 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-10-25T02:04:01.8053822Z 2026-10-25 01:58:26 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 984ms (18.763s including waiting). Image size: 196304120 bytes.2026-10-25T02:04:01.8055407Z 2026-10-25 01:58:26 +0000 UTC Normal Container created2026-10-25T02:04:01.8056449Z 2026-10-25 01:58:26 +0000 UTC Normal Container started2026-10-25T02:04:01.8057181Z 2026-10-25T02:04:01.8057753Z ---2026-10-25T02:04:01.8059409Z TestOSPoolEP 2026-10-25T02:04:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:01.8095923Z TestOSPoolEP 2026-10-25T02:04:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 delete -f /tmp/TestOSPoolEP2220917093]2026-10-25T02:04:01.9203579Z TestOSPoolEP 2026-10-25T02:04:01Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-fq7vt8 namespace2026-10-25T02:04:01.9275237Z TestOSPoolEP 2026-10-25T02:04:01Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-fq7vt8 namespace2026-10-25T02:04:02.8054209Z TestOSPoolEP 2026-10-25T02:04:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 delete -f /tmp/TestOSPoolEP3467458636]2026-10-25T02:04:02.9093941Z TestOSPoolEP 2026-10-25T02:04:02Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-fq7vt8 namespace2026-10-25T02:04:02.9159103Z TestOSPoolEP 2026-10-25T02:04:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fq7vt8 delete -k /tmp/kustomize-template-3070630109]2026-10-25T02:04:03.0658679Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: serviceaccount "cvmfs-nodeplugin" deleted from test-ospool-ep-fq7vt8 namespace2026-10-25T02:04:03.0741679Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: service "frontier-squid" deleted from test-ospool-ep-fq7vt8 namespace2026-10-25T02:04:03.0861725Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: service "test-cm" deleted from test-ospool-ep-fq7vt8 namespace2026-10-25T02:04:03.0916523Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: deployment.apps "cvmfs-nodeplugin" deleted from test-ospool-ep-fq7vt8 namespace2026-10-25T02:04:03.0960152Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: deployment.apps "frontier-squid" deleted from test-ospool-ep-fq7vt8 namespace2026-10-25T02:04:03.1066956Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-fq7vt8 namespace2026-10-25T02:04:03.1181147Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-fq7vt8 namespace2026-10-25T02:04:03.1713431Z --- FAIL: TestOSPoolEP (368.90s)2026-10-25T02:04:03.1716357Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (40.06s)2026-10-25T02:04:03.1717490Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP (11.03s)2026-10-25T02:04:03.1720053Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity (0.57s)2026-10-25T02:04:03.1721318Z --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (302.03s)2026-10-25T02:04:03.1722186Z FAIL2026-10-25T02:04:03.1750931Z FAIL github.com/osg-htc/k8s-integration-tests/test 368.915s2026-10-25T02:04:03.1945134Z FAIL2026-10-25T02:04:03.3053697Z ##[error]Process completed with exit code 1.2026-10-25T02:04:03.3128937Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-25T02:04:03.3132536Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-10-25T02:04:03.3244462Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-25T02:04:03.3245063Z env:2026-10-25T02:04:03.3245389Z GOTOOLCHAIN: local2026-10-25T02:04:03.3246118Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-25T02:04:03.3246950Z ##[endgroup]2026-10-25T02:04:03.3762090Z ##[group]Run actions/upload-artifact@v42026-10-25T02:04:03.3762627Z with:2026-10-25T02:04:03.3763315Z name: TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd72026-10-25T02:04:03.3764129Z path: /tmp/k8s-tests2026-10-25T02:04:03.3764546Z retention-days: 52026-10-25T02:04:03.3764950Z if-no-files-found: warn2026-10-25T02:04:03.3765393Z compression-level: 62026-10-25T02:04:03.3765797Z overwrite: false2026-10-25T02:04:03.3766201Z include-hidden-files: false2026-10-25T02:04:03.3766631Z env:2026-10-25T02:04:03.3766976Z GOTOOLCHAIN: local2026-10-25T02:04:03.3767359Z ##[endgroup]2026-10-25T02:04:03.6200622Z (node:15656) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-25T02:04:03.6204098Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-25T02:04:03.6307195Z With the provided path, there will be 10 files uploaded2026-10-25T02:04:03.6320302Z Artifact name is valid!2026-10-25T02:04:03.6333817Z Root directory input is valid!2026-10-25T02:04:03.8502009Z Beginning upload of artifact content to blob storage2026-10-25T02:04:03.9037522Z (node:15656) [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-25T02:04:03.9587274Z Uploaded bytes 159442026-10-25T02:04:03.9810726Z Finished uploading artifact content to blob storage!2026-10-25T02:04:03.9811844Z SHA256 digest of uploaded artifact zip is 2ce44c2f8e65acd5d4946d697e5c7be4f3ba736da96b95da6af7745ce104663c2026-10-25T02:04:03.9814485Z Finalizing artifact upload2026-10-25T02:04:04.3719442Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7.zip successfully finalized. Artifact ID 125837508732026-10-25T02:04:04.3722280Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7 has been successfully uploaded! Final size is 15944 bytes. Artifact ID is 125837508732026-10-25T02:04:04.3728621Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/40152541575/artifacts/125837508732026-10-25T02:04:04.3956923Z Post job cleanup.2026-10-25T02:04:04.4926062Z [command]/usr/bin/git version2026-10-25T02:04:04.5012011Z git version 2.55.02026-10-25T02:04:04.5060853Z Temporarily overriding HOME='/home/runner/work/_temp/7a90ba38-95ba-464d-a955-a5db371e16dd' before making global git config changes2026-10-25T02:04:04.5062666Z Adding repository directory to the temporary git global config as a safe directory2026-10-25T02:04:04.5067717Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-25T02:04:04.5126324Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-25T02:04:04.5174373Z [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-25T02:04:04.5501981Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-25T02:04:04.5568113Z http.https://github.com/.extraheader2026-10-25T02:04:04.5583933Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-10-25T02:04:04.5632272Z [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-25T02:04:04.5966554Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-25T02:04:04.6008482Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-25T02:04:04.6447525Z Cleaning up orphan processes2026-10-25T02:04:04.7570784Z ##[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/