2026-08-09T00:54:30.4008658Z Current runner version: '2.336.0'2026-08-09T00:54:30.4034682Z ##[group]Runner Image Provisioner2026-08-09T00:54:30.4035542Z Hosted Compute Agent2026-08-09T00:54:30.4036259Z Version: 20260707.5632026-08-09T00:54:30.4036928Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-08-09T00:54:30.4037718Z Build Date: 2026-07-07T19:33:50Z2026-08-09T00:54:30.4038459Z Worker ID: {c70a7d70-1c02-41a1-b265-2c004a167b7a}2026-08-09T00:54:30.4039563Z Azure Region: eastus22026-08-09T00:54:30.4040237Z ##[endgroup]2026-08-09T00:54:30.4041722Z ##[group]Operating System2026-08-09T00:54:30.4042342Z Ubuntu2026-08-09T00:54:30.4043007Z 22.04.52026-08-09T00:54:30.4043552Z LTS2026-08-09T00:54:30.4044129Z ##[endgroup]2026-08-09T00:54:30.4044752Z ##[group]Runner Image2026-08-09T00:54:30.4045379Z Image: ubuntu-22.042026-08-09T00:54:30.4046044Z Version: 20260720.234.22026-08-09T00:54:30.4047341Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-08-09T00:54:30.4048949Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-08-09T00:54:30.4050299Z ##[endgroup]2026-08-09T00:54:30.4051588Z ##[group]GITHUB_TOKEN Permissions2026-08-09T00:54:30.4053852Z Contents: read2026-08-09T00:54:30.4054572Z Metadata: read2026-08-09T00:54:30.4055184Z Packages: read2026-08-09T00:54:30.4055720Z ##[endgroup]2026-08-09T00:54:30.4058229Z Secret source: Actions2026-08-09T00:54:30.4059632Z Prepare workflow directory2026-08-09T00:54:30.4453621Z Prepare all required actions2026-08-09T00:54:30.4501609Z Getting action download info2026-08-09T00:54:30.6735639Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-09T00:54:30.8861422Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-09T00:54:31.0283509Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-09T00:54:31.2065248Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-09T00:54:31.4502829Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-09T00:54:31.4507362Z ##[group] Inputs2026-08-09T00:54:31.4507891Z testName: TestOSPoolEP2026-08-09T00:54:31.4508765Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-09T00:54:31.4509870Z setupScript: 2026-08-09T00:54:31.4510294Z setupEnv: {}2026-08-09T00:54:31.4510717Z ##[endgroup]2026-08-09T00:54:31.4511650Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-testing) / Run Tests2026-08-09T00:54:31.5205992Z ##[group]Run actions/checkout@v52026-08-09T00:54:31.5206796Z with:2026-08-09T00:54:31.5207277Z repository: mwestphall/k8s-integration-tests2026-08-09T00:54:31.5211687Z token: ***2026-08-09T00:54:31.5212114Z ssh-strict: true2026-08-09T00:54:31.5212570Z ssh-user: git2026-08-09T00:54:31.5213009Z persist-credentials: true2026-08-09T00:54:31.5213484Z clean: true2026-08-09T00:54:31.5213909Z sparse-checkout-cone-mode: true2026-08-09T00:54:31.5214405Z fetch-depth: 12026-08-09T00:54:31.5214820Z fetch-tags: false2026-08-09T00:54:31.5215236Z show-progress: true2026-08-09T00:54:31.5215663Z lfs: false2026-08-09T00:54:31.5216049Z submodules: false2026-08-09T00:54:31.5216476Z set-safe-directory: true2026-08-09T00:54:31.5216958Z allow-unsafe-pr-checkout: false2026-08-09T00:54:31.5217660Z ##[endgroup]2026-08-09T00:54:31.6285730Z Syncing repository: mwestphall/k8s-integration-tests2026-08-09T00:54:31.6288664Z ##[group]Getting Git version info2026-08-09T00:54:31.6290400Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-09T00:54:31.6292256Z [command]/usr/bin/git version2026-08-09T00:54:31.6378803Z git version 2.54.02026-08-09T00:54:31.6399733Z ##[endgroup]2026-08-09T00:54:31.6415825Z Temporarily overriding HOME='/home/runner/work/_temp/ed133b1e-b776-46a9-b666-5a9aafd7ee76' before making global git config changes2026-08-09T00:54:31.6418231Z Adding repository directory to the temporary git global config as a safe directory2026-08-09T00:54:31.6421640Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-09T00:54:31.6463798Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-09T00:54:31.6468400Z ##[group]Initializing the repository2026-08-09T00:54:31.6475957Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-09T00:54:31.6562017Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-09T00:54:31.6563736Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-09T00:54:31.6565708Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-09T00:54:31.6566901Z hint: call:2026-08-09T00:54:31.6567614Z hint:2026-08-09T00:54:31.6568653Z hint: git config --global init.defaultBranch <name>2026-08-09T00:54:31.6569819Z hint:2026-08-09T00:54:31.6570690Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-09T00:54:31.6572118Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-09T00:54:31.6573187Z hint:2026-08-09T00:54:31.6573608Z hint: git branch -m <name>2026-08-09T00:54:31.6574082Z hint:2026-08-09T00:54:31.6574908Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-09T00:54:31.6576740Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-09T00:54:31.6579650Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-09T00:54:31.6614913Z ##[endgroup]2026-08-09T00:54:31.6616046Z ##[group]Disabling automatic garbage collection2026-08-09T00:54:31.6619565Z [command]/usr/bin/git config --local gc.auto 02026-08-09T00:54:31.6652533Z ##[endgroup]2026-08-09T00:54:31.6653587Z ##[group]Setting up auth2026-08-09T00:54:31.6660802Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-09T00:54:31.6697547Z [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-09T00:54:31.7082529Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-09T00:54:31.7125511Z [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-09T00:54:31.7402890Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-09T00:54:31.7440170Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-09T00:54:31.7700514Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-09T00:54:31.7741741Z ##[endgroup]2026-08-09T00:54:31.7742487Z ##[group]Fetching the repository2026-08-09T00:54:31.7751015Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-09T00:54:32.0008251Z From https://github.com/mwestphall/k8s-integration-tests2026-08-09T00:54:32.0009788Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-09T00:54:32.0036344Z ##[endgroup]2026-08-09T00:54:32.0037473Z ##[group]Determining the checkout info2026-08-09T00:54:32.0039808Z ##[endgroup]2026-08-09T00:54:32.0045780Z [command]/usr/bin/git sparse-checkout disable2026-08-09T00:54:32.0100645Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-09T00:54:32.0128700Z ##[group]Checking out the ref2026-08-09T00:54:32.0133876Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-09T00:54:32.0229055Z Switched to a new branch 'main'2026-08-09T00:54:32.0232184Z branch 'main' set up to track 'origin/main'.2026-08-09T00:54:32.0237934Z ##[endgroup]2026-08-09T00:54:32.0281122Z [command]/usr/bin/git log -1 --format=%H2026-08-09T00:54:32.0310555Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-09T00:54:32.0553586Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-09T00:54:32.0554742Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-09T00:54:32.0555785Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-09T00:54:32.0668922Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-09T00:54:32.0669820Z env:2026-08-09T00:54:32.0670585Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-09T00:54:32.0671495Z SETUP_ENV_YAML: {}2026-08-09T00:54:32.0671922Z ##[endgroup]2026-08-09T00:54:32.6346264Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-09T00:54:32.6347428Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-09T00:54:32.6410717Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-09T00:54:32.6411423Z env:2026-08-09T00:54:32.6412291Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-09T00:54:32.6413285Z ##[endgroup]2026-08-09T00:54:32.6567909Z ##[group]Run true2026-08-09T00:54:32.6568397Z [36;1mtrue[0m2026-08-09T00:54:32.6624598Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-09T00:54:32.6625332Z ##[endgroup]2026-08-09T00:54:32.6821763Z ##[group]Run medyagh/setup-minikube@latest2026-08-09T00:54:32.6822411Z with:2026-08-09T00:54:32.6822837Z start: true2026-08-09T00:54:32.6823259Z cache: true2026-08-09T00:54:32.6823701Z minikube-version: latest2026-08-09T00:54:32.6824202Z wait: all2026-08-09T00:54:32.6824617Z ##[endgroup]2026-08-09T00:54:32.8156976Z (node:2054) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-09T00:54:32.8160502Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-09T00:54:33.6065593Z [command]/usr/bin/chmod +x /home/runner/work/_temp/46480118-670d-4a9d-99a6-bad7bd8edc9c2026-08-09T00:54:33.7719874Z [command]/home/runner/bin/minikube version --short2026-08-09T00:54:33.8125708Z v1.38.12026-08-09T00:54:33.8943784Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-09T00:54:33.9044200Z (node:2054) [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-09T00:54:33.9059612Z Cache hit for: kic-v1.38.1-x642026-08-09T00:54:34.9594376Z Received 134217728 of 544082657 (24.7%), 126.4 MBs/sec2026-08-09T00:54:34.9750363Z Received 134217728 of 224218863 (59.9%), 127.4 MBs/sec2026-08-09T00:54:35.4063179Z Received 224218863 of 224218863 (100.0%), 148.7 MBs/sec2026-08-09T00:54:35.4064300Z Cache Size: ~214 MB (224218863 B)2026-08-09T00:54:35.5222170Z [command]/usr/bin/tar -xf /home/runner/work/_temp/f288b665-6000-42c8-a340-6dd351c1c2aa/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-09T00:54:35.9617104Z Received 381681664 of 544082657 (70.2%), 180.6 MBs/sec2026-08-09T00:54:36.1707879Z Cache restored successfully2026-08-09T00:54:36.7418994Z Received 544082657 of 544082657 (100.0%), 185.6 MBs/sec2026-08-09T00:54:36.7420127Z Cache Size: ~519 MB (544082657 B)2026-08-09T00:54:36.7533858Z [command]/usr/bin/tar -xf /home/runner/work/_temp/abb6560d-5f30-4053-b759-4139015a67eb/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-09T00:54:37.5916985Z Cache restored successfully2026-08-09T00:54:37.7104426Z [command]/home/runner/bin/minikube start --wait all2026-08-09T00:54:37.7543991Z * minikube v1.38.1 on Ubuntu 22.042026-08-09T00:54:38.1374694Z ! 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-09T00:54:38.1378421Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-09T00:54:38.1869275Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-09T00:54:38.1878044Z * Using Docker driver with root privileges2026-08-09T00:54:38.1889976Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-09T00:54:38.1899092Z * Pulling base image v0.0.50 ...2026-08-09T00:55:10.6505074Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-09T00:55:15.8202697Z * Verifying Kubernetes components...2026-08-09T00:55:15.8470951Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-09T00:55:16.5685185Z * Enabled addons: default-storageclass, storage-provisioner2026-08-09T00:55:31.5308045Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-09T00:55:31.5433417Z [command]/home/runner/bin/minikube version --short2026-08-09T00:55:31.5830194Z v1.38.12026-08-09T00:55:31.6195902Z ##[group]Run actions/setup-go@v62026-08-09T00:55:31.6196206Z with:2026-08-09T00:55:31.6196416Z go-version: 1.262026-08-09T00:55:31.6196644Z cache: true2026-08-09T00:55:31.6196871Z cache-dependency-path: go.sum2026-08-09T00:55:31.6197132Z check-latest: false2026-08-09T00:55:31.6200116Z token: ***2026-08-09T00:55:31.6200336Z ##[endgroup]2026-08-09T00:55:31.7499122Z Setup go version spec 1.262026-08-09T00:55:31.7550836Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-09T00:55:31.7553196Z Added go to the path2026-08-09T00:55:31.7556415Z Successfully set up Go version 1.262026-08-09T00:55:32.3897232Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-09T00:55:32.3933650Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-09T00:55:32.3963056Z /home/runner/go/pkg/mod2026-08-09T00:55:32.3986402Z /home/runner/.cache/go-build2026-08-09T00:55:32.4765910Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-09T00:55:33.5335682Z Received 180355072 of 251839808 (71.6%), 172.0 MBs/sec2026-08-09T00:55:33.8683649Z Received 251839808 of 251839808 (100.0%), 179.9 MBs/sec2026-08-09T00:55:33.8684828Z Cache Size: ~240 MB (251839808 B)2026-08-09T00:55:33.8795908Z [command]/usr/bin/tar -xf /home/runner/work/_temp/e19a92e2-7fd1-497f-a994-5318ea6d3210/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-09T00:55:36.8209458Z Cache restored successfully2026-08-09T00:55:36.8869823Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-09T00:55:36.8922449Z go version go1.26.5 linux/amd642026-08-09T00:55:36.8922772Z 2026-08-09T00:55:36.8923234Z ##[group]go env2026-08-09T00:55:36.9182719Z AR='ar'2026-08-09T00:55:36.9183064Z CC='gcc'2026-08-09T00:55:36.9183404Z CGO_CFLAGS='-O2 -g'2026-08-09T00:55:36.9183834Z CGO_CPPFLAGS=''2026-08-09T00:55:36.9184220Z CGO_CXXFLAGS='-O2 -g'2026-08-09T00:55:36.9184616Z CGO_ENABLED='1'2026-08-09T00:55:36.9184973Z CGO_FFLAGS='-O2 -g'2026-08-09T00:55:36.9185264Z CGO_LDFLAGS='-O2 -g'2026-08-09T00:55:36.9185494Z CXX='g++'2026-08-09T00:55:36.9185716Z GCCGO='gccgo'2026-08-09T00:55:36.9186214Z GO111MODULE=''2026-08-09T00:55:36.9186566Z GOAMD64='v1'2026-08-09T00:55:36.9187175Z GOARCH='amd64'2026-08-09T00:55:36.9187493Z GOAUTH='netrc'2026-08-09T00:55:36.9187782Z GOBIN=''2026-08-09T00:55:36.9188133Z GOCACHE='/home/runner/.cache/go-build'2026-08-09T00:55:36.9188487Z GOCACHEPROG=''2026-08-09T00:55:36.9188825Z GODEBUG=''2026-08-09T00:55:36.9189315Z GOENV='/home/runner/.config/go/env'2026-08-09T00:55:36.9189688Z GOEXE=''2026-08-09T00:55:36.9189888Z GOEXPERIMENT=''2026-08-09T00:55:36.9190121Z GOFIPS140='off'2026-08-09T00:55:36.9190328Z GOFLAGS=''2026-08-09T00:55:36.9191052Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build3297064653=/tmp/go-build -gno-record-gcc-switches'2026-08-09T00:55:36.9191766Z GOHOSTARCH='amd64'2026-08-09T00:55:36.9191993Z GOHOSTOS='linux'2026-08-09T00:55:36.9192217Z GOINSECURE=''2026-08-09T00:55:36.9192615Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-09T00:55:36.9193050Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-09T00:55:36.9193327Z GONOPROXY=''2026-08-09T00:55:36.9193527Z GONOSUMDB=''2026-08-09T00:55:36.9193756Z GOOS='linux'2026-08-09T00:55:36.9193968Z GOPATH='/home/runner/go'2026-08-09T00:55:36.9194208Z GOPRIVATE=''2026-08-09T00:55:36.9194486Z GOPROXY='https://proxy.golang.org,direct'2026-08-09T00:55:36.9194941Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-09T00:55:36.9195251Z GOSUMDB='sum.golang.org'2026-08-09T00:55:36.9195506Z GOTELEMETRY='local'2026-08-09T00:55:36.9195798Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-09T00:55:36.9196113Z GOTMPDIR=''2026-08-09T00:55:36.9196320Z GOTOOLCHAIN='local'2026-08-09T00:55:36.9196920Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-09T00:55:36.9197304Z GOVCS=''2026-08-09T00:55:36.9197516Z GOVERSION='go1.26.5'2026-08-09T00:55:36.9197751Z GOWORK=''2026-08-09T00:55:36.9197971Z PKG_CONFIG='pkg-config'2026-08-09T00:55:36.9198127Z 2026-08-09T00:55:36.9198471Z ##[endgroup]2026-08-09T00:55:36.9414891Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-09T00:55:36.9415402Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-09T00:55:36.9479499Z shell: /usr/bin/bash -e {0}2026-08-09T00:55:36.9479767Z env:2026-08-09T00:55:36.9479987Z GOTOOLCHAIN: local2026-08-09T00:55:36.9480250Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-08-09T00:55:36.9480540Z OSPOOL_EP_CMTag: 25.x-el92026-08-09T00:55:36.9480796Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-09T00:55:36.9481053Z ##[endgroup]2026-08-09T00:55:43.1434448Z === RUN TestOSPoolEP2026-08-09T00:55:43.1436896Z === PAUSE TestOSPoolEP2026-08-09T00:55:43.1437339Z === CONT TestOSPoolEP2026-08-09T00:55:43.1438533Z TestOSPoolEP 2026-08-09T00:55:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:55:43.1747971Z TestOSPoolEP 2026-08-09T00:55:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv apply -f /tmp/TestOSPoolEP71830418]2026-08-09T00:55:44.2778711Z TestOSPoolEP 2026-08-09T00:55:44Z logger.go:67: pod/idtoken-generator created2026-08-09T00:55:44.2852453Z TestOSPoolEP 2026-08-09T00:55:44Z logger.go:67: secret/pool-passwd created2026-08-09T00:55:44.2903252Z TestOSPoolEP 2026-08-09T00:55:44Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-09T00:55:44.2904550Z TestOSPoolEP 2026-08-09T00:55:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:55:44.2940015Z TestOSPoolEP 2026-08-09T00:55:44Z 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-09T00:55:54.2949533Z TestOSPoolEP 2026-08-09T00:55:54Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-09T00:55:54.2950676Z TestOSPoolEP 2026-08-09T00:55:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:55:54.2978514Z TestOSPoolEP 2026-08-09T00:55:54Z 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-09T00:56:04.2985325Z TestOSPoolEP 2026-08-09T00:56:04Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-09T00:56:04.2986361Z TestOSPoolEP 2026-08-09T00:56:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:04.3012783Z TestOSPoolEP 2026-08-09T00:56:04Z logger.go:67: Pod is now available2026-08-09T00:56:04.3014192Z TestOSPoolEP 2026-08-09T00:56:04Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-09T00:56:04.7037460Z TestOSPoolEP 2026-08-09T00:56:04Z logger.go:67: ***2026-08-09T00:56:04.7094779Z TestOSPoolEP 2026-08-09T00:56:04Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv apply -f /tmp/TestOSPoolEP3141410265]2026-08-09T00:56:04.8885254Z TestOSPoolEP 2026-08-09T00:56:04Z logger.go:67: secret/pool-token created2026-08-09T00:56:04.8916570Z TestOSPoolEP 2026-08-09T00:56:04Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-09T00:56:04.8917932Z TestOSPoolEP 2026-08-09T00:56:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:04.8935938Z TestOSPoolEP 2026-08-09T00:56:04Z logger.go:67: Secret is now available2026-08-09T00:56:04.8964298Z TestOSPoolEP 2026-08-09T00:56:04Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv apply -k /tmp/kustomize-template-2811991146]2026-08-09T00:56:05.1694437Z TestOSPoolEP 2026-08-09T00:56:05Z logger.go:67: service/test-cm created2026-08-09T00:56:05.1771771Z TestOSPoolEP 2026-08-09T00:56:05Z 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-09T00:56:05.1775593Z TestOSPoolEP 2026-08-09T00:56:05Z logger.go:67: deployment.apps/ospool-ep created2026-08-09T00:56:05.1893690Z TestOSPoolEP 2026-08-09T00:56:05Z logger.go:67: deployment.apps/test-cm created2026-08-09T00:56:05.1940893Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-09T00:56:05.1942382Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:05Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:05.2034936Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:05Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-09T00:56:05.2047051Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:05Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:05.2049094Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:05Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-09T00:56:05.2055866Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:05Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:05.2087337Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:05Z 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-08-09T00:56:05.2092678Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:05Z 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-08-09T00:56:15.2093283Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:15Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-09T00:56:15.2095922Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:15Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:15.2099021Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:15Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-09T00:56:15.2101532Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:15Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:15.2139648Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:15Z logger.go:67: Deployment is now available2026-08-09T00:56:15.2145071Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:15Z 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-08-09T00:56:25.2153718Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:25Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-09T00:56:25.2154851Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:25.2181874Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:25Z logger.go:67: Deployment is now available2026-08-09T00:56:25.2183611Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-09T00:56:25.2184533Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-09T00:56:25.2185484Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-09T00:56:25.2186448Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-09T00:56:25.2187349Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-09T00:56:25.2188184Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-09T00:56:25.2189019Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-09T00:56:25.2190045Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-09T00:56:25.2191604Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:56:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:25.2193895Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:56:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:25.2195509Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-09T00:56:25.2197139Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-09T00:56:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:25.2227241Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:56:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:25.2232879Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-09T00:56:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:25.2235347Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:56:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:25.2257234Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:56:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T00:56:25.2261293Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:56:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)']2026-08-09T00:56:25.2264578Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-09T00:56:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_SINGULARITY]2026-08-09T00:56:25.4493944Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-09T00:56:25.4496491Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-j26j5 failed. Retrying in 30s.2026-08-09T00:56:25.4647491Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-09T00:56:25.4649842Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-j26j5 failed. Retrying in 10s.2026-08-09T00:56:25.4700907Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-09T00:56:25.4702313Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)']' in pod test-cm-5bb545475c-j26j5 failed. Retrying in 10s.2026-08-09T00:56:35.4660559Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-09T00:56:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_SINGULARITY]2026-08-09T00:56:35.4713910Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:56:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)']2026-08-09T00:56:35.7141827Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-09T00:56:35.7143783Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-j26j5 failed. Retrying in 10s.2026-08-09T00:56:35.7319845Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-09T00:56:35.7321633Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)']' in pod test-cm-5bb545475c-j26j5 failed. Retrying in 10s.2026-08-09T00:56:45.7146819Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-09T00:56:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_SINGULARITY]2026-08-09T00:56:45.7330220Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:56:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)']2026-08-09T00:56:45.9069727Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-09T00:56:45Z logger.go:67: true2026-08-09T00:56:45.9172586Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:56:45Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-09T00:56:45.9174487Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:56:45Z logger.go:67: 2026-08-09T00:56:45.9176698Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:56:45Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-65c844ddbb-bjnww LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-08-09T00:56:45.9178335Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:56:45Z logger.go:67: 2026-08-09T00:56:45.9180146Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:56:45Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-09T00:56:45.9181553Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:56:45Z logger.go:67: 2026-08-09T00:56:45.9182879Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:56:45Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-09T00:56:45.9184141Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:56:45Z logger.go:67: 2026-08-09T00:56:45.9188660Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:56:45Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-09T00:56:55.4503696Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:56:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T00:56:55.6050197Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:56:55Z logger.go:67: undefined2026-08-09T00:56:55.6104569Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-09T00:56:55.6105799Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-j26j5 failed. Retrying in 30s.2026-08-09T00:57:25.6118504Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:57:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T00:57:25.7556112Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:57:25Z logger.go:67: undefined2026-08-09T00:57:25.7610587Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-j26j5 failed. Retrying in 30s.2026-08-09T00:57:55.7622143Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:57:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T00:57:55.9116420Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:57:55Z logger.go:67: undefined2026-08-09T00:57:55.9166915Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-j26j5 failed. Retrying in 30s.2026-08-09T00:58:25.9172357Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:58:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T00:58:26.0613746Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:58:26Z logger.go:67: undefined2026-08-09T00:58:26.0675159Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-j26j5 failed. Retrying in 30s.2026-08-09T00:58:56.0702527Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:58:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T00:58:56.2175899Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:58:56Z logger.go:67: undefined2026-08-09T00:58:56.2235294Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-j26j5 failed. Retrying in 30s.2026-08-09T00:59:26.2237582Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:59:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T00:59:26.3707302Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:59:26Z logger.go:67: undefined2026-08-09T00:59:26.3762397Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-j26j5 failed. Retrying in 30s.2026-08-09T00:59:56.3783808Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:59:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T00:59:56.5272980Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:59:56Z logger.go:67: undefined2026-08-09T00:59:56.5330363Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-j26j5 failed. Retrying in 30s.2026-08-09T01:00:26.5335437Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:00:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T01:00:26.6804828Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:00:26Z logger.go:67: undefined2026-08-09T01:00:26.6869758Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-j26j5 failed. Retrying in 30s.2026-08-09T01:00:56.6903865Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:00:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T01:00:56.8365851Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:00:56Z logger.go:67: undefined2026-08-09T01:00:56.8425936Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-j26j5 failed. Retrying in 30s.2026-08-09T01:01:26.8463360Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:01:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T01:01:26.9974292Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:01:26Z logger.go:67: undefined2026-08-09T01:01:27.0034882Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-j26j5 failed. Retrying in 30s.2026-08-09T01:01:57.0047225Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:01:57Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv exec test-cm-5bb545475c-j26j5 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bjnww",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T01:01:57.1932712Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:01:57Z logger.go:67: true2026-08-09T01:01:57.2005403Z TestOSPoolEP 2026-08-09T01:01:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T01:01:57.2098216Z TestOSPoolEP 2026-08-09T01:01:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T01:01:57.3899963Z TestOSPoolEP 2026-08-09T01:01:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T01:01:57.5226631Z TestOSPoolEP 2026-08-09T01:01:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T01:01:57.6351066Z TestOSPoolEP 2026-08-09T01:01:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T01:01:57.6403681Z === NAME TestOSPoolEP2026-08-09T01:01:57.6408335Z ospool_ep_test.go:101: ---2026-08-09T01:01:57.6409713Z Events for pod idtoken-generator:2026-08-09T01:01:57.6411492Z 2026-08-09 00:55:44 +0000 UTC Normal Successfully assigned test-ospool-ep-iw4ekv/idtoken-generator to minikube2026-08-09T01:01:57.6415196Z 2026-08-09 00:55:45 +0000 UTC Normal Pulling image "htcondor/base"2026-08-09T01:01:57.6417146Z 2026-08-09 00:55:53 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.287s (8.287s including waiting). Image size: 560910730 bytes.2026-08-09T01:01:57.6419358Z 2026-08-09 00:55:53 +0000 UTC Normal Container created2026-08-09T01:01:57.6421116Z 2026-08-09 00:55:53 +0000 UTC Normal Container started2026-08-09T01:01:57.6421728Z 2026-08-09T01:01:57.6422131Z ---2026-08-09T01:01:57.6423208Z TestOSPoolEP 2026-08-09T01:01:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T01:01:57.6438778Z ospool_ep_test.go:101: ---2026-08-09T01:01:57.6439771Z Events for pod ospool-ep-65c844ddbb-bjnww:2026-08-09T01:01:57.6441270Z 2026-08-09 00:56:05 +0000 UTC Normal Successfully assigned test-ospool-ep-iw4ekv/ospool-ep-65c844ddbb-bjnww to minikube2026-08-09T01:01:57.6442969Z 2026-08-09 00:56:05 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-09T01:01:57.6445134Z 2026-08-09 00:56:07 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.846s (1.846s including waiting). Image size: 5590942 bytes.2026-08-09T01:01:57.6446701Z 2026-08-09 00:56:07 +0000 UTC Normal Container created2026-08-09T01:01:57.6447603Z 2026-08-09 00:56:07 +0000 UTC Normal Container started2026-08-09T01:01:57.6448905Z 2026-08-09 00:56:08 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-08-09T01:01:57.6456111Z 2026-08-09 00:56:22 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 13.626s (13.626s including waiting). Image size: 1266439120 bytes.2026-08-09T01:01:57.6457764Z 2026-08-09 00:56:22 +0000 UTC Normal Container created2026-08-09T01:01:57.6458690Z 2026-08-09 00:56:22 +0000 UTC Normal Container started2026-08-09T01:01:57.6459439Z 2026-08-09T01:01:57.6459756Z ---2026-08-09T01:01:57.6461234Z TestOSPoolEP 2026-08-09T01:01:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T01:01:57.6462734Z ospool_ep_test.go:101: ---2026-08-09T01:01:57.6464177Z Events for pod test-cm-5bb545475c-j26j5:2026-08-09T01:01:57.6465845Z 2026-08-09 00:56:05 +0000 UTC Normal Successfully assigned test-ospool-ep-iw4ekv/test-cm-5bb545475c-j26j5 to minikube2026-08-09T01:01:57.6467484Z 2026-08-09 00:56:05 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-08-09T01:01:57.6470066Z 2026-08-09 00:56:07 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 311ms (2.132s including waiting). Image size: 560910756 bytes.2026-08-09T01:01:57.6471664Z 2026-08-09 00:56:07 +0000 UTC Normal Container created2026-08-09T01:01:57.6473655Z 2026-08-09 00:56:07 +0000 UTC Normal Container started2026-08-09T01:01:57.6474217Z 2026-08-09T01:01:57.6474549Z ---2026-08-09T01:01:57.6475778Z TestOSPoolEP 2026-08-09T01:01:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T01:01:57.6501329Z TestOSPoolEP 2026-08-09T01:01:57Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv delete -f /tmp/TestOSPoolEP1568505776]2026-08-09T01:01:57.7501669Z TestOSPoolEP 2026-08-09T01:01:57Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-iw4ekv namespace2026-08-09T01:01:57.7583012Z TestOSPoolEP 2026-08-09T01:01:57Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-iw4ekv namespace2026-08-09T01:01:58.7047603Z TestOSPoolEP 2026-08-09T01:01:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv delete -f /tmp/TestOSPoolEP954899628]2026-08-09T01:01:58.8096729Z TestOSPoolEP 2026-08-09T01:01:58Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-iw4ekv namespace2026-08-09T01:01:58.8142130Z TestOSPoolEP 2026-08-09T01:01:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-iw4ekv delete -k /tmp/kustomize-template-2811991146]2026-08-09T01:01:58.9424421Z TestOSPoolEP 2026-08-09T01:01:58Z logger.go:67: service "test-cm" deleted from test-ospool-ep-iw4ekv namespace2026-08-09T01:01:58.9502534Z TestOSPoolEP 2026-08-09T01:01:58Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-iw4ekv namespace2026-08-09T01:01:58.9545894Z TestOSPoolEP 2026-08-09T01:01:58Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-iw4ekv namespace2026-08-09T01:01:58.9655977Z --- PASS: TestOSPoolEP (43.84s)2026-08-09T01:01:58.9687276Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (20.02s)2026-08-09T01:01:58.9690077Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.70s)2026-08-09T01:01:58.9730127Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.70s)2026-08-09T01:01:58.9750225Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (331.98s)2026-08-09T01:01:58.9760078Z PASS2026-08-09T01:01:58.9792859Z ok github.com/osg-htc/k8s-integration-tests/test 375.837s2026-08-09T01:01:59.0941998Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-09T01:01:59.0942927Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-09T01:01:59.1027551Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-09T01:01:59.1027930Z env:2026-08-09T01:01:59.1028156Z GOTOOLCHAIN: local2026-08-09T01:01:59.1028631Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-09T01:01:59.1029104Z ##[endgroup]2026-08-09T01:01:59.1301803Z 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-09T01:01:59.1303430Z ##[group]Run actions/upload-artifact@v42026-08-09T01:01:59.1303758Z with:2026-08-09T01:01:59.1304249Z name: TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe52026-08-09T01:01:59.1305099Z path: /tmp/k8s-tests2026-08-09T01:01:59.1305449Z retention-days: 52026-08-09T01:01:59.1305693Z if-no-files-found: warn2026-08-09T01:01:59.1305942Z compression-level: 62026-08-09T01:01:59.1306164Z overwrite: false2026-08-09T01:01:59.1306389Z include-hidden-files: false2026-08-09T01:01:59.1306628Z env:2026-08-09T01:01:59.1306820Z GOTOOLCHAIN: local2026-08-09T01:01:59.1307031Z ##[endgroup]2026-08-09T01:01:59.3766178Z (node:17502) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-09T01:01:59.3791682Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-09T01:01:59.3917605Z With the provided path, there will be 6 files uploaded2026-08-09T01:01:59.3927162Z Artifact name is valid!2026-08-09T01:01:59.3949900Z Root directory input is valid!2026-08-09T01:01:59.5548751Z Beginning upload of artifact content to blob storage2026-08-09T01:01:59.6004662Z (node:17502) [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-09T01:01:59.6740861Z Uploaded bytes 139852026-08-09T01:01:59.6939705Z Finished uploading artifact content to blob storage!2026-08-09T01:01:59.6943497Z SHA256 digest of uploaded artifact zip is dd54440f8556e7e4458de23527a9fde9466748c5ab4b08a267e29e0281ea01da2026-08-09T01:01:59.6947878Z Finalizing artifact upload2026-08-09T01:01:59.8583794Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5.zip successfully finalized. Artifact ID 90302835562026-08-09T01:01:59.8585781Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5 has been successfully uploaded! Final size is 13985 bytes. Artifact ID is 90302835562026-08-09T01:01:59.8591909Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/31287162726/artifacts/90302835562026-08-09T01:01:59.8790009Z Post job cleanup.2026-08-09T01:02:00.0145690Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-09T01:02:00.0190803Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-09T01:02:00.0230940Z /home/runner/go/pkg/mod2026-08-09T01:02:00.0251136Z /home/runner/.cache/go-build2026-08-09T01:02:00.0256174Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-09T01:02:00.0452847Z Post job cleanup.2026-08-09T01:02:00.1666900Z [command]/usr/bin/git version2026-08-09T01:02:00.1712157Z git version 2.54.02026-08-09T01:02:00.1753440Z Temporarily overriding HOME='/home/runner/work/_temp/fc6cecd0-890c-4879-8a5a-e4896879ab03' before making global git config changes2026-08-09T01:02:00.1754819Z Adding repository directory to the temporary git global config as a safe directory2026-08-09T01:02:00.1759494Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-09T01:02:00.1806431Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-09T01:02:00.1848127Z [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-09T01:02:00.2160209Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-09T01:02:00.2188452Z http.https://github.com/.extraheader2026-08-09T01:02:00.2200826Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-09T01:02:00.2243413Z [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-09T01:02:00.2576623Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-09T01:02:00.2625421Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-09T01:02:00.3077853Z Cleaning up orphan processes2026-08-09T01:02:00.3842222Z ##[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/