2026-06-17T15:05:32.1206091Z Current runner version: '2.335.1'2026-06-17T15:05:32.1231018Z ##[group]Runner Image Provisioner2026-06-17T15:05:32.1232140Z Hosted Compute Agent2026-06-17T15:05:32.1232819Z Version: 20260527.5392026-06-17T15:05:32.1233684Z Commit: a891dd388383b896fa6ac04a82c0b75cec9810782026-06-17T15:05:32.1234533Z Build Date: 2026-05-27T21:39:57Z2026-06-17T15:05:32.1235386Z Worker ID: {cbe51a95-25b5-4193-8390-01da12bc15e7}2026-06-17T15:05:32.1236236Z Azure Region: westus2026-06-17T15:05:32.1236930Z ##[endgroup]2026-06-17T15:05:32.1238641Z ##[group]Operating System2026-06-17T15:05:32.1239415Z Ubuntu2026-06-17T15:05:32.1240055Z 22.04.52026-06-17T15:05:32.1241014Z LTS2026-06-17T15:05:32.1241673Z ##[endgroup]2026-06-17T15:05:32.1242393Z ##[group]Runner Image2026-06-17T15:05:32.1243198Z Image: ubuntu-22.042026-06-17T15:05:32.1243867Z Version: 20260607.168.12026-06-17T15:05:32.1245445Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260607.168/images/ubuntu/Ubuntu2204-Readme.md2026-06-17T15:05:32.1247412Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260607.1682026-06-17T15:05:32.1248672Z ##[endgroup]2026-06-17T15:05:32.1250148Z ##[group]GITHUB_TOKEN Permissions2026-06-17T15:05:32.1252319Z Contents: read2026-06-17T15:05:32.1253501Z Metadata: read2026-06-17T15:05:32.1254229Z Packages: read2026-06-17T15:05:32.1254914Z ##[endgroup]2026-06-17T15:05:32.1257389Z Secret source: Actions2026-06-17T15:05:32.1258273Z Prepare workflow directory2026-06-17T15:05:32.2338103Z Prepare all required actions2026-06-17T15:05:32.2376375Z Getting action download info2026-06-17T15:05:32.9662524Z Download action repository 'actions/checkout@v5' (SHA:93cb6efe18208431cddfb8368fd83d5badbf9bfd)2026-06-17T15:05:33.0649353Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-06-17T15:05:33.5128832Z Download action repository 'actions/setup-go@v6' (SHA:4a3601121dd01d1626a1e23e37211e3254c1c06c)2026-06-17T15:05:34.0090171Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-06-17T15:05:34.2752450Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/feature/test-web-view (e1bf63656ebd356a907b072ebb074782d99b7040)2026-06-17T15:05:34.2759049Z ##[group] Inputs2026-06-17T15:05:34.2760051Z testName: TestOSPoolEP2026-06-17T15:05:34.2762277Z testEnv: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-06-17T15:05:34.2764394Z setupScript: 2026-06-17T15:05:34.2765289Z setupEnv: {}2026-06-17T15:05:34.2766162Z ##[endgroup]2026-06-17T15:05:34.2767561Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-06-17T15:05:34.3633683Z ##[group]Run actions/checkout@v52026-06-17T15:05:34.3635249Z with:2026-06-17T15:05:34.3636199Z repository: mwestphall/k8s-integration-tests2026-06-17T15:05:34.3646583Z token: ***2026-06-17T15:05:34.3647466Z ssh-strict: true2026-06-17T15:05:34.3648341Z ssh-user: git2026-06-17T15:05:34.3649237Z persist-credentials: true2026-06-17T15:05:34.3650224Z clean: true2026-06-17T15:05:34.3651250Z sparse-checkout-cone-mode: true2026-06-17T15:05:34.3652320Z fetch-depth: 12026-06-17T15:05:34.3653179Z fetch-tags: false2026-06-17T15:05:34.3654075Z show-progress: true2026-06-17T15:05:34.3654988Z lfs: false2026-06-17T15:05:34.3655827Z submodules: false2026-06-17T15:05:34.3656732Z set-safe-directory: true2026-06-17T15:05:34.3658054Z ##[endgroup]2026-06-17T15:05:34.4672698Z Syncing repository: mwestphall/k8s-integration-tests2026-06-17T15:05:34.4675524Z ##[group]Getting Git version info2026-06-17T15:05:34.4677297Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-06-17T15:05:34.4679781Z [command]/usr/bin/git version2026-06-17T15:05:34.4723690Z git version 2.54.02026-06-17T15:05:34.4777839Z ##[endgroup]2026-06-17T15:05:34.4791341Z Temporarily overriding HOME='/home/runner/work/_temp/cc0fce78-c382-4956-a10a-0c791477271d' before making global git config changes2026-06-17T15:05:34.4796317Z Adding repository directory to the temporary git global config as a safe directory2026-06-17T15:05:34.4799480Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-06-17T15:05:34.4831280Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-06-17T15:05:34.4835315Z ##[group]Initializing the repository2026-06-17T15:05:34.4839142Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-06-17T15:05:34.4955014Z hint: Using 'master' as the name for the initial branch. This default branch name2026-06-17T15:05:34.4958512Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-06-17T15:05:34.4961103Z hint: to use in all of your new repositories, which will suppress this warning,2026-06-17T15:05:34.4963215Z hint: call:2026-06-17T15:05:34.4964199Z hint:2026-06-17T15:05:34.4965184Z hint: git config --global init.defaultBranch <name>2026-06-17T15:05:34.4966576Z hint:2026-06-17T15:05:34.4967901Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-06-17T15:05:34.4969741Z hint: 'development'. The just-created branch can be renamed via this command:2026-06-17T15:05:34.4971466Z hint:2026-06-17T15:05:34.4972280Z hint: git branch -m <name>2026-06-17T15:05:34.4973194Z hint:2026-06-17T15:05:34.4974424Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-06-17T15:05:34.4976699Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-06-17T15:05:34.4980301Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-06-17T15:05:34.5005384Z ##[endgroup]2026-06-17T15:05:34.5007295Z ##[group]Disabling automatic garbage collection2026-06-17T15:05:34.5009143Z [command]/usr/bin/git config --local gc.auto 02026-06-17T15:05:34.5038380Z ##[endgroup]2026-06-17T15:05:34.5039751Z ##[group]Setting up auth2026-06-17T15:05:34.5044117Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-06-17T15:05:34.5076618Z [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-06-17T15:05:34.5406791Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-06-17T15:05:34.5444890Z [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-06-17T15:05:34.5681724Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-06-17T15:05:34.5716498Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-06-17T15:05:34.5954392Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-06-17T15:05:34.5989122Z ##[endgroup]2026-06-17T15:05:34.5991891Z ##[group]Fetching the repository2026-06-17T15:05:34.6002115Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +e1bf63656ebd356a907b072ebb074782d99b7040:refs/remotes/origin/feature/test-web-view2026-06-17T15:05:35.3255396Z From https://github.com/mwestphall/k8s-integration-tests2026-06-17T15:05:35.3257743Z * [new ref] e1bf63656ebd356a907b072ebb074782d99b7040 -> origin/feature/test-web-view2026-06-17T15:05:35.3283833Z ##[endgroup]2026-06-17T15:05:35.3285837Z ##[group]Determining the checkout info2026-06-17T15:05:35.3287896Z ##[endgroup]2026-06-17T15:05:35.3291042Z [command]/usr/bin/git sparse-checkout disable2026-06-17T15:05:35.3334807Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-06-17T15:05:35.3362849Z ##[group]Checking out the ref2026-06-17T15:05:35.3366784Z [command]/usr/bin/git checkout --progress --force -B feature/test-web-view refs/remotes/origin/feature/test-web-view2026-06-17T15:05:35.3450928Z Switched to a new branch 'feature/test-web-view'2026-06-17T15:05:35.3454124Z branch 'feature/test-web-view' set up to track 'origin/feature/test-web-view'.2026-06-17T15:05:35.3459889Z ##[endgroup]2026-06-17T15:05:35.3498592Z [command]/usr/bin/git log -1 --format=%H2026-06-17T15:05:35.3523410Z e1bf63656ebd356a907b072ebb074782d99b70402026-06-17T15:05:35.3759802Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-06-17T15:05:35.3761454Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-06-17T15:05:35.3895636Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-06-17T15:05:35.3896692Z env:2026-06-17T15:05:35.3969714Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-06-17T15:05:35.3971989Z ##[endgroup]2026-06-17T15:05:35.4181578Z ##[group]Run true2026-06-17T15:05:35.4182690Z [36;1mtrue[0m2026-06-17T15:05:35.4240019Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-06-17T15:05:35.4241249Z ##[endgroup]2026-06-17T15:05:35.4478683Z ##[group]Run medyagh/setup-minikube@latest2026-06-17T15:05:35.4479646Z with:2026-06-17T15:05:35.4480433Z start: true2026-06-17T15:05:35.4481421Z cache: true2026-06-17T15:05:35.4482193Z minikube-version: latest2026-06-17T15:05:35.4482970Z wait: all2026-06-17T15:05:35.4483679Z ##[endgroup]2026-06-17T15:05:35.5760118Z (node:2030) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-06-17T15:05:35.5762545Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-06-17T15:05:36.6969145Z [command]/usr/bin/chmod +x /home/runner/work/_temp/8322bcb7-1c22-4918-a3b2-b33956ff92ef2026-06-17T15:05:36.8611900Z [command]/home/runner/bin/minikube version --short2026-06-17T15:05:36.9010527Z v1.38.12026-06-17T15:05:37.2017105Z Cache hit for: kic-v1.38.1-x642026-06-17T15:05:37.2181550Z (node:2030) [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-06-17T15:05:37.5162009Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-06-17T15:05:38.4976714Z Received 4194304 of 544082650 (0.8%), 4.0 MBs/sec2026-06-17T15:05:38.8211763Z Received 4194304 of 224218855 (1.9%), 4.0 MBs/sec2026-06-17T15:05:39.4944606Z Received 130023424 of 544082650 (23.9%), 61.9 MBs/sec2026-06-17T15:05:39.8261933Z Received 50331648 of 224218855 (22.4%), 24.0 MBs/sec2026-06-17T15:05:40.4949212Z Received 218103808 of 544082650 (40.1%), 69.3 MBs/sec2026-06-17T15:05:40.9101571Z Received 100663296 of 224218855 (44.9%), 31.1 MBs/sec2026-06-17T15:05:41.4952506Z Received 331350016 of 544082650 (60.9%), 78.9 MBs/sec2026-06-17T15:05:41.9068265Z Received 113246208 of 224218855 (50.5%), 26.4 MBs/sec2026-06-17T15:05:42.4957563Z Received 444596224 of 544082650 (81.7%), 84.7 MBs/sec2026-06-17T15:05:42.9063921Z Received 113246208 of 224218855 (50.5%), 21.2 MBs/sec2026-06-17T15:05:43.4954659Z Received 536870912 of 544082650 (98.7%), 85.3 MBs/sec2026-06-17T15:05:43.6846321Z Received 544082650 of 544082650 (100.0%), 83.8 MBs/sec2026-06-17T15:05:43.6847612Z Cache Size: ~519 MB (544082650 B)2026-06-17T15:05:43.6976702Z [command]/usr/bin/tar -xf /home/runner/work/_temp/750fa583-47b4-4843-81b9-954c0c568d9a/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-06-17T15:05:43.9068695Z Received 113246208 of 224218855 (50.5%), 17.7 MBs/sec2026-06-17T15:05:44.5552379Z Cache restored successfully2026-06-17T15:05:44.9066856Z Received 201326592 of 224218855 (89.8%), 27.1 MBs/sec2026-06-17T15:05:45.5063714Z Received 224218855 of 224218855 (100.0%), 27.8 MBs/sec2026-06-17T15:05:45.5065545Z Cache Size: ~214 MB (224218855 B)2026-06-17T15:05:45.5161607Z [command]/usr/bin/tar -xf /home/runner/work/_temp/ce5979b7-9836-45ea-ad85-c202b07224ff/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-06-17T15:05:46.0536833Z Cache restored successfully2026-06-17T15:05:46.1069970Z [command]/home/runner/bin/minikube start --wait all2026-06-17T15:05:46.1498280Z * minikube v1.38.1 on Ubuntu 22.042026-06-17T15:05:46.5925492Z ! 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-06-17T15:05:46.5933240Z * Automatically selected the docker driver. Other choices: podman, ssh, none2026-06-17T15:05:46.6424770Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-06-17T15:05:46.6434362Z * Using Docker driver with root privileges2026-06-17T15:05:46.6447106Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-06-17T15:05:46.6454922Z * Pulling base image v0.0.50 ...2026-06-17T15:06:18.2514954Z * Configuring bridge CNI (Container Networking Interface) ...2026-06-17T15:06:23.4068376Z * Verifying Kubernetes components...2026-06-17T15:06:23.4314492Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-06-17T15:06:24.1992515Z * Enabled addons: storage-provisioner, default-storageclass2026-06-17T15:07:12.8395667Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-06-17T15:07:12.8521897Z [command]/home/runner/bin/minikube version --short2026-06-17T15:07:12.8931449Z v1.38.12026-06-17T15:07:12.9265128Z ##[group]Run actions/setup-go@v62026-06-17T15:07:12.9265437Z with:2026-06-17T15:07:12.9265680Z go-version: 1.262026-06-17T15:07:12.9265907Z cache: true2026-06-17T15:07:12.9266149Z cache-dependency-path: go.sum2026-06-17T15:07:12.9266437Z check-latest: false2026-06-17T15:07:12.9269589Z token: ***2026-06-17T15:07:12.9269825Z ##[endgroup]2026-06-17T15:07:13.0871298Z Setup go version spec 1.262026-06-17T15:07:13.0954076Z Attempting to download 1.26...2026-06-17T15:07:13.8537519Z matching 1.26...2026-06-17T15:07:13.8545992Z Acquiring 1.26.4 from https://github.com/actions/go-versions/releases/download/1.26.4-26891772857/go-1.26.4-linux-x64.tar.gz2026-06-17T15:07:14.4130662Z Extracting Go...2026-06-17T15:07:14.4246111Z [command]/usr/bin/tar xz --warning=no-unknown-keyword --overwrite -C /home/runner/work/_temp/a7073bd2-ef1d-49bb-aa34-544c90dbeedf -f /home/runner/work/_temp/cfe634d1-ab4c-4b6e-83c8-7d4c9e44c0082026-06-17T15:07:16.1604843Z Successfully extracted go to /home/runner/work/_temp/a7073bd2-ef1d-49bb-aa34-544c90dbeedf2026-06-17T15:07:16.1606410Z Adding to the cache ...2026-06-17T15:07:22.0844945Z Successfully cached go to /opt/hostedtoolcache/go/1.26.4/x642026-06-17T15:07:22.0849898Z Added go to the path2026-06-17T15:07:22.0850538Z Successfully set up Go version 1.262026-06-17T15:07:22.1154561Z [command]/opt/hostedtoolcache/go/1.26.4/x64/bin/go env GOMODCACHE2026-06-17T15:07:22.1186730Z [command]/opt/hostedtoolcache/go/1.26.4/x64/bin/go env GOCACHE2026-06-17T15:07:22.1219201Z /home/runner/go/pkg/mod2026-06-17T15:07:22.1243393Z /home/runner/.cache/go-build2026-06-17T15:07:22.4792928Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.4-4d532554cd8420c389c8064f4e1b4d5cc1d79ec73be5008309ef5f6e35b363a42026-06-17T15:07:23.7756000Z Received 0 of 252076037 (0.0%), 0.0 MBs/sec2026-06-17T15:07:24.7764093Z Received 121634816 of 252076037 (48.3%), 57.9 MBs/sec2026-06-17T15:07:25.8040140Z Received 252076037 of 252076037 (100.0%), 79.4 MBs/sec2026-06-17T15:07:25.8041813Z Cache Size: ~240 MB (252076037 B)2026-06-17T15:07:25.8136393Z [command]/usr/bin/tar -xf /home/runner/work/_temp/7541ae66-b2c6-4f55-b0e9-cb0f567346ec/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-06-17T15:07:28.9997072Z Cache restored successfully2026-06-17T15:07:29.0595393Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.4-4d532554cd8420c389c8064f4e1b4d5cc1d79ec73be5008309ef5f6e35b363a42026-06-17T15:07:29.0627728Z go version go1.26.4 linux/amd642026-06-17T15:07:29.0628015Z 2026-06-17T15:07:29.0628413Z ##[group]go env2026-06-17T15:07:29.0769466Z AR='ar'2026-06-17T15:07:29.0769921Z CC='gcc'2026-06-17T15:07:29.0770372Z CGO_CFLAGS='-O2 -g'2026-06-17T15:07:29.0771127Z CGO_CPPFLAGS=''2026-06-17T15:07:29.0771620Z CGO_CXXFLAGS='-O2 -g'2026-06-17T15:07:29.0772108Z CGO_ENABLED='1'2026-06-17T15:07:29.0772583Z CGO_FFLAGS='-O2 -g'2026-06-17T15:07:29.0773204Z CGO_LDFLAGS='-O2 -g'2026-06-17T15:07:29.0773666Z CXX='g++'2026-06-17T15:07:29.0773968Z GCCGO='gccgo'2026-06-17T15:07:29.0774253Z GO111MODULE=''2026-06-17T15:07:29.0774542Z GOAMD64='v1'2026-06-17T15:07:29.0774831Z GOARCH='amd64'2026-06-17T15:07:29.0775101Z GOAUTH='netrc'2026-06-17T15:07:29.0775391Z GOBIN=''2026-06-17T15:07:29.0775712Z GOCACHE='/home/runner/.cache/go-build'2026-06-17T15:07:29.0776133Z GOCACHEPROG=''2026-06-17T15:07:29.0776431Z GODEBUG=''2026-06-17T15:07:29.0776766Z GOENV='/home/runner/.config/go/env'2026-06-17T15:07:29.0777154Z GOEXE=''2026-06-17T15:07:29.0777448Z GOEXPERIMENT=''2026-06-17T15:07:29.0777765Z GOFIPS140='off'2026-06-17T15:07:29.0778059Z GOFLAGS=''2026-06-17T15:07:29.0779036Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build3541419010=/tmp/go-build -gno-record-gcc-switches'2026-06-17T15:07:29.0780063Z GOHOSTARCH='amd64'2026-06-17T15:07:29.0780381Z GOHOSTOS='linux'2026-06-17T15:07:29.0780689Z GOINSECURE=''2026-06-17T15:07:29.0781779Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-06-17T15:07:29.0782422Z GOMODCACHE='/home/runner/go/pkg/mod'2026-06-17T15:07:29.0782833Z GONOPROXY=''2026-06-17T15:07:29.0783129Z GONOSUMDB=''2026-06-17T15:07:29.0783421Z GOOS='linux'2026-06-17T15:07:29.0783726Z GOPATH='/home/runner/go'2026-06-17T15:07:29.0784121Z GOPRIVATE=''2026-06-17T15:07:29.0784615Z GOPROXY='https://proxy.golang.org,direct'2026-06-17T15:07:29.0785125Z GOROOT='/opt/hostedtoolcache/go/1.26.4/x64'2026-06-17T15:07:29.0785572Z GOSUMDB='sum.golang.org'2026-06-17T15:07:29.0785936Z GOTELEMETRY='local'2026-06-17T15:07:29.0786340Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-06-17T15:07:29.0786729Z GOTMPDIR=''2026-06-17T15:07:29.0786980Z GOTOOLCHAIN='local'2026-06-17T15:07:29.0787391Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.4/x64/pkg/tool/linux_amd64'2026-06-17T15:07:29.0787840Z GOVCS=''2026-06-17T15:07:29.0788098Z GOVERSION='go1.26.4'2026-06-17T15:07:29.0788366Z GOWORK=''2026-06-17T15:07:29.0788626Z PKG_CONFIG='pkg-config'2026-06-17T15:07:29.0788811Z 2026-06-17T15:07:29.0789177Z ##[endgroup]2026-06-17T15:07:29.1006107Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-06-17T15:07:29.1006710Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-06-17T15:07:29.1062935Z shell: /usr/bin/bash -e {0}2026-06-17T15:07:29.1063259Z env:2026-06-17T15:07:29.1063500Z GOTOOLCHAIN: local2026-06-17T15:07:29.1063804Z OSPOOL_EP_OSPoolEPTag: 25-release2026-06-17T15:07:29.1064143Z OSPOOL_EP_CMTag: 25.0-el92026-06-17T15:07:29.1064461Z OSPOOL_EP_CvmfsType: cvmfsexec2026-06-17T15:07:29.1064772Z ##[endgroup]2026-06-17T15:07:31.3303574Z === RUN TestOSPoolEP2026-06-17T15:07:31.3304360Z === PAUSE TestOSPoolEP2026-06-17T15:07:31.3304777Z === CONT TestOSPoolEP2026-06-17T15:07:31.3306209Z TestOSPoolEP 2026-06-17T15:07:31Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:07:31.3465264Z TestOSPoolEP 2026-06-17T15:07:31Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi apply -f /tmp/TestOSPoolEP1569329052]2026-06-17T15:07:32.0194779Z TestOSPoolEP 2026-06-17T15:07:32Z logger.go:67: pod/idtoken-generator created2026-06-17T15:07:32.0287194Z TestOSPoolEP 2026-06-17T15:07:32Z logger.go:67: secret/pool-passwd created2026-06-17T15:07:32.0342207Z TestOSPoolEP 2026-06-17T15:07:32Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-06-17T15:07:32.0344378Z TestOSPoolEP 2026-06-17T15:07:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:07:32.0365502Z TestOSPoolEP 2026-06-17T15:07:32Z 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-06-17T15:07:42.0388271Z TestOSPoolEP 2026-06-17T15:07:42Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-06-17T15:07:42.0394174Z TestOSPoolEP 2026-06-17T15:07:42Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:07:42.0415761Z TestOSPoolEP 2026-06-17T15:07:42Z 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-06-17T15:07:52.0426529Z TestOSPoolEP 2026-06-17T15:07:52Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-06-17T15:07:52.0428200Z TestOSPoolEP 2026-06-17T15:07:52Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:07:52.0448893Z TestOSPoolEP 2026-06-17T15:07:52Z logger.go:67: Pod is now available2026-06-17T15:07:52.0451288Z TestOSPoolEP 2026-06-17T15:07:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-06-17T15:07:53.6048685Z TestOSPoolEP 2026-06-17T15:07:53Z logger.go:67: ***2026-06-17T15:07:53.6118539Z TestOSPoolEP 2026-06-17T15:07:53Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi apply -f /tmp/TestOSPoolEP3586684211]2026-06-17T15:07:53.7891788Z TestOSPoolEP 2026-06-17T15:07:53Z logger.go:67: secret/pool-token created2026-06-17T15:07:53.7923352Z TestOSPoolEP 2026-06-17T15:07:53Z retry.go:91: Wait for secret pool-token to be provisioned.2026-06-17T15:07:53.7924530Z TestOSPoolEP 2026-06-17T15:07:53Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:07:53.7942345Z TestOSPoolEP 2026-06-17T15:07:53Z logger.go:67: Secret is now available2026-06-17T15:07:53.7974666Z TestOSPoolEP 2026-06-17T15:07:53Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi apply -k /tmp/kustomize-template-3974619723]2026-06-17T15:07:54.1296609Z TestOSPoolEP 2026-06-17T15:07:54Z logger.go:67: service/test-cm created2026-06-17T15:07:54.1393199Z TestOSPoolEP 2026-06-17T15:07:54Z 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-06-17T15:07:54.1402545Z TestOSPoolEP 2026-06-17T15:07:54Z logger.go:67: deployment.apps/ospool-ep created2026-06-17T15:07:54.1525942Z TestOSPoolEP 2026-06-17T15:07:54Z logger.go:67: deployment.apps/test-cm created2026-06-17T15:07:54.1566795Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-06-17T15:07:54.1577491Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:07:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:07:54.1659173Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:07:54Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-06-17T15:07:54.1661702Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:07:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:07:54.1670342Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:07:54Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-06-17T15:07:54.1672747Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:07:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:07:54.1785538Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:07:54Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-6c7d796845". Sleeping for 10s and will try again.2026-06-17T15:07:54.1793122Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:07:54Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "test-cm-54b7d49f85". Sleeping for 10s and will try again.2026-06-17T15:08:04.1793573Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:08:04Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-06-17T15:08:04.1797552Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:08:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:08:04.1801761Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:08:04Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-06-17T15:08:04.1804841Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:08:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:08:04.1824590Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:08:04Z logger.go:67: Deployment is now available2026-06-17T15:08:04.1826966Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:08:04Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-06-17T15:08:14.1845897Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:08:14Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-06-17T15:08:14.1847207Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:08:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:08:14.1892412Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:08:14Z 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-06-17T15:08:24.1900216Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:08:24Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-06-17T15:08:24.1902604Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:08:24Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:08:24.1930127Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-06-17T15:08:24Z logger.go:67: Deployment is now available2026-06-17T15:08:24.1942659Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-06-17T15:08:24.1943934Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-06-17T15:08:24.1947490Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-06-17T15:08:24.1948717Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-06-17T15:08:24.1950239Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-06-17T15:08:24.1954404Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-06-17T15:08:24.1955565Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-06-17T15:08:24.1957969Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-17T15:08:24Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:08:24.1962711Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-06-17T15:08:24.1984509Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:08:24Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:08:24.1986065Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-06-17T15:08:24.1987756Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-17T15:08:24Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:08:24.2003841Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:08:24Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:08:24.2006180Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-17T15:08:24Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:08:24.2008451Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-17T15:08:24Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:08:24.2011908Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-17T15:08:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_SINGULARITY]2026-06-17T15:08:24.2052037Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:08:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-17T15:08:24.2055741Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-17T15:08:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)']2026-06-17T15:08:24.4953146Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-nmcsd failed. Retrying in 10s.2026-06-17T15:08:24.4971592Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-06-17T15:08:24.4975365Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmcsd failed. Retrying in 30s.2026-06-17T15:08:24.4983271Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-06-17T15:08:24.4984592Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)']' in pod test-cm-54b7d49f85-nmcsd failed. Retrying in 10s.2026-06-17T15:08:34.4966762Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-17T15:08:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_SINGULARITY]2026-06-17T15:08:34.4993287Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-17T15:08:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)']2026-06-17T15:08:34.7444313Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)']' in pod test-cm-54b7d49f85-nmcsd failed. Retrying in 10s.2026-06-17T15:08:34.7446174Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-06-17T15:08:34.7447477Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-nmcsd failed. Retrying in 10s.2026-06-17T15:08:44.7458822Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-17T15:08:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_SINGULARITY]2026-06-17T15:08:44.7495724Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-17T15:08:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)']2026-06-17T15:08:44.9603262Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-06-17T15:08:44Z logger.go:67: true2026-06-17T15:08:44.9605913Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-17T15:08:44Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-06-17T15:08:44.9607781Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-17T15:08:44Z logger.go:67: 2026-06-17T15:08:44.9609930Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-17T15:08:44Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-47g2g LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-06-17T15:08:44.9612343Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-17T15:08:44Z logger.go:67: 2026-06-17T15:08:44.9617662Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-17T15:08:44Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-06-17T15:08:44.9619308Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-17T15:08:44Z logger.go:67: 2026-06-17T15:08:44.9621091Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-17T15:08:44Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-06-17T15:08:44.9622567Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-17T15:08:44Z logger.go:67: 2026-06-17T15:08:44.9624093Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-06-17T15:08:44Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-06-17T15:08:54.4984084Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:08:54Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-17T15:08:54.6503719Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:08:54Z logger.go:67: undefined2026-06-17T15:08:54.6551712Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-06-17T15:08:54.6553319Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmcsd failed. Retrying in 30s.2026-06-17T15:09:24.6558593Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:09:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-17T15:09:24.7959894Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:09:24Z logger.go:67: undefined2026-06-17T15:09:24.8014167Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmcsd failed. Retrying in 30s.2026-06-17T15:09:54.8024402Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:09:54Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-17T15:09:54.9456895Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:09:54Z logger.go:67: undefined2026-06-17T15:09:54.9513485Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmcsd failed. Retrying in 30s.2026-06-17T15:10:24.9517115Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:10:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-17T15:10:25.1018810Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:10:25Z logger.go:67: undefined2026-06-17T15:10:25.1077159Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmcsd failed. Retrying in 30s.2026-06-17T15:10:55.1109922Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:10:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-17T15:10:55.2519347Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:10:55Z logger.go:67: undefined2026-06-17T15:10:55.2595050Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmcsd failed. Retrying in 30s.2026-06-17T15:11:25.2636485Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:11:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-17T15:11:25.4130709Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:11:25Z logger.go:67: undefined2026-06-17T15:11:25.4192928Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmcsd failed. Retrying in 30s.2026-06-17T15:11:55.4239236Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:11:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-17T15:11:55.5725236Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:11:55Z logger.go:67: undefined2026-06-17T15:11:55.5794290Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmcsd failed. Retrying in 30s.2026-06-17T15:12:25.5799335Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:12:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-17T15:12:25.7248809Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:12:25Z logger.go:67: undefined2026-06-17T15:12:25.7305130Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmcsd failed. Retrying in 30s.2026-06-17T15:12:55.7348313Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:12:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-17T15:12:55.8786431Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:12:55Z logger.go:67: undefined2026-06-17T15:12:55.8845477Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmcsd failed. Retrying in 30s.2026-06-17T15:13:25.8851358Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:13:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-17T15:13:26.0342982Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:13:26Z logger.go:67: undefined2026-06-17T15:13:26.0402900Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-nmcsd failed. Retrying in 30s.2026-06-17T15:13:56.0406965Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:13:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi exec test-cm-54b7d49f85-nmcsd -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-47g2g",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-06-17T15:13:56.2267470Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-06-17T15:13:56Z logger.go:67: true2026-06-17T15:13:56.2328403Z TestOSPoolEP 2026-06-17T15:13:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:13:56.2402398Z TestOSPoolEP 2026-06-17T15:13:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:13:56.4038206Z TestOSPoolEP 2026-06-17T15:13:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:13:56.5273900Z TestOSPoolEP 2026-06-17T15:13:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:13:56.6437404Z TestOSPoolEP 2026-06-17T15:13:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:13:56.6462241Z === NAME TestOSPoolEP2026-06-17T15:13:56.6468661Z ospool_ep_test.go:101: ---2026-06-17T15:13:56.6469501Z Events for pod idtoken-generator:2026-06-17T15:13:56.6471229Z 2026-06-17 15:07:32 +0000 UTC Normal Successfully assigned test-ospool-ep-fjyoqi/idtoken-generator to minikube2026-06-17T15:13:56.6472610Z 2026-06-17 15:07:35 +0000 UTC Normal Pulling image "htcondor/base"2026-06-17T15:13:56.6474216Z 2026-06-17 15:07:44 +0000 UTC Normal Successfully pulled image "htcondor/base" in 9.182s (9.182s including waiting). Image size: 557830759 bytes.2026-06-17T15:13:56.6475014Z 2026-06-17 15:07:44 +0000 UTC Normal Container created2026-06-17T15:13:56.6475508Z 2026-06-17 15:07:44 +0000 UTC Normal Container started2026-06-17T15:13:56.6475828Z 2026-06-17T15:13:56.6476043Z ---2026-06-17T15:13:56.6476623Z TestOSPoolEP 2026-06-17T15:13:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:13:56.6490629Z ospool_ep_test.go:101: ---2026-06-17T15:13:56.6491588Z Events for pod ospool-ep-6c7d796845-47g2g:2026-06-17T15:13:56.6493437Z 2026-06-17 15:07:54 +0000 UTC Normal Successfully assigned test-ospool-ep-fjyoqi/ospool-ep-6c7d796845-47g2g to minikube2026-06-17T15:13:56.6495099Z 2026-06-17 15:07:54 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-06-17T15:13:56.6497274Z 2026-06-17 15:07:56 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 2.038s (2.038s including waiting). Image size: 5590942 bytes.2026-06-17T15:13:56.6498840Z 2026-06-17 15:07:56 +0000 UTC Normal Container created2026-06-17T15:13:56.6499877Z 2026-06-17 15:07:56 +0000 UTC Normal Container started2026-06-17T15:13:56.6501465Z 2026-06-17 15:07:57 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-06-17T15:13:56.6503870Z 2026-06-17 15:08:17 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 14.393s (19.867s including waiting). Image size: 1117466755 bytes.2026-06-17T15:13:56.6509196Z 2026-06-17 15:08:17 +0000 UTC Normal Container created2026-06-17T15:13:56.6510156Z 2026-06-17 15:08:17 +0000 UTC Normal Container started2026-06-17T15:13:56.6511009Z 2026-06-17T15:13:56.6511395Z ---2026-06-17T15:13:56.6512432Z TestOSPoolEP 2026-06-17T15:13:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:13:56.6513837Z ospool_ep_test.go:101: ---2026-06-17T15:13:56.6514669Z Events for pod test-cm-54b7d49f85-nmcsd:2026-06-17T15:13:56.6516221Z 2026-06-17 15:07:54 +0000 UTC Normal Successfully assigned test-ospool-ep-fjyoqi/test-cm-54b7d49f85-nmcsd to minikube2026-06-17T15:13:56.6521540Z 2026-06-17 15:07:54 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-06-17T15:13:56.6524161Z 2026-06-17 15:08:02 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 6.01s (8.029s including waiting). Image size: 569448471 bytes.2026-06-17T15:13:56.6525730Z 2026-06-17 15:08:02 +0000 UTC Normal Container created2026-06-17T15:13:56.6529295Z 2026-06-17 15:08:02 +0000 UTC Normal Container started2026-06-17T15:13:56.6529914Z 2026-06-17T15:13:56.6531124Z ---2026-06-17T15:13:56.6535697Z TestOSPoolEP 2026-06-17T15:13:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-06-17T15:13:56.6560193Z TestOSPoolEP 2026-06-17T15:13:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi delete -f /tmp/TestOSPoolEP191215832]2026-06-17T15:13:56.7606024Z TestOSPoolEP 2026-06-17T15:13:56Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-fjyoqi namespace2026-06-17T15:13:56.7634125Z TestOSPoolEP 2026-06-17T15:13:56Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-fjyoqi namespace2026-06-17T15:13:58.2697492Z TestOSPoolEP 2026-06-17T15:13:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi delete -f /tmp/TestOSPoolEP2405900722]2026-06-17T15:13:58.3595121Z TestOSPoolEP 2026-06-17T15:13:58Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-fjyoqi namespace2026-06-17T15:13:58.3631853Z TestOSPoolEP 2026-06-17T15:13:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-fjyoqi delete -k /tmp/kustomize-template-3974619723]2026-06-17T15:13:58.4666835Z TestOSPoolEP 2026-06-17T15:13:58Z logger.go:67: service "test-cm" deleted from test-ospool-ep-fjyoqi namespace2026-06-17T15:13:58.4736281Z TestOSPoolEP 2026-06-17T15:13:58Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-fjyoqi namespace2026-06-17T15:13:58.4767779Z TestOSPoolEP 2026-06-17T15:13:58Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-fjyoqi namespace2026-06-17T15:13:58.4892963Z --- PASS: TestOSPoolEP (55.12s)2026-06-17T15:13:58.4896433Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.04s)2026-06-17T15:13:58.4897737Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.77s)2026-06-17T15:13:58.4898767Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.77s)2026-06-17T15:13:58.4899836Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (332.04s)2026-06-17T15:13:58.4900502Z PASS2026-06-17T15:13:58.4926922Z ok github.com/osg-htc/k8s-integration-tests/test 387.173s2026-06-17T15:13:58.5893454Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-06-17T15:13:58.5894135Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-06-17T15:13:58.5952006Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-06-17T15:13:58.5952397Z env:2026-06-17T15:13:58.5952609Z GOTOOLCHAIN: local2026-06-17T15:13:58.5953160Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-06-17T15:13:58.5953760Z ##[endgroup]2026-06-17T15:13:58.6123679Z 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-06-17T15:13:58.6124968Z ##[group]Run actions/upload-artifact@v42026-06-17T15:13:58.6125250Z with:2026-06-17T15:13:58.6125634Z name: TestOSPoolEP-cc19cc9f6a267801fd4b50ff75e13034a08c460c9bda971d5975af0507e12f662026-06-17T15:13:58.6126103Z path: /tmp/k8s-tests2026-06-17T15:13:58.6126333Z retention-days: 52026-06-17T15:13:58.6126564Z if-no-files-found: warn2026-06-17T15:13:58.6126804Z compression-level: 62026-06-17T15:13:58.6127032Z overwrite: false2026-06-17T15:13:58.6127254Z include-hidden-files: false2026-06-17T15:13:58.6127499Z env:2026-06-17T15:13:58.6127686Z GOTOOLCHAIN: local2026-06-17T15:13:58.6127920Z ##[endgroup]2026-06-17T15:13:58.8238263Z (node:18217) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-06-17T15:13:58.8239740Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-06-17T15:13:58.8315700Z With the provided path, there will be 6 files uploaded2026-06-17T15:13:58.8325675Z Artifact name is valid!2026-06-17T15:13:58.8330316Z Root directory input is valid!2026-06-17T15:13:59.3958504Z Beginning upload of artifact content to blob storage2026-06-17T15:13:59.4308592Z (node:18217) [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-06-17T15:13:59.7505785Z Uploaded bytes 140002026-06-17T15:13:59.8252596Z Finished uploading artifact content to blob storage!2026-06-17T15:13:59.8253674Z SHA256 digest of uploaded artifact zip is d4f668f36bd1448b23945289e15154d4bf3a9504946887766975eca7fc2797cc2026-06-17T15:13:59.8255966Z Finalizing artifact upload2026-06-17T15:14:00.1676888Z Artifact TestOSPoolEP-cc19cc9f6a267801fd4b50ff75e13034a08c460c9bda971d5975af0507e12f66.zip successfully finalized. Artifact ID 76996461162026-06-17T15:14:00.1681536Z Artifact TestOSPoolEP-cc19cc9f6a267801fd4b50ff75e13034a08c460c9bda971d5975af0507e12f66 has been successfully uploaded! Final size is 14000 bytes. Artifact ID is 76996461162026-06-17T15:14:00.1687005Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/27698815032/artifacts/76996461162026-06-17T15:14:00.1883831Z Post job cleanup.2026-06-17T15:14:00.3498682Z [command]/opt/hostedtoolcache/go/1.26.4/x64/bin/go env GOMODCACHE2026-06-17T15:14:00.3541709Z [command]/opt/hostedtoolcache/go/1.26.4/x64/bin/go env GOCACHE2026-06-17T15:14:00.3568901Z /home/runner/go/pkg/mod2026-06-17T15:14:00.3591014Z /home/runner/.cache/go-build2026-06-17T15:14:00.3601296Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.4-4d532554cd8420c389c8064f4e1b4d5cc1d79ec73be5008309ef5f6e35b363a4, not saving cache.2026-06-17T15:14:00.3746192Z Post job cleanup.2026-06-17T15:14:00.4678019Z [command]/usr/bin/git version2026-06-17T15:14:00.4722386Z git version 2.54.02026-06-17T15:14:00.4759063Z Temporarily overriding HOME='/home/runner/work/_temp/a906c77c-4801-4478-9114-e94cb6502e81' before making global git config changes2026-06-17T15:14:00.4766756Z Adding repository directory to the temporary git global config as a safe directory2026-06-17T15:14:00.4768262Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-06-17T15:14:00.4803193Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-06-17T15:14:00.4863170Z [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-06-17T15:14:00.5145474Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-06-17T15:14:00.5172159Z http.https://github.com/.extraheader2026-06-17T15:14:00.5185005Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-06-17T15:14:00.5219166Z [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-06-17T15:14:00.5469075Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-06-17T15:14:00.5504860Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-06-17T15:14:00.5907043Z Cleaning up orphan processes2026-06-17T15:14:00.6568312Z ##[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/