2026-08-04T01:25:30.9159195Z Current runner version: '2.336.0'2026-08-04T01:25:30.9185482Z ##[group]Runner Image Provisioner2026-08-04T01:25:30.9186737Z Hosted Compute Agent2026-08-04T01:25:30.9187387Z Version: 20260707.5632026-08-04T01:25:30.9188103Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-08-04T01:25:30.9188856Z Build Date: 2026-07-07T19:33:50Z2026-08-04T01:25:30.9189561Z Worker ID: {6c587ad7-07c6-4284-9ceb-812ae1ac8dca}2026-08-04T01:25:30.9190697Z Azure Region: centralus2026-08-04T01:25:30.9191382Z ##[endgroup]2026-08-04T01:25:30.9193207Z ##[group]Operating System2026-08-04T01:25:30.9194001Z Ubuntu2026-08-04T01:25:30.9194567Z 22.04.52026-08-04T01:25:30.9195137Z LTS2026-08-04T01:25:30.9195701Z ##[endgroup]2026-08-04T01:25:30.9196254Z ##[group]Runner Image2026-08-04T01:25:30.9197019Z Image: ubuntu-22.042026-08-04T01:25:30.9197619Z Version: 20260720.234.22026-08-04T01:25:30.9198974Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-08-04T01:25:30.9200827Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-08-04T01:25:30.9201922Z ##[endgroup]2026-08-04T01:25:30.9203093Z ##[group]GITHUB_TOKEN Permissions2026-08-04T01:25:30.9205499Z Contents: read2026-08-04T01:25:30.9206133Z Metadata: read2026-08-04T01:25:30.9206684Z Packages: read2026-08-04T01:25:30.9207749Z ##[endgroup]2026-08-04T01:25:30.9209867Z Secret source: Actions2026-08-04T01:25:30.9211889Z Prepare workflow directory2026-08-04T01:25:30.9609051Z Prepare all required actions2026-08-04T01:25:30.9679424Z Getting action download info2026-08-04T01:25:31.2027588Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-04T01:25:31.5743000Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-04T01:25:31.8723971Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-04T01:25:32.2071097Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-04T01:25:32.4736718Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-04T01:25:32.4743158Z ##[group] Inputs2026-08-04T01:25:32.4744172Z testName: TestOSPoolEP2026-08-04T01:25:32.4745994Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-04T01:25:32.4747982Z setupScript: 2026-08-04T01:25:32.4748865Z setupEnv: {}2026-08-04T01:25:32.4749730Z ##[endgroup]2026-08-04T01:25:32.4751372Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-testing) / Run Tests2026-08-04T01:25:32.5633887Z ##[group]Run actions/checkout@v52026-08-04T01:25:32.5635252Z with:2026-08-04T01:25:32.5636210Z repository: mwestphall/k8s-integration-tests2026-08-04T01:25:32.5645794Z token: ***2026-08-04T01:25:32.5646641Z ssh-strict: true2026-08-04T01:25:32.5647545Z ssh-user: git2026-08-04T01:25:32.5648429Z persist-credentials: true2026-08-04T01:25:32.5649414Z clean: true2026-08-04T01:25:32.5650424Z sparse-checkout-cone-mode: true2026-08-04T01:25:32.5651738Z fetch-depth: 12026-08-04T01:25:32.5652815Z fetch-tags: false2026-08-04T01:25:32.5654020Z show-progress: true2026-08-04T01:25:32.5654998Z lfs: false2026-08-04T01:25:32.5655876Z submodules: false2026-08-04T01:25:32.5656973Z set-safe-directory: true2026-08-04T01:25:32.5658020Z allow-unsafe-pr-checkout: false2026-08-04T01:25:32.5659440Z ##[endgroup]2026-08-04T01:25:32.6717504Z Syncing repository: mwestphall/k8s-integration-tests2026-08-04T01:25:32.6722136Z ##[group]Getting Git version info2026-08-04T01:25:32.6725001Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-04T01:25:32.6728856Z [command]/usr/bin/git version2026-08-04T01:25:32.6796796Z git version 2.54.02026-08-04T01:25:32.6829390Z ##[endgroup]2026-08-04T01:25:32.6852684Z Temporarily overriding HOME='/home/runner/work/_temp/340e53ef-4e17-4be4-9a73-e5f8fdbc71f2' before making global git config changes2026-08-04T01:25:32.6856377Z Adding repository directory to the temporary git global config as a safe directory2026-08-04T01:25:32.6860106Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-04T01:25:32.6900742Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-04T01:25:32.6904926Z ##[group]Initializing the repository2026-08-04T01:25:32.6910863Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-04T01:25:32.7026372Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-04T01:25:32.7029769Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-04T01:25:32.7034294Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-04T01:25:32.7036924Z hint: call:2026-08-04T01:25:32.7038284Z hint:2026-08-04T01:25:32.7039897Z hint: git config --global init.defaultBranch <name>2026-08-04T01:25:32.7047976Z hint:2026-08-04T01:25:32.7049867Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-04T01:25:32.7053164Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-04T01:25:32.7055700Z hint:2026-08-04T01:25:32.7057040Z hint: git branch -m <name>2026-08-04T01:25:32.7058767Z hint:2026-08-04T01:25:32.7061115Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-04T01:25:32.7065144Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-04T01:25:32.7071707Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-04T01:25:32.7089806Z ##[endgroup]2026-08-04T01:25:32.7092709Z ##[group]Disabling automatic garbage collection2026-08-04T01:25:32.7096565Z [command]/usr/bin/git config --local gc.auto 02026-08-04T01:25:32.7132093Z ##[endgroup]2026-08-04T01:25:32.7133524Z ##[group]Setting up auth2026-08-04T01:25:32.7139012Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-04T01:25:32.7184236Z [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-04T01:25:32.7586386Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-04T01:25:32.7620730Z [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-04T01:25:32.7867305Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-04T01:25:32.7904686Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-04T01:25:32.8150991Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-04T01:25:32.8191679Z ##[endgroup]2026-08-04T01:25:32.8194223Z ##[group]Fetching the repository2026-08-04T01:25:32.8204148Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-04T01:25:33.1328705Z From https://github.com/mwestphall/k8s-integration-tests2026-08-04T01:25:33.1330878Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-04T01:25:33.1356458Z ##[endgroup]2026-08-04T01:25:33.1358402Z ##[group]Determining the checkout info2026-08-04T01:25:33.1360777Z ##[endgroup]2026-08-04T01:25:33.1364663Z [command]/usr/bin/git sparse-checkout disable2026-08-04T01:25:33.1413129Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-04T01:25:33.1447619Z ##[group]Checking out the ref2026-08-04T01:25:33.1451299Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-04T01:25:33.1546896Z Switched to a new branch 'main'2026-08-04T01:25:33.1550662Z branch 'main' set up to track 'origin/main'.2026-08-04T01:25:33.1556565Z ##[endgroup]2026-08-04T01:25:33.1605204Z [command]/usr/bin/git log -1 --format=%H2026-08-04T01:25:33.1634335Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-04T01:25:33.1964880Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-04T01:25:33.1967153Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-04T01:25:33.1969288Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-04T01:25:33.2099397Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-04T01:25:33.2100997Z env:2026-08-04T01:25:33.2102568Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-04T01:25:33.2104435Z SETUP_ENV_YAML: {}2026-08-04T01:25:33.2105278Z ##[endgroup]2026-08-04T01:25:33.8898546Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-04T01:25:33.8899273Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-04T01:25:33.8957449Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-04T01:25:33.8957864Z env:2026-08-04T01:25:33.8958377Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-04T01:25:33.8958939Z ##[endgroup]2026-08-04T01:25:33.9093305Z ##[group]Run true2026-08-04T01:25:33.9093607Z [36;1mtrue[0m2026-08-04T01:25:33.9145419Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-04T01:25:33.9145847Z ##[endgroup]2026-08-04T01:25:33.9310640Z ##[group]Run medyagh/setup-minikube@latest2026-08-04T01:25:33.9311031Z with:2026-08-04T01:25:33.9311266Z start: true2026-08-04T01:25:33.9311506Z cache: true2026-08-04T01:25:33.9311758Z minikube-version: latest2026-08-04T01:25:33.9312035Z wait: all2026-08-04T01:25:33.9312264Z ##[endgroup]2026-08-04T01:25:34.0570612Z (node:2287) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-04T01:25:34.0571772Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-04T01:25:35.1794135Z [command]/usr/bin/chmod +x /home/runner/work/_temp/30812711-9eeb-46da-9fc4-7e723fbf9e062026-08-04T01:25:35.3521486Z [command]/home/runner/bin/minikube version --short2026-08-04T01:25:35.3944038Z v1.38.12026-08-04T01:25:35.5196884Z Cache hit for: kic-v1.38.1-x642026-08-04T01:25:35.5315372Z (node:2287) [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-04T01:25:35.5322557Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-04T01:25:36.6605272Z Received 125829120 of 544082657 (23.1%), 119.8 MBs/sec2026-08-04T01:25:36.6770073Z Received 88080384 of 224218863 (39.3%), 84.0 MBs/sec2026-08-04T01:25:37.7167621Z Received 268435456 of 544082657 (49.3%), 124.3 MBs/sec2026-08-04T01:25:37.7168092Z Received 213909504 of 224218863 (95.4%), 100.0 MBs/sec2026-08-04T01:25:37.7892160Z Received 224218863 of 224218863 (100.0%), 101.2 MBs/sec2026-08-04T01:25:37.7893431Z Cache Size: ~214 MB (224218863 B)2026-08-04T01:25:37.8081990Z [command]/usr/bin/tar -xf /home/runner/work/_temp/91f01a6e-baeb-4ca3-953c-13a9927fc5ee/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-04T01:25:38.4451408Z Cache restored successfully2026-08-04T01:25:38.7178242Z Received 402653184 of 544082657 (74.0%), 125.5 MBs/sec2026-08-04T01:25:39.5175204Z Received 544082657 of 544082657 (100.0%), 134.4 MBs/sec2026-08-04T01:25:39.5176015Z Cache Size: ~519 MB (544082657 B)2026-08-04T01:25:39.5293378Z [command]/usr/bin/tar -xf /home/runner/work/_temp/8d9d4414-2306-4626-97dd-05afb48573c3/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-04T01:25:40.3577512Z Cache restored successfully2026-08-04T01:25:40.4766623Z [command]/home/runner/bin/minikube start --wait all2026-08-04T01:25:40.5186361Z * minikube v1.38.1 on Ubuntu 22.042026-08-04T01:25:42.8987728Z ! 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-04T01:25:42.8994525Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-04T01:25:42.9591940Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-04T01:25:42.9621844Z * Using Docker driver with root privileges2026-08-04T01:25:42.9639831Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-04T01:25:42.9646762Z * Pulling base image v0.0.50 ...2026-08-04T01:26:14.1097614Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-04T01:26:19.2760581Z * Verifying Kubernetes components...2026-08-04T01:26:19.3093930Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-04T01:26:20.0687132Z * Enabled addons: storage-provisioner, default-storageclass2026-08-04T01:26:59.4818472Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-04T01:26:59.4934711Z [command]/home/runner/bin/minikube version --short2026-08-04T01:26:59.5307186Z v1.38.12026-08-04T01:26:59.5620041Z ##[group]Run actions/setup-go@v62026-08-04T01:26:59.5620534Z with:2026-08-04T01:26:59.5620746Z go-version: 1.262026-08-04T01:26:59.5620991Z cache: true2026-08-04T01:26:59.5621218Z cache-dependency-path: go.sum2026-08-04T01:26:59.5621496Z check-latest: false2026-08-04T01:26:59.5624049Z token: ***2026-08-04T01:26:59.5624266Z ##[endgroup]2026-08-04T01:26:59.6873254Z Setup go version spec 1.262026-08-04T01:26:59.7212166Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-04T01:26:59.7214806Z Added go to the path2026-08-04T01:26:59.7218200Z Successfully set up Go version 1.262026-08-04T01:27:00.8302109Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-04T01:27:00.8337751Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-04T01:27:00.8366217Z /home/runner/go/pkg/mod2026-08-04T01:27:00.8392394Z /home/runner/.cache/go-build2026-08-04T01:27:00.9783873Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-04T01:27:02.1392117Z Received 88080384 of 251839808 (35.0%), 83.9 MBs/sec2026-08-04T01:27:03.1402794Z Received 247645504 of 251839808 (98.3%), 117.9 MBs/sec2026-08-04T01:27:03.2438898Z Received 251839808 of 251839808 (100.0%), 113.9 MBs/sec2026-08-04T01:27:03.2441334Z Cache Size: ~240 MB (251839808 B)2026-08-04T01:27:03.2485354Z [command]/usr/bin/tar -xf /home/runner/work/_temp/fa49a8a3-b464-46d9-9ab8-fc1fc4b7c4cc/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-04T01:27:06.3262201Z Cache restored successfully2026-08-04T01:27:06.3810825Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-04T01:27:06.3856045Z go version go1.26.5 linux/amd642026-08-04T01:27:06.3856373Z 2026-08-04T01:27:06.3856861Z ##[group]go env2026-08-04T01:27:06.5261038Z AR='ar'2026-08-04T01:27:06.5261740Z CC='gcc'2026-08-04T01:27:06.5262410Z CGO_CFLAGS='-O2 -g'2026-08-04T01:27:06.5263060Z CGO_CPPFLAGS=''2026-08-04T01:27:06.5263699Z CGO_CXXFLAGS='-O2 -g'2026-08-04T01:27:06.5264621Z CGO_ENABLED='1'2026-08-04T01:27:06.5265158Z CGO_FFLAGS='-O2 -g'2026-08-04T01:27:06.5265728Z CGO_LDFLAGS='-O2 -g'2026-08-04T01:27:06.5266280Z CXX='g++'2026-08-04T01:27:06.5266799Z GCCGO='gccgo'2026-08-04T01:27:06.5267321Z GO111MODULE=''2026-08-04T01:27:06.5268121Z GOAMD64='v1'2026-08-04T01:27:06.5268679Z GOARCH='amd64'2026-08-04T01:27:06.5269231Z GOAUTH='netrc'2026-08-04T01:27:06.5269757Z GOBIN=''2026-08-04T01:27:06.5270530Z GOCACHE='/home/runner/.cache/go-build'2026-08-04T01:27:06.5271249Z GOCACHEPROG=''2026-08-04T01:27:06.5271791Z GODEBUG=''2026-08-04T01:27:06.5272343Z GOENV='/home/runner/.config/go/env'2026-08-04T01:27:06.5272998Z GOEXE=''2026-08-04T01:27:06.5273528Z GOEXPERIMENT=''2026-08-04T01:27:06.5274094Z GOFIPS140='off'2026-08-04T01:27:06.5274644Z GOFLAGS=''2026-08-04T01:27:06.5276097Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build95714491=/tmp/go-build -gno-record-gcc-switches'2026-08-04T01:27:06.5277479Z GOHOSTARCH='amd64'2026-08-04T01:27:06.5278043Z GOHOSTOS='linux'2026-08-04T01:27:06.5278597Z GOINSECURE=''2026-08-04T01:27:06.5279418Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-04T01:27:06.5280633Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-04T01:27:06.5281319Z GONOPROXY=''2026-08-04T01:27:06.5281876Z GONOSUMDB=''2026-08-04T01:27:06.5282410Z GOOS='linux'2026-08-04T01:27:06.5282956Z GOPATH='/home/runner/go'2026-08-04T01:27:06.5283521Z GOPRIVATE=''2026-08-04T01:27:06.5284118Z GOPROXY='https://proxy.golang.org,direct'2026-08-04T01:27:06.5284857Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-04T01:27:06.5285536Z GOSUMDB='sum.golang.org'2026-08-04T01:27:06.5286109Z GOTELEMETRY='local'2026-08-04T01:27:06.5286732Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-04T01:27:06.5287434Z GOTMPDIR=''2026-08-04T01:27:06.5288221Z GOTOOLCHAIN='local'2026-08-04T01:27:06.5288985Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-04T01:27:06.5289806Z GOVCS=''2026-08-04T01:27:06.5290604Z GOVERSION='go1.26.5'2026-08-04T01:27:06.5291182Z GOWORK=''2026-08-04T01:27:06.5291699Z PKG_CONFIG='pkg-config'2026-08-04T01:27:06.5292105Z 2026-08-04T01:27:06.5292809Z ##[endgroup]2026-08-04T01:27:06.5678719Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-04T01:27:06.5679282Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-04T01:27:06.5735503Z shell: /usr/bin/bash -e {0}2026-08-04T01:27:06.5735876Z env:2026-08-04T01:27:06.5736183Z GOTOOLCHAIN: local2026-08-04T01:27:06.5736441Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-08-04T01:27:06.5736729Z OSPOOL_EP_CMTag: 25.x-el92026-08-04T01:27:06.5736987Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-04T01:27:06.5737236Z ##[endgroup]2026-08-04T01:27:14.7671898Z === RUN TestOSPoolEP2026-08-04T01:27:14.7672410Z === PAUSE TestOSPoolEP2026-08-04T01:27:14.7672867Z === CONT TestOSPoolEP2026-08-04T01:27:14.7675224Z TestOSPoolEP 2026-08-04T01:27:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:14.7766039Z TestOSPoolEP 2026-08-04T01:27:14Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb apply -f /tmp/TestOSPoolEP518254178]2026-08-04T01:27:15.2642389Z TestOSPoolEP 2026-08-04T01:27:15Z logger.go:67: pod/idtoken-generator created2026-08-04T01:27:15.2730185Z TestOSPoolEP 2026-08-04T01:27:15Z logger.go:67: secret/pool-passwd created2026-08-04T01:27:15.2799525Z TestOSPoolEP 2026-08-04T01:27:15Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-04T01:27:15.2804787Z TestOSPoolEP 2026-08-04T01:27:15Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:15.2828548Z TestOSPoolEP 2026-08-04T01:27:15Z 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-04T01:27:25.2834549Z TestOSPoolEP 2026-08-04T01:27:25Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-04T01:27:25.2836325Z TestOSPoolEP 2026-08-04T01:27:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:25.2862800Z TestOSPoolEP 2026-08-04T01:27:25Z 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-04T01:27:35.2866170Z TestOSPoolEP 2026-08-04T01:27:35Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-04T01:27:35.2867281Z TestOSPoolEP 2026-08-04T01:27:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:35.2891985Z TestOSPoolEP 2026-08-04T01:27:35Z logger.go:67: Pod is now available2026-08-04T01:27:35.2893755Z TestOSPoolEP 2026-08-04T01:27:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-04T01:27:35.7892178Z TestOSPoolEP 2026-08-04T01:27:35Z logger.go:67: ***2026-08-04T01:27:35.7949128Z TestOSPoolEP 2026-08-04T01:27:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb apply -f /tmp/TestOSPoolEP4014263142]2026-08-04T01:27:35.9983462Z TestOSPoolEP 2026-08-04T01:27:35Z logger.go:67: secret/pool-token created2026-08-04T01:27:36.0017787Z TestOSPoolEP 2026-08-04T01:27:36Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-04T01:27:36.0019294Z TestOSPoolEP 2026-08-04T01:27:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:36.0036764Z TestOSPoolEP 2026-08-04T01:27:36Z logger.go:67: Secret is now available2026-08-04T01:27:36.0061248Z TestOSPoolEP 2026-08-04T01:27:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb apply -k /tmp/kustomize-template-3593345927]2026-08-04T01:27:36.2760049Z TestOSPoolEP 2026-08-04T01:27:36Z logger.go:67: service/test-cm created2026-08-04T01:27:36.2850666Z TestOSPoolEP 2026-08-04T01:27:36Z 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-04T01:27:36.2853669Z TestOSPoolEP 2026-08-04T01:27:36Z logger.go:67: deployment.apps/ospool-ep created2026-08-04T01:27:36.2944815Z TestOSPoolEP 2026-08-04T01:27:36Z logger.go:67: deployment.apps/test-cm created2026-08-04T01:27:36.3004219Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-04T01:27:36.3006054Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:36.3180624Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:36Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-04T01:27:36.3182971Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:36.3188398Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:36Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-04T01:27:36.3190857Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:36.3299831Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:36Z 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-5bb545475c". Sleeping for 10s and will try again.2026-08-04T01:27:36.3309286Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:36Z 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-65c844ddbb". Sleeping for 10s and will try again.2026-08-04T01:27:46.3303685Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:46Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-04T01:27:46.3304877Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:46.3313217Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:46Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-04T01:27:46.3314636Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:46.3364071Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:46Z 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-65c844ddbb" is progressing.. Sleeping for 10s and will try again.2026-08-04T01:27:46.3367053Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:46Z logger.go:67: Deployment is now available2026-08-04T01:27:56.3363890Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:56Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-04T01:27:56.3366107Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:56.3392223Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:56Z logger.go:67: Deployment is now available2026-08-04T01:27:56.3393896Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-04T01:27:56.3394676Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-04T01:27:56.3395479Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-04T01:27:56.3396381Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-04T01:27:56.3397225Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-04T01:27:56.3397994Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-04T01:27:56.3398745Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-04T01:27:56.3399616Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-04T01:27:56.3401572Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-04T01:27:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:56.3403140Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-04T01:27:56.3404696Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:27:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:56.3406933Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:27:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:56.3428275Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-04T01:27:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:56.3433435Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:27:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:56.3451892Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:27:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:56.3476737Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:27:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:27:56.3492764Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:27:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)']2026-08-04T01:27:56.3511428Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-04T01:27:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_SINGULARITY]2026-08-04T01:27:56.6021080Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-jgdqk failed. Retrying in 30s.2026-08-04T01:27:56.6222720Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-04T01:27:56.6225292Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-jgdqk failed. Retrying in 10s.2026-08-04T01:27:56.6239531Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-04T01:27:56.6241692Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)']' in pod test-cm-5bb545475c-jgdqk failed. Retrying in 10s.2026-08-04T01:28:06.6218740Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-04T01:28:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_SINGULARITY]2026-08-04T01:28:06.6253766Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)']2026-08-04T01:28:06.8196718Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)']' in pod test-cm-5bb545475c-jgdqk failed. Retrying in 10s.2026-08-04T01:28:06.8204453Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-04T01:28:06.8205756Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-jgdqk failed. Retrying in 10s.2026-08-04T01:28:16.8217235Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-04T01:28:16Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_SINGULARITY]2026-08-04T01:28:16.8221386Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:16Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)']2026-08-04T01:28:17.0386546Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-04T01:28:17Z logger.go:67: true2026-08-04T01:28:17.0388310Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:17Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-04T01:28:17.0392697Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:17Z logger.go:67: 2026-08-04T01:28:17.0398500Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:17Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-65c844ddbb-984qw LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-08-04T01:28:17.0400517Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:17Z logger.go:67: 2026-08-04T01:28:17.0402179Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:17Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-04T01:28:17.0407883Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:17Z logger.go:67: 2026-08-04T01:28:17.0414002Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:17Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-04T01:28:17.0415946Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:17Z logger.go:67: 2026-08-04T01:28:17.0420325Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:17Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-04T01:28:26.6030430Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:28:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:28:26.7544998Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:28:26Z logger.go:67: undefined2026-08-04T01:28:26.7619600Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-04T01:28:26.7622053Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-jgdqk failed. Retrying in 30s.2026-08-04T01:28:56.7626082Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:28:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:28:56.9168041Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:28:56Z logger.go:67: undefined2026-08-04T01:28:56.9225446Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-jgdqk failed. Retrying in 30s.2026-08-04T01:29:26.9232125Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:29:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:29:27.0873452Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:29:27Z logger.go:67: undefined2026-08-04T01:29:27.0924841Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-jgdqk failed. Retrying in 30s.2026-08-04T01:29:57.0929226Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:29:57Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:29:57.2454357Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:29:57Z logger.go:67: undefined2026-08-04T01:29:57.2509692Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-jgdqk failed. Retrying in 30s.2026-08-04T01:30:27.2536246Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:30:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:30:27.4059826Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:30:27Z logger.go:67: undefined2026-08-04T01:30:27.4133551Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-jgdqk failed. Retrying in 30s.2026-08-04T01:30:57.4158587Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:30:57Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:30:57.5645828Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:30:57Z logger.go:67: undefined2026-08-04T01:30:57.5699706Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-jgdqk failed. Retrying in 30s.2026-08-04T01:31:27.5729466Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:31:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:31:27.7169103Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:31:27Z logger.go:67: undefined2026-08-04T01:31:27.7226226Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-jgdqk failed. Retrying in 30s.2026-08-04T01:31:57.7232572Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:31:57Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:31:57.8855096Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:31:57Z logger.go:67: undefined2026-08-04T01:31:57.8928589Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-jgdqk failed. Retrying in 30s.2026-08-04T01:32:27.8957629Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:32:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:32:28.0396199Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:32:28Z logger.go:67: undefined2026-08-04T01:32:28.0455578Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-jgdqk failed. Retrying in 30s.2026-08-04T01:32:58.0490091Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:32:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:32:58.1983841Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:32:58Z logger.go:67: undefined2026-08-04T01:32:58.2039534Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-jgdqk failed. Retrying in 30s.2026-08-04T01:33:28.2068502Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:33:28Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb exec test-cm-5bb545475c-jgdqk -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-984qw",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:33:28.3831424Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:33:28Z logger.go:67: true2026-08-04T01:33:28.3884797Z TestOSPoolEP 2026-08-04T01:33:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:33:28.3969907Z TestOSPoolEP 2026-08-04T01:33:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:33:28.6468111Z TestOSPoolEP 2026-08-04T01:33:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:33:28.7911988Z TestOSPoolEP 2026-08-04T01:33:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:33:28.9089077Z TestOSPoolEP 2026-08-04T01:33:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:33:28.9112520Z === NAME TestOSPoolEP2026-08-04T01:33:28.9113385Z ospool_ep_test.go:101: ---2026-08-04T01:33:28.9114781Z Events for pod idtoken-generator:2026-08-04T01:33:28.9116159Z 2026-08-04 01:27:15 +0000 UTC Normal Successfully assigned test-ospool-ep-pnxnlb/idtoken-generator to minikube2026-08-04T01:33:28.9117432Z 2026-08-04 01:27:16 +0000 UTC Normal Pulling image "htcondor/base"2026-08-04T01:33:28.9119140Z 2026-08-04 01:27:25 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.848s (8.848s including waiting). Image size: 560910730 bytes.2026-08-04T01:33:28.9120883Z 2026-08-04 01:27:25 +0000 UTC Normal Container created2026-08-04T01:33:28.9121728Z 2026-08-04 01:27:25 +0000 UTC Normal Container started2026-08-04T01:33:28.9122245Z 2026-08-04T01:33:28.9123060Z ---2026-08-04T01:33:28.9124081Z TestOSPoolEP 2026-08-04T01:33:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:33:28.9143183Z ospool_ep_test.go:101: ---2026-08-04T01:33:28.9144656Z Events for pod ospool-ep-65c844ddbb-984qw:2026-08-04T01:33:28.9146239Z 2026-08-04 01:27:36 +0000 UTC Normal Successfully assigned test-ospool-ep-pnxnlb/ospool-ep-65c844ddbb-984qw to minikube2026-08-04T01:33:28.9147902Z 2026-08-04 01:27:36 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-04T01:33:28.9150111Z 2026-08-04 01:27:38 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.819s (1.819s including waiting). Image size: 5590942 bytes.2026-08-04T01:33:28.9152306Z 2026-08-04 01:27:38 +0000 UTC Normal Container created2026-08-04T01:33:28.9152972Z 2026-08-04 01:27:38 +0000 UTC Normal Container started2026-08-04T01:33:28.9153887Z 2026-08-04 01:27:39 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-08-04T01:33:28.9156364Z 2026-08-04 01:27:53 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 14.204s (14.548s including waiting). Image size: 1250776798 bytes.2026-08-04T01:33:28.9158087Z 2026-08-04 01:27:53 +0000 UTC Normal Container created2026-08-04T01:33:28.9159021Z 2026-08-04 01:27:53 +0000 UTC Normal Container started2026-08-04T01:33:28.9159633Z 2026-08-04T01:33:28.9160014Z ---2026-08-04T01:33:28.9161310Z TestOSPoolEP 2026-08-04T01:33:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:33:28.9168202Z ospool_ep_test.go:101: ---2026-08-04T01:33:28.9169650Z Events for pod test-cm-5bb545475c-jgdqk:2026-08-04T01:33:28.9171810Z 2026-08-04 01:27:36 +0000 UTC Normal Successfully assigned test-ospool-ep-pnxnlb/test-cm-5bb545475c-jgdqk to minikube2026-08-04T01:33:28.9173570Z 2026-08-04 01:27:36 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-08-04T01:33:28.9175948Z 2026-08-04 01:27:39 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 750ms (2.558s including waiting). Image size: 560910756 bytes.2026-08-04T01:33:28.9177720Z 2026-08-04 01:27:39 +0000 UTC Normal Container created2026-08-04T01:33:28.9178948Z 2026-08-04 01:27:39 +0000 UTC Normal Container started2026-08-04T01:33:28.9179807Z 2026-08-04T01:33:28.9180176Z ---2026-08-04T01:33:28.9182586Z TestOSPoolEP 2026-08-04T01:33:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:33:28.9233769Z TestOSPoolEP 2026-08-04T01:33:28Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb delete -f /tmp/TestOSPoolEP979906169]2026-08-04T01:33:29.0220730Z TestOSPoolEP 2026-08-04T01:33:29Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-pnxnlb namespace2026-08-04T01:33:29.0273210Z TestOSPoolEP 2026-08-04T01:33:29Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-pnxnlb namespace2026-08-04T01:33:30.2676074Z TestOSPoolEP 2026-08-04T01:33:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb delete -f /tmp/TestOSPoolEP3602858560]2026-08-04T01:33:30.3598626Z TestOSPoolEP 2026-08-04T01:33:30Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-pnxnlb namespace2026-08-04T01:33:30.3651071Z TestOSPoolEP 2026-08-04T01:33:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-pnxnlb delete -k /tmp/kustomize-template-3593345927]2026-08-04T01:33:30.4936371Z TestOSPoolEP 2026-08-04T01:33:30Z logger.go:67: service "test-cm" deleted from test-ospool-ep-pnxnlb namespace2026-08-04T01:33:30.4974399Z TestOSPoolEP 2026-08-04T01:33:30Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-pnxnlb namespace2026-08-04T01:33:30.5044651Z TestOSPoolEP 2026-08-04T01:33:30Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-pnxnlb namespace2026-08-04T01:33:30.5154295Z --- PASS: TestOSPoolEP (43.70s)2026-08-04T01:33:30.5156178Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (20.04s)2026-08-04T01:33:30.5158843Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.71s)2026-08-04T01:33:30.5160993Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.71s)2026-08-04T01:33:30.5163891Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (332.05s)2026-08-04T01:33:30.5165942Z PASS2026-08-04T01:33:30.5201646Z ok github.com/osg-htc/k8s-integration-tests/test 375.763s2026-08-04T01:33:30.6354012Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-04T01:33:30.6354647Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-04T01:33:30.6413608Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-04T01:33:30.6413961Z env:2026-08-04T01:33:30.6414157Z GOTOOLCHAIN: local2026-08-04T01:33:30.6414627Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-04T01:33:30.6415111Z ##[endgroup]2026-08-04T01:33:30.6640159Z 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-04T01:33:30.6642632Z ##[group]Run actions/upload-artifact@v42026-08-04T01:33:30.6643436Z with:2026-08-04T01:33:30.6644090Z name: TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe52026-08-04T01:33:30.6644944Z path: /tmp/k8s-tests2026-08-04T01:33:30.6645335Z retention-days: 52026-08-04T01:33:30.6645731Z if-no-files-found: warn2026-08-04T01:33:30.6646150Z compression-level: 62026-08-04T01:33:30.6646542Z overwrite: false2026-08-04T01:33:30.6646939Z include-hidden-files: false2026-08-04T01:33:30.6647377Z env:2026-08-04T01:33:30.6647581Z GOTOOLCHAIN: local2026-08-04T01:33:30.6647991Z ##[endgroup]2026-08-04T01:33:30.8843600Z (node:17717) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-04T01:33:30.8844566Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-04T01:33:30.8987004Z With the provided path, there will be 6 files uploaded2026-08-04T01:33:30.8988509Z Artifact name is valid!2026-08-04T01:33:30.8989451Z Root directory input is valid!2026-08-04T01:33:31.1158090Z Beginning upload of artifact content to blob storage2026-08-04T01:33:31.1596479Z (node:17717) [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-04T01:33:31.2943754Z Uploaded bytes 139682026-08-04T01:33:31.3302044Z Finished uploading artifact content to blob storage!2026-08-04T01:33:31.3303168Z SHA256 digest of uploaded artifact zip is 5209c19f3cd1c0cffc9f7707f0a12f37ba371d6a6a347d3d813b8a23482f08da2026-08-04T01:33:31.3304931Z Finalizing artifact upload2026-08-04T01:33:31.5029598Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5.zip successfully finalized. Artifact ID 88771990672026-08-04T01:33:31.5032318Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5 has been successfully uploaded! Final size is 13968 bytes. Artifact ID is 88771990672026-08-04T01:33:31.5037597Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/30868701385/artifacts/88771990672026-08-04T01:33:31.5213962Z Post job cleanup.2026-08-04T01:33:31.6556462Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-04T01:33:31.6604899Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-04T01:33:31.6640229Z /home/runner/go/pkg/mod2026-08-04T01:33:31.6665031Z /home/runner/.cache/go-build2026-08-04T01:33:31.6681842Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-04T01:33:31.6876116Z Post job cleanup.2026-08-04T01:33:31.7861186Z [command]/usr/bin/git version2026-08-04T01:33:31.7908784Z git version 2.54.02026-08-04T01:33:31.7955527Z Temporarily overriding HOME='/home/runner/work/_temp/08aabd5e-7a96-4b39-bd67-92c192991c11' before making global git config changes2026-08-04T01:33:31.7957209Z Adding repository directory to the temporary git global config as a safe directory2026-08-04T01:33:31.7962909Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-04T01:33:31.8016905Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-04T01:33:31.8076846Z [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-04T01:33:31.8465480Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-04T01:33:31.8492488Z http.https://github.com/.extraheader2026-08-04T01:33:31.8507705Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-04T01:33:31.8542810Z [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-04T01:33:31.8852073Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-04T01:33:31.8892396Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-04T01:33:31.9331730Z Cleaning up orphan processes2026-08-04T01:33:32.0207011Z ##[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/