All Test Logs

2026-10-19T02:01:29.4457689Z Current runner version: '2.337.0'2026-10-19T02:01:29.4471595Z ##[group]Runner Image Provisioner2026-10-19T02:01:29.4472104Z Hosted Compute Agent2026-10-19T02:01:29.4472417Z Version: 20261012.6012026-10-19T02:01:29.4472739Z Commit: f3dc54e1fb89da6852db922499a0233137369e1d2026-10-19T02:01:29.4473139Z Build Date: 2026-10-12T17:48:21Z2026-10-19T02:01:29.4473496Z Worker ID: {ebc37451-3c76-4859-8038-4420a784c3a4}2026-10-19T02:01:29.4473868Z Region: westus22026-10-19T02:01:29.4474184Z Cloud: Azure2026-10-19T02:01:29.4474574Z ##[endgroup]2026-10-19T02:01:29.4475508Z ##[group]Operating System2026-10-19T02:01:29.4475829Z Ubuntu2026-10-19T02:01:29.4476119Z 22.04.52026-10-19T02:01:29.4476394Z LTS2026-10-19T02:01:29.4476663Z ##[endgroup]2026-10-19T02:01:29.4476963Z ##[group]Runner Image2026-10-19T02:01:29.4477274Z Image: ubuntu-22.042026-10-19T02:01:29.4477564Z Version: 20261012.322.12026-10-19T02:01:29.4478247Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20261012.322/images/ubuntu/Ubuntu2204-Readme.md2026-10-19T02:01:29.4479037Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20261012.3222026-10-19T02:01:29.4479539Z ##[endgroup]2026-10-19T02:01:29.4481311Z ##[group]GITHUB_TOKEN Permissions2026-10-19T02:01:29.4482634Z Actions: write2026-10-19T02:01:29.4482963Z ArtifactMetadata: write2026-10-19T02:01:29.4483289Z Attestations: write2026-10-19T02:01:29.4483583Z Checks: write2026-10-19T02:01:29.4483880Z CodeQuality: write2026-10-19T02:01:29.4484179Z Contents: write2026-10-19T02:01:29.4484496Z CopilotRequests: write2026-10-19T02:01:29.4484815Z Deployments: write2026-10-19T02:01:29.4485216Z Discussions: write2026-10-19T02:01:29.4485527Z Drives: write2026-10-19T02:01:29.4485805Z Issues: write2026-10-19T02:01:29.4486114Z Metadata: read2026-10-19T02:01:29.4486418Z Models: read2026-10-19T02:01:29.4486696Z Packages: write2026-10-19T02:01:29.4487021Z Pages: write2026-10-19T02:01:29.4487304Z PullRequests: write2026-10-19T02:01:29.4487607Z RepositoryProjects: write2026-10-19T02:01:29.4487949Z SecurityEvents: write2026-10-19T02:01:29.4488251Z Statuses: write2026-10-19T02:01:29.4488576Z VulnerabilityAlerts: read2026-10-19T02:01:29.4488889Z ##[endgroup]2026-10-19T02:01:29.4490049Z Secret source: Actions2026-10-19T02:01:29.4490548Z Cache mode: write2026-10-19T02:01:29.4490966Z Prepare workflow directory2026-10-19T02:01:29.4665300Z Prepare all required actions2026-10-19T02:01:29.4693307Z Getting action download info2026-10-19T02:01:29.7910232Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-10-19T02:01:29.8822123Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-10-19T02:01:30.2272523Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-10-19T02:01:30.4570428Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-10-19T02:01:30.7421147Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (63ec080e4eea87fb8a9eae678ab9944ec2461251)2026-10-19T02:01:30.7424216Z ##[group] Inputs2026-10-19T02:01:30.7424525Z   testName: TestOSPoolEP2026-10-19T02:01:30.7425143Z   testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-19T02:01:30.7425669Z   setupScript: 2026-10-19T02:01:30.7425919Z   setupEnv: {}2026-10-19T02:01:30.7426173Z ##[endgroup]2026-10-19T02:01:30.7426563Z Complete job name: ospool-ep / Run OSPool EP test (cvmfs-bind, 25-testing) / Run Tests2026-10-19T02:01:30.7775310Z ##[group]Run actions/checkout@v52026-10-19T02:01:30.7775736Z with:2026-10-19T02:01:30.7775997Z   repository: osg-htc/k8s-integration-tests2026-10-19T02:01:30.7778209Z   token: ***2026-10-19T02:01:30.7778447Z   ssh-strict: true2026-10-19T02:01:30.7778691Z   ssh-user: git2026-10-19T02:01:30.7778950Z   persist-credentials: true2026-10-19T02:01:30.7779231Z   clean: true2026-10-19T02:01:30.7779625Z   sparse-checkout-cone-mode: true2026-10-19T02:01:30.7779918Z   fetch-depth: 12026-10-19T02:01:30.7780160Z   fetch-tags: false2026-10-19T02:01:30.7780411Z   show-progress: true2026-10-19T02:01:30.7780664Z   lfs: false2026-10-19T02:01:30.7780901Z   submodules: false2026-10-19T02:01:30.7781153Z   set-safe-directory: true2026-10-19T02:01:30.7781577Z   allow-unsafe-pr-checkout: false2026-10-19T02:01:30.7782022Z ##[endgroup]2026-10-19T02:01:30.8383090Z Syncing repository: osg-htc/k8s-integration-tests2026-10-19T02:01:30.8385039Z ##[group]Getting Git version info2026-10-19T02:01:30.8386065Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-19T02:01:30.8387460Z [command]/usr/bin/git version2026-10-19T02:01:30.8388394Z git version 2.55.02026-10-19T02:01:30.8401114Z ##[endgroup]2026-10-19T02:01:30.8410406Z Temporarily overriding HOME='/home/runner/work/_temp/c79d338c-8547-4666-9846-f172b8479ea8' before making global git config changes2026-10-19T02:01:30.8411928Z Adding repository directory to the temporary git global config as a safe directory2026-10-19T02:01:30.8413532Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-19T02:01:30.8434426Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-19T02:01:30.8436779Z ##[group]Initializing the repository2026-10-19T02:01:30.8444320Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-19T02:01:30.8518029Z hint: Using 'master' as the name for the initial branch. This default branch name2026-10-19T02:01:30.8519258Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-10-19T02:01:30.8520264Z hint: to use in all of your new repositories, which will suppress this warning,2026-10-19T02:01:30.8521049Z hint: call:2026-10-19T02:01:30.8522504Z hint:2026-10-19T02:01:30.8523245Z hint: 	git config --global init.defaultBranch <name>2026-10-19T02:01:30.8524118Z hint:2026-10-19T02:01:30.8525268Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-10-19T02:01:30.8526456Z hint: 'development'. The just-created branch can be renamed via this command:2026-10-19T02:01:30.8527386Z hint:2026-10-19T02:01:30.8528007Z hint: 	git branch -m <name>2026-10-19T02:01:30.8528719Z hint:2026-10-19T02:01:30.8529595Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-10-19T02:01:30.8531065Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-10-19T02:01:30.8533506Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-10-19T02:01:30.8541713Z ##[endgroup]2026-10-19T02:01:30.8542848Z ##[group]Disabling automatic garbage collection2026-10-19T02:01:30.8544083Z [command]/usr/bin/git config --local gc.auto 02026-10-19T02:01:30.8562581Z ##[endgroup]2026-10-19T02:01:30.8563528Z ##[group]Setting up auth2026-10-19T02:01:30.8567522Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-19T02:01:30.8584716Z [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-19T02:01:30.8759075Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-19T02:01:30.8778305Z [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-19T02:01:30.8882331Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-19T02:01:30.8900667Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-19T02:01:30.8997320Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-10-19T02:01:30.9017975Z ##[endgroup]2026-10-19T02:01:30.9019137Z ##[group]Fetching the repository2026-10-19T02:01:30.9024120Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +63ec080e4eea87fb8a9eae678ab9944ec2461251:refs/remotes/origin/main2026-10-19T02:01:31.2435906Z From https://github.com/osg-htc/k8s-integration-tests2026-10-19T02:01:31.2437149Z  * [new ref]         63ec080e4eea87fb8a9eae678ab9944ec2461251 -> origin/main2026-10-19T02:01:31.2440092Z ##[endgroup]2026-10-19T02:01:31.2441221Z ##[group]Determining the checkout info2026-10-19T02:01:31.2442409Z ##[endgroup]2026-10-19T02:01:31.2444703Z [command]/usr/bin/git sparse-checkout disable2026-10-19T02:01:31.2467071Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-10-19T02:01:31.2483535Z ##[group]Checking out the ref2026-10-19T02:01:31.2485193Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-10-19T02:01:31.2525136Z Switched to a new branch 'main'2026-10-19T02:01:31.2526450Z branch 'main' set up to track 'origin/main'.2026-10-19T02:01:31.2529205Z ##[endgroup]2026-10-19T02:01:31.2546489Z [command]/usr/bin/git log -1 --format=%H2026-10-19T02:01:31.2557546Z 63ec080e4eea87fb8a9eae678ab9944ec24612512026-10-19T02:01:31.2783521Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-19T02:01:31.2785271Z echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-19T02:01:31.2786836Z echo "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-19T02:01:31.3024260Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-19T02:01:31.3025312Z env:2026-10-19T02:01:31.3026492Z   TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-19T02:01:31.3027896Z   SETUP_ENV_YAML: {}2026-10-19T02:01:31.3028537Z ##[endgroup]2026-10-19T02:01:31.4575710Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-19T02:01:31.4577576Z echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-19T02:01:31.4602418Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-19T02:01:31.4603238Z env:2026-10-19T02:01:31.4604322Z   TEST_ENV: {  "OSPOOL_EP_OSPoolEPTag": "25-testing",  "OSPOOL_EP_CMTag": "25.x-el9",  "OSPOOL_EP_CvmfsType": "cvmfs-bind"}2026-10-19T02:01:31.4605849Z ##[endgroup]2026-10-19T02:01:31.4697637Z ##[group]Run true2026-10-19T02:01:31.4698158Z true2026-10-19T02:01:31.4718662Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-19T02:01:31.4719474Z ##[endgroup]2026-10-19T02:01:31.4867559Z ##[group]Run medyagh/setup-minikube@latest2026-10-19T02:01:31.4868226Z with:2026-10-19T02:01:31.4868695Z   start: true2026-10-19T02:01:31.4869180Z   cache: true2026-10-19T02:01:31.4869690Z   minikube-version: latest2026-10-19T02:01:31.4870258Z   wait: all2026-10-19T02:01:31.4870731Z ##[endgroup]2026-10-19T02:01:31.5598230Z (node:1881) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-19T02:01:31.5599918Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-19T02:01:32.6660158Z [command]/usr/bin/chmod +x /home/runner/work/_temp/9db80acf-d8d2-40be-b4d1-47b98204b3a32026-10-19T02:01:33.3232787Z [command]/home/runner/bin/minikube version --short2026-10-19T02:01:33.4002895Z v1.39.02026-10-19T02:01:33.6320461Z Cache hit for: kic-v1.39.0-x642026-10-19T02:01:33.6387376Z (node:1881) [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-19T02:01:33.6391506Z Cache hit for: preloaded-tarball-v1.39.0-x64-stable-docker2026-10-19T02:01:34.8998560Z Received 41943040 of 531630645 (7.9%), 40.0 MBs/sec2026-10-19T02:01:34.9117228Z Received 54525952 of 288577004 (18.9%), 52.0 MBs/sec2026-10-19T02:01:35.9001360Z Received 180355072 of 531630645 (33.9%), 86.0 MBs/sec2026-10-19T02:01:35.9121972Z Received 226492416 of 288577004 (78.5%), 107.9 MBs/sec2026-10-19T02:01:36.5363097Z Received 288577004 of 288577004 (100.0%), 104.8 MBs/sec2026-10-19T02:01:36.5363564Z Cache Size: ~275 MB (288577004 B)2026-10-19T02:01:36.5382013Z [command]/usr/bin/tar -xf /home/runner/work/_temp/edca5ad1-26cb-4991-a9ca-8eb30198f37e/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-19T02:01:36.9036637Z Received 327155712 of 531630645 (61.5%), 103.9 MBs/sec2026-10-19T02:01:36.9126006Z Cache restored successfully2026-10-19T02:01:37.9079273Z Received 469762048 of 531630645 (88.4%), 111.9 MBs/sec2026-10-19T02:01:38.3004001Z Received 531630645 of 531630645 (100.0%), 115.2 MBs/sec2026-10-19T02:01:38.3035550Z Cache Size: ~507 MB (531630645 B)2026-10-19T02:01:38.3085250Z [command]/usr/bin/tar -xf /home/runner/work/_temp/d2d62a45-8515-4443-addb-a7376fabf198/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-19T02:01:38.6344486Z Cache restored successfully2026-10-19T02:01:38.6691115Z [command]/home/runner/bin/minikube start --wait all2026-10-19T02:01:38.6914235Z * minikube v1.39.0 on Ubuntu 22.042026-10-19T02:01:39.5411556Z ! 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-19T02:01:39.5422860Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-10-19T02:01:39.5718618Z * Using Docker driver with root privileges2026-10-19T02:01:39.5724420Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-10-19T02:01:39.5728865Z * Pulling base image v0.0.51 ...2026-10-19T02:02:03.0650926Z * Preparing Kubernetes v1.37.0 on containerd 2.3.4 ...2026-10-19T02:02:08.9695063Z * Configuring CNI (Container Networking Interface) ...2026-10-19T02:02:15.1445596Z * Verifying Kubernetes components...2026-10-19T02:02:15.1566785Z   - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-10-19T02:02:15.4198834Z * Enabled addons: storage-provisioner, default-storageclass2026-10-19T02:02:30.9116367Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-10-19T02:02:30.9174707Z [command]/home/runner/bin/minikube version --short2026-10-19T02:02:30.9406977Z v1.39.02026-10-19T02:02:30.9582334Z ##[group]Run actions/setup-go@v62026-10-19T02:02:30.9582496Z with:2026-10-19T02:02:30.9582616Z   go-version: 1.262026-10-19T02:02:30.9582735Z   cache: true2026-10-19T02:02:30.9582868Z   cache-dependency-path: go.sum2026-10-19T02:02:30.9583031Z   check-latest: false2026-10-19T02:02:30.9584451Z   token: ***2026-10-19T02:02:30.9584570Z ##[endgroup]2026-10-19T02:02:31.0320386Z Setup go version spec 1.262026-10-19T02:02:31.0551499Z Found in cache @ /opt/hostedtoolcache/go/1.26.9/x642026-10-19T02:02:31.0552909Z Added go to the path2026-10-19T02:02:31.0554906Z Successfully set up Go version 1.262026-10-19T02:02:31.2088183Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOMODCACHE2026-10-19T02:02:31.2108601Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOCACHE2026-10-19T02:02:31.2123424Z /home/runner/go/pkg/mod2026-10-19T02:02:31.2132803Z /home/runner/.cache/go-build2026-10-19T02:02:31.4467566Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-19T02:02:32.7243443Z Received 33554432 of 249167808 (13.5%), 32.0 MBs/sec2026-10-19T02:02:33.7220785Z Received 197132288 of 249167808 (79.1%), 94.0 MBs/sec2026-10-19T02:02:34.0024712Z Received 249167808 of 249167808 (100.0%), 104.2 MBs/sec2026-10-19T02:02:34.0025643Z Cache Size: ~238 MB (249167808 B)2026-10-19T02:02:34.0066659Z [command]/usr/bin/tar -xf /home/runner/work/_temp/799cd18e-dffa-443b-a783-1a2482c0da7a/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-19T02:02:35.0259274Z Cache restored successfully2026-10-19T02:02:35.0454005Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-19T02:02:35.0473935Z go version go1.26.9 linux/amd642026-10-19T02:02:35.0474089Z 2026-10-19T02:02:35.0474329Z ##[group]go env2026-10-19T02:02:35.0541107Z AR='ar'2026-10-19T02:02:35.0541308Z CC='gcc'2026-10-19T02:02:35.0541494Z CGO_CFLAGS='-O2 -g'2026-10-19T02:02:35.0541643Z CGO_CPPFLAGS=''2026-10-19T02:02:35.0541776Z CGO_CXXFLAGS='-O2 -g'2026-10-19T02:02:35.0541915Z CGO_ENABLED='1'2026-10-19T02:02:35.0542097Z CGO_FFLAGS='-O2 -g'2026-10-19T02:02:35.0542270Z CGO_LDFLAGS='-O2 -g'2026-10-19T02:02:35.0542448Z CXX='g++'2026-10-19T02:02:35.0542568Z GCCGO='gccgo'2026-10-19T02:02:35.0542687Z GO111MODULE=''2026-10-19T02:02:35.0542809Z GOAMD64='v1'2026-10-19T02:02:35.0542939Z GOARCH='amd64'2026-10-19T02:02:35.0543060Z GOAUTH='netrc'2026-10-19T02:02:35.0543176Z GOBIN=''2026-10-19T02:02:35.0543309Z GOCACHE='/home/runner/.cache/go-build'2026-10-19T02:02:35.0543474Z GOCACHEPROG=''2026-10-19T02:02:35.0543594Z GODEBUG=''2026-10-19T02:02:35.0543742Z GOENV='/home/runner/.config/go/env'2026-10-19T02:02:35.0543898Z GOEXE=''2026-10-19T02:02:35.0544011Z GOEXPERIMENT=''2026-10-19T02:02:35.0544138Z GOFIPS140='off'2026-10-19T02:02:35.0544256Z GOFLAGS=''2026-10-19T02:02:35.0544645Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build3184033391=/tmp/go-build -gno-record-gcc-switches'2026-10-19T02:02:35.0545116Z GOHOSTARCH='amd64'2026-10-19T02:02:35.0545251Z GOHOSTOS='linux'2026-10-19T02:02:35.0545375Z GOINSECURE=''2026-10-19T02:02:35.0545590Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-10-19T02:02:35.0545825Z GOMODCACHE='/home/runner/go/pkg/mod'2026-10-19T02:02:35.0545984Z GONOPROXY=''2026-10-19T02:02:35.0546100Z GONOSUMDB=''2026-10-19T02:02:35.0546218Z GOOS='linux'2026-10-19T02:02:35.0546365Z GOPATH='/home/runner/go'2026-10-19T02:02:35.0546501Z GOPRIVATE=''2026-10-19T02:02:35.0546670Z GOPROXY='https://proxy.golang.org,direct'2026-10-19T02:02:35.0546870Z GOROOT='/opt/hostedtoolcache/go/1.26.9/x64'2026-10-19T02:02:35.0547051Z GOSUMDB='sum.golang.org'2026-10-19T02:02:35.0547195Z GOTELEMETRY='local'2026-10-19T02:02:35.0547362Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-10-19T02:02:35.0547538Z GOTMPDIR=''2026-10-19T02:02:35.0547808Z GOTOOLCHAIN='local'2026-10-19T02:02:35.0548003Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.9/x64/pkg/tool/linux_amd64'2026-10-19T02:02:35.0548205Z GOVCS=''2026-10-19T02:02:35.0548323Z GOVERSION='go1.26.9'2026-10-19T02:02:35.0548458Z GOWORK=''2026-10-19T02:02:35.0548584Z PKG_CONFIG='pkg-config'2026-10-19T02:02:35.0548671Z 2026-10-19T02:02:35.0548869Z ##[endgroup]2026-10-19T02:02:35.0802239Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-19T02:02:35.0802618Z go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-19T02:02:35.0830799Z shell: /usr/bin/bash -e {0}2026-10-19T02:02:35.0830942Z env:2026-10-19T02:02:35.0831057Z   GOTOOLCHAIN: local2026-10-19T02:02:35.0831195Z   OSPOOL_EP_OSPoolEPTag: 25-testing2026-10-19T02:02:35.0831351Z   OSPOOL_EP_CMTag: 25.x-el92026-10-19T02:02:35.0831500Z   OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-19T02:02:35.0831648Z ##[endgroup]2026-10-19T02:02:39.1579528Z === RUN   TestOSPoolEP2026-10-19T02:02:39.1579899Z === PAUSE TestOSPoolEP2026-10-19T02:02:39.1580118Z === CONT  TestOSPoolEP2026-10-19T02:02:39.1580778Z TestOSPoolEP 2026-10-19T02:02:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:02:39.1669456Z TestOSPoolEP 2026-10-19T02:02:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k apply -f /tmp/TestOSPoolEP141733250]2026-10-19T02:02:39.3783358Z TestOSPoolEP 2026-10-19T02:02:39Z logger.go:67: pod/idtoken-generator created2026-10-19T02:02:39.4763611Z TestOSPoolEP 2026-10-19T02:02:39Z logger.go:67: secret/pool-passwd created2026-10-19T02:02:39.4800036Z TestOSPoolEP 2026-10-19T02:02:39Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-19T02:02:39.4813304Z TestOSPoolEP 2026-10-19T02:02:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:02:39.4859455Z TestOSPoolEP 2026-10-19T02:02:39Z 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-19T02:02:49.4860506Z TestOSPoolEP 2026-10-19T02:02:49Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-19T02:02:49.4861223Z TestOSPoolEP 2026-10-19T02:02:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:02:49.4875534Z TestOSPoolEP 2026-10-19T02:02:49Z logger.go:67: Pod is now available2026-10-19T02:02:49.4876398Z TestOSPoolEP 2026-10-19T02:02:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-10-19T02:02:49.5648919Z TestOSPoolEP 2026-10-19T02:02:49Z logger.go:67: ***2026-10-19T02:02:49.5675148Z TestOSPoolEP 2026-10-19T02:02:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k apply -f /tmp/TestOSPoolEP3600448646]2026-10-19T02:02:49.6662837Z TestOSPoolEP 2026-10-19T02:02:49Z logger.go:67: secret/pool-token created2026-10-19T02:02:49.6676128Z TestOSPoolEP 2026-10-19T02:02:49Z retry.go:91: Wait for secret pool-token to be provisioned.2026-10-19T02:02:49.6676850Z TestOSPoolEP 2026-10-19T02:02:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:02:49.6689449Z TestOSPoolEP 2026-10-19T02:02:49Z logger.go:67: Secret is now available2026-10-19T02:02:49.6698112Z TestOSPoolEP 2026-10-19T02:02:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k apply -k /tmp/kustomize-template-1940611818]2026-10-19T02:02:49.8457792Z TestOSPoolEP 2026-10-19T02:02:49Z logger.go:67: serviceaccount/cvmfs-nodeplugin created2026-10-19T02:02:49.8523029Z TestOSPoolEP 2026-10-19T02:02:49Z logger.go:67: service/frontier-squid created2026-10-19T02:02:49.8571352Z TestOSPoolEP 2026-10-19T02:02:49Z logger.go:67: service/test-cm created2026-10-19T02:02:49.8616264Z TestOSPoolEP 2026-10-19T02:02:49Z logger.go:67: deployment.apps/cvmfs-nodeplugin created2026-10-19T02:02:49.8669223Z TestOSPoolEP 2026-10-19T02:02:49Z logger.go:67: deployment.apps/frontier-squid created2026-10-19T02:02:49.8799414Z TestOSPoolEP 2026-10-19T02:02:49Z 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-19T02:02:49.8800474Z TestOSPoolEP 2026-10-19T02:02:49Z logger.go:67: deployment.apps/ospool-ep created2026-10-19T02:02:49.8927601Z TestOSPoolEP 2026-10-19T02:02:49Z logger.go:67: deployment.apps/test-cm created2026-10-19T02:02:49.8939330Z === RUN   TestOSPoolEP/Confirm_deployments_become_ready.2026-10-19T02:02:49.8940101Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:02:49.8997289Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:49Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-19T02:02:49.8998595Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:02:49.9003496Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:49Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-19T02:02:49.9004539Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:02:49.9016887Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:49Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-19T02:02:49.9022246Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:02:49.9027695Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:49Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-19T02:02:49.9032946Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:02:49.9040556Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:49Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available, missing 'Progressing' condition. Sleeping for 10s and will try again.2026-10-19T02:02:49.9056371Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:49Z 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-19T02:02:49.9103141Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:49Z 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-19T02:02:49.9134311Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:49Z 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-19T02:02:59.9043048Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:59Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-19T02:02:59.9045391Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:02:59.9059844Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:59Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-19T02:02:59.9061025Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:02:59.9111051Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:59Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-19T02:02:59.9118346Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:02:59.9148495Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:59Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-19T02:02:59.9149677Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:02:59.9453943Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:59Z 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-19T02:02:59.9458987Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:59Z logger.go:67: Deployment is now available2026-10-19T02:02:59.9462269Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:59Z 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-19T02:02:59.9480855Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:02:59Z 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-19T02:03:09.9461293Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:09Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-19T02:03:09.9462250Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:03:09.9467442Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:09Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-19T02:03:09.9468615Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:03:09.9479261Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:09Z logger.go:67: Deployment is now available2026-10-19T02:03:09.9480962Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:09Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-674fbdcc48" is progressing.. Sleeping for 10s and will try again.2026-10-19T02:03:09.9482556Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:09Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-19T02:03:09.9483148Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:03:09.9492036Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:09Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "test-cm-5886f7986" is progressing.. Sleeping for 10s and will try again.2026-10-19T02:03:19.9487372Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:19Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-19T02:03:19.9488258Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:03:19.9495776Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:19Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-19T02:03:19.9496845Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:03:19.9508460Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:19Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-674fbdcc48" is progressing.. Sleeping for 10s and will try again.2026-10-19T02:03:19.9513669Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:19Z logger.go:67: Deployment is now available2026-10-19T02:03:29.9518829Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:29Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-19T02:03:29.9519822Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:03:29.9536808Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-19T02:03:29Z logger.go:67: Deployment is now available2026-10-19T02:03:29.9538400Z === RUN   TestOSPoolEP/Confirm_condor_status_lists_the_EP2026-10-19T02:03:29.9539043Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-19T02:03:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:03:29.9554026Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-19T02:03:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k cp ../test-configs/ospool-ep/condor_status.sh test-cm-5886f7986-m8vqp:/tmp/condor_status.sh]2026-10-19T02:03:30.0632016Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-19T02:03:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k exec test-cm-5886f7986-m8vqp -- chmod +x /tmp/condor_status.sh]2026-10-19T02:03:30.1418935Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-19T02:03:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k exec test-cm-5886f7986-m8vqp -- sh -c /tmp/condor_status.sh]2026-10-19T02:03:30.2267209Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-19T02:03:30Z logger.go:67: command terminated with exit code 12026-10-19T02:03:30.2282519Z     test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-5886f7986-m8vqp failed. Retrying in 10s.2026-10-19T02:03:40.2287597Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-19T02:03:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k exec test-cm-5886f7986-m8vqp -- sh -c /tmp/condor_status.sh]2026-10-19T02:03:40.3089118Z === RUN   TestOSPoolEP/Confirm_EP_container_advertises_singularity2026-10-19T02:03:40.3089701Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-19T02:03:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:03:40.3110536Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-19T02:03:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k cp ../test-configs/ospool-ep/has_singularity.sh test-cm-5886f7986-m8vqp:/tmp/has_singularity.sh]2026-10-19T02:03:40.4036893Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-19T02:03:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k exec test-cm-5886f7986-m8vqp -- chmod +x /tmp/has_singularity.sh]2026-10-19T02:03:40.4786401Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-19T02:03:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k exec test-cm-5886f7986-m8vqp -- sh -c /tmp/has_singularity.sh]2026-10-19T02:03:40.5584779Z === RUN   TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-10-19T02:03:40.5585705Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:03:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:03:40.5605475Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:03:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k cp ../test-configs/ospool-ep/has_cvmfs.sh test-cm-5886f7986-m8vqp:/tmp/has_cvmfs.sh]2026-10-19T02:03:40.6468556Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:03:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k exec test-cm-5886f7986-m8vqp -- chmod +x /tmp/has_cvmfs.sh]2026-10-19T02:03:40.7171689Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:03:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k exec test-cm-5886f7986-m8vqp -- sh -c /tmp/has_cvmfs.sh]2026-10-19T02:03:40.7939742Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:03:40Z logger.go:67: command terminated with exit code 12026-10-19T02:03:40.7958235Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-m8vqp failed. Retrying in 30s.2026-10-19T02:04:10.7966919Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:04:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k exec test-cm-5886f7986-m8vqp -- sh -c /tmp/has_cvmfs.sh]2026-10-19T02:04:10.8755275Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:04:10Z logger.go:67: command terminated with exit code 12026-10-19T02:04:10.8766417Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-m8vqp failed. Retrying in 30s.2026-10-19T02:04:40.8768123Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:04:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k exec test-cm-5886f7986-m8vqp -- sh -c /tmp/has_cvmfs.sh]2026-10-19T02:04:40.9604149Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:04:40Z logger.go:67: command terminated with exit code 12026-10-19T02:04:40.9616587Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-m8vqp failed. Retrying in 30s.2026-10-19T02:05:10.9627969Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:05:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k exec test-cm-5886f7986-m8vqp -- sh -c /tmp/has_cvmfs.sh]2026-10-19T02:05:11.0433295Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:05:11Z logger.go:67: command terminated with exit code 12026-10-19T02:05:11.0446312Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-m8vqp failed. Retrying in 30s.2026-10-19T02:05:41.0451619Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:05:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k exec test-cm-5886f7986-m8vqp -- sh -c /tmp/has_cvmfs.sh]2026-10-19T02:05:41.1602421Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:05:41Z logger.go:67: command terminated with exit code 12026-10-19T02:05:41.1619024Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-m8vqp failed. Retrying in 30s.2026-10-19T02:06:11.1637893Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:06:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k exec test-cm-5886f7986-m8vqp -- sh -c /tmp/has_cvmfs.sh]2026-10-19T02:06:11.2464541Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:06:11Z logger.go:67: command terminated with exit code 12026-10-19T02:06:11.2479298Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-m8vqp failed. Retrying in 30s.2026-10-19T02:06:41.2482558Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:06:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k exec test-cm-5886f7986-m8vqp -- sh -c /tmp/has_cvmfs.sh]2026-10-19T02:06:41.3288279Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:06:41Z logger.go:67: command terminated with exit code 12026-10-19T02:06:41.3301780Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-m8vqp failed. Retrying in 30s.2026-10-19T02:07:11.3319922Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:07:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k exec test-cm-5886f7986-m8vqp -- sh -c /tmp/has_cvmfs.sh]2026-10-19T02:07:11.4122001Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:07:11Z logger.go:67: command terminated with exit code 12026-10-19T02:07:11.4135531Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-m8vqp failed. Retrying in 30s.2026-10-19T02:07:41.4139150Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:07:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k exec test-cm-5886f7986-m8vqp -- sh -c /tmp/has_cvmfs.sh]2026-10-19T02:07:41.5138040Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:07:41Z logger.go:67: command terminated with exit code 12026-10-19T02:07:41.5157831Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-m8vqp failed. Retrying in 30s.2026-10-19T02:08:11.5174434Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:08:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k exec test-cm-5886f7986-m8vqp -- sh -c /tmp/has_cvmfs.sh]2026-10-19T02:08:11.6031930Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-19T02:08:11Z logger.go:67: command terminated with exit code 12026-10-19T02:08:11.6045289Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-m8vqp failed. Retrying in 30s.2026-10-19T02:08:41.6048256Z     test_utils.go:105: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-m8vqp did not succeed within {10 30000000000} retries2026-10-19T02:08:41.6077656Z TestOSPoolEP 2026-10-19T02:08:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:08:41.6129707Z TestOSPoolEP 2026-10-19T02:08:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:08:41.6819341Z TestOSPoolEP 2026-10-19T02:08:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:08:41.7394177Z TestOSPoolEP 2026-10-19T02:08:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:08:41.8002268Z TestOSPoolEP 2026-10-19T02:08:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:08:41.8624452Z TestOSPoolEP 2026-10-19T02:08:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:08:41.9236356Z TestOSPoolEP 2026-10-19T02:08:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:08:41.9253763Z === NAME  TestOSPoolEP2026-10-19T02:08:41.9254109Z     ospool_ep_test.go:72: ---2026-10-19T02:08:41.9254519Z         Events for pod cvmfs-nodeplugin-5cd89c7cfd-fxc9c:2026-10-19T02:08:41.9255487Z         2026-10-19 02:02:49 +0000 UTC	Normal	Successfully assigned test-ospool-ep-jpdu9k/cvmfs-nodeplugin-5cd89c7cfd-fxc9c to minikube2026-10-19T02:08:41.9256361Z         2026-10-19 02:02:50 +0000 UTC	Normal	Pulling image "opensciencegrid/cvmfs-nodeplugin:fresh"2026-10-19T02:08:41.9257450Z         2026-10-19 02:02:55 +0000 UTC	Normal	Successfully pulled image "opensciencegrid/cvmfs-nodeplugin:fresh" in 5.155s (5.155s including waiting). Image size: 155940803 bytes.2026-10-19T02:08:41.9258146Z         2026-10-19 02:02:55 +0000 UTC	Normal	Container created2026-10-19T02:08:41.9258747Z         2026-10-19 02:02:55 +0000 UTC	Normal	Container started2026-10-19T02:08:41.9259467Z         2026-10-19T02:08:41.9259661Z         ---2026-10-19T02:08:41.9260157Z TestOSPoolEP 2026-10-19T02:08:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:08:41.9269997Z     ospool_ep_test.go:72: ---2026-10-19T02:08:41.9270354Z         Events for pod frontier-squid-65f85c968-566pl:2026-10-19T02:08:41.9270827Z         2026-10-19 02:02:49 +0000 UTC	Normal	Successfully assigned test-ospool-ep-jpdu9k/frontier-squid-65f85c968-566pl to minikube2026-10-19T02:08:41.9271362Z         2026-10-19 02:02:50 +0000 UTC	Normal	Pulling image "opensciencegrid/frontier-squid:fresh"2026-10-19T02:08:41.9272069Z         2026-10-19 02:03:05 +0000 UTC	Normal	Successfully pulled image "opensciencegrid/frontier-squid:fresh" in 9.981s (15.111s including waiting). Image size: 453187319 bytes.2026-10-19T02:08:41.9272596Z         2026-10-19 02:03:05 +0000 UTC	Normal	Container created2026-10-19T02:08:41.9272924Z         2026-10-19 02:03:05 +0000 UTC	Normal	Container started2026-10-19T02:08:41.9273236Z         2026-10-19T02:08:41.9273436Z         ---2026-10-19T02:08:41.9273948Z TestOSPoolEP 2026-10-19T02:08:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:08:41.9284393Z     ospool_ep_test.go:72: ---2026-10-19T02:08:41.9284809Z         Events for pod idtoken-generator:2026-10-19T02:08:41.9285592Z         2026-10-19 02:02:39 +0000 UTC	Normal	Successfully assigned test-ospool-ep-jpdu9k/idtoken-generator to minikube2026-10-19T02:08:41.9286248Z         2026-10-19 02:02:39 +0000 UTC	Normal	Pulling image "htcondor/base"2026-10-19T02:08:41.9287119Z         2026-10-19 02:02:47 +0000 UTC	Normal	Successfully pulled image "htcondor/base" in 7.949s (7.949s including waiting). Image size: 196303183 bytes.2026-10-19T02:08:41.9287796Z         2026-10-19 02:02:47 +0000 UTC	Normal	Container created2026-10-19T02:08:41.9288234Z         2026-10-19 02:02:47 +0000 UTC	Normal	Container started2026-10-19T02:08:41.9288537Z         2026-10-19T02:08:41.9288728Z         ---2026-10-19T02:08:41.9289218Z TestOSPoolEP 2026-10-19T02:08:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:08:41.9297905Z     ospool_ep_test.go:72: ---2026-10-19T02:08:41.9298394Z         Events for pod ospool-ep-674fbdcc48-v4g24:2026-10-19T02:08:41.9299269Z         2026-10-19 02:02:49 +0000 UTC	Normal	Successfully assigned test-ospool-ep-jpdu9k/ospool-ep-674fbdcc48-v4g24 to minikube2026-10-19T02:08:41.9300201Z         2026-10-19 02:02:50 +0000 UTC	Normal	Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-10-19T02:08:41.9301347Z         2026-10-19 02:03:08 +0000 UTC	Normal	Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 3.126s (18.218s including waiting). Image size: 2893600 bytes.2026-10-19T02:08:41.9302185Z         2026-10-19 02:03:08 +0000 UTC	Normal	Container created2026-10-19T02:08:41.9302710Z         2026-10-19 02:03:08 +0000 UTC	Normal	Container started2026-10-19T02:08:41.9303626Z         2026-10-19 02:03:10 +0000 UTC	Normal	Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-10-19T02:08:41.9304861Z         2026-10-19 02:03:27 +0000 UTC	Normal	Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 17.44s (17.613s including waiting). Image size: 528545456 bytes.2026-10-19T02:08:41.9305820Z         2026-10-19 02:03:27 +0000 UTC	Normal	Container created2026-10-19T02:08:41.9306333Z         2026-10-19 02:03:27 +0000 UTC	Normal	Container started2026-10-19T02:08:41.9306705Z         2026-10-19T02:08:41.9307138Z         ---2026-10-19T02:08:41.9307816Z TestOSPoolEP 2026-10-19T02:08:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:08:41.9315302Z     ospool_ep_test.go:72: ---2026-10-19T02:08:41.9315735Z         Events for pod test-cm-5886f7986-m8vqp:2026-10-19T02:08:41.9316819Z         2026-10-19 02:02:49 +0000 UTC	Normal	Successfully assigned test-ospool-ep-jpdu9k/test-cm-5886f7986-m8vqp to minikube2026-10-19T02:08:41.9317579Z         2026-10-19 02:02:50 +0000 UTC	Normal	Pulling image "htcondor/cm:25.x-el9"2026-10-19T02:08:41.9318549Z         2026-10-19 02:03:10 +0000 UTC	Normal	Successfully pulled image "htcondor/cm:25.x-el9" in 1.877s (20.08s including waiting). Image size: 196304120 bytes.2026-10-19T02:08:41.9319287Z         2026-10-19 02:03:10 +0000 UTC	Normal	Container created2026-10-19T02:08:41.9319785Z         2026-10-19 02:03:10 +0000 UTC	Normal	Container started2026-10-19T02:08:41.9320123Z         2026-10-19T02:08:41.9320531Z         ---2026-10-19T02:08:41.9321150Z TestOSPoolEP 2026-10-19T02:08:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-19T02:08:41.9360294Z TestOSPoolEP 2026-10-19T02:08:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k delete -f /tmp/TestOSPoolEP3129721702]2026-10-19T02:08:41.9966130Z TestOSPoolEP 2026-10-19T02:08:41Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-jpdu9k namespace2026-10-19T02:08:41.9974590Z TestOSPoolEP 2026-10-19T02:08:41Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-jpdu9k namespace2026-10-19T02:08:43.1686368Z TestOSPoolEP 2026-10-19T02:08:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k delete -f /tmp/TestOSPoolEP247371149]2026-10-19T02:08:43.2255128Z TestOSPoolEP 2026-10-19T02:08:43Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-jpdu9k namespace2026-10-19T02:08:43.2280999Z TestOSPoolEP 2026-10-19T02:08:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jpdu9k delete -k /tmp/kustomize-template-1940611818]2026-10-19T02:08:43.2966643Z TestOSPoolEP 2026-10-19T02:08:43Z logger.go:67: serviceaccount "cvmfs-nodeplugin" deleted from test-ospool-ep-jpdu9k namespace2026-10-19T02:08:43.3044747Z TestOSPoolEP 2026-10-19T02:08:43Z logger.go:67: service "frontier-squid" deleted from test-ospool-ep-jpdu9k namespace2026-10-19T02:08:43.3096769Z TestOSPoolEP 2026-10-19T02:08:43Z logger.go:67: service "test-cm" deleted from test-ospool-ep-jpdu9k namespace2026-10-19T02:08:43.3129650Z TestOSPoolEP 2026-10-19T02:08:43Z logger.go:67: deployment.apps "cvmfs-nodeplugin" deleted from test-ospool-ep-jpdu9k namespace2026-10-19T02:08:43.3176997Z TestOSPoolEP 2026-10-19T02:08:43Z logger.go:67: deployment.apps "frontier-squid" deleted from test-ospool-ep-jpdu9k namespace2026-10-19T02:08:43.3205144Z TestOSPoolEP 2026-10-19T02:08:43Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-jpdu9k namespace2026-10-19T02:08:43.3236522Z TestOSPoolEP 2026-10-19T02:08:43Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-jpdu9k namespace2026-10-19T02:08:43.3588283Z --- FAIL: TestOSPoolEP (364.20s)2026-10-19T02:08:43.3601806Z     --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (40.06s)2026-10-19T02:08:43.3605111Z     --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP (10.35s)2026-10-19T02:08:43.3606663Z     --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity (0.25s)2026-10-19T02:08:43.3661041Z     --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (301.05s)2026-10-19T02:08:43.3671592Z FAIL2026-10-19T02:08:43.3672170Z FAIL	github.com/osg-htc/k8s-integration-tests/test	364.210s2026-10-19T02:08:43.3695578Z FAIL2026-10-19T02:08:43.4087804Z ##[error]Process completed with exit code 1.2026-10-19T02:08:43.4150485Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-19T02:08:43.4151100Z echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-19T02:08:43.4211188Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-19T02:08:43.4211500Z env:2026-10-19T02:08:43.4211811Z   GOTOOLCHAIN: local2026-10-19T02:08:43.4212219Z   TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-19T02:08:43.4212843Z ##[endgroup]2026-10-19T02:08:43.4482713Z ##[group]Run actions/upload-artifact@v42026-10-19T02:08:43.4483004Z with:2026-10-19T02:08:43.4483364Z   name: TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd72026-10-19T02:08:43.4483790Z   path: /tmp/k8s-tests2026-10-19T02:08:43.4484006Z   retention-days: 52026-10-19T02:08:43.4484207Z   if-no-files-found: warn2026-10-19T02:08:43.4484422Z   compression-level: 62026-10-19T02:08:43.4484620Z   overwrite: false2026-10-19T02:08:43.4484824Z   include-hidden-files: false2026-10-19T02:08:43.4485298Z env:2026-10-19T02:08:43.4485481Z   GOTOOLCHAIN: local2026-10-19T02:08:43.4485685Z ##[endgroup]2026-10-19T02:08:43.5574829Z (node:16452) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-19T02:08:43.5575385Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-19T02:08:43.5626074Z With the provided path, there will be 10 files uploaded2026-10-19T02:08:43.5626812Z Artifact name is valid!2026-10-19T02:08:43.5627133Z Root directory input is valid!2026-10-19T02:08:43.9527586Z Beginning upload of artifact content to blob storage2026-10-19T02:08:43.9730299Z (node:16452) [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-19T02:08:44.2998231Z Uploaded bytes 160852026-10-19T02:08:44.3715383Z Finished uploading artifact content to blob storage!2026-10-19T02:08:44.3716309Z SHA256 digest of uploaded artifact zip is b1bd817a640ebbfe4a2cbefcd648cb1c446eeecb76d24a59801ff3df6561c13e2026-10-19T02:08:44.3717026Z Finalizing artifact upload2026-10-19T02:08:44.6393466Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7.zip successfully finalized. Artifact ID 121587027062026-10-19T02:08:44.6394683Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7 has been successfully uploaded! Final size is 16085 bytes. Artifact ID is 121587027062026-10-19T02:08:44.6398874Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/39187994572/artifacts/121587027062026-10-19T02:08:44.6521422Z Post job cleanup.2026-10-19T02:08:44.7037928Z [command]/usr/bin/git version2026-10-19T02:08:44.7067687Z git version 2.55.02026-10-19T02:08:44.7093391Z Temporarily overriding HOME='/home/runner/work/_temp/88f27aaa-0b4e-41b1-bf1c-4944457ac9d0' before making global git config changes2026-10-19T02:08:44.7094208Z Adding repository directory to the temporary git global config as a safe directory2026-10-19T02:08:44.7102428Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-19T02:08:44.7125167Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-19T02:08:44.7146381Z [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-19T02:08:44.7318032Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-19T02:08:44.7333335Z http.https://github.com/.extraheader2026-10-19T02:08:44.7342311Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-10-19T02:08:44.7369475Z [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-19T02:08:44.7523598Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-19T02:08:44.7566039Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-19T02:08:44.7789189Z Cleaning up orphan processes2026-10-19T02:08:44.8237639Z ##[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/