2026-08-11T00:55:35.3343898Z Current runner version: '2.336.0'2026-08-11T00:55:35.3377808Z ##[group]Runner Image Provisioner2026-08-11T00:55:35.3379239Z Hosted Compute Agent2026-08-11T00:55:35.3380568Z Version: 20260707.5632026-08-11T00:55:35.3381596Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-08-11T00:55:35.3382851Z Build Date: 2026-07-07T19:33:50Z2026-08-11T00:55:35.3384006Z Worker ID: {1e06f820-29a5-48e6-9a88-d1336c610cb5}2026-08-11T00:55:35.3385285Z Azure Region: eastus2026-08-11T00:55:35.3386218Z ##[endgroup]2026-08-11T00:55:35.3388572Z ##[group]Operating System2026-08-11T00:55:35.3390007Z Ubuntu2026-08-11T00:55:35.3390914Z 22.04.52026-08-11T00:55:35.3391704Z LTS2026-08-11T00:55:35.3392686Z ##[endgroup]2026-08-11T00:55:35.3393645Z ##[group]Runner Image2026-08-11T00:55:35.3394792Z Image: ubuntu-22.042026-08-11T00:55:35.3395759Z Version: 20260720.234.22026-08-11T00:55:35.3397953Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-08-11T00:55:35.3400921Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-08-11T00:55:35.3403245Z ##[endgroup]2026-08-11T00:55:35.3405188Z ##[group]GITHUB_TOKEN Permissions2026-08-11T00:55:35.3408115Z Contents: read2026-08-11T00:55:35.3409065Z Metadata: read2026-08-11T00:55:35.3410297Z Packages: read2026-08-11T00:55:35.3411181Z ##[endgroup]2026-08-11T00:55:35.3414132Z Secret source: Actions2026-08-11T00:55:35.3416142Z Prepare workflow directory2026-08-11T00:55:35.3880390Z Prepare all required actions2026-08-11T00:55:35.3949795Z Getting action download info2026-08-11T00:55:35.5865860Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-11T00:55:35.8356283Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-11T00:55:35.9522514Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-11T00:55:36.1158969Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-11T00:55:36.4280545Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-11T00:55:36.4286276Z ##[group] Inputs2026-08-11T00:55:36.4286880Z testName: TestOSPoolEP2026-08-11T00:55:36.4287986Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-11T00:55:36.4289173Z setupScript: 2026-08-11T00:55:36.4289923Z setupEnv: {}2026-08-11T00:55:36.4290427Z ##[endgroup]2026-08-11T00:55:36.4291255Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-testing) / Run Tests2026-08-11T00:55:36.5063848Z ##[group]Run actions/checkout@v52026-08-11T00:55:36.5064836Z with:2026-08-11T00:55:36.5065380Z repository: mwestphall/k8s-integration-tests2026-08-11T00:55:36.5070290Z token: ***2026-08-11T00:55:36.5070785Z ssh-strict: true2026-08-11T00:55:36.5071316Z ssh-user: git2026-08-11T00:55:36.5071826Z persist-credentials: true2026-08-11T00:55:36.5072372Z clean: true2026-08-11T00:55:36.5072862Z sparse-checkout-cone-mode: true2026-08-11T00:55:36.5073448Z fetch-depth: 12026-08-11T00:55:36.5073924Z fetch-tags: false2026-08-11T00:55:36.5074419Z show-progress: true2026-08-11T00:55:36.5074917Z lfs: false2026-08-11T00:55:36.5075365Z submodules: false2026-08-11T00:55:36.5075858Z set-safe-directory: true2026-08-11T00:55:36.5076424Z allow-unsafe-pr-checkout: false2026-08-11T00:55:36.5077303Z ##[endgroup]2026-08-11T00:55:36.6103751Z Syncing repository: mwestphall/k8s-integration-tests2026-08-11T00:55:36.6106728Z ##[group]Getting Git version info2026-08-11T00:55:36.6108597Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-11T00:55:36.6111182Z [command]/usr/bin/git version2026-08-11T00:55:36.6168905Z git version 2.54.02026-08-11T00:55:36.6200283Z ##[endgroup]2026-08-11T00:55:36.6207668Z Temporarily overriding HOME='/home/runner/work/_temp/ab5365a2-e056-4515-b0ef-c2ad2bab4670' before making global git config changes2026-08-11T00:55:36.6210877Z Adding repository directory to the temporary git global config as a safe directory2026-08-11T00:55:36.6214197Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-11T00:55:36.6254231Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-11T00:55:36.6258413Z ##[group]Initializing the repository2026-08-11T00:55:36.6263818Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-11T00:55:36.6402511Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-11T00:55:36.6404838Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-11T00:55:36.6406948Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-11T00:55:36.6408573Z hint: call:2026-08-11T00:55:36.6409509Z hint:2026-08-11T00:55:36.6410494Z hint: git config --global init.defaultBranch <name>2026-08-11T00:55:36.6411723Z hint:2026-08-11T00:55:36.6412869Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-11T00:55:36.6414845Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-11T00:55:36.6416373Z hint:2026-08-11T00:55:36.6417119Z hint: git branch -m <name>2026-08-11T00:55:36.6417983Z hint:2026-08-11T00:55:36.6419161Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-11T00:55:36.6421837Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-11T00:55:36.6425612Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-11T00:55:36.6448885Z ##[endgroup]2026-08-11T00:55:36.6450512Z ##[group]Disabling automatic garbage collection2026-08-11T00:55:36.6452999Z [command]/usr/bin/git config --local gc.auto 02026-08-11T00:55:36.6486890Z ##[endgroup]2026-08-11T00:55:36.6488157Z ##[group]Setting up auth2026-08-11T00:55:36.6494939Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-11T00:55:36.6531720Z [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-11T00:55:36.6929446Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-11T00:55:36.6979997Z [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-11T00:55:36.7233334Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-11T00:55:36.7271583Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-11T00:55:36.7517550Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-11T00:55:36.7557917Z ##[endgroup]2026-08-11T00:55:36.7558868Z ##[group]Fetching the repository2026-08-11T00:55:36.7568449Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-11T00:55:36.9846584Z From https://github.com/mwestphall/k8s-integration-tests2026-08-11T00:55:36.9848037Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-11T00:55:36.9874533Z ##[endgroup]2026-08-11T00:55:36.9875571Z ##[group]Determining the checkout info2026-08-11T00:55:36.9877433Z ##[endgroup]2026-08-11T00:55:36.9883375Z [command]/usr/bin/git sparse-checkout disable2026-08-11T00:55:36.9932474Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-11T00:55:37.0004465Z ##[group]Checking out the ref2026-08-11T00:55:37.0006340Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-11T00:55:37.0072121Z Switched to a new branch 'main'2026-08-11T00:55:37.0075282Z branch 'main' set up to track 'origin/main'.2026-08-11T00:55:37.0081961Z ##[endgroup]2026-08-11T00:55:37.0123665Z [command]/usr/bin/git log -1 --format=%H2026-08-11T00:55:37.0152342Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-11T00:55:37.0421667Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-11T00:55:37.0424595Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-11T00:55:37.0427332Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-11T00:55:37.0548904Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-11T00:55:37.0550792Z env:2026-08-11T00:55:37.0552790Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-11T00:55:37.0555234Z SETUP_ENV_YAML: {}2026-08-11T00:55:37.0556247Z ##[endgroup]2026-08-11T00:55:37.6357098Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-11T00:55:37.6359722Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-11T00:55:37.6420656Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-11T00:55:37.6421984Z env:2026-08-11T00:55:37.6423736Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-11T00:55:37.6425836Z ##[endgroup]2026-08-11T00:55:37.6612335Z ##[group]Run true2026-08-11T00:55:37.6613167Z [36;1mtrue[0m2026-08-11T00:55:37.6668287Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-11T00:55:37.6669944Z ##[endgroup]2026-08-11T00:55:37.6945555Z ##[group]Run medyagh/setup-minikube@latest2026-08-11T00:55:37.6946673Z with:2026-08-11T00:55:37.6947365Z start: true2026-08-11T00:55:37.6948095Z cache: true2026-08-11T00:55:37.6948860Z minikube-version: latest2026-08-11T00:55:37.6949898Z wait: all2026-08-11T00:55:37.6950609Z ##[endgroup]2026-08-11T00:55:37.8262016Z (node:2152) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-11T00:55:37.8266773Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-11T00:55:38.7920790Z [command]/usr/bin/chmod +x /home/runner/work/_temp/581ca965-63cb-4f1a-bcf2-892ee8aaae132026-08-11T00:55:38.9729109Z [command]/home/runner/bin/minikube version --short2026-08-11T00:55:39.0253148Z v1.38.12026-08-11T00:55:39.1097713Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-11T00:55:39.1256698Z Cache hit for: kic-v1.38.1-x642026-08-11T00:55:39.1260187Z (node:2152) [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-11T00:55:40.1760578Z Received 100663296 of 224218863 (44.9%), 94.8 MBs/sec2026-08-11T00:55:40.1875980Z Received 109051904 of 544082657 (20.0%), 103.8 MBs/sec2026-08-11T00:55:41.1846717Z Received 224218863 of 224218863 (100.0%), 105.4 MBs/sec2026-08-11T00:55:41.1847914Z Cache Size: ~214 MB (224218863 B)2026-08-11T00:55:41.2110853Z Received 226492416 of 544082657 (41.6%), 106.7 MBs/sec2026-08-11T00:55:41.2733712Z [command]/usr/bin/tar -xf /home/runner/work/_temp/aae8c4f5-70df-40e4-9e65-c21a2749858b/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-11T00:55:42.1963703Z Cache restored successfully2026-08-11T00:55:42.2130612Z Received 402653184 of 544082657 (74.0%), 126.9 MBs/sec2026-08-11T00:55:42.8896863Z Received 544082657 of 544082657 (100.0%), 140.1 MBs/sec2026-08-11T00:55:42.8903683Z Cache Size: ~519 MB (544082657 B)2026-08-11T00:55:42.9061825Z [command]/usr/bin/tar -xf /home/runner/work/_temp/4dd3a5b3-d8ce-48c5-ab74-bc66b4a2b235/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-11T00:55:43.8036639Z Cache restored successfully2026-08-11T00:55:43.9201589Z [command]/home/runner/bin/minikube start --wait all2026-08-11T00:55:43.9575280Z * minikube v1.38.1 on Ubuntu 22.042026-08-11T00:55:44.1098075Z ! 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-11T00:55:44.4320765Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-11T00:55:44.4843415Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-11T00:55:44.4847875Z * Using Docker driver with root privileges2026-08-11T00:55:44.4859057Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-11T00:55:44.4867191Z * Pulling base image v0.0.50 ...2026-08-11T00:56:13.0082433Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-11T00:56:17.6820741Z * Verifying Kubernetes components...2026-08-11T00:56:17.7091190Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-11T00:56:18.3423679Z * Enabled addons: storage-provisioner, default-storageclass2026-08-11T00:57:04.1864339Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-11T00:57:04.1989120Z [command]/home/runner/bin/minikube version --short2026-08-11T00:57:04.2404822Z v1.38.12026-08-11T00:57:04.2714062Z ##[group]Run actions/setup-go@v62026-08-11T00:57:04.2714343Z with:2026-08-11T00:57:04.2714529Z go-version: 1.262026-08-11T00:57:04.2714737Z cache: true2026-08-11T00:57:04.2714949Z cache-dependency-path: go.sum2026-08-11T00:57:04.2715215Z check-latest: false2026-08-11T00:57:04.2717484Z token: ***2026-08-11T00:57:04.2717681Z ##[endgroup]2026-08-11T00:57:04.4055576Z Setup go version spec 1.262026-08-11T00:57:04.4554919Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-11T00:57:04.4558020Z Added go to the path2026-08-11T00:57:04.4562527Z Successfully set up Go version 1.262026-08-11T00:57:05.1157226Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-11T00:57:05.1195484Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-11T00:57:05.1228738Z /home/runner/go/pkg/mod2026-08-11T00:57:05.1258330Z /home/runner/.cache/go-build2026-08-11T00:57:05.1915991Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-11T00:57:06.2584208Z Received 0 of 251839808 (0.0%), 0.0 MBs/sec2026-08-11T00:57:07.2596729Z Received 0 of 251839808 (0.0%), 0.0 MBs/sec2026-08-11T00:57:08.2603913Z Received 0 of 251839808 (0.0%), 0.0 MBs/sec2026-08-11T00:57:09.2616195Z Received 0 of 251839808 (0.0%), 0.0 MBs/sec2026-08-11T00:57:10.2622540Z Received 0 of 251839808 (0.0%), 0.0 MBs/sec2026-08-11T00:57:11.2637285Z Received 209715200 of 251839808 (83.3%), 33.3 MBs/sec2026-08-11T00:57:11.5015998Z Received 251839808 of 251839808 (100.0%), 38.5 MBs/sec2026-08-11T00:57:11.5017563Z Cache Size: ~240 MB (251839808 B)2026-08-11T00:57:11.5084742Z [command]/usr/bin/tar -xf /home/runner/work/_temp/9e94e2c0-d732-4333-91f5-cd50838015be/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-11T00:57:14.6366275Z Cache restored successfully2026-08-11T00:57:14.7025267Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-11T00:57:14.7048640Z go version go1.26.5 linux/amd642026-08-11T00:57:14.7048860Z 2026-08-11T00:57:14.7049148Z ##[group]go env2026-08-11T00:57:14.7560153Z AR='ar'2026-08-11T00:57:14.7560530Z CC='gcc'2026-08-11T00:57:14.7560900Z CGO_CFLAGS='-O2 -g'2026-08-11T00:57:14.7561319Z CGO_CPPFLAGS=''2026-08-11T00:57:14.7561632Z CGO_CXXFLAGS='-O2 -g'2026-08-11T00:57:14.7561897Z CGO_ENABLED='1'2026-08-11T00:57:14.7562137Z CGO_FFLAGS='-O2 -g'2026-08-11T00:57:14.7562384Z CGO_LDFLAGS='-O2 -g'2026-08-11T00:57:14.7562618Z CXX='g++'2026-08-11T00:57:14.7562829Z GCCGO='gccgo'2026-08-11T00:57:14.7563061Z GO111MODULE=''2026-08-11T00:57:14.7563366Z GOAMD64='v1'2026-08-11T00:57:14.7563681Z GOARCH='amd64'2026-08-11T00:57:14.7563901Z GOAUTH='netrc'2026-08-11T00:57:14.7564113Z GOBIN=''2026-08-11T00:57:14.7564364Z GOCACHE='/home/runner/.cache/go-build'2026-08-11T00:57:14.7564878Z GOCACHEPROG=''2026-08-11T00:57:14.7565260Z GODEBUG=''2026-08-11T00:57:14.7565522Z GOENV='/home/runner/.config/go/env'2026-08-11T00:57:14.7565815Z GOEXE=''2026-08-11T00:57:14.7566026Z GOEXPERIMENT=''2026-08-11T00:57:14.7566256Z GOFIPS140='off'2026-08-11T00:57:14.7566508Z GOFLAGS=''2026-08-11T00:57:14.7567288Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build3140635615=/tmp/go-build -gno-record-gcc-switches'2026-08-11T00:57:14.7568065Z GOHOSTARCH='amd64'2026-08-11T00:57:14.7568306Z GOHOSTOS='linux'2026-08-11T00:57:14.7568537Z GOINSECURE=''2026-08-11T00:57:14.7568931Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-11T00:57:14.7569879Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-11T00:57:14.7570192Z GONOPROXY=''2026-08-11T00:57:14.7570392Z GONOSUMDB=''2026-08-11T00:57:14.7570586Z GOOS='linux'2026-08-11T00:57:14.7570817Z GOPATH='/home/runner/go'2026-08-11T00:57:14.7571051Z GOPRIVATE=''2026-08-11T00:57:14.7571313Z GOPROXY='https://proxy.golang.org,direct'2026-08-11T00:57:14.7572018Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-11T00:57:14.7572463Z GOSUMDB='sum.golang.org'2026-08-11T00:57:14.7572705Z GOTELEMETRY='local'2026-08-11T00:57:14.7572985Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-11T00:57:14.7573481Z GOTMPDIR=''2026-08-11T00:57:14.7573693Z GOTOOLCHAIN='local'2026-08-11T00:57:14.7574026Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-11T00:57:14.7574526Z GOVCS=''2026-08-11T00:57:14.7574781Z GOVERSION='go1.26.5'2026-08-11T00:57:14.7574999Z GOWORK=''2026-08-11T00:57:14.7575210Z PKG_CONFIG='pkg-config'2026-08-11T00:57:14.7575356Z 2026-08-11T00:57:14.7575840Z ##[endgroup]2026-08-11T00:57:14.7750736Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-11T00:57:14.7751293Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-11T00:57:14.7806926Z shell: /usr/bin/bash -e {0}2026-08-11T00:57:14.7807187Z env:2026-08-11T00:57:14.7807389Z GOTOOLCHAIN: local2026-08-11T00:57:14.7807632Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-08-11T00:57:14.7807908Z OSPOOL_EP_CMTag: 25.x-el92026-08-11T00:57:14.7808159Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-11T00:57:14.7808408Z ##[endgroup]2026-08-11T00:57:21.4964988Z === RUN TestOSPoolEP2026-08-11T00:57:21.4967693Z === PAUSE TestOSPoolEP2026-08-11T00:57:21.4968355Z === CONT TestOSPoolEP2026-08-11T00:57:21.4970274Z TestOSPoolEP 2026-08-11T00:57:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:21.5090150Z TestOSPoolEP 2026-08-11T00:57:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t apply -f /tmp/TestOSPoolEP1807897862]2026-08-11T00:57:22.0983290Z TestOSPoolEP 2026-08-11T00:57:22Z logger.go:67: pod/idtoken-generator created2026-08-11T00:57:22.1082721Z TestOSPoolEP 2026-08-11T00:57:22Z logger.go:67: secret/pool-passwd created2026-08-11T00:57:22.1130994Z TestOSPoolEP 2026-08-11T00:57:22Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-11T00:57:22.1135717Z TestOSPoolEP 2026-08-11T00:57:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:22.1159672Z TestOSPoolEP 2026-08-11T00:57:22Z retry.go:103: Wait for pod idtoken-generator to be provisioned. returned an error: Pod idtoken-generator is not available, reason: , message: . Sleeping for 10s and will try again.2026-08-11T00:57:32.1168796Z TestOSPoolEP 2026-08-11T00:57:32Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-11T00:57:32.1171358Z TestOSPoolEP 2026-08-11T00:57:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:32.1197046Z TestOSPoolEP 2026-08-11T00:57:32Z 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-11T00:57:42.1206926Z TestOSPoolEP 2026-08-11T00:57:42Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-11T00:57:42.1208190Z TestOSPoolEP 2026-08-11T00:57:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:42.1232227Z TestOSPoolEP 2026-08-11T00:57:42Z logger.go:67: Pod is now available2026-08-11T00:57:42.1233915Z TestOSPoolEP 2026-08-11T00:57:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-11T00:57:42.6463022Z TestOSPoolEP 2026-08-11T00:57:42Z logger.go:67: ***2026-08-11T00:57:42.6524216Z TestOSPoolEP 2026-08-11T00:57:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t apply -f /tmp/TestOSPoolEP3652215108]2026-08-11T00:57:42.8348135Z TestOSPoolEP 2026-08-11T00:57:42Z logger.go:67: secret/pool-token created2026-08-11T00:57:42.8379951Z TestOSPoolEP 2026-08-11T00:57:42Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-11T00:57:42.8381239Z TestOSPoolEP 2026-08-11T00:57:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:42.8401183Z TestOSPoolEP 2026-08-11T00:57:42Z logger.go:67: Secret is now available2026-08-11T00:57:42.8429088Z TestOSPoolEP 2026-08-11T00:57:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t apply -k /tmp/kustomize-template-376034739]2026-08-11T00:57:43.1075156Z TestOSPoolEP 2026-08-11T00:57:43Z logger.go:67: service/test-cm created2026-08-11T00:57:43.1176323Z TestOSPoolEP 2026-08-11T00:57:43Z 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-11T00:57:43.1178426Z TestOSPoolEP 2026-08-11T00:57:43Z logger.go:67: deployment.apps/ospool-ep created2026-08-11T00:57:43.1268184Z TestOSPoolEP 2026-08-11T00:57:43Z logger.go:67: deployment.apps/test-cm created2026-08-11T00:57:43.1319622Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-11T00:57:43.1321620Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:43.1412969Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:43Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-11T00:57:43.1432329Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:43.1434995Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:43Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-11T00:57:43.1443101Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:43.1532626Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:43Z 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-11T00:57:43.1540948Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:43Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-65c844ddbb". Sleeping for 10s and will try again.2026-08-11T00:57:53.1544328Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:53Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-11T00:57:53.1546481Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:53Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:53.1548686Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:53Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-11T00:57:53.1552379Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:53Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:53.1572685Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:53Z logger.go:67: Deployment is now available2026-08-11T00:57:53.1579756Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:53Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-65c844ddbb" is progressing.. Sleeping for 10s and will try again.2026-08-11T00:58:03.1582733Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:58:03Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-11T00:58:03.1584715Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:58:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:58:03.1622214Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:58:03Z logger.go:67: Deployment is now available2026-08-11T00:58:03.1625417Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-11T00:58:03.1629521Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-11T00:58:03.1630306Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-11T00:58:03.1631101Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-11T00:58:03.1631835Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-11T00:58:03.1632635Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-11T00:58:03.1633366Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-11T00:58:03.1634097Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-11T00:58:03.1635567Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:58:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:58:03.1637696Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:58:03.1639102Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-11T00:58:03.1640949Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-11T00:58:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:58:03.1665719Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:58:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:58:03.1672345Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:58:03.1675503Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-11T00:58:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:58:03.1686867Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:58:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T00:58:03.1711239Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-11T00:58:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_SINGULARITY]2026-08-11T00:58:03.1805647Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)']2026-08-11T00:58:03.5267510Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-nr75k failed. Retrying in 10s.2026-08-11T00:58:03.5281062Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-11T00:58:03.5283121Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)']' in pod test-cm-5bb545475c-nr75k failed. Retrying in 10s.2026-08-11T00:58:03.5369905Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-11T00:58:03.5372411Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-nr75k failed. Retrying in 30s.2026-08-11T00:58:13.5285432Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-11T00:58:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_SINGULARITY]2026-08-11T00:58:13.5293871Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)']2026-08-11T00:58:13.7334103Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-11T00:58:13.7336267Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-nr75k failed. Retrying in 10s.2026-08-11T00:58:13.7404868Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-11T00:58:13.7406497Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)']' in pod test-cm-5bb545475c-nr75k failed. Retrying in 10s.2026-08-11T00:58:23.7355760Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-11T00:58:23Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_SINGULARITY]2026-08-11T00:58:23.7409464Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:23Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)']2026-08-11T00:58:23.9359593Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-11T00:58:23Z logger.go:67: true2026-08-11T00:58:23.9366501Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:23Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-11T00:58:23.9368124Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:23Z logger.go:67: 2026-08-11T00:58:23.9370210Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:23Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-65c844ddbb-bhngq LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-08-11T00:58:23.9371831Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:23Z logger.go:67: 2026-08-11T00:58:23.9373040Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:23Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-11T00:58:23.9374330Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:23Z logger.go:67: 2026-08-11T00:58:23.9375411Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:23Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-11T00:58:23.9376350Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:23Z logger.go:67: 2026-08-11T00:58:23.9377756Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:23Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-11T00:58:33.5378822Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:58:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T00:58:33.7139829Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:58:33Z logger.go:67: undefined2026-08-11T00:58:33.7226720Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-11T00:58:33.7228123Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-nr75k failed. Retrying in 30s.2026-08-11T00:59:03.7239517Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:59:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T00:59:03.9471214Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:59:03Z logger.go:67: undefined2026-08-11T00:59:03.9544427Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-nr75k failed. Retrying in 30s.2026-08-11T00:59:33.9556053Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:59:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T00:59:34.1475604Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:59:34Z logger.go:67: undefined2026-08-11T00:59:34.1538979Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-nr75k failed. Retrying in 30s.2026-08-11T01:00:04.1545278Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:00:04Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T01:00:04.3203796Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:00:04Z logger.go:67: undefined2026-08-11T01:00:04.3267613Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-nr75k failed. Retrying in 30s.2026-08-11T01:00:34.3283893Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:00:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T01:00:34.4770925Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:00:34Z logger.go:67: undefined2026-08-11T01:00:34.4832772Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-nr75k failed. Retrying in 30s.2026-08-11T01:01:04.4853355Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:01:04Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T01:01:04.6267099Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:01:04Z logger.go:67: undefined2026-08-11T01:01:04.6321259Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-nr75k failed. Retrying in 30s.2026-08-11T01:01:34.6351783Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:01:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T01:01:34.7881872Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:01:34Z logger.go:67: undefined2026-08-11T01:01:34.7941999Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-nr75k failed. Retrying in 30s.2026-08-11T01:02:04.7947610Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:02:04Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T01:02:04.9406070Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:02:04Z logger.go:67: undefined2026-08-11T01:02:04.9482635Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-nr75k failed. Retrying in 30s.2026-08-11T01:02:34.9486832Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:02:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T01:02:35.1070185Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:02:35Z logger.go:67: undefined2026-08-11T01:02:35.1134815Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-nr75k failed. Retrying in 30s.2026-08-11T01:03:05.1168896Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:03:05Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T01:03:05.2597496Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:03:05Z logger.go:67: undefined2026-08-11T01:03:05.2654052Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-nr75k failed. Retrying in 30s.2026-08-11T01:03:35.2688561Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:03:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t exec test-cm-5bb545475c-nr75k -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-bhngq",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T01:03:35.4287446Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:03:35Z logger.go:67: true2026-08-11T01:03:35.4351003Z TestOSPoolEP 2026-08-11T01:03:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T01:03:35.4433187Z TestOSPoolEP 2026-08-11T01:03:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T01:03:35.6117249Z TestOSPoolEP 2026-08-11T01:03:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T01:03:35.7590990Z TestOSPoolEP 2026-08-11T01:03:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T01:03:35.9293237Z TestOSPoolEP 2026-08-11T01:03:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T01:03:35.9331220Z === NAME TestOSPoolEP2026-08-11T01:03:35.9336722Z ospool_ep_test.go:101: ---2026-08-11T01:03:35.9344485Z Events for pod idtoken-generator:2026-08-11T01:03:35.9346300Z 2026-08-11 00:57:22 +0000 UTC Normal Successfully assigned test-ospool-ep-4ooe3t/idtoken-generator to minikube2026-08-11T01:03:35.9348152Z 2026-08-11 00:57:23 +0000 UTC Normal Pulling image "htcondor/base"2026-08-11T01:03:35.9350853Z 2026-08-11 00:57:31 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.28s (8.28s including waiting). Image size: 560910730 bytes.2026-08-11T01:03:35.9352587Z 2026-08-11 00:57:31 +0000 UTC Normal Container created2026-08-11T01:03:35.9355739Z 2026-08-11 00:57:31 +0000 UTC Normal Container started2026-08-11T01:03:35.9356432Z 2026-08-11T01:03:35.9356816Z ---2026-08-11T01:03:35.9357877Z TestOSPoolEP 2026-08-11T01:03:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T01:03:35.9379999Z ospool_ep_test.go:101: ---2026-08-11T01:03:35.9380807Z Events for pod ospool-ep-65c844ddbb-bhngq:2026-08-11T01:03:35.9388452Z 2026-08-11 00:57:43 +0000 UTC Normal Successfully assigned test-ospool-ep-4ooe3t/ospool-ep-65c844ddbb-bhngq to minikube2026-08-11T01:03:35.9389859Z 2026-08-11 00:57:43 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-11T01:03:35.9391093Z 2026-08-11 00:57:45 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.684s (1.684s including waiting). Image size: 5590942 bytes.2026-08-11T01:03:35.9391964Z 2026-08-11 00:57:45 +0000 UTC Normal Container created2026-08-11T01:03:35.9392455Z 2026-08-11 00:57:45 +0000 UTC Normal Container started2026-08-11T01:03:35.9393193Z 2026-08-11 00:57:45 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-08-11T01:03:35.9394487Z 2026-08-11 00:57:59 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 13.935s (13.936s including waiting). Image size: 1273054585 bytes.2026-08-11T01:03:35.9395359Z 2026-08-11 00:57:59 +0000 UTC Normal Container created2026-08-11T01:03:35.9395814Z 2026-08-11 00:57:59 +0000 UTC Normal Container started2026-08-11T01:03:35.9396568Z 2026-08-11T01:03:35.9396776Z ---2026-08-11T01:03:35.9397345Z TestOSPoolEP 2026-08-11T01:03:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T01:03:35.9426958Z ospool_ep_test.go:101: ---2026-08-11T01:03:35.9430547Z Events for pod test-cm-5bb545475c-nr75k:2026-08-11T01:03:35.9440204Z 2026-08-11 00:57:43 +0000 UTC Normal Successfully assigned test-ospool-ep-4ooe3t/test-cm-5bb545475c-nr75k to minikube2026-08-11T01:03:35.9441667Z 2026-08-11 00:57:43 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-08-11T01:03:35.9446017Z 2026-08-11 00:57:45 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 264ms (1.937s including waiting). Image size: 560910756 bytes.2026-08-11T01:03:35.9451896Z 2026-08-11 00:57:45 +0000 UTC Normal Container created2026-08-11T01:03:35.9452786Z 2026-08-11 00:57:45 +0000 UTC Normal Container started2026-08-11T01:03:35.9453357Z 2026-08-11T01:03:35.9453700Z ---2026-08-11T01:03:35.9454691Z TestOSPoolEP 2026-08-11T01:03:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T01:03:35.9456628Z TestOSPoolEP 2026-08-11T01:03:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t delete -f /tmp/TestOSPoolEP515739238]2026-08-11T01:03:36.0817653Z TestOSPoolEP 2026-08-11T01:03:36Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-4ooe3t namespace2026-08-11T01:03:36.0879921Z TestOSPoolEP 2026-08-11T01:03:36Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-4ooe3t namespace2026-08-11T01:03:36.9097388Z TestOSPoolEP 2026-08-11T01:03:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t delete -f /tmp/TestOSPoolEP1394723149]2026-08-11T01:03:37.0138970Z TestOSPoolEP 2026-08-11T01:03:37Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-4ooe3t namespace2026-08-11T01:03:37.0189604Z TestOSPoolEP 2026-08-11T01:03:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-4ooe3t delete -k /tmp/kustomize-template-376034739]2026-08-11T01:03:37.1488377Z TestOSPoolEP 2026-08-11T01:03:37Z logger.go:67: service "test-cm" deleted from test-ospool-ep-4ooe3t namespace2026-08-11T01:03:37.1596587Z TestOSPoolEP 2026-08-11T01:03:37Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-4ooe3t namespace2026-08-11T01:03:37.1633513Z TestOSPoolEP 2026-08-11T01:03:37Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-4ooe3t namespace2026-08-11T01:03:37.1740370Z --- PASS: TestOSPoolEP (43.40s)2026-08-11T01:03:37.1741524Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (20.03s)2026-08-11T01:03:37.1742877Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.78s)2026-08-11T01:03:37.1744355Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.78s)2026-08-11T01:03:37.1745795Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (332.27s)2026-08-11T01:03:37.1746775Z PASS2026-08-11T01:03:37.1787542Z ok github.com/osg-htc/k8s-integration-tests/test 375.695s2026-08-11T01:03:37.3184601Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-11T01:03:37.3185701Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-11T01:03:37.3267731Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-11T01:03:37.3268330Z env:2026-08-11T01:03:37.3268668Z GOTOOLCHAIN: local2026-08-11T01:03:37.3269661Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-11T01:03:37.3270910Z ##[endgroup]2026-08-11T01:03:37.3618946Z 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-11T01:03:37.3623515Z ##[group]Run actions/upload-artifact@v42026-08-11T01:03:37.3623972Z with:2026-08-11T01:03:37.3624582Z name: TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe52026-08-11T01:03:37.3625335Z path: /tmp/k8s-tests2026-08-11T01:03:37.3625698Z retention-days: 52026-08-11T01:03:37.3626047Z if-no-files-found: warn2026-08-11T01:03:37.3626426Z compression-level: 62026-08-11T01:03:37.3626782Z overwrite: false2026-08-11T01:03:37.3627131Z include-hidden-files: false2026-08-11T01:03:37.3627524Z env:2026-08-11T01:03:37.3627833Z GOTOOLCHAIN: local2026-08-11T01:03:37.3628172Z ##[endgroup]2026-08-11T01:03:37.6130189Z (node:17963) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-11T01:03:37.6131695Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-11T01:03:37.6306878Z With the provided path, there will be 6 files uploaded2026-08-11T01:03:37.6308356Z Artifact name is valid!2026-08-11T01:03:37.6309276Z Root directory input is valid!2026-08-11T01:03:37.7898819Z Beginning upload of artifact content to blob storage2026-08-11T01:03:37.8231179Z (node:17963) [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-11T01:03:37.8765505Z Uploaded bytes 139842026-08-11T01:03:37.8970393Z Finished uploading artifact content to blob storage!2026-08-11T01:03:37.8971580Z SHA256 digest of uploaded artifact zip is b3b6f17f1dd25b7c2756091b1d50e5b421eaffeb4bcc1a8701e59ec5c82ea8282026-08-11T01:03:37.8976048Z Finalizing artifact upload2026-08-11T01:03:38.0563092Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5.zip successfully finalized. Artifact ID 90852947492026-08-11T01:03:38.0565955Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5 has been successfully uploaded! Final size is 13984 bytes. Artifact ID is 90852947492026-08-11T01:03:38.0571909Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/31447663543/artifacts/90852947492026-08-11T01:03:38.0749878Z Post job cleanup.2026-08-11T01:03:38.2084080Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-11T01:03:38.2140284Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-11T01:03:38.2173584Z /home/runner/go/pkg/mod2026-08-11T01:03:38.2200174Z /home/runner/.cache/go-build2026-08-11T01:03:38.2206522Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-11T01:03:38.2407744Z Post job cleanup.2026-08-11T01:03:38.3483988Z [command]/usr/bin/git version2026-08-11T01:03:38.3530273Z git version 2.54.02026-08-11T01:03:38.3588448Z Temporarily overriding HOME='/home/runner/work/_temp/a913a826-e012-4fac-93d6-a95d2323dd67' before making global git config changes2026-08-11T01:03:38.3611885Z Adding repository directory to the temporary git global config as a safe directory2026-08-11T01:03:38.3613312Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-11T01:03:38.3658161Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-11T01:03:38.3717029Z [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-11T01:03:38.4042711Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-11T01:03:38.4076774Z http.https://github.com/.extraheader2026-08-11T01:03:38.4095672Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-11T01:03:38.4136245Z [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-11T01:03:38.4427826Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-11T01:03:38.4467529Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-11T01:03:38.4914575Z Cleaning up orphan processes2026-08-11T01:03:38.5685687Z ##[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/