2026-06-16T21:18:20.2142288Z Current runner version: '2.335.1'2026-06-16T21:18:20.2168256Z ##[group]Runner Image Provisioner2026-06-16T21:18:20.2169227Z Hosted Compute Agent2026-06-16T21:18:20.2169836Z Version: 20260527.5392026-06-16T21:18:20.2170595Z Commit: a891dd388383b896fa6ac04a82c0b75cec9810782026-06-16T21:18:20.2171349Z Build Date: 2026-05-27T21:39:57Z2026-06-16T21:18:20.2172102Z Worker ID: {5025dfb7-5f4e-40be-8e36-75b3eaa4980e}2026-06-16T21:18:20.2172851Z Azure Region: westus2026-06-16T21:18:20.2173443Z ##[endgroup]2026-06-16T21:18:20.2175472Z ##[group]Operating System2026-06-16T21:18:20.2176211Z Ubuntu2026-06-16T21:18:20.2176814Z 22.04.52026-06-16T21:18:20.2177361Z LTS2026-06-16T21:18:20.2177899Z ##[endgroup]2026-06-16T21:18:20.2178528Z ##[group]Runner Image2026-06-16T21:18:20.2179150Z Image: ubuntu-22.042026-06-16T21:18:20.2179706Z Version: 20260607.168.12026-06-16T21:18:20.2181089Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260607.168/images/ubuntu/Ubuntu2204-Readme.md2026-06-16T21:18:20.2182733Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260607.1682026-06-16T21:18:20.2183748Z ##[endgroup]2026-06-16T21:18:20.2185408Z ##[group]GITHUB_TOKEN Permissions2026-06-16T21:18:20.2187459Z Contents: read2026-06-16T21:18:20.2188549Z Metadata: read2026-06-16T21:18:20.2189183Z Packages: read2026-06-16T21:18:20.2189799Z ##[endgroup]2026-06-16T21:18:20.2192300Z Secret source: Actions2026-06-16T21:18:20.2193099Z Prepare workflow directory2026-06-16T21:18:20.2602750Z Prepare all required actions2026-06-16T21:18:20.2641863Z Getting action download info2026-06-16T21:18:20.6948834Z Download action repository 'actions/checkout@v5' (SHA:93cb6efe18208431cddfb8368fd83d5badbf9bfd)2026-06-16T21:18:21.3397448Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-06-16T21:18:21.6953536Z Download action repository 'actions/setup-go@v6' (SHA:4a3601121dd01d1626a1e23e37211e3254c1c06c)2026-06-16T21:18:22.0986589Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-06-16T21:18:22.4190827Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/feature/test-web-view (5e630c471b898ab153532b9dee0ddcad968e518b)2026-06-16T21:18:22.4195393Z ##[group] Inputs2026-06-16T21:18:22.4195753Z testName: TestOSPoolEP2026-06-16T21:18:22.4196381Z testEnv: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-06-16T21:18:22.4197022Z setupScript: 2026-06-16T21:18:22.4197279Z setupEnv: {}2026-06-16T21:18:22.4197541Z ##[endgroup]2026-06-16T21:18:22.4197983Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-testing) / Run Tests2026-06-16T21:18:22.4907422Z ##[group]Run actions/checkout@v52026-06-16T21:18:22.4908092Z with:2026-06-16T21:18:22.4908406Z repository: mwestphall/k8s-integration-tests2026-06-16T21:18:22.4911334Z token: ***2026-06-16T21:18:22.4911636Z ssh-strict: true2026-06-16T21:18:22.4911898Z ssh-user: git2026-06-16T21:18:22.4912163Z persist-credentials: true2026-06-16T21:18:22.4912446Z clean: true2026-06-16T21:18:22.4912731Z sparse-checkout-cone-mode: true2026-06-16T21:18:22.4913040Z fetch-depth: 12026-06-16T21:18:22.4913290Z fetch-tags: false2026-06-16T21:18:22.4913550Z show-progress: true2026-06-16T21:18:22.4913810Z lfs: false2026-06-16T21:18:22.4914046Z submodules: false2026-06-16T21:18:22.4914606Z set-safe-directory: true2026-06-16T21:18:22.4915217Z ##[endgroup]2026-06-16T21:18:22.5959238Z Syncing repository: mwestphall/k8s-integration-tests2026-06-16T21:18:22.5960770Z ##[group]Getting Git version info2026-06-16T21:18:22.5961452Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-06-16T21:18:22.5962327Z [command]/usr/bin/git version2026-06-16T21:18:22.7576538Z git version 2.54.02026-06-16T21:18:22.7635085Z ##[endgroup]2026-06-16T21:18:22.7650048Z Temporarily overriding HOME='/home/runner/work/_temp/04846b1f-ee4f-472a-a4c2-7108740a15cb' before making global git config changes2026-06-16T21:18:22.7651436Z Adding repository directory to the temporary git global config as a safe directory2026-06-16T21:18:22.7656822Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-06-16T21:18:22.7695612Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-06-16T21:18:22.7700100Z ##[group]Initializing the repository2026-06-16T21:18:22.7705176Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-06-16T21:18:22.8293261Z hint: Using 'master' as the name for the initial branch. This default branch name2026-06-16T21:18:22.8295187Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-06-16T21:18:22.8296660Z hint: to use in all of your new repositories, which will suppress this warning,2026-06-16T21:18:22.8297439Z hint: call:2026-06-16T21:18:22.8297805Z hint:2026-06-16T21:18:22.8298359Z hint: git config --global init.defaultBranch <name>2026-06-16T21:18:22.8298953Z hint:2026-06-16T21:18:22.8299506Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-06-16T21:18:22.8300636Z hint: 'development'. The just-created branch can be renamed via this command:2026-06-16T21:18:22.8301352Z hint:2026-06-16T21:18:22.8301735Z hint: git branch -m <name>2026-06-16T21:18:22.8302169Z hint:2026-06-16T21:18:22.8302761Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-06-16T21:18:22.8303919Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-06-16T21:18:22.8307249Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-06-16T21:18:22.8435433Z ##[endgroup]2026-06-16T21:18:22.8441020Z ##[group]Disabling automatic garbage collection2026-06-16T21:18:22.8442297Z [command]/usr/bin/git config --local gc.auto 02026-06-16T21:18:22.8475402Z ##[endgroup]2026-06-16T21:18:22.8475958Z ##[group]Setting up auth2026-06-16T21:18:22.8483517Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-06-16T21:18:22.8518650Z [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-06-16T21:18:23.1330048Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-06-16T21:18:23.1365322Z [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-06-16T21:18:23.1617521Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-06-16T21:18:23.1654096Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-06-16T21:18:23.1922667Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-06-16T21:18:23.1960465Z ##[endgroup]2026-06-16T21:18:23.1961209Z ##[group]Fetching the repository2026-06-16T21:18:23.1970500Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +5e630c471b898ab153532b9dee0ddcad968e518b:refs/remotes/origin/feature/test-web-view2026-06-16T21:18:23.8019520Z From https://github.com/mwestphall/k8s-integration-tests2026-06-16T21:18:23.8021166Z * [new ref] 5e630c471b898ab153532b9dee0ddcad968e518b -> origin/feature/test-web-view2026-06-16T21:18:23.8059767Z ##[endgroup]2026-06-16T21:18:23.8060536Z ##[group]Determining the checkout info2026-06-16T21:18:23.8061867Z ##[endgroup]2026-06-16T21:18:23.8069899Z [command]/usr/bin/git sparse-checkout disable2026-06-16T21:18:23.8178617Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-06-16T21:18:23.8210232Z ##[group]Checking out the ref2026-06-16T21:18:23.8216884Z [command]/usr/bin/git checkout --progress --force -B feature/test-web-view refs/remotes/origin/feature/test-web-view2026-06-16T21:18:23.8355677Z Switched to a new branch 'feature/test-web-view'2026-06-16T21:18:23.8361444Z branch 'feature/test-web-view' set up to track 'origin/feature/test-web-view'.2026-06-16T21:18:23.8367151Z ##[endgroup]2026-06-16T21:18:23.8426206Z [command]/usr/bin/git log -1 --format=%H2026-06-16T21:18:23.8454582Z 5e630c471b898ab153532b9dee0ddcad968e518b2026-06-16T21:18:23.8766811Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-06-16T21:18:23.8767598Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-06-16T21:18:23.9215450Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-06-16T21:18:23.9216019Z env:2026-06-16T21:18:23.9216777Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-06-16T21:18:23.9217635Z ##[endgroup]2026-06-16T21:18:23.9402422Z ##[group]Run true2026-06-16T21:18:23.9402694Z [36;1mtrue[0m2026-06-16T21:18:23.9455401Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-06-16T21:18:23.9455824Z ##[endgroup]2026-06-16T21:18:23.9620516Z ##[group]Run medyagh/setup-minikube@latest2026-06-16T21:18:23.9620843Z with:2026-06-16T21:18:23.9621029Z start: true2026-06-16T21:18:23.9621220Z cache: true2026-06-16T21:18:23.9621416Z minikube-version: latest2026-06-16T21:18:23.9621647Z wait: all2026-06-16T21:18:23.9621834Z ##[endgroup]2026-06-16T21:18:24.0893383Z (node:2031) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-06-16T21:18:24.0895001Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-06-16T21:18:25.2466700Z [command]/usr/bin/chmod +x /home/runner/work/_temp/4c880553-1ac0-4463-9a42-bad1d3ffc4762026-06-16T21:18:25.4382860Z [command]/home/runner/bin/minikube version --short2026-06-16T21:18:25.4902105Z v1.38.12026-06-16T21:18:25.7766562Z Cache hit for: kic-v1.38.1-x642026-06-16T21:18:25.7886936Z (node:2031) [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-06-16T21:18:25.7975662Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-06-16T21:18:27.0793097Z Received 4194304 of 544082650 (0.8%), 4.0 MBs/sec2026-06-16T21:18:27.0998039Z Received 4194304 of 224218855 (1.9%), 4.0 MBs/sec2026-06-16T21:18:28.0793570Z Received 113246208 of 544082650 (20.8%), 54.0 MBs/sec2026-06-16T21:18:28.1070842Z Received 92274688 of 224218855 (41.2%), 43.9 MBs/sec2026-06-16T21:18:29.0792473Z Received 222298112 of 544082650 (40.9%), 70.7 MBs/sec2026-06-16T21:18:29.1080868Z Received 167772160 of 224218855 (74.8%), 53.2 MBs/sec2026-06-16T21:18:29.5522549Z Received 224218855 of 224218855 (100.0%), 62.0 MBs/sec2026-06-16T21:18:29.5523987Z Cache Size: ~214 MB (224218855 B)2026-06-16T21:18:29.5567894Z [command]/usr/bin/tar -xf /home/runner/work/_temp/f1eb7335-0f52-45eb-b344-b87f67be6c24/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-06-16T21:18:30.0826158Z Received 348127232 of 544082650 (64.0%), 83.0 MBs/sec2026-06-16T21:18:30.1899354Z Cache restored successfully2026-06-16T21:18:31.0807855Z Received 478150656 of 544082650 (87.9%), 91.2 MBs/sec2026-06-16T21:18:31.7111072Z Received 544082650 of 544082650 (100.0%), 92.1 MBs/sec2026-06-16T21:18:31.7112223Z Cache Size: ~519 MB (544082650 B)2026-06-16T21:18:31.7233170Z [command]/usr/bin/tar -xf /home/runner/work/_temp/011d6ba8-a2a0-4e89-950a-8344b06e23ae/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-06-16T21:18:32.5625739Z Cache restored successfully2026-06-16T21:18:32.6849045Z [command]/home/runner/bin/minikube start --wait all2026-06-16T21:18:32.7259952Z * minikube v1.38.1 on Ubuntu 22.042026-06-16T21:18:32.8815486Z ! 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-06-16T21:18:37.2292250Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-06-16T21:18:37.3138872Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-06-16T21:18:37.3151214Z * Using Docker driver with root privileges2026-06-16T21:18:37.3161583Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-06-16T21:18:37.3171293Z * Pulling base image v0.0.50 ...2026-06-16T21:19:09.7202389Z * Configuring bridge CNI (Container Networking Interface) ...2026-06-16T21:19:14.3972773Z * Verifying Kubernetes components...2026-06-16T21:19:14.4307391Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-06-16T21:19:14.9869995Z * Enabled addons: storage-provisioner, default-storageclass2026-06-16T21:19:54.1986550Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-06-16T21:19:54.2121354Z [command]/home/runner/bin/minikube version --short2026-06-16T21:19:54.2499444Z v1.38.12026-06-16T21:19:54.2772158Z ##[group]Run actions/setup-go@v62026-06-16T21:19:54.2772463Z with:2026-06-16T21:19:54.2772672Z go-version: 1.262026-06-16T21:19:54.2772885Z cache: true2026-06-16T21:19:54.2773110Z cache-dependency-path: go.sum2026-06-16T21:19:54.2773383Z check-latest: false2026-06-16T21:19:54.2776851Z token: ***2026-06-16T21:19:54.2777081Z ##[endgroup]2026-06-16T21:19:54.4330756Z Setup go version spec 1.262026-06-16T21:19:54.4988254Z Attempting to download 1.26...2026-06-16T21:19:55.1303665Z matching 1.26...2026-06-16T21:19:55.1312692Z Acquiring 1.26.4 from https://github.com/actions/go-versions/releases/download/1.26.4-26891772857/go-1.26.4-linux-x64.tar.gz2026-06-16T21:19:55.6877006Z Extracting Go...2026-06-16T21:19:55.7073246Z [command]/usr/bin/tar xz --warning=no-unknown-keyword --overwrite -C /home/runner/work/_temp/1da07e89-c80b-4efe-ae4e-3769612b6ff5 -f /home/runner/work/_temp/4380ba20-e2a6-43c3-b3c5-97f9a46035aa2026-06-16T21:19:57.3800624Z Successfully extracted go to /home/runner/work/_temp/1da07e89-c80b-4efe-ae4e-3769612b6ff52026-06-16T21:19:57.3801507Z Adding to the cache ...2026-06-16T21:20:03.3453199Z Successfully cached go to /opt/hostedtoolcache/go/1.26.4/x642026-06-16T21:20:03.3456775Z Added go to the path2026-06-16T21:20:03.3459597Z Successfully set up Go version 1.262026-06-16T21:20:03.3759722Z [command]/opt/hostedtoolcache/go/1.26.4/x64/bin/go env GOMODCACHE2026-06-16T21:20:03.3809884Z [command]/opt/hostedtoolcache/go/1.26.4/x64/bin/go env GOCACHE2026-06-16T21:20:03.3825337Z /home/runner/go/pkg/mod2026-06-16T21:20:03.3852068Z /home/runner/.cache/go-build2026-06-16T21:20:03.6656298Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.4-4d532554cd8420c389c8064f4e1b4d5cc1d79ec73be5008309ef5f6e35b363a42026-06-16T21:20:04.9573413Z Received 0 of 252076037 (0.0%), 0.0 MBs/sec2026-06-16T21:20:05.9590973Z Received 113246208 of 252076037 (44.9%), 53.9 MBs/sec2026-06-16T21:20:06.9587093Z Received 230686720 of 252076037 (91.5%), 73.3 MBs/sec2026-06-16T21:20:07.1939703Z Received 252076037 of 252076037 (100.0%), 74.3 MBs/sec2026-06-16T21:20:07.1941149Z Cache Size: ~240 MB (252076037 B)2026-06-16T21:20:07.1988278Z [command]/usr/bin/tar -xf /home/runner/work/_temp/20411c68-9cd8-4499-9a49-1f813044bab8/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-06-16T21:20:10.4932181Z Cache restored successfully2026-06-16T21:20:10.5484280Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.4-4d532554cd8420c389c8064f4e1b4d5cc1d79ec73be5008309ef5f6e35b363a42026-06-16T21:20:10.5512529Z go version go1.26.4 linux/amd642026-06-16T21:20:10.5512874Z 2026-06-16T21:20:10.5513339Z ##[group]go env2026-06-16T21:20:10.6560727Z AR='ar'2026-06-16T21:20:10.6561131Z CC='gcc'2026-06-16T21:20:10.6561515Z CGO_CFLAGS='-O2 -g'2026-06-16T21:20:10.6561954Z CGO_CPPFLAGS=''2026-06-16T21:20:10.6562366Z CGO_CXXFLAGS='-O2 -g'2026-06-16T21:20:10.6562855Z CGO_ENABLED='1'2026-06-16T21:20:10.6563307Z CGO_FFLAGS='-O2 -g'2026-06-16T21:20:10.6563863Z CGO_LDFLAGS='-O2 -g'2026-06-16T21:20:10.6564611Z CXX='g++'2026-06-16T21:20:10.6564977Z GCCGO='gccgo'2026-06-16T21:20:10.6565363Z GO111MODULE=''2026-06-16T21:20:10.6565738Z GOAMD64='v1'2026-06-16T21:20:10.6566104Z GOARCH='amd64'2026-06-16T21:20:10.6566468Z GOAUTH='netrc'2026-06-16T21:20:10.6566829Z GOBIN=''2026-06-16T21:20:10.6567234Z GOCACHE='/home/runner/.cache/go-build'2026-06-16T21:20:10.6567759Z GOCACHEPROG=''2026-06-16T21:20:10.6568129Z GODEBUG=''2026-06-16T21:20:10.6568522Z GOENV='/home/runner/.config/go/env'2026-06-16T21:20:10.6569019Z GOEXE=''2026-06-16T21:20:10.6569376Z GOEXPERIMENT=''2026-06-16T21:20:10.6569781Z GOFIPS140='off'2026-06-16T21:20:10.6570147Z GOFLAGS=''2026-06-16T21:20:10.6571389Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build3380676435=/tmp/go-build -gno-record-gcc-switches'2026-06-16T21:20:10.6572673Z GOHOSTARCH='amd64'2026-06-16T21:20:10.6573065Z GOHOSTOS='linux'2026-06-16T21:20:10.6573760Z GOINSECURE=''2026-06-16T21:20:10.6574770Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-06-16T21:20:10.6575603Z GOMODCACHE='/home/runner/go/pkg/mod'2026-06-16T21:20:10.6576111Z GONOPROXY=''2026-06-16T21:20:10.6576407Z GONOSUMDB=''2026-06-16T21:20:10.6576664Z GOOS='linux'2026-06-16T21:20:10.6576959Z GOPATH='/home/runner/go'2026-06-16T21:20:10.6577272Z GOPRIVATE=''2026-06-16T21:20:10.6577615Z GOPROXY='https://proxy.golang.org,direct'2026-06-16T21:20:10.6578074Z GOROOT='/opt/hostedtoolcache/go/1.26.4/x64'2026-06-16T21:20:10.6578501Z GOSUMDB='sum.golang.org'2026-06-16T21:20:10.6578815Z GOTELEMETRY='local'2026-06-16T21:20:10.6579187Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-06-16T21:20:10.6579616Z GOTMPDIR=''2026-06-16T21:20:10.6579884Z GOTOOLCHAIN='local'2026-06-16T21:20:10.6580320Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.4/x64/pkg/tool/linux_amd64'2026-06-16T21:20:10.6580809Z GOVCS=''2026-06-16T21:20:10.6581064Z GOVERSION='go1.26.4'2026-06-16T21:20:10.6581372Z GOWORK=''2026-06-16T21:20:10.6581644Z PKG_CONFIG='pkg-config'2026-06-16T21:20:10.6581843Z 2026-06-16T21:20:10.6582268Z ##[endgroup]2026-06-16T21:20:10.6799265Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-06-16T21:20:10.6799856Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-06-16T21:20:10.6854704Z shell: /usr/bin/bash -e {0}2026-06-16T21:20:10.6855014Z env:2026-06-16T21:20:10.6855241Z GOTOOLCHAIN: local2026-06-16T21:20:10.6855527Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-06-16T21:20:10.6855865Z OSPOOL_EP_CMTag: 25.x-el92026-06-16T21:20:10.6856161Z OSPOOL_EP_CvmfsType: cvmfsexec2026-06-16T21:20:10.6856458Z ##[endgroup]2026-06-16T21:20:12.9856284Z === RUN TestOSPoolEP2026-06-16T21:20:12.9858428Z === PAUSE TestOSPoolEP2026-06-16T21:20:12.9858929Z === CONT TestOSPoolEP2026-06-16T21:20:12.9860110Z TestOSPoolEP 2026-06-16T21:20:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:12.9981906Z TestOSPoolEP 2026-06-16T21:20:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 apply -f /tmp/TestOSPoolEP2767219384]2026-06-16T21:20:13.5022793Z TestOSPoolEP 2026-06-16T21:20:13Z logger.go:67: pod/idtoken-generator created2026-06-16T21:20:13.5127196Z TestOSPoolEP 2026-06-16T21:20:13Z logger.go:67: secret/pool-passwd created2026-06-16T21:20:13.5177091Z TestOSPoolEP 2026-06-16T21:20:13Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-06-16T21:20:13.5179222Z TestOSPoolEP 2026-06-16T21:20:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:13.5225481Z TestOSPoolEP 2026-06-16T21:20:13Z 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-06-16T21:20:23.5223394Z TestOSPoolEP 2026-06-16T21:20:23Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-06-16T21:20:23.5227141Z TestOSPoolEP 2026-06-16T21:20:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:23.5255723Z TestOSPoolEP 2026-06-16T21:20:23Z 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-06-16T21:20:33.5257457Z TestOSPoolEP 2026-06-16T21:20:33Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-06-16T21:20:33.5260722Z TestOSPoolEP 2026-06-16T21:20:33Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:33.5287978Z TestOSPoolEP 2026-06-16T21:20:33Z logger.go:67: Pod is now available2026-06-16T21:20:33.5291173Z TestOSPoolEP 2026-06-16T21:20:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-06-16T21:20:34.1716548Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: ***2026-06-16T21:20:34.1765875Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 apply -f /tmp/TestOSPoolEP3772697541]2026-06-16T21:20:34.3606548Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: secret/pool-token created2026-06-16T21:20:34.3636830Z TestOSPoolEP 2026-06-16T21:20:34Z retry.go:91: Wait for secret pool-token to be provisioned.2026-06-16T21:20:34.3638641Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:34.3657641Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: Secret is now available2026-06-16T21:20:34.3678243Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 apply -k /tmp/kustomize-template-1081069141]2026-06-16T21:20:34.6607377Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: service/test-cm created2026-06-16T21:20:34.6700403Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: Warning: spec.template.spec.containers[0].env[8]: hides previous definition of "OSG_SQUID_LOCATION", which may be dropped when using apply2026-06-16T21:20:34.6704635Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: deployment.apps/ospool-ep created2026-06-16T21:20:34.6785554Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: deployment.apps/test-cm created2026-06-16T21:20:34.6855980Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-06-16T21:20:34.6863059Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:34.6951920Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:34Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-06-16T21:20:34.6954070Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:34.6958333Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:34Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-06-16T21:20:34.6962027Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:34.7047498Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:34Z 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-65c844ddbb". Sleeping for 10s and will try again.2026-06-16T21:20:34.7072895Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:34Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "test-cm-5bb545475c". Sleeping for 10s and will try again.2026-06-16T21:20:44.7049678Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:44Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-06-16T21:20:44.7051999Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:44.7073700Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:44Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-06-16T21:20:44.7078524Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:44.7082151Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20: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: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-65c844ddbb" is progressing.. Sleeping for 10s and will try again.2026-06-16T21:20:44.7093068Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:44Z logger.go:67: Deployment is now available2026-06-16T21:20:54.7081410Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:54Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-06-16T21:20:54.7085057Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:54.7115100Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:54Z logger.go:67: Deployment is now available2026-06-16T21:20:54.7118056Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-06-16T21:20:54.7118930Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-06-16T21:20:54.7119749Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-06-16T21:20:54.7120498Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-06-16T21:20:54.7121299Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-06-16T21:20:54.7122007Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-06-16T21:20:54.7122787Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-06-16T21:20:54.7124638Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:20:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:54.7138992Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-06-16T21:20:54.7141940Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:20:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:54.7143513Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-06-16T21:20:54.7145494Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-16T21:20:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:54.7167156Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:20:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:54.7187750Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:20:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:54.7193283Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-16T21:20:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:54.7200227Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:20:54Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:20:54.7211709Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-16T21:20:54Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_SINGULARITY]2026-06-16T21:20:54.7216709Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:20:54Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)']2026-06-16T21:20:54.9968453Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-06-16T21:20:54.9972312Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)']' in pod test-cm-5bb545475c-2pfgp failed. Retrying in 10s.2026-06-16T21:20:55.0049786Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-06-16T21:20:55.0050952Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-2pfgp failed. Retrying in 10s.2026-06-16T21:20:55.0111990Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-06-16T21:20:55.0115327Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2pfgp failed. Retrying in 30s.2026-06-16T21:21:04.9970387Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:04Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)']2026-06-16T21:21:05.0054836Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-16T21:21:05Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_SINGULARITY]2026-06-16T21:21:05.2040202Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-06-16T21:21:05.2041334Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)']' in pod test-cm-5bb545475c-2pfgp failed. Retrying in 10s.2026-06-16T21:21:05.2051603Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-06-16T21:21:05.2052962Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-2pfgp failed. Retrying in 10s.2026-06-16T21:21:15.2046197Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)']2026-06-16T21:21:15.2055417Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-16T21:21:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_SINGULARITY]2026-06-16T21:21:15.4270031Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:15Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-06-16T21:21:15.4272377Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:15Z logger.go:67: 2026-06-16T21:21:15.4274921Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:15Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-65c844ddbb-djl5n LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-06-16T21:21:15.4276796Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:15Z logger.go:67: 2026-06-16T21:21:15.4278419Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:15Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-06-16T21:21:15.4279999Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:15Z logger.go:67: 2026-06-16T21:21:15.4281474Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:15Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-06-16T21:21:15.4282945Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:15Z logger.go:67: 2026-06-16T21:21:15.4284683Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:15Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-06-16T21:21:15.4340211Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-16T21:21:15Z logger.go:67: true2026-06-16T21:21:25.0118571Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:21:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:21:25.1635550Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:21:25Z logger.go:67: undefined2026-06-16T21:21:25.1697949Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-06-16T21:21:25.1699493Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2pfgp failed. Retrying in 30s.2026-06-16T21:21:55.1710574Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:21:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:21:55.3222335Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:21:55Z logger.go:67: undefined2026-06-16T21:21:55.3277726Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2pfgp failed. Retrying in 30s.2026-06-16T21:22:25.3283420Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:22:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:22:25.4768513Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:22:25Z logger.go:67: undefined2026-06-16T21:22:25.4832414Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2pfgp failed. Retrying in 30s.2026-06-16T21:22:55.4836055Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:22:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:22:55.6319587Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:22:55Z logger.go:67: undefined2026-06-16T21:22:55.6385927Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2pfgp failed. Retrying in 30s.2026-06-16T21:23:25.6388898Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:23:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:23:25.7829691Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:23:25Z logger.go:67: undefined2026-06-16T21:23:25.7885806Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2pfgp failed. Retrying in 30s.2026-06-16T21:23:55.7893408Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:23:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:23:55.9389547Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:23:55Z logger.go:67: undefined2026-06-16T21:23:55.9457518Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2pfgp failed. Retrying in 30s.2026-06-16T21:24:25.9468608Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:24:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:24:26.0965499Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:24:26Z logger.go:67: undefined2026-06-16T21:24:26.1031122Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2pfgp failed. Retrying in 30s.2026-06-16T21:24:56.1036499Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:24:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:24:56.2537868Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:24:56Z logger.go:67: undefined2026-06-16T21:24:56.2591164Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2pfgp failed. Retrying in 30s.2026-06-16T21:25:26.2622684Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:25:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:25:26.4160740Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:25:26Z logger.go:67: undefined2026-06-16T21:25:26.4219765Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2pfgp failed. Retrying in 30s.2026-06-16T21:25:56.4250143Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:25:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:25:56.5820092Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:25:56Z logger.go:67: undefined2026-06-16T21:25:56.5877316Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2pfgp failed. Retrying in 30s.2026-06-16T21:26:26.5916507Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:26:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 exec test-cm-5bb545475c-2pfgp -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-djl5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:26:26.7574534Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:26:26Z logger.go:67: true2026-06-16T21:26:26.7653300Z TestOSPoolEP 2026-06-16T21:26:26Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:26:26.7731870Z TestOSPoolEP 2026-06-16T21:26:26Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:26:26.9541541Z TestOSPoolEP 2026-06-16T21:26:26Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:26:27.1012391Z TestOSPoolEP 2026-06-16T21:26:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:26:27.2287263Z TestOSPoolEP 2026-06-16T21:26:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:26:27.2321087Z === NAME TestOSPoolEP2026-06-16T21:26:27.2321597Z ospool_ep_test.go:101: ---2026-06-16T21:26:27.2322001Z Events for pod idtoken-generator:2026-06-16T21:26:27.2322864Z 2026-06-16 21:20:13 +0000 UTC Normal Successfully assigned test-ospool-ep-lg5yy8/idtoken-generator to minikube2026-06-16T21:26:27.2323671Z 2026-06-16 21:20:16 +0000 UTC Normal Pulling image "htcondor/base"2026-06-16T21:26:27.2325164Z 2026-06-16 21:20:25 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.953s (8.953s including waiting). Image size: 557830759 bytes.2026-06-16T21:26:27.2326346Z 2026-06-16 21:20:25 +0000 UTC Normal Container created2026-06-16T21:26:27.2326876Z 2026-06-16 21:20:25 +0000 UTC Normal Container started2026-06-16T21:26:27.2327375Z 2026-06-16T21:26:27.2327686Z ---2026-06-16T21:26:27.2328720Z TestOSPoolEP 2026-06-16T21:26:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:26:27.2349925Z ospool_ep_test.go:101: ---2026-06-16T21:26:27.2350799Z Events for pod ospool-ep-65c844ddbb-djl5n:2026-06-16T21:26:27.2352460Z 2026-06-16 21:20:34 +0000 UTC Normal Successfully assigned test-ospool-ep-lg5yy8/ospool-ep-65c844ddbb-djl5n to minikube2026-06-16T21:26:27.2354220Z 2026-06-16 21:20:35 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-06-16T21:26:27.2356850Z 2026-06-16 21:20:37 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 2.086s (2.087s including waiting). Image size: 5590942 bytes.2026-06-16T21:26:27.2358605Z 2026-06-16 21:20:37 +0000 UTC Normal Container created2026-06-16T21:26:27.2359554Z 2026-06-16 21:20:37 +0000 UTC Normal Container started2026-06-16T21:26:27.2361022Z 2026-06-16 21:20:37 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-06-16T21:26:27.2363555Z 2026-06-16 21:20:53 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 14.628s (15.776s including waiting). Image size: 1117371412 bytes.2026-06-16T21:26:27.2365896Z 2026-06-16 21:20:53 +0000 UTC Normal Container created2026-06-16T21:26:27.2366882Z 2026-06-16 21:20:53 +0000 UTC Normal Container started2026-06-16T21:26:27.2367520Z 2026-06-16T21:26:27.2367993Z ---2026-06-16T21:26:27.2369124Z TestOSPoolEP 2026-06-16T21:26:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:26:27.2394087Z ospool_ep_test.go:101: ---2026-06-16T21:26:27.2394971Z Events for pod test-cm-5bb545475c-2pfgp:2026-06-16T21:26:27.2400878Z 2026-06-16 21:20:34 +0000 UTC Normal Successfully assigned test-ospool-ep-lg5yy8/test-cm-5bb545475c-2pfgp to minikube2026-06-16T21:26:27.2402443Z 2026-06-16 21:20:35 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-06-16T21:26:27.2404517Z 2026-06-16 21:20:38 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 1.38s (3.45s including waiting). Image size: 557830785 bytes.2026-06-16T21:26:27.2413574Z 2026-06-16 21:20:38 +0000 UTC Normal Container created2026-06-16T21:26:27.2414662Z 2026-06-16 21:20:38 +0000 UTC Normal Container started2026-06-16T21:26:27.2415415Z 2026-06-16T21:26:27.2415809Z ---2026-06-16T21:26:27.2416802Z TestOSPoolEP 2026-06-16T21:26:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:26:27.2450743Z TestOSPoolEP 2026-06-16T21:26:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 delete -f /tmp/TestOSPoolEP252089751]2026-06-16T21:26:27.3508142Z TestOSPoolEP 2026-06-16T21:26:27Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-lg5yy8 namespace2026-06-16T21:26:27.3643844Z TestOSPoolEP 2026-06-16T21:26:27Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-lg5yy8 namespace2026-06-16T21:26:28.6277218Z TestOSPoolEP 2026-06-16T21:26:28Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 delete -f /tmp/TestOSPoolEP3532032855]2026-06-16T21:26:28.7456426Z TestOSPoolEP 2026-06-16T21:26:28Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-lg5yy8 namespace2026-06-16T21:26:28.7507955Z TestOSPoolEP 2026-06-16T21:26:28Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lg5yy8 delete -k /tmp/kustomize-template-1081069141]2026-06-16T21:26:28.9004732Z TestOSPoolEP 2026-06-16T21:26:28Z logger.go:67: service "test-cm" deleted from test-ospool-ep-lg5yy8 namespace2026-06-16T21:26:28.9059526Z TestOSPoolEP 2026-06-16T21:26:28Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-lg5yy8 namespace2026-06-16T21:26:28.9127779Z TestOSPoolEP 2026-06-16T21:26:28Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-lg5yy8 namespace2026-06-16T21:26:28.9306956Z --- PASS: TestOSPoolEP (43.89s)2026-06-16T21:26:28.9345894Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (20.03s)2026-06-16T21:26:28.9347361Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.72s)2026-06-16T21:26:28.9348914Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.73s)2026-06-16T21:26:28.9349937Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (332.05s)2026-06-16T21:26:28.9350639Z PASS2026-06-16T21:26:28.9362777Z ok github.com/osg-htc/k8s-integration-tests/test 375.963s2026-06-16T21:26:29.0163688Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-06-16T21:26:29.0165114Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-06-16T21:26:29.0233598Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-06-16T21:26:29.0234023Z env:2026-06-16T21:26:29.0234464Z GOTOOLCHAIN: local2026-06-16T21:26:29.0235219Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-06-16T21:26:29.0236311Z ##[endgroup]2026-06-16T21:26:29.0478734Z ##[group]Run actions/upload-artifact@v42026-06-16T21:26:29.0479088Z with:2026-06-16T21:26:29.0479490Z name: TestOSPoolEP-2901a61bab0f5cd8fd38f5d7b4adf511c8a145f9690ace071d07e117774ae1fb2026-06-16T21:26:29.0479978Z path: /tmp/k8s-tests2026-06-16T21:26:29.0480216Z retention-days: 52026-06-16T21:26:29.0480446Z if-no-files-found: warn2026-06-16T21:26:29.0480686Z compression-level: 62026-06-16T21:26:29.0480907Z overwrite: false2026-06-16T21:26:29.0481122Z include-hidden-files: false2026-06-16T21:26:29.0481367Z env:2026-06-16T21:26:29.0481551Z GOTOOLCHAIN: local2026-06-16T21:26:29.0481766Z ##[endgroup]2026-06-16T21:26:29.3733897Z With the provided path, there will be 6 files uploaded2026-06-16T21:26:29.3735341Z Artifact name is valid!2026-06-16T21:26:29.3735882Z Root directory input is valid!2026-06-16T21:26:29.8161757Z Beginning upload of artifact content to blob storage2026-06-16T21:26:30.2345161Z Uploaded bytes 139852026-06-16T21:26:30.3223120Z Finished uploading artifact content to blob storage!2026-06-16T21:26:30.3226848Z SHA256 digest of uploaded artifact zip is 544c8287484c02e763b04750bc4ec71391c8bc60cfa8b513f61b3635300e32c82026-06-16T21:26:30.3228972Z Finalizing artifact upload2026-06-16T21:26:30.6297415Z Artifact TestOSPoolEP-2901a61bab0f5cd8fd38f5d7b4adf511c8a145f9690ace071d07e117774ae1fb.zip successfully finalized. Artifact ID 76800648232026-06-16T21:26:30.6299588Z Artifact TestOSPoolEP-2901a61bab0f5cd8fd38f5d7b4adf511c8a145f9690ace071d07e117774ae1fb has been successfully uploaded! Final size is 13985 bytes. Artifact ID is 76800648232026-06-16T21:26:30.6301500Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/27648802079/artifacts/76800648232026-06-16T21:26:30.6453192Z Post job cleanup.2026-06-16T21:26:30.7977491Z [command]/opt/hostedtoolcache/go/1.26.4/x64/bin/go env GOMODCACHE2026-06-16T21:26:30.8037982Z [command]/opt/hostedtoolcache/go/1.26.4/x64/bin/go env GOCACHE2026-06-16T21:26:30.8072936Z /home/runner/go/pkg/mod2026-06-16T21:26:30.8098159Z /home/runner/.cache/go-build2026-06-16T21:26:30.8106890Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.4-4d532554cd8420c389c8064f4e1b4d5cc1d79ec73be5008309ef5f6e35b363a4, not saving cache.2026-06-16T21:26:30.8325756Z Post job cleanup.2026-06-16T21:26:30.9259034Z [command]/usr/bin/git version2026-06-16T21:26:30.9297951Z git version 2.54.02026-06-16T21:26:30.9338945Z Temporarily overriding HOME='/home/runner/work/_temp/a0594b34-a754-43ac-b55a-2923aa55e375' before making global git config changes2026-06-16T21:26:30.9340894Z Adding repository directory to the temporary git global config as a safe directory2026-06-16T21:26:30.9346155Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-06-16T21:26:30.9385037Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-06-16T21:26:30.9422464Z [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-06-16T21:26:30.9689845Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-06-16T21:26:30.9715454Z http.https://github.com/.extraheader2026-06-16T21:26:30.9726898Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-06-16T21:26:30.9761955Z [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-06-16T21:26:31.0036064Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-06-16T21:26:31.0070701Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-06-16T21:26:31.0468370Z Cleaning up orphan processes2026-06-16T21:26:31.1264884Z ##[warning]Node.js 20 actions are deprecated. The following actions are running on Node.js 20 and may not work as expected: actions/upload-artifact@v4. Actions will be forced to run with Node.js 24 by default starting June 16th, 2026. Node.js 20 will be removed from the runner on September 16th, 2026. Please check if updated versions of these actions are available that support Node.js 24. To opt into Node.js 24 now, set the FORCE_JAVASCRIPT_ACTIONS_TO_NODE24=true environment variable on the runner or in your workflow file. Once Node.js 24 becomes the default, you can temporarily opt out by setting ACTIONS_ALLOW_USE_UNSECURE_NODE_VERSION=true. For more information see: https://github.blog/changelog/2025-09-19-deprecation-of-node-20-on-github-actions-runners/