2026-08-08T00:51:21.9860672Z Current runner version: '2.336.0'2026-08-08T00:51:21.9895820Z ##[group]Runner Image Provisioner2026-08-08T00:51:21.9897173Z Hosted Compute Agent2026-08-08T00:51:21.9898223Z Version: 20260707.5632026-08-08T00:51:21.9899331Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-08-08T00:51:21.9900536Z Build Date: 2026-07-07T19:33:50Z2026-08-08T00:51:21.9901781Z Worker ID: {5c46e364-dc24-4878-a088-d03cd5bd7a9d}2026-08-08T00:51:21.9902990Z Azure Region: westus22026-08-08T00:51:21.9903943Z ##[endgroup]2026-08-08T00:51:21.9906838Z ##[group]Operating System2026-08-08T00:51:21.9907886Z Ubuntu2026-08-08T00:51:21.9908904Z 22.04.52026-08-08T00:51:21.9909860Z LTS2026-08-08T00:51:21.9910770Z ##[endgroup]2026-08-08T00:51:21.9911940Z ##[group]Runner Image2026-08-08T00:51:21.9913010Z Image: ubuntu-22.042026-08-08T00:51:21.9913991Z Version: 20260720.234.22026-08-08T00:51:21.9916564Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-08-08T00:51:21.9919463Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-08-08T00:51:21.9921257Z ##[endgroup]2026-08-08T00:51:21.9923392Z ##[group]GITHUB_TOKEN Permissions2026-08-08T00:51:21.9926576Z Contents: read2026-08-08T00:51:21.9927566Z Metadata: read2026-08-08T00:51:21.9928620Z Packages: read2026-08-08T00:51:21.9929599Z ##[endgroup]2026-08-08T00:51:21.9933142Z Secret source: Actions2026-08-08T00:51:21.9935262Z Prepare workflow directory2026-08-08T00:51:22.0446706Z Prepare all required actions2026-08-08T00:51:22.0504591Z Getting action download info2026-08-08T00:51:22.3936525Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-08T00:51:22.6778994Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-08T00:51:22.8578419Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-08T00:51:23.0604173Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-08T00:51:23.3546237Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-08T00:51:23.3551719Z ##[group] Inputs2026-08-08T00:51:23.3552338Z testName: TestOSPoolEP2026-08-08T00:51:23.3553468Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-08T00:51:23.3554811Z setupScript: 2026-08-08T00:51:23.3555311Z setupEnv: {}2026-08-08T00:51:23.3556235Z ##[endgroup]2026-08-08T00:51:23.3557085Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-08-08T00:51:23.4347070Z ##[group]Run actions/checkout@v52026-08-08T00:51:23.4348035Z with:2026-08-08T00:51:23.4348585Z repository: mwestphall/k8s-integration-tests2026-08-08T00:51:23.4353491Z token: ***2026-08-08T00:51:23.4353970Z ssh-strict: true2026-08-08T00:51:23.4354479Z ssh-user: git2026-08-08T00:51:23.4354979Z persist-credentials: true2026-08-08T00:51:23.4355942Z clean: true2026-08-08T00:51:23.4356465Z sparse-checkout-cone-mode: true2026-08-08T00:51:23.4357055Z fetch-depth: 12026-08-08T00:51:23.4357531Z fetch-tags: false2026-08-08T00:51:23.4358023Z show-progress: true2026-08-08T00:51:23.4358515Z lfs: false2026-08-08T00:51:23.4358949Z submodules: false2026-08-08T00:51:23.4359439Z set-safe-directory: true2026-08-08T00:51:23.4360004Z allow-unsafe-pr-checkout: false2026-08-08T00:51:23.4360924Z ##[endgroup]2026-08-08T00:51:23.5403186Z Syncing repository: mwestphall/k8s-integration-tests2026-08-08T00:51:23.5406634Z ##[group]Getting Git version info2026-08-08T00:51:23.5408430Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-08T00:51:23.5411031Z [command]/usr/bin/git version2026-08-08T00:51:23.5476387Z git version 2.54.02026-08-08T00:51:23.5533546Z ##[endgroup]2026-08-08T00:51:23.5547942Z Temporarily overriding HOME='/home/runner/work/_temp/09d988c7-ac4e-4992-bc87-ee4cbf7fdc15' before making global git config changes2026-08-08T00:51:23.5551181Z Adding repository directory to the temporary git global config as a safe directory2026-08-08T00:51:23.5554186Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-08T00:51:23.5593274Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-08T00:51:23.5599615Z ##[group]Initializing the repository2026-08-08T00:51:23.5604854Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-08T00:51:23.5740607Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-08T00:51:23.5742847Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-08T00:51:23.5745694Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-08T00:51:23.5747543Z hint: call:2026-08-08T00:51:23.5748492Z hint:2026-08-08T00:51:23.5749628Z hint: git config --global init.defaultBranch <name>2026-08-08T00:51:23.5750972Z hint:2026-08-08T00:51:23.5752188Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-08T00:51:23.5754737Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-08T00:51:23.5756749Z hint:2026-08-08T00:51:23.5757645Z hint: git branch -m <name>2026-08-08T00:51:23.5758652Z hint:2026-08-08T00:51:23.5760044Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-08T00:51:23.5762613Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-08T00:51:23.5766212Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-08T00:51:23.5804489Z ##[endgroup]2026-08-08T00:51:23.5806306Z ##[group]Disabling automatic garbage collection2026-08-08T00:51:23.5808444Z [command]/usr/bin/git config --local gc.auto 02026-08-08T00:51:23.5844903Z ##[endgroup]2026-08-08T00:51:23.5847061Z ##[group]Setting up auth2026-08-08T00:51:23.5854689Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-08T00:51:23.5890322Z [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-08-08T00:51:23.6295245Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-08T00:51:23.6338765Z [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-08-08T00:51:23.6587157Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-08T00:51:23.6625727Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-08T00:51:23.6870023Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-08T00:51:23.6908658Z ##[endgroup]2026-08-08T00:51:23.6909570Z ##[group]Fetching the repository2026-08-08T00:51:23.6918462Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-08T00:51:24.0738811Z From https://github.com/mwestphall/k8s-integration-tests2026-08-08T00:51:24.0740864Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-08T00:51:24.0774922Z ##[endgroup]2026-08-08T00:51:24.0776355Z ##[group]Determining the checkout info2026-08-08T00:51:24.0778605Z ##[endgroup]2026-08-08T00:51:24.0790782Z [command]/usr/bin/git sparse-checkout disable2026-08-08T00:51:24.0839127Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-08T00:51:24.0876365Z ##[group]Checking out the ref2026-08-08T00:51:24.0880451Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-08T00:51:24.0973257Z Switched to a new branch 'main'2026-08-08T00:51:24.0976420Z branch 'main' set up to track 'origin/main'.2026-08-08T00:51:24.0990203Z ##[endgroup]2026-08-08T00:51:24.1029120Z [command]/usr/bin/git log -1 --format=%H2026-08-08T00:51:24.1057084Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-08T00:51:24.1359649Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-08T00:51:24.1361152Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-08T00:51:24.1362484Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-08T00:51:24.1491763Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-08T00:51:24.1492592Z env:2026-08-08T00:51:24.1493555Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-08T00:51:24.1494685Z SETUP_ENV_YAML: {}2026-08-08T00:51:24.1495175Z ##[endgroup]2026-08-08T00:51:24.6327076Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-08T00:51:24.6329737Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-08T00:51:24.6389686Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-08T00:51:24.6391167Z env:2026-08-08T00:51:24.6393109Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-08T00:51:24.6395627Z ##[endgroup]2026-08-08T00:51:24.6576240Z ##[group]Run true2026-08-08T00:51:24.6577121Z [36;1mtrue[0m2026-08-08T00:51:24.6630772Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-08T00:51:24.6632141Z ##[endgroup]2026-08-08T00:51:24.6908885Z ##[group]Run medyagh/setup-minikube@latest2026-08-08T00:51:24.6909993Z with:2026-08-08T00:51:24.6910682Z start: true2026-08-08T00:51:24.6911418Z cache: true2026-08-08T00:51:24.6912201Z minikube-version: latest2026-08-08T00:51:24.6913094Z wait: all2026-08-08T00:51:24.6913817Z ##[endgroup]2026-08-08T00:51:24.8264251Z (node:2051) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-08T00:51:24.8268798Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-08T00:51:25.7865606Z [command]/usr/bin/chmod +x /home/runner/work/_temp/974cf027-e10d-43e1-a469-04f73d3e21d92026-08-08T00:51:25.9447573Z [command]/home/runner/bin/minikube version --short2026-08-08T00:51:25.9862331Z v1.38.12026-08-08T00:51:26.2286356Z Cache hit for: kic-v1.38.1-x642026-08-08T00:51:26.2392130Z (node:2051) [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-08-08T00:51:26.2404358Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-08T00:51:27.5676760Z Received 0 of 224218863 (0.0%), 0.0 MBs/sec2026-08-08T00:51:27.5825890Z Received 0 of 544082657 (0.0%), 0.0 MBs/sec2026-08-08T00:51:28.5657620Z Received 92274688 of 224218863 (41.2%), 44.0 MBs/sec2026-08-08T00:51:28.5829315Z Received 100663296 of 544082657 (18.5%), 48.0 MBs/sec2026-08-08T00:51:29.6198247Z Received 134217728 of 224218863 (59.9%), 41.9 MBs/sec2026-08-08T00:51:29.6201602Z Received 188743680 of 544082657 (34.7%), 59.3 MBs/sec2026-08-08T00:51:30.6184573Z Received 215830255 of 224218863 (96.3%), 50.8 MBs/sec2026-08-08T00:51:30.6185599Z Received 318767104 of 544082657 (58.6%), 75.3 MBs/sec2026-08-08T00:51:30.8052054Z Received 224218863 of 224218863 (100.0%), 50.4 MBs/sec2026-08-08T00:51:30.8053056Z Cache Size: ~214 MB (224218863 B)2026-08-08T00:51:30.8661858Z [command]/usr/bin/tar -xf /home/runner/work/_temp/f3ef24a0-41ba-4d9a-95c5-9beface46039/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-08T00:51:31.4157292Z Cache restored successfully2026-08-08T00:51:31.6179354Z Received 398458880 of 544082657 (73.2%), 75.5 MBs/sec2026-08-08T00:51:32.6246459Z Received 499122176 of 544082657 (91.7%), 78.8 MBs/sec2026-08-08T00:51:33.3356672Z Received 544082657 of 544082657 (100.0%), 76.8 MBs/sec2026-08-08T00:51:33.3358174Z Cache Size: ~519 MB (544082657 B)2026-08-08T00:51:33.3470391Z [command]/usr/bin/tar -xf /home/runner/work/_temp/d91faecc-16b2-4ccc-b54f-b9eead30a356/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-08T00:51:34.1652599Z Cache restored successfully2026-08-08T00:51:34.2793773Z [command]/home/runner/bin/minikube start --wait all2026-08-08T00:51:34.3194771Z * minikube v1.38.1 on Ubuntu 22.042026-08-08T00:51:34.4592539Z ! 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-08-08T00:51:36.5948729Z * Automatically selected the docker driver. Other choices: podman, ssh, none2026-08-08T00:51:36.6573987Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-08T00:51:36.6585013Z * Using Docker driver with root privileges2026-08-08T00:51:36.6596157Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-08T00:51:36.6609770Z * Pulling base image v0.0.50 ...2026-08-08T00:52:07.4444606Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-08T00:52:12.5852254Z * Verifying Kubernetes components...2026-08-08T00:52:12.6196715Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-08T00:52:13.3243628Z * Enabled addons: storage-provisioner, default-storageclass2026-08-08T00:52:56.4725964Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-08T00:52:56.4832882Z [command]/home/runner/bin/minikube version --short2026-08-08T00:52:56.5176415Z v1.38.12026-08-08T00:52:56.5463199Z ##[group]Run actions/setup-go@v62026-08-08T00:52:56.5463499Z with:2026-08-08T00:52:56.5463705Z go-version: 1.262026-08-08T00:52:56.5463931Z cache: true2026-08-08T00:52:56.5464155Z cache-dependency-path: go.sum2026-08-08T00:52:56.5464431Z check-latest: false2026-08-08T00:52:56.5467463Z token: ***2026-08-08T00:52:56.5467696Z ##[endgroup]2026-08-08T00:52:56.6778411Z Setup go version spec 1.262026-08-08T00:52:56.7115025Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-08T00:52:56.7118116Z Added go to the path2026-08-08T00:52:56.7122116Z Successfully set up Go version 1.262026-08-08T00:52:57.3799323Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-08T00:52:57.3838641Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-08T00:52:57.3867521Z /home/runner/go/pkg/mod2026-08-08T00:52:57.3889355Z /home/runner/.cache/go-build2026-08-08T00:52:57.6585079Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-08T00:52:59.0118871Z Received 0 of 251839808 (0.0%), 0.0 MBs/sec2026-08-08T00:53:00.0126435Z Received 104857600 of 251839808 (41.6%), 50.0 MBs/sec2026-08-08T00:53:01.0124886Z Received 192937984 of 251839808 (76.6%), 61.3 MBs/sec2026-08-08T00:53:01.4072346Z Received 251839808 of 251839808 (100.0%), 70.7 MBs/sec2026-08-08T00:53:01.4073954Z Cache Size: ~240 MB (251839808 B)2026-08-08T00:53:01.4140629Z [command]/usr/bin/tar -xf /home/runner/work/_temp/623e4006-5bc3-4ae6-a2f1-bf95808a4edb/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-08T00:53:04.4298903Z Cache restored successfully2026-08-08T00:53:04.4957068Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-08T00:53:04.4984919Z go version go1.26.5 linux/amd642026-08-08T00:53:04.4985259Z 2026-08-08T00:53:04.4985968Z ##[group]go env2026-08-08T00:53:04.5364231Z AR='ar'2026-08-08T00:53:04.5364581Z CC='gcc'2026-08-08T00:53:04.5364949Z CGO_CFLAGS='-O2 -g'2026-08-08T00:53:04.5365558Z CGO_CPPFLAGS=''2026-08-08T00:53:04.5365971Z CGO_CXXFLAGS='-O2 -g'2026-08-08T00:53:04.5366358Z CGO_ENABLED='1'2026-08-08T00:53:04.5366717Z CGO_FFLAGS='-O2 -g'2026-08-08T00:53:04.5367120Z CGO_LDFLAGS='-O2 -g'2026-08-08T00:53:04.5367476Z CXX='g++'2026-08-08T00:53:04.5367795Z GCCGO='gccgo'2026-08-08T00:53:04.5368137Z GO111MODULE=''2026-08-08T00:53:04.5368497Z GOAMD64='v1'2026-08-08T00:53:04.5368831Z GOARCH='amd64'2026-08-08T00:53:04.5369160Z GOAUTH='netrc'2026-08-08T00:53:04.5369485Z GOBIN=''2026-08-08T00:53:04.5369895Z GOCACHE='/home/runner/.cache/go-build'2026-08-08T00:53:04.5370314Z GOCACHEPROG=''2026-08-08T00:53:04.5370536Z GODEBUG=''2026-08-08T00:53:04.5370747Z GOENV='/home/runner/.config/go/env'2026-08-08T00:53:04.5371010Z GOEXE=''2026-08-08T00:53:04.5371502Z GOEXPERIMENT=''2026-08-08T00:53:04.5371843Z GOFIPS140='off'2026-08-08T00:53:04.5372169Z GOFLAGS=''2026-08-08T00:53:04.5373208Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build243123711=/tmp/go-build -gno-record-gcc-switches'2026-08-08T00:53:04.5374320Z GOHOSTARCH='amd64'2026-08-08T00:53:04.5374695Z GOHOSTOS='linux'2026-08-08T00:53:04.5375048Z GOINSECURE=''2026-08-08T00:53:04.5375994Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-08T00:53:04.5376850Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-08T00:53:04.5377286Z GONOPROXY=''2026-08-08T00:53:04.5377596Z GONOSUMDB=''2026-08-08T00:53:04.5377952Z GOOS='linux'2026-08-08T00:53:04.5378331Z GOPATH='/home/runner/go'2026-08-08T00:53:04.5378747Z GOPRIVATE=''2026-08-08T00:53:04.5379200Z GOPROXY='https://proxy.golang.org,direct'2026-08-08T00:53:04.5379815Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-08T00:53:04.5380283Z GOSUMDB='sum.golang.org'2026-08-08T00:53:04.5380530Z GOTELEMETRY='local'2026-08-08T00:53:04.5381381Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-08T00:53:04.5381999Z GOTMPDIR=''2026-08-08T00:53:04.5382384Z GOTOOLCHAIN='local'2026-08-08T00:53:04.5382937Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-08T00:53:04.5383602Z GOVCS=''2026-08-08T00:53:04.5383977Z GOVERSION='go1.26.5'2026-08-08T00:53:04.5384368Z GOWORK=''2026-08-08T00:53:04.5384601Z PKG_CONFIG='pkg-config'2026-08-08T00:53:04.5384745Z 2026-08-08T00:53:04.5385026Z ##[endgroup]2026-08-08T00:53:04.5548775Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-08T00:53:04.5549338Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-08T00:53:04.5608227Z shell: /usr/bin/bash -e {0}2026-08-08T00:53:04.5608484Z env:2026-08-08T00:53:04.5608695Z GOTOOLCHAIN: local2026-08-08T00:53:04.5608940Z OSPOOL_EP_OSPoolEPTag: 25-release2026-08-08T00:53:04.5609232Z OSPOOL_EP_CMTag: 25.0-el92026-08-08T00:53:04.5609503Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-08T00:53:04.5609769Z ##[endgroup]2026-08-08T00:53:10.9921400Z === RUN TestOSPoolEP2026-08-08T00:53:10.9923514Z === PAUSE TestOSPoolEP2026-08-08T00:53:10.9923971Z === CONT TestOSPoolEP2026-08-08T00:53:10.9937507Z TestOSPoolEP 2026-08-08T00:53:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:53:11.0285644Z TestOSPoolEP 2026-08-08T00:53:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz apply -f /tmp/TestOSPoolEP3800870255]2026-08-08T00:53:12.1017643Z TestOSPoolEP 2026-08-08T00:53:12Z logger.go:67: pod/idtoken-generator created2026-08-08T00:53:12.1149023Z TestOSPoolEP 2026-08-08T00:53:12Z logger.go:67: secret/pool-passwd created2026-08-08T00:53:12.1201087Z TestOSPoolEP 2026-08-08T00:53:12Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-08T00:53:12.1202877Z TestOSPoolEP 2026-08-08T00:53:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:53:12.1236611Z TestOSPoolEP 2026-08-08T00:53:12Z 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-08-08T00:53:22.1245003Z TestOSPoolEP 2026-08-08T00:53:22Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-08T00:53:22.1246852Z TestOSPoolEP 2026-08-08T00:53:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:53:22.1267669Z TestOSPoolEP 2026-08-08T00:53:22Z 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-08-08T00:53:32.1266908Z TestOSPoolEP 2026-08-08T00:53:32Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-08T00:53:32.1268362Z TestOSPoolEP 2026-08-08T00:53:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:53:32.1287201Z TestOSPoolEP 2026-08-08T00:53:32Z logger.go:67: Pod is now available2026-08-08T00:53:32.1288866Z TestOSPoolEP 2026-08-08T00:53:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-08T00:53:32.5503058Z TestOSPoolEP 2026-08-08T00:53:32Z logger.go:67: ***2026-08-08T00:53:32.5564809Z TestOSPoolEP 2026-08-08T00:53:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz apply -f /tmp/TestOSPoolEP1063634662]2026-08-08T00:53:32.7403293Z TestOSPoolEP 2026-08-08T00:53:32Z logger.go:67: secret/pool-token created2026-08-08T00:53:32.7437406Z TestOSPoolEP 2026-08-08T00:53:32Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-08T00:53:32.7438783Z TestOSPoolEP 2026-08-08T00:53:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:53:32.7457162Z TestOSPoolEP 2026-08-08T00:53:32Z logger.go:67: Secret is now available2026-08-08T00:53:32.7478915Z TestOSPoolEP 2026-08-08T00:53:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz apply -k /tmp/kustomize-template-2501406411]2026-08-08T00:53:33.0236534Z TestOSPoolEP 2026-08-08T00:53:33Z logger.go:67: service/test-cm created2026-08-08T00:53:33.0333163Z TestOSPoolEP 2026-08-08T00:53:33Z logger.go:67: deployment.apps/ospool-ep created2026-08-08T00:53:33.0335720Z TestOSPoolEP 2026-08-08T00:53:33Z 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-08-08T00:53:33.0486929Z TestOSPoolEP 2026-08-08T00:53:33Z logger.go:67: deployment.apps/test-cm created2026-08-08T00:53:33.0527279Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-08T00:53:33.0529262Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:53:33Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:53:33.0627936Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:53:33Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-08T00:53:33.0630150Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:53:33Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:53:33.0632400Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:53:33Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-08T00:53:33.0634512Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:53:33Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:53:33.0808524Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:53:33Z 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-6c7d796845". Sleeping for 10s and will try again.2026-08-08T00:53:33.0845644Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:53:33Z 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-54b7d49f85". Sleeping for 10s and will try again.2026-08-08T00:53:43.0816816Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:53:43Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-08T00:53:43.0818670Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:53:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:53:43.0841882Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:53:43Z 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-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-08-08T00:53:43.0851188Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:53:43Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-08T00:53:43.0852997Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:53:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:53:43.0867678Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:53:43Z logger.go:67: Deployment is now available2026-08-08T00:53:53.0858800Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:53:53Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-08T00:53:53.0860448Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:53:53Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:53:53.0889501Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:53:53Z 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-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-08-08T00:54:03.0905558Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:54:03Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-08T00:54:03.0907775Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:54:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:54:03.0947228Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-08T00:54:03Z logger.go:67: Deployment is now available2026-08-08T00:54:03.0953566Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-08T00:54:03.0954526Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-08T00:54:03.0955322Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-08T00:54:03.0961324Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-08T00:54:03.0962343Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-08T00:54:03.0963519Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-08T00:54:03.0964264Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-08T00:54:03.0965320Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-08T00:54:03.0967013Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-08T00:54:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:54:03.0969137Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:54:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:54:03.0970272Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-08T00:54:03.0971744Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-08T00:54:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:54:03.0985680Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:54:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:54:03.0989736Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-08T00:54:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:54:03.0991987Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-08T00:54:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:54:03.1008438Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:54:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-08T00:54:03.1012951Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-08T00:54:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)']2026-08-08T00:54:03.1042124Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-08T00:54:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_SINGULARITY]2026-08-08T00:54:03.3423667Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-sm8h4 failed. Retrying in 10s.2026-08-08T00:54:03.3427111Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-08T00:54:03.3430204Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)']' in pod test-cm-54b7d49f85-sm8h4 failed. Retrying in 10s.2026-08-08T00:54:03.3471467Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-08T00:54:03.3472668Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-sm8h4 failed. Retrying in 30s.2026-08-08T00:54:13.3426479Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-08T00:54:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_SINGULARITY]2026-08-08T00:54:13.3430997Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-08T00:54:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)']2026-08-08T00:54:13.5375824Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-08T00:54:13.5377274Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-sm8h4 failed. Retrying in 10s.2026-08-08T00:54:13.5389497Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-08T00:54:13.5390574Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)']' in pod test-cm-54b7d49f85-sm8h4 failed. Retrying in 10s.2026-08-08T00:54:23.5390871Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-08T00:54:23Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_SINGULARITY]2026-08-08T00:54:23.5394896Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-08T00:54:23Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)']2026-08-08T00:54:23.7077124Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-08T00:54:23Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-08T00:54:23.7081408Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-08T00:54:23Z logger.go:67: 2026-08-08T00:54:23.7083539Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-08T00:54:23Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-zmvgg LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-08-08T00:54:23.7085808Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-08T00:54:23Z logger.go:67: 2026-08-08T00:54:23.7087641Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-08T00:54:23Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-08T00:54:23.7089164Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-08T00:54:23Z logger.go:67: 2026-08-08T00:54:23.7090547Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-08T00:54:23Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-08T00:54:23.7091885Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-08T00:54:23Z logger.go:67: 2026-08-08T00:54:23.7093585Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-08T00:54:23Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-08T00:54:23.7127452Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-08T00:54:23Z logger.go:67: true2026-08-08T00:54:33.3484700Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:54:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-08T00:54:33.4998512Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:54:33Z logger.go:67: undefined2026-08-08T00:54:33.5054930Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-08T00:54:33.5056710Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-sm8h4 failed. Retrying in 30s.2026-08-08T00:55:03.5058105Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:55:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-08T00:55:03.6483313Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:55:03Z logger.go:67: undefined2026-08-08T00:55:03.6541077Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-sm8h4 failed. Retrying in 30s.2026-08-08T00:55:33.6545152Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:55:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-08T00:55:33.8027364Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:55:33Z logger.go:67: undefined2026-08-08T00:55:33.8084582Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-sm8h4 failed. Retrying in 30s.2026-08-08T00:56:03.8090325Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:56:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-08T00:56:03.9481608Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:56:03Z logger.go:67: undefined2026-08-08T00:56:03.9534364Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-sm8h4 failed. Retrying in 30s.2026-08-08T00:56:33.9549580Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:56:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-08T00:56:34.0944488Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:56:34Z logger.go:67: undefined2026-08-08T00:56:34.1000624Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-sm8h4 failed. Retrying in 30s.2026-08-08T00:57:04.1025997Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:57:04Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-08T00:57:04.2504732Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:57:04Z logger.go:67: undefined2026-08-08T00:57:04.2544763Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-sm8h4 failed. Retrying in 30s.2026-08-08T00:57:34.2578672Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:57:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-08T00:57:34.4042173Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:57:34Z logger.go:67: undefined2026-08-08T00:57:34.4100558Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-sm8h4 failed. Retrying in 30s.2026-08-08T00:58:04.4104592Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:58:04Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-08T00:58:04.5533150Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:58:04Z logger.go:67: undefined2026-08-08T00:58:04.5584707Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-sm8h4 failed. Retrying in 30s.2026-08-08T00:58:34.5617910Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:58:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-08T00:58:34.7074919Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:58:34Z logger.go:67: undefined2026-08-08T00:58:34.7120168Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-sm8h4 failed. Retrying in 30s.2026-08-08T00:59:04.7147417Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:59:04Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-08T00:59:04.8597113Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:59:04Z logger.go:67: undefined2026-08-08T00:59:04.8654532Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-sm8h4 failed. Retrying in 30s.2026-08-08T00:59:34.8683094Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:59:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz exec test-cm-54b7d49f85-sm8h4 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-zmvgg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-08T00:59:35.0313356Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-08T00:59:35Z logger.go:67: true2026-08-08T00:59:35.0375555Z TestOSPoolEP 2026-08-08T00:59:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:59:35.0445102Z TestOSPoolEP 2026-08-08T00:59:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:59:35.1968684Z TestOSPoolEP 2026-08-08T00:59:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:59:35.3366974Z TestOSPoolEP 2026-08-08T00:59:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:59:35.4635882Z TestOSPoolEP 2026-08-08T00:59:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:59:35.4662737Z === NAME TestOSPoolEP2026-08-08T00:59:35.4663498Z ospool_ep_test.go:101: ---2026-08-08T00:59:35.4664302Z Events for pod idtoken-generator:2026-08-08T00:59:35.4665902Z 2026-08-08 00:53:12 +0000 UTC Normal Successfully assigned test-ospool-ep-yvlchz/idtoken-generator to minikube2026-08-08T00:59:35.4667218Z 2026-08-08 00:53:12 +0000 UTC Normal Pulling image "htcondor/base"2026-08-08T00:59:35.4668908Z 2026-08-08 00:53:22 +0000 UTC Normal Successfully pulled image "htcondor/base" in 9.195s (9.195s including waiting). Image size: 560910730 bytes.2026-08-08T00:59:35.4670178Z 2026-08-08 00:53:22 +0000 UTC Normal Container created2026-08-08T00:59:35.4670659Z 2026-08-08 00:53:22 +0000 UTC Normal Container started2026-08-08T00:59:35.4671132Z 2026-08-08T00:59:35.4671484Z ---2026-08-08T00:59:35.4672464Z TestOSPoolEP 2026-08-08T00:59:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:59:35.4688508Z ospool_ep_test.go:101: ---2026-08-08T00:59:35.4689308Z Events for pod ospool-ep-6c7d796845-zmvgg:2026-08-08T00:59:35.4690848Z 2026-08-08 00:53:33 +0000 UTC Normal Successfully assigned test-ospool-ep-yvlchz/ospool-ep-6c7d796845-zmvgg to minikube2026-08-08T00:59:35.4692936Z 2026-08-08 00:53:33 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-08T00:59:35.4695005Z 2026-08-08 00:53:35 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 2.035s (2.035s including waiting). Image size: 5590942 bytes.2026-08-08T00:59:35.4696797Z 2026-08-08 00:53:35 +0000 UTC Normal Container created2026-08-08T00:59:35.4697578Z 2026-08-08 00:53:35 +0000 UTC Normal Container started2026-08-08T00:59:35.4698875Z 2026-08-08 00:53:36 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-08-08T00:59:35.4701171Z 2026-08-08 00:53:57 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 15.65s (21.346s including waiting). Image size: 1266346391 bytes.2026-08-08T00:59:35.4702757Z 2026-08-08 00:53:57 +0000 UTC Normal Container created2026-08-08T00:59:35.4703547Z 2026-08-08 00:53:57 +0000 UTC Normal Container started2026-08-08T00:59:35.4704100Z 2026-08-08T00:59:35.4704443Z ---2026-08-08T00:59:35.4705589Z TestOSPoolEP 2026-08-08T00:59:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:59:35.4756748Z ospool_ep_test.go:101: ---2026-08-08T00:59:35.4758401Z Events for pod test-cm-54b7d49f85-sm8h4:2026-08-08T00:59:35.4765799Z 2026-08-08 00:53:33 +0000 UTC Normal Successfully assigned test-ospool-ep-yvlchz/test-cm-54b7d49f85-sm8h4 to minikube2026-08-08T00:59:35.4767405Z 2026-08-08 00:53:33 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-08-08T00:59:35.4769561Z 2026-08-08 00:53:42 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 6.439s (8.469s including waiting). Image size: 573055668 bytes.2026-08-08T00:59:35.4770392Z 2026-08-08 00:53:42 +0000 UTC Normal Container created2026-08-08T00:59:35.4770898Z 2026-08-08 00:53:42 +0000 UTC Normal Container started2026-08-08T00:59:35.4771226Z 2026-08-08T00:59:35.4771430Z ---2026-08-08T00:59:35.4771998Z TestOSPoolEP 2026-08-08T00:59:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-08T00:59:35.4799874Z TestOSPoolEP 2026-08-08T00:59:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz delete -f /tmp/TestOSPoolEP3440186232]2026-08-08T00:59:35.5739555Z TestOSPoolEP 2026-08-08T00:59:35Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-yvlchz namespace2026-08-08T00:59:35.5791835Z TestOSPoolEP 2026-08-08T00:59:35Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-yvlchz namespace2026-08-08T00:59:36.2266734Z TestOSPoolEP 2026-08-08T00:59:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz delete -f /tmp/TestOSPoolEP1021777343]2026-08-08T00:59:36.3216654Z TestOSPoolEP 2026-08-08T00:59:36Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-yvlchz namespace2026-08-08T00:59:36.3263426Z TestOSPoolEP 2026-08-08T00:59:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-yvlchz delete -k /tmp/kustomize-template-2501406411]2026-08-08T00:59:36.4670215Z TestOSPoolEP 2026-08-08T00:59:36Z logger.go:67: service "test-cm" deleted from test-ospool-ep-yvlchz namespace2026-08-08T00:59:36.4715325Z TestOSPoolEP 2026-08-08T00:59:36Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-yvlchz namespace2026-08-08T00:59:36.4758863Z TestOSPoolEP 2026-08-08T00:59:36Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-yvlchz namespace2026-08-08T00:59:36.4887714Z --- PASS: TestOSPoolEP (53.55s)2026-08-08T00:59:36.4889929Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.04s)2026-08-08T00:59:36.4896452Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.62s)2026-08-08T00:59:36.4897954Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.62s)2026-08-08T00:59:36.4899718Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (331.94s)2026-08-08T00:59:36.4900532Z PASS2026-08-08T00:59:36.4918530Z ok github.com/osg-htc/k8s-integration-tests/test 385.511s2026-08-08T00:59:36.6076083Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-08T00:59:36.6076763Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-08T00:59:36.6151883Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-08T00:59:36.6152290Z env:2026-08-08T00:59:36.6152491Z GOTOOLCHAIN: local2026-08-08T00:59:36.6153709Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-08T00:59:36.6155807Z ##[endgroup]2026-08-08T00:59:36.6368556Z Node 20 is being deprecated. This workflow is running with Node 24 by default. If you need to temporarily use Node 20, you can set the ACTIONS_ALLOW_USE_UNSECURE_NODE_VERSION=true environment variable. For more information see: https://github.blog/changelog/2025-09-19-deprecation-of-node-20-on-github-actions-runners/2026-08-08T00:59:36.6369875Z ##[group]Run actions/upload-artifact@v42026-08-08T00:59:36.6370160Z with:2026-08-08T00:59:36.6370539Z name: TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce72322026-08-08T00:59:36.6371014Z path: /tmp/k8s-tests2026-08-08T00:59:36.6371243Z retention-days: 52026-08-08T00:59:36.6371462Z if-no-files-found: warn2026-08-08T00:59:36.6371703Z compression-level: 62026-08-08T00:59:36.6371916Z overwrite: false2026-08-08T00:59:36.6372133Z include-hidden-files: false2026-08-08T00:59:36.6372384Z env:2026-08-08T00:59:36.6372563Z GOTOOLCHAIN: local2026-08-08T00:59:36.6372768Z ##[endgroup]2026-08-08T00:59:36.8910726Z (node:17674) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-08T00:59:36.8912423Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-08T00:59:36.9034150Z With the provided path, there will be 6 files uploaded2026-08-08T00:59:36.9046133Z Artifact name is valid!2026-08-08T00:59:36.9046926Z Root directory input is valid!2026-08-08T00:59:37.2193041Z Beginning upload of artifact content to blob storage2026-08-08T00:59:37.2759779Z (node:17674) [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-08-08T00:59:37.6572729Z Uploaded bytes 139882026-08-08T00:59:37.7433148Z Finished uploading artifact content to blob storage!2026-08-08T00:59:37.7434220Z SHA256 digest of uploaded artifact zip is 6de6c755726ee5742808d5baea8ab2074892e51f292f7e7ee8409b9813daf07b2026-08-08T00:59:37.7436247Z Finalizing artifact upload2026-08-08T00:59:37.9535312Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232.zip successfully finalized. Artifact ID 90139740972026-08-08T00:59:37.9537452Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232 has been successfully uploaded! Final size is 13988 bytes. Artifact ID is 90139740972026-08-08T00:59:37.9542923Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/31231210933/artifacts/90139740972026-08-08T00:59:37.9716039Z Post job cleanup.2026-08-08T00:59:38.1131641Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-08T00:59:38.1177050Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-08T00:59:38.1226950Z /home/runner/.cache/go-build2026-08-08T00:59:38.1235784Z /home/runner/go/pkg/mod2026-08-08T00:59:38.1243919Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-08T00:59:38.1418370Z Post job cleanup.2026-08-08T00:59:38.2352579Z [command]/usr/bin/git version2026-08-08T00:59:38.2395213Z git version 2.54.02026-08-08T00:59:38.2479437Z Temporarily overriding HOME='/home/runner/work/_temp/3152179d-cb44-457c-bdf5-430d0bd6b766' before making global git config changes2026-08-08T00:59:38.2480801Z Adding repository directory to the temporary git global config as a safe directory2026-08-08T00:59:38.2482072Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-08T00:59:38.2530411Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-08T00:59:38.2568958Z [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-08-08T00:59:38.2935280Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-08T00:59:38.2963264Z http.https://github.com/.extraheader2026-08-08T00:59:38.2982658Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-08T00:59:38.3025185Z [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-08-08T00:59:38.3436678Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-08T00:59:38.3483027Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-08T00:59:38.4000261Z Cleaning up orphan processes2026-08-08T00:59:38.4746832Z ##[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/