2026-08-06T01:28:16.1368446Z Current runner version: '2.336.0'2026-08-06T01:28:16.1404224Z ##[group]Runner Image Provisioner2026-08-06T01:28:16.1405639Z Hosted Compute Agent2026-08-06T01:28:16.1406591Z Version: 20260707.5632026-08-06T01:28:16.1407649Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-08-06T01:28:16.1408832Z Build Date: 2026-07-07T19:33:50Z2026-08-06T01:28:16.1409969Z Worker ID: {a96f20ca-a2ca-4e7b-8b1a-d14f483e611a}2026-08-06T01:28:16.1411218Z Azure Region: centralus2026-08-06T01:28:16.1412170Z ##[endgroup]2026-08-06T01:28:16.1414322Z ##[group]Operating System2026-08-06T01:28:16.1415442Z Ubuntu2026-08-06T01:28:16.1416335Z 22.04.52026-08-06T01:28:16.1417215Z LTS2026-08-06T01:28:16.1418072Z ##[endgroup]2026-08-06T01:28:16.1418919Z ##[group]Runner Image2026-08-06T01:28:16.1419965Z Image: ubuntu-22.042026-08-06T01:28:16.1420921Z Version: 20260720.234.22026-08-06T01:28:16.1423057Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-08-06T01:28:16.1425916Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-08-06T01:28:16.1427641Z ##[endgroup]2026-08-06T01:28:16.1429522Z ##[group]GITHUB_TOKEN Permissions2026-08-06T01:28:16.1432773Z Contents: read2026-08-06T01:28:16.1434006Z Metadata: read2026-08-06T01:28:16.1434848Z Packages: read2026-08-06T01:28:16.1436434Z ##[endgroup]2026-08-06T01:28:16.1439954Z Secret source: Actions2026-08-06T01:28:16.1441936Z Prepare workflow directory2026-08-06T01:28:16.1819553Z Prepare all required actions2026-08-06T01:28:16.1888152Z Getting action download info2026-08-06T01:28:16.4221619Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-06T01:28:16.7728384Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-06T01:28:17.1113051Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-06T01:28:17.4970954Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-06T01:28:17.7702913Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-06T01:28:17.7709164Z ##[group] Inputs2026-08-06T01:28:17.7710152Z testName: TestOSPoolEP2026-08-06T01:28:17.7711915Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-06T01:28:17.7714002Z setupScript: 2026-08-06T01:28:17.7714878Z setupEnv: {}2026-08-06T01:28:17.7715726Z ##[endgroup]2026-08-06T01:28:17.7717103Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-testing) / Run Tests2026-08-06T01:28:17.8591822Z ##[group]Run actions/checkout@v52026-08-06T01:28:17.8593841Z with:2026-08-06T01:28:17.8594939Z repository: mwestphall/k8s-integration-tests2026-08-06T01:28:17.8603858Z token: ***2026-08-06T01:28:17.8604735Z ssh-strict: true2026-08-06T01:28:17.8605647Z ssh-user: git2026-08-06T01:28:17.8606522Z persist-credentials: true2026-08-06T01:28:17.8607483Z clean: true2026-08-06T01:28:17.8608367Z sparse-checkout-cone-mode: true2026-08-06T01:28:17.8609405Z fetch-depth: 12026-08-06T01:28:17.8610249Z fetch-tags: false2026-08-06T01:28:17.8611117Z show-progress: true2026-08-06T01:28:17.8611989Z lfs: false2026-08-06T01:28:17.8612807Z submodules: false2026-08-06T01:28:17.8613807Z set-safe-directory: true2026-08-06T01:28:17.8614813Z allow-unsafe-pr-checkout: false2026-08-06T01:28:17.8616305Z ##[endgroup]2026-08-06T01:28:17.9703641Z Syncing repository: mwestphall/k8s-integration-tests2026-08-06T01:28:17.9707932Z ##[group]Getting Git version info2026-08-06T01:28:17.9710640Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-06T01:28:17.9714568Z [command]/usr/bin/git version2026-08-06T01:28:17.9716569Z git version 2.54.02026-08-06T01:28:17.9740237Z ##[endgroup]2026-08-06T01:28:17.9756371Z Temporarily overriding HOME='/home/runner/work/_temp/ba2954c1-57f5-453b-93c5-741da8965d8c' before making global git config changes2026-08-06T01:28:17.9760846Z Adding repository directory to the temporary git global config as a safe directory2026-08-06T01:28:17.9765276Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-06T01:28:17.9804593Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-06T01:28:17.9809444Z ##[group]Initializing the repository2026-08-06T01:28:17.9814708Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-06T01:28:17.9898329Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-06T01:28:17.9901666Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-06T01:28:17.9905245Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-06T01:28:17.9907838Z hint: call:2026-08-06T01:28:17.9909677Z hint:2026-08-06T01:28:17.9911414Z hint: git config --global init.defaultBranch <name>2026-08-06T01:28:17.9913769Z hint:2026-08-06T01:28:17.9915735Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-06T01:28:17.9918864Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-06T01:28:17.9921458Z hint:2026-08-06T01:28:17.9923040Z hint: git branch -m <name>2026-08-06T01:28:17.9924946Z hint:2026-08-06T01:28:17.9927344Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-06T01:28:17.9931548Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-06T01:28:17.9938243Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-06T01:28:17.9952874Z ##[endgroup]2026-08-06T01:28:17.9955862Z ##[group]Disabling automatic garbage collection2026-08-06T01:28:17.9959366Z [command]/usr/bin/git config --local gc.auto 02026-08-06T01:28:18.0007135Z ##[endgroup]2026-08-06T01:28:18.0009418Z ##[group]Setting up auth2026-08-06T01:28:18.0011663Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-06T01:28:18.0046473Z [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-06T01:28:18.0410395Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-06T01:28:18.0470648Z [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-06T01:28:18.0751842Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-06T01:28:18.0791491Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-06T01:28:18.1064487Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-06T01:28:18.1117040Z ##[endgroup]2026-08-06T01:28:18.1119357Z ##[group]Fetching the repository2026-08-06T01:28:18.1130880Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-06T01:28:18.4416400Z From https://github.com/mwestphall/k8s-integration-tests2026-08-06T01:28:18.4418112Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-06T01:28:18.4445417Z ##[endgroup]2026-08-06T01:28:18.4447514Z ##[group]Determining the checkout info2026-08-06T01:28:18.4449878Z ##[endgroup]2026-08-06T01:28:18.4454334Z [command]/usr/bin/git sparse-checkout disable2026-08-06T01:28:18.4505735Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-06T01:28:18.4544269Z ##[group]Checking out the ref2026-08-06T01:28:18.4547730Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-06T01:28:18.4645905Z Switched to a new branch 'main'2026-08-06T01:28:18.4648891Z branch 'main' set up to track 'origin/main'.2026-08-06T01:28:18.4656385Z ##[endgroup]2026-08-06T01:28:18.4700138Z [command]/usr/bin/git log -1 --format=%H2026-08-06T01:28:18.4730006Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-06T01:28:18.5085288Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-06T01:28:18.5087538Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-06T01:28:18.5089613Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-06T01:28:18.5205654Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-06T01:28:18.5207029Z env:2026-08-06T01:28:18.5208574Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-06T01:28:18.5210371Z SETUP_ENV_YAML: {}2026-08-06T01:28:18.5211239Z ##[endgroup]2026-08-06T01:28:19.0672576Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-06T01:28:19.0673499Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-06T01:28:19.0734492Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-06T01:28:19.0734889Z env:2026-08-06T01:28:19.0735373Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-06T01:28:19.0735908Z ##[endgroup]2026-08-06T01:28:19.0880286Z ##[group]Run true2026-08-06T01:28:19.0880599Z [36;1mtrue[0m2026-08-06T01:28:19.0938663Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-06T01:28:19.0939086Z ##[endgroup]2026-08-06T01:28:19.1106679Z ##[group]Run medyagh/setup-minikube@latest2026-08-06T01:28:19.1107046Z with:2026-08-06T01:28:19.1107288Z start: true2026-08-06T01:28:19.1107526Z cache: true2026-08-06T01:28:19.1107775Z minikube-version: latest2026-08-06T01:28:19.1108059Z wait: all2026-08-06T01:28:19.1108293Z ##[endgroup]2026-08-06T01:28:19.2427281Z (node:2169) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-06T01:28:19.2428564Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-06T01:28:20.2951090Z [command]/usr/bin/chmod +x /home/runner/work/_temp/372e40d3-ca7d-4ee9-89a8-f1e7a4d2ab582026-08-06T01:28:20.4541057Z [command]/home/runner/bin/minikube version --short2026-08-06T01:28:20.4951653Z v1.38.12026-08-06T01:28:20.6213637Z Cache hit for: kic-v1.38.1-x642026-08-06T01:28:20.6332951Z (node:2169) [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-06T01:28:20.6346771Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-06T01:28:21.7728464Z Received 121634816 of 544082657 (22.4%), 115.9 MBs/sec2026-08-06T01:28:21.7958881Z Received 104857600 of 224218863 (46.8%), 100.0 MBs/sec2026-08-06T01:28:22.8472900Z Received 268435456 of 544082657 (49.3%), 123.3 MBs/sec2026-08-06T01:28:22.8475205Z Received 192937984 of 224218863 (86.0%), 89.7 MBs/sec2026-08-06T01:28:23.0045229Z Received 224218863 of 224218863 (100.0%), 96.8 MBs/sec2026-08-06T01:28:23.0046223Z Cache Size: ~214 MB (224218863 B)2026-08-06T01:28:23.0466860Z [command]/usr/bin/tar -xf /home/runner/work/_temp/3c5b70b5-3769-4da3-9c3b-612647f4f173/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-06T01:28:23.6764065Z Cache restored successfully2026-08-06T01:28:23.8470244Z Received 427819008 of 544082657 (78.6%), 132.7 MBs/sec2026-08-06T01:28:24.6562377Z Received 544082657 of 544082657 (100.0%), 133.6 MBs/sec2026-08-06T01:28:24.6563527Z Cache Size: ~519 MB (544082657 B)2026-08-06T01:28:24.6684031Z [command]/usr/bin/tar -xf /home/runner/work/_temp/4eacda52-4795-40f5-8e29-7bd0a3484601/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-06T01:28:25.5512436Z Cache restored successfully2026-08-06T01:28:25.6687117Z [command]/home/runner/bin/minikube start --wait all2026-08-06T01:28:25.7099181Z * minikube v1.38.1 on Ubuntu 22.042026-08-06T01:28:26.1139447Z ! 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-06T01:28:26.1141365Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-06T01:28:26.1635970Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-06T01:28:26.1644299Z * Using Docker driver with root privileges2026-08-06T01:28:26.1655124Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-06T01:28:26.1659855Z * Pulling base image v0.0.50 ...2026-08-06T01:28:56.7527034Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-06T01:29:01.9518081Z * Verifying Kubernetes components...2026-08-06T01:29:01.9752671Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-06T01:29:02.6905638Z * Enabled addons: storage-provisioner, default-storageclass2026-08-06T01:29:40.0449765Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-06T01:29:40.0594547Z [command]/home/runner/bin/minikube version --short2026-08-06T01:29:40.1007073Z v1.38.12026-08-06T01:29:40.1321830Z ##[group]Run actions/setup-go@v62026-08-06T01:29:40.1322116Z with:2026-08-06T01:29:40.1322316Z go-version: 1.262026-08-06T01:29:40.1322550Z cache: true2026-08-06T01:29:40.1322771Z cache-dependency-path: go.sum2026-08-06T01:29:40.1323030Z check-latest: false2026-08-06T01:29:40.1325766Z token: ***2026-08-06T01:29:40.1325976Z ##[endgroup]2026-08-06T01:29:40.2694187Z Setup go version spec 1.262026-08-06T01:29:40.2864773Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-06T01:29:40.2867563Z Added go to the path2026-08-06T01:29:40.2870881Z Successfully set up Go version 1.262026-08-06T01:29:40.3459028Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-06T01:29:40.3500871Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-06T01:29:40.3564152Z /home/runner/go/pkg/mod2026-08-06T01:29:40.3578575Z /home/runner/.cache/go-build2026-08-06T01:29:40.5013019Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-06T01:29:41.6937234Z Received 83886080 of 251839808 (33.3%), 79.8 MBs/sec2026-08-06T01:29:42.6981077Z Received 146800640 of 251839808 (58.3%), 69.8 MBs/sec2026-08-06T01:29:43.2828592Z Received 251839808 of 251839808 (100.0%), 92.7 MBs/sec2026-08-06T01:29:43.2829902Z Cache Size: ~240 MB (251839808 B)2026-08-06T01:29:43.2864673Z [command]/usr/bin/tar -xf /home/runner/work/_temp/9ed54801-223b-486d-9397-834a83d9515c/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-06T01:29:46.3221470Z Cache restored successfully2026-08-06T01:29:46.3788652Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-06T01:29:46.3819051Z go version go1.26.5 linux/amd642026-08-06T01:29:46.3819373Z 2026-08-06T01:29:46.3819763Z ##[group]go env2026-08-06T01:29:46.3969850Z AR='ar'2026-08-06T01:29:46.3970237Z CC='gcc'2026-08-06T01:29:46.3970608Z CGO_CFLAGS='-O2 -g'2026-08-06T01:29:46.3971013Z CGO_CPPFLAGS=''2026-08-06T01:29:46.3971374Z CGO_CXXFLAGS='-O2 -g'2026-08-06T01:29:46.3971981Z CGO_ENABLED='1'2026-08-06T01:29:46.3972199Z CGO_FFLAGS='-O2 -g'2026-08-06T01:29:46.3972430Z CGO_LDFLAGS='-O2 -g'2026-08-06T01:29:46.3972653Z CXX='g++'2026-08-06T01:29:46.3972859Z GCCGO='gccgo'2026-08-06T01:29:46.3973314Z GO111MODULE=''2026-08-06T01:29:46.3973594Z GOAMD64='v1'2026-08-06T01:29:46.3973801Z GOARCH='amd64'2026-08-06T01:29:46.3974009Z GOAUTH='netrc'2026-08-06T01:29:46.3974214Z GOBIN=''2026-08-06T01:29:46.3974444Z GOCACHE='/home/runner/.cache/go-build'2026-08-06T01:29:46.3974741Z GOCACHEPROG=''2026-08-06T01:29:46.3974949Z GODEBUG=''2026-08-06T01:29:46.3975177Z GOENV='/home/runner/.config/go/env'2026-08-06T01:29:46.3975444Z GOEXE=''2026-08-06T01:29:46.3975642Z GOEXPERIMENT=''2026-08-06T01:29:46.3975878Z GOFIPS140='off'2026-08-06T01:29:46.3976080Z GOFLAGS=''2026-08-06T01:29:46.3976774Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build3648361415=/tmp/go-build -gno-record-gcc-switches'2026-08-06T01:29:46.3977482Z GOHOSTARCH='amd64'2026-08-06T01:29:46.3977713Z GOHOSTOS='linux'2026-08-06T01:29:46.3977937Z GOINSECURE=''2026-08-06T01:29:46.3978319Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-06T01:29:46.3978759Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-06T01:29:46.3979035Z GONOPROXY=''2026-08-06T01:29:46.3979244Z GONOSUMDB=''2026-08-06T01:29:46.3979437Z GOOS='linux'2026-08-06T01:29:46.3979647Z GOPATH='/home/runner/go'2026-08-06T01:29:46.3979888Z GOPRIVATE=''2026-08-06T01:29:46.3980176Z GOPROXY='https://proxy.golang.org,direct'2026-08-06T01:29:46.3980523Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-06T01:29:46.3980947Z GOSUMDB='sum.golang.org'2026-08-06T01:29:46.3981253Z GOTELEMETRY='local'2026-08-06T01:29:46.3981534Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-06T01:29:46.3981846Z GOTMPDIR=''2026-08-06T01:29:46.3982303Z GOTOOLCHAIN='local'2026-08-06T01:29:46.3982645Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-06T01:29:46.3983024Z GOVCS=''2026-08-06T01:29:46.3983423Z GOVERSION='go1.26.5'2026-08-06T01:29:46.3983659Z GOWORK=''2026-08-06T01:29:46.3983879Z PKG_CONFIG='pkg-config'2026-08-06T01:29:46.3984031Z 2026-08-06T01:29:46.3984379Z ##[endgroup]2026-08-06T01:29:46.4219070Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-06T01:29:46.4219597Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-06T01:29:46.4279940Z shell: /usr/bin/bash -e {0}2026-08-06T01:29:46.4280219Z env:2026-08-06T01:29:46.4280431Z GOTOOLCHAIN: local2026-08-06T01:29:46.4280684Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-08-06T01:29:46.4280972Z OSPOOL_EP_CMTag: 25.x-el92026-08-06T01:29:46.4281233Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-06T01:29:46.4281508Z ##[endgroup]2026-08-06T01:29:49.7000258Z === RUN TestOSPoolEP2026-08-06T01:29:49.7001240Z === PAUSE TestOSPoolEP2026-08-06T01:29:49.7001543Z === CONT TestOSPoolEP2026-08-06T01:29:49.7006997Z TestOSPoolEP 2026-08-06T01:29:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:29:49.7115177Z TestOSPoolEP 2026-08-06T01:29:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf apply -f /tmp/TestOSPoolEP3120860576]2026-08-06T01:29:50.1243427Z TestOSPoolEP 2026-08-06T01:29:50Z logger.go:67: pod/idtoken-generator created2026-08-06T01:29:50.1323421Z TestOSPoolEP 2026-08-06T01:29:50Z logger.go:67: secret/pool-passwd created2026-08-06T01:29:50.1366122Z TestOSPoolEP 2026-08-06T01:29:50Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-06T01:29:50.1367607Z TestOSPoolEP 2026-08-06T01:29:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:29:50.1400874Z TestOSPoolEP 2026-08-06T01:29:50Z 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-06T01:30:00.1425949Z TestOSPoolEP 2026-08-06T01:30:00Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-06T01:30:00.1429080Z TestOSPoolEP 2026-08-06T01:30:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:30:00.1462055Z TestOSPoolEP 2026-08-06T01:30:00Z 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-06T01:30:10.1463502Z TestOSPoolEP 2026-08-06T01:30:10Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-06T01:30:10.1465597Z TestOSPoolEP 2026-08-06T01:30:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:30:10.1491488Z TestOSPoolEP 2026-08-06T01:30:10Z logger.go:67: Pod is now available2026-08-06T01:30:10.1493297Z TestOSPoolEP 2026-08-06T01:30:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-06T01:30:10.5892815Z TestOSPoolEP 2026-08-06T01:30:10Z logger.go:67: ***2026-08-06T01:30:10.5955827Z TestOSPoolEP 2026-08-06T01:30:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf apply -f /tmp/TestOSPoolEP2677064145]2026-08-06T01:30:10.7779018Z TestOSPoolEP 2026-08-06T01:30:10Z logger.go:67: secret/pool-token created2026-08-06T01:30:10.7816355Z TestOSPoolEP 2026-08-06T01:30:10Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-06T01:30:10.7817719Z TestOSPoolEP 2026-08-06T01:30:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:30:10.7837537Z TestOSPoolEP 2026-08-06T01:30:10Z logger.go:67: Secret is now available2026-08-06T01:30:10.7857268Z TestOSPoolEP 2026-08-06T01:30:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf apply -k /tmp/kustomize-template-511286943]2026-08-06T01:30:11.0556191Z TestOSPoolEP 2026-08-06T01:30:11Z logger.go:67: service/test-cm created2026-08-06T01:30:11.0683606Z TestOSPoolEP 2026-08-06T01:30:11Z 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-06T01:30:11.0686083Z TestOSPoolEP 2026-08-06T01:30:11Z logger.go:67: deployment.apps/ospool-ep created2026-08-06T01:30:11.0763973Z TestOSPoolEP 2026-08-06T01:30:11Z logger.go:67: deployment.apps/test-cm created2026-08-06T01:30:11.0827640Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-06T01:30:11.0858110Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-06T01:30:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:30:11.0914678Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-06T01:30:11Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-06T01:30:11.0962789Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-06T01:30:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:30:11.0965615Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-06T01:30:11Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-06T01:30:11.0971344Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-06T01:30:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:30:11.1025040Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-06T01:30:11Z 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-06T01:30:11.1032073Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-06T01:30:11Z 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-06T01:30:21.1033893Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-06T01:30:21Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-06T01:30:21.1037489Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-06T01:30:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:30:21.1039214Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-06T01:30:21Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-06T01:30:21.1040537Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-06T01:30:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:30:21.1072391Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-06T01:30:21Z logger.go:67: Deployment is now available2026-08-06T01:30:21.1085043Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-06T01:30:21Z 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-06T01:30:31.1086106Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-06T01:30:31Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-06T01:30:31.1087222Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-06T01:30:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:30:31.1112452Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-06T01:30:31Z logger.go:67: Deployment is now available2026-08-06T01:30:31.1114288Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-06T01:30:31.1114982Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-06T01:30:31.1115608Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-06T01:30:31.1116302Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-06T01:30:31.1116881Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-06T01:30:31.1117435Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-06T01:30:31.1117848Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-06T01:30:31.1118930Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-06T01:30:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:30:31.1120248Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-06T01:30:31.1122086Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:30:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:30:31.1142659Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-06T01:30:31.1144597Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-06T01:30:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:30:31.1155245Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-06T01:30:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:30:31.1157348Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:30:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:30:31.1160992Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-06T01:30:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:30:31.1183720Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-06T01:30:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)']2026-08-06T01:30:31.1188692Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:30:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-06T01:30:31.1216246Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-06T01:30:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_SINGULARITY]2026-08-06T01:30:31.3188257Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-tskrm failed. Retrying in 10s.2026-08-06T01:30:31.3557648Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-06T01:30:31.3561437Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tskrm failed. Retrying in 30s.2026-08-06T01:30:31.3565567Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-06T01:30:31.3567122Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)']' in pod test-cm-5bb545475c-tskrm failed. Retrying in 10s.2026-08-06T01:30:41.3201445Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-06T01:30:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_SINGULARITY]2026-08-06T01:30:41.3576231Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-06T01:30:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)']2026-08-06T01:30:41.5171465Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-06T01:30:41.5173759Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-tskrm failed. Retrying in 10s.2026-08-06T01:30:41.5568893Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-06T01:30:41.5569939Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)']' in pod test-cm-5bb545475c-tskrm failed. Retrying in 10s.2026-08-06T01:30:51.5190080Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-06T01:30:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_SINGULARITY]2026-08-06T01:30:51.5577627Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-06T01:30:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)']2026-08-06T01:30:51.6916083Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-06T01:30:51Z logger.go:67: true2026-08-06T01:30:51.7524709Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-06T01:30:51Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-06T01:30:51.7526556Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-06T01:30:51Z logger.go:67: 2026-08-06T01:30:51.7528048Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-06T01:30:51Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-65c844ddbb-56n7r LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-08-06T01:30:51.7529287Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-06T01:30:51Z logger.go:67: 2026-08-06T01:30:51.7530143Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-06T01:30:51Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-06T01:30:51.7530945Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-06T01:30:51Z logger.go:67: 2026-08-06T01:30:51.7531716Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-06T01:30:51Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-06T01:30:51.7532459Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-06T01:30:51Z logger.go:67: 2026-08-06T01:30:51.7533442Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-06T01:30:51Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-06T01:31:01.3564098Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:31:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-06T01:31:01.5126728Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:31:01Z logger.go:67: undefined2026-08-06T01:31:01.5187764Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-06T01:31:01.5189033Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tskrm failed. Retrying in 30s.2026-08-06T01:31:31.5200128Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:31:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-06T01:31:31.6679028Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:31:31Z logger.go:67: undefined2026-08-06T01:31:31.6752541Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tskrm failed. Retrying in 30s.2026-08-06T01:32:01.6760600Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:32:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-06T01:32:01.8272253Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:32:01Z logger.go:67: undefined2026-08-06T01:32:01.8337761Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tskrm failed. Retrying in 30s.2026-08-06T01:32:31.8340410Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:32:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-06T01:32:31.9817947Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:32:31Z logger.go:67: undefined2026-08-06T01:32:31.9881095Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tskrm failed. Retrying in 30s.2026-08-06T01:33:01.9898417Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:33:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-06T01:33:02.1395811Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:33:02Z logger.go:67: undefined2026-08-06T01:33:02.1460483Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tskrm failed. Retrying in 30s.2026-08-06T01:33:32.1485798Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:33:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-06T01:33:32.3035953Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:33:32Z logger.go:67: undefined2026-08-06T01:33:32.3097209Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tskrm failed. Retrying in 30s.2026-08-06T01:34:02.3101078Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:34:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-06T01:34:02.4611816Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:34:02Z logger.go:67: undefined2026-08-06T01:34:02.4671951Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tskrm failed. Retrying in 30s.2026-08-06T01:34:32.4692689Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:34:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-06T01:34:32.6169278Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:34:32Z logger.go:67: undefined2026-08-06T01:34:32.6229245Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tskrm failed. Retrying in 30s.2026-08-06T01:35:02.6253577Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:35:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-06T01:35:02.7725828Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:35:02Z logger.go:67: undefined2026-08-06T01:35:02.7789294Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tskrm failed. Retrying in 30s.2026-08-06T01:35:32.7817868Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:35:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-06T01:35:32.9313724Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:35:32Z logger.go:67: undefined2026-08-06T01:35:32.9379294Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tskrm failed. Retrying in 30s.2026-08-06T01:36:02.9385117Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:36:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf exec test-cm-5bb545475c-tskrm -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-56n7r",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-06T01:36:03.1125977Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-06T01:36:03Z logger.go:67: true2026-08-06T01:36:03.1194234Z TestOSPoolEP 2026-08-06T01:36:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:36:03.1285553Z TestOSPoolEP 2026-08-06T01:36:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:36:03.3720250Z TestOSPoolEP 2026-08-06T01:36:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:36:03.5203041Z TestOSPoolEP 2026-08-06T01:36:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:36:03.6376994Z TestOSPoolEP 2026-08-06T01:36:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:36:03.6409514Z === NAME TestOSPoolEP2026-08-06T01:36:03.6412055Z ospool_ep_test.go:101: ---2026-08-06T01:36:03.6413075Z Events for pod idtoken-generator:2026-08-06T01:36:03.6414632Z 2026-08-06 01:29:50 +0000 UTC Normal Successfully assigned test-ospool-ep-kxaupf/idtoken-generator to minikube2026-08-06T01:36:03.6416006Z 2026-08-06 01:29:53 +0000 UTC Normal Pulling image "htcondor/base"2026-08-06T01:36:03.6417694Z 2026-08-06 01:30:02 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.894s (8.894s including waiting). Image size: 560910730 bytes.2026-08-06T01:36:03.6419197Z 2026-08-06 01:30:02 +0000 UTC Normal Container created2026-08-06T01:36:03.6420533Z 2026-08-06 01:30:02 +0000 UTC Normal Container started2026-08-06T01:36:03.6421172Z 2026-08-06T01:36:03.6421573Z ---2026-08-06T01:36:03.6422911Z TestOSPoolEP 2026-08-06T01:36:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:36:03.6453055Z ospool_ep_test.go:101: ---2026-08-06T01:36:03.6454273Z Events for pod ospool-ep-65c844ddbb-56n7r:2026-08-06T01:36:03.6455783Z 2026-08-06 01:30:11 +0000 UTC Normal Successfully assigned test-ospool-ep-kxaupf/ospool-ep-65c844ddbb-56n7r to minikube2026-08-06T01:36:03.6457446Z 2026-08-06 01:30:11 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-06T01:36:03.6459515Z 2026-08-06 01:30:12 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.344s (1.344s including waiting). Image size: 5590942 bytes.2026-08-06T01:36:03.6460904Z 2026-08-06 01:30:12 +0000 UTC Normal Container created2026-08-06T01:36:03.6461696Z 2026-08-06 01:30:13 +0000 UTC Normal Container started2026-08-06T01:36:03.6462877Z 2026-08-06 01:30:13 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-08-06T01:36:03.6465468Z 2026-08-06 01:30:27 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 13.609s (13.609s including waiting). Image size: 1259139928 bytes.2026-08-06T01:36:03.6466785Z 2026-08-06 01:30:27 +0000 UTC Normal Container created2026-08-06T01:36:03.6467262Z 2026-08-06 01:30:27 +0000 UTC Normal Container started2026-08-06T01:36:03.6467585Z 2026-08-06T01:36:03.6467808Z ---2026-08-06T01:36:03.6468380Z TestOSPoolEP 2026-08-06T01:36:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:36:03.6490534Z ospool_ep_test.go:101: ---2026-08-06T01:36:03.6491827Z Events for pod test-cm-5bb545475c-tskrm:2026-08-06T01:36:03.6493655Z 2026-08-06 01:30:11 +0000 UTC Normal Successfully assigned test-ospool-ep-kxaupf/test-cm-5bb545475c-tskrm to minikube2026-08-06T01:36:03.6495442Z 2026-08-06 01:30:11 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-08-06T01:36:03.6499501Z 2026-08-06 01:30:13 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 624ms (1.947s including waiting). Image size: 560910756 bytes.2026-08-06T01:36:03.6500783Z 2026-08-06 01:30:13 +0000 UTC Normal Container created2026-08-06T01:36:03.6504748Z 2026-08-06 01:30:13 +0000 UTC Normal Container started2026-08-06T01:36:03.6506085Z 2026-08-06T01:36:03.6506448Z ---2026-08-06T01:36:03.6507383Z TestOSPoolEP 2026-08-06T01:36:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-06T01:36:03.6536141Z TestOSPoolEP 2026-08-06T01:36:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf delete -f /tmp/TestOSPoolEP3718572692]2026-08-06T01:36:03.7610269Z TestOSPoolEP 2026-08-06T01:36:03Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-kxaupf namespace2026-08-06T01:36:03.7647068Z TestOSPoolEP 2026-08-06T01:36:03Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-kxaupf namespace2026-08-06T01:36:04.8199516Z TestOSPoolEP 2026-08-06T01:36:04Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf delete -f /tmp/TestOSPoolEP807135123]2026-08-06T01:36:04.9141602Z TestOSPoolEP 2026-08-06T01:36:04Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-kxaupf namespace2026-08-06T01:36:04.9191027Z TestOSPoolEP 2026-08-06T01:36:04Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-kxaupf delete -k /tmp/kustomize-template-511286943]2026-08-06T01:36:05.0649628Z TestOSPoolEP 2026-08-06T01:36:05Z logger.go:67: service "test-cm" deleted from test-ospool-ep-kxaupf namespace2026-08-06T01:36:05.0736873Z TestOSPoolEP 2026-08-06T01:36:05Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-kxaupf namespace2026-08-06T01:36:05.0788053Z TestOSPoolEP 2026-08-06T01:36:05Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-kxaupf namespace2026-08-06T01:36:05.0912371Z --- PASS: TestOSPoolEP (43.38s)2026-08-06T01:36:05.0933755Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (20.03s)2026-08-06T01:36:05.0941575Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.59s)2026-08-06T01:36:05.0943476Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.65s)2026-08-06T01:36:05.0944545Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (332.01s)2026-08-06T01:36:05.0945717Z PASS2026-08-06T01:36:05.0946748Z ok github.com/osg-htc/k8s-integration-tests/test 375.408s2026-08-06T01:36:05.2242556Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-06T01:36:05.2243627Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-06T01:36:05.2334445Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-06T01:36:05.2334994Z env:2026-08-06T01:36:05.2335300Z GOTOOLCHAIN: local2026-08-06T01:36:05.2336024Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-06T01:36:05.2336771Z ##[endgroup]2026-08-06T01:36:05.2631353Z 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-06T01:36:05.2633764Z ##[group]Run actions/upload-artifact@v42026-08-06T01:36:05.2634200Z with:2026-08-06T01:36:05.2634773Z name: TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe52026-08-06T01:36:05.2635716Z path: /tmp/k8s-tests2026-08-06T01:36:05.2636067Z retention-days: 52026-08-06T01:36:05.2636600Z if-no-files-found: warn2026-08-06T01:36:05.2637203Z compression-level: 62026-08-06T01:36:05.2637559Z overwrite: false2026-08-06T01:36:05.2638234Z include-hidden-files: false2026-08-06T01:36:05.2638564Z env:2026-08-06T01:36:05.2638822Z GOTOOLCHAIN: local2026-08-06T01:36:05.2639170Z ##[endgroup]2026-08-06T01:36:05.5328682Z (node:17611) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-06T01:36:05.5331272Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-06T01:36:05.5546910Z With the provided path, there will be 6 files uploaded2026-08-06T01:36:05.5548155Z Artifact name is valid!2026-08-06T01:36:05.5549416Z Root directory input is valid!2026-08-06T01:36:05.7736513Z Beginning upload of artifact content to blob storage2026-08-06T01:36:05.8115790Z (node:17611) [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-06T01:36:05.9815009Z Uploaded bytes 139872026-08-06T01:36:06.0212826Z Finished uploading artifact content to blob storage!2026-08-06T01:36:06.0214312Z SHA256 digest of uploaded artifact zip is 5dae429f4ff9f02b7e440376d410a3bfc151c739f5ba87c0012ef4938586711b2026-08-06T01:36:06.0215623Z Finalizing artifact upload2026-08-06T01:36:06.1862034Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5.zip successfully finalized. Artifact ID 89528539772026-08-06T01:36:06.1864206Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5 has been successfully uploaded! Final size is 13987 bytes. Artifact ID is 89528539772026-08-06T01:36:06.1871964Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/31062817703/artifacts/89528539772026-08-06T01:36:06.2089599Z Post job cleanup.2026-08-06T01:36:06.3395381Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-06T01:36:06.3443794Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-06T01:36:06.3483603Z /home/runner/go/pkg/mod2026-08-06T01:36:06.3512207Z /home/runner/.cache/go-build2026-08-06T01:36:06.3520768Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-06T01:36:06.3717811Z Post job cleanup.2026-08-06T01:36:06.4651328Z [command]/usr/bin/git version2026-08-06T01:36:06.4696284Z git version 2.54.02026-08-06T01:36:06.4737631Z Temporarily overriding HOME='/home/runner/work/_temp/6322c800-500f-41aa-ae4f-3a2195eae000' before making global git config changes2026-08-06T01:36:06.4738988Z Adding repository directory to the temporary git global config as a safe directory2026-08-06T01:36:06.4745120Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-06T01:36:06.4788700Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-06T01:36:06.4827794Z [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-06T01:36:06.5228441Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-06T01:36:06.5282375Z http.https://github.com/.extraheader2026-08-06T01:36:06.5338400Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-06T01:36:06.5346883Z [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-06T01:36:06.5904512Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-06T01:36:06.5985714Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-06T01:36:06.6561174Z Cleaning up orphan processes2026-08-06T01:36:06.7307020Z ##[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/