2026-10-21T02:11:49.2417629Z Current runner version: '2.338.0'2026-10-21T02:11:49.2452988Z ##[group]Runner Image Provisioner2026-10-21T02:11:49.2454442Z Hosted Compute Agent2026-10-21T02:11:49.2455794Z Version: 20261015.6102026-10-21T02:11:49.2457003Z Commit: 267fdb4e8bbec4ab5ea31367f3a00d5c480c76562026-10-21T02:11:49.2458460Z Build Date: 2026-10-14T17:06:54Z2026-10-21T02:11:49.2459821Z Worker ID: {be1a3dde-4592-457e-801d-7062f8a1722e}2026-10-21T02:11:49.2461180Z Region: eastus22026-10-21T02:11:49.2462564Z Cloud: Azure2026-10-21T02:11:49.2463524Z ##[endgroup]2026-10-21T02:11:49.2465918Z ##[group]Operating System2026-10-21T02:11:49.2467097Z Ubuntu2026-10-21T02:11:49.2468029Z 22.04.52026-10-21T02:11:49.2469095Z LTS2026-10-21T02:11:49.2470065Z ##[endgroup]2026-10-21T02:11:49.2471295Z ##[group]Runner Image2026-10-21T02:11:49.2472813Z Image: ubuntu-22.042026-10-21T02:11:49.2473819Z Version: 20261018.327.12026-10-21T02:11:49.2476259Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20261018.327/images/ubuntu/Ubuntu2204-Readme.md2026-10-21T02:11:49.2480095Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20261018.3272026-10-21T02:11:49.2481882Z ##[endgroup]2026-10-21T02:11:49.2488014Z ##[group]GITHUB_TOKEN Permissions2026-10-21T02:11:49.2491387Z Actions: write2026-10-21T02:11:49.2492804Z ArtifactMetadata: write2026-10-21T02:11:49.2493863Z Attestations: write2026-10-21T02:11:49.2494797Z Checks: write2026-10-21T02:11:49.2495975Z CodeQuality: write2026-10-21T02:11:49.2496969Z Contents: write2026-10-21T02:11:49.2498001Z CopilotRequests: write2026-10-21T02:11:49.2499031Z Deployments: write2026-10-21T02:11:49.2500118Z Discussions: write2026-10-21T02:11:49.2501275Z Drives: write2026-10-21T02:11:49.2502430Z Issues: write2026-10-21T02:11:49.2503597Z Metadata: read2026-10-21T02:11:49.2504644Z Models: read2026-10-21T02:11:49.2506034Z Packages: write2026-10-21T02:11:49.2507181Z Pages: write2026-10-21T02:11:49.2508074Z PullRequests: write2026-10-21T02:11:49.2509234Z RepositoryProjects: write2026-10-21T02:11:49.2510413Z SecurityEvents: write2026-10-21T02:11:49.2511418Z Statuses: write2026-10-21T02:11:49.2512855Z VulnerabilityAlerts: read2026-10-21T02:11:49.2513923Z ##[endgroup]2026-10-21T02:11:49.2516916Z Secret source: Actions2026-10-21T02:11:49.2518410Z Cache mode: write2026-10-21T02:11:49.2519809Z Prepare workflow directory2026-10-21T02:11:49.2979613Z Prepare all required actions2026-10-21T02:11:49.3048799Z Getting action download info2026-10-21T02:11:49.5203639Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-10-21T02:11:49.7799849Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-10-21T02:11:49.9634407Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-10-21T02:11:50.1802740Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-10-21T02:11:50.4487626Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (63ec080e4eea87fb8a9eae678ab9944ec2461251)2026-10-21T02:11:50.4493895Z ##[group] Inputs2026-10-21T02:11:50.4494932Z testName: TestOSPoolEP2026-10-21T02:11:50.4496778Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-21T02:11:50.4498778Z setupScript: 2026-10-21T02:11:50.4499696Z setupEnv: {}2026-10-21T02:11:50.4500589Z ##[endgroup]2026-10-21T02:11:50.4502269Z Complete job name: ospool-ep / Run OSPool EP test (cvmfs-bind, 25-testing) / Run Tests2026-10-21T02:11:50.5411451Z ##[group]Run actions/checkout@v52026-10-21T02:11:50.5413118Z with:2026-10-21T02:11:50.5414055Z repository: osg-htc/k8s-integration-tests2026-10-21T02:11:50.5423333Z token: ***2026-10-21T02:11:50.5424446Z ssh-strict: true2026-10-21T02:11:50.5425684Z ssh-user: git2026-10-21T02:11:50.5426608Z persist-credentials: true2026-10-21T02:11:50.5427610Z clean: true2026-10-21T02:11:50.5428829Z sparse-checkout-cone-mode: true2026-10-21T02:11:50.5429908Z fetch-depth: 12026-10-21T02:11:50.5430788Z fetch-tags: false2026-10-21T02:11:50.5431702Z show-progress: true2026-10-21T02:11:50.5432842Z lfs: false2026-10-21T02:11:50.5433721Z submodules: false2026-10-21T02:11:50.5434648Z set-safe-directory: true2026-10-21T02:11:50.5435708Z allow-unsafe-pr-checkout: false2026-10-21T02:11:50.5437120Z ##[endgroup]2026-10-21T02:11:50.6499350Z Syncing repository: osg-htc/k8s-integration-tests2026-10-21T02:11:50.6503808Z ##[group]Getting Git version info2026-10-21T02:11:50.6506977Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-21T02:11:50.6511162Z [command]/usr/bin/git version2026-10-21T02:11:50.6579886Z git version 2.55.02026-10-21T02:11:50.6603941Z ##[endgroup]2026-10-21T02:11:50.6638371Z Temporarily overriding HOME='/home/runner/work/_temp/f2511fa0-4d94-43ea-bb2d-97ca216f8566' before making global git config changes2026-10-21T02:11:50.6643460Z Adding repository directory to the temporary git global config as a safe directory2026-10-21T02:11:50.6646427Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-21T02:11:50.6697510Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-21T02:11:50.6702916Z ##[group]Initializing the repository2026-10-21T02:11:50.6708214Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-21T02:11:50.6854289Z hint: Using 'master' as the name for the initial branch. This default branch name2026-10-21T02:11:50.6858075Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-10-21T02:11:50.6861787Z hint: to use in all of your new repositories, which will suppress this warning,2026-10-21T02:11:50.6864946Z hint: call:2026-10-21T02:11:50.6866505Z hint:2026-10-21T02:11:50.6869650Z hint: git config --global init.defaultBranch <name>2026-10-21T02:11:50.6871855Z hint:2026-10-21T02:11:50.6873920Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-10-21T02:11:50.6876869Z hint: 'development'. The just-created branch can be renamed via this command:2026-10-21T02:11:50.6879847Z hint:2026-10-21T02:11:50.6881770Z hint: git branch -m <name>2026-10-21T02:11:50.6883881Z hint:2026-10-21T02:11:50.6886288Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-10-21T02:11:50.6890754Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-10-21T02:11:50.6898300Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-10-21T02:11:50.6914717Z ##[endgroup]2026-10-21T02:11:50.6917787Z ##[group]Disabling automatic garbage collection2026-10-21T02:11:50.6919273Z [command]/usr/bin/git config --local gc.auto 02026-10-21T02:11:50.6969457Z ##[endgroup]2026-10-21T02:11:50.6972414Z ##[group]Setting up auth2026-10-21T02:11:50.6977567Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-21T02:11:50.7022789Z [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-21T02:11:50.7411376Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-21T02:11:50.7456690Z [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-21T02:11:50.7726620Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-21T02:11:50.7770737Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-21T02:11:50.8033936Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-10-21T02:11:50.8079043Z ##[endgroup]2026-10-21T02:11:50.8082658Z ##[group]Fetching the repository2026-10-21T02:11:50.8090982Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +63ec080e4eea87fb8a9eae678ab9944ec2461251:refs/remotes/origin/main2026-10-21T02:11:51.0639191Z From https://github.com/osg-htc/k8s-integration-tests2026-10-21T02:11:51.0640622Z * [new ref] 63ec080e4eea87fb8a9eae678ab9944ec2461251 -> origin/main2026-10-21T02:11:51.0644373Z ##[endgroup]2026-10-21T02:11:51.0645616Z ##[group]Determining the checkout info2026-10-21T02:11:51.0646962Z ##[endgroup]2026-10-21T02:11:51.0651037Z [command]/usr/bin/git sparse-checkout disable2026-10-21T02:11:51.0705167Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-10-21T02:11:51.0742927Z ##[group]Checking out the ref2026-10-21T02:11:51.0746926Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-10-21T02:11:51.0857509Z Switched to a new branch 'main'2026-10-21T02:11:51.0861439Z branch 'main' set up to track 'origin/main'.2026-10-21T02:11:51.0867844Z ##[endgroup]2026-10-21T02:11:51.0910368Z [command]/usr/bin/git log -1 --format=%H2026-10-21T02:11:51.0940714Z 63ec080e4eea87fb8a9eae678ab9944ec24612512026-10-21T02:11:51.1256088Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-21T02:11:51.1256862Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-21T02:11:51.1257515Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-21T02:11:51.1296122Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-21T02:11:51.1296530Z env:2026-10-21T02:11:51.1297019Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-21T02:11:51.1297589Z SETUP_ENV_YAML: {}2026-10-21T02:11:51.1297845Z ##[endgroup]2026-10-21T02:11:52.3117869Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-21T02:11:52.3118561Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-10-21T02:11:52.3152730Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-21T02:11:52.3153074Z env:2026-10-21T02:11:52.3153524Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfs-bind"}2026-10-21T02:11:52.3154034Z ##[endgroup]2026-10-21T02:11:52.3266325Z ##[group]Run true2026-10-21T02:11:52.3266575Z [36;1mtrue[0m2026-10-21T02:11:52.3297193Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-21T02:11:52.3297570Z ##[endgroup]2026-10-21T02:11:52.3439163Z ##[group]Run medyagh/setup-minikube@latest2026-10-21T02:11:52.3439479Z with:2026-10-21T02:11:52.3439689Z start: true2026-10-21T02:11:52.3439881Z cache: true2026-10-21T02:11:52.3440087Z minikube-version: latest2026-10-21T02:11:52.3440331Z wait: all2026-10-21T02:11:52.3440517Z ##[endgroup]2026-10-21T02:11:52.4710493Z (node:2173) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-21T02:11:52.4711612Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-21T02:11:53.3542369Z [command]/usr/bin/chmod +x /home/runner/work/_temp/4d6f956a-f35e-457d-9330-e7ac194e5cdb2026-10-21T02:11:53.5266893Z [command]/home/runner/bin/minikube version --short2026-10-21T02:11:53.5816448Z v1.39.02026-10-21T02:11:53.6594867Z Cache hit for: kic-v1.39.0-x642026-10-21T02:11:53.6602561Z Cache hit for: preloaded-tarball-v1.39.0-x64-stable-docker2026-10-21T02:11:53.6714300Z (node:2173) [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-21T02:11:54.7202930Z Received 130023424 of 288577004 (45.1%), 123.3 MBs/sec2026-10-21T02:11:54.8251215Z Received 134217728 of 531630645 (25.2%), 117.2 MBs/sec2026-10-21T02:11:55.7787417Z Received 268435456 of 288577004 (93.0%), 124.0 MBs/sec2026-10-21T02:11:55.8333452Z Received 272629760 of 531630645 (51.3%), 124.3 MBs/sec2026-10-21T02:11:55.9752946Z Received 288577004 of 288577004 (100.0%), 121.8 MBs/sec2026-10-21T02:11:55.9753747Z Cache Size: ~275 MB (288577004 B)2026-10-21T02:11:56.1182729Z [command]/usr/bin/tar -xf /home/runner/work/_temp/db9461b1-8955-433b-8a8f-2d936efdbc5a/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-21T02:11:56.8273398Z Received 457179136 of 531630645 (86.0%), 140.9 MBs/sec2026-10-21T02:11:57.0164480Z Cache restored successfully2026-10-21T02:11:57.2295579Z Received 531630645 of 531630645 (100.0%), 145.0 MBs/sec2026-10-21T02:11:57.2297157Z Cache Size: ~507 MB (531630645 B)2026-10-21T02:11:57.2333272Z [command]/usr/bin/tar -xf /home/runner/work/_temp/164aaf3f-9548-4cef-9d4b-835e07d47274/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-21T02:11:58.1380397Z Cache restored successfully2026-10-21T02:11:58.2590608Z [command]/home/runner/bin/minikube start --wait all2026-10-21T02:11:58.3150704Z * minikube v1.39.0 on Ubuntu 22.042026-10-21T02:12:04.1962336Z ! 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-21T02:12:04.1966947Z * Automatically selected the docker driver. Other choices: podman, ssh, none2026-10-21T02:12:04.2735208Z * Using Docker driver with root privileges2026-10-21T02:12:04.2749381Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-10-21T02:12:04.2757411Z * Pulling base image v0.0.51 ...2026-10-21T02:12:23.8435889Z * Preparing Kubernetes v1.37.0 on containerd 2.3.4 ...2026-10-21T02:12:31.8035239Z * Configuring CNI (Container Networking Interface) ...2026-10-21T02:12:37.1639366Z * Verifying Kubernetes components...2026-10-21T02:12:37.1992017Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-10-21T02:12:37.7142549Z * Enabled addons: default-storageclass, storage-provisioner2026-10-21T02:12:58.3803078Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-10-21T02:12:58.3946526Z [command]/home/runner/bin/minikube version --short2026-10-21T02:12:58.4456145Z v1.39.02026-10-21T02:12:58.5000088Z ##[group]Run actions/setup-go@v62026-10-21T02:12:58.5000406Z with:2026-10-21T02:12:58.5000616Z go-version: 1.262026-10-21T02:12:58.5000834Z cache: true2026-10-21T02:12:58.5001069Z cache-dependency-path: go.sum2026-10-21T02:12:58.5001334Z check-latest: false2026-10-21T02:12:58.5004286Z token: ***2026-10-21T02:12:58.5004508Z ##[endgroup]2026-10-21T02:12:58.6371613Z Setup go version spec 1.262026-10-21T02:12:58.6518260Z Found in cache @ /opt/hostedtoolcache/go/1.26.9/x642026-10-21T02:12:58.6520839Z Added go to the path2026-10-21T02:12:58.6524929Z Successfully set up Go version 1.262026-10-21T02:12:59.7868005Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOMODCACHE2026-10-21T02:12:59.7914885Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOCACHE2026-10-21T02:12:59.7940632Z /home/runner/go/pkg/mod2026-10-21T02:12:59.7964355Z /home/runner/.cache/go-build2026-10-21T02:12:59.8947800Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-21T02:13:00.9633597Z Received 222298112 of 249167808 (89.2%), 211.2 MBs/sec2026-10-21T02:13:01.1356022Z Received 249167808 of 249167808 (100.0%), 201.5 MBs/sec2026-10-21T02:13:01.1358111Z Cache Size: ~238 MB (249167808 B)2026-10-21T02:13:01.1445815Z [command]/usr/bin/tar -xf /home/runner/work/_temp/e1f3da49-e8b9-4c72-bf4c-64b2c917b278/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-21T02:13:04.2457136Z Cache restored successfully2026-10-21T02:13:04.3020678Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-21T02:13:04.3044427Z go version go1.26.9 linux/amd642026-10-21T02:13:04.3044719Z 2026-10-21T02:13:04.3045111Z ##[group]go env2026-10-21T02:13:04.3402963Z AR='ar'2026-10-21T02:13:04.3403367Z CC='gcc'2026-10-21T02:13:04.3403736Z CGO_CFLAGS='-O2 -g'2026-10-21T02:13:04.3404325Z CGO_CPPFLAGS=''2026-10-21T02:13:04.3404770Z CGO_CXXFLAGS='-O2 -g'2026-10-21T02:13:04.3405225Z CGO_ENABLED='1'2026-10-21T02:13:04.3405650Z CGO_FFLAGS='-O2 -g'2026-10-21T02:13:04.3406037Z CGO_LDFLAGS='-O2 -g'2026-10-21T02:13:04.3406432Z CXX='g++'2026-10-21T02:13:04.3406803Z GCCGO='gccgo'2026-10-21T02:13:04.3407167Z GO111MODULE=''2026-10-21T02:13:04.3407544Z GOAMD64='v1'2026-10-21T02:13:04.3407917Z GOARCH='amd64'2026-10-21T02:13:04.3408287Z GOAUTH='netrc'2026-10-21T02:13:04.3408637Z GOBIN=''2026-10-21T02:13:04.3409023Z GOCACHE='/home/runner/.cache/go-build'2026-10-21T02:13:04.3409459Z GOCACHEPROG=''2026-10-21T02:13:04.3409811Z GODEBUG=''2026-10-21T02:13:04.3410197Z GOENV='/home/runner/.config/go/env'2026-10-21T02:13:04.3410621Z GOEXE=''2026-10-21T02:13:04.3410953Z GOEXPERIMENT=''2026-10-21T02:13:04.3411323Z GOFIPS140='off'2026-10-21T02:13:04.3411693Z GOFLAGS=''2026-10-21T02:13:04.3412769Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build3546486130=/tmp/go-build -gno-record-gcc-switches'2026-10-21T02:13:04.3413674Z GOHOSTARCH='amd64'2026-10-21T02:13:04.3414057Z GOHOSTOS='linux'2026-10-21T02:13:04.3414435Z GOINSECURE=''2026-10-21T02:13:04.3414955Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-10-21T02:13:04.3415561Z GOMODCACHE='/home/runner/go/pkg/mod'2026-10-21T02:13:04.3416003Z GONOPROXY=''2026-10-21T02:13:04.3416359Z GONOSUMDB=''2026-10-21T02:13:04.3416756Z GOOS='linux'2026-10-21T02:13:04.3417106Z GOPATH='/home/runner/go'2026-10-21T02:13:04.3417468Z GOPRIVATE=''2026-10-21T02:13:04.3417868Z GOPROXY='https://proxy.golang.org,direct'2026-10-21T02:13:04.3418347Z GOROOT='/opt/hostedtoolcache/go/1.26.9/x64'2026-10-21T02:13:04.3418776Z GOSUMDB='sum.golang.org'2026-10-21T02:13:04.3419172Z GOTELEMETRY='local'2026-10-21T02:13:04.3419585Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-10-21T02:13:04.3420033Z GOTMPDIR=''2026-10-21T02:13:04.3420398Z GOTOOLCHAIN='local'2026-10-21T02:13:04.3421125Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.9/x64/pkg/tool/linux_amd64'2026-10-21T02:13:04.3421674Z GOVCS=''2026-10-21T02:13:04.3422227Z GOVERSION='go1.26.9'2026-10-21T02:13:04.3422642Z GOWORK=''2026-10-21T02:13:04.3422994Z PKG_CONFIG='pkg-config'2026-10-21T02:13:04.3423225Z 2026-10-21T02:13:04.3423579Z ##[endgroup]2026-10-21T02:13:04.3690707Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-21T02:13:04.3691252Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-10-21T02:13:04.3726708Z shell: /usr/bin/bash -e {0}2026-10-21T02:13:04.3726981Z env:2026-10-21T02:13:04.3727179Z GOTOOLCHAIN: local2026-10-21T02:13:04.3727429Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-10-21T02:13:04.3727708Z OSPOOL_EP_CMTag: 25.x-el92026-10-21T02:13:04.3728004Z OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-21T02:13:04.3728263Z ##[endgroup]2026-10-21T02:13:13.8326610Z === RUN TestOSPoolEP2026-10-21T02:13:13.8335511Z === PAUSE TestOSPoolEP2026-10-21T02:13:13.8336015Z === CONT TestOSPoolEP2026-10-21T02:13:13.8337096Z TestOSPoolEP 2026-10-21T02:13:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:13:13.8454998Z TestOSPoolEP 2026-10-21T02:13:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb apply -f /tmp/TestOSPoolEP1202045974]2026-10-21T02:13:14.3235818Z TestOSPoolEP 2026-10-21T02:13:14Z logger.go:67: pod/idtoken-generator created2026-10-21T02:13:14.3327748Z TestOSPoolEP 2026-10-21T02:13:14Z logger.go:67: secret/pool-passwd created2026-10-21T02:13:14.3358385Z TestOSPoolEP 2026-10-21T02:13:14Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-21T02:13:14.3359710Z TestOSPoolEP 2026-10-21T02:13:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:13:14.3389804Z TestOSPoolEP 2026-10-21T02:13:14Z 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-21T02:13:24.3400333Z TestOSPoolEP 2026-10-21T02:13:24Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-21T02:13:24.3401542Z TestOSPoolEP 2026-10-21T02:13:24Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:13:24.3430366Z TestOSPoolEP 2026-10-21T02:13:24Z logger.go:67: Pod is now available2026-10-21T02:13:24.3439565Z TestOSPoolEP 2026-10-21T02:13:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-10-21T02:13:25.0833807Z TestOSPoolEP 2026-10-21T02:13:25Z logger.go:67: ***2026-10-21T02:13:25.0896623Z TestOSPoolEP 2026-10-21T02:13:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb apply -f /tmp/TestOSPoolEP3056456754]2026-10-21T02:13:25.2837529Z TestOSPoolEP 2026-10-21T02:13:25Z logger.go:67: secret/pool-token created2026-10-21T02:13:25.2877004Z TestOSPoolEP 2026-10-21T02:13:25Z retry.go:91: Wait for secret pool-token to be provisioned.2026-10-21T02:13:25.2878371Z TestOSPoolEP 2026-10-21T02:13:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:13:25.2896464Z TestOSPoolEP 2026-10-21T02:13:25Z logger.go:67: Secret is now available2026-10-21T02:13:25.2918478Z TestOSPoolEP 2026-10-21T02:13:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb apply -k /tmp/kustomize-template-3192314064]2026-10-21T02:13:25.7305006Z TestOSPoolEP 2026-10-21T02:13:25Z logger.go:67: serviceaccount/cvmfs-nodeplugin created2026-10-21T02:13:25.7376904Z TestOSPoolEP 2026-10-21T02:13:25Z logger.go:67: service/frontier-squid created2026-10-21T02:13:25.7495807Z TestOSPoolEP 2026-10-21T02:13:25Z logger.go:67: service/test-cm created2026-10-21T02:13:25.7606870Z TestOSPoolEP 2026-10-21T02:13:25Z logger.go:67: deployment.apps/cvmfs-nodeplugin created2026-10-21T02:13:25.7689431Z TestOSPoolEP 2026-10-21T02:13:25Z logger.go:67: deployment.apps/frontier-squid created2026-10-21T02:13:25.7857136Z TestOSPoolEP 2026-10-21T02:13:25Z 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-21T02:13:25.7859925Z TestOSPoolEP 2026-10-21T02:13:25Z logger.go:67: deployment.apps/ospool-ep created2026-10-21T02:13:25.8133535Z TestOSPoolEP 2026-10-21T02:13:25Z logger.go:67: deployment.apps/test-cm created2026-10-21T02:13:25.8184149Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-10-21T02:13:25.8186434Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:13:25.8279236Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:25Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-21T02:13:25.8284688Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:13:25.8302600Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:25Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-21T02:13:25.8306631Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:13:25.8313932Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:25Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-21T02:13:25.8316000Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:13:25.8318186Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:25Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-21T02:13:25.8320435Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:13:25.8405110Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:25Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "test-cm-5886f7986". Sleeping for 10s and will try again.2026-10-21T02:13:25.8415077Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:25Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-674fbdcc48". Sleeping for 10s and will try again.2026-10-21T02:13:25.8420663Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:25Z 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-21T02:13:25.8426665Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:25Z 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-21T02:13:35.8424943Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:35Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-21T02:13:35.8451415Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:13:35.8459291Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:35Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-21T02:13:35.8462516Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:13:35.8466354Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:35Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-21T02:13:35.8476212Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:13:35.8480404Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:35Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-21T02:13:35.8483535Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:13:35.8487540Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:35Z logger.go:67: Deployment is now available2026-10-21T02:13:35.8500329Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:35Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-674fbdcc48" is progressing.. Sleeping for 10s and will try again.2026-10-21T02:13:35.8506455Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:35Z 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-21T02:13:35.8514034Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:35Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "test-cm-5886f7986" is progressing.. Sleeping for 10s and will try again.2026-10-21T02:13:45.8506943Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:45Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-21T02:13:45.8509074Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:45Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-21T02:13:45.8513307Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:45Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:13:45.8516153Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:45Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:13:45.8518812Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:45Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-21T02:13:45.8521305Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:45Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:13:45.8549207Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:45Z logger.go:67: Deployment is now available2026-10-21T02:13:45.8558160Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:45Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-674fbdcc48" is progressing.. Sleeping for 10s and will try again.2026-10-21T02:13:45.8565615Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:45Z logger.go:67: Deployment is now available2026-10-21T02:13:55.8579681Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:55Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-21T02:13:55.8581673Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:55Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:13:55.8626308Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:13:55Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-674fbdcc48" is progressing.. Sleeping for 10s and will try again.2026-10-21T02:14:05.8635254Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:14:05Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-21T02:14:05.8637259Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:14:05Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:14:05.8662453Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-21T02:14:05Z logger.go:67: Deployment is now available2026-10-21T02:14:05.8664803Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP2026-10-21T02:14:05.8672524Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-21T02:14:05Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:14:05.8688446Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-21T02:14:05Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb cp ../test-configs/ospool-ep/condor_status.sh test-cm-5886f7986-z5lqv:/tmp/condor_status.sh]2026-10-21T02:14:06.2535426Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-21T02:14:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb exec test-cm-5886f7986-z5lqv -- chmod +x /tmp/condor_status.sh]2026-10-21T02:14:06.4223956Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-21T02:14:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb exec test-cm-5886f7986-z5lqv -- sh -c /tmp/condor_status.sh]2026-10-21T02:14:06.5910055Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-21T02:14:06Z logger.go:67: command terminated with exit code 12026-10-21T02:14:06.5945066Z test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-5886f7986-z5lqv failed. Retrying in 10s.2026-10-21T02:14:16.5955169Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-21T02:14:16Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb exec test-cm-5886f7986-z5lqv -- sh -c /tmp/condor_status.sh]2026-10-21T02:14:16.7598322Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity2026-10-21T02:14:16.7605185Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-21T02:14:16Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:14:16.7632346Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-21T02:14:16Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb cp ../test-configs/ospool-ep/has_singularity.sh test-cm-5886f7986-z5lqv:/tmp/has_singularity.sh]2026-10-21T02:14:16.9566533Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-21T02:14:16Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb exec test-cm-5886f7986-z5lqv -- chmod +x /tmp/has_singularity.sh]2026-10-21T02:14:17.1221581Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-21T02:14:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb exec test-cm-5886f7986-z5lqv -- sh -c /tmp/has_singularity.sh]2026-10-21T02:14:17.2842862Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-10-21T02:14:17.2844366Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:14:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:14:17.2885707Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:14:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb cp ../test-configs/ospool-ep/has_cvmfs.sh test-cm-5886f7986-z5lqv:/tmp/has_cvmfs.sh]2026-10-21T02:14:17.4844822Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:14:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb exec test-cm-5886f7986-z5lqv -- chmod +x /tmp/has_cvmfs.sh]2026-10-21T02:14:17.6462558Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:14:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb exec test-cm-5886f7986-z5lqv -- sh -c /tmp/has_cvmfs.sh]2026-10-21T02:14:17.8107774Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:14:17Z logger.go:67: command terminated with exit code 12026-10-21T02:14:17.8152694Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-z5lqv failed. Retrying in 30s.2026-10-21T02:14:47.8156244Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:14:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb exec test-cm-5886f7986-z5lqv -- sh -c /tmp/has_cvmfs.sh]2026-10-21T02:14:47.9831115Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:14:47Z logger.go:67: command terminated with exit code 12026-10-21T02:14:47.9865773Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-z5lqv failed. Retrying in 30s.2026-10-21T02:15:17.9875905Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:15:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb exec test-cm-5886f7986-z5lqv -- sh -c /tmp/has_cvmfs.sh]2026-10-21T02:15:18.1376546Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:15:18Z logger.go:67: command terminated with exit code 12026-10-21T02:15:18.1409898Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-z5lqv failed. Retrying in 30s.2026-10-21T02:15:48.1413847Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:15:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb exec test-cm-5886f7986-z5lqv -- sh -c /tmp/has_cvmfs.sh]2026-10-21T02:15:48.2878688Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:15:48Z logger.go:67: command terminated with exit code 12026-10-21T02:15:48.2913174Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-z5lqv failed. Retrying in 30s.2026-10-21T02:16:18.2918684Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:16:18Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb exec test-cm-5886f7986-z5lqv -- sh -c /tmp/has_cvmfs.sh]2026-10-21T02:16:18.4372356Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:16:18Z logger.go:67: command terminated with exit code 12026-10-21T02:16:18.4405903Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-z5lqv failed. Retrying in 30s.2026-10-21T02:16:48.4409616Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:16:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb exec test-cm-5886f7986-z5lqv -- sh -c /tmp/has_cvmfs.sh]2026-10-21T02:16:48.5861001Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:16:48Z logger.go:67: command terminated with exit code 12026-10-21T02:16:48.5897215Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-z5lqv failed. Retrying in 30s.2026-10-21T02:17:18.5937376Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:17:18Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb exec test-cm-5886f7986-z5lqv -- sh -c /tmp/has_cvmfs.sh]2026-10-21T02:17:18.7411851Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:17:18Z logger.go:67: command terminated with exit code 12026-10-21T02:17:18.7446299Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-z5lqv failed. Retrying in 30s.2026-10-21T02:17:48.7496318Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:17:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb exec test-cm-5886f7986-z5lqv -- sh -c /tmp/has_cvmfs.sh]2026-10-21T02:17:48.8994471Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:17:48Z logger.go:67: command terminated with exit code 12026-10-21T02:17:48.9009353Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-z5lqv failed. Retrying in 30s.2026-10-21T02:18:18.9013689Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:18:18Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb exec test-cm-5886f7986-z5lqv -- sh -c /tmp/has_cvmfs.sh]2026-10-21T02:18:19.0493461Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:18:19Z logger.go:67: command terminated with exit code 12026-10-21T02:18:19.0530550Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-z5lqv failed. Retrying in 30s.2026-10-21T02:18:49.0575682Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:18:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb exec test-cm-5886f7986-z5lqv -- sh -c /tmp/has_cvmfs.sh]2026-10-21T02:18:49.2063115Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-21T02:18:49Z logger.go:67: command terminated with exit code 12026-10-21T02:18:49.2096822Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-z5lqv failed. Retrying in 30s.2026-10-21T02:19:19.2148702Z test_utils.go:105: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-z5lqv did not succeed within {10 30000000000} retries2026-10-21T02:19:19.2150551Z TestOSPoolEP 2026-10-21T02:19:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:19:19.2228337Z TestOSPoolEP 2026-10-21T02:19:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:19:20.4033114Z TestOSPoolEP 2026-10-21T02:19:20Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:19:20.5271240Z TestOSPoolEP 2026-10-21T02:19:20Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:19:20.6443891Z TestOSPoolEP 2026-10-21T02:19:20Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:19:20.7881873Z TestOSPoolEP 2026-10-21T02:19:20Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:19:20.9085397Z TestOSPoolEP 2026-10-21T02:19:20Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:19:20.9111296Z === NAME TestOSPoolEP2026-10-21T02:19:20.9112085Z ospool_ep_test.go:72: ---2026-10-21T02:19:20.9113020Z Events for pod cvmfs-nodeplugin-5cd89c7cfd-rqd28:2026-10-21T02:19:20.9114719Z 2026-10-21 02:13:25 +0000 UTC Normal Successfully assigned test-ospool-ep-r9tbdb/cvmfs-nodeplugin-5cd89c7cfd-rqd28 to minikube2026-10-21T02:19:20.9116444Z 2026-10-21 02:13:26 +0000 UTC Normal Pulling image "opensciencegrid/cvmfs-nodeplugin:fresh"2026-10-21T02:19:20.9119315Z 2026-10-21 02:13:31 +0000 UTC Normal Successfully pulled image "opensciencegrid/cvmfs-nodeplugin:fresh" in 5.029s (5.029s including waiting). Image size: 155940803 bytes.2026-10-21T02:19:20.9120987Z 2026-10-21 02:13:31 +0000 UTC Normal Container created2026-10-21T02:19:20.9121888Z 2026-10-21 02:13:31 +0000 UTC Normal Container started2026-10-21T02:19:20.9122871Z 2026-10-21T02:19:20.9123277Z ---2026-10-21T02:19:20.9124358Z TestOSPoolEP 2026-10-21T02:19:20Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:19:20.9139300Z ospool_ep_test.go:72: ---2026-10-21T02:19:20.9140058Z Events for pod frontier-squid-65f85c968-4jkcs:2026-10-21T02:19:20.9141601Z 2026-10-21 02:13:25 +0000 UTC Normal Successfully assigned test-ospool-ep-r9tbdb/frontier-squid-65f85c968-4jkcs to minikube2026-10-21T02:19:20.9143525Z 2026-10-21 02:13:26 +0000 UTC Normal Pulling image "opensciencegrid/frontier-squid:fresh"2026-10-21T02:19:20.9145764Z 2026-10-21 02:13:41 +0000 UTC Normal Successfully pulled image "opensciencegrid/frontier-squid:fresh" in 10.623s (15.594s including waiting). Image size: 453187319 bytes.2026-10-21T02:19:20.9147875Z 2026-10-21 02:13:41 +0000 UTC Normal Container created2026-10-21T02:19:20.9151716Z 2026-10-21 02:13:41 +0000 UTC Normal Container started2026-10-21T02:19:20.9152827Z 2026-10-21T02:19:20.9153225Z ---2026-10-21T02:19:20.9154584Z TestOSPoolEP 2026-10-21T02:19:20Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:19:20.9179810Z ospool_ep_test.go:72: ---2026-10-21T02:19:20.9180934Z Events for pod idtoken-generator:2026-10-21T02:19:20.9183031Z 2026-10-21 02:13:14 +0000 UTC Normal Successfully assigned test-ospool-ep-r9tbdb/idtoken-generator to minikube2026-10-21T02:19:20.9184652Z 2026-10-21 02:13:14 +0000 UTC Normal Pulling image "htcondor/base"2026-10-21T02:19:20.9187553Z 2026-10-21 02:13:19 +0000 UTC Normal Successfully pulled image "htcondor/base" in 5.249s (5.249s including waiting). Image size: 196303183 bytes.2026-10-21T02:19:20.9189968Z 2026-10-21 02:13:19 +0000 UTC Normal Container created2026-10-21T02:19:20.9191430Z 2026-10-21 02:13:20 +0000 UTC Normal Container started2026-10-21T02:19:20.9192854Z 2026-10-21T02:19:20.9193689Z ---2026-10-21T02:19:20.9195397Z TestOSPoolEP 2026-10-21T02:19:20Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:19:20.9208450Z ospool_ep_test.go:72: ---2026-10-21T02:19:20.9210107Z Events for pod ospool-ep-674fbdcc48-pd7z9:2026-10-21T02:19:20.9211884Z 2026-10-21 02:13:25 +0000 UTC Normal Successfully assigned test-ospool-ep-r9tbdb/ospool-ep-674fbdcc48-pd7z9 to minikube2026-10-21T02:19:20.9213738Z 2026-10-21 02:13:26 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-10-21T02:19:20.9216351Z 2026-10-21 02:13:43 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 2.073s (17.658s including waiting). Image size: 2893600 bytes.2026-10-21T02:19:20.9217841Z 2026-10-21 02:13:43 +0000 UTC Normal Container created2026-10-21T02:19:20.9218710Z 2026-10-21 02:13:44 +0000 UTC Normal Container started2026-10-21T02:19:20.9219967Z 2026-10-21 02:13:45 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-10-21T02:19:20.9222486Z 2026-10-21 02:13:57 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 12.077s (12.077s including waiting). Image size: 537408098 bytes.2026-10-21T02:19:20.9224212Z 2026-10-21 02:13:57 +0000 UTC Normal Container created2026-10-21T02:19:20.9225064Z 2026-10-21 02:13:57 +0000 UTC Normal Container started2026-10-21T02:19:20.9225587Z 2026-10-21T02:19:20.9225932Z ---2026-10-21T02:19:20.9227238Z TestOSPoolEP 2026-10-21T02:19:20Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:19:20.9242497Z ospool_ep_test.go:72: ---2026-10-21T02:19:20.9259378Z Events for pod test-cm-5886f7986-z5lqv:2026-10-21T02:19:20.9262292Z 2026-10-21 02:13:25 +0000 UTC Normal Successfully assigned test-ospool-ep-r9tbdb/test-cm-5886f7986-z5lqv to minikube2026-10-21T02:19:20.9264384Z 2026-10-21 02:13:26 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-10-21T02:19:20.9266555Z 2026-10-21 02:13:45 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 1.186s (18.821s including waiting). Image size: 196304120 bytes.2026-10-21T02:19:20.9269907Z 2026-10-21 02:13:45 +0000 UTC Normal Container created2026-10-21T02:19:20.9271228Z 2026-10-21 02:13:45 +0000 UTC Normal Container started2026-10-21T02:19:20.9273924Z 2026-10-21T02:19:20.9275569Z ---2026-10-21T02:19:20.9278247Z TestOSPoolEP 2026-10-21T02:19:20Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-21T02:19:20.9280330Z TestOSPoolEP 2026-10-21T02:19:20Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb delete -f /tmp/TestOSPoolEP285804517]2026-10-21T02:19:21.0400331Z TestOSPoolEP 2026-10-21T02:19:21Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-r9tbdb namespace2026-10-21T02:19:21.0433757Z TestOSPoolEP 2026-10-21T02:19:21Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-r9tbdb namespace2026-10-21T02:19:21.9860202Z TestOSPoolEP 2026-10-21T02:19:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb delete -f /tmp/TestOSPoolEP2468058821]2026-10-21T02:19:22.0888459Z TestOSPoolEP 2026-10-21T02:19:22Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-r9tbdb namespace2026-10-21T02:19:22.0943890Z TestOSPoolEP 2026-10-21T02:19:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-r9tbdb delete -k /tmp/kustomize-template-3192314064]2026-10-21T02:19:22.2392550Z TestOSPoolEP 2026-10-21T02:19:22Z logger.go:67: serviceaccount "cvmfs-nodeplugin" deleted from test-ospool-ep-r9tbdb namespace2026-10-21T02:19:22.2491245Z TestOSPoolEP 2026-10-21T02:19:22Z logger.go:67: service "frontier-squid" deleted from test-ospool-ep-r9tbdb namespace2026-10-21T02:19:22.2597028Z TestOSPoolEP 2026-10-21T02:19:22Z logger.go:67: service "test-cm" deleted from test-ospool-ep-r9tbdb namespace2026-10-21T02:19:22.2662705Z TestOSPoolEP 2026-10-21T02:19:22Z logger.go:67: deployment.apps "cvmfs-nodeplugin" deleted from test-ospool-ep-r9tbdb namespace2026-10-21T02:19:22.2703676Z TestOSPoolEP 2026-10-21T02:19:22Z logger.go:67: deployment.apps "frontier-squid" deleted from test-ospool-ep-r9tbdb namespace2026-10-21T02:19:22.2809106Z TestOSPoolEP 2026-10-21T02:19:22Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-r9tbdb namespace2026-10-21T02:19:22.2913439Z TestOSPoolEP 2026-10-21T02:19:22Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-r9tbdb namespace2026-10-21T02:19:22.3375570Z --- FAIL: TestOSPoolEP (368.50s)2026-10-21T02:19:22.3383640Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (40.05s)2026-10-21T02:19:22.3385068Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP (10.89s)2026-10-21T02:19:22.3386478Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity (0.52s)2026-10-21T02:19:22.3388677Z --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (301.93s)2026-10-21T02:19:22.3389582Z FAIL2026-10-21T02:19:22.3410921Z FAIL github.com/osg-htc/k8s-integration-tests/test 368.522s2026-10-21T02:19:22.3549742Z FAIL2026-10-21T02:19:22.5413730Z ##[error]Process completed with exit code 1.2026-10-21T02:19:22.5472014Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-21T02:19:22.5472926Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-10-21T02:19:22.5507626Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-21T02:19:22.5507989Z env:2026-10-21T02:19:22.5508190Z GOTOOLCHAIN: local2026-10-21T02:19:22.5508661Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-21T02:19:22.5509157Z ##[endgroup]2026-10-21T02:19:22.5653073Z ##[group]Run actions/upload-artifact@v42026-10-21T02:19:22.5653417Z with:2026-10-21T02:19:22.5653822Z name: TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd72026-10-21T02:19:22.5654321Z path: /tmp/k8s-tests2026-10-21T02:19:22.5654562Z retention-days: 52026-10-21T02:19:22.5654791Z if-no-files-found: warn2026-10-21T02:19:22.5655039Z compression-level: 62026-10-21T02:19:22.5655257Z overwrite: false2026-10-21T02:19:22.5655490Z include-hidden-files: false2026-10-21T02:19:22.5655728Z env:2026-10-21T02:19:22.5655929Z GOTOOLCHAIN: local2026-10-21T02:19:22.5656148Z ##[endgroup]2026-10-21T02:19:22.7696965Z (node:15904) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-21T02:19:22.7699098Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-21T02:19:22.8102422Z With the provided path, there will be 10 files uploaded2026-10-21T02:19:22.8154027Z Artifact name is valid!2026-10-21T02:19:22.8154806Z Root directory input is valid!2026-10-21T02:19:23.0215211Z Beginning upload of artifact content to blob storage2026-10-21T02:19:23.0600452Z (node:15904) [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-21T02:19:23.0842963Z Uploaded bytes 160632026-10-21T02:19:23.0980973Z Finished uploading artifact content to blob storage!2026-10-21T02:19:23.0982360Z SHA256 digest of uploaded artifact zip is 19b6ce1a444612c561241317b497604afa669ec0cacab988f82c5fdead4e3de12026-10-21T02:19:23.0984475Z Finalizing artifact upload2026-10-21T02:19:23.3094153Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7.zip successfully finalized. Artifact ID 123158025122026-10-21T02:19:23.3096674Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7 has been successfully uploaded! Final size is 16063 bytes. Artifact ID is 123158025122026-10-21T02:19:23.3102279Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/39531648625/artifacts/123158025122026-10-21T02:19:23.3353713Z Post job cleanup.2026-10-21T02:19:23.4333720Z [command]/usr/bin/git version2026-10-21T02:19:23.4383303Z git version 2.55.02026-10-21T02:19:23.4436762Z Temporarily overriding HOME='/home/runner/work/_temp/b6090ebc-d2a1-4f13-b88e-9247fcc8992e' before making global git config changes2026-10-21T02:19:23.4448473Z Adding repository directory to the temporary git global config as a safe directory2026-10-21T02:19:23.4449861Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-21T02:19:23.4528287Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-21T02:19:23.4610702Z [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-21T02:19:23.4935845Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-21T02:19:23.4969740Z http.https://github.com/.extraheader2026-10-21T02:19:23.4983090Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-10-21T02:19:23.5020222Z [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-21T02:19:23.5344867Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-21T02:19:23.5397054Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-21T02:19:23.5931104Z Cleaning up orphan processes2026-10-21T02:19:23.6859653Z ##[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/