All Test Logs

2026-07-30T01:23:24.1347266Z Current runner version: '2.336.0'2026-07-30T01:23:24.1367200Z ##[group]Runner Image Provisioner2026-07-30T01:23:24.1367901Z Hosted Compute Agent2026-07-30T01:23:24.1368491Z Version: 20260707.5632026-07-30T01:23:24.1369043Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-07-30T01:23:24.1369684Z Build Date: 2026-07-07T19:33:50Z2026-07-30T01:23:24.1370298Z Worker ID: {8ab96c0f-0c29-4037-8d3a-c9db6312c90d}2026-07-30T01:23:24.1370911Z Azure Region: westcentralus2026-07-30T01:23:24.1371483Z ##[endgroup]2026-07-30T01:23:24.1372590Z ##[group]Operating System2026-07-30T01:23:24.1373090Z Ubuntu2026-07-30T01:23:24.1373633Z 22.04.52026-07-30T01:23:24.1374066Z LTS2026-07-30T01:23:24.1374539Z ##[endgroup]2026-07-30T01:23:24.1375038Z ##[group]Runner Image2026-07-30T01:23:24.1375686Z Image: ubuntu-22.042026-07-30T01:23:24.1376227Z Version: 20260720.234.22026-07-30T01:23:24.1377266Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-07-30T01:23:24.1378560Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-07-30T01:23:24.1379343Z ##[endgroup]2026-07-30T01:23:24.1380397Z ##[group]GITHUB_TOKEN Permissions2026-07-30T01:23:24.1382131Z Contents: read2026-07-30T01:23:24.1382712Z Metadata: read2026-07-30T01:23:24.1383212Z Packages: read2026-07-30T01:23:24.1383642Z ##[endgroup]2026-07-30T01:23:24.1385936Z Secret source: Actions2026-07-30T01:23:24.1386831Z Prepare workflow directory2026-07-30T01:23:24.1640326Z Prepare all required actions2026-07-30T01:23:24.1679720Z Getting action download info2026-07-30T01:23:24.4525119Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-07-30T01:23:24.9581099Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-07-30T01:23:25.4492749Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-07-30T01:23:26.0174321Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-07-30T01:23:26.2509267Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-07-30T01:23:26.2513826Z ##[group] Inputs2026-07-30T01:23:26.2514673Z   testName: TestOSPoolEP2026-07-30T01:23:26.2516310Z   testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-07-30T01:23:26.2517910Z   setupScript: 2026-07-30T01:23:26.2518645Z   setupEnv: {}2026-07-30T01:23:26.2519375Z ##[endgroup]2026-07-30T01:23:26.2520543Z Complete job name: ospool-ep / Run OSPool EP test (cvmfs-bind, 25-release) / Run Tests2026-07-30T01:23:26.3234566Z ##[group]Run actions/checkout@v52026-07-30T01:23:26.3235886Z with:2026-07-30T01:23:26.3236697Z   repository: mwestphall/k8s-integration-tests2026-07-30T01:23:26.3244477Z   token: ***2026-07-30T01:23:26.3245312Z   ssh-strict: true2026-07-30T01:23:26.3246110Z   ssh-user: git2026-07-30T01:23:26.3246874Z   persist-credentials: true2026-07-30T01:23:26.3247713Z   clean: true2026-07-30T01:23:26.3248474Z   sparse-checkout-cone-mode: true2026-07-30T01:23:26.3249379Z   fetch-depth: 12026-07-30T01:23:26.3250116Z   fetch-tags: false2026-07-30T01:23:26.3250872Z   show-progress: true2026-07-30T01:23:26.3251646Z   lfs: false2026-07-30T01:23:26.3252357Z   submodules: false2026-07-30T01:23:26.3253124Z   set-safe-directory: true2026-07-30T01:23:26.3253998Z   allow-unsafe-pr-checkout: false2026-07-30T01:23:26.3255105Z ##[endgroup]2026-07-30T01:23:26.4127311Z Syncing repository: mwestphall/k8s-integration-tests2026-07-30T01:23:26.4129588Z ##[group]Getting Git version info2026-07-30T01:23:26.4131028Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-07-30T01:23:26.4132942Z [command]/usr/bin/git version2026-07-30T01:23:26.4170031Z git version 2.54.02026-07-30T01:23:26.4187814Z ##[endgroup]2026-07-30T01:23:26.4199976Z Temporarily overriding HOME='/home/runner/work/_temp/82a4d9df-a78f-46e4-ba82-694d44b0ed64' before making global git config changes2026-07-30T01:23:26.4203493Z Adding repository directory to the temporary git global config as a safe directory2026-07-30T01:23:26.4206929Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-07-30T01:23:26.4246712Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-07-30T01:23:26.4250009Z ##[group]Initializing the repository2026-07-30T01:23:26.4255510Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-07-30T01:23:26.4324495Z hint: Using 'master' as the name for the initial branch. This default branch name2026-07-30T01:23:26.4327342Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-07-30T01:23:26.4330027Z hint: to use in all of your new repositories, which will suppress this warning,2026-07-30T01:23:26.4332143Z hint: call:2026-07-30T01:23:26.4333399Z hint:2026-07-30T01:23:26.4334908Z hint: 	git config --global init.defaultBranch <name>2026-07-30T01:23:26.4336944Z hint:2026-07-30T01:23:26.4338541Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-07-30T01:23:26.4340999Z hint: 'development'. The just-created branch can be renamed via this command:2026-07-30T01:23:26.4342950Z hint:2026-07-30T01:23:26.4344171Z hint: 	git branch -m <name>2026-07-30T01:23:26.4345700Z hint:2026-07-30T01:23:26.4347549Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-07-30T01:23:26.4350625Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-07-30T01:23:26.4356218Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-07-30T01:23:26.4370066Z ##[endgroup]2026-07-30T01:23:26.4371815Z ##[group]Disabling automatic garbage collection2026-07-30T01:23:26.4373362Z [command]/usr/bin/git config --local gc.auto 02026-07-30T01:23:26.4402167Z ##[endgroup]2026-07-30T01:23:26.4403871Z ##[group]Setting up auth2026-07-30T01:23:26.4406713Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-07-30T01:23:26.4434450Z [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-07-30T01:23:26.4709661Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-07-30T01:23:26.4742957Z [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-07-30T01:23:26.4958876Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-07-30T01:23:26.4991625Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-07-30T01:23:26.5194458Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-07-30T01:23:26.5226692Z ##[endgroup]2026-07-30T01:23:26.5227969Z ##[group]Fetching the repository2026-07-30T01:23:26.5234581Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-07-30T01:23:26.9718020Z From https://github.com/mwestphall/k8s-integration-tests2026-07-30T01:23:26.9718937Z  * [new ref]         ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-07-30T01:23:26.9740034Z ##[endgroup]2026-07-30T01:23:26.9740382Z ##[group]Determining the checkout info2026-07-30T01:23:26.9742319Z ##[endgroup]2026-07-30T01:23:26.9747041Z [command]/usr/bin/git sparse-checkout disable2026-07-30T01:23:26.9782666Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-07-30T01:23:26.9809676Z ##[group]Checking out the ref2026-07-30T01:23:26.9813437Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-07-30T01:23:26.9885098Z Switched to a new branch 'main'2026-07-30T01:23:26.9888159Z branch 'main' set up to track 'origin/main'.2026-07-30T01:23:26.9892406Z ##[endgroup]2026-07-30T01:23:26.9930254Z [command]/usr/bin/git log -1 --format=%H2026-07-30T01:23:26.9952388Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-07-30T01:23:27.0139301Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-07-30T01:23:27.0139846Z echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-07-30T01:23:27.0140311Z echo "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-07-30T01:23:27.0231797Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-07-30T01:23:27.0232113Z env:2026-07-30T01:23:27.0232471Z   TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-07-30T01:23:27.0232865Z   SETUP_ENV_YAML: {}2026-07-30T01:23:27.0233046Z ##[endgroup]2026-07-30T01:23:27.1603020Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-07-30T01:23:27.1603555Z echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-07-30T01:23:27.1651087Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-07-30T01:23:27.1651367Z env:2026-07-30T01:23:27.1651733Z   TEST_ENV: {  "OSPOOL_EP_OSPoolEPTag": "25-release",  "OSPOOL_EP_CMTag": "25.0-el9",  "OSPOOL_EP_CvmfsType": "cvmfs-bind"}2026-07-30T01:23:27.1652140Z ##[endgroup]2026-07-30T01:23:27.1758362Z ##[group]Run true2026-07-30T01:23:27.1758563Z true2026-07-30T01:23:27.1800147Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-07-30T01:23:27.1800589Z ##[endgroup]2026-07-30T01:23:27.1925052Z ##[group]Run medyagh/setup-minikube@latest2026-07-30T01:23:27.1925603Z with:2026-07-30T01:23:27.1925771Z   start: true2026-07-30T01:23:27.1925948Z   cache: true2026-07-30T01:23:27.1926133Z   minikube-version: latest2026-07-30T01:23:27.1926347Z   wait: all2026-07-30T01:23:27.1926521Z ##[endgroup]2026-07-30T01:23:27.2968146Z (node:2040) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-07-30T01:23:27.2968786Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-07-30T01:23:28.5583955Z [command]/usr/bin/chmod +x /home/runner/work/_temp/aa6039f6-3303-42dc-ae94-1b4a9f372cf72026-07-30T01:23:29.2587680Z [command]/home/runner/bin/minikube version --short2026-07-30T01:23:29.3213362Z v1.38.12026-07-30T01:23:29.5112412Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-07-30T01:23:29.5121223Z Cache hit for: kic-v1.38.1-x642026-07-30T01:23:29.5202201Z (node:2040) [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-07-30T01:23:30.7426967Z Received 58720256 of 544082657 (10.8%), 56.0 MBs/sec2026-07-30T01:23:30.7560070Z Received 46137344 of 224218863 (20.6%), 44.0 MBs/sec2026-07-30T01:23:31.7412470Z Received 218103808 of 544082657 (40.1%), 104.1 MBs/sec2026-07-30T01:23:31.7564395Z Received 197132288 of 224218863 (87.9%), 94.0 MBs/sec2026-07-30T01:23:32.0115570Z Received 224218863 of 224218863 (100.0%), 94.8 MBs/sec2026-07-30T01:23:32.0116649Z Cache Size: ~214 MB (224218863 B)2026-07-30T01:23:32.0156520Z [command]/usr/bin/tar -xf /home/runner/work/_temp/d1eb35c9-6613-4954-aa47-c446edb793b4/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-07-30T01:23:32.4786302Z Cache restored successfully2026-07-30T01:23:32.7412455Z Received 377487360 of 544082657 (69.4%), 120.0 MBs/sec2026-07-30T01:23:33.7417453Z Received 536870912 of 544082657 (98.7%), 128.0 MBs/sec2026-07-30T01:23:33.9203778Z Received 544082657 of 544082657 (100.0%), 124.2 MBs/sec2026-07-30T01:23:33.9205095Z Cache Size: ~519 MB (544082657 B)2026-07-30T01:23:33.9303380Z [command]/usr/bin/tar -xf /home/runner/work/_temp/fbe216fe-838e-45ff-9108-0d90c7c3d12a/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-07-30T01:23:34.5822042Z Cache restored successfully2026-07-30T01:23:34.6762937Z [command]/home/runner/bin/minikube start --wait all2026-07-30T01:23:34.7058986Z * minikube v1.38.1 on Ubuntu 22.042026-07-30T01:23:35.0086922Z ! The minimum required version for podman is "4.9.0". your version is "3.4.4". minikube might not work. use at your own risk. To install latest version please see https://podman.io/getting-started/installation.html2026-07-30T01:23:35.0094541Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-07-30T01:23:35.0462591Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-07-30T01:23:35.0466994Z * Using Docker driver with root privileges2026-07-30T01:23:35.0477293Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-07-30T01:23:35.0486091Z * Pulling base image v0.0.50 ...2026-07-30T01:24:08.5714962Z * Configuring bridge CNI (Container Networking Interface) ...2026-07-30T01:24:13.7177032Z * Verifying Kubernetes components...2026-07-30T01:24:13.7416629Z   - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-07-30T01:24:14.1750460Z * Enabled addons: default-storageclass, storage-provisioner2026-07-30T01:24:57.3203847Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-07-30T01:24:58.0706713Z [command]/home/runner/bin/minikube version --short2026-07-30T01:24:58.0977196Z v1.38.12026-07-30T01:24:58.1205791Z ##[group]Run actions/setup-go@v62026-07-30T01:24:58.1206051Z with:2026-07-30T01:24:58.1206226Z   go-version: 1.262026-07-30T01:24:58.1206409Z   cache: true2026-07-30T01:24:58.1206593Z   cache-dependency-path: go.sum2026-07-30T01:24:58.1206806Z   check-latest: false2026-07-30T01:24:58.1208851Z   token: ***2026-07-30T01:24:58.1209028Z ##[endgroup]2026-07-30T01:24:58.2234174Z Setup go version spec 1.262026-07-30T01:24:58.4562459Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-07-30T01:24:58.4565386Z Added go to the path2026-07-30T01:24:58.4568444Z Successfully set up Go version 1.262026-07-30T01:24:59.8231499Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-07-30T01:24:59.8261081Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-07-30T01:24:59.8285498Z /home/runner/go/pkg/mod2026-07-30T01:24:59.8302294Z /home/runner/.cache/go-build2026-07-30T01:25:00.0246971Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-07-30T01:25:01.2426529Z Received 67108864 of 251839808 (26.6%), 63.9 MBs/sec2026-07-30T01:25:02.2419132Z Received 243451200 of 251839808 (96.7%), 116.0 MBs/sec2026-07-30T01:25:02.3993938Z Received 251839808 of 251839808 (100.0%), 111.2 MBs/sec2026-07-30T01:25:02.3994929Z Cache Size: ~240 MB (251839808 B)2026-07-30T01:25:02.4051181Z [command]/usr/bin/tar -xf /home/runner/work/_temp/4fa2b637-522a-4ec1-a026-8bf139341924/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-07-30T01:25:04.9087168Z Cache restored successfully2026-07-30T01:25:05.0202031Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-07-30T01:25:05.0222551Z go version go1.26.5 linux/amd642026-07-30T01:25:05.0222732Z 2026-07-30T01:25:05.0223000Z ##[group]go env2026-07-30T01:25:05.0322009Z AR='ar'2026-07-30T01:25:05.0322278Z CC='gcc'2026-07-30T01:25:05.0322529Z CGO_CFLAGS='-O2 -g'2026-07-30T01:25:05.0322958Z CGO_CPPFLAGS=''2026-07-30T01:25:05.0323156Z CGO_CXXFLAGS='-O2 -g'2026-07-30T01:25:05.0323444Z CGO_ENABLED='1'2026-07-30T01:25:05.0323715Z CGO_FFLAGS='-O2 -g'2026-07-30T01:25:05.0324016Z CGO_LDFLAGS='-O2 -g'2026-07-30T01:25:05.0324268Z CXX='g++'2026-07-30T01:25:05.0324511Z GCCGO='gccgo'2026-07-30T01:25:05.0324766Z GO111MODULE=''2026-07-30T01:25:05.0325012Z GOAMD64='v1'2026-07-30T01:25:05.0325394Z GOARCH='amd64'2026-07-30T01:25:05.0325598Z GOAUTH='netrc'2026-07-30T01:25:05.0325759Z GOBIN=''2026-07-30T01:25:05.0325948Z GOCACHE='/home/runner/.cache/go-build'2026-07-30T01:25:05.0326182Z GOCACHEPROG=''2026-07-30T01:25:05.0326355Z GODEBUG=''2026-07-30T01:25:05.0326562Z GOENV='/home/runner/.config/go/env'2026-07-30T01:25:05.0326782Z GOEXE=''2026-07-30T01:25:05.0326953Z GOEXPERIMENT=''2026-07-30T01:25:05.0327127Z GOFIPS140='off'2026-07-30T01:25:05.0327300Z GOFLAGS=''2026-07-30T01:25:05.0327831Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build1640379625=/tmp/go-build -gno-record-gcc-switches'2026-07-30T01:25:05.0328343Z GOHOSTARCH='amd64'2026-07-30T01:25:05.0328531Z GOHOSTOS='linux'2026-07-30T01:25:05.0328703Z GOINSECURE=''2026-07-30T01:25:05.0328992Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-07-30T01:25:05.0329326Z GOMODCACHE='/home/runner/go/pkg/mod'2026-07-30T01:25:05.0329549Z GONOPROXY=''2026-07-30T01:25:05.0329714Z GONOSUMDB=''2026-07-30T01:25:05.0329874Z GOOS='linux'2026-07-30T01:25:05.0330051Z GOPATH='/home/runner/go'2026-07-30T01:25:05.0330241Z GOPRIVATE=''2026-07-30T01:25:05.0330470Z GOPROXY='https://proxy.golang.org,direct'2026-07-30T01:25:05.0330734Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-07-30T01:25:05.0330981Z GOSUMDB='sum.golang.org'2026-07-30T01:25:05.0331178Z GOTELEMETRY='local'2026-07-30T01:25:05.0331402Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-07-30T01:25:05.0331651Z GOTMPDIR=''2026-07-30T01:25:05.0332025Z GOTOOLCHAIN='local'2026-07-30T01:25:05.0332303Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-07-30T01:25:05.0332585Z GOVCS=''2026-07-30T01:25:05.0332750Z GOVERSION='go1.26.5'2026-07-30T01:25:05.0332934Z GOWORK=''2026-07-30T01:25:05.0333105Z PKG_CONFIG='pkg-config'2026-07-30T01:25:05.0333226Z 2026-07-30T01:25:05.0333476Z ##[endgroup]2026-07-30T01:25:05.0498147Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-07-30T01:25:05.0498549Z go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-07-30T01:25:05.0547024Z shell: /usr/bin/bash -e {0}2026-07-30T01:25:05.0547255Z env:2026-07-30T01:25:05.0547432Z   GOTOOLCHAIN: local2026-07-30T01:25:05.0547647Z   OSPOOL_EP_OSPoolEPTag: 25-release2026-07-30T01:25:05.0547879Z   OSPOOL_EP_CMTag: 25.0-el92026-07-30T01:25:05.0548093Z   OSPOOL_EP_CvmfsType: cvmfs-bind2026-07-30T01:25:05.0548323Z ##[endgroup]2026-07-30T01:25:09.9819838Z === RUN   TestOSPoolEP2026-07-30T01:25:09.9820277Z === PAUSE TestOSPoolEP2026-07-30T01:25:09.9820579Z === CONT  TestOSPoolEP2026-07-30T01:25:09.9821190Z TestOSPoolEP 2026-07-30T01:25:09Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:09.9917836Z TestOSPoolEP 2026-07-30T01:25:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst apply -f /tmp/TestOSPoolEP3758698276]2026-07-30T01:25:10.2635619Z TestOSPoolEP 2026-07-30T01:25:10Z logger.go:67: pod/idtoken-generator created2026-07-30T01:25:10.2856189Z TestOSPoolEP 2026-07-30T01:25:10Z logger.go:67: secret/pool-passwd created2026-07-30T01:25:10.2890836Z TestOSPoolEP 2026-07-30T01:25:10Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-07-30T01:25:10.2891881Z TestOSPoolEP 2026-07-30T01:25:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:10.2982255Z TestOSPoolEP 2026-07-30T01:25:10Z 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-07-30T01:25:20.2999238Z TestOSPoolEP 2026-07-30T01:25:20Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-07-30T01:25:20.3003006Z TestOSPoolEP 2026-07-30T01:25:20Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:20.3029102Z TestOSPoolEP 2026-07-30T01:25:20Z 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-07-30T01:25:30.3039224Z TestOSPoolEP 2026-07-30T01:25:30Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-07-30T01:25:30.3040131Z TestOSPoolEP 2026-07-30T01:25:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:30.3060710Z TestOSPoolEP 2026-07-30T01:25:30Z logger.go:67: Pod is now available2026-07-30T01:25:30.3062093Z TestOSPoolEP 2026-07-30T01:25:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-07-30T01:25:30.4226596Z TestOSPoolEP 2026-07-30T01:25:30Z logger.go:67: ***2026-07-30T01:25:30.4275349Z TestOSPoolEP 2026-07-30T01:25:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst apply -f /tmp/TestOSPoolEP2093762213]2026-07-30T01:25:30.5594851Z TestOSPoolEP 2026-07-30T01:25:30Z logger.go:67: secret/pool-token created2026-07-30T01:25:30.5626039Z TestOSPoolEP 2026-07-30T01:25:30Z retry.go:91: Wait for secret pool-token to be provisioned.2026-07-30T01:25:30.5627143Z TestOSPoolEP 2026-07-30T01:25:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:30.5638522Z TestOSPoolEP 2026-07-30T01:25:30Z logger.go:67: Secret is now available2026-07-30T01:25:30.5655261Z TestOSPoolEP 2026-07-30T01:25:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst apply -k /tmp/kustomize-template-2324811614]2026-07-30T01:25:30.8118271Z TestOSPoolEP 2026-07-30T01:25:30Z logger.go:67: serviceaccount/cvmfs-nodeplugin created2026-07-30T01:25:30.8197550Z TestOSPoolEP 2026-07-30T01:25:30Z logger.go:67: service/frontier-squid created2026-07-30T01:25:30.8260086Z TestOSPoolEP 2026-07-30T01:25:30Z logger.go:67: service/test-cm created2026-07-30T01:25:30.8326920Z TestOSPoolEP 2026-07-30T01:25:30Z logger.go:67: deployment.apps/cvmfs-nodeplugin created2026-07-30T01:25:30.8387569Z TestOSPoolEP 2026-07-30T01:25:30Z logger.go:67: deployment.apps/frontier-squid created2026-07-30T01:25:30.8503435Z TestOSPoolEP 2026-07-30T01:25:30Z logger.go:67: Warning: spec.template.spec.containers[0].env[6]: hides previous definition of "OSG_SQUID_LOCATION", which may be dropped when using apply2026-07-30T01:25:30.8505964Z TestOSPoolEP 2026-07-30T01:25:30Z logger.go:67: deployment.apps/ospool-ep created2026-07-30T01:25:30.8622859Z TestOSPoolEP 2026-07-30T01:25:30Z logger.go:67: deployment.apps/test-cm created2026-07-30T01:25:30.8681705Z === RUN   TestOSPoolEP/Confirm_deployments_become_ready.2026-07-30T01:25:30.8684075Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:30.8731343Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:30Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-07-30T01:25:30.8747709Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:30.8749189Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:30Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-30T01:25:30.8750731Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:30.8752547Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:30Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-07-30T01:25:30.8754718Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:30.8756863Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:30Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-07-30T01:25:30.8759073Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:30.8786737Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:30Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "test-cm-54b7d49f85". Sleeping for 10s and will try again.2026-07-30T01:25:30.8790677Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:30Z retry.go:103: Wait for deployment frontier-squid to be provisioned. returned an error: Deployment frontier-squid is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "frontier-squid-765494655". Sleeping for 10s and will try again.2026-07-30T01:25:30.8794520Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:30Z retry.go:103: Wait for deployment cvmfs-nodeplugin to be provisioned. returned an error: Deployment cvmfs-nodeplugin is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "cvmfs-nodeplugin-6b55bb5648" is progressing.. Sleeping for 10s and will try again.2026-07-30T01:25:30.8807892Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:30Z 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-7779fdb9d4". Sleeping for 10s and will try again.2026-07-30T01:25:40.8796783Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:40Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-07-30T01:25:40.8798555Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:40.8800216Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:40Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-07-30T01:25:40.8801802Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:40.8803293Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:40Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-07-30T01:25:40.8804832Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:40.8815753Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:40Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-30T01:25:40.8821371Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:40.8824579Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:40Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "test-cm-54b7d49f85" is progressing.. Sleeping for 10s and will try again.2026-07-30T01:25:40.8828661Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:40Z retry.go:103: Wait for deployment frontier-squid to be provisioned. returned an error: Deployment frontier-squid is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "frontier-squid-765494655" is progressing.. Sleeping for 10s and will try again.2026-07-30T01:25:40.8832627Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:40Z retry.go:103: Wait for deployment cvmfs-nodeplugin to be provisioned. returned an error: Deployment cvmfs-nodeplugin is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "cvmfs-nodeplugin-6b55bb5648" is progressing.. Sleeping for 10s and will try again.2026-07-30T01:25:40.8836623Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:40Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-7779fdb9d4" is progressing.. Sleeping for 10s and will try again.2026-07-30T01:25:50.8834180Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:50Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-07-30T01:25:50.8835990Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:50.8845040Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:50Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-30T01:25:50.8847376Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:50.8848798Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:50Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-07-30T01:25:50.8851864Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:50.8856030Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:50Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-07-30T01:25:50.8861995Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:25:50.8878403Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:50Z retry.go:103: Wait for deployment frontier-squid to be provisioned. returned an error: Deployment frontier-squid is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "frontier-squid-765494655" is progressing.. Sleeping for 10s and will try again.2026-07-30T01:25:50.8880825Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:50Z logger.go:67: Deployment is now available2026-07-30T01:25:50.8889496Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:50Z 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-07-30T01:25:50.8892865Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:25:50Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-7779fdb9d4" is progressing.. Sleeping for 10s and will try again.2026-07-30T01:26:00.8886874Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:00Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-07-30T01:26:00.8888178Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:26:00.8896449Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:00Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-07-30T01:26:00.8898085Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:00Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-30T01:26:00.8901745Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:26:00.8903278Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:26:00.8911299Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:00Z logger.go:67: Deployment is now available2026-07-30T01:26:00.8913347Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:00Z 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-07-30T01:26:00.8916005Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:00Z 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-7779fdb9d4" is progressing.. Sleeping for 10s and will try again.2026-07-30T01:26:10.8921763Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:10Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-30T01:26:10.8923226Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:26:10.8924579Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:10Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-07-30T01:26:10.8926145Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:26:10.8942767Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:10Z logger.go:67: Deployment is now available2026-07-30T01:26:10.8945408Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:10Z 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-7779fdb9d4" is progressing.. Sleeping for 10s and will try again.2026-07-30T01:26:20.8952143Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:20Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-30T01:26:20.8953832Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:20Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:26:20.8978363Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:20Z 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-7779fdb9d4" is progressing.. Sleeping for 10s and will try again.2026-07-30T01:26:30.8988979Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:30Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-30T01:26:30.8992462Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:26:30.9016778Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:30Z 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-7779fdb9d4" is progressing.. Sleeping for 10s and will try again.2026-07-30T01:26:40.9023495Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:40Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-07-30T01:26:40.9024751Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:26:40.9048432Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-07-30T01:26:40Z logger.go:67: Deployment is now available2026-07-30T01:26:40.9061805Z === RUN   TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-30T01:26:40.9063184Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-30T01:26:40.9063768Z === RUN   TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-07-30T01:26:40.9064401Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-07-30T01:26:40.9064968Z === RUN   TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-30T01:26:40.9065670Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-30T01:26:40.9066561Z === CONT  TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-30T01:26:40.9067636Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:26:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:26:40.9068665Z === CONT  TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-30T01:26:40.9069747Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:26:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:26:40.9070796Z === CONT  TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-07-30T01:26:40.9100815Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-30T01:26:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:26:40.9102537Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:26:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:26:40.9104172Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-30T01:26:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:26:40.9105881Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:26:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:26:40.9118908Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:26:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:26:40.9138689Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:26:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)']2026-07-30T01:26:40.9147340Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-30T01:26:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_SINGULARITY]2026-07-30T01:26:41.1400960Z === NAME  TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-30T01:26:41.1403469Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)']' in pod test-cm-54b7d49f85-nmr6g failed. Retrying in 10s.2026-07-30T01:26:41.1404778Z === NAME  TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-07-30T01:26:41.1406419Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-nmr6g failed. Retrying in 10s.2026-07-30T01:26:41.1409948Z === NAME  TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-30T01:26:41.1411720Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmr6g failed. Retrying in 30s.2026-07-30T01:26:51.1411344Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:26:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)']2026-07-30T01:26:51.1414897Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-30T01:26:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_SINGULARITY]2026-07-30T01:26:51.3087635Z === NAME  TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-07-30T01:26:51.3090945Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-nmr6g failed. Retrying in 10s.2026-07-30T01:26:51.3191061Z === NAME  TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-07-30T01:26:51.3192329Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)']' in pod test-cm-54b7d49f85-nmr6g failed. Retrying in 10s.2026-07-30T01:27:01.3090099Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-30T01:27:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_SINGULARITY]2026-07-30T01:27:01.3201808Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:27:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)']2026-07-30T01:27:01.4519011Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-07-30T01:27:01Z logger.go:67: true2026-07-30T01:27:01.4548452Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:27:01Z logger.go:67: Name                                                    OpSys      Arch     State     Activity LoadAv Mem     ActvtyTime2026-07-30T01:27:01.4549852Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:27:01Z logger.go:67: 2026-07-30T01:27:01.4551067Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:27:01Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-7779fdb9d4-vn79p LINUX      X86_64   Unclaimed Idle      0.000  15991  0+00:00:002026-07-30T01:27:01.4553000Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:27:01Z logger.go:67: 2026-07-30T01:27:01.4554229Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:27:01Z logger.go:67:                Total Owner Claimed Unclaimed Matched Preempting  Drain Backfill BkIdle2026-07-30T01:27:01.4555667Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:27:01Z logger.go:67: 2026-07-30T01:27:01.4556951Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:27:01Z logger.go:67:   X86_64/LINUX     1     0       0         1       0          0      0        0      02026-07-30T01:27:01.4558116Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:27:01Z logger.go:67: 2026-07-30T01:27:01.4559120Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-07-30T01:27:01Z logger.go:67:          Total     1     0       0         1       0          0      0        0      02026-07-30T01:27:11.1417768Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:27:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:27:11.2717468Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:27:11Z logger.go:67: undefined2026-07-30T01:27:11.2787558Z === NAME  TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-07-30T01:27:11.2789146Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmr6g failed. Retrying in 30s.2026-07-30T01:27:41.2794742Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:27:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:27:41.4561316Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:27:41Z logger.go:67: undefined2026-07-30T01:27:41.4617837Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmr6g failed. Retrying in 30s.2026-07-30T01:28:11.4626150Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:28:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:28:11.6586859Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:28:11Z logger.go:67: undefined2026-07-30T01:28:11.6645675Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmr6g failed. Retrying in 30s.2026-07-30T01:28:41.6649513Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:28:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:28:41.8144076Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:28:41Z logger.go:67: undefined2026-07-30T01:28:41.8200459Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmr6g failed. Retrying in 30s.2026-07-30T01:29:11.8204248Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:29:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:29:11.9744449Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:29:11Z logger.go:67: undefined2026-07-30T01:29:11.9782326Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmr6g failed. Retrying in 30s.2026-07-30T01:29:41.9789478Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:29:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:29:42.0947208Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:29:42Z logger.go:67: undefined2026-07-30T01:29:42.0993157Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmr6g failed. Retrying in 30s.2026-07-30T01:30:12.1012134Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:30:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:30:12.2249141Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:30:12Z logger.go:67: undefined2026-07-30T01:30:12.2310490Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmr6g failed. Retrying in 30s.2026-07-30T01:30:42.2317044Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:30:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:30:42.3478787Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:30:42Z logger.go:67: undefined2026-07-30T01:30:42.3527716Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmr6g failed. Retrying in 30s.2026-07-30T01:31:12.3535509Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:31:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:31:12.4694338Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:31:12Z logger.go:67: undefined2026-07-30T01:31:12.4740719Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmr6g failed. Retrying in 30s.2026-07-30T01:31:42.4749082Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:31:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:31:42.5880380Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:31:42Z logger.go:67: undefined2026-07-30T01:31:42.5920451Z     test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmr6g failed. Retrying in 30s.2026-07-30T01:32:12.5945419Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:32:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst exec test-cm-54b7d49f85-nmr6g -- sh -c condor_status -const 'regexp("ospool-ep-7779fdb9d4-vn79p",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-07-30T01:32:12.7245682Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-07-30T01:32:12Z logger.go:67: true2026-07-30T01:32:12.7296124Z TestOSPoolEP 2026-07-30T01:32:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:32:12.7406865Z TestOSPoolEP 2026-07-30T01:32:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:32:12.8399982Z TestOSPoolEP 2026-07-30T01:32:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:32:12.9444666Z TestOSPoolEP 2026-07-30T01:32:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:32:13.0295510Z TestOSPoolEP 2026-07-30T01:32:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:32:13.1459885Z TestOSPoolEP 2026-07-30T01:32:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:32:13.2344350Z TestOSPoolEP 2026-07-30T01:32:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:32:13.2422460Z === NAME  TestOSPoolEP2026-07-30T01:32:13.2423003Z     ospool_ep_test.go:101: ---2026-07-30T01:32:13.2423574Z         Events for pod cvmfs-nodeplugin-6b55bb5648-spj6m:2026-07-30T01:32:13.2424704Z         2026-07-30 01:25:30 +0000 UTC	Normal	Successfully assigned test-ospool-ep-mk3jst/cvmfs-nodeplugin-6b55bb5648-spj6m to minikube2026-07-30T01:32:13.2425999Z         2026-07-30 01:25:31 +0000 UTC	Normal	Pulling image "opensciencegrid/cvmfs-nodeplugin:fresh"2026-07-30T01:32:13.2427502Z         2026-07-30 01:25:40 +0000 UTC	Normal	Successfully pulled image "opensciencegrid/cvmfs-nodeplugin:fresh" in 8.998s (8.999s including waiting). Image size: 431389691 bytes.2026-07-30T01:32:13.2428559Z         2026-07-30 01:25:40 +0000 UTC	Normal	Container created2026-07-30T01:32:13.2429395Z         2026-07-30 01:25:40 +0000 UTC	Normal	Container started2026-07-30T01:32:13.2429798Z         2026-07-30T01:32:13.2430067Z         ---2026-07-30T01:32:13.2430705Z TestOSPoolEP 2026-07-30T01:32:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:32:13.2448655Z     ospool_ep_test.go:101: ---2026-07-30T01:32:13.2449374Z         Events for pod frontier-squid-765494655-kjd7j:2026-07-30T01:32:13.2450501Z         2026-07-30 01:25:30 +0000 UTC	Normal	Successfully assigned test-ospool-ep-mk3jst/frontier-squid-765494655-kjd7j to minikube2026-07-30T01:32:13.2451641Z         2026-07-30 01:25:31 +0000 UTC	Normal	Pulling image "opensciencegrid/frontier-squid:fresh"2026-07-30T01:32:13.2453187Z         2026-07-30 01:26:00 +0000 UTC	Normal	Successfully pulled image "opensciencegrid/frontier-squid:fresh" in 19.753s (28.73s including waiting). Image size: 970524479 bytes.2026-07-30T01:32:13.2454255Z         2026-07-30 01:26:00 +0000 UTC	Normal	Container created2026-07-30T01:32:13.2454889Z         2026-07-30 01:26:00 +0000 UTC	Normal	Container started2026-07-30T01:32:13.2455528Z         2026-07-30T01:32:13.2455813Z         ---2026-07-30T01:32:13.2456539Z TestOSPoolEP 2026-07-30T01:32:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:32:13.2466690Z     ospool_ep_test.go:101: ---2026-07-30T01:32:13.2467456Z         Events for pod idtoken-generator:2026-07-30T01:32:13.2468836Z         2026-07-30 01:25:10 +0000 UTC	Normal	Successfully assigned test-ospool-ep-mk3jst/idtoken-generator to minikube2026-07-30T01:32:13.2469914Z         2026-07-30 01:25:17 +0000 UTC	Normal	Pulling image "htcondor/base"2026-07-30T01:32:13.2471531Z         2026-07-30 01:25:27 +0000 UTC	Normal	Successfully pulled image "htcondor/base" in 10.228s (10.228s including waiting). Image size: 560910730 bytes.2026-07-30T01:32:13.2472344Z         2026-07-30 01:25:27 +0000 UTC	Normal	Container created2026-07-30T01:32:13.2472832Z         2026-07-30 01:25:27 +0000 UTC	Normal	Container started2026-07-30T01:32:13.2473118Z         2026-07-30T01:32:13.2473296Z         ---2026-07-30T01:32:13.2473840Z TestOSPoolEP 2026-07-30T01:32:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:32:13.2486703Z     ospool_ep_test.go:101: ---2026-07-30T01:32:13.2487665Z         Events for pod ospool-ep-7779fdb9d4-vn79p:2026-07-30T01:32:13.2489195Z         2026-07-30 01:25:30 +0000 UTC	Normal	Successfully assigned test-ospool-ep-mk3jst/ospool-ep-7779fdb9d4-vn79p to minikube2026-07-30T01:32:13.2490457Z         2026-07-30 01:25:31 +0000 UTC	Normal	Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-07-30T01:32:13.2492212Z         2026-07-30 01:26:10 +0000 UTC	Normal	Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 2.037s (38.858s including waiting). Image size: 5590942 bytes.2026-07-30T01:32:13.2493361Z         2026-07-30 01:26:10 +0000 UTC	Normal	Container created2026-07-30T01:32:13.2494045Z         2026-07-30 01:26:10 +0000 UTC	Normal	Container started2026-07-30T01:32:13.2495019Z         2026-07-30 01:26:11 +0000 UTC	Normal	Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-07-30T01:32:13.2497039Z         2026-07-30 01:26:30 +0000 UTC	Normal	Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 19.446s (19.446s including waiting). Image size: 1383210994 bytes.2026-07-30T01:32:13.2498344Z         2026-07-30 01:26:30 +0000 UTC	Normal	Container created2026-07-30T01:32:13.2498957Z         2026-07-30 01:26:30 +0000 UTC	Normal	Container started2026-07-30T01:32:13.2499379Z         2026-07-30T01:32:13.2499691Z         ---2026-07-30T01:32:13.2500517Z TestOSPoolEP 2026-07-30T01:32:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:32:13.2516180Z     ospool_ep_test.go:101: ---2026-07-30T01:32:13.2516695Z         Events for pod test-cm-54b7d49f85-nmr6g:2026-07-30T01:32:13.2518359Z         2026-07-30 01:25:30 +0000 UTC	Normal	Successfully assigned test-ospool-ep-mk3jst/test-cm-54b7d49f85-nmr6g to minikube2026-07-30T01:32:13.2519357Z         2026-07-30 01:25:31 +0000 UTC	Normal	Pulling image "htcondor/cm:25.0-el9"2026-07-30T01:32:13.2520620Z         2026-07-30 01:26:08 +0000 UTC	Normal	Successfully pulled image "htcondor/cm:25.0-el9" in 8.132s (36.821s including waiting). Image size: 573055668 bytes.2026-07-30T01:32:13.2521577Z         2026-07-30 01:26:08 +0000 UTC	Normal	Container created2026-07-30T01:32:13.2522166Z         2026-07-30 01:26:08 +0000 UTC	Normal	Container started2026-07-30T01:32:13.2522555Z         2026-07-30T01:32:13.2522808Z         ---2026-07-30T01:32:13.2523506Z TestOSPoolEP 2026-07-30T01:32:13Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-07-30T01:32:13.2561534Z TestOSPoolEP 2026-07-30T01:32:13Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst delete -f /tmp/TestOSPoolEP1050368973]2026-07-30T01:32:13.3285357Z TestOSPoolEP 2026-07-30T01:32:13Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-mk3jst namespace2026-07-30T01:32:13.3341084Z TestOSPoolEP 2026-07-30T01:32:13Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-mk3jst namespace2026-07-30T01:32:14.3343812Z TestOSPoolEP 2026-07-30T01:32:14Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst delete -f /tmp/TestOSPoolEP827224832]2026-07-30T01:32:14.4510633Z TestOSPoolEP 2026-07-30T01:32:14Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-mk3jst namespace2026-07-30T01:32:14.4549373Z TestOSPoolEP 2026-07-30T01:32:14Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-mk3jst delete -k /tmp/kustomize-template-2324811614]2026-07-30T01:32:14.5930866Z TestOSPoolEP 2026-07-30T01:32:14Z logger.go:67: serviceaccount "cvmfs-nodeplugin" deleted from test-ospool-ep-mk3jst namespace2026-07-30T01:32:14.6049341Z TestOSPoolEP 2026-07-30T01:32:14Z logger.go:67: service "frontier-squid" deleted from test-ospool-ep-mk3jst namespace2026-07-30T01:32:14.6151986Z TestOSPoolEP 2026-07-30T01:32:14Z logger.go:67: service "test-cm" deleted from test-ospool-ep-mk3jst namespace2026-07-30T01:32:14.6221184Z TestOSPoolEP 2026-07-30T01:32:14Z logger.go:67: deployment.apps "cvmfs-nodeplugin" deleted from test-ospool-ep-mk3jst namespace2026-07-30T01:32:14.6296851Z TestOSPoolEP 2026-07-30T01:32:14Z logger.go:67: deployment.apps "frontier-squid" deleted from test-ospool-ep-mk3jst namespace2026-07-30T01:32:14.6392129Z TestOSPoolEP 2026-07-30T01:32:14Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-mk3jst namespace2026-07-30T01:32:14.6457908Z TestOSPoolEP 2026-07-30T01:32:14Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-mk3jst namespace2026-07-30T01:32:14.6772678Z --- PASS: TestOSPoolEP (92.87s)2026-07-30T01:32:14.6803229Z     --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (70.04s)2026-07-30T01:32:14.6808120Z     --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.55s)2026-07-30T01:32:14.6809357Z     --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.55s)2026-07-30T01:32:14.6835880Z     --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (331.82s)2026-07-30T01:32:14.6857067Z PASS2026-07-30T01:32:14.6890195Z ok  	github.com/osg-htc/k8s-integration-tests/test	424.708s2026-07-30T01:32:14.8086318Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-07-30T01:32:14.8087062Z echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-07-30T01:32:14.8161572Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-07-30T01:32:14.8162079Z env:2026-07-30T01:32:14.8162358Z   GOTOOLCHAIN: local2026-07-30T01:32:14.8162910Z   TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-07-30T01:32:14.8163617Z ##[endgroup]2026-07-30T01:32:14.8396941Z 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-07-30T01:32:14.8398534Z ##[group]Run actions/upload-artifact@v42026-07-30T01:32:14.8398875Z with:2026-07-30T01:32:14.8399341Z   name: TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f02026-07-30T01:32:14.8399918Z   path: /tmp/k8s-tests2026-07-30T01:32:14.8400196Z   retention-days: 52026-07-30T01:32:14.8400492Z   if-no-files-found: warn2026-07-30T01:32:14.8401320Z   compression-level: 62026-07-30T01:32:14.8402549Z   overwrite: false2026-07-30T01:32:14.8402841Z   include-hidden-files: false2026-07-30T01:32:14.8403141Z env:2026-07-30T01:32:14.8403374Z   GOTOOLCHAIN: local2026-07-30T01:32:14.8403631Z ##[endgroup]2026-07-30T01:32:15.0515318Z (node:19827) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-07-30T01:32:15.0520241Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-07-30T01:32:15.0688431Z With the provided path, there will be 10 files uploaded2026-07-30T01:32:15.0689275Z Artifact name is valid!2026-07-30T01:32:15.0689699Z Root directory input is valid!2026-07-30T01:32:15.3533145Z Beginning upload of artifact content to blob storage2026-07-30T01:32:15.3808777Z (node:19827) [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-07-30T01:32:15.6433470Z Uploaded bytes 159572026-07-30T01:32:15.7044452Z Finished uploading artifact content to blob storage!2026-07-30T01:32:15.7045655Z SHA256 digest of uploaded artifact zip is 6bd6b5297208e77ea80cb11de9a38019a3f8b72ae24a2306f6ea247158c0fbbb2026-07-30T01:32:15.7046951Z Finalizing artifact upload2026-07-30T01:32:15.9117428Z Artifact TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f0.zip successfully finalized. Artifact ID 87452826182026-07-30T01:32:15.9118909Z Artifact TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f0 has been successfully uploaded! Final size is 15957 bytes. Artifact ID is 87452826182026-07-30T01:32:15.9123777Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/30505493403/artifacts/87452826182026-07-30T01:32:15.9280650Z Post job cleanup.2026-07-30T01:32:16.0288288Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-07-30T01:32:16.0357993Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-07-30T01:32:16.0390108Z /home/runner/go/pkg/mod2026-07-30T01:32:16.0405362Z /home/runner/.cache/go-build2026-07-30T01:32:16.0416485Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-07-30T01:32:16.0653610Z Post job cleanup.2026-07-30T01:32:16.1421783Z [command]/usr/bin/git version2026-07-30T01:32:16.1461198Z git version 2.54.02026-07-30T01:32:16.1496329Z Temporarily overriding HOME='/home/runner/work/_temp/53fd4481-e68d-4363-b085-9395f007eb39' before making global git config changes2026-07-30T01:32:16.1506565Z Adding repository directory to the temporary git global config as a safe directory2026-07-30T01:32:16.1507739Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-07-30T01:32:16.1568714Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-07-30T01:32:16.1617241Z [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-07-30T01:32:16.1872827Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-07-30T01:32:16.1894978Z http.https://github.com/.extraheader2026-07-30T01:32:16.1910702Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-07-30T01:32:16.1936584Z [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-07-30T01:32:16.2277334Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-07-30T01:32:16.2311715Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-07-30T01:32:16.2672425Z Cleaning up orphan processes2026-07-30T01:32:16.3442988Z ##[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/