2026-08-29T04:28:10.9570939Z Current runner version: '2.336.0'2026-08-29T04:28:10.9591690Z ##[group]Runner Image Provisioner2026-08-29T04:28:10.9592539Z Hosted Compute Agent2026-08-29T04:28:10.9593154Z Version: 20260819.5862026-08-29T04:28:10.9593775Z Commit: 3cc4a88dfa507ef76119ad1bb3eccc6378bb2b762026-08-29T04:28:10.9594462Z Build Date: 2026-08-18T23:20:18Z2026-08-29T04:28:10.9595156Z Worker ID: {1d86326e-1573-4fa2-a8b4-c6d59eb2e663}2026-08-29T04:28:10.9595840Z Azure Region: westcentralus2026-08-29T04:28:10.9596419Z ##[endgroup]2026-08-29T04:28:10.9597664Z ##[group]Operating System2026-08-29T04:28:10.9598485Z Ubuntu2026-08-29T04:28:10.9599051Z 22.04.52026-08-29T04:28:10.9599539Z LTS2026-08-29T04:28:10.9600035Z ##[endgroup]2026-08-29T04:28:10.9600580Z ##[group]Runner Image2026-08-29T04:28:10.9601139Z Image: ubuntu-22.042026-08-29T04:28:10.9601707Z Version: 20260824.273.32026-08-29T04:28:10.9602886Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260824.273/images/ubuntu/Ubuntu2204-Readme.md2026-08-29T04:28:10.9604365Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260824.2732026-08-29T04:28:10.9605256Z ##[endgroup]2026-08-29T04:28:10.9608523Z ##[group]GITHUB_TOKEN Permissions2026-08-29T04:28:10.9610842Z Actions: write2026-08-29T04:28:10.9611674Z ArtifactMetadata: write2026-08-29T04:28:10.9612297Z Attestations: write2026-08-29T04:28:10.9612845Z Checks: write2026-08-29T04:28:10.9613378Z CodeQuality: write2026-08-29T04:28:10.9613925Z Contents: write2026-08-29T04:28:10.9614473Z CopilotRequests: write2026-08-29T04:28:10.9615034Z Deployments: write2026-08-29T04:28:10.9615599Z Discussions: write2026-08-29T04:28:10.9616152Z Drives: write2026-08-29T04:28:10.9616674Z Issues: write2026-08-29T04:28:10.9617190Z Metadata: read2026-08-29T04:28:10.9617779Z Models: read2026-08-29T04:28:10.9618433Z Packages: write2026-08-29T04:28:10.9618989Z Pages: write2026-08-29T04:28:10.9619510Z PullRequests: write2026-08-29T04:28:10.9620071Z RepositoryProjects: write2026-08-29T04:28:10.9620721Z SecurityEvents: write2026-08-29T04:28:10.9621242Z Statuses: write2026-08-29T04:28:10.9621842Z VulnerabilityAlerts: read2026-08-29T04:28:10.9622398Z ##[endgroup]2026-08-29T04:28:10.9624403Z Secret source: Actions2026-08-29T04:28:10.9625482Z Prepare workflow directory2026-08-29T04:28:10.9929341Z Prepare all required actions2026-08-29T04:28:10.9978472Z Getting action download info2026-08-29T04:28:11.3511613Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-29T04:28:11.5733080Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-29T04:28:12.0787404Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-29T04:28:12.6536689Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-29T04:28:12.9175811Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-29T04:28:12.9180351Z ##[group] Inputs2026-08-29T04:28:12.9180959Z testName: TestOSPoolEP2026-08-29T04:28:12.9181832Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-29T04:28:12.9182833Z setupScript: 2026-08-29T04:28:12.9183320Z setupEnv: {}2026-08-29T04:28:12.9183809Z ##[endgroup]2026-08-29T04:28:12.9184585Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-testing) / Run Tests2026-08-29T04:28:12.9782259Z ##[group]Run actions/checkout@v52026-08-29T04:28:12.9783082Z with:2026-08-29T04:28:12.9783724Z repository: osg-htc/k8s-integration-tests2026-08-29T04:28:12.9787797Z token: ***2026-08-29T04:28:12.9788522Z ssh-strict: true2026-08-29T04:28:12.9789041Z ssh-user: git2026-08-29T04:28:12.9789549Z persist-credentials: true2026-08-29T04:28:12.9790101Z clean: true2026-08-29T04:28:12.9790601Z sparse-checkout-cone-mode: true2026-08-29T04:28:12.9791405Z fetch-depth: 12026-08-29T04:28:12.9791881Z fetch-tags: false2026-08-29T04:28:12.9792363Z show-progress: true2026-08-29T04:28:12.9792897Z lfs: false2026-08-29T04:28:12.9793384Z submodules: false2026-08-29T04:28:12.9793907Z set-safe-directory: true2026-08-29T04:28:12.9794459Z allow-unsafe-pr-checkout: false2026-08-29T04:28:12.9795189Z ##[endgroup]2026-08-29T04:28:13.0762351Z Syncing repository: osg-htc/k8s-integration-tests2026-08-29T04:28:13.0764048Z ##[group]Getting Git version info2026-08-29T04:28:13.0765172Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-29T04:28:13.0766448Z [command]/usr/bin/git version2026-08-29T04:28:13.0810545Z git version 2.55.02026-08-29T04:28:13.0830801Z ##[endgroup]2026-08-29T04:28:13.0846207Z Temporarily overriding HOME='/home/runner/work/_temp/32a35ab0-adce-4a9d-85b7-ae14c6978bf6' before making global git config changes2026-08-29T04:28:13.0849115Z Adding repository directory to the temporary git global config as a safe directory2026-08-29T04:28:13.0851418Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-29T04:28:13.0884773Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-29T04:28:13.0888455Z ##[group]Initializing the repository2026-08-29T04:28:13.0900105Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-29T04:28:13.0979637Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-29T04:28:13.0981765Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-29T04:28:13.0983555Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-29T04:28:13.0984926Z hint: call:2026-08-29T04:28:13.0985903Z hint:2026-08-29T04:28:13.0986954Z hint: git config --global init.defaultBranch <name>2026-08-29T04:28:13.0988291Z hint:2026-08-29T04:28:13.0989509Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-29T04:28:13.0991083Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-29T04:28:13.0992511Z hint:2026-08-29T04:28:13.0993506Z hint: git branch -m <name>2026-08-29T04:28:13.0994519Z hint:2026-08-29T04:28:13.0995823Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-29T04:28:13.0997805Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-29T04:28:13.1001486Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-08-29T04:28:13.1016455Z ##[endgroup]2026-08-29T04:28:13.1017618Z ##[group]Disabling automatic garbage collection2026-08-29T04:28:13.1020613Z [command]/usr/bin/git config --local gc.auto 02026-08-29T04:28:13.1048615Z ##[endgroup]2026-08-29T04:28:13.1049749Z ##[group]Setting up auth2026-08-29T04:28:13.1054618Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-29T04:28:13.1084144Z [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-29T04:28:13.1395811Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-29T04:28:13.1438780Z [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-29T04:28:13.1629365Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-29T04:28:13.1660383Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-29T04:28:13.1854437Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-29T04:28:13.1884551Z ##[endgroup]2026-08-29T04:28:13.1885569Z ##[group]Fetching the repository2026-08-29T04:28:13.1892882Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-29T04:28:13.6530260Z From https://github.com/osg-htc/k8s-integration-tests2026-08-29T04:28:13.6532769Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-29T04:28:13.6538027Z ##[endgroup]2026-08-29T04:28:13.6540132Z ##[group]Determining the checkout info2026-08-29T04:28:13.6542195Z ##[endgroup]2026-08-29T04:28:13.6544400Z [command]/usr/bin/git sparse-checkout disable2026-08-29T04:28:13.6586880Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-29T04:28:13.6614916Z ##[group]Checking out the ref2026-08-29T04:28:13.6619085Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-29T04:28:13.6686420Z Switched to a new branch 'main'2026-08-29T04:28:13.6688779Z branch 'main' set up to track 'origin/main'.2026-08-29T04:28:13.6696131Z ##[endgroup]2026-08-29T04:28:13.6726996Z [command]/usr/bin/git log -1 --format=%H2026-08-29T04:28:13.6748339Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-29T04:28:13.7001177Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-29T04:28:13.7003956Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-29T04:28:13.7006575Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-29T04:28:13.7236839Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-29T04:28:13.7238745Z env:2026-08-29T04:28:13.7240711Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-29T04:28:13.7242970Z SETUP_ENV_YAML: {}2026-08-29T04:28:13.7244013Z ##[endgroup]2026-08-29T04:28:14.6987659Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-29T04:28:14.6990367Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-29T04:28:14.7038928Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-29T04:28:14.7040361Z env:2026-08-29T04:28:14.7042137Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-29T04:28:14.7044182Z ##[endgroup]2026-08-29T04:28:14.7217243Z ##[group]Run true2026-08-29T04:28:14.7218420Z [36;1mtrue[0m2026-08-29T04:28:14.7261921Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-29T04:28:14.7263287Z ##[endgroup]2026-08-29T04:28:14.7527004Z ##[group]Run medyagh/setup-minikube@latest2026-08-29T04:28:14.7528207Z with:2026-08-29T04:28:14.7528985Z start: true2026-08-29T04:28:14.7529797Z cache: true2026-08-29T04:28:14.7530681Z minikube-version: latest2026-08-29T04:28:14.7531706Z wait: all2026-08-29T04:28:14.7532480Z ##[endgroup]2026-08-29T04:28:14.8726387Z (node:1920) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-29T04:28:14.8729485Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-29T04:28:16.3937230Z [command]/usr/bin/chmod +x /home/runner/work/_temp/9df813b7-c722-4c22-9051-0b3dd7887baa2026-08-29T04:28:17.0794915Z [command]/home/runner/bin/minikube version --short2026-08-29T04:28:17.1558308Z v1.38.12026-08-29T04:28:17.4060749Z Cache hit for: kic-v1.38.1-x642026-08-29T04:28:17.4162275Z (node:1920) [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-29T04:28:17.4169862Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-29T04:28:18.6232265Z Received 79691776 of 544082637 (14.6%), 76.0 MBs/sec2026-08-29T04:28:19.6240233Z Received 268435456 of 544082637 (49.3%), 127.9 MBs/sec2026-08-29T04:28:20.6244474Z Received 452984832 of 544082637 (83.3%), 143.9 MBs/sec2026-08-29T04:28:21.2359385Z Received 544082637 of 544082637 (100.0%), 143.6 MBs/sec2026-08-29T04:28:21.2360535Z Cache Size: ~519 MB (544082637 B)2026-08-29T04:28:21.2478954Z [command]/usr/bin/tar -xf /home/runner/work/_temp/2622cf90-bd48-4a88-a5f3-40e8e1c9422d/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-29T04:28:21.8174590Z Cache restored successfully2026-08-29T04:28:23.6300772Z Received 96468992 of 224218830 (43.0%), 92.0 MBs/sec2026-08-29T04:28:24.4161313Z Received 224218830 of 224218830 (100.0%), 119.7 MBs/sec2026-08-29T04:28:24.4162094Z Cache Size: ~214 MB (224218830 B)2026-08-29T04:28:24.4230237Z [command]/usr/bin/tar -xf /home/runner/work/_temp/ef265be7-4dca-498e-9a5a-064798987cf3/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-29T04:28:24.9132432Z Cache restored successfully2026-08-29T04:28:24.9425312Z [command]/home/runner/bin/minikube start --wait all2026-08-29T04:28:24.9793898Z * minikube v1.38.1 on Ubuntu 22.042026-08-29T04:28:27.9684690Z * Automatically selected the docker driver. Other choices: podman, ssh, none2026-08-29T04:28:28.0160077Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-29T04:28:28.0171476Z * Using Docker driver with root privileges2026-08-29T04:28:28.0184298Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-29T04:28:28.0192401Z * Pulling base image v0.0.50 ...2026-08-29T04:29:03.5834349Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-29T04:29:08.2186892Z * Verifying Kubernetes components...2026-08-29T04:29:08.2381272Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-29T04:29:08.7570078Z * Enabled addons: storage-provisioner, default-storageclass2026-08-29T04:29:48.6143167Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-29T04:29:48.6226540Z [command]/home/runner/bin/minikube version --short2026-08-29T04:29:48.6618096Z v1.38.12026-08-29T04:29:48.6839679Z ##[group]Run actions/setup-go@v62026-08-29T04:29:48.6840090Z with:2026-08-29T04:29:48.6840383Z go-version: 1.262026-08-29T04:29:48.6840732Z cache: true2026-08-29T04:29:48.6841062Z cache-dependency-path: go.sum2026-08-29T04:29:48.6841432Z check-latest: false2026-08-29T04:29:48.6844029Z token: ***2026-08-29T04:29:48.6844357Z ##[endgroup]2026-08-29T04:29:48.8043066Z Setup go version spec 1.262026-08-29T04:29:48.8102922Z Found in cache @ /opt/hostedtoolcache/go/1.26.7/x642026-08-29T04:29:48.8104904Z Added go to the path2026-08-29T04:29:48.8108022Z Successfully set up Go version 1.262026-08-29T04:29:49.9662508Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOMODCACHE2026-08-29T04:29:49.9692788Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOCACHE2026-08-29T04:29:49.9716776Z /home/runner/go/pkg/mod2026-08-29T04:29:49.9735837Z /home/runner/.cache/go-build2026-08-29T04:29:50.1596106Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-29T04:29:51.3971502Z Received 67108864 of 251715014 (26.7%), 64.0 MBs/sec2026-08-29T04:29:52.3978612Z Received 239075328 of 251715014 (95.0%), 113.9 MBs/sec2026-08-29T04:29:52.5641820Z Received 251715014 of 251715014 (100.0%), 110.8 MBs/sec2026-08-29T04:29:52.5643327Z Cache Size: ~240 MB (251715014 B)2026-08-29T04:29:52.5709022Z [command]/usr/bin/tar -xf /home/runner/work/_temp/f42b5e02-7e75-415c-814e-ee2a34e95132/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-29T04:29:54.4298084Z Cache restored successfully2026-08-29T04:29:54.4624285Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-29T04:29:54.4651922Z go version go1.26.7 linux/amd642026-08-29T04:29:54.4652325Z 2026-08-29T04:29:54.4653002Z ##[group]go env2026-08-29T04:29:54.5164449Z AR='ar'2026-08-29T04:29:54.5164930Z CC='gcc'2026-08-29T04:29:54.5165576Z CGO_CFLAGS='-O2 -g'2026-08-29T04:29:54.5166149Z CGO_CPPFLAGS=''2026-08-29T04:29:54.5166794Z CGO_CXXFLAGS='-O2 -g'2026-08-29T04:29:54.5167276Z CGO_ENABLED='1'2026-08-29T04:29:54.5167773Z CGO_FFLAGS='-O2 -g'2026-08-29T04:29:54.5168309Z CGO_LDFLAGS='-O2 -g'2026-08-29T04:29:54.5169522Z CXX='g++'2026-08-29T04:29:54.5170027Z GCCGO='gccgo'2026-08-29T04:29:54.5170524Z GO111MODULE=''2026-08-29T04:29:54.5171053Z GOAMD64='v1'2026-08-29T04:29:54.5171446Z GOARCH='amd64'2026-08-29T04:29:54.5171807Z GOAUTH='netrc'2026-08-29T04:29:54.5172225Z GOBIN=''2026-08-29T04:29:54.5172642Z GOCACHE='/home/runner/.cache/go-build'2026-08-29T04:29:54.5173037Z GOCACHEPROG=''2026-08-29T04:29:54.5173382Z GODEBUG=''2026-08-29T04:29:54.5173752Z GOENV='/home/runner/.config/go/env'2026-08-29T04:29:54.5174156Z GOEXE=''2026-08-29T04:29:54.5174473Z GOEXPERIMENT=''2026-08-29T04:29:54.5174846Z GOFIPS140='off'2026-08-29T04:29:54.5175145Z GOFLAGS=''2026-08-29T04:29:54.5176000Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build1189352023=/tmp/go-build -gno-record-gcc-switches'2026-08-29T04:29:54.5176712Z GOHOSTARCH='amd64'2026-08-29T04:29:54.5177100Z GOHOSTOS='linux'2026-08-29T04:29:54.5177405Z GOINSECURE=''2026-08-29T04:29:54.5178121Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-29T04:29:54.5178761Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-29T04:29:54.5179186Z GONOPROXY=''2026-08-29T04:29:54.5179482Z GONOSUMDB=''2026-08-29T04:29:54.5179819Z GOOS='linux'2026-08-29T04:29:54.5180153Z GOPATH='/home/runner/go'2026-08-29T04:29:54.5180503Z GOPRIVATE=''2026-08-29T04:29:54.5180936Z GOPROXY='https://proxy.golang.org,direct'2026-08-29T04:29:54.5181371Z GOROOT='/opt/hostedtoolcache/go/1.26.7/x64'2026-08-29T04:29:54.5181816Z GOSUMDB='sum.golang.org'2026-08-29T04:29:54.5182152Z GOTELEMETRY='local'2026-08-29T04:29:54.5182576Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-29T04:29:54.5183008Z GOTMPDIR=''2026-08-29T04:29:54.5183579Z GOTOOLCHAIN='local'2026-08-29T04:29:54.5184014Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.7/x64/pkg/tool/linux_amd64'2026-08-29T04:29:54.5184503Z GOVCS=''2026-08-29T04:29:54.5184831Z GOVERSION='go1.26.7'2026-08-29T04:29:54.5185208Z GOWORK=''2026-08-29T04:29:54.5185536Z PKG_CONFIG='pkg-config'2026-08-29T04:29:54.5185755Z 2026-08-29T04:29:54.5186196Z ##[endgroup]2026-08-29T04:29:54.5362198Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-29T04:29:54.5362901Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-29T04:29:54.5402875Z shell: /usr/bin/bash -e {0}2026-08-29T04:29:54.5403281Z env:2026-08-29T04:29:54.5403709Z GOTOOLCHAIN: local2026-08-29T04:29:54.5404074Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-08-29T04:29:54.5404509Z OSPOOL_EP_CMTag: 25.x-el92026-08-29T04:29:54.5404862Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-29T04:29:54.5405268Z ##[endgroup]2026-08-29T04:30:01.9764431Z === RUN TestOSPoolEP2026-08-29T04:30:01.9767017Z === PAUSE TestOSPoolEP2026-08-29T04:30:01.9767582Z === CONT TestOSPoolEP2026-08-29T04:30:01.9769218Z TestOSPoolEP 2026-08-29T04:30:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:02.0844716Z TestOSPoolEP 2026-08-29T04:30:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp apply -f /tmp/TestOSPoolEP658221086]2026-08-29T04:30:02.8375848Z TestOSPoolEP 2026-08-29T04:30:02Z logger.go:67: pod/idtoken-generator created2026-08-29T04:30:02.8641455Z TestOSPoolEP 2026-08-29T04:30:02Z logger.go:67: secret/pool-passwd created2026-08-29T04:30:02.8678022Z TestOSPoolEP 2026-08-29T04:30:02Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-29T04:30:02.8680601Z TestOSPoolEP 2026-08-29T04:30:02Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:02.8806058Z TestOSPoolEP 2026-08-29T04:30:02Z 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-29T04:30:12.8813418Z TestOSPoolEP 2026-08-29T04:30:12Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-29T04:30:12.8815236Z TestOSPoolEP 2026-08-29T04:30:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:12.8851955Z TestOSPoolEP 2026-08-29T04:30:12Z 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-29T04:30:22.8852256Z TestOSPoolEP 2026-08-29T04:30:22Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-29T04:30:22.8853744Z TestOSPoolEP 2026-08-29T04:30:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:22.8876061Z TestOSPoolEP 2026-08-29T04:30:22Z logger.go:67: Pod is now available2026-08-29T04:30:22.8877712Z TestOSPoolEP 2026-08-29T04:30:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-29T04:30:23.3933051Z TestOSPoolEP 2026-08-29T04:30:23Z logger.go:67: ***2026-08-29T04:30:23.3975682Z TestOSPoolEP 2026-08-29T04:30:23Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp apply -f /tmp/TestOSPoolEP1517663640]2026-08-29T04:30:23.4813508Z TestOSPoolEP 2026-08-29T04:30:23Z logger.go:67: secret/pool-token created2026-08-29T04:30:23.4831675Z TestOSPoolEP 2026-08-29T04:30:23Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-29T04:30:23.4832870Z TestOSPoolEP 2026-08-29T04:30:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:23.4853896Z TestOSPoolEP 2026-08-29T04:30:23Z logger.go:67: Secret is now available2026-08-29T04:30:23.4868951Z TestOSPoolEP 2026-08-29T04:30:23Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp apply -k /tmp/kustomize-template-2636847504]2026-08-29T04:30:23.6126458Z TestOSPoolEP 2026-08-29T04:30:23Z logger.go:67: service/test-cm created2026-08-29T04:30:23.6222555Z TestOSPoolEP 2026-08-29T04:30:23Z logger.go:67: deployment.apps/ospool-ep created2026-08-29T04:30:23.6224646Z TestOSPoolEP 2026-08-29T04:30:23Z 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-29T04:30:23.6287255Z TestOSPoolEP 2026-08-29T04:30:23Z logger.go:67: deployment.apps/test-cm created2026-08-29T04:30:23.6356075Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-29T04:30:23.6360305Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:23.6456679Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:23Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-29T04:30:23.6459682Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:23.6461791Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:23Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-29T04:30:23.6464064Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:23.6503077Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:23Z 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-29T04:30:23.6513332Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:23Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "test-cm-5bb545475c". Sleeping for 10s and will try again.2026-08-29T04:30:33.6511575Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:33Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-29T04:30:33.6513801Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:33Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:33.6533172Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:33Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-29T04:30:33.6540271Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:33Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:33.6566281Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:33Z 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-29T04:30:33.6569206Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:33Z logger.go:67: Deployment is now available2026-08-29T04:30:43.6573290Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:43Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-29T04:30:43.6575584Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:43.6607287Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:43Z 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-29T04:30:53.6613754Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:53Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-29T04:30:53.6615475Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:53Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:53.6645841Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-29T04:30:53Z logger.go:67: Deployment is now available2026-08-29T04:30:53.6647471Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-29T04:30:53.6648723Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-29T04:30:53.6649744Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-29T04:30:53.6650930Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-29T04:30:53.6653658Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-29T04:30:53.6654975Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-29T04:30:53.6655857Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-29T04:30:53.6657411Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-29T04:30:53.6660214Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:30:53Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:53.6661434Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:30:53Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:53.6662329Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-29T04:30:53.6664031Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-29T04:30:53Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:53.6680577Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:30:53Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:53.6682884Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-29T04:30:53Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:53.6684736Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:30:53Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:30:53.6711828Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:30:53Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:30:53.6750825Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-29T04:30:53Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_SINGULARITY]2026-08-29T04:30:53.6779802Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:30:53Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)']2026-08-29T04:30:53.7912171Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-29T04:30:53.7914219Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-c5qfg failed. Retrying in 30s.2026-08-29T04:30:53.8636348Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-29T04:30:53.8640313Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)']' in pod test-cm-5bb545475c-c5qfg failed. Retrying in 10s.2026-08-29T04:30:53.8641667Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-29T04:30:53.8643328Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-c5qfg failed. Retrying in 10s.2026-08-29T04:31:03.8642744Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-29T04:31:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_SINGULARITY]2026-08-29T04:31:03.8648457Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:31:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)']2026-08-29T04:31:03.9809401Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-29T04:31:03.9811317Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)']' in pod test-cm-5bb545475c-c5qfg failed. Retrying in 10s.2026-08-29T04:31:03.9815835Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-29T04:31:03.9817433Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-c5qfg failed. Retrying in 10s.2026-08-29T04:31:13.9827753Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-29T04:31:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_SINGULARITY]2026-08-29T04:31:13.9831446Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:31:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)']2026-08-29T04:31:14.0915073Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:31:14Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-29T04:31:14.0916668Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:31:14Z logger.go:67: 2026-08-29T04:31:14.0918653Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:31:14Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-65c844ddbb-8mdv4 LINUX X86_64 Unclaimed Idle 0.000 15987 0+00:00:002026-08-29T04:31:14.0920226Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:31:14Z logger.go:67: 2026-08-29T04:31:14.0921713Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:31:14Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-29T04:31:14.0922956Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:31:14Z logger.go:67: 2026-08-29T04:31:14.0924814Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:31:14Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-29T04:31:14.0925977Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:31:14Z logger.go:67: 2026-08-29T04:31:14.0927294Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-29T04:31:14Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-29T04:31:14.0948710Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-29T04:31:14Z logger.go:67: true2026-08-29T04:31:23.7919742Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:31:23Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:31:23.8862815Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:31:23Z logger.go:67: undefined2026-08-29T04:31:23.8902011Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-29T04:31:23.8903576Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-c5qfg failed. Retrying in 30s.2026-08-29T04:31:53.8909580Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:31:53Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:31:54.0069894Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:31:54Z logger.go:67: undefined2026-08-29T04:31:54.0108067Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-c5qfg failed. Retrying in 30s.2026-08-29T04:32:24.0112626Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:32:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:32:24.1401308Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:32:24Z logger.go:67: undefined2026-08-29T04:32:24.1426995Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-c5qfg failed. Retrying in 30s.2026-08-29T04:32:54.1432119Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:32:54Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:32:54.2862146Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:32:54Z logger.go:67: undefined2026-08-29T04:32:54.2899434Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-c5qfg failed. Retrying in 30s.2026-08-29T04:33:24.2913207Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:33:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:33:24.4041688Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:33:24Z logger.go:67: undefined2026-08-29T04:33:24.4075579Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-c5qfg failed. Retrying in 30s.2026-08-29T04:33:54.4095217Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:33:54Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:33:54.5028511Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:33:54Z logger.go:67: undefined2026-08-29T04:33:54.5073838Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-c5qfg failed. Retrying in 30s.2026-08-29T04:34:24.5075762Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:34:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:34:24.6139357Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:34:24Z logger.go:67: undefined2026-08-29T04:34:24.6189960Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-c5qfg failed. Retrying in 30s.2026-08-29T04:34:54.6193979Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:34:54Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:34:54.7155373Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:34:54Z logger.go:67: undefined2026-08-29T04:34:54.7187340Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-c5qfg failed. Retrying in 30s.2026-08-29T04:35:24.7197367Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:35:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:35:24.8181525Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:35:24Z logger.go:67: undefined2026-08-29T04:35:24.8214664Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-c5qfg failed. Retrying in 30s.2026-08-29T04:35:54.8240597Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:35:54Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:35:54.9225108Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:35:54Z logger.go:67: undefined2026-08-29T04:35:54.9259456Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-c5qfg failed. Retrying in 30s.2026-08-29T04:36:24.9262233Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:36:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp exec test-cm-5bb545475c-c5qfg -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-8mdv4",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-29T04:36:25.0241372Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-29T04:36:25Z logger.go:67: true2026-08-29T04:36:25.0275128Z TestOSPoolEP 2026-08-29T04:36:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:36:25.0347304Z TestOSPoolEP 2026-08-29T04:36:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:36:25.1172374Z TestOSPoolEP 2026-08-29T04:36:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:36:25.1866504Z TestOSPoolEP 2026-08-29T04:36:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:36:25.2424775Z TestOSPoolEP 2026-08-29T04:36:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:36:25.2445769Z === NAME TestOSPoolEP2026-08-29T04:36:25.2446657Z ospool_ep_test.go:101: ---2026-08-29T04:36:25.2447412Z Events for pod idtoken-generator:2026-08-29T04:36:25.2449192Z 2026-08-29 04:30:02 +0000 UTC Normal Successfully assigned test-ospool-ep-wfq4wp/idtoken-generator to minikube2026-08-29T04:36:25.2450539Z 2026-08-29 04:30:08 +0000 UTC Normal Pulling image "htcondor/base"2026-08-29T04:36:25.2452132Z 2026-08-29 04:30:18 +0000 UTC Normal Successfully pulled image "htcondor/base" in 10.366s (10.366s including waiting). Image size: 522365028 bytes.2026-08-29T04:36:25.2453431Z 2026-08-29 04:30:18 +0000 UTC Normal Container created2026-08-29T04:36:25.2454253Z 2026-08-29 04:30:18 +0000 UTC Normal Container started2026-08-29T04:36:25.2454884Z 2026-08-29T04:36:25.2455279Z ---2026-08-29T04:36:25.2456708Z TestOSPoolEP 2026-08-29T04:36:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:36:25.2469428Z ospool_ep_test.go:101: ---2026-08-29T04:36:25.2470386Z Events for pod ospool-ep-65c844ddbb-8mdv4:2026-08-29T04:36:25.2472365Z 2026-08-29 04:30:23 +0000 UTC Normal Successfully assigned test-ospool-ep-wfq4wp/ospool-ep-65c844ddbb-8mdv4 to minikube2026-08-29T04:36:25.2473837Z 2026-08-29 04:30:24 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-29T04:36:25.2475662Z 2026-08-29 04:30:26 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 2.439s (2.439s including waiting). Image size: 5590942 bytes.2026-08-29T04:36:25.2476984Z 2026-08-29 04:30:26 +0000 UTC Normal Container created2026-08-29T04:36:25.2477799Z 2026-08-29 04:30:26 +0000 UTC Normal Container started2026-08-29T04:36:25.2478832Z 2026-08-29 04:30:27 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-08-29T04:36:25.2480165Z 2026-08-29 04:30:48 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 20.533s (20.96s including waiting). Image size: 1288058081 bytes.2026-08-29T04:36:25.2481068Z 2026-08-29 04:30:48 +0000 UTC Normal Container created2026-08-29T04:36:25.2481670Z 2026-08-29 04:30:48 +0000 UTC Normal Container started2026-08-29T04:36:25.2482116Z 2026-08-29T04:36:25.2482445Z ---2026-08-29T04:36:25.2483097Z TestOSPoolEP 2026-08-29T04:36:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:36:25.2499832Z ospool_ep_test.go:101: ---2026-08-29T04:36:25.2500677Z Events for pod test-cm-5bb545475c-c5qfg:2026-08-29T04:36:25.2501964Z 2026-08-29 04:30:23 +0000 UTC Normal Successfully assigned test-ospool-ep-wfq4wp/test-cm-5bb545475c-c5qfg to minikube2026-08-29T04:36:25.2503359Z 2026-08-29 04:30:24 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-08-29T04:36:25.2504860Z 2026-08-29 04:30:27 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 1.215s (3.637s including waiting). Image size: 522365054 bytes.2026-08-29T04:36:25.2506142Z 2026-08-29 04:30:27 +0000 UTC Normal Container created2026-08-29T04:36:25.2506741Z 2026-08-29 04:30:27 +0000 UTC Normal Container started2026-08-29T04:36:25.2507177Z 2026-08-29T04:36:25.2507516Z ---2026-08-29T04:36:25.2508543Z TestOSPoolEP 2026-08-29T04:36:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-29T04:36:25.2541233Z TestOSPoolEP 2026-08-29T04:36:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp delete -f /tmp/TestOSPoolEP1835989513]2026-08-29T04:36:25.3041537Z TestOSPoolEP 2026-08-29T04:36:25Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-wfq4wp namespace2026-08-29T04:36:25.3122630Z TestOSPoolEP 2026-08-29T04:36:25Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-wfq4wp namespace2026-08-29T04:36:26.3594228Z TestOSPoolEP 2026-08-29T04:36:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp delete -f /tmp/TestOSPoolEP1389298890]2026-08-29T04:36:26.4073467Z TestOSPoolEP 2026-08-29T04:36:26Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-wfq4wp namespace2026-08-29T04:36:26.4105672Z TestOSPoolEP 2026-08-29T04:36:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wfq4wp delete -k /tmp/kustomize-template-2636847504]2026-08-29T04:36:26.4706731Z TestOSPoolEP 2026-08-29T04:36:26Z logger.go:67: service "test-cm" deleted from test-ospool-ep-wfq4wp namespace2026-08-29T04:36:26.4756359Z TestOSPoolEP 2026-08-29T04:36:26Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-wfq4wp namespace2026-08-29T04:36:26.4784836Z TestOSPoolEP 2026-08-29T04:36:26Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-wfq4wp namespace2026-08-29T04:36:26.5043242Z --- PASS: TestOSPoolEP (53.16s)2026-08-29T04:36:26.5094694Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.03s)2026-08-29T04:36:26.5117787Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.43s)2026-08-29T04:36:26.5152766Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.43s)2026-08-29T04:36:26.5160399Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (331.36s)2026-08-29T04:36:26.5161604Z PASS2026-08-29T04:36:26.5162679Z ok github.com/osg-htc/k8s-integration-tests/test 384.542s2026-08-29T04:36:26.5718438Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-29T04:36:26.5719762Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-29T04:36:26.5775577Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-29T04:36:26.5776081Z env:2026-08-29T04:36:26.5776430Z GOTOOLCHAIN: local2026-08-29T04:36:26.5777017Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-29T04:36:26.5777553Z ##[endgroup]2026-08-29T04:36:26.5936303Z 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-29T04:36:26.5938117Z ##[group]Run actions/upload-artifact@v42026-08-29T04:36:26.5938589Z with:2026-08-29T04:36:26.5939240Z name: TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe52026-08-29T04:36:26.5939862Z path: /tmp/k8s-tests2026-08-29T04:36:26.5940304Z retention-days: 52026-08-29T04:36:26.5940686Z if-no-files-found: warn2026-08-29T04:36:26.5941117Z compression-level: 62026-08-29T04:36:26.5941549Z overwrite: false2026-08-29T04:36:26.5941971Z include-hidden-files: false2026-08-29T04:36:26.5942375Z env:2026-08-29T04:36:26.5942757Z GOTOOLCHAIN: local2026-08-29T04:36:26.5943120Z ##[endgroup]2026-08-29T04:36:26.7958601Z (node:17522) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-29T04:36:26.7960181Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-29T04:36:26.8028373Z With the provided path, there will be 6 files uploaded2026-08-29T04:36:26.8029734Z Artifact name is valid!2026-08-29T04:36:26.8030436Z Root directory input is valid!2026-08-29T04:36:27.1599598Z Beginning upload of artifact content to blob storage2026-08-29T04:36:27.1862478Z (node:17522) [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-29T04:36:27.4728574Z Uploaded bytes 141282026-08-29T04:36:27.5373245Z Finished uploading artifact content to blob storage!2026-08-29T04:36:27.5374433Z SHA256 digest of uploaded artifact zip is dcd2ae24f86b00c81054b05141578e3c899ba23c0c5a60c5c46de4422dcf74b12026-08-29T04:36:27.5376655Z Finalizing artifact upload2026-08-29T04:36:27.7953874Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5.zip successfully finalized. Artifact ID 97094105622026-08-29T04:36:27.7955677Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5 has been successfully uploaded! Final size is 14128 bytes. Artifact ID is 97094105622026-08-29T04:36:27.7961158Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/33233886885/artifacts/97094105622026-08-29T04:36:27.8101825Z Post job cleanup.2026-08-29T04:36:27.9296603Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOMODCACHE2026-08-29T04:36:27.9349776Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOCACHE2026-08-29T04:36:27.9377966Z /home/runner/go/pkg/mod2026-08-29T04:36:27.9430215Z /home/runner/.cache/go-build2026-08-29T04:36:27.9431874Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-29T04:36:27.9591137Z Post job cleanup.2026-08-29T04:36:28.0447545Z [command]/usr/bin/git version2026-08-29T04:36:28.0486239Z git version 2.55.02026-08-29T04:36:28.0523453Z Temporarily overriding HOME='/home/runner/work/_temp/c505a0c4-8e08-458c-9382-a1a91bddcb19' before making global git config changes2026-08-29T04:36:28.0524988Z Adding repository directory to the temporary git global config as a safe directory2026-08-29T04:36:28.0528299Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-29T04:36:28.0564476Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-29T04:36:28.0596421Z [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-29T04:36:28.0810809Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-29T04:36:28.0831634Z http.https://github.com/.extraheader2026-08-29T04:36:28.0840450Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-29T04:36:28.0872502Z [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-29T04:36:28.1081268Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-29T04:36:28.1111056Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-29T04:36:28.1426891Z Cleaning up orphan processes2026-08-29T04:36:28.2001313Z ##[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/