All Test Logs

2026-10-26T01:57:53.2799610Z Current runner version: '2.338.0'2026-10-26T01:57:53.2815646Z ##[group]Runner Image Provisioner2026-10-26T01:57:53.2816268Z Hosted Compute Agent2026-10-26T01:57:53.2816727Z Version: 20261021.6182026-10-26T01:57:53.2817152Z Commit: 21505ad2541d5be6135ed84fc33697146cf75b8e2026-10-26T01:57:53.2817859Z Build Date: 2026-10-21T00:45:21Z2026-10-26T01:57:53.2818405Z Worker ID: {00444b7d-a168-41bf-b45c-82d4cd3a3fb5}2026-10-26T01:57:53.2818884Z Region: centralus2026-10-26T01:57:53.2819310Z Cloud: Azure2026-10-26T01:57:53.2819674Z ##[endgroup]2026-10-26T01:57:53.2820646Z ##[group]Operating System2026-10-26T01:57:53.2821090Z Ubuntu2026-10-26T01:57:53.2821446Z 22.04.52026-10-26T01:57:53.2821817Z LTS2026-10-26T01:57:53.2822176Z ##[endgroup]2026-10-26T01:57:53.2822534Z ##[group]Runner Image2026-10-26T01:57:53.2822976Z Image: ubuntu-22.042026-10-26T01:57:53.2823355Z Version: 20261012.322.12026-10-26T01:57:53.2824239Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20261012.322/images/ubuntu/Ubuntu2204-Readme.md2026-10-26T01:57:53.2825293Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20261012.3222026-10-26T01:57:53.2825973Z ##[endgroup]2026-10-26T01:57:53.2828393Z ##[group]GITHUB_TOKEN Permissions2026-10-26T01:57:53.2830245Z Actions: write2026-10-26T01:57:53.2830640Z ArtifactMetadata: write2026-10-26T01:57:53.2831080Z Attestations: write2026-10-26T01:57:53.2831461Z Checks: write2026-10-26T01:57:53.2831820Z CodeQuality: write2026-10-26T01:57:53.2832264Z Contents: write2026-10-26T01:57:53.2832640Z CopilotRequests: write2026-10-26T01:57:53.2833066Z Deployments: write2026-10-26T01:57:53.2833437Z Discussions: write2026-10-26T01:57:53.2833806Z Drives: write2026-10-26T01:57:53.2834200Z Issues: write2026-10-26T01:57:53.2834613Z Metadata: read2026-10-26T01:57:53.2834982Z Models: read2026-10-26T01:57:53.2835354Z Packages: write2026-10-26T01:57:53.2835787Z Pages: write2026-10-26T01:57:53.2836207Z PullRequests: write2026-10-26T01:57:53.2836619Z RepositoryProjects: write2026-10-26T01:57:53.2837029Z SecurityEvents: write2026-10-26T01:57:53.2837431Z Statuses: write2026-10-26T01:57:53.2838110Z VulnerabilityAlerts: read2026-10-26T01:57:53.2838550Z ##[endgroup]2026-10-26T01:57:53.2840090Z Secret source: Actions2026-10-26T01:57:53.2840734Z Cache mode: write2026-10-26T01:57:53.2841201Z Prepare workflow directory2026-10-26T01:57:53.3090550Z Prepare all required actions2026-10-26T01:57:53.3124375Z Getting action download info2026-10-26T01:57:53.5766352Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-10-26T01:57:53.6763581Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-10-26T01:57:54.0083799Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-10-26T01:57:54.4501955Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-10-26T01:57:54.6634762Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (63ec080e4eea87fb8a9eae678ab9944ec2461251)2026-10-26T01:57:54.6639308Z ##[group] Inputs2026-10-26T01:57:54.6640122Z   testName: TestOSPoolEP2026-10-26T01:57:54.6641496Z   testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-26T01:57:54.6642898Z   setupScript: 2026-10-26T01:57:54.6643615Z   setupEnv: {}2026-10-26T01:57:54.6644317Z ##[endgroup]2026-10-26T01:57:54.6645387Z Complete job name: ospool-ep / Run OSPool EP test (cvmfs-bind, 25-testing) / Run Tests2026-10-26T01:57:54.7257160Z ##[group]Run actions/checkout@v52026-10-26T01:57:54.7258432Z with:2026-10-26T01:57:54.7259145Z   repository: osg-htc/k8s-integration-tests2026-10-26T01:57:54.7264428Z   token: ***2026-10-26T01:57:54.7265090Z   ssh-strict: true2026-10-26T01:57:54.7265744Z   ssh-user: git2026-10-26T01:57:54.7266454Z   persist-credentials: true2026-10-26T01:57:54.7267214Z   clean: true2026-10-26T01:57:54.7268194Z   sparse-checkout-cone-mode: true2026-10-26T01:57:54.7269111Z   fetch-depth: 12026-10-26T01:57:54.7269762Z   fetch-tags: false2026-10-26T01:57:54.7270472Z   show-progress: true2026-10-26T01:57:54.7271187Z   lfs: false2026-10-26T01:57:54.7271876Z   submodules: false2026-10-26T01:57:54.7272567Z   set-safe-directory: true2026-10-26T01:57:54.7273332Z   allow-unsafe-pr-checkout: false2026-10-26T01:57:54.7274655Z ##[endgroup]2026-10-26T01:57:54.8023942Z Syncing repository: osg-htc/k8s-integration-tests2026-10-26T01:57:54.8026850Z ##[group]Getting Git version info2026-10-26T01:57:54.8028910Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-26T01:57:54.8031490Z [command]/usr/bin/git version2026-10-26T01:57:54.8052323Z git version 2.55.02026-10-26T01:57:54.8066775Z ##[endgroup]2026-10-26T01:57:54.8078296Z Temporarily overriding HOME='/home/runner/work/_temp/76acb250-8d24-490b-831c-f21753117dd5' before making global git config changes2026-10-26T01:57:54.8081087Z Adding repository directory to the temporary git global config as a safe directory2026-10-26T01:57:54.8083594Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-26T01:57:54.8106029Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-26T01:57:54.8110725Z ##[group]Initializing the repository2026-10-26T01:57:54.8116205Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-26T01:57:54.8194163Z hint: Using 'master' as the name for the initial branch. This default branch name2026-10-26T01:57:54.8196453Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-10-26T01:57:54.8198864Z hint: to use in all of your new repositories, which will suppress this warning,2026-10-26T01:57:54.8200550Z hint: call:2026-10-26T01:57:54.8201528Z hint:2026-10-26T01:57:54.8202457Z hint: 	git config --global init.defaultBranch <name>2026-10-26T01:57:54.8203443Z hint:2026-10-26T01:57:54.8204398Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-10-26T01:57:54.8206048Z hint: 'development'. The just-created branch can be renamed via this command:2026-10-26T01:57:54.8207511Z hint:2026-10-26T01:57:54.8208715Z hint: 	git branch -m <name>2026-10-26T01:57:54.8209748Z hint:2026-10-26T01:57:54.8211041Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-10-26T01:57:54.8213430Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-10-26T01:57:54.8217371Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-10-26T01:57:54.8236169Z ##[endgroup]2026-10-26T01:57:54.8237311Z ##[group]Disabling automatic garbage collection2026-10-26T01:57:54.8239861Z [command]/usr/bin/git config --local gc.auto 02026-10-26T01:57:54.8267180Z ##[endgroup]2026-10-26T01:57:54.8269323Z ##[group]Setting up auth2026-10-26T01:57:54.8271703Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-26T01:57:54.8298345Z [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-26T01:57:54.8560213Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-26T01:57:54.8588547Z [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-26T01:57:54.8740821Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-26T01:57:54.8761293Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-26T01:57:54.8897884Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-10-26T01:57:54.8928416Z ##[endgroup]2026-10-26T01:57:54.8929951Z ##[group]Fetching the repository2026-10-26T01:57:54.8935384Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +63ec080e4eea87fb8a9eae678ab9944ec2461251:refs/remotes/origin/main2026-10-26T01:57:55.2798702Z From https://github.com/osg-htc/k8s-integration-tests2026-10-26T01:57:55.2799215Z  * [new ref]         63ec080e4eea87fb8a9eae678ab9944ec2461251 -> origin/main2026-10-26T01:57:55.2801590Z ##[endgroup]2026-10-26T01:57:55.2802084Z ##[group]Determining the checkout info2026-10-26T01:57:55.2803002Z ##[endgroup]2026-10-26T01:57:55.2806684Z [command]/usr/bin/git sparse-checkout disable2026-10-26T01:57:55.2838968Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-10-26T01:57:55.2860225Z ##[group]Checking out the ref2026-10-26T01:57:55.2863623Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-10-26T01:57:55.2915429Z Switched to a new branch 'main'2026-10-26T01:57:55.2916229Z branch 'main' set up to track 'origin/main'.2026-10-26T01:57:55.2919699Z ##[endgroup]2026-10-26T01:57:55.2943268Z [command]/usr/bin/git log -1 --format=%H2026-10-26T01:57:55.2959609Z 63ec080e4eea87fb8a9eae678ab9944ec24612512026-10-26T01:57:55.3180989Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-26T01:57:55.3181949Z echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-26T01:57:55.3182743Z echo "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-26T01:57:55.3453076Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-26T01:57:55.3453629Z env:2026-10-26T01:57:55.3454126Z   TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-26T01:57:55.3454646Z   SETUP_ENV_YAML: {}2026-10-26T01:57:55.3454972Z ##[endgroup]2026-10-26T01:57:55.6401542Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-26T01:57:55.6402179Z echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-26T01:57:55.6436091Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-26T01:57:55.6436501Z env:2026-10-26T01:57:55.6436956Z   TEST_ENV: {  "OSPOOL_EP_OSPoolEPTag": "25-testing",  "OSPOOL_EP_CMTag": "25.x-el9",  "OSPOOL_EP_CvmfsType": "cvmfs-bind"}2026-10-26T01:57:55.6437489Z ##[endgroup]2026-10-26T01:57:55.6538000Z ##[group]Run true2026-10-26T01:57:55.6538384Z true2026-10-26T01:57:55.6568615Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-26T01:57:55.6569041Z ##[endgroup]2026-10-26T01:57:55.6694497Z ##[group]Run medyagh/setup-minikube@latest2026-10-26T01:57:55.6694907Z with:2026-10-26T01:57:55.6695249Z   start: true2026-10-26T01:57:55.6695573Z   cache: true2026-10-26T01:57:55.6695937Z   minikube-version: latest2026-10-26T01:57:55.6696281Z   wait: all2026-10-26T01:57:55.6696577Z ##[endgroup]2026-10-26T01:57:55.7578773Z (node:1949) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-26T01:57:55.7580393Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-26T01:57:56.7524610Z [command]/usr/bin/chmod +x /home/runner/work/_temp/e3e9ddab-07c3-43f6-878a-f54613c13f592026-10-26T01:57:57.3884391Z [command]/home/runner/bin/minikube version --short2026-10-26T01:57:57.4870701Z v1.39.02026-10-26T01:57:57.6251741Z Cache hit for: kic-v1.39.0-x642026-10-26T01:57:57.6325339Z (node:1949) [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-26T01:57:57.6330919Z Cache hit for: preloaded-tarball-v1.39.0-x64-stable-docker2026-10-26T01:57:58.7974524Z Received 134217728 of 531630645 (25.2%), 124.3 MBs/sec2026-10-26T01:57:58.7988942Z Received 121634816 of 288577004 (42.1%), 114.2 MBs/sec2026-10-26T01:57:59.7968896Z Received 335544320 of 531630645 (63.1%), 157.6 MBs/sec2026-10-26T01:57:59.7969435Z Received 268435456 of 288577004 (93.0%), 127.0 MBs/sec2026-10-26T01:57:59.9467503Z Received 288577004 of 288577004 (100.0%), 127.1 MBs/sec2026-10-26T01:57:59.9468155Z Cache Size: ~275 MB (288577004 B)2026-10-26T01:57:59.9605605Z [command]/usr/bin/tar -xf /home/runner/work/_temp/821711ed-8eac-48bf-8c6a-efd5890969fd/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-26T01:58:00.5481590Z Cache restored successfully2026-10-26T01:58:00.7435079Z Received 531630645 of 531630645 (100.0%), 170.3 MBs/sec2026-10-26T01:58:00.7435610Z Cache Size: ~507 MB (531630645 B)2026-10-26T01:58:00.7492334Z [command]/usr/bin/tar -xf /home/runner/work/_temp/a2b3e0ff-2fa9-4bed-b828-917ed4978c1f/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-26T01:58:01.2277193Z Cache restored successfully2026-10-26T01:58:01.2816523Z [command]/home/runner/bin/minikube start --wait all2026-10-26T01:58:01.3179824Z * minikube v1.39.0 on Ubuntu 22.042026-10-26T01:58:03.1948772Z ! 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-26T01:58:03.1956355Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-10-26T01:58:03.2321069Z * Using Docker driver with root privileges2026-10-26T01:58:03.2334073Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-10-26T01:58:03.2342140Z * Pulling base image v0.0.51 ...2026-10-26T01:58:27.1714315Z * Preparing Kubernetes v1.37.0 on containerd 2.3.4 ...2026-10-26T01:58:33.7144721Z * Configuring CNI (Container Networking Interface) ...2026-10-26T01:58:39.4459184Z * Verifying Kubernetes components...2026-10-26T01:58:39.4653066Z   - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-10-26T01:58:39.7775553Z * Enabled addons: storage-provisioner, default-storageclass2026-10-26T01:58:56.6412801Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-10-26T01:58:56.6489075Z [command]/home/runner/bin/minikube version --short2026-10-26T01:58:56.6821283Z v1.39.02026-10-26T01:58:56.7058382Z ##[group]Run actions/setup-go@v62026-10-26T01:58:56.7058673Z with:2026-10-26T01:58:56.7058903Z   go-version: 1.262026-10-26T01:58:56.7059132Z   cache: true2026-10-26T01:58:56.7059394Z   cache-dependency-path: go.sum2026-10-26T01:58:56.7059682Z   check-latest: false2026-10-26T01:58:56.7061277Z   token: ***2026-10-26T01:58:56.7061529Z ##[endgroup]2026-10-26T01:58:56.7958803Z Setup go version spec 1.262026-10-26T01:58:56.8239094Z Found in cache @ /opt/hostedtoolcache/go/1.26.9/x642026-10-26T01:58:56.8240764Z Added go to the path2026-10-26T01:58:56.8242976Z Successfully set up Go version 1.262026-10-26T01:58:57.2193882Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOMODCACHE2026-10-26T01:58:57.2224019Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOCACHE2026-10-26T01:58:57.2241347Z /home/runner/go/pkg/mod2026-10-26T01:58:57.2255770Z /home/runner/.cache/go-build2026-10-26T01:58:57.3576788Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-26T01:58:58.5020027Z Received 100663296 of 249167808 (40.4%), 95.9 MBs/sec2026-10-26T01:58:59.4985024Z Received 244973504 of 249167808 (98.3%), 116.8 MBs/sec2026-10-26T01:58:59.8377456Z Received 249167808 of 249167808 (100.0%), 101.5 MBs/sec2026-10-26T01:58:59.8378398Z Cache Size: ~238 MB (249167808 B)2026-10-26T01:58:59.8404270Z [command]/usr/bin/tar -xf /home/runner/work/_temp/848c3e1f-b691-4d10-919d-d6f29b492421/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-26T01:59:01.2527410Z Cache restored successfully2026-10-26T01:59:01.2776417Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-26T01:59:01.2801013Z go version go1.26.9 linux/amd642026-10-26T01:59:01.2801319Z 2026-10-26T01:59:01.2801773Z ##[group]go env2026-10-26T01:59:01.2981898Z AR='ar'2026-10-26T01:59:01.2982375Z CC='gcc'2026-10-26T01:59:01.2985620Z CGO_CFLAGS='-O2 -g'2026-10-26T01:59:01.2986213Z CGO_CPPFLAGS=''2026-10-26T01:59:01.2986715Z CGO_CXXFLAGS='-O2 -g'2026-10-26T01:59:01.2987160Z CGO_ENABLED='1'2026-10-26T01:59:01.2987454Z CGO_FFLAGS='-O2 -g'2026-10-26T01:59:01.2987958Z CGO_LDFLAGS='-O2 -g'2026-10-26T01:59:01.2988222Z CXX='g++'2026-10-26T01:59:01.2988457Z GCCGO='gccgo'2026-10-26T01:59:01.2988778Z GO111MODULE=''2026-10-26T01:59:01.2989155Z GOAMD64='v1'2026-10-26T01:59:01.2989476Z GOARCH='amd64'2026-10-26T01:59:01.2989760Z GOAUTH='netrc'2026-10-26T01:59:01.2990023Z GOBIN=''2026-10-26T01:59:01.2990349Z GOCACHE='/home/runner/.cache/go-build'2026-10-26T01:59:01.2990718Z GOCACHEPROG=''2026-10-26T01:59:01.2991035Z GODEBUG=''2026-10-26T01:59:01.2991357Z GOENV='/home/runner/.config/go/env'2026-10-26T01:59:01.2991744Z GOEXE=''2026-10-26T01:59:01.2992017Z GOEXPERIMENT=''2026-10-26T01:59:01.2992369Z GOFIPS140='off'2026-10-26T01:59:01.2992638Z GOFLAGS=''2026-10-26T01:59:01.2993442Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build2399445616=/tmp/go-build -gno-record-gcc-switches'2026-10-26T01:59:01.2994149Z GOHOSTARCH='amd64'2026-10-26T01:59:01.2994437Z GOHOSTOS='linux'2026-10-26T01:59:01.2994722Z GOINSECURE=''2026-10-26T01:59:01.2995123Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-10-26T01:59:01.2995619Z GOMODCACHE='/home/runner/go/pkg/mod'2026-10-26T01:59:01.2995953Z GONOPROXY=''2026-10-26T01:59:01.2996273Z GONOSUMDB=''2026-10-26T01:59:01.2996546Z GOOS='linux'2026-10-26T01:59:01.2996872Z GOPATH='/home/runner/go'2026-10-26T01:59:01.2997180Z GOPRIVATE=''2026-10-26T01:59:01.2997555Z GOPROXY='https://proxy.golang.org,direct'2026-10-26T01:59:01.2998150Z GOROOT='/opt/hostedtoolcache/go/1.26.9/x64'2026-10-26T01:59:01.2998555Z GOSUMDB='sum.golang.org'2026-10-26T01:59:01.2998874Z GOTELEMETRY='local'2026-10-26T01:59:01.2999149Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-10-26T01:59:01.2999480Z GOTMPDIR=''2026-10-26T01:59:01.2999854Z GOTOOLCHAIN='local'2026-10-26T01:59:01.3000206Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.9/x64/pkg/tool/linux_amd64'2026-10-26T01:59:01.3000515Z GOVCS=''2026-10-26T01:59:01.3000777Z GOVERSION='go1.26.9'2026-10-26T01:59:01.3000996Z GOWORK=''2026-10-26T01:59:01.3001242Z PKG_CONFIG='pkg-config'2026-10-26T01:59:01.3001392Z 2026-10-26T01:59:01.3001742Z ##[endgroup]2026-10-26T01:59:01.3195976Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-26T01:59:01.3196433Z go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-26T01:59:01.3230925Z shell: /usr/bin/bash -e {0}2026-10-26T01:59:01.3231310Z env:2026-10-26T01:59:01.3231560Z   GOTOOLCHAIN: local2026-10-26T01:59:01.3231836Z   OSPOOL_EP_OSPoolEPTag: 25-testing2026-10-26T01:59:01.3232152Z   OSPOOL_EP_CMTag: 25.x-el92026-10-26T01:59:01.3232454Z   OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-26T01:59:01.3232726Z ##[endgroup]2026-10-26T01:59:06.8726400Z === RUN   TestOSPoolEP2026-10-26T01:59:06.8728241Z === PAUSE TestOSPoolEP2026-10-26T01:59:06.8728762Z === CONT  TestOSPoolEP2026-10-26T01:59:06.8729430Z TestOSPoolEP 2026-10-26T01:59:06Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:06.8825991Z TestOSPoolEP 2026-10-26T01:59:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv apply -f /tmp/TestOSPoolEP2234624091]2026-10-26T01:59:07.1802469Z TestOSPoolEP 2026-10-26T01:59:07Z logger.go:67: pod/idtoken-generator created2026-10-26T01:59:07.1949502Z TestOSPoolEP 2026-10-26T01:59:07Z logger.go:67: secret/pool-passwd created2026-10-26T01:59:07.1981131Z TestOSPoolEP 2026-10-26T01:59:07Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-26T01:59:07.1982783Z TestOSPoolEP 2026-10-26T01:59:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:07.2036005Z TestOSPoolEP 2026-10-26T01:59:07Z 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-26T01:59:17.2040878Z TestOSPoolEP 2026-10-26T01:59:17Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-26T01:59:17.2042174Z TestOSPoolEP 2026-10-26T01:59:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:17.2065772Z TestOSPoolEP 2026-10-26T01:59:17Z logger.go:67: Pod is now available2026-10-26T01:59:17.2067148Z TestOSPoolEP 2026-10-26T01:59:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-10-26T01:59:17.5384257Z TestOSPoolEP 2026-10-26T01:59:17Z logger.go:67: ***2026-10-26T01:59:17.5424316Z TestOSPoolEP 2026-10-26T01:59:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv apply -f /tmp/TestOSPoolEP2958416372]2026-10-26T01:59:17.6831076Z TestOSPoolEP 2026-10-26T01:59:17Z logger.go:67: secret/pool-token created2026-10-26T01:59:17.6847603Z TestOSPoolEP 2026-10-26T01:59:17Z retry.go:91: Wait for secret pool-token to be provisioned.2026-10-26T01:59:17.6848568Z TestOSPoolEP 2026-10-26T01:59:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:17.6883987Z TestOSPoolEP 2026-10-26T01:59:17Z logger.go:67: Secret is now available2026-10-26T01:59:17.6893988Z TestOSPoolEP 2026-10-26T01:59:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv apply -k /tmp/kustomize-template-1024558233]2026-10-26T01:59:17.9378603Z TestOSPoolEP 2026-10-26T01:59:17Z logger.go:67: serviceaccount/cvmfs-nodeplugin created2026-10-26T01:59:17.9456716Z TestOSPoolEP 2026-10-26T01:59:17Z logger.go:67: service/frontier-squid created2026-10-26T01:59:17.9547214Z TestOSPoolEP 2026-10-26T01:59:17Z logger.go:67: service/test-cm created2026-10-26T01:59:17.9636785Z TestOSPoolEP 2026-10-26T01:59:17Z logger.go:67: deployment.apps/cvmfs-nodeplugin created2026-10-26T01:59:17.9697883Z TestOSPoolEP 2026-10-26T01:59:17Z logger.go:67: deployment.apps/frontier-squid created2026-10-26T01:59:17.9849975Z TestOSPoolEP 2026-10-26T01:59:17Z 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-26T01:59:17.9852931Z TestOSPoolEP 2026-10-26T01:59:17Z logger.go:67: deployment.apps/ospool-ep created2026-10-26T01:59:17.9950415Z TestOSPoolEP 2026-10-26T01:59:17Z logger.go:67: deployment.apps/test-cm created2026-10-26T01:59:17.9999815Z === RUN   TestOSPoolEP/Confirm_deployments_become_ready.2026-10-26T01:59:18.0001394Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:18.0107184Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:18Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-26T01:59:18.0124720Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:18Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:18.0126871Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:18Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-26T01:59:18.0129038Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:18Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:18.0130675Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:18Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-26T01:59:18.0132052Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:18Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:18.0133582Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:18Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-26T01:59:18.0135016Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:18Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:18.0188078Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:18Z 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-26T01:59:18.0195001Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:18Z 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-26T01:59:18.0198691Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:18Z 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-26T01:59:18.0202073Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:18Z 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-26T01:59:28.0201298Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:28Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-26T01:59:28.0205757Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:28.0207065Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:28Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-26T01:59:28.0228470Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:28.0229650Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:28Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-26T01:59:28.0230778Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:28.0231910Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:28Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-26T01:59:28.0233037Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:28.0257775Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:28Z 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-26T01:59:28.0267204Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:28Z 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-26T01:59:28.0269994Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:28Z 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-26T01:59:28.0271852Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:28Z logger.go:67: Deployment is now available2026-10-26T01:59:38.0260662Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:38Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-26T01:59:38.0261485Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:38Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:38.0269540Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:38Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-26T01:59:38.0271059Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:38Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:38.0272492Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:38Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-26T01:59:38.0273677Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:38Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:38.0286337Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:38Z logger.go:67: Deployment is now available2026-10-26T01:59:38.0289318Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:38Z logger.go:67: Deployment is now available2026-10-26T01:59:38.0292238Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:38Z 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-26T01:59:48.0300910Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:48Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-26T01:59:48.0301972Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:48Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:48.1439959Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-26T01:59:48Z logger.go:67: Deployment is now available2026-10-26T01:59:48.1440662Z === RUN   TestOSPoolEP/Confirm_condor_status_lists_the_EP2026-10-26T01:59:48.1442342Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-26T01:59:48Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T01:59:48.1463589Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-26T01:59:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv cp ../test-configs/ospool-ep/condor_status.sh test-cm-5886f7986-s9qnh:/tmp/condor_status.sh]2026-10-26T01:59:48.7442824Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-26T01:59:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec test-cm-5886f7986-s9qnh -- chmod +x /tmp/condor_status.sh]2026-10-26T01:59:48.8649586Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-26T01:59:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec test-cm-5886f7986-s9qnh -- sh -c /tmp/condor_status.sh]2026-10-26T01:59:48.9829652Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-26T01:59:48Z logger.go:67: command terminated with exit code 12026-10-26T01:59:48.9842072Z     test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-5886f7986-s9qnh failed. Retrying in 10s.2026-10-26T01:59:58.9861647Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-26T01:59:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec test-cm-5886f7986-s9qnh -- sh -c /tmp/condor_status.sh]2026-10-26T01:59:59.1058497Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-26T01:59:59Z logger.go:67: command terminated with exit code 12026-10-26T01:59:59.1084049Z     test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-5886f7986-s9qnh failed. Retrying in 10s.2026-10-26T02:00:09.1093017Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-26T02:00:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec test-cm-5886f7986-s9qnh -- sh -c /tmp/condor_status.sh]2026-10-26T02:00:09.2136416Z === RUN   TestOSPoolEP/Confirm_EP_container_advertises_singularity2026-10-26T02:00:09.2137507Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-26T02:00:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T02:00:09.2165671Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-26T02:00:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv cp ../test-configs/ospool-ep/has_singularity.sh test-cm-5886f7986-s9qnh:/tmp/has_singularity.sh]2026-10-26T02:00:09.3272858Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-26T02:00:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec test-cm-5886f7986-s9qnh -- chmod +x /tmp/has_singularity.sh]2026-10-26T02:00:09.4173432Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-26T02:00:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec test-cm-5886f7986-s9qnh -- sh -c /tmp/has_singularity.sh]2026-10-26T02:00:09.5169636Z === RUN   TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-10-26T02:00:09.5170622Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:00:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T02:00:09.5188437Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:00:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv cp ../test-configs/ospool-ep/has_cvmfs.sh test-cm-5886f7986-s9qnh:/tmp/has_cvmfs.sh]2026-10-26T02:00:09.6251211Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:00:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec test-cm-5886f7986-s9qnh -- chmod +x /tmp/has_cvmfs.sh]2026-10-26T02:00:09.7102602Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:00:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec test-cm-5886f7986-s9qnh -- sh -c /tmp/has_cvmfs.sh]2026-10-26T02:00:09.8036130Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:00:09Z logger.go:67: command terminated with exit code 12026-10-26T02:00:09.8047293Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-s9qnh failed. Retrying in 30s.2026-10-26T02:00:39.8058522Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:00:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec test-cm-5886f7986-s9qnh -- sh -c /tmp/has_cvmfs.sh]2026-10-26T02:00:39.9102211Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:00:39Z logger.go:67: command terminated with exit code 12026-10-26T02:00:39.9117779Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-s9qnh failed. Retrying in 30s.2026-10-26T02:01:09.9121631Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:01:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec test-cm-5886f7986-s9qnh -- sh -c /tmp/has_cvmfs.sh]2026-10-26T02:01:10.0148533Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:01:10Z logger.go:67: command terminated with exit code 12026-10-26T02:01:10.0165531Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-s9qnh failed. Retrying in 30s.2026-10-26T02:01:40.0176949Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:01:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec test-cm-5886f7986-s9qnh -- sh -c /tmp/has_cvmfs.sh]2026-10-26T02:01:40.1283293Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:01:40Z logger.go:67: command terminated with exit code 12026-10-26T02:01:40.1298740Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-s9qnh failed. Retrying in 30s.2026-10-26T02:02:10.1305052Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:02:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec test-cm-5886f7986-s9qnh -- sh -c /tmp/has_cvmfs.sh]2026-10-26T02:02:10.2365194Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:02:10Z logger.go:67: command terminated with exit code 12026-10-26T02:02:10.2379460Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-s9qnh failed. Retrying in 30s.2026-10-26T02:02:40.2407009Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:02:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec test-cm-5886f7986-s9qnh -- sh -c /tmp/has_cvmfs.sh]2026-10-26T02:02:40.3472145Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:02:40Z logger.go:67: command terminated with exit code 12026-10-26T02:02:40.3491585Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-s9qnh failed. Retrying in 30s.2026-10-26T02:03:10.3493956Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:03:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec test-cm-5886f7986-s9qnh -- sh -c /tmp/has_cvmfs.sh]2026-10-26T02:03:10.4529629Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:03:10Z logger.go:67: command terminated with exit code 12026-10-26T02:03:10.4545696Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-s9qnh failed. Retrying in 30s.2026-10-26T02:03:40.4548831Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:03:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec test-cm-5886f7986-s9qnh -- sh -c /tmp/has_cvmfs.sh]2026-10-26T02:03:40.5557066Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:03:40Z logger.go:67: command terminated with exit code 12026-10-26T02:03:40.5571954Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-s9qnh failed. Retrying in 30s.2026-10-26T02:04:10.5576173Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:04:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec test-cm-5886f7986-s9qnh -- sh -c /tmp/has_cvmfs.sh]2026-10-26T02:04:10.6680905Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:04:10Z logger.go:67: command terminated with exit code 12026-10-26T02:04:10.6695194Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-s9qnh failed. Retrying in 30s.2026-10-26T02:04:40.6697303Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:04:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv exec test-cm-5886f7986-s9qnh -- sh -c /tmp/has_cvmfs.sh]2026-10-26T02:04:40.7790994Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-26T02:04:40Z logger.go:67: command terminated with exit code 12026-10-26T02:04:40.7808738Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-s9qnh failed. Retrying in 30s.2026-10-26T02:05:10.7849028Z     test_utils.go:105: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-s9qnh did not succeed within {10 30000000000} retries2026-10-26T02:05:10.7850115Z TestOSPoolEP 2026-10-26T02:05:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T02:05:10.7914229Z TestOSPoolEP 2026-10-26T02:05:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T02:05:10.8681690Z TestOSPoolEP 2026-10-26T02:05:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T02:05:10.9494589Z TestOSPoolEP 2026-10-26T02:05:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T02:05:11.0259552Z TestOSPoolEP 2026-10-26T02:05:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T02:05:11.1008753Z TestOSPoolEP 2026-10-26T02:05:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T02:05:11.1737143Z TestOSPoolEP 2026-10-26T02:05:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T02:05:11.1758026Z === NAME  TestOSPoolEP2026-10-26T02:05:11.1758612Z     ospool_ep_test.go:72: ---2026-10-26T02:05:11.1759119Z         Events for pod cvmfs-nodeplugin-5cd89c7cfd-zrjq7:2026-10-26T02:05:11.1760080Z         2026-10-26 01:59:17 +0000 UTC	Normal	Successfully assigned test-ospool-ep-4vvhhv/cvmfs-nodeplugin-5cd89c7cfd-zrjq7 to minikube2026-10-26T02:05:11.1760943Z         2026-10-26 01:59:18 +0000 UTC	Normal	Pulling image "opensciencegrid/cvmfs-nodeplugin:fresh"2026-10-26T02:05:11.1762069Z         2026-10-26 01:59:22 +0000 UTC	Normal	Successfully pulled image "opensciencegrid/cvmfs-nodeplugin:fresh" in 4.354s (4.354s including waiting). Image size: 155940803 bytes.2026-10-26T02:05:11.1762908Z         2026-10-26 01:59:22 +0000 UTC	Normal	Container created2026-10-26T02:05:11.1765133Z         2026-10-26 01:59:22 +0000 UTC	Normal	Container started2026-10-26T02:05:11.1765589Z         2026-10-26T02:05:11.1766124Z         ---2026-10-26T02:05:11.1766897Z TestOSPoolEP 2026-10-26T02:05:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T02:05:11.1779950Z     ospool_ep_test.go:72: ---2026-10-26T02:05:11.1780662Z         Events for pod frontier-squid-65f85c968-9k2dq:2026-10-26T02:05:11.1781539Z         2026-10-26 01:59:17 +0000 UTC	Normal	Successfully assigned test-ospool-ep-4vvhhv/frontier-squid-65f85c968-9k2dq to minikube2026-10-26T02:05:11.1782483Z         2026-10-26 01:59:18 +0000 UTC	Normal	Pulling image "opensciencegrid/frontier-squid:fresh"2026-10-26T02:05:11.1783576Z         2026-10-26 01:59:32 +0000 UTC	Normal	Successfully pulled image "opensciencegrid/frontier-squid:fresh" in 9.793s (13.9s including waiting). Image size: 453187319 bytes.2026-10-26T02:05:11.1784409Z         2026-10-26 01:59:32 +0000 UTC	Normal	Container created2026-10-26T02:05:11.1785510Z         2026-10-26 01:59:32 +0000 UTC	Normal	Container started2026-10-26T02:05:11.1786297Z         2026-10-26T02:05:11.1786628Z         ---2026-10-26T02:05:11.1787180Z TestOSPoolEP 2026-10-26T02:05:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T02:05:11.1800733Z     ospool_ep_test.go:72: ---2026-10-26T02:05:11.1801209Z         Events for pod idtoken-generator:2026-10-26T02:05:11.1802213Z         2026-10-26 01:59:07 +0000 UTC	Normal	Successfully assigned test-ospool-ep-4vvhhv/idtoken-generator to minikube2026-10-26T02:05:11.1803018Z         2026-10-26 01:59:07 +0000 UTC	Normal	Pulling image "htcondor/base"2026-10-26T02:05:11.1803990Z         2026-10-26 01:59:15 +0000 UTC	Normal	Successfully pulled image "htcondor/base" in 7.82s (7.82s including waiting). Image size: 196303183 bytes.2026-10-26T02:05:11.1804984Z         2026-10-26 01:59:15 +0000 UTC	Normal	Container created2026-10-26T02:05:11.1806303Z         2026-10-26 01:59:15 +0000 UTC	Normal	Container started2026-10-26T02:05:11.1806726Z         2026-10-26T02:05:11.1807040Z         ---2026-10-26T02:05:11.1812042Z TestOSPoolEP 2026-10-26T02:05:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T02:05:11.1819126Z     ospool_ep_test.go:72: ---2026-10-26T02:05:11.1819649Z         Events for pod ospool-ep-674fbdcc48-t78dn:2026-10-26T02:05:11.1821056Z         2026-10-26 01:59:18 +0000 UTC	Normal	Successfully assigned test-ospool-ep-4vvhhv/ospool-ep-674fbdcc48-t78dn to minikube2026-10-26T02:05:11.1822037Z         2026-10-26 01:59:18 +0000 UTC	Normal	Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-10-26T02:05:11.1823596Z         2026-10-26 01:59:35 +0000 UTC	Normal	Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 2.811s (16.68s including waiting). Image size: 2893600 bytes.2026-10-26T02:05:11.1824609Z         2026-10-26 01:59:35 +0000 UTC	Normal	Container created2026-10-26T02:05:11.1825180Z         2026-10-26 01:59:35 +0000 UTC	Normal	Container started2026-10-26T02:05:11.1825906Z         2026-10-26 01:59:35 +0000 UTC	Normal	Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-10-26T02:05:11.1827167Z         2026-10-26 01:59:47 +0000 UTC	Normal	Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 11.339s (11.663s including waiting). Image size: 543733340 bytes.2026-10-26T02:05:11.1828166Z         2026-10-26 01:59:47 +0000 UTC	Normal	Container created2026-10-26T02:05:11.1828740Z         2026-10-26 01:59:47 +0000 UTC	Normal	Container started2026-10-26T02:05:11.1829112Z         2026-10-26T02:05:11.1829412Z         ---2026-10-26T02:05:11.1830011Z TestOSPoolEP 2026-10-26T02:05:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T02:05:11.1838614Z     ospool_ep_test.go:72: ---2026-10-26T02:05:11.1839251Z         Events for pod test-cm-5886f7986-s9qnh:2026-10-26T02:05:11.1840824Z         2026-10-26 01:59:18 +0000 UTC	Normal	Successfully assigned test-ospool-ep-4vvhhv/test-cm-5886f7986-s9qnh to minikube2026-10-26T02:05:11.1841608Z         2026-10-26 01:59:18 +0000 UTC	Normal	Pulling image "htcondor/cm:25.x-el9"2026-10-26T02:05:11.1842688Z         2026-10-26 01:59:36 +0000 UTC	Normal	Successfully pulled image "htcondor/cm:25.x-el9" in 995ms (17.598s including waiting). Image size: 196304120 bytes.2026-10-26T02:05:11.1843472Z         2026-10-26 01:59:36 +0000 UTC	Normal	Container created2026-10-26T02:05:11.1844045Z         2026-10-26 01:59:36 +0000 UTC	Normal	Container started2026-10-26T02:05:11.1844433Z         2026-10-26T02:05:11.1844751Z         ---2026-10-26T02:05:11.1845325Z TestOSPoolEP 2026-10-26T02:05:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-26T02:05:11.1864251Z TestOSPoolEP 2026-10-26T02:05:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv delete -f /tmp/TestOSPoolEP2485354055]2026-10-26T02:05:11.2523711Z TestOSPoolEP 2026-10-26T02:05:11Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-4vvhhv namespace2026-10-26T02:05:11.2549159Z TestOSPoolEP 2026-10-26T02:05:11Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-4vvhhv namespace2026-10-26T02:05:12.6070627Z TestOSPoolEP 2026-10-26T02:05:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv delete -f /tmp/TestOSPoolEP2686711100]2026-10-26T02:05:12.6891805Z TestOSPoolEP 2026-10-26T02:05:12Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-4vvhhv namespace2026-10-26T02:05:12.6917995Z TestOSPoolEP 2026-10-26T02:05:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4vvhhv delete -k /tmp/kustomize-template-1024558233]2026-10-26T02:05:12.7718681Z TestOSPoolEP 2026-10-26T02:05:12Z logger.go:67: serviceaccount "cvmfs-nodeplugin" deleted from test-ospool-ep-4vvhhv namespace2026-10-26T02:05:12.7796892Z TestOSPoolEP 2026-10-26T02:05:12Z logger.go:67: service "frontier-squid" deleted from test-ospool-ep-4vvhhv namespace2026-10-26T02:05:12.7894012Z TestOSPoolEP 2026-10-26T02:05:12Z logger.go:67: service "test-cm" deleted from test-ospool-ep-4vvhhv namespace2026-10-26T02:05:12.7934693Z TestOSPoolEP 2026-10-26T02:05:12Z logger.go:67: deployment.apps "cvmfs-nodeplugin" deleted from test-ospool-ep-4vvhhv namespace2026-10-26T02:05:12.7968435Z TestOSPoolEP 2026-10-26T02:05:12Z logger.go:67: deployment.apps "frontier-squid" deleted from test-ospool-ep-4vvhhv namespace2026-10-26T02:05:12.7994996Z TestOSPoolEP 2026-10-26T02:05:12Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-4vvhhv namespace2026-10-26T02:05:12.8076228Z TestOSPoolEP 2026-10-26T02:05:12Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-4vvhhv namespace2026-10-26T02:05:12.8391569Z --- FAIL: TestOSPoolEP (365.97s)2026-10-26T02:05:12.8392427Z     --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.14s)2026-10-26T02:05:12.8393068Z     --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP (21.07s)2026-10-26T02:05:12.8393669Z     --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity (0.30s)2026-10-26T02:05:12.8394308Z     --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (301.27s)2026-10-26T02:05:12.8394765Z FAIL2026-10-26T02:05:12.8415785Z FAIL	github.com/osg-htc/k8s-integration-tests/test	365.981s2026-10-26T02:05:12.8494267Z FAIL2026-10-26T02:05:12.9053691Z ##[error]Process completed with exit code 1.2026-10-26T02:05:12.9117938Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-26T02:05:12.9118746Z echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-26T02:05:12.9180323Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-26T02:05:12.9180819Z env:2026-10-26T02:05:12.9181196Z   GOTOOLCHAIN: local2026-10-26T02:05:12.9181824Z   TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-26T02:05:12.9182509Z ##[endgroup]2026-10-26T02:05:12.9365586Z ##[group]Run actions/upload-artifact@v42026-10-26T02:05:12.9366142Z with:2026-10-26T02:05:12.9366703Z   name: TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd72026-10-26T02:05:12.9367345Z   path: /tmp/k8s-tests2026-10-26T02:05:12.9368363Z   retention-days: 52026-10-26T02:05:12.9368873Z   if-no-files-found: warn2026-10-26T02:05:12.9369221Z   compression-level: 62026-10-26T02:05:12.9369570Z   overwrite: false2026-10-26T02:05:12.9369891Z   include-hidden-files: false2026-10-26T02:05:12.9370235Z env:2026-10-26T02:05:12.9370581Z   GOTOOLCHAIN: local2026-10-26T02:05:12.9370879Z ##[endgroup]2026-10-26T02:05:13.0659539Z (node:16813) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-26T02:05:13.0673871Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-26T02:05:13.0884189Z With the provided path, there will be 10 files uploaded2026-10-26T02:05:13.0910748Z Artifact name is valid!2026-10-26T02:05:13.0911268Z Root directory input is valid!2026-10-26T02:05:13.3309233Z Beginning upload of artifact content to blob storage2026-10-26T02:05:13.3657880Z (node:16813) [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-26T02:05:13.5485731Z Uploaded bytes 159602026-10-26T02:05:13.5929085Z Finished uploading artifact content to blob storage!2026-10-26T02:05:13.5929782Z SHA256 digest of uploaded artifact zip is c7b44957ca1e123f5886fa8c7e77cb1dac92663de5947400bb9038cf339bf5562026-10-26T02:05:13.5930690Z Finalizing artifact upload2026-10-26T02:05:13.9652612Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7.zip successfully finalized. Artifact ID 126223638572026-10-26T02:05:13.9653578Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7 has been successfully uploaded! Final size is 15960 bytes. Artifact ID is 126223638572026-10-26T02:05:13.9657610Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/40256740596/artifacts/126223638572026-10-26T02:05:13.9818065Z Post job cleanup.2026-10-26T02:05:14.0557191Z [command]/usr/bin/git version2026-10-26T02:05:14.0596888Z git version 2.55.02026-10-26T02:05:14.0614765Z Temporarily overriding HOME='/home/runner/work/_temp/330d641b-6fb2-4c6e-92f8-2ad9475fdcb5' before making global git config changes2026-10-26T02:05:14.0618968Z Adding repository directory to the temporary git global config as a safe directory2026-10-26T02:05:14.0619850Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-26T02:05:14.0644060Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-26T02:05:14.0666972Z [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-26T02:05:14.0819581Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-26T02:05:14.0835864Z http.https://github.com/.extraheader2026-10-26T02:05:14.0843853Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-10-26T02:05:14.0868853Z [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-26T02:05:14.1020585Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-26T02:05:14.1042368Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-26T02:05:14.1335599Z Cleaning up orphan processes2026-10-26T02:05:14.1881780Z ##[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/