2026-10-18T01:44:24.4930906Z Current runner version: '2.337.0'2026-10-18T01:44:24.4951086Z ##[group]Runner Image Provisioner2026-10-18T01:44:24.4951925Z Hosted Compute Agent2026-10-18T01:44:24.4952541Z Version: 20261012.6012026-10-18T01:44:24.4952908Z Commit: f3dc54e1fb89da6852db922499a0233137369e1d2026-10-18T01:44:24.4953366Z Build Date: 2026-10-12T17:48:21Z2026-10-18T01:44:24.4953770Z Worker ID: {279f408c-ec1c-457f-9e4b-6108022dfacb}2026-10-18T01:44:24.4954192Z Region: southcentralus2026-10-18T01:44:24.4954541Z Cloud: Azure2026-10-18T01:44:24.4954861Z ##[endgroup]2026-10-18T01:44:24.4955980Z ##[group]Operating System2026-10-18T01:44:24.4956358Z Ubuntu2026-10-18T01:44:24.4956680Z 22.04.52026-10-18T01:44:24.4956985Z LTS2026-10-18T01:44:24.4957291Z ##[endgroup]2026-10-18T01:44:24.4957630Z ##[group]Runner Image2026-10-18T01:44:24.4957987Z Image: ubuntu-22.042026-10-18T01:44:24.4958318Z Version: 20261012.322.12026-10-18T01:44:24.4959138Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20261012.322/images/ubuntu/Ubuntu2204-Readme.md2026-10-18T01:44:24.4960039Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20261012.3222026-10-18T01:44:24.4960609Z ##[endgroup]2026-10-18T01:44:24.4962813Z ##[group]GITHUB_TOKEN Permissions2026-10-18T01:44:24.4964490Z Actions: write2026-10-18T01:44:24.4964864Z ArtifactMetadata: write2026-10-18T01:44:24.4965239Z Attestations: write2026-10-18T01:44:24.4965576Z Checks: write2026-10-18T01:44:24.4965923Z CodeQuality: write2026-10-18T01:44:24.4966262Z Contents: write2026-10-18T01:44:24.4966581Z CopilotRequests: write2026-10-18T01:44:24.4966953Z Deployments: write2026-10-18T01:44:24.4967301Z Discussions: write2026-10-18T01:44:24.4967657Z Drives: write2026-10-18T01:44:24.4967969Z Issues: write2026-10-18T01:44:24.4968341Z Metadata: read2026-10-18T01:44:24.4968680Z Models: read2026-10-18T01:44:24.4968995Z Packages: write2026-10-18T01:44:24.4969326Z Pages: write2026-10-18T01:44:24.4969656Z PullRequests: write2026-10-18T01:44:24.4970003Z RepositoryProjects: write2026-10-18T01:44:24.4970407Z SecurityEvents: write2026-10-18T01:44:24.4970749Z Statuses: write2026-10-18T01:44:24.4971103Z VulnerabilityAlerts: read2026-10-18T01:44:24.4971455Z ##[endgroup]2026-10-18T01:44:24.4973136Z Secret source: Actions2026-10-18T01:44:24.4973741Z Cache mode: write2026-10-18T01:44:24.4974263Z Prepare workflow directory2026-10-18T01:44:24.5201552Z Prepare all required actions2026-10-18T01:44:24.5235487Z Getting action download info2026-10-18T01:44:24.7950555Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-10-18T01:44:24.9180113Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-10-18T01:44:25.3059771Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-10-18T01:44:25.7353348Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-10-18T01:44:26.0135558Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (63ec080e4eea87fb8a9eae678ab9944ec2461251)2026-10-18T01:44:26.0139671Z ##[group] Inputs2026-10-18T01:44:26.0140290Z testName: TestOSPoolEP2026-10-18T01:44:26.0141405Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-18T01:44:26.0142837Z setupScript: 2026-10-18T01:44:26.0143397Z setupEnv: {}2026-10-18T01:44:26.0143935Z ##[endgroup]2026-10-18T01:44:26.0144794Z Complete job name: ospool-ep / Run OSPool EP test (cvmfs-bind, 25-testing) / Run Tests2026-10-18T01:44:26.0647892Z ##[group]Run actions/checkout@v52026-10-18T01:44:26.0648689Z with:2026-10-18T01:44:26.0649240Z repository: osg-htc/k8s-integration-tests2026-10-18T01:44:26.0654776Z token: ***2026-10-18T01:44:26.0655289Z ssh-strict: true2026-10-18T01:44:26.0655830Z ssh-user: git2026-10-18T01:44:26.0656385Z persist-credentials: true2026-10-18T01:44:26.0656980Z clean: true2026-10-18T01:44:26.0657714Z sparse-checkout-cone-mode: true2026-10-18T01:44:26.0658349Z fetch-depth: 12026-10-18T01:44:26.0658868Z fetch-tags: false2026-10-18T01:44:26.0659414Z show-progress: true2026-10-18T01:44:26.0659959Z lfs: false2026-10-18T01:44:26.0660460Z submodules: false2026-10-18T01:44:26.0661034Z set-safe-directory: true2026-10-18T01:44:26.0661660Z allow-unsafe-pr-checkout: false2026-10-18T01:44:26.0662466Z ##[endgroup]2026-10-18T01:44:26.1337987Z Syncing repository: osg-htc/k8s-integration-tests2026-10-18T01:44:26.1340432Z ##[group]Getting Git version info2026-10-18T01:44:26.1341897Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-18T01:44:26.1343801Z [command]/usr/bin/git version2026-10-18T01:44:26.1386112Z git version 2.55.02026-10-18T01:44:26.1408533Z ##[endgroup]2026-10-18T01:44:26.1417020Z Temporarily overriding HOME='/home/runner/work/_temp/b3579fad-7a73-4f05-9982-a402a494d73b' before making global git config changes2026-10-18T01:44:26.1419672Z Adding repository directory to the temporary git global config as a safe directory2026-10-18T01:44:26.1422205Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-18T01:44:26.1447396Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-18T01:44:26.1449987Z ##[group]Initializing the repository2026-10-18T01:44:26.1454044Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-18T01:44:26.1519934Z hint: Using 'master' as the name for the initial branch. This default branch name2026-10-18T01:44:26.1521947Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-10-18T01:44:26.1523980Z hint: to use in all of your new repositories, which will suppress this warning,2026-10-18T01:44:26.1525344Z hint: call:2026-10-18T01:44:26.1526044Z hint:2026-10-18T01:44:26.1526944Z hint: git config --global init.defaultBranch <name>2026-10-18T01:44:26.1528041Z hint:2026-10-18T01:44:26.1529029Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-10-18T01:44:26.1530779Z hint: 'development'. The just-created branch can be renamed via this command:2026-10-18T01:44:26.1531726Z hint:2026-10-18T01:44:26.1532363Z hint: git branch -m <name>2026-10-18T01:44:26.1532920Z hint:2026-10-18T01:44:26.1533676Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-10-18T01:44:26.1535375Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-10-18T01:44:26.1538357Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-10-18T01:44:26.1558011Z ##[endgroup]2026-10-18T01:44:26.1559349Z ##[group]Disabling automatic garbage collection2026-10-18T01:44:26.1560819Z [command]/usr/bin/git config --local gc.auto 02026-10-18T01:44:26.1583427Z ##[endgroup]2026-10-18T01:44:26.1584633Z ##[group]Setting up auth2026-10-18T01:44:26.1595948Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-18T01:44:26.1623840Z [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-18T01:44:26.1822482Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-18T01:44:26.1839415Z [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-18T01:44:26.1958147Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-18T01:44:26.1979098Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-18T01:44:26.2094522Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-10-18T01:44:26.2122814Z ##[endgroup]2026-10-18T01:44:26.2123978Z ##[group]Fetching the repository2026-10-18T01:44:26.2129686Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +63ec080e4eea87fb8a9eae678ab9944ec2461251:refs/remotes/origin/main2026-10-18T01:44:26.5657887Z From https://github.com/osg-htc/k8s-integration-tests2026-10-18T01:44:26.5658402Z * [new ref] 63ec080e4eea87fb8a9eae678ab9944ec2461251 -> origin/main2026-10-18T01:44:26.5661190Z ##[endgroup]2026-10-18T01:44:26.5661602Z ##[group]Determining the checkout info2026-10-18T01:44:26.5663295Z ##[endgroup]2026-10-18T01:44:26.5667236Z [command]/usr/bin/git sparse-checkout disable2026-10-18T01:44:26.5694928Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-10-18T01:44:26.5712178Z ##[group]Checking out the ref2026-10-18T01:44:26.5714549Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-10-18T01:44:26.5759059Z Switched to a new branch 'main'2026-10-18T01:44:26.5759728Z branch 'main' set up to track 'origin/main'.2026-10-18T01:44:26.5765799Z ##[endgroup]2026-10-18T01:44:26.5784288Z [command]/usr/bin/git log -1 --format=%H2026-10-18T01:44:26.5797416Z 63ec080e4eea87fb8a9eae678ab9944ec24612512026-10-18T01:44:26.6029564Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-18T01:44:26.6030093Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-18T01:44:26.6030527Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-18T01:44:26.6325769Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-18T01:44:26.6326098Z env:2026-10-18T01:44:26.6326450Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-18T01:44:26.6326851Z SETUP_ENV_YAML: {}2026-10-18T01:44:26.6327041Z ##[endgroup]2026-10-18T01:44:26.7812705Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-18T01:44:26.7813177Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-10-18T01:44:26.7847764Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-18T01:44:26.7848025Z env:2026-10-18T01:44:26.7848367Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfs-bind"}2026-10-18T01:44:26.7848738Z ##[endgroup]2026-10-18T01:44:26.7933333Z ##[group]Run true2026-10-18T01:44:26.7933580Z [36;1mtrue[0m2026-10-18T01:44:26.7968534Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-18T01:44:26.7968827Z ##[endgroup]2026-10-18T01:44:26.8150993Z ##[group]Run medyagh/setup-minikube@latest2026-10-18T01:44:26.8151277Z with:2026-10-18T01:44:26.8151487Z start: true2026-10-18T01:44:26.8151680Z cache: true2026-10-18T01:44:26.8151886Z minikube-version: latest2026-10-18T01:44:26.8152282Z wait: all2026-10-18T01:44:26.8152473Z ##[endgroup]2026-10-18T01:44:26.8914273Z (node:1855) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-18T01:44:26.8915254Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-18T01:44:28.1452765Z [command]/usr/bin/chmod +x /home/runner/work/_temp/7a3be2f8-711b-42a8-a9c0-5c751d889b0b2026-10-18T01:44:28.9109435Z [command]/home/runner/bin/minikube version --short2026-10-18T01:44:28.9354961Z v1.39.02026-10-18T01:44:29.0914181Z Cache hit for: preloaded-tarball-v1.39.0-x64-stable-docker2026-10-18T01:44:29.0989402Z (node:1855) [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-18T01:44:29.0996534Z Cache hit for: kic-v1.39.0-x642026-10-18T01:44:30.2715183Z Received 130023424 of 288577004 (45.1%), 123.9 MBs/sec2026-10-18T01:44:30.3223589Z Received 125829120 of 531630645 (23.7%), 115.8 MBs/sec2026-10-18T01:44:31.0752630Z Received 288577004 of 288577004 (100.0%), 152.6 MBs/sec2026-10-18T01:44:31.0753236Z Cache Size: ~275 MB (288577004 B)2026-10-18T01:44:31.0778478Z [command]/usr/bin/tar -xf /home/runner/work/_temp/8f74a017-9204-45f2-945a-ae5ff0877ee8/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-18T01:44:31.3231865Z Received 281018368 of 531630645 (52.9%), 131.6 MBs/sec2026-10-18T01:44:31.5184063Z Cache restored successfully2026-10-18T01:44:32.3208656Z Received 494927872 of 531630645 (93.1%), 155.4 MBs/sec2026-10-18T01:44:32.4931011Z Received 531630645 of 531630645 (100.0%), 158.0 MBs/sec2026-10-18T01:44:32.4931958Z Cache Size: ~507 MB (531630645 B)2026-10-18T01:44:32.5102285Z [command]/usr/bin/tar -xf /home/runner/work/_temp/8e0d4c5d-6b2c-4405-82a5-1d1650410a39/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-18T01:44:32.8748398Z Cache restored successfully2026-10-18T01:44:32.9256788Z [command]/home/runner/bin/minikube start --wait all2026-10-18T01:44:32.9521415Z * minikube v1.39.0 on Ubuntu 22.042026-10-18T01:44:34.5326295Z ! 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-18T01:44:34.5333477Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-10-18T01:44:34.5647902Z * Using Docker driver with root privileges2026-10-18T01:44:34.5654390Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-10-18T01:44:34.5658620Z * Pulling base image v0.0.51 ...2026-10-18T01:44:59.0586732Z * Preparing Kubernetes v1.37.0 on containerd 2.3.4 ...2026-10-18T01:45:04.7803376Z * Configuring CNI (Container Networking Interface) ...2026-10-18T01:45:10.0537985Z * Verifying Kubernetes components...2026-10-18T01:45:10.0713870Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-10-18T01:45:10.3720386Z * Enabled addons: storage-provisioner, default-storageclass2026-10-18T01:45:26.6805292Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-10-18T01:45:26.6877549Z [command]/home/runner/bin/minikube version --short2026-10-18T01:45:26.7128249Z v1.39.02026-10-18T01:45:26.7307832Z ##[group]Run actions/setup-go@v62026-10-18T01:45:26.7308014Z with:2026-10-18T01:45:26.7308145Z go-version: 1.262026-10-18T01:45:26.7308272Z cache: true2026-10-18T01:45:26.7308419Z cache-dependency-path: go.sum2026-10-18T01:45:26.7308583Z check-latest: false2026-10-18T01:45:26.7310013Z token: ***2026-10-18T01:45:26.7310141Z ##[endgroup]2026-10-18T01:45:26.8168860Z Setup go version spec 1.262026-10-18T01:45:26.8205620Z Found in cache @ /opt/hostedtoolcache/go/1.26.9/x642026-10-18T01:45:26.8207408Z Added go to the path2026-10-18T01:45:26.8209832Z Successfully set up Go version 1.262026-10-18T01:45:26.9957133Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOMODCACHE2026-10-18T01:45:26.9993682Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOCACHE2026-10-18T01:45:27.0007863Z /home/runner/go/pkg/mod2026-10-18T01:45:27.0024712Z /home/runner/.cache/go-build2026-10-18T01:45:27.1674508Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-18T01:45:28.3817176Z Received 134217728 of 249167808 (53.9%), 123.6 MBs/sec2026-10-18T01:45:28.8516996Z Received 249167808 of 249167808 (100.0%), 157.6 MBs/sec2026-10-18T01:45:28.8517556Z Cache Size: ~238 MB (249167808 B)2026-10-18T01:45:28.8610081Z [command]/usr/bin/tar -xf /home/runner/work/_temp/2f9c9b32-5e50-43ee-8e6d-d3a46753a3f0/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-18T01:45:29.9530275Z Cache restored successfully2026-10-18T01:45:29.9733534Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-18T01:45:29.9760582Z go version go1.26.9 linux/amd642026-10-18T01:45:29.9760761Z 2026-10-18T01:45:29.9761043Z ##[group]go env2026-10-18T01:45:29.9830414Z AR='ar'2026-10-18T01:45:29.9830663Z CC='gcc'2026-10-18T01:45:29.9830873Z CGO_CFLAGS='-O2 -g'2026-10-18T01:45:29.9831195Z CGO_CPPFLAGS=''2026-10-18T01:45:29.9831429Z CGO_CXXFLAGS='-O2 -g'2026-10-18T01:45:29.9831640Z CGO_ENABLED='1'2026-10-18T01:45:29.9831831Z CGO_FFLAGS='-O2 -g'2026-10-18T01:45:29.9832032Z CGO_LDFLAGS='-O2 -g'2026-10-18T01:45:29.9832388Z CXX='g++'2026-10-18T01:45:29.9832580Z GCCGO='gccgo'2026-10-18T01:45:29.9832762Z GO111MODULE=''2026-10-18T01:45:29.9832945Z GOAMD64='v1'2026-10-18T01:45:29.9833141Z GOARCH='amd64'2026-10-18T01:45:29.9833348Z GOAUTH='netrc'2026-10-18T01:45:29.9833522Z GOBIN=''2026-10-18T01:45:29.9833719Z GOCACHE='/home/runner/.cache/go-build'2026-10-18T01:45:29.9833977Z GOCACHEPROG=''2026-10-18T01:45:29.9834178Z GODEBUG=''2026-10-18T01:45:29.9834426Z GOENV='/home/runner/.config/go/env'2026-10-18T01:45:29.9834692Z GOEXE=''2026-10-18T01:45:29.9834870Z GOEXPERIMENT=''2026-10-18T01:45:29.9835066Z GOFIPS140='off'2026-10-18T01:45:29.9835248Z GOFLAGS=''2026-10-18T01:45:29.9835814Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build1033950354=/tmp/go-build -gno-record-gcc-switches'2026-10-18T01:45:29.9836386Z GOHOSTARCH='amd64'2026-10-18T01:45:29.9836585Z GOHOSTOS='linux'2026-10-18T01:45:29.9836778Z GOINSECURE=''2026-10-18T01:45:29.9837095Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-10-18T01:45:29.9837471Z GOMODCACHE='/home/runner/go/pkg/mod'2026-10-18T01:45:29.9837712Z GONOPROXY=''2026-10-18T01:45:29.9837905Z GONOSUMDB=''2026-10-18T01:45:29.9838082Z GOOS='linux'2026-10-18T01:45:29.9838276Z GOPATH='/home/runner/go'2026-10-18T01:45:29.9838494Z GOPRIVATE=''2026-10-18T01:45:29.9838747Z GOPROXY='https://proxy.golang.org,direct'2026-10-18T01:45:29.9839047Z GOROOT='/opt/hostedtoolcache/go/1.26.9/x64'2026-10-18T01:45:29.9839325Z GOSUMDB='sum.golang.org'2026-10-18T01:45:29.9839556Z GOTELEMETRY='local'2026-10-18T01:45:29.9839809Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-10-18T01:45:29.9840085Z GOTMPDIR=''2026-10-18T01:45:29.9840278Z GOTOOLCHAIN='local'2026-10-18T01:45:29.9840862Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.9/x64/pkg/tool/linux_amd64'2026-10-18T01:45:29.9841189Z GOVCS=''2026-10-18T01:45:29.9841370Z GOVERSION='go1.26.9'2026-10-18T01:45:29.9841571Z GOWORK=''2026-10-18T01:45:29.9841766Z PKG_CONFIG='pkg-config'2026-10-18T01:45:29.9841908Z 2026-10-18T01:45:29.9842396Z ##[endgroup]2026-10-18T01:45:30.0078012Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-18T01:45:30.0078344Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-10-18T01:45:30.0112290Z shell: /usr/bin/bash -e {0}2026-10-18T01:45:30.0112461Z env:2026-10-18T01:45:30.0112585Z GOTOOLCHAIN: local2026-10-18T01:45:30.0112732Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-10-18T01:45:30.0112891Z OSPOOL_EP_CMTag: 25.x-el92026-10-18T01:45:30.0113164Z OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-18T01:45:30.0113397Z ##[endgroup]2026-10-18T01:45:34.1382555Z === RUN TestOSPoolEP2026-10-18T01:45:34.1382937Z === PAUSE TestOSPoolEP2026-10-18T01:45:34.1383141Z === CONT TestOSPoolEP2026-10-18T01:45:34.1393681Z TestOSPoolEP 2026-10-18T01:45:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:45:34.1710239Z TestOSPoolEP 2026-10-18T01:45:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 apply -f /tmp/TestOSPoolEP2565864174]2026-10-18T01:45:34.3861608Z TestOSPoolEP 2026-10-18T01:45:34Z logger.go:67: pod/idtoken-generator created2026-10-18T01:45:34.3902334Z TestOSPoolEP 2026-10-18T01:45:34Z logger.go:67: secret/pool-passwd created2026-10-18T01:45:34.3960895Z TestOSPoolEP 2026-10-18T01:45:34Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-18T01:45:34.3985367Z TestOSPoolEP 2026-10-18T01:45:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:45:34.3990407Z TestOSPoolEP 2026-10-18T01:45:34Z 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-18T01:45:44.3982885Z TestOSPoolEP 2026-10-18T01:45:44Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-18T01:45:44.3985348Z TestOSPoolEP 2026-10-18T01:45:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:45:44.4006051Z TestOSPoolEP 2026-10-18T01:45:44Z logger.go:67: Pod is now available2026-10-18T01:45:44.4006783Z TestOSPoolEP 2026-10-18T01:45:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-10-18T01:45:44.4839440Z TestOSPoolEP 2026-10-18T01:45:44Z logger.go:67: ***2026-10-18T01:45:44.4867336Z TestOSPoolEP 2026-10-18T01:45:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 apply -f /tmp/TestOSPoolEP2017606297]2026-10-18T01:45:44.5966884Z TestOSPoolEP 2026-10-18T01:45:44Z logger.go:67: secret/pool-token created2026-10-18T01:45:44.5980399Z TestOSPoolEP 2026-10-18T01:45:44Z retry.go:91: Wait for secret pool-token to be provisioned.2026-10-18T01:45:44.5980915Z TestOSPoolEP 2026-10-18T01:45:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:45:44.5996448Z TestOSPoolEP 2026-10-18T01:45:44Z logger.go:67: Secret is now available2026-10-18T01:45:44.6005175Z TestOSPoolEP 2026-10-18T01:45:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 apply -k /tmp/kustomize-template-454407576]2026-10-18T01:45:44.7963700Z TestOSPoolEP 2026-10-18T01:45:44Z logger.go:67: serviceaccount/cvmfs-nodeplugin created2026-10-18T01:45:44.8023665Z TestOSPoolEP 2026-10-18T01:45:44Z logger.go:67: service/frontier-squid created2026-10-18T01:45:44.8094478Z TestOSPoolEP 2026-10-18T01:45:44Z logger.go:67: service/test-cm created2026-10-18T01:45:44.8150130Z TestOSPoolEP 2026-10-18T01:45:44Z logger.go:67: deployment.apps/cvmfs-nodeplugin created2026-10-18T01:45:44.8224515Z TestOSPoolEP 2026-10-18T01:45:44Z logger.go:67: deployment.apps/frontier-squid created2026-10-18T01:45:44.8360337Z TestOSPoolEP 2026-10-18T01:45:44Z 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-18T01:45:44.8366689Z TestOSPoolEP 2026-10-18T01:45:44Z logger.go:67: deployment.apps/ospool-ep created2026-10-18T01:45:44.8501950Z TestOSPoolEP 2026-10-18T01:45:44Z logger.go:67: deployment.apps/test-cm created2026-10-18T01:45:44.8526981Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-10-18T01:45:44.8537922Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:45:44.8603269Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:44Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-18T01:45:44.8604511Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:45:44.8605607Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:44Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-18T01:45:44.8607020Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:45:44.8625064Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:44Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-18T01:45:44.8626100Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:45:44.8627039Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:44Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-18T01:45:44.8628092Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:45:44.8679481Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:44Z 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: NewReplicaSetCreated, message: Created new replica set "frontier-squid-65f85c968". Sleeping for 10s and will try again.2026-10-18T01:45:44.8681472Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:44Z 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-18T01:45:44.8683282Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:44Z 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-18T01:45:44.8684800Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:44Z 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-18T01:45:54.8686289Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:54Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-18T01:45:54.8711897Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:45:54.8715716Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:54Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-18T01:45:54.8719495Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:45:54.8722205Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:54Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-18T01:45:54.8723339Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:45:54.8726315Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:54Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-18T01:45:54.8729310Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:45:54.8736004Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:54Z logger.go:67: Deployment is now available2026-10-18T01:45:54.8754504Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:54Z 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-18T01:45:54.8757718Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:54Z 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-18T01:45:54.8760560Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:45:54Z 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-18T01:46:04.8755261Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:04Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-18T01:46:04.8759346Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:46:04.8772623Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:04Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-18T01:46:04.8773810Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:46:04.8776072Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:04Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-18T01:46:04.8778383Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:46:04.8798463Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:04Z logger.go:67: Deployment is now available2026-10-18T01:46:04.8800432Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:04Z 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-18T01:46:04.8804524Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:04Z 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-18T01:46:14.8797943Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:14Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-18T01:46:14.8798852Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:46:14.8806062Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:14Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-18T01:46:14.8807011Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:46:14.8821882Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:14Z logger.go:67: Deployment is now available2026-10-18T01:46:14.8823049Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:14Z 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-18T01:46:24.8841646Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:24Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-18T01:46:24.8842864Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:24Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:46:24.8870101Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:24Z 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-18T01:46:34.8877410Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:34Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-18T01:46:34.8878025Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:46:34.8904296Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-18T01:46:34Z logger.go:67: Deployment is now available2026-10-18T01:46:34.8906203Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP2026-10-18T01:46:34.8906850Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-18T01:46:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:46:34.8925332Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-18T01:46:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 cp ../test-configs/ospool-ep/condor_status.sh test-cm-5886f7986-d6qk9:/tmp/condor_status.sh]2026-10-18T01:46:35.2046618Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-18T01:46:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec test-cm-5886f7986-d6qk9 -- chmod +x /tmp/condor_status.sh]2026-10-18T01:46:35.3374204Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-18T01:46:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec test-cm-5886f7986-d6qk9 -- sh -c /tmp/condor_status.sh]2026-10-18T01:46:35.5447231Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-18T01:46:35Z logger.go:67: command terminated with exit code 12026-10-18T01:46:35.5448148Z test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-5886f7986-d6qk9 failed. Retrying in 10s.2026-10-18T01:46:45.5413292Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-18T01:46:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec test-cm-5886f7986-d6qk9 -- sh -c /tmp/condor_status.sh]2026-10-18T01:46:45.6533658Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-18T01:46:45Z logger.go:67: command terminated with exit code 12026-10-18T01:46:45.6535606Z test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-5886f7986-d6qk9 failed. Retrying in 10s.2026-10-18T01:46:55.6537963Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-18T01:46:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec test-cm-5886f7986-d6qk9 -- sh -c /tmp/condor_status.sh]2026-10-18T01:46:55.7388856Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity2026-10-18T01:46:55.7389702Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-18T01:46:55Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:46:55.7414000Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-18T01:46:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 cp ../test-configs/ospool-ep/has_singularity.sh test-cm-5886f7986-d6qk9:/tmp/has_singularity.sh]2026-10-18T01:46:55.8368656Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-18T01:46:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec test-cm-5886f7986-d6qk9 -- chmod +x /tmp/has_singularity.sh]2026-10-18T01:46:55.9113476Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-18T01:46:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec test-cm-5886f7986-d6qk9 -- sh -c /tmp/has_singularity.sh]2026-10-18T01:46:56.0026752Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-10-18T01:46:56.0027613Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:46:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:46:56.0051742Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:46:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 cp ../test-configs/ospool-ep/has_cvmfs.sh test-cm-5886f7986-d6qk9:/tmp/has_cvmfs.sh]2026-10-18T01:46:56.1005836Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:46:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec test-cm-5886f7986-d6qk9 -- chmod +x /tmp/has_cvmfs.sh]2026-10-18T01:46:56.1781774Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:46:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec test-cm-5886f7986-d6qk9 -- sh -c /tmp/has_cvmfs.sh]2026-10-18T01:46:56.2727716Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:46:56Z logger.go:67: command terminated with exit code 12026-10-18T01:46:56.2739065Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-d6qk9 failed. Retrying in 30s.2026-10-18T01:47:26.2750537Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:47:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec test-cm-5886f7986-d6qk9 -- sh -c /tmp/has_cvmfs.sh]2026-10-18T01:47:26.3567881Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:47:26Z logger.go:67: command terminated with exit code 12026-10-18T01:47:26.3578643Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-d6qk9 failed. Retrying in 30s.2026-10-18T01:47:56.3583879Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:47:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec test-cm-5886f7986-d6qk9 -- sh -c /tmp/has_cvmfs.sh]2026-10-18T01:47:56.4420481Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:47:56Z logger.go:67: command terminated with exit code 12026-10-18T01:47:56.4431703Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-d6qk9 failed. Retrying in 30s.2026-10-18T01:48:26.4436321Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:48:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec test-cm-5886f7986-d6qk9 -- sh -c /tmp/has_cvmfs.sh]2026-10-18T01:48:26.5344478Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:48:26Z logger.go:67: command terminated with exit code 12026-10-18T01:48:26.5356656Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-d6qk9 failed. Retrying in 30s.2026-10-18T01:48:56.5368620Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:48:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec test-cm-5886f7986-d6qk9 -- sh -c /tmp/has_cvmfs.sh]2026-10-18T01:48:56.6201103Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:48:56Z logger.go:67: command terminated with exit code 12026-10-18T01:48:56.6214567Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-d6qk9 failed. Retrying in 30s.2026-10-18T01:49:26.6224988Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:49:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec test-cm-5886f7986-d6qk9 -- sh -c /tmp/has_cvmfs.sh]2026-10-18T01:49:26.7062279Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:49:26Z logger.go:67: command terminated with exit code 12026-10-18T01:49:26.7074647Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-d6qk9 failed. Retrying in 30s.2026-10-18T01:49:56.7082321Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:49:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec test-cm-5886f7986-d6qk9 -- sh -c /tmp/has_cvmfs.sh]2026-10-18T01:49:56.7923570Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:49:56Z logger.go:67: command terminated with exit code 12026-10-18T01:49:56.7935500Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-d6qk9 failed. Retrying in 30s.2026-10-18T01:50:26.7936417Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:50:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec test-cm-5886f7986-d6qk9 -- sh -c /tmp/has_cvmfs.sh]2026-10-18T01:50:26.8968933Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:50:26Z logger.go:67: command terminated with exit code 12026-10-18T01:50:26.8982917Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-d6qk9 failed. Retrying in 30s.2026-10-18T01:50:56.9003316Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:50:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec test-cm-5886f7986-d6qk9 -- sh -c /tmp/has_cvmfs.sh]2026-10-18T01:50:56.9808296Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:50:56Z logger.go:67: command terminated with exit code 12026-10-18T01:50:56.9819586Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-d6qk9 failed. Retrying in 30s.2026-10-18T01:51:26.9828815Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:51:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 exec test-cm-5886f7986-d6qk9 -- sh -c /tmp/has_cvmfs.sh]2026-10-18T01:51:27.0691469Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-18T01:51:27Z logger.go:67: command terminated with exit code 12026-10-18T01:51:27.0705216Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-d6qk9 failed. Retrying in 30s.2026-10-18T01:51:57.0725598Z test_utils.go:105: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-d6qk9 did not succeed within {10 30000000000} retries2026-10-18T01:51:57.0726847Z TestOSPoolEP 2026-10-18T01:51:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:51:57.0783279Z TestOSPoolEP 2026-10-18T01:51:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:51:57.1486357Z TestOSPoolEP 2026-10-18T01:51:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:51:57.2110890Z TestOSPoolEP 2026-10-18T01:51:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:51:57.2783356Z TestOSPoolEP 2026-10-18T01:51:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:51:57.3628756Z TestOSPoolEP 2026-10-18T01:51:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:51:57.4305352Z TestOSPoolEP 2026-10-18T01:51:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:51:57.4329148Z === NAME TestOSPoolEP2026-10-18T01:51:57.4329468Z ospool_ep_test.go:72: ---2026-10-18T01:51:57.4329883Z Events for pod cvmfs-nodeplugin-5cd89c7cfd-6tjxm:2026-10-18T01:51:57.4330560Z 2026-10-18 01:45:44 +0000 UTC Normal Successfully assigned test-ospool-ep-zu3yg5/cvmfs-nodeplugin-5cd89c7cfd-6tjxm to minikube2026-10-18T01:51:57.4331128Z 2026-10-18 01:45:45 +0000 UTC Normal Pulling image "opensciencegrid/cvmfs-nodeplugin:fresh"2026-10-18T01:51:57.4331831Z 2026-10-18 01:45:48 +0000 UTC Normal Successfully pulled image "opensciencegrid/cvmfs-nodeplugin:fresh" in 3.738s (3.738s including waiting). Image size: 155940803 bytes.2026-10-18T01:51:57.4332511Z 2026-10-18 01:45:48 +0000 UTC Normal Container created2026-10-18T01:51:57.4332915Z 2026-10-18 01:45:48 +0000 UTC Normal Container started2026-10-18T01:51:57.4333212Z 2026-10-18T01:51:57.4333411Z ---2026-10-18T01:51:57.4333900Z TestOSPoolEP 2026-10-18T01:51:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:51:57.4348597Z ospool_ep_test.go:72: ---2026-10-18T01:51:57.4349157Z Events for pod frontier-squid-65f85c968-mjwv5:2026-10-18T01:51:57.4350068Z 2026-10-18 01:45:44 +0000 UTC Normal Successfully assigned test-ospool-ep-zu3yg5/frontier-squid-65f85c968-mjwv5 to minikube2026-10-18T01:51:57.4351077Z 2026-10-18 01:45:45 +0000 UTC Normal Pulling image "opensciencegrid/frontier-squid:fresh"2026-10-18T01:51:57.4352479Z 2026-10-18 01:45:57 +0000 UTC Normal Successfully pulled image "opensciencegrid/frontier-squid:fresh" in 8.543s (12.268s including waiting). Image size: 453187319 bytes.2026-10-18T01:51:57.4353353Z 2026-10-18 01:45:57 +0000 UTC Normal Container created2026-10-18T01:51:57.4353911Z 2026-10-18 01:45:57 +0000 UTC Normal Container started2026-10-18T01:51:57.4354283Z 2026-10-18T01:51:57.4354498Z ---2026-10-18T01:51:57.4355046Z TestOSPoolEP 2026-10-18T01:51:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:51:57.4365688Z ospool_ep_test.go:72: ---2026-10-18T01:51:57.4366272Z Events for pod idtoken-generator:2026-10-18T01:51:57.4367181Z 2026-10-18 01:45:34 +0000 UTC Normal Successfully assigned test-ospool-ep-zu3yg5/idtoken-generator to minikube2026-10-18T01:51:57.4367936Z 2026-10-18 01:45:34 +0000 UTC Normal Pulling image "htcondor/base"2026-10-18T01:51:57.4369281Z 2026-10-18 01:45:42 +0000 UTC Normal Successfully pulled image "htcondor/base" in 7.731s (7.731s including waiting). Image size: 196303183 bytes.2026-10-18T01:51:57.4370050Z 2026-10-18 01:45:42 +0000 UTC Normal Container created2026-10-18T01:51:57.4370596Z 2026-10-18 01:45:42 +0000 UTC Normal Container started2026-10-18T01:51:57.4370942Z 2026-10-18T01:51:57.4371135Z ---2026-10-18T01:51:57.4371723Z TestOSPoolEP 2026-10-18T01:51:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:51:57.4382902Z ospool_ep_test.go:72: ---2026-10-18T01:51:57.4383369Z Events for pod ospool-ep-674fbdcc48-gvxgq:2026-10-18T01:51:57.4384130Z 2026-10-18 01:45:44 +0000 UTC Normal Successfully assigned test-ospool-ep-zu3yg5/ospool-ep-674fbdcc48-gvxgq to minikube2026-10-18T01:51:57.4384925Z 2026-10-18 01:45:45 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-10-18T01:51:57.4385981Z 2026-10-18 01:46:11 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 13.74s (25.986s including waiting). Image size: 2893600 bytes.2026-10-18T01:51:57.4386967Z 2026-10-18 01:46:11 +0000 UTC Normal Container created2026-10-18T01:51:57.4387403Z 2026-10-18 01:46:11 +0000 UTC Normal Container started2026-10-18T01:51:57.4388056Z 2026-10-18 01:46:12 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-10-18T01:51:57.4389197Z 2026-10-18 01:46:29 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 17.288s (17.552s including waiting). Image size: 528545456 bytes.2026-10-18T01:51:57.4389981Z 2026-10-18 01:46:29 +0000 UTC Normal Container created2026-10-18T01:51:57.4390413Z 2026-10-18 01:46:29 +0000 UTC Normal Container started2026-10-18T01:51:57.4390702Z 2026-10-18T01:51:57.4390896Z ---2026-10-18T01:51:57.4391402Z TestOSPoolEP 2026-10-18T01:51:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:51:57.4404983Z ospool_ep_test.go:72: ---2026-10-18T01:51:57.4405440Z Events for pod test-cm-5886f7986-d6qk9:2026-10-18T01:51:57.4406134Z 2026-10-18 01:45:44 +0000 UTC Normal Successfully assigned test-ospool-ep-zu3yg5/test-cm-5886f7986-d6qk9 to minikube2026-10-18T01:51:57.4406821Z 2026-10-18 01:45:45 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-10-18T01:51:57.4407759Z 2026-10-18 01:46:12 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 1.099s (27.063s including waiting). Image size: 196304120 bytes.2026-10-18T01:51:57.4408519Z 2026-10-18 01:46:12 +0000 UTC Normal Container created2026-10-18T01:51:57.4408947Z 2026-10-18 01:46:12 +0000 UTC Normal Container started2026-10-18T01:51:57.4409238Z 2026-10-18T01:51:57.4409433Z ---2026-10-18T01:51:57.4409914Z TestOSPoolEP 2026-10-18T01:51:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-18T01:51:57.4432861Z TestOSPoolEP 2026-10-18T01:51:57Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 delete -f /tmp/TestOSPoolEP4092248294]2026-10-18T01:51:57.5065059Z TestOSPoolEP 2026-10-18T01:51:57Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-zu3yg5 namespace2026-10-18T01:51:57.5125839Z TestOSPoolEP 2026-10-18T01:51:57Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-zu3yg5 namespace2026-10-18T01:51:58.7186013Z TestOSPoolEP 2026-10-18T01:51:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 delete -f /tmp/TestOSPoolEP1115222683]2026-10-18T01:51:58.7745422Z TestOSPoolEP 2026-10-18T01:51:58Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-zu3yg5 namespace2026-10-18T01:51:58.7782632Z TestOSPoolEP 2026-10-18T01:51:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-zu3yg5 delete -k /tmp/kustomize-template-454407576]2026-10-18T01:51:58.8533958Z TestOSPoolEP 2026-10-18T01:51:58Z logger.go:67: serviceaccount "cvmfs-nodeplugin" deleted from test-ospool-ep-zu3yg5 namespace2026-10-18T01:51:58.8601886Z TestOSPoolEP 2026-10-18T01:51:58Z logger.go:67: service "frontier-squid" deleted from test-ospool-ep-zu3yg5 namespace2026-10-18T01:51:58.8700241Z TestOSPoolEP 2026-10-18T01:51:58Z logger.go:67: service "test-cm" deleted from test-ospool-ep-zu3yg5 namespace2026-10-18T01:51:58.8736910Z TestOSPoolEP 2026-10-18T01:51:58Z logger.go:67: deployment.apps "cvmfs-nodeplugin" deleted from test-ospool-ep-zu3yg5 namespace2026-10-18T01:51:58.8801405Z TestOSPoolEP 2026-10-18T01:51:58Z logger.go:67: deployment.apps "frontier-squid" deleted from test-ospool-ep-zu3yg5 namespace2026-10-18T01:51:58.8822054Z TestOSPoolEP 2026-10-18T01:51:58Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-zu3yg5 namespace2026-10-18T01:51:58.8877723Z TestOSPoolEP 2026-10-18T01:51:58Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-zu3yg5 namespace2026-10-18T01:51:58.9171552Z --- FAIL: TestOSPoolEP (384.78s)2026-10-18T01:51:58.9173195Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (50.04s)2026-10-18T01:51:58.9174023Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP (20.85s)2026-10-18T01:51:58.9174818Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity (0.26s)2026-10-18T01:51:58.9175552Z --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (301.07s)2026-10-18T01:51:58.9176130Z FAIL2026-10-18T01:51:58.9184723Z FAIL github.com/osg-htc/k8s-integration-tests/test 384.788s2026-10-18T01:51:58.9248501Z FAIL2026-10-18T01:51:58.9678167Z ##[error]Process completed with exit code 1.2026-10-18T01:51:58.9745163Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-18T01:51:58.9745894Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-10-18T01:51:58.9797070Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-18T01:51:58.9797409Z env:2026-10-18T01:51:58.9797669Z GOTOOLCHAIN: local2026-10-18T01:51:58.9798094Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-18T01:51:58.9798496Z ##[endgroup]2026-10-18T01:51:59.0217150Z ##[group]Run actions/upload-artifact@v42026-10-18T01:51:59.0217355Z with:2026-10-18T01:51:59.0217686Z name: TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd72026-10-18T01:51:59.0217957Z path: /tmp/k8s-tests2026-10-18T01:51:59.0218099Z retention-days: 52026-10-18T01:51:59.0218275Z if-no-files-found: warn2026-10-18T01:51:59.0218456Z compression-level: 62026-10-18T01:51:59.0218592Z overwrite: false2026-10-18T01:51:59.0218728Z include-hidden-files: false2026-10-18T01:51:59.0218878Z env:2026-10-18T01:51:59.0218998Z GOTOOLCHAIN: local2026-10-18T01:51:59.0219197Z ##[endgroup]2026-10-18T01:51:59.1468714Z (node:16678) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-18T01:51:59.1470176Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-18T01:51:59.1531647Z With the provided path, there will be 10 files uploaded2026-10-18T01:51:59.1532408Z Artifact name is valid!2026-10-18T01:51:59.1532848Z Root directory input is valid!2026-10-18T01:51:59.4541843Z Beginning upload of artifact content to blob storage2026-10-18T01:51:59.4755377Z (node:16678) [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-18T01:51:59.6657736Z Uploaded bytes 161102026-10-18T01:51:59.7118560Z Finished uploading artifact content to blob storage!2026-10-18T01:51:59.7119154Z SHA256 digest of uploaded artifact zip is 7574bc5e30a1fa5756707d13430d4697f4896266908459363bc83e35abb66c342026-10-18T01:51:59.7119934Z Finalizing artifact upload2026-10-18T01:51:59.9593789Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7.zip successfully finalized. Artifact ID 121217107912026-10-18T01:51:59.9594918Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7 has been successfully uploaded! Final size is 16110 bytes. Artifact ID is 121217107912026-10-18T01:51:59.9599030Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/39087566320/artifacts/121217107912026-10-18T01:51:59.9725630Z Post job cleanup.2026-10-18T01:52:00.0247322Z [command]/usr/bin/git version2026-10-18T01:52:00.0279890Z git version 2.55.02026-10-18T01:52:00.0305829Z Temporarily overriding HOME='/home/runner/work/_temp/27b7c8b6-9d20-409d-a353-ad2ff14e673c' before making global git config changes2026-10-18T01:52:00.0306306Z Adding repository directory to the temporary git global config as a safe directory2026-10-18T01:52:00.0309667Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-18T01:52:00.0333654Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-18T01:52:00.0354301Z [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-18T01:52:00.0511998Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-18T01:52:00.0525212Z http.https://github.com/.extraheader2026-10-18T01:52:00.0532477Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-10-18T01:52:00.0554067Z [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-18T01:52:00.0685803Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-18T01:52:00.0708680Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-18T01:52:00.0933630Z Cleaning up orphan processes2026-10-18T01:52:00.1360711Z ##[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/