2026-10-25T01:56:26.1945919Z Current runner version: '2.338.0'2026-10-25T01:56:26.1971791Z ##[group]Runner Image Provisioner2026-10-25T01:56:26.1972789Z Hosted Compute Agent2026-10-25T01:56:26.1973447Z Version: 20261021.6182026-10-25T01:56:26.1974239Z Commit: 21505ad2541d5be6135ed84fc33697146cf75b8e2026-10-25T01:56:26.1975021Z Build Date: 2026-10-21T00:45:21Z2026-10-25T01:56:26.1975750Z Worker ID: {b19d6895-d05a-4358-9245-2ce01ae9b0bf}2026-10-25T01:56:26.1976581Z Region: centralus2026-10-25T01:56:26.1977207Z Cloud: Azure2026-10-25T01:56:26.1977828Z ##[endgroup]2026-10-25T01:56:26.1980254Z ##[group]Operating System2026-10-25T01:56:26.1980966Z Ubuntu2026-10-25T01:56:26.1981637Z 22.04.52026-10-25T01:56:26.1982254Z LTS2026-10-25T01:56:26.1982895Z ##[endgroup]2026-10-25T01:56:26.1983527Z ##[group]Runner Image2026-10-25T01:56:26.1984181Z Image: ubuntu-22.042026-10-25T01:56:26.1984847Z Version: 20261012.322.12026-10-25T01:56:26.1986198Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20261012.322/images/ubuntu/Ubuntu2204-Readme.md2026-10-25T01:56:26.1987907Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20261012.3222026-10-25T01:56:26.1988912Z ##[endgroup]2026-10-25T01:56:26.1992747Z ##[group]GITHUB_TOKEN Permissions2026-10-25T01:56:26.1995499Z Actions: write2026-10-25T01:56:26.1996330Z ArtifactMetadata: write2026-10-25T01:56:26.1997010Z Attestations: write2026-10-25T01:56:26.1997683Z Checks: write2026-10-25T01:56:26.1998300Z CodeQuality: write2026-10-25T01:56:26.1998881Z Contents: write2026-10-25T01:56:26.1999972Z CopilotRequests: write2026-10-25T01:56:26.2000640Z Deployments: write2026-10-25T01:56:26.2001293Z Discussions: write2026-10-25T01:56:26.2001919Z Drives: write2026-10-25T01:56:26.2002499Z Issues: write2026-10-25T01:56:26.2003309Z Metadata: read2026-10-25T01:56:26.2003924Z Models: read2026-10-25T01:56:26.2004580Z Packages: write2026-10-25T01:56:26.2005221Z Pages: write2026-10-25T01:56:26.2005808Z PullRequests: write2026-10-25T01:56:26.2006545Z RepositoryProjects: write2026-10-25T01:56:26.2007223Z SecurityEvents: write2026-10-25T01:56:26.2007879Z Statuses: write2026-10-25T01:56:26.2008522Z VulnerabilityAlerts: read2026-10-25T01:56:26.2009453Z ##[endgroup]2026-10-25T01:56:26.2011795Z Secret source: Actions2026-10-25T01:56:26.2012777Z Cache mode: write2026-10-25T01:56:26.2013634Z Prepare workflow directory2026-10-25T01:56:26.2356262Z Prepare all required actions2026-10-25T01:56:26.2404648Z Getting action download info2026-10-25T01:56:26.5193177Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-10-25T01:56:26.6286987Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-10-25T01:56:26.9424478Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-10-25T01:56:27.3091496Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-10-25T01:56:27.5681465Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (63ec080e4eea87fb8a9eae678ab9944ec2461251)2026-10-25T01:56:27.5686524Z ##[group] Inputs2026-10-25T01:56:27.5687149Z testName: TestOSPoolEP2026-10-25T01:56:27.5688259Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-25T01:56:27.5689850Z setupScript: 2026-10-25T01:56:27.5690377Z setupEnv: {}2026-10-25T01:56:27.5690878Z ##[endgroup]2026-10-25T01:56:27.5691713Z Complete job name: ospool-ep / Run OSPool EP test (cvmfs-bind, 25-release) / Run Tests2026-10-25T01:56:27.6534379Z ##[group]Run actions/checkout@v52026-10-25T01:56:27.6535478Z with:2026-10-25T01:56:27.6536362Z repository: osg-htc/k8s-integration-tests2026-10-25T01:56:27.6541464Z token: ***2026-10-25T01:56:27.6541979Z ssh-strict: true2026-10-25T01:56:27.6542492Z ssh-user: git2026-10-25T01:56:27.6543015Z persist-credentials: true2026-10-25T01:56:27.6543592Z clean: true2026-10-25T01:56:27.6544387Z sparse-checkout-cone-mode: true2026-10-25T01:56:27.6545008Z fetch-depth: 12026-10-25T01:56:27.6545528Z fetch-tags: false2026-10-25T01:56:27.6546052Z show-progress: true2026-10-25T01:56:27.6546571Z lfs: false2026-10-25T01:56:27.6547040Z submodules: false2026-10-25T01:56:27.6547557Z set-safe-directory: true2026-10-25T01:56:27.6548154Z allow-unsafe-pr-checkout: false2026-10-25T01:56:27.6549638Z ##[endgroup]2026-10-25T01:56:27.7670304Z Syncing repository: osg-htc/k8s-integration-tests2026-10-25T01:56:27.7672426Z ##[group]Getting Git version info2026-10-25T01:56:27.7673573Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-25T01:56:27.7675068Z [command]/usr/bin/git version2026-10-25T01:56:27.7760734Z git version 2.55.02026-10-25T01:56:27.7766180Z ##[endgroup]2026-10-25T01:56:27.7780241Z Temporarily overriding HOME='/home/runner/work/_temp/60172b79-0715-4f8e-854c-3f1ea51516c6' before making global git config changes2026-10-25T01:56:27.7790737Z Adding repository directory to the temporary git global config as a safe directory2026-10-25T01:56:27.7792429Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-25T01:56:27.7830472Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-25T01:56:27.7835560Z ##[group]Initializing the repository2026-10-25T01:56:27.7840828Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-25T01:56:27.7971508Z hint: Using 'master' as the name for the initial branch. This default branch name2026-10-25T01:56:27.7974097Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-10-25T01:56:27.7976398Z hint: to use in all of your new repositories, which will suppress this warning,2026-10-25T01:56:27.7978313Z hint: call:2026-10-25T01:56:27.7979874Z hint:2026-10-25T01:56:27.7980981Z hint: git config --global init.defaultBranch <name>2026-10-25T01:56:27.7982499Z hint:2026-10-25T01:56:27.7983711Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-10-25T01:56:27.7985705Z hint: 'development'. The just-created branch can be renamed via this command:2026-10-25T01:56:27.7987359Z hint:2026-10-25T01:56:27.7988201Z hint: git branch -m <name>2026-10-25T01:56:27.7989426Z hint:2026-10-25T01:56:27.7990818Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-10-25T01:56:27.7993389Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-10-25T01:56:27.7997146Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-10-25T01:56:27.8037681Z ##[endgroup]2026-10-25T01:56:27.8039596Z ##[group]Disabling automatic garbage collection2026-10-25T01:56:27.8042899Z [command]/usr/bin/git config --local gc.auto 02026-10-25T01:56:27.8082022Z ##[endgroup]2026-10-25T01:56:27.8083531Z ##[group]Setting up auth2026-10-25T01:56:27.8090298Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-25T01:56:27.8129843Z [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.8582461Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-25T01:56:27.8624080Z [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.8887039Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-25T01:56:27.8928120Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-25T01:56:27.9214157Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-10-25T01:56:27.9265925Z ##[endgroup]2026-10-25T01:56:27.9276415Z ##[group]Fetching the repository2026-10-25T01:56:27.9280200Z [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:28.2742865Z From https://github.com/osg-htc/k8s-integration-tests2026-10-25T01:56:28.2744701Z * [new ref] 63ec080e4eea87fb8a9eae678ab9944ec2461251 -> origin/main2026-10-25T01:56:28.2749516Z ##[endgroup]2026-10-25T01:56:28.2751559Z ##[group]Determining the checkout info2026-10-25T01:56:28.2753375Z ##[endgroup]2026-10-25T01:56:28.2756792Z [command]/usr/bin/git sparse-checkout disable2026-10-25T01:56:28.2807885Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-10-25T01:56:28.2843866Z ##[group]Checking out the ref2026-10-25T01:56:28.2847123Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-10-25T01:56:28.2953825Z Switched to a new branch 'main'2026-10-25T01:56:28.2956734Z branch 'main' set up to track 'origin/main'.2026-10-25T01:56:28.3043454Z ##[endgroup]2026-10-25T01:56:28.3047350Z [command]/usr/bin/git log -1 --format=%H2026-10-25T01:56:28.3049277Z 63ec080e4eea87fb8a9eae678ab9944ec24612512026-10-25T01:56:28.3322758Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-25T01:56:28.3325472Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-25T01:56:28.3328171Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-25T01:56:28.3754374Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-25T01:56:28.3755948Z env:2026-10-25T01:56:28.3757848Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-25T01:56:28.3760528Z SETUP_ENV_YAML: {}2026-10-25T01:56:28.3761537Z ##[endgroup]2026-10-25T01:56:29.4364053Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-25T01:56:29.4364805Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-10-25T01:56:29.4437375Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-25T01:56:29.4437779Z env:2026-10-25T01:56:29.4438329Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfs-bind"}2026-10-25T01:56:29.4438927Z ##[endgroup]2026-10-25T01:56:29.4594782Z ##[group]Run true2026-10-25T01:56:29.4595104Z [36;1mtrue[0m2026-10-25T01:56:29.4660485Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-25T01:56:29.4660900Z ##[endgroup]2026-10-25T01:56:29.4852939Z ##[group]Run medyagh/setup-minikube@latest2026-10-25T01:56:29.4853320Z with:2026-10-25T01:56:29.4853578Z start: true2026-10-25T01:56:29.4853818Z cache: true2026-10-25T01:56:29.4854089Z minikube-version: latest2026-10-25T01:56:29.4854399Z wait: all2026-10-25T01:56:29.4854634Z ##[endgroup]2026-10-25T01:56:29.6213679Z (node:2084) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-25T01:56:29.6214748Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-25T01:56:30.7637459Z [command]/usr/bin/chmod +x /home/runner/work/_temp/f99aeae7-5555-4f5c-8124-d43c3c127ec42026-10-25T01:56:30.9377450Z [command]/home/runner/bin/minikube version --short2026-10-25T01:56:30.9923631Z v1.39.02026-10-25T01:56:31.1397102Z Cache hit for: kic-v1.39.0-x642026-10-25T01:56:31.1514454Z (node:2084) [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.1523140Z Cache hit for: preloaded-tarball-v1.39.0-x64-stable-docker2026-10-25T01:56:32.3019779Z Received 88080384 of 531630645 (16.6%), 83.4 MBs/sec2026-10-25T01:56:32.3185304Z Received 88080384 of 288577004 (30.5%), 83.5 MBs/sec2026-10-25T01:56:33.3069740Z Received 234881024 of 531630645 (44.2%), 111.3 MBs/sec2026-10-25T01:56:33.3226505Z Received 209715200 of 288577004 (72.7%), 99.5 MBs/sec2026-10-25T01:56:33.9875850Z Received 288577004 of 288577004 (100.0%), 102.9 MBs/sec2026-10-25T01:56:33.9900122Z Cache Size: ~275 MB (288577004 B)2026-10-25T01:56:34.0789692Z [command]/usr/bin/tar -xf /home/runner/work/_temp/08e8e37c-ce80-470a-ba1c-bd45e380115c/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-25T01:56:34.3164522Z Received 356515840 of 531630645 (67.1%), 112.7 MBs/sec2026-10-25T01:56:34.9190883Z Cache restored successfully2026-10-25T01:56:35.3134291Z Received 515899392 of 531630645 (97.0%), 122.4 MBs/sec2026-10-25T01:56:35.4544215Z Received 531630645 of 531630645 (100.0%), 121.9 MBs/sec2026-10-25T01:56:35.4546283Z Cache Size: ~507 MB (531630645 B)2026-10-25T01:56:35.4665511Z [command]/usr/bin/tar -xf /home/runner/work/_temp/90ab432f-9a8d-4fb0-9640-f365667c0259/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-25T01:56:36.2767622Z Cache restored successfully2026-10-25T01:56:36.3956366Z [command]/home/runner/bin/minikube start --wait all2026-10-25T01:56:36.4415839Z * minikube v1.39.0 on Ubuntu 22.042026-10-25T01:56:40.7289244Z ! 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:40.7290771Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-10-25T01:56:40.8188317Z * Using Docker driver with root privileges2026-10-25T01:56:40.8199264Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-10-25T01:56:40.8207052Z * Pulling base image v0.0.51 ...2026-10-25T01:57:03.2642931Z * Preparing Kubernetes v1.37.0 on containerd 2.3.4 ...2026-10-25T01:57:11.4332664Z * Configuring CNI (Container Networking Interface) ...2026-10-25T01:57:17.2976418Z * Verifying Kubernetes components...2026-10-25T01:57:17.3235415Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-10-25T01:57:17.9112467Z * Enabled addons: default-storageclass, storage-provisioner2026-10-25T01:57:37.2251065Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-10-25T01:57:37.2380948Z [command]/home/runner/bin/minikube version --short2026-10-25T01:57:37.2971562Z v1.39.02026-10-25T01:57:37.3310072Z ##[group]Run actions/setup-go@v62026-10-25T01:57:37.3310413Z with:2026-10-25T01:57:37.3310626Z go-version: 1.262026-10-25T01:57:37.3310847Z cache: true2026-10-25T01:57:37.3311090Z cache-dependency-path: go.sum2026-10-25T01:57:37.3311374Z check-latest: false2026-10-25T01:57:37.3313728Z token: ***2026-10-25T01:57:37.3313944Z ##[endgroup]2026-10-25T01:57:37.4703842Z Setup go version spec 1.262026-10-25T01:57:37.5003635Z Found in cache @ /opt/hostedtoolcache/go/1.26.9/x642026-10-25T01:57:37.5006659Z Added go to the path2026-10-25T01:57:37.5011216Z Successfully set up Go version 1.262026-10-25T01:57:38.5935092Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOMODCACHE2026-10-25T01:57:38.5980837Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOCACHE2026-10-25T01:57:38.6016593Z /home/runner/go/pkg/mod2026-10-25T01:57:38.6040796Z /home/runner/.cache/go-build2026-10-25T01:57:38.7967526Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-25T01:57:44.9558471Z Received 100663296 of 249167808 (40.4%), 96.0 MBs/sec2026-10-25T01:57:45.9557210Z Received 249167808 of 249167808 (100.0%), 118.7 MBs/sec2026-10-25T01:57:45.9559149Z Cache Size: ~238 MB (249167808 B)2026-10-25T01:57:45.9640623Z [command]/usr/bin/tar -xf /home/runner/work/_temp/80bfc120-3da1-4ef7-8ef6-05aaff43e205/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-25T01:57:49.2137384Z Cache restored successfully2026-10-25T01:57:49.2761718Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-25T01:57:49.2787826Z go version go1.26.9 linux/amd642026-10-25T01:57:49.2788057Z 2026-10-25T01:57:49.2788404Z ##[group]go env2026-10-25T01:57:49.3162549Z AR='ar'2026-10-25T01:57:49.3162997Z CC='gcc'2026-10-25T01:57:49.3163406Z CGO_CFLAGS='-O2 -g'2026-10-25T01:57:49.3163907Z CGO_CPPFLAGS=''2026-10-25T01:57:49.3164209Z CGO_CXXFLAGS='-O2 -g'2026-10-25T01:57:49.3164515Z CGO_ENABLED='1'2026-10-25T01:57:49.3164782Z CGO_FFLAGS='-O2 -g'2026-10-25T01:57:49.3165065Z CGO_LDFLAGS='-O2 -g'2026-10-25T01:57:49.3165335Z CXX='g++'2026-10-25T01:57:49.3165599Z GCCGO='gccgo'2026-10-25T01:57:49.3165868Z GO111MODULE=''2026-10-25T01:57:49.3166127Z GOAMD64='v1'2026-10-25T01:57:49.3166375Z GOARCH='amd64'2026-10-25T01:57:49.3166629Z GOAUTH='netrc'2026-10-25T01:57:49.3166871Z GOBIN=''2026-10-25T01:57:49.3167156Z GOCACHE='/home/runner/.cache/go-build'2026-10-25T01:57:49.3167530Z GOCACHEPROG=''2026-10-25T01:57:49.3167794Z GODEBUG=''2026-10-25T01:57:49.3168062Z GOENV='/home/runner/.config/go/env'2026-10-25T01:57:49.3168390Z GOEXE=''2026-10-25T01:57:49.3168633Z GOEXPERIMENT=''2026-10-25T01:57:49.3168902Z GOFIPS140='off'2026-10-25T01:57:49.3169481Z GOFLAGS=''2026-10-25T01:57:49.3170355Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build2864161639=/tmp/go-build -gno-record-gcc-switches'2026-10-25T01:57:49.3171207Z GOHOSTARCH='amd64'2026-10-25T01:57:49.3171486Z GOHOSTOS='linux'2026-10-25T01:57:49.3171747Z GOINSECURE=''2026-10-25T01:57:49.3172189Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-10-25T01:57:49.3172729Z GOMODCACHE='/home/runner/go/pkg/mod'2026-10-25T01:57:49.3173075Z GONOPROXY=''2026-10-25T01:57:49.3173328Z GONOSUMDB=''2026-10-25T01:57:49.3173579Z GOOS='linux'2026-10-25T01:57:49.3173878Z GOPATH='/home/runner/go'2026-10-25T01:57:49.3174173Z GOPRIVATE=''2026-10-25T01:57:49.3174495Z GOPROXY='https://proxy.golang.org,direct'2026-10-25T01:57:49.3174913Z GOROOT='/opt/hostedtoolcache/go/1.26.9/x64'2026-10-25T01:57:49.3175290Z GOSUMDB='sum.golang.org'2026-10-25T01:57:49.3175595Z GOTELEMETRY='local'2026-10-25T01:57:49.3175946Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-10-25T01:57:49.3176336Z GOTMPDIR=''2026-10-25T01:57:49.3176593Z GOTOOLCHAIN='local'2026-10-25T01:57:49.3177276Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.9/x64/pkg/tool/linux_amd64'2026-10-25T01:57:49.3177722Z GOVCS=''2026-10-25T01:57:49.3177926Z GOVERSION='go1.26.9'2026-10-25T01:57:49.3178166Z GOWORK=''2026-10-25T01:57:49.3178389Z PKG_CONFIG='pkg-config'2026-10-25T01:57:49.3178558Z 2026-10-25T01:57:49.3178895Z ##[endgroup]2026-10-25T01:57:49.3440734Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-25T01:57:49.3441285Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-10-25T01:57:49.3513158Z shell: /usr/bin/bash -e {0}2026-10-25T01:57:49.3513433Z env:2026-10-25T01:57:49.3513637Z GOTOOLCHAIN: local2026-10-25T01:57:49.3513893Z OSPOOL_EP_OSPoolEPTag: 25-release2026-10-25T01:57:49.3514185Z OSPOOL_EP_CMTag: 25.0-el92026-10-25T01:57:49.3514458Z OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-25T01:57:49.3514729Z ##[endgroup]2026-10-25T01:57:57.2979617Z === RUN TestOSPoolEP2026-10-25T01:57:57.2980495Z === PAUSE TestOSPoolEP2026-10-25T01:57:57.2980893Z === CONT TestOSPoolEP2026-10-25T01:57:57.2982486Z TestOSPoolEP 2026-10-25T01:57:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:57:57.3111407Z TestOSPoolEP 2026-10-25T01:57:57Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 apply -f /tmp/TestOSPoolEP163408878]2026-10-25T01:57:57.7948587Z TestOSPoolEP 2026-10-25T01:57:57Z logger.go:67: pod/idtoken-generator created2026-10-25T01:57:57.8036871Z TestOSPoolEP 2026-10-25T01:57:57Z logger.go:67: secret/pool-passwd created2026-10-25T01:57:57.8101682Z TestOSPoolEP 2026-10-25T01:57:57Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-25T01:57:57.8103084Z TestOSPoolEP 2026-10-25T01:57:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:57:57.8129593Z TestOSPoolEP 2026-10-25T01:57:57Z 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:07.8136475Z TestOSPoolEP 2026-10-25T01:58:07Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-25T01:58:07.8138045Z TestOSPoolEP 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.8164300Z TestOSPoolEP 2026-10-25T01:58:07Z logger.go:67: Pod is now available2026-10-25T01:58:07.8167333Z TestOSPoolEP 2026-10-25T01:58:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-10-25T01:58:08.5179595Z TestOSPoolEP 2026-10-25T01:58:08Z logger.go:67: ***2026-10-25T01:58:08.5245803Z TestOSPoolEP 2026-10-25T01:58:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 apply -f /tmp/TestOSPoolEP3894667943]2026-10-25T01:58:08.7260050Z TestOSPoolEP 2026-10-25T01:58:08Z logger.go:67: secret/pool-token created2026-10-25T01:58:08.7299349Z TestOSPoolEP 2026-10-25T01:58:08Z retry.go:91: Wait for secret pool-token to be provisioned.2026-10-25T01:58:08.7300630Z TestOSPoolEP 2026-10-25T01:58:08Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:08.7318459Z TestOSPoolEP 2026-10-25T01:58:08Z logger.go:67: Secret is now available2026-10-25T01:58:08.7347062Z TestOSPoolEP 2026-10-25T01:58:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 apply -k /tmp/kustomize-template-652470652]2026-10-25T01:58:09.1271324Z TestOSPoolEP 2026-10-25T01:58:09Z logger.go:67: serviceaccount/cvmfs-nodeplugin created2026-10-25T01:58:09.1354719Z TestOSPoolEP 2026-10-25T01:58:09Z logger.go:67: service/frontier-squid created2026-10-25T01:58:09.1451204Z TestOSPoolEP 2026-10-25T01:58:09Z logger.go:67: service/test-cm created2026-10-25T01:58:09.1524202Z TestOSPoolEP 2026-10-25T01:58:09Z logger.go:67: deployment.apps/cvmfs-nodeplugin created2026-10-25T01:58:09.1606711Z TestOSPoolEP 2026-10-25T01:58:09Z logger.go:67: deployment.apps/frontier-squid created2026-10-25T01:58:09.1857667Z TestOSPoolEP 2026-10-25T01:58:09Z 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:09.1866159Z TestOSPoolEP 2026-10-25T01:58:09Z logger.go:67: deployment.apps/ospool-ep created2026-10-25T01:58:09.2080898Z TestOSPoolEP 2026-10-25T01:58:09Z logger.go:67: deployment.apps/test-cm created2026-10-25T01:58:09.2154534Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-10-25T01:58:09.2155914Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:09.2282747Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:09Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-25T01:58:09.2323884Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:09.2337508Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:09Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-25T01:58:09.2340335Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:09.2344159Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:09Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-25T01:58:09.2346185Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:09.2348109Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:09Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-25T01:58:09.2350222Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:09.2468764Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:09Z 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:09.2473759Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:09Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-cc75b66b9". Sleeping for 10s and will try again.2026-10-25T01:58:09.2476728Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:09Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "test-cm-7f9d786cd6". Sleeping for 10s and will try again.2026-10-25T01:58:09.2481097Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:09Z 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:19.2506625Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:19Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-25T01:58:19.2509937Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:19.2538763Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:19Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-25T01:58:19.2544693Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:19.2546703Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:19Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-25T01:58:19.2548550Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:19.2550776Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:19Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-25T01:58:19.2553106Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:19.2563880Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:19Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "test-cm-7f9d786cd6" is progressing.. Sleeping for 10s and will try again.2026-10-25T01:58:19.2569937Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:19Z 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:19.2573841Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:19Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-cc75b66b9" is progressing.. Sleeping for 10s and will try again.2026-10-25T01:58:19.2576586Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:19Z logger.go:67: Deployment is now available2026-10-25T01:58:29.2572325Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:29Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-25T01:58:29.2591096Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:29.2593282Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:29Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-25T01:58:29.2595321Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:29.2597176Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:29Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-25T01:58:29.2599454Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:29.2623461Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:29Z logger.go:67: Deployment is now available2026-10-25T01:58:29.2659716Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:29Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "test-cm-7f9d786cd6" is progressing.. Sleeping for 10s and will try again.2026-10-25T01:58:29.2676564Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:29Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-cc75b66b9" is progressing.. Sleeping for 10s and will try again.2026-10-25T01:58:39.2674311Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:39Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-25T01:58:39.2677389Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:39.2687405Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:39Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-25T01:58:39.2690243Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:39.2710810Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:39Z logger.go:67: Deployment is now available2026-10-25T01:58:39.2732671Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:39Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-cc75b66b9" is progressing.. Sleeping for 10s and will try again.2026-10-25T01:58:49.2727399Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:49Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-25T01:58:49.2729875Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:49.2759957Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-25T01:58:49Z logger.go:67: Deployment is now available2026-10-25T01:58:49.2762786Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP2026-10-25T01:58:49.2764391Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-25T01:58:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:58:49.2793466Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-25T01:58:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 cp ../test-configs/ospool-ep/condor_status.sh test-cm-7f9d786cd6-gr7fk:/tmp/condor_status.sh]2026-10-25T01:58:49.6676833Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-25T01:58:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 exec test-cm-7f9d786cd6-gr7fk -- chmod +x /tmp/condor_status.sh]2026-10-25T01:58:49.8790628Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-25T01:58:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 exec test-cm-7f9d786cd6-gr7fk -- sh -c /tmp/condor_status.sh]2026-10-25T01:58:50.0830680Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-25T01:58:50Z logger.go:67: command terminated with exit code 12026-10-25T01:58:50.0878254Z test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-7f9d786cd6-gr7fk failed. Retrying in 10s.2026-10-25T01:59:00.0893687Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-25T01:59:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 exec test-cm-7f9d786cd6-gr7fk -- sh -c /tmp/condor_status.sh]2026-10-25T01:59:00.3051174Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity2026-10-25T01:59:00.3053257Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-25T01:59:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:59:00.3087548Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-25T01:59:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 cp ../test-configs/ospool-ep/has_singularity.sh test-cm-7f9d786cd6-gr7fk:/tmp/has_singularity.sh]2026-10-25T01:59:00.5765079Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-25T01:59:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 exec test-cm-7f9d786cd6-gr7fk -- chmod +x /tmp/has_singularity.sh]2026-10-25T01:59:00.7765117Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-25T01:59:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 exec test-cm-7f9d786cd6-gr7fk -- sh -c /tmp/has_singularity.sh]2026-10-25T01:59:00.9631458Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-10-25T01:59:00.9635433Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T01:59:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T01:59:00.9665477Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T01:59:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 cp ../test-configs/ospool-ep/has_cvmfs.sh test-cm-7f9d786cd6-gr7fk:/tmp/has_cvmfs.sh]2026-10-25T01:59:01.1877020Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T01:59:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 exec test-cm-7f9d786cd6-gr7fk -- chmod +x /tmp/has_cvmfs.sh]2026-10-25T01:59:01.3377683Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T01:59:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 exec test-cm-7f9d786cd6-gr7fk -- sh -c /tmp/has_cvmfs.sh]2026-10-25T01:59:01.5032222Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T01:59:01Z logger.go:67: command terminated with exit code 12026-10-25T01:59:01.5071958Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gr7fk failed. Retrying in 30s.2026-10-25T01:59:31.5084376Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T01:59:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 exec test-cm-7f9d786cd6-gr7fk -- sh -c /tmp/has_cvmfs.sh]2026-10-25T01:59:31.6766078Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T01:59:31Z logger.go:67: command terminated with exit code 12026-10-25T01:59:31.6813606Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gr7fk failed. Retrying in 30s.2026-10-25T02:00:01.6816389Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:00:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 exec test-cm-7f9d786cd6-gr7fk -- sh -c /tmp/has_cvmfs.sh]2026-10-25T02:00:01.8482942Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:00:01Z logger.go:67: command terminated with exit code 12026-10-25T02:00:01.8519531Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gr7fk failed. Retrying in 30s.2026-10-25T02:00:31.8530819Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:00:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 exec test-cm-7f9d786cd6-gr7fk -- sh -c /tmp/has_cvmfs.sh]2026-10-25T02:00:31.9994463Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:00:31Z logger.go:67: command terminated with exit code 12026-10-25T02:00:32.0028859Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gr7fk failed. Retrying in 30s.2026-10-25T02:01:02.0037004Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:01:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 exec test-cm-7f9d786cd6-gr7fk -- sh -c /tmp/has_cvmfs.sh]2026-10-25T02:01:02.1881839Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:01:02Z logger.go:67: command terminated with exit code 12026-10-25T02:01:02.1922752Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gr7fk failed. Retrying in 30s.2026-10-25T02:01:32.1926629Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:01:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 exec test-cm-7f9d786cd6-gr7fk -- sh -c /tmp/has_cvmfs.sh]2026-10-25T02:01:32.3417608Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:01:32Z logger.go:67: command terminated with exit code 12026-10-25T02:01:32.3455327Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gr7fk failed. Retrying in 30s.2026-10-25T02:02:02.3490014Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:02:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 exec test-cm-7f9d786cd6-gr7fk -- sh -c /tmp/has_cvmfs.sh]2026-10-25T02:02:02.5004361Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:02:02Z logger.go:67: command terminated with exit code 12026-10-25T02:02:02.5041310Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gr7fk failed. Retrying in 30s.2026-10-25T02:02:32.5056562Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:02:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 exec test-cm-7f9d786cd6-gr7fk -- sh -c /tmp/has_cvmfs.sh]2026-10-25T02:02:32.6552636Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:02:32Z logger.go:67: command terminated with exit code 12026-10-25T02:02:32.6587549Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gr7fk failed. Retrying in 30s.2026-10-25T02:03:02.6641855Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:03:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 exec test-cm-7f9d786cd6-gr7fk -- sh -c /tmp/has_cvmfs.sh]2026-10-25T02:03:02.8161465Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:03:02Z logger.go:67: command terminated with exit code 12026-10-25T02:03:02.8194256Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gr7fk failed. Retrying in 30s.2026-10-25T02:03:32.8198363Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:03:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 exec test-cm-7f9d786cd6-gr7fk -- sh -c /tmp/has_cvmfs.sh]2026-10-25T02:03:32.9717326Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-25T02:03:32Z logger.go:67: command terminated with exit code 12026-10-25T02:03:32.9751807Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gr7fk failed. Retrying in 30s.2026-10-25T02:04:02.9812622Z test_utils.go:105: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gr7fk did not succeed within {10 30000000000} retries2026-10-25T02:04:02.9817537Z TestOSPoolEP 2026-10-25T02:04:02Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:02.9888583Z TestOSPoolEP 2026-10-25T02:04:02Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:03.1431699Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:03.2700945Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:03.3898435Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:03.5287551Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:03.6586228Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:03.6618374Z === NAME TestOSPoolEP2026-10-25T02:04:03.6619916Z ospool_ep_test.go:72: ---2026-10-25T02:04:03.6620754Z Events for pod cvmfs-nodeplugin-5cd89c7cfd-7n6ns:2026-10-25T02:04:03.6622446Z 2026-10-25 01:58:09 +0000 UTC Normal Successfully assigned test-ospool-ep-ndnpc1/cvmfs-nodeplugin-5cd89c7cfd-7n6ns to minikube2026-10-25T02:04:03.6624193Z 2026-10-25 01:58:09 +0000 UTC Normal Pulling image "opensciencegrid/cvmfs-nodeplugin:fresh"2026-10-25T02:04:03.6626545Z 2026-10-25 01:58:15 +0000 UTC Normal Successfully pulled image "opensciencegrid/cvmfs-nodeplugin:fresh" in 5.578s (5.578s including waiting). Image size: 155940803 bytes.2026-10-25T02:04:03.6627760Z 2026-10-25 01:58:15 +0000 UTC Normal Container created2026-10-25T02:04:03.6629686Z 2026-10-25 01:58:15 +0000 UTC Normal Container started2026-10-25T02:04:03.6630311Z 2026-10-25T02:04:03.6630692Z ---2026-10-25T02:04:03.6631719Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:03.6647419Z ospool_ep_test.go:72: ---2026-10-25T02:04:03.6648571Z Events for pod frontier-squid-65f85c968-bq8f4:2026-10-25T02:04:03.6650208Z 2026-10-25 01:58:09 +0000 UTC Normal Successfully assigned test-ospool-ep-ndnpc1/frontier-squid-65f85c968-bq8f4 to minikube2026-10-25T02:04:03.6651646Z 2026-10-25 01:58:09 +0000 UTC Normal Pulling image "opensciencegrid/frontier-squid:fresh"2026-10-25T02:04:03.6654021Z 2026-10-25 01:58:26 +0000 UTC Normal Successfully pulled image "opensciencegrid/frontier-squid:fresh" in 11.175s (16.691s including waiting). Image size: 453187319 bytes.2026-10-25T02:04:03.6655409Z 2026-10-25 01:58:26 +0000 UTC Normal Container created2026-10-25T02:04:03.6656170Z 2026-10-25 01:58:26 +0000 UTC Normal Container started2026-10-25T02:04:03.6656694Z 2026-10-25T02:04:03.6657024Z ---2026-10-25T02:04:03.6657922Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:03.6672331Z ospool_ep_test.go:72: ---2026-10-25T02:04:03.6672952Z Events for pod idtoken-generator:2026-10-25T02:04:03.6674170Z 2026-10-25 01:57:57 +0000 UTC Normal Successfully assigned test-ospool-ep-ndnpc1/idtoken-generator to minikube2026-10-25T02:04:03.6675345Z 2026-10-25 01:57:58 +0000 UTC Normal Pulling image "htcondor/base"2026-10-25T02:04:03.6676882Z 2026-10-25 01:58:03 +0000 UTC Normal Successfully pulled image "htcondor/base" in 5.632s (5.632s including waiting). Image size: 196303183 bytes.2026-10-25T02:04:03.6678082Z 2026-10-25 01:58:03 +0000 UTC Normal Container created2026-10-25T02:04:03.6678874Z 2026-10-25 01:58:03 +0000 UTC Normal Container started2026-10-25T02:04:03.6679586Z 2026-10-25T02:04:03.6679934Z ---2026-10-25T02:04:03.6680804Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:03.6698318Z ospool_ep_test.go:72: ---2026-10-25T02:04:03.6699922Z Events for pod ospool-ep-cc75b66b9-dnjvj:2026-10-25T02:04:03.6701247Z 2026-10-25 01:58:09 +0000 UTC Normal Successfully assigned test-ospool-ep-ndnpc1/ospool-ep-cc75b66b9-dnjvj to minikube2026-10-25T02:04:03.6702787Z 2026-10-25 01:58:09 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-10-25T02:04:03.6704822Z 2026-10-25 01:58:27 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.537s (18.2s including waiting). Image size: 2893600 bytes.2026-10-25T02:04:03.6706673Z 2026-10-25 01:58:27 +0000 UTC Normal Container created2026-10-25T02:04:03.6707582Z 2026-10-25 01:58:27 +0000 UTC Normal Container started2026-10-25T02:04:03.6709324Z 2026-10-25 01:58:28 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-10-25T02:04:03.6711428Z 2026-10-25 01:58:47 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 15.04s (18.593s including waiting). Image size: 537931704 bytes.2026-10-25T02:04:03.6712845Z 2026-10-25 01:58:47 +0000 UTC Normal Container created2026-10-25T02:04:03.6713604Z 2026-10-25 01:58:47 +0000 UTC Normal Container started2026-10-25T02:04:03.6714111Z 2026-10-25T02:04:03.6714438Z ---2026-10-25T02:04:03.6715333Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:03.6732795Z ospool_ep_test.go:72: ---2026-10-25T02:04:03.6733957Z Events for pod test-cm-7f9d786cd6-gr7fk:2026-10-25T02:04:03.6736006Z 2026-10-25 01:58:09 +0000 UTC Normal Successfully assigned test-ospool-ep-ndnpc1/test-cm-7f9d786cd6-gr7fk to minikube2026-10-25T02:04:03.6737525Z 2026-10-25 01:58:09 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-10-25T02:04:03.6739896Z 2026-10-25 01:58:32 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 4.559s (22.729s including waiting). Image size: 198153089 bytes.2026-10-25T02:04:03.6741351Z 2026-10-25 01:58:32 +0000 UTC Normal Container created2026-10-25T02:04:03.6742137Z 2026-10-25 01:58:32 +0000 UTC Normal Container started2026-10-25T02:04:03.6742495Z 2026-10-25T02:04:03.6742726Z ---2026-10-25T02:04:03.6743468Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-25T02:04:03.6776039Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 delete -f /tmp/TestOSPoolEP4262458872]2026-10-25T02:04:03.7874427Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-ndnpc1 namespace2026-10-25T02:04:03.7974559Z TestOSPoolEP 2026-10-25T02:04:03Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-ndnpc1 namespace2026-10-25T02:04:05.6014635Z TestOSPoolEP 2026-10-25T02:04:05Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 delete -f /tmp/TestOSPoolEP1211809966]2026-10-25T02:04:05.7218793Z TestOSPoolEP 2026-10-25T02:04:05Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-ndnpc1 namespace2026-10-25T02:04:05.7272935Z TestOSPoolEP 2026-10-25T02:04:05Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ndnpc1 delete -k /tmp/kustomize-template-652470652]2026-10-25T02:04:05.8717663Z TestOSPoolEP 2026-10-25T02:04:05Z logger.go:67: serviceaccount "cvmfs-nodeplugin" deleted from test-ospool-ep-ndnpc1 namespace2026-10-25T02:04:05.8835823Z TestOSPoolEP 2026-10-25T02:04:05Z logger.go:67: service "frontier-squid" deleted from test-ospool-ep-ndnpc1 namespace2026-10-25T02:04:05.8936802Z TestOSPoolEP 2026-10-25T02:04:05Z logger.go:67: service "test-cm" deleted from test-ospool-ep-ndnpc1 namespace2026-10-25T02:04:05.8994074Z TestOSPoolEP 2026-10-25T02:04:05Z logger.go:67: deployment.apps "cvmfs-nodeplugin" deleted from test-ospool-ep-ndnpc1 namespace2026-10-25T02:04:05.9121367Z TestOSPoolEP 2026-10-25T02:04:05Z logger.go:67: deployment.apps "frontier-squid" deleted from test-ospool-ep-ndnpc1 namespace2026-10-25T02:04:05.9259398Z TestOSPoolEP 2026-10-25T02:04:05Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-ndnpc1 namespace2026-10-25T02:04:05.9454757Z TestOSPoolEP 2026-10-25T02:04:05Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-ndnpc1 namespace2026-10-25T02:04:05.9832187Z --- FAIL: TestOSPoolEP (368.69s)2026-10-25T02:04:05.9855599Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (40.06s)2026-10-25T02:04:05.9870720Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP (11.03s)2026-10-25T02:04:05.9873841Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity (0.66s)2026-10-25T02:04:05.9876701Z --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (302.02s)2026-10-25T02:04:05.9877801Z FAIL2026-10-25T02:04:05.9878590Z FAIL github.com/osg-htc/k8s-integration-tests/test 368.703s2026-10-25T02:04:06.0003240Z FAIL2026-10-25T02:04:06.1164705Z ##[error]Process completed with exit code 1.2026-10-25T02:04:06.1261054Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-25T02:04:06.1262167Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-10-25T02:04:06.1380022Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-25T02:04:06.1380632Z env:2026-10-25T02:04:06.1381268Z GOTOOLCHAIN: local2026-10-25T02:04:06.1382044Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-25T02:04:06.1382877Z ##[endgroup]2026-10-25T02:04:06.1750220Z ##[group]Run actions/upload-artifact@v42026-10-25T02:04:06.1750725Z with:2026-10-25T02:04:06.1751334Z name: TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f02026-10-25T02:04:06.1752066Z path: /tmp/k8s-tests2026-10-25T02:04:06.1752436Z retention-days: 52026-10-25T02:04:06.1752790Z if-no-files-found: warn2026-10-25T02:04:06.1753175Z compression-level: 62026-10-25T02:04:06.1753530Z overwrite: false2026-10-25T02:04:06.1753885Z include-hidden-files: false2026-10-25T02:04:06.1754264Z env:2026-10-25T02:04:06.1754568Z GOTOOLCHAIN: local2026-10-25T02:04:06.1754905Z ##[endgroup]2026-10-25T02:04:06.5050555Z (node:16036) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-25T02:04:06.5060751Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-25T02:04:06.5224440Z With the provided path, there will be 10 files uploaded2026-10-25T02:04:06.5229552Z Artifact name is valid!2026-10-25T02:04:06.5231186Z Root directory input is valid!2026-10-25T02:04:06.8222444Z Beginning upload of artifact content to blob storage2026-10-25T02:04:06.8589816Z (node:16036) [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:07.0158271Z Uploaded bytes 159132026-10-25T02:04:07.0554962Z Finished uploading artifact content to blob storage!2026-10-25T02:04:07.0556755Z SHA256 digest of uploaded artifact zip is 3162959404b94b97ed74334552cbd0bb503db1523dc7fc56f0e27f7d03f15cf22026-10-25T02:04:07.0558064Z Finalizing artifact upload2026-10-25T02:04:07.5134903Z Artifact TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f0.zip successfully finalized. Artifact ID 125836360702026-10-25T02:04:07.5137865Z Artifact TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f0 has been successfully uploaded! Final size is 15913 bytes. Artifact ID is 125836360702026-10-25T02:04:07.5143505Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/40152541575/artifacts/125836360702026-10-25T02:04:07.5367216Z Post job cleanup.2026-10-25T02:04:07.6373638Z [command]/usr/bin/git version2026-10-25T02:04:07.6438064Z git version 2.55.02026-10-25T02:04:07.6496904Z Temporarily overriding HOME='/home/runner/work/_temp/cff874b6-5dc0-47c2-8c3c-e94ff29209db' before making global git config changes2026-10-25T02:04:07.6498572Z Adding repository directory to the temporary git global config as a safe directory2026-10-25T02:04:07.6507768Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-25T02:04:07.6566801Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-25T02:04:07.6632521Z [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:07.6962931Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-25T02:04:07.6994491Z http.https://github.com/.extraheader2026-10-25T02:04:07.7008566Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-10-25T02:04:07.7052362Z [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:07.7498289Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-25T02:04:07.7554037Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-25T02:04:07.8039488Z Cleaning up orphan processes2026-10-25T02:04:07.9045923Z ##[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/