2026-08-13T01:03:43.2881956Z Current runner version: '2.336.0'2026-08-13T01:03:43.2918008Z ##[group]Runner Image Provisioner2026-08-13T01:03:43.2919436Z Hosted Compute Agent2026-08-13T01:03:43.2920386Z Version: 20260729.5662026-08-13T01:03:43.2921392Z Commit: cf7153fe6e25b664e8693c24944bf2b00355d1092026-08-13T01:03:43.2922689Z Build Date: 2026-07-29T19:17:02Z2026-08-13T01:03:43.2923782Z Worker ID: {0d37a084-92d6-48f8-89b2-25076d9b3201}2026-08-13T01:03:43.2924877Z Azure Region: eastus22026-08-13T01:03:43.2926250Z ##[endgroup]2026-08-13T01:03:43.2928512Z ##[group]Operating System2026-08-13T01:03:43.2929629Z Ubuntu2026-08-13T01:03:43.2930457Z 22.04.52026-08-13T01:03:43.2931204Z LTS2026-08-13T01:03:43.2932138Z ##[endgroup]2026-08-13T01:03:43.2933015Z ##[group]Runner Image2026-08-13T01:03:43.2934052Z Image: ubuntu-22.042026-08-13T01:03:43.2934958Z Version: 20260810.260.12026-08-13T01:03:43.2937919Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260810.260/images/ubuntu/Ubuntu2204-Readme.md2026-08-13T01:03:43.2940453Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260810.2602026-08-13T01:03:43.2942168Z ##[endgroup]2026-08-13T01:03:43.2944035Z ##[group]GITHUB_TOKEN Permissions2026-08-13T01:03:43.2947354Z Contents: read2026-08-13T01:03:43.2948262Z Metadata: read2026-08-13T01:03:43.2949289Z Packages: read2026-08-13T01:03:43.2950134Z ##[endgroup]2026-08-13T01:03:43.2953116Z Secret source: Actions2026-08-13T01:03:43.2955146Z Prepare workflow directory2026-08-13T01:03:43.3425843Z Prepare all required actions2026-08-13T01:03:43.3495767Z Getting action download info2026-08-13T01:03:43.5107394Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-13T01:03:43.5871829Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-13T01:03:43.7420503Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-13T01:03:43.9162885Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-13T01:03:44.2441425Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-13T01:03:44.2448016Z ##[group] Inputs2026-08-13T01:03:44.2448633Z testName: TestOSPoolEP2026-08-13T01:03:44.2450019Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-13T01:03:44.2451534Z setupScript: 2026-08-13T01:03:44.2452024Z setupEnv: {}2026-08-13T01:03:44.2452496Z ##[endgroup]2026-08-13T01:03:44.2453444Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-testing) / Run Tests2026-08-13T01:03:44.3282413Z ##[group]Run actions/checkout@v52026-08-13T01:03:44.3283505Z with:2026-08-13T01:03:44.3284075Z repository: mwestphall/k8s-integration-tests2026-08-13T01:03:44.3292932Z token: ***2026-08-13T01:03:44.3293436Z ssh-strict: true2026-08-13T01:03:44.3293975Z ssh-user: git2026-08-13T01:03:44.3294500Z persist-credentials: true2026-08-13T01:03:44.3295119Z clean: true2026-08-13T01:03:44.3295633Z sparse-checkout-cone-mode: true2026-08-13T01:03:44.3296408Z fetch-depth: 12026-08-13T01:03:44.3296916Z fetch-tags: false2026-08-13T01:03:44.3297437Z show-progress: true2026-08-13T01:03:44.3297966Z lfs: false2026-08-13T01:03:44.3298426Z submodules: false2026-08-13T01:03:44.3298943Z set-safe-directory: true2026-08-13T01:03:44.3299568Z allow-unsafe-pr-checkout: false2026-08-13T01:03:44.3300482Z ##[endgroup]2026-08-13T01:03:44.4397691Z Syncing repository: mwestphall/k8s-integration-tests2026-08-13T01:03:44.4400697Z ##[group]Getting Git version info2026-08-13T01:03:44.4402462Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-13T01:03:44.4404489Z [command]/usr/bin/git version2026-08-13T01:03:44.4454715Z git version 2.54.02026-08-13T01:03:44.4477861Z ##[endgroup]2026-08-13T01:03:44.4494568Z Temporarily overriding HOME='/home/runner/work/_temp/14d24091-e5b9-4ecd-bc10-2d77212ae17b' before making global git config changes2026-08-13T01:03:44.4497376Z Adding repository directory to the temporary git global config as a safe directory2026-08-13T01:03:44.4500845Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-13T01:03:44.4543526Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-13T01:03:44.4547503Z ##[group]Initializing the repository2026-08-13T01:03:44.4553878Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-13T01:03:44.4639488Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-13T01:03:44.4642095Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-13T01:03:44.4644495Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-13T01:03:44.4645807Z hint: call:2026-08-13T01:03:44.4647016Z hint:2026-08-13T01:03:44.4647803Z hint: git config --global init.defaultBranch <name>2026-08-13T01:03:44.4648825Z hint:2026-08-13T01:03:44.4650829Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-13T01:03:44.4652480Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-13T01:03:44.4653743Z hint:2026-08-13T01:03:44.4654359Z hint: git branch -m <name>2026-08-13T01:03:44.4655135Z hint:2026-08-13T01:03:44.4656453Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-13T01:03:44.4659987Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-13T01:03:44.4663618Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-13T01:03:44.4701285Z ##[endgroup]2026-08-13T01:03:44.4702236Z ##[group]Disabling automatic garbage collection2026-08-13T01:03:44.4705421Z [command]/usr/bin/git config --local gc.auto 02026-08-13T01:03:44.4743394Z ##[endgroup]2026-08-13T01:03:44.4744249Z ##[group]Setting up auth2026-08-13T01:03:44.4751689Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-13T01:03:44.4789457Z [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-13T01:03:44.5167963Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-13T01:03:44.5210841Z [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-13T01:03:44.5509726Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-13T01:03:44.5553988Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-13T01:03:44.5834271Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-13T01:03:44.5879056Z ##[endgroup]2026-08-13T01:03:44.5881088Z ##[group]Fetching the repository2026-08-13T01:03:44.5890101Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-13T01:03:44.8492308Z From https://github.com/mwestphall/k8s-integration-tests2026-08-13T01:03:44.8493455Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-13T01:03:44.8521154Z ##[endgroup]2026-08-13T01:03:44.8521905Z ##[group]Determining the checkout info2026-08-13T01:03:44.8524049Z ##[endgroup]2026-08-13T01:03:44.8529963Z [command]/usr/bin/git sparse-checkout disable2026-08-13T01:03:44.8581064Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-13T01:03:44.8618378Z ##[group]Checking out the ref2026-08-13T01:03:44.8622632Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-13T01:03:44.8720311Z Switched to a new branch 'main'2026-08-13T01:03:44.8723545Z branch 'main' set up to track 'origin/main'.2026-08-13T01:03:44.8729508Z ##[endgroup]2026-08-13T01:03:44.8782252Z [command]/usr/bin/git log -1 --format=%H2026-08-13T01:03:44.8814935Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-13T01:03:44.9052617Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-13T01:03:44.9053396Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-13T01:03:44.9054045Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-13T01:03:44.9356610Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-13T01:03:44.9357077Z env:2026-08-13T01:03:44.9357558Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-13T01:03:44.9358088Z SETUP_ENV_YAML: {}2026-08-13T01:03:44.9358352Z ##[endgroup]2026-08-13T01:03:45.7261373Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-13T01:03:45.7262080Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-13T01:03:45.7339425Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-13T01:03:45.7339841Z env:2026-08-13T01:03:45.7340353Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-13T01:03:45.7340919Z ##[endgroup]2026-08-13T01:03:45.7500191Z ##[group]Run true2026-08-13T01:03:45.7500486Z [36;1mtrue[0m2026-08-13T01:03:45.7571738Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-13T01:03:45.7572177Z ##[endgroup]2026-08-13T01:03:45.7753896Z ##[group]Run medyagh/setup-minikube@latest2026-08-13T01:03:45.7754256Z with:2026-08-13T01:03:45.7754497Z start: true2026-08-13T01:03:45.7754738Z cache: true2026-08-13T01:03:45.7754980Z minikube-version: latest2026-08-13T01:03:45.7755260Z wait: all2026-08-13T01:03:45.7755494Z ##[endgroup]2026-08-13T01:03:45.9114916Z (node:1855) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-13T01:03:45.9116084Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-13T01:03:47.2237281Z [command]/usr/bin/chmod +x /home/runner/work/_temp/01052730-2ed2-4ad7-ac67-633eca9b329c2026-08-13T01:03:47.3885061Z [command]/home/runner/bin/minikube version --short2026-08-13T01:03:47.4447986Z v1.38.12026-08-13T01:03:47.5234542Z Cache hit for: kic-v1.38.1-x642026-08-13T01:03:47.5351680Z (node:1855) [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-13T01:03:47.5359162Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-13T01:03:48.5807038Z Received 134217728 of 224218863 (59.9%), 127.9 MBs/sec2026-08-13T01:03:48.6877149Z Received 134217728 of 544082657 (24.7%), 117.9 MBs/sec2026-08-13T01:03:49.1816174Z Received 224218863 of 224218863 (100.0%), 133.6 MBs/sec2026-08-13T01:03:49.1817288Z Cache Size: ~214 MB (224218863 B)2026-08-13T01:03:49.2400797Z [command]/usr/bin/tar -xf /home/runner/work/_temp/40867775-b477-4c2e-a3f9-0e8ba3943543/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-13T01:03:49.6987823Z Received 281018368 of 544082657 (51.6%), 127.6 MBs/sec2026-08-13T01:03:49.8776586Z Cache restored successfully2026-08-13T01:03:50.7022583Z Received 520093696 of 544082657 (95.6%), 159.8 MBs/sec2026-08-13T01:03:50.9449262Z Received 544082657 of 544082657 (100.0%), 155.0 MBs/sec2026-08-13T01:03:50.9450353Z Cache Size: ~519 MB (544082657 B)2026-08-13T01:03:50.9572758Z [command]/usr/bin/tar -xf /home/runner/work/_temp/236dca55-8ad1-4fa1-aaca-5940cd79e105/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-13T01:03:51.8837143Z Cache restored successfully2026-08-13T01:03:52.0092308Z [command]/home/runner/bin/minikube start --wait all2026-08-13T01:03:52.0567716Z * minikube v1.38.1 on Ubuntu 22.042026-08-13T01:03:55.2524691Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-13T01:03:55.3103800Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-13T01:03:55.3111601Z * Using Docker driver with root privileges2026-08-13T01:03:55.3119935Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-13T01:03:55.3127886Z * Pulling base image v0.0.50 ...2026-08-13T01:04:25.4730974Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-13T01:04:30.6453511Z * Verifying Kubernetes components...2026-08-13T01:04:30.6720678Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-13T01:04:31.3311829Z * Enabled addons: storage-provisioner, default-storageclass2026-08-13T01:05:16.1654438Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-13T01:05:16.1838710Z [command]/home/runner/bin/minikube version --short2026-08-13T01:05:16.2416670Z v1.38.12026-08-13T01:05:16.2779818Z ##[group]Run actions/setup-go@v62026-08-13T01:05:16.2780103Z with:2026-08-13T01:05:16.2780304Z go-version: 1.262026-08-13T01:05:16.2780515Z cache: true2026-08-13T01:05:16.2780738Z cache-dependency-path: go.sum2026-08-13T01:05:16.2781008Z check-latest: false2026-08-13T01:05:16.2783637Z token: ***2026-08-13T01:05:16.2783862Z ##[endgroup]2026-08-13T01:05:16.4203065Z Setup go version spec 1.262026-08-13T01:05:16.4255652Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-13T01:05:16.4258418Z Added go to the path2026-08-13T01:05:16.4262169Z Successfully set up Go version 1.262026-08-13T01:05:16.9755798Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-13T01:05:16.9804792Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-13T01:05:16.9843289Z /home/runner/go/pkg/mod2026-08-13T01:05:16.9870906Z /home/runner/.cache/go-build2026-08-13T01:05:17.0740165Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-13T01:05:18.1345728Z Received 171966464 of 251839808 (68.3%), 162.4 MBs/sec2026-08-13T01:05:18.4992187Z Received 251839808 of 251839808 (100.0%), 174.7 MBs/sec2026-08-13T01:05:18.4993793Z Cache Size: ~240 MB (251839808 B)2026-08-13T01:05:18.5062128Z [command]/usr/bin/tar -xf /home/runner/work/_temp/36019e41-a2cf-463a-8351-0358791dd5cc/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-13T01:05:21.6547863Z Cache restored successfully2026-08-13T01:05:21.7179158Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-13T01:05:21.7204626Z go version go1.26.5 linux/amd642026-08-13T01:05:21.7204847Z 2026-08-13T01:05:21.7205182Z ##[group]go env2026-08-13T01:05:21.8059803Z AR='ar'2026-08-13T01:05:21.8060135Z CC='gcc'2026-08-13T01:05:21.8060442Z CGO_CFLAGS='-O2 -g'2026-08-13T01:05:21.8061049Z CGO_CPPFLAGS=''2026-08-13T01:05:21.8061410Z CGO_CXXFLAGS='-O2 -g'2026-08-13T01:05:21.8061790Z CGO_ENABLED='1'2026-08-13T01:05:21.8062205Z CGO_FFLAGS='-O2 -g'2026-08-13T01:05:21.8062535Z CGO_LDFLAGS='-O2 -g'2026-08-13T01:05:21.8062865Z CXX='g++'2026-08-13T01:05:21.8063193Z GCCGO='gccgo'2026-08-13T01:05:21.8063528Z GO111MODULE=''2026-08-13T01:05:21.8063974Z GOAMD64='v1'2026-08-13T01:05:21.8064314Z GOARCH='amd64'2026-08-13T01:05:21.8065121Z GOAUTH='netrc'2026-08-13T01:05:21.8065647Z GOBIN=''2026-08-13T01:05:21.8066067Z GOCACHE='/home/runner/.cache/go-build'2026-08-13T01:05:21.8066435Z GOCACHEPROG=''2026-08-13T01:05:21.8066658Z GODEBUG=''2026-08-13T01:05:21.8066912Z GOENV='/home/runner/.config/go/env'2026-08-13T01:05:21.8067192Z GOEXE=''2026-08-13T01:05:21.8067395Z GOEXPERIMENT=''2026-08-13T01:05:21.8067608Z GOFIPS140='off'2026-08-13T01:05:21.8067815Z GOFLAGS=''2026-08-13T01:05:21.8068617Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build2399634097=/tmp/go-build -gno-record-gcc-switches'2026-08-13T01:05:21.8069316Z GOHOSTARCH='amd64'2026-08-13T01:05:21.8091570Z GOHOSTOS='linux'2026-08-13T01:05:21.8091936Z GOINSECURE=''2026-08-13T01:05:21.8092347Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-13T01:05:21.8092787Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-13T01:05:21.8093070Z GONOPROXY=''2026-08-13T01:05:21.8093290Z GONOSUMDB=''2026-08-13T01:05:21.8093516Z GOOS='linux'2026-08-13T01:05:21.8093742Z GOPATH='/home/runner/go'2026-08-13T01:05:21.8093990Z GOPRIVATE=''2026-08-13T01:05:21.8094293Z GOPROXY='https://proxy.golang.org,direct'2026-08-13T01:05:21.8094652Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-13T01:05:21.8094963Z GOSUMDB='sum.golang.org'2026-08-13T01:05:21.8095323Z GOTELEMETRY='local'2026-08-13T01:05:21.8095748Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-13T01:05:21.8096328Z GOTMPDIR=''2026-08-13T01:05:21.8096544Z GOTOOLCHAIN='local'2026-08-13T01:05:21.8097222Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-13T01:05:21.8097634Z GOVCS=''2026-08-13T01:05:21.8097843Z GOVERSION='go1.26.5'2026-08-13T01:05:21.8098073Z GOWORK=''2026-08-13T01:05:21.8098289Z PKG_CONFIG='pkg-config'2026-08-13T01:05:21.8098447Z 2026-08-13T01:05:21.8098829Z ##[endgroup]2026-08-13T01:05:21.8356821Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-13T01:05:21.8357344Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-13T01:05:21.8433485Z shell: /usr/bin/bash -e {0}2026-08-13T01:05:21.8433759Z env:2026-08-13T01:05:21.8433978Z GOTOOLCHAIN: local2026-08-13T01:05:21.8434243Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-08-13T01:05:21.8434537Z OSPOOL_EP_CMTag: 25.x-el92026-08-13T01:05:21.8434790Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-13T01:05:21.8435053Z ##[endgroup]2026-08-13T01:05:28.7738648Z === RUN TestOSPoolEP2026-08-13T01:05:28.7743273Z === PAUSE TestOSPoolEP2026-08-13T01:05:28.7743698Z === CONT TestOSPoolEP2026-08-13T01:05:28.7744742Z TestOSPoolEP 2026-08-13T01:05:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:05:28.8028361Z TestOSPoolEP 2026-08-13T01:05:28Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict apply -f /tmp/TestOSPoolEP1432427718]2026-08-13T01:05:29.5302580Z TestOSPoolEP 2026-08-13T01:05:29Z logger.go:67: pod/idtoken-generator created2026-08-13T01:05:29.5368369Z TestOSPoolEP 2026-08-13T01:05:29Z logger.go:67: secret/pool-passwd created2026-08-13T01:05:29.5444970Z TestOSPoolEP 2026-08-13T01:05:29Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-13T01:05:29.5448180Z TestOSPoolEP 2026-08-13T01:05:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:05:29.5464865Z TestOSPoolEP 2026-08-13T01:05:29Z retry.go:103: Wait for pod idtoken-generator to be provisioned. returned an error: Pod idtoken-generator is not available, reason: , message: . Sleeping for 10s and will try again.2026-08-13T01:05:39.5473328Z TestOSPoolEP 2026-08-13T01:05:39Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-13T01:05:39.5474798Z TestOSPoolEP 2026-08-13T01:05:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:05:39.5498083Z TestOSPoolEP 2026-08-13T01:05:39Z logger.go:67: Pod is now available2026-08-13T01:05:39.5500003Z TestOSPoolEP 2026-08-13T01:05:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-13T01:05:40.0791354Z TestOSPoolEP 2026-08-13T01:05:40Z logger.go:67: ***2026-08-13T01:05:40.0867943Z TestOSPoolEP 2026-08-13T01:05:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict apply -f /tmp/TestOSPoolEP2356108042]2026-08-13T01:05:40.2791283Z TestOSPoolEP 2026-08-13T01:05:40Z logger.go:67: secret/pool-token created2026-08-13T01:05:40.2833927Z TestOSPoolEP 2026-08-13T01:05:40Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-13T01:05:40.2835242Z TestOSPoolEP 2026-08-13T01:05:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:05:40.2855193Z TestOSPoolEP 2026-08-13T01:05:40Z logger.go:67: Secret is now available2026-08-13T01:05:40.2886824Z TestOSPoolEP 2026-08-13T01:05:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict apply -k /tmp/kustomize-template-945579396]2026-08-13T01:05:40.5563617Z TestOSPoolEP 2026-08-13T01:05:40Z logger.go:67: service/test-cm created2026-08-13T01:05:40.5653465Z TestOSPoolEP 2026-08-13T01:05:40Z logger.go:67: Warning: spec.template.spec.containers[0].env[8]: hides previous definition of "OSG_SQUID_LOCATION", which may be dropped when using apply2026-08-13T01:05:40.5673006Z TestOSPoolEP 2026-08-13T01:05:40Z logger.go:67: deployment.apps/ospool-ep created2026-08-13T01:05:40.5790145Z TestOSPoolEP 2026-08-13T01:05:40Z logger.go:67: deployment.apps/test-cm created2026-08-13T01:05:40.5851840Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-13T01:05:40.5854001Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-13T01:05:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:05:40.6123077Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-13T01:05:40Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-13T01:05:40.6125410Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-13T01:05:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:05:40.6127973Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-13T01:05:40Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-13T01:05:40.6129954Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-13T01:05:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:05:40.6180430Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-13T01:05:40Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "test-cm-5bb545475c". Sleeping for 10s and will try again.2026-08-13T01:05:40.6185358Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-13T01:05:40Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-65c844ddbb". Sleeping for 10s and will try again.2026-08-13T01:05:50.6190316Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-13T01:05:50Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-13T01:05:50.6200926Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-13T01:05:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:05:50.6202437Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-13T01:05:50Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-13T01:05:50.6205835Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-13T01:05:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:05:50.6227653Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-13T01:05:50Z logger.go:67: Deployment is now available2026-08-13T01:05:50.6240342Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-13T01:05:50Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-65c844ddbb" is progressing.. Sleeping for 10s and will try again.2026-08-13T01:06:00.6251564Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-13T01:06:00Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-13T01:06:00.6253557Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-13T01:06:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:06:00.6308031Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-13T01:06:00Z logger.go:67: Deployment is now available2026-08-13T01:06:00.6309135Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-13T01:06:00.6310037Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-13T01:06:00.6313340Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-13T01:06:00.6320703Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-13T01:06:00.6322042Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-13T01:06:00.6323151Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-13T01:06:00.6324442Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-13T01:06:00.6325838Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-13T01:06:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:06:00.6327745Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-13T01:06:00.6330362Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:06:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:06:00.6331723Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-13T01:06:00.6333514Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-13T01:06:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:06:00.6358379Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-13T01:06:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:06:00.6361271Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:06:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:06:00.6373582Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-13T01:06:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:06:00.6402575Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:06:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-13T01:06:00.6427847Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-13T01:06:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)']2026-08-13T01:06:00.6446213Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-13T01:06:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_SINGULARITY]2026-08-13T01:06:00.9368837Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-kvwzt failed. Retrying in 10s.2026-08-13T01:06:00.9441472Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-13T01:06:00.9444015Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-kvwzt failed. Retrying in 30s.2026-08-13T01:06:00.9553584Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-13T01:06:00.9556553Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)']' in pod test-cm-5bb545475c-kvwzt failed. Retrying in 10s.2026-08-13T01:06:10.9381942Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-13T01:06:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_SINGULARITY]2026-08-13T01:06:10.9570763Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-13T01:06:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)']2026-08-13T01:06:11.1465778Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-13T01:06:11.1467659Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-kvwzt failed. Retrying in 10s.2026-08-13T01:06:11.1473952Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-13T01:06:21.1479783Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)']' in pod test-cm-5bb545475c-kvwzt failed. Retrying in 10s.2026-08-13T01:06:21.1482375Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-13T01:06:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_SINGULARITY]2026-08-13T01:06:21.1485568Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-13T01:06:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)']2026-08-13T01:06:21.3250068Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-13T01:06:21Z logger.go:67: true2026-08-13T01:06:21.3251895Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-13T01:06:21Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-13T01:06:21.3253306Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-13T01:06:21Z logger.go:67: 2026-08-13T01:06:21.3255029Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-13T01:06:21Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-65c844ddbb-vcbf8 LINUX X86_64 Unclaimed Idle 0.000 15988 0+00:00:002026-08-13T01:06:21.3256903Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-13T01:06:21Z logger.go:67: 2026-08-13T01:06:21.3258329Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-13T01:06:21Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-13T01:06:21.3259711Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-13T01:06:21Z logger.go:67: 2026-08-13T01:06:21.3260875Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-13T01:06:21Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-13T01:06:21.3262554Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-13T01:06:21Z logger.go:67: 2026-08-13T01:06:21.3263824Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-13T01:06:21Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-13T01:06:30.9450578Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:06:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-13T01:06:31.0966473Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:06:31Z logger.go:67: undefined2026-08-13T01:06:31.1034415Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-13T01:06:31.1036639Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-kvwzt failed. Retrying in 30s.2026-08-13T01:07:01.1043357Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:07:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-13T01:07:01.2607136Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:07:01Z logger.go:67: undefined2026-08-13T01:07:01.2670764Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-kvwzt failed. Retrying in 30s.2026-08-13T01:07:31.2682686Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:07:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-13T01:07:31.4252492Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:07:31Z logger.go:67: undefined2026-08-13T01:07:31.4315555Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-kvwzt failed. Retrying in 30s.2026-08-13T01:08:01.4320023Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:08:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-13T01:08:01.5875582Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:08:01Z logger.go:67: undefined2026-08-13T01:08:01.5945628Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-kvwzt failed. Retrying in 30s.2026-08-13T01:08:31.5970495Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:08:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-13T01:08:31.7502777Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:08:31Z logger.go:67: undefined2026-08-13T01:08:31.7570642Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-kvwzt failed. Retrying in 30s.2026-08-13T01:09:01.7573644Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:09:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-13T01:09:01.9135293Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:09:01Z logger.go:67: undefined2026-08-13T01:09:01.9199186Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-kvwzt failed. Retrying in 30s.2026-08-13T01:09:31.9220564Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:09:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-13T01:09:32.0767169Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:09:32Z logger.go:67: undefined2026-08-13T01:09:32.0820457Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-kvwzt failed. Retrying in 30s.2026-08-13T01:10:02.0824372Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:10:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-13T01:10:02.2343072Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:10:02Z logger.go:67: undefined2026-08-13T01:10:02.2409763Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-kvwzt failed. Retrying in 30s.2026-08-13T01:10:32.2413252Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:10:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-13T01:10:32.3964009Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:10:32Z logger.go:67: undefined2026-08-13T01:10:32.4037845Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-kvwzt failed. Retrying in 30s.2026-08-13T01:11:02.4067127Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:11:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-13T01:11:02.5584991Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:11:02Z logger.go:67: undefined2026-08-13T01:11:02.5649056Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-kvwzt failed. Retrying in 30s.2026-08-13T01:11:32.5684240Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:11:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict exec test-cm-5bb545475c-kvwzt -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-vcbf8",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-13T01:11:32.7534658Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-13T01:11:32Z logger.go:67: true2026-08-13T01:11:32.7608504Z TestOSPoolEP 2026-08-13T01:11:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:11:32.7689438Z TestOSPoolEP 2026-08-13T01:11:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:11:32.9384639Z TestOSPoolEP 2026-08-13T01:11:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:11:33.0808459Z TestOSPoolEP 2026-08-13T01:11:33Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:11:33.2019145Z TestOSPoolEP 2026-08-13T01:11:33Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:11:33.2048647Z === NAME TestOSPoolEP2026-08-13T01:11:33.2049313Z ospool_ep_test.go:101: ---2026-08-13T01:11:33.2049909Z Events for pod idtoken-generator:2026-08-13T01:11:33.2051235Z 2026-08-13 01:05:29 +0000 UTC Normal Successfully assigned test-ospool-ep-xgmict/idtoken-generator to minikube2026-08-13T01:11:33.2052446Z 2026-08-13 01:05:30 +0000 UTC Normal Pulling image "htcondor/base"2026-08-13T01:11:33.2054022Z 2026-08-13 01:05:38 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.432s (8.432s including waiting). Image size: 560910730 bytes.2026-08-13T01:11:33.2055154Z 2026-08-13 01:05:38 +0000 UTC Normal Container created2026-08-13T01:11:33.2056426Z 2026-08-13 01:05:38 +0000 UTC Normal Container started2026-08-13T01:11:33.2056993Z 2026-08-13T01:11:33.2057548Z ---2026-08-13T01:11:33.2058640Z TestOSPoolEP 2026-08-13T01:11:33Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:11:33.2077087Z ospool_ep_test.go:101: ---2026-08-13T01:11:33.2077803Z Events for pod ospool-ep-65c844ddbb-vcbf8:2026-08-13T01:11:33.2079774Z 2026-08-13 01:05:40 +0000 UTC Normal Successfully assigned test-ospool-ep-xgmict/ospool-ep-65c844ddbb-vcbf8 to minikube2026-08-13T01:11:33.2081044Z 2026-08-13 01:05:41 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-13T01:11:33.2082307Z 2026-08-13 01:05:42 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.521s (1.521s including waiting). Image size: 5590942 bytes.2026-08-13T01:11:33.2083128Z 2026-08-13 01:05:42 +0000 UTC Normal Container created2026-08-13T01:11:33.2083656Z 2026-08-13 01:05:42 +0000 UTC Normal Container started2026-08-13T01:11:33.2085636Z 2026-08-13 01:05:43 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-08-13T01:11:33.2090088Z 2026-08-13 01:05:57 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 13.976s (13.976s including waiting). Image size: 1273054585 bytes.2026-08-13T01:11:33.2092739Z 2026-08-13 01:05:57 +0000 UTC Normal Container created2026-08-13T01:11:33.2093668Z 2026-08-13 01:05:57 +0000 UTC Normal Container started2026-08-13T01:11:33.2094321Z 2026-08-13T01:11:33.2094555Z ---2026-08-13T01:11:33.2095389Z TestOSPoolEP 2026-08-13T01:11:33Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:11:33.2108276Z ospool_ep_test.go:101: ---2026-08-13T01:11:33.2112294Z Events for pod test-cm-5bb545475c-kvwzt:2026-08-13T01:11:33.2125524Z 2026-08-13 01:05:40 +0000 UTC Normal Successfully assigned test-ospool-ep-xgmict/test-cm-5bb545475c-kvwzt to minikube2026-08-13T01:11:33.2127123Z 2026-08-13 01:05:41 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-08-13T01:11:33.2128773Z 2026-08-13 01:05:42 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 332ms (1.822s including waiting). Image size: 560910756 bytes.2026-08-13T01:11:33.2130213Z 2026-08-13 01:05:42 +0000 UTC Normal Container created2026-08-13T01:11:33.2131005Z 2026-08-13 01:05:43 +0000 UTC Normal Container started2026-08-13T01:11:33.2131528Z 2026-08-13T01:11:33.2131860Z ---2026-08-13T01:11:33.2133088Z TestOSPoolEP 2026-08-13T01:11:33Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-13T01:11:33.2140223Z TestOSPoolEP 2026-08-13T01:11:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict delete -f /tmp/TestOSPoolEP143262849]2026-08-13T01:11:33.3196848Z TestOSPoolEP 2026-08-13T01:11:33Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-xgmict namespace2026-08-13T01:11:33.3279215Z TestOSPoolEP 2026-08-13T01:11:33Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-xgmict namespace2026-08-13T01:11:34.3777650Z TestOSPoolEP 2026-08-13T01:11:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict delete -f /tmp/TestOSPoolEP2717938271]2026-08-13T01:11:34.4830993Z TestOSPoolEP 2026-08-13T01:11:34Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-xgmict namespace2026-08-13T01:11:34.4884938Z TestOSPoolEP 2026-08-13T01:11:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-xgmict delete -k /tmp/kustomize-template-945579396]2026-08-13T01:11:34.6232417Z TestOSPoolEP 2026-08-13T01:11:34Z logger.go:67: service "test-cm" deleted from test-ospool-ep-xgmict namespace2026-08-13T01:11:34.6307036Z TestOSPoolEP 2026-08-13T01:11:34Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-xgmict namespace2026-08-13T01:11:34.6349477Z TestOSPoolEP 2026-08-13T01:11:34Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-xgmict namespace2026-08-13T01:11:34.6491132Z --- PASS: TestOSPoolEP (33.74s)2026-08-13T01:11:34.6517978Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (20.04s)2026-08-13T01:11:34.6544902Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.70s)2026-08-13T01:11:34.6547600Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.70s)2026-08-13T01:11:34.6549388Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (332.13s)2026-08-13T01:11:34.6550379Z PASS2026-08-13T01:11:34.6551247Z ok github.com/osg-htc/k8s-integration-tests/test 365.894s2026-08-13T01:11:34.7904390Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-13T01:11:34.7905305Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-13T01:11:34.8026983Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-13T01:11:34.8027519Z env:2026-08-13T01:11:34.8027847Z GOTOOLCHAIN: local2026-08-13T01:11:34.8028481Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-13T01:11:34.8028955Z ##[endgroup]2026-08-13T01:11:34.8262039Z 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-13T01:11:34.8263372Z ##[group]Run actions/upload-artifact@v42026-08-13T01:11:34.8263668Z with:2026-08-13T01:11:34.8264059Z name: TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe52026-08-13T01:11:34.8264733Z path: /tmp/k8s-tests2026-08-13T01:11:34.8264991Z retention-days: 52026-08-13T01:11:34.8265241Z if-no-files-found: warn2026-08-13T01:11:34.8265499Z compression-level: 62026-08-13T01:11:34.8265753Z overwrite: false2026-08-13T01:11:34.8266211Z include-hidden-files: false2026-08-13T01:11:34.8266475Z env:2026-08-13T01:11:34.8266692Z GOTOOLCHAIN: local2026-08-13T01:11:34.8266923Z ##[endgroup]2026-08-13T01:11:35.0387489Z (node:17340) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-13T01:11:35.0388938Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-13T01:11:35.0550722Z With the provided path, there will be 6 files uploaded2026-08-13T01:11:35.0552971Z Artifact name is valid!2026-08-13T01:11:35.0553779Z Root directory input is valid!2026-08-13T01:11:35.2033839Z Beginning upload of artifact content to blob storage2026-08-13T01:11:35.2388552Z (node:17340) [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-13T01:11:35.2659865Z Uploaded bytes 140012026-08-13T01:11:35.2905626Z Finished uploading artifact content to blob storage!2026-08-13T01:11:35.2907215Z SHA256 digest of uploaded artifact zip is a6658ab9b7d60b1c39184fe8086c9783aad59acf4f9f66fc2ffe7703cee6b8a52026-08-13T01:11:35.2908394Z Finalizing artifact upload2026-08-13T01:11:35.4510399Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5.zip successfully finalized. Artifact ID 91647147722026-08-13T01:11:35.4512434Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5 has been successfully uploaded! Final size is 14001 bytes. Artifact ID is 91647147722026-08-13T01:11:35.4518084Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/31656485328/artifacts/91647147722026-08-13T01:11:35.4717185Z Post job cleanup.2026-08-13T01:11:35.6208112Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-13T01:11:35.6277193Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-13T01:11:35.6320514Z /home/runner/go/pkg/mod2026-08-13T01:11:35.6365717Z /home/runner/.cache/go-build2026-08-13T01:11:35.6372317Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-13T01:11:35.6610641Z Post job cleanup.2026-08-13T01:11:35.7811583Z [command]/usr/bin/git version2026-08-13T01:11:35.7858251Z git version 2.54.02026-08-13T01:11:35.7912872Z Temporarily overriding HOME='/home/runner/work/_temp/027a6c3f-c5b1-4e6a-81ab-dae047f4e9e5' before making global git config changes2026-08-13T01:11:35.7915613Z Adding repository directory to the temporary git global config as a safe directory2026-08-13T01:11:35.7921005Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-13T01:11:35.7972918Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-13T01:11:35.8037781Z [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-13T01:11:35.8513914Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-13T01:11:35.8516843Z http.https://github.com/.extraheader2026-08-13T01:11:35.8538507Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-13T01:11:35.8589490Z [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-13T01:11:35.8987542Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-13T01:11:35.9059749Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-13T01:11:35.9626724Z Cleaning up orphan processes2026-08-13T01:11:36.0520029Z ##[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/