2026-08-01T01:51:15.5034232Z Current runner version: '2.336.0'2026-08-01T01:51:15.5068138Z ##[group]Runner Image Provisioner2026-08-01T01:51:15.5069757Z Hosted Compute Agent2026-08-01T01:51:15.5070723Z Version: 20260707.5632026-08-01T01:51:15.5071894Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-08-01T01:51:15.5073144Z Build Date: 2026-07-07T19:33:50Z2026-08-01T01:51:15.5074452Z Worker ID: {22e66614-673b-4302-8066-b3b892ffc8f6}2026-08-01T01:51:15.5075658Z Azure Region: eastus2026-08-01T01:51:15.5076529Z ##[endgroup]2026-08-01T01:51:15.5079059Z ##[group]Operating System2026-08-01T01:51:15.5080337Z Ubuntu2026-08-01T01:51:15.5081260Z 22.04.52026-08-01T01:51:15.5082114Z LTS2026-08-01T01:51:15.5082973Z ##[endgroup]2026-08-01T01:51:15.5084136Z ##[group]Runner Image2026-08-01T01:51:15.5085114Z Image: ubuntu-22.042026-08-01T01:51:15.5085996Z Version: 20260720.234.22026-08-01T01:51:15.5088222Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-08-01T01:51:15.5091244Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-08-01T01:51:15.5092946Z ##[endgroup]2026-08-01T01:51:15.5095472Z ##[group]GITHUB_TOKEN Permissions2026-08-01T01:51:15.5098413Z Contents: read2026-08-01T01:51:15.5099761Z Metadata: read2026-08-01T01:51:15.5100703Z Packages: read2026-08-01T01:51:15.5101589Z ##[endgroup]2026-08-01T01:51:15.5104945Z Secret source: Actions2026-08-01T01:51:15.5106909Z Prepare workflow directory2026-08-01T01:51:15.5570571Z Prepare all required actions2026-08-01T01:51:15.5639354Z Getting action download info2026-08-01T01:51:15.7492536Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-01T01:51:15.9494888Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-01T01:51:16.0597680Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-01T01:51:16.2024637Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-01T01:51:16.5197286Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-01T01:51:16.5202361Z ##[group] Inputs2026-08-01T01:51:16.5202939Z testName: TestOSPoolEP2026-08-01T01:51:16.5204008Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-01T01:51:16.5205150Z setupScript: 2026-08-01T01:51:16.5205614Z setupEnv: {}2026-08-01T01:51:16.5206061Z ##[endgroup]2026-08-01T01:51:16.5206834Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-testing) / Run Tests2026-08-01T01:51:16.5956362Z ##[group]Run actions/checkout@v52026-08-01T01:51:16.5957295Z with:2026-08-01T01:51:16.5957815Z repository: mwestphall/k8s-integration-tests2026-08-01T01:51:16.5963011Z token: ***2026-08-01T01:51:16.5963474Z ssh-strict: true2026-08-01T01:51:16.5963952Z ssh-user: git2026-08-01T01:51:16.5964413Z persist-credentials: true2026-08-01T01:51:16.5964932Z clean: true2026-08-01T01:51:16.5965400Z sparse-checkout-cone-mode: true2026-08-01T01:51:16.5965961Z fetch-depth: 12026-08-01T01:51:16.5966403Z fetch-tags: false2026-08-01T01:51:16.5966865Z show-progress: true2026-08-01T01:51:16.5967332Z lfs: false2026-08-01T01:51:16.5967746Z submodules: false2026-08-01T01:51:16.5968217Z set-safe-directory: true2026-08-01T01:51:16.5968748Z allow-unsafe-pr-checkout: false2026-08-01T01:51:16.5969750Z ##[endgroup]2026-08-01T01:51:16.6993143Z Syncing repository: mwestphall/k8s-integration-tests2026-08-01T01:51:16.6995926Z ##[group]Getting Git version info2026-08-01T01:51:16.6997596Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-01T01:51:16.7000153Z [command]/usr/bin/git version2026-08-01T01:51:16.7031625Z git version 2.54.02026-08-01T01:51:16.7085800Z ##[endgroup]2026-08-01T01:51:16.7101624Z Temporarily overriding HOME='/home/runner/work/_temp/cc030442-b090-4408-9243-f2621c016939' before making global git config changes2026-08-01T01:51:16.7104665Z Adding repository directory to the temporary git global config as a safe directory2026-08-01T01:51:16.7129698Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-01T01:51:16.7157690Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-01T01:51:16.7164030Z ##[group]Initializing the repository2026-08-01T01:51:16.7170226Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-01T01:51:16.7284035Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-01T01:51:16.7286185Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-01T01:51:16.7288361Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-01T01:51:16.7290503Z hint: call:2026-08-01T01:51:16.7291176Z hint:2026-08-01T01:51:16.7291924Z hint: git config --global init.defaultBranch <name>2026-08-01T01:51:16.7292811Z hint:2026-08-01T01:51:16.7293635Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-01T01:51:16.7295146Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-01T01:51:16.7297172Z hint:2026-08-01T01:51:16.7297877Z hint: git branch -m <name>2026-08-01T01:51:16.7298597Z hint:2026-08-01T01:51:16.7300181Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-01T01:51:16.7302910Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-01T01:51:16.7306552Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-01T01:51:16.7340480Z ##[endgroup]2026-08-01T01:51:16.7341746Z ##[group]Disabling automatic garbage collection2026-08-01T01:51:16.7343860Z [command]/usr/bin/git config --local gc.auto 02026-08-01T01:51:16.7376293Z ##[endgroup]2026-08-01T01:51:16.7377440Z ##[group]Setting up auth2026-08-01T01:51:16.7383127Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-01T01:51:16.7416936Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :"2026-08-01T01:51:16.7787606Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-01T01:51:16.7827453Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :"2026-08-01T01:51:16.8088734Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-01T01:51:16.8125333Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-01T01:51:16.8365595Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-01T01:51:16.8404762Z ##[endgroup]2026-08-01T01:51:16.8405657Z ##[group]Fetching the repository2026-08-01T01:51:16.8414439Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-01T01:51:17.0126406Z From https://github.com/mwestphall/k8s-integration-tests2026-08-01T01:51:17.0127620Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-01T01:51:17.0155382Z ##[endgroup]2026-08-01T01:51:17.0157386Z ##[group]Determining the checkout info2026-08-01T01:51:17.0159712Z ##[endgroup]2026-08-01T01:51:17.0165031Z [command]/usr/bin/git sparse-checkout disable2026-08-01T01:51:17.0212366Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-01T01:51:17.0245044Z ##[group]Checking out the ref2026-08-01T01:51:17.0249114Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-01T01:51:17.0402346Z Switched to a new branch 'main'2026-08-01T01:51:17.0406847Z branch 'main' set up to track 'origin/main'.2026-08-01T01:51:17.0417245Z ##[endgroup]2026-08-01T01:51:17.0453756Z [command]/usr/bin/git log -1 --format=%H2026-08-01T01:51:17.0482497Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-01T01:51:17.0726136Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-01T01:51:17.0727571Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-01T01:51:17.0728867Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-01T01:51:17.0845848Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-01T01:51:17.0846661Z env:2026-08-01T01:51:17.0847628Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-01T01:51:17.0848799Z SETUP_ENV_YAML: {}2026-08-01T01:51:17.0849277Z ##[endgroup]2026-08-01T01:51:17.7136646Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-01T01:51:17.7139202Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-01T01:51:17.7202622Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-01T01:51:17.7204048Z env:2026-08-01T01:51:17.7205882Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-01T01:51:17.7208087Z ##[endgroup]2026-08-01T01:51:17.7394057Z ##[group]Run true2026-08-01T01:51:17.7394959Z [36;1mtrue[0m2026-08-01T01:51:17.7453324Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-01T01:51:17.7454687Z ##[endgroup]2026-08-01T01:51:17.7737393Z ##[group]Run medyagh/setup-minikube@latest2026-08-01T01:51:17.7738518Z with:2026-08-01T01:51:17.7739284Z start: true2026-08-01T01:51:17.7740285Z cache: true2026-08-01T01:51:17.7741091Z minikube-version: latest2026-08-01T01:51:17.7741996Z wait: all2026-08-01T01:51:17.7742731Z ##[endgroup]2026-08-01T01:51:17.9093865Z (node:2221) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-01T01:51:17.9098877Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-01T01:51:18.7407255Z [command]/usr/bin/chmod +x /home/runner/work/_temp/5b24f582-85b5-423e-a6e3-edcef654f7e72026-08-01T01:51:18.9011506Z [command]/home/runner/bin/minikube version --short2026-08-01T01:51:18.9474616Z v1.38.12026-08-01T01:51:19.0072385Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-01T01:51:19.0184069Z (node:2221) [DEP0169] DeprecationWarning: `url.parse()` behavior is not standardized and prone to errors that have security implications. Use the WHATWG URL API instead. CVEs are not issued for `url.parse()` vulnerabilities.2026-08-01T01:51:19.0204014Z Cache hit for: kic-v1.38.1-x642026-08-01T01:51:20.1395044Z Received 125829120 of 224218863 (56.1%), 109.1 MBs/sec2026-08-01T01:51:20.1395732Z Received 134217728 of 544082657 (24.7%), 118.4 MBs/sec2026-08-01T01:51:20.9071582Z Received 224218863 of 224218863 (100.0%), 114.5 MBs/sec2026-08-01T01:51:20.9072988Z Cache Size: ~214 MB (224218863 B)2026-08-01T01:51:21.0723424Z [command]/usr/bin/tar -xf /home/runner/work/_temp/a3f7b4c4-cb16-47e5-8241-cb910c171a61/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-01T01:51:21.1457286Z Received 272629760 of 544082657 (50.1%), 124.6 MBs/sec2026-08-01T01:51:21.8167892Z Cache restored successfully2026-08-01T01:51:22.1492205Z Received 473956352 of 544082657 (87.1%), 146.3 MBs/sec2026-08-01T01:51:22.5566465Z Received 544082657 of 544082657 (100.0%), 148.3 MBs/sec2026-08-01T01:51:22.5568107Z Cache Size: ~519 MB (544082657 B)2026-08-01T01:51:22.5681727Z [command]/usr/bin/tar -xf /home/runner/work/_temp/8aaac212-11f5-453b-a94a-cd0a71c5a2cf/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-01T01:51:23.3905603Z Cache restored successfully2026-08-01T01:51:23.5045092Z [command]/home/runner/bin/minikube start --wait all2026-08-01T01:51:23.5465035Z * minikube v1.38.1 on Ubuntu 22.042026-08-01T01:51:23.6943706Z ! 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-08-01T01:51:28.0545540Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-01T01:51:28.1219436Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-01T01:51:28.1230446Z * Using Docker driver with root privileges2026-08-01T01:51:28.1243282Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-01T01:51:28.1251614Z * Pulling base image v0.0.50 ...2026-08-01T01:52:01.1834195Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-01T01:52:05.8475395Z * Verifying Kubernetes components...2026-08-01T01:52:05.8770258Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-01T01:52:06.5796968Z * Enabled addons: storage-provisioner, default-storageclass2026-08-01T01:52:44.4929668Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-01T01:52:44.5038891Z [command]/home/runner/bin/minikube version --short2026-08-01T01:52:44.5473180Z v1.38.12026-08-01T01:52:44.5833721Z ##[group]Run actions/setup-go@v62026-08-01T01:52:44.5834043Z with:2026-08-01T01:52:44.5834263Z go-version: 1.262026-08-01T01:52:44.5834507Z cache: true2026-08-01T01:52:44.5834742Z cache-dependency-path: go.sum2026-08-01T01:52:44.5835016Z check-latest: false2026-08-01T01:52:44.5838003Z token: ***2026-08-01T01:52:44.5838394Z ##[endgroup]2026-08-01T01:52:44.7229725Z Setup go version spec 1.262026-08-01T01:52:44.7571202Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-01T01:52:44.7571900Z Added go to the path2026-08-01T01:52:44.7575186Z Successfully set up Go version 1.262026-08-01T01:52:45.4998362Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-01T01:52:45.5034351Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-01T01:52:45.5070333Z /home/runner/go/pkg/mod2026-08-01T01:52:45.5095985Z /home/runner/.cache/go-build2026-08-01T01:52:45.5744143Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-01T01:52:46.6320402Z Received 184549376 of 251839808 (73.3%), 176.0 MBs/sec2026-08-01T01:52:46.9576196Z Received 251839808 of 251839808 (100.0%), 181.1 MBs/sec2026-08-01T01:52:46.9577883Z Cache Size: ~240 MB (251839808 B)2026-08-01T01:52:46.9645004Z [command]/usr/bin/tar -xf /home/runner/work/_temp/5af05468-91ae-4d96-b78c-73027baa6ebc/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-01T01:52:50.0145135Z Cache restored successfully2026-08-01T01:52:50.0735555Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-01T01:52:50.0763516Z go version go1.26.5 linux/amd642026-08-01T01:52:50.0763835Z 2026-08-01T01:52:50.0764324Z ##[group]go env2026-08-01T01:52:50.1607939Z AR='ar'2026-08-01T01:52:50.1608365Z CC='gcc'2026-08-01T01:52:50.1608756Z CGO_CFLAGS='-O2 -g'2026-08-01T01:52:50.1609221Z CGO_CPPFLAGS=''2026-08-01T01:52:50.1609928Z CGO_CXXFLAGS='-O2 -g'2026-08-01T01:52:50.1610376Z CGO_ENABLED='1'2026-08-01T01:52:50.1610791Z CGO_FFLAGS='-O2 -g'2026-08-01T01:52:50.1611231Z CGO_LDFLAGS='-O2 -g'2026-08-01T01:52:50.1611908Z CXX='g++'2026-08-01T01:52:50.1612238Z GCCGO='gccgo'2026-08-01T01:52:50.1612575Z GO111MODULE=''2026-08-01T01:52:50.1612908Z GOAMD64='v1'2026-08-01T01:52:50.1613235Z GOARCH='amd64'2026-08-01T01:52:50.1613566Z GOAUTH='netrc'2026-08-01T01:52:50.1613886Z GOBIN=''2026-08-01T01:52:50.1614269Z GOCACHE='/home/runner/.cache/go-build'2026-08-01T01:52:50.1614753Z GOCACHEPROG=''2026-08-01T01:52:50.1615094Z GODEBUG=''2026-08-01T01:52:50.1615448Z GOENV='/home/runner/.config/go/env'2026-08-01T01:52:50.1615879Z GOEXE=''2026-08-01T01:52:50.1616234Z GOEXPERIMENT=''2026-08-01T01:52:50.1616615Z GOFIPS140='off'2026-08-01T01:52:50.1616950Z GOFLAGS=''2026-08-01T01:52:50.1618106Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build959686303=/tmp/go-build -gno-record-gcc-switches'2026-08-01T01:52:50.1619299Z GOHOSTARCH='amd64'2026-08-01T01:52:50.1619937Z GOHOSTOS='linux'2026-08-01T01:52:50.1620336Z GOINSECURE=''2026-08-01T01:52:50.1620959Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-01T01:52:50.1621717Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-01T01:52:50.1622150Z GONOPROXY=''2026-08-01T01:52:50.1622484Z GONOSUMDB=''2026-08-01T01:52:50.1622794Z GOOS='linux'2026-08-01T01:52:50.1623124Z GOPATH='/home/runner/go'2026-08-01T01:52:50.1623514Z GOPRIVATE=''2026-08-01T01:52:50.1623917Z GOPROXY='https://proxy.golang.org,direct'2026-08-01T01:52:50.1624481Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-01T01:52:50.1624958Z GOSUMDB='sum.golang.org'2026-08-01T01:52:50.1625350Z GOTELEMETRY='local'2026-08-01T01:52:50.1625802Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-01T01:52:50.1626304Z GOTMPDIR=''2026-08-01T01:52:50.1626649Z GOTOOLCHAIN='local'2026-08-01T01:52:50.1627478Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-01T01:52:50.1628083Z GOVCS=''2026-08-01T01:52:50.1628408Z GOVERSION='go1.26.5'2026-08-01T01:52:50.1628757Z GOWORK=''2026-08-01T01:52:50.1629118Z PKG_CONFIG='pkg-config'2026-08-01T01:52:50.1629364Z 2026-08-01T01:52:50.1630185Z ##[endgroup]2026-08-01T01:52:50.1812206Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-01T01:52:50.1812727Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-01T01:52:50.1870085Z shell: /usr/bin/bash -e {0}2026-08-01T01:52:50.1870353Z env:2026-08-01T01:52:50.1870563Z GOTOOLCHAIN: local2026-08-01T01:52:50.1870816Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-08-01T01:52:50.1871118Z OSPOOL_EP_CMTag: 25.x-el92026-08-01T01:52:50.1871379Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-01T01:52:50.1871650Z ##[endgroup]2026-08-01T01:52:57.1462845Z === RUN TestOSPoolEP2026-08-01T01:52:57.1463829Z === PAUSE TestOSPoolEP2026-08-01T01:52:57.1464402Z === CONT TestOSPoolEP2026-08-01T01:52:57.1465747Z TestOSPoolEP 2026-08-01T01:52:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:52:57.2518207Z TestOSPoolEP 2026-08-01T01:52:57Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx apply -f /tmp/TestOSPoolEP184815905]2026-08-01T01:52:57.7185764Z TestOSPoolEP 2026-08-01T01:52:57Z logger.go:67: pod/idtoken-generator created2026-08-01T01:52:57.7260428Z TestOSPoolEP 2026-08-01T01:52:57Z logger.go:67: secret/pool-passwd created2026-08-01T01:52:57.7308820Z TestOSPoolEP 2026-08-01T01:52:57Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-01T01:52:57.7311154Z TestOSPoolEP 2026-08-01T01:52:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:52:57.7336375Z TestOSPoolEP 2026-08-01T01:52:57Z retry.go:103: Wait for pod idtoken-generator to be provisioned. returned an error: Pod idtoken-generator is not available, reason: , message: . Sleeping for 10s and will try again.2026-08-01T01:53:07.7338195Z TestOSPoolEP 2026-08-01T01:53:07Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-01T01:53:07.7339959Z TestOSPoolEP 2026-08-01T01:53:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:53:07.7364286Z TestOSPoolEP 2026-08-01T01:53:07Z retry.go:103: Wait for pod idtoken-generator to be provisioned. returned an error: Pod idtoken-generator is not available, reason: , message: . Sleeping for 10s and will try again.2026-08-01T01:53:17.7368473Z TestOSPoolEP 2026-08-01T01:53:17Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-01T01:53:17.7369947Z TestOSPoolEP 2026-08-01T01:53:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:53:17.7395699Z TestOSPoolEP 2026-08-01T01:53:17Z logger.go:67: Pod is now available2026-08-01T01:53:17.7397752Z TestOSPoolEP 2026-08-01T01:53:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-01T01:53:18.2468830Z TestOSPoolEP 2026-08-01T01:53:18Z logger.go:67: ***2026-08-01T01:53:18.2532464Z TestOSPoolEP 2026-08-01T01:53:18Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx apply -f /tmp/TestOSPoolEP135336634]2026-08-01T01:53:18.4393748Z TestOSPoolEP 2026-08-01T01:53:18Z logger.go:67: secret/pool-token created2026-08-01T01:53:18.4421076Z TestOSPoolEP 2026-08-01T01:53:18Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-01T01:53:18.4422581Z TestOSPoolEP 2026-08-01T01:53:18Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:53:18.4445072Z TestOSPoolEP 2026-08-01T01:53:18Z logger.go:67: Secret is now available2026-08-01T01:53:18.4464001Z TestOSPoolEP 2026-08-01T01:53:18Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx apply -k /tmp/kustomize-template-2131508226]2026-08-01T01:53:18.7439894Z TestOSPoolEP 2026-08-01T01:53:18Z logger.go:67: service/test-cm created2026-08-01T01:53:18.7543633Z TestOSPoolEP 2026-08-01T01:53:18Z logger.go:67: Warning: spec.template.spec.containers[0].env[8]: hides previous definition of "OSG_SQUID_LOCATION", which may be dropped when using apply2026-08-01T01:53:18.7555648Z TestOSPoolEP 2026-08-01T01:53:18Z logger.go:67: deployment.apps/ospool-ep created2026-08-01T01:53:18.7739824Z TestOSPoolEP 2026-08-01T01:53:18Z logger.go:67: deployment.apps/test-cm created2026-08-01T01:53:18.7756764Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-01T01:53:18.7758684Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-01T01:53:18Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:53:18.7830337Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-01T01:53:18Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-01T01:53:18.7832583Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-01T01:53:18Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:53:18.7834677Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-01T01:53:18Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-01T01:53:18.7836697Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-01T01:53:18Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:53:18.7883545Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-01T01:53:18Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-65c844ddbb". Sleeping for 10s and will try again.2026-08-01T01:53:18.7887503Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-01T01:53:18Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "test-cm-5bb545475c". Sleeping for 10s and will try again.2026-08-01T01:53:28.7887654Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-01T01:53:28Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-01T01:53:28.7890631Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-01T01:53:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:53:28.7892943Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-01T01:53:28Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-01T01:53:28.7895023Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-01T01:53:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:53:28.7940920Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-01T01:53:28Z logger.go:67: Deployment is now available2026-08-01T01:53:28.7947874Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-01T01:53:28Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-65c844ddbb" is progressing.. Sleeping for 10s and will try again.2026-08-01T01:53:38.7958140Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-01T01:53:38Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-01T01:53:38.7959794Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-01T01:53:38Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:53:38.7981709Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-01T01:53:38Z logger.go:67: Deployment is now available2026-08-01T01:53:38.7983194Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-01T01:53:38.7983933Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-01T01:53:38.7984377Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-01T01:53:38.7984891Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-01T01:53:38.7985363Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-01T01:53:38.7985804Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-01T01:53:38.7986243Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-01T01:53:38.7987091Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-01T01:53:38Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:53:38.7994897Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-01T01:53:38.7996642Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:53:38Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:53:38.7998023Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-01T01:53:38.7999952Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-01T01:53:38Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:53:38.8019288Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-01T01:53:38Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:53:38.8021993Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-01T01:53:38Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:53:38.8023497Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:53:38Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:53:38.8051904Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:53:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-01T01:53:38.8064336Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-01T01:53:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_SINGULARITY]2026-08-01T01:53:38.8068372Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-01T01:53:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)']2026-08-01T01:53:39.0071095Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-2rvk7 failed. Retrying in 10s.2026-08-01T01:53:39.0412132Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-01T01:53:39.0414991Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)']' in pod test-cm-5bb545475c-2rvk7 failed. Retrying in 10s.2026-08-01T01:53:39.0434383Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-01T01:53:39.0435958Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2rvk7 failed. Retrying in 30s.2026-08-01T01:53:49.0069272Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-01T01:53:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_SINGULARITY]2026-08-01T01:53:49.0424705Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-01T01:53:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)']2026-08-01T01:53:49.1804684Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-01T01:53:49.1806128Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-2rvk7 failed. Retrying in 10s.2026-08-01T01:53:49.2223218Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-01T01:53:49.2224240Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)']' in pod test-cm-5bb545475c-2rvk7 failed. Retrying in 10s.2026-08-01T01:53:59.1824743Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-01T01:53:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_SINGULARITY]2026-08-01T01:53:59.2227857Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-01T01:53:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)']2026-08-01T01:53:59.3975329Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-01T01:53:59Z logger.go:67: true2026-08-01T01:53:59.4418770Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-01T01:53:59Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-01T01:53:59.4421252Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-01T01:53:59Z logger.go:67: 2026-08-01T01:53:59.4423441Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-01T01:53:59Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-65c844ddbb-rqxkg LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-08-01T01:53:59.4425138Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-01T01:53:59Z logger.go:67: 2026-08-01T01:53:59.4426732Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-01T01:53:59Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-01T01:53:59.4428245Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-01T01:53:59Z logger.go:67: 2026-08-01T01:53:59.4429946Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-01T01:53:59Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-01T01:53:59.4431385Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-01T01:53:59Z logger.go:67: 2026-08-01T01:53:59.4432795Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-01T01:53:59Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-01T01:54:09.0446534Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:54:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-01T01:54:09.1922951Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:54:09Z logger.go:67: undefined2026-08-01T01:54:09.1976302Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-01T01:54:09.1977779Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2rvk7 failed. Retrying in 30s.2026-08-01T01:54:39.1982633Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:54:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-01T01:54:39.3468933Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:54:39Z logger.go:67: undefined2026-08-01T01:54:39.3523573Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2rvk7 failed. Retrying in 30s.2026-08-01T01:55:09.3532228Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:55:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-01T01:55:09.5033285Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:55:09Z logger.go:67: undefined2026-08-01T01:55:09.5087635Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2rvk7 failed. Retrying in 30s.2026-08-01T01:55:39.5092319Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:55:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-01T01:55:39.6538398Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:55:39Z logger.go:67: undefined2026-08-01T01:55:39.6599069Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2rvk7 failed. Retrying in 30s.2026-08-01T01:56:09.6621530Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:56:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-01T01:56:09.8098173Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:56:09Z logger.go:67: undefined2026-08-01T01:56:09.8159630Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2rvk7 failed. Retrying in 30s.2026-08-01T01:56:39.8164775Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:56:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-01T01:56:39.9636106Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:56:39Z logger.go:67: undefined2026-08-01T01:56:39.9693500Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2rvk7 failed. Retrying in 30s.2026-08-01T01:57:09.9717351Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:57:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-01T01:57:10.1176903Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:57:10Z logger.go:67: undefined2026-08-01T01:57:10.1230304Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2rvk7 failed. Retrying in 30s.2026-08-01T01:57:40.1236532Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:57:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-01T01:57:40.2687207Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:57:40Z logger.go:67: undefined2026-08-01T01:57:40.2745944Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2rvk7 failed. Retrying in 30s.2026-08-01T01:58:10.2770807Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:58:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-01T01:58:10.4344431Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:58:10Z logger.go:67: undefined2026-08-01T01:58:10.4401718Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2rvk7 failed. Retrying in 30s.2026-08-01T01:58:40.4404062Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:58:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-01T01:58:40.5883236Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:58:40Z logger.go:67: undefined2026-08-01T01:58:40.5939937Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-2rvk7 failed. Retrying in 30s.2026-08-01T01:59:10.5961834Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:59:10Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx exec test-cm-5bb545475c-2rvk7 -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-rqxkg",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-01T01:59:10.7841259Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-01T01:59:10Z logger.go:67: true2026-08-01T01:59:10.7905598Z TestOSPoolEP 2026-08-01T01:59:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:59:10.7991594Z TestOSPoolEP 2026-08-01T01:59:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:59:10.9621214Z TestOSPoolEP 2026-08-01T01:59:10Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:59:11.1504667Z TestOSPoolEP 2026-08-01T01:59:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:59:11.2678281Z TestOSPoolEP 2026-08-01T01:59:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:59:11.2704313Z === NAME TestOSPoolEP2026-08-01T01:59:11.2704690Z ospool_ep_test.go:101: ---2026-08-01T01:59:11.2705067Z Events for pod idtoken-generator:2026-08-01T01:59:11.2705890Z 2026-08-01 01:52:57 +0000 UTC Normal Successfully assigned test-ospool-ep-ixk9qx/idtoken-generator to minikube2026-08-01T01:59:11.2706642Z 2026-08-01 01:52:58 +0000 UTC Normal Pulling image "htcondor/base"2026-08-01T01:59:11.2707621Z 2026-08-01 01:53:06 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.244s (8.245s including waiting). Image size: 560910730 bytes.2026-08-01T01:59:11.2708402Z 2026-08-01 01:53:06 +0000 UTC Normal Container created2026-08-01T01:59:11.2709194Z 2026-08-01 01:53:06 +0000 UTC Normal Container started2026-08-01T01:59:11.2710107Z 2026-08-01T01:59:11.2710325Z ---2026-08-01T01:59:11.2711267Z TestOSPoolEP 2026-08-01T01:59:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:59:11.2729357Z ospool_ep_test.go:101: ---2026-08-01T01:59:11.2730345Z Events for pod ospool-ep-65c844ddbb-rqxkg:2026-08-01T01:59:11.2731787Z 2026-08-01 01:53:18 +0000 UTC Normal Successfully assigned test-ospool-ep-ixk9qx/ospool-ep-65c844ddbb-rqxkg to minikube2026-08-01T01:59:11.2732730Z 2026-08-01 01:53:19 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-01T01:59:11.2734208Z 2026-08-01 01:53:20 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.375s (1.375s including waiting). Image size: 5590942 bytes.2026-08-01T01:59:11.2735613Z 2026-08-01 01:53:20 +0000 UTC Normal Container created2026-08-01T01:59:11.2736595Z 2026-08-01 01:53:20 +0000 UTC Normal Container started2026-08-01T01:59:11.2737947Z 2026-08-01 01:53:21 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-08-01T01:59:11.2741534Z 2026-08-01 01:53:34 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 13.35s (13.35s including waiting). Image size: 1250776798 bytes.2026-08-01T01:59:11.2769771Z 2026-08-01 01:53:34 +0000 UTC Normal Container created2026-08-01T01:59:11.2770674Z 2026-08-01 01:53:34 +0000 UTC Normal Container started2026-08-01T01:59:11.2771215Z 2026-08-01T01:59:11.2771556Z ---2026-08-01T01:59:11.2772483Z TestOSPoolEP 2026-08-01T01:59:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:59:11.2786590Z ospool_ep_test.go:101: ---2026-08-01T01:59:11.2788073Z Events for pod test-cm-5bb545475c-2rvk7:2026-08-01T01:59:11.2790513Z 2026-08-01 01:53:18 +0000 UTC Normal Successfully assigned test-ospool-ep-ixk9qx/test-cm-5bb545475c-2rvk7 to minikube2026-08-01T01:59:11.2792123Z 2026-08-01 01:53:19 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-08-01T01:59:11.2794050Z 2026-08-01 01:53:20 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 317ms (1.664s including waiting). Image size: 560910756 bytes.2026-08-01T01:59:11.2795360Z 2026-08-01 01:53:20 +0000 UTC Normal Container created2026-08-01T01:59:11.2796153Z 2026-08-01 01:53:21 +0000 UTC Normal Container started2026-08-01T01:59:11.2796705Z 2026-08-01T01:59:11.2797204Z ---2026-08-01T01:59:11.2798419Z TestOSPoolEP 2026-08-01T01:59:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-01T01:59:11.2824121Z TestOSPoolEP 2026-08-01T01:59:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx delete -f /tmp/TestOSPoolEP3759028744]2026-08-01T01:59:11.3830437Z TestOSPoolEP 2026-08-01T01:59:11Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-ixk9qx namespace2026-08-01T01:59:11.3888971Z TestOSPoolEP 2026-08-01T01:59:11Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-ixk9qx namespace2026-08-01T01:59:12.0684159Z TestOSPoolEP 2026-08-01T01:59:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx delete -f /tmp/TestOSPoolEP2933530138]2026-08-01T01:59:12.1606888Z TestOSPoolEP 2026-08-01T01:59:12Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-ixk9qx namespace2026-08-01T01:59:12.1647968Z TestOSPoolEP 2026-08-01T01:59:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ixk9qx delete -k /tmp/kustomize-template-2131508226]2026-08-01T01:59:12.3114980Z TestOSPoolEP 2026-08-01T01:59:12Z logger.go:67: service "test-cm" deleted from test-ospool-ep-ixk9qx namespace2026-08-01T01:59:12.3165020Z TestOSPoolEP 2026-08-01T01:59:12Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-ixk9qx namespace2026-08-01T01:59:12.3208151Z TestOSPoolEP 2026-08-01T01:59:12Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-ixk9qx namespace2026-08-01T01:59:12.3308225Z --- PASS: TestOSPoolEP (43.19s)2026-08-01T01:59:12.3340542Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (20.02s)2026-08-01T01:59:12.3350576Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.61s)2026-08-01T01:59:12.3352874Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.65s)2026-08-01T01:59:12.3354451Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (331.99s)2026-08-01T01:59:12.3355753Z PASS2026-08-01T01:59:12.3356760Z ok github.com/osg-htc/k8s-integration-tests/test 375.200s2026-08-01T01:59:12.4556026Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-01T01:59:12.4557017Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-01T01:59:12.4635335Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-01T01:59:12.4635948Z env:2026-08-01T01:59:12.4636334Z GOTOOLCHAIN: local2026-08-01T01:59:12.4637024Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-01T01:59:12.4637852Z ##[endgroup]2026-08-01T01:59:12.4898166Z Node 20 is being deprecated. This workflow is running with Node 24 by default. If you need to temporarily use Node 20, you can set the ACTIONS_ALLOW_USE_UNSECURE_NODE_VERSION=true environment variable. For more information see: https://github.blog/changelog/2025-09-19-deprecation-of-node-20-on-github-actions-runners/2026-08-01T01:59:12.4899786Z ##[group]Run actions/upload-artifact@v42026-08-01T01:59:12.4900065Z with:2026-08-01T01:59:12.4900627Z name: TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe52026-08-01T01:59:12.4901697Z path: /tmp/k8s-tests2026-08-01T01:59:12.4901976Z retention-days: 52026-08-01T01:59:12.4902195Z if-no-files-found: warn2026-08-01T01:59:12.4902427Z compression-level: 62026-08-01T01:59:12.4902723Z overwrite: false2026-08-01T01:59:12.4903109Z include-hidden-files: false2026-08-01T01:59:12.4903432Z env:2026-08-01T01:59:12.4903620Z GOTOOLCHAIN: local2026-08-01T01:59:12.4903836Z ##[endgroup]2026-08-01T01:59:12.7508789Z (node:17379) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-01T01:59:12.7511730Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-01T01:59:12.7650316Z With the provided path, there will be 6 files uploaded2026-08-01T01:59:12.7652881Z Artifact name is valid!2026-08-01T01:59:12.7653497Z Root directory input is valid!2026-08-01T01:59:12.9042768Z Beginning upload of artifact content to blob storage2026-08-01T01:59:12.9363770Z (node:17379) [DEP0169] DeprecationWarning: `url.parse()` behavior is not standardized and prone to errors that have security implications. Use the WHATWG URL API instead. CVEs are not issued for `url.parse()` vulnerabilities.2026-08-01T01:59:12.9744593Z Uploaded bytes 140302026-08-01T01:59:12.9901134Z Finished uploading artifact content to blob storage!2026-08-01T01:59:12.9902731Z SHA256 digest of uploaded artifact zip is bc044aa2190c587b11c0bcf9a4b54ae55bcf3631b6b72a00fd744229363d3bd62026-08-01T01:59:12.9904661Z Finalizing artifact upload2026-08-01T01:59:13.1612878Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5.zip successfully finalized. Artifact ID 88115533972026-08-01T01:59:13.1615160Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5 has been successfully uploaded! Final size is 14030 bytes. Artifact ID is 88115533972026-08-01T01:59:13.1620725Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/30678801319/artifacts/88115533972026-08-01T01:59:13.1798922Z Post job cleanup.2026-08-01T01:59:13.3109687Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-01T01:59:13.3166311Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-01T01:59:13.3190400Z /home/runner/go/pkg/mod2026-08-01T01:59:13.3216529Z /home/runner/.cache/go-build2026-08-01T01:59:13.3227758Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-01T01:59:13.3394994Z Post job cleanup.2026-08-01T01:59:13.4310230Z [command]/usr/bin/git version2026-08-01T01:59:13.4354689Z git version 2.54.02026-08-01T01:59:13.4395105Z Temporarily overriding HOME='/home/runner/work/_temp/282e499c-fd25-45da-90fb-b2890ecc4dac' before making global git config changes2026-08-01T01:59:13.4402175Z Adding repository directory to the temporary git global config as a safe directory2026-08-01T01:59:13.4404132Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-01T01:59:13.4458429Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-01T01:59:13.4509743Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :"2026-08-01T01:59:13.4898958Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-01T01:59:13.4944128Z http.https://github.com/.extraheader2026-08-01T01:59:13.4952525Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-01T01:59:13.5013567Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :"2026-08-01T01:59:13.5417098Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-01T01:59:13.5469189Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-01T01:59:13.6000721Z Cleaning up orphan processes2026-08-01T01:59:13.6797238Z ##[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/