2026-09-01T02:14:36.4203107Z Current runner version: '2.337.0'2026-09-01T02:14:36.4223280Z ##[group]Runner Image Provisioner2026-09-01T02:14:36.4224041Z Hosted Compute Agent2026-09-01T02:14:36.4224501Z Version: 20260819.5862026-09-01T02:14:36.4225017Z Commit: 3cc4a88dfa507ef76119ad1bb3eccc6378bb2b762026-09-01T02:14:36.4225653Z Build Date: 2026-08-18T23:20:18Z2026-09-01T02:14:36.4226202Z Worker ID: {ce69039d-b598-4390-bf13-b0c93f1fe8d5}2026-09-01T02:14:36.4226704Z Azure Region: centralus2026-09-01T02:14:36.4227169Z ##[endgroup]2026-09-01T02:14:36.4228304Z ##[group]Operating System2026-09-01T02:14:36.4228771Z Ubuntu2026-09-01T02:14:36.4229228Z 22.04.52026-09-01T02:14:36.4230018Z LTS2026-09-01T02:14:36.4230401Z ##[endgroup]2026-09-01T02:14:36.4230806Z ##[group]Runner Image2026-09-01T02:14:36.4231231Z Image: ubuntu-22.042026-09-01T02:14:36.4231657Z Version: 20260824.273.32026-09-01T02:14:36.4232566Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260824.273/images/ubuntu/Ubuntu2204-Readme.md2026-09-01T02:14:36.4233797Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260824.2732026-09-01T02:14:36.4234639Z ##[endgroup]2026-09-01T02:14:36.4236801Z ##[group]GITHUB_TOKEN Permissions2026-09-01T02:14:36.4239020Z Actions: write2026-09-01T02:14:36.4239883Z ArtifactMetadata: write2026-09-01T02:14:36.4240331Z Attestations: write2026-09-01T02:14:36.4240751Z Checks: write2026-09-01T02:14:36.4241149Z CodeQuality: write2026-09-01T02:14:36.4241598Z Contents: write2026-09-01T02:14:36.4242060Z CopilotRequests: write2026-09-01T02:14:36.4242692Z Deployments: write2026-09-01T02:14:36.4243140Z Discussions: write2026-09-01T02:14:36.4243535Z Drives: write2026-09-01T02:14:36.4243970Z Issues: write2026-09-01T02:14:36.4244364Z Metadata: read2026-09-01T02:14:36.4244809Z Models: read2026-09-01T02:14:36.4245165Z Packages: write2026-09-01T02:14:36.4245582Z Pages: write2026-09-01T02:14:36.4246009Z PullRequests: write2026-09-01T02:14:36.4246491Z RepositoryProjects: write2026-09-01T02:14:36.4246993Z SecurityEvents: write2026-09-01T02:14:36.4247513Z Statuses: write2026-09-01T02:14:36.4247948Z VulnerabilityAlerts: read2026-09-01T02:14:36.4248362Z ##[endgroup]2026-09-01T02:14:36.4250243Z Secret source: Actions2026-09-01T02:14:36.4251100Z Prepare workflow directory2026-09-01T02:14:36.4617402Z Prepare all required actions2026-09-01T02:14:36.4660442Z Getting action download info2026-09-01T02:14:36.7289712Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-09-01T02:14:36.9378166Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-09-01T02:14:37.3027801Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-09-01T02:14:37.6575658Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-09-01T02:14:37.9572825Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-09-01T02:14:37.9576996Z ##[group] Inputs2026-09-01T02:14:37.9577829Z testName: TestOSPoolEP2026-09-01T02:14:37.9579134Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-09-01T02:14:37.9580751Z setupScript: 2026-09-01T02:14:37.9581473Z setupEnv: {}2026-09-01T02:14:37.9582213Z ##[endgroup]2026-09-01T02:14:37.9583296Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-09-01T02:14:38.0193305Z ##[group]Run actions/checkout@v52026-09-01T02:14:38.0194414Z with:2026-09-01T02:14:38.0195151Z repository: osg-htc/k8s-integration-tests2026-09-01T02:14:38.0201892Z token: ***2026-09-01T02:14:38.0202613Z ssh-strict: true2026-09-01T02:14:38.0203365Z ssh-user: git2026-09-01T02:14:38.0204090Z persist-credentials: true2026-09-01T02:14:38.0204843Z clean: true2026-09-01T02:14:38.0205537Z sparse-checkout-cone-mode: true2026-09-01T02:14:38.0206610Z fetch-depth: 12026-09-01T02:14:38.0207286Z fetch-tags: false2026-09-01T02:14:38.0207997Z show-progress: true2026-09-01T02:14:38.0208739Z lfs: false2026-09-01T02:14:38.0209381Z submodules: false2026-09-01T02:14:38.0210231Z set-safe-directory: true2026-09-01T02:14:38.0211026Z allow-unsafe-pr-checkout: false2026-09-01T02:14:38.0212077Z ##[endgroup]2026-09-01T02:14:38.1053432Z Syncing repository: osg-htc/k8s-integration-tests2026-09-01T02:14:38.1056472Z ##[group]Getting Git version info2026-09-01T02:14:38.1058421Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-09-01T02:14:38.1060912Z [command]/usr/bin/git version2026-09-01T02:14:38.1098341Z git version 2.55.02026-09-01T02:14:38.1113799Z ##[endgroup]2026-09-01T02:14:38.1123240Z Temporarily overriding HOME='/home/runner/work/_temp/33799370-eabd-49f9-bea5-d0b0d0e9c185' before making global git config changes2026-09-01T02:14:38.1127407Z Adding repository directory to the temporary git global config as a safe directory2026-09-01T02:14:38.1129649Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-09-01T02:14:38.1156909Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-09-01T02:14:38.1161029Z ##[group]Initializing the repository2026-09-01T02:14:38.1165925Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-09-01T02:14:38.3035623Z hint: Using 'master' as the name for the initial branch. This default branch name2026-09-01T02:14:38.3037980Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-09-01T02:14:38.3039265Z hint: to use in all of your new repositories, which will suppress this warning,2026-09-01T02:14:38.3040491Z hint: call:2026-09-01T02:14:38.3041323Z hint:2026-09-01T02:14:38.3042263Z hint: git config --global init.defaultBranch <name>2026-09-01T02:14:38.3043116Z hint:2026-09-01T02:14:38.3044014Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-09-01T02:14:38.3044962Z hint: 'development'. The just-created branch can be renamed via this command:2026-09-01T02:14:38.3045752Z hint:2026-09-01T02:14:38.3046400Z hint: git branch -m <name>2026-09-01T02:14:38.3047032Z hint:2026-09-01T02:14:38.3047782Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-09-01T02:14:38.3048898Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-09-01T02:14:38.3051398Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-09-01T02:14:38.3073138Z ##[endgroup]2026-09-01T02:14:38.3073904Z ##[group]Disabling automatic garbage collection2026-09-01T02:14:38.3076746Z [command]/usr/bin/git config --local gc.auto 02026-09-01T02:14:38.3099651Z ##[endgroup]2026-09-01T02:14:38.3100528Z ##[group]Setting up auth2026-09-01T02:14:38.3103675Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-09-01T02:14:38.3125887Z [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-09-01T02:14:38.3389178Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-09-01T02:14:38.3410849Z [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-09-01T02:14:38.3555065Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-09-01T02:14:38.3576771Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-09-01T02:14:38.3720280Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-09-01T02:14:38.3743951Z ##[endgroup]2026-09-01T02:14:38.3744757Z ##[group]Fetching the repository2026-09-01T02:14:38.3750108Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-09-01T02:14:38.7876342Z From https://github.com/osg-htc/k8s-integration-tests2026-09-01T02:14:38.7877222Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-09-01T02:14:38.7880950Z ##[endgroup]2026-09-01T02:14:38.7882039Z ##[group]Determining the checkout info2026-09-01T02:14:38.7883270Z ##[endgroup]2026-09-01T02:14:38.7889055Z [command]/usr/bin/git sparse-checkout disable2026-09-01T02:14:38.7916926Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-09-01T02:14:38.7938405Z ##[group]Checking out the ref2026-09-01T02:14:38.7941817Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-09-01T02:14:38.7989121Z Switched to a new branch 'main'2026-09-01T02:14:38.7989950Z branch 'main' set up to track 'origin/main'.2026-09-01T02:14:38.7996698Z ##[endgroup]2026-09-01T02:14:38.8018199Z [command]/usr/bin/git log -1 --format=%H2026-09-01T02:14:38.8034428Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-09-01T02:14:38.8212918Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-09-01T02:14:38.8213780Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-09-01T02:14:38.8214488Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-09-01T02:14:38.8572814Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-09-01T02:14:38.8573447Z env:2026-09-01T02:14:38.8574167Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-09-01T02:14:38.8574837Z SETUP_ENV_YAML: {}2026-09-01T02:14:38.8575281Z ##[endgroup]2026-09-01T02:14:38.9773302Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-09-01T02:14:38.9774053Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-09-01T02:14:38.9813477Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-09-01T02:14:38.9814018Z env:2026-09-01T02:14:38.9814677Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-09-01T02:14:38.9815297Z ##[endgroup]2026-09-01T02:14:38.9922261Z ##[group]Run true2026-09-01T02:14:38.9922739Z [36;1mtrue[0m2026-09-01T02:14:38.9954923Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-09-01T02:14:38.9955480Z ##[endgroup]2026-09-01T02:14:39.0086885Z ##[group]Run medyagh/setup-minikube@latest2026-09-01T02:14:39.0087387Z with:2026-09-01T02:14:39.0087812Z start: true2026-09-01T02:14:39.0088226Z cache: true2026-09-01T02:14:39.0088655Z minikube-version: latest2026-09-01T02:14:39.0089127Z wait: all2026-09-01T02:14:39.0089713Z ##[endgroup]2026-09-01T02:14:39.0981200Z (node:1731) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-09-01T02:14:39.0982196Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-09-01T02:14:40.0074253Z [command]/usr/bin/chmod +x /home/runner/work/_temp/4600cb75-f863-45c1-b096-fab2d1ae491a2026-09-01T02:14:40.7313671Z [command]/home/runner/bin/minikube version --short2026-09-01T02:14:40.8255805Z v1.38.12026-09-01T02:14:40.9504894Z Cache hit for: kic-v1.38.1-x642026-09-01T02:14:40.9583733Z (node:1731) [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-09-01T02:14:40.9590836Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-09-01T02:14:42.0942860Z Received 130023424 of 224218830 (58.0%), 123.9 MBs/sec2026-09-01T02:14:42.1154681Z Received 130023424 of 544082637 (23.9%), 124.0 MBs/sec2026-09-01T02:14:42.7508098Z Received 224218830 of 224218830 (100.0%), 129.0 MBs/sec2026-09-01T02:14:42.7508618Z Cache Size: ~214 MB (224218830 B)2026-09-01T02:14:42.8073803Z [command]/usr/bin/tar -xf /home/runner/work/_temp/4d5353f1-d9ae-4407-be35-312616ed713e/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-09-01T02:14:43.1196961Z Received 268435456 of 544082637 (49.3%), 127.7 MBs/sec2026-09-01T02:14:43.2275688Z Cache restored successfully2026-09-01T02:14:44.1216528Z Received 469762048 of 544082637 (86.3%), 149.0 MBs/sec2026-09-01T02:14:44.5261289Z Received 544082637 of 544082637 (100.0%), 152.2 MBs/sec2026-09-01T02:14:44.5262646Z Cache Size: ~519 MB (544082637 B)2026-09-01T02:14:44.5372562Z [command]/usr/bin/tar -xf /home/runner/work/_temp/0a6516a8-bdad-4139-94ed-76db14960b89/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-09-01T02:14:45.0002297Z Cache restored successfully2026-09-01T02:14:45.0621873Z [command]/home/runner/bin/minikube start --wait all2026-09-01T02:14:45.1352221Z * minikube v1.38.1 on Ubuntu 22.042026-09-01T02:14:45.9221743Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-09-01T02:14:45.9647525Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-09-01T02:14:45.9658715Z * Using Docker driver with root privileges2026-09-01T02:14:45.9675481Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-09-01T02:14:45.9685330Z * Pulling base image v0.0.50 ...2026-09-01T02:15:19.2337387Z * Configuring bridge CNI (Container Networking Interface) ...2026-09-01T02:15:23.8888666Z * Verifying Kubernetes components...2026-09-01T02:15:23.9051262Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-09-01T02:15:24.2409898Z * Enabled addons: storage-provisioner, default-storageclass2026-09-01T02:15:39.3073103Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-09-01T02:15:39.3189715Z [command]/home/runner/bin/minikube version --short2026-09-01T02:15:39.3519387Z v1.38.12026-09-01T02:15:39.3733894Z ##[group]Run actions/setup-go@v62026-09-01T02:15:39.3734174Z with:2026-09-01T02:15:39.3734434Z go-version: 1.262026-09-01T02:15:39.3734653Z cache: true2026-09-01T02:15:39.3734897Z cache-dependency-path: go.sum2026-09-01T02:15:39.3735165Z check-latest: false2026-09-01T02:15:39.3737070Z token: ***2026-09-01T02:15:39.3737287Z ##[endgroup]2026-09-01T02:15:39.4648987Z Setup go version spec 1.262026-09-01T02:15:39.4718944Z Found in cache @ /opt/hostedtoolcache/go/1.26.7/x642026-09-01T02:15:39.4720973Z Added go to the path2026-09-01T02:15:39.4723288Z Successfully set up Go version 1.262026-09-01T02:15:39.6342799Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOMODCACHE2026-09-01T02:15:39.6379076Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOCACHE2026-09-01T02:15:39.6393602Z /home/runner/go/pkg/mod2026-09-01T02:15:39.6410351Z /home/runner/.cache/go-build2026-09-01T02:15:39.7777030Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-09-01T02:15:40.9408759Z Received 134217728 of 251715014 (53.3%), 125.5 MBs/sec2026-09-01T02:15:41.5071045Z Received 251715014 of 251715014 (100.0%), 151.2 MBs/sec2026-09-01T02:15:41.5071660Z Cache Size: ~240 MB (251715014 B)2026-09-01T02:15:41.5132914Z [command]/usr/bin/tar -xf /home/runner/work/_temp/ee102a11-9a9b-4757-ba19-65411cff74ed/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-09-01T02:15:42.9485077Z Cache restored successfully2026-09-01T02:15:42.9733188Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-09-01T02:15:42.9761246Z go version go1.26.7 linux/amd642026-09-01T02:15:42.9761551Z 2026-09-01T02:15:42.9761969Z ##[group]go env2026-09-01T02:15:42.9987747Z AR='ar'2026-09-01T02:15:42.9988134Z CC='gcc'2026-09-01T02:15:42.9988492Z CGO_CFLAGS='-O2 -g'2026-09-01T02:15:42.9988848Z CGO_CPPFLAGS=''2026-09-01T02:15:42.9989137Z CGO_CXXFLAGS='-O2 -g'2026-09-01T02:15:42.9989646Z CGO_ENABLED='1'2026-09-01T02:15:42.9989909Z CGO_FFLAGS='-O2 -g'2026-09-01T02:15:42.9990250Z CGO_LDFLAGS='-O2 -g'2026-09-01T02:15:42.9990547Z CXX='g++'2026-09-01T02:15:42.9990839Z GCCGO='gccgo'2026-09-01T02:15:42.9991131Z GO111MODULE=''2026-09-01T02:15:42.9991432Z GOAMD64='v1'2026-09-01T02:15:42.9991694Z GOARCH='amd64'2026-09-01T02:15:42.9992006Z GOAUTH='netrc'2026-09-01T02:15:42.9992275Z GOBIN=''2026-09-01T02:15:42.9992568Z GOCACHE='/home/runner/.cache/go-build'2026-09-01T02:15:42.9992937Z GOCACHEPROG=''2026-09-01T02:15:42.9993235Z GODEBUG=''2026-09-01T02:15:42.9993520Z GOENV='/home/runner/.config/go/env'2026-09-01T02:15:42.9993876Z GOEXE=''2026-09-01T02:15:42.9994131Z GOEXPERIMENT=''2026-09-01T02:15:42.9994483Z GOFIPS140='off'2026-09-01T02:15:42.9994774Z GOFLAGS=''2026-09-01T02:15:42.9995547Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build3764725870=/tmp/go-build -gno-record-gcc-switches'2026-09-01T02:15:42.9996221Z GOHOSTARCH='amd64'2026-09-01T02:15:42.9996543Z GOHOSTOS='linux'2026-09-01T02:15:42.9996850Z GOINSECURE=''2026-09-01T02:15:42.9997315Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-09-01T02:15:42.9997813Z GOMODCACHE='/home/runner/go/pkg/mod'2026-09-01T02:15:42.9998135Z GONOPROXY=''2026-09-01T02:15:42.9998439Z GONOSUMDB=''2026-09-01T02:15:42.9998677Z GOOS='linux'2026-09-01T02:15:42.9999011Z GOPATH='/home/runner/go'2026-09-01T02:15:42.9999308Z GOPRIVATE=''2026-09-01T02:15:42.9999830Z GOPROXY='https://proxy.golang.org,direct'2026-09-01T02:15:43.0000187Z GOROOT='/opt/hostedtoolcache/go/1.26.7/x64'2026-09-01T02:15:43.0000619Z GOSUMDB='sum.golang.org'2026-09-01T02:15:43.0000929Z GOTELEMETRY='local'2026-09-01T02:15:43.0001281Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-09-01T02:15:43.0001689Z GOTMPDIR=''2026-09-01T02:15:43.0001927Z GOTOOLCHAIN='local'2026-09-01T02:15:43.0002628Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.7/x64/pkg/tool/linux_amd64'2026-09-01T02:15:43.0003018Z GOVCS=''2026-09-01T02:15:43.0003304Z GOVERSION='go1.26.7'2026-09-01T02:15:43.0003626Z GOWORK=''2026-09-01T02:15:43.0003958Z PKG_CONFIG='pkg-config'2026-09-01T02:15:43.0004166Z 2026-09-01T02:15:43.0004588Z ##[endgroup]2026-09-01T02:15:43.0149076Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-09-01T02:15:43.0149812Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-09-01T02:15:43.0182625Z shell: /usr/bin/bash -e {0}2026-09-01T02:15:43.0183009Z env:2026-09-01T02:15:43.0183243Z GOTOOLCHAIN: local2026-09-01T02:15:43.0183551Z OSPOOL_EP_OSPoolEPTag: 25-release2026-09-01T02:15:43.0183846Z OSPOOL_EP_CMTag: 25.0-el92026-09-01T02:15:43.0184145Z OSPOOL_EP_CvmfsType: cvmfsexec2026-09-01T02:15:43.0184431Z ##[endgroup]2026-09-01T02:15:48.9952684Z === RUN TestOSPoolEP2026-09-01T02:15:48.9954992Z === PAUSE TestOSPoolEP2026-09-01T02:15:48.9955347Z === CONT TestOSPoolEP2026-09-01T02:15:48.9956049Z TestOSPoolEP 2026-09-01T02:15:48Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:15:49.0020983Z TestOSPoolEP 2026-09-01T02:15:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou apply -f /tmp/TestOSPoolEP3232367810]2026-09-01T02:15:49.1363010Z TestOSPoolEP 2026-09-01T02:15:49Z logger.go:67: pod/idtoken-generator created2026-09-01T02:15:49.1462776Z TestOSPoolEP 2026-09-01T02:15:49Z logger.go:67: secret/pool-passwd created2026-09-01T02:15:49.1478323Z TestOSPoolEP 2026-09-01T02:15:49Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-09-01T02:15:49.1479324Z TestOSPoolEP 2026-09-01T02:15:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:15:49.1497541Z TestOSPoolEP 2026-09-01T02:15:49Z 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-09-01T02:15:59.1499888Z TestOSPoolEP 2026-09-01T02:15:59Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-09-01T02:15:59.1500832Z TestOSPoolEP 2026-09-01T02:15:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:15:59.1531566Z TestOSPoolEP 2026-09-01T02:15:59Z 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-09-01T02:16:09.1533364Z TestOSPoolEP 2026-09-01T02:16:09Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-09-01T02:16:09.1534284Z TestOSPoolEP 2026-09-01T02:16:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:09.1558190Z TestOSPoolEP 2026-09-01T02:16:09Z 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-09-01T02:16:19.1567203Z TestOSPoolEP 2026-09-01T02:16:19Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-09-01T02:16:19.1568044Z TestOSPoolEP 2026-09-01T02:16:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:19.1589929Z TestOSPoolEP 2026-09-01T02:16:19Z logger.go:67: Pod is now available2026-09-01T02:16:19.1591087Z TestOSPoolEP 2026-09-01T02:16:19Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-09-01T02:16:19.2372351Z TestOSPoolEP 2026-09-01T02:16:19Z logger.go:67: ***2026-09-01T02:16:19.2410712Z TestOSPoolEP 2026-09-01T02:16:19Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou apply -f /tmp/TestOSPoolEP3939748894]2026-09-01T02:16:19.3052289Z TestOSPoolEP 2026-09-01T02:16:19Z logger.go:67: secret/pool-token created2026-09-01T02:16:19.3069328Z TestOSPoolEP 2026-09-01T02:16:19Z retry.go:91: Wait for secret pool-token to be provisioned.2026-09-01T02:16:19.3070746Z TestOSPoolEP 2026-09-01T02:16:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:19.3466079Z TestOSPoolEP 2026-09-01T02:16:19Z logger.go:67: Secret is now available2026-09-01T02:16:19.3483430Z TestOSPoolEP 2026-09-01T02:16:19Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou apply -k /tmp/kustomize-template-3508267409]2026-09-01T02:16:19.4564117Z TestOSPoolEP 2026-09-01T02:16:19Z logger.go:67: service/test-cm created2026-09-01T02:16:19.4633629Z TestOSPoolEP 2026-09-01T02:16:19Z 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-09-01T02:16:19.4635361Z TestOSPoolEP 2026-09-01T02:16:19Z logger.go:67: deployment.apps/ospool-ep created2026-09-01T02:16:19.4726432Z TestOSPoolEP 2026-09-01T02:16:19Z logger.go:67: deployment.apps/test-cm created2026-09-01T02:16:19.4744105Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-09-01T02:16:19.4745903Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:19.4776757Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:19Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-09-01T02:16:19.4782376Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:19.4783690Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:19Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-09-01T02:16:19.4784510Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:19Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:19.4794602Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:19Z 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-09-01T02:16:19.4833649Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:19Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-6c7d796845". Sleeping for 10s and will try again.2026-09-01T02:16:29.4804340Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:29Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-09-01T02:16:29.4805878Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:29.4835395Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:29Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-09-01T02:16:29.4836566Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:29Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:29.4956387Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:29Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "test-cm-54b7d49f85" is progressing.. Sleeping for 10s and will try again.2026-09-01T02:16:29.4959153Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:29Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-09-01T02:16:39.4956132Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:39Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-09-01T02:16:39.4957227Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:39.4959391Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:39Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-09-01T02:16:39.4960974Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:39.4984314Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:39Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-09-01T02:16:39.4986423Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:39Z logger.go:67: Deployment is now available2026-09-01T02:16:49.4988147Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:49Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-09-01T02:16:49.4988966Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:49.5012680Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:49Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-09-01T02:16:59.5022622Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:59Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-09-01T02:16:59.5023477Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:59.5047645Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-09-01T02:16:59Z logger.go:67: Deployment is now available2026-09-01T02:16:59.5048369Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-09-01T02:16:59.5049011Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-09-01T02:16:59.5049622Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-09-01T02:16:59.5050213Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-09-01T02:16:59.5050765Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-09-01T02:16:59.5051245Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-09-01T02:16:59.5051736Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-09-01T02:16:59.5052534Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-09-01T02:16:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:59.5060188Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-09-01T02:16:59.5061490Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:16:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:59.5062348Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-09-01T02:16:59.5063735Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-09-01T02:16:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:59.5076470Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-09-01T02:16:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:59.5077623Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-09-01T02:16:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:59.5080788Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:16:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:16:59.5105233Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-09-01T02:16:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou exec test-cm-54b7d49f85-6fmjh -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)']2026-09-01T02:16:59.5107562Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-09-01T02:16:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou exec test-cm-54b7d49f85-6fmjh -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_SINGULARITY]2026-09-01T02:16:59.5109403Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:16:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou exec test-cm-54b7d49f85-6fmjh -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-09-01T02:16:59.6225150Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-09-01T02:16:59.6226745Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)']' in pod test-cm-54b7d49f85-6fmjh failed. Retrying in 10s.2026-09-01T02:16:59.6244936Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-09-01T02:16:59.6246501Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-6fmjh failed. Retrying in 30s.2026-09-01T02:16:59.6254379Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-09-01T02:16:59.6255216Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-6fmjh failed. Retrying in 10s.2026-09-01T02:17:09.6226832Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-09-01T02:17:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou exec test-cm-54b7d49f85-6fmjh -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)']2026-09-01T02:17:09.6258577Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-09-01T02:17:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou exec test-cm-54b7d49f85-6fmjh -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_SINGULARITY]2026-09-01T02:17:09.7207537Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-09-01T02:17:09Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-09-01T02:17:09.7211865Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-09-01T02:17:09Z logger.go:67: 2026-09-01T02:17:09.7225629Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-09-01T02:17:09Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-lmcvs LINUX X86_64 Unclaimed Idle 0.000 15987 0+00:00:002026-09-01T02:17:09.7235511Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-09-01T02:17:09Z logger.go:67: 2026-09-01T02:17:09.7236399Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-09-01T02:17:09Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-09-01T02:17:09.7242313Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-09-01T02:17:09Z logger.go:67: 2026-09-01T02:17:09.7245815Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-09-01T02:17:09Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-09-01T02:17:09.7246769Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-09-01T02:17:09Z logger.go:67: 2026-09-01T02:17:09.7251446Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-09-01T02:17:09Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-09-01T02:17:09.7259698Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-09-01T02:17:09Z logger.go:67: true2026-09-01T02:17:29.6255777Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:17:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou exec test-cm-54b7d49f85-6fmjh -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-09-01T02:17:29.7058387Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:17:29Z logger.go:67: undefined2026-09-01T02:17:29.7087198Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-09-01T02:17:29.7088171Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-6fmjh failed. Retrying in 30s.2026-09-01T02:17:59.7098818Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:17:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou exec test-cm-54b7d49f85-6fmjh -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-09-01T02:17:59.7888745Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:17:59Z logger.go:67: undefined2026-09-01T02:17:59.7922149Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-6fmjh failed. Retrying in 30s.2026-09-01T02:18:29.7925022Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:18:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou exec test-cm-54b7d49f85-6fmjh -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-09-01T02:18:29.8764508Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:18:29Z logger.go:67: undefined2026-09-01T02:18:29.8788179Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-6fmjh failed. Retrying in 30s.2026-09-01T02:18:59.8792120Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:18:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou exec test-cm-54b7d49f85-6fmjh -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-09-01T02:18:59.9574956Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:18:59Z logger.go:67: undefined2026-09-01T02:18:59.9605785Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-6fmjh failed. Retrying in 30s.2026-09-01T02:19:29.9613878Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:19:29Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou exec test-cm-54b7d49f85-6fmjh -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-09-01T02:19:30.0399701Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:19:30Z logger.go:67: undefined2026-09-01T02:19:30.0429313Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-6fmjh failed. Retrying in 30s.2026-09-01T02:20:00.0440160Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:20:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou exec test-cm-54b7d49f85-6fmjh -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-09-01T02:20:00.1487827Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:20:00Z logger.go:67: undefined2026-09-01T02:20:00.1519329Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-6fmjh failed. Retrying in 30s.2026-09-01T02:20:30.1521687Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:20:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou exec test-cm-54b7d49f85-6fmjh -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-09-01T02:20:30.2295565Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:20:30Z logger.go:67: undefined2026-09-01T02:20:30.2321210Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-6fmjh failed. Retrying in 30s.2026-09-01T02:21:00.2324679Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:21:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou exec test-cm-54b7d49f85-6fmjh -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-09-01T02:21:00.3214374Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:21:00Z logger.go:67: undefined2026-09-01T02:21:00.3245244Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-6fmjh failed. Retrying in 30s.2026-09-01T02:21:30.3247468Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:21:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou exec test-cm-54b7d49f85-6fmjh -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-09-01T02:21:30.4097599Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:21:30Z logger.go:67: undefined2026-09-01T02:21:30.4128252Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-6fmjh failed. Retrying in 30s.2026-09-01T02:22:00.4138030Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:22:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou exec test-cm-54b7d49f85-6fmjh -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-09-01T02:22:00.4967938Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:22:00Z logger.go:67: undefined2026-09-01T02:22:00.4994272Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-6fmjh failed. Retrying in 30s.2026-09-01T02:22:30.5003819Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:22:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou exec test-cm-54b7d49f85-6fmjh -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-lmcvs",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-09-01T02:22:30.5806765Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-09-01T02:22:30Z logger.go:67: true2026-09-01T02:22:30.5871745Z TestOSPoolEP 2026-09-01T02:22:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:22:30.5923596Z TestOSPoolEP 2026-09-01T02:22:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:22:30.6427004Z TestOSPoolEP 2026-09-01T02:22:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:22:30.7016061Z TestOSPoolEP 2026-09-01T02:22:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:22:30.7526337Z TestOSPoolEP 2026-09-01T02:22:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:22:30.7547381Z === NAME TestOSPoolEP2026-09-01T02:22:30.7547911Z ospool_ep_test.go:101: ---2026-09-01T02:22:30.7548437Z Events for pod idtoken-generator:2026-09-01T02:22:30.7549376Z 2026-09-01 02:15:49 +0000 UTC Normal Successfully assigned test-ospool-ep-lci1ou/idtoken-generator to minikube2026-09-01T02:22:30.7550340Z 2026-09-01 02:15:58 +0000 UTC Normal Pulling image "htcondor/base"2026-09-01T02:22:30.7551396Z 2026-09-01 02:16:09 +0000 UTC Normal Successfully pulled image "htcondor/base" in 11.035s (11.035s including waiting). Image size: 522365028 bytes.2026-09-01T02:22:30.7553046Z 2026-09-01 02:16:09 +0000 UTC Normal Container created2026-09-01T02:22:30.7553675Z 2026-09-01 02:16:09 +0000 UTC Normal Container started2026-09-01T02:22:30.7554062Z 2026-09-01T02:22:30.7554383Z ---2026-09-01T02:22:30.7554981Z TestOSPoolEP 2026-09-01T02:22:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:22:30.7569242Z ospool_ep_test.go:101: ---2026-09-01T02:22:30.7570300Z Events for pod ospool-ep-6c7d796845-lmcvs:2026-09-01T02:22:30.7572166Z 2026-09-01 02:16:19 +0000 UTC Normal Successfully assigned test-ospool-ep-lci1ou/ospool-ep-6c7d796845-lmcvs to minikube2026-09-01T02:22:30.7573232Z 2026-09-01 02:16:20 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-09-01T02:22:30.7574402Z 2026-09-01 02:16:31 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.941s (10.857s including waiting). Image size: 5590942 bytes.2026-09-01T02:22:30.7575289Z 2026-09-01 02:16:31 +0000 UTC Normal Container created2026-09-01T02:22:30.7575851Z 2026-09-01 02:16:31 +0000 UTC Normal Container started2026-09-01T02:22:30.7576682Z 2026-09-01 02:16:32 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-09-01T02:22:30.7577969Z 2026-09-01 02:16:51 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 18.843s (18.843s including waiting). Image size: 1290304444 bytes.2026-09-01T02:22:30.7579249Z 2026-09-01 02:16:51 +0000 UTC Normal Container created2026-09-01T02:22:30.7579909Z 2026-09-01 02:16:51 +0000 UTC Normal Container started2026-09-01T02:22:30.7580319Z 2026-09-01T02:22:30.7580624Z ---2026-09-01T02:22:30.7581339Z TestOSPoolEP 2026-09-01T02:22:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:22:30.7587782Z ospool_ep_test.go:101: ---2026-09-01T02:22:30.7588506Z Events for pod test-cm-54b7d49f85-6fmjh:2026-09-01T02:22:30.7589647Z 2026-09-01 02:16:19 +0000 UTC Normal Successfully assigned test-ospool-ep-lci1ou/test-cm-54b7d49f85-6fmjh to minikube2026-09-01T02:22:30.7590439Z 2026-09-01 02:16:20 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-09-01T02:22:30.7591703Z 2026-09-01 02:16:29 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 8.916s (8.916s including waiting). Image size: 534362849 bytes.2026-09-01T02:22:30.7592467Z 2026-09-01 02:16:29 +0000 UTC Normal Container created2026-09-01T02:22:30.7592975Z 2026-09-01 02:16:29 +0000 UTC Normal Container started2026-09-01T02:22:30.7593311Z 2026-09-01T02:22:30.7593568Z ---2026-09-01T02:22:30.7594070Z TestOSPoolEP 2026-09-01T02:22:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-09-01T02:22:30.7636172Z TestOSPoolEP 2026-09-01T02:22:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou delete -f /tmp/TestOSPoolEP2342101482]2026-09-01T02:22:30.8000599Z TestOSPoolEP 2026-09-01T02:22:30Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-lci1ou namespace2026-09-01T02:22:30.8040476Z TestOSPoolEP 2026-09-01T02:22:30Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-lci1ou namespace2026-09-01T02:22:31.9152738Z TestOSPoolEP 2026-09-01T02:22:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou delete -f /tmp/TestOSPoolEP3063936426]2026-09-01T02:22:31.9580199Z TestOSPoolEP 2026-09-01T02:22:31Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-lci1ou namespace2026-09-01T02:22:31.9608017Z TestOSPoolEP 2026-09-01T02:22:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-lci1ou delete -k /tmp/kustomize-template-3508267409]2026-09-01T02:22:32.0189342Z TestOSPoolEP 2026-09-01T02:22:32Z logger.go:67: service "test-cm" deleted from test-ospool-ep-lci1ou namespace2026-09-01T02:22:32.0228119Z TestOSPoolEP 2026-09-01T02:22:32Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-lci1ou namespace2026-09-01T02:22:32.0260248Z TestOSPoolEP 2026-09-01T02:22:32Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-lci1ou namespace2026-09-01T02:22:32.0320934Z --- PASS: TestOSPoolEP (71.96s)2026-09-01T02:22:32.0322630Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (40.03s)2026-09-01T02:22:32.0326747Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (10.22s)2026-09-01T02:22:32.0327658Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (10.22s)2026-09-01T02:22:32.0330921Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (331.08s)2026-09-01T02:22:32.0331534Z PASS2026-09-01T02:22:32.0345807Z ok github.com/osg-htc/k8s-integration-tests/test 403.049s2026-09-01T02:22:32.0905767Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-09-01T02:22:32.0906352Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-09-01T02:22:32.0948539Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-09-01T02:22:32.0949011Z env:2026-09-01T02:22:32.0949266Z GOTOOLCHAIN: local2026-09-01T02:22:32.0949927Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-09-01T02:22:32.0950365Z ##[endgroup]2026-09-01T02:22:32.1077466Z 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-09-01T02:22:32.1078678Z ##[group]Run actions/upload-artifact@v42026-09-01T02:22:32.1078999Z with:2026-09-01T02:22:32.1079447Z name: TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce72322026-09-01T02:22:32.1080190Z path: /tmp/k8s-tests2026-09-01T02:22:32.1080487Z retention-days: 52026-09-01T02:22:32.1080803Z if-no-files-found: warn2026-09-01T02:22:32.1081092Z compression-level: 62026-09-01T02:22:32.1081510Z overwrite: false2026-09-01T02:22:32.1081779Z include-hidden-files: false2026-09-01T02:22:32.1082118Z env:2026-09-01T02:22:32.1082357Z GOTOOLCHAIN: local2026-09-01T02:22:32.1082671Z ##[endgroup]2026-09-01T02:22:32.2445969Z (node:17347) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-09-01T02:22:32.2446886Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-09-01T02:22:32.2541621Z With the provided path, there will be 6 files uploaded2026-09-01T02:22:32.2542828Z Artifact name is valid!2026-09-01T02:22:32.2543503Z Root directory input is valid!2026-09-01T02:22:32.5192747Z Beginning upload of artifact content to blob storage2026-09-01T02:22:32.5446906Z (node:17347) [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-09-01T02:22:32.7224410Z Uploaded bytes 141212026-09-01T02:22:32.7586010Z Finished uploading artifact content to blob storage!2026-09-01T02:22:32.7586668Z SHA256 digest of uploaded artifact zip is cefd55376f379a9c6c33fa0ba8ef7d7cf9882be2cf3e11ab470fe63e77d543de2026-09-01T02:22:32.7588106Z Finalizing artifact upload2026-09-01T02:22:32.9830681Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232.zip successfully finalized. Artifact ID 97835833302026-09-01T02:22:32.9831498Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232 has been successfully uploaded! Final size is 14121 bytes. Artifact ID is 97835833302026-09-01T02:22:32.9832549Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/33461797843/artifacts/97835833302026-09-01T02:22:32.9954518Z Post job cleanup.2026-09-01T02:22:33.0909878Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOMODCACHE2026-09-01T02:22:33.0941586Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOCACHE2026-09-01T02:22:33.0969767Z /home/runner/go/pkg/mod2026-09-01T02:22:33.0993003Z /home/runner/.cache/go-build2026-09-01T02:22:33.0998347Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-09-01T02:22:33.1126923Z Post job cleanup.2026-09-01T02:22:33.1851139Z [command]/usr/bin/git version2026-09-01T02:22:33.1898704Z git version 2.55.02026-09-01T02:22:33.1936899Z Temporarily overriding HOME='/home/runner/work/_temp/f2f2d987-360b-4781-8e96-d3ae1712a31e' before making global git config changes2026-09-01T02:22:33.1946105Z Adding repository directory to the temporary git global config as a safe directory2026-09-01T02:22:33.1947012Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-09-01T02:22:33.1974834Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-09-01T02:22:33.2031817Z [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-09-01T02:22:33.2309005Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-09-01T02:22:33.2333044Z http.https://github.com/.extraheader2026-09-01T02:22:33.2353939Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-09-01T02:22:33.2389174Z [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-09-01T02:22:33.2691781Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-09-01T02:22:33.2718224Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-09-01T02:22:33.2979012Z Cleaning up orphan processes2026-09-01T02:22:33.3415473Z ##[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/