2026-07-28T01:30:06.9038463Z Current runner version: '2.336.0'2026-07-28T01:30:06.9072916Z ##[group]Runner Image Provisioner2026-07-28T01:30:06.9074156Z Hosted Compute Agent2026-07-28T01:30:06.9074991Z Version: 20260707.5632026-07-28T01:30:06.9075818Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-07-28T01:30:06.9076804Z Build Date: 2026-07-07T19:33:50Z2026-07-28T01:30:06.9077652Z Worker ID: {94570340-a3eb-46f0-9cd8-b3595eda5464}2026-07-28T01:30:06.9078631Z Azure Region: northcentralus2026-07-28T01:30:06.9079466Z ##[endgroup]2026-07-28T01:30:06.9081840Z ##[group]Operating System2026-07-28T01:30:06.9083004Z Ubuntu2026-07-28T01:30:06.9083746Z 22.04.52026-07-28T01:30:06.9084440Z LTS2026-07-28T01:30:06.9085119Z ##[endgroup]2026-07-28T01:30:06.9085868Z ##[group]Runner Image2026-07-28T01:30:06.9086738Z Image: ubuntu-22.042026-07-28T01:30:06.9087506Z Version: 20260720.234.22026-07-28T01:30:06.9089333Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-07-28T01:30:06.9091503Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-07-28T01:30:06.9093022Z ##[endgroup]2026-07-28T01:30:06.9094716Z ##[group]GITHUB_TOKEN Permissions2026-07-28T01:30:06.9098159Z Contents: read2026-07-28T01:30:06.9099004Z Metadata: read2026-07-28T01:30:06.9099748Z Packages: read2026-07-28T01:30:06.9101050Z ##[endgroup]2026-07-28T01:30:06.9104408Z Secret source: Actions2026-07-28T01:30:06.9106268Z Prepare workflow directory2026-07-28T01:30:06.9581590Z Prepare all required actions2026-07-28T01:30:06.9654768Z Getting action download info2026-07-28T01:30:07.2093364Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-07-28T01:30:07.5448617Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-07-28T01:30:07.8184806Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-07-28T01:30:08.1104202Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-07-28T01:30:08.5056427Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-07-28T01:30:08.5062855Z ##[group] Inputs2026-07-28T01:30:08.5064014Z testName: TestOSPoolEP2026-07-28T01:30:08.5065902Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-07-28T01:30:08.5067872Z setupScript: 2026-07-28T01:30:08.5068832Z setupEnv: {}2026-07-28T01:30:08.5069812Z ##[endgroup]2026-07-28T01:30:08.5071242Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-07-28T01:30:08.5963082Z ##[group]Run actions/checkout@v52026-07-28T01:30:08.5964527Z with:2026-07-28T01:30:08.5965650Z repository: mwestphall/k8s-integration-tests2026-07-28T01:30:08.5974367Z token: ***2026-07-28T01:30:08.5975403Z ssh-strict: true2026-07-28T01:30:08.5976437Z ssh-user: git2026-07-28T01:30:08.5977425Z persist-credentials: true2026-07-28T01:30:08.5978561Z clean: true2026-07-28T01:30:08.5979570Z sparse-checkout-cone-mode: true2026-07-28T01:30:08.5980837Z fetch-depth: 12026-07-28T01:30:08.5982106Z fetch-tags: false2026-07-28T01:30:08.5983414Z show-progress: true2026-07-28T01:30:08.5984490Z lfs: false2026-07-28T01:30:08.5985591Z submodules: false2026-07-28T01:30:08.5986615Z set-safe-directory: true2026-07-28T01:30:08.5987770Z allow-unsafe-pr-checkout: false2026-07-28T01:30:08.5989488Z ##[endgroup]2026-07-28T01:30:08.7055498Z Syncing repository: mwestphall/k8s-integration-tests2026-07-28T01:30:08.7059086Z ##[group]Getting Git version info2026-07-28T01:30:08.7061442Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-07-28T01:30:08.7064781Z [command]/usr/bin/git version2026-07-28T01:30:08.7098672Z git version 2.54.02026-07-28T01:30:08.7122817Z ##[endgroup]2026-07-28T01:30:08.7140166Z Temporarily overriding HOME='/home/runner/work/_temp/9c26cc9e-f580-4954-9cc3-69ddc2ac3c5b' before making global git config changes2026-07-28T01:30:08.7143243Z Adding repository directory to the temporary git global config as a safe directory2026-07-28T01:30:08.7146238Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-07-28T01:30:08.7181737Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-07-28T01:30:08.7185022Z ##[group]Initializing the repository2026-07-28T01:30:08.7189623Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-07-28T01:30:08.7266501Z hint: Using 'master' as the name for the initial branch. This default branch name2026-07-28T01:30:08.7268970Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-07-28T01:30:08.7271118Z hint: to use in all of your new repositories, which will suppress this warning,2026-07-28T01:30:08.7273213Z hint: call:2026-07-28T01:30:08.7274213Z hint:2026-07-28T01:30:08.7275331Z hint: git config --global init.defaultBranch <name>2026-07-28T01:30:08.7276657Z hint:2026-07-28T01:30:08.7277913Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-07-28T01:30:08.7279729Z hint: 'development'. The just-created branch can be renamed via this command:2026-07-28T01:30:08.7281149Z hint:2026-07-28T01:30:08.7282060Z hint: git branch -m <name>2026-07-28T01:30:08.7283536Z hint:2026-07-28T01:30:08.7285368Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-07-28T01:30:08.7289040Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-07-28T01:30:08.7295847Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-07-28T01:30:08.7315109Z ##[endgroup]2026-07-28T01:30:08.7317349Z ##[group]Disabling automatic garbage collection2026-07-28T01:30:08.7319340Z [command]/usr/bin/git config --local gc.auto 02026-07-28T01:30:08.7349450Z ##[endgroup]2026-07-28T01:30:08.7351047Z ##[group]Setting up auth2026-07-28T01:30:08.7355942Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-07-28T01:30:08.7386863Z [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-28T01:30:08.7702178Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-07-28T01:30:08.7738321Z [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-28T01:30:08.7939438Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-07-28T01:30:08.7968027Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-07-28T01:30:08.8154183Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-07-28T01:30:08.8187991Z ##[endgroup]2026-07-28T01:30:08.8189748Z ##[group]Fetching the repository2026-07-28T01:30:08.8197496Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-07-28T01:30:09.0941276Z From https://github.com/mwestphall/k8s-integration-tests2026-07-28T01:30:09.0944401Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-07-28T01:30:09.0971974Z ##[endgroup]2026-07-28T01:30:09.0974122Z ##[group]Determining the checkout info2026-07-28T01:30:09.0975761Z ##[endgroup]2026-07-28T01:30:09.1006665Z [command]/usr/bin/git sparse-checkout disable2026-07-28T01:30:09.1012215Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-07-28T01:30:09.1036612Z ##[group]Checking out the ref2026-07-28T01:30:09.1039986Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-07-28T01:30:09.1109650Z Switched to a new branch 'main'2026-07-28T01:30:09.1112840Z branch 'main' set up to track 'origin/main'.2026-07-28T01:30:09.1118485Z ##[endgroup]2026-07-28T01:30:09.1150697Z [command]/usr/bin/git log -1 --format=%H2026-07-28T01:30:09.1172751Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-07-28T01:30:09.1409384Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-07-28T01:30:09.1411665Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-07-28T01:30:09.1413854Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-07-28T01:30:09.1507695Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-07-28T01:30:09.1508945Z env:2026-07-28T01:30:09.1510490Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-07-28T01:30:09.1512413Z SETUP_ENV_YAML: {}2026-07-28T01:30:09.1513327Z ##[endgroup]2026-07-28T01:30:09.9976420Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-07-28T01:30:09.9977185Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-07-28T01:30:10.0012953Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-07-28T01:30:10.0013422Z env:2026-07-28T01:30:10.0014062Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-07-28T01:30:10.0014664Z ##[endgroup]2026-07-28T01:30:10.0132165Z ##[group]Run true2026-07-28T01:30:10.0132801Z [36;1mtrue[0m2026-07-28T01:30:10.0164707Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-07-28T01:30:10.0165222Z ##[endgroup]2026-07-28T01:30:10.0313919Z ##[group]Run medyagh/setup-minikube@latest2026-07-28T01:30:10.0314394Z with:2026-07-28T01:30:10.0314758Z start: true2026-07-28T01:30:10.0315099Z cache: true2026-07-28T01:30:10.0315497Z minikube-version: latest2026-07-28T01:30:10.0315868Z wait: all2026-07-28T01:30:10.0316178Z ##[endgroup]2026-07-28T01:30:10.1588368Z (node:2041) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-07-28T01:30:10.1589681Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-07-28T01:30:11.2714189Z [command]/usr/bin/chmod +x /home/runner/work/_temp/4b47510b-a948-4477-a2ba-66802783bd612026-07-28T01:30:12.0423599Z [command]/home/runner/bin/minikube version --short2026-07-28T01:30:12.1457260Z v1.38.12026-07-28T01:30:12.2457498Z Cache hit for: kic-v1.38.1-x642026-07-28T01:30:12.2564901Z (node:2041) [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-28T01:30:12.2576258Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-07-28T01:30:13.3787292Z Received 134217728 of 544082657 (24.7%), 126.7 MBs/sec2026-07-28T01:30:13.3962678Z Received 134217728 of 224218863 (59.9%), 126.6 MBs/sec2026-07-28T01:30:13.8204468Z Received 224218863 of 224218863 (100.0%), 149.1 MBs/sec2026-07-28T01:30:13.8205045Z Cache Size: ~214 MB (224218863 B)2026-07-28T01:30:13.8377445Z [command]/usr/bin/tar -xf /home/runner/work/_temp/3aa0be20-91e1-4d5a-ade0-0dcb0d19861e/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-07-28T01:30:14.3819626Z Received 331350016 of 544082657 (60.9%), 156.8 MBs/sec2026-07-28T01:30:14.3965116Z Cache restored successfully2026-07-28T01:30:15.3937949Z Received 536870912 of 544082657 (98.7%), 169.1 MBs/sec2026-07-28T01:30:15.5121401Z Received 544082657 of 544082657 (100.0%), 165.0 MBs/sec2026-07-28T01:30:15.5122931Z Cache Size: ~519 MB (544082657 B)2026-07-28T01:30:15.5251793Z [command]/usr/bin/tar -xf /home/runner/work/_temp/49cd9ad8-8e79-41fa-8a04-f32b296ab472/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-07-28T01:30:16.0038508Z Cache restored successfully2026-07-28T01:30:16.0751557Z [command]/home/runner/bin/minikube start --wait all2026-07-28T01:30:16.1134891Z * minikube v1.38.1 on Ubuntu 22.042026-07-28T01:30:16.5139685Z ! 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-07-28T01:30:16.5151490Z * Automatically selected the docker driver. Other choices: podman, ssh, none2026-07-28T01:30:16.5640392Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-07-28T01:30:16.5655492Z * Using Docker driver with root privileges2026-07-28T01:30:16.5672105Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-07-28T01:30:16.5685027Z * Pulling base image v0.0.50 ...2026-07-28T01:30:52.2380161Z * Configuring bridge CNI (Container Networking Interface) ...2026-07-28T01:30:56.9257250Z * Verifying Kubernetes components...2026-07-28T01:30:56.9513845Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-07-28T01:30:57.5054395Z * Enabled addons: default-storageclass, storage-provisioner2026-07-28T01:31:37.1070681Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-07-28T01:31:37.1173336Z [command]/home/runner/bin/minikube version --short2026-07-28T01:31:37.1564433Z v1.38.12026-07-28T01:31:37.1786408Z ##[group]Run actions/setup-go@v62026-07-28T01:31:37.1786684Z with:2026-07-28T01:31:37.1786889Z go-version: 1.262026-07-28T01:31:37.1787110Z cache: true2026-07-28T01:31:37.1787350Z cache-dependency-path: go.sum2026-07-28T01:31:37.1787602Z check-latest: false2026-07-28T01:31:37.1789853Z token: ***2026-07-28T01:31:37.1790061Z ##[endgroup]2026-07-28T01:31:37.3039766Z Setup go version spec 1.262026-07-28T01:31:37.3097794Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-07-28T01:31:37.3100392Z Added go to the path2026-07-28T01:31:37.3104129Z Successfully set up Go version 1.262026-07-28T01:31:38.2283432Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-07-28T01:31:38.2313756Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-07-28T01:31:38.2341272Z /home/runner/go/pkg/mod2026-07-28T01:31:38.2367685Z /home/runner/.cache/go-build2026-07-28T01:31:38.3849572Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-07-28T01:31:39.5188945Z Received 134217728 of 251839808 (53.3%), 127.9 MBs/sec2026-07-28T01:31:40.0103050Z Received 251839808 of 251839808 (100.0%), 160.9 MBs/sec2026-07-28T01:31:40.0159942Z Cache Size: ~240 MB (251839808 B)2026-07-28T01:31:40.0218968Z [command]/usr/bin/tar -xf /home/runner/work/_temp/e1d69f00-8c94-4395-9417-31374cf2215f/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-07-28T01:31:41.8356112Z Cache restored successfully2026-07-28T01:31:41.8702657Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-07-28T01:31:41.8727984Z go version go1.26.5 linux/amd642026-07-28T01:31:41.8728255Z 2026-07-28T01:31:41.8728660Z ##[group]go env2026-07-28T01:31:41.9217777Z AR='ar'2026-07-28T01:31:41.9218160Z CC='gcc'2026-07-28T01:31:41.9218547Z CGO_CFLAGS='-O2 -g'2026-07-28T01:31:41.9218979Z CGO_CPPFLAGS=''2026-07-28T01:31:41.9219381Z CGO_CXXFLAGS='-O2 -g'2026-07-28T01:31:41.9219774Z CGO_ENABLED='1'2026-07-28T01:31:41.9220112Z CGO_FFLAGS='-O2 -g'2026-07-28T01:31:41.9220446Z CGO_LDFLAGS='-O2 -g'2026-07-28T01:31:41.9221150Z CXX='g++'2026-07-28T01:31:41.9221458Z GCCGO='gccgo'2026-07-28T01:31:41.9221782Z GO111MODULE=''2026-07-28T01:31:41.9222103Z GOAMD64='v1'2026-07-28T01:31:41.9222642Z GOARCH='amd64'2026-07-28T01:31:41.9222970Z GOAUTH='netrc'2026-07-28T01:31:41.9223280Z GOBIN=''2026-07-28T01:31:41.9223631Z GOCACHE='/home/runner/.cache/go-build'2026-07-28T01:31:41.9224104Z GOCACHEPROG=''2026-07-28T01:31:41.9224436Z GODEBUG=''2026-07-28T01:31:41.9224912Z GOENV='/home/runner/.config/go/env'2026-07-28T01:31:41.9225327Z GOEXE=''2026-07-28T01:31:41.9225592Z GOEXPERIMENT=''2026-07-28T01:31:41.9225893Z GOFIPS140='off'2026-07-28T01:31:41.9226184Z GOFLAGS=''2026-07-28T01:31:41.9227143Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build4146669130=/tmp/go-build -gno-record-gcc-switches'2026-07-28T01:31:41.9228075Z GOHOSTARCH='amd64'2026-07-28T01:31:41.9228395Z GOHOSTOS='linux'2026-07-28T01:31:41.9228737Z GOINSECURE=''2026-07-28T01:31:41.9229264Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-07-28T01:31:41.9229885Z GOMODCACHE='/home/runner/go/pkg/mod'2026-07-28T01:31:41.9230258Z GONOPROXY=''2026-07-28T01:31:41.9230548Z GONOSUMDB=''2026-07-28T01:31:41.9230805Z GOOS='linux'2026-07-28T01:31:41.9231106Z GOPATH='/home/runner/go'2026-07-28T01:31:41.9231441Z GOPRIVATE=''2026-07-28T01:31:41.9231793Z GOPROXY='https://proxy.golang.org,direct'2026-07-28T01:31:41.9232442Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-07-28T01:31:41.9232838Z GOSUMDB='sum.golang.org'2026-07-28T01:31:41.9233172Z GOTELEMETRY='local'2026-07-28T01:31:41.9233538Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-07-28T01:31:41.9233998Z GOTMPDIR=''2026-07-28T01:31:41.9234243Z GOTOOLCHAIN='local'2026-07-28T01:31:41.9234964Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-07-28T01:31:41.9235478Z GOVCS=''2026-07-28T01:31:41.9235734Z GOVERSION='go1.26.5'2026-07-28T01:31:41.9236028Z GOWORK=''2026-07-28T01:31:41.9236345Z PKG_CONFIG='pkg-config'2026-07-28T01:31:41.9236539Z 2026-07-28T01:31:41.9236966Z ##[endgroup]2026-07-28T01:31:41.9381391Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-07-28T01:31:41.9381869Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-07-28T01:31:41.9415435Z shell: /usr/bin/bash -e {0}2026-07-28T01:31:41.9415738Z env:2026-07-28T01:31:41.9415962Z GOTOOLCHAIN: local2026-07-28T01:31:41.9416217Z OSPOOL_EP_OSPoolEPTag: 25-release2026-07-28T01:31:41.9416500Z OSPOOL_EP_CMTag: 25.0-el92026-07-28T01:31:41.9416756Z OSPOOL_EP_CvmfsType: cvmfsexec2026-07-28T01:31:41.9417011Z ##[endgroup]2026-07-28T01:31:50.1520582Z === RUN TestOSPoolEP2026-07-28T01:31:50.1522598Z === PAUSE TestOSPoolEP2026-07-28T01:31:50.1522922Z === CONT TestOSPoolEP2026-07-28T01:31:50.1523644Z TestOSPoolEP 2026-07-28T01:31:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:31:50.2167665Z TestOSPoolEP 2026-07-28T01:31:50Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 apply -f /tmp/TestOSPoolEP3436220691]2026-07-28T01:31:51.1483650Z TestOSPoolEP 2026-07-28T01:31:51Z logger.go:67: pod/idtoken-generator created2026-07-28T01:31:51.2795572Z TestOSPoolEP 2026-07-28T01:31:51Z logger.go:67: secret/pool-passwd created2026-07-28T01:31:51.2817222Z TestOSPoolEP 2026-07-28T01:31:51Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-07-28T01:31:51.2818467Z TestOSPoolEP 2026-07-28T01:31:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:31:51.3436431Z TestOSPoolEP 2026-07-28T01:31:51Z 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-28T01:32:01.3438419Z TestOSPoolEP 2026-07-28T01:32:01Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-07-28T01:32:01.3442232Z TestOSPoolEP 2026-07-28T01:32:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:32:01.3466177Z TestOSPoolEP 2026-07-28T01:32:01Z 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-28T01:32:11.3472729Z TestOSPoolEP 2026-07-28T01:32:11Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-07-28T01:32:11.3577021Z TestOSPoolEP 2026-07-28T01:32:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:32:11.3578068Z TestOSPoolEP 2026-07-28T01:32:11Z logger.go:67: Pod is now available2026-07-28T01:32:11.3579625Z TestOSPoolEP 2026-07-28T01:32:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-07-28T01:32:12.0373590Z TestOSPoolEP 2026-07-28T01:32:12Z logger.go:67: ***2026-07-28T01:32:12.0426317Z TestOSPoolEP 2026-07-28T01:32:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 apply -f /tmp/TestOSPoolEP2678512250]2026-07-28T01:32:12.2165404Z TestOSPoolEP 2026-07-28T01:32:12Z logger.go:67: secret/pool-token created2026-07-28T01:32:12.2181679Z TestOSPoolEP 2026-07-28T01:32:12Z retry.go:91: Wait for secret pool-token to be provisioned.2026-07-28T01:32:12.2182758Z TestOSPoolEP 2026-07-28T01:32:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:32:12.2203611Z TestOSPoolEP 2026-07-28T01:32:12Z logger.go:67: Secret is now available2026-07-28T01:32:12.2216490Z TestOSPoolEP 2026-07-28T01:32:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 apply -k /tmp/kustomize-template-3220468251]2026-07-28T01:32:12.5384661Z TestOSPoolEP 2026-07-28T01:32:12Z logger.go:67: service/test-cm created2026-07-28T01:32:12.5459508Z TestOSPoolEP 2026-07-28T01:32:12Z 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-28T01:32:12.5462033Z TestOSPoolEP 2026-07-28T01:32:12Z logger.go:67: deployment.apps/ospool-ep created2026-07-28T01:32:12.5533625Z TestOSPoolEP 2026-07-28T01:32:12Z logger.go:67: deployment.apps/test-cm created2026-07-28T01:32:12.5594714Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-07-28T01:32:12.5596541Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:32:12.5778897Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:12Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-07-28T01:32:12.5780878Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:32:12.5782804Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:12Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-28T01:32:12.5817844Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:32:12.5894392Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:12Z 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-07-28T01:32:12.5939825Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32: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: NewReplicaSetCreated, message: Created new replica set "ospool-ep-6c7d796845". Sleeping for 10s and will try again.2026-07-28T01:32:22.5898378Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:22Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-07-28T01:32:22.5899555Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:32:22.5928521Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:22Z logger.go:67: Deployment is now available2026-07-28T01:32:22.5947557Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:22Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-28T01:32:22.5949165Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:32:22.5968840Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:22Z 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-07-28T01:32:32.5992195Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:32Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-28T01:32:32.5993848Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:32:32.6021582Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:32Z 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-07-28T01:32:42.6035912Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:42Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-28T01:32:42.6037382Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:32:42.6062971Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-28T01:32:42Z logger.go:67: Deployment is now available2026-07-28T01:32:42.6064067Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-28T01:32:42.6064753Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-28T01:32:42.6065550Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-07-28T01:32:42.6066342Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-07-28T01:32:42.6067199Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-28T01:32:42.6067925Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-28T01:32:42.6069009Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-28T01:32:42.6073167Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-28T01:32:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:32:42.6084725Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-28T01:32:42.6092613Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:32:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:32:42.6097418Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-07-28T01:32:42.6103486Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-28T01:32:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:32:42.6105450Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-28T01:32:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:32:42.6108031Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:32:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:32:42.6131477Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-28T01:32:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:32:42.6139753Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:32:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-28T01:32:42.6146007Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-28T01:32:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)']2026-07-28T01:32:42.6157382Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-28T01:32:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_SINGULARITY]2026-07-28T01:32:42.8234986Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-pvwg2 failed. Retrying in 10s.2026-07-28T01:32:42.8376699Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-28T01:32:42.8378469Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)']' in pod test-cm-54b7d49f85-pvwg2 failed. Retrying in 10s.2026-07-28T01:32:42.8379399Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-28T01:32:42.8380529Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pvwg2 failed. Retrying in 30s.2026-07-28T01:32:52.8254627Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-28T01:32:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_SINGULARITY]2026-07-28T01:32:52.8389007Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-28T01:32:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)']2026-07-28T01:32:52.9932134Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-07-28T01:32:52.9934612Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-pvwg2 failed. Retrying in 10s.2026-07-28T01:32:53.0025195Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-28T01:32:53.0026517Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)']' in pod test-cm-54b7d49f85-pvwg2 failed. Retrying in 10s.2026-07-28T01:33:02.9963818Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-28T01:33:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_SINGULARITY]2026-07-28T01:33:03.0045860Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-28T01:33:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)']2026-07-28T01:33:03.2213624Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-28T01:33:03Z logger.go:67: true2026-07-28T01:33:03.2351628Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-28T01:33:03Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-07-28T01:33:03.2356080Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-28T01:33:03Z logger.go:67: 2026-07-28T01:33:03.2357527Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-28T01:33:03Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-cqw5n LINUX X86_64 Unclaimed Idle 0.000 15990 0+00:00:002026-07-28T01:33:03.2358906Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-28T01:33:03Z logger.go:67: 2026-07-28T01:33:03.2360065Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-28T01:33:03Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-07-28T01:33:03.2361202Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-28T01:33:03Z logger.go:67: 2026-07-28T01:33:03.2362600Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-28T01:33:03Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-07-28T01:33:03.2363579Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-28T01:33:03Z logger.go:67: 2026-07-28T01:33:03.2364580Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-28T01:33:03Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-07-28T01:33:12.8388516Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:33:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-28T01:33:12.9798244Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:33:12Z logger.go:67: undefined2026-07-28T01:33:12.9839181Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-28T01:33:12.9840463Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pvwg2 failed. Retrying in 30s.2026-07-28T01:33:42.9847352Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:33:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-28T01:33:43.1260705Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:33:43Z logger.go:67: undefined2026-07-28T01:33:43.1292557Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pvwg2 failed. Retrying in 30s.2026-07-28T01:34:13.1304885Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:34:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-28T01:34:13.2749407Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:34:13Z logger.go:67: undefined2026-07-28T01:34:13.2782410Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pvwg2 failed. Retrying in 30s.2026-07-28T01:34:43.2788258Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:34:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-28T01:34:43.4167092Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:34:43Z logger.go:67: undefined2026-07-28T01:34:43.4203206Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pvwg2 failed. Retrying in 30s.2026-07-28T01:35:13.4234306Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:35:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-28T01:35:13.5648555Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:35:13Z logger.go:67: undefined2026-07-28T01:35:13.5690198Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pvwg2 failed. Retrying in 30s.2026-07-28T01:35:43.5726089Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:35:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-28T01:35:43.7424952Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:35:43Z logger.go:67: undefined2026-07-28T01:35:43.7464829Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pvwg2 failed. Retrying in 30s.2026-07-28T01:36:13.7497280Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:36:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-28T01:36:13.8879475Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:36:13Z logger.go:67: undefined2026-07-28T01:36:13.8926630Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pvwg2 failed. Retrying in 30s.2026-07-28T01:36:43.8932084Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:36:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-28T01:36:44.0597333Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:36:44Z logger.go:67: undefined2026-07-28T01:36:44.0634197Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pvwg2 failed. Retrying in 30s.2026-07-28T01:37:14.0670334Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:37:14Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-28T01:37:14.2047597Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:37:14Z logger.go:67: undefined2026-07-28T01:37:14.2085380Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pvwg2 failed. Retrying in 30s.2026-07-28T01:37:44.2116595Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:37:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-28T01:37:44.3543895Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:37:44Z logger.go:67: undefined2026-07-28T01:37:44.3585548Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pvwg2 failed. Retrying in 30s.2026-07-28T01:38:14.3616831Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:38:14Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 exec test-cm-54b7d49f85-pvwg2 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cqw5n",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-28T01:38:14.5083437Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-28T01:38:14Z logger.go:67: true2026-07-28T01:38:14.5122199Z TestOSPoolEP 2026-07-28T01:38:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:38:14.5199861Z TestOSPoolEP 2026-07-28T01:38:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:38:14.7006957Z TestOSPoolEP 2026-07-28T01:38:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:38:14.8152837Z TestOSPoolEP 2026-07-28T01:38:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:38:14.9146355Z TestOSPoolEP 2026-07-28T01:38:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:38:14.9169197Z === NAME TestOSPoolEP2026-07-28T01:38:14.9169799Z ospool_ep_test.go:101: ---2026-07-28T01:38:14.9171876Z Events for pod idtoken-generator:2026-07-28T01:38:14.9173675Z 2026-07-28 01:31:51 +0000 UTC Normal Successfully assigned test-ospool-ep-phxra1/idtoken-generator to minikube2026-07-28T01:38:14.9174862Z 2026-07-28 01:31:56 +0000 UTC Normal Pulling image "htcondor/base"2026-07-28T01:38:14.9176200Z 2026-07-28 01:32:07 +0000 UTC Normal Successfully pulled image "htcondor/base" in 10.722s (10.722s including waiting). Image size: 560910730 bytes.2026-07-28T01:38:14.9177174Z 2026-07-28 01:32:07 +0000 UTC Normal Container created2026-07-28T01:38:14.9177856Z 2026-07-28 01:32:07 +0000 UTC Normal Container started2026-07-28T01:38:14.9178191Z 2026-07-28T01:38:14.9178584Z ---2026-07-28T01:38:14.9179291Z TestOSPoolEP 2026-07-28T01:38:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:38:14.9194502Z ospool_ep_test.go:101: ---2026-07-28T01:38:14.9195092Z Events for pod ospool-ep-6c7d796845-cqw5n:2026-07-28T01:38:14.9196205Z 2026-07-28 01:32:12 +0000 UTC Normal Successfully assigned test-ospool-ep-phxra1/ospool-ep-6c7d796845-cqw5n to minikube2026-07-28T01:38:14.9197435Z 2026-07-28 01:32:13 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-07-28T01:38:14.9198993Z 2026-07-28 01:32:14 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 984ms (984ms including waiting). Image size: 5590942 bytes.2026-07-28T01:38:14.9200030Z 2026-07-28 01:32:14 +0000 UTC Normal Container created2026-07-28T01:38:14.9200704Z 2026-07-28 01:32:14 +0000 UTC Normal Container started2026-07-28T01:38:14.9201573Z 2026-07-28 01:32:15 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-07-28T01:38:14.9203690Z 2026-07-28 01:32:40 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 19.579s (25.47s including waiting). Image size: 1383210994 bytes.2026-07-28T01:38:14.9204789Z 2026-07-28 01:32:40 +0000 UTC Normal Container created2026-07-28T01:38:14.9205438Z 2026-07-28 01:32:40 +0000 UTC Normal Container started2026-07-28T01:38:14.9205998Z 2026-07-28T01:38:14.9206398Z ---2026-07-28T01:38:14.9207228Z TestOSPoolEP 2026-07-28T01:38:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:38:14.9217602Z ospool_ep_test.go:101: ---2026-07-28T01:38:14.9218875Z Events for pod test-cm-54b7d49f85-pvwg2:2026-07-28T01:38:14.9220045Z 2026-07-28 01:32:12 +0000 UTC Normal Successfully assigned test-ospool-ep-phxra1/test-cm-54b7d49f85-pvwg2 to minikube2026-07-28T01:38:14.9221212Z 2026-07-28 01:32:13 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-07-28T01:38:14.9222922Z 2026-07-28 01:32:20 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 6.895s (7.866s including waiting). Image size: 573055668 bytes.2026-07-28T01:38:14.9223953Z 2026-07-28 01:32:20 +0000 UTC Normal Container created2026-07-28T01:38:14.9224619Z 2026-07-28 01:32:20 +0000 UTC Normal Container started2026-07-28T01:38:14.9225079Z 2026-07-28T01:38:14.9225395Z ---2026-07-28T01:38:14.9226184Z TestOSPoolEP 2026-07-28T01:38:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-28T01:38:14.9272446Z TestOSPoolEP 2026-07-28T01:38:14Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 delete -f /tmp/TestOSPoolEP438387635]2026-07-28T01:38:15.0205205Z TestOSPoolEP 2026-07-28T01:38:15Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-phxra1 namespace2026-07-28T01:38:15.0269737Z TestOSPoolEP 2026-07-28T01:38:15Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-phxra1 namespace2026-07-28T01:38:16.0641999Z TestOSPoolEP 2026-07-28T01:38:16Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 delete -f /tmp/TestOSPoolEP3382064591]2026-07-28T01:38:16.1550888Z TestOSPoolEP 2026-07-28T01:38:16Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-phxra1 namespace2026-07-28T01:38:16.1580897Z TestOSPoolEP 2026-07-28T01:38:16Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-phxra1 delete -k /tmp/kustomize-template-3220468251]2026-07-28T01:38:16.2834028Z TestOSPoolEP 2026-07-28T01:38:16Z logger.go:67: service "test-cm" deleted from test-ospool-ep-phxra1 namespace2026-07-28T01:38:16.2888431Z TestOSPoolEP 2026-07-28T01:38:16Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-phxra1 namespace2026-07-28T01:38:16.2940959Z TestOSPoolEP 2026-07-28T01:38:16Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-phxra1 namespace2026-07-28T01:38:16.3101774Z --- PASS: TestOSPoolEP (54.25s)2026-07-28T01:38:16.3142635Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.05s)2026-07-28T01:38:16.3144389Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.62s)2026-07-28T01:38:16.3145367Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.63s)2026-07-28T01:38:16.3146238Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (331.90s)2026-07-28T01:38:16.3146791Z PASS2026-07-28T01:38:16.3147263Z ok github.com/osg-htc/k8s-integration-tests/test 386.174s2026-07-28T01:38:16.3831269Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-07-28T01:38:16.3831962Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-07-28T01:38:16.3872957Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-07-28T01:38:16.3873589Z env:2026-07-28T01:38:16.3873851Z GOTOOLCHAIN: local2026-07-28T01:38:16.3874389Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-07-28T01:38:16.3874932Z ##[endgroup]2026-07-28T01:38:16.4017369Z 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-28T01:38:16.4018853Z ##[group]Run actions/upload-artifact@v42026-07-28T01:38:16.4019195Z with:2026-07-28T01:38:16.4019652Z name: TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce72322026-07-28T01:38:16.4020205Z path: /tmp/k8s-tests2026-07-28T01:38:16.4020488Z retention-days: 52026-07-28T01:38:16.4020763Z if-no-files-found: warn2026-07-28T01:38:16.4021056Z compression-level: 62026-07-28T01:38:16.4021346Z overwrite: false2026-07-28T01:38:16.4021616Z include-hidden-files: false2026-07-28T01:38:16.4021907Z env:2026-07-28T01:38:16.4022147Z GOTOOLCHAIN: local2026-07-28T01:38:16.4022592Z ##[endgroup]2026-07-28T01:38:16.6048261Z (node:17874) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-07-28T01:38:16.6053965Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-07-28T01:38:16.6343866Z With the provided path, there will be 6 files uploaded2026-07-28T01:38:16.6347451Z Artifact name is valid!2026-07-28T01:38:16.6350550Z Root directory input is valid!2026-07-28T01:38:16.8487909Z Beginning upload of artifact content to blob storage2026-07-28T01:38:16.8759072Z (node:17874) [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-28T01:38:17.0066622Z Uploaded bytes 141982026-07-28T01:38:17.0415323Z Finished uploading artifact content to blob storage!2026-07-28T01:38:17.0418771Z SHA256 digest of uploaded artifact zip is 55b635f4b0a8b2889f1cb16c617b422e2f8ebd6036d9b23e41121500102dba282026-07-28T01:38:17.0421299Z Finalizing artifact upload2026-07-28T01:38:17.2046401Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232.zip successfully finalized. Artifact ID 86739106162026-07-28T01:38:17.2048101Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232 has been successfully uploaded! Final size is 14198 bytes. Artifact ID is 86739106162026-07-28T01:38:17.2053515Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/30320418545/artifacts/86739106162026-07-28T01:38:17.2189847Z Post job cleanup.2026-07-28T01:38:17.3429132Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-07-28T01:38:17.3478103Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-07-28T01:38:17.3511363Z /home/runner/go/pkg/mod2026-07-28T01:38:17.3535847Z /home/runner/.cache/go-build2026-07-28T01:38:17.3543547Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-07-28T01:38:17.3654716Z Post job cleanup.2026-07-28T01:38:17.4585777Z [command]/usr/bin/git version2026-07-28T01:38:17.4623391Z git version 2.54.02026-07-28T01:38:17.4664470Z Temporarily overriding HOME='/home/runner/work/_temp/c7dcc8c1-f4f1-47a4-a355-118cf3a01b86' before making global git config changes2026-07-28T01:38:17.4665640Z Adding repository directory to the temporary git global config as a safe directory2026-07-28T01:38:17.4668404Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-07-28T01:38:17.4707532Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-07-28T01:38:17.4740406Z [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-28T01:38:17.4967092Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-07-28T01:38:17.4990789Z http.https://github.com/.extraheader2026-07-28T01:38:17.5003534Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-07-28T01:38:17.5039057Z [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-28T01:38:17.5264278Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-07-28T01:38:17.5297424Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-07-28T01:38:17.5664808Z Cleaning up orphan processes2026-07-28T01:38:17.6276940Z ##[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/