2026-08-16T00:39:14.7450059Z Current runner version: '2.336.0'2026-08-16T00:39:14.7486601Z ##[group]Runner Image Provisioner2026-08-16T00:39:14.7487841Z Hosted Compute Agent2026-08-16T00:39:14.7488843Z Version: 20260729.5662026-08-16T00:39:14.7489906Z Commit: cf7153fe6e25b664e8693c24944bf2b00355d1092026-08-16T00:39:14.7491069Z Build Date: 2026-07-29T19:17:02Z2026-08-16T00:39:14.7492282Z Worker ID: {fc66b664-d2d0-4a78-9aeb-6221dc49b138}2026-08-16T00:39:14.7493424Z Azure Region: eastus22026-08-16T00:39:14.7494302Z ##[endgroup]2026-08-16T00:39:14.7496695Z ##[group]Operating System2026-08-16T00:39:14.7497669Z Ubuntu2026-08-16T00:39:14.7498602Z 22.04.52026-08-16T00:39:14.7499465Z LTS2026-08-16T00:39:14.7500298Z ##[endgroup]2026-08-16T00:39:14.7501303Z ##[group]Runner Image2026-08-16T00:39:14.7502229Z Image: ubuntu-22.042026-08-16T00:39:14.7503114Z Version: 20260810.260.12026-08-16T00:39:14.7505329Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260810.260/images/ubuntu/Ubuntu2204-Readme.md2026-08-16T00:39:14.7508157Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260810.2602026-08-16T00:39:14.7509771Z ##[endgroup]2026-08-16T00:39:14.7511876Z ##[group]GITHUB_TOKEN Permissions2026-08-16T00:39:14.7515155Z Contents: read2026-08-16T00:39:14.7516302Z Metadata: read2026-08-16T00:39:14.7517984Z Packages: read2026-08-16T00:39:14.7518893Z ##[endgroup]2026-08-16T00:39:14.7521738Z Secret source: Actions2026-08-16T00:39:14.7523952Z Prepare workflow directory2026-08-16T00:39:14.7994690Z Prepare all required actions2026-08-16T00:39:14.8064274Z Getting action download info2026-08-16T00:39:15.0129668Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-16T00:39:15.1376928Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-16T00:39:15.3010751Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-16T00:39:15.4931536Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-16T00:39:15.7496861Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-16T00:39:15.7501966Z ##[group] Inputs2026-08-16T00:39:15.7502531Z testName: TestOSPoolEP2026-08-16T00:39:15.7503461Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-16T00:39:15.7504445Z setupScript: 2026-08-16T00:39:15.7504923Z setupEnv: {}2026-08-16T00:39:15.7505397Z ##[endgroup]2026-08-16T00:39:15.7506491Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-testing) / Run Tests2026-08-16T00:39:15.8289930Z ##[group]Run actions/checkout@v52026-08-16T00:39:15.8290838Z with:2026-08-16T00:39:15.8291358Z repository: mwestphall/k8s-integration-tests2026-08-16T00:39:15.8295868Z token: ***2026-08-16T00:39:15.8296331Z ssh-strict: true2026-08-16T00:39:15.8296858Z ssh-user: git2026-08-16T00:39:15.8297345Z persist-credentials: true2026-08-16T00:39:15.8297851Z clean: true2026-08-16T00:39:15.8298306Z sparse-checkout-cone-mode: true2026-08-16T00:39:15.8298837Z fetch-depth: 12026-08-16T00:39:15.8299277Z fetch-tags: false2026-08-16T00:39:15.8299745Z show-progress: true2026-08-16T00:39:15.8300486Z lfs: false2026-08-16T00:39:15.8300985Z submodules: false2026-08-16T00:39:15.8301457Z set-safe-directory: true2026-08-16T00:39:15.8301971Z allow-unsafe-pr-checkout: false2026-08-16T00:39:15.8302751Z ##[endgroup]2026-08-16T00:39:15.9419684Z Syncing repository: mwestphall/k8s-integration-tests2026-08-16T00:39:15.9423048Z ##[group]Getting Git version info2026-08-16T00:39:15.9424860Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-16T00:39:15.9427325Z [command]/usr/bin/git version2026-08-16T00:39:15.9450510Z git version 2.54.02026-08-16T00:39:15.9505951Z ##[endgroup]2026-08-16T00:39:15.9522434Z Temporarily overriding HOME='/home/runner/work/_temp/6e6e4b4f-4fea-4291-b1c3-a87089111353' before making global git config changes2026-08-16T00:39:15.9525079Z Adding repository directory to the temporary git global config as a safe directory2026-08-16T00:39:15.9528235Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-16T00:39:15.9575388Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-16T00:39:15.9580359Z ##[group]Initializing the repository2026-08-16T00:39:15.9585781Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-16T00:39:15.9678617Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-16T00:39:15.9680920Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-16T00:39:15.9683115Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-16T00:39:15.9684972Z hint: call:2026-08-16T00:39:15.9686375Z hint:2026-08-16T00:39:15.9687623Z hint: git config --global init.defaultBranch <name>2026-08-16T00:39:15.9688997Z hint:2026-08-16T00:39:15.9690300Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-16T00:39:15.9692216Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-16T00:39:15.9693931Z hint:2026-08-16T00:39:15.9695069Z hint: git branch -m <name>2026-08-16T00:39:15.9696698Z hint:2026-08-16T00:39:15.9698129Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-16T00:39:15.9700371Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-16T00:39:15.9704530Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-16T00:39:15.9746484Z ##[endgroup]2026-08-16T00:39:15.9747876Z ##[group]Disabling automatic garbage collection2026-08-16T00:39:15.9752936Z [command]/usr/bin/git config --local gc.auto 02026-08-16T00:39:15.9817610Z ##[endgroup]2026-08-16T00:39:15.9818910Z ##[group]Setting up auth2026-08-16T00:39:15.9824998Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-16T00:39:15.9867604Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :"2026-08-16T00:39:16.0271952Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-16T00:39:16.0324397Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :"2026-08-16T00:39:16.0632711Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-16T00:39:16.0677372Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-16T00:39:16.0969315Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-16T00:39:16.1019250Z ##[endgroup]2026-08-16T00:39:16.1020573Z ##[group]Fetching the repository2026-08-16T00:39:16.1029603Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-16T00:39:16.3840600Z From https://github.com/mwestphall/k8s-integration-tests2026-08-16T00:39:16.3842847Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-16T00:39:16.3872278Z ##[endgroup]2026-08-16T00:39:16.3873534Z ##[group]Determining the checkout info2026-08-16T00:39:16.3875065Z ##[endgroup]2026-08-16T00:39:16.3882268Z [command]/usr/bin/git sparse-checkout disable2026-08-16T00:39:16.3939019Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-16T00:39:16.3982246Z ##[group]Checking out the ref2026-08-16T00:39:16.3987233Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-16T00:39:16.4093867Z Switched to a new branch 'main'2026-08-16T00:39:16.4096087Z branch 'main' set up to track 'origin/main'.2026-08-16T00:39:16.4102266Z ##[endgroup]2026-08-16T00:39:16.4163873Z [command]/usr/bin/git log -1 --format=%H2026-08-16T00:39:16.4200394Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-16T00:39:16.4494065Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-16T00:39:16.4497069Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-16T00:39:16.4499670Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-16T00:39:16.4811765Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-16T00:39:16.4813370Z env:2026-08-16T00:39:16.4815218Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-16T00:39:16.4817655Z SETUP_ENV_YAML: {}2026-08-16T00:39:16.4818636Z ##[endgroup]2026-08-16T00:39:17.3130808Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-16T00:39:17.3133252Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-16T00:39:17.3216636Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-16T00:39:17.3218019Z env:2026-08-16T00:39:17.3219774Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-16T00:39:17.3221849Z ##[endgroup]2026-08-16T00:39:17.3450252Z ##[group]Run true2026-08-16T00:39:17.3451155Z [36;1mtrue[0m2026-08-16T00:39:17.3539247Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-16T00:39:17.3540651Z ##[endgroup]2026-08-16T00:39:17.3873040Z ##[group]Run medyagh/setup-minikube@latest2026-08-16T00:39:17.3874190Z with:2026-08-16T00:39:17.3874958Z start: true2026-08-16T00:39:17.3875883Z cache: true2026-08-16T00:39:17.3876748Z minikube-version: latest2026-08-16T00:39:17.3877712Z wait: all2026-08-16T00:39:17.3878492Z ##[endgroup]2026-08-16T00:39:17.5267693Z (node:1915) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-16T00:39:17.5271646Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-16T00:39:18.2066860Z [command]/usr/bin/chmod +x /home/runner/work/_temp/6e886464-501e-4ddb-9c76-4f956ee7ae8e2026-08-16T00:39:18.3792859Z [command]/home/runner/bin/minikube version --short2026-08-16T00:39:18.4392157Z v1.38.12026-08-16T00:39:18.5120846Z Cache hit for: kic-v1.38.1-x642026-08-16T00:39:18.5127979Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-16T00:39:18.5237416Z (node:1915) [DEP0169] DeprecationWarning: `url.parse()` behavior is not standardized and prone to errors that have security implications. Use the WHATWG URL API instead. CVEs are not issued for `url.parse()` vulnerabilities.2026-08-16T00:39:19.5713242Z Received 134217728 of 544082657 (24.7%), 127.5 MBs/sec2026-08-16T00:39:19.6097591Z Received 121634816 of 224218863 (54.2%), 113.7 MBs/sec2026-08-16T00:39:20.4983998Z Received 224218863 of 224218863 (100.0%), 112.0 MBs/sec2026-08-16T00:39:20.4985182Z Cache Size: ~214 MB (224218863 B)2026-08-16T00:39:20.5800630Z Received 289406976 of 544082657 (53.2%), 137.4 MBs/sec2026-08-16T00:39:20.5907776Z [command]/usr/bin/tar -xf /home/runner/work/_temp/94c99bca-e397-4f86-932a-91fb653e1406/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-16T00:39:21.2177100Z Cache restored successfully2026-08-16T00:39:21.5771535Z Received 478150656 of 544082657 (87.9%), 151.5 MBs/sec2026-08-16T00:39:21.9402695Z Received 544082657 of 544082657 (100.0%), 153.8 MBs/sec2026-08-16T00:39:21.9404077Z Cache Size: ~519 MB (544082657 B)2026-08-16T00:39:21.9530836Z [command]/usr/bin/tar -xf /home/runner/work/_temp/4cd28a37-a27d-4965-b9c9-4cded45f8d5e/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-16T00:39:22.8211697Z Cache restored successfully2026-08-16T00:39:22.9470788Z [command]/home/runner/bin/minikube start --wait all2026-08-16T00:39:23.0082430Z * minikube v1.38.1 on Ubuntu 22.042026-08-16T00:39:27.8111360Z * Automatically selected the docker driver. Other choices: podman, ssh, none2026-08-16T00:39:27.9146113Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-16T00:39:27.9154385Z * Using Docker driver with root privileges2026-08-16T00:39:27.9163868Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-16T00:39:27.9172889Z * Pulling base image v0.0.50 ...2026-08-16T00:39:59.1583098Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-16T00:40:03.8237342Z * Verifying Kubernetes components...2026-08-16T00:40:03.8524462Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-16T00:40:04.4948909Z * Enabled addons: default-storageclass, storage-provisioner2026-08-16T00:40:47.6337001Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-16T00:40:47.6447849Z [command]/home/runner/bin/minikube version --short2026-08-16T00:40:47.6948737Z v1.38.12026-08-16T00:40:47.7311622Z ##[group]Run actions/setup-go@v62026-08-16T00:40:47.7312059Z with:2026-08-16T00:40:47.7312268Z go-version: 1.262026-08-16T00:40:47.7312483Z cache: true2026-08-16T00:40:47.7312720Z cache-dependency-path: go.sum2026-08-16T00:40:47.7312985Z check-latest: false2026-08-16T00:40:47.7315404Z token: ***2026-08-16T00:40:47.7315887Z ##[endgroup]2026-08-16T00:40:47.8827682Z Setup go version spec 1.262026-08-16T00:40:47.9068179Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-16T00:40:47.9071034Z Added go to the path2026-08-16T00:40:47.9074127Z Successfully set up Go version 1.262026-08-16T00:40:48.4408071Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-16T00:40:48.4455914Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-16T00:40:48.4498375Z /home/runner/go/pkg/mod2026-08-16T00:40:48.4537254Z /home/runner/.cache/go-build2026-08-16T00:40:48.5375250Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-16T00:40:49.5877789Z Received 180355072 of 251839808 (71.6%), 171.1 MBs/sec2026-08-16T00:40:49.9293330Z Received 251839808 of 251839808 (100.0%), 178.2 MBs/sec2026-08-16T00:40:49.9294496Z Cache Size: ~240 MB (251839808 B)2026-08-16T00:40:49.9366021Z [command]/usr/bin/tar -xf /home/runner/work/_temp/995c3a66-99b6-483f-be8d-6f8b5d479c9c/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-16T00:40:53.0612991Z Cache restored successfully2026-08-16T00:40:53.1291090Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-16T00:40:53.1317723Z go version go1.26.5 linux/amd642026-08-16T00:40:53.1318059Z 2026-08-16T00:40:53.1318531Z ##[group]go env2026-08-16T00:40:53.2148868Z AR='ar'2026-08-16T00:40:53.2149562Z CC='gcc'2026-08-16T00:40:53.2150235Z CGO_CFLAGS='-O2 -g'2026-08-16T00:40:53.2150604Z CGO_CPPFLAGS=''2026-08-16T00:40:53.2150858Z CGO_CXXFLAGS='-O2 -g'2026-08-16T00:40:53.2151113Z CGO_ENABLED='1'2026-08-16T00:40:53.2151333Z CGO_FFLAGS='-O2 -g'2026-08-16T00:40:53.2151568Z CGO_LDFLAGS='-O2 -g'2026-08-16T00:40:53.2151790Z CXX='g++'2026-08-16T00:40:53.2152005Z GCCGO='gccgo'2026-08-16T00:40:53.2152241Z GO111MODULE=''2026-08-16T00:40:53.2152501Z GOAMD64='v1'2026-08-16T00:40:53.2152707Z GOARCH='amd64'2026-08-16T00:40:53.2152910Z GOAUTH='netrc'2026-08-16T00:40:53.2153653Z GOBIN=''2026-08-16T00:40:53.2153888Z GOCACHE='/home/runner/.cache/go-build'2026-08-16T00:40:53.2154287Z GOCACHEPROG=''2026-08-16T00:40:53.2154502Z GODEBUG=''2026-08-16T00:40:53.2154796Z GOENV='/home/runner/.config/go/env'2026-08-16T00:40:53.2155071Z GOEXE=''2026-08-16T00:40:53.2155331Z GOEXPERIMENT=''2026-08-16T00:40:53.2178188Z GOFIPS140='off'2026-08-16T00:40:53.2178477Z GOFLAGS=''2026-08-16T00:40:53.2179263Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build3931215595=/tmp/go-build -gno-record-gcc-switches'2026-08-16T00:40:53.2179972Z GOHOSTARCH='amd64'2026-08-16T00:40:53.2180205Z GOHOSTOS='linux'2026-08-16T00:40:53.2180418Z GOINSECURE=''2026-08-16T00:40:53.2180798Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-16T00:40:53.2181229Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-16T00:40:53.2181516Z GONOPROXY=''2026-08-16T00:40:53.2181722Z GONOSUMDB=''2026-08-16T00:40:53.2181929Z GOOS='linux'2026-08-16T00:40:53.2182145Z GOPATH='/home/runner/go'2026-08-16T00:40:53.2182396Z GOPRIVATE=''2026-08-16T00:40:53.2182686Z GOPROXY='https://proxy.golang.org,direct'2026-08-16T00:40:53.2183038Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-16T00:40:53.2183356Z GOSUMDB='sum.golang.org'2026-08-16T00:40:53.2183602Z GOTELEMETRY='local'2026-08-16T00:40:53.2183889Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-16T00:40:53.2184202Z GOTMPDIR=''2026-08-16T00:40:53.2184409Z GOTOOLCHAIN='local'2026-08-16T00:40:53.2185133Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-16T00:40:53.2185512Z GOVCS=''2026-08-16T00:40:53.2185972Z GOVERSION='go1.26.5'2026-08-16T00:40:53.2186210Z GOWORK=''2026-08-16T00:40:53.2186434Z PKG_CONFIG='pkg-config'2026-08-16T00:40:53.2186597Z 2026-08-16T00:40:53.2186987Z ##[endgroup]2026-08-16T00:40:53.2464200Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-16T00:40:53.2464741Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-16T00:40:53.2541852Z shell: /usr/bin/bash -e {0}2026-08-16T00:40:53.2542136Z env:2026-08-16T00:40:53.2542370Z GOTOOLCHAIN: local2026-08-16T00:40:53.2542636Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-08-16T00:40:53.2542943Z OSPOOL_EP_CMTag: 25.x-el92026-08-16T00:40:53.2543212Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-16T00:40:53.2543494Z ##[endgroup]2026-08-16T00:41:00.2900680Z === RUN TestOSPoolEP2026-08-16T00:41:00.2903276Z === PAUSE TestOSPoolEP2026-08-16T00:41:00.2903714Z === CONT TestOSPoolEP2026-08-16T00:41:00.2904678Z TestOSPoolEP 2026-08-16T00:41:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:00.3469014Z TestOSPoolEP 2026-08-16T00:41:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu apply -f /tmp/TestOSPoolEP3817945143]2026-08-16T00:41:00.8535797Z TestOSPoolEP 2026-08-16T00:41:00Z logger.go:67: pod/idtoken-generator created2026-08-16T00:41:00.8607084Z TestOSPoolEP 2026-08-16T00:41:00Z logger.go:67: secret/pool-passwd created2026-08-16T00:41:00.8693186Z TestOSPoolEP 2026-08-16T00:41:00Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-16T00:41:00.8694716Z TestOSPoolEP 2026-08-16T00:41:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:00.8737902Z TestOSPoolEP 2026-08-16T00:41:00Z retry.go:103: Wait for pod idtoken-generator to be provisioned. returned an error: Pod idtoken-generator is not available, reason: , message: . Sleeping for 10s and will try again.2026-08-16T00:41:10.8746365Z TestOSPoolEP 2026-08-16T00:41:10Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-16T00:41:10.8747955Z TestOSPoolEP 2026-08-16T00:41:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:10.8782086Z TestOSPoolEP 2026-08-16T00:41:10Z logger.go:67: Pod is now available2026-08-16T00:41:10.8784814Z TestOSPoolEP 2026-08-16T00:41:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-16T00:41:11.3296230Z TestOSPoolEP 2026-08-16T00:41:11Z logger.go:67: ***2026-08-16T00:41:11.3371951Z TestOSPoolEP 2026-08-16T00:41:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu apply -f /tmp/TestOSPoolEP743764648]2026-08-16T00:41:11.5357122Z TestOSPoolEP 2026-08-16T00:41:11Z logger.go:67: secret/pool-token created2026-08-16T00:41:11.5400516Z TestOSPoolEP 2026-08-16T00:41:11Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-16T00:41:11.5401913Z TestOSPoolEP 2026-08-16T00:41:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:11.5426956Z TestOSPoolEP 2026-08-16T00:41:11Z logger.go:67: Secret is now available2026-08-16T00:41:11.5456946Z TestOSPoolEP 2026-08-16T00:41:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu apply -k /tmp/kustomize-template-3049641275]2026-08-16T00:41:11.8338222Z TestOSPoolEP 2026-08-16T00:41:11Z logger.go:67: service/test-cm created2026-08-16T00:41:11.8445366Z TestOSPoolEP 2026-08-16T00:41:11Z logger.go:67: Warning: spec.template.spec.containers[0].env[8]: hides previous definition of "OSG_SQUID_LOCATION", which may be dropped when using apply2026-08-16T00:41:11.8447839Z TestOSPoolEP 2026-08-16T00:41:11Z logger.go:67: deployment.apps/ospool-ep created2026-08-16T00:41:11.8531481Z TestOSPoolEP 2026-08-16T00:41:11Z logger.go:67: deployment.apps/test-cm created2026-08-16T00:41:11.8597960Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-16T00:41:11.8600236Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:11.8658465Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:11Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-16T00:41:11.8660536Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:11.8667313Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:11Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-16T00:41:11.8669172Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:11.8764952Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:11Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available, missing 'Progressing' condition. Sleeping for 10s and will try again.2026-08-16T00:41:11.8768993Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:11Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-65c844ddbb". Sleeping for 10s and will try again.2026-08-16T00:41:21.8772152Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:21Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-16T00:41:21.8773842Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:21.8778192Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:21Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-16T00:41:21.8780015Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:21.8813967Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41: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: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-65c844ddbb" is progressing.. Sleeping for 10s and will try again.2026-08-16T00:41:21.8816282Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:21Z logger.go:67: Deployment is now available2026-08-16T00:41:31.8819321Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:31Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-16T00:41:31.8821249Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:31.8850601Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:31Z logger.go:67: Deployment is now available2026-08-16T00:41:31.8851411Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-16T00:41:31.8852071Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-16T00:41:31.8853160Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-16T00:41:31.8854088Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-16T00:41:31.8854841Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-16T00:41:31.8855512Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-16T00:41:31.8856377Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-16T00:41:31.8858173Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:41:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:31.8859573Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-16T00:41:31.8869811Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:41:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:31.8874293Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-16T00:41:31.8876531Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-16T00:41:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:31.8922427Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:41:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:31.8943853Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-16T00:41:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:31.8955312Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:41:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:31.8959651Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:41:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)']2026-08-16T00:41:31.8972560Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-16T00:41:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_SINGULARITY]2026-08-16T00:41:31.8985371Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:41:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:41:32.1875201Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-16T00:41:32.1879388Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-rscn4 failed. Retrying in 30s.2026-08-16T00:41:32.1891662Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-16T00:41:32.1907615Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)']' in pod test-cm-5bb545475c-rscn4 failed. Retrying in 10s.2026-08-16T00:41:32.1934458Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-16T00:41:32.1936594Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-rscn4 failed. Retrying in 10s.2026-08-16T00:41:42.1910266Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:41:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)']2026-08-16T00:41:42.1946191Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-16T00:41:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_SINGULARITY]2026-08-16T00:41:42.4454785Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-rscn4 failed. Retrying in 10s.2026-08-16T00:41:42.4475426Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-16T00:41:42.4478830Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)']' in pod test-cm-5bb545475c-rscn4 failed. Retrying in 10s.2026-08-16T00:41:52.4460426Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-16T00:41:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_SINGULARITY]2026-08-16T00:41:52.4487385Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:41:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)']2026-08-16T00:41:52.6782016Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-16T00:41:52Z logger.go:67: true2026-08-16T00:41:52.6891831Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:41:52Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-16T00:41:52.6894083Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:41:52Z logger.go:67: 2026-08-16T00:41:52.6896018Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:41:52Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-65c844ddbb-gk9bk LINUX X86_64 Unclaimed Idle 0.000 15988 0+00:00:002026-08-16T00:41:52.6897618Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:41:52Z logger.go:67: 2026-08-16T00:41:52.6899159Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:41:52Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-16T00:41:52.6900573Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:41:52Z logger.go:67: 2026-08-16T00:41:52.6901728Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:41:52Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-16T00:41:52.6902932Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:41:52Z logger.go:67: 2026-08-16T00:41:52.6904492Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:41:52Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-16T00:42:02.1878332Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:42:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:42:02.3570250Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:42:02Z logger.go:67: undefined2026-08-16T00:42:02.3643769Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-16T00:42:02.3645098Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-rscn4 failed. Retrying in 30s.2026-08-16T00:42:32.3654592Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:42:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:42:32.5269774Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:42:32Z logger.go:67: undefined2026-08-16T00:42:32.5335185Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-rscn4 failed. Retrying in 30s.2026-08-16T00:43:02.5344392Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:43:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:43:02.6969730Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:43:02Z logger.go:67: undefined2026-08-16T00:43:02.7052117Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-rscn4 failed. Retrying in 30s.2026-08-16T00:43:32.7054708Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:43:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:43:32.8691662Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:43:32Z logger.go:67: undefined2026-08-16T00:43:32.8757997Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-rscn4 failed. Retrying in 30s.2026-08-16T00:44:02.8759729Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:44:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:44:03.0413080Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:44:03Z logger.go:67: undefined2026-08-16T00:44:03.0489811Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-rscn4 failed. Retrying in 30s.2026-08-16T00:44:33.0518332Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:44:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:44:33.2224058Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:44:33Z logger.go:67: undefined2026-08-16T00:44:33.2293677Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-rscn4 failed. Retrying in 30s.2026-08-16T00:45:03.2316685Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:45:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:45:03.3968693Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:45:03Z logger.go:67: undefined2026-08-16T00:45:03.4041992Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-rscn4 failed. Retrying in 30s.2026-08-16T00:45:33.4044429Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:45:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:45:33.5661508Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:45:33Z logger.go:67: undefined2026-08-16T00:45:33.5735342Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-rscn4 failed. Retrying in 30s.2026-08-16T00:46:03.5737690Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:46:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:46:03.7371837Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:46:03Z logger.go:67: undefined2026-08-16T00:46:03.7447383Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-rscn4 failed. Retrying in 30s.2026-08-16T00:46:33.7454406Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:46:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:46:33.9054961Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:46:33Z logger.go:67: undefined2026-08-16T00:46:33.9124085Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-rscn4 failed. Retrying in 30s.2026-08-16T00:47:03.9153734Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:47:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu exec test-cm-5bb545475c-rscn4 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-gk9bk",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:47:04.1037472Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:47:04Z logger.go:67: true2026-08-16T00:47:04.1126983Z TestOSPoolEP 2026-08-16T00:47:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:47:04.1219829Z TestOSPoolEP 2026-08-16T00:47:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:47:04.2518730Z TestOSPoolEP 2026-08-16T00:47:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:47:04.3954765Z TestOSPoolEP 2026-08-16T00:47:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:47:04.5397156Z TestOSPoolEP 2026-08-16T00:47:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:47:04.5423995Z === NAME TestOSPoolEP2026-08-16T00:47:04.5424598Z ospool_ep_test.go:101: ---2026-08-16T00:47:04.5425154Z Events for pod idtoken-generator:2026-08-16T00:47:04.5426321Z 2026-08-16 00:41:00 +0000 UTC Normal Successfully assigned test-ospool-ep-fmsohu/idtoken-generator to minikube2026-08-16T00:47:04.5427246Z 2026-08-16 00:41:01 +0000 UTC Normal Pulling image "htcondor/base"2026-08-16T00:47:04.5428474Z 2026-08-16 00:41:09 +0000 UTC Normal Successfully pulled image "htcondor/base" in 7.832s (7.832s including waiting). Image size: 560910730 bytes.2026-08-16T00:47:04.5429437Z 2026-08-16 00:41:09 +0000 UTC Normal Container created2026-08-16T00:47:04.5430099Z 2026-08-16 00:41:09 +0000 UTC Normal Container started2026-08-16T00:47:04.5430624Z 2026-08-16T00:47:04.5430945Z ---2026-08-16T00:47:04.5431646Z TestOSPoolEP 2026-08-16T00:47:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:47:04.5451865Z ospool_ep_test.go:101: ---2026-08-16T00:47:04.5452554Z Events for pod ospool-ep-65c844ddbb-gk9bk:2026-08-16T00:47:04.5453964Z 2026-08-16 00:41:11 +0000 UTC Normal Successfully assigned test-ospool-ep-fmsohu/ospool-ep-65c844ddbb-gk9bk to minikube2026-08-16T00:47:04.5456831Z 2026-08-16 00:41:12 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-16T00:47:04.5459037Z 2026-08-16 00:41:14 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.885s (1.885s including waiting). Image size: 5590942 bytes.2026-08-16T00:47:04.5460525Z 2026-08-16 00:41:14 +0000 UTC Normal Container created2026-08-16T00:47:04.5461125Z 2026-08-16 00:41:14 +0000 UTC Normal Container started2026-08-16T00:47:04.5461873Z 2026-08-16 00:41:14 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-08-16T00:47:04.5463186Z 2026-08-16 00:41:30 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 15.525s (15.525s including waiting). Image size: 1273054585 bytes.2026-08-16T00:47:04.5464058Z 2026-08-16 00:41:30 +0000 UTC Normal Container created2026-08-16T00:47:04.5464532Z 2026-08-16 00:41:30 +0000 UTC Normal Container started2026-08-16T00:47:04.5464846Z 2026-08-16T00:47:04.5465087Z ---2026-08-16T00:47:04.5466031Z TestOSPoolEP 2026-08-16T00:47:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:47:04.5488037Z ospool_ep_test.go:101: ---2026-08-16T00:47:04.5488735Z Events for pod test-cm-5bb545475c-rscn4:2026-08-16T00:47:04.5490091Z 2026-08-16 00:41:11 +0000 UTC Normal Successfully assigned test-ospool-ep-fmsohu/test-cm-5bb545475c-rscn4 to minikube2026-08-16T00:47:04.5491395Z 2026-08-16 00:41:12 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-08-16T00:47:04.5493084Z 2026-08-16 00:41:14 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 312ms (2.175s including waiting). Image size: 560910756 bytes.2026-08-16T00:47:04.5494360Z 2026-08-16 00:41:14 +0000 UTC Normal Container created2026-08-16T00:47:04.5495191Z 2026-08-16 00:41:14 +0000 UTC Normal Container started2026-08-16T00:47:04.5495979Z 2026-08-16T00:47:04.5496351Z ---2026-08-16T00:47:04.5497251Z TestOSPoolEP 2026-08-16T00:47:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:47:04.5533592Z TestOSPoolEP 2026-08-16T00:47:04Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu delete -f /tmp/TestOSPoolEP990798646]2026-08-16T00:47:04.6591365Z TestOSPoolEP 2026-08-16T00:47:04Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-fmsohu namespace2026-08-16T00:47:04.6692259Z TestOSPoolEP 2026-08-16T00:47:04Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-fmsohu namespace2026-08-16T00:47:06.0826196Z TestOSPoolEP 2026-08-16T00:47:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu delete -f /tmp/TestOSPoolEP1397688983]2026-08-16T00:47:06.1901516Z TestOSPoolEP 2026-08-16T00:47:06Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-fmsohu namespace2026-08-16T00:47:06.1966413Z TestOSPoolEP 2026-08-16T00:47:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fmsohu delete -k /tmp/kustomize-template-3049641275]2026-08-16T00:47:06.3475979Z TestOSPoolEP 2026-08-16T00:47:06Z logger.go:67: service "test-cm" deleted from test-ospool-ep-fmsohu namespace2026-08-16T00:47:06.3544132Z TestOSPoolEP 2026-08-16T00:47:06Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-fmsohu namespace2026-08-16T00:47:06.3602862Z TestOSPoolEP 2026-08-16T00:47:06Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-fmsohu namespace2026-08-16T00:47:06.3767894Z --- PASS: TestOSPoolEP (33.86s)2026-08-16T00:47:06.3781422Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (20.03s)2026-08-16T00:47:06.3797111Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.80s)2026-08-16T00:47:06.3810044Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.81s)2026-08-16T00:47:06.3812109Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (332.23s)2026-08-16T00:47:06.3813001Z PASS2026-08-16T00:47:06.3813771Z ok github.com/osg-htc/k8s-integration-tests/test 366.103s2026-08-16T00:47:06.5083522Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-16T00:47:06.5084183Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-16T00:47:06.5169101Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-16T00:47:06.5169666Z env:2026-08-16T00:47:06.5169974Z GOTOOLCHAIN: local2026-08-16T00:47:06.5170673Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-16T00:47:06.5171432Z ##[endgroup]2026-08-16T00:47:06.5420371Z Node 20 is being deprecated. This workflow is running with Node 24 by default. If you need to temporarily use Node 20, you can set the ACTIONS_ALLOW_USE_UNSECURE_NODE_VERSION=true environment variable. For more information see: https://github.blog/changelog/2025-09-19-deprecation-of-node-20-on-github-actions-runners/2026-08-16T00:47:06.5422041Z ##[group]Run actions/upload-artifact@v42026-08-16T00:47:06.5422359Z with:2026-08-16T00:47:06.5422962Z name: TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe52026-08-16T00:47:06.5423464Z path: /tmp/k8s-tests2026-08-16T00:47:06.5423705Z retention-days: 52026-08-16T00:47:06.5423940Z if-no-files-found: warn2026-08-16T00:47:06.5424255Z compression-level: 62026-08-16T00:47:06.5424580Z overwrite: false2026-08-16T00:47:06.5424841Z include-hidden-files: false2026-08-16T00:47:06.5425096Z env:2026-08-16T00:47:06.5425305Z GOTOOLCHAIN: local2026-08-16T00:47:06.5425723Z ##[endgroup]2026-08-16T00:47:06.7716356Z (node:17096) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-16T00:47:06.7717316Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-16T00:47:06.7856967Z With the provided path, there will be 6 files uploaded2026-08-16T00:47:06.7858840Z Artifact name is valid!2026-08-16T00:47:06.7859707Z Root directory input is valid!2026-08-16T00:47:06.9465825Z Beginning upload of artifact content to blob storage2026-08-16T00:47:06.9779621Z (node:17096) [DEP0169] DeprecationWarning: `url.parse()` behavior is not standardized and prone to errors that have security implications. Use the WHATWG URL API instead. CVEs are not issued for `url.parse()` vulnerabilities.2026-08-16T00:47:07.0070340Z Uploaded bytes 139422026-08-16T00:47:07.0199657Z Finished uploading artifact content to blob storage!2026-08-16T00:47:07.0200802Z SHA256 digest of uploaded artifact zip is 8fd382f5b112193a758d7345b39bad6ac8ad97980e24ff5cbf4f2e7c8852cf742026-08-16T00:47:07.0202224Z Finalizing artifact upload2026-08-16T00:47:07.1989682Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5.zip successfully finalized. Artifact ID 92554987782026-08-16T00:47:07.1991797Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5 has been successfully uploaded! Final size is 13942 bytes. Artifact ID is 92554987782026-08-16T00:47:07.1997822Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/31917732211/artifacts/92554987782026-08-16T00:47:07.2234517Z Post job cleanup.2026-08-16T00:47:07.3852945Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-16T00:47:07.3916851Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-16T00:47:07.3987154Z /home/runner/go/pkg/mod2026-08-16T00:47:07.3991949Z /home/runner/.cache/go-build2026-08-16T00:47:07.4014339Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-16T00:47:07.4233471Z Post job cleanup.2026-08-16T00:47:07.5538344Z [command]/usr/bin/git version2026-08-16T00:47:07.5589251Z git version 2.54.02026-08-16T00:47:07.5635346Z Temporarily overriding HOME='/home/runner/work/_temp/050136a9-8c51-4728-9bcc-48e1c31d774a' before making global git config changes2026-08-16T00:47:07.5636908Z Adding repository directory to the temporary git global config as a safe directory2026-08-16T00:47:07.5642773Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-16T00:47:07.5696983Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-16T00:47:07.5745021Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :"2026-08-16T00:47:07.6080101Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-16T00:47:07.6114124Z http.https://github.com/.extraheader2026-08-16T00:47:07.6131403Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-16T00:47:07.6176770Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :"2026-08-16T00:47:07.6530330Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-16T00:47:07.6588839Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-16T00:47:07.7138455Z Cleaning up orphan processes2026-08-16T00:47:07.7930992Z ##[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/