2026-10-24T02:10:02.4091124Z Current runner version: '2.338.0'2026-10-24T02:10:02.4116319Z ##[group]Runner Image Provisioner2026-10-24T02:10:02.4117396Z Hosted Compute Agent2026-10-24T02:10:02.4118030Z Version: 20261012.6012026-10-24T02:10:02.4118908Z Commit: f3dc54e1fb89da6852db922499a0233137369e1d2026-10-24T02:10:02.4119745Z Build Date: 2026-10-12T17:48:21Z2026-10-24T02:10:02.4120461Z Worker ID: {7012dbb2-54c7-4305-a1d8-75efe3a53787}2026-10-24T02:10:02.4121284Z Region: westcentralus2026-10-24T02:10:02.4121907Z Cloud: Azure2026-10-24T02:10:02.4122461Z ##[endgroup]2026-10-24T02:10:02.4124029Z ##[group]Operating System2026-10-24T02:10:02.4124776Z Ubuntu2026-10-24T02:10:02.4125431Z 22.04.52026-10-24T02:10:02.4126036Z LTS2026-10-24T02:10:02.4126567Z ##[endgroup]2026-10-24T02:10:02.4127221Z ##[group]Runner Image2026-10-24T02:10:02.4127848Z Image: ubuntu-22.042026-10-24T02:10:02.4128685Z Version: 20261012.322.12026-10-24T02:10:02.4130089Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20261012.322/images/ubuntu/Ubuntu2204-Readme.md2026-10-24T02:10:02.4131735Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20261012.3222026-10-24T02:10:02.4132721Z ##[endgroup]2026-10-24T02:10:02.4136228Z ##[group]GITHUB_TOKEN Permissions2026-10-24T02:10:02.4138875Z Actions: write2026-10-24T02:10:02.4139593Z ArtifactMetadata: write2026-10-24T02:10:02.4140266Z Attestations: write2026-10-24T02:10:02.4140849Z Checks: write2026-10-24T02:10:02.4141482Z CodeQuality: write2026-10-24T02:10:02.4142079Z Contents: write2026-10-24T02:10:02.4142634Z CopilotRequests: write2026-10-24T02:10:02.4143371Z Deployments: write2026-10-24T02:10:02.4143995Z Discussions: write2026-10-24T02:10:02.4144623Z Drives: write2026-10-24T02:10:02.4145179Z Issues: write2026-10-24T02:10:02.4145801Z Metadata: read2026-10-24T02:10:02.4146458Z Models: read2026-10-24T02:10:02.4147010Z Packages: write2026-10-24T02:10:02.4147629Z Pages: write2026-10-24T02:10:02.4148430Z PullRequests: write2026-10-24T02:10:02.4149193Z RepositoryProjects: write2026-10-24T02:10:02.4149965Z SecurityEvents: write2026-10-24T02:10:02.4150551Z Statuses: write2026-10-24T02:10:02.4151182Z VulnerabilityAlerts: read2026-10-24T02:10:02.4151827Z ##[endgroup]2026-10-24T02:10:02.4153966Z Secret source: Actions2026-10-24T02:10:02.4155042Z Cache mode: write2026-10-24T02:10:02.4155756Z Prepare workflow directory2026-10-24T02:10:02.4500993Z Prepare all required actions2026-10-24T02:10:02.4548924Z Getting action download info2026-10-24T02:10:02.7690128Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-10-24T02:10:02.9100340Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-10-24T02:10:03.3448567Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-10-24T02:10:03.8461083Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-10-24T02:10:04.1775262Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (63ec080e4eea87fb8a9eae678ab9944ec2461251)2026-10-24T02:10:04.1781760Z ##[group] Inputs2026-10-24T02:10:04.1782682Z testName: TestOSPoolEP2026-10-24T02:10:04.1784401Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-24T02:10:04.1786257Z setupScript: 2026-10-24T02:10:04.1787045Z setupEnv: {}2026-10-24T02:10:04.1787810Z ##[endgroup]2026-10-24T02:10:04.1789325Z Complete job name: ospool-ep / Run OSPool EP test (cvmfs-bind, 25-release) / Run Tests2026-10-24T02:10:04.2663987Z ##[group]Run actions/checkout@v52026-10-24T02:10:04.2665271Z with:2026-10-24T02:10:04.2666106Z repository: osg-htc/k8s-integration-tests2026-10-24T02:10:04.2675626Z token: ***2026-10-24T02:10:04.2676408Z ssh-strict: true2026-10-24T02:10:04.2677199Z ssh-user: git2026-10-24T02:10:04.2678007Z persist-credentials: true2026-10-24T02:10:04.2679062Z clean: true2026-10-24T02:10:04.2680400Z sparse-checkout-cone-mode: true2026-10-24T02:10:04.2681591Z fetch-depth: 12026-10-24T02:10:04.2682544Z fetch-tags: false2026-10-24T02:10:04.2683414Z show-progress: true2026-10-24T02:10:04.2684219Z lfs: false2026-10-24T02:10:04.2684971Z submodules: false2026-10-24T02:10:04.2685794Z set-safe-directory: true2026-10-24T02:10:04.2686736Z allow-unsafe-pr-checkout: false2026-10-24T02:10:04.2688049Z ##[endgroup]2026-10-24T02:10:04.3759367Z Syncing repository: osg-htc/k8s-integration-tests2026-10-24T02:10:04.3763286Z ##[group]Getting Git version info2026-10-24T02:10:04.3765911Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-24T02:10:04.3769769Z [command]/usr/bin/git version2026-10-24T02:10:04.3812148Z git version 2.55.02026-10-24T02:10:04.3838000Z ##[endgroup]2026-10-24T02:10:04.3855437Z Temporarily overriding HOME='/home/runner/work/_temp/f538a450-848d-48d7-b1ba-b293f26bf5dc' before making global git config changes2026-10-24T02:10:04.3860763Z Adding repository directory to the temporary git global config as a safe directory2026-10-24T02:10:04.3865882Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-24T02:10:04.3906723Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-24T02:10:04.3911666Z ##[group]Initializing the repository2026-10-24T02:10:04.3915843Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-24T02:10:04.4042531Z hint: Using 'master' as the name for the initial branch. This default branch name2026-10-24T02:10:04.4045088Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-10-24T02:10:04.4048483Z hint: to use in all of your new repositories, which will suppress this warning,2026-10-24T02:10:04.4050307Z hint: call:2026-10-24T02:10:04.4051194Z hint:2026-10-24T02:10:04.4052291Z hint: git config --global init.defaultBranch <name>2026-10-24T02:10:04.4054091Z hint:2026-10-24T02:10:04.4055708Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-10-24T02:10:04.4057714Z hint: 'development'. The just-created branch can be renamed via this command:2026-10-24T02:10:04.4060414Z hint:2026-10-24T02:10:04.4061937Z hint: git branch -m <name>2026-10-24T02:10:04.4063554Z hint:2026-10-24T02:10:04.4065787Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-10-24T02:10:04.4069281Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-10-24T02:10:04.4074798Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-10-24T02:10:04.4106226Z ##[endgroup]2026-10-24T02:10:04.4109223Z ##[group]Disabling automatic garbage collection2026-10-24T02:10:04.4111786Z [command]/usr/bin/git config --local gc.auto 02026-10-24T02:10:04.4151586Z ##[endgroup]2026-10-24T02:10:04.4153365Z ##[group]Setting up auth2026-10-24T02:10:04.4160352Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-24T02:10:04.4200141Z [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-24T02:10:04.4663428Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-24T02:10:04.4714767Z [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-24T02:10:04.5015333Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-24T02:10:04.5060130Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-24T02:10:04.5342530Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-10-24T02:10:04.5388109Z ##[endgroup]2026-10-24T02:10:04.5397159Z ##[group]Fetching the repository2026-10-24T02:10:04.5400081Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +63ec080e4eea87fb8a9eae678ab9944ec2461251:refs/remotes/origin/main2026-10-24T02:10:04.9703440Z From https://github.com/osg-htc/k8s-integration-tests2026-10-24T02:10:04.9705096Z * [new ref] 63ec080e4eea87fb8a9eae678ab9944ec2461251 -> origin/main2026-10-24T02:10:04.9709206Z ##[endgroup]2026-10-24T02:10:04.9710587Z ##[group]Determining the checkout info2026-10-24T02:10:04.9712457Z ##[endgroup]2026-10-24T02:10:04.9717518Z [command]/usr/bin/git sparse-checkout disable2026-10-24T02:10:04.9770292Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-10-24T02:10:04.9806577Z ##[group]Checking out the ref2026-10-24T02:10:04.9810634Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-10-24T02:10:04.9915676Z Switched to a new branch 'main'2026-10-24T02:10:04.9919655Z branch 'main' set up to track 'origin/main'.2026-10-24T02:10:04.9931307Z ##[endgroup]2026-10-24T02:10:04.9987819Z [command]/usr/bin/git log -1 --format=%H2026-10-24T02:10:05.0021128Z 63ec080e4eea87fb8a9eae678ab9944ec24612512026-10-24T02:10:05.0291018Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-24T02:10:05.0293343Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-24T02:10:05.0295577Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-24T02:10:05.1055155Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-24T02:10:05.1056503Z env:2026-10-24T02:10:05.1058464Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-24T02:10:05.1060420Z SETUP_ENV_YAML: {}2026-10-24T02:10:05.1061329Z ##[endgroup]2026-10-24T02:10:05.9483062Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-24T02:10:05.9483880Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-10-24T02:10:05.9562530Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-24T02:10:05.9563042Z env:2026-10-24T02:10:05.9563652Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfs-bind"}2026-10-24T02:10:05.9564325Z ##[endgroup]2026-10-24T02:10:05.9722944Z ##[group]Run true2026-10-24T02:10:05.9723344Z [36;1mtrue[0m2026-10-24T02:10:05.9788400Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-24T02:10:05.9788940Z ##[endgroup]2026-10-24T02:10:05.9982400Z ##[group]Run medyagh/setup-minikube@latest2026-10-24T02:10:05.9982857Z with:2026-10-24T02:10:05.9983190Z start: true2026-10-24T02:10:05.9983503Z cache: true2026-10-24T02:10:05.9983835Z minikube-version: latest2026-10-24T02:10:05.9984197Z wait: all2026-10-24T02:10:05.9984502Z ##[endgroup]2026-10-24T02:10:06.1278935Z (node:2255) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-24T02:10:06.1280028Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-24T02:10:07.5611229Z [command]/usr/bin/chmod +x /home/runner/work/_temp/7ad66773-e3c7-4e2d-b4aa-2d47e474bf182026-10-24T02:10:07.7445637Z [command]/home/runner/bin/minikube version --short2026-10-24T02:10:07.7901076Z v1.39.02026-10-24T02:10:07.9750182Z Cache hit for: preloaded-tarball-v1.39.0-x64-stable-docker2026-10-24T02:10:07.9863537Z (node:2255) [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-24T02:10:07.9880955Z Cache hit for: kic-v1.39.0-x642026-10-24T02:10:09.2002852Z Received 41943040 of 531630645 (7.9%), 40.0 MBs/sec2026-10-24T02:10:09.2189054Z Received 37748736 of 288577004 (13.1%), 35.9 MBs/sec2026-10-24T02:10:10.2062065Z Received 167772160 of 531630645 (31.6%), 79.7 MBs/sec2026-10-24T02:10:10.2199011Z Received 138412032 of 288577004 (48.0%), 65.9 MBs/sec2026-10-24T02:10:11.2064111Z Received 301989888 of 531630645 (56.8%), 95.7 MBs/sec2026-10-24T02:10:11.2219257Z Received 275994092 of 288577004 (95.6%), 87.6 MBs/sec2026-10-24T02:10:11.2952928Z Received 288577004 of 288577004 (100.0%), 89.4 MBs/sec2026-10-24T02:10:11.2953886Z Cache Size: ~275 MB (288577004 B)2026-10-24T02:10:11.3453399Z [command]/usr/bin/tar -xf /home/runner/work/_temp/71fc2c38-d7d5-440f-ae6b-ed54fa1af0a5/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-24T02:10:12.2128861Z Received 423624704 of 531630645 (79.7%), 100.6 MBs/sec2026-10-24T02:10:12.2714397Z Cache restored successfully2026-10-24T02:10:12.8675803Z Received 531630645 of 531630645 (100.0%), 108.6 MBs/sec2026-10-24T02:10:12.8677323Z Cache Size: ~507 MB (531630645 B)2026-10-24T02:10:12.8817969Z [command]/usr/bin/tar -xf /home/runner/work/_temp/6b7ba466-7c99-4805-993d-014c66a50dd4/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-24T02:10:13.8635578Z Cache restored successfully2026-10-24T02:10:13.9833320Z [command]/home/runner/bin/minikube start --wait all2026-10-24T02:10:14.0314879Z * minikube v1.39.0 on Ubuntu 22.042026-10-24T02:10:16.7631394Z ! 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-24T02:10:16.7644924Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-10-24T02:10:16.8454895Z * Using Docker driver with root privileges2026-10-24T02:10:16.8464080Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-10-24T02:10:16.8470905Z * Pulling base image v0.0.51 ...2026-10-24T02:10:38.2443721Z * Preparing Kubernetes v1.37.0 on containerd 2.3.4 ...2026-10-24T02:10:46.1851080Z * Configuring CNI (Container Networking Interface) ...2026-10-24T02:10:51.5628912Z * Verifying Kubernetes components...2026-10-24T02:10:51.5925536Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-10-24T02:10:52.1462194Z * Enabled addons: storage-provisioner, default-storageclass2026-10-24T02:11:11.3394434Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-10-24T02:11:11.3549762Z [command]/home/runner/bin/minikube version --short2026-10-24T02:11:11.4053252Z v1.39.02026-10-24T02:11:11.4381675Z ##[group]Run actions/setup-go@v62026-10-24T02:11:11.4381969Z with:2026-10-24T02:11:11.4382174Z go-version: 1.262026-10-24T02:11:11.4382400Z cache: true2026-10-24T02:11:11.4382624Z cache-dependency-path: go.sum2026-10-24T02:11:11.4382875Z check-latest: false2026-10-24T02:11:11.4385452Z token: ***2026-10-24T02:11:11.4385665Z ##[endgroup]2026-10-24T02:11:11.5728454Z Setup go version spec 1.262026-10-24T02:11:11.6325480Z Found in cache @ /opt/hostedtoolcache/go/1.26.9/x642026-10-24T02:11:11.6327952Z Added go to the path2026-10-24T02:11:11.6332123Z Successfully set up Go version 1.262026-10-24T02:11:12.6685291Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOMODCACHE2026-10-24T02:11:12.6732666Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOCACHE2026-10-24T02:11:12.6768122Z /home/runner/go/pkg/mod2026-10-24T02:11:12.6798325Z /home/runner/.cache/go-build2026-10-24T02:11:12.8621474Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-24T02:11:14.0808934Z Received 37748736 of 249167808 (15.1%), 35.8 MBs/sec2026-10-24T02:11:15.0826811Z Received 171966464 of 249167808 (69.0%), 81.7 MBs/sec2026-10-24T02:11:15.6865906Z Received 249167808 of 249167808 (100.0%), 91.0 MBs/sec2026-10-24T02:11:15.6867447Z Cache Size: ~238 MB (249167808 B)2026-10-24T02:11:15.6936859Z [command]/usr/bin/tar -xf /home/runner/work/_temp/c19ffe55-d845-4776-837e-b98a1e766e09/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-24T02:11:18.8136814Z Cache restored successfully2026-10-24T02:11:18.8685819Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-24T02:11:18.8711688Z go version go1.26.9 linux/amd642026-10-24T02:11:18.8711928Z 2026-10-24T02:11:18.8712254Z ##[group]go env2026-10-24T02:11:18.9563875Z AR='ar'2026-10-24T02:11:18.9564301Z CC='gcc'2026-10-24T02:11:18.9564626Z CGO_CFLAGS='-O2 -g'2026-10-24T02:11:18.9564887Z CGO_CPPFLAGS=''2026-10-24T02:11:18.9565131Z CGO_CXXFLAGS='-O2 -g'2026-10-24T02:11:18.9565483Z CGO_ENABLED='1'2026-10-24T02:11:18.9565892Z CGO_FFLAGS='-O2 -g'2026-10-24T02:11:18.9566295Z CGO_LDFLAGS='-O2 -g'2026-10-24T02:11:18.9566687Z CXX='g++'2026-10-24T02:11:18.9567029Z GCCGO='gccgo'2026-10-24T02:11:18.9567333Z GO111MODULE=''2026-10-24T02:11:18.9567544Z GOAMD64='v1'2026-10-24T02:11:18.9567753Z GOARCH='amd64'2026-10-24T02:11:18.9567960Z GOAUTH='netrc'2026-10-24T02:11:18.9568452Z GOBIN=''2026-10-24T02:11:18.9568703Z GOCACHE='/home/runner/.cache/go-build'2026-10-24T02:11:18.9569004Z GOCACHEPROG=''2026-10-24T02:11:18.9569230Z GODEBUG=''2026-10-24T02:11:18.9569459Z GOENV='/home/runner/.config/go/env'2026-10-24T02:11:18.9569727Z GOEXE=''2026-10-24T02:11:18.9569934Z GOEXPERIMENT=''2026-10-24T02:11:18.9570180Z GOFIPS140='off'2026-10-24T02:11:18.9570390Z GOFLAGS=''2026-10-24T02:11:18.9571101Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build3700390823=/tmp/go-build -gno-record-gcc-switches'2026-10-24T02:11:18.9571830Z GOHOSTARCH='amd64'2026-10-24T02:11:18.9572069Z GOHOSTOS='linux'2026-10-24T02:11:18.9572291Z GOINSECURE=''2026-10-24T02:11:18.9572654Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-10-24T02:11:18.9573093Z GOMODCACHE='/home/runner/go/pkg/mod'2026-10-24T02:11:18.9573369Z GONOPROXY=''2026-10-24T02:11:18.9573579Z GONOSUMDB=''2026-10-24T02:11:18.9573776Z GOOS='linux'2026-10-24T02:11:18.9573996Z GOPATH='/home/runner/go'2026-10-24T02:11:18.9574232Z GOPRIVATE=''2026-10-24T02:11:18.9574500Z GOPROXY='https://proxy.golang.org,direct'2026-10-24T02:11:18.9574864Z GOROOT='/opt/hostedtoolcache/go/1.26.9/x64'2026-10-24T02:11:18.9575180Z GOSUMDB='sum.golang.org'2026-10-24T02:11:18.9575437Z GOTELEMETRY='local'2026-10-24T02:11:18.9575719Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-10-24T02:11:18.9576041Z GOTMPDIR=''2026-10-24T02:11:18.9576509Z GOTOOLCHAIN='local'2026-10-24T02:11:18.9576864Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.9/x64/pkg/tool/linux_amd64'2026-10-24T02:11:18.9577240Z GOVCS=''2026-10-24T02:11:18.9577452Z GOVERSION='go1.26.9'2026-10-24T02:11:18.9577674Z GOWORK=''2026-10-24T02:11:18.9577895Z PKG_CONFIG='pkg-config'2026-10-24T02:11:18.9578041Z 2026-10-24T02:11:18.9578689Z ##[endgroup]2026-10-24T02:11:18.9842738Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-24T02:11:18.9843501Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-10-24T02:11:18.9916514Z shell: /usr/bin/bash -e {0}2026-10-24T02:11:18.9916785Z env:2026-10-24T02:11:18.9916987Z GOTOOLCHAIN: local2026-10-24T02:11:18.9917242Z OSPOOL_EP_OSPoolEPTag: 25-release2026-10-24T02:11:18.9917519Z OSPOOL_EP_CMTag: 25.0-el92026-10-24T02:11:18.9917783Z OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-24T02:11:18.9918043Z ##[endgroup]2026-10-24T02:11:26.0509729Z === RUN TestOSPoolEP2026-10-24T02:11:26.0512099Z === PAUSE TestOSPoolEP2026-10-24T02:11:26.0512486Z === CONT TestOSPoolEP2026-10-24T02:11:26.0513352Z TestOSPoolEP 2026-10-24T02:11:26Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:26.0627555Z TestOSPoolEP 2026-10-24T02:11:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm apply -f /tmp/TestOSPoolEP1762463550]2026-10-24T02:11:26.6591138Z TestOSPoolEP 2026-10-24T02:11:26Z logger.go:67: pod/idtoken-generator created2026-10-24T02:11:26.6692017Z TestOSPoolEP 2026-10-24T02:11:26Z logger.go:67: secret/pool-passwd created2026-10-24T02:11:26.6743504Z TestOSPoolEP 2026-10-24T02:11:26Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-24T02:11:26.6745502Z TestOSPoolEP 2026-10-24T02:11:26Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:26.6766102Z TestOSPoolEP 2026-10-24T02:11:26Z 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-24T02:11:36.6777006Z TestOSPoolEP 2026-10-24T02:11:36Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-24T02:11:36.6778830Z TestOSPoolEP 2026-10-24T02:11:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:36.6800830Z TestOSPoolEP 2026-10-24T02:11:36Z logger.go:67: Pod is now available2026-10-24T02:11:36.6802912Z TestOSPoolEP 2026-10-24T02:11:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-10-24T02:11:37.2203577Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: ***2026-10-24T02:11:37.2271274Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm apply -f /tmp/TestOSPoolEP788690974]2026-10-24T02:11:37.4320309Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: secret/pool-token created2026-10-24T02:11:37.4359269Z TestOSPoolEP 2026-10-24T02:11:37Z retry.go:91: Wait for secret pool-token to be provisioned.2026-10-24T02:11:37.4360160Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:37.4378066Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: Secret is now available2026-10-24T02:11:37.4399420Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm apply -k /tmp/kustomize-template-205996500]2026-10-24T02:11:37.8303643Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: serviceaccount/cvmfs-nodeplugin created2026-10-24T02:11:37.8428037Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: service/frontier-squid created2026-10-24T02:11:37.8514302Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: service/test-cm created2026-10-24T02:11:37.8589458Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: deployment.apps/cvmfs-nodeplugin created2026-10-24T02:11:37.8698454Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: deployment.apps/frontier-squid created2026-10-24T02:11:37.8844886Z TestOSPoolEP 2026-10-24T02:11:37Z 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-24T02:11:37.8849808Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: deployment.apps/ospool-ep created2026-10-24T02:11:37.9022382Z TestOSPoolEP 2026-10-24T02:11:37Z logger.go:67: deployment.apps/test-cm created2026-10-24T02:11:37.9129946Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-10-24T02:11:37.9135803Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:37.9235444Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:37Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-24T02:11:37.9240835Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:37.9242843Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:37Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-24T02:11:37.9245036Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:37.9247002Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:37Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-24T02:11:37.9249129Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:37.9251132Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:37Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-24T02:11:37.9253308Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:37.9301305Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:37Z 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-24T02:11:37.9341463Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:37Z 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-24T02:11:37.9347465Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:37Z 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-24T02:11:37.9361445Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11: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: NewReplicaSetCreated, message: Created new replica set "ospool-ep-cc75b66b9". Sleeping for 10s and will try again.2026-10-24T02:11:47.9303726Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:47Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-24T02:11:47.9331881Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:47.9366980Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:47Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-24T02:11:47.9369824Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:47.9374020Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:47Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-24T02:11:47.9379623Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:47.9386542Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:47Z 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-24T02:11:47.9391450Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:47Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-24T02:11:47.9395343Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:47.9399110Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:47Z logger.go:67: Deployment is now available2026-10-24T02:11:47.9404115Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:47Z 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-24T02:11:47.9417565Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:47Z 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-24T02:11:57.9371290Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:57Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-24T02:11:57.9372639Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:57.9401763Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:57Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-24T02:11:57.9404590Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:57.9409554Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:57Z 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-24T02:11:57.9426265Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:57Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-24T02:11:57.9428910Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:11:57.9431554Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:57Z logger.go:67: Deployment is now available2026-10-24T02:11:57.9445191Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:11:57Z 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-24T02:12:07.9402704Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:07Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-24T02:12:07.9404700Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:12:07.9437579Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:07Z logger.go:67: Deployment is now available2026-10-24T02:12:07.9451789Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:07Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-24T02:12:07.9454099Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:12:07.9472719Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12: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: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-cc75b66b9" is progressing.. Sleeping for 10s and will try again.2026-10-24T02:12:17.9482885Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:17Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-24T02:12:17.9484377Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:12:17.9515540Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12: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-cc75b66b9" is progressing.. Sleeping for 10s and will try again.2026-10-24T02:12:27.9527329Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:27Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-24T02:12:27.9529481Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:12:27.9557053Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-24T02:12:27Z logger.go:67: Deployment is now available2026-10-24T02:12:27.9566448Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP2026-10-24T02:12:27.9569264Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-24T02:12:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:12:27.9592782Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-24T02:12:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm cp ../test-configs/ospool-ep/condor_status.sh test-cm-7f9d786cd6-gz96b:/tmp/condor_status.sh]2026-10-24T02:12:28.3896987Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-24T02:12:28Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm exec test-cm-7f9d786cd6-gz96b -- chmod +x /tmp/condor_status.sh]2026-10-24T02:12:28.6155096Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-24T02:12:28Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm exec test-cm-7f9d786cd6-gz96b -- sh -c /tmp/condor_status.sh]2026-10-24T02:12:28.8317086Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-24T02:12:28Z logger.go:67: command terminated with exit code 12026-10-24T02:12:28.8353258Z test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-7f9d786cd6-gz96b failed. Retrying in 10s.2026-10-24T02:12:38.8356169Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-24T02:12:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm exec test-cm-7f9d786cd6-gz96b -- sh -c /tmp/condor_status.sh]2026-10-24T02:12:39.0005050Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity2026-10-24T02:12:39.0007061Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-24T02:12:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:12:39.0054325Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-24T02:12:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm cp ../test-configs/ospool-ep/has_singularity.sh test-cm-7f9d786cd6-gz96b:/tmp/has_singularity.sh]2026-10-24T02:12:39.2041859Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-24T02:12:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm exec test-cm-7f9d786cd6-gz96b -- chmod +x /tmp/has_singularity.sh]2026-10-24T02:12:39.3841593Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-24T02:12:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm exec test-cm-7f9d786cd6-gz96b -- sh -c /tmp/has_singularity.sh]2026-10-24T02:12:39.5599076Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-10-24T02:12:39.5600389Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:12:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:12:39.5632974Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:12:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm cp ../test-configs/ospool-ep/has_cvmfs.sh test-cm-7f9d786cd6-gz96b:/tmp/has_cvmfs.sh]2026-10-24T02:12:39.7480882Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:12:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm exec test-cm-7f9d786cd6-gz96b -- chmod +x /tmp/has_cvmfs.sh]2026-10-24T02:12:39.9020885Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:12:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm exec test-cm-7f9d786cd6-gz96b -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:12:40.0645155Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:12:40Z logger.go:67: command terminated with exit code 12026-10-24T02:12:40.0680595Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gz96b failed. Retrying in 30s.2026-10-24T02:13:10.0690204Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:13:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm exec test-cm-7f9d786cd6-gz96b -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:13:10.2595649Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:13:10Z logger.go:67: command terminated with exit code 12026-10-24T02:13:10.2629239Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gz96b failed. Retrying in 30s.2026-10-24T02:13:40.2640711Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:13:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm exec test-cm-7f9d786cd6-gz96b -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:13:40.4119088Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:13:40Z logger.go:67: command terminated with exit code 12026-10-24T02:13:40.4154928Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gz96b failed. Retrying in 30s.2026-10-24T02:14:10.4165878Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:14:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm exec test-cm-7f9d786cd6-gz96b -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:14:10.5680451Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:14:10Z logger.go:67: command terminated with exit code 12026-10-24T02:14:10.5710293Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gz96b failed. Retrying in 30s.2026-10-24T02:14:40.5715007Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:14:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm exec test-cm-7f9d786cd6-gz96b -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:14:40.7147805Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:14:40Z logger.go:67: command terminated with exit code 12026-10-24T02:14:40.7181777Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gz96b failed. Retrying in 30s.2026-10-24T02:15:10.7225707Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:15:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm exec test-cm-7f9d786cd6-gz96b -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:15:10.8686801Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:15:10Z logger.go:67: command terminated with exit code 12026-10-24T02:15:10.8720830Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gz96b failed. Retrying in 30s.2026-10-24T02:15:40.8764866Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:15:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm exec test-cm-7f9d786cd6-gz96b -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:15:41.0300631Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:15:41Z logger.go:67: command terminated with exit code 12026-10-24T02:15:41.0314476Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gz96b failed. Retrying in 30s.2026-10-24T02:16:11.0364049Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:16:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm exec test-cm-7f9d786cd6-gz96b -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:16:11.1843587Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:16:11Z logger.go:67: command terminated with exit code 12026-10-24T02:16:11.1875997Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gz96b failed. Retrying in 30s.2026-10-24T02:16:41.1880329Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:16:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm exec test-cm-7f9d786cd6-gz96b -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:16:41.3387465Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:16:41Z logger.go:67: command terminated with exit code 12026-10-24T02:16:41.3423814Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gz96b failed. Retrying in 30s.2026-10-24T02:17:11.3476608Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:17:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm exec test-cm-7f9d786cd6-gz96b -- sh -c /tmp/has_cvmfs.sh]2026-10-24T02:17:11.4969838Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-24T02:17:11Z logger.go:67: command terminated with exit code 12026-10-24T02:17:11.5002624Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gz96b failed. Retrying in 30s.2026-10-24T02:17:41.5057106Z test_utils.go:105: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-gz96b did not succeed within {10 30000000000} retries2026-10-24T02:17:41.5059904Z TestOSPoolEP 2026-10-24T02:17:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:41.5148579Z TestOSPoolEP 2026-10-24T02:17:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:41.6674410Z TestOSPoolEP 2026-10-24T02:17:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:41.7966404Z TestOSPoolEP 2026-10-24T02:17:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:41.9147158Z TestOSPoolEP 2026-10-24T02:17:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:42.0506531Z TestOSPoolEP 2026-10-24T02:17:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:42.1882982Z TestOSPoolEP 2026-10-24T02:17:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:42.1905164Z === NAME TestOSPoolEP2026-10-24T02:17:42.1905923Z ospool_ep_test.go:72: ---2026-10-24T02:17:42.1906620Z Events for pod cvmfs-nodeplugin-5cd89c7cfd-k9b2d:2026-10-24T02:17:42.1908104Z 2026-10-24 02:11:37 +0000 UTC Normal Successfully assigned test-ospool-ep-vpvljm/cvmfs-nodeplugin-5cd89c7cfd-k9b2d to minikube2026-10-24T02:17:42.1909808Z 2026-10-24 02:11:38 +0000 UTC Normal Pulling image "opensciencegrid/cvmfs-nodeplugin:fresh"2026-10-24T02:17:42.1911754Z 2026-10-24 02:11:44 +0000 UTC Normal Successfully pulled image "opensciencegrid/cvmfs-nodeplugin:fresh" in 5.765s (5.765s including waiting). Image size: 155940803 bytes.2026-10-24T02:17:42.1913130Z 2026-10-24 02:11:44 +0000 UTC Normal Container created2026-10-24T02:17:42.1913899Z 2026-10-24 02:11:44 +0000 UTC Normal Container started2026-10-24T02:17:42.1914425Z 2026-10-24T02:17:42.1914756Z ---2026-10-24T02:17:42.1915644Z TestOSPoolEP 2026-10-24T02:17:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:42.1930431Z ospool_ep_test.go:72: ---2026-10-24T02:17:42.1931084Z Events for pod frontier-squid-65f85c968-kzlqs:2026-10-24T02:17:42.1932226Z 2026-10-24 02:11:37 +0000 UTC Normal Successfully assigned test-ospool-ep-vpvljm/frontier-squid-65f85c968-kzlqs to minikube2026-10-24T02:17:42.1933283Z 2026-10-24 02:11:38 +0000 UTC Normal Pulling image "opensciencegrid/frontier-squid:fresh"2026-10-24T02:17:42.1934777Z 2026-10-24 02:11:55 +0000 UTC Normal Successfully pulled image "opensciencegrid/frontier-squid:fresh" in 11.527s (17.189s including waiting). Image size: 453187319 bytes.2026-10-24T02:17:42.1936215Z 2026-10-24 02:11:55 +0000 UTC Normal Container created2026-10-24T02:17:42.1937159Z 2026-10-24 02:11:55 +0000 UTC Normal Container started2026-10-24T02:17:42.1937766Z 2026-10-24T02:17:42.1938449Z ---2026-10-24T02:17:42.1939663Z TestOSPoolEP 2026-10-24T02:17:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:42.1956883Z ospool_ep_test.go:72: ---2026-10-24T02:17:42.1957578Z Events for pod idtoken-generator:2026-10-24T02:17:42.1959250Z 2026-10-24 02:11:26 +0000 UTC Normal Successfully assigned test-ospool-ep-vpvljm/idtoken-generator to minikube2026-10-24T02:17:42.1960649Z 2026-10-24 02:11:27 +0000 UTC Normal Pulling image "htcondor/base"2026-10-24T02:17:42.1962501Z 2026-10-24 02:11:33 +0000 UTC Normal Successfully pulled image "htcondor/base" in 6.418s (6.418s including waiting). Image size: 196303183 bytes.2026-10-24T02:17:42.1963963Z 2026-10-24 02:11:33 +0000 UTC Normal Container created2026-10-24T02:17:42.1964700Z 2026-10-24 02:11:33 +0000 UTC Normal Container started2026-10-24T02:17:42.1965293Z 2026-10-24T02:17:42.1965677Z ---2026-10-24T02:17:42.1967003Z TestOSPoolEP 2026-10-24T02:17:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:42.1985455Z ospool_ep_test.go:72: ---2026-10-24T02:17:42.1986619Z Events for pod ospool-ep-cc75b66b9-w9dzx:2026-10-24T02:17:42.1988290Z 2026-10-24 02:11:37 +0000 UTC Normal Successfully assigned test-ospool-ep-vpvljm/ospool-ep-cc75b66b9-w9dzx to minikube2026-10-24T02:17:42.1989752Z 2026-10-24 02:11:38 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-10-24T02:17:42.1991688Z 2026-10-24 02:11:59 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 3.461s (20.647s including waiting). Image size: 2893600 bytes.2026-10-24T02:17:42.1993046Z 2026-10-24 02:11:59 +0000 UTC Normal Container created2026-10-24T02:17:42.1994123Z 2026-10-24 02:11:59 +0000 UTC Normal Container started2026-10-24T02:17:42.1995313Z 2026-10-24 02:11:59 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-10-24T02:17:42.1997420Z 2026-10-24 02:12:20 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 16.239s (21.233s including waiting). Image size: 537931704 bytes.2026-10-24T02:17:42.2005031Z 2026-10-24 02:12:20 +0000 UTC Normal Container created2026-10-24T02:17:42.2005837Z 2026-10-24 02:12:20 +0000 UTC Normal Container started2026-10-24T02:17:42.2006360Z 2026-10-24T02:17:42.2006684Z ---2026-10-24T02:17:42.2007583Z TestOSPoolEP 2026-10-24T02:17:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:42.2019325Z ospool_ep_test.go:72: ---2026-10-24T02:17:42.2020243Z Events for pod test-cm-7f9d786cd6-gz96b:2026-10-24T02:17:42.2022146Z 2026-10-24 02:11:37 +0000 UTC Normal Successfully assigned test-ospool-ep-vpvljm/test-cm-7f9d786cd6-gz96b to minikube2026-10-24T02:17:42.2023630Z 2026-10-24 02:11:38 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-10-24T02:17:42.2025505Z 2026-10-24 02:12:04 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 5.566s (26.168s including waiting). Image size: 198153089 bytes.2026-10-24T02:17:42.2026914Z 2026-10-24 02:12:04 +0000 UTC Normal Container created2026-10-24T02:17:42.2027686Z 2026-10-24 02:12:04 +0000 UTC Normal Container started2026-10-24T02:17:42.2028303Z 2026-10-24T02:17:42.2028653Z ---2026-10-24T02:17:42.2029479Z TestOSPoolEP 2026-10-24T02:17:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-24T02:17:42.2053396Z TestOSPoolEP 2026-10-24T02:17:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm delete -f /tmp/TestOSPoolEP671340942]2026-10-24T02:17:42.3131092Z TestOSPoolEP 2026-10-24T02:17:42Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-vpvljm namespace2026-10-24T02:17:42.3239073Z TestOSPoolEP 2026-10-24T02:17:42Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-vpvljm namespace2026-10-24T02:17:43.4757146Z TestOSPoolEP 2026-10-24T02:17:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm delete -f /tmp/TestOSPoolEP848604626]2026-10-24T02:17:43.5799528Z TestOSPoolEP 2026-10-24T02:17:43Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-vpvljm namespace2026-10-24T02:17:43.5847779Z TestOSPoolEP 2026-10-24T02:17:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-vpvljm delete -k /tmp/kustomize-template-205996500]2026-10-24T02:17:43.7116472Z TestOSPoolEP 2026-10-24T02:17:43Z logger.go:67: serviceaccount "cvmfs-nodeplugin" deleted from test-ospool-ep-vpvljm namespace2026-10-24T02:17:43.7199273Z TestOSPoolEP 2026-10-24T02:17:43Z logger.go:67: service "frontier-squid" deleted from test-ospool-ep-vpvljm namespace2026-10-24T02:17:43.7283454Z TestOSPoolEP 2026-10-24T02:17:43Z logger.go:67: service "test-cm" deleted from test-ospool-ep-vpvljm namespace2026-10-24T02:17:43.7409186Z TestOSPoolEP 2026-10-24T02:17:43Z logger.go:67: deployment.apps "cvmfs-nodeplugin" deleted from test-ospool-ep-vpvljm namespace2026-10-24T02:17:43.7438401Z TestOSPoolEP 2026-10-24T02:17:43Z logger.go:67: deployment.apps "frontier-squid" deleted from test-ospool-ep-vpvljm namespace2026-10-24T02:17:43.7505192Z TestOSPoolEP 2026-10-24T02:17:43Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-vpvljm namespace2026-10-24T02:17:43.7614649Z TestOSPoolEP 2026-10-24T02:17:43Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-vpvljm namespace2026-10-24T02:17:43.7992319Z --- FAIL: TestOSPoolEP (377.75s)2026-10-24T02:17:43.8018345Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (50.04s)2026-10-24T02:17:43.8026813Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP (11.04s)2026-10-24T02:17:43.8027912Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity (0.56s)2026-10-24T02:17:43.8029271Z --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (301.95s)2026-10-24T02:17:43.8029965Z FAIL2026-10-24T02:17:43.8030534Z FAIL github.com/osg-htc/k8s-integration-tests/test 377.765s2026-10-24T02:17:43.8160639Z FAIL2026-10-24T02:17:43.9184950Z ##[error]Process completed with exit code 1.2026-10-24T02:17:43.9285080Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-24T02:17:43.9286075Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-10-24T02:17:43.9388804Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-24T02:17:43.9389333Z env:2026-10-24T02:17:43.9389651Z GOTOOLCHAIN: local2026-10-24T02:17:43.9390331Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-24T02:17:43.9391031Z ##[endgroup]2026-10-24T02:17:43.9696840Z ##[group]Run actions/upload-artifact@v42026-10-24T02:17:43.9697383Z with:2026-10-24T02:17:43.9698001Z name: TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f02026-10-24T02:17:43.9699015Z path: /tmp/k8s-tests2026-10-24T02:17:43.9699401Z retention-days: 52026-10-24T02:17:43.9699796Z if-no-files-found: warn2026-10-24T02:17:43.9700187Z compression-level: 62026-10-24T02:17:43.9700542Z overwrite: false2026-10-24T02:17:43.9700954Z include-hidden-files: false2026-10-24T02:17:43.9701372Z env:2026-10-24T02:17:43.9701691Z GOTOOLCHAIN: local2026-10-24T02:17:43.9702073Z ##[endgroup]2026-10-24T02:17:44.2125180Z (node:16202) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-24T02:17:44.2126448Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-24T02:17:44.2273523Z With the provided path, there will be 10 files uploaded2026-10-24T02:17:44.2280519Z Artifact name is valid!2026-10-24T02:17:44.2305199Z Root directory input is valid!2026-10-24T02:17:44.5497313Z Beginning upload of artifact content to blob storage2026-10-24T02:17:44.5928976Z (node:16202) [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-24T02:17:44.8628950Z Uploaded bytes 159952026-10-24T02:17:44.9301068Z Finished uploading artifact content to blob storage!2026-10-24T02:17:44.9302204Z SHA256 digest of uploaded artifact zip is a5474e5a5f7b3fc7e0234ee1856828ce6ae05efc7c5c52165b98b86d61db53e42026-10-24T02:17:44.9304094Z Finalizing artifact upload2026-10-24T02:17:45.4695424Z Artifact TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f0.zip successfully finalized. Artifact ID 125435490002026-10-24T02:17:45.4698538Z Artifact TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f0 has been successfully uploaded! Final size is 15995 bytes. Artifact ID is 125435490002026-10-24T02:17:45.4704669Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/40053022520/artifacts/125435490002026-10-24T02:17:45.5088352Z Post job cleanup.2026-10-24T02:17:45.6319972Z [command]/usr/bin/git version2026-10-24T02:17:45.6373696Z git version 2.55.02026-10-24T02:17:45.6420284Z Temporarily overriding HOME='/home/runner/work/_temp/b0c5f5eb-17cc-43e6-8ba9-748df38d66b6' before making global git config changes2026-10-24T02:17:45.6427558Z Adding repository directory to the temporary git global config as a safe directory2026-10-24T02:17:45.6429754Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-24T02:17:45.6486699Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-24T02:17:45.6530757Z [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-24T02:17:45.6910808Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-24T02:17:45.6934931Z http.https://github.com/.extraheader2026-10-24T02:17:45.6961102Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-10-24T02:17:45.7030598Z [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-24T02:17:45.7542710Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-24T02:17:45.7579210Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-24T02:17:45.8134509Z Cleaning up orphan processes2026-10-24T02:17:45.9123468Z ##[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/