2026-08-28T07:16:47.6118688Z Current runner version: '2.336.0'2026-08-28T07:16:47.6142235Z ##[group]Runner Image Provisioner2026-08-28T07:16:47.6143083Z Hosted Compute Agent2026-08-28T07:16:47.6143694Z Version: 20260819.5862026-08-28T07:16:47.6144308Z Commit: 3cc4a88dfa507ef76119ad1bb3eccc6378bb2b762026-08-28T07:16:47.6144968Z Build Date: 2026-08-18T23:20:18Z2026-08-28T07:16:47.6145706Z Worker ID: {6f8cce31-175d-47c4-8c3c-3bb559f74d32}2026-08-28T07:16:47.6146509Z Azure Region: westus32026-08-28T07:16:47.6147087Z ##[endgroup]2026-08-28T07:16:47.6148491Z ##[group]Operating System2026-08-28T07:16:47.6149056Z Ubuntu2026-08-28T07:16:47.6149624Z 22.04.52026-08-28T07:16:47.6150116Z LTS2026-08-28T07:16:47.6150615Z ##[endgroup]2026-08-28T07:16:47.6151160Z ##[group]Runner Image2026-08-28T07:16:47.6151753Z Image: ubuntu-22.042026-08-28T07:16:47.6152337Z Version: 20260824.273.32026-08-28T07:16:47.6153438Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260824.273/images/ubuntu/Ubuntu2204-Readme.md2026-08-28T07:16:47.6154870Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260824.2732026-08-28T07:16:47.6155750Z ##[endgroup]2026-08-28T07:16:47.6158698Z ##[group]GITHUB_TOKEN Permissions2026-08-28T07:16:47.6161315Z Actions: write2026-08-28T07:16:47.6161949Z ArtifactMetadata: write2026-08-28T07:16:47.6162577Z Attestations: write2026-08-28T07:16:47.6163125Z Checks: write2026-08-28T07:16:47.6163677Z CodeQuality: write2026-08-28T07:16:47.6164201Z Contents: write2026-08-28T07:16:47.6164761Z CopilotRequests: write2026-08-28T07:16:47.6165314Z Deployments: write2026-08-28T07:16:47.6165844Z Discussions: write2026-08-28T07:16:47.6166561Z Drives: write2026-08-28T07:16:47.6167136Z Issues: write2026-08-28T07:16:47.6167677Z Metadata: read2026-08-28T07:16:47.6168341Z Models: read2026-08-28T07:16:47.6168870Z Packages: write2026-08-28T07:16:47.6169420Z Pages: write2026-08-28T07:16:47.6169931Z PullRequests: write2026-08-28T07:16:47.6170519Z RepositoryProjects: write2026-08-28T07:16:47.6171099Z SecurityEvents: write2026-08-28T07:16:47.6171617Z Statuses: write2026-08-28T07:16:47.6172176Z VulnerabilityAlerts: read2026-08-28T07:16:47.6172729Z ##[endgroup]2026-08-28T07:16:47.6174821Z Secret source: Actions2026-08-28T07:16:47.6175877Z Prepare workflow directory2026-08-28T07:16:47.6554621Z Prepare all required actions2026-08-28T07:16:47.6601661Z Getting action download info2026-08-28T07:16:47.9964705Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-28T07:16:48.0835410Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-28T07:16:48.6019244Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-28T07:16:49.2221418Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-28T07:16:49.4852214Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-28T07:16:49.4858325Z ##[group] Inputs2026-08-28T07:16:49.4859451Z testName: TestOSPoolEP2026-08-28T07:16:49.4861191Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-28T07:16:49.4863131Z setupScript: 2026-08-28T07:16:49.4864097Z setupEnv: {}2026-08-28T07:16:49.4865039Z ##[endgroup]2026-08-28T07:16:49.4866687Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-08-28T07:16:49.5809519Z ##[group]Run actions/checkout@v52026-08-28T07:16:49.5812213Z with:2026-08-28T07:16:49.5813460Z repository: osg-htc/k8s-integration-tests2026-08-28T07:16:49.5823478Z token: ***2026-08-28T07:16:49.5824379Z ssh-strict: true2026-08-28T07:16:49.5825264Z ssh-user: git2026-08-28T07:16:49.5826158Z persist-credentials: true2026-08-28T07:16:49.5827340Z clean: true2026-08-28T07:16:49.5828697Z sparse-checkout-cone-mode: true2026-08-28T07:16:49.5830765Z fetch-depth: 12026-08-28T07:16:49.5831632Z fetch-tags: false2026-08-28T07:16:49.5832584Z show-progress: true2026-08-28T07:16:49.5833480Z lfs: false2026-08-28T07:16:49.5834342Z submodules: false2026-08-28T07:16:49.5835276Z set-safe-directory: true2026-08-28T07:16:49.5836302Z allow-unsafe-pr-checkout: false2026-08-28T07:16:49.5838138Z ##[endgroup]2026-08-28T07:16:49.7000659Z Syncing repository: osg-htc/k8s-integration-tests2026-08-28T07:16:49.7007658Z ##[group]Getting Git version info2026-08-28T07:16:49.7009423Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-28T07:16:49.7012565Z [command]/usr/bin/git version2026-08-28T07:16:49.7086852Z git version 2.55.02026-08-28T07:16:49.7122896Z ##[endgroup]2026-08-28T07:16:49.7134847Z Temporarily overriding HOME='/home/runner/work/_temp/9838f341-34d8-4613-a6de-ec2ff7514c85' before making global git config changes2026-08-28T07:16:49.7140165Z Adding repository directory to the temporary git global config as a safe directory2026-08-28T07:16:49.7149711Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-28T07:16:49.7190352Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-28T07:16:49.7195300Z ##[group]Initializing the repository2026-08-28T07:16:49.7202453Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-28T07:16:49.7300466Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-28T07:16:49.7305005Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-28T07:16:49.7309517Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-28T07:16:49.7312353Z hint: call:2026-08-28T07:16:49.7313821Z hint:2026-08-28T07:16:49.7315203Z hint: git config --global init.defaultBranch <name>2026-08-28T07:16:49.7317296Z hint:2026-08-28T07:16:49.7319445Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-28T07:16:49.7322725Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-28T07:16:49.7325434Z hint:2026-08-28T07:16:49.7327102Z hint: git branch -m <name>2026-08-28T07:16:49.7328835Z hint:2026-08-28T07:16:49.7331128Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-28T07:16:49.7335280Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-28T07:16:49.7342411Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-08-28T07:16:49.7348565Z ##[endgroup]2026-08-28T07:16:49.7350362Z ##[group]Disabling automatic garbage collection2026-08-28T07:16:49.7352714Z [command]/usr/bin/git config --local gc.auto 02026-08-28T07:16:49.7379421Z ##[endgroup]2026-08-28T07:16:49.7382045Z ##[group]Setting up auth2026-08-28T07:16:49.7384727Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-28T07:16:49.7412591Z [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-28T07:16:49.7709416Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-28T07:16:49.7738373Z [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-28T07:16:49.7925871Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-28T07:16:49.7957478Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-28T07:16:49.8139902Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-28T07:16:49.8172217Z ##[endgroup]2026-08-28T07:16:49.8173966Z ##[group]Fetching the repository2026-08-28T07:16:49.8181104Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-28T07:16:50.3251027Z From https://github.com/osg-htc/k8s-integration-tests2026-08-28T07:16:50.3253383Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-28T07:16:50.3258420Z ##[endgroup]2026-08-28T07:16:50.3260642Z ##[group]Determining the checkout info2026-08-28T07:16:50.3263048Z ##[endgroup]2026-08-28T07:16:50.3265453Z [command]/usr/bin/git sparse-checkout disable2026-08-28T07:16:50.3301140Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-28T07:16:50.3329296Z ##[group]Checking out the ref2026-08-28T07:16:50.3330680Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-28T07:16:50.3391676Z Switched to a new branch 'main'2026-08-28T07:16:50.3393508Z branch 'main' set up to track 'origin/main'.2026-08-28T07:16:50.3400578Z ##[endgroup]2026-08-28T07:16:50.3431211Z [command]/usr/bin/git log -1 --format=%H2026-08-28T07:16:50.3451966Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-28T07:16:50.3682326Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-28T07:16:50.3684471Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-28T07:16:50.3686501Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-28T07:16:50.3925784Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-28T07:16:50.3927106Z env:2026-08-28T07:16:50.3928501Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-28T07:16:50.3930119Z SETUP_ENV_YAML: {}2026-08-28T07:16:50.3930936Z ##[endgroup]2026-08-28T07:16:50.8793351Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-28T07:16:50.8793998Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-28T07:16:50.8831424Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-28T07:16:50.8831814Z env:2026-08-28T07:16:50.8832291Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-28T07:16:50.8832813Z ##[endgroup]2026-08-28T07:16:50.8937703Z ##[group]Run true2026-08-28T07:16:50.8937988Z [36;1mtrue[0m2026-08-28T07:16:50.8971229Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-28T07:16:50.8971881Z ##[endgroup]2026-08-28T07:16:50.9107098Z ##[group]Run medyagh/setup-minikube@latest2026-08-28T07:16:50.9107443Z with:2026-08-28T07:16:50.9107682Z start: true2026-08-28T07:16:50.9107921Z cache: true2026-08-28T07:16:50.9108184Z minikube-version: latest2026-08-28T07:16:50.9108461Z wait: all2026-08-28T07:16:50.9108689Z ##[endgroup]2026-08-28T07:16:51.0295500Z (node:1806) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-28T07:16:51.0296952Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-28T07:16:51.9008025Z [command]/usr/bin/chmod +x /home/runner/work/_temp/82f9b1a7-5d8b-4433-bcda-024bd0c64f272026-08-28T07:16:52.0125556Z [command]/home/runner/bin/minikube version --short2026-08-28T07:16:52.0502661Z v1.38.12026-08-28T07:16:52.2552151Z Cache hit for: kic-v1.38.1-x642026-08-28T07:16:52.2566310Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-28T07:16:52.2667464Z (node:1806) [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-28T07:16:53.4779378Z Received 62914560 of 544082637 (11.6%), 60.0 MBs/sec2026-08-28T07:16:54.4793284Z Received 230686720 of 544082637 (42.4%), 109.9 MBs/sec2026-08-28T07:16:55.4806950Z Received 398458880 of 544082637 (73.2%), 126.5 MBs/sec2026-08-28T07:16:56.4816098Z Received 539888333 of 544082637 (99.2%), 128.6 MBs/sec2026-08-28T07:16:56.6166184Z Received 544082637 of 544082637 (100.0%), 125.4 MBs/sec2026-08-28T07:16:56.6167353Z Cache Size: ~519 MB (544082637 B)2026-08-28T07:16:56.6200165Z [command]/usr/bin/tar -xf /home/runner/work/_temp/28d00e90-1bc9-4357-b28f-c058d5594e7b/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-28T07:16:57.1566890Z Cache restored successfully2026-08-28T07:16:58.4782375Z Received 62914560 of 224218830 (28.1%), 59.9 MBs/sec2026-08-28T07:16:59.5158032Z Received 224218830 of 224218830 (100.0%), 105.0 MBs/sec2026-08-28T07:16:59.5187263Z Cache Size: ~214 MB (224218830 B)2026-08-28T07:16:59.5250305Z [command]/usr/bin/tar -xf /home/runner/work/_temp/6fb1c410-a24e-4709-beee-580e5192927b/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-28T07:17:00.0057937Z Cache restored successfully2026-08-28T07:17:00.0342577Z [command]/home/runner/bin/minikube start --wait all2026-08-28T07:17:00.0768743Z * minikube v1.38.1 on Ubuntu 22.042026-08-28T07:17:04.1640980Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-28T07:17:04.2059379Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-28T07:17:04.2069396Z * Using Docker driver with root privileges2026-08-28T07:17:04.2079235Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-28T07:17:04.2085520Z * Pulling base image v0.0.50 ...2026-08-28T07:17:32.5070328Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-28T07:17:37.6477846Z * Verifying Kubernetes components...2026-08-28T07:17:37.6832084Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-28T07:17:38.2851306Z * Enabled addons: storage-provisioner, default-storageclass2026-08-28T07:18:16.6451215Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-28T07:18:16.6555253Z [command]/home/runner/bin/minikube version --short2026-08-28T07:18:16.6924768Z v1.38.12026-08-28T07:18:16.7164034Z ##[group]Run actions/setup-go@v62026-08-28T07:18:16.7164295Z with:2026-08-28T07:18:16.7164507Z go-version: 1.262026-08-28T07:18:16.7164802Z cache: true2026-08-28T07:18:16.7165024Z cache-dependency-path: go.sum2026-08-28T07:18:16.7165293Z check-latest: false2026-08-28T07:18:16.7168094Z token: ***2026-08-28T07:18:16.7168310Z ##[endgroup]2026-08-28T07:18:16.8423447Z Setup go version spec 1.262026-08-28T07:18:16.8503473Z Found in cache @ /opt/hostedtoolcache/go/1.26.7/x642026-08-28T07:18:16.8504275Z Added go to the path2026-08-28T07:18:16.8507607Z Successfully set up Go version 1.262026-08-28T07:18:16.8977670Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOMODCACHE2026-08-28T07:18:16.9009129Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOCACHE2026-08-28T07:18:16.9035282Z /home/runner/go/pkg/mod2026-08-28T07:18:16.9058063Z /home/runner/.cache/go-build2026-08-28T07:18:17.1176771Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-28T07:18:18.3585799Z Received 46137344 of 251715014 (18.3%), 44.0 MBs/sec2026-08-28T07:18:19.3583475Z Received 188743680 of 251715014 (75.0%), 90.0 MBs/sec2026-08-28T07:18:19.8404341Z Received 251715014 of 251715014 (100.0%), 96.7 MBs/sec2026-08-28T07:18:19.8405807Z Cache Size: ~240 MB (251715014 B)2026-08-28T07:18:19.8439318Z [command]/usr/bin/tar -xf /home/runner/work/_temp/5c1d1e14-0f70-48c0-b71c-46cd4bc7d3a0/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-28T07:18:21.7579179Z Cache restored successfully2026-08-28T07:18:21.7872087Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-28T07:18:21.7901469Z go version go1.26.7 linux/amd642026-08-28T07:18:21.7901819Z 2026-08-28T07:18:21.7902289Z ##[group]go env2026-08-28T07:18:21.8435836Z AR='ar'2026-08-28T07:18:21.8436273Z CC='gcc'2026-08-28T07:18:21.8436818Z CGO_CFLAGS='-O2 -g'2026-08-28T07:18:21.8437237Z CGO_CPPFLAGS=''2026-08-28T07:18:21.8437644Z CGO_CXXFLAGS='-O2 -g'2026-08-28T07:18:21.8438037Z CGO_ENABLED='1'2026-08-28T07:18:21.8438412Z CGO_FFLAGS='-O2 -g'2026-08-28T07:18:21.8438645Z CGO_LDFLAGS='-O2 -g'2026-08-28T07:18:21.8438866Z CXX='g++'2026-08-28T07:18:21.8439077Z GCCGO='gccgo'2026-08-28T07:18:21.8439288Z GO111MODULE=''2026-08-28T07:18:21.8439506Z GOAMD64='v1'2026-08-28T07:18:21.8439724Z GOARCH='amd64'2026-08-28T07:18:21.8439937Z GOAUTH='netrc'2026-08-28T07:18:21.8440144Z GOBIN=''2026-08-28T07:18:21.8440387Z GOCACHE='/home/runner/.cache/go-build'2026-08-28T07:18:21.8440692Z GOCACHEPROG=''2026-08-28T07:18:21.8440909Z GODEBUG=''2026-08-28T07:18:21.8441158Z GOENV='/home/runner/.config/go/env'2026-08-28T07:18:21.8441424Z GOEXE=''2026-08-28T07:18:21.8441620Z GOEXPERIMENT=''2026-08-28T07:18:21.8441840Z GOFIPS140='off'2026-08-28T07:18:21.8442046Z GOFLAGS=''2026-08-28T07:18:21.8442730Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build3825138398=/tmp/go-build -gno-record-gcc-switches'2026-08-28T07:18:21.8443379Z GOHOSTARCH='amd64'2026-08-28T07:18:21.8443610Z GOHOSTOS='linux'2026-08-28T07:18:21.8443826Z GOINSECURE=''2026-08-28T07:18:21.8444182Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-28T07:18:21.8444593Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-28T07:18:21.8444877Z GONOPROXY=''2026-08-28T07:18:21.8445085Z GONOSUMDB=''2026-08-28T07:18:21.8445296Z GOOS='linux'2026-08-28T07:18:21.8445518Z GOPATH='/home/runner/go'2026-08-28T07:18:21.8445776Z GOPRIVATE=''2026-08-28T07:18:21.8446043Z GOPROXY='https://proxy.golang.org,direct'2026-08-28T07:18:21.8446538Z GOROOT='/opt/hostedtoolcache/go/1.26.7/x64'2026-08-28T07:18:21.8446865Z GOSUMDB='sum.golang.org'2026-08-28T07:18:21.8447127Z GOTELEMETRY='local'2026-08-28T07:18:21.8447407Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-28T07:18:21.8447740Z GOTMPDIR=''2026-08-28T07:18:21.8448251Z GOTOOLCHAIN='local'2026-08-28T07:18:21.8448604Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.7/x64/pkg/tool/linux_amd64'2026-08-28T07:18:21.8448956Z GOVCS=''2026-08-28T07:18:21.8449177Z GOVERSION='go1.26.7'2026-08-28T07:18:21.8449404Z GOWORK=''2026-08-28T07:18:21.8449626Z PKG_CONFIG='pkg-config'2026-08-28T07:18:21.8449783Z 2026-08-28T07:18:21.8450133Z ##[endgroup]2026-08-28T07:18:21.8660028Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-28T07:18:21.8660518Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-28T07:18:21.8697288Z shell: /usr/bin/bash -e {0}2026-08-28T07:18:21.8697584Z env:2026-08-28T07:18:21.8697793Z GOTOOLCHAIN: local2026-08-28T07:18:21.8698054Z OSPOOL_EP_OSPoolEPTag: 25-release2026-08-28T07:18:21.8698340Z OSPOOL_EP_CMTag: 25.0-el92026-08-28T07:18:21.8698693Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-28T07:18:21.8698955Z ##[endgroup]2026-08-28T07:18:23.8237063Z === RUN TestOSPoolEP2026-08-28T07:18:23.8237530Z === PAUSE TestOSPoolEP2026-08-28T07:18:23.8237857Z === CONT TestOSPoolEP2026-08-28T07:18:23.8241918Z TestOSPoolEP 2026-08-28T07:18:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:23.8335729Z TestOSPoolEP 2026-08-28T07:18:23Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj apply -f /tmp/TestOSPoolEP651942658]2026-08-28T07:18:24.1725892Z TestOSPoolEP 2026-08-28T07:18:24Z logger.go:67: pod/idtoken-generator created2026-08-28T07:18:24.1774052Z TestOSPoolEP 2026-08-28T07:18:24Z logger.go:67: secret/pool-passwd created2026-08-28T07:18:24.1826480Z TestOSPoolEP 2026-08-28T07:18:24Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-28T07:18:24.1827817Z TestOSPoolEP 2026-08-28T07:18:24Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:24.1838660Z TestOSPoolEP 2026-08-28T07:18:24Z 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-28T07:18:34.1848537Z TestOSPoolEP 2026-08-28T07:18:34Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-28T07:18:34.1857491Z TestOSPoolEP 2026-08-28T07:18:34Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:34.1878791Z TestOSPoolEP 2026-08-28T07:18:34Z 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-28T07:18:44.1879376Z TestOSPoolEP 2026-08-28T07:18:44Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-28T07:18:44.1880592Z TestOSPoolEP 2026-08-28T07:18:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:44.1905862Z TestOSPoolEP 2026-08-28T07:18:44Z logger.go:67: Pod is now available2026-08-28T07:18:44.1907497Z TestOSPoolEP 2026-08-28T07:18:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-28T07:18:44.5553325Z TestOSPoolEP 2026-08-28T07:18:44Z logger.go:67: ***2026-08-28T07:18:44.5599760Z TestOSPoolEP 2026-08-28T07:18:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj apply -f /tmp/TestOSPoolEP1923224002]2026-08-28T07:18:44.6914487Z TestOSPoolEP 2026-08-28T07:18:44Z logger.go:67: secret/pool-token created2026-08-28T07:18:44.6935637Z TestOSPoolEP 2026-08-28T07:18:44Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-28T07:18:44.6936744Z TestOSPoolEP 2026-08-28T07:18:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:44.6953487Z TestOSPoolEP 2026-08-28T07:18:44Z logger.go:67: Secret is now available2026-08-28T07:18:44.6981893Z TestOSPoolEP 2026-08-28T07:18:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj apply -k /tmp/kustomize-template-525416700]2026-08-28T07:18:44.8220963Z TestOSPoolEP 2026-08-28T07:18:44Z logger.go:67: service/test-cm created2026-08-28T07:18:44.8305316Z TestOSPoolEP 2026-08-28T07:18:44Z 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-28T07:18:44.8307621Z TestOSPoolEP 2026-08-28T07:18:44Z logger.go:67: deployment.apps/ospool-ep created2026-08-28T07:18:44.8385913Z TestOSPoolEP 2026-08-28T07:18:44Z logger.go:67: deployment.apps/test-cm created2026-08-28T07:18:44.8451561Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-28T07:18:44.8453871Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:44.8488544Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:44Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-28T07:18:44.8509020Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:44.8510831Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:44Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-28T07:18:44.8512403Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:44Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:44.8598771Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:44Z 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-28T07:18:44.8615273Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:44Z 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-28T07:18:54.8599608Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:54Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-28T07:18:54.8602464Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:54.8625091Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:54Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-28T07:18:54.8628430Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:54.8634041Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:54Z 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-28T07:18:54.8650440Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:54Z 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-28T07:19:04.8641850Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:19:04Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-28T07:19:04.8643132Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:19:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:19:04.8652404Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:19:04Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-28T07:19:04.8654060Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:19:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:19:04.8671170Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:19:04Z 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-28T07:19:04.8673957Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:19:04Z logger.go:67: Deployment is now available2026-08-28T07:19:14.8674985Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:19:14Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-28T07:19:14.8676228Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:19:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:19:14.8711190Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:19:14Z logger.go:67: Deployment is now available2026-08-28T07:19:14.8712396Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-28T07:19:14.8720088Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-28T07:19:14.8720912Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-28T07:19:14.8721685Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-28T07:19:14.8722428Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-28T07:19:14.8723151Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-28T07:19:14.8723846Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-28T07:19:14.8725107Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:19:14.8726153Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-28T07:19:14.8727266Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-28T07:19:14.8728898Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:19:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:19:14.8731057Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-28T07:19:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:19:14.8743544Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:19:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:19:14.8749509Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-28T07:19:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:19:14.8751665Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:19:14.8768607Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:19:14Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:19:14.8776682Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-28T07:19:14Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_SINGULARITY]2026-08-28T07:19:14.8790727Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:14Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)']2026-08-28T07:19:15.0043918Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-28T07:19:15.0045940Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)']' in pod test-cm-54b7d49f85-l2mbr failed. Retrying in 10s.2026-08-28T07:19:15.0683890Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-28T07:19:15.0685479Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-l2mbr failed. Retrying in 30s.2026-08-28T07:19:15.0686934Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-28T07:19:15.0687959Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-l2mbr failed. Retrying in 10s.2026-08-28T07:19:25.0050324Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)']2026-08-28T07:19:25.0694351Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-28T07:19:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_SINGULARITY]2026-08-28T07:19:25.1572418Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-28T07:19:25.1574708Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)']' in pod test-cm-54b7d49f85-l2mbr failed. Retrying in 10s.2026-08-28T07:19:25.2029143Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-28T07:19:25.2031030Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-l2mbr failed. Retrying in 10s.2026-08-28T07:19:35.1578252Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)']2026-08-28T07:19:35.2031706Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-28T07:19:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_SINGULARITY]2026-08-28T07:19:35.2629315Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:35Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-28T07:19:35.2631067Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:35Z logger.go:67: 2026-08-28T07:19:35.2633916Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:35Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-sqhvc LINUX X86_64 Unclaimed Idle 0.000 15987 0+00:00:002026-08-28T07:19:35.2635797Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:35Z logger.go:67: 2026-08-28T07:19:35.2637718Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:35Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-28T07:19:35.2639807Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:35Z logger.go:67: 2026-08-28T07:19:35.2641263Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:35Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-28T07:19:35.2642857Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:35Z logger.go:67: 2026-08-28T07:19:35.2644639Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:35Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-28T07:19:35.3124561Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-28T07:19:35Z logger.go:67: true2026-08-28T07:19:45.0687142Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:19:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:19:45.1627238Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:19:45Z logger.go:67: undefined2026-08-28T07:19:45.1667896Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-28T07:19:45.1669319Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-l2mbr failed. Retrying in 30s.2026-08-28T07:20:15.1685674Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:20:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:20:15.2632727Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:20:15Z logger.go:67: undefined2026-08-28T07:20:15.2673872Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-l2mbr failed. Retrying in 30s.2026-08-28T07:20:45.2679143Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:20:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:20:45.3595742Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:20:45Z logger.go:67: undefined2026-08-28T07:20:45.3634084Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-l2mbr failed. Retrying in 30s.2026-08-28T07:21:15.3640480Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:21:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:21:15.4575680Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:21:15Z logger.go:67: undefined2026-08-28T07:21:15.4612859Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-l2mbr failed. Retrying in 30s.2026-08-28T07:21:45.4630657Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:21:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:21:45.5543968Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:21:45Z logger.go:67: undefined2026-08-28T07:21:45.5584283Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-l2mbr failed. Retrying in 30s.2026-08-28T07:22:15.5588168Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:22:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:22:15.6532754Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:22:15Z logger.go:67: undefined2026-08-28T07:22:15.6574808Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-l2mbr failed. Retrying in 30s.2026-08-28T07:22:45.6590883Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:22:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:22:45.7617630Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:22:45Z logger.go:67: undefined2026-08-28T07:22:45.7658342Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-l2mbr failed. Retrying in 30s.2026-08-28T07:23:15.7663625Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:23:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:23:15.8794655Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:23:15Z logger.go:67: undefined2026-08-28T07:23:15.8837252Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-l2mbr failed. Retrying in 30s.2026-08-28T07:23:45.8851842Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:23:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:23:45.9815656Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:23:45Z logger.go:67: undefined2026-08-28T07:23:45.9854385Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-l2mbr failed. Retrying in 30s.2026-08-28T07:24:15.9855560Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:24:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:24:16.0852269Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:24:16Z logger.go:67: undefined2026-08-28T07:24:16.0890440Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-l2mbr failed. Retrying in 30s.2026-08-28T07:24:46.0911928Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:24:46Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj exec test-cm-54b7d49f85-l2mbr -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-sqhvc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:24:46.1963571Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:24:46Z logger.go:67: true2026-08-28T07:24:46.2005696Z TestOSPoolEP 2026-08-28T07:24:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:24:46.2097454Z TestOSPoolEP 2026-08-28T07:24:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:24:46.3114401Z TestOSPoolEP 2026-08-28T07:24:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:24:46.3876841Z TestOSPoolEP 2026-08-28T07:24:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:24:46.4606715Z TestOSPoolEP 2026-08-28T07:24:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:24:46.4635726Z === NAME TestOSPoolEP2026-08-28T07:24:46.4636953Z ospool_ep_test.go:101: ---2026-08-28T07:24:46.4637652Z Events for pod idtoken-generator:2026-08-28T07:24:46.4638987Z 2026-08-28 07:18:24 +0000 UTC Normal Successfully assigned test-ospool-ep-jmu1dj/idtoken-generator to minikube2026-08-28T07:24:46.4640786Z 2026-08-28 07:18:27 +0000 UTC Normal Pulling image "htcondor/base"2026-08-28T07:24:46.4642496Z 2026-08-28 07:18:34 +0000 UTC Normal Successfully pulled image "htcondor/base" in 7.594s (7.594s including waiting). Image size: 522365028 bytes.2026-08-28T07:24:46.4643403Z 2026-08-28 07:18:34 +0000 UTC Normal Container created2026-08-28T07:24:46.4644167Z 2026-08-28 07:18:35 +0000 UTC Normal Container started2026-08-28T07:24:46.4644817Z 2026-08-28T07:24:46.4645270Z ---2026-08-28T07:24:46.4646596Z TestOSPoolEP 2026-08-28T07:24:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:24:46.4654317Z ospool_ep_test.go:101: ---2026-08-28T07:24:46.4655681Z Events for pod ospool-ep-6c7d796845-sqhvc:2026-08-28T07:24:46.4657608Z 2026-08-28 07:18:44 +0000 UTC Normal Successfully assigned test-ospool-ep-jmu1dj/ospool-ep-6c7d796845-sqhvc to minikube2026-08-28T07:24:46.4659554Z 2026-08-28 07:18:45 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-28T07:24:46.4662094Z 2026-08-28 07:18:48 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 3.162s (3.162s including waiting). Image size: 5590942 bytes.2026-08-28T07:24:46.4664133Z 2026-08-28 07:18:48 +0000 UTC Normal Container created2026-08-28T07:24:46.4664808Z 2026-08-28 07:18:48 +0000 UTC Normal Container started2026-08-28T07:24:46.4665961Z 2026-08-28 07:18:49 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-08-28T07:24:46.4667811Z 2026-08-28 07:19:12 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 14.948s (22.857s including waiting). Image size: 1288097653 bytes.2026-08-28T07:24:46.4669180Z 2026-08-28 07:19:12 +0000 UTC Normal Container created2026-08-28T07:24:46.4669879Z 2026-08-28 07:19:12 +0000 UTC Normal Container started2026-08-28T07:24:46.4670374Z 2026-08-28T07:24:46.4670724Z ---2026-08-28T07:24:46.4671544Z TestOSPoolEP 2026-08-28T07:24:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:24:46.4679811Z ospool_ep_test.go:101: ---2026-08-28T07:24:46.4680919Z Events for pod test-cm-54b7d49f85-l2mbr:2026-08-28T07:24:46.4692703Z 2026-08-28 07:18:44 +0000 UTC Normal Successfully assigned test-ospool-ep-jmu1dj/test-cm-54b7d49f85-l2mbr to minikube2026-08-28T07:24:46.4693986Z 2026-08-28 07:18:45 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-08-28T07:24:46.4696045Z 2026-08-28 07:18:57 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 8.597s (11.741s including waiting). Image size: 534362849 bytes.2026-08-28T07:24:46.4697327Z 2026-08-28 07:18:57 +0000 UTC Normal Container created2026-08-28T07:24:46.4697939Z 2026-08-28 07:18:57 +0000 UTC Normal Container started2026-08-28T07:24:46.4698361Z 2026-08-28T07:24:46.4698604Z ---2026-08-28T07:24:46.4699270Z TestOSPoolEP 2026-08-28T07:24:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:24:46.4757681Z TestOSPoolEP 2026-08-28T07:24:46Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj delete -f /tmp/TestOSPoolEP2373259438]2026-08-28T07:24:46.5244042Z TestOSPoolEP 2026-08-28T07:24:46Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-jmu1dj namespace2026-08-28T07:24:46.5297147Z TestOSPoolEP 2026-08-28T07:24:46Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-jmu1dj namespace2026-08-28T07:24:47.1801155Z TestOSPoolEP 2026-08-28T07:24:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj delete -f /tmp/TestOSPoolEP2834083419]2026-08-28T07:24:47.2318308Z TestOSPoolEP 2026-08-28T07:24:47Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-jmu1dj namespace2026-08-28T07:24:47.2357400Z TestOSPoolEP 2026-08-28T07:24:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-jmu1dj delete -k /tmp/kustomize-template-525416700]2026-08-28T07:24:47.3101931Z TestOSPoolEP 2026-08-28T07:24:47Z logger.go:67: service "test-cm" deleted from test-ospool-ep-jmu1dj namespace2026-08-28T07:24:47.3138111Z TestOSPoolEP 2026-08-28T07:24:47Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-jmu1dj namespace2026-08-28T07:24:47.3169960Z TestOSPoolEP 2026-08-28T07:24:47Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-jmu1dj namespace2026-08-28T07:24:47.3260060Z --- PASS: TestOSPoolEP (52.17s)2026-08-28T07:24:47.3267530Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.03s)2026-08-28T07:24:47.3269149Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.40s)2026-08-28T07:24:47.3270286Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.45s)2026-08-28T07:24:47.3271621Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (331.33s)2026-08-28T07:24:47.3272519Z PASS2026-08-28T07:24:47.3281064Z ok github.com/osg-htc/k8s-integration-tests/test 383.516s2026-08-28T07:24:47.3932837Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-28T07:24:47.3933439Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-28T07:24:47.3972618Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-28T07:24:47.3973006Z env:2026-08-28T07:24:47.3973237Z GOTOOLCHAIN: local2026-08-28T07:24:47.3973667Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-28T07:24:47.3974132Z ##[endgroup]2026-08-28T07:24:47.4109661Z 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-28T07:24:47.4110902Z ##[group]Run actions/upload-artifact@v42026-08-28T07:24:47.4111191Z with:2026-08-28T07:24:47.4111577Z name: TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce72322026-08-28T07:24:47.4112036Z path: /tmp/k8s-tests2026-08-28T07:24:47.4112274Z retention-days: 52026-08-28T07:24:47.4112511Z if-no-files-found: warn2026-08-28T07:24:47.4112755Z compression-level: 62026-08-28T07:24:47.4112988Z overwrite: false2026-08-28T07:24:47.4113216Z include-hidden-files: false2026-08-28T07:24:47.4113466Z env:2026-08-28T07:24:47.4113659Z GOTOOLCHAIN: local2026-08-28T07:24:47.4113881Z ##[endgroup]2026-08-28T07:24:47.6025578Z (node:17597) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-28T07:24:47.6026509Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-28T07:24:47.6119646Z With the provided path, there will be 6 files uploaded2026-08-28T07:24:47.6120820Z Artifact name is valid!2026-08-28T07:24:47.6122699Z Root directory input is valid!2026-08-28T07:24:47.9621706Z Beginning upload of artifact content to blob storage2026-08-28T07:24:47.9905259Z (node:17597) [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-28T07:24:48.2398182Z Uploaded bytes 141072026-08-28T07:24:48.3061543Z Finished uploading artifact content to blob storage!2026-08-28T07:24:48.3062462Z SHA256 digest of uploaded artifact zip is 982366580b42d52db566644c6ac02a851084e939a7e55c1c8c160dd2887b44982026-08-28T07:24:48.3064227Z Finalizing artifact upload2026-08-28T07:24:48.5432989Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232.zip successfully finalized. Artifact ID 96778148272026-08-28T07:24:48.5435806Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232 has been successfully uploaded! Final size is 14107 bytes. Artifact ID is 96778148272026-08-28T07:24:48.5441734Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/33150867377/artifacts/96778148272026-08-28T07:24:48.5582592Z Post job cleanup.2026-08-28T07:24:48.6842374Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOMODCACHE2026-08-28T07:24:48.6885440Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOCACHE2026-08-28T07:24:48.6916064Z /home/runner/go/pkg/mod2026-08-28T07:24:48.6932324Z /home/runner/.cache/go-build2026-08-28T07:24:48.6941273Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-28T07:24:48.7134145Z Post job cleanup.2026-08-28T07:24:48.7982762Z [command]/usr/bin/git version2026-08-28T07:24:48.8026890Z git version 2.55.02026-08-28T07:24:48.8071000Z Temporarily overriding HOME='/home/runner/work/_temp/cb398bc5-6b09-4f61-a20f-4cf991c984f1' before making global git config changes2026-08-28T07:24:48.8071754Z Adding repository directory to the temporary git global config as a safe directory2026-08-28T07:24:48.8078021Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-28T07:24:48.8113460Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-28T07:24:48.8144055Z [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-28T07:24:48.8361620Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-28T07:24:48.8384610Z http.https://github.com/.extraheader2026-08-28T07:24:48.8395746Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-28T07:24:48.8425762Z [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-28T07:24:48.8628588Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-28T07:24:48.8669437Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-28T07:24:48.9030188Z Cleaning up orphan processes2026-08-28T07:24:48.9680119Z ##[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/