2026-08-11T00:55:35.3679282Z Current runner version: '2.336.0'2026-08-11T00:55:35.3716356Z ##[group]Runner Image Provisioner2026-08-11T00:55:35.3717737Z Hosted Compute Agent2026-08-11T00:55:35.3718844Z Version: 20260707.5632026-08-11T00:55:35.3720018Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-08-11T00:55:35.3721320Z Build Date: 2026-07-07T19:33:50Z2026-08-11T00:55:35.3722727Z Worker ID: {c246d28b-3d32-43ba-bbcd-b403525eb95a}2026-08-11T00:55:35.3724332Z Azure Region: eastus2026-08-11T00:55:35.3725396Z ##[endgroup]2026-08-11T00:55:35.3728056Z ##[group]Operating System2026-08-11T00:55:35.3729803Z Ubuntu2026-08-11T00:55:35.3730778Z 22.04.52026-08-11T00:55:35.3731561Z LTS2026-08-11T00:55:35.3732537Z ##[endgroup]2026-08-11T00:55:35.3733426Z ##[group]Runner Image2026-08-11T00:55:35.3734922Z Image: ubuntu-22.042026-08-11T00:55:35.3735926Z Version: 20260720.234.22026-08-11T00:55:35.3738454Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-08-11T00:55:35.3741296Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-08-11T00:55:35.3743032Z ##[endgroup]2026-08-11T00:55:35.3745421Z ##[group]GITHUB_TOKEN Permissions2026-08-11T00:55:35.3748632Z Contents: read2026-08-11T00:55:35.3749600Z Metadata: read2026-08-11T00:55:35.3750517Z Packages: read2026-08-11T00:55:35.3751681Z ##[endgroup]2026-08-11T00:55:35.3755082Z Secret source: Actions2026-08-11T00:55:35.3757543Z Prepare workflow directory2026-08-11T00:55:35.4275719Z Prepare all required actions2026-08-11T00:55:35.4352446Z Getting action download info2026-08-11T00:55:35.5867925Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-11T00:55:35.8132079Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-11T00:55:35.9263036Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-11T00:55:36.0675234Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-11T00:55:36.3825320Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-11T00:55:36.3831864Z ##[group] Inputs2026-08-11T00:55:36.3832819Z testName: TestOSPoolEP2026-08-11T00:55:36.3834990Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-11T00:55:36.3836707Z setupScript: 2026-08-11T00:55:36.3837244Z setupEnv: {}2026-08-11T00:55:36.3837770Z ##[endgroup]2026-08-11T00:55:36.3838957Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-08-11T00:55:36.4689402Z ##[group]Run actions/checkout@v52026-08-11T00:55:36.4690453Z with:2026-08-11T00:55:36.4691029Z repository: mwestphall/k8s-integration-tests2026-08-11T00:55:36.4700654Z token: ***2026-08-11T00:55:36.4701149Z ssh-strict: true2026-08-11T00:55:36.4701686Z ssh-user: git2026-08-11T00:55:36.4702211Z persist-credentials: true2026-08-11T00:55:36.4702811Z clean: true2026-08-11T00:55:36.4703324Z sparse-checkout-cone-mode: true2026-08-11T00:55:36.4704141Z fetch-depth: 12026-08-11T00:55:36.4704626Z fetch-tags: false2026-08-11T00:55:36.4705144Z show-progress: true2026-08-11T00:55:36.4705663Z lfs: false2026-08-11T00:55:36.4706126Z submodules: false2026-08-11T00:55:36.4706644Z set-safe-directory: true2026-08-11T00:55:36.4707275Z allow-unsafe-pr-checkout: false2026-08-11T00:55:36.4708264Z ##[endgroup]2026-08-11T00:55:36.5741463Z Syncing repository: mwestphall/k8s-integration-tests2026-08-11T00:55:36.5744186Z ##[group]Getting Git version info2026-08-11T00:55:36.5745578Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-11T00:55:36.5747579Z [command]/usr/bin/git version2026-08-11T00:55:36.5865112Z git version 2.54.02026-08-11T00:55:36.5896828Z ##[endgroup]2026-08-11T00:55:36.5912952Z Temporarily overriding HOME='/home/runner/work/_temp/3d34f882-938a-44d8-851a-19a0cdcd32ec' before making global git config changes2026-08-11T00:55:36.5917148Z Adding repository directory to the temporary git global config as a safe directory2026-08-11T00:55:36.5920743Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-11T00:55:36.5962840Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-11T00:55:36.5966416Z ##[group]Initializing the repository2026-08-11T00:55:36.5972270Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-11T00:55:36.6099998Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-11T00:55:36.6102469Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-11T00:55:36.6105265Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-11T00:55:36.6106989Z hint: call:2026-08-11T00:55:36.6108280Z hint:2026-08-11T00:55:36.6109670Z hint: git config --global init.defaultBranch <name>2026-08-11T00:55:36.6111096Z hint:2026-08-11T00:55:36.6112357Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-11T00:55:36.6114657Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-11T00:55:36.6117557Z hint:2026-08-11T00:55:36.6118339Z hint: git branch -m <name>2026-08-11T00:55:36.6119147Z hint:2026-08-11T00:55:36.6120030Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-11T00:55:36.6122187Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-11T00:55:36.6126605Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-11T00:55:36.6159453Z ##[endgroup]2026-08-11T00:55:36.6161030Z ##[group]Disabling automatic garbage collection2026-08-11T00:55:36.6164359Z [command]/usr/bin/git config --local gc.auto 02026-08-11T00:55:36.6200108Z ##[endgroup]2026-08-11T00:55:36.6201493Z ##[group]Setting up auth2026-08-11T00:55:36.6209263Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-11T00:55:36.6245068Z [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-11T00:55:36.6679611Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-11T00:55:36.6721388Z [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-11T00:55:36.6967780Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-11T00:55:36.7005649Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-11T00:55:36.7255243Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-11T00:55:36.7296568Z ##[endgroup]2026-08-11T00:55:36.7297594Z ##[group]Fetching the repository2026-08-11T00:55:36.7306845Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-11T00:55:36.9679011Z From https://github.com/mwestphall/k8s-integration-tests2026-08-11T00:55:36.9680848Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-11T00:55:36.9705154Z ##[endgroup]2026-08-11T00:55:36.9706546Z ##[group]Determining the checkout info2026-08-11T00:55:36.9708604Z ##[endgroup]2026-08-11T00:55:36.9712971Z [command]/usr/bin/git sparse-checkout disable2026-08-11T00:55:36.9762470Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-11T00:55:36.9795213Z ##[group]Checking out the ref2026-08-11T00:55:36.9798987Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-11T00:55:36.9897000Z Switched to a new branch 'main'2026-08-11T00:55:36.9900685Z branch 'main' set up to track 'origin/main'.2026-08-11T00:55:36.9907576Z ##[endgroup]2026-08-11T00:55:36.9946876Z [command]/usr/bin/git log -1 --format=%H2026-08-11T00:55:36.9974957Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-11T00:55:37.0244365Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-11T00:55:37.0246873Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-11T00:55:37.0249198Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-11T00:55:37.0393423Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-11T00:55:37.0395056Z env:2026-08-11T00:55:37.0396746Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-11T00:55:37.0398772Z SETUP_ENV_YAML: {}2026-08-11T00:55:37.0399640Z ##[endgroup]2026-08-11T00:55:37.5999662Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-11T00:55:37.6001125Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-11T00:55:37.6062795Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-11T00:55:37.6063922Z env:2026-08-11T00:55:37.6065049Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-11T00:55:37.6066275Z ##[endgroup]2026-08-11T00:55:37.6238688Z ##[group]Run true2026-08-11T00:55:37.6239526Z [36;1mtrue[0m2026-08-11T00:55:37.6299933Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-11T00:55:37.6300944Z ##[endgroup]2026-08-11T00:55:37.6528908Z ##[group]Run medyagh/setup-minikube@latest2026-08-11T00:55:37.6529816Z with:2026-08-11T00:55:37.6530551Z start: true2026-08-11T00:55:37.6531284Z cache: true2026-08-11T00:55:37.6532042Z minikube-version: latest2026-08-11T00:55:37.6532839Z wait: all2026-08-11T00:55:37.6533564Z ##[endgroup]2026-08-11T00:55:37.7826204Z (node:2065) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-11T00:55:37.7827993Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-11T00:55:38.5603314Z [command]/usr/bin/chmod +x /home/runner/work/_temp/7072e5fd-e5d4-4db9-b3fa-b503e27429f92026-08-11T00:55:38.7302833Z [command]/home/runner/bin/minikube version --short2026-08-11T00:55:38.7684447Z v1.38.12026-08-11T00:55:38.8321826Z Cache hit for: kic-v1.38.1-x642026-08-11T00:55:38.8333385Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-11T00:55:38.8448279Z (node:2065) [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-11T00:55:39.8771010Z Received 117440512 of 544082657 (21.6%), 112.1 MBs/sec2026-08-11T00:55:39.9005879Z Received 67108864 of 224218863 (29.9%), 64.0 MBs/sec2026-08-11T00:55:40.8770698Z Received 247463936 of 544082657 (45.5%), 118.1 MBs/sec2026-08-11T00:55:40.9010260Z Received 167772160 of 224218863 (74.8%), 80.0 MBs/sec2026-08-11T00:55:41.2727724Z Received 224218863 of 224218863 (100.0%), 90.1 MBs/sec2026-08-11T00:55:41.2730906Z Cache Size: ~214 MB (224218863 B)2026-08-11T00:55:41.3855407Z [command]/usr/bin/tar -xf /home/runner/work/_temp/a04e2cf3-05eb-42d6-ab73-e3f3c8ac6a4c/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-11T00:55:41.9635095Z Received 402653184 of 544082657 (74.0%), 124.5 MBs/sec2026-08-11T00:55:42.4095187Z Cache restored successfully2026-08-11T00:55:42.6713529Z Received 544082657 of 544082657 (100.0%), 136.8 MBs/sec2026-08-11T00:55:42.6714653Z Cache Size: ~519 MB (544082657 B)2026-08-11T00:55:42.6855237Z [command]/usr/bin/tar -xf /home/runner/work/_temp/f7ec5cc7-b041-4609-a984-1c1085be1f94/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-11T00:55:43.6247317Z Cache restored successfully2026-08-11T00:55:43.7423851Z [command]/home/runner/bin/minikube start --wait all2026-08-11T00:55:43.7821384Z * minikube v1.38.1 on Ubuntu 22.042026-08-11T00:55:47.1060891Z ! The minimum required version for podman is "4.9.0". your version is "3.4.4". minikube might not work. use at your own risk. To install latest version please see https://podman.io/getting-started/installation.html2026-08-11T00:55:47.1077843Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-11T00:55:47.1772943Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-11T00:55:47.1783478Z * Using Docker driver with root privileges2026-08-11T00:55:47.1796663Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-11T00:55:47.1809727Z * Pulling base image v0.0.50 ...2026-08-11T00:56:18.4123468Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-11T00:56:23.0902452Z * Verifying Kubernetes components...2026-08-11T00:56:23.1112611Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-11T00:56:23.8135802Z * Enabled addons: storage-provisioner, default-storageclass2026-08-11T00:57:02.9706891Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-11T00:57:02.9822297Z [command]/home/runner/bin/minikube version --short2026-08-11T00:57:03.0186698Z v1.38.12026-08-11T00:57:03.0507365Z ##[group]Run actions/setup-go@v62026-08-11T00:57:03.0507664Z with:2026-08-11T00:57:03.0507861Z go-version: 1.262026-08-11T00:57:03.0508093Z cache: true2026-08-11T00:57:03.0508306Z cache-dependency-path: go.sum2026-08-11T00:57:03.0508564Z check-latest: false2026-08-11T00:57:03.0511363Z token: ***2026-08-11T00:57:03.0511571Z ##[endgroup]2026-08-11T00:57:03.1840086Z Setup go version spec 1.262026-08-11T00:57:03.2811588Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-11T00:57:03.2815356Z Added go to the path2026-08-11T00:57:03.2820516Z Successfully set up Go version 1.262026-08-11T00:57:03.8727235Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-11T00:57:03.8769758Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-11T00:57:03.8798832Z /home/runner/go/pkg/mod2026-08-11T00:57:03.8828981Z /home/runner/.cache/go-build2026-08-11T00:57:03.9577253Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-11T00:57:05.0255018Z Received 213909504 of 251839808 (84.9%), 203.2 MBs/sec2026-08-11T00:57:05.2882786Z Received 251839808 of 251839808 (100.0%), 189.6 MBs/sec2026-08-11T00:57:05.2885271Z Cache Size: ~240 MB (251839808 B)2026-08-11T00:57:05.3004167Z [command]/usr/bin/tar -xf /home/runner/work/_temp/57130f21-3462-4113-b5e5-654cb3c3ae9a/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-11T00:57:08.3373154Z Cache restored successfully2026-08-11T00:57:08.3950903Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-11T00:57:08.3976037Z go version go1.26.5 linux/amd642026-08-11T00:57:08.3976276Z 2026-08-11T00:57:08.3976623Z ##[group]go env2026-08-11T00:57:08.4263206Z AR='ar'2026-08-11T00:57:08.4263943Z CC='gcc'2026-08-11T00:57:08.4264429Z CGO_CFLAGS='-O2 -g'2026-08-11T00:57:08.4264965Z CGO_CPPFLAGS=''2026-08-11T00:57:08.4265387Z CGO_CXXFLAGS='-O2 -g'2026-08-11T00:57:08.4265774Z CGO_ENABLED='1'2026-08-11T00:57:08.4266126Z CGO_FFLAGS='-O2 -g'2026-08-11T00:57:08.4266819Z CGO_LDFLAGS='-O2 -g'2026-08-11T00:57:08.4267172Z CXX='g++'2026-08-11T00:57:08.4267494Z GCCGO='gccgo'2026-08-11T00:57:08.4267815Z GO111MODULE=''2026-08-11T00:57:08.4268142Z GOAMD64='v1'2026-08-11T00:57:08.4268471Z GOARCH='amd64'2026-08-11T00:57:08.4268799Z GOAUTH='netrc'2026-08-11T00:57:08.4269127Z GOBIN=''2026-08-11T00:57:08.4269488Z GOCACHE='/home/runner/.cache/go-build'2026-08-11T00:57:08.4269968Z GOCACHEPROG=''2026-08-11T00:57:08.4270298Z GODEBUG=''2026-08-11T00:57:08.4270691Z GOENV='/home/runner/.config/go/env'2026-08-11T00:57:08.4271166Z GOEXE=''2026-08-11T00:57:08.4271494Z GOEXPERIMENT=''2026-08-11T00:57:08.4271836Z GOFIPS140='off'2026-08-11T00:57:08.4272172Z GOFLAGS=''2026-08-11T00:57:08.4273287Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build2810090027=/tmp/go-build -gno-record-gcc-switches'2026-08-11T00:57:08.4274716Z GOHOSTARCH='amd64'2026-08-11T00:57:08.4275077Z GOHOSTOS='linux'2026-08-11T00:57:08.4275437Z GOINSECURE=''2026-08-11T00:57:08.4276028Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-11T00:57:08.4276730Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-11T00:57:08.4277187Z GONOPROXY=''2026-08-11T00:57:08.4277512Z GONOSUMDB=''2026-08-11T00:57:08.4277833Z GOOS='linux'2026-08-11T00:57:08.4278175Z GOPATH='/home/runner/go'2026-08-11T00:57:08.4278559Z GOPRIVATE=''2026-08-11T00:57:08.4278988Z GOPROXY='https://proxy.golang.org,direct'2026-08-11T00:57:08.4279544Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-11T00:57:08.4280042Z GOSUMDB='sum.golang.org'2026-08-11T00:57:08.4280431Z GOTELEMETRY='local'2026-08-11T00:57:08.4280886Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-11T00:57:08.4281412Z GOTMPDIR=''2026-08-11T00:57:08.4281762Z GOTOOLCHAIN='local'2026-08-11T00:57:08.4282614Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-11T00:57:08.4283243Z GOVCS=''2026-08-11T00:57:08.4283581Z GOVERSION='go1.26.5'2026-08-11T00:57:08.4284254Z GOWORK=''2026-08-11T00:57:08.4284610Z PKG_CONFIG='pkg-config'2026-08-11T00:57:08.4284853Z 2026-08-11T00:57:08.4285371Z ##[endgroup]2026-08-11T00:57:08.4488475Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-11T00:57:08.4489019Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-11T00:57:08.4545324Z shell: /usr/bin/bash -e {0}2026-08-11T00:57:08.4545590Z env:2026-08-11T00:57:08.4545793Z GOTOOLCHAIN: local2026-08-11T00:57:08.4546040Z OSPOOL_EP_OSPoolEPTag: 25-release2026-08-11T00:57:08.4546316Z OSPOOL_EP_CMTag: 25.0-el92026-08-11T00:57:08.4546564Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-11T00:57:08.4546813Z ##[endgroup]2026-08-11T00:57:15.0759016Z === RUN TestOSPoolEP2026-08-11T00:57:15.0761213Z === PAUSE TestOSPoolEP2026-08-11T00:57:15.0761517Z === CONT TestOSPoolEP2026-08-11T00:57:15.0762344Z TestOSPoolEP 2026-08-11T00:57:15Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:15.1035630Z TestOSPoolEP 2026-08-11T00:57:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 apply -f /tmp/TestOSPoolEP3035358903]2026-08-11T00:57:16.1414982Z TestOSPoolEP 2026-08-11T00:57:16Z logger.go:67: pod/idtoken-generator created2026-08-11T00:57:16.1505000Z TestOSPoolEP 2026-08-11T00:57:16Z logger.go:67: secret/pool-passwd created2026-08-11T00:57:16.1531486Z TestOSPoolEP 2026-08-11T00:57:16Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-11T00:57:16.1542537Z TestOSPoolEP 2026-08-11T00:57:16Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:16.1557062Z TestOSPoolEP 2026-08-11T00:57:16Z 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-11T00:57:26.1565877Z TestOSPoolEP 2026-08-11T00:57:26Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-11T00:57:26.1568043Z TestOSPoolEP 2026-08-11T00:57:26Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:26.1595706Z TestOSPoolEP 2026-08-11T00:57:26Z 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-11T00:57:36.1605225Z TestOSPoolEP 2026-08-11T00:57:36Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-11T00:57:36.1606380Z TestOSPoolEP 2026-08-11T00:57:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:36.1629564Z TestOSPoolEP 2026-08-11T00:57:36Z logger.go:67: Pod is now available2026-08-11T00:57:36.1631230Z TestOSPoolEP 2026-08-11T00:57:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-11T00:57:36.7584898Z TestOSPoolEP 2026-08-11T00:57:36Z logger.go:67: ***2026-08-11T00:57:36.7640323Z TestOSPoolEP 2026-08-11T00:57:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 apply -f /tmp/TestOSPoolEP479273343]2026-08-11T00:57:36.9462281Z TestOSPoolEP 2026-08-11T00:57:36Z logger.go:67: secret/pool-token created2026-08-11T00:57:36.9492286Z TestOSPoolEP 2026-08-11T00:57:36Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-11T00:57:36.9493466Z TestOSPoolEP 2026-08-11T00:57:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:36.9510390Z TestOSPoolEP 2026-08-11T00:57:36Z logger.go:67: Secret is now available2026-08-11T00:57:36.9529270Z TestOSPoolEP 2026-08-11T00:57:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 apply -k /tmp/kustomize-template-1180232748]2026-08-11T00:57:37.2759426Z TestOSPoolEP 2026-08-11T00:57:37Z logger.go:67: service/test-cm created2026-08-11T00:57:37.2867750Z TestOSPoolEP 2026-08-11T00:57:37Z 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-11T00:57:37.2875197Z TestOSPoolEP 2026-08-11T00:57:37Z logger.go:67: deployment.apps/ospool-ep created2026-08-11T00:57:37.2973103Z TestOSPoolEP 2026-08-11T00:57:37Z logger.go:67: deployment.apps/test-cm created2026-08-11T00:57:37.3050895Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-11T00:57:37.3067709Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:37.3197596Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:37Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-11T00:57:37.3200532Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:37.3205074Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:37Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-11T00:57:37.3211124Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:37.3241425Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:37Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-6c7d796845". Sleeping for 10s and will try again.2026-08-11T00:57:37.3269709Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:37Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "test-cm-54b7d49f85". Sleeping for 10s and will try again.2026-08-11T00:57:47.3258761Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:47Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-11T00:57:47.3272422Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:47.3285138Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:47Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-11T00:57:47.3292076Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:47.3296062Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:47Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-08-11T00:57:47.3312175Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:47Z logger.go:67: Deployment is now available2026-08-11T00:57:57.3307276Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:57Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-11T00:57:57.3309394Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:57:57.3337263Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:57:57Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-08-11T00:58:07.3347018Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:58:07Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-11T00:58:07.3348188Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:58:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:58:07.3382102Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-11T00:58:07Z logger.go:67: Deployment is now available2026-08-11T00:58:07.3383059Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-11T00:58:07.3384047Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-11T00:58:07.3385018Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-11T00:58:07.3385990Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-11T00:58:07.3386869Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-11T00:58:07.3387613Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-11T00:58:07.3388357Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-11T00:58:07.3389089Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-11T00:58:07.3390571Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:58:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:58:07.3392702Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:58:07.3395828Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-11T00:58:07.3409370Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-11T00:58:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:58:07.3419557Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:58:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:58:07.3427298Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-11T00:58:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:58:07.3450326Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T00:58:07.3454024Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-11T00:58:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 exec test-cm-54b7d49f85-7sz6c -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_SINGULARITY]2026-08-11T00:58:07.3458549Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:58:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 exec test-cm-54b7d49f85-7sz6c -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T00:58:07.3506134Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 exec test-cm-54b7d49f85-7sz6c -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)']2026-08-11T00:58:07.6385388Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-11T00:58:07.6394573Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)']' in pod test-cm-54b7d49f85-7sz6c failed. Retrying in 10s.2026-08-11T00:58:07.6859747Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-11T00:58:07.6862571Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-7sz6c failed. Retrying in 30s.2026-08-11T00:58:07.6866722Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-11T00:58:07.6868895Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-7sz6c failed. Retrying in 10s.2026-08-11T00:58:17.6409311Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 exec test-cm-54b7d49f85-7sz6c -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)']2026-08-11T00:58:17.6875840Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-11T00:58:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 exec test-cm-54b7d49f85-7sz6c -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_SINGULARITY]2026-08-11T00:58:17.8654004Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:17Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-11T00:58:17.8655259Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:17Z logger.go:67: 2026-08-11T00:58:17.8656587Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:17Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-cq7z6 LINUX X86_64 Unclaimed Idle 0.000 15995 0+00:00:002026-08-11T00:58:17.8657751Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:17Z logger.go:67: 2026-08-11T00:58:17.8659186Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:17Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-11T00:58:17.8660521Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:17Z logger.go:67: 2026-08-11T00:58:17.8664978Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:17Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-11T00:58:17.8668387Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:17Z logger.go:67: 2026-08-11T00:58:17.8670915Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-11T00:58:17Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-11T00:58:17.9145785Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-11T00:58:17Z logger.go:67: true2026-08-11T00:58:37.6869855Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:58:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 exec test-cm-54b7d49f85-7sz6c -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T00:58:37.8411418Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:58:37Z logger.go:67: undefined2026-08-11T00:58:37.8461200Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-11T00:58:37.8462650Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-7sz6c failed. Retrying in 30s.2026-08-11T00:59:07.8466824Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:59:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 exec test-cm-54b7d49f85-7sz6c -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T00:59:08.0012467Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:59:08Z logger.go:67: undefined2026-08-11T00:59:08.0072608Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-7sz6c failed. Retrying in 30s.2026-08-11T00:59:38.0081300Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:59:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 exec test-cm-54b7d49f85-7sz6c -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T00:59:38.1627844Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T00:59:38Z logger.go:67: undefined2026-08-11T00:59:38.1686891Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-7sz6c failed. Retrying in 30s.2026-08-11T01:00:08.1691258Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:00:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 exec test-cm-54b7d49f85-7sz6c -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T01:00:08.3169359Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:00:08Z logger.go:67: undefined2026-08-11T01:00:08.3225165Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-7sz6c failed. Retrying in 30s.2026-08-11T01:00:38.3244380Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:00:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 exec test-cm-54b7d49f85-7sz6c -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T01:00:38.4711385Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:00:38Z logger.go:67: undefined2026-08-11T01:00:38.4768149Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-7sz6c failed. Retrying in 30s.2026-08-11T01:01:08.4801265Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:01:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 exec test-cm-54b7d49f85-7sz6c -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T01:01:08.6291638Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:01:08Z logger.go:67: undefined2026-08-11T01:01:08.6346642Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-7sz6c failed. Retrying in 30s.2026-08-11T01:01:38.6352726Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:01:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 exec test-cm-54b7d49f85-7sz6c -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T01:01:38.7966626Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:01:38Z logger.go:67: undefined2026-08-11T01:01:38.8036478Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-7sz6c failed. Retrying in 30s.2026-08-11T01:02:08.8041070Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:02:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 exec test-cm-54b7d49f85-7sz6c -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T01:02:08.9621081Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:02:08Z logger.go:67: undefined2026-08-11T01:02:08.9676583Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-7sz6c failed. Retrying in 30s.2026-08-11T01:02:38.9705425Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:02:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 exec test-cm-54b7d49f85-7sz6c -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T01:02:39.1185059Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:02:39Z logger.go:67: undefined2026-08-11T01:02:39.1242466Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-7sz6c failed. Retrying in 30s.2026-08-11T01:03:09.1278814Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:03:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 exec test-cm-54b7d49f85-7sz6c -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T01:03:09.2782572Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:03:09Z logger.go:67: undefined2026-08-11T01:03:09.2845448Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-7sz6c failed. Retrying in 30s.2026-08-11T01:03:39.2879375Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:03:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 exec test-cm-54b7d49f85-7sz6c -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-cq7z6",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-11T01:03:39.4457110Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-11T01:03:39Z logger.go:67: true2026-08-11T01:03:39.4527910Z TestOSPoolEP 2026-08-11T01:03:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T01:03:39.4595232Z TestOSPoolEP 2026-08-11T01:03:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T01:03:39.6796288Z TestOSPoolEP 2026-08-11T01:03:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T01:03:39.8101307Z TestOSPoolEP 2026-08-11T01:03:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T01:03:39.9150009Z TestOSPoolEP 2026-08-11T01:03:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T01:03:39.9176902Z === NAME TestOSPoolEP2026-08-11T01:03:39.9177668Z ospool_ep_test.go:101: ---2026-08-11T01:03:39.9178324Z Events for pod idtoken-generator:2026-08-11T01:03:39.9179722Z 2026-08-11 00:57:16 +0000 UTC Normal Successfully assigned test-ospool-ep-gn6uw0/idtoken-generator to minikube2026-08-11T01:03:39.9180938Z 2026-08-11 00:57:17 +0000 UTC Normal Pulling image "htcondor/base"2026-08-11T01:03:39.9182107Z 2026-08-11 00:57:25 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.341s (8.341s including waiting). Image size: 560910730 bytes.2026-08-11T01:03:39.9183343Z 2026-08-11 00:57:25 +0000 UTC Normal Container created2026-08-11T01:03:39.9184308Z 2026-08-11 00:57:25 +0000 UTC Normal Container started2026-08-11T01:03:39.9184655Z 2026-08-11T01:03:39.9184877Z ---2026-08-11T01:03:39.9185584Z TestOSPoolEP 2026-08-11T01:03:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T01:03:39.9201140Z ospool_ep_test.go:101: ---2026-08-11T01:03:39.9201897Z Events for pod ospool-ep-6c7d796845-cq7z6:2026-08-11T01:03:39.9203407Z 2026-08-11 00:57:37 +0000 UTC Normal Successfully assigned test-ospool-ep-gn6uw0/ospool-ep-6c7d796845-cq7z6 to minikube2026-08-11T01:03:39.9205591Z 2026-08-11 00:57:37 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-11T01:03:39.9207439Z 2026-08-11 00:57:39 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.628s (1.628s including waiting). Image size: 5590942 bytes.2026-08-11T01:03:39.9208463Z 2026-08-11 00:57:39 +0000 UTC Normal Container created2026-08-11T01:03:39.9208955Z 2026-08-11 00:57:39 +0000 UTC Normal Container started2026-08-11T01:03:39.9209855Z 2026-08-11 00:57:40 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-08-11T01:03:39.9211782Z 2026-08-11 00:57:59 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 14.387s (18.887s including waiting). Image size: 1273000231 bytes.2026-08-11T01:03:39.9213473Z 2026-08-11 00:57:59 +0000 UTC Normal Container created2026-08-11T01:03:39.9214582Z 2026-08-11 00:57:59 +0000 UTC Normal Container started2026-08-11T01:03:39.9215166Z 2026-08-11T01:03:39.9215551Z ---2026-08-11T01:03:39.9216377Z TestOSPoolEP 2026-08-11T01:03:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T01:03:39.9222265Z ospool_ep_test.go:101: ---2026-08-11T01:03:39.9224707Z Events for pod test-cm-54b7d49f85-7sz6c:2026-08-11T01:03:39.9226762Z 2026-08-11 00:57:37 +0000 UTC Normal Successfully assigned test-ospool-ep-gn6uw0/test-cm-54b7d49f85-7sz6c to minikube2026-08-11T01:03:39.9229359Z 2026-08-11 00:57:37 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-08-11T01:03:39.9231197Z 2026-08-11 00:57:44 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 5.43s (7.032s including waiting). Image size: 573055668 bytes.2026-08-11T01:03:39.9232540Z 2026-08-11 00:57:44 +0000 UTC Normal Container created2026-08-11T01:03:39.9233372Z 2026-08-11 00:57:44 +0000 UTC Normal Container started2026-08-11T01:03:39.9234140Z 2026-08-11T01:03:39.9234486Z ---2026-08-11T01:03:39.9235453Z TestOSPoolEP 2026-08-11T01:03:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-11T01:03:39.9260192Z TestOSPoolEP 2026-08-11T01:03:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 delete -f /tmp/TestOSPoolEP564463982]2026-08-11T01:03:40.0171089Z TestOSPoolEP 2026-08-11T01:03:40Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-gn6uw0 namespace2026-08-11T01:03:40.0218635Z TestOSPoolEP 2026-08-11T01:03:40Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-gn6uw0 namespace2026-08-11T01:03:40.4426506Z TestOSPoolEP 2026-08-11T01:03:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 delete -f /tmp/TestOSPoolEP2597008892]2026-08-11T01:03:40.5318271Z TestOSPoolEP 2026-08-11T01:03:40Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-gn6uw0 namespace2026-08-11T01:03:40.5362626Z TestOSPoolEP 2026-08-11T01:03:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gn6uw0 delete -k /tmp/kustomize-template-1180232748]2026-08-11T01:03:40.6525050Z TestOSPoolEP 2026-08-11T01:03:40Z logger.go:67: service "test-cm" deleted from test-ospool-ep-gn6uw0 namespace2026-08-11T01:03:40.6570868Z TestOSPoolEP 2026-08-11T01:03:40Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-gn6uw0 namespace2026-08-11T01:03:40.6614260Z TestOSPoolEP 2026-08-11T01:03:40Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-gn6uw0 namespace2026-08-11T01:03:40.6702553Z --- PASS: TestOSPoolEP (53.48s)2026-08-11T01:03:40.6726485Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.04s)2026-08-11T01:03:40.6727887Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (10.53s)2026-08-11T01:03:40.6729025Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (10.58s)2026-08-11T01:03:40.6731673Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (332.11s)2026-08-11T01:03:40.6732570Z PASS2026-08-11T01:03:40.6748345Z ok github.com/osg-htc/k8s-integration-tests/test 385.610s2026-08-11T01:03:40.7938728Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-11T01:03:40.7939400Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-11T01:03:40.7999557Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-11T01:03:40.8000122Z env:2026-08-11T01:03:40.8000426Z GOTOOLCHAIN: local2026-08-11T01:03:40.8001131Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-11T01:03:40.8001892Z ##[endgroup]2026-08-11T01:03:40.8229472Z 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-11T01:03:40.8231094Z ##[group]Run actions/upload-artifact@v42026-08-11T01:03:40.8231525Z with:2026-08-11T01:03:40.8231919Z name: TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce72322026-08-11T01:03:40.8232558Z path: /tmp/k8s-tests2026-08-11T01:03:40.8232798Z retention-days: 52026-08-11T01:03:40.8233026Z if-no-files-found: warn2026-08-11T01:03:40.8233262Z compression-level: 62026-08-11T01:03:40.8234094Z overwrite: false2026-08-11T01:03:40.8234397Z include-hidden-files: false2026-08-11T01:03:40.8234810Z env:2026-08-11T01:03:40.8235139Z GOTOOLCHAIN: local2026-08-11T01:03:40.8235508Z ##[endgroup]2026-08-11T01:03:41.0275134Z (node:18194) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-11T01:03:41.0276669Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-11T01:03:41.0397991Z With the provided path, there will be 6 files uploaded2026-08-11T01:03:41.0405378Z Artifact name is valid!2026-08-11T01:03:41.0407398Z Root directory input is valid!2026-08-11T01:03:41.1814711Z Beginning upload of artifact content to blob storage2026-08-11T01:03:41.2142609Z (node:18194) [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-11T01:03:41.2642765Z Uploaded bytes 143172026-08-11T01:03:41.2836356Z Finished uploading artifact content to blob storage!2026-08-11T01:03:41.2837584Z SHA256 digest of uploaded artifact zip is 70e3ceaa63a680561f674456867a63df23caf696830edb1ec447342df1b0a1e62026-08-11T01:03:41.2840169Z Finalizing artifact upload2026-08-11T01:03:41.4461288Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232.zip successfully finalized. Artifact ID 90852957492026-08-11T01:03:41.4495597Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232 has been successfully uploaded! Final size is 14317 bytes. Artifact ID is 90852957492026-08-11T01:03:41.4505996Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/31447663543/artifacts/90852957492026-08-11T01:03:41.4737418Z Post job cleanup.2026-08-11T01:03:41.6490759Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-11T01:03:41.6552208Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-11T01:03:41.6631522Z /home/runner/go/pkg/mod2026-08-11T01:03:41.6726109Z /home/runner/.cache/go-build2026-08-11T01:03:41.6787316Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-11T01:03:41.7101119Z Post job cleanup.2026-08-11T01:03:41.8294683Z [command]/usr/bin/git version2026-08-11T01:03:41.8362242Z git version 2.54.02026-08-11T01:03:41.8415260Z Temporarily overriding HOME='/home/runner/work/_temp/f505c77f-bda4-4c7d-8da5-751dd48f2616' before making global git config changes2026-08-11T01:03:41.8424003Z Adding repository directory to the temporary git global config as a safe directory2026-08-11T01:03:41.8427190Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-11T01:03:41.8490863Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-11T01:03:41.8535768Z [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-11T01:03:41.8825049Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-11T01:03:41.8854408Z http.https://github.com/.extraheader2026-08-11T01:03:41.8861363Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-11T01:03:41.8899794Z [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-11T01:03:41.9186322Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-11T01:03:41.9225789Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-11T01:03:41.9664319Z Cleaning up orphan processes2026-08-11T01:03:42.0409902Z ##[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/