All Test Logs

2026-08-15T00:37:31.6135525Z Current runner version: '2.336.0'2026-08-15T00:37:31.6161738Z ##[group]Runner Image Provisioner2026-08-15T00:37:31.6162650Z Hosted Compute Agent2026-08-15T00:37:31.6163244Z Version: 20260729.5662026-08-15T00:37:31.6164078Z Commit: cf7153fe6e25b664e8693c24944bf2b00355d1092026-08-15T00:37:31.6164827Z Build Date: 2026-07-29T19:17:02Z2026-08-15T00:37:31.6165646Z Worker ID: {d2c51367-f2c2-4bbe-9413-6cc04ebe8962}2026-08-15T00:37:31.6166464Z Azure Region: westus2026-08-15T00:37:31.6167050Z ##[endgroup]2026-08-15T00:37:31.6169089Z ##[group]Operating System2026-08-15T00:37:31.6169783Z Ubuntu2026-08-15T00:37:31.6170328Z 22.04.52026-08-15T00:37:31.6171047Z LTS2026-08-15T00:37:31.6171584Z ##[endgroup]2026-08-15T00:37:31.6172269Z ##[group]Runner Image2026-08-15T00:37:31.6172915Z Image: ubuntu-22.042026-08-15T00:37:31.6173515Z Version: 20260810.260.12026-08-15T00:37:31.6174884Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260810.260/images/ubuntu/Ubuntu2204-Readme.md2026-08-15T00:37:31.6176534Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260810.2602026-08-15T00:37:31.6177535Z ##[endgroup]2026-08-15T00:37:31.6179285Z ##[group]GITHUB_TOKEN Permissions2026-08-15T00:37:31.6181571Z Contents: read2026-08-15T00:37:31.6182211Z Metadata: read2026-08-15T00:37:31.6182966Z Packages: read2026-08-15T00:37:31.6183547Z ##[endgroup]2026-08-15T00:37:31.6185643Z Secret source: Actions2026-08-15T00:37:31.6187402Z Prepare workflow directory2026-08-15T00:37:31.6539771Z Prepare all required actions2026-08-15T00:37:31.6614577Z Getting action download info2026-08-15T00:37:31.9959167Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-15T00:37:32.1308045Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-15T00:37:32.4492600Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-15T00:37:32.7805954Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-15T00:37:33.0542821Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-15T00:37:33.0550187Z ##[group] Inputs2026-08-15T00:37:33.0551085Z   testName: TestOSPoolEP2026-08-15T00:37:33.0552443Z   testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-08-15T00:37:33.0553483Z   setupScript: 2026-08-15T00:37:33.0554327Z   setupEnv: {}2026-08-15T00:37:33.0554789Z ##[endgroup]2026-08-15T00:37:33.0555469Z Complete job name: ospool-ep / Run OSPool EP test (cvmfs-bind, 25-testing) / Run Tests2026-08-15T00:37:33.1404294Z ##[group]Run actions/checkout@v52026-08-15T00:37:33.1405222Z with:2026-08-15T00:37:33.1405738Z   repository: mwestphall/k8s-integration-tests2026-08-15T00:37:33.1409903Z   token: ***2026-08-15T00:37:33.1410341Z   ssh-strict: true2026-08-15T00:37:33.1410810Z   ssh-user: git2026-08-15T00:37:33.1411269Z   persist-credentials: true2026-08-15T00:37:33.1411774Z   clean: true2026-08-15T00:37:33.1412211Z   sparse-checkout-cone-mode: true2026-08-15T00:37:33.1412720Z   fetch-depth: 12026-08-15T00:37:33.1413131Z   fetch-tags: false2026-08-15T00:37:33.1413575Z   show-progress: true2026-08-15T00:37:33.1414023Z   lfs: false2026-08-15T00:37:33.1414434Z   submodules: false2026-08-15T00:37:33.1414873Z   set-safe-directory: true2026-08-15T00:37:33.1415363Z   allow-unsafe-pr-checkout: false2026-08-15T00:37:33.1416236Z ##[endgroup]2026-08-15T00:37:33.2584426Z Syncing repository: mwestphall/k8s-integration-tests2026-08-15T00:37:33.2586548Z ##[group]Getting Git version info2026-08-15T00:37:33.2587558Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-15T00:37:33.2589241Z [command]/usr/bin/git version2026-08-15T00:37:33.2687343Z git version 2.54.02026-08-15T00:37:33.2723706Z ##[endgroup]2026-08-15T00:37:33.2749890Z Temporarily overriding HOME='/home/runner/work/_temp/328a504f-ecaa-47f7-b5f0-7b78d0825eb9' before making global git config changes2026-08-15T00:37:33.2755271Z Adding repository directory to the temporary git global config as a safe directory2026-08-15T00:37:33.2757834Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-15T00:37:33.2793623Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-15T00:37:33.2797242Z ##[group]Initializing the repository2026-08-15T00:37:33.2803461Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-15T00:37:33.2924396Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-15T00:37:33.2926473Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-15T00:37:33.2928246Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-15T00:37:33.2930046Z hint: call:2026-08-15T00:37:33.2931004Z hint:2026-08-15T00:37:33.2932272Z hint: 	git config --global init.defaultBranch <name>2026-08-15T00:37:33.2933521Z hint:2026-08-15T00:37:33.2934775Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-15T00:37:33.2936535Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-15T00:37:33.2937973Z hint:2026-08-15T00:37:33.2939363Z hint: 	git branch -m <name>2026-08-15T00:37:33.2940446Z hint:2026-08-15T00:37:33.2941706Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-15T00:37:33.2944064Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-15T00:37:33.2947843Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-15T00:37:33.2984867Z ##[endgroup]2026-08-15T00:37:33.2986159Z ##[group]Disabling automatic garbage collection2026-08-15T00:37:33.2990239Z [command]/usr/bin/git config --local gc.auto 02026-08-15T00:37:33.3027582Z ##[endgroup]2026-08-15T00:37:33.3029257Z ##[group]Setting up auth2026-08-15T00:37:33.3049509Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-15T00:37:33.3098929Z [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-15T00:37:33.3516499Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-15T00:37:33.3565494Z [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-15T00:37:33.3844117Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-15T00:37:33.3889012Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-15T00:37:33.4161065Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-15T00:37:33.4206690Z ##[endgroup]2026-08-15T00:37:33.4208084Z ##[group]Fetching the repository2026-08-15T00:37:33.4218007Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-15T00:37:33.8788745Z From https://github.com/mwestphall/k8s-integration-tests2026-08-15T00:37:33.8790463Z  * [new ref]         ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-15T00:37:33.8818695Z ##[endgroup]2026-08-15T00:37:33.8819631Z ##[group]Determining the checkout info2026-08-15T00:37:33.8821640Z ##[endgroup]2026-08-15T00:37:33.8827179Z [command]/usr/bin/git sparse-checkout disable2026-08-15T00:37:33.8880619Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-15T00:37:33.8922278Z ##[group]Checking out the ref2026-08-15T00:37:33.8923134Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-15T00:37:33.9022935Z Switched to a new branch 'main'2026-08-15T00:37:33.9025943Z branch 'main' set up to track 'origin/main'.2026-08-15T00:37:33.9035733Z ##[endgroup]2026-08-15T00:37:33.9095619Z [command]/usr/bin/git log -1 --format=%H2026-08-15T00:37:33.9131828Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-15T00:37:33.9504886Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-15T00:37:33.9506125Z echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-15T00:37:33.9507191Z echo "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-15T00:37:33.9874794Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-15T00:37:33.9875547Z env:2026-08-15T00:37:33.9876361Z   TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-08-15T00:37:33.9877283Z   SETUP_ENV_YAML: {}2026-08-15T00:37:33.9877708Z ##[endgroup]2026-08-15T00:37:36.1212668Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-15T00:37:36.1213415Z echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-15T00:37:36.1289142Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-15T00:37:36.1289556Z env:2026-08-15T00:37:36.1290084Z   TEST_ENV: {  "OSPOOL_EP_OSPoolEPTag": "25-testing",  "OSPOOL_EP_CMTag": "25.x-el9",  "OSPOOL_EP_CvmfsType": "cvmfs-bind"}2026-08-15T00:37:36.1290689Z ##[endgroup]2026-08-15T00:37:36.1450777Z ##[group]Run true2026-08-15T00:37:36.1451096Z true2026-08-15T00:37:36.1523821Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-15T00:37:36.1524262Z ##[endgroup]2026-08-15T00:37:36.1722231Z ##[group]Run medyagh/setup-minikube@latest2026-08-15T00:37:36.1722608Z with:2026-08-15T00:37:36.1722836Z   start: true2026-08-15T00:37:36.1723064Z   cache: true2026-08-15T00:37:36.1723329Z   minikube-version: latest2026-08-15T00:37:36.1723626Z   wait: all2026-08-15T00:37:36.1723854Z ##[endgroup]2026-08-15T00:37:36.3103421Z (node:1878) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-15T00:37:36.3104609Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-15T00:37:37.1569345Z [command]/usr/bin/chmod +x /home/runner/work/_temp/f01fde7a-b8af-406d-8d52-e76ec5de93982026-08-15T00:37:37.3328289Z [command]/home/runner/bin/minikube version --short2026-08-15T00:37:37.3930339Z v1.38.12026-08-15T00:37:37.6450406Z Cache hit for: kic-v1.38.1-x642026-08-15T00:37:37.6461309Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-15T00:37:37.6563386Z (node:1878) [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-15T00:37:38.9645363Z Received 0 of 224218863 (0.0%), 0.0 MBs/sec2026-08-15T00:37:38.9801369Z Received 4194304 of 544082657 (0.8%), 4.0 MBs/sec2026-08-15T00:37:39.9666373Z Received 71303168 of 224218863 (31.8%), 34.0 MBs/sec2026-08-15T00:37:39.9825342Z Received 96468992 of 544082657 (17.7%), 46.0 MBs/sec2026-08-15T00:37:40.9688704Z Received 159383552 of 224218863 (71.1%), 50.6 MBs/sec2026-08-15T00:37:40.9833271Z Received 167772160 of 544082657 (30.8%), 53.3 MBs/sec2026-08-15T00:37:41.6152865Z Received 224218863 of 224218863 (100.0%), 58.6 MBs/sec2026-08-15T00:37:41.6154335Z Cache Size: ~214 MB (224218863 B)2026-08-15T00:37:41.6591316Z [command]/usr/bin/tar -xf /home/runner/work/_temp/63f1d33b-455f-475f-9428-6143dcbdb7c2/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-15T00:37:41.9854000Z Received 268435456 of 544082657 (49.3%), 63.9 MBs/sec2026-08-15T00:37:42.2972750Z Cache restored successfully2026-08-15T00:37:43.0010739Z Received 402653184 of 544082657 (74.0%), 76.5 MBs/sec2026-08-15T00:37:43.9992137Z Received 524288000 of 544082657 (96.4%), 83.1 MBs/sec2026-08-15T00:37:44.5194341Z Received 544082657 of 544082657 (100.0%), 79.4 MBs/sec2026-08-15T00:37:44.5195492Z Cache Size: ~519 MB (544082657 B)2026-08-15T00:37:44.5332448Z [command]/usr/bin/tar -xf /home/runner/work/_temp/9a7da3f2-3e7c-4f1f-a7df-9177437e91a4/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-15T00:37:45.5307340Z Cache restored successfully2026-08-15T00:37:45.6557167Z [command]/home/runner/bin/minikube start --wait all2026-08-15T00:37:45.7209674Z * minikube v1.38.1 on Ubuntu 22.042026-08-15T00:38:01.8821534Z * Automatically selected the docker driver. Other choices: podman, ssh, none2026-08-15T00:38:01.9452376Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-15T00:38:01.9462478Z * Using Docker driver with root privileges2026-08-15T00:38:01.9473623Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-15T00:38:01.9482442Z * Pulling base image v0.0.50 ...2026-08-15T00:38:34.4757164Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-15T00:38:39.1699397Z * Verifying Kubernetes components...2026-08-15T00:38:39.2028213Z   - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-15T00:38:40.0358477Z * Enabled addons: storage-provisioner, default-storageclass2026-08-15T00:39:25.3670898Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-15T00:39:25.3810426Z [command]/home/runner/bin/minikube version --short2026-08-15T00:39:25.4326468Z v1.38.12026-08-15T00:39:25.4625466Z ##[group]Run actions/setup-go@v62026-08-15T00:39:25.4625775Z with:2026-08-15T00:39:25.4625975Z   go-version: 1.262026-08-15T00:39:25.4626181Z   cache: true2026-08-15T00:39:25.4626408Z   cache-dependency-path: go.sum2026-08-15T00:39:25.4626666Z   check-latest: false2026-08-15T00:39:25.4629522Z   token: ***2026-08-15T00:39:25.4629730Z ##[endgroup]2026-08-15T00:39:25.6045962Z Setup go version spec 1.262026-08-15T00:39:25.6247225Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-15T00:39:25.6250351Z Added go to the path2026-08-15T00:39:25.6254206Z Successfully set up Go version 1.262026-08-15T00:39:25.6931033Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-15T00:39:25.6976961Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-15T00:39:25.7014787Z /home/runner/go/pkg/mod2026-08-15T00:39:25.7042564Z /home/runner/.cache/go-build2026-08-15T00:39:25.9589327Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-15T00:39:27.2741587Z Received 4194304 of 251839808 (1.7%), 4.0 MBs/sec2026-08-15T00:39:28.2706030Z Received 121634816 of 251839808 (48.3%), 57.9 MBs/sec2026-08-15T00:39:29.2717656Z Received 235062592 of 251839808 (93.3%), 74.6 MBs/sec2026-08-15T00:39:29.4567344Z Received 251839808 of 251839808 (100.0%), 75.3 MBs/sec2026-08-15T00:39:29.4569269Z Cache Size: ~240 MB (251839808 B)2026-08-15T00:39:29.4687059Z [command]/usr/bin/tar -xf /home/runner/work/_temp/8f4a4258-7d22-41d9-9c0a-983e2249efb9/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-15T00:39:32.7445460Z Cache restored successfully2026-08-15T00:39:32.8137096Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-15T00:39:32.8168306Z go version go1.26.5 linux/amd642026-08-15T00:39:32.8168985Z 2026-08-15T00:39:32.8169517Z ##[group]go env2026-08-15T00:39:32.8331325Z AR='ar'2026-08-15T00:39:32.8332094Z CC='gcc'2026-08-15T00:39:32.8332464Z CGO_CFLAGS='-O2 -g'2026-08-15T00:39:32.8332878Z CGO_CPPFLAGS=''2026-08-15T00:39:32.8333279Z CGO_CXXFLAGS='-O2 -g'2026-08-15T00:39:32.8406735Z CGO_ENABLED='1'2026-08-15T00:39:32.8407312Z CGO_FFLAGS='-O2 -g'2026-08-15T00:39:32.8407715Z CGO_LDFLAGS='-O2 -g'2026-08-15T00:39:32.8408125Z CXX='g++'2026-08-15T00:39:32.8408627Z GCCGO='gccgo'2026-08-15T00:39:32.8409007Z GO111MODULE=''2026-08-15T00:39:32.8409367Z GOAMD64='v1'2026-08-15T00:39:32.8409720Z GOARCH='amd64'2026-08-15T00:39:32.8409938Z GOAUTH='netrc'2026-08-15T00:39:32.8410134Z GOBIN=''2026-08-15T00:39:32.8410367Z GOCACHE='/home/runner/.cache/go-build'2026-08-15T00:39:32.8410658Z GOCACHEPROG=''2026-08-15T00:39:32.8410860Z GODEBUG=''2026-08-15T00:39:32.8411084Z GOENV='/home/runner/.config/go/env'2026-08-15T00:39:32.8411375Z GOEXE=''2026-08-15T00:39:32.8411577Z GOEXPERIMENT=''2026-08-15T00:39:32.8411794Z GOFIPS140='off'2026-08-15T00:39:32.8412019Z GOFLAGS=''2026-08-15T00:39:32.8412719Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build1993746731=/tmp/go-build -gno-record-gcc-switches'2026-08-15T00:39:32.8413423Z GOHOSTARCH='amd64'2026-08-15T00:39:32.8413685Z GOHOSTOS='linux'2026-08-15T00:39:32.8413898Z GOINSECURE=''2026-08-15T00:39:32.8414287Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-15T00:39:32.8414730Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-15T00:39:32.8415013Z GONOPROXY=''2026-08-15T00:39:32.8415213Z GONOSUMDB=''2026-08-15T00:39:32.8415402Z GOOS='linux'2026-08-15T00:39:32.8415927Z GOPATH='/home/runner/go'2026-08-15T00:39:32.8416207Z GOPRIVATE=''2026-08-15T00:39:32.8416485Z GOPROXY='https://proxy.golang.org,direct'2026-08-15T00:39:32.8416842Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-15T00:39:32.8417156Z GOSUMDB='sum.golang.org'2026-08-15T00:39:32.8417414Z GOTELEMETRY='local'2026-08-15T00:39:32.8418035Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-15T00:39:32.8424834Z GOTMPDIR=''2026-08-15T00:39:32.8425263Z GOTOOLCHAIN='local'2026-08-15T00:39:32.8426059Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-15T00:39:32.8427700Z GOVCS=''2026-08-15T00:39:32.8428408Z GOVERSION='go1.26.5'2026-08-15T00:39:32.8428845Z GOWORK=''2026-08-15T00:39:32.8429503Z PKG_CONFIG='pkg-config'2026-08-15T00:39:32.8429785Z 2026-08-15T00:39:32.8430282Z ##[endgroup]2026-08-15T00:39:32.8541704Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-15T00:39:32.8542248Z go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-15T00:39:32.8635562Z shell: /usr/bin/bash -e {0}2026-08-15T00:39:32.8635985Z env:2026-08-15T00:39:32.8636311Z   GOTOOLCHAIN: local2026-08-15T00:39:32.8636689Z   OSPOOL_EP_OSPoolEPTag: 25-testing2026-08-15T00:39:32.8637164Z   OSPOOL_EP_CMTag: 25.x-el92026-08-15T00:39:32.8637621Z   OSPOOL_EP_CvmfsType: cvmfs-bind2026-08-15T00:39:32.8638120Z ##[endgroup]2026-08-15T00:39:37.2295250Z === RUN   TestOSPoolEP2026-08-15T00:39:37.2295974Z === PAUSE TestOSPoolEP2026-08-15T00:39:37.2296397Z === CONT  TestOSPoolEP2026-08-15T00:39:37.2298273Z TestOSPoolEP 2026-08-15T00:39:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:39:37.2399362Z TestOSPoolEP 2026-08-15T00:39:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz apply -f /tmp/TestOSPoolEP967980589]2026-08-15T00:39:37.7992480Z TestOSPoolEP 2026-08-15T00:39:37Z logger.go:67: pod/idtoken-generator created2026-08-15T00:39:37.8062054Z TestOSPoolEP 2026-08-15T00:39:37Z logger.go:67: secret/pool-passwd created2026-08-15T00:39:37.8133895Z TestOSPoolEP 2026-08-15T00:39:37Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-15T00:39:37.8135843Z TestOSPoolEP 2026-08-15T00:39:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:39:37.8158834Z TestOSPoolEP 2026-08-15T00:39:37Z 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-15T00:39:47.8167031Z TestOSPoolEP 2026-08-15T00:39:47Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-15T00:39:47.8168733Z TestOSPoolEP 2026-08-15T00:39:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:39:47.8197602Z TestOSPoolEP 2026-08-15T00:39:47Z 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-15T00:39:57.8201955Z TestOSPoolEP 2026-08-15T00:39:57Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-15T00:39:57.8202908Z TestOSPoolEP 2026-08-15T00:39:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:39:57.8223417Z TestOSPoolEP 2026-08-15T00:39:57Z logger.go:67: Pod is now available2026-08-15T00:39:57.8225708Z TestOSPoolEP 2026-08-15T00:39:57Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-15T00:39:58.4076783Z TestOSPoolEP 2026-08-15T00:39:58Z logger.go:67: ***2026-08-15T00:39:58.4143745Z TestOSPoolEP 2026-08-15T00:39:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz apply -f /tmp/TestOSPoolEP1946293917]2026-08-15T00:39:58.6094787Z TestOSPoolEP 2026-08-15T00:39:58Z logger.go:67: secret/pool-token created2026-08-15T00:39:58.6134954Z TestOSPoolEP 2026-08-15T00:39:58Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-15T00:39:58.6136048Z TestOSPoolEP 2026-08-15T00:39:58Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:39:58.6154319Z TestOSPoolEP 2026-08-15T00:39:58Z logger.go:67: Secret is now available2026-08-15T00:39:58.6186002Z TestOSPoolEP 2026-08-15T00:39:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz apply -k /tmp/kustomize-template-1784159070]2026-08-15T00:39:59.0056909Z TestOSPoolEP 2026-08-15T00:39:59Z logger.go:67: serviceaccount/cvmfs-nodeplugin created2026-08-15T00:39:59.0148248Z TestOSPoolEP 2026-08-15T00:39:59Z logger.go:67: service/frontier-squid created2026-08-15T00:39:59.0240402Z TestOSPoolEP 2026-08-15T00:39:59Z logger.go:67: service/test-cm created2026-08-15T00:39:59.0313718Z TestOSPoolEP 2026-08-15T00:39:59Z logger.go:67: deployment.apps/cvmfs-nodeplugin created2026-08-15T00:39:59.0401424Z TestOSPoolEP 2026-08-15T00:39:59Z logger.go:67: deployment.apps/frontier-squid created2026-08-15T00:39:59.0579426Z TestOSPoolEP 2026-08-15T00:39:59Z logger.go:67: Warning: spec.template.spec.containers[0].env[6]: hides previous definition of "OSG_SQUID_LOCATION", which may be dropped when using apply2026-08-15T00:39:59.0586118Z TestOSPoolEP 2026-08-15T00:39:59Z logger.go:67: deployment.apps/ospool-ep created2026-08-15T00:39:59.0807199Z TestOSPoolEP 2026-08-15T00:39:59Z logger.go:67: deployment.apps/test-cm created2026-08-15T00:39:59.0875623Z === RUN   TestOSPoolEP/Confirm_deployments_become_ready.2026-08-15T00:39:59.0880221Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:39:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:39:59.0972446Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:39:59Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-08-15T00:39:59.0978210Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:39:59Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-15T00:39:59.0982883Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:39:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:39:59.0985654Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:39:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:39:59.0987719Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:39:59Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-15T00:39:59.0990214Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:39:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:39:59.0992457Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:39:59Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-08-15T00:39:59.0994619Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:39:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:39:59.1063791Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:39:59Z retry.go:103: Wait for deployment frontier-squid to be provisioned. returned an error: Deployment frontier-squid is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "frontier-squid-765494655" is progressing.. Sleeping for 10s and will try again.2026-08-15T00:39:59.1106327Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:39:59Z retry.go:103: Wait for deployment cvmfs-nodeplugin to be provisioned. returned an error: Deployment cvmfs-nodeplugin is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "cvmfs-nodeplugin-6b55bb5648" is progressing.. Sleeping for 10s and will try again.2026-08-15T00:39:59.1113661Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:39:59Z 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-5c56576469". Sleeping for 10s and will try again.2026-08-15T00:39:59.1166275Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:39:59Z 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-15T00:40:09.1073943Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:09Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-08-15T00:40:09.1102121Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:09.1120395Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:09Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-08-15T00:40:09.1126327Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:09.1142170Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:09Z retry.go:103: Wait for deployment frontier-squid to be provisioned. returned an error: Deployment frontier-squid is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "frontier-squid-765494655" is progressing.. Sleeping for 10s and will try again.2026-08-15T00:40:09.1150718Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:09Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-15T00:40:09.1153854Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:09.1163863Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:09Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-15T00:40:09.1166779Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:09.1213139Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:09Z logger.go:67: Deployment is now available2026-08-15T00:40:09.1219400Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:09Z 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-5c56576469" is progressing.. Sleeping for 10s and will try again.2026-08-15T00:40:09.1232341Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:09Z 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: ReplicaSetUpdated, message: ReplicaSet "test-cm-5bb545475c" is progressing.. Sleeping for 10s and will try again.2026-08-15T00:40:19.1142108Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:19Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-08-15T00:40:19.1144115Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:19.1182384Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:19Z retry.go:103: Wait for deployment frontier-squid to be provisioned. returned an error: Deployment frontier-squid is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "frontier-squid-765494655" is progressing.. Sleeping for 10s and will try again.2026-08-15T00:40:19.1219204Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:19Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-15T00:40:19.1223430Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:19.1234222Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:19Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-15T00:40:19.1237399Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:19.1278811Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:19Z 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: ReplicaSetUpdated, message: ReplicaSet "test-cm-5bb545475c" is progressing.. Sleeping for 10s and will try again.2026-08-15T00:40:19.1282722Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:19Z 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-5c56576469" is progressing.. Sleeping for 10s and will try again.2026-08-15T00:40:29.1181849Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:29Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-08-15T00:40:29.1183080Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:29.1202937Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:29Z logger.go:67: Deployment is now available2026-08-15T00:40:29.1288793Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:29Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-15T00:40:29.1290848Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:29.1292695Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:29Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-15T00:40:29.1294747Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:29.1305661Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:29Z logger.go:67: Deployment is now available2026-08-15T00:40:29.1308840Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:29Z 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-5c56576469" is progressing.. Sleeping for 10s and will try again.2026-08-15T00:40:39.1321128Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:39Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-15T00:40:39.1323141Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:39.1355554Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:39Z 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-5c56576469" is progressing.. Sleeping for 10s and will try again.2026-08-15T00:40:49.1366287Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:49Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-15T00:40:49.1367661Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:49.1393726Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-15T00:40:49Z logger.go:67: Deployment is now available2026-08-15T00:40:49.1404663Z === RUN   TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-15T00:40:49.1405643Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-15T00:40:49.1406643Z === RUN   TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-15T00:40:49.1407742Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-15T00:40:49.1408986Z === RUN   TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-15T00:40:49.1409771Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-15T00:40:49.1410549Z === CONT  TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-15T00:40:49.1411329Z === CONT  TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-15T00:40:49.1412403Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-15T00:40:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:49.1413851Z === CONT  TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-15T00:40:49.1415170Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-15T00:40:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:49.1417404Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:40:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:49.1456081Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-15T00:40:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:49.1461225Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:40:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:49.1482784Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-15T00:40:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:40:49.1486044Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-15T00:40:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz exec test-cm-5bb545475c-h6std -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_SINGULARITY]2026-08-15T00:40:49.1500528Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-15T00:40:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz exec test-cm-5bb545475c-h6std -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)']2026-08-15T00:40:49.1534316Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:40:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz exec test-cm-5bb545475c-h6std -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-15T00:40:49.5556372Z === NAME  TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-15T00:40:49.5559782Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)']' in pod test-cm-5bb545475c-h6std failed. Retrying in 10s.2026-08-15T00:40:49.5608283Z === NAME  TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-15T00:40:49.5611335Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-h6std failed. Retrying in 10s.2026-08-15T00:40:49.5714580Z === NAME  TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-15T00:40:49.5716364Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-h6std failed. Retrying in 30s.2026-08-15T00:40:59.5574106Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-15T00:40:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz exec test-cm-5bb545475c-h6std -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)']2026-08-15T00:40:59.5621379Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-15T00:40:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz exec test-cm-5bb545475c-h6std -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_SINGULARITY]2026-08-15T00:40:59.8272580Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-15T00:40:59Z logger.go:67: Name                                                    OpSys      Arch     State     Activity LoadAv Mem     ActvtyTime2026-08-15T00:40:59.8274224Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-15T00:40:59Z logger.go:67: 2026-08-15T00:40:59.8277583Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-15T00:40:59Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-5c56576469-l579n LINUX      X86_64   Unclaimed Idle      0.000  15988  0+00:00:002026-08-15T00:40:59.8280014Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-15T00:40:59Z logger.go:67: 2026-08-15T00:40:59.8282008Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-15T00:40:59Z logger.go:67:                Total Owner Claimed Unclaimed Matched Preempting  Drain Backfill BkIdle2026-08-15T00:40:59.8284015Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-15T00:40:59Z logger.go:67: 2026-08-15T00:40:59.8285526Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-15T00:40:59Z logger.go:67:   X86_64/LINUX     1     0       0         1       0          0      0        0      02026-08-15T00:40:59.8288094Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-15T00:40:59Z logger.go:67: 2026-08-15T00:40:59.8290386Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-15T00:40:59Z logger.go:67:          Total     1     0       0         1       0          0      0        0      02026-08-15T00:40:59.8394867Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-15T00:40:59Z logger.go:67: true2026-08-15T00:41:19.5729848Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:41:19Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz exec test-cm-5bb545475c-h6std -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-15T00:41:19.7670916Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:41:19Z logger.go:67: undefined2026-08-15T00:41:19.7748182Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-h6std failed. Retrying in 30s.2026-08-15T00:41:49.7753783Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:41:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz exec test-cm-5bb545475c-h6std -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-15T00:41:50.0025581Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:41:50Z logger.go:67: undefined2026-08-15T00:41:50.0099123Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-h6std failed. Retrying in 30s.2026-08-15T00:42:20.0110554Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:42:20Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz exec test-cm-5bb545475c-h6std -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-15T00:42:20.1668546Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:42:20Z logger.go:67: undefined2026-08-15T00:42:20.1736118Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-h6std failed. Retrying in 30s.2026-08-15T00:42:50.1741676Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:42:50Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz exec test-cm-5bb545475c-h6std -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-15T00:42:50.3287447Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:42:50Z logger.go:67: undefined2026-08-15T00:42:50.3354719Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-h6std failed. Retrying in 30s.2026-08-15T00:43:20.3383240Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:43:20Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz exec test-cm-5bb545475c-h6std -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-15T00:43:20.4948777Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:43:20Z logger.go:67: undefined2026-08-15T00:43:20.5015991Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-h6std failed. Retrying in 30s.2026-08-15T00:43:50.5047178Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:43:50Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz exec test-cm-5bb545475c-h6std -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-15T00:43:50.6671493Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:43:50Z logger.go:67: undefined2026-08-15T00:43:50.6738922Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-h6std failed. Retrying in 30s.2026-08-15T00:44:20.6774322Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:44:20Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz exec test-cm-5bb545475c-h6std -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-15T00:44:20.8771865Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:44:20Z logger.go:67: undefined2026-08-15T00:44:20.8844454Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-h6std failed. Retrying in 30s.2026-08-15T00:44:50.8851336Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:44:50Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz exec test-cm-5bb545475c-h6std -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-15T00:44:51.0508236Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:44:51Z logger.go:67: undefined2026-08-15T00:44:51.0576850Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-h6std failed. Retrying in 30s.2026-08-15T00:45:21.0603190Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:45:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz exec test-cm-5bb545475c-h6std -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-15T00:45:21.2153094Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:45:21Z logger.go:67: undefined2026-08-15T00:45:21.2227259Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-h6std failed. Retrying in 30s.2026-08-15T00:45:51.2262349Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:45:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz exec test-cm-5bb545475c-h6std -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-15T00:45:51.3813003Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:45:51Z logger.go:67: undefined2026-08-15T00:45:51.3882301Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-h6std failed. Retrying in 30s.2026-08-15T00:46:21.3897115Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:46:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz exec test-cm-5bb545475c-h6std -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-15T00:46:21.5446396Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-15T00:46:21Z logger.go:67: false2026-08-15T00:46:21.5514582Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-h6std failed. Retrying in 30s.2026-08-15T00:46:51.5519294Z     test_utils.go:105: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-l579n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-h6std did not succeed within {12 30000000000} retries2026-08-15T00:46:51.5523959Z TestOSPoolEP 2026-08-15T00:46:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:46:51.5599427Z TestOSPoolEP 2026-08-15T00:46:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:46:51.8145988Z TestOSPoolEP 2026-08-15T00:46:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:46:51.9234183Z TestOSPoolEP 2026-08-15T00:46:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:46:52.0338252Z TestOSPoolEP 2026-08-15T00:46:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:46:52.1907776Z TestOSPoolEP 2026-08-15T00:46:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:46:52.3031285Z TestOSPoolEP 2026-08-15T00:46:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:46:52.3146032Z === NAME  TestOSPoolEP2026-08-15T00:46:52.3146545Z     ospool_ep_test.go:101: ---2026-08-15T00:46:52.3147250Z         Events for pod cvmfs-nodeplugin-6b55bb5648-tvf5j:2026-08-15T00:46:52.3148819Z         2026-08-15 00:39:59 +0000 UTC	Normal	Successfully assigned test-ospool-ep-twimkz/cvmfs-nodeplugin-6b55bb5648-tvf5j to minikube2026-08-15T00:46:52.3150255Z         2026-08-15 00:39:59 +0000 UTC	Normal	Pulling image "opensciencegrid/cvmfs-nodeplugin:fresh"2026-08-15T00:46:52.3152507Z         2026-08-15 00:40:07 +0000 UTC	Normal	Successfully pulled image "opensciencegrid/cvmfs-nodeplugin:fresh" in 7.998s (7.998s including waiting). Image size: 431389691 bytes.2026-08-15T00:46:52.3153950Z         2026-08-15 00:40:07 +0000 UTC	Normal	Container created2026-08-15T00:46:52.3154555Z         2026-08-15 00:40:07 +0000 UTC	Normal	Container started2026-08-15T00:46:52.3154959Z         2026-08-15T00:46:52.3155210Z         ---2026-08-15T00:46:52.3155902Z TestOSPoolEP 2026-08-15T00:46:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:46:52.3172628Z     ospool_ep_test.go:101: ---2026-08-15T00:46:52.3173394Z         Events for pod frontier-squid-765494655-bb92c:2026-08-15T00:46:52.3174278Z         2026-08-15 00:39:59 +0000 UTC	Normal	Successfully assigned test-ospool-ep-twimkz/frontier-squid-765494655-bb92c to minikube2026-08-15T00:46:52.3175636Z         2026-08-15 00:39:59 +0000 UTC	Normal	Pulling image "opensciencegrid/frontier-squid:fresh"2026-08-15T00:46:52.3177009Z         2026-08-15 00:40:24 +0000 UTC	Normal	Successfully pulled image "opensciencegrid/frontier-squid:fresh" in 16.972s (24.96s including waiting). Image size: 970524479 bytes.2026-08-15T00:46:52.3178071Z         2026-08-15 00:40:24 +0000 UTC	Normal	Container created2026-08-15T00:46:52.3179034Z         2026-08-15 00:40:24 +0000 UTC	Normal	Container started2026-08-15T00:46:52.3179442Z         2026-08-15T00:46:52.3179699Z         ---2026-08-15T00:46:52.3180277Z TestOSPoolEP 2026-08-15T00:46:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:46:52.3199008Z     ospool_ep_test.go:101: ---2026-08-15T00:46:52.3199738Z         Events for pod idtoken-generator:2026-08-15T00:46:52.3201184Z         2026-08-15 00:39:37 +0000 UTC	Normal	Successfully assigned test-ospool-ep-twimkz/idtoken-generator to minikube2026-08-15T00:46:52.3202959Z         2026-08-15 00:39:40 +0000 UTC	Normal	Pulling image "htcondor/base"2026-08-15T00:46:52.3204761Z         2026-08-15 00:39:49 +0000 UTC	Normal	Successfully pulled image "htcondor/base" in 8.989s (8.989s including waiting). Image size: 560910730 bytes.2026-08-15T00:46:52.3205973Z         2026-08-15 00:39:49 +0000 UTC	Normal	Container created2026-08-15T00:46:52.3206482Z         2026-08-15 00:39:50 +0000 UTC	Normal	Container started2026-08-15T00:46:52.3206969Z         2026-08-15T00:46:52.3207197Z         ---2026-08-15T00:46:52.3207783Z TestOSPoolEP 2026-08-15T00:46:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:46:52.3224424Z     ospool_ep_test.go:101: ---2026-08-15T00:46:52.3225370Z         Events for pod ospool-ep-5c56576469-l579n:2026-08-15T00:46:52.3226535Z         2026-08-15 00:39:59 +0000 UTC	Normal	Successfully assigned test-ospool-ep-twimkz/ospool-ep-5c56576469-l579n to minikube2026-08-15T00:46:52.3227477Z         2026-08-15 00:39:59 +0000 UTC	Normal	Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-15T00:46:52.3229035Z         2026-08-15 00:40:27 +0000 UTC	Normal	Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 2.457s (27.386s including waiting). Image size: 5590942 bytes.2026-08-15T00:46:52.3229922Z         2026-08-15 00:40:27 +0000 UTC	Normal	Container created2026-08-15T00:46:52.3230528Z         2026-08-15 00:40:27 +0000 UTC	Normal	Container started2026-08-15T00:46:52.3231645Z         2026-08-15 00:40:27 +0000 UTC	Normal	Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-08-15T00:46:52.3234321Z         2026-08-15 00:40:44 +0000 UTC	Normal	Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 16.698s (17.1s including waiting). Image size: 1273054585 bytes.2026-08-15T00:46:52.3235965Z         2026-08-15 00:40:44 +0000 UTC	Normal	Container created2026-08-15T00:46:52.3236634Z         2026-08-15 00:40:45 +0000 UTC	Normal	Container started2026-08-15T00:46:52.3237093Z         2026-08-15T00:46:52.3237443Z         ---2026-08-15T00:46:52.3238104Z TestOSPoolEP 2026-08-15T00:46:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:46:52.3257432Z     ospool_ep_test.go:101: ---2026-08-15T00:46:52.3273967Z         Events for pod test-cm-5bb545475c-h6std:2026-08-15T00:46:52.3276467Z         2026-08-15 00:39:59 +0000 UTC	Normal	Successfully assigned test-ospool-ep-twimkz/test-cm-5bb545475c-h6std to minikube2026-08-15T00:46:52.3277989Z         2026-08-15 00:39:59 +0000 UTC	Normal	Pulling image "htcondor/cm:25.x-el9"2026-08-15T00:46:52.3280954Z         2026-08-15 00:40:28 +0000 UTC	Normal	Successfully pulled image "htcondor/cm:25.x-el9" in 1.111s (28.497s including waiting). Image size: 560910756 bytes.2026-08-15T00:46:52.3282410Z         2026-08-15 00:40:28 +0000 UTC	Normal	Container created2026-08-15T00:46:52.3283252Z         2026-08-15 00:40:28 +0000 UTC	Normal	Container started2026-08-15T00:46:52.3283699Z         2026-08-15T00:46:52.3284004Z         ---2026-08-15T00:46:52.3284582Z TestOSPoolEP 2026-08-15T00:46:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-15T00:46:52.3313172Z TestOSPoolEP 2026-08-15T00:46:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz delete -f /tmp/TestOSPoolEP11093125]2026-08-15T00:46:52.4356810Z TestOSPoolEP 2026-08-15T00:46:52Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-twimkz namespace2026-08-15T00:46:52.4396961Z TestOSPoolEP 2026-08-15T00:46:52Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-twimkz namespace2026-08-15T00:46:53.4433269Z TestOSPoolEP 2026-08-15T00:46:53Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz delete -f /tmp/TestOSPoolEP2347483959]2026-08-15T00:46:53.5383673Z TestOSPoolEP 2026-08-15T00:46:53Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-twimkz namespace2026-08-15T00:46:53.5435078Z TestOSPoolEP 2026-08-15T00:46:53Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-twimkz delete -k /tmp/kustomize-template-1784159070]2026-08-15T00:46:53.6607898Z TestOSPoolEP 2026-08-15T00:46:53Z logger.go:67: serviceaccount "cvmfs-nodeplugin" deleted from test-ospool-ep-twimkz namespace2026-08-15T00:46:53.6696397Z TestOSPoolEP 2026-08-15T00:46:53Z logger.go:67: service "frontier-squid" deleted from test-ospool-ep-twimkz namespace2026-08-15T00:46:53.6801573Z TestOSPoolEP 2026-08-15T00:46:53Z logger.go:67: service "test-cm" deleted from test-ospool-ep-twimkz namespace2026-08-15T00:46:53.6849870Z TestOSPoolEP 2026-08-15T00:46:53Z logger.go:67: deployment.apps "cvmfs-nodeplugin" deleted from test-ospool-ep-twimkz namespace2026-08-15T00:46:53.6897332Z TestOSPoolEP 2026-08-15T00:46:53Z logger.go:67: deployment.apps "frontier-squid" deleted from test-ospool-ep-twimkz namespace2026-08-15T00:46:53.6948676Z TestOSPoolEP 2026-08-15T00:46:53Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-twimkz namespace2026-08-15T00:46:53.6997213Z TestOSPoolEP 2026-08-15T00:46:53Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-twimkz namespace2026-08-15T00:46:53.7275132Z --- FAIL: TestOSPoolEP (74.09s)2026-08-15T00:46:53.7276332Z     --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (50.05s)2026-08-15T00:46:53.7277621Z     --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (10.69s)2026-08-15T00:46:53.7279015Z     --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (10.71s)2026-08-15T00:46:53.7280146Z     --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (362.41s)2026-08-15T00:46:53.7280840Z FAIL2026-08-15T00:46:53.7325058Z FAIL	github.com/osg-htc/k8s-integration-tests/test	436.515s2026-08-15T00:46:53.7460293Z FAIL2026-08-15T00:46:53.8740705Z ##[error]Process completed with exit code 1.2026-08-15T00:46:53.8821289Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-15T00:46:53.8822402Z echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-15T00:46:53.8924155Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-15T00:46:53.8924783Z env:2026-08-15T00:46:53.8925154Z   GOTOOLCHAIN: local2026-08-15T00:46:53.8925943Z   TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-08-15T00:46:53.8926792Z ##[endgroup]2026-08-15T00:46:53.9322336Z 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-15T00:46:53.9325085Z ##[group]Run actions/upload-artifact@v42026-08-15T00:46:53.9325582Z with:2026-08-15T00:46:53.9326431Z   name: TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd72026-08-15T00:46:53.9331237Z   path: /tmp/k8s-tests2026-08-15T00:46:53.9331676Z   retention-days: 52026-08-15T00:46:53.9332082Z   if-no-files-found: warn2026-08-15T00:46:53.9332500Z   compression-level: 62026-08-15T00:46:53.9332913Z   overwrite: false2026-08-15T00:46:53.9333331Z   include-hidden-files: false2026-08-15T00:46:53.9333780Z env:2026-08-15T00:46:53.9334134Z   GOTOOLCHAIN: local2026-08-15T00:46:53.9334517Z ##[endgroup]2026-08-15T00:46:54.1878002Z (node:19826) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-15T00:46:54.1880027Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-15T00:46:54.2100921Z With the provided path, there will be 10 files uploaded2026-08-15T00:46:54.2102316Z Artifact name is valid!2026-08-15T00:46:54.2102805Z Root directory input is valid!2026-08-15T00:46:54.5347911Z Beginning upload of artifact content to blob storage2026-08-15T00:46:54.5719805Z (node:19826) [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-15T00:46:54.9245518Z Uploaded bytes 159842026-08-15T00:46:55.0038644Z Finished uploading artifact content to blob storage!2026-08-15T00:46:55.0040100Z SHA256 digest of uploaded artifact zip is b56743fcccb04dbda8f61c2bd44567e70bef9dfc6f39aae0d984c67a09457e2f2026-08-15T00:46:55.0043576Z Finalizing artifact upload2026-08-15T00:46:55.2422796Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7.zip successfully finalized. Artifact ID 92386334082026-08-15T00:46:55.2425595Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7 has been successfully uploaded! Final size is 15984 bytes. Artifact ID is 92386334082026-08-15T00:46:55.2431421Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/31854176039/artifacts/92386334082026-08-15T00:46:55.2636425Z Post job cleanup.2026-08-15T00:46:55.3595542Z [command]/usr/bin/git version2026-08-15T00:46:55.3643763Z git version 2.54.02026-08-15T00:46:55.3690238Z Temporarily overriding HOME='/home/runner/work/_temp/72db0008-73f2-41c8-8b16-e08e46d7e77c' before making global git config changes2026-08-15T00:46:55.3692141Z Adding repository directory to the temporary git global config as a safe directory2026-08-15T00:46:55.3696987Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-15T00:46:55.3745308Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-15T00:46:55.3787965Z [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-15T00:46:55.4105410Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-15T00:46:55.4135157Z http.https://github.com/.extraheader2026-08-15T00:46:55.4147523Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-15T00:46:55.4188177Z [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-15T00:46:55.4641307Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-15T00:46:55.4793262Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-15T00:46:55.5295453Z Cleaning up orphan processes2026-08-15T00:46:55.6470228Z ##[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/