2026-08-28T07:16:47.5314687Z Current runner version: '2.336.0'2026-08-28T07:16:47.5338732Z ##[group]Runner Image Provisioner2026-08-28T07:16:47.5339543Z Hosted Compute Agent2026-08-28T07:16:47.5340121Z Version: 20260819.5862026-08-28T07:16:47.5340724Z Commit: 3cc4a88dfa507ef76119ad1bb3eccc6378bb2b762026-08-28T07:16:47.5341405Z Build Date: 2026-08-18T23:20:18Z2026-08-28T07:16:47.5342062Z Worker ID: {10bd0614-3998-4895-981c-41927c340c99}2026-08-28T07:16:47.5342705Z Azure Region: centralus2026-08-28T07:16:47.5343499Z ##[endgroup]2026-08-28T07:16:47.5344977Z ##[group]Operating System2026-08-28T07:16:47.5345538Z Ubuntu2026-08-28T07:16:47.5346065Z 22.04.52026-08-28T07:16:47.5346534Z LTS2026-08-28T07:16:47.5346985Z ##[endgroup]2026-08-28T07:16:47.5347529Z ##[group]Runner Image2026-08-28T07:16:47.5348106Z Image: ubuntu-22.042026-08-28T07:16:47.5348663Z Version: 20260824.273.32026-08-28T07:16:47.5349797Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260824.273/images/ubuntu/Ubuntu2204-Readme.md2026-08-28T07:16:47.5351181Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260824.2732026-08-28T07:16:47.5352057Z ##[endgroup]2026-08-28T07:16:47.5354944Z ##[group]GITHUB_TOKEN Permissions2026-08-28T07:16:47.5357422Z Actions: write2026-08-28T07:16:47.5358292Z ArtifactMetadata: write2026-08-28T07:16:47.5358860Z Attestations: write2026-08-28T07:16:47.5359453Z Checks: write2026-08-28T07:16:47.5359973Z CodeQuality: write2026-08-28T07:16:47.5360517Z Contents: write2026-08-28T07:16:47.5361063Z CopilotRequests: write2026-08-28T07:16:47.5361618Z Deployments: write2026-08-28T07:16:47.5362132Z Discussions: write2026-08-28T07:16:47.5362676Z Drives: write2026-08-28T07:16:47.5363317Z Issues: write2026-08-28T07:16:47.5363829Z Metadata: read2026-08-28T07:16:47.5364486Z Models: read2026-08-28T07:16:47.5364967Z Packages: write2026-08-28T07:16:47.5365507Z Pages: write2026-08-28T07:16:47.5366027Z PullRequests: write2026-08-28T07:16:47.5366594Z RepositoryProjects: write2026-08-28T07:16:47.5367197Z SecurityEvents: write2026-08-28T07:16:47.5367732Z Statuses: write2026-08-28T07:16:47.5368279Z VulnerabilityAlerts: read2026-08-28T07:16:47.5368842Z ##[endgroup]2026-08-28T07:16:47.5370987Z Secret source: Actions2026-08-28T07:16:47.5371976Z Prepare workflow directory2026-08-28T07:16:47.5742800Z Prepare all required actions2026-08-28T07:16:47.5793922Z Getting action download info2026-08-28T07:16:47.8806152Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-28T07:16:47.9710719Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-28T07:16:48.2881468Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-28T07:16:48.6412935Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-28T07:16:48.8454216Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-28T07:16:48.8459222Z ##[group] Inputs2026-08-28T07:16:48.8459846Z testName: TestOSPoolEP2026-08-28T07:16:48.8460764Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-28T07:16:48.8461732Z setupScript: 2026-08-28T07:16:48.8462220Z setupEnv: {}2026-08-28T07:16:48.8462698Z ##[endgroup]2026-08-28T07:16:48.8463706Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-testing) / Run Tests2026-08-28T07:16:48.9211503Z ##[group]Run actions/checkout@v52026-08-28T07:16:48.9212298Z with:2026-08-28T07:16:48.9212759Z repository: osg-htc/k8s-integration-tests2026-08-28T07:16:48.9216715Z token: ***2026-08-28T07:16:48.9217128Z ssh-strict: true2026-08-28T07:16:48.9217568Z ssh-user: git2026-08-28T07:16:48.9218020Z persist-credentials: true2026-08-28T07:16:48.9218490Z clean: true2026-08-28T07:16:48.9218897Z sparse-checkout-cone-mode: true2026-08-28T07:16:48.9219629Z fetch-depth: 12026-08-28T07:16:48.9220033Z fetch-tags: false2026-08-28T07:16:48.9220462Z show-progress: true2026-08-28T07:16:48.9220900Z lfs: false2026-08-28T07:16:48.9221310Z submodules: false2026-08-28T07:16:48.9221740Z set-safe-directory: true2026-08-28T07:16:48.9222227Z allow-unsafe-pr-checkout: false2026-08-28T07:16:48.9223010Z ##[endgroup]2026-08-28T07:16:49.0240696Z Syncing repository: osg-htc/k8s-integration-tests2026-08-28T07:16:49.0243708Z ##[group]Getting Git version info2026-08-28T07:16:49.0244679Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-28T07:16:49.0246381Z [command]/usr/bin/git version2026-08-28T07:16:49.0291900Z git version 2.55.02026-08-28T07:16:49.0316315Z ##[endgroup]2026-08-28T07:16:49.0334637Z Temporarily overriding HOME='/home/runner/work/_temp/fc7c4170-bf30-42be-b7d0-347b8728cb51' before making global git config changes2026-08-28T07:16:49.0337224Z Adding repository directory to the temporary git global config as a safe directory2026-08-28T07:16:49.0341699Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-28T07:16:49.0377463Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-28T07:16:49.0381750Z ##[group]Initializing the repository2026-08-28T07:16:49.0387364Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-28T07:16:49.0494087Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-28T07:16:49.0495260Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-28T07:16:49.0496687Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-28T07:16:49.0498313Z hint: call:2026-08-28T07:16:49.0498998Z hint:2026-08-28T07:16:49.0499899Z hint: git config --global init.defaultBranch <name>2026-08-28T07:16:49.0500658Z hint:2026-08-28T07:16:49.0501656Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-28T07:16:49.0502670Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-28T07:16:49.0503891Z hint:2026-08-28T07:16:49.0504565Z hint: git branch -m <name>2026-08-28T07:16:49.0505272Z hint:2026-08-28T07:16:49.0506212Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-28T07:16:49.0508153Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-28T07:16:49.0511367Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-08-28T07:16:49.0545207Z ##[endgroup]2026-08-28T07:16:49.0546242Z ##[group]Disabling automatic garbage collection2026-08-28T07:16:49.0550623Z [command]/usr/bin/git config --local gc.auto 02026-08-28T07:16:49.0579040Z ##[endgroup]2026-08-28T07:16:49.0579967Z ##[group]Setting up auth2026-08-28T07:16:49.0588182Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-28T07:16:49.0628509Z [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.0968391Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-28T07:16:49.1002259Z [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.1222509Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-28T07:16:49.1255655Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-28T07:16:49.1446176Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-28T07:16:49.1479633Z ##[endgroup]2026-08-28T07:16:49.1480862Z ##[group]Fetching the repository2026-08-28T07:16:49.1489048Z [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:49.6055303Z From https://github.com/osg-htc/k8s-integration-tests2026-08-28T07:16:49.6057220Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-28T07:16:49.6062123Z ##[endgroup]2026-08-28T07:16:49.6064322Z ##[group]Determining the checkout info2026-08-28T07:16:49.6066378Z ##[endgroup]2026-08-28T07:16:49.6072684Z [command]/usr/bin/git sparse-checkout disable2026-08-28T07:16:49.6117547Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-28T07:16:49.6146232Z ##[group]Checking out the ref2026-08-28T07:16:49.6150217Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-28T07:16:49.6214509Z Switched to a new branch 'main'2026-08-28T07:16:49.6216540Z branch 'main' set up to track 'origin/main'.2026-08-28T07:16:49.6231735Z ##[endgroup]2026-08-28T07:16:49.6266365Z [command]/usr/bin/git log -1 --format=%H2026-08-28T07:16:49.6288595Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-28T07:16:49.6546721Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-28T07:16:49.6549387Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-28T07:16:49.6551894Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-28T07:16:49.6811998Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-28T07:16:49.6813774Z env:2026-08-28T07:16:49.6815629Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-28T07:16:49.6817817Z SETUP_ENV_YAML: {}2026-08-28T07:16:49.6818862Z ##[endgroup]2026-08-28T07:16:50.6062436Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-28T07:16:50.6063043Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-28T07:16:50.6101244Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-28T07:16:50.6101591Z env:2026-08-28T07:16:50.6102033Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-28T07:16:50.6102571Z ##[endgroup]2026-08-28T07:16:50.6209158Z ##[group]Run true2026-08-28T07:16:50.6209422Z [36;1mtrue[0m2026-08-28T07:16:50.6246634Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-28T07:16:50.6247011Z ##[endgroup]2026-08-28T07:16:50.6385704Z ##[group]Run medyagh/setup-minikube@latest2026-08-28T07:16:50.6386008Z with:2026-08-28T07:16:50.6386203Z start: true2026-08-28T07:16:50.6386400Z cache: true2026-08-28T07:16:50.6386622Z minikube-version: latest2026-08-28T07:16:50.6386876Z wait: all2026-08-28T07:16:50.6387059Z ##[endgroup]2026-08-28T07:16:50.7650095Z (node:1823) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-28T07:16:50.7650830Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-28T07:16:54.4378534Z [command]/usr/bin/chmod +x /home/runner/work/_temp/62b8d131-cad4-4a92-9f88-d97209791ea62026-08-28T07:16:54.5608596Z [command]/home/runner/bin/minikube version --short2026-08-28T07:16:54.5993963Z v1.38.12026-08-28T07:16:54.7382089Z Cache hit for: kic-v1.38.1-x642026-08-28T07:16:54.7487420Z (node:1823) [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:54.7519670Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-28T07:16:55.8746860Z Received 125829120 of 544082637 (23.1%), 119.9 MBs/sec2026-08-28T07:16:55.9041164Z Received 88080384 of 224218830 (39.3%), 83.3 MBs/sec2026-08-28T07:16:56.8764175Z Received 301989888 of 544082637 (55.5%), 143.8 MBs/sec2026-08-28T07:16:56.9054420Z Received 220024526 of 224218830 (98.1%), 104.3 MBs/sec2026-08-28T07:16:57.0544746Z Received 224218830 of 224218830 (100.0%), 99.0 MBs/sec2026-08-28T07:16:57.0545543Z Cache Size: ~214 MB (224218830 B)2026-08-28T07:16:57.1168904Z [command]/usr/bin/tar -xf /home/runner/work/_temp/642927d1-b641-4660-a32e-cd01a383181a/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-28T07:16:57.6414067Z Cache restored successfully2026-08-28T07:16:57.8814590Z Received 515899392 of 544082637 (94.8%), 163.8 MBs/sec2026-08-28T07:16:58.2089010Z Received 544082637 of 544082637 (100.0%), 155.6 MBs/sec2026-08-28T07:16:58.2090196Z Cache Size: ~519 MB (544082637 B)2026-08-28T07:16:58.2216886Z [command]/usr/bin/tar -xf /home/runner/work/_temp/15900e88-6b07-4102-b2ba-9f8b714ba03a/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-28T07:16:58.7622404Z Cache restored successfully2026-08-28T07:16:58.8330351Z [command]/home/runner/bin/minikube start --wait all2026-08-28T07:16:58.8706718Z * minikube v1.38.1 on Ubuntu 22.042026-08-28T07:17:03.8367500Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-28T07:17:03.8910550Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-28T07:17:03.8919020Z * Using Docker driver with root privileges2026-08-28T07:17:03.8928325Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-28T07:17:03.8935155Z * Pulling base image v0.0.50 ...2026-08-28T07:17:31.8745029Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-28T07:17:36.5105901Z * Verifying Kubernetes components...2026-08-28T07:17:36.5382062Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-28T07:17:36.9694595Z * Enabled addons: storage-provisioner, default-storageclass2026-08-28T07:18:13.0076242Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-28T07:18:13.0190825Z [command]/home/runner/bin/minikube version --short2026-08-28T07:18:13.0556200Z v1.38.12026-08-28T07:18:13.0795137Z ##[group]Run actions/setup-go@v62026-08-28T07:18:13.0795401Z with:2026-08-28T07:18:13.0795611Z go-version: 1.262026-08-28T07:18:13.0795812Z cache: true2026-08-28T07:18:13.0796032Z cache-dependency-path: go.sum2026-08-28T07:18:13.0796286Z check-latest: false2026-08-28T07:18:13.0799082Z token: ***2026-08-28T07:18:13.0799296Z ##[endgroup]2026-08-28T07:18:13.2048043Z Setup go version spec 1.262026-08-28T07:18:13.2728158Z Found in cache @ /opt/hostedtoolcache/go/1.26.7/x642026-08-28T07:18:13.2730006Z Added go to the path2026-08-28T07:18:13.2734436Z Successfully set up Go version 1.262026-08-28T07:18:14.7089638Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOMODCACHE2026-08-28T07:18:14.7123637Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOCACHE2026-08-28T07:18:14.7148755Z /home/runner/go/pkg/mod2026-08-28T07:18:14.7171524Z /home/runner/.cache/go-build2026-08-28T07:18:14.8629308Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-28T07:18:16.0194618Z Received 134217728 of 251715014 (53.3%), 125.2 MBs/sec2026-08-28T07:18:16.6170829Z Received 251715014 of 251715014 (100.0%), 148.0 MBs/sec2026-08-28T07:18:16.6184912Z Cache Size: ~240 MB (251715014 B)2026-08-28T07:18:16.6254194Z [command]/usr/bin/tar -xf /home/runner/work/_temp/71e543cf-6de7-49ee-b6ef-d5cb1b1ab976/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-28T07:18:18.5519321Z Cache restored successfully2026-08-28T07:18:18.5845082Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-28T07:18:18.5869316Z go version go1.26.7 linux/amd642026-08-28T07:18:18.5869546Z 2026-08-28T07:18:18.5869875Z ##[group]go env2026-08-28T07:18:18.6370834Z AR='ar'2026-08-28T07:18:18.6371377Z CC='gcc'2026-08-28T07:18:18.6371729Z CGO_CFLAGS='-O2 -g'2026-08-28T07:18:18.6372086Z CGO_CPPFLAGS=''2026-08-28T07:18:18.6372498Z CGO_CXXFLAGS='-O2 -g'2026-08-28T07:18:18.6372754Z CGO_ENABLED='1'2026-08-28T07:18:18.6372967Z CGO_FFLAGS='-O2 -g'2026-08-28T07:18:18.6373400Z CGO_LDFLAGS='-O2 -g'2026-08-28T07:18:18.6373629Z CXX='g++'2026-08-28T07:18:18.6373847Z GCCGO='gccgo'2026-08-28T07:18:18.6374136Z GO111MODULE=''2026-08-28T07:18:18.6374385Z GOAMD64='v1'2026-08-28T07:18:18.6374609Z GOARCH='amd64'2026-08-28T07:18:18.6374873Z GOAUTH='netrc'2026-08-28T07:18:18.6375122Z GOBIN=''2026-08-28T07:18:18.6375361Z GOCACHE='/home/runner/.cache/go-build'2026-08-28T07:18:18.6375726Z GOCACHEPROG=''2026-08-28T07:18:18.6376001Z GODEBUG=''2026-08-28T07:18:18.6376246Z GOENV='/home/runner/.config/go/env'2026-08-28T07:18:18.6376595Z GOEXE=''2026-08-28T07:18:18.6376788Z GOEXPERIMENT=''2026-08-28T07:18:18.6377008Z GOFIPS140='off'2026-08-28T07:18:18.6377252Z GOFLAGS=''2026-08-28T07:18:18.6377984Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build1596046189=/tmp/go-build -gno-record-gcc-switches'2026-08-28T07:18:18.6378790Z GOHOSTARCH='amd64'2026-08-28T07:18:18.6379097Z GOHOSTOS='linux'2026-08-28T07:18:18.6379343Z GOINSECURE=''2026-08-28T07:18:18.6379773Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-28T07:18:18.6380228Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-28T07:18:18.6380692Z GONOPROXY=''2026-08-28T07:18:18.6380907Z GONOSUMDB=''2026-08-28T07:18:18.6381100Z GOOS='linux'2026-08-28T07:18:18.6381317Z GOPATH='/home/runner/go'2026-08-28T07:18:18.6381551Z GOPRIVATE=''2026-08-28T07:18:18.6381824Z GOPROXY='https://proxy.golang.org,direct'2026-08-28T07:18:18.6382159Z GOROOT='/opt/hostedtoolcache/go/1.26.7/x64'2026-08-28T07:18:18.6382461Z GOSUMDB='sum.golang.org'2026-08-28T07:18:18.6382698Z GOTELEMETRY='local'2026-08-28T07:18:18.6382983Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-28T07:18:18.6383435Z GOTMPDIR=''2026-08-28T07:18:18.6383649Z GOTOOLCHAIN='local'2026-08-28T07:18:18.6384228Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.7/x64/pkg/tool/linux_amd64'2026-08-28T07:18:18.6384590Z GOVCS=''2026-08-28T07:18:18.6384792Z GOVERSION='go1.26.7'2026-08-28T07:18:18.6385017Z GOWORK=''2026-08-28T07:18:18.6385233Z PKG_CONFIG='pkg-config'2026-08-28T07:18:18.6385388Z 2026-08-28T07:18:18.6385727Z ##[endgroup]2026-08-28T07:18:18.6555067Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-28T07:18:18.6555548Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-28T07:18:18.6591697Z shell: /usr/bin/bash -e {0}2026-08-28T07:18:18.6591971Z env:2026-08-28T07:18:18.6592190Z GOTOOLCHAIN: local2026-08-28T07:18:18.6592436Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-08-28T07:18:18.6592710Z OSPOOL_EP_CMTag: 25.x-el92026-08-28T07:18:18.6592958Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-28T07:18:18.6593455Z ##[endgroup]2026-08-28T07:18:27.9961852Z === RUN TestOSPoolEP2026-08-28T07:18:27.9964163Z === PAUSE TestOSPoolEP2026-08-28T07:18:27.9964457Z === CONT TestOSPoolEP2026-08-28T07:18:27.9965158Z TestOSPoolEP 2026-08-28T07:18:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:28.0097715Z TestOSPoolEP 2026-08-28T07:18:28Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz apply -f /tmp/TestOSPoolEP1845411629]2026-08-28T07:18:28.2438779Z TestOSPoolEP 2026-08-28T07:18:28Z logger.go:67: pod/idtoken-generator created2026-08-28T07:18:28.2543548Z TestOSPoolEP 2026-08-28T07:18:28Z logger.go:67: secret/pool-passwd created2026-08-28T07:18:28.2575343Z TestOSPoolEP 2026-08-28T07:18:28Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-28T07:18:28.2578954Z TestOSPoolEP 2026-08-28T07:18:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:28.2595736Z TestOSPoolEP 2026-08-28T07:18:28Z 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:38.2595179Z TestOSPoolEP 2026-08-28T07:18:38Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-28T07:18:38.2596094Z TestOSPoolEP 2026-08-28T07:18:38Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:38.2620563Z TestOSPoolEP 2026-08-28T07:18:38Z logger.go:67: Pod is now available2026-08-28T07:18:38.2624135Z TestOSPoolEP 2026-08-28T07:18:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-28T07:18:38.3872199Z TestOSPoolEP 2026-08-28T07:18:38Z logger.go:67: ***2026-08-28T07:18:38.3922826Z TestOSPoolEP 2026-08-28T07:18:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz apply -f /tmp/TestOSPoolEP2947982927]2026-08-28T07:18:38.4853666Z TestOSPoolEP 2026-08-28T07:18:38Z logger.go:67: secret/pool-token created2026-08-28T07:18:38.4876862Z TestOSPoolEP 2026-08-28T07:18:38Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-28T07:18:38.4877816Z TestOSPoolEP 2026-08-28T07:18:38Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:38.4897173Z TestOSPoolEP 2026-08-28T07:18:38Z logger.go:67: Secret is now available2026-08-28T07:18:38.4922816Z TestOSPoolEP 2026-08-28T07:18:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz apply -k /tmp/kustomize-template-3725855231]2026-08-28T07:18:38.6281199Z TestOSPoolEP 2026-08-28T07:18:38Z logger.go:67: service/test-cm created2026-08-28T07:18:38.6341436Z TestOSPoolEP 2026-08-28T07:18:38Z 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:38.6343014Z TestOSPoolEP 2026-08-28T07:18:38Z logger.go:67: deployment.apps/ospool-ep created2026-08-28T07:18:38.6417341Z TestOSPoolEP 2026-08-28T07:18:38Z logger.go:67: deployment.apps/test-cm created2026-08-28T07:18:38.6474231Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-28T07:18:38.6477253Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:38Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:38.6497702Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:38Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-28T07:18:38.6510896Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:38Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:38.6513457Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:38Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-28T07:18:38.6515663Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:38Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:38.6628383Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:38Z 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-28T07:18:38.6660474Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:38Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available, missing 'Progressing' condition. Sleeping for 10s and will try again.2026-08-28T07:18:48.6629412Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:48Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-28T07:18:48.6631399Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:48Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:48.6651584Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:48Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-28T07:18:48.6669508Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:48Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:48.6719443Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:48Z 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-28T07:18:48.6724323Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:48Z logger.go:67: Deployment is now available2026-08-28T07:18:58.6727047Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:58Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-28T07:18:58.6729452Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:58Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:58.6752938Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-28T07:18:58Z logger.go:67: Deployment is now available2026-08-28T07:18:58.6754702Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-28T07:18:58.6755668Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-28T07:18:58.6756699Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-28T07:18:58.6757764Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-28T07:18:58.6758804Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-28T07:18:58.6767230Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-28T07:18:58.6768185Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-28T07:18:58.6769460Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-28T07:18:58.6771141Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:18:58Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:58.6773638Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-28T07:18:58Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:58.6775197Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-28T07:18:58.6776806Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:18:58Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:58.6784415Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-28T07:18:58Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:58.6797629Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:18:58Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:58.6810644Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:18:58Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:18:58.6817498Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-28T07:18:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_SINGULARITY]2026-08-28T07:18:58.6846211Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:18:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)']2026-08-28T07:18:58.6865043Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:18:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:18:58.8398755Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-28T07:18:58.8400437Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)']' in pod test-cm-5bb545475c-95mvd failed. Retrying in 10s.2026-08-28T07:18:58.8494660Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-28T07:18:58.8495754Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-95mvd failed. Retrying in 10s.2026-08-28T07:18:58.8506257Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-28T07:18:58.8508640Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-95mvd failed. Retrying in 30s.2026-08-28T07:19:08.8406536Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)']2026-08-28T07:19:08.8504546Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-28T07:19:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_SINGULARITY]2026-08-28T07:19:08.9638287Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-28T07:19:08.9639711Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-95mvd failed. Retrying in 10s.2026-08-28T07:19:08.9802985Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-28T07:19:08.9804192Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)']' in pod test-cm-5bb545475c-95mvd failed. Retrying in 10s.2026-08-28T07:19:18.9646318Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-28T07:19:18Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_SINGULARITY]2026-08-28T07:19:18.9809042Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:18Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)']2026-08-28T07:19:19.0768719Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-28T07:19:19Z logger.go:67: true2026-08-28T07:19:19.0967321Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:19Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-28T07:19:19.0969514Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:19Z logger.go:67: 2026-08-28T07:19:19.0971639Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:19Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-65c844ddbb-l2rdp LINUX X86_64 Unclaimed Idle 0.000 15987 0+00:00:002026-08-28T07:19:19.0973454Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:19Z logger.go:67: 2026-08-28T07:19:19.0975199Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:19Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-28T07:19:19.0977000Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:19Z logger.go:67: 2026-08-28T07:19:19.0978516Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:19Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-28T07:19:19.0979901Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:19Z logger.go:67: 2026-08-28T07:19:19.0981206Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-28T07:19:19Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-28T07:19:28.8518412Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:19:28Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:19:28.9482065Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:19:28Z logger.go:67: undefined2026-08-28T07:19:28.9517347Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-28T07:19:28.9518497Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-95mvd failed. Retrying in 30s.2026-08-28T07:19:58.9523911Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:19:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:19:59.0550349Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:19:59Z logger.go:67: undefined2026-08-28T07:19:59.0588357Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-95mvd failed. Retrying in 30s.2026-08-28T07:20:29.0597932Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:20:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:20:29.1614277Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:20:29Z logger.go:67: undefined2026-08-28T07:20:29.1655051Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-95mvd failed. Retrying in 30s.2026-08-28T07:20:59.1658461Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:20:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:20:59.3128269Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:20:59Z logger.go:67: undefined2026-08-28T07:20:59.3175895Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-95mvd failed. Retrying in 30s.2026-08-28T07:21:29.3177910Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:21:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:21:29.4127452Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:21:29Z logger.go:67: undefined2026-08-28T07:21:29.4164584Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-95mvd failed. Retrying in 30s.2026-08-28T07:21:59.4173577Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:21:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:21:59.5125341Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:21:59Z logger.go:67: undefined2026-08-28T07:21:59.5164201Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-95mvd failed. Retrying in 30s.2026-08-28T07:22:29.5174049Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:22:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:22:29.6232934Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:22:29Z logger.go:67: undefined2026-08-28T07:22:29.6272351Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-95mvd failed. Retrying in 30s.2026-08-28T07:22:59.6284926Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:22:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:22:59.7206161Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:22:59Z logger.go:67: undefined2026-08-28T07:22:59.7245347Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-95mvd failed. Retrying in 30s.2026-08-28T07:23:29.7254959Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:23:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:23:29.8196735Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:23:29Z logger.go:67: undefined2026-08-28T07:23:29.8237601Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-95mvd failed. Retrying in 30s.2026-08-28T07:23:59.8253918Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:23:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:23:59.9268991Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:23:59Z logger.go:67: undefined2026-08-28T07:23:59.9309142Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-95mvd failed. Retrying in 30s.2026-08-28T07:24:29.9312262Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:24:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz exec test-cm-5bb545475c-95mvd -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-l2rdp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-28T07:24:30.0429788Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-28T07:24:30Z logger.go:67: true2026-08-28T07:24:30.0473820Z TestOSPoolEP 2026-08-28T07:24:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:24:30.0550130Z TestOSPoolEP 2026-08-28T07:24:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:24:30.1672029Z TestOSPoolEP 2026-08-28T07:24:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:24:30.2495169Z TestOSPoolEP 2026-08-28T07:24:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:24:30.3119916Z TestOSPoolEP 2026-08-28T07:24:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:24:30.3145714Z === NAME TestOSPoolEP2026-08-28T07:24:30.3146354Z ospool_ep_test.go:101: ---2026-08-28T07:24:30.3146976Z Events for pod idtoken-generator:2026-08-28T07:24:30.3148227Z 2026-08-28 07:18:28 +0000 UTC Normal Successfully assigned test-ospool-ep-f7yruz/idtoken-generator to minikube2026-08-28T07:24:30.3149430Z 2026-08-28 07:18:29 +0000 UTC Normal Pulling image "htcondor/base"2026-08-28T07:24:30.3150942Z 2026-08-28 07:18:36 +0000 UTC Normal Successfully pulled image "htcondor/base" in 7.309s (7.309s including waiting). Image size: 522365028 bytes.2026-08-28T07:24:30.3152111Z 2026-08-28 07:18:36 +0000 UTC Normal Container created2026-08-28T07:24:30.3152849Z 2026-08-28 07:18:36 +0000 UTC Normal Container started2026-08-28T07:24:30.3153632Z 2026-08-28T07:24:30.3153952Z ---2026-08-28T07:24:30.3154795Z TestOSPoolEP 2026-08-28T07:24:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:24:30.3174944Z ospool_ep_test.go:101: ---2026-08-28T07:24:30.3175977Z Events for pod ospool-ep-65c844ddbb-l2rdp:2026-08-28T07:24:30.3177867Z 2026-08-28 07:18:38 +0000 UTC Normal Successfully assigned test-ospool-ep-f7yruz/ospool-ep-65c844ddbb-l2rdp to minikube2026-08-28T07:24:30.3186189Z 2026-08-28 07:18:39 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-28T07:24:30.3188238Z 2026-08-28 07:18:40 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.773s (1.773s including waiting). Image size: 5590942 bytes.2026-08-28T07:24:30.3189549Z 2026-08-28 07:18:40 +0000 UTC Normal Container created2026-08-28T07:24:30.3190386Z 2026-08-28 07:18:40 +0000 UTC Normal Container started2026-08-28T07:24:30.3191499Z 2026-08-28 07:18:41 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-08-28T07:24:30.3193615Z 2026-08-28 07:18:53 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 11.838s (12.244s including waiting). Image size: 1288058081 bytes.2026-08-28T07:24:30.3194970Z 2026-08-28 07:18:53 +0000 UTC Normal Container created2026-08-28T07:24:30.3195708Z 2026-08-28 07:18:53 +0000 UTC Normal Container started2026-08-28T07:24:30.3196220Z 2026-08-28T07:24:30.3196566Z ---2026-08-28T07:24:30.3197416Z TestOSPoolEP 2026-08-28T07:24:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:24:30.3199877Z ospool_ep_test.go:101: ---2026-08-28T07:24:30.3207034Z Events for pod test-cm-5bb545475c-95mvd:2026-08-28T07:24:30.3208359Z 2026-08-28 07:18:38 +0000 UTC Normal Successfully assigned test-ospool-ep-f7yruz/test-cm-5bb545475c-95mvd to minikube2026-08-28T07:24:30.3209522Z 2026-08-28 07:18:39 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-08-28T07:24:30.3211022Z 2026-08-28 07:18:41 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 1.053s (2.812s including waiting). Image size: 522365054 bytes.2026-08-28T07:24:30.3212246Z 2026-08-28 07:18:41 +0000 UTC Normal Container created2026-08-28T07:24:30.3212990Z 2026-08-28 07:18:41 +0000 UTC Normal Container started2026-08-28T07:24:30.3216959Z 2026-08-28T07:24:30.3217275Z ---2026-08-28T07:24:30.3218125Z TestOSPoolEP 2026-08-28T07:24:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-28T07:24:30.3234990Z TestOSPoolEP 2026-08-28T07:24:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz delete -f /tmp/TestOSPoolEP4074420231]2026-08-28T07:24:30.3744312Z TestOSPoolEP 2026-08-28T07:24:30Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-f7yruz namespace2026-08-28T07:24:30.3802218Z TestOSPoolEP 2026-08-28T07:24:30Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-f7yruz namespace2026-08-28T07:24:31.5597093Z TestOSPoolEP 2026-08-28T07:24:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz delete -f /tmp/TestOSPoolEP3399532662]2026-08-28T07:24:31.6091593Z TestOSPoolEP 2026-08-28T07:24:31Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-f7yruz namespace2026-08-28T07:24:31.6129050Z TestOSPoolEP 2026-08-28T07:24:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-f7yruz delete -k /tmp/kustomize-template-3725855231]2026-08-28T07:24:31.6861310Z TestOSPoolEP 2026-08-28T07:24:31Z logger.go:67: service "test-cm" deleted from test-ospool-ep-f7yruz namespace2026-08-28T07:24:31.6888787Z TestOSPoolEP 2026-08-28T07:24:31Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-f7yruz namespace2026-08-28T07:24:31.6966998Z TestOSPoolEP 2026-08-28T07:24:31Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-f7yruz namespace2026-08-28T07:24:31.7031679Z --- PASS: TestOSPoolEP (32.34s)2026-08-28T07:24:31.7057384Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (20.03s)2026-08-28T07:24:31.7058371Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.41s)2026-08-28T07:24:31.7059571Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.43s)2026-08-28T07:24:31.7060430Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (331.37s)2026-08-28T07:24:31.7060993Z PASS2026-08-28T07:24:31.7071281Z ok github.com/osg-htc/k8s-integration-tests/test 363.722s2026-08-28T07:24:31.7662093Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-28T07:24:31.7662728Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-28T07:24:31.7711195Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-28T07:24:31.7711696Z env:2026-08-28T07:24:31.7712004Z GOTOOLCHAIN: local2026-08-28T07:24:31.7712642Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-28T07:24:31.7713480Z ##[endgroup]2026-08-28T07:24:31.7863701Z 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:31.7865109Z ##[group]Run actions/upload-artifact@v42026-08-28T07:24:31.7865385Z with:2026-08-28T07:24:31.7865959Z name: TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe52026-08-28T07:24:31.7866406Z path: /tmp/k8s-tests2026-08-28T07:24:31.7866627Z retention-days: 52026-08-28T07:24:31.7866859Z if-no-files-found: warn2026-08-28T07:24:31.7867092Z compression-level: 62026-08-28T07:24:31.7867317Z overwrite: false2026-08-28T07:24:31.7867701Z include-hidden-files: false2026-08-28T07:24:31.7867950Z env:2026-08-28T07:24:31.7868136Z GOTOOLCHAIN: local2026-08-28T07:24:31.7868387Z ##[endgroup]2026-08-28T07:24:31.9757113Z (node:17316) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-28T07:24:31.9758086Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-28T07:24:31.9856117Z With the provided path, there will be 6 files uploaded2026-08-28T07:24:31.9857284Z Artifact name is valid!2026-08-28T07:24:31.9859586Z Root directory input is valid!2026-08-28T07:24:32.2607625Z Beginning upload of artifact content to blob storage2026-08-28T07:24:32.2891274Z (node:17316) [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:32.4945892Z Uploaded bytes 140872026-08-28T07:24:32.5359832Z Finished uploading artifact content to blob storage!2026-08-28T07:24:32.5361027Z SHA256 digest of uploaded artifact zip is e97750a033e6b3a678493eb6140c0a8ef526f929b6ebacda1f14d093b7a419162026-08-28T07:24:32.5364205Z Finalizing artifact upload2026-08-28T07:24:32.7685982Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5.zip successfully finalized. Artifact ID 96778088572026-08-28T07:24:32.7687995Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5 has been successfully uploaded! Final size is 14087 bytes. Artifact ID is 96778088572026-08-28T07:24:32.7693322Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/33150867377/artifacts/96778088572026-08-28T07:24:32.7843884Z Post job cleanup.2026-08-28T07:24:32.9114529Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOCACHE2026-08-28T07:24:32.9156676Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOMODCACHE2026-08-28T07:24:32.9193924Z /home/runner/.cache/go-build2026-08-28T07:24:32.9202347Z /home/runner/go/pkg/mod2026-08-28T07:24:32.9231725Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-28T07:24:32.9486490Z Post job cleanup.2026-08-28T07:24:33.0397643Z [command]/usr/bin/git version2026-08-28T07:24:33.0452453Z git version 2.55.02026-08-28T07:24:33.0501062Z Temporarily overriding HOME='/home/runner/work/_temp/e4264f1e-874a-4d61-90e7-96badd01968c' before making global git config changes2026-08-28T07:24:33.0511657Z Adding repository directory to the temporary git global config as a safe directory2026-08-28T07:24:33.0514415Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-28T07:24:33.0554324Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-28T07:24:33.0595354Z [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:33.0869339Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-28T07:24:33.0894565Z http.https://github.com/.extraheader2026-08-28T07:24:33.0905824Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-28T07:24:33.0941752Z [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:33.1156982Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-28T07:24:33.1191224Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-28T07:24:33.1581829Z Cleaning up orphan processes2026-08-28T07:24:33.2175803Z ##[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/