2026-10-22T02:06:14.1438904Z Current runner version: '2.338.0'2026-10-22T02:06:14.1475587Z ##[group]Runner Image Provisioner2026-10-22T02:06:14.1477113Z Hosted Compute Agent2026-10-22T02:06:14.1478194Z Version: 20261015.6102026-10-22T02:06:14.1479636Z Commit: 267fdb4e8bbec4ab5ea31367f3a00d5c480c76562026-10-22T02:06:14.1481067Z Build Date: 2026-10-14T17:06:54Z2026-10-22T02:06:14.1482858Z Worker ID: {50f08148-1b00-4afd-82d1-c929a9c34313}2026-10-22T02:06:14.1484287Z Region: northcentralus2026-10-22T02:06:14.1485346Z Cloud: Azure2026-10-22T02:06:14.1486479Z ##[endgroup]2026-10-22T02:06:14.1488942Z ##[group]Operating System2026-10-22T02:06:14.1490104Z Ubuntu2026-10-22T02:06:14.1491401Z 22.04.52026-10-22T02:06:14.1492596Z LTS2026-10-22T02:06:14.1493716Z ##[endgroup]2026-10-22T02:06:14.1494802Z ##[group]Runner Image2026-10-22T02:06:14.1495957Z Image: ubuntu-22.042026-10-22T02:06:14.1497204Z Version: 20261018.327.12026-10-22T02:06:14.1499447Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20261018.327/images/ubuntu/Ubuntu2204-Readme.md2026-10-22T02:06:14.1502862Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20261018.3272026-10-22T02:06:14.1505268Z ##[endgroup]2026-10-22T02:06:14.1511367Z ##[group]GITHUB_TOKEN Permissions2026-10-22T02:06:14.1515495Z Actions: write2026-10-22T02:06:14.1516636Z ArtifactMetadata: write2026-10-22T02:06:14.1517610Z Attestations: write2026-10-22T02:06:14.1518343Z Checks: write2026-10-22T02:06:14.1518940Z CodeQuality: write2026-10-22T02:06:14.1519534Z Contents: write2026-10-22T02:06:14.1520215Z CopilotRequests: write2026-10-22T02:06:14.1520865Z Deployments: write2026-10-22T02:06:14.1521487Z Discussions: write2026-10-22T02:06:14.1522483Z Drives: write2026-10-22T02:06:14.1523050Z Issues: write2026-10-22T02:06:14.1523820Z Metadata: read2026-10-22T02:06:14.1524427Z Models: read2026-10-22T02:06:14.1525040Z Packages: write2026-10-22T02:06:14.1525659Z Pages: write2026-10-22T02:06:14.1526250Z PullRequests: write2026-10-22T02:06:14.1526927Z RepositoryProjects: write2026-10-22T02:06:14.1527598Z SecurityEvents: write2026-10-22T02:06:14.1528285Z Statuses: write2026-10-22T02:06:14.1528918Z VulnerabilityAlerts: read2026-10-22T02:06:14.1529543Z ##[endgroup]2026-10-22T02:06:14.1531702Z Secret source: Actions2026-10-22T02:06:14.1533012Z Cache mode: write2026-10-22T02:06:14.1534108Z Prepare workflow directory2026-10-22T02:06:14.1948885Z Prepare all required actions2026-10-22T02:06:14.2021065Z Getting action download info2026-10-22T02:06:14.4794031Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-10-22T02:06:14.6370330Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-10-22T02:06:14.9434160Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-10-22T02:06:15.2224518Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-10-22T02:06:15.4795242Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (63ec080e4eea87fb8a9eae678ab9944ec2461251)2026-10-22T02:06:15.4799856Z ##[group] Inputs2026-10-22T02:06:15.4800440Z testName: TestOSPoolEP2026-10-22T02:06:15.4801403Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-22T02:06:15.4802656Z setupScript: 2026-10-22T02:06:15.4803139Z setupEnv: {}2026-10-22T02:06:15.4803618Z ##[endgroup]2026-10-22T02:06:15.4804368Z Complete job name: ospool-ep / Run OSPool EP test (cvmfs-bind, 25-release) / Run Tests2026-10-22T02:06:15.5572583Z ##[group]Run actions/checkout@v52026-10-22T02:06:15.5573596Z with:2026-10-22T02:06:15.5574150Z repository: osg-htc/k8s-integration-tests2026-10-22T02:06:15.5578542Z token: ***2026-10-22T02:06:15.5579025Z ssh-strict: true2026-10-22T02:06:15.5579506Z ssh-user: git2026-10-22T02:06:15.5580043Z persist-credentials: true2026-10-22T02:06:15.5580804Z clean: true2026-10-22T02:06:15.5581818Z sparse-checkout-cone-mode: true2026-10-22T02:06:15.5582782Z fetch-depth: 12026-10-22T02:06:15.5583265Z fetch-tags: false2026-10-22T02:06:15.5583770Z show-progress: true2026-10-22T02:06:15.5584278Z lfs: false2026-10-22T02:06:15.5584739Z submodules: false2026-10-22T02:06:15.5585239Z set-safe-directory: true2026-10-22T02:06:15.5585800Z allow-unsafe-pr-checkout: false2026-10-22T02:06:15.5586708Z ##[endgroup]2026-10-22T02:06:15.6616640Z Syncing repository: osg-htc/k8s-integration-tests2026-10-22T02:06:15.6619627Z ##[group]Getting Git version info2026-10-22T02:06:15.6621405Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-22T02:06:15.6623833Z [command]/usr/bin/git version2026-10-22T02:06:15.6662448Z git version 2.55.02026-10-22T02:06:15.6693658Z ##[endgroup]2026-10-22T02:06:15.6700165Z Temporarily overriding HOME='/home/runner/work/_temp/2e37a3eb-220b-4d9f-ba59-52aca7ddb93e' before making global git config changes2026-10-22T02:06:15.6702963Z Adding repository directory to the temporary git global config as a safe directory2026-10-22T02:06:15.6706249Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-22T02:06:15.6745923Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-22T02:06:15.6750277Z ##[group]Initializing the repository2026-10-22T02:06:15.6754693Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-22T02:06:15.6859290Z hint: Using 'master' as the name for the initial branch. This default branch name2026-10-22T02:06:15.6861314Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-10-22T02:06:15.6863484Z hint: to use in all of your new repositories, which will suppress this warning,2026-10-22T02:06:15.6866478Z hint: call:2026-10-22T02:06:15.6867467Z hint:2026-10-22T02:06:15.6868548Z hint: git config --global init.defaultBranch <name>2026-10-22T02:06:15.6869854Z hint:2026-10-22T02:06:15.6872213Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-10-22T02:06:15.6874220Z hint: 'development'. The just-created branch can be renamed via this command:2026-10-22T02:06:15.6875771Z hint:2026-10-22T02:06:15.6876707Z hint: git branch -m <name>2026-10-22T02:06:15.6877770Z hint:2026-10-22T02:06:15.6879235Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-10-22T02:06:15.6881671Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-10-22T02:06:15.6886218Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-10-22T02:06:15.6913155Z ##[endgroup]2026-10-22T02:06:15.6914709Z ##[group]Disabling automatic garbage collection2026-10-22T02:06:15.6918251Z [command]/usr/bin/git config --local gc.auto 02026-10-22T02:06:15.6984163Z ##[endgroup]2026-10-22T02:06:15.6985750Z ##[group]Setting up auth2026-10-22T02:06:15.6992729Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-22T02:06:15.7029340Z [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-22T02:06:15.7419605Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-22T02:06:15.7462996Z [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-22T02:06:15.7744871Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-22T02:06:15.7786086Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-22T02:06:15.8043673Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-10-22T02:06:15.8088908Z ##[endgroup]2026-10-22T02:06:15.8089793Z ##[group]Fetching the repository2026-10-22T02:06:15.8098393Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +63ec080e4eea87fb8a9eae678ab9944ec2461251:refs/remotes/origin/main2026-10-22T02:06:16.1238510Z From https://github.com/osg-htc/k8s-integration-tests2026-10-22T02:06:16.1240886Z * [new ref] 63ec080e4eea87fb8a9eae678ab9944ec2461251 -> origin/main2026-10-22T02:06:16.1245790Z ##[endgroup]2026-10-22T02:06:16.1247993Z ##[group]Determining the checkout info2026-10-22T02:06:16.1250399Z ##[endgroup]2026-10-22T02:06:16.1255759Z [command]/usr/bin/git sparse-checkout disable2026-10-22T02:06:16.1309297Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-10-22T02:06:16.1347119Z ##[group]Checking out the ref2026-10-22T02:06:16.1350945Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-10-22T02:06:16.1456966Z Switched to a new branch 'main'2026-10-22T02:06:16.1461087Z branch 'main' set up to track 'origin/main'.2026-10-22T02:06:16.1469133Z ##[endgroup]2026-10-22T02:06:16.1513922Z [command]/usr/bin/git log -1 --format=%H2026-10-22T02:06:16.1544941Z 63ec080e4eea87fb8a9eae678ab9944ec24612512026-10-22T02:06:16.1961033Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-22T02:06:16.1964231Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-22T02:06:16.1967029Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-22T02:06:16.2008796Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-22T02:06:16.2010567Z env:2026-10-22T02:06:16.2012830Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-22T02:06:16.2015307Z SETUP_ENV_YAML: {}2026-10-22T02:06:16.2016382Z ##[endgroup]2026-10-22T02:06:16.9369243Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-22T02:06:16.9371548Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-10-22T02:06:16.9408453Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-22T02:06:16.9409796Z env:2026-10-22T02:06:16.9411500Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfs-bind"}2026-10-22T02:06:16.9413776Z ##[endgroup]2026-10-22T02:06:16.9584300Z ##[group]Run true2026-10-22T02:06:16.9585259Z [36;1mtrue[0m2026-10-22T02:06:16.9617667Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-22T02:06:16.9619022Z ##[endgroup]2026-10-22T02:06:16.9882721Z ##[group]Run medyagh/setup-minikube@latest2026-10-22T02:06:16.9883882Z with:2026-10-22T02:06:16.9884727Z start: true2026-10-22T02:06:16.9885571Z cache: true2026-10-22T02:06:16.9886476Z minikube-version: latest2026-10-22T02:06:16.9887465Z wait: all2026-10-22T02:06:16.9888291Z ##[endgroup]2026-10-22T02:06:17.1173286Z (node:2231) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-22T02:06:17.1175878Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-22T02:06:18.0947003Z [command]/usr/bin/chmod +x /home/runner/work/_temp/061f4784-ab99-4fc4-8e79-f071bd6142f12026-10-22T02:06:18.2898444Z [command]/home/runner/bin/minikube version --short2026-10-22T02:06:18.3414996Z v1.39.02026-10-22T02:06:18.4823719Z Cache hit for: preloaded-tarball-v1.39.0-x64-stable-docker2026-10-22T02:06:18.4935867Z (node:2231) [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-22T02:06:18.4943634Z Cache hit for: kic-v1.39.0-x642026-10-22T02:06:19.5817775Z Received 79691776 of 531630645 (15.0%), 76.0 MBs/sec2026-10-22T02:06:19.6332165Z Received 29360128 of 288577004 (10.2%), 28.0 MBs/sec2026-10-22T02:06:20.5822365Z Received 113246208 of 531630645 (21.3%), 54.0 MBs/sec2026-10-22T02:06:20.6330219Z Received 71303168 of 288577004 (24.7%), 34.0 MBs/sec2026-10-22T02:06:21.5820806Z Received 113246208 of 531630645 (21.3%), 36.0 MBs/sec2026-10-22T02:06:21.6331645Z Received 104857600 of 288577004 (36.3%), 33.3 MBs/sec2026-10-22T02:06:22.5833338Z Received 113246208 of 531630645 (21.3%), 27.0 MBs/sec2026-10-22T02:06:22.6325241Z Received 104857600 of 288577004 (36.3%), 25.0 MBs/sec2026-10-22T02:06:23.5846187Z Received 113246208 of 531630645 (21.3%), 21.6 MBs/sec2026-10-22T02:06:23.6328379Z Received 104857600 of 288577004 (36.3%), 20.0 MBs/sec2026-10-22T02:06:24.5929938Z Received 201326592 of 531630645 (37.9%), 31.9 MBs/sec2026-10-22T02:06:24.6326006Z Received 201326592 of 288577004 (69.8%), 32.0 MBs/sec2026-10-22T02:06:25.3190479Z Received 288577004 of 288577004 (100.0%), 41.2 MBs/sec2026-10-22T02:06:25.3222355Z Cache Size: ~275 MB (288577004 B)2026-10-22T02:06:25.3490817Z [command]/usr/bin/tar -xf /home/runner/work/_temp/cebbe99f-1e2a-4b49-b5d2-6af4ceef571d/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-22T02:06:25.5946540Z Received 385875968 of 531630645 (72.6%), 52.5 MBs/sec2026-10-22T02:06:26.1813090Z Cache restored successfully2026-10-22T02:06:26.4804024Z Received 531630645 of 531630645 (100.0%), 64.2 MBs/sec2026-10-22T02:06:26.4805521Z Cache Size: ~507 MB (531630645 B)2026-10-22T02:06:26.4921533Z [command]/usr/bin/tar -xf /home/runner/work/_temp/2a0aa290-ef6e-4eda-bb7a-7b859168493d/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-22T02:06:27.3395921Z Cache restored successfully2026-10-22T02:06:27.4607589Z [command]/home/runner/bin/minikube start --wait all2026-10-22T02:06:27.5168608Z * minikube v1.39.0 on Ubuntu 22.042026-10-22T02:06:27.6685096Z ! 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-22T02:06:30.2824282Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-10-22T02:06:30.3533236Z * Using Docker driver with root privileges2026-10-22T02:06:30.3545637Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-10-22T02:06:30.3553850Z * Pulling base image v0.0.51 ...2026-10-22T02:06:51.3698387Z * Preparing Kubernetes v1.37.0 on containerd 2.3.4 ...2026-10-22T02:06:59.5186230Z * Configuring CNI (Container Networking Interface) ...2026-10-22T02:07:04.8601647Z * Verifying Kubernetes components...2026-10-22T02:07:04.8872360Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-10-22T02:07:05.4424410Z * Enabled addons: storage-provisioner, default-storageclass2026-10-22T02:07:30.4683535Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-10-22T02:07:30.4802978Z [command]/home/runner/bin/minikube version --short2026-10-22T02:07:30.5395961Z v1.39.02026-10-22T02:07:30.5735948Z ##[group]Run actions/setup-go@v62026-10-22T02:07:30.5736250Z with:2026-10-22T02:07:30.5736462Z go-version: 1.262026-10-22T02:07:30.5736680Z cache: true2026-10-22T02:07:30.5736919Z cache-dependency-path: go.sum2026-10-22T02:07:30.5737191Z check-latest: false2026-10-22T02:07:30.5739815Z token: ***2026-10-22T02:07:30.5740033Z ##[endgroup]2026-10-22T02:07:30.7067117Z Setup go version spec 1.262026-10-22T02:07:30.7621162Z Found in cache @ /opt/hostedtoolcache/go/1.26.9/x642026-10-22T02:07:30.7624248Z Added go to the path2026-10-22T02:07:30.7628144Z Successfully set up Go version 1.262026-10-22T02:07:31.5605940Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOMODCACHE2026-10-22T02:07:31.5681230Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOCACHE2026-10-22T02:07:31.5708239Z /home/runner/go/pkg/mod2026-10-22T02:07:31.5737807Z /home/runner/.cache/go-build2026-10-22T02:07:31.6970497Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-22T02:07:32.7969566Z Received 134217728 of 249167808 (53.9%), 128.0 MBs/sec2026-10-22T02:07:33.3053667Z Received 249167808 of 249167808 (100.0%), 157.9 MBs/sec2026-10-22T02:07:33.3055055Z Cache Size: ~238 MB (249167808 B)2026-10-22T02:07:33.3120504Z [command]/usr/bin/tar -xf /home/runner/work/_temp/067e5d8a-b656-4900-a3ab-2d0e3761b288/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-22T02:07:36.4962620Z Cache restored successfully2026-10-22T02:07:36.5741103Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-22T02:07:36.5767012Z go version go1.26.9 linux/amd642026-10-22T02:07:36.5767232Z 2026-10-22T02:07:36.5767559Z ##[group]go env2026-10-22T02:07:36.6375150Z AR='ar'2026-10-22T02:07:36.6375544Z CC='gcc'2026-10-22T02:07:36.6375911Z CGO_CFLAGS='-O2 -g'2026-10-22T02:07:36.6376550Z CGO_CPPFLAGS=''2026-10-22T02:07:36.6376950Z CGO_CXXFLAGS='-O2 -g'2026-10-22T02:07:36.6377211Z CGO_ENABLED='1'2026-10-22T02:07:36.6377445Z CGO_FFLAGS='-O2 -g'2026-10-22T02:07:36.6377743Z CGO_LDFLAGS='-O2 -g'2026-10-22T02:07:36.6377972Z CXX='g++'2026-10-22T02:07:36.6378188Z GCCGO='gccgo'2026-10-22T02:07:36.6378407Z GO111MODULE=''2026-10-22T02:07:36.6378627Z GOAMD64='v1'2026-10-22T02:07:36.6378852Z GOARCH='amd64'2026-10-22T02:07:36.6379069Z GOAUTH='netrc'2026-10-22T02:07:36.6379272Z GOBIN=''2026-10-22T02:07:36.6379513Z GOCACHE='/home/runner/.cache/go-build'2026-10-22T02:07:36.6379807Z GOCACHEPROG=''2026-10-22T02:07:36.6380027Z GODEBUG=''2026-10-22T02:07:36.6380283Z GOENV='/home/runner/.config/go/env'2026-10-22T02:07:36.6380570Z GOEXE=''2026-10-22T02:07:36.6380776Z GOEXPERIMENT=''2026-10-22T02:07:36.6381004Z GOFIPS140='off'2026-10-22T02:07:36.6381211Z GOFLAGS=''2026-10-22T02:07:36.6382140Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build2257166732=/tmp/go-build -gno-record-gcc-switches'2026-10-22T02:07:36.6382867Z GOHOSTARCH='amd64'2026-10-22T02:07:36.6383109Z GOHOSTOS='linux'2026-10-22T02:07:36.6383333Z GOINSECURE=''2026-10-22T02:07:36.6383709Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-10-22T02:07:36.6384154Z GOMODCACHE='/home/runner/go/pkg/mod'2026-10-22T02:07:36.6384443Z GONOPROXY=''2026-10-22T02:07:36.6384653Z GONOSUMDB=''2026-10-22T02:07:36.6384865Z GOOS='linux'2026-10-22T02:07:36.6385094Z GOPATH='/home/runner/go'2026-10-22T02:07:36.6385354Z GOPRIVATE=''2026-10-22T02:07:36.6385624Z GOPROXY='https://proxy.golang.org,direct'2026-10-22T02:07:36.6385974Z GOROOT='/opt/hostedtoolcache/go/1.26.9/x64'2026-10-22T02:07:36.6386301Z GOSUMDB='sum.golang.org'2026-10-22T02:07:36.6386563Z GOTELEMETRY='local'2026-10-22T02:07:36.6386863Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-10-22T02:07:36.6387184Z GOTMPDIR=''2026-10-22T02:07:36.6387408Z GOTOOLCHAIN='local'2026-10-22T02:07:36.6388068Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.9/x64/pkg/tool/linux_amd64'2026-10-22T02:07:36.6388470Z GOVCS=''2026-10-22T02:07:36.6388684Z GOVERSION='go1.26.9'2026-10-22T02:07:36.6388921Z GOWORK=''2026-10-22T02:07:36.6389147Z PKG_CONFIG='pkg-config'2026-10-22T02:07:36.6389304Z 2026-10-22T02:07:36.6389624Z ##[endgroup]2026-10-22T02:07:36.6654601Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-22T02:07:36.6655166Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-10-22T02:07:36.6690375Z shell: /usr/bin/bash -e {0}2026-10-22T02:07:36.6690646Z env:2026-10-22T02:07:36.6690856Z GOTOOLCHAIN: local2026-10-22T02:07:36.6691121Z OSPOOL_EP_OSPoolEPTag: 25-release2026-10-22T02:07:36.6691608Z OSPOOL_EP_CMTag: 25.0-el92026-10-22T02:07:36.6692252Z OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-22T02:07:36.6692545Z ##[endgroup]2026-10-22T02:07:45.4489709Z === RUN TestOSPoolEP2026-10-22T02:07:45.4490160Z === PAUSE TestOSPoolEP2026-10-22T02:07:45.4490425Z === CONT TestOSPoolEP2026-10-22T02:07:45.4503649Z TestOSPoolEP 2026-10-22T02:07:45Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:45.4615019Z TestOSPoolEP 2026-10-22T02:07:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh apply -f /tmp/TestOSPoolEP3106136934]2026-10-22T02:07:46.0091570Z TestOSPoolEP 2026-10-22T02:07:46Z logger.go:67: pod/idtoken-generator created2026-10-22T02:07:46.0181791Z TestOSPoolEP 2026-10-22T02:07:46Z logger.go:67: secret/pool-passwd created2026-10-22T02:07:46.0222533Z TestOSPoolEP 2026-10-22T02:07:46Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-22T02:07:46.0225106Z TestOSPoolEP 2026-10-22T02:07:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:46.0239662Z TestOSPoolEP 2026-10-22T02:07:46Z 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-22T02:07:56.0247753Z TestOSPoolEP 2026-10-22T02:07:56Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-22T02:07:56.0248762Z TestOSPoolEP 2026-10-22T02:07:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:56.0268800Z TestOSPoolEP 2026-10-22T02:07:56Z logger.go:67: Pod is now available2026-10-22T02:07:56.0270700Z TestOSPoolEP 2026-10-22T02:07:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-10-22T02:07:56.6749912Z TestOSPoolEP 2026-10-22T02:07:56Z logger.go:67: ***2026-10-22T02:07:56.6808437Z TestOSPoolEP 2026-10-22T02:07:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh apply -f /tmp/TestOSPoolEP1373212829]2026-10-22T02:07:56.8800891Z TestOSPoolEP 2026-10-22T02:07:56Z logger.go:67: secret/pool-token created2026-10-22T02:07:56.8838273Z TestOSPoolEP 2026-10-22T02:07:56Z retry.go:91: Wait for secret pool-token to be provisioned.2026-10-22T02:07:56.8839851Z TestOSPoolEP 2026-10-22T02:07:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:56.8863553Z TestOSPoolEP 2026-10-22T02:07:56Z logger.go:67: Secret is now available2026-10-22T02:07:56.8881220Z TestOSPoolEP 2026-10-22T02:07:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh apply -k /tmp/kustomize-template-1302007275]2026-10-22T02:07:57.3403036Z TestOSPoolEP 2026-10-22T02:07:57Z logger.go:67: serviceaccount/cvmfs-nodeplugin created2026-10-22T02:07:57.3489429Z TestOSPoolEP 2026-10-22T02:07:57Z logger.go:67: service/frontier-squid created2026-10-22T02:07:57.3593501Z TestOSPoolEP 2026-10-22T02:07:57Z logger.go:67: service/test-cm created2026-10-22T02:07:57.3672892Z TestOSPoolEP 2026-10-22T02:07:57Z logger.go:67: deployment.apps/cvmfs-nodeplugin created2026-10-22T02:07:57.3750211Z TestOSPoolEP 2026-10-22T02:07:57Z logger.go:67: deployment.apps/frontier-squid created2026-10-22T02:07:57.3962109Z TestOSPoolEP 2026-10-22T02:07:57Z 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-22T02:07:57.3988593Z TestOSPoolEP 2026-10-22T02:07:57Z logger.go:67: deployment.apps/ospool-ep created2026-10-22T02:07:57.4130489Z TestOSPoolEP 2026-10-22T02:07:57Z logger.go:67: deployment.apps/test-cm created2026-10-22T02:07:57.4198567Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-10-22T02:07:57.4201101Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:57.4264448Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:57Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-22T02:07:57.4268812Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:57.4272250Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:57Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-22T02:07:57.4274863Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:57.4278689Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:57Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-22T02:07:57.4280939Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:57.4293532Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:57Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-22T02:07:57.4295873Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:07:57.4378953Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07: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: NewReplicaSetCreated, message: Created new replica set "ospool-ep-cc75b66b9". Sleeping for 10s and will try again.2026-10-22T02:07:57.4405034Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07: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: NewReplicaSetCreated, message: Created new replica set "test-cm-7f9d786cd6". Sleeping for 10s and will try again.2026-10-22T02:07:57.4425685Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:57Z 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-22T02:07:57.4441509Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:07:57Z 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-22T02:08:07.4395363Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:07Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-22T02:08:07.4417112Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:07.4421301Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:07Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-22T02:08:07.4423652Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:07.4432673Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:07Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-22T02:08:07.4434708Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:07.4448638Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:07Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-22T02:08:07.4451708Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:07.4456842Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08: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-22T02:08:07.4473754Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:07Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "test-cm-7f9d786cd6" is progressing.. Sleeping for 10s and will try again.2026-10-22T02:08:07.4479621Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:07Z retry.go:103: Wait for deployment frontier-squid to be provisioned. returned an error: Deployment frontier-squid is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "frontier-squid-65f85c968" is progressing.. Sleeping for 10s and will try again.2026-10-22T02:08:07.4498368Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:07Z logger.go:67: Deployment is now available2026-10-22T02:08:17.4466201Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:17Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-22T02:08:17.4485266Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:17.4487133Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:17Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-22T02:08:17.4489094Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:17.4491034Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:17Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-22T02:08:17.4493243Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:17.4532560Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:17Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "test-cm-7f9d786cd6" is progressing.. Sleeping for 10s and will try again.2026-10-22T02:08:17.4540178Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:17Z logger.go:67: Deployment is now available2026-10-22T02:08:17.4565291Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08: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-22T02:08:27.4538199Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:27Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-22T02:08:27.4539544Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:27.4568472Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:27Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-22T02:08:27.4570129Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:27.4576695Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:27Z logger.go:67: Deployment is now available2026-10-22T02:08:27.4593531Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:27Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-cc75b66b9" is progressing.. Sleeping for 10s and will try again.2026-10-22T02:08:37.4605327Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:37Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-22T02:08:37.4608102Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:37.4647103Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-22T02:08:37Z logger.go:67: Deployment is now available2026-10-22T02:08:37.4649710Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP2026-10-22T02:08:37.4659443Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-22T02:08:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:37.4685092Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-22T02:08:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh cp ../test-configs/ospool-ep/condor_status.sh test-cm-7f9d786cd6-6f547:/tmp/condor_status.sh]2026-10-22T02:08:38.1747923Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-22T02:08:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh exec test-cm-7f9d786cd6-6f547 -- chmod +x /tmp/condor_status.sh]2026-10-22T02:08:38.3316556Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-22T02:08:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh exec test-cm-7f9d786cd6-6f547 -- sh -c /tmp/condor_status.sh]2026-10-22T02:08:38.5037473Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-22T02:08:38Z logger.go:67: command terminated with exit code 12026-10-22T02:08:38.5073185Z test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-7f9d786cd6-6f547 failed. Retrying in 10s.2026-10-22T02:08:48.5078324Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-22T02:08:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh exec test-cm-7f9d786cd6-6f547 -- sh -c /tmp/condor_status.sh]2026-10-22T02:08:48.6780281Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity2026-10-22T02:08:48.6782914Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-22T02:08:48Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:48.6811357Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-22T02:08:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh cp ../test-configs/ospool-ep/has_singularity.sh test-cm-7f9d786cd6-6f547:/tmp/has_singularity.sh]2026-10-22T02:08:48.8863769Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-22T02:08:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh exec test-cm-7f9d786cd6-6f547 -- chmod +x /tmp/has_singularity.sh]2026-10-22T02:08:49.0379864Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-22T02:08:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh exec test-cm-7f9d786cd6-6f547 -- sh -c /tmp/has_singularity.sh]2026-10-22T02:08:49.2243558Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-10-22T02:08:49.2245221Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:08:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:08:49.2272780Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:08:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh cp ../test-configs/ospool-ep/has_cvmfs.sh test-cm-7f9d786cd6-6f547:/tmp/has_cvmfs.sh]2026-10-22T02:08:49.4175995Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:08:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh exec test-cm-7f9d786cd6-6f547 -- chmod +x /tmp/has_cvmfs.sh]2026-10-22T02:08:49.5703601Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:08:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh exec test-cm-7f9d786cd6-6f547 -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:08:49.7343374Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:08:49Z logger.go:67: command terminated with exit code 12026-10-22T02:08:49.7381588Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-6f547 failed. Retrying in 30s.2026-10-22T02:09:19.7384684Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:09:19Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh exec test-cm-7f9d786cd6-6f547 -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:09:19.9061551Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:09:19Z logger.go:67: command terminated with exit code 12026-10-22T02:09:19.9094119Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-6f547 failed. Retrying in 30s.2026-10-22T02:09:49.9098657Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:09:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh exec test-cm-7f9d786cd6-6f547 -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:09:50.0724724Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:09:50Z logger.go:67: command terminated with exit code 12026-10-22T02:09:50.0760166Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-6f547 failed. Retrying in 30s.2026-10-22T02:10:20.0765136Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:10:20Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh exec test-cm-7f9d786cd6-6f547 -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:10:20.2204071Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:10:20Z logger.go:67: command terminated with exit code 12026-10-22T02:10:20.2237041Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-6f547 failed. Retrying in 30s.2026-10-22T02:10:50.2242482Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:10:50Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh exec test-cm-7f9d786cd6-6f547 -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:10:50.3778574Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:10:50Z logger.go:67: command terminated with exit code 12026-10-22T02:10:50.3808904Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-6f547 failed. Retrying in 30s.2026-10-22T02:11:20.3853598Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:11:20Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh exec test-cm-7f9d786cd6-6f547 -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:11:20.5341102Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:11:20Z logger.go:67: command terminated with exit code 12026-10-22T02:11:20.5373633Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-6f547 failed. Retrying in 30s.2026-10-22T02:11:50.5408318Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:11:50Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh exec test-cm-7f9d786cd6-6f547 -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:11:50.6944678Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:11:50Z logger.go:67: command terminated with exit code 12026-10-22T02:11:50.6976995Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-6f547 failed. Retrying in 30s.2026-10-22T02:12:20.7028748Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:12:20Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh exec test-cm-7f9d786cd6-6f547 -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:12:20.8514475Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:12:20Z logger.go:67: command terminated with exit code 12026-10-22T02:12:20.8545040Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-6f547 failed. Retrying in 30s.2026-10-22T02:12:50.8550511Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:12:50Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh exec test-cm-7f9d786cd6-6f547 -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:12:51.0000961Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:12:50Z logger.go:67: command terminated with exit code 12026-10-22T02:12:51.0035175Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-6f547 failed. Retrying in 30s.2026-10-22T02:13:21.0037965Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:13:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh exec test-cm-7f9d786cd6-6f547 -- sh -c /tmp/has_cvmfs.sh]2026-10-22T02:13:21.1503229Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-22T02:13:21Z logger.go:67: command terminated with exit code 12026-10-22T02:13:21.1540970Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-6f547 failed. Retrying in 30s.2026-10-22T02:13:51.1553214Z test_utils.go:105: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-6f547 did not succeed within {10 30000000000} retries2026-10-22T02:13:51.1554908Z TestOSPoolEP 2026-10-22T02:13:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:51.1642067Z TestOSPoolEP 2026-10-22T02:13:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:51.3213569Z TestOSPoolEP 2026-10-22T02:13:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:51.4508888Z TestOSPoolEP 2026-10-22T02:13:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:51.5658814Z TestOSPoolEP 2026-10-22T02:13:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:51.7281183Z TestOSPoolEP 2026-10-22T02:13:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:51.8464274Z TestOSPoolEP 2026-10-22T02:13:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:51.8492714Z === NAME TestOSPoolEP2026-10-22T02:13:51.8493519Z ospool_ep_test.go:72: ---2026-10-22T02:13:51.8494263Z Events for pod cvmfs-nodeplugin-5cd89c7cfd-sgfxq:2026-10-22T02:13:51.8496242Z 2026-10-22 02:07:57 +0000 UTC Normal Successfully assigned test-ospool-ep-6tj7nh/cvmfs-nodeplugin-5cd89c7cfd-sgfxq to minikube2026-10-22T02:13:51.8497844Z 2026-10-22 02:07:57 +0000 UTC Normal Pulling image "opensciencegrid/cvmfs-nodeplugin:fresh"2026-10-22T02:13:51.8501636Z 2026-10-22 02:08:02 +0000 UTC Normal Successfully pulled image "opensciencegrid/cvmfs-nodeplugin:fresh" in 5.162s (5.162s including waiting). Image size: 155940803 bytes.2026-10-22T02:13:51.8504149Z 2026-10-22 02:08:03 +0000 UTC Normal Container created2026-10-22T02:13:51.8504995Z 2026-10-22 02:08:03 +0000 UTC Normal Container started2026-10-22T02:13:51.8505608Z 2026-10-22T02:13:51.8506240Z ---2026-10-22T02:13:51.8507251Z TestOSPoolEP 2026-10-22T02:13:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:51.8520853Z ospool_ep_test.go:72: ---2026-10-22T02:13:51.8521821Z Events for pod frontier-squid-65f85c968-xjbpx:2026-10-22T02:13:51.8523688Z 2026-10-22 02:07:57 +0000 UTC Normal Successfully assigned test-ospool-ep-6tj7nh/frontier-squid-65f85c968-xjbpx to minikube2026-10-22T02:13:51.8525170Z 2026-10-22 02:07:57 +0000 UTC Normal Pulling image "opensciencegrid/frontier-squid:fresh"2026-10-22T02:13:51.8527123Z 2026-10-22 02:08:13 +0000 UTC Normal Successfully pulled image "opensciencegrid/frontier-squid:fresh" in 10.3s (15.395s including waiting). Image size: 453187319 bytes.2026-10-22T02:13:51.8528550Z 2026-10-22 02:08:13 +0000 UTC Normal Container created2026-10-22T02:13:51.8529357Z 2026-10-22 02:08:13 +0000 UTC Normal Container started2026-10-22T02:13:51.8529883Z 2026-10-22T02:13:51.8530222Z ---2026-10-22T02:13:51.8531141Z TestOSPoolEP 2026-10-22T02:13:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:51.8548040Z ospool_ep_test.go:72: ---2026-10-22T02:13:51.8548899Z Events for pod idtoken-generator:2026-10-22T02:13:51.8550252Z 2026-10-22 02:07:46 +0000 UTC Normal Successfully assigned test-ospool-ep-6tj7nh/idtoken-generator to minikube2026-10-22T02:13:51.8551530Z 2026-10-22 02:07:46 +0000 UTC Normal Pulling image "htcondor/base"2026-10-22T02:13:51.8553496Z 2026-10-22 02:07:52 +0000 UTC Normal Successfully pulled image "htcondor/base" in 5.718s (5.718s including waiting). Image size: 196303183 bytes.2026-10-22T02:13:51.8554834Z 2026-10-22 02:07:52 +0000 UTC Normal Container created2026-10-22T02:13:51.8555649Z 2026-10-22 02:07:52 +0000 UTC Normal Container started2026-10-22T02:13:51.8556237Z 2026-10-22T02:13:51.8556578Z ---2026-10-22T02:13:51.8557571Z TestOSPoolEP 2026-10-22T02:13:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:51.8576622Z ospool_ep_test.go:72: ---2026-10-22T02:13:51.8577352Z Events for pod ospool-ep-cc75b66b9-tl8fm:2026-10-22T02:13:51.8578598Z 2026-10-22 02:07:57 +0000 UTC Normal Successfully assigned test-ospool-ep-6tj7nh/ospool-ep-cc75b66b9-tl8fm to minikube2026-10-22T02:13:51.8579853Z 2026-10-22 02:07:57 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-10-22T02:13:51.8581675Z 2026-10-22 02:08:14 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.36s (16.709s including waiting). Image size: 2893600 bytes.2026-10-22T02:13:51.8583841Z 2026-10-22 02:08:14 +0000 UTC Normal Container created2026-10-22T02:13:51.8587506Z 2026-10-22 02:08:14 +0000 UTC Normal Container started2026-10-22T02:13:51.8588829Z 2026-10-22 02:08:15 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-10-22T02:13:51.8591208Z 2026-10-22 02:08:31 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 12.032s (15.211s including waiting). Image size: 537931704 bytes.2026-10-22T02:13:51.8593468Z 2026-10-22 02:08:31 +0000 UTC Normal Container created2026-10-22T02:13:51.8620954Z 2026-10-22 02:08:31 +0000 UTC Normal Container started2026-10-22T02:13:51.8621572Z 2026-10-22T02:13:51.8622174Z ---2026-10-22T02:13:51.8623222Z TestOSPoolEP 2026-10-22T02:13:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:51.8635211Z ospool_ep_test.go:72: ---2026-10-22T02:13:51.8640966Z Events for pod test-cm-7f9d786cd6-6f547:2026-10-22T02:13:51.8643113Z 2026-10-22 02:07:57 +0000 UTC Normal Successfully assigned test-ospool-ep-6tj7nh/test-cm-7f9d786cd6-6f547 to minikube2026-10-22T02:13:51.8644418Z 2026-10-22 02:07:57 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-10-22T02:13:51.8646124Z 2026-10-22 02:08:19 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 4.491s (21.165s including waiting). Image size: 198153089 bytes.2026-10-22T02:13:51.8647410Z 2026-10-22 02:08:19 +0000 UTC Normal Container created2026-10-22T02:13:51.8648207Z 2026-10-22 02:08:19 +0000 UTC Normal Container started2026-10-22T02:13:51.8648726Z 2026-10-22T02:13:51.8649068Z ---2026-10-22T02:13:51.8649995Z TestOSPoolEP 2026-10-22T02:13:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-22T02:13:51.8679442Z TestOSPoolEP 2026-10-22T02:13:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh delete -f /tmp/TestOSPoolEP1944251925]2026-10-22T02:13:51.9688003Z TestOSPoolEP 2026-10-22T02:13:51Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-6tj7nh namespace2026-10-22T02:13:51.9743501Z TestOSPoolEP 2026-10-22T02:13:51Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-6tj7nh namespace2026-10-22T02:13:53.6990345Z TestOSPoolEP 2026-10-22T02:13:53Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh delete -f /tmp/TestOSPoolEP2101363200]2026-10-22T02:13:53.8360687Z TestOSPoolEP 2026-10-22T02:13:53Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-6tj7nh namespace2026-10-22T02:13:53.8419670Z TestOSPoolEP 2026-10-22T02:13:53Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-6tj7nh delete -k /tmp/kustomize-template-1302007275]2026-10-22T02:13:53.9685003Z TestOSPoolEP 2026-10-22T02:13:53Z logger.go:67: serviceaccount "cvmfs-nodeplugin" deleted from test-ospool-ep-6tj7nh namespace2026-10-22T02:13:53.9760204Z TestOSPoolEP 2026-10-22T02:13:53Z logger.go:67: service "frontier-squid" deleted from test-ospool-ep-6tj7nh namespace2026-10-22T02:13:53.9910799Z TestOSPoolEP 2026-10-22T02:13:53Z logger.go:67: service "test-cm" deleted from test-ospool-ep-6tj7nh namespace2026-10-22T02:13:53.9958693Z TestOSPoolEP 2026-10-22T02:13:53Z logger.go:67: deployment.apps "cvmfs-nodeplugin" deleted from test-ospool-ep-6tj7nh namespace2026-10-22T02:13:54.0014132Z TestOSPoolEP 2026-10-22T02:13:54Z logger.go:67: deployment.apps "frontier-squid" deleted from test-ospool-ep-6tj7nh namespace2026-10-22T02:13:54.0093039Z TestOSPoolEP 2026-10-22T02:13:54Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-6tj7nh namespace2026-10-22T02:13:54.0185243Z TestOSPoolEP 2026-10-22T02:13:54Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-6tj7nh namespace2026-10-22T02:13:54.0624049Z --- FAIL: TestOSPoolEP (368.61s)2026-10-22T02:13:54.0625726Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (40.05s)2026-10-22T02:13:54.0626774Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP (11.21s)2026-10-22T02:13:54.0627796Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity (0.55s)2026-10-22T02:13:54.0628876Z --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (301.93s)2026-10-22T02:13:54.0629831Z FAIL2026-10-22T02:13:54.0662920Z FAIL github.com/osg-htc/k8s-integration-tests/test 368.630s2026-10-22T02:13:54.0798007Z FAIL2026-10-22T02:13:54.2505684Z ##[error]Process completed with exit code 1.2026-10-22T02:13:54.2575635Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-22T02:13:54.2577060Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-10-22T02:13:54.2616563Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-22T02:13:54.2617426Z env:2026-10-22T02:13:54.2618076Z GOTOOLCHAIN: local2026-10-22T02:13:54.2619002Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-22T02:13:54.2683907Z ##[endgroup]2026-10-22T02:13:54.2906881Z ##[group]Run actions/upload-artifact@v42026-10-22T02:13:54.2907777Z with:2026-10-22T02:13:54.2908787Z name: TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f02026-10-22T02:13:54.2909877Z path: /tmp/k8s-tests2026-10-22T02:13:54.2910291Z retention-days: 52026-10-22T02:13:54.2910682Z if-no-files-found: warn2026-10-22T02:13:54.2911367Z compression-level: 62026-10-22T02:13:54.2911840Z overwrite: false2026-10-22T02:13:54.2912546Z include-hidden-files: false2026-10-22T02:13:54.2912940Z env:2026-10-22T02:13:54.2913616Z GOTOOLCHAIN: local2026-10-22T02:13:54.2914021Z ##[endgroup]2026-10-22T02:13:54.4665928Z (node:16121) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-22T02:13:54.4667621Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-22T02:13:54.4768899Z With the provided path, there will be 10 files uploaded2026-10-22T02:13:54.4774108Z Artifact name is valid!2026-10-22T02:13:54.4776587Z Root directory input is valid!2026-10-22T02:13:54.7381210Z Beginning upload of artifact content to blob storage2026-10-22T02:13:54.7845758Z (node:16121) [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-22T02:13:54.9233900Z Uploaded bytes 160122026-10-22T02:13:54.9608187Z Finished uploading artifact content to blob storage!2026-10-22T02:13:54.9609558Z SHA256 digest of uploaded artifact zip is 4d143ed25659bbb4d9d3a18d7d3abbcd9c1caf0bb680c7ce2d87db304b75d6d22026-10-22T02:13:54.9610860Z Finalizing artifact upload2026-10-22T02:13:55.4223346Z Artifact TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f0.zip successfully finalized. Artifact ID 123962098872026-10-22T02:13:55.4225666Z Artifact TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f0 has been successfully uploaded! Final size is 16012 bytes. Artifact ID is 123962098872026-10-22T02:13:55.4231153Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/39709501354/artifacts/123962098872026-10-22T02:13:55.4444365Z Post job cleanup.2026-10-22T02:13:55.5335986Z [command]/usr/bin/git version2026-10-22T02:13:55.5384795Z git version 2.55.02026-10-22T02:13:55.5430522Z Temporarily overriding HOME='/home/runner/work/_temp/be21ceb3-25ff-4765-a72b-4ebe23a4c3f9' before making global git config changes2026-10-22T02:13:55.5432275Z Adding repository directory to the temporary git global config as a safe directory2026-10-22T02:13:55.5436505Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-22T02:13:55.5478344Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-22T02:13:55.5516707Z [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-22T02:13:55.5839701Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-22T02:13:55.5867756Z http.https://github.com/.extraheader2026-10-22T02:13:55.5880496Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-10-22T02:13:55.5920645Z [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-22T02:13:55.6218240Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-22T02:13:55.6293125Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-22T02:13:55.6857429Z Cleaning up orphan processes2026-10-22T02:13:55.7897366Z ##[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/