2026-06-16T21:18:19.8911516Z Current runner version: '2.335.1'2026-06-16T21:18:19.8937586Z ##[group]Runner Image Provisioner2026-06-16T21:18:19.8938475Z Hosted Compute Agent2026-06-16T21:18:19.8939185Z Version: 20260527.5392026-06-16T21:18:19.8939857Z Commit: a891dd388383b896fa6ac04a82c0b75cec9810782026-06-16T21:18:19.8940601Z Build Date: 2026-05-27T21:39:57Z2026-06-16T21:18:19.8941407Z Worker ID: {a2345180-8382-4a5a-a654-319e5b23f94f}2026-06-16T21:18:19.8942146Z Azure Region: westus32026-06-16T21:18:19.8942788Z ##[endgroup]2026-06-16T21:18:19.8944424Z ##[group]Operating System2026-06-16T21:18:19.8945487Z Ubuntu2026-06-16T21:18:19.8946268Z 22.04.52026-06-16T21:18:19.8946804Z LTS2026-06-16T21:18:19.8947326Z ##[endgroup]2026-06-16T21:18:19.8947967Z ##[group]Runner Image2026-06-16T21:18:19.8948645Z Image: ubuntu-22.042026-06-16T21:18:19.8949280Z Version: 20260607.168.12026-06-16T21:18:19.8950587Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260607.168/images/ubuntu/Ubuntu2204-Readme.md2026-06-16T21:18:19.8952150Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260607.1682026-06-16T21:18:19.8953189Z ##[endgroup]2026-06-16T21:18:19.8954416Z ##[group]GITHUB_TOKEN Permissions2026-06-16T21:18:19.8956640Z Contents: read2026-06-16T21:18:19.8957817Z Metadata: read2026-06-16T21:18:19.8958448Z Packages: read2026-06-16T21:18:19.8959060Z ##[endgroup]2026-06-16T21:18:19.8961514Z Secret source: Actions2026-06-16T21:18:19.8962302Z Prepare workflow directory2026-06-16T21:18:19.9314347Z Prepare all required actions2026-06-16T21:18:19.9352903Z Getting action download info2026-06-16T21:18:20.2895396Z Download action repository 'actions/checkout@v5' (SHA:93cb6efe18208431cddfb8368fd83d5badbf9bfd)2026-06-16T21:18:20.4323005Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-06-16T21:18:20.9525785Z Download action repository 'actions/setup-go@v6' (SHA:4a3601121dd01d1626a1e23e37211e3254c1c06c)2026-06-16T21:18:21.5954325Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-06-16T21:18:21.8547139Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/feature/test-web-view (5e630c471b898ab153532b9dee0ddcad968e518b)2026-06-16T21:18:21.8553991Z ##[group] Inputs2026-06-16T21:18:21.8555293Z testName: TestOSPoolEP2026-06-16T21:18:21.8557333Z testEnv: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-06-16T21:18:21.8560032Z setupScript: 2026-06-16T21:18:21.8560948Z setupEnv: {}2026-06-16T21:18:21.8561851Z ##[endgroup]2026-06-16T21:18:21.8563267Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-06-16T21:18:21.9419911Z ##[group]Run actions/checkout@v52026-06-16T21:18:21.9421323Z with:2026-06-16T21:18:21.9422245Z repository: mwestphall/k8s-integration-tests2026-06-16T21:18:21.9432774Z token: ***2026-06-16T21:18:21.9433648Z ssh-strict: true2026-06-16T21:18:21.9434506Z ssh-user: git2026-06-16T21:18:21.9435543Z persist-credentials: true2026-06-16T21:18:21.9436497Z clean: true2026-06-16T21:18:21.9437366Z sparse-checkout-cone-mode: true2026-06-16T21:18:21.9438400Z fetch-depth: 12026-06-16T21:18:21.9439229Z fetch-tags: false2026-06-16T21:18:21.9440089Z show-progress: true2026-06-16T21:18:21.9440958Z lfs: false2026-06-16T21:18:21.9441759Z submodules: false2026-06-16T21:18:21.9442626Z set-safe-directory: true2026-06-16T21:18:21.9443849Z ##[endgroup]2026-06-16T21:18:22.0500249Z Syncing repository: mwestphall/k8s-integration-tests2026-06-16T21:18:22.0503251Z ##[group]Getting Git version info2026-06-16T21:18:22.0505465Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-06-16T21:18:22.0507758Z [command]/usr/bin/git version2026-06-16T21:18:22.0571507Z git version 2.54.02026-06-16T21:18:22.0625338Z ##[endgroup]2026-06-16T21:18:22.0640936Z Temporarily overriding HOME='/home/runner/work/_temp/143d4d30-feb8-4e75-80fe-8cf7b8a7d7d5' before making global git config changes2026-06-16T21:18:22.0645296Z Adding repository directory to the temporary git global config as a safe directory2026-06-16T21:18:22.0648641Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-06-16T21:18:22.0682257Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-06-16T21:18:22.0685688Z ##[group]Initializing the repository2026-06-16T21:18:22.0690516Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-06-16T21:18:22.0808339Z hint: Using 'master' as the name for the initial branch. This default branch name2026-06-16T21:18:22.0812006Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-06-16T21:18:22.0815801Z hint: to use in all of your new repositories, which will suppress this warning,2026-06-16T21:18:22.0817670Z hint: call:2026-06-16T21:18:22.0818857Z hint:2026-06-16T21:18:22.0820447Z hint: git config --global init.defaultBranch <name>2026-06-16T21:18:22.0821747Z hint:2026-06-16T21:18:22.0822885Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-06-16T21:18:22.0824751Z hint: 'development'. The just-created branch can be renamed via this command:2026-06-16T21:18:22.0826633Z hint:2026-06-16T21:18:22.0827459Z hint: git branch -m <name>2026-06-16T21:18:22.0828398Z hint:2026-06-16T21:18:22.0829691Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-06-16T21:18:22.0832004Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-06-16T21:18:22.0835954Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-06-16T21:18:22.0859628Z ##[endgroup]2026-06-16T21:18:22.0861064Z ##[group]Disabling automatic garbage collection2026-06-16T21:18:22.0862893Z [command]/usr/bin/git config --local gc.auto 02026-06-16T21:18:22.0893615Z ##[endgroup]2026-06-16T21:18:22.0895390Z ##[group]Setting up auth2026-06-16T21:18:22.0900271Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-06-16T21:18:22.0931764Z [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-06-16T21:18:22.1279993Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-06-16T21:18:22.1316601Z [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-06-16T21:18:22.1550589Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-06-16T21:18:22.1586546Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-06-16T21:18:22.1824666Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-06-16T21:18:22.1861077Z ##[endgroup]2026-06-16T21:18:22.1865251Z ##[group]Fetching the repository2026-06-16T21:18:22.1875004Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +5e630c471b898ab153532b9dee0ddcad968e518b:refs/remotes/origin/feature/test-web-view2026-06-16T21:18:22.7693125Z From https://github.com/mwestphall/k8s-integration-tests2026-06-16T21:18:22.7696581Z * [new ref] 5e630c471b898ab153532b9dee0ddcad968e518b -> origin/feature/test-web-view2026-06-16T21:18:22.7722203Z ##[endgroup]2026-06-16T21:18:22.7723175Z ##[group]Determining the checkout info2026-06-16T21:18:22.7725216Z ##[endgroup]2026-06-16T21:18:22.7731033Z [command]/usr/bin/git sparse-checkout disable2026-06-16T21:18:22.7774070Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-06-16T21:18:22.7802725Z ##[group]Checking out the ref2026-06-16T21:18:22.7807879Z [command]/usr/bin/git checkout --progress --force -B feature/test-web-view refs/remotes/origin/feature/test-web-view2026-06-16T21:18:22.7891049Z Switched to a new branch 'feature/test-web-view'2026-06-16T21:18:22.7895449Z branch 'feature/test-web-view' set up to track 'origin/feature/test-web-view'.2026-06-16T21:18:22.7900191Z ##[endgroup]2026-06-16T21:18:22.7938425Z [command]/usr/bin/git log -1 --format=%H2026-06-16T21:18:22.7962719Z 5e630c471b898ab153532b9dee0ddcad968e518b2026-06-16T21:18:22.8189442Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-06-16T21:18:22.8190327Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-06-16T21:18:22.8319425Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-06-16T21:18:22.8320006Z env:2026-06-16T21:18:22.8320775Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-06-16T21:18:22.8321619Z ##[endgroup]2026-06-16T21:18:22.8577363Z ##[group]Run true2026-06-16T21:18:22.8577725Z [36;1mtrue[0m2026-06-16T21:18:22.8632656Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-06-16T21:18:22.8633129Z ##[endgroup]2026-06-16T21:18:22.8809035Z ##[group]Run medyagh/setup-minikube@latest2026-06-16T21:18:22.8809488Z with:2026-06-16T21:18:22.8809793Z start: true2026-06-16T21:18:22.8810095Z cache: true2026-06-16T21:18:22.8810414Z minikube-version: latest2026-06-16T21:18:22.8810768Z wait: all2026-06-16T21:18:22.8811066Z ##[endgroup]2026-06-16T21:18:23.0185186Z (node:2042) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-06-16T21:18:23.0186952Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-06-16T21:18:24.1229918Z [command]/usr/bin/chmod +x /home/runner/work/_temp/6e6c0e26-68f4-44fa-9bc9-6448cbc37ba92026-06-16T21:18:24.3004004Z [command]/home/runner/bin/minikube version --short2026-06-16T21:18:24.3445910Z v1.38.12026-06-16T21:18:24.5758273Z Cache hit for: kic-v1.38.1-x642026-06-16T21:18:24.5866652Z (node:2042) [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-06-16T21:18:24.5986601Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-06-16T21:18:25.8215051Z Received 29360128 of 224218855 (13.1%), 27.8 MBs/sec2026-06-16T21:18:25.8344669Z Received 29360128 of 544082650 (5.4%), 27.9 MBs/sec2026-06-16T21:18:26.8259409Z Received 134217728 of 224218855 (59.9%), 63.7 MBs/sec2026-06-16T21:18:26.8366404Z Received 142606336 of 544082650 (26.2%), 67.9 MBs/sec2026-06-16T21:18:27.4128374Z Received 224218855 of 224218855 (100.0%), 82.3 MBs/sec2026-06-16T21:18:27.4129859Z Cache Size: ~214 MB (224218855 B)2026-06-16T21:18:27.4383940Z [command]/usr/bin/tar -xf /home/runner/work/_temp/85a4482d-5f23-44cd-922d-132f5bd241a2/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-06-16T21:18:27.8357865Z Received 268435456 of 544082650 (49.3%), 85.2 MBs/sec2026-06-16T21:18:28.0337242Z Cache restored successfully2026-06-16T21:18:28.8662421Z Received 402653184 of 544082650 (74.0%), 95.2 MBs/sec2026-06-16T21:18:29.8686338Z Received 532676608 of 544082650 (97.9%), 100.9 MBs/sec2026-06-16T21:18:30.3909518Z Received 544082650 of 544082650 (100.0%), 93.4 MBs/sec2026-06-16T21:18:30.3910947Z Cache Size: ~519 MB (544082650 B)2026-06-16T21:18:30.4027051Z [command]/usr/bin/tar -xf /home/runner/work/_temp/116b5027-e85f-4707-809b-381bb7bc1680/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-06-16T21:18:31.1868014Z Cache restored successfully2026-06-16T21:18:31.3018985Z [command]/home/runner/bin/minikube start --wait all2026-06-16T21:18:31.3426323Z * minikube v1.38.1 on Ubuntu 22.042026-06-16T21:18:31.7818521Z ! 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-06-16T21:18:31.7830638Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-06-16T21:18:31.8371058Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-06-16T21:18:31.8382978Z * Using Docker driver with root privileges2026-06-16T21:18:31.8397502Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-06-16T21:18:31.8406718Z * Pulling base image v0.0.50 ...2026-06-16T21:19:04.0687361Z * Configuring bridge CNI (Container Networking Interface) ...2026-06-16T21:19:09.2432701Z * Verifying Kubernetes components...2026-06-16T21:19:09.2671076Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-06-16T21:19:10.0227652Z * Enabled addons: storage-provisioner, default-storageclass2026-06-16T21:19:55.5047036Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-06-16T21:19:55.5151450Z [command]/home/runner/bin/minikube version --short2026-06-16T21:19:55.5540003Z v1.38.12026-06-16T21:19:55.5802958Z ##[group]Run actions/setup-go@v62026-06-16T21:19:55.5803278Z with:2026-06-16T21:19:55.5803481Z go-version: 1.262026-06-16T21:19:55.5803690Z cache: true2026-06-16T21:19:55.5803916Z cache-dependency-path: go.sum2026-06-16T21:19:55.5804186Z check-latest: false2026-06-16T21:19:55.5807402Z token: ***2026-06-16T21:19:55.5807614Z ##[endgroup]2026-06-16T21:19:55.7270275Z Setup go version spec 1.262026-06-16T21:19:55.7353821Z Attempting to download 1.26...2026-06-16T21:19:56.6157653Z matching 1.26...2026-06-16T21:19:56.6166709Z Acquiring 1.26.4 from https://github.com/actions/go-versions/releases/download/1.26.4-26891772857/go-1.26.4-linux-x64.tar.gz2026-06-16T21:19:57.2243976Z Extracting Go...2026-06-16T21:19:57.2369314Z [command]/usr/bin/tar xz --warning=no-unknown-keyword --overwrite -C /home/runner/work/_temp/6e5de118-d7ba-4bbb-ae22-af54b6d1b8b8 -f /home/runner/work/_temp/19372be6-9fe9-429a-91b2-1e87131640792026-06-16T21:19:58.9280997Z Successfully extracted go to /home/runner/work/_temp/6e5de118-d7ba-4bbb-ae22-af54b6d1b8b82026-06-16T21:19:58.9282307Z Adding to the cache ...2026-06-16T21:20:04.9210097Z Successfully cached go to /opt/hostedtoolcache/go/1.26.4/x642026-06-16T21:20:04.9211860Z Added go to the path2026-06-16T21:20:04.9215045Z Successfully set up Go version 1.262026-06-16T21:20:04.9451400Z [command]/opt/hostedtoolcache/go/1.26.4/x64/bin/go env GOMODCACHE2026-06-16T21:20:04.9481259Z [command]/opt/hostedtoolcache/go/1.26.4/x64/bin/go env GOCACHE2026-06-16T21:20:04.9510860Z /home/runner/go/pkg/mod2026-06-16T21:20:04.9533866Z /home/runner/.cache/go-build2026-06-16T21:20:05.1955969Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.4-4d532554cd8420c389c8064f4e1b4d5cc1d79ec73be5008309ef5f6e35b363a42026-06-16T21:20:06.4701989Z Received 33554432 of 252076037 (13.3%), 32.0 MBs/sec2026-06-16T21:20:07.4716394Z Received 150994944 of 252076037 (59.9%), 71.9 MBs/sec2026-06-16T21:20:08.2175636Z Received 252076037 of 252076037 (100.0%), 87.5 MBs/sec2026-06-16T21:20:08.2177205Z Cache Size: ~240 MB (252076037 B)2026-06-16T21:20:08.2298771Z [command]/usr/bin/tar -xf /home/runner/work/_temp/14089157-8b62-472d-8b26-9e12fb6bd13b/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-06-16T21:20:11.3669988Z Cache restored successfully2026-06-16T21:20:11.4238452Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.4-4d532554cd8420c389c8064f4e1b4d5cc1d79ec73be5008309ef5f6e35b363a42026-06-16T21:20:11.4260981Z go version go1.26.4 linux/amd642026-06-16T21:20:11.4261213Z 2026-06-16T21:20:11.4261860Z ##[group]go env2026-06-16T21:20:11.4968105Z AR='ar'2026-06-16T21:20:11.4968672Z CC='gcc'2026-06-16T21:20:11.4969105Z CGO_CFLAGS='-O2 -g'2026-06-16T21:20:11.4969613Z CGO_CPPFLAGS=''2026-06-16T21:20:11.4970114Z CGO_CXXFLAGS='-O2 -g'2026-06-16T21:20:11.4970606Z CGO_ENABLED='1'2026-06-16T21:20:11.4971285Z CGO_FFLAGS='-O2 -g'2026-06-16T21:20:11.4971723Z CGO_LDFLAGS='-O2 -g'2026-06-16T21:20:11.4972221Z CXX='g++'2026-06-16T21:20:11.4972621Z GCCGO='gccgo'2026-06-16T21:20:11.4973059Z GO111MODULE=''2026-06-16T21:20:11.4973478Z GOAMD64='v1'2026-06-16T21:20:11.4973926Z GOARCH='amd64'2026-06-16T21:20:11.4974360Z GOAUTH='netrc'2026-06-16T21:20:11.4974980Z GOBIN=''2026-06-16T21:20:11.4975458Z GOCACHE='/home/runner/.cache/go-build'2026-06-16T21:20:11.4976077Z GOCACHEPROG=''2026-06-16T21:20:11.4976524Z GODEBUG=''2026-06-16T21:20:11.4976997Z GOENV='/home/runner/.config/go/env'2026-06-16T21:20:11.4977434Z GOEXE=''2026-06-16T21:20:11.4977766Z GOEXPERIMENT=''2026-06-16T21:20:11.4978110Z GOFIPS140='off'2026-06-16T21:20:11.4978468Z GOFLAGS=''2026-06-16T21:20:11.4979543Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build2803352531=/tmp/go-build -gno-record-gcc-switches'2026-06-16T21:20:11.4980693Z GOHOSTARCH='amd64'2026-06-16T21:20:11.4981060Z GOHOSTOS='linux'2026-06-16T21:20:11.4981417Z GOINSECURE=''2026-06-16T21:20:11.4982338Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-06-16T21:20:11.4983070Z GOMODCACHE='/home/runner/go/pkg/mod'2026-06-16T21:20:11.4983533Z GONOPROXY=''2026-06-16T21:20:11.4983868Z GONOSUMDB=''2026-06-16T21:20:11.4984200Z GOOS='linux'2026-06-16T21:20:11.4984543Z GOPATH='/home/runner/go'2026-06-16T21:20:11.4985222Z GOPRIVATE=''2026-06-16T21:20:11.4985648Z GOPROXY='https://proxy.golang.org,direct'2026-06-16T21:20:11.4986218Z GOROOT='/opt/hostedtoolcache/go/1.26.4/x64'2026-06-16T21:20:11.4986743Z GOSUMDB='sum.golang.org'2026-06-16T21:20:11.4987148Z GOTELEMETRY='local'2026-06-16T21:20:11.4987606Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-06-16T21:20:11.4988127Z GOTMPDIR=''2026-06-16T21:20:11.4988453Z GOTOOLCHAIN='local'2026-06-16T21:20:11.4989009Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.4/x64/pkg/tool/linux_amd64'2026-06-16T21:20:11.4989600Z GOVCS=''2026-06-16T21:20:11.4989911Z GOVERSION='go1.26.4'2026-06-16T21:20:11.4990263Z GOWORK=''2026-06-16T21:20:11.4990619Z PKG_CONFIG='pkg-config'2026-06-16T21:20:11.4990869Z 2026-06-16T21:20:11.4991357Z ##[endgroup]2026-06-16T21:20:11.5198741Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-06-16T21:20:11.5199291Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-06-16T21:20:11.5252984Z shell: /usr/bin/bash -e {0}2026-06-16T21:20:11.5253276Z env:2026-06-16T21:20:11.5253503Z GOTOOLCHAIN: local2026-06-16T21:20:11.5253784Z OSPOOL_EP_OSPoolEPTag: 25-release2026-06-16T21:20:11.5254103Z OSPOOL_EP_CMTag: 25.0-el92026-06-16T21:20:11.5254386Z OSPOOL_EP_CvmfsType: cvmfsexec2026-06-16T21:20:11.5254690Z ##[endgroup]2026-06-16T21:20:13.7031800Z === RUN TestOSPoolEP2026-06-16T21:20:13.7032252Z === PAUSE TestOSPoolEP2026-06-16T21:20:13.7032515Z === CONT TestOSPoolEP2026-06-16T21:20:13.7033181Z TestOSPoolEP 2026-06-16T21:20:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:13.7114092Z TestOSPoolEP 2026-06-16T21:20:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 apply -f /tmp/TestOSPoolEP1218569420]2026-06-16T21:20:14.2272741Z TestOSPoolEP 2026-06-16T21:20:14Z logger.go:67: pod/idtoken-generator created2026-06-16T21:20:14.2356663Z TestOSPoolEP 2026-06-16T21:20:14Z logger.go:67: secret/pool-passwd created2026-06-16T21:20:14.2384758Z TestOSPoolEP 2026-06-16T21:20:14Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-06-16T21:20:14.2387235Z TestOSPoolEP 2026-06-16T21:20:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:14.2415882Z TestOSPoolEP 2026-06-16T21:20:14Z 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-06-16T21:20:24.2432848Z TestOSPoolEP 2026-06-16T21:20:24Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-06-16T21:20:24.2434480Z TestOSPoolEP 2026-06-16T21:20:24Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:24.2459992Z TestOSPoolEP 2026-06-16T21:20:24Z 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-06-16T21:20:34.2469650Z TestOSPoolEP 2026-06-16T21:20:34Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-06-16T21:20:34.2471604Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:34.2500623Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: Pod is now available2026-06-16T21:20:34.2503128Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-06-16T21:20:34.7676150Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: ***2026-06-16T21:20:34.7736671Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 apply -f /tmp/TestOSPoolEP3212778549]2026-06-16T21:20:34.9572019Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: secret/pool-token created2026-06-16T21:20:34.9603806Z TestOSPoolEP 2026-06-16T21:20:34Z retry.go:91: Wait for secret pool-token to be provisioned.2026-06-16T21:20:34.9605367Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:34.9622775Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: Secret is now available2026-06-16T21:20:34.9648597Z TestOSPoolEP 2026-06-16T21:20:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 apply -k /tmp/kustomize-template-1576505136]2026-06-16T21:20:35.2347330Z TestOSPoolEP 2026-06-16T21:20:35Z logger.go:67: service/test-cm created2026-06-16T21:20:35.2444336Z TestOSPoolEP 2026-06-16T21:20:35Z 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-06-16T21:20:35.2451874Z TestOSPoolEP 2026-06-16T21:20:35Z logger.go:67: deployment.apps/ospool-ep created2026-06-16T21:20:35.2592007Z TestOSPoolEP 2026-06-16T21:20:35Z logger.go:67: deployment.apps/test-cm created2026-06-16T21:20:35.2649093Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-06-16T21:20:35.2660824Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:35.2723355Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:35Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-06-16T21:20:35.2725921Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:35.2741686Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:35Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-06-16T21:20:35.2744300Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:35.2858264Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:35Z 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-06-16T21:20:35.2863152Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:35Z 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-06-16T21:20:45.2871396Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:45Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-06-16T21:20:45.2874007Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:45Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:45.2876568Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:45Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-06-16T21:20:45.2878050Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:45Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:45.2892290Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:45Z logger.go:67: Deployment is now available2026-06-16T21:20:45.2894163Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:45Z 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-06-16T21:20:55.2905789Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:55Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-06-16T21:20:55.2907845Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:55Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:20:55.2938204Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:20:55Z 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-06-16T21:21:05.2938264Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:21:05Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-06-16T21:21:05.2940054Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:21:05Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:21:05.2965509Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-16T21:21:05Z logger.go:67: Deployment is now available2026-06-16T21:21:05.2966812Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-06-16T21:21:05.2967675Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-06-16T21:21:05.2968466Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-06-16T21:21:05.2969297Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-06-16T21:21:05.2970024Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-06-16T21:21:05.2970616Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-06-16T21:21:05.2971219Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-06-16T21:21:05.2972492Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:05Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:21:05.2974490Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-06-16T21:21:05.2976288Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:21:05Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:21:05.2993482Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-06-16T21:21:05.3001183Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-16T21:21:05Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:21:05.3003251Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:05Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:21:05.3004685Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:21:05Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:21:05.3013385Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-16T21:21:05Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:21:05.3036826Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:05Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)']2026-06-16T21:21:05.3044486Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:21:05Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:21:05.3058666Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-16T21:21:05Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_SINGULARITY]2026-06-16T21:21:05.5825206Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 10s.2026-06-16T21:21:05.5937896Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-06-16T21:21:05.5945281Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 30s.2026-06-16T21:21:05.5984796Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-06-16T21:21:05.5987415Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)']' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 10s.2026-06-16T21:21:15.5827912Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-16T21:21:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_SINGULARITY]2026-06-16T21:21:15.5993514Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)']2026-06-16T21:21:15.7669941Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-06-16T21:21:15.7672036Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 10s.2026-06-16T21:21:15.7910644Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-06-16T21:21:15.7911721Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)']' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 10s.2026-06-16T21:21:25.7685149Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-16T21:21:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_SINGULARITY]2026-06-16T21:21:25.7920485Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)']2026-06-16T21:21:25.9491493Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-06-16T21:21:25.9493456Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 10s.2026-06-16T21:21:25.9577607Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-06-16T21:21:25.9578696Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)']' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 10s.2026-06-16T21:21:35.5945950Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:21:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:21:35.7527345Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-06-16T21:21:35.7529455Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 30s.2026-06-16T21:21:35.9500549Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-16T21:21:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_SINGULARITY]2026-06-16T21:21:35.9611452Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)']2026-06-16T21:21:36.1293545Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-06-16T21:21:36.1295072Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)']' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 10s.2026-06-16T21:21:36.1304691Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-06-16T21:21:36.1306182Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 10s.2026-06-16T21:21:46.1299233Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:46Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)']2026-06-16T21:21:46.1312097Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-16T21:21:46Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_SINGULARITY]2026-06-16T21:21:46.3449348Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:46Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-06-16T21:21:46.3465853Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:46Z logger.go:67: 2026-06-16T21:21:46.3468266Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:46Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-x96hm LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-06-16T21:21:46.3470110Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:46Z logger.go:67: 2026-06-16T21:21:46.3471770Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:46Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-06-16T21:21:46.3473416Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:46Z logger.go:67: 2026-06-16T21:21:46.3475110Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:46Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-06-16T21:21:46.3476628Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:46Z logger.go:67: 2026-06-16T21:21:46.3478137Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-16T21:21:46Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-06-16T21:21:46.3479692Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-16T21:21:46Z logger.go:67: true2026-06-16T21:22:05.7532280Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:22:05Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:22:05.8972049Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:22:05Z logger.go:67: undefined2026-06-16T21:22:05.9036440Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-06-16T21:22:05.9037918Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 30s.2026-06-16T21:22:35.9049629Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:22:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:22:36.0708177Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:22:36Z logger.go:67: undefined2026-06-16T21:22:36.0786119Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 30s.2026-06-16T21:23:06.0790947Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:23:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:23:06.2845603Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:23:06Z logger.go:67: undefined2026-06-16T21:23:06.2926492Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 30s.2026-06-16T21:23:36.2943518Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:23:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:23:36.4580444Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:23:36Z logger.go:67: undefined2026-06-16T21:23:36.4634942Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 30s.2026-06-16T21:24:06.4649449Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:24:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:24:06.6334013Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:24:06Z logger.go:67: undefined2026-06-16T21:24:06.6393984Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 30s.2026-06-16T21:24:36.6409018Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:24:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:24:36.8315633Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:24:36Z logger.go:67: undefined2026-06-16T21:24:36.8397272Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 30s.2026-06-16T21:25:06.8400770Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:25:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:25:06.9880477Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:25:06Z logger.go:67: undefined2026-06-16T21:25:06.9937548Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 30s.2026-06-16T21:25:36.9976233Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:25:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:25:37.1467782Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:25:37Z logger.go:67: undefined2026-06-16T21:25:37.1529802Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 30s.2026-06-16T21:26:07.1535125Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:26:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:26:07.2926131Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:26:07Z logger.go:67: undefined2026-06-16T21:26:07.2977894Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 30s.2026-06-16T21:26:37.3015758Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:26:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 exec test-cm-54b7d49f85-wvhd9 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-16T21:26:37.4593089Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-16T21:26:37Z logger.go:67: undefined2026-06-16T21:26:37.4653314Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wvhd9 failed. Retrying in 30s.2026-06-16T21:27:07.4657747Z test_utils.go:105: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-x96hm",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wvhd9 did not succeed within {12 30000000000} retries2026-06-16T21:27:07.4660816Z TestOSPoolEP 2026-06-16T21:27:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:27:07.4730424Z TestOSPoolEP 2026-06-16T21:27:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:27:07.6268861Z TestOSPoolEP 2026-06-16T21:27:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:27:07.7476740Z TestOSPoolEP 2026-06-16T21:27:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:27:07.8505695Z TestOSPoolEP 2026-06-16T21:27:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:27:07.8536369Z === NAME TestOSPoolEP2026-06-16T21:27:07.8537011Z ospool_ep_test.go:101: ---2026-06-16T21:27:07.8537437Z Events for pod idtoken-generator:2026-06-16T21:27:07.8538508Z 2026-06-16 21:20:14 +0000 UTC Normal Successfully assigned test-ospool-ep-7cf2v5/idtoken-generator to minikube2026-06-16T21:27:07.8539499Z 2026-06-16 21:20:17 +0000 UTC Normal Pulling image "htcondor/base"2026-06-16T21:27:07.8540733Z 2026-06-16 21:20:26 +0000 UTC Normal Successfully pulled image "htcondor/base" in 9.047s (9.047s including waiting). Image size: 557830759 bytes.2026-06-16T21:27:07.8541863Z 2026-06-16 21:20:26 +0000 UTC Normal Container created2026-06-16T21:27:07.8542421Z 2026-06-16 21:20:26 +0000 UTC Normal Container started2026-06-16T21:27:07.8542991Z 2026-06-16T21:27:07.8543407Z ---2026-06-16T21:27:07.8544545Z TestOSPoolEP 2026-06-16T21:27:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:27:07.8569374Z ospool_ep_test.go:101: ---2026-06-16T21:27:07.8570136Z Events for pod ospool-ep-6c7d796845-x96hm:2026-06-16T21:27:07.8571975Z 2026-06-16 21:20:35 +0000 UTC Normal Successfully assigned test-ospool-ep-7cf2v5/ospool-ep-6c7d796845-x96hm to minikube2026-06-16T21:27:07.8573662Z 2026-06-16 21:20:35 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-06-16T21:27:07.8575798Z 2026-06-16 21:20:37 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 2.083s (2.083s including waiting). Image size: 5590942 bytes.2026-06-16T21:27:07.8576835Z 2026-06-16 21:20:37 +0000 UTC Normal Container created2026-06-16T21:27:07.8577330Z 2026-06-16 21:20:37 +0000 UTC Normal Container started2026-06-16T21:27:07.8578056Z 2026-06-16 21:20:38 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-06-16T21:27:07.8580292Z 2026-06-16 21:21:02 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 18.385s (24.207s including waiting). Image size: 1117466755 bytes.2026-06-16T21:27:07.8581967Z 2026-06-16 21:21:02 +0000 UTC Normal Container created2026-06-16T21:27:07.8582889Z 2026-06-16 21:21:02 +0000 UTC Normal Container started2026-06-16T21:27:07.8583428Z 2026-06-16T21:27:07.8583849Z ---2026-06-16T21:27:07.8585079Z TestOSPoolEP 2026-06-16T21:27:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:27:07.8595678Z ospool_ep_test.go:101: ---2026-06-16T21:27:07.8596886Z Events for pod test-cm-54b7d49f85-wvhd9:2026-06-16T21:27:07.8598706Z 2026-06-16 21:20:35 +0000 UTC Normal Successfully assigned test-ospool-ep-7cf2v5/test-cm-54b7d49f85-wvhd9 to minikube2026-06-16T21:27:07.8600134Z 2026-06-16 21:20:35 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-06-16T21:27:07.8601986Z 2026-06-16 21:20:43 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 6.017s (8.075s including waiting). Image size: 569448471 bytes.2026-06-16T21:27:07.8603393Z 2026-06-16 21:20:43 +0000 UTC Normal Container created2026-06-16T21:27:07.8604250Z 2026-06-16 21:20:43 +0000 UTC Normal Container started2026-06-16T21:27:07.8605039Z 2026-06-16T21:27:07.8605416Z ---2026-06-16T21:27:07.8606446Z TestOSPoolEP 2026-06-16T21:27:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-16T21:27:07.8631536Z TestOSPoolEP 2026-06-16T21:27:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 delete -f /tmp/TestOSPoolEP219185923]2026-06-16T21:27:07.9541486Z TestOSPoolEP 2026-06-16T21:27:07Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-7cf2v5 namespace2026-06-16T21:27:07.9582977Z TestOSPoolEP 2026-06-16T21:27:07Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-7cf2v5 namespace2026-06-16T21:27:09.1760744Z TestOSPoolEP 2026-06-16T21:27:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 delete -f /tmp/TestOSPoolEP1806611964]2026-06-16T21:27:09.2879648Z TestOSPoolEP 2026-06-16T21:27:09Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-7cf2v5 namespace2026-06-16T21:27:09.2923724Z TestOSPoolEP 2026-06-16T21:27:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-7cf2v5 delete -k /tmp/kustomize-template-1576505136]2026-06-16T21:27:09.4578757Z TestOSPoolEP 2026-06-16T21:27:09Z logger.go:67: service "test-cm" deleted from test-ospool-ep-7cf2v5 namespace2026-06-16T21:27:09.4628769Z TestOSPoolEP 2026-06-16T21:27:09Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-7cf2v5 namespace2026-06-16T21:27:09.4680258Z TestOSPoolEP 2026-06-16T21:27:09Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-7cf2v5 namespace2026-06-16T21:27:09.4781515Z --- FAIL: TestOSPoolEP (53.61s)2026-06-16T21:27:09.4782276Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.03s)2026-06-16T21:27:09.4783200Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (41.06s)2026-06-16T21:27:09.4783995Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (41.06s)2026-06-16T21:27:09.4785094Z --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (362.17s)2026-06-16T21:27:09.4785748Z FAIL2026-06-16T21:27:09.4830956Z FAIL github.com/osg-htc/k8s-integration-tests/test 415.793s2026-06-16T21:27:09.5051408Z FAIL2026-06-16T21:27:09.5619611Z ##[error]Process completed with exit code 1.2026-06-16T21:27:09.5681753Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-06-16T21:27:09.5683011Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-06-16T21:27:09.5772864Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-06-16T21:27:09.5773688Z env:2026-06-16T21:27:09.5774256Z GOTOOLCHAIN: local2026-06-16T21:27:09.5775291Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-06-16T21:27:09.5776503Z ##[endgroup]2026-06-16T21:27:09.6023873Z ##[group]Run actions/upload-artifact@v42026-06-16T21:27:09.6024402Z with:2026-06-16T21:27:09.6025383Z name: TestOSPoolEP-cc19cc9f6a267801fd4b50ff75e13034a08c460c9bda971d5975af0507e12f662026-06-16T21:27:09.6026241Z path: /tmp/k8s-tests2026-06-16T21:27:09.6026652Z retention-days: 52026-06-16T21:27:09.6027050Z if-no-files-found: warn2026-06-16T21:27:09.6027481Z compression-level: 62026-06-16T21:27:09.6028171Z overwrite: false2026-06-16T21:27:09.6028566Z include-hidden-files: false2026-06-16T21:27:09.6028988Z env:2026-06-16T21:27:09.6029322Z GOTOOLCHAIN: local2026-06-16T21:27:09.6029698Z ##[endgroup]2026-06-16T21:27:09.9162187Z With the provided path, there will be 6 files uploaded2026-06-16T21:27:09.9185850Z Artifact name is valid!2026-06-16T21:27:09.9187676Z Root directory input is valid!2026-06-16T21:27:10.2843361Z Beginning upload of artifact content to blob storage2026-06-16T21:27:10.5909175Z Uploaded bytes 141062026-06-16T21:27:10.6570551Z Finished uploading artifact content to blob storage!2026-06-16T21:27:10.6575187Z SHA256 digest of uploaded artifact zip is a81bb337a8847f7fbd16a5014eb4fa10a0e8de04b0b19c55c8fa1bf8adffe9502026-06-16T21:27:10.6577277Z Finalizing artifact upload2026-06-16T21:27:10.8931685Z Artifact TestOSPoolEP-cc19cc9f6a267801fd4b50ff75e13034a08c460c9bda971d5975af0507e12f66.zip successfully finalized. Artifact ID 76800783962026-06-16T21:27:10.8933857Z Artifact TestOSPoolEP-cc19cc9f6a267801fd4b50ff75e13034a08c460c9bda971d5975af0507e12f66 has been successfully uploaded! Final size is 14106 bytes. Artifact ID is 76800783962026-06-16T21:27:10.8939324Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/27648802079/artifacts/76800783962026-06-16T21:27:10.9133468Z Post job cleanup.2026-06-16T21:27:11.0005473Z [command]/usr/bin/git version2026-06-16T21:27:11.0042937Z git version 2.54.02026-06-16T21:27:11.0115190Z Temporarily overriding HOME='/home/runner/work/_temp/768fe452-b069-4917-b870-3341336d9aee' before making global git config changes2026-06-16T21:27:11.0116684Z Adding repository directory to the temporary git global config as a safe directory2026-06-16T21:27:11.0121652Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-06-16T21:27:11.0160469Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-06-16T21:27:11.0195294Z [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-06-16T21:27:11.0449371Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-06-16T21:27:11.0472897Z http.https://github.com/.extraheader2026-06-16T21:27:11.0483846Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-06-16T21:27:11.0517814Z [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-06-16T21:27:11.0765931Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-06-16T21:27:11.0799644Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-06-16T21:27:11.1202938Z Cleaning up orphan processes2026-06-16T21:27:11.2074261Z ##[warning]Node.js 20 actions are deprecated. The following actions are running on Node.js 20 and may not work as expected: actions/upload-artifact@v4. Actions will be forced to run with Node.js 24 by default starting June 16th, 2026. Node.js 20 will be removed from the runner on September 16th, 2026. Please check if updated versions of these actions are available that support Node.js 24. To opt into Node.js 24 now, set the FORCE_JAVASCRIPT_ACTIONS_TO_NODE24=true environment variable on the runner or in your workflow file. Once Node.js 24 becomes the default, you can temporarily opt out by setting ACTIONS_ALLOW_USE_UNSECURE_NODE_VERSION=true. For more information see: https://github.blog/changelog/2025-09-19-deprecation-of-node-20-on-github-actions-runners/