2026-07-29T01:41:09.3041376Z Current runner version: '2.336.0'2026-07-29T01:41:09.3082002Z ##[group]Runner Image Provisioner2026-07-29T01:41:09.3083343Z Hosted Compute Agent2026-07-29T01:41:09.3084595Z Version: 20260707.5632026-07-29T01:41:09.3085740Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-07-29T01:41:09.3087552Z Build Date: 2026-07-07T19:33:50Z2026-07-29T01:41:09.3088759Z Worker ID: {55fd370c-758b-498c-b554-e33a2e2b949c}2026-07-29T01:41:09.3089950Z Azure Region: northcentralus2026-07-29T01:41:09.3091156Z ##[endgroup]2026-07-29T01:41:09.3093737Z ##[group]Operating System2026-07-29T01:41:09.3095032Z Ubuntu2026-07-29T01:41:09.3095989Z 22.04.52026-07-29T01:41:09.3097175Z LTS2026-07-29T01:41:09.3098312Z ##[endgroup]2026-07-29T01:41:09.3099273Z ##[group]Runner Image2026-07-29T01:41:09.3100574Z Image: ubuntu-22.042026-07-29T01:41:09.3101678Z Version: 20260720.234.22026-07-29T01:41:09.3104073Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-07-29T01:41:09.3107277Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-07-29T01:41:09.3109139Z ##[endgroup]2026-07-29T01:41:09.3111244Z ##[group]GITHUB_TOKEN Permissions2026-07-29T01:41:09.3114674Z Contents: read2026-07-29T01:41:09.3115739Z Metadata: read2026-07-29T01:41:09.3116988Z Packages: read2026-07-29T01:41:09.3118094Z ##[endgroup]2026-07-29T01:41:09.3121524Z Secret source: Actions2026-07-29T01:41:09.3123840Z Prepare workflow directory2026-07-29T01:41:09.3627464Z Prepare all required actions2026-07-29T01:41:09.3699747Z Getting action download info2026-07-29T01:41:09.5664393Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-07-29T01:41:10.3529769Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-07-29T01:41:10.5723917Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-07-29T01:41:10.8424216Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-07-29T01:41:11.1761749Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-07-29T01:41:11.1768294Z ##[group] Inputs2026-07-29T01:41:11.1769345Z testName: TestOSPoolEP2026-07-29T01:41:11.1771209Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-07-29T01:41:11.1773209Z setupScript: 2026-07-29T01:41:11.1774122Z setupEnv: {}2026-07-29T01:41:11.1775012Z ##[endgroup]2026-07-29T01:41:11.1776657Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-07-29T01:41:11.2831093Z ##[group]Run actions/checkout@v52026-07-29T01:41:11.2832583Z with:2026-07-29T01:41:11.2833576Z repository: mwestphall/k8s-integration-tests2026-07-29T01:41:11.2843613Z token: ***2026-07-29T01:41:11.2844545Z ssh-strict: true2026-07-29T01:41:11.2845472Z ssh-user: git2026-07-29T01:41:11.2846613Z persist-credentials: true2026-07-29T01:41:11.2847635Z clean: true2026-07-29T01:41:11.2848549Z sparse-checkout-cone-mode: true2026-07-29T01:41:11.2849630Z fetch-depth: 12026-07-29T01:41:11.2850524Z fetch-tags: false2026-07-29T01:41:11.2851455Z show-progress: true2026-07-29T01:41:11.2852376Z lfs: false2026-07-29T01:41:11.2853227Z submodules: false2026-07-29T01:41:11.2854161Z set-safe-directory: true2026-07-29T01:41:11.2855218Z allow-unsafe-pr-checkout: false2026-07-29T01:41:11.2856823Z ##[endgroup]2026-07-29T01:41:11.3972732Z Syncing repository: mwestphall/k8s-integration-tests2026-07-29T01:41:11.3977442Z ##[group]Getting Git version info2026-07-29T01:41:11.3980324Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-07-29T01:41:11.3984113Z [command]/usr/bin/git version2026-07-29T01:41:11.5308478Z git version 2.54.02026-07-29T01:41:11.5332108Z ##[endgroup]2026-07-29T01:41:11.5348956Z Temporarily overriding HOME='/home/runner/work/_temp/11f0dc10-03e4-4535-839f-0fd1ac010433' before making global git config changes2026-07-29T01:41:11.5352553Z Adding repository directory to the temporary git global config as a safe directory2026-07-29T01:41:11.5356711Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-07-29T01:41:11.5398080Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-07-29T01:41:11.5402444Z ##[group]Initializing the repository2026-07-29T01:41:11.5407878Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-07-29T01:41:11.5942319Z hint: Using 'master' as the name for the initial branch. This default branch name2026-07-29T01:41:11.5944913Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-07-29T01:41:11.5948014Z hint: to use in all of your new repositories, which will suppress this warning,2026-07-29T01:41:11.5950277Z hint: call:2026-07-29T01:41:11.5951078Z hint:2026-07-29T01:41:11.5952114Z hint: git config --global init.defaultBranch <name>2026-07-29T01:41:11.5953806Z hint:2026-07-29T01:41:11.5955277Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-07-29T01:41:11.5957804Z hint: 'development'. The just-created branch can be renamed via this command:2026-07-29T01:41:11.5959304Z hint:2026-07-29T01:41:11.5960128Z hint: git branch -m <name>2026-07-29T01:41:11.5961080Z hint:2026-07-29T01:41:11.5962337Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-07-29T01:41:11.5964702Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-07-29T01:41:11.5968911Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-07-29T01:41:11.6053680Z ##[endgroup]2026-07-29T01:41:11.6056301Z ##[group]Disabling automatic garbage collection2026-07-29T01:41:11.6058527Z [command]/usr/bin/git config --local gc.auto 02026-07-29T01:41:11.6093030Z ##[endgroup]2026-07-29T01:41:11.6094904Z ##[group]Setting up auth2026-07-29T01:41:11.6099103Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-07-29T01:41:11.6135264Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :"2026-07-29T01:41:11.8307372Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-07-29T01:41:11.8345361Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :"2026-07-29T01:41:11.8600872Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-07-29T01:41:11.8639283Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-07-29T01:41:11.8887204Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-07-29T01:41:11.8947167Z ##[endgroup]2026-07-29T01:41:11.8947973Z ##[group]Fetching the repository2026-07-29T01:41:11.8957128Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-07-29T01:41:12.2974377Z From https://github.com/mwestphall/k8s-integration-tests2026-07-29T01:41:12.2975331Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-07-29T01:41:12.3011754Z ##[endgroup]2026-07-29T01:41:12.3012330Z ##[group]Determining the checkout info2026-07-29T01:41:12.3015506Z ##[endgroup]2026-07-29T01:41:12.3023708Z [command]/usr/bin/git sparse-checkout disable2026-07-29T01:41:12.3131209Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-07-29T01:41:12.3169987Z ##[group]Checking out the ref2026-07-29T01:41:12.3177148Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-07-29T01:41:12.3334126Z Switched to a new branch 'main'2026-07-29T01:41:12.3336562Z branch 'main' set up to track 'origin/main'.2026-07-29T01:41:12.3344102Z ##[endgroup]2026-07-29T01:41:12.3389353Z [command]/usr/bin/git log -1 --format=%H2026-07-29T01:41:12.3417658Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-07-29T01:41:12.3734827Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-07-29T01:41:12.3735544Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-07-29T01:41:12.3736784Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-07-29T01:41:12.4299508Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-07-29T01:41:12.4299973Z env:2026-07-29T01:41:12.4300492Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-07-29T01:41:12.4301098Z SETUP_ENV_YAML: {}2026-07-29T01:41:12.4301344Z ##[endgroup]2026-07-29T01:41:13.0496867Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-07-29T01:41:13.0497577Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-07-29T01:41:13.0552644Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-07-29T01:41:13.0552990Z env:2026-07-29T01:41:13.0553426Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-07-29T01:41:13.0553942Z ##[endgroup]2026-07-29T01:41:13.0683676Z ##[group]Run true2026-07-29T01:41:13.0683958Z [36;1mtrue[0m2026-07-29T01:41:13.0734992Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-07-29T01:41:13.0735361Z ##[endgroup]2026-07-29T01:41:13.0887424Z ##[group]Run medyagh/setup-minikube@latest2026-07-29T01:41:13.0887749Z with:2026-07-29T01:41:13.0887935Z start: true2026-07-29T01:41:13.0888125Z cache: true2026-07-29T01:41:13.0888330Z minikube-version: latest2026-07-29T01:41:13.0888583Z wait: all2026-07-29T01:41:13.0888771Z ##[endgroup]2026-07-29T01:41:13.2151710Z (node:2159) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-07-29T01:41:13.2152670Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-07-29T01:41:14.1831840Z [command]/usr/bin/chmod +x /home/runner/work/_temp/dbb46f3c-4a31-4d6a-a638-bcf602f409e92026-07-29T01:41:14.3372437Z [command]/home/runner/bin/minikube version --short2026-07-29T01:41:14.3874529Z v1.38.12026-07-29T01:41:14.5054860Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-07-29T01:41:14.5157095Z (node:2159) [DEP0169] DeprecationWarning: `url.parse()` behavior is not standardized and prone to errors that have security implications. Use the WHATWG URL API instead. CVEs are not issued for `url.parse()` vulnerabilities.2026-07-29T01:41:14.5168612Z Cache hit for: kic-v1.38.1-x642026-07-29T01:41:15.6017579Z Received 130023424 of 224218863 (58.0%), 123.8 MBs/sec2026-07-29T01:41:16.1772170Z Received 224218863 of 224218863 (100.0%), 135.4 MBs/sec2026-07-29T01:41:16.1773457Z Cache Size: ~214 MB (224218863 B)2026-07-29T01:41:16.1814343Z [command]/usr/bin/tar -xf /home/runner/work/_temp/93c5573c-3386-4567-9e30-5c9db66b6224/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-07-29T01:41:16.6970664Z Cache restored successfully2026-07-29T01:41:20.6125549Z Received 134217728 of 544082657 (24.7%), 127.9 MBs/sec2026-07-29T01:41:21.6124295Z Received 343932928 of 544082657 (63.2%), 163.9 MBs/sec2026-07-29T01:41:22.6500158Z Received 536870912 of 544082657 (98.7%), 168.5 MBs/sec2026-07-29T01:41:22.7589373Z Received 544082657 of 544082657 (100.0%), 164.9 MBs/sec2026-07-29T01:41:22.7590340Z Cache Size: ~519 MB (544082657 B)2026-07-29T01:41:22.7703594Z [command]/usr/bin/tar -xf /home/runner/work/_temp/e4b39bf6-ad31-4d87-b31c-33d0c56a46d0/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-07-29T01:41:23.5327661Z Cache restored successfully2026-07-29T01:41:23.6478542Z [command]/home/runner/bin/minikube start --wait all2026-07-29T01:41:23.6880865Z * minikube v1.38.1 on Ubuntu 22.042026-07-29T01:41:27.7530045Z ! The minimum required version for podman is "4.9.0". your version is "3.4.4". minikube might not work. use at your own risk. To install latest version please see https://podman.io/getting-started/installation.html2026-07-29T01:41:27.7535122Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-07-29T01:41:27.8022690Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-07-29T01:41:27.8033015Z * Using Docker driver with root privileges2026-07-29T01:41:27.8042771Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-07-29T01:41:27.8051166Z * Pulling base image v0.0.50 ...2026-07-29T01:41:59.2928756Z * Configuring bridge CNI (Container Networking Interface) ...2026-07-29T01:42:04.4551514Z * Verifying Kubernetes components...2026-07-29T01:42:04.4783773Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-07-29T01:42:05.0907211Z * Enabled addons: default-storageclass, storage-provisioner2026-07-29T01:42:41.9266529Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-07-29T01:42:41.9361883Z [command]/home/runner/bin/minikube version --short2026-07-29T01:42:41.9809913Z v1.38.12026-07-29T01:42:42.0110207Z ##[group]Run actions/setup-go@v62026-07-29T01:42:42.0110525Z with:2026-07-29T01:42:42.0110748Z go-version: 1.262026-07-29T01:42:42.0110978Z cache: true2026-07-29T01:42:42.0111252Z cache-dependency-path: go.sum2026-07-29T01:42:42.0111534Z check-latest: false2026-07-29T01:42:42.0113900Z token: ***2026-07-29T01:42:42.0114124Z ##[endgroup]2026-07-29T01:42:42.1517470Z Setup go version spec 1.262026-07-29T01:42:42.1799820Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-07-29T01:42:42.1802224Z Added go to the path2026-07-29T01:42:42.1805292Z Successfully set up Go version 1.262026-07-29T01:42:43.3258406Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-07-29T01:42:43.3294014Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-07-29T01:42:43.3323112Z /home/runner/go/pkg/mod2026-07-29T01:42:43.3346506Z /home/runner/.cache/go-build2026-07-29T01:42:43.4576424Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-07-29T01:42:44.6107178Z Received 134217728 of 251839808 (53.3%), 127.0 MBs/sec2026-07-29T01:42:45.2017486Z Received 251839808 of 251839808 (100.0%), 150.2 MBs/sec2026-07-29T01:42:45.2045519Z Cache Size: ~240 MB (251839808 B)2026-07-29T01:42:45.2102431Z [command]/usr/bin/tar -xf /home/runner/work/_temp/330cdc72-ad2d-402b-8c3f-af9f648bb39e/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-07-29T01:42:48.1417983Z Cache restored successfully2026-07-29T01:42:48.2082958Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-07-29T01:42:48.2107242Z go version go1.26.5 linux/amd642026-07-29T01:42:48.2107477Z 2026-07-29T01:42:48.2107818Z ##[group]go env2026-07-29T01:42:48.3308568Z AR='ar'2026-07-29T01:42:48.3308969Z CC='gcc'2026-07-29T01:42:48.3309343Z CGO_CFLAGS='-O2 -g'2026-07-29T01:42:48.3310043Z CGO_CPPFLAGS=''2026-07-29T01:42:48.3310585Z CGO_CXXFLAGS='-O2 -g'2026-07-29T01:42:48.3310980Z CGO_ENABLED='1'2026-07-29T01:42:48.3311377Z CGO_FFLAGS='-O2 -g'2026-07-29T01:42:48.3311760Z CGO_LDFLAGS='-O2 -g'2026-07-29T01:42:48.3312522Z CXX='g++'2026-07-29T01:42:48.3312860Z GCCGO='gccgo'2026-07-29T01:42:48.3333153Z GO111MODULE=''2026-07-29T01:42:48.3333565Z GOAMD64='v1'2026-07-29T01:42:48.3333936Z GOARCH='amd64'2026-07-29T01:42:48.3334258Z GOAUTH='netrc'2026-07-29T01:42:48.3334596Z GOBIN=''2026-07-29T01:42:48.3334980Z GOCACHE='/home/runner/.cache/go-build'2026-07-29T01:42:48.3335464Z GOCACHEPROG=''2026-07-29T01:42:48.3335816Z GODEBUG=''2026-07-29T01:42:48.3336474Z GOENV='/home/runner/.config/go/env'2026-07-29T01:42:48.3336931Z GOEXE=''2026-07-29T01:42:48.3337270Z GOEXPERIMENT=''2026-07-29T01:42:48.3337544Z GOFIPS140='off'2026-07-29T01:42:48.3337815Z GOFLAGS=''2026-07-29T01:42:48.3338539Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build3785832799=/tmp/go-build -gno-record-gcc-switches'2026-07-29T01:42:48.3339357Z GOHOSTARCH='amd64'2026-07-29T01:42:48.3339579Z GOHOSTOS='linux'2026-07-29T01:42:48.3339790Z GOINSECURE=''2026-07-29T01:42:48.3340324Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-07-29T01:42:48.3341036Z GOMODCACHE='/home/runner/go/pkg/mod'2026-07-29T01:42:48.3341618Z GONOPROXY=''2026-07-29T01:42:48.3341854Z GONOSUMDB=''2026-07-29T01:42:48.3342056Z GOOS='linux'2026-07-29T01:42:48.3342271Z GOPATH='/home/runner/go'2026-07-29T01:42:48.3342514Z GOPRIVATE=''2026-07-29T01:42:48.3342781Z GOPROXY='https://proxy.golang.org,direct'2026-07-29T01:42:48.3343118Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-07-29T01:42:48.3343424Z GOSUMDB='sum.golang.org'2026-07-29T01:42:48.3343663Z GOTELEMETRY='local'2026-07-29T01:42:48.3343944Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-07-29T01:42:48.3344253Z GOTMPDIR=''2026-07-29T01:42:48.3344465Z GOTOOLCHAIN='local'2026-07-29T01:42:48.3345082Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-07-29T01:42:48.3345460Z GOVCS=''2026-07-29T01:42:48.3345666Z GOVERSION='go1.26.5'2026-07-29T01:42:48.3345906Z GOWORK=''2026-07-29T01:42:48.3346378Z PKG_CONFIG='pkg-config'2026-07-29T01:42:48.3346531Z 2026-07-29T01:42:48.3346874Z ##[endgroup]2026-07-29T01:42:48.3524534Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-07-29T01:42:48.3525078Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-07-29T01:42:48.3581843Z shell: /usr/bin/bash -e {0}2026-07-29T01:42:48.3582106Z env:2026-07-29T01:42:48.3582311Z GOTOOLCHAIN: local2026-07-29T01:42:48.3582559Z OSPOOL_EP_OSPoolEPTag: 25-release2026-07-29T01:42:48.3582838Z OSPOOL_EP_CMTag: 25.0-el92026-07-29T01:42:48.3583088Z OSPOOL_EP_CvmfsType: cvmfsexec2026-07-29T01:42:48.3583342Z ##[endgroup]2026-07-29T01:42:58.5237229Z === RUN TestOSPoolEP2026-07-29T01:42:58.5239037Z === PAUSE TestOSPoolEP2026-07-29T01:42:58.5239932Z === CONT TestOSPoolEP2026-07-29T01:42:58.5242020Z TestOSPoolEP 2026-07-29T01:42:58Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:42:58.5355561Z TestOSPoolEP 2026-07-29T01:42:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi apply -f /tmp/TestOSPoolEP1378052224]2026-07-29T01:42:59.0759391Z TestOSPoolEP 2026-07-29T01:42:59Z logger.go:67: pod/idtoken-generator created2026-07-29T01:42:59.0818061Z TestOSPoolEP 2026-07-29T01:42:59Z logger.go:67: secret/pool-passwd created2026-07-29T01:42:59.0865003Z TestOSPoolEP 2026-07-29T01:42:59Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-07-29T01:42:59.0867289Z TestOSPoolEP 2026-07-29T01:42:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:42:59.0901599Z TestOSPoolEP 2026-07-29T01:42:59Z retry.go:103: Wait for pod idtoken-generator to be provisioned. returned an error: Pod idtoken-generator is not available, reason: , message: . Sleeping for 10s and will try again.2026-07-29T01:43:09.0911254Z TestOSPoolEP 2026-07-29T01:43:09Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-07-29T01:43:09.0915530Z TestOSPoolEP 2026-07-29T01:43:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:43:09.0937296Z TestOSPoolEP 2026-07-29T01:43:09Z logger.go:67: Pod is now available2026-07-29T01:43:09.0939566Z TestOSPoolEP 2026-07-29T01:43:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-07-29T01:43:09.7043199Z TestOSPoolEP 2026-07-29T01:43:09Z logger.go:67: ***2026-07-29T01:43:09.7099585Z TestOSPoolEP 2026-07-29T01:43:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi apply -f /tmp/TestOSPoolEP2836999140]2026-07-29T01:43:09.8896711Z TestOSPoolEP 2026-07-29T01:43:09Z logger.go:67: secret/pool-token created2026-07-29T01:43:09.8930056Z TestOSPoolEP 2026-07-29T01:43:09Z retry.go:91: Wait for secret pool-token to be provisioned.2026-07-29T01:43:09.8931580Z TestOSPoolEP 2026-07-29T01:43:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:43:09.8948537Z TestOSPoolEP 2026-07-29T01:43:09Z logger.go:67: Secret is now available2026-07-29T01:43:09.8978039Z TestOSPoolEP 2026-07-29T01:43:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi apply -k /tmp/kustomize-template-667468505]2026-07-29T01:43:10.1973915Z TestOSPoolEP 2026-07-29T01:43:10Z logger.go:67: service/test-cm created2026-07-29T01:43:10.2069042Z TestOSPoolEP 2026-07-29T01:43:10Z logger.go:67: Warning: spec.template.spec.containers[0].env[8]: hides previous definition of "OSG_SQUID_LOCATION", which may be dropped when using apply2026-07-29T01:43:10.2072200Z TestOSPoolEP 2026-07-29T01:43:10Z logger.go:67: deployment.apps/ospool-ep created2026-07-29T01:43:10.2160899Z TestOSPoolEP 2026-07-29T01:43:10Z logger.go:67: deployment.apps/test-cm created2026-07-29T01:43:10.2224994Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-07-29T01:43:10.2227061Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:43:10.2330414Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:10Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-07-29T01:43:10.2332678Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:43:10.2334896Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:10Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-29T01:43:10.2361523Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:43:10.2398895Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:10Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "test-cm-54b7d49f85". Sleeping for 10s and will try again.2026-07-29T01:43:10.2454499Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:10Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-6c7d796845". Sleeping for 10s and will try again.2026-07-29T01:43:20.2434701Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:20Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-07-29T01:43:20.2439813Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:20Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:43:20.2460703Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:20Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-29T01:43:20.2469344Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:20Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:43:20.2471489Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:20Z logger.go:67: Deployment is now available2026-07-29T01:43:20.2507408Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:20Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-07-29T01:43:30.2510685Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:30Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-29T01:43:30.2512186Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:43:30.2539819Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:30Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-07-29T01:43:40.2550191Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:40Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-29T01:43:40.2552173Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:43:40.2582262Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-29T01:43:40Z logger.go:67: Deployment is now available2026-07-29T01:43:40.2583267Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-29T01:43:40.2584101Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-29T01:43:40.2585007Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-07-29T01:43:40.2586409Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-07-29T01:43:40.2587588Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-29T01:43:40.2588712Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-29T01:43:40.2589696Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-29T01:43:40.2591358Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-29T01:43:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:43:40.2592210Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-29T01:43:40.2593040Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:43:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:43:40.2593857Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-07-29T01:43:40.2594725Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-29T01:43:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:43:40.2626406Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-29T01:43:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:43:40.2629024Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-29T01:43:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:43:40.2633785Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:43:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:43:40.2693780Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-29T01:43:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi exec test-cm-54b7d49f85-jxbss -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_SINGULARITY]2026-07-29T01:43:40.2702411Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:43:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi exec test-cm-54b7d49f85-jxbss -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-29T01:43:40.2707020Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-29T01:43:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi exec test-cm-54b7d49f85-jxbss -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)']2026-07-29T01:43:40.5476715Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-jxbss failed. Retrying in 10s.2026-07-29T01:43:40.5550647Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-29T01:43:40.5555120Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)']' in pod test-cm-54b7d49f85-jxbss failed. Retrying in 10s.2026-07-29T01:43:40.5584497Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-29T01:43:40.5585831Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-jxbss failed. Retrying in 30s.2026-07-29T01:43:50.5479674Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-29T01:43:50Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi exec test-cm-54b7d49f85-jxbss -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_SINGULARITY]2026-07-29T01:43:50.5572540Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-29T01:43:50Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi exec test-cm-54b7d49f85-jxbss -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)']2026-07-29T01:43:50.7172164Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-29T01:43:50Z logger.go:67: true2026-07-29T01:43:50.7282891Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-29T01:43:50Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-07-29T01:43:50.7284488Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-29T01:43:50Z logger.go:67: 2026-07-29T01:43:50.7286607Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-29T01:43:50Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-8q2tp LINUX X86_64 Unclaimed Idle 0.000 15995 0+00:00:002026-07-29T01:43:50.7288375Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-29T01:43:50Z logger.go:67: 2026-07-29T01:43:50.7289881Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-29T01:43:50Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-07-29T01:43:50.7291280Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-29T01:43:50Z logger.go:67: 2026-07-29T01:43:50.7292638Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-29T01:43:50Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-07-29T01:43:50.7293990Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-29T01:43:50Z logger.go:67: 2026-07-29T01:43:50.7295333Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-29T01:43:50Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-07-29T01:44:10.5596848Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:44:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi exec test-cm-54b7d49f85-jxbss -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-29T01:44:10.7043429Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:44:10Z logger.go:67: undefined2026-07-29T01:44:10.7111137Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-jxbss failed. Retrying in 30s.2026-07-29T01:44:40.7121890Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:44:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi exec test-cm-54b7d49f85-jxbss -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-29T01:44:40.8664703Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:44:40Z logger.go:67: undefined2026-07-29T01:44:40.8719385Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-jxbss failed. Retrying in 30s.2026-07-29T01:45:10.8728312Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:45:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi exec test-cm-54b7d49f85-jxbss -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-29T01:45:11.0242805Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:45:11Z logger.go:67: undefined2026-07-29T01:45:11.0300238Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-jxbss failed. Retrying in 30s.2026-07-29T01:45:41.0304157Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:45:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi exec test-cm-54b7d49f85-jxbss -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-29T01:45:41.2012770Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:45:41Z logger.go:67: undefined2026-07-29T01:45:41.2078108Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-jxbss failed. Retrying in 30s.2026-07-29T01:46:11.2104106Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:46:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi exec test-cm-54b7d49f85-jxbss -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-29T01:46:11.3837182Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:46:11Z logger.go:67: undefined2026-07-29T01:46:11.3901210Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-jxbss failed. Retrying in 30s.2026-07-29T01:46:41.3913176Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:46:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi exec test-cm-54b7d49f85-jxbss -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-29T01:46:41.5341821Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:46:41Z logger.go:67: undefined2026-07-29T01:46:41.5399015Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-jxbss failed. Retrying in 30s.2026-07-29T01:47:11.5429816Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:47:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi exec test-cm-54b7d49f85-jxbss -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-29T01:47:11.7152110Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:47:11Z logger.go:67: undefined2026-07-29T01:47:11.7211898Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-jxbss failed. Retrying in 30s.2026-07-29T01:47:41.7217473Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:47:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi exec test-cm-54b7d49f85-jxbss -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-29T01:47:41.8701349Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:47:41Z logger.go:67: undefined2026-07-29T01:47:41.8763084Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-jxbss failed. Retrying in 30s.2026-07-29T01:48:11.8766420Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:48:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi exec test-cm-54b7d49f85-jxbss -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-29T01:48:12.0222145Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:48:12Z logger.go:67: undefined2026-07-29T01:48:12.0278516Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-jxbss failed. Retrying in 30s.2026-07-29T01:48:42.0305921Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:48:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi exec test-cm-54b7d49f85-jxbss -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-29T01:48:42.1757337Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:48:42Z logger.go:67: undefined2026-07-29T01:48:42.1813790Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-jxbss failed. Retrying in 30s.2026-07-29T01:49:12.1845661Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:49:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi exec test-cm-54b7d49f85-jxbss -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-8q2tp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-29T01:49:12.3339643Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-29T01:49:12Z logger.go:67: true2026-07-29T01:49:12.3404393Z TestOSPoolEP 2026-07-29T01:49:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:49:12.3476814Z TestOSPoolEP 2026-07-29T01:49:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:49:12.5569708Z TestOSPoolEP 2026-07-29T01:49:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:49:12.6805137Z TestOSPoolEP 2026-07-29T01:49:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:49:12.7975444Z TestOSPoolEP 2026-07-29T01:49:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:49:12.8005790Z === NAME TestOSPoolEP2026-07-29T01:49:12.8012377Z ospool_ep_test.go:101: ---2026-07-29T01:49:12.8014872Z Events for pod idtoken-generator:2026-07-29T01:49:12.8016539Z 2026-07-29 01:42:59 +0000 UTC Normal Successfully assigned test-ospool-ep-54knmi/idtoken-generator to minikube2026-07-29T01:49:12.8019838Z 2026-07-29 01:42:59 +0000 UTC Normal Pulling image "htcondor/base"2026-07-29T01:49:12.8022059Z 2026-07-29 01:43:08 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.291s (8.291s including waiting). Image size: 560910730 bytes.2026-07-29T01:49:12.8023920Z 2026-07-29 01:43:08 +0000 UTC Normal Container created2026-07-29T01:49:12.8024862Z 2026-07-29 01:43:08 +0000 UTC Normal Container started2026-07-29T01:49:12.8025442Z 2026-07-29T01:49:12.8025803Z ---2026-07-29T01:49:12.8027259Z TestOSPoolEP 2026-07-29T01:49:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:49:12.8028436Z ospool_ep_test.go:101: ---2026-07-29T01:49:12.8029127Z Events for pod ospool-ep-6c7d796845-8q2tp:2026-07-29T01:49:12.8030619Z 2026-07-29 01:43:10 +0000 UTC Normal Successfully assigned test-ospool-ep-54knmi/ospool-ep-6c7d796845-8q2tp to minikube2026-07-29T01:49:12.8032234Z 2026-07-29 01:43:10 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-07-29T01:49:12.8034408Z 2026-07-29 01:43:12 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.37s (1.37s including waiting). Image size: 5590942 bytes.2026-07-29T01:49:12.8035920Z 2026-07-29 01:43:12 +0000 UTC Normal Container created2026-07-29T01:49:12.8037997Z 2026-07-29 01:43:12 +0000 UTC Normal Container started2026-07-29T01:49:12.8039630Z 2026-07-29 01:43:13 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-07-29T01:49:12.8042130Z 2026-07-29 01:43:31 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 13.39s (18.02s including waiting). Image size: 1383210994 bytes.2026-07-29T01:49:12.8043842Z 2026-07-29 01:43:31 +0000 UTC Normal Container created2026-07-29T01:49:12.8044724Z 2026-07-29 01:43:31 +0000 UTC Normal Container started2026-07-29T01:49:12.8045287Z 2026-07-29T01:49:12.8045656Z ---2026-07-29T01:49:12.8046883Z TestOSPoolEP 2026-07-29T01:49:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:49:12.8051092Z ospool_ep_test.go:101: ---2026-07-29T01:49:12.8053882Z Events for pod test-cm-54b7d49f85-jxbss:2026-07-29T01:49:12.8055334Z 2026-07-29 01:43:10 +0000 UTC Normal Successfully assigned test-ospool-ep-54knmi/test-cm-54b7d49f85-jxbss to minikube2026-07-29T01:49:12.8056962Z 2026-07-29 01:43:10 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-07-29T01:49:12.8058795Z 2026-07-29 01:43:17 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 5.55s (6.907s including waiting). Image size: 573055668 bytes.2026-07-29T01:49:12.8060411Z 2026-07-29 01:43:17 +0000 UTC Normal Container created2026-07-29T01:49:12.8061194Z 2026-07-29 01:43:17 +0000 UTC Normal Container started2026-07-29T01:49:12.8061727Z 2026-07-29T01:49:12.8062060Z ---2026-07-29T01:49:12.8062930Z TestOSPoolEP 2026-07-29T01:49:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-29T01:49:12.8118109Z TestOSPoolEP 2026-07-29T01:49:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi delete -f /tmp/TestOSPoolEP620038986]2026-07-29T01:49:12.9079913Z TestOSPoolEP 2026-07-29T01:49:12Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-54knmi namespace2026-07-29T01:49:12.9144101Z TestOSPoolEP 2026-07-29T01:49:12Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-54knmi namespace2026-07-29T01:49:15.1256320Z TestOSPoolEP 2026-07-29T01:49:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi delete -f /tmp/TestOSPoolEP2672605617]2026-07-29T01:49:15.2122823Z TestOSPoolEP 2026-07-29T01:49:15Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-54knmi namespace2026-07-29T01:49:15.2167223Z TestOSPoolEP 2026-07-29T01:49:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-54knmi delete -k /tmp/kustomize-template-667468505]2026-07-29T01:49:15.3286757Z TestOSPoolEP 2026-07-29T01:49:15Z logger.go:67: service "test-cm" deleted from test-ospool-ep-54knmi namespace2026-07-29T01:49:15.3329330Z TestOSPoolEP 2026-07-29T01:49:15Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-54knmi namespace2026-07-29T01:49:15.3358648Z TestOSPoolEP 2026-07-29T01:49:15Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-54knmi namespace2026-07-29T01:49:15.3465571Z --- PASS: TestOSPoolEP (44.74s)2026-07-29T01:49:15.3466852Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.04s)2026-07-29T01:49:15.3468120Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (10.46s)2026-07-29T01:49:15.3469274Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (10.48s)2026-07-29T01:49:15.3470335Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (332.08s)2026-07-29T01:49:15.3470754Z PASS2026-07-29T01:49:15.3495228Z ok github.com/osg-htc/k8s-integration-tests/test 376.841s2026-07-29T01:49:15.4672921Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-07-29T01:49:15.4673820Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-07-29T01:49:15.4740450Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-07-29T01:49:15.4740814Z env:2026-07-29T01:49:15.4741017Z GOTOOLCHAIN: local2026-07-29T01:49:15.4741480Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-07-29T01:49:15.4741969Z ##[endgroup]2026-07-29T01:49:15.4934621Z Node 20 is being deprecated. This workflow is running with Node 24 by default. If you need to temporarily use Node 20, you can set the ACTIONS_ALLOW_USE_UNSECURE_NODE_VERSION=true environment variable. For more information see: https://github.blog/changelog/2025-09-19-deprecation-of-node-20-on-github-actions-runners/2026-07-29T01:49:15.4935980Z ##[group]Run actions/upload-artifact@v42026-07-29T01:49:15.4936582Z with:2026-07-29T01:49:15.4936971Z name: TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce72322026-07-29T01:49:15.4937454Z path: /tmp/k8s-tests2026-07-29T01:49:15.4937687Z retention-days: 52026-07-29T01:49:15.4937905Z if-no-files-found: warn2026-07-29T01:49:15.4938143Z compression-level: 62026-07-29T01:49:15.4938367Z overwrite: false2026-07-29T01:49:15.4938588Z include-hidden-files: false2026-07-29T01:49:15.4938832Z env:2026-07-29T01:49:15.4939020Z GOTOOLCHAIN: local2026-07-29T01:49:15.4939233Z ##[endgroup]2026-07-29T01:49:15.7017262Z (node:18210) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-07-29T01:49:15.7018779Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-07-29T01:49:15.7175040Z With the provided path, there will be 6 files uploaded2026-07-29T01:49:15.7178703Z Artifact name is valid!2026-07-29T01:49:15.7182381Z Root directory input is valid!2026-07-29T01:49:15.9030561Z Beginning upload of artifact content to blob storage2026-07-29T01:49:15.9352674Z (node:18210) [DEP0169] DeprecationWarning: `url.parse()` behavior is not standardized and prone to errors that have security implications. Use the WHATWG URL API instead. CVEs are not issued for `url.parse()` vulnerabilities.2026-07-29T01:49:16.0430755Z Uploaded bytes 140842026-07-29T01:49:16.0778846Z Finished uploading artifact content to blob storage!2026-07-29T01:49:16.0780209Z SHA256 digest of uploaded artifact zip is 4246185e3ad28ce39d11af333c8b6eac25021fe153c56cdcaba3d689dc9ecf092026-07-29T01:49:16.0782482Z Finalizing artifact upload2026-07-29T01:49:16.2394290Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232.zip successfully finalized. Artifact ID 87098677332026-07-29T01:49:16.2397221Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232 has been successfully uploaded! Final size is 14084 bytes. Artifact ID is 87098677332026-07-29T01:49:16.2401138Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/30414769998/artifacts/87098677332026-07-29T01:49:16.2578327Z Post job cleanup.2026-07-29T01:49:16.4221368Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-07-29T01:49:16.4296126Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-07-29T01:49:16.4325943Z /home/runner/go/pkg/mod2026-07-29T01:49:16.4348129Z /home/runner/.cache/go-build2026-07-29T01:49:16.4355541Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-07-29T01:49:16.4569155Z Post job cleanup.2026-07-29T01:49:16.5865920Z [command]/usr/bin/git version2026-07-29T01:49:16.5907621Z git version 2.54.02026-07-29T01:49:16.5984043Z Temporarily overriding HOME='/home/runner/work/_temp/c17fcce4-9941-4aab-b833-cc4a3c315990' before making global git config changes2026-07-29T01:49:16.5985628Z Adding repository directory to the temporary git global config as a safe directory2026-07-29T01:49:16.5992349Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-07-29T01:49:16.6034973Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-07-29T01:49:16.6078076Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :"2026-07-29T01:49:16.6418001Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-07-29T01:49:16.6445951Z http.https://github.com/.extraheader2026-07-29T01:49:16.6460517Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-07-29T01:49:16.6498157Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :"2026-07-29T01:49:16.6780079Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-07-29T01:49:16.6828957Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-07-29T01:49:16.7269961Z Cleaning up orphan processes2026-07-29T01:49:16.8054268Z ##[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/