2026-08-02T01:47:59.1989725Z Current runner version: '2.336.0'2026-08-02T01:47:59.2015574Z ##[group]Runner Image Provisioner2026-08-02T01:47:59.2016416Z Hosted Compute Agent2026-08-02T01:47:59.2017118Z Version: 20260707.5632026-08-02T01:47:59.2017747Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-08-02T01:47:59.2018462Z Build Date: 2026-07-07T19:33:50Z2026-08-02T01:47:59.2019255Z Worker ID: {66a0fbcc-35b5-48e9-a930-97074771abd1}2026-08-02T01:47:59.2019987Z Azure Region: eastus2026-08-02T01:47:59.2020610Z ##[endgroup]2026-08-02T01:47:59.2022360Z ##[group]Operating System2026-08-02T01:47:59.2022996Z Ubuntu2026-08-02T01:47:59.2023632Z 22.04.52026-08-02T01:47:59.2024150Z LTS2026-08-02T01:47:59.2024666Z ##[endgroup]2026-08-02T01:47:59.2025314Z ##[group]Runner Image2026-08-02T01:47:59.2025918Z Image: ubuntu-22.042026-08-02T01:47:59.2026640Z Version: 20260720.234.22026-08-02T01:47:59.2027927Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-08-02T01:47:59.2029533Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-08-02T01:47:59.2030496Z ##[endgroup]2026-08-02T01:47:59.2031861Z ##[group]GITHUB_TOKEN Permissions2026-08-02T01:47:59.2034120Z Contents: read2026-08-02T01:47:59.2035192Z Metadata: read2026-08-02T01:47:59.2035762Z Packages: read2026-08-02T01:47:59.2036338Z ##[endgroup]2026-08-02T01:47:59.2038842Z Secret source: Actions2026-08-02T01:47:59.2039875Z Prepare workflow directory2026-08-02T01:47:59.2373296Z Prepare all required actions2026-08-02T01:47:59.2421393Z Getting action download info2026-08-02T01:47:59.4410649Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-02T01:48:00.0310255Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-02T01:48:00.1568958Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-02T01:48:00.3118031Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-02T01:48:00.6152644Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-02T01:48:00.6157250Z ##[group] Inputs2026-08-02T01:48:00.6157767Z testName: TestOSPoolEP2026-08-02T01:48:00.6158610Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-02T01:48:00.6159513Z setupScript: 2026-08-02T01:48:00.6159955Z setupEnv: {}2026-08-02T01:48:00.6160381Z ##[endgroup]2026-08-02T01:48:00.6161052Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-08-02T01:48:00.6905431Z ##[group]Run actions/checkout@v52026-08-02T01:48:00.6906311Z with:2026-08-02T01:48:00.6906790Z repository: mwestphall/k8s-integration-tests2026-08-02T01:48:00.6910891Z token: ***2026-08-02T01:48:00.6911325Z ssh-strict: true2026-08-02T01:48:00.6911992Z ssh-user: git2026-08-02T01:48:00.6912432Z persist-credentials: true2026-08-02T01:48:00.6912911Z clean: true2026-08-02T01:48:00.6913339Z sparse-checkout-cone-mode: true2026-08-02T01:48:00.6913840Z fetch-depth: 12026-08-02T01:48:00.6914257Z fetch-tags: false2026-08-02T01:48:00.6914676Z show-progress: true2026-08-02T01:48:00.6915106Z lfs: false2026-08-02T01:48:00.6915501Z submodules: false2026-08-02T01:48:00.6915929Z set-safe-directory: true2026-08-02T01:48:00.6916417Z allow-unsafe-pr-checkout: false2026-08-02T01:48:00.6917193Z ##[endgroup]2026-08-02T01:48:00.7952525Z Syncing repository: mwestphall/k8s-integration-tests2026-08-02T01:48:00.7955163Z ##[group]Getting Git version info2026-08-02T01:48:00.7956697Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-02T01:48:00.7958637Z [command]/usr/bin/git version2026-08-02T01:48:00.8968527Z git version 2.54.02026-08-02T01:48:00.8991962Z ##[endgroup]2026-08-02T01:48:00.9007963Z Temporarily overriding HOME='/home/runner/work/_temp/949c33f6-ec22-4dfc-a50f-39ddf48ea23f' before making global git config changes2026-08-02T01:48:00.9011024Z Adding repository directory to the temporary git global config as a safe directory2026-08-02T01:48:00.9013588Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-02T01:48:00.9055351Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-02T01:48:00.9059398Z ##[group]Initializing the repository2026-08-02T01:48:00.9064339Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-02T01:48:00.9510611Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-02T01:48:00.9513597Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-02T01:48:00.9515933Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-02T01:48:00.9518177Z hint: call:2026-08-02T01:48:00.9519055Z hint:2026-08-02T01:48:00.9519954Z hint: git config --global init.defaultBranch <name>2026-08-02T01:48:00.9521067Z hint:2026-08-02T01:48:00.9522421Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-02T01:48:00.9524217Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-02T01:48:00.9525589Z hint:2026-08-02T01:48:00.9526277Z hint: git branch -m <name>2026-08-02T01:48:00.9527050Z hint:2026-08-02T01:48:00.9528056Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-02T01:48:00.9529987Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-02T01:48:00.9533646Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-02T01:48:00.9620928Z ##[endgroup]2026-08-02T01:48:00.9622511Z ##[group]Disabling automatic garbage collection2026-08-02T01:48:00.9625759Z [command]/usr/bin/git config --local gc.auto 02026-08-02T01:48:00.9660262Z ##[endgroup]2026-08-02T01:48:00.9660990Z ##[group]Setting up auth2026-08-02T01:48:00.9667490Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-02T01:48:00.9704668Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :"2026-08-02T01:48:01.1478520Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-02T01:48:01.1517963Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :"2026-08-02T01:48:01.1789616Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-02T01:48:01.1834449Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-02T01:48:01.2116014Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-02T01:48:01.2163419Z ##[endgroup]2026-08-02T01:48:01.2166119Z ##[group]Fetching the repository2026-08-02T01:48:01.2174609Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-02T01:48:01.5034632Z From https://github.com/mwestphall/k8s-integration-tests2026-08-02T01:48:01.5038784Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-02T01:48:01.5065989Z ##[endgroup]2026-08-02T01:48:01.5069357Z ##[group]Determining the checkout info2026-08-02T01:48:01.5072696Z ##[endgroup]2026-08-02T01:48:01.5074828Z [command]/usr/bin/git sparse-checkout disable2026-08-02T01:48:01.5173112Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-02T01:48:01.5206201Z ##[group]Checking out the ref2026-08-02T01:48:01.5209075Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-02T01:48:01.5357424Z Switched to a new branch 'main'2026-08-02T01:48:01.5360772Z branch 'main' set up to track 'origin/main'.2026-08-02T01:48:01.5367969Z ##[endgroup]2026-08-02T01:48:01.5417689Z [command]/usr/bin/git log -1 --format=%H2026-08-02T01:48:01.5446764Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-02T01:48:01.5797308Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-02T01:48:01.5800022Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-02T01:48:01.5803161Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-02T01:48:01.6301874Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-02T01:48:01.6303869Z env:2026-08-02T01:48:01.6306259Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-02T01:48:01.6309190Z SETUP_ENV_YAML: {}2026-08-02T01:48:01.6310466Z ##[endgroup]2026-08-02T01:48:02.1943047Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-02T01:48:02.1945570Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-02T01:48:02.2004364Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-02T01:48:02.2005753Z env:2026-08-02T01:48:02.2007546Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-02T01:48:02.2009743Z ##[endgroup]2026-08-02T01:48:02.2195144Z ##[group]Run true2026-08-02T01:48:02.2196067Z [36;1mtrue[0m2026-08-02T01:48:02.2249943Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-02T01:48:02.2251351Z ##[endgroup]2026-08-02T01:48:02.2536305Z ##[group]Run medyagh/setup-minikube@latest2026-08-02T01:48:02.2537470Z with:2026-08-02T01:48:02.2538232Z start: true2026-08-02T01:48:02.2539025Z cache: true2026-08-02T01:48:02.2539860Z minikube-version: latest2026-08-02T01:48:02.2540808Z wait: all2026-08-02T01:48:02.2541576Z ##[endgroup]2026-08-02T01:48:02.3889082Z (node:2076) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-02T01:48:02.3893695Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-02T01:48:03.4724825Z [command]/usr/bin/chmod +x /home/runner/work/_temp/70b1976d-e99f-4d44-bb34-84f9666fc6fb2026-08-02T01:48:03.6314721Z [command]/home/runner/bin/minikube version --short2026-08-02T01:48:03.6792398Z v1.38.12026-08-02T01:48:03.7649684Z Cache hit for: kic-v1.38.1-x642026-08-02T01:48:03.7657284Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-02T01:48:03.7768019Z (node:2076) [DEP0169] DeprecationWarning: `url.parse()` behavior is not standardized and prone to errors that have security implications. Use the WHATWG URL API instead. CVEs are not issued for `url.parse()` vulnerabilities.2026-08-02T01:48:09.8096050Z Received 125829120 of 224218863 (56.1%), 119.3 MBs/sec2026-08-02T01:48:09.9232871Z Received 134217728 of 544082657 (24.7%), 116.7 MBs/sec2026-08-02T01:48:10.4962004Z Received 224218863 of 224218863 (100.0%), 126.3 MBs/sec2026-08-02T01:48:10.4963723Z Cache Size: ~214 MB (224218863 B)2026-08-02T01:48:10.5416677Z [command]/usr/bin/tar -xf /home/runner/work/_temp/7a3a7357-972f-4a1b-9d4d-1105f76ca978/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-02T01:48:10.9338587Z Received 301989888 of 544082657 (55.5%), 136.5 MBs/sec2026-08-02T01:48:11.2894149Z Cache restored successfully2026-08-02T01:48:11.9916576Z Received 536870912 of 544082657 (98.7%), 161.6 MBs/sec2026-08-02T01:48:12.1116892Z Received 544082657 of 544082657 (100.0%), 157.8 MBs/sec2026-08-02T01:48:12.1123635Z Cache Size: ~519 MB (544082657 B)2026-08-02T01:48:12.1253271Z [command]/usr/bin/tar -xf /home/runner/work/_temp/df9630b8-578e-49d4-9934-b954f2593851/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-02T01:48:12.9015087Z Cache restored successfully2026-08-02T01:48:13.0182134Z [command]/home/runner/bin/minikube start --wait all2026-08-02T01:48:13.0575542Z * minikube v1.38.1 on Ubuntu 22.042026-08-02T01:48:16.5914143Z ! The minimum required version for podman is "4.9.0". your version is "3.4.4". minikube might not work. use at your own risk. To install latest version please see https://podman.io/getting-started/installation.html2026-08-02T01:48:16.5932262Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-02T01:48:16.6569165Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-02T01:48:16.6579577Z * Using Docker driver with root privileges2026-08-02T01:48:16.6591373Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-02T01:48:16.6599077Z * Pulling base image v0.0.50 ...2026-08-02T01:48:48.3209232Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-02T01:48:53.4778358Z * Verifying Kubernetes components...2026-08-02T01:48:53.5060162Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-02T01:48:54.3304886Z * Enabled addons: storage-provisioner, default-storageclass2026-08-02T01:49:33.8882551Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-02T01:49:33.8976001Z [command]/home/runner/bin/minikube version --short2026-08-02T01:49:33.9392938Z v1.38.12026-08-02T01:49:33.9734773Z ##[group]Run actions/setup-go@v62026-08-02T01:49:33.9735070Z with:2026-08-02T01:49:33.9735268Z go-version: 1.262026-08-02T01:49:33.9735475Z cache: true2026-08-02T01:49:33.9735695Z cache-dependency-path: go.sum2026-08-02T01:49:33.9735973Z check-latest: false2026-08-02T01:49:33.9738661Z token: ***2026-08-02T01:49:33.9738869Z ##[endgroup]2026-08-02T01:49:34.1008657Z Setup go version spec 1.262026-08-02T01:49:34.1243288Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-02T01:49:34.1243808Z Added go to the path2026-08-02T01:49:34.1244155Z Successfully set up Go version 1.262026-08-02T01:49:34.7498953Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-02T01:49:34.7538541Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-02T01:49:34.7570501Z /home/runner/go/pkg/mod2026-08-02T01:49:34.7593477Z /home/runner/.cache/go-build2026-08-02T01:49:34.8235040Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-02T01:49:35.8927967Z Received 184549376 of 251839808 (73.3%), 175.8 MBs/sec2026-08-02T01:49:36.1550612Z Received 251839808 of 251839808 (100.0%), 189.7 MBs/sec2026-08-02T01:49:36.1552764Z Cache Size: ~240 MB (251839808 B)2026-08-02T01:49:36.1590040Z [command]/usr/bin/tar -xf /home/runner/work/_temp/f4eef33f-b509-43c9-8aad-e2faf4dd4fa7/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-02T01:49:39.2934502Z Cache restored successfully2026-08-02T01:49:39.3518835Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-02T01:49:39.3546640Z go version go1.26.5 linux/amd642026-08-02T01:49:39.3546853Z 2026-08-02T01:49:39.3547159Z ##[group]go env2026-08-02T01:49:39.4616259Z AR='ar'2026-08-02T01:49:39.4616795Z CC='gcc'2026-08-02T01:49:39.4617562Z CGO_CFLAGS='-O2 -g'2026-08-02T01:49:39.4618407Z CGO_CPPFLAGS=''2026-08-02T01:49:39.4618895Z CGO_CXXFLAGS='-O2 -g'2026-08-02T01:49:39.4619370Z CGO_ENABLED='1'2026-08-02T01:49:39.4619805Z CGO_FFLAGS='-O2 -g'2026-08-02T01:49:39.4620242Z CGO_LDFLAGS='-O2 -g'2026-08-02T01:49:39.4621055Z CXX='g++'2026-08-02T01:49:39.4621480Z GCCGO='gccgo'2026-08-02T01:49:39.4622170Z GO111MODULE=''2026-08-02T01:49:39.4622614Z GOAMD64='v1'2026-08-02T01:49:39.4623016Z GOARCH='amd64'2026-08-02T01:49:39.4623372Z GOAUTH='netrc'2026-08-02T01:49:39.4623721Z GOBIN=''2026-08-02T01:49:39.4624105Z GOCACHE='/home/runner/.cache/go-build'2026-08-02T01:49:39.4624633Z GOCACHEPROG=''2026-08-02T01:49:39.4625181Z GODEBUG=''2026-08-02T01:49:39.4625556Z GOENV='/home/runner/.config/go/env'2026-08-02T01:49:39.4626029Z GOEXE=''2026-08-02T01:49:39.4626378Z GOEXPERIMENT=''2026-08-02T01:49:39.4626784Z GOFIPS140='off'2026-08-02T01:49:39.4627128Z GOFLAGS=''2026-08-02T01:49:39.4628853Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build4020163793=/tmp/go-build -gno-record-gcc-switches'2026-08-02T01:49:39.4656054Z GOHOSTARCH='amd64'2026-08-02T01:49:39.4656456Z GOHOSTOS='linux'2026-08-02T01:49:39.4656834Z GOINSECURE=''2026-08-02T01:49:39.4657468Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-02T01:49:39.4658251Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-02T01:49:39.4658857Z GONOPROXY=''2026-08-02T01:49:39.4659236Z GONOSUMDB=''2026-08-02T01:49:39.4659563Z GOOS='linux'2026-08-02T01:49:39.4659911Z GOPATH='/home/runner/go'2026-08-02T01:49:39.4660321Z GOPRIVATE=''2026-08-02T01:49:39.4660750Z GOPROXY='https://proxy.golang.org,direct'2026-08-02T01:49:39.4661347Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-02T01:49:39.4662089Z GOSUMDB='sum.golang.org'2026-08-02T01:49:39.4662501Z GOTELEMETRY='local'2026-08-02T01:49:39.4662974Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-02T01:49:39.4663499Z GOTMPDIR=''2026-08-02T01:49:39.4663837Z GOTOOLCHAIN='local'2026-08-02T01:49:39.4664742Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-02T01:49:39.4665388Z GOVCS=''2026-08-02T01:49:39.4665714Z GOVERSION='go1.26.5'2026-08-02T01:49:39.4666084Z GOWORK=''2026-08-02T01:49:39.4666448Z PKG_CONFIG='pkg-config'2026-08-02T01:49:39.4666706Z 2026-08-02T01:49:39.4667188Z ##[endgroup]2026-08-02T01:49:39.4864967Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-02T01:49:39.4865521Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-02T01:49:39.4921173Z shell: /usr/bin/bash -e {0}2026-08-02T01:49:39.4921465Z env:2026-08-02T01:49:39.4922008Z GOTOOLCHAIN: local2026-08-02T01:49:39.4922332Z OSPOOL_EP_OSPoolEPTag: 25-release2026-08-02T01:49:39.4922664Z OSPOOL_EP_CMTag: 25.0-el92026-08-02T01:49:39.4922968Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-02T01:49:39.4923276Z ##[endgroup]2026-08-02T01:49:47.8437577Z === RUN TestOSPoolEP2026-08-02T01:49:47.8439935Z === PAUSE TestOSPoolEP2026-08-02T01:49:47.8440375Z === CONT TestOSPoolEP2026-08-02T01:49:47.8442003Z TestOSPoolEP 2026-08-02T01:49:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:49:47.8560852Z TestOSPoolEP 2026-08-02T01:49:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue apply -f /tmp/TestOSPoolEP1382451405]2026-08-02T01:49:48.3540503Z TestOSPoolEP 2026-08-02T01:49:48Z logger.go:67: pod/idtoken-generator created2026-08-02T01:49:48.3633839Z TestOSPoolEP 2026-08-02T01:49:48Z logger.go:67: secret/pool-passwd created2026-08-02T01:49:48.3671772Z TestOSPoolEP 2026-08-02T01:49:48Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-02T01:49:48.3673510Z TestOSPoolEP 2026-08-02T01:49:48Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:49:48.3694224Z TestOSPoolEP 2026-08-02T01:49:48Z retry.go:103: Wait for pod idtoken-generator to be provisioned. returned an error: Pod idtoken-generator is not available, reason: , message: . Sleeping for 10s and will try again.2026-08-02T01:49:58.3701343Z TestOSPoolEP 2026-08-02T01:49:58Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-02T01:49:58.3704407Z TestOSPoolEP 2026-08-02T01:49:58Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:49:58.3753245Z TestOSPoolEP 2026-08-02T01:49:58Z logger.go:67: Pod is now available2026-08-02T01:49:58.3755516Z TestOSPoolEP 2026-08-02T01:49:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-02T01:49:58.9739950Z TestOSPoolEP 2026-08-02T01:49:58Z logger.go:67: ***2026-08-02T01:49:58.9799320Z TestOSPoolEP 2026-08-02T01:49:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue apply -f /tmp/TestOSPoolEP2192226052]2026-08-02T01:49:59.1729812Z TestOSPoolEP 2026-08-02T01:49:59Z logger.go:67: secret/pool-token created2026-08-02T01:49:59.1757932Z TestOSPoolEP 2026-08-02T01:49:59Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-02T01:49:59.1759201Z TestOSPoolEP 2026-08-02T01:49:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:49:59.1779588Z TestOSPoolEP 2026-08-02T01:49:59Z logger.go:67: Secret is now available2026-08-02T01:49:59.1804034Z TestOSPoolEP 2026-08-02T01:49:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue apply -k /tmp/kustomize-template-3995195342]2026-08-02T01:49:59.4925252Z TestOSPoolEP 2026-08-02T01:49:59Z logger.go:67: service/test-cm created2026-08-02T01:49:59.5036506Z TestOSPoolEP 2026-08-02T01:49:59Z logger.go:67: Warning: spec.template.spec.containers[0].env[8]: hides previous definition of "OSG_SQUID_LOCATION", which may be dropped when using apply2026-08-02T01:49:59.5040043Z TestOSPoolEP 2026-08-02T01:49:59Z logger.go:67: deployment.apps/ospool-ep created2026-08-02T01:49:59.5181013Z TestOSPoolEP 2026-08-02T01:49:59Z logger.go:67: deployment.apps/test-cm created2026-08-02T01:49:59.5246947Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-02T01:49:59.5251134Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:49:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:49:59.5335538Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:49:59Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-02T01:49:59.5343644Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:49:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:49:59.5347877Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:49:59Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-02T01:49:59.5350511Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:49:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:49:59.5435307Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:49:59Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "test-cm-54b7d49f85". Sleeping for 10s and will try again.2026-08-02T01:49:59.5441370Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:49:59Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-6c7d796845". Sleeping for 10s and will try again.2026-08-02T01:50:09.5444427Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:50:09Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-02T01:50:09.5447485Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:50:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:50:09.5450426Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:50:09Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-02T01:50:09.5453330Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:50:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:50:09.5487323Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:50:09Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-08-02T01:50:09.5491369Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:50:09Z logger.go:67: Deployment is now available2026-08-02T01:50:19.5495152Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:50:19Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-02T01:50:19.5497340Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:50:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:50:19.5526371Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:50:19Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-08-02T01:50:29.5534878Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:50:29Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-02T01:50:29.5537156Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:50:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:50:29.5559890Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-02T01:50:29Z logger.go:67: Deployment is now available2026-08-02T01:50:29.5560995Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-02T01:50:29.5561554Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-02T01:50:29.5564569Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-02T01:50:29.5565576Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-02T01:50:29.5566444Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-02T01:50:29.5567265Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-02T01:50:29.5568080Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-02T01:50:29.5569708Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-02T01:50:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:50:29.5578121Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-02T01:50:29.5578921Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-02T01:50:29.5580497Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:50:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:50:29.5583134Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-02T01:50:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:50:29.5604802Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:50:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:50:29.5607694Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-02T01:50:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:50:29.5610752Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-02T01:50:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:50:29.5633297Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-02T01:50:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_SINGULARITY]2026-08-02T01:50:29.5637093Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-02T01:50:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)']2026-08-02T01:50:29.5641095Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:50:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-02T01:50:29.7972413Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-99xvb failed. Retrying in 10s.2026-08-02T01:50:29.7974312Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-02T01:50:29.7976770Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-99xvb failed. Retrying in 30s.2026-08-02T01:50:29.7996293Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-02T01:50:29.7997750Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)']' in pod test-cm-54b7d49f85-99xvb failed. Retrying in 10s.2026-08-02T01:50:39.7981410Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-02T01:50:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_SINGULARITY]2026-08-02T01:50:39.8006890Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-02T01:50:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)']2026-08-02T01:50:40.0290260Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)']' in pod test-cm-54b7d49f85-99xvb failed. Retrying in 10s.2026-08-02T01:50:40.0323440Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-02T01:50:40.0325695Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-99xvb failed. Retrying in 10s.2026-08-02T01:50:50.0294888Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-02T01:50:50Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)']2026-08-02T01:50:50.0330835Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-02T01:50:50Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_SINGULARITY]2026-08-02T01:50:50.2140301Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-99xvb failed. Retrying in 10s.2026-08-02T01:50:50.2324229Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-02T01:50:50.2325750Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)']' in pod test-cm-54b7d49f85-99xvb failed. Retrying in 10s.2026-08-02T01:50:59.7981324Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:50:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-02T01:50:59.9453610Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:50:59Z logger.go:67: undefined2026-08-02T01:50:59.9507039Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-02T01:50:59.9508668Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-99xvb failed. Retrying in 30s.2026-08-02T01:51:00.2142011Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-02T01:51:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_SINGULARITY]2026-08-02T01:51:00.2336929Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-02T01:51:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)']2026-08-02T01:51:00.4156381Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-02T01:51:00Z logger.go:67: true2026-08-02T01:51:00.4363824Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-02T01:51:00Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-02T01:51:00.4365466Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-02T01:51:00Z logger.go:67: 2026-08-02T01:51:00.4367690Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-02T01:51:00Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-clmqr LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-08-02T01:51:00.4369305Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-02T01:51:00Z logger.go:67: 2026-08-02T01:51:00.4371002Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-02T01:51:00Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-02T01:51:00.4372505Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-02T01:51:00Z logger.go:67: 2026-08-02T01:51:00.4374032Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-02T01:51:00Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-02T01:51:00.4375596Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-02T01:51:00Z logger.go:67: 2026-08-02T01:51:00.4377176Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-02T01:51:00Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-02T01:51:29.9516828Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:51:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-02T01:51:30.0970449Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:51:30Z logger.go:67: undefined2026-08-02T01:51:30.1031600Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-99xvb failed. Retrying in 30s.2026-08-02T01:52:00.1043091Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:52:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-02T01:52:00.2527751Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:52:00Z logger.go:67: undefined2026-08-02T01:52:00.2580532Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-99xvb failed. Retrying in 30s.2026-08-02T01:52:30.2585652Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:52:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-02T01:52:30.4533999Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:52:30Z logger.go:67: undefined2026-08-02T01:52:30.4605667Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-99xvb failed. Retrying in 30s.2026-08-02T01:53:00.4627589Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:53:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-02T01:53:00.6324355Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:53:00Z logger.go:67: undefined2026-08-02T01:53:00.6393382Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-99xvb failed. Retrying in 30s.2026-08-02T01:53:30.6400639Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:53:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-02T01:53:30.8083540Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:53:30Z logger.go:67: undefined2026-08-02T01:53:30.8182401Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-99xvb failed. Retrying in 30s.2026-08-02T01:54:00.8213921Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:54:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-02T01:54:01.0103211Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:54:01Z logger.go:67: undefined2026-08-02T01:54:01.0178308Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-99xvb failed. Retrying in 30s.2026-08-02T01:54:31.0182967Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:54:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-02T01:54:31.1639679Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:54:31Z logger.go:67: undefined2026-08-02T01:54:31.1705535Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-99xvb failed. Retrying in 30s.2026-08-02T01:55:01.1738795Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:55:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-02T01:55:01.3313519Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:55:01Z logger.go:67: undefined2026-08-02T01:55:01.3383102Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-99xvb failed. Retrying in 30s.2026-08-02T01:55:31.3385477Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:55:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-02T01:55:31.4862081Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:55:31Z logger.go:67: undefined2026-08-02T01:55:31.4921315Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-99xvb failed. Retrying in 30s.2026-08-02T01:56:01.4930552Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:56:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue exec test-cm-54b7d49f85-99xvb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-clmqr",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-02T01:56:01.6663004Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-02T01:56:01Z logger.go:67: true2026-08-02T01:56:01.6754792Z TestOSPoolEP 2026-08-02T01:56:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:56:01.6826787Z TestOSPoolEP 2026-08-02T01:56:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:56:01.8455505Z TestOSPoolEP 2026-08-02T01:56:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:56:02.0010972Z TestOSPoolEP 2026-08-02T01:56:02Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:56:02.1388647Z TestOSPoolEP 2026-08-02T01:56:02Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:56:02.1421797Z === NAME TestOSPoolEP2026-08-02T01:56:02.1427583Z ospool_ep_test.go:101: ---2026-08-02T01:56:02.1428796Z Events for pod idtoken-generator:2026-08-02T01:56:02.1436758Z 2026-08-02 01:49:48 +0000 UTC Normal Successfully assigned test-ospool-ep-wptgue/idtoken-generator to minikube2026-08-02T01:56:02.1438250Z 2026-08-02 01:49:49 +0000 UTC Normal Pulling image "htcondor/base"2026-08-02T01:56:02.1440137Z 2026-08-02 01:49:57 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.455s (8.455s including waiting). Image size: 560910730 bytes.2026-08-02T01:56:02.1441589Z 2026-08-02 01:49:57 +0000 UTC Normal Container created2026-08-02T01:56:02.1442894Z 2026-08-02 01:49:57 +0000 UTC Normal Container started2026-08-02T01:56:02.1443626Z 2026-08-02T01:56:02.1444715Z ---2026-08-02T01:56:02.1446163Z TestOSPoolEP 2026-08-02T01:56:02Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:56:02.1474058Z ospool_ep_test.go:101: ---2026-08-02T01:56:02.1475558Z Events for pod ospool-ep-6c7d796845-clmqr:2026-08-02T01:56:02.1478076Z 2026-08-02 01:49:59 +0000 UTC Normal Successfully assigned test-ospool-ep-wptgue/ospool-ep-6c7d796845-clmqr to minikube2026-08-02T01:56:02.1480129Z 2026-08-02 01:50:00 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-02T01:56:02.1483597Z 2026-08-02 01:50:01 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.545s (1.545s including waiting). Image size: 5590942 bytes.2026-08-02T01:56:02.1486459Z 2026-08-02 01:50:01 +0000 UTC Normal Container created2026-08-02T01:56:02.1487971Z 2026-08-02 01:50:01 +0000 UTC Normal Container started2026-08-02T01:56:02.1489573Z 2026-08-02 01:50:02 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-08-02T01:56:02.1493173Z 2026-08-02 01:50:21 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 13.935s (19.821s including waiting). Image size: 1383210994 bytes.2026-08-02T01:56:02.1495716Z 2026-08-02 01:50:21 +0000 UTC Normal Container created2026-08-02T01:56:02.1497093Z 2026-08-02 01:50:21 +0000 UTC Normal Container started2026-08-02T01:56:02.1498121Z 2026-08-02T01:56:02.1498479Z ---2026-08-02T01:56:02.1506504Z TestOSPoolEP 2026-08-02T01:56:02Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:56:02.1510456Z ospool_ep_test.go:101: ---2026-08-02T01:56:02.1511094Z Events for pod test-cm-54b7d49f85-99xvb:2026-08-02T01:56:02.1515280Z 2026-08-02 01:49:59 +0000 UTC Normal Successfully assigned test-ospool-ep-wptgue/test-cm-54b7d49f85-99xvb to minikube2026-08-02T01:56:02.1518028Z 2026-08-02 01:50:00 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-08-02T01:56:02.1524037Z 2026-08-02 01:50:07 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 6.376s (7.894s including waiting). Image size: 573055668 bytes.2026-08-02T01:56:02.1525388Z 2026-08-02 01:50:07 +0000 UTC Normal Container created2026-08-02T01:56:02.1526188Z 2026-08-02 01:50:08 +0000 UTC Normal Container started2026-08-02T01:56:02.1526700Z 2026-08-02T01:56:02.1527013Z ---2026-08-02T01:56:02.1532560Z TestOSPoolEP 2026-08-02T01:56:02Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-02T01:56:02.1560768Z TestOSPoolEP 2026-08-02T01:56:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue delete -f /tmp/TestOSPoolEP1579556932]2026-08-02T01:56:02.2878872Z TestOSPoolEP 2026-08-02T01:56:02Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-wptgue namespace2026-08-02T01:56:02.2981458Z TestOSPoolEP 2026-08-02T01:56:02Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-wptgue namespace2026-08-02T01:56:03.1567946Z TestOSPoolEP 2026-08-02T01:56:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue delete -f /tmp/TestOSPoolEP1700599084]2026-08-02T01:56:03.2511180Z TestOSPoolEP 2026-08-02T01:56:03Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-wptgue namespace2026-08-02T01:56:03.2561266Z TestOSPoolEP 2026-08-02T01:56:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wptgue delete -k /tmp/kustomize-template-3995195342]2026-08-02T01:56:03.3814351Z TestOSPoolEP 2026-08-02T01:56:03Z logger.go:67: service "test-cm" deleted from test-ospool-ep-wptgue namespace2026-08-02T01:56:03.3871305Z TestOSPoolEP 2026-08-02T01:56:03Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-wptgue namespace2026-08-02T01:56:03.3921480Z TestOSPoolEP 2026-08-02T01:56:03Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-wptgue namespace2026-08-02T01:56:03.4065735Z --- PASS: TestOSPoolEP (43.44s)2026-08-02T01:56:03.4084985Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.03s)2026-08-02T01:56:03.4087786Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (30.87s)2026-08-02T01:56:03.4088978Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (30.89s)2026-08-02T01:56:03.4090230Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (332.12s)2026-08-02T01:56:03.4092237Z PASS2026-08-02T01:56:03.4126713Z ok github.com/osg-htc/k8s-integration-tests/test 375.579s2026-08-02T01:56:03.5367046Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-02T01:56:03.5368057Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-02T01:56:03.5427132Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-02T01:56:03.5427515Z env:2026-08-02T01:56:03.5427735Z GOTOOLCHAIN: local2026-08-02T01:56:03.5428230Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-02T01:56:03.5428752Z ##[endgroup]2026-08-02T01:56:03.5667132Z Node 20 is being deprecated. This workflow is running with Node 24 by default. If you need to temporarily use Node 20, you can set the ACTIONS_ALLOW_USE_UNSECURE_NODE_VERSION=true environment variable. For more information see: https://github.blog/changelog/2025-09-19-deprecation-of-node-20-on-github-actions-runners/2026-08-02T01:56:03.5668987Z ##[group]Run actions/upload-artifact@v42026-08-02T01:56:03.5669438Z with:2026-08-02T01:56:03.5669837Z name: TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce72322026-08-02T01:56:03.5670307Z path: /tmp/k8s-tests2026-08-02T01:56:03.5670532Z retention-days: 52026-08-02T01:56:03.5670759Z if-no-files-found: warn2026-08-02T01:56:03.5670991Z compression-level: 62026-08-02T01:56:03.5671209Z overwrite: false2026-08-02T01:56:03.5671425Z include-hidden-files: false2026-08-02T01:56:03.5671892Z env:2026-08-02T01:56:03.5672306Z GOTOOLCHAIN: local2026-08-02T01:56:03.5672825Z ##[endgroup]2026-08-02T01:56:03.8487543Z (node:17667) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-02T01:56:03.8489059Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-02T01:56:03.8676633Z With the provided path, there will be 6 files uploaded2026-08-02T01:56:03.8684336Z Artifact name is valid!2026-08-02T01:56:03.8686741Z Root directory input is valid!2026-08-02T01:56:04.0205066Z Beginning upload of artifact content to blob storage2026-08-02T01:56:04.0511163Z (node:17667) [DEP0169] DeprecationWarning: `url.parse()` behavior is not standardized and prone to errors that have security implications. Use the WHATWG URL API instead. CVEs are not issued for `url.parse()` vulnerabilities.2026-08-02T01:56:04.0990697Z Uploaded bytes 139502026-08-02T01:56:04.1173045Z Finished uploading artifact content to blob storage!2026-08-02T01:56:04.1175168Z SHA256 digest of uploaded artifact zip is 968707040c8d2ffd655717d6d85a5516d6ab8d1b59398c4520050dead4bc62032026-08-02T01:56:04.1176834Z Finalizing artifact upload2026-08-02T01:56:04.2795487Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232.zip successfully finalized. Artifact ID 88270084782026-08-02T01:56:04.2797259Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232 has been successfully uploaded! Final size is 13950 bytes. Artifact ID is 88270084782026-08-02T01:56:04.2802991Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/30727694946/artifacts/88270084782026-08-02T01:56:04.2993151Z Post job cleanup.2026-08-02T01:56:04.4357872Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-02T01:56:04.4406030Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-02T01:56:04.4439117Z /home/runner/go/pkg/mod2026-08-02T01:56:04.4455780Z /home/runner/.cache/go-build2026-08-02T01:56:04.4470067Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-02T01:56:04.4643113Z Post job cleanup.2026-08-02T01:56:04.5697137Z [command]/usr/bin/git version2026-08-02T01:56:04.5751079Z git version 2.54.02026-08-02T01:56:04.5796266Z Temporarily overriding HOME='/home/runner/work/_temp/3083a067-7623-453b-8d6f-2dc7295e8a97' before making global git config changes2026-08-02T01:56:04.5798445Z Adding repository directory to the temporary git global config as a safe directory2026-08-02T01:56:04.5804524Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-02T01:56:04.5852169Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-02T01:56:04.5895784Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :"2026-08-02T01:56:04.6188047Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-02T01:56:04.6230547Z http.https://github.com/.extraheader2026-08-02T01:56:04.6243243Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-02T01:56:04.6291098Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :"2026-08-02T01:56:04.6586601Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-02T01:56:04.6631519Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-02T01:56:04.7078641Z Cleaning up orphan processes2026-08-02T01:56:04.7847629Z ##[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/