2026-08-16T00:39:15.1814613Z Current runner version: '2.336.0'2026-08-16T00:39:15.1835071Z ##[group]Runner Image Provisioner2026-08-16T00:39:15.1835756Z Hosted Compute Agent2026-08-16T00:39:15.1836343Z Version: 20260729.5662026-08-16T00:39:15.1836865Z Commit: cf7153fe6e25b664e8693c24944bf2b00355d1092026-08-16T00:39:15.1837492Z Build Date: 2026-07-29T19:17:02Z2026-08-16T00:39:15.1838076Z Worker ID: {34b5215b-5782-4aa2-993c-14036599715a}2026-08-16T00:39:15.1838657Z Azure Region: westus32026-08-16T00:39:15.1839217Z ##[endgroup]2026-08-16T00:39:15.1840488Z ##[group]Operating System2026-08-16T00:39:15.1840983Z Ubuntu2026-08-16T00:39:15.1841524Z 22.04.52026-08-16T00:39:15.1841951Z LTS2026-08-16T00:39:15.1842406Z ##[endgroup]2026-08-16T00:39:15.1842893Z ##[group]Runner Image2026-08-16T00:39:15.1843386Z Image: ubuntu-22.042026-08-16T00:39:15.1843909Z Version: 20260810.260.12026-08-16T00:39:15.1844934Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260810.260/images/ubuntu/Ubuntu2204-Readme.md2026-08-16T00:39:15.1846187Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260810.2602026-08-16T00:39:15.1846951Z ##[endgroup]2026-08-16T00:39:15.1847976Z ##[group]GITHUB_TOKEN Permissions2026-08-16T00:39:15.1849601Z Contents: read2026-08-16T00:39:15.1850329Z Metadata: read2026-08-16T00:39:15.1850820Z Packages: read2026-08-16T00:39:15.1851296Z ##[endgroup]2026-08-16T00:39:15.1853346Z Secret source: Actions2026-08-16T00:39:15.1854306Z Prepare workflow directory2026-08-16T00:39:15.2123176Z Prepare all required actions2026-08-16T00:39:15.2177441Z Getting action download info2026-08-16T00:39:15.5306145Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-16T00:39:15.6514691Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-16T00:39:16.2496707Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-16T00:39:16.8410082Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-16T00:39:17.1026946Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-16T00:39:17.1031883Z ##[group] Inputs2026-08-16T00:39:17.1032693Z testName: TestOSPoolEP2026-08-16T00:39:17.1033969Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-16T00:39:17.1035378Z setupScript: 2026-08-16T00:39:17.1036148Z setupEnv: {}2026-08-16T00:39:17.1036796Z ##[endgroup]2026-08-16T00:39:17.1037769Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-08-16T00:39:17.1715416Z ##[group]Run actions/checkout@v52026-08-16T00:39:17.1716462Z with:2026-08-16T00:39:17.1717158Z repository: mwestphall/k8s-integration-tests2026-08-16T00:39:17.1724440Z token: ***2026-08-16T00:39:17.1725058Z ssh-strict: true2026-08-16T00:39:17.1725718Z ssh-user: git2026-08-16T00:39:17.1726363Z persist-credentials: true2026-08-16T00:39:17.1727060Z clean: true2026-08-16T00:39:17.1727699Z sparse-checkout-cone-mode: true2026-08-16T00:39:17.1728458Z fetch-depth: 12026-08-16T00:39:17.1729064Z fetch-tags: false2026-08-16T00:39:17.1729704Z show-progress: true2026-08-16T00:39:17.1730544Z lfs: false2026-08-16T00:39:17.1731135Z submodules: false2026-08-16T00:39:17.1731787Z set-safe-directory: true2026-08-16T00:39:17.1732521Z allow-unsafe-pr-checkout: false2026-08-16T00:39:17.1733504Z ##[endgroup]2026-08-16T00:39:17.2614660Z Syncing repository: mwestphall/k8s-integration-tests2026-08-16T00:39:17.2619824Z ##[group]Getting Git version info2026-08-16T00:39:17.2622061Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-16T00:39:17.2641432Z [command]/usr/bin/git version2026-08-16T00:39:17.2711702Z git version 2.54.02026-08-16T00:39:17.2734634Z ##[endgroup]2026-08-16T00:39:17.2757617Z Temporarily overriding HOME='/home/runner/work/_temp/440e7bb4-623e-4d53-9bdc-b55c8ca6fe63' before making global git config changes2026-08-16T00:39:17.2762726Z Adding repository directory to the temporary git global config as a safe directory2026-08-16T00:39:17.2766209Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-16T00:39:17.2826517Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-16T00:39:17.2832827Z ##[group]Initializing the repository2026-08-16T00:39:17.2837881Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-16T00:39:17.2925969Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-16T00:39:17.2943271Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-16T00:39:17.2946002Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-16T00:39:17.2948124Z hint: call:2026-08-16T00:39:17.2949219Z hint:2026-08-16T00:39:17.2950780Z hint: git config --global init.defaultBranch <name>2026-08-16T00:39:17.2952633Z hint:2026-08-16T00:39:17.2954184Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-16T00:39:17.2956594Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-16T00:39:17.2958566Z hint:2026-08-16T00:39:17.2959844Z hint: git branch -m <name>2026-08-16T00:39:17.2961444Z hint:2026-08-16T00:39:17.2963166Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-16T00:39:17.2966330Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-16T00:39:17.2972241Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-16T00:39:17.2981352Z ##[endgroup]2026-08-16T00:39:17.2983427Z ##[group]Disabling automatic garbage collection2026-08-16T00:39:17.2985420Z [command]/usr/bin/git config --local gc.auto 02026-08-16T00:39:17.3021509Z ##[endgroup]2026-08-16T00:39:17.3023454Z ##[group]Setting up auth2026-08-16T00:39:17.3026051Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-16T00:39:17.3084685Z [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-16T00:39:17.3377819Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-16T00:39:17.3416665Z [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-16T00:39:17.3645253Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-16T00:39:17.3680774Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-16T00:39:17.3901298Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-16T00:39:17.3936111Z ##[endgroup]2026-08-16T00:39:17.3937190Z ##[group]Fetching the repository2026-08-16T00:39:17.3945427Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-16T00:39:17.9835145Z From https://github.com/mwestphall/k8s-integration-tests2026-08-16T00:39:17.9835995Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-16T00:39:17.9864834Z ##[endgroup]2026-08-16T00:39:17.9865368Z ##[group]Determining the checkout info2026-08-16T00:39:17.9867525Z ##[endgroup]2026-08-16T00:39:17.9874102Z [command]/usr/bin/git sparse-checkout disable2026-08-16T00:39:17.9917657Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-16T00:39:17.9950896Z ##[group]Checking out the ref2026-08-16T00:39:17.9955436Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-16T00:39:18.0032603Z Switched to a new branch 'main'2026-08-16T00:39:18.0035143Z branch 'main' set up to track 'origin/main'.2026-08-16T00:39:18.0040699Z ##[endgroup]2026-08-16T00:39:18.0121870Z [command]/usr/bin/git log -1 --format=%H2026-08-16T00:39:18.0149553Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-16T00:39:18.0417303Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-16T00:39:18.0418133Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-16T00:39:18.0418634Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-16T00:39:18.2017973Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-16T00:39:18.2018323Z env:2026-08-16T00:39:18.2018692Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-16T00:39:18.2019088Z SETUP_ENV_YAML: {}2026-08-16T00:39:18.2019265Z ##[endgroup]2026-08-16T00:39:18.3854044Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-16T00:39:18.3854567Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-16T00:39:18.3915234Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-16T00:39:18.3915517Z env:2026-08-16T00:39:18.3915871Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-16T00:39:18.3916280Z ##[endgroup]2026-08-16T00:39:18.4034369Z ##[group]Run true2026-08-16T00:39:18.4034559Z [36;1mtrue[0m2026-08-16T00:39:18.4088116Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-16T00:39:18.4088420Z ##[endgroup]2026-08-16T00:39:18.4220983Z ##[group]Run medyagh/setup-minikube@latest2026-08-16T00:39:18.4221223Z with:2026-08-16T00:39:18.4221374Z start: true2026-08-16T00:39:18.4221531Z cache: true2026-08-16T00:39:18.4221692Z minikube-version: latest2026-08-16T00:39:18.4221885Z wait: all2026-08-16T00:39:18.4222038Z ##[endgroup]2026-08-16T00:39:18.5255678Z (node:1868) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-16T00:39:18.5256414Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-16T00:39:19.2866218Z [command]/usr/bin/chmod +x /home/runner/work/_temp/2954da57-d9d7-44c3-a1b2-da2fe2e62b6e2026-08-16T00:39:20.1047730Z [command]/home/runner/bin/minikube version --short2026-08-16T00:39:20.1519542Z v1.38.12026-08-16T00:39:20.3683614Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-16T00:39:20.3768324Z (node:1868) [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-16T00:39:20.3774276Z Cache hit for: kic-v1.38.1-x642026-08-16T00:39:21.5949093Z Received 41943040 of 544082657 (7.7%), 40.0 MBs/sec2026-08-16T00:39:22.6011590Z Received 163577856 of 544082657 (30.1%), 78.0 MBs/sec2026-08-16T00:39:23.5992207Z Received 301989888 of 544082657 (55.5%), 95.9 MBs/sec2026-08-16T00:39:24.6055986Z Received 436207616 of 544082657 (80.2%), 103.8 MBs/sec2026-08-16T00:39:25.6034180Z Received 539888353 of 544082657 (99.2%), 102.8 MBs/sec2026-08-16T00:39:25.7026329Z Received 544082657 of 544082657 (100.0%), 101.6 MBs/sec2026-08-16T00:39:25.7027298Z Cache Size: ~519 MB (544082657 B)2026-08-16T00:39:25.7054571Z [command]/usr/bin/tar -xf /home/runner/work/_temp/250f7d5e-f52e-45f6-8d12-98d8c04fee3a/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-16T00:39:26.3892435Z Cache restored successfully2026-08-16T00:39:26.6605139Z Received 29360128 of 224218863 (13.1%), 28.0 MBs/sec2026-08-16T00:39:27.6606373Z Received 142606336 of 224218863 (63.6%), 68.0 MBs/sec2026-08-16T00:39:28.1700478Z Received 224218863 of 224218863 (100.0%), 85.2 MBs/sec2026-08-16T00:39:28.1701522Z Cache Size: ~214 MB (224218863 B)2026-08-16T00:39:28.1797253Z [command]/usr/bin/tar -xf /home/runner/work/_temp/330e7273-36c0-4695-b0f9-0618466ab12b/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-16T00:39:28.6045116Z Cache restored successfully2026-08-16T00:39:28.6475302Z [command]/home/runner/bin/minikube start --wait all2026-08-16T00:39:28.6934038Z * minikube v1.38.1 on Ubuntu 22.042026-08-16T00:39:30.1275383Z * Automatically selected the docker driver. Other choices: podman, ssh, none2026-08-16T00:39:30.1722905Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-16T00:39:30.1730507Z * Using Docker driver with root privileges2026-08-16T00:39:30.1741692Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-16T00:39:30.1783246Z * Pulling base image v0.0.50 ...2026-08-16T00:40:04.7863125Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-16T00:40:09.9163551Z * Verifying Kubernetes components...2026-08-16T00:40:09.9366022Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-16T00:40:10.4586317Z * Enabled addons: default-storageclass, storage-provisioner2026-08-16T00:40:48.3682143Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-16T00:40:48.5416662Z [command]/home/runner/bin/minikube version --short2026-08-16T00:40:48.5775812Z v1.38.12026-08-16T00:40:48.6035532Z ##[group]Run actions/setup-go@v62026-08-16T00:40:48.6035772Z with:2026-08-16T00:40:48.6035940Z go-version: 1.262026-08-16T00:40:48.6036108Z cache: true2026-08-16T00:40:48.6036291Z cache-dependency-path: go.sum2026-08-16T00:40:48.6036518Z check-latest: false2026-08-16T00:40:48.6038576Z token: ***2026-08-16T00:40:48.6038745Z ##[endgroup]2026-08-16T00:40:48.7141918Z Setup go version spec 1.262026-08-16T00:40:48.8166127Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-16T00:40:48.8168527Z Added go to the path2026-08-16T00:40:48.8171979Z Successfully set up Go version 1.262026-08-16T00:40:49.0438426Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-16T00:40:49.0468153Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-16T00:40:49.0493908Z /home/runner/go/pkg/mod2026-08-16T00:40:49.0516126Z /home/runner/.cache/go-build2026-08-16T00:40:49.2488834Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-16T00:40:50.5080395Z Received 46137344 of 251839808 (18.3%), 44.0 MBs/sec2026-08-16T00:40:51.5080539Z Received 180355072 of 251839808 (71.6%), 86.0 MBs/sec2026-08-16T00:40:51.9599407Z Received 251839808 of 251839808 (100.0%), 97.9 MBs/sec2026-08-16T00:40:51.9601199Z Cache Size: ~240 MB (251839808 B)2026-08-16T00:40:51.9658829Z [command]/usr/bin/tar -xf /home/runner/work/_temp/f4de574a-d8d1-4359-ab62-0d0d7f04df1f/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-16T00:40:54.3710684Z Cache restored successfully2026-08-16T00:40:54.4168481Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-16T00:40:54.4191764Z go version go1.26.5 linux/amd642026-08-16T00:40:54.4191949Z 2026-08-16T00:40:54.4192241Z ##[group]go env2026-08-16T00:40:54.5923633Z AR='ar'2026-08-16T00:40:54.5923936Z CC='gcc'2026-08-16T00:40:54.5924233Z CGO_CFLAGS='-O2 -g'2026-08-16T00:40:54.5924555Z CGO_CPPFLAGS=''2026-08-16T00:40:54.5924850Z CGO_CXXFLAGS='-O2 -g'2026-08-16T00:40:54.5925150Z CGO_ENABLED='1'2026-08-16T00:40:54.5925428Z CGO_FFLAGS='-O2 -g'2026-08-16T00:40:54.5926001Z CGO_LDFLAGS='-O2 -g'2026-08-16T00:40:54.5926276Z CXX='g++'2026-08-16T00:40:54.5926509Z GCCGO='gccgo'2026-08-16T00:40:54.5926745Z GO111MODULE=''2026-08-16T00:40:54.5926995Z GOAMD64='v1'2026-08-16T00:40:54.5927250Z GOARCH='amd64'2026-08-16T00:40:54.5927499Z GOAUTH='netrc'2026-08-16T00:40:54.5927732Z GOBIN=''2026-08-16T00:40:54.5928007Z GOCACHE='/home/runner/.cache/go-build'2026-08-16T00:40:54.5928345Z GOCACHEPROG=''2026-08-16T00:40:54.5928594Z GODEBUG=''2026-08-16T00:40:54.5928913Z GOENV='/home/runner/.config/go/env'2026-08-16T00:40:54.5929234Z GOEXE=''2026-08-16T00:40:54.5929474Z GOEXPERIMENT=''2026-08-16T00:40:54.5950804Z GOFIPS140='off'2026-08-16T00:40:54.5951152Z GOFLAGS=''2026-08-16T00:40:54.5952030Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build2707099709=/tmp/go-build -gno-record-gcc-switches'2026-08-16T00:40:54.5952894Z GOHOSTARCH='amd64'2026-08-16T00:40:54.5953174Z GOHOSTOS='linux'2026-08-16T00:40:54.5953456Z GOINSECURE=''2026-08-16T00:40:54.5953915Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-16T00:40:54.5954471Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-16T00:40:54.5954819Z GONOPROXY=''2026-08-16T00:40:54.5955074Z GONOSUMDB=''2026-08-16T00:40:54.5955332Z GOOS='linux'2026-08-16T00:40:54.5955599Z GOPATH='/home/runner/go'2026-08-16T00:40:54.5955904Z GOPRIVATE=''2026-08-16T00:40:54.5956249Z GOPROXY='https://proxy.golang.org,direct'2026-08-16T00:40:54.5956681Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-16T00:40:54.5957067Z GOSUMDB='sum.golang.org'2026-08-16T00:40:54.5957375Z GOTELEMETRY='local'2026-08-16T00:40:54.5957733Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-16T00:40:54.5958123Z GOTMPDIR=''2026-08-16T00:40:54.5958724Z GOTOOLCHAIN='local'2026-08-16T00:40:54.5959154Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-16T00:40:54.5959615Z GOVCS=''2026-08-16T00:40:54.5960054Z GOVERSION='go1.26.5'2026-08-16T00:40:54.5960341Z GOWORK=''2026-08-16T00:40:54.5960616Z PKG_CONFIG='pkg-config'2026-08-16T00:40:54.5960803Z 2026-08-16T00:40:54.5961229Z ##[endgroup]2026-08-16T00:40:54.6163370Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-16T00:40:54.6163857Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-16T00:40:54.6226678Z shell: /usr/bin/bash -e {0}2026-08-16T00:40:54.6226894Z env:2026-08-16T00:40:54.6227073Z GOTOOLCHAIN: local2026-08-16T00:40:54.6227275Z OSPOOL_EP_OSPoolEPTag: 25-release2026-08-16T00:40:54.6227510Z OSPOOL_EP_CMTag: 25.0-el92026-08-16T00:40:54.6227718Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-16T00:40:54.6227934Z ##[endgroup]2026-08-16T00:41:00.3395003Z === RUN TestOSPoolEP2026-08-16T00:41:00.3395532Z === PAUSE TestOSPoolEP2026-08-16T00:41:00.3395861Z === CONT TestOSPoolEP2026-08-16T00:41:00.3396744Z TestOSPoolEP 2026-08-16T00:41:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:00.3523127Z TestOSPoolEP 2026-08-16T00:41:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa apply -f /tmp/TestOSPoolEP374693119]2026-08-16T00:41:00.6979016Z TestOSPoolEP 2026-08-16T00:41:00Z logger.go:67: pod/idtoken-generator created2026-08-16T00:41:00.7120982Z TestOSPoolEP 2026-08-16T00:41:00Z logger.go:67: secret/pool-passwd created2026-08-16T00:41:00.7164877Z TestOSPoolEP 2026-08-16T00:41:00Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-16T00:41:00.7166096Z TestOSPoolEP 2026-08-16T00:41:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:00.7192480Z TestOSPoolEP 2026-08-16T00:41:00Z 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-16T00:41:10.7194415Z TestOSPoolEP 2026-08-16T00:41:10Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-16T00:41:10.7195714Z TestOSPoolEP 2026-08-16T00:41:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:10.7223863Z TestOSPoolEP 2026-08-16T00:41:10Z 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-16T00:41:20.7225078Z TestOSPoolEP 2026-08-16T00:41:20Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-16T00:41:20.7226090Z TestOSPoolEP 2026-08-16T00:41:20Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:20.7248644Z TestOSPoolEP 2026-08-16T00:41:20Z logger.go:67: Pod is now available2026-08-16T00:41:20.7250059Z TestOSPoolEP 2026-08-16T00:41:20Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-16T00:41:20.8435837Z TestOSPoolEP 2026-08-16T00:41:20Z logger.go:67: ***2026-08-16T00:41:20.8493431Z TestOSPoolEP 2026-08-16T00:41:20Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa apply -f /tmp/TestOSPoolEP4213319732]2026-08-16T00:41:21.0021993Z TestOSPoolEP 2026-08-16T00:41:21Z logger.go:67: secret/pool-token created2026-08-16T00:41:21.0058083Z TestOSPoolEP 2026-08-16T00:41:21Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-16T00:41:21.0059064Z TestOSPoolEP 2026-08-16T00:41:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:21.0074607Z TestOSPoolEP 2026-08-16T00:41:21Z logger.go:67: Secret is now available2026-08-16T00:41:21.0090495Z TestOSPoolEP 2026-08-16T00:41:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa apply -k /tmp/kustomize-template-4177592131]2026-08-16T00:41:21.2024545Z TestOSPoolEP 2026-08-16T00:41:21Z logger.go:67: service/test-cm created2026-08-16T00:41:21.2120334Z TestOSPoolEP 2026-08-16T00:41:21Z logger.go:67: deployment.apps/ospool-ep created2026-08-16T00:41:21.2126698Z TestOSPoolEP 2026-08-16T00:41:21Z 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-16T00:41:21.2240719Z TestOSPoolEP 2026-08-16T00:41:21Z logger.go:67: deployment.apps/test-cm created2026-08-16T00:41:21.2307623Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-16T00:41:21.2318852Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:21.2370497Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:21Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-16T00:41:21.2375685Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:21.2386164Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:21Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-16T00:41:21.2387762Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:21.2420329Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:21Z 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-16T00:41:21.2423942Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:21Z 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-16T00:41:31.2430275Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:31Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-16T00:41:31.2431580Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:31.2432842Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:31Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-16T00:41:31.2433902Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:31.2448860Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:31Z 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: ReplicaSetUpdated, message: ReplicaSet "test-cm-54b7d49f85" is progressing.. Sleeping for 10s and will try again.2026-08-16T00:41:31.2451770Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:31Z 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-16T00:41:41.2453350Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:41Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-16T00:41:41.2456289Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:41.2458827Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:41Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-16T00:41:41.2461079Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:41.2481791Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:41Z 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-16T00:41:41.2483548Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:41Z logger.go:67: Deployment is now available2026-08-16T00:41:51.2483380Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:51Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-16T00:41:51.2484273Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:51.2505343Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-16T00:41:51Z logger.go:67: Deployment is now available2026-08-16T00:41:51.2506123Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-16T00:41:51.2512122Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-16T00:41:51.2512831Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-16T00:41:51.2513562Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-16T00:41:51.2517760Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-16T00:41:51.2527460Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-16T00:41:51.2528266Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-16T00:41:51.2529376Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:41:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:51.2530771Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-16T00:41:51.2531995Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:41:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:51.2533292Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-16T00:41:51.2534578Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-16T00:41:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:51.2537119Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:41:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:51.2538465Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-16T00:41:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:51.2541889Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:41:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:41:51.2557360Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:41:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:41:51.2562175Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-16T00:41:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_SINGULARITY]2026-08-16T00:41:51.2565554Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:41:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)']2026-08-16T00:41:51.4321988Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-wbs7t failed. Retrying in 10s.2026-08-16T00:41:51.4619851Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-16T00:41:51.4622129Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wbs7t failed. Retrying in 30s.2026-08-16T00:41:51.4628480Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-16T00:41:51.4629276Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)']' in pod test-cm-54b7d49f85-wbs7t failed. Retrying in 10s.2026-08-16T00:42:01.4325579Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-16T00:42:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_SINGULARITY]2026-08-16T00:42:01.4639764Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:42:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)']2026-08-16T00:42:01.6344912Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-16T00:42:01.6346851Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-wbs7t failed. Retrying in 10s.2026-08-16T00:42:01.6741507Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-16T00:42:01.6742822Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)']' in pod test-cm-54b7d49f85-wbs7t failed. Retrying in 10s.2026-08-16T00:42:11.6354527Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-16T00:42:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_SINGULARITY]2026-08-16T00:42:11.6748159Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:42:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)']2026-08-16T00:42:11.7835632Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-16T00:42:11Z logger.go:67: true2026-08-16T00:42:11.8226889Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:42:11Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-16T00:42:11.8227975Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:42:11Z logger.go:67: 2026-08-16T00:42:11.8229309Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:42:11Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-sx66t LINUX X86_64 Unclaimed Idle 0.000 15988 0+00:00:002026-08-16T00:42:11.8230710Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:42:11Z logger.go:67: 2026-08-16T00:42:11.8231803Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:42:11Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-16T00:42:11.8233225Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:42:11Z logger.go:67: 2026-08-16T00:42:11.8234249Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:42:11Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-16T00:42:11.8235200Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:42:11Z logger.go:67: 2026-08-16T00:42:11.8236054Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-16T00:42:11Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-16T00:42:21.4621606Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:42:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:42:21.5820368Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:42:21Z logger.go:67: undefined2026-08-16T00:42:21.5871321Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-16T00:42:21.5872298Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wbs7t failed. Retrying in 30s.2026-08-16T00:42:51.5880277Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:42:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:42:51.7064633Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:42:51Z logger.go:67: undefined2026-08-16T00:42:51.7114661Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wbs7t failed. Retrying in 30s.2026-08-16T00:43:21.7118307Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:43:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:43:21.8361167Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:43:21Z logger.go:67: undefined2026-08-16T00:43:21.8414525Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wbs7t failed. Retrying in 30s.2026-08-16T00:43:51.8426051Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:43:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:43:51.9653676Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:43:51Z logger.go:67: undefined2026-08-16T00:43:51.9706405Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wbs7t failed. Retrying in 30s.2026-08-16T00:44:21.9713684Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:44:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:44:22.0937898Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:44:22Z logger.go:67: undefined2026-08-16T00:44:22.0993036Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wbs7t failed. Retrying in 30s.2026-08-16T00:44:52.0994345Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:44:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:44:52.2190171Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:44:52Z logger.go:67: undefined2026-08-16T00:44:52.2245160Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wbs7t failed. Retrying in 30s.2026-08-16T00:45:22.2249404Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:45:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:45:22.3468676Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:45:22Z logger.go:67: undefined2026-08-16T00:45:22.3522027Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wbs7t failed. Retrying in 30s.2026-08-16T00:45:52.3536277Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:45:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:45:52.4719703Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:45:52Z logger.go:67: undefined2026-08-16T00:45:52.4772113Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wbs7t failed. Retrying in 30s.2026-08-16T00:46:22.4784696Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:46:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:46:22.6000487Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:46:22Z logger.go:67: undefined2026-08-16T00:46:22.6053146Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wbs7t failed. Retrying in 30s.2026-08-16T00:46:52.6077214Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:46:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:46:52.7296566Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:46:52Z logger.go:67: undefined2026-08-16T00:46:52.7347991Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-wbs7t failed. Retrying in 30s.2026-08-16T00:47:22.7353077Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:47:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa exec test-cm-54b7d49f85-wbs7t -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sx66t",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-16T00:47:22.8774549Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-16T00:47:22Z logger.go:67: true2026-08-16T00:47:22.8831487Z TestOSPoolEP 2026-08-16T00:47:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:47:22.8892695Z TestOSPoolEP 2026-08-16T00:47:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:47:23.0027813Z TestOSPoolEP 2026-08-16T00:47:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:47:23.1286804Z TestOSPoolEP 2026-08-16T00:47:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:47:23.2206856Z TestOSPoolEP 2026-08-16T00:47:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:47:23.2231741Z === NAME TestOSPoolEP2026-08-16T00:47:23.2232349Z ospool_ep_test.go:101: ---2026-08-16T00:47:23.2232808Z Events for pod idtoken-generator:2026-08-16T00:47:23.2233794Z 2026-08-16 00:41:00 +0000 UTC Normal Successfully assigned test-ospool-ep-2q8voa/idtoken-generator to minikube2026-08-16T00:47:23.2234699Z 2026-08-16 00:41:06 +0000 UTC Normal Pulling image "htcondor/base"2026-08-16T00:47:23.2235965Z 2026-08-16 00:41:16 +0000 UTC Normal Successfully pulled image "htcondor/base" in 10.036s (10.036s including waiting). Image size: 560910730 bytes.2026-08-16T00:47:23.2236965Z 2026-08-16 00:41:16 +0000 UTC Normal Container created2026-08-16T00:47:23.2237563Z 2026-08-16 00:41:17 +0000 UTC Normal Container started2026-08-16T00:47:23.2237985Z 2026-08-16T00:47:23.2238249Z ---2026-08-16T00:47:23.2238962Z TestOSPoolEP 2026-08-16T00:47:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:47:23.2261149Z ospool_ep_test.go:101: ---2026-08-16T00:47:23.2262244Z Events for pod ospool-ep-6c7d796845-sx66t:2026-08-16T00:47:23.2263363Z 2026-08-16 00:41:21 +0000 UTC Normal Successfully assigned test-ospool-ep-2q8voa/ospool-ep-6c7d796845-sx66t to minikube2026-08-16T00:47:23.2264533Z 2026-08-16 00:41:21 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-16T00:47:23.2266066Z 2026-08-16 00:41:24 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 2.513s (2.513s including waiting). Image size: 5590942 bytes.2026-08-16T00:47:23.2267174Z 2026-08-16 00:41:24 +0000 UTC Normal Container created2026-08-16T00:47:23.2267802Z 2026-08-16 00:41:24 +0000 UTC Normal Container started2026-08-16T00:47:23.2268672Z 2026-08-16 00:41:24 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-08-16T00:47:23.2270439Z 2026-08-16 00:41:49 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 18.61s (24.983s including waiting). Image size: 1273000231 bytes.2026-08-16T00:47:23.2271254Z 2026-08-16 00:41:49 +0000 UTC Normal Container created2026-08-16T00:47:23.2271631Z 2026-08-16 00:41:49 +0000 UTC Normal Container started2026-08-16T00:47:23.2271884Z 2026-08-16T00:47:23.2272059Z ---2026-08-16T00:47:23.2272502Z TestOSPoolEP 2026-08-16T00:47:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:47:23.2286770Z ospool_ep_test.go:101: ---2026-08-16T00:47:23.2287750Z Events for pod test-cm-54b7d49f85-wbs7t:2026-08-16T00:47:23.2297139Z 2026-08-16 00:41:21 +0000 UTC Normal Successfully assigned test-ospool-ep-2q8voa/test-cm-54b7d49f85-wbs7t to minikube2026-08-16T00:47:23.2298380Z 2026-08-16 00:41:21 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-08-16T00:47:23.2299669Z 2026-08-16 00:41:30 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 6.583s (9.084s including waiting). Image size: 573055668 bytes.2026-08-16T00:47:23.2301017Z 2026-08-16 00:41:30 +0000 UTC Normal Container created2026-08-16T00:47:23.2301648Z 2026-08-16 00:41:30 +0000 UTC Normal Container started2026-08-16T00:47:23.2302059Z 2026-08-16T00:47:23.2302324Z ---2026-08-16T00:47:23.2303161Z TestOSPoolEP 2026-08-16T00:47:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-16T00:47:23.2330683Z TestOSPoolEP 2026-08-16T00:47:23Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa delete -f /tmp/TestOSPoolEP63733691]2026-08-16T00:47:23.3168982Z TestOSPoolEP 2026-08-16T00:47:23Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-2q8voa namespace2026-08-16T00:47:23.3221159Z TestOSPoolEP 2026-08-16T00:47:23Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-2q8voa namespace2026-08-16T00:47:24.0836868Z TestOSPoolEP 2026-08-16T00:47:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa delete -f /tmp/TestOSPoolEP94201628]2026-08-16T00:47:24.1651451Z TestOSPoolEP 2026-08-16T00:47:24Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-2q8voa namespace2026-08-16T00:47:24.1704483Z TestOSPoolEP 2026-08-16T00:47:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-2q8voa delete -k /tmp/kustomize-template-4177592131]2026-08-16T00:47:24.2752920Z TestOSPoolEP 2026-08-16T00:47:24Z logger.go:67: service "test-cm" deleted from test-ospool-ep-2q8voa namespace2026-08-16T00:47:24.2794094Z TestOSPoolEP 2026-08-16T00:47:24Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-2q8voa namespace2026-08-16T00:47:24.2832641Z TestOSPoolEP 2026-08-16T00:47:24Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-2q8voa namespace2026-08-16T00:47:24.2925335Z --- PASS: TestOSPoolEP (52.32s)2026-08-16T00:47:24.2946692Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.02s)2026-08-16T00:47:24.2948605Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.54s)2026-08-16T00:47:24.2949813Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.58s)2026-08-16T00:47:24.2950865Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (331.63s)2026-08-16T00:47:24.2951339Z PASS2026-08-16T00:47:24.2970232Z ok github.com/osg-htc/k8s-integration-tests/test 383.969s2026-08-16T00:47:24.3971171Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-16T00:47:24.3971990Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-16T00:47:24.4075941Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-16T00:47:24.4076358Z env:2026-08-16T00:47:24.4076618Z GOTOOLCHAIN: local2026-08-16T00:47:24.4077146Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-16T00:47:24.4077848Z ##[endgroup]2026-08-16T00:47:24.4363092Z 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-16T00:47:24.4364621Z ##[group]Run actions/upload-artifact@v42026-08-16T00:47:24.4364961Z with:2026-08-16T00:47:24.4365423Z name: TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce72322026-08-16T00:47:24.4365985Z path: /tmp/k8s-tests2026-08-16T00:47:24.4366268Z retention-days: 52026-08-16T00:47:24.4366544Z if-no-files-found: warn2026-08-16T00:47:24.4366823Z compression-level: 62026-08-16T00:47:24.4367236Z overwrite: false2026-08-16T00:47:24.4367685Z include-hidden-files: false2026-08-16T00:47:24.4368256Z env:2026-08-16T00:47:24.4368667Z GOTOOLCHAIN: local2026-08-16T00:47:24.4369070Z ##[endgroup]2026-08-16T00:47:24.6343412Z (node:17754) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-16T00:47:24.6361847Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-16T00:47:24.6475176Z With the provided path, there will be 6 files uploaded2026-08-16T00:47:24.6476167Z Artifact name is valid!2026-08-16T00:47:24.6476762Z Root directory input is valid!2026-08-16T00:47:24.9309560Z Beginning upload of artifact content to blob storage2026-08-16T00:47:24.9526607Z (node:17754) [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-16T00:47:25.2226879Z Uploaded bytes 141222026-08-16T00:47:25.2819037Z Finished uploading artifact content to blob storage!2026-08-16T00:47:25.2819743Z SHA256 digest of uploaded artifact zip is 2b29e500ceaf96e81e4585d9c5c80bad87aba4ee6ddac312b52b36d6815f48712026-08-16T00:47:25.2821362Z Finalizing artifact upload2026-08-16T00:47:25.4690125Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232.zip successfully finalized. Artifact ID 92555020112026-08-16T00:47:25.4691664Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232 has been successfully uploaded! Final size is 14122 bytes. Artifact ID is 92555020112026-08-16T00:47:25.4695635Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/31917732211/artifacts/92555020112026-08-16T00:47:25.4852581Z Post job cleanup.2026-08-16T00:47:25.5901321Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-16T00:47:25.5925686Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-16T00:47:25.5950362Z /home/runner/go/pkg/mod2026-08-16T00:47:25.5981278Z /home/runner/.cache/go-build2026-08-16T00:47:25.5982400Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-16T00:47:25.6146941Z Post job cleanup.2026-08-16T00:47:25.6897127Z [command]/usr/bin/git version2026-08-16T00:47:25.6936009Z git version 2.54.02026-08-16T00:47:25.6967885Z Temporarily overriding HOME='/home/runner/work/_temp/23a97507-4345-49ba-a809-089577e73b7c' before making global git config changes2026-08-16T00:47:25.6968972Z Adding repository directory to the temporary git global config as a safe directory2026-08-16T00:47:25.6972955Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-16T00:47:25.7009313Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-16T00:47:25.7044379Z [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-16T00:47:25.7309047Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-16T00:47:25.7337385Z http.https://github.com/.extraheader2026-08-16T00:47:25.7347986Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-16T00:47:25.7379348Z [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-16T00:47:25.7625098Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-16T00:47:25.7663241Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-16T00:47:25.8038272Z Cleaning up orphan processes2026-08-16T00:47:25.8624772Z ##[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/