2026-07-30T01:23:23.1713775Z Current runner version: '2.336.0'2026-07-30T01:23:23.1740996Z ##[group]Runner Image Provisioner2026-07-30T01:23:23.1741856Z Hosted Compute Agent2026-07-30T01:23:23.1742590Z Version: 20260707.5632026-07-30T01:23:23.1743284Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-07-30T01:23:23.1744031Z Build Date: 2026-07-07T19:33:50Z2026-07-30T01:23:23.1744831Z Worker ID: {f66c8d20-76cd-434a-ac08-05a173542b83}2026-07-30T01:23:23.1746019Z Azure Region: eastus2026-07-30T01:23:23.1746794Z ##[endgroup]2026-07-30T01:23:23.1748505Z ##[group]Operating System2026-07-30T01:23:23.1749176Z Ubuntu2026-07-30T01:23:23.1749819Z 22.04.52026-07-30T01:23:23.1750403Z LTS2026-07-30T01:23:23.1750943Z ##[endgroup]2026-07-30T01:23:23.1751675Z ##[group]Runner Image2026-07-30T01:23:23.1752287Z Image: ubuntu-22.042026-07-30T01:23:23.1752924Z Version: 20260726.241.12026-07-30T01:23:23.1754225Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260726.241/images/ubuntu/Ubuntu2204-Readme.md2026-07-30T01:23:23.1756262Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260726.2412026-07-30T01:23:23.1757293Z ##[endgroup]2026-07-30T01:23:23.1758624Z ##[group]GITHUB_TOKEN Permissions2026-07-30T01:23:23.1760806Z Contents: read2026-07-30T01:23:23.1761859Z Metadata: read2026-07-30T01:23:23.1762565Z Packages: read2026-07-30T01:23:23.1763167Z ##[endgroup]2026-07-30T01:23:23.1765678Z Secret source: Actions2026-07-30T01:23:23.1767244Z Prepare workflow directory2026-07-30T01:23:23.2107858Z Prepare all required actions2026-07-30T01:23:23.2157435Z Getting action download info2026-07-30T01:23:23.4496925Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-07-30T01:23:23.5857726Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-07-30T01:23:23.7936935Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-07-30T01:23:23.9290488Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-07-30T01:23:24.2048254Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-07-30T01:23:24.2054162Z ##[group] Inputs2026-07-30T01:23:24.2054794Z testName: TestOSPoolEP2026-07-30T01:23:24.2056629Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-07-30T01:23:24.2058232Z setupScript: 2026-07-30T01:23:24.2058721Z setupEnv: {}2026-07-30T01:23:24.2059472Z ##[endgroup]2026-07-30T01:23:24.2060468Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-testing) / Run Tests2026-07-30T01:23:24.2888173Z ##[group]Run actions/checkout@v52026-07-30T01:23:24.2889196Z with:2026-07-30T01:23:24.2889768Z repository: mwestphall/k8s-integration-tests2026-07-30T01:23:24.2898244Z token: ***2026-07-30T01:23:24.2898729Z ssh-strict: true2026-07-30T01:23:24.2899251Z ssh-user: git2026-07-30T01:23:24.2899778Z persist-credentials: true2026-07-30T01:23:24.2900396Z clean: true2026-07-30T01:23:24.2900914Z sparse-checkout-cone-mode: true2026-07-30T01:23:24.2901599Z fetch-depth: 12026-07-30T01:23:24.2902098Z fetch-tags: false2026-07-30T01:23:24.2902621Z show-progress: true2026-07-30T01:23:24.2903208Z lfs: false2026-07-30T01:23:24.2903669Z submodules: false2026-07-30T01:23:24.2904206Z set-safe-directory: true2026-07-30T01:23:24.2904857Z allow-unsafe-pr-checkout: false2026-07-30T01:23:24.2905973Z ##[endgroup]2026-07-30T01:23:24.3932581Z Syncing repository: mwestphall/k8s-integration-tests2026-07-30T01:23:24.3936197Z ##[group]Getting Git version info2026-07-30T01:23:24.3938475Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-07-30T01:23:24.3941483Z [command]/usr/bin/git version2026-07-30T01:23:24.4091563Z git version 2.54.02026-07-30T01:23:24.4115947Z ##[endgroup]2026-07-30T01:23:24.4134105Z Temporarily overriding HOME='/home/runner/work/_temp/0b1c8fb6-1d9d-4593-9e7d-1ec65eb778eb' before making global git config changes2026-07-30T01:23:24.4138999Z Adding repository directory to the temporary git global config as a safe directory2026-07-30T01:23:24.4142941Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-07-30T01:23:24.4182877Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-07-30T01:23:24.4189965Z ##[group]Initializing the repository2026-07-30T01:23:24.4194743Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-07-30T01:23:24.4288108Z hint: Using 'master' as the name for the initial branch. This default branch name2026-07-30T01:23:24.4290741Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-07-30T01:23:24.4293954Z hint: to use in all of your new repositories, which will suppress this warning,2026-07-30T01:23:24.4296650Z hint: call:2026-07-30T01:23:24.4297891Z hint:2026-07-30T01:23:24.4299373Z hint: git config --global init.defaultBranch <name>2026-07-30T01:23:24.4300956Z hint:2026-07-30T01:23:24.4302281Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-07-30T01:23:24.4304836Z hint: 'development'. The just-created branch can be renamed via this command:2026-07-30T01:23:24.4307173Z hint:2026-07-30T01:23:24.4307789Z hint: git branch -m <name>2026-07-30T01:23:24.4308368Z hint:2026-07-30T01:23:24.4309419Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-07-30T01:23:24.4312843Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-07-30T01:23:24.4318063Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-07-30T01:23:24.4376341Z ##[endgroup]2026-07-30T01:23:24.4377928Z ##[group]Disabling automatic garbage collection2026-07-30T01:23:24.4381000Z [command]/usr/bin/git config --local gc.auto 02026-07-30T01:23:24.4416258Z ##[endgroup]2026-07-30T01:23:24.4417691Z ##[group]Setting up auth2026-07-30T01:23:24.4433758Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-07-30T01:23:24.4473499Z [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-07-30T01:23:24.4848704Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-07-30T01:23:24.4889567Z [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-07-30T01:23:24.5138933Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-07-30T01:23:24.5176321Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-07-30T01:23:24.5424296Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-07-30T01:23:24.5463836Z ##[endgroup]2026-07-30T01:23:24.5473244Z ##[group]Fetching the repository2026-07-30T01:23:24.5475817Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-07-30T01:23:24.7500438Z From https://github.com/mwestphall/k8s-integration-tests2026-07-30T01:23:24.7501873Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-07-30T01:23:24.7527611Z ##[endgroup]2026-07-30T01:23:24.7528313Z ##[group]Determining the checkout info2026-07-30T01:23:24.7531293Z ##[endgroup]2026-07-30T01:23:24.7538964Z [command]/usr/bin/git sparse-checkout disable2026-07-30T01:23:24.7586908Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-07-30T01:23:24.7619465Z ##[group]Checking out the ref2026-07-30T01:23:24.7625929Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-07-30T01:23:24.7718032Z Switched to a new branch 'main'2026-07-30T01:23:24.7721645Z branch 'main' set up to track 'origin/main'.2026-07-30T01:23:24.7727231Z ##[endgroup]2026-07-30T01:23:24.7775736Z [command]/usr/bin/git log -1 --format=%H2026-07-30T01:23:24.7803277Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-07-30T01:23:24.8036218Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-07-30T01:23:24.8037249Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-07-30T01:23:24.8038115Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-07-30T01:23:24.8144886Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-07-30T01:23:24.8145706Z env:2026-07-30T01:23:24.8146401Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-07-30T01:23:24.8147168Z SETUP_ENV_YAML: {}2026-07-30T01:23:24.8147565Z ##[endgroup]2026-07-30T01:23:25.7827600Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-07-30T01:23:25.7828351Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-07-30T01:23:25.7885919Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-07-30T01:23:25.7886322Z env:2026-07-30T01:23:25.7886833Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-07-30T01:23:25.7887424Z ##[endgroup]2026-07-30T01:23:25.8023607Z ##[group]Run true2026-07-30T01:23:25.8023907Z [36;1mtrue[0m2026-07-30T01:23:25.8074741Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-07-30T01:23:25.8075170Z ##[endgroup]2026-07-30T01:23:25.8241622Z ##[group]Run medyagh/setup-minikube@latest2026-07-30T01:23:25.8241993Z with:2026-07-30T01:23:25.8242223Z start: true2026-07-30T01:23:25.8242459Z cache: true2026-07-30T01:23:25.8242710Z minikube-version: latest2026-07-30T01:23:25.8243038Z wait: all2026-07-30T01:23:25.8243263Z ##[endgroup]2026-07-30T01:23:25.9489874Z (node:1840) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-07-30T01:23:25.9491626Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-07-30T01:23:26.8567128Z [command]/usr/bin/chmod +x /home/runner/work/_temp/cf437493-54e8-49a0-895d-3e31b1b6e8222026-07-30T01:23:27.0252634Z [command]/home/runner/bin/minikube version --short2026-07-30T01:23:27.0697420Z v1.38.12026-07-30T01:23:27.1379888Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-07-30T01:23:27.1480365Z (node:1840) [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-07-30T01:23:27.1486456Z Cache hit for: kic-v1.38.1-x642026-07-30T01:23:28.1937092Z Received 134217728 of 224218863 (59.9%), 127.2 MBs/sec2026-07-30T01:23:28.2052657Z Received 121634816 of 544082657 (22.4%), 115.9 MBs/sec2026-07-30T01:23:28.7687745Z Received 224218863 of 224218863 (100.0%), 135.2 MBs/sec2026-07-30T01:23:28.7689184Z Cache Size: ~214 MB (224218863 B)2026-07-30T01:23:28.8507870Z [command]/usr/bin/tar -xf /home/runner/work/_temp/ec2e15b0-e5a8-4e72-82b0-941a22f30f68/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-07-30T01:23:29.2579511Z Received 268435456 of 544082657 (49.3%), 124.7 MBs/sec2026-07-30T01:23:29.7806258Z Cache restored successfully2026-07-30T01:23:30.2572322Z Received 473956352 of 544082657 (87.1%), 148.1 MBs/sec2026-07-30T01:23:30.6752847Z Received 544082657 of 544082657 (100.0%), 149.5 MBs/sec2026-07-30T01:23:30.6796212Z Cache Size: ~519 MB (544082657 B)2026-07-30T01:23:30.6900521Z [command]/usr/bin/tar -xf /home/runner/work/_temp/bba78269-326d-424a-bdaa-ed1cfed1f03a/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-07-30T01:23:31.6669945Z Cache restored successfully2026-07-30T01:23:31.7807690Z [command]/home/runner/bin/minikube start --wait all2026-07-30T01:23:31.8213134Z * minikube v1.38.1 on Ubuntu 22.042026-07-30T01:23:35.3477451Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-07-30T01:23:35.3947071Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-07-30T01:23:35.3954579Z * Using Docker driver with root privileges2026-07-30T01:23:35.3967084Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-07-30T01:23:35.3979079Z * Pulling base image v0.0.50 ...2026-07-30T01:24:07.1406443Z * Configuring bridge CNI (Container Networking Interface) ...2026-07-30T01:24:11.7908129Z * Verifying Kubernetes components...2026-07-30T01:24:11.8114022Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-07-30T01:24:12.3432846Z * Enabled addons: storage-provisioner, default-storageclass2026-07-30T01:24:49.6374379Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-07-30T01:24:49.6471218Z [command]/home/runner/bin/minikube version --short2026-07-30T01:24:49.6849765Z v1.38.12026-07-30T01:24:49.7171813Z ##[group]Run actions/setup-go@v62026-07-30T01:24:49.7172116Z with:2026-07-30T01:24:49.7172312Z go-version: 1.262026-07-30T01:24:49.7172521Z cache: true2026-07-30T01:24:49.7172746Z cache-dependency-path: go.sum2026-07-30T01:24:49.7173013Z check-latest: false2026-07-30T01:24:49.7175911Z token: ***2026-07-30T01:24:49.7176132Z ##[endgroup]2026-07-30T01:24:49.8541570Z Setup go version spec 1.262026-07-30T01:24:49.8599466Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-07-30T01:24:49.8601620Z Added go to the path2026-07-30T01:24:49.8605215Z Successfully set up Go version 1.262026-07-30T01:24:51.3128710Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-07-30T01:24:51.3169357Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-07-30T01:24:51.3194969Z /home/runner/go/pkg/mod2026-07-30T01:24:51.3218058Z /home/runner/.cache/go-build2026-07-30T01:24:51.3852269Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-07-30T01:24:57.4463661Z Received 218103808 of 251839808 (86.6%), 207.8 MBs/sec2026-07-30T01:24:57.6146648Z Received 251839808 of 251839808 (100.0%), 205.5 MBs/sec2026-07-30T01:24:57.6148461Z Cache Size: ~240 MB (251839808 B)2026-07-30T01:24:57.6222578Z [command]/usr/bin/tar -xf /home/runner/work/_temp/d3ef51b8-eb25-4355-999b-171a59a6ad12/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-07-30T01:25:00.7536344Z Cache restored successfully2026-07-30T01:25:00.8154450Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-07-30T01:25:00.8183525Z go version go1.26.5 linux/amd642026-07-30T01:25:00.8184012Z 2026-07-30T01:25:00.8184633Z ##[group]go env2026-07-30T01:25:00.9189723Z AR='ar'2026-07-30T01:25:00.9190129Z CC='gcc'2026-07-30T01:25:00.9190494Z CGO_CFLAGS='-O2 -g'2026-07-30T01:25:00.9190919Z CGO_CPPFLAGS=''2026-07-30T01:25:00.9191271Z CGO_CXXFLAGS='-O2 -g'2026-07-30T01:25:00.9191518Z CGO_ENABLED='1'2026-07-30T01:25:00.9191742Z CGO_FFLAGS='-O2 -g'2026-07-30T01:25:00.9191977Z CGO_LDFLAGS='-O2 -g'2026-07-30T01:25:00.9192198Z CXX='g++'2026-07-30T01:25:00.9192406Z GCCGO='gccgo'2026-07-30T01:25:00.9192619Z GO111MODULE=''2026-07-30T01:25:00.9192834Z GOAMD64='v1'2026-07-30T01:25:00.9193056Z GOARCH='amd64'2026-07-30T01:25:00.9193266Z GOAUTH='netrc'2026-07-30T01:25:00.9193755Z GOBIN=''2026-07-30T01:25:00.9193986Z GOCACHE='/home/runner/.cache/go-build'2026-07-30T01:25:00.9194291Z GOCACHEPROG=''2026-07-30T01:25:00.9194501Z GODEBUG=''2026-07-30T01:25:00.9194752Z GOENV='/home/runner/.config/go/env'2026-07-30T01:25:00.9195034Z GOEXE=''2026-07-30T01:25:00.9195242Z GOEXPERIMENT=''2026-07-30T01:25:00.9195780Z GOFIPS140='off'2026-07-30T01:25:00.9196008Z GOFLAGS=''2026-07-30T01:25:00.9196755Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build1007022563=/tmp/go-build -gno-record-gcc-switches'2026-07-30T01:25:00.9197506Z GOHOSTARCH='amd64'2026-07-30T01:25:00.9197736Z GOHOSTOS='linux'2026-07-30T01:25:00.9197964Z GOINSECURE=''2026-07-30T01:25:00.9198554Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-07-30T01:25:00.9199092Z GOMODCACHE='/home/runner/go/pkg/mod'2026-07-30T01:25:00.9199562Z GONOPROXY=''2026-07-30T01:25:00.9258039Z GONOSUMDB=''2026-07-30T01:25:00.9258427Z GOOS='linux'2026-07-30T01:25:00.9258798Z GOPATH='/home/runner/go'2026-07-30T01:25:00.9259182Z GOPRIVATE=''2026-07-30T01:25:00.9259590Z GOPROXY='https://proxy.golang.org,direct'2026-07-30T01:25:00.9260129Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-07-30T01:25:00.9260616Z GOSUMDB='sum.golang.org'2026-07-30T01:25:00.9261012Z GOTELEMETRY='local'2026-07-30T01:25:00.9261460Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-07-30T01:25:00.9261968Z GOTMPDIR=''2026-07-30T01:25:00.9262295Z GOTOOLCHAIN='local'2026-07-30T01:25:00.9263146Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-07-30T01:25:00.9263757Z GOVCS=''2026-07-30T01:25:00.9264071Z GOVERSION='go1.26.5'2026-07-30T01:25:00.9264420Z GOWORK=''2026-07-30T01:25:00.9264780Z PKG_CONFIG='pkg-config'2026-07-30T01:25:00.9265033Z 2026-07-30T01:25:00.9265756Z ##[endgroup]2026-07-30T01:25:00.9399615Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-07-30T01:25:00.9400134Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-07-30T01:25:00.9458058Z shell: /usr/bin/bash -e {0}2026-07-30T01:25:00.9458322Z env:2026-07-30T01:25:00.9458516Z GOTOOLCHAIN: local2026-07-30T01:25:00.9458762Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-07-30T01:25:00.9459039Z OSPOOL_EP_CMTag: 25.x-el92026-07-30T01:25:00.9459296Z OSPOOL_EP_CvmfsType: cvmfsexec2026-07-30T01:25:00.9459569Z ##[endgroup]2026-07-30T01:25:10.7642116Z === RUN TestOSPoolEP2026-07-30T01:25:10.7642747Z === PAUSE TestOSPoolEP2026-07-30T01:25:10.7643181Z === CONT TestOSPoolEP2026-07-30T01:25:10.7647580Z TestOSPoolEP 2026-07-30T01:25:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:10.7735321Z TestOSPoolEP 2026-07-30T01:25:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj apply -f /tmp/TestOSPoolEP1708132552]2026-07-30T01:25:11.0469067Z TestOSPoolEP 2026-07-30T01:25:11Z logger.go:67: pod/idtoken-generator created2026-07-30T01:25:11.0524197Z TestOSPoolEP 2026-07-30T01:25:11Z logger.go:67: secret/pool-passwd created2026-07-30T01:25:11.0569290Z TestOSPoolEP 2026-07-30T01:25:11Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-07-30T01:25:11.0579717Z TestOSPoolEP 2026-07-30T01:25:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:11.0606972Z TestOSPoolEP 2026-07-30T01:25:11Z 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-07-30T01:25:21.0607753Z TestOSPoolEP 2026-07-30T01:25:21Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-07-30T01:25:21.0609612Z TestOSPoolEP 2026-07-30T01:25:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:21.0629990Z TestOSPoolEP 2026-07-30T01:25:21Z logger.go:67: Pod is now available2026-07-30T01:25:21.0632638Z TestOSPoolEP 2026-07-30T01:25:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-07-30T01:25:21.5884876Z TestOSPoolEP 2026-07-30T01:25:21Z logger.go:67: ***2026-07-30T01:25:21.5929320Z TestOSPoolEP 2026-07-30T01:25:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj apply -f /tmp/TestOSPoolEP1721800017]2026-07-30T01:25:21.6808178Z TestOSPoolEP 2026-07-30T01:25:21Z logger.go:67: secret/pool-token created2026-07-30T01:25:21.6828673Z TestOSPoolEP 2026-07-30T01:25:21Z retry.go:91: Wait for secret pool-token to be provisioned.2026-07-30T01:25:21.6830265Z TestOSPoolEP 2026-07-30T01:25:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:21.6847584Z TestOSPoolEP 2026-07-30T01:25:21Z logger.go:67: Secret is now available2026-07-30T01:25:21.6881238Z TestOSPoolEP 2026-07-30T01:25:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj apply -k /tmp/kustomize-template-721901806]2026-07-30T01:25:21.8481463Z TestOSPoolEP 2026-07-30T01:25:21Z logger.go:67: service/test-cm created2026-07-30T01:25:21.8554244Z TestOSPoolEP 2026-07-30T01:25:21Z 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-07-30T01:25:21.8559123Z TestOSPoolEP 2026-07-30T01:25:21Z logger.go:67: deployment.apps/ospool-ep created2026-07-30T01:25:21.8650851Z TestOSPoolEP 2026-07-30T01:25:21Z logger.go:67: deployment.apps/test-cm created2026-07-30T01:25:21.8715472Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-07-30T01:25:21.8718721Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:21.8786618Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:21Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-07-30T01:25:21.8811580Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:21.8814012Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:21Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-30T01:25:21.8841033Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:21.8847633Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:21Z 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-07-30T01:25:21.8867956Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:21Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-65c844ddbb". Sleeping for 10s and will try again.2026-07-30T01:25:31.8855788Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:31Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-07-30T01:25:31.8889909Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:31.8908049Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:31Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-30T01:25:31.8918781Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:31.8922659Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:31Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-65c844ddbb" is progressing.. Sleeping for 10s and will try again.2026-07-30T01:25:31.8926266Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:31Z logger.go:67: Deployment is now available2026-07-30T01:25:41.8927257Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:41Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-30T01:25:41.8929584Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:41.8950647Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:41Z logger.go:67: Deployment is now available2026-07-30T01:25:41.8958389Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-30T01:25:41.8959517Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-30T01:25:41.8960425Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-07-30T01:25:41.8961273Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-07-30T01:25:41.8962134Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-30T01:25:41.8962997Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-30T01:25:41.8964251Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-30T01:25:41.8966456Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-30T01:25:41.8968329Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:25:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:41.8970479Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:25:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:41.8971832Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-07-30T01:25:41.8972930Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-30T01:25:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:41.8990879Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:25:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:41.8993198Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:25:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:41.8997148Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-30T01:25:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:41.9017926Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:25:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)']2026-07-30T01:25:41.9041159Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-30T01:25:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_SINGULARITY]2026-07-30T01:25:41.9045184Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:25:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:25:42.0439557Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-lk895 failed. Retrying in 10s.2026-07-30T01:25:42.0614757Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-30T01:25:42.0616576Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)']' in pod test-cm-5bb545475c-lk895 failed. Retrying in 10s.2026-07-30T01:25:42.0804969Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-30T01:25:42.0807210Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-lk895 failed. Retrying in 30s.2026-07-30T01:25:52.0441788Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-30T01:25:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_SINGULARITY]2026-07-30T01:25:52.0624812Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:25:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)']2026-07-30T01:25:52.1763898Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-07-30T01:25:52.1765914Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-lk895 failed. Retrying in 10s.2026-07-30T01:25:52.1990518Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-30T01:25:52.1991598Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)']' in pod test-cm-5bb545475c-lk895 failed. Retrying in 10s.2026-07-30T01:26:02.1774192Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-30T01:26:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_SINGULARITY]2026-07-30T01:26:02.1998181Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:26:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)']2026-07-30T01:26:02.3077661Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-30T01:26:02Z logger.go:67: true2026-07-30T01:26:02.3123302Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:26:02Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-07-30T01:26:02.3124978Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:26:02Z logger.go:67: 2026-07-30T01:26:02.3126507Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:26:02Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-65c844ddbb-nfnmv LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-07-30T01:26:02.3127697Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:26:02Z logger.go:67: 2026-07-30T01:26:02.3128898Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:26:02Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-07-30T01:26:02.3130080Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:26:02Z logger.go:67: 2026-07-30T01:26:02.3131057Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:26:02Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-07-30T01:26:02.3132602Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:26:02Z logger.go:67: 2026-07-30T01:26:02.3134093Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:26:02Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-07-30T01:26:12.0809877Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:26:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:26:12.1818759Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:26:12Z logger.go:67: undefined2026-07-30T01:26:12.1860418Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-30T01:26:12.1862024Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-lk895 failed. Retrying in 30s.2026-07-30T01:26:42.1866419Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:26:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:26:42.3359114Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:26:42Z logger.go:67: undefined2026-07-30T01:26:42.3403388Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-lk895 failed. Retrying in 30s.2026-07-30T01:27:12.3416381Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:27:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:27:12.4456715Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:27:12Z logger.go:67: undefined2026-07-30T01:27:12.4510586Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-lk895 failed. Retrying in 30s.2026-07-30T01:27:42.4518089Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:27:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:27:42.5536012Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:27:42Z logger.go:67: undefined2026-07-30T01:27:42.5583501Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-lk895 failed. Retrying in 30s.2026-07-30T01:28:12.5589321Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:28:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:28:12.6571369Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:28:12Z logger.go:67: undefined2026-07-30T01:28:12.6614971Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-lk895 failed. Retrying in 30s.2026-07-30T01:28:42.6628003Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:28:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:28:42.7639003Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:28:42Z logger.go:67: undefined2026-07-30T01:28:42.7689414Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-lk895 failed. Retrying in 30s.2026-07-30T01:29:12.7696605Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:29:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:29:12.9092174Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:29:12Z logger.go:67: undefined2026-07-30T01:29:12.9136318Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-lk895 failed. Retrying in 30s.2026-07-30T01:29:42.9141254Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:29:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:29:43.0352472Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:29:43Z logger.go:67: undefined2026-07-30T01:29:43.0394975Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-lk895 failed. Retrying in 30s.2026-07-30T01:30:13.0412224Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:30:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:30:13.1418004Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:30:13Z logger.go:67: undefined2026-07-30T01:30:13.1465264Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-lk895 failed. Retrying in 30s.2026-07-30T01:30:43.1486476Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:30:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:30:43.2523248Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:30:43Z logger.go:67: undefined2026-07-30T01:30:43.2563838Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-lk895 failed. Retrying in 30s.2026-07-30T01:31:13.2582753Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:31:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj exec test-cm-5bb545475c-lk895 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-nfnmv",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:31:13.3740879Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:31:13Z logger.go:67: true2026-07-30T01:31:13.3799982Z TestOSPoolEP 2026-07-30T01:31:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:31:13.3886734Z TestOSPoolEP 2026-07-30T01:31:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:31:13.4863578Z TestOSPoolEP 2026-07-30T01:31:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:31:13.6002954Z TestOSPoolEP 2026-07-30T01:31:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:31:13.6689179Z TestOSPoolEP 2026-07-30T01:31:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:31:13.6714643Z === NAME TestOSPoolEP2026-07-30T01:31:13.6715334Z ospool_ep_test.go:101: ---2026-07-30T01:31:13.6716009Z Events for pod idtoken-generator:2026-07-30T01:31:13.6717772Z 2026-07-30 01:25:11 +0000 UTC Normal Successfully assigned test-ospool-ep-lfhdvj/idtoken-generator to minikube2026-07-30T01:31:13.6719061Z 2026-07-30 01:25:12 +0000 UTC Normal Pulling image "htcondor/base"2026-07-30T01:31:13.6722576Z 2026-07-30 01:25:20 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.087s (8.087s including waiting). Image size: 560910730 bytes.2026-07-30T01:31:13.6724220Z 2026-07-30 01:25:20 +0000 UTC Normal Container created2026-07-30T01:31:13.6725111Z 2026-07-30 01:25:20 +0000 UTC Normal Container started2026-07-30T01:31:13.6725956Z 2026-07-30T01:31:13.6726337Z ---2026-07-30T01:31:13.6727673Z TestOSPoolEP 2026-07-30T01:31:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:31:13.6744366Z ospool_ep_test.go:101: ---2026-07-30T01:31:13.6746276Z Events for pod ospool-ep-65c844ddbb-nfnmv:2026-07-30T01:31:13.6748454Z 2026-07-30 01:25:21 +0000 UTC Normal Successfully assigned test-ospool-ep-lfhdvj/ospool-ep-65c844ddbb-nfnmv to minikube2026-07-30T01:31:13.6750086Z 2026-07-30 01:25:22 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-07-30T01:31:13.6752202Z 2026-07-30 01:25:24 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.764s (1.764s including waiting). Image size: 5590942 bytes.2026-07-30T01:31:13.6753809Z 2026-07-30 01:25:24 +0000 UTC Normal Container created2026-07-30T01:31:13.6754597Z 2026-07-30 01:25:24 +0000 UTC Normal Container started2026-07-30T01:31:13.6756130Z 2026-07-30 01:25:24 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-07-30T01:31:13.6758472Z 2026-07-30 01:25:38 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 13.612s (13.612s including waiting). Image size: 1250776798 bytes.2026-07-30T01:31:13.6760063Z 2026-07-30 01:25:38 +0000 UTC Normal Container created2026-07-30T01:31:13.6760892Z 2026-07-30 01:25:38 +0000 UTC Normal Container started2026-07-30T01:31:13.6761450Z 2026-07-30T01:31:13.6761804Z ---2026-07-30T01:31:13.6762775Z TestOSPoolEP 2026-07-30T01:31:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:31:13.6763936Z ospool_ep_test.go:101: ---2026-07-30T01:31:13.6764582Z Events for pod test-cm-5bb545475c-lk895:2026-07-30T01:31:13.6766168Z 2026-07-30 01:25:21 +0000 UTC Normal Successfully assigned test-ospool-ep-lfhdvj/test-cm-5bb545475c-lk895 to minikube2026-07-30T01:31:13.6767533Z 2026-07-30 01:25:22 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-07-30T01:31:13.6770311Z 2026-07-30 01:25:24 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 259ms (2.006s including waiting). Image size: 560910756 bytes.2026-07-30T01:31:13.6772099Z 2026-07-30 01:25:24 +0000 UTC Normal Container created2026-07-30T01:31:13.6773480Z 2026-07-30 01:25:24 +0000 UTC Normal Container started2026-07-30T01:31:13.6774292Z 2026-07-30T01:31:13.6774618Z ---2026-07-30T01:31:13.6776526Z TestOSPoolEP 2026-07-30T01:31:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:31:13.6807852Z TestOSPoolEP 2026-07-30T01:31:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj delete -f /tmp/TestOSPoolEP2509514718]2026-07-30T01:31:13.8295214Z TestOSPoolEP 2026-07-30T01:31:13Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-lfhdvj namespace2026-07-30T01:31:13.8376006Z TestOSPoolEP 2026-07-30T01:31:13Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-lfhdvj namespace2026-07-30T01:31:15.9950839Z TestOSPoolEP 2026-07-30T01:31:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj delete -f /tmp/TestOSPoolEP2551508966]2026-07-30T01:31:16.0540956Z TestOSPoolEP 2026-07-30T01:31:16Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-lfhdvj namespace2026-07-30T01:31:16.0573079Z TestOSPoolEP 2026-07-30T01:31:16Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lfhdvj delete -k /tmp/kustomize-template-721901806]2026-07-30T01:31:16.1314327Z TestOSPoolEP 2026-07-30T01:31:16Z logger.go:67: service "test-cm" deleted from test-ospool-ep-lfhdvj namespace2026-07-30T01:31:16.1388816Z TestOSPoolEP 2026-07-30T01:31:16Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-lfhdvj namespace2026-07-30T01:31:16.1437442Z TestOSPoolEP 2026-07-30T01:31:16Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-lfhdvj namespace2026-07-30T01:31:16.1523984Z --- PASS: TestOSPoolEP (33.90s)2026-07-30T01:31:16.1547946Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (20.02s)2026-07-30T01:31:16.1551653Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.42s)2026-07-30T01:31:16.1553985Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.42s)2026-07-30T01:31:16.1555664Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (331.48s)2026-07-30T01:31:16.1556680Z PASS2026-07-30T01:31:16.1557349Z ok github.com/osg-htc/k8s-integration-tests/test 365.403s2026-07-30T01:31:16.2763218Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-07-30T01:31:16.2764217Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-07-30T01:31:16.2840436Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-07-30T01:31:16.2840988Z env:2026-07-30T01:31:16.2841296Z GOTOOLCHAIN: local2026-07-30T01:31:16.2842022Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-07-30T01:31:16.2842816Z ##[endgroup]2026-07-30T01:31:16.3028393Z 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-07-30T01:31:16.3029828Z ##[group]Run actions/upload-artifact@v42026-07-30T01:31:16.3030109Z with:2026-07-30T01:31:16.3030496Z name: TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe52026-07-30T01:31:16.3030990Z path: /tmp/k8s-tests2026-07-30T01:31:16.3031213Z retention-days: 52026-07-30T01:31:16.3031437Z if-no-files-found: warn2026-07-30T01:31:16.3031674Z compression-level: 62026-07-30T01:31:16.3031898Z overwrite: false2026-07-30T01:31:16.3032114Z include-hidden-files: false2026-07-30T01:31:16.3032351Z env:2026-07-30T01:31:16.3032540Z GOTOOLCHAIN: local2026-07-30T01:31:16.3032746Z ##[endgroup]2026-07-30T01:31:16.5159236Z (node:17017) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-07-30T01:31:16.5160760Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-07-30T01:31:16.5435834Z With the provided path, there will be 6 files uploaded2026-07-30T01:31:16.5442103Z Artifact name is valid!2026-07-30T01:31:16.5442787Z Root directory input is valid!2026-07-30T01:31:16.6882505Z Beginning upload of artifact content to blob storage2026-07-30T01:31:16.7215708Z (node:17017) [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-07-30T01:31:16.7540807Z Uploaded bytes 139852026-07-30T01:31:16.7686761Z Finished uploading artifact content to blob storage!2026-07-30T01:31:16.7688023Z SHA256 digest of uploaded artifact zip is c0acb2d34e1d26daeeead111dad737fa9702e840d4576967d373e1243468e41f2026-07-30T01:31:16.7690402Z Finalizing artifact upload2026-07-30T01:31:16.9198543Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5.zip successfully finalized. Artifact ID 87452662582026-07-30T01:31:16.9200796Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5 has been successfully uploaded! Final size is 13985 bytes. Artifact ID is 87452662582026-07-30T01:31:16.9207650Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/30505493403/artifacts/87452662582026-07-30T01:31:16.9443783Z Post job cleanup.2026-07-30T01:31:17.1117911Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-07-30T01:31:17.1172727Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-07-30T01:31:17.1210710Z /home/runner/go/pkg/mod2026-07-30T01:31:17.1213529Z /home/runner/.cache/go-build2026-07-30T01:31:17.1245630Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-07-30T01:31:17.1506108Z Post job cleanup.2026-07-30T01:31:17.2635915Z [command]/usr/bin/git version2026-07-30T01:31:17.2686911Z git version 2.54.02026-07-30T01:31:17.2748065Z Temporarily overriding HOME='/home/runner/work/_temp/976f1082-45b4-42e6-acaa-6aa5f2465424' before making global git config changes2026-07-30T01:31:17.2759770Z Adding repository directory to the temporary git global config as a safe directory2026-07-30T01:31:17.2766238Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-07-30T01:31:17.2832591Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-07-30T01:31:17.2881122Z [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-07-30T01:31:17.3287696Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-07-30T01:31:17.3329270Z http.https://github.com/.extraheader2026-07-30T01:31:17.3354670Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-07-30T01:31:17.3403421Z [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-07-30T01:31:17.3810658Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-07-30T01:31:17.3863949Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-07-30T01:31:17.4390827Z Cleaning up orphan processes2026-07-30T01:31:17.5230896Z ##[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/