2026-08-12T01:02:36.9634966Z Current runner version: '2.336.0'2026-08-12T01:02:36.9668955Z ##[group]Runner Image Provisioner2026-08-12T01:02:36.9670515Z Hosted Compute Agent2026-08-12T01:02:36.9671528Z Version: 20260707.5632026-08-12T01:02:36.9672553Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-08-12T01:02:36.9673691Z Build Date: 2026-07-07T19:33:50Z2026-08-12T01:02:36.9674977Z Worker ID: {a8664efd-85ca-4b1b-99bc-1f7ba1e0d557}2026-08-12T01:02:36.9676114Z Azure Region: centralus2026-08-12T01:02:36.9676980Z ##[endgroup]2026-08-12T01:02:36.9679497Z ##[group]Operating System2026-08-12T01:02:36.9680508Z Ubuntu2026-08-12T01:02:36.9681477Z 22.04.52026-08-12T01:02:36.9682325Z LTS2026-08-12T01:02:36.9683118Z ##[endgroup]2026-08-12T01:02:36.9683994Z ##[group]Runner Image2026-08-12T01:02:36.9684915Z Image: ubuntu-22.042026-08-12T01:02:36.9685900Z Version: 20260720.234.22026-08-12T01:02:36.9687926Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-08-12T01:02:36.9690748Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-08-12T01:02:36.9692286Z ##[endgroup]2026-08-12T01:02:36.9694278Z ##[group]GITHUB_TOKEN Permissions2026-08-12T01:02:36.9697167Z Contents: read2026-08-12T01:02:36.9698064Z Metadata: read2026-08-12T01:02:36.9699093Z Packages: read2026-08-12T01:02:36.9700300Z ##[endgroup]2026-08-12T01:02:36.9703630Z Secret source: Actions2026-08-12T01:02:36.9705815Z Prepare workflow directory2026-08-12T01:02:37.0084419Z Prepare all required actions2026-08-12T01:02:37.0141755Z Getting action download info2026-08-12T01:02:37.2549049Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-12T01:02:37.6439208Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-12T01:02:37.9579752Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-12T01:02:38.3427529Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-12T01:02:38.6065964Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-12T01:02:38.6072571Z ##[group] Inputs2026-08-12T01:02:38.6073565Z testName: TestOSPoolEP2026-08-12T01:02:38.6075308Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-12T01:02:38.6077254Z setupScript: 2026-08-12T01:02:38.6078135Z setupEnv: {}2026-08-12T01:02:38.6078997Z ##[endgroup]2026-08-12T01:02:38.6080540Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-08-12T01:02:38.7015068Z ##[group]Run actions/checkout@v52026-08-12T01:02:38.7016383Z with:2026-08-12T01:02:38.7017274Z repository: mwestphall/k8s-integration-tests2026-08-12T01:02:38.7025757Z token: ***2026-08-12T01:02:38.7026930Z ssh-strict: true2026-08-12T01:02:38.7027796Z ssh-user: git2026-08-12T01:02:38.7028630Z persist-credentials: true2026-08-12T01:02:38.7029814Z clean: true2026-08-12T01:02:38.7030647Z sparse-checkout-cone-mode: true2026-08-12T01:02:38.7031642Z fetch-depth: 12026-08-12T01:02:38.7032449Z fetch-tags: false2026-08-12T01:02:38.7033280Z show-progress: true2026-08-12T01:02:38.7034105Z lfs: false2026-08-12T01:02:38.7034881Z submodules: false2026-08-12T01:02:38.7035714Z set-safe-directory: true2026-08-12T01:02:38.7036656Z allow-unsafe-pr-checkout: false2026-08-12T01:02:38.7037979Z ##[endgroup]2026-08-12T01:02:38.8133961Z Syncing repository: mwestphall/k8s-integration-tests2026-08-12T01:02:38.8136879Z ##[group]Getting Git version info2026-08-12T01:02:38.8138659Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-12T01:02:38.8141171Z [command]/usr/bin/git version2026-08-12T01:02:38.8175238Z git version 2.54.02026-08-12T01:02:38.8199891Z ##[endgroup]2026-08-12T01:02:38.8216869Z Temporarily overriding HOME='/home/runner/work/_temp/f995acae-11ad-453d-9c7b-445bb50419d0' before making global git config changes2026-08-12T01:02:38.8221350Z Adding repository directory to the temporary git global config as a safe directory2026-08-12T01:02:38.8225458Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-12T01:02:38.8275391Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-12T01:02:38.8281054Z ##[group]Initializing the repository2026-08-12T01:02:38.8287387Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-12T01:02:38.8378820Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-12T01:02:38.8382199Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-12T01:02:38.8385404Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-12T01:02:38.8388116Z hint: call:2026-08-12T01:02:38.8390143Z hint:2026-08-12T01:02:38.8391809Z hint: git config --global init.defaultBranch <name>2026-08-12T01:02:38.8393855Z hint:2026-08-12T01:02:38.8395735Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-12T01:02:38.8398707Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-12T01:02:38.8401370Z hint:2026-08-12T01:02:38.8402760Z hint: git branch -m <name>2026-08-12T01:02:38.8404575Z hint:2026-08-12T01:02:38.8406598Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-12T01:02:38.8410470Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-12T01:02:38.8416743Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-12T01:02:38.8433145Z ##[endgroup]2026-08-12T01:02:38.8435248Z ##[group]Disabling automatic garbage collection2026-08-12T01:02:38.8437261Z [command]/usr/bin/git config --local gc.auto 02026-08-12T01:02:38.8473641Z ##[endgroup]2026-08-12T01:02:38.8475706Z ##[group]Setting up auth2026-08-12T01:02:38.8480001Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-12T01:02:38.8519006Z [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-12T01:02:38.8875753Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-12T01:02:38.8918504Z [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-12T01:02:38.9199057Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-12T01:02:38.9238261Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-12T01:02:38.9518860Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-12T01:02:38.9561259Z ##[endgroup]2026-08-12T01:02:38.9562653Z ##[group]Fetching the repository2026-08-12T01:02:38.9571622Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-12T01:02:39.3507569Z From https://github.com/mwestphall/k8s-integration-tests2026-08-12T01:02:39.3510523Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-12T01:02:39.3536255Z ##[endgroup]2026-08-12T01:02:39.3537984Z ##[group]Determining the checkout info2026-08-12T01:02:39.3540005Z ##[endgroup]2026-08-12T01:02:39.3544165Z [command]/usr/bin/git sparse-checkout disable2026-08-12T01:02:39.3592120Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-12T01:02:39.3643468Z ##[group]Checking out the ref2026-08-12T01:02:39.3645566Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-12T01:02:39.3726942Z Switched to a new branch 'main'2026-08-12T01:02:39.3729881Z branch 'main' set up to track 'origin/main'.2026-08-12T01:02:39.3736802Z ##[endgroup]2026-08-12T01:02:39.3779743Z [command]/usr/bin/git log -1 --format=%H2026-08-12T01:02:39.3812133Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-12T01:02:39.4185295Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-12T01:02:39.4187906Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-12T01:02:39.4190564Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-12T01:02:39.4308385Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-12T01:02:39.4310174Z env:2026-08-12T01:02:39.4311667Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-12T01:02:39.4313970Z SETUP_ENV_YAML: {}2026-08-12T01:02:39.4314805Z ##[endgroup]2026-08-12T01:02:39.8455755Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-12T01:02:39.8456553Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-12T01:02:39.8520905Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-12T01:02:39.8521344Z env:2026-08-12T01:02:39.8521904Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-12T01:02:39.8522535Z ##[endgroup]2026-08-12T01:02:39.8677450Z ##[group]Run true2026-08-12T01:02:39.8677802Z [36;1mtrue[0m2026-08-12T01:02:39.8743301Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-12T01:02:39.8743786Z ##[endgroup]2026-08-12T01:02:39.8931557Z ##[group]Run medyagh/setup-minikube@latest2026-08-12T01:02:39.8931987Z with:2026-08-12T01:02:39.8932288Z start: true2026-08-12T01:02:39.8932591Z cache: true2026-08-12T01:02:39.8932906Z minikube-version: latest2026-08-12T01:02:39.8933249Z wait: all2026-08-12T01:02:39.8933546Z ##[endgroup]2026-08-12T01:02:40.0222288Z (node:2047) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-12T01:02:40.0223338Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-12T01:02:40.8594328Z [command]/usr/bin/chmod +x /home/runner/work/_temp/623ac5be-0c79-464f-bbcf-49131396d0a32026-08-12T01:02:41.0189611Z [command]/home/runner/bin/minikube version --short2026-08-12T01:02:41.0590197Z v1.38.12026-08-12T01:02:41.2149180Z Cache hit for: kic-v1.38.1-x642026-08-12T01:02:41.2265861Z (node:2047) [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-12T01:02:41.2273740Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-12T01:02:42.3416534Z Received 50331648 of 544082657 (9.3%), 48.0 MBs/sec2026-08-12T01:02:42.3618895Z Received 20971520 of 224218863 (9.4%), 20.0 MBs/sec2026-08-12T01:02:43.3414313Z Received 113246208 of 544082657 (20.8%), 54.0 MBs/sec2026-08-12T01:02:43.3615871Z Received 62914560 of 224218863 (28.1%), 30.0 MBs/sec2026-08-12T01:02:44.3419927Z Received 113246208 of 544082657 (20.8%), 36.0 MBs/sec2026-08-12T01:02:44.3632031Z Received 104857600 of 224218863 (46.8%), 33.3 MBs/sec2026-08-12T01:02:45.3424935Z Received 113246208 of 544082657 (20.8%), 27.0 MBs/sec2026-08-12T01:02:45.3636742Z Received 104857600 of 224218863 (46.8%), 25.0 MBs/sec2026-08-12T01:02:46.3429770Z Received 113246208 of 544082657 (20.8%), 21.6 MBs/sec2026-08-12T01:02:46.3641576Z Received 104857600 of 224218863 (46.8%), 20.0 MBs/sec2026-08-12T01:02:47.3461300Z Received 180355072 of 544082657 (33.1%), 28.7 MBs/sec2026-08-12T01:02:47.3649878Z Received 167772160 of 224218863 (74.8%), 26.7 MBs/sec2026-08-12T01:02:47.7546817Z Received 224218863 of 224218863 (100.0%), 33.4 MBs/sec2026-08-12T01:02:47.7547851Z Cache Size: ~214 MB (224218863 B)2026-08-12T01:02:47.8709217Z [command]/usr/bin/tar -xf /home/runner/work/_temp/01396a8c-6987-4b1e-9065-e95c6baab567/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-12T01:02:48.3566318Z Received 373293056 of 544082657 (68.6%), 50.8 MBs/sec2026-08-12T01:02:48.4852470Z Cache restored successfully2026-08-12T01:02:49.3490039Z Received 536870912 of 544082657 (98.7%), 63.9 MBs/sec2026-08-12T01:02:49.4185475Z Received 544082657 of 544082657 (100.0%), 64.2 MBs/sec2026-08-12T01:02:49.4186089Z Cache Size: ~519 MB (544082657 B)2026-08-12T01:02:49.4308832Z [command]/usr/bin/tar -xf /home/runner/work/_temp/d90dd6e1-fba1-43cf-a282-cb770b70ab62/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-12T01:02:50.2896956Z Cache restored successfully2026-08-12T01:02:50.4115183Z [command]/home/runner/bin/minikube start --wait all2026-08-12T01:02:50.4519877Z * minikube v1.38.1 on Ubuntu 22.042026-08-12T01:02:50.8801658Z ! 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-12T01:02:50.8807985Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-12T01:02:50.9355487Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-12T01:02:50.9364276Z * Using Docker driver with root privileges2026-08-12T01:02:50.9373899Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-12T01:02:50.9380682Z * Pulling base image v0.0.50 ...2026-08-12T01:03:24.1801150Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-12T01:03:29.3685006Z * Verifying Kubernetes components...2026-08-12T01:03:29.3919807Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-12T01:03:30.1207029Z * Enabled addons: default-storageclass, storage-provisioner2026-08-12T01:04:16.9966535Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-12T01:04:17.0051415Z [command]/home/runner/bin/minikube version --short2026-08-12T01:04:17.0430269Z v1.38.12026-08-12T01:04:17.0747245Z ##[group]Run actions/setup-go@v62026-08-12T01:04:17.0747531Z with:2026-08-12T01:04:17.0747732Z go-version: 1.262026-08-12T01:04:17.0747950Z cache: true2026-08-12T01:04:17.0748174Z cache-dependency-path: go.sum2026-08-12T01:04:17.0748434Z check-latest: false2026-08-12T01:04:17.0751122Z token: ***2026-08-12T01:04:17.0751340Z ##[endgroup]2026-08-12T01:04:17.2068254Z Setup go version spec 1.262026-08-12T01:04:17.2125001Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-12T01:04:17.2127908Z Added go to the path2026-08-12T01:04:17.2131933Z Successfully set up Go version 1.262026-08-12T01:04:17.7103888Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-12T01:04:17.7140154Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-12T01:04:17.7170376Z /home/runner/go/pkg/mod2026-08-12T01:04:17.7198640Z /home/runner/.cache/go-build2026-08-12T01:04:17.8483878Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-12T01:04:18.9944345Z Received 104857600 of 251839808 (41.6%), 99.9 MBs/sec2026-08-12T01:04:19.9584084Z Received 251839808 of 251839808 (100.0%), 122.2 MBs/sec2026-08-12T01:04:19.9585684Z Cache Size: ~240 MB (251839808 B)2026-08-12T01:04:19.9650290Z [command]/usr/bin/tar -xf /home/runner/work/_temp/ce37c65d-d6fa-472b-beef-fb54f2c5c83d/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-12T01:04:22.9392330Z Cache restored successfully2026-08-12T01:04:22.9997524Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-12T01:04:23.0036413Z go version go1.26.5 linux/amd642026-08-12T01:04:23.0037036Z 2026-08-12T01:04:23.0037481Z ##[group]go env2026-08-12T01:04:23.0628489Z AR='ar'2026-08-12T01:04:23.0628869Z CC='gcc'2026-08-12T01:04:23.0629178Z CGO_CFLAGS='-O2 -g'2026-08-12T01:04:23.0629882Z CGO_CPPFLAGS=''2026-08-12T01:04:23.0630247Z CGO_CXXFLAGS='-O2 -g'2026-08-12T01:04:23.0630596Z CGO_ENABLED='1'2026-08-12T01:04:23.0630933Z CGO_FFLAGS='-O2 -g'2026-08-12T01:04:23.0631272Z CGO_LDFLAGS='-O2 -g'2026-08-12T01:04:23.0631608Z CXX='g++'2026-08-12T01:04:23.0631906Z GCCGO='gccgo'2026-08-12T01:04:23.0632202Z GO111MODULE=''2026-08-12T01:04:23.0632495Z GOAMD64='v1'2026-08-12T01:04:23.0632783Z GOARCH='amd64'2026-08-12T01:04:23.0633115Z GOAUTH='netrc'2026-08-12T01:04:23.0633407Z GOBIN=''2026-08-12T01:04:23.0633743Z GOCACHE='/home/runner/.cache/go-build'2026-08-12T01:04:23.0634176Z GOCACHEPROG=''2026-08-12T01:04:23.0634480Z GODEBUG=''2026-08-12T01:04:23.0634811Z GOENV='/home/runner/.config/go/env'2026-08-12T01:04:23.0635200Z GOEXE=''2026-08-12T01:04:23.0635494Z GOEXPERIMENT=''2026-08-12T01:04:23.0635807Z GOFIPS140='off'2026-08-12T01:04:23.0636124Z GOFLAGS=''2026-08-12T01:04:23.0637154Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build2330650449=/tmp/go-build -gno-record-gcc-switches'2026-08-12T01:04:23.0638170Z GOHOSTARCH='amd64'2026-08-12T01:04:23.0638493Z GOHOSTOS='linux'2026-08-12T01:04:23.0638805Z GOINSECURE=''2026-08-12T01:04:23.0639553Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-12T01:04:23.0640191Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-12T01:04:23.0640598Z GONOPROXY=''2026-08-12T01:04:23.0640903Z GONOSUMDB=''2026-08-12T01:04:23.0641183Z GOOS='linux'2026-08-12T01:04:23.0641490Z GOPATH='/home/runner/go'2026-08-12T01:04:23.0641844Z GOPRIVATE=''2026-08-12T01:04:23.0642233Z GOPROXY='https://proxy.golang.org,direct'2026-08-12T01:04:23.0642745Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-12T01:04:23.0643204Z GOSUMDB='sum.golang.org'2026-08-12T01:04:23.0643560Z GOTELEMETRY='local'2026-08-12T01:04:23.0643970Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-12T01:04:23.0644441Z GOTMPDIR=''2026-08-12T01:04:23.0644737Z GOTOOLCHAIN='local'2026-08-12T01:04:23.0645613Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-12T01:04:23.0646172Z GOVCS=''2026-08-12T01:04:23.0646454Z GOVERSION='go1.26.5'2026-08-12T01:04:23.0646776Z GOWORK=''2026-08-12T01:04:23.0647081Z PKG_CONFIG='pkg-config'2026-08-12T01:04:23.0647305Z 2026-08-12T01:04:23.0647772Z ##[endgroup]2026-08-12T01:04:23.0958180Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-12T01:04:23.0958709Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-12T01:04:23.1019441Z shell: /usr/bin/bash -e {0}2026-08-12T01:04:23.1019717Z env:2026-08-12T01:04:23.1019923Z GOTOOLCHAIN: local2026-08-12T01:04:23.1020176Z OSPOOL_EP_OSPoolEPTag: 25-release2026-08-12T01:04:23.1020455Z OSPOOL_EP_CMTag: 25.0-el92026-08-12T01:04:23.1020714Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-12T01:04:23.1020973Z ##[endgroup]2026-08-12T01:04:30.7381231Z === RUN TestOSPoolEP2026-08-12T01:04:30.7383890Z === PAUSE TestOSPoolEP2026-08-12T01:04:30.7384355Z === CONT TestOSPoolEP2026-08-12T01:04:30.7385389Z TestOSPoolEP 2026-08-12T01:04:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:04:30.7461050Z TestOSPoolEP 2026-08-12T01:04:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 apply -f /tmp/TestOSPoolEP1348963922]2026-08-12T01:04:31.3835118Z TestOSPoolEP 2026-08-12T01:04:31Z logger.go:67: pod/idtoken-generator created2026-08-12T01:04:31.3909064Z TestOSPoolEP 2026-08-12T01:04:31Z logger.go:67: secret/pool-passwd created2026-08-12T01:04:31.3963787Z TestOSPoolEP 2026-08-12T01:04:31Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-12T01:04:31.3968782Z TestOSPoolEP 2026-08-12T01:04:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:04:31.3988176Z TestOSPoolEP 2026-08-12T01:04:31Z 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-12T01:04:41.3994398Z TestOSPoolEP 2026-08-12T01:04:41Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-12T01:04:41.3997562Z TestOSPoolEP 2026-08-12T01:04:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:04:41.4020208Z TestOSPoolEP 2026-08-12T01:04:41Z 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-12T01:04:51.4031439Z TestOSPoolEP 2026-08-12T01:04:51Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-12T01:04:51.4032688Z TestOSPoolEP 2026-08-12T01:04:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:04:51.4058978Z TestOSPoolEP 2026-08-12T01:04:51Z logger.go:67: Pod is now available2026-08-12T01:04:51.4060650Z TestOSPoolEP 2026-08-12T01:04:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-12T01:04:52.3594260Z TestOSPoolEP 2026-08-12T01:04:52Z logger.go:67: ***2026-08-12T01:04:52.3658967Z TestOSPoolEP 2026-08-12T01:04:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 apply -f /tmp/TestOSPoolEP3935130693]2026-08-12T01:04:52.5346683Z TestOSPoolEP 2026-08-12T01:04:52Z logger.go:67: secret/pool-token created2026-08-12T01:04:52.5378879Z TestOSPoolEP 2026-08-12T01:04:52Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-12T01:04:52.5380374Z TestOSPoolEP 2026-08-12T01:04:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:04:52.5399587Z TestOSPoolEP 2026-08-12T01:04:52Z logger.go:67: Secret is now available2026-08-12T01:04:52.5418204Z TestOSPoolEP 2026-08-12T01:04:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 apply -k /tmp/kustomize-template-2502516354]2026-08-12T01:04:52.7973116Z TestOSPoolEP 2026-08-12T01:04:52Z logger.go:67: service/test-cm created2026-08-12T01:04:52.8045543Z TestOSPoolEP 2026-08-12T01:04:52Z 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-12T01:04:52.8048688Z TestOSPoolEP 2026-08-12T01:04:52Z logger.go:67: deployment.apps/ospool-ep created2026-08-12T01:04:52.8174518Z TestOSPoolEP 2026-08-12T01:04:52Z logger.go:67: deployment.apps/test-cm created2026-08-12T01:04:52.8211149Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-12T01:04:52.8215489Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:04:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:04:52.8310509Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:04:52Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-12T01:04:52.8313463Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:04:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:04:52.8316582Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:04:52Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-12T01:04:52.8318629Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:04:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:04:52.8379875Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:04:52Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-6c7d796845". Sleeping for 10s and will try again.2026-08-12T01:04:52.8382775Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:04:52Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "test-cm-54b7d49f85". Sleeping for 10s and will try again.2026-08-12T01:05:02.8394269Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:05:02Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-12T01:05:02.8396041Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:05:02Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:05:02.8400751Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:05:02Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-12T01:05:02.8401835Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:05:02Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:05:02.8419498Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:05:02Z logger.go:67: Deployment is now available2026-08-12T01:05:02.8422493Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:05:02Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-08-12T01:05:12.8433078Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:05:12Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-12T01:05:12.8435692Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:05:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:05:12.8465402Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:05:12Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-08-12T01:05:22.8469008Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:05:22Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-12T01:05:22.8470958Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:05:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:05:22.8500675Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-12T01:05:22Z logger.go:67: Deployment is now available2026-08-12T01:05:22.8503716Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-12T01:05:22.8504719Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-12T01:05:22.8505468Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-12T01:05:22.8506239Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-12T01:05:22.8506941Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-12T01:05:22.8508083Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-12T01:05:22.8508726Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-12T01:05:22.8509633Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-12T01:05:22.8510861Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-12T01:05:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:05:22.8512577Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:05:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:05:22.8514031Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-12T01:05:22.8515812Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-12T01:05:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:05:22.8529828Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-12T01:05:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:05:22.8531887Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:05:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:05:22.8536169Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-12T01:05:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:05:22.8550482Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-12T01:05:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 exec test-cm-54b7d49f85-9j2rl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_SINGULARITY]2026-08-12T01:05:22.8559185Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:05:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 exec test-cm-54b7d49f85-9j2rl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-12T01:05:22.8565954Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-12T01:05:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 exec test-cm-54b7d49f85-9j2rl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)']2026-08-12T01:05:23.0771222Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-12T01:05:23.0791799Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9j2rl failed. Retrying in 30s.2026-08-12T01:05:23.0794347Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-12T01:05:23.0796123Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-9j2rl failed. Retrying in 10s.2026-08-12T01:05:23.0800234Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-12T01:05:23.0801905Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)']' in pod test-cm-54b7d49f85-9j2rl failed. Retrying in 10s.2026-08-12T01:05:33.0803560Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-12T01:05:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 exec test-cm-54b7d49f85-9j2rl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)']2026-08-12T01:05:33.0838740Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-12T01:05:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 exec test-cm-54b7d49f85-9j2rl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_SINGULARITY]2026-08-12T01:05:33.2919044Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-12T01:05:33Z logger.go:67: true2026-08-12T01:05:33.2959132Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-12T01:05:33Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-12T01:05:33.2966288Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-12T01:05:33Z logger.go:67: 2026-08-12T01:05:33.2968139Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-12T01:05:33Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-xj765 LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-08-12T01:05:33.2969845Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-12T01:05:33Z logger.go:67: 2026-08-12T01:05:33.2970858Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-12T01:05:33Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-12T01:05:33.2971858Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-12T01:05:33Z logger.go:67: 2026-08-12T01:05:33.2973075Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-12T01:05:33Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-12T01:05:33.2974285Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-12T01:05:33Z logger.go:67: 2026-08-12T01:05:33.2975465Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-12T01:05:33Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-12T01:05:53.0782003Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:05:53Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 exec test-cm-54b7d49f85-9j2rl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-12T01:05:53.2285055Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:05:53Z logger.go:67: undefined2026-08-12T01:05:53.2347019Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-12T01:05:53.2348266Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9j2rl failed. Retrying in 30s.2026-08-12T01:06:23.2350823Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:06:23Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 exec test-cm-54b7d49f85-9j2rl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-12T01:06:23.3807673Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:06:23Z logger.go:67: undefined2026-08-12T01:06:23.3874341Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9j2rl failed. Retrying in 30s.2026-08-12T01:06:53.3876764Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:06:53Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 exec test-cm-54b7d49f85-9j2rl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-12T01:06:53.5395620Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:06:53Z logger.go:67: undefined2026-08-12T01:06:53.5461504Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9j2rl failed. Retrying in 30s.2026-08-12T01:07:23.5465352Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:07:23Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 exec test-cm-54b7d49f85-9j2rl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-12T01:07:23.6922107Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:07:23Z logger.go:67: undefined2026-08-12T01:07:23.6981543Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9j2rl failed. Retrying in 30s.2026-08-12T01:07:53.7006899Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:07:53Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 exec test-cm-54b7d49f85-9j2rl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-12T01:07:53.8452725Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:07:53Z logger.go:67: undefined2026-08-12T01:07:53.8510852Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9j2rl failed. Retrying in 30s.2026-08-12T01:08:23.8534008Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:08:23Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 exec test-cm-54b7d49f85-9j2rl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-12T01:08:24.0572354Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:08:24Z logger.go:67: undefined2026-08-12T01:08:24.0640375Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9j2rl failed. Retrying in 30s.2026-08-12T01:08:54.0645332Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:08:54Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 exec test-cm-54b7d49f85-9j2rl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-12T01:08:54.2184137Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:08:54Z logger.go:67: undefined2026-08-12T01:08:54.2243181Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9j2rl failed. Retrying in 30s.2026-08-12T01:09:24.2247542Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:09:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 exec test-cm-54b7d49f85-9j2rl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-12T01:09:24.3707285Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:09:24Z logger.go:67: undefined2026-08-12T01:09:24.3765333Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9j2rl failed. Retrying in 30s.2026-08-12T01:09:54.3787807Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:09:54Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 exec test-cm-54b7d49f85-9j2rl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-12T01:09:54.5298922Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:09:54Z logger.go:67: undefined2026-08-12T01:09:54.5376904Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9j2rl failed. Retrying in 30s.2026-08-12T01:10:24.5379979Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:10:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 exec test-cm-54b7d49f85-9j2rl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-12T01:10:24.6907001Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:10:24Z logger.go:67: undefined2026-08-12T01:10:24.6968907Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9j2rl failed. Retrying in 30s.2026-08-12T01:10:54.7012960Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:10:54Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 exec test-cm-54b7d49f85-9j2rl -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-xj765",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-12T01:10:54.8565493Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-12T01:10:54Z logger.go:67: true2026-08-12T01:10:54.8633952Z TestOSPoolEP 2026-08-12T01:10:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:10:54.8706811Z TestOSPoolEP 2026-08-12T01:10:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:10:55.2331159Z TestOSPoolEP 2026-08-12T01:10:55Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:10:55.3496640Z TestOSPoolEP 2026-08-12T01:10:55Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:10:55.4516934Z TestOSPoolEP 2026-08-12T01:10:55Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:10:55.4542577Z === NAME TestOSPoolEP2026-08-12T01:10:55.4543049Z ospool_ep_test.go:101: ---2026-08-12T01:10:55.4543537Z Events for pod idtoken-generator:2026-08-12T01:10:55.4544759Z 2026-08-12 01:04:31 +0000 UTC Normal Successfully assigned test-ospool-ep-mj9he4/idtoken-generator to minikube2026-08-12T01:10:55.4545723Z 2026-08-12 01:04:32 +0000 UTC Normal Pulling image "htcondor/base"2026-08-12T01:10:55.4546941Z 2026-08-12 01:04:41 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.745s (8.745s including waiting). Image size: 560910730 bytes.2026-08-12T01:10:55.4548124Z 2026-08-12 01:04:41 +0000 UTC Normal Container created2026-08-12T01:10:55.4548755Z 2026-08-12 01:04:41 +0000 UTC Normal Container started2026-08-12T01:10:55.4549471Z 2026-08-12T01:10:55.4549812Z ---2026-08-12T01:10:55.4550705Z TestOSPoolEP 2026-08-12T01:10:55Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:10:55.4567680Z ospool_ep_test.go:101: ---2026-08-12T01:10:55.4568151Z Events for pod ospool-ep-6c7d796845-xj765:2026-08-12T01:10:55.4569253Z 2026-08-12 01:04:52 +0000 UTC Normal Successfully assigned test-ospool-ep-mj9he4/ospool-ep-6c7d796845-xj765 to minikube2026-08-12T01:10:55.4570851Z 2026-08-12 01:04:53 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-12T01:10:55.4572824Z 2026-08-12 01:04:54 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.685s (1.685s including waiting). Image size: 5590942 bytes.2026-08-12T01:10:55.4574286Z 2026-08-12 01:04:55 +0000 UTC Normal Container created2026-08-12T01:10:55.4575039Z 2026-08-12 01:04:55 +0000 UTC Normal Container started2026-08-12T01:10:55.4576232Z 2026-08-12 01:04:56 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-08-12T01:10:55.4578007Z 2026-08-12 01:05:15 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 14.258s (19.345s including waiting). Image size: 1273000231 bytes.2026-08-12T01:10:55.4579545Z 2026-08-12 01:05:15 +0000 UTC Normal Container created2026-08-12T01:10:55.4580371Z 2026-08-12 01:05:15 +0000 UTC Normal Container started2026-08-12T01:10:55.4580889Z 2026-08-12T01:10:55.4581235Z ---2026-08-12T01:10:55.4582147Z TestOSPoolEP 2026-08-12T01:10:55Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:10:55.4590112Z ospool_ep_test.go:101: ---2026-08-12T01:10:55.4591078Z Events for pod test-cm-54b7d49f85-9j2rl:2026-08-12T01:10:55.4592351Z 2026-08-12 01:04:52 +0000 UTC Normal Successfully assigned test-ospool-ep-mj9he4/test-cm-54b7d49f85-9j2rl to minikube2026-08-12T01:10:55.4594608Z 2026-08-12 01:04:53 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-08-12T01:10:55.4596350Z 2026-08-12 01:05:01 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 6.189s (7.857s including waiting). Image size: 573055668 bytes.2026-08-12T01:10:55.4597411Z 2026-08-12 01:05:01 +0000 UTC Normal Container created2026-08-12T01:10:55.4597916Z 2026-08-12 01:05:01 +0000 UTC Normal Container started2026-08-12T01:10:55.4598251Z 2026-08-12T01:10:55.4598469Z ---2026-08-12T01:10:55.4599054Z TestOSPoolEP 2026-08-12T01:10:55Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-12T01:10:55.4627312Z TestOSPoolEP 2026-08-12T01:10:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 delete -f /tmp/TestOSPoolEP3854871369]2026-08-12T01:10:55.5490089Z TestOSPoolEP 2026-08-12T01:10:55Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-mj9he4 namespace2026-08-12T01:10:55.5540320Z TestOSPoolEP 2026-08-12T01:10:55Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-mj9he4 namespace2026-08-12T01:10:56.1028702Z TestOSPoolEP 2026-08-12T01:10:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 delete -f /tmp/TestOSPoolEP2472285180]2026-08-12T01:10:56.1889175Z TestOSPoolEP 2026-08-12T01:10:56Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-mj9he4 namespace2026-08-12T01:10:56.1934951Z TestOSPoolEP 2026-08-12T01:10:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mj9he4 delete -k /tmp/kustomize-template-2502516354]2026-08-12T01:10:56.2980844Z TestOSPoolEP 2026-08-12T01:10:56Z logger.go:67: service "test-cm" deleted from test-ospool-ep-mj9he4 namespace2026-08-12T01:10:56.3044317Z TestOSPoolEP 2026-08-12T01:10:56Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-mj9he4 namespace2026-08-12T01:10:56.3082639Z TestOSPoolEP 2026-08-12T01:10:56Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-mj9he4 namespace2026-08-12T01:10:56.3202179Z --- PASS: TestOSPoolEP (53.57s)2026-08-12T01:10:56.3205301Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.03s)2026-08-12T01:10:56.3208412Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (10.45s)2026-08-12T01:10:56.3211880Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (10.45s)2026-08-12T01:10:56.3214530Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (332.01s)2026-08-12T01:10:56.3216404Z PASS2026-08-12T01:10:56.3240155Z ok github.com/osg-htc/k8s-integration-tests/test 385.598s2026-08-12T01:10:56.4318284Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-12T01:10:56.4318963Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-12T01:10:56.4389076Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-12T01:10:56.4389692Z env:2026-08-12T01:10:56.4389938Z GOTOOLCHAIN: local2026-08-12T01:10:56.4390390Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-12T01:10:56.4390876Z ##[endgroup]2026-08-12T01:10:56.4593097Z 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-12T01:10:56.4595037Z ##[group]Run actions/upload-artifact@v42026-08-12T01:10:56.4595447Z with:2026-08-12T01:10:56.4596023Z name: TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce72322026-08-12T01:10:56.4596726Z path: /tmp/k8s-tests2026-08-12T01:10:56.4597057Z retention-days: 52026-08-12T01:10:56.4597378Z if-no-files-found: warn2026-08-12T01:10:56.4597738Z compression-level: 62026-08-12T01:10:56.4598080Z overwrite: false2026-08-12T01:10:56.4598405Z include-hidden-files: false2026-08-12T01:10:56.4598758Z env:2026-08-12T01:10:56.4599030Z GOTOOLCHAIN: local2026-08-12T01:10:56.4599552Z ##[endgroup]2026-08-12T01:10:56.7008298Z (node:18231) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-12T01:10:56.7009655Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-12T01:10:56.7115253Z With the provided path, there will be 6 files uploaded2026-08-12T01:10:56.7116792Z Artifact name is valid!2026-08-12T01:10:56.7117388Z Root directory input is valid!2026-08-12T01:10:56.9210022Z Beginning upload of artifact content to blob storage2026-08-12T01:10:56.9559208Z (node:18231) [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-12T01:10:57.1390819Z Uploaded bytes 142322026-08-12T01:10:57.1833614Z Finished uploading artifact content to blob storage!2026-08-12T01:10:57.1835309Z SHA256 digest of uploaded artifact zip is dcfc5cadb41cf989bf9814f759b6066b400efe3a630ad4b47417aeb6b7abff742026-08-12T01:10:57.1837375Z Finalizing artifact upload2026-08-12T01:10:57.3648023Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232.zip successfully finalized. Artifact ID 91248472682026-08-12T01:10:57.3650279Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232 has been successfully uploaded! Final size is 14232 bytes. Artifact ID is 91248472682026-08-12T01:10:57.3655489Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/31552283944/artifacts/91248472682026-08-12T01:10:57.3835190Z Post job cleanup.2026-08-12T01:10:57.5223432Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-12T01:10:57.5269099Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-12T01:10:57.5321334Z /home/runner/go/pkg/mod2026-08-12T01:10:57.5334393Z /home/runner/.cache/go-build2026-08-12T01:10:57.5348774Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-12T01:10:57.5559507Z Post job cleanup.2026-08-12T01:10:57.6493400Z [command]/usr/bin/git version2026-08-12T01:10:57.6537959Z git version 2.54.02026-08-12T01:10:57.6577783Z Temporarily overriding HOME='/home/runner/work/_temp/af409c7c-db91-49c1-b8a1-599ee855246f' before making global git config changes2026-08-12T01:10:57.6580115Z Adding repository directory to the temporary git global config as a safe directory2026-08-12T01:10:57.6584226Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-12T01:10:57.6625836Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-12T01:10:57.6663935Z [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-12T01:10:57.6955647Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-12T01:10:57.6986249Z http.https://github.com/.extraheader2026-08-12T01:10:57.6998788Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-12T01:10:57.7036479Z [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-12T01:10:57.7360279Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-12T01:10:57.7401470Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-12T01:10:57.7863873Z Cleaning up orphan processes2026-08-12T01:10:57.8644072Z ##[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/