2026-08-09T00:54:30.8399284Z Current runner version: '2.336.0'2026-08-09T00:54:30.8428034Z ##[group]Runner Image Provisioner2026-08-09T00:54:30.8429998Z Hosted Compute Agent2026-08-09T00:54:30.8431280Z Version: 20260707.5632026-08-09T00:54:30.8432265Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-08-09T00:54:30.8433472Z Build Date: 2026-07-07T19:33:50Z2026-08-09T00:54:30.8434544Z Worker ID: {001cf955-43c7-46da-b3d4-aa432d0ced64}2026-08-09T00:54:30.8435639Z Azure Region: northcentralus2026-08-09T00:54:30.8436631Z ##[endgroup]2026-08-09T00:54:30.8438690Z ##[group]Operating System2026-08-09T00:54:30.8439610Z Ubuntu2026-08-09T00:54:30.8440521Z 22.04.52026-08-09T00:54:30.8441528Z LTS2026-08-09T00:54:30.8442349Z ##[endgroup]2026-08-09T00:54:30.8443193Z ##[group]Runner Image2026-08-09T00:54:30.8444065Z Image: ubuntu-22.042026-08-09T00:54:30.8445010Z Version: 20260720.234.22026-08-09T00:54:30.8446928Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-08-09T00:54:30.8449459Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-08-09T00:54:30.8451182Z ##[endgroup]2026-08-09T00:54:30.8453124Z ##[group]GITHUB_TOKEN Permissions2026-08-09T00:54:30.8455961Z Contents: read2026-08-09T00:54:30.8456948Z Metadata: read2026-08-09T00:54:30.8457823Z Packages: read2026-08-09T00:54:30.8458421Z ##[endgroup]2026-08-09T00:54:30.8461696Z Secret source: Actions2026-08-09T00:54:30.8463173Z Prepare workflow directory2026-08-09T00:54:30.8836856Z Prepare all required actions2026-08-09T00:54:30.8890458Z Getting action download info2026-08-09T00:54:31.1308237Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-09T00:54:31.4515961Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-09T00:54:31.7246931Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-09T00:54:32.0108685Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-09T00:54:32.3581394Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-09T00:54:32.3587510Z ##[group] Inputs2026-08-09T00:54:32.3588406Z testName: TestOSPoolEP2026-08-09T00:54:32.3590099Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-09T00:54:32.3592193Z setupScript: 2026-08-09T00:54:32.3592960Z setupEnv: {}2026-08-09T00:54:32.3593710Z ##[endgroup]2026-08-09T00:54:32.3594977Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-08-09T00:54:32.4520367Z ##[group]Run actions/checkout@v52026-08-09T00:54:32.4522102Z with:2026-08-09T00:54:32.4522980Z repository: mwestphall/k8s-integration-tests2026-08-09T00:54:32.4532591Z token: ***2026-08-09T00:54:32.4533528Z ssh-strict: true2026-08-09T00:54:32.4534369Z ssh-user: git2026-08-09T00:54:32.4535174Z persist-credentials: true2026-08-09T00:54:32.4536074Z clean: true2026-08-09T00:54:32.4536879Z sparse-checkout-cone-mode: true2026-08-09T00:54:32.4537837Z fetch-depth: 12026-08-09T00:54:32.4538612Z fetch-tags: false2026-08-09T00:54:32.4539423Z show-progress: true2026-08-09T00:54:32.4540228Z lfs: false2026-08-09T00:54:32.4541257Z submodules: false2026-08-09T00:54:32.4542079Z set-safe-directory: true2026-08-09T00:54:32.4543011Z allow-unsafe-pr-checkout: false2026-08-09T00:54:32.4544287Z ##[endgroup]2026-08-09T00:54:32.5655819Z Syncing repository: mwestphall/k8s-integration-tests2026-08-09T00:54:32.5660048Z ##[group]Getting Git version info2026-08-09T00:54:32.5663029Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-09T00:54:32.5666624Z [command]/usr/bin/git version2026-08-09T00:54:32.5705404Z git version 2.54.02026-08-09T00:54:32.5766115Z ##[endgroup]2026-08-09T00:54:32.5783789Z Temporarily overriding HOME='/home/runner/work/_temp/73703430-7f14-4269-83c5-53899119c095' before making global git config changes2026-08-09T00:54:32.5789065Z Adding repository directory to the temporary git global config as a safe directory2026-08-09T00:54:32.5794436Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-09T00:54:32.5836186Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-09T00:54:32.5840810Z ##[group]Initializing the repository2026-08-09T00:54:32.5846007Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-09T00:54:32.5957227Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-09T00:54:32.5961203Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-09T00:54:32.5964786Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-09T00:54:32.5967575Z hint: call:2026-08-09T00:54:32.5969305Z hint:2026-08-09T00:54:32.5971462Z hint: git config --global init.defaultBranch <name>2026-08-09T00:54:32.5973702Z hint:2026-08-09T00:54:32.5976203Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-09T00:54:32.5980159Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-09T00:54:32.5983534Z hint:2026-08-09T00:54:32.5985471Z hint: git branch -m <name>2026-08-09T00:54:32.5987660Z hint:2026-08-09T00:54:32.5990376Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-09T00:54:32.5995606Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-09T00:54:32.6002512Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-09T00:54:32.6014687Z ##[endgroup]2026-08-09T00:54:32.6017026Z ##[group]Disabling automatic garbage collection2026-08-09T00:54:32.6019365Z [command]/usr/bin/git config --local gc.auto 02026-08-09T00:54:32.6054800Z ##[endgroup]2026-08-09T00:54:32.6056958Z ##[group]Setting up auth2026-08-09T00:54:32.6059369Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-09T00:54:32.6097709Z [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-09T00:54:32.6482334Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-09T00:54:32.6527624Z [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-09T00:54:32.6808547Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-09T00:54:32.6851575Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-09T00:54:32.7109505Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-09T00:54:32.7152353Z ##[endgroup]2026-08-09T00:54:32.7154597Z ##[group]Fetching the repository2026-08-09T00:54:32.7164659Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-09T00:54:33.0332234Z From https://github.com/mwestphall/k8s-integration-tests2026-08-09T00:54:33.0334939Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-09T00:54:33.0365927Z ##[endgroup]2026-08-09T00:54:33.0368602Z ##[group]Determining the checkout info2026-08-09T00:54:33.0372566Z ##[endgroup]2026-08-09T00:54:33.0375657Z [command]/usr/bin/git sparse-checkout disable2026-08-09T00:54:33.0431912Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-09T00:54:33.0471941Z ##[group]Checking out the ref2026-08-09T00:54:33.0476331Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-09T00:54:33.0573111Z Switched to a new branch 'main'2026-08-09T00:54:33.0575986Z branch 'main' set up to track 'origin/main'.2026-08-09T00:54:33.0584891Z ##[endgroup]2026-08-09T00:54:33.0639093Z [command]/usr/bin/git log -1 --format=%H2026-08-09T00:54:33.0668130Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-09T00:54:33.1013425Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-09T00:54:33.1015521Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-09T00:54:33.1017450Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-09T00:54:33.1173305Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-09T00:54:33.1174658Z env:2026-08-09T00:54:33.1176175Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-09T00:54:33.1177948Z SETUP_ENV_YAML: {}2026-08-09T00:54:33.1178842Z ##[endgroup]2026-08-09T00:54:34.1535310Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-09T00:54:34.1536040Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-09T00:54:34.1594913Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-09T00:54:34.1595318Z env:2026-08-09T00:54:34.1595814Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-09T00:54:34.1596393Z ##[endgroup]2026-08-09T00:54:34.1742058Z ##[group]Run true2026-08-09T00:54:34.1742369Z [36;1mtrue[0m2026-08-09T00:54:34.1801741Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-09T00:54:34.1802176Z ##[endgroup]2026-08-09T00:54:34.1986594Z ##[group]Run medyagh/setup-minikube@latest2026-08-09T00:54:34.1986976Z with:2026-08-09T00:54:34.1987206Z start: true2026-08-09T00:54:34.1987438Z cache: true2026-08-09T00:54:34.1987685Z minikube-version: latest2026-08-09T00:54:34.1987981Z wait: all2026-08-09T00:54:34.1988206Z ##[endgroup]2026-08-09T00:54:34.3305085Z (node:2141) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-09T00:54:34.3306584Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-09T00:54:35.1885895Z [command]/usr/bin/chmod +x /home/runner/work/_temp/3127d941-a32a-4c94-bcbf-ce98edf3edac2026-08-09T00:54:35.3478049Z [command]/home/runner/bin/minikube version --short2026-08-09T00:54:35.3890990Z v1.38.12026-08-09T00:54:35.4919764Z Cache hit for: kic-v1.38.1-x642026-08-09T00:54:35.5030233Z (node:2141) [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-09T00:54:35.5036500Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-09T00:54:36.6491958Z Received 130023424 of 544082657 (23.9%), 116.7 MBs/sec2026-08-09T00:54:36.6506798Z Received 134217728 of 224218863 (59.9%), 122.6 MBs/sec2026-08-09T00:54:37.3208020Z Received 224218863 of 224218863 (100.0%), 124.6 MBs/sec2026-08-09T00:54:37.3209143Z Cache Size: ~214 MB (224218863 B)2026-08-09T00:54:37.3688069Z [command]/usr/bin/tar -xf /home/runner/work/_temp/edf3d9de-eff5-42ff-a1ec-0367f0816048/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-09T00:54:37.6499481Z Received 268435456 of 544082657 (49.3%), 124.0 MBs/sec2026-08-09T00:54:38.0002186Z Cache restored successfully2026-08-09T00:54:38.6511939Z Received 490733568 of 544082657 (90.2%), 152.7 MBs/sec2026-08-09T00:54:39.0285587Z Received 544082657 of 544082657 (100.0%), 150.7 MBs/sec2026-08-09T00:54:39.0286903Z Cache Size: ~519 MB (544082657 B)2026-08-09T00:54:39.0408685Z [command]/usr/bin/tar -xf /home/runner/work/_temp/eb01137b-766e-4f47-9400-8f2cb611784e/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-09T00:54:39.8989120Z Cache restored successfully2026-08-09T00:54:40.0136622Z [command]/home/runner/bin/minikube start --wait all2026-08-09T00:54:40.0563089Z * minikube v1.38.1 on Ubuntu 22.042026-08-09T00:54:45.0626058Z ! 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-09T00:54:45.0636987Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-09T00:54:45.1517287Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-09T00:54:45.1587097Z * Using Docker driver with root privileges2026-08-09T00:54:45.1710999Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-09T00:54:45.1913780Z * Pulling base image v0.0.50 ...2026-08-09T00:55:18.9651197Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-09T00:55:23.6502376Z * Verifying Kubernetes components...2026-08-09T00:55:23.6713151Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-09T00:55:24.3190464Z * Enabled addons: storage-provisioner, default-storageclass2026-08-09T00:56:04.5167209Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-09T00:56:04.5291065Z [command]/home/runner/bin/minikube version --short2026-08-09T00:56:04.5725153Z v1.38.12026-08-09T00:56:04.6052019Z ##[group]Run actions/setup-go@v62026-08-09T00:56:04.6052328Z with:2026-08-09T00:56:04.6052528Z go-version: 1.262026-08-09T00:56:04.6052738Z cache: true2026-08-09T00:56:04.6052990Z cache-dependency-path: go.sum2026-08-09T00:56:04.6053250Z check-latest: false2026-08-09T00:56:04.6055865Z token: ***2026-08-09T00:56:04.6056070Z ##[endgroup]2026-08-09T00:56:04.7438987Z Setup go version spec 1.262026-08-09T00:56:04.8054704Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-09T00:56:04.8057918Z Added go to the path2026-08-09T00:56:04.8062695Z Successfully set up Go version 1.262026-08-09T00:56:05.6632075Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-09T00:56:05.6686659Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-09T00:56:05.6727368Z /home/runner/go/pkg/mod2026-08-09T00:56:05.6754912Z /home/runner/.cache/go-build2026-08-09T00:56:05.7999373Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-09T00:56:06.9200256Z Received 130023424 of 251839808 (51.6%), 124.0 MBs/sec2026-08-09T00:56:07.6633784Z Received 251839808 of 251839808 (100.0%), 137.7 MBs/sec2026-08-09T00:56:07.6635715Z Cache Size: ~240 MB (251839808 B)2026-08-09T00:56:07.6687567Z [command]/usr/bin/tar -xf /home/runner/work/_temp/fb7714a7-7600-4d72-955f-212263692293/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-09T00:56:10.8324699Z Cache restored successfully2026-08-09T00:56:10.9001334Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-09T00:56:10.9031226Z go version go1.26.5 linux/amd642026-08-09T00:56:10.9031561Z 2026-08-09T00:56:10.9032054Z ##[group]go env2026-08-09T00:56:10.9447426Z AR='ar'2026-08-09T00:56:10.9447894Z CC='gcc'2026-08-09T00:56:10.9448502Z CGO_CFLAGS='-O2 -g'2026-08-09T00:56:10.9448879Z CGO_CPPFLAGS=''2026-08-09T00:56:10.9449281Z CGO_CXXFLAGS='-O2 -g'2026-08-09T00:56:10.9449586Z CGO_ENABLED='1'2026-08-09T00:56:10.9449941Z CGO_FFLAGS='-O2 -g'2026-08-09T00:56:10.9450348Z CGO_LDFLAGS='-O2 -g'2026-08-09T00:56:10.9451440Z CXX='g++'2026-08-09T00:56:10.9451729Z GCCGO='gccgo'2026-08-09T00:56:10.9451995Z GO111MODULE=''2026-08-09T00:56:10.9452259Z GOAMD64='v1'2026-08-09T00:56:10.9452541Z GOARCH='amd64'2026-08-09T00:56:10.9511371Z GOAUTH='netrc'2026-08-09T00:56:10.9511796Z GOBIN=''2026-08-09T00:56:10.9512151Z GOCACHE='/home/runner/.cache/go-build'2026-08-09T00:56:10.9512602Z GOCACHEPROG=''2026-08-09T00:56:10.9512945Z GODEBUG=''2026-08-09T00:56:10.9513340Z GOENV='/home/runner/.config/go/env'2026-08-09T00:56:10.9513756Z GOEXE=''2026-08-09T00:56:10.9514082Z GOEXPERIMENT=''2026-08-09T00:56:10.9514410Z GOFIPS140='off'2026-08-09T00:56:10.9514746Z GOFLAGS=''2026-08-09T00:56:10.9515809Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build1144565699=/tmp/go-build -gno-record-gcc-switches'2026-08-09T00:56:10.9516867Z GOHOSTARCH='amd64'2026-08-09T00:56:10.9517321Z GOHOSTOS='linux'2026-08-09T00:56:10.9517693Z GOINSECURE=''2026-08-09T00:56:10.9518277Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-09T00:56:10.9518996Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-09T00:56:10.9519486Z GONOPROXY=''2026-08-09T00:56:10.9519840Z GONOSUMDB=''2026-08-09T00:56:10.9520198Z GOOS='linux'2026-08-09T00:56:10.9520840Z GOPATH='/home/runner/go'2026-08-09T00:56:10.9521266Z GOPRIVATE=''2026-08-09T00:56:10.9521718Z GOPROXY='https://proxy.golang.org,direct'2026-08-09T00:56:10.9522307Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-09T00:56:10.9522832Z GOSUMDB='sum.golang.org'2026-08-09T00:56:10.9523245Z GOTELEMETRY='local'2026-08-09T00:56:10.9523727Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-09T00:56:10.9524250Z GOTMPDIR=''2026-08-09T00:56:10.9524596Z GOTOOLCHAIN='local'2026-08-09T00:56:10.9525604Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-09T00:56:10.9526264Z GOVCS=''2026-08-09T00:56:10.9526618Z GOVERSION='go1.26.5'2026-08-09T00:56:10.9526989Z GOWORK=''2026-08-09T00:56:10.9527359Z PKG_CONFIG='pkg-config'2026-08-09T00:56:10.9527600Z 2026-08-09T00:56:10.9528171Z ##[endgroup]2026-08-09T00:56:10.9707849Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-09T00:56:10.9708380Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-09T00:56:10.9768032Z shell: /usr/bin/bash -e {0}2026-08-09T00:56:10.9768313Z env:2026-08-09T00:56:10.9768522Z GOTOOLCHAIN: local2026-08-09T00:56:10.9768779Z OSPOOL_EP_OSPoolEPTag: 25-release2026-08-09T00:56:10.9769064Z OSPOOL_EP_CMTag: 25.0-el92026-08-09T00:56:10.9769318Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-09T00:56:10.9769577Z ##[endgroup]2026-08-09T00:56:19.0426668Z === RUN TestOSPoolEP2026-08-09T00:56:19.0429115Z === PAUSE TestOSPoolEP2026-08-09T00:56:19.0429618Z === CONT TestOSPoolEP2026-08-09T00:56:19.0430475Z TestOSPoolEP 2026-08-09T00:56:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:19.0554411Z TestOSPoolEP 2026-08-09T00:56:19Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 apply -f /tmp/TestOSPoolEP3231240453]2026-08-09T00:56:19.6865506Z TestOSPoolEP 2026-08-09T00:56:19Z logger.go:67: pod/idtoken-generator created2026-08-09T00:56:19.6936634Z TestOSPoolEP 2026-08-09T00:56:19Z logger.go:67: secret/pool-passwd created2026-08-09T00:56:19.6980470Z TestOSPoolEP 2026-08-09T00:56:19Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-09T00:56:19.6982635Z TestOSPoolEP 2026-08-09T00:56:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:19.7021645Z TestOSPoolEP 2026-08-09T00:56:19Z 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-09T00:56:29.7027271Z TestOSPoolEP 2026-08-09T00:56:29Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-09T00:56:29.7035544Z TestOSPoolEP 2026-08-09T00:56:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:29.7062691Z TestOSPoolEP 2026-08-09T00:56:29Z 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-09T00:56:39.7072148Z TestOSPoolEP 2026-08-09T00:56:39Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-09T00:56:39.7073286Z TestOSPoolEP 2026-08-09T00:56:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:39.7098898Z TestOSPoolEP 2026-08-09T00:56:39Z logger.go:67: Pod is now available2026-08-09T00:56:39.7101097Z TestOSPoolEP 2026-08-09T00:56:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-09T00:56:40.3800178Z TestOSPoolEP 2026-08-09T00:56:40Z logger.go:67: ***2026-08-09T00:56:40.3864159Z TestOSPoolEP 2026-08-09T00:56:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 apply -f /tmp/TestOSPoolEP862830585]2026-08-09T00:56:40.5774651Z TestOSPoolEP 2026-08-09T00:56:40Z logger.go:67: secret/pool-token created2026-08-09T00:56:40.5805387Z TestOSPoolEP 2026-08-09T00:56:40Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-09T00:56:40.5806551Z TestOSPoolEP 2026-08-09T00:56:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:40.5828384Z TestOSPoolEP 2026-08-09T00:56:40Z logger.go:67: Secret is now available2026-08-09T00:56:40.5859844Z TestOSPoolEP 2026-08-09T00:56:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 apply -k /tmp/kustomize-template-734642814]2026-08-09T00:56:40.8621339Z TestOSPoolEP 2026-08-09T00:56:40Z logger.go:67: service/test-cm created2026-08-09T00:56:40.8724998Z TestOSPoolEP 2026-08-09T00:56:40Z 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-09T00:56:40.8727878Z TestOSPoolEP 2026-08-09T00:56:40Z logger.go:67: deployment.apps/ospool-ep created2026-08-09T00:56:40.8858722Z TestOSPoolEP 2026-08-09T00:56:40Z logger.go:67: deployment.apps/test-cm created2026-08-09T00:56:40.8905476Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-09T00:56:40.8910869Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:40.8986891Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:40Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-09T00:56:40.9018717Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:40.9031175Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:40Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-09T00:56:40.9033279Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:40.9116019Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:40Z 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-09T00:56:40.9121695Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:40Z 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-09T00:56:50.9133597Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:50Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-09T00:56:50.9137032Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:50.9139665Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:50Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-09T00:56:50.9143591Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:56:50.9163913Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:50Z logger.go:67: Deployment is now available2026-08-09T00:56:50.9171530Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:56:50Z 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-09T00:57:00.9174682Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:57:00Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-09T00:57:00.9176845Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:57:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:57:00.9209049Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:57:00Z 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-09T00:57:10.9213800Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:57:10Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-09T00:57:10.9224486Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:57:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:57:10.9242808Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-09T00:57:10Z logger.go:67: Deployment is now available2026-08-09T00:57:10.9245300Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-09T00:57:10.9245834Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-09T00:57:10.9246394Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-09T00:57:10.9246872Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-09T00:57:10.9247326Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-09T00:57:10.9247937Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-09T00:57:10.9248648Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-09T00:57:10.9250077Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:57:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:57:10.9283017Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-09T00:57:10.9285249Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-09T00:57:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:57:10.9287063Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-09T00:57:10.9289356Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:57:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:57:10.9303479Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-09T00:57:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:57:10.9334254Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:57:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:57:10.9338373Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-09T00:57:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 exec test-cm-54b7d49f85-pmq2h -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_SINGULARITY]2026-08-09T00:57:10.9342153Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:57:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T00:57:10.9366563Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:57:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 exec test-cm-54b7d49f85-pmq2h -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)']2026-08-09T00:57:10.9384372Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:57:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 exec test-cm-54b7d49f85-pmq2h -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T00:57:11.2469638Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-09T00:57:11.2472756Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-pmq2h failed. Retrying in 10s.2026-08-09T00:57:11.2569329Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-09T00:57:11.2572246Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pmq2h failed. Retrying in 30s.2026-08-09T00:57:11.2631762Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-09T00:57:11.2633928Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)']' in pod test-cm-54b7d49f85-pmq2h failed. Retrying in 10s.2026-08-09T00:57:21.2488090Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-09T00:57:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 exec test-cm-54b7d49f85-pmq2h -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_SINGULARITY]2026-08-09T00:57:21.2640891Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:57:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 exec test-cm-54b7d49f85-pmq2h -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)']2026-08-09T00:57:21.4522502Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-09T00:57:21Z logger.go:67: true2026-08-09T00:57:21.4694683Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:57:21Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-09T00:57:21.4696573Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:57:21Z logger.go:67: 2026-08-09T00:57:21.4698628Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:57:21Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-f4x5l LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-08-09T00:57:21.4701044Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:57:21Z logger.go:67: 2026-08-09T00:57:21.4704092Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:57:21Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-09T00:57:21.4706902Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:57:21Z logger.go:67: 2026-08-09T00:57:21.4710078Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:57:21Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-09T00:57:21.4714199Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:57:21Z logger.go:67: 2026-08-09T00:57:21.4716708Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-09T00:57:21Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-09T00:57:41.2573922Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:57:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 exec test-cm-54b7d49f85-pmq2h -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T00:57:41.4153016Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:57:41Z logger.go:67: undefined2026-08-09T00:57:41.4209755Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-09T00:57:41.4211507Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pmq2h failed. Retrying in 30s.2026-08-09T00:58:11.4219926Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:58:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 exec test-cm-54b7d49f85-pmq2h -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T00:58:11.5763260Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:58:11Z logger.go:67: undefined2026-08-09T00:58:11.5824280Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pmq2h failed. Retrying in 30s.2026-08-09T00:58:41.5828500Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:58:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 exec test-cm-54b7d49f85-pmq2h -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T00:58:41.7373892Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:58:41Z logger.go:67: undefined2026-08-09T00:58:41.7447349Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pmq2h failed. Retrying in 30s.2026-08-09T00:59:11.7453528Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:59:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 exec test-cm-54b7d49f85-pmq2h -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T00:59:11.8971264Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:59:11Z logger.go:67: undefined2026-08-09T00:59:11.9031758Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pmq2h failed. Retrying in 30s.2026-08-09T00:59:41.9036364Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:59:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 exec test-cm-54b7d49f85-pmq2h -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T00:59:42.0546452Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T00:59:42Z logger.go:67: undefined2026-08-09T00:59:42.0609338Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pmq2h failed. Retrying in 30s.2026-08-09T01:00:12.0636724Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:00:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 exec test-cm-54b7d49f85-pmq2h -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T01:00:12.2428665Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:00:12Z logger.go:67: undefined2026-08-09T01:00:12.2504326Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pmq2h failed. Retrying in 30s.2026-08-09T01:00:42.2506297Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:00:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 exec test-cm-54b7d49f85-pmq2h -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T01:00:42.4063907Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:00:42Z logger.go:67: undefined2026-08-09T01:00:42.4117269Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pmq2h failed. Retrying in 30s.2026-08-09T01:01:12.4121592Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:01:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 exec test-cm-54b7d49f85-pmq2h -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T01:01:12.5774894Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:01:12Z logger.go:67: undefined2026-08-09T01:01:12.5869502Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pmq2h failed. Retrying in 30s.2026-08-09T01:01:42.5919729Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:01:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 exec test-cm-54b7d49f85-pmq2h -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T01:01:42.7428046Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:01:42Z logger.go:67: undefined2026-08-09T01:01:42.7485115Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pmq2h failed. Retrying in 30s.2026-08-09T01:02:12.7488907Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:02:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 exec test-cm-54b7d49f85-pmq2h -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T01:02:12.8958857Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:02:12Z logger.go:67: undefined2026-08-09T01:02:12.9018552Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-pmq2h failed. Retrying in 30s.2026-08-09T01:02:42.9031761Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:02:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 exec test-cm-54b7d49f85-pmq2h -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-f4x5l",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-09T01:02:43.0901812Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-09T01:02:43Z logger.go:67: true2026-08-09T01:02:43.0975479Z TestOSPoolEP 2026-08-09T01:02:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T01:02:43.1060307Z TestOSPoolEP 2026-08-09T01:02:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T01:02:43.3447804Z TestOSPoolEP 2026-08-09T01:02:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T01:02:43.4686409Z TestOSPoolEP 2026-08-09T01:02:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T01:02:43.5793654Z TestOSPoolEP 2026-08-09T01:02:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T01:02:43.5823041Z === NAME TestOSPoolEP2026-08-09T01:02:43.5823804Z ospool_ep_test.go:101: ---2026-08-09T01:02:43.5824405Z Events for pod idtoken-generator:2026-08-09T01:02:43.5825376Z 2026-08-09 00:56:19 +0000 UTC Normal Successfully assigned test-ospool-ep-ltuzu8/idtoken-generator to minikube2026-08-09T01:02:43.5826540Z 2026-08-09 00:56:21 +0000 UTC Normal Pulling image "htcondor/base"2026-08-09T01:02:43.5827713Z 2026-08-09 00:56:30 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.347s (8.347s including waiting). Image size: 560910730 bytes.2026-08-09T01:02:43.5828967Z 2026-08-09 00:56:30 +0000 UTC Normal Container created2026-08-09T01:02:43.5829902Z 2026-08-09 00:56:30 +0000 UTC Normal Container started2026-08-09T01:02:43.5830551Z 2026-08-09T01:02:43.5831241Z ---2026-08-09T01:02:43.5832284Z TestOSPoolEP 2026-08-09T01:02:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T01:02:43.5850301Z ospool_ep_test.go:101: ---2026-08-09T01:02:43.5851058Z Events for pod ospool-ep-6c7d796845-f4x5l:2026-08-09T01:02:43.5852322Z 2026-08-09 00:56:40 +0000 UTC Normal Successfully assigned test-ospool-ep-ltuzu8/ospool-ep-6c7d796845-f4x5l to minikube2026-08-09T01:02:43.5853500Z 2026-08-09 00:56:41 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-09T01:02:43.5855003Z 2026-08-09 00:56:42 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.261s (1.261s including waiting). Image size: 5590942 bytes.2026-08-09T01:02:43.5856391Z 2026-08-09 00:56:42 +0000 UTC Normal Container created2026-08-09T01:02:43.5856949Z 2026-08-09 00:56:42 +0000 UTC Normal Container started2026-08-09T01:02:43.5858091Z 2026-08-09 00:56:43 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-08-09T01:02:43.5860945Z 2026-08-09 00:57:01 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 13.491s (18.693s including waiting). Image size: 1266346391 bytes.2026-08-09T01:02:43.5862787Z 2026-08-09 00:57:01 +0000 UTC Normal Container created2026-08-09T01:02:43.5863716Z 2026-08-09 00:57:01 +0000 UTC Normal Container started2026-08-09T01:02:43.5864362Z 2026-08-09T01:02:43.5864821Z ---2026-08-09T01:02:43.5865872Z TestOSPoolEP 2026-08-09T01:02:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T01:02:43.5873950Z ospool_ep_test.go:101: ---2026-08-09T01:02:43.5875373Z Events for pod test-cm-54b7d49f85-pmq2h:2026-08-09T01:02:43.5876857Z 2026-08-09 00:56:40 +0000 UTC Normal Successfully assigned test-ospool-ep-ltuzu8/test-cm-54b7d49f85-pmq2h to minikube2026-08-09T01:02:43.5878244Z 2026-08-09 00:56:41 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-08-09T01:02:43.5880955Z 2026-08-09 00:56:48 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 5.553s (6.796s including waiting). Image size: 573055668 bytes.2026-08-09T01:02:43.5882330Z 2026-08-09 00:56:48 +0000 UTC Normal Container created2026-08-09T01:02:43.5883183Z 2026-08-09 00:56:48 +0000 UTC Normal Container started2026-08-09T01:02:43.5883724Z 2026-08-09T01:02:43.5884078Z ---2026-08-09T01:02:43.5885070Z TestOSPoolEP 2026-08-09T01:02:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-09T01:02:43.5913798Z TestOSPoolEP 2026-08-09T01:02:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 delete -f /tmp/TestOSPoolEP115572459]2026-08-09T01:02:43.6872705Z TestOSPoolEP 2026-08-09T01:02:43Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-ltuzu8 namespace2026-08-09T01:02:43.6931721Z TestOSPoolEP 2026-08-09T01:02:43Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-ltuzu8 namespace2026-08-09T01:02:45.1942619Z TestOSPoolEP 2026-08-09T01:02:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 delete -f /tmp/TestOSPoolEP92225103]2026-08-09T01:02:45.3006302Z TestOSPoolEP 2026-08-09T01:02:45Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-ltuzu8 namespace2026-08-09T01:02:45.3050978Z TestOSPoolEP 2026-08-09T01:02:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ltuzu8 delete -k /tmp/kustomize-template-734642814]2026-08-09T01:02:45.4195136Z TestOSPoolEP 2026-08-09T01:02:45Z logger.go:67: service "test-cm" deleted from test-ospool-ep-ltuzu8 namespace2026-08-09T01:02:45.4239032Z TestOSPoolEP 2026-08-09T01:02:45Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-ltuzu8 namespace2026-08-09T01:02:45.4285656Z TestOSPoolEP 2026-08-09T01:02:45Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-ltuzu8 namespace2026-08-09T01:02:45.4382991Z --- PASS: TestOSPoolEP (54.22s)2026-08-09T01:02:45.4410327Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.04s)2026-08-09T01:02:45.4416556Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (10.53s)2026-08-09T01:02:45.4418495Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (10.55s)2026-08-09T01:02:45.4419445Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (332.17s)2026-08-09T01:02:45.4420052Z PASS2026-08-09T01:02:45.4421144Z ok github.com/osg-htc/k8s-integration-tests/test 386.411s2026-08-09T01:02:45.5627277Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-09T01:02:45.5628354Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-09T01:02:45.5691737Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-09T01:02:45.5692292Z env:2026-08-09T01:02:45.5692607Z GOTOOLCHAIN: local2026-08-09T01:02:45.5693315Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-09T01:02:45.5694079Z ##[endgroup]2026-08-09T01:02:45.5905357Z 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-09T01:02:45.5907531Z ##[group]Run actions/upload-artifact@v42026-08-09T01:02:45.5907995Z with:2026-08-09T01:02:45.5908646Z name: TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce72322026-08-09T01:02:45.5909508Z path: /tmp/k8s-tests2026-08-09T01:02:45.5909936Z retention-days: 52026-08-09T01:02:45.5910346Z if-no-files-found: warn2026-08-09T01:02:45.5911036Z compression-level: 62026-08-09T01:02:45.5911522Z overwrite: false2026-08-09T01:02:45.5912240Z include-hidden-files: false2026-08-09T01:02:45.5912683Z env:2026-08-09T01:02:45.5913018Z GOTOOLCHAIN: local2026-08-09T01:02:45.5913385Z ##[endgroup]2026-08-09T01:02:45.8059651Z (node:18215) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-09T01:02:45.8061575Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-09T01:02:45.8175769Z With the provided path, there will be 6 files uploaded2026-08-09T01:02:45.8179721Z Artifact name is valid!2026-08-09T01:02:45.8181264Z Root directory input is valid!2026-08-09T01:02:46.0080213Z Beginning upload of artifact content to blob storage2026-08-09T01:02:46.0486437Z (node:18215) [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-09T01:02:46.1708053Z Uploaded bytes 141152026-08-09T01:02:46.2081128Z Finished uploading artifact content to blob storage!2026-08-09T01:02:46.2085898Z SHA256 digest of uploaded artifact zip is f8365fc13a0bcca30314697712dfe2866303cb6e04aed96ce0453fa6c43f525a2026-08-09T01:02:46.2087112Z Finalizing artifact upload2026-08-09T01:02:46.3679551Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232.zip successfully finalized. Artifact ID 90302920792026-08-09T01:02:46.3682528Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232 has been successfully uploaded! Final size is 14115 bytes. Artifact ID is 90302920792026-08-09T01:02:46.3689007Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/31287162726/artifacts/90302920792026-08-09T01:02:46.3902607Z Post job cleanup.2026-08-09T01:02:46.5323841Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-09T01:02:46.5372268Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-09T01:02:46.5419223Z /home/runner/go/pkg/mod2026-08-09T01:02:46.5444354Z /home/runner/.cache/go-build2026-08-09T01:02:46.5453874Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-09T01:02:46.5630483Z Post job cleanup.2026-08-09T01:02:46.6626684Z [command]/usr/bin/git version2026-08-09T01:02:46.6690373Z git version 2.54.02026-08-09T01:02:46.6747128Z Temporarily overriding HOME='/home/runner/work/_temp/bf23d7cb-df5f-464e-83e6-c2b7a85dca74' before making global git config changes2026-08-09T01:02:46.6756996Z Adding repository directory to the temporary git global config as a safe directory2026-08-09T01:02:46.6758356Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-09T01:02:46.6804047Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-09T01:02:46.6869848Z [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-09T01:02:46.7244484Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-09T01:02:46.7272718Z http.https://github.com/.extraheader2026-08-09T01:02:46.7287719Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-09T01:02:46.7336850Z [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-09T01:02:46.7628411Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-09T01:02:46.7669823Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-09T01:02:46.8101067Z Cleaning up orphan processes2026-08-09T01:02:46.8905789Z ##[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/