2026-08-14T01:03:02.7473447Z Current runner version: '2.336.0'2026-08-14T01:03:02.7495024Z ##[group]Runner Image Provisioner2026-08-14T01:03:02.7495702Z Hosted Compute Agent2026-08-14T01:03:02.7496282Z Version: 20260707.5632026-08-14T01:03:02.7496796Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-08-14T01:03:02.7497405Z Build Date: 2026-07-07T19:33:50Z2026-08-14T01:03:02.7497992Z Worker ID: {1fb2be78-da58-4040-9d31-9416ba04e7db}2026-08-14T01:03:02.7498567Z Azure Region: westus32026-08-14T01:03:02.7499088Z ##[endgroup]2026-08-14T01:03:02.7500198Z ##[group]Operating System2026-08-14T01:03:02.7500678Z Ubuntu2026-08-14T01:03:02.7501197Z 22.04.52026-08-14T01:03:02.7501624Z LTS2026-08-14T01:03:02.7502071Z ##[endgroup]2026-08-14T01:03:02.7502541Z ##[group]Runner Image2026-08-14T01:03:02.7503035Z Image: ubuntu-22.042026-08-14T01:03:02.7503563Z Version: 20260720.234.22026-08-14T01:03:02.7504798Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-08-14T01:03:02.7506086Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-08-14T01:03:02.7506853Z ##[endgroup]2026-08-14T01:03:02.7507885Z ##[group]GITHUB_TOKEN Permissions2026-08-14T01:03:02.7509649Z Contents: read2026-08-14T01:03:02.7510189Z Metadata: read2026-08-14T01:03:02.7510675Z Packages: read2026-08-14T01:03:02.7511374Z ##[endgroup]2026-08-14T01:03:02.7513427Z Secret source: Actions2026-08-14T01:03:02.7514651Z Prepare workflow directory2026-08-14T01:03:02.7769303Z Prepare all required actions2026-08-14T01:03:02.7807268Z Getting action download info2026-08-14T01:03:03.1116660Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-14T01:03:03.6832561Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-14T01:03:04.3225870Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-14T01:03:04.9421447Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-14T01:03:05.5778488Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-14T01:03:05.5781784Z ##[group] Inputs2026-08-14T01:03:05.5782061Z testName: TestOSPoolEP2026-08-14T01:03:05.5782476Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-08-14T01:03:05.5782907Z setupScript: 2026-08-14T01:03:05.5783113Z setupEnv: {}2026-08-14T01:03:05.5783316Z ##[endgroup]2026-08-14T01:03:05.5783639Z Complete job name: ospool-ep / Run OSPool EP test (cvmfs-bind, 25-testing) / Run Tests2026-08-14T01:03:05.6725566Z ##[group]Run actions/checkout@v52026-08-14T01:03:05.6726201Z with:2026-08-14T01:03:05.6726453Z repository: mwestphall/k8s-integration-tests2026-08-14T01:03:05.6728870Z token: ***2026-08-14T01:03:05.6729086Z ssh-strict: true2026-08-14T01:03:05.6729325Z ssh-user: git2026-08-14T01:03:05.6729536Z persist-credentials: true2026-08-14T01:03:05.6729765Z clean: true2026-08-14T01:03:05.6729969Z sparse-checkout-cone-mode: true2026-08-14T01:03:05.6730209Z fetch-depth: 12026-08-14T01:03:05.6730406Z fetch-tags: false2026-08-14T01:03:05.6730606Z show-progress: true2026-08-14T01:03:05.6730805Z lfs: false2026-08-14T01:03:05.6730993Z submodules: false2026-08-14T01:03:05.6731197Z set-safe-directory: true2026-08-14T01:03:05.6731433Z allow-unsafe-pr-checkout: false2026-08-14T01:03:05.6731799Z ##[endgroup]2026-08-14T01:03:05.7610776Z Syncing repository: mwestphall/k8s-integration-tests2026-08-14T01:03:05.7611957Z ##[group]Getting Git version info2026-08-14T01:03:05.7612452Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-14T01:03:05.7613032Z [command]/usr/bin/git version2026-08-14T01:03:05.7725853Z git version 2.54.02026-08-14T01:03:05.7739531Z ##[endgroup]2026-08-14T01:03:05.7745373Z Temporarily overriding HOME='/home/runner/work/_temp/d684d2b0-8b67-4a12-be2b-fec03c13598b' before making global git config changes2026-08-14T01:03:05.7750020Z Adding repository directory to the temporary git global config as a safe directory2026-08-14T01:03:05.7750942Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-14T01:03:05.7822982Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-14T01:03:05.7824444Z ##[group]Initializing the repository2026-08-14T01:03:05.7826800Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-14T01:03:05.8040000Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-14T01:03:05.8043030Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-14T01:03:05.8043586Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-14T01:03:05.8044152Z hint: call:2026-08-14T01:03:05.8044346Z hint:2026-08-14T01:03:05.8044649Z hint: git config --global init.defaultBranch <name>2026-08-14T01:03:05.8044964Z hint:2026-08-14T01:03:05.8045240Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-14T01:03:05.8045663Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-14T01:03:05.8045995Z hint:2026-08-14T01:03:05.8046201Z hint: git branch -m <name>2026-08-14T01:03:05.8046425Z hint:2026-08-14T01:03:05.8046719Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-14T01:03:05.8047242Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-14T01:03:05.8048870Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-14T01:03:05.8124009Z ##[endgroup]2026-08-14T01:03:05.8124953Z ##[group]Disabling automatic garbage collection2026-08-14T01:03:05.8125791Z [command]/usr/bin/git config --local gc.auto 02026-08-14T01:03:05.8236018Z ##[endgroup]2026-08-14T01:03:05.8236871Z ##[group]Setting up auth2026-08-14T01:03:05.8237629Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-14T01:03:05.8276739Z [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-14T01:03:06.0191124Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-14T01:03:06.0228151Z [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-14T01:03:06.0437192Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-14T01:03:06.0466952Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-14T01:03:06.0669043Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-14T01:03:06.1004781Z ##[endgroup]2026-08-14T01:03:06.1013078Z ##[group]Fetching the repository2026-08-14T01:03:06.1014284Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-14T01:03:07.0793943Z From https://github.com/mwestphall/k8s-integration-tests2026-08-14T01:03:07.0794815Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-14T01:03:07.0816581Z ##[endgroup]2026-08-14T01:03:07.0816964Z ##[group]Determining the checkout info2026-08-14T01:03:07.0819255Z ##[endgroup]2026-08-14T01:03:07.0825686Z [command]/usr/bin/git sparse-checkout disable2026-08-14T01:03:07.2666022Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-14T01:03:07.3008668Z ##[group]Checking out the ref2026-08-14T01:03:07.3015871Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-14T01:03:07.5300932Z Switched to a new branch 'main'2026-08-14T01:03:07.5301901Z branch 'main' set up to track 'origin/main'.2026-08-14T01:03:07.5310693Z ##[endgroup]2026-08-14T01:03:07.5350492Z [command]/usr/bin/git log -1 --format=%H2026-08-14T01:03:07.5374473Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-14T01:03:07.6581135Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-14T01:03:07.6581745Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-14T01:03:07.6582224Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-14T01:03:07.7092593Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-14T01:03:07.7092947Z env:2026-08-14T01:03:07.7093298Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-08-14T01:03:07.7093692Z SETUP_ENV_YAML: {}2026-08-14T01:03:07.7093995Z ##[endgroup]2026-08-14T01:03:07.9308240Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-14T01:03:07.9308773Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-14T01:03:07.9357221Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-14T01:03:07.9357504Z env:2026-08-14T01:03:07.9357865Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfs-bind"}2026-08-14T01:03:07.9358259Z ##[endgroup]2026-08-14T01:03:07.9491692Z ##[group]Run true2026-08-14T01:03:07.9491909Z [36;1mtrue[0m2026-08-14T01:03:07.9537935Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-14T01:03:07.9538233Z ##[endgroup]2026-08-14T01:03:07.9701106Z ##[group]Run medyagh/setup-minikube@latest2026-08-14T01:03:07.9701342Z with:2026-08-14T01:03:07.9701495Z start: true2026-08-14T01:03:07.9701649Z cache: true2026-08-14T01:03:07.9701809Z minikube-version: latest2026-08-14T01:03:07.9701994Z wait: all2026-08-14T01:03:07.9702147Z ##[endgroup]2026-08-14T01:03:08.0700658Z (node:1958) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-14T01:03:08.0701271Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-14T01:03:09.0007004Z [command]/usr/bin/chmod +x /home/runner/work/_temp/b845976e-310e-4936-bf26-b9ca235eb43c2026-08-14T01:03:10.1448003Z [command]/home/runner/bin/minikube version --short2026-08-14T01:03:10.2079751Z v1.38.12026-08-14T01:03:10.4234054Z Cache hit for: kic-v1.38.1-x642026-08-14T01:03:10.4326354Z (node:1958) [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-14T01:03:10.4360676Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-14T01:03:11.6652653Z Received 33554432 of 544082657 (6.2%), 32.0 MBs/sec2026-08-14T01:03:11.6796143Z Received 54525952 of 224218863 (24.3%), 52.0 MBs/sec2026-08-14T01:03:12.6671043Z Received 150994944 of 544082657 (27.8%), 71.9 MBs/sec2026-08-14T01:03:12.6832942Z Received 176160768 of 224218863 (78.6%), 83.8 MBs/sec2026-08-14T01:03:13.1047829Z Received 224218863 of 224218863 (100.0%), 88.2 MBs/sec2026-08-14T01:03:13.1048783Z Cache Size: ~214 MB (224218863 B)2026-08-14T01:03:13.1352915Z [command]/usr/bin/tar -xf /home/runner/work/_temp/074a1ad5-aa9f-4d4b-90e4-74f3648a49d0/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-14T01:03:13.5807654Z Cache restored successfully2026-08-14T01:03:13.6672497Z Received 276824064 of 544082657 (50.9%), 87.9 MBs/sec2026-08-14T01:03:14.6703693Z Received 398458880 of 544082657 (73.2%), 94.9 MBs/sec2026-08-14T01:03:15.6687075Z Received 524288000 of 544082657 (96.4%), 99.9 MBs/sec2026-08-14T01:03:16.3059641Z Received 544082657 of 544082657 (100.0%), 92.0 MBs/sec2026-08-14T01:03:16.3060630Z Cache Size: ~519 MB (544082657 B)2026-08-14T01:03:16.3157349Z [command]/usr/bin/tar -xf /home/runner/work/_temp/df1d6dd7-651f-4a12-9d44-9a1f52d9f29a/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-14T01:03:16.9559371Z Cache restored successfully2026-08-14T01:03:17.9368112Z [command]/home/runner/bin/minikube start --wait all2026-08-14T01:03:18.0272986Z * minikube v1.38.1 on Ubuntu 22.042026-08-14T01:03:18.5556795Z ! 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-14T01:03:18.5562433Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-14T01:03:18.5937777Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-14T01:03:18.5984045Z * Using Docker driver with root privileges2026-08-14T01:03:18.5996654Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-14T01:03:18.6004340Z * Pulling base image v0.0.50 ...2026-08-14T01:03:58.7585898Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-14T01:04:02.8784702Z * Verifying Kubernetes components...2026-08-14T01:04:02.9823953Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-14T01:04:03.4712458Z * Enabled addons: default-storageclass, storage-provisioner2026-08-14T01:04:44.1739449Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-14T01:04:44.1830309Z [command]/home/runner/bin/minikube version --short2026-08-14T01:04:44.2537792Z v1.38.12026-08-14T01:04:44.2782068Z ##[group]Run actions/setup-go@v62026-08-14T01:04:44.2782296Z with:2026-08-14T01:04:44.2782451Z go-version: 1.262026-08-14T01:04:44.2782620Z cache: true2026-08-14T01:04:44.2782798Z cache-dependency-path: go.sum2026-08-14T01:04:44.2783001Z check-latest: false2026-08-14T01:04:44.2785407Z token: ***2026-08-14T01:04:44.2785578Z ##[endgroup]2026-08-14T01:04:44.3804058Z Setup go version spec 1.262026-08-14T01:04:44.4071669Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-14T01:04:44.4072087Z Added go to the path2026-08-14T01:04:44.4074360Z Successfully set up Go version 1.262026-08-14T01:04:44.5758878Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-14T01:04:44.5789535Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-14T01:04:44.5815317Z /home/runner/go/pkg/mod2026-08-14T01:04:44.5841621Z /home/runner/.cache/go-build2026-08-14T01:04:44.7937464Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-14T01:04:46.0206461Z Received 41943040 of 251839808 (16.7%), 40.0 MBs/sec2026-08-14T01:04:47.0210469Z Received 176160768 of 251839808 (69.9%), 84.0 MBs/sec2026-08-14T01:04:47.4420545Z Received 251839808 of 251839808 (100.0%), 99.2 MBs/sec2026-08-14T01:04:47.4421421Z Cache Size: ~240 MB (251839808 B)2026-08-14T01:04:47.4511619Z [command]/usr/bin/tar -xf /home/runner/work/_temp/6ac1e146-85e3-47d5-a8b5-4a25816a043e/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-14T01:04:49.6587059Z Cache restored successfully2026-08-14T01:04:49.7023246Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-14T01:04:49.7046303Z go version go1.26.5 linux/amd642026-08-14T01:04:49.7046577Z 2026-08-14T01:04:49.7046893Z ##[group]go env2026-08-14T01:04:49.7179066Z AR='ar'2026-08-14T01:04:49.7179631Z CC='gcc'2026-08-14T01:04:49.7180034Z CGO_CFLAGS='-O2 -g'2026-08-14T01:04:49.7180293Z CGO_CPPFLAGS=''2026-08-14T01:04:49.7180544Z CGO_CXXFLAGS='-O2 -g'2026-08-14T01:04:49.7180737Z CGO_ENABLED='1'2026-08-14T01:04:49.7180960Z CGO_FFLAGS='-O2 -g'2026-08-14T01:04:49.7181136Z CGO_LDFLAGS='-O2 -g'2026-08-14T01:04:49.7181307Z CXX='g++'2026-08-14T01:04:49.7181476Z GCCGO='gccgo'2026-08-14T01:04:49.7181648Z GO111MODULE=''2026-08-14T01:04:49.7181823Z GOAMD64='v1'2026-08-14T01:04:49.7198275Z GOARCH='amd64'2026-08-14T01:04:49.7198565Z GOAUTH='netrc'2026-08-14T01:04:49.7198803Z GOBIN=''2026-08-14T01:04:49.7199061Z GOCACHE='/home/runner/.cache/go-build'2026-08-14T01:04:49.7199399Z GOCACHEPROG=''2026-08-14T01:04:49.7199638Z GODEBUG=''2026-08-14T01:04:49.7199894Z GOENV='/home/runner/.config/go/env'2026-08-14T01:04:49.7200178Z GOEXE=''2026-08-14T01:04:49.7200420Z GOEXPERIMENT=''2026-08-14T01:04:49.7200592Z GOFIPS140='off'2026-08-14T01:04:49.7200763Z GOFLAGS=''2026-08-14T01:04:49.7201305Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build2193873977=/tmp/go-build -gno-record-gcc-switches'2026-08-14T01:04:49.7201831Z GOHOSTARCH='amd64'2026-08-14T01:04:49.7202012Z GOHOSTOS='linux'2026-08-14T01:04:49.7202182Z GOINSECURE=''2026-08-14T01:04:49.7202473Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-14T01:04:49.7202809Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-14T01:04:49.7203031Z GONOPROXY=''2026-08-14T01:04:49.7203193Z GONOSUMDB=''2026-08-14T01:04:49.7203351Z GOOS='linux'2026-08-14T01:04:49.7203514Z GOPATH='/home/runner/go'2026-08-14T01:04:49.7203698Z GOPRIVATE=''2026-08-14T01:04:49.7204137Z GOPROXY='https://proxy.golang.org,direct'2026-08-14T01:04:49.7204407Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-14T01:04:49.7204655Z GOSUMDB='sum.golang.org'2026-08-14T01:04:49.7204846Z GOTELEMETRY='local'2026-08-14T01:04:49.7205073Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-14T01:04:49.7205324Z GOTMPDIR=''2026-08-14T01:04:49.7205723Z GOTOOLCHAIN='local'2026-08-14T01:04:49.7205988Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-14T01:04:49.7206296Z GOVCS=''2026-08-14T01:04:49.7206463Z GOVERSION='go1.26.5'2026-08-14T01:04:49.7206642Z GOWORK=''2026-08-14T01:04:49.7206808Z PKG_CONFIG='pkg-config'2026-08-14T01:04:49.7206927Z 2026-08-14T01:04:49.7207195Z ##[endgroup]2026-08-14T01:04:49.7356189Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-14T01:04:49.7356597Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-14T01:04:49.7406341Z shell: /usr/bin/bash -e {0}2026-08-14T01:04:49.7406548Z env:2026-08-14T01:04:49.7406723Z GOTOOLCHAIN: local2026-08-14T01:04:49.7406924Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-08-14T01:04:49.7407150Z OSPOOL_EP_CMTag: 25.x-el92026-08-14T01:04:49.7407357Z OSPOOL_EP_CvmfsType: cvmfs-bind2026-08-14T01:04:49.7407571Z ##[endgroup]2026-08-14T01:04:55.5661597Z === RUN TestOSPoolEP2026-08-14T01:04:55.5663527Z === PAUSE TestOSPoolEP2026-08-14T01:04:55.5663998Z === CONT TestOSPoolEP2026-08-14T01:04:55.5664689Z TestOSPoolEP 2026-08-14T01:04:55Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:04:55.9467110Z TestOSPoolEP 2026-08-14T01:04:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah apply -f /tmp/TestOSPoolEP2439966707]2026-08-14T01:04:56.2742619Z TestOSPoolEP 2026-08-14T01:04:56Z logger.go:67: pod/idtoken-generator created2026-08-14T01:04:56.2811854Z TestOSPoolEP 2026-08-14T01:04:56Z logger.go:67: secret/pool-passwd created2026-08-14T01:04:56.2855792Z TestOSPoolEP 2026-08-14T01:04:56Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-14T01:04:56.2856965Z TestOSPoolEP 2026-08-14T01:04:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:04:56.3041888Z TestOSPoolEP 2026-08-14T01:04:56Z 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-14T01:05:06.3039287Z TestOSPoolEP 2026-08-14T01:05:06Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-14T01:05:06.3059016Z TestOSPoolEP 2026-08-14T01:05:06Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:06.3084430Z TestOSPoolEP 2026-08-14T01:05:06Z 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-14T01:05:16.3085274Z TestOSPoolEP 2026-08-14T01:05:16Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-14T01:05:16.3086249Z TestOSPoolEP 2026-08-14T01:05:16Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:16.3106187Z TestOSPoolEP 2026-08-14T01:05:16Z logger.go:67: Pod is now available2026-08-14T01:05:16.3107232Z TestOSPoolEP 2026-08-14T01:05:16Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-14T01:05:16.4225900Z TestOSPoolEP 2026-08-14T01:05:16Z logger.go:67: ***2026-08-14T01:05:16.4282854Z TestOSPoolEP 2026-08-14T01:05:16Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah apply -f /tmp/TestOSPoolEP764568190]2026-08-14T01:05:16.5624850Z TestOSPoolEP 2026-08-14T01:05:16Z logger.go:67: secret/pool-token created2026-08-14T01:05:16.5650950Z TestOSPoolEP 2026-08-14T01:05:16Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-14T01:05:16.5651747Z TestOSPoolEP 2026-08-14T01:05:16Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:16.5666363Z TestOSPoolEP 2026-08-14T01:05:16Z logger.go:67: Secret is now available2026-08-14T01:05:16.5685992Z TestOSPoolEP 2026-08-14T01:05:16Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah apply -k /tmp/kustomize-template-3824082739]2026-08-14T01:05:16.8147549Z TestOSPoolEP 2026-08-14T01:05:16Z logger.go:67: serviceaccount/cvmfs-nodeplugin created2026-08-14T01:05:16.8216849Z TestOSPoolEP 2026-08-14T01:05:16Z logger.go:67: service/frontier-squid created2026-08-14T01:05:16.8353285Z TestOSPoolEP 2026-08-14T01:05:16Z logger.go:67: service/test-cm created2026-08-14T01:05:16.8412077Z TestOSPoolEP 2026-08-14T01:05:16Z logger.go:67: deployment.apps/cvmfs-nodeplugin created2026-08-14T01:05:16.8499748Z TestOSPoolEP 2026-08-14T01:05:16Z logger.go:67: deployment.apps/frontier-squid created2026-08-14T01:05:16.8646067Z TestOSPoolEP 2026-08-14T01:05:16Z logger.go:67: Warning: spec.template.spec.containers[0].env[6]: hides previous definition of "OSG_SQUID_LOCATION", which may be dropped when using apply2026-08-14T01:05:16.8647687Z TestOSPoolEP 2026-08-14T01:05:16Z logger.go:67: deployment.apps/ospool-ep created2026-08-14T01:05:16.8776200Z TestOSPoolEP 2026-08-14T01:05:16Z logger.go:67: deployment.apps/test-cm created2026-08-14T01:05:16.8828044Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-14T01:05:16.8829332Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:16Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:16.8912725Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:16Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-14T01:05:16.8946174Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:16Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:16.8947592Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:16Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-08-14T01:05:16.8949276Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:16Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:16.8950572Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:16Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-08-14T01:05:16.8951926Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:16Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:16.8953303Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:16Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-14T01:05:16.8954700Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:16Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:16.8972573Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:16Z retry.go:103: Wait for deployment cvmfs-nodeplugin to be provisioned. returned an error: Deployment cvmfs-nodeplugin is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "cvmfs-nodeplugin-6b55bb5648" is progressing.. Sleeping for 10s and will try again.2026-08-14T01:05:16.8976623Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:16Z 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-14T01:05:16.9062721Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:16Z retry.go:103: Wait for deployment frontier-squid to be provisioned. returned an error: Deployment frontier-squid is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "frontier-squid-765494655" is progressing.. Sleeping for 10s and will try again.2026-08-14T01:05:16.9077651Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:16Z 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-5c56576469". Sleeping for 10s and will try again.2026-08-14T01:05:26.8979481Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:26Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-14T01:05:26.8980695Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:26Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-08-14T01:05:26.8982048Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:26Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:26.8983535Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:26Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:26.9011795Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:26Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "test-cm-5bb545475c" is progressing.. Sleeping for 10s and will try again.2026-08-14T01:05:26.9015691Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:26Z retry.go:103: Wait for deployment cvmfs-nodeplugin to be provisioned. returned an error: Deployment cvmfs-nodeplugin is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "cvmfs-nodeplugin-6b55bb5648" is progressing.. Sleeping for 10s and will try again.2026-08-14T01:05:26.9062136Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:26Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-08-14T01:05:26.9063229Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:26Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:26.9084936Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:26Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-14T01:05:26.9088498Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:26Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:26.9091689Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:26Z retry.go:103: Wait for deployment frontier-squid to be provisioned. returned an error: Deployment frontier-squid is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "frontier-squid-765494655" is progressing.. Sleeping for 10s and will try again.2026-08-14T01:05:26.9104584Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:26Z 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-5c56576469" is progressing.. Sleeping for 10s and will try again.2026-08-14T01:05:36.9028474Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:36Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-08-14T01:05:36.9033658Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:36.9035931Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:36Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-14T01:05:36.9038267Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:36.9091967Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:36Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-08-14T01:05:36.9093636Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:36.9113263Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:36Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-14T01:05:36.9115046Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:37.2157422Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:37Z 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-5c56576469" is progressing.. Sleeping for 10s and will try again.2026-08-14T01:05:37.2159741Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:37Z logger.go:67: Deployment is now available2026-08-14T01:05:37.2161991Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:37Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "test-cm-5bb545475c" is progressing.. Sleeping for 10s and will try again.2026-08-14T01:05:37.2165909Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:37Z retry.go:103: Wait for deployment frontier-squid to be provisioned. returned an error: Deployment frontier-squid is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "frontier-squid-765494655" is progressing.. Sleeping for 10s and will try again.2026-08-14T01:05:47.2166885Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:47Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-08-14T01:05:47.2177165Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:47.2178947Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:47Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-14T01:05:47.2180726Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:47.2182200Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:47Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-14T01:05:47.2183621Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:47.2224214Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:47Z retry.go:103: Wait for deployment frontier-squid to be provisioned. returned an error: Deployment frontier-squid is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "frontier-squid-765494655" is progressing.. Sleeping for 10s and will try again.2026-08-14T01:05:47.2234864Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:47Z 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-5c56576469" is progressing.. Sleeping for 10s and will try again.2026-08-14T01:05:47.2238160Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:47Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "test-cm-5bb545475c" is progressing.. Sleeping for 10s and will try again.2026-08-14T01:05:57.2226742Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:57Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-08-14T01:05:57.2228177Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:57.2237543Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:57Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-14T01:05:57.2244964Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:57.2246309Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:57Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-14T01:05:57.2251920Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:57.2264045Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:57Z logger.go:67: Deployment is now available2026-08-14T01:05:57.2266940Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:57Z 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-5c56576469" is progressing.. Sleeping for 10s and will try again.2026-08-14T01:05:57.2270426Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:57Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "test-cm-5bb545475c" is progressing.. Sleeping for 10s and will try again.2026-08-14T01:06:07.2279198Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:06:07Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-14T01:06:07.2285211Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:06:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:06:07.2286781Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:06:07Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-14T01:06:07.2288232Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:06:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:06:07.2301010Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:06:07Z logger.go:67: Deployment is now available2026-08-14T01:06:07.2303460Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:06:07Z 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-5c56576469" is progressing.. Sleeping for 10s and will try again.2026-08-14T01:06:17.2313745Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:06:17Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-14T01:06:17.2317861Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:06:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:06:17.3326558Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:06:17Z 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-5c56576469" is progressing.. Sleeping for 10s and will try again.2026-08-14T01:06:27.3340624Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:06:27Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-14T01:06:27.3342161Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:06:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:06:27.3381009Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:06:27Z logger.go:67: Deployment is now available2026-08-14T01:06:27.3382022Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-14T01:06:27.3382683Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-14T01:06:27.3383433Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-14T01:06:27.3384316Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-14T01:06:27.3384922Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-14T01:06:27.3411933Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-14T01:06:27.3412855Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-14T01:06:27.3415045Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:06:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:06:27.3416058Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-14T01:06:27.3417067Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:06:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:06:27.3418122Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-14T01:06:27.3419244Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-14T01:06:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:06:27.3434413Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:06:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:06:27.3452289Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-14T01:06:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:06:27.3476885Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:06:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:06:27.3481339Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:06:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)']2026-08-14T01:06:27.3525591Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-14T01:06:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_SINGULARITY]2026-08-14T01:06:27.3530079Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:06:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:06:27.6135326Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-14T01:06:27.6137383Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-8qv8r failed. Retrying in 30s.2026-08-14T01:06:27.6155732Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-14T01:06:27.6157343Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-8qv8r failed. Retrying in 10s.2026-08-14T01:06:27.6283692Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-14T01:06:27.6285398Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)']' in pod test-cm-5bb545475c-8qv8r failed. Retrying in 10s.2026-08-14T01:06:37.6167976Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-14T01:06:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_SINGULARITY]2026-08-14T01:06:37.6292442Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:06:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)']2026-08-14T01:06:37.9036493Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)']' in pod test-cm-5bb545475c-8qv8r failed. Retrying in 10s.2026-08-14T01:06:37.9161373Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-14T01:06:37.9163743Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-8qv8r failed. Retrying in 10s.2026-08-14T01:06:47.9057812Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:06:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)']2026-08-14T01:06:47.9171884Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-14T01:06:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_SINGULARITY]2026-08-14T01:06:48.0913115Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-14T01:06:48Z logger.go:67: true2026-08-14T01:06:48.0993315Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:06:48Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-14T01:06:48.0997623Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:06:48Z logger.go:67: 2026-08-14T01:06:48.0998816Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:06:48Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-5c56576469-njr7k LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-08-14T01:06:48.0999939Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:06:48Z logger.go:67: 2026-08-14T01:06:48.1000969Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:06:48Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-14T01:06:48.1001961Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:06:48Z logger.go:67: 2026-08-14T01:06:48.1002971Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:06:48Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-14T01:06:48.1004177Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:06:48Z logger.go:67: 2026-08-14T01:06:48.1005437Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:06:48Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-14T01:06:57.6138890Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:06:57Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:06:57.7637887Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:06:57Z logger.go:67: undefined2026-08-14T01:06:57.7694304Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-14T01:06:57.7695554Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-8qv8r failed. Retrying in 30s.2026-08-14T01:07:27.7700583Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:07:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:07:27.9112548Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:07:27Z logger.go:67: undefined2026-08-14T01:07:27.9155519Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-8qv8r failed. Retrying in 30s.2026-08-14T01:07:57.9166001Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:07:57Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:07:58.0676298Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:07:58Z logger.go:67: undefined2026-08-14T01:07:58.0730298Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-8qv8r failed. Retrying in 30s.2026-08-14T01:08:28.0734965Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:08:28Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:08:28.1908846Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:08:28Z logger.go:67: undefined2026-08-14T01:08:28.1954902Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-8qv8r failed. Retrying in 30s.2026-08-14T01:08:58.1986343Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:08:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:08:58.3281354Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:08:58Z logger.go:67: undefined2026-08-14T01:08:58.3335651Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-8qv8r failed. Retrying in 30s.2026-08-14T01:09:28.3358846Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:09:28Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:09:28.4486039Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:09:28Z logger.go:67: undefined2026-08-14T01:09:28.4537766Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-8qv8r failed. Retrying in 30s.2026-08-14T01:09:58.4561374Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:09:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:09:58.5772383Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:09:58Z logger.go:67: undefined2026-08-14T01:09:58.5819383Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-8qv8r failed. Retrying in 30s.2026-08-14T01:10:28.5823050Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:10:28Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:10:28.7010676Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:10:28Z logger.go:67: undefined2026-08-14T01:10:28.7059595Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-8qv8r failed. Retrying in 30s.2026-08-14T01:10:58.7066114Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:10:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:10:58.8306140Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:10:58Z logger.go:67: undefined2026-08-14T01:10:58.8347805Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-8qv8r failed. Retrying in 30s.2026-08-14T01:11:28.8376559Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:11:28Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:11:28.9550894Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:11:28Z logger.go:67: undefined2026-08-14T01:11:28.9595448Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-8qv8r failed. Retrying in 30s.2026-08-14T01:11:58.9628298Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:11:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah exec test-cm-5bb545475c-8qv8r -- sh -c condor_status -const 'regexp("ospool-ep-5c56576469-njr7k",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:11:59.0911206Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:11:59Z logger.go:67: true2026-08-14T01:11:59.0947450Z TestOSPoolEP 2026-08-14T01:11:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:59.1011258Z TestOSPoolEP 2026-08-14T01:11:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:59.2357085Z TestOSPoolEP 2026-08-14T01:11:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:59.3673308Z TestOSPoolEP 2026-08-14T01:11:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:59.4791272Z TestOSPoolEP 2026-08-14T01:11:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:59.6295829Z TestOSPoolEP 2026-08-14T01:11:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:59.7080111Z TestOSPoolEP 2026-08-14T01:11:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:59.7687301Z === NAME TestOSPoolEP2026-08-14T01:11:59.7708959Z ospool_ep_test.go:101: ---2026-08-14T01:11:59.7709506Z Events for pod cvmfs-nodeplugin-6b55bb5648-h2qns:2026-08-14T01:11:59.7710450Z 2026-08-14 01:05:16 +0000 UTC Normal Successfully assigned test-ospool-ep-id5lah/cvmfs-nodeplugin-6b55bb5648-h2qns to minikube2026-08-14T01:11:59.7711640Z 2026-08-14 01:05:17 +0000 UTC Normal Pulling image "opensciencegrid/cvmfs-nodeplugin:fresh"2026-08-14T01:11:59.7713168Z 2026-08-14 01:05:26 +0000 UTC Normal Successfully pulled image "opensciencegrid/cvmfs-nodeplugin:fresh" in 9.527s (9.527s including waiting). Image size: 431389691 bytes.2026-08-14T01:11:59.7714465Z 2026-08-14 01:05:26 +0000 UTC Normal Container created2026-08-14T01:11:59.7715087Z 2026-08-14 01:05:27 +0000 UTC Normal Container started2026-08-14T01:11:59.7715490Z 2026-08-14T01:11:59.7715747Z ---2026-08-14T01:11:59.7716801Z TestOSPoolEP 2026-08-14T01:11:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:59.7717602Z ospool_ep_test.go:101: ---2026-08-14T01:11:59.7718114Z Events for pod frontier-squid-765494655-whlgs:2026-08-14T01:11:59.7719172Z 2026-08-14 01:05:16 +0000 UTC Normal Successfully assigned test-ospool-ep-id5lah/frontier-squid-765494655-whlgs to minikube2026-08-14T01:11:59.7720317Z 2026-08-14 01:05:17 +0000 UTC Normal Pulling image "opensciencegrid/frontier-squid:fresh"2026-08-14T01:11:59.7721874Z 2026-08-14 01:05:55 +0000 UTC Normal Successfully pulled image "opensciencegrid/frontier-squid:fresh" in 28.562s (38.045s including waiting). Image size: 970524479 bytes.2026-08-14T01:11:59.7722965Z 2026-08-14 01:05:55 +0000 UTC Normal Container created2026-08-14T01:11:59.7723575Z 2026-08-14 01:05:55 +0000 UTC Normal Container started2026-08-14T01:11:59.7724308Z 2026-08-14T01:11:59.7724579Z ---2026-08-14T01:11:59.7725275Z TestOSPoolEP 2026-08-14T01:11:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:59.7737901Z ospool_ep_test.go:101: ---2026-08-14T01:11:59.7739886Z Events for pod idtoken-generator:2026-08-14T01:11:59.7741387Z 2026-08-14 01:04:56 +0000 UTC Normal Successfully assigned test-ospool-ep-id5lah/idtoken-generator to minikube2026-08-14T01:11:59.7742282Z 2026-08-14 01:05:03 +0000 UTC Normal Pulling image "htcondor/base"2026-08-14T01:11:59.7743366Z 2026-08-14 01:05:14 +0000 UTC Normal Successfully pulled image "htcondor/base" in 10.831s (10.831s including waiting). Image size: 560910730 bytes.2026-08-14T01:11:59.7744392Z 2026-08-14 01:05:14 +0000 UTC Normal Container created2026-08-14T01:11:59.7744908Z 2026-08-14 01:05:14 +0000 UTC Normal Container started2026-08-14T01:11:59.7745250Z 2026-08-14T01:11:59.7745471Z ---2026-08-14T01:11:59.7746096Z TestOSPoolEP 2026-08-14T01:11:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:59.7757112Z ospool_ep_test.go:101: ---2026-08-14T01:11:59.7757737Z Events for pod ospool-ep-5c56576469-njr7k:2026-08-14T01:11:59.7759259Z 2026-08-14 01:05:16 +0000 UTC Normal Successfully assigned test-ospool-ep-id5lah/ospool-ep-5c56576469-njr7k to minikube2026-08-14T01:11:59.7760422Z 2026-08-14 01:05:17 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-14T01:11:59.7761969Z 2026-08-14 01:05:58 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 2.619s (40.661s including waiting). Image size: 5590942 bytes.2026-08-14T01:11:59.7763046Z 2026-08-14 01:05:58 +0000 UTC Normal Container created2026-08-14T01:11:59.7763430Z 2026-08-14 01:05:58 +0000 UTC Normal Container started2026-08-14T01:11:59.7764196Z 2026-08-14 01:05:58 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-08-14T01:11:59.7765518Z 2026-08-14 01:06:23 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 23.481s (24.607s including waiting). Image size: 1273054585 bytes.2026-08-14T01:11:59.7766297Z 2026-08-14 01:06:23 +0000 UTC Normal Container created2026-08-14T01:11:59.7766934Z 2026-08-14 01:06:23 +0000 UTC Normal Container started2026-08-14T01:11:59.7767256Z 2026-08-14T01:11:59.7767456Z ---2026-08-14T01:11:59.7768150Z TestOSPoolEP 2026-08-14T01:11:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:59.7778275Z ospool_ep_test.go:101: ---2026-08-14T01:11:59.7778854Z Events for pod test-cm-5bb545475c-8qv8r:2026-08-14T01:11:59.7779875Z 2026-08-14 01:05:16 +0000 UTC Normal Successfully assigned test-ospool-ep-id5lah/test-cm-5bb545475c-8qv8r to minikube2026-08-14T01:11:59.7780965Z 2026-08-14 01:05:17 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-08-14T01:11:59.7781856Z 2026-08-14 01:05:59 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 1.682s (42.33s including waiting). Image size: 560910756 bytes.2026-08-14T01:11:59.7782615Z 2026-08-14 01:05:59 +0000 UTC Normal Container created2026-08-14T01:11:59.7783191Z 2026-08-14 01:05:59 +0000 UTC Normal Container started2026-08-14T01:11:59.7783578Z 2026-08-14T01:11:59.7784022Z ---2026-08-14T01:11:59.7784526Z TestOSPoolEP 2026-08-14T01:11:59Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:59.7812423Z TestOSPoolEP 2026-08-14T01:11:59Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah delete -f /tmp/TestOSPoolEP3969985139]2026-08-14T01:11:59.8541404Z TestOSPoolEP 2026-08-14T01:11:59Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-id5lah namespace2026-08-14T01:11:59.8585130Z TestOSPoolEP 2026-08-14T01:11:59Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-id5lah namespace2026-08-14T01:12:02.2604951Z TestOSPoolEP 2026-08-14T01:12:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah delete -f /tmp/TestOSPoolEP4053325047]2026-08-14T01:12:02.3273186Z TestOSPoolEP 2026-08-14T01:12:02Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-id5lah namespace2026-08-14T01:12:02.3305881Z TestOSPoolEP 2026-08-14T01:12:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-id5lah delete -k /tmp/kustomize-template-3824082739]2026-08-14T01:12:02.4133482Z TestOSPoolEP 2026-08-14T01:12:02Z logger.go:67: serviceaccount "cvmfs-nodeplugin" deleted from test-ospool-ep-id5lah namespace2026-08-14T01:12:02.4240078Z TestOSPoolEP 2026-08-14T01:12:02Z logger.go:67: service "frontier-squid" deleted from test-ospool-ep-id5lah namespace2026-08-14T01:12:02.4306202Z TestOSPoolEP 2026-08-14T01:12:02Z logger.go:67: service "test-cm" deleted from test-ospool-ep-id5lah namespace2026-08-14T01:12:02.4338426Z TestOSPoolEP 2026-08-14T01:12:02Z logger.go:67: deployment.apps "cvmfs-nodeplugin" deleted from test-ospool-ep-id5lah namespace2026-08-14T01:12:02.4368683Z TestOSPoolEP 2026-08-14T01:12:02Z logger.go:67: deployment.apps "frontier-squid" deleted from test-ospool-ep-id5lah namespace2026-08-14T01:12:02.4415559Z TestOSPoolEP 2026-08-14T01:12:02Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-id5lah namespace2026-08-14T01:12:02.4472571Z TestOSPoolEP 2026-08-14T01:12:02Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-id5lah namespace2026-08-14T01:12:02.6986832Z --- PASS: TestOSPoolEP (95.37s)2026-08-14T01:12:02.6987706Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (70.45s)2026-08-14T01:12:02.6997559Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.76s)2026-08-14T01:12:02.7001423Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.77s)2026-08-14T01:12:02.7004936Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (331.76s)2026-08-14T01:12:02.7005899Z PASS2026-08-14T01:12:02.7020720Z ok github.com/osg-htc/k8s-integration-tests/test 427.145s2026-08-14T01:12:02.8011448Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-14T01:12:02.8012503Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-14T01:12:02.8073211Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-14T01:12:02.8073638Z env:2026-08-14T01:12:02.8074150Z GOTOOLCHAIN: local2026-08-14T01:12:02.8074703Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-08-14T01:12:02.8075202Z ##[endgroup]2026-08-14T01:12:02.8218184Z 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-14T01:12:02.8219405Z ##[group]Run actions/upload-artifact@v42026-08-14T01:12:02.8219627Z with:2026-08-14T01:12:02.8219936Z name: TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd72026-08-14T01:12:02.8220298Z path: /tmp/k8s-tests2026-08-14T01:12:02.8220483Z retention-days: 52026-08-14T01:12:02.8220670Z if-no-files-found: warn2026-08-14T01:12:02.8220862Z compression-level: 62026-08-14T01:12:02.8221041Z overwrite: false2026-08-14T01:12:02.8221218Z include-hidden-files: false2026-08-14T01:12:02.8221415Z env:2026-08-14T01:12:02.8221564Z GOTOOLCHAIN: local2026-08-14T01:12:02.8221734Z ##[endgroup]2026-08-14T01:12:02.9656394Z (node:20690) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-14T01:12:02.9657315Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-14T01:12:02.9746560Z With the provided path, there will be 10 files uploaded2026-08-14T01:12:02.9766854Z Artifact name is valid!2026-08-14T01:12:02.9767398Z Root directory input is valid!2026-08-14T01:12:03.2620231Z Beginning upload of artifact content to blob storage2026-08-14T01:12:03.2875518Z (node:20690) [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-14T01:12:03.5895826Z Uploaded bytes 160982026-08-14T01:12:03.6597592Z Finished uploading artifact content to blob storage!2026-08-14T01:12:03.6598712Z SHA256 digest of uploaded artifact zip is 8eea579a7b6c518c2de2d7547fa8beec2946c0781382067e23d91f24a0bc264e2026-08-14T01:12:03.6601037Z Finalizing artifact upload2026-08-14T01:12:03.8519213Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7.zip successfully finalized. Artifact ID 92041669002026-08-14T01:12:03.8520637Z Artifact TestOSPoolEP-05a4720e5d6ef9fda450cd79968ef4672e792902d79a5df02f9e5a9f1c5aafd7 has been successfully uploaded! Final size is 16098 bytes. Artifact ID is 92041669002026-08-14T01:12:03.8527526Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/31759369059/artifacts/92041669002026-08-14T01:12:03.8690718Z Post job cleanup.2026-08-14T01:12:03.9717397Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-14T01:12:03.9752368Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-14T01:12:03.9777083Z /home/runner/go/pkg/mod2026-08-14T01:12:03.9789409Z /home/runner/.cache/go-build2026-08-14T01:12:03.9797797Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-14T01:12:03.9950890Z Post job cleanup.2026-08-14T01:12:04.0710284Z [command]/usr/bin/git version2026-08-14T01:12:04.0747496Z git version 2.54.02026-08-14T01:12:04.0782264Z Temporarily overriding HOME='/home/runner/work/_temp/e534a284-1f15-4d0f-a1b7-21fd7151c32e' before making global git config changes2026-08-14T01:12:04.0783132Z Adding repository directory to the temporary git global config as a safe directory2026-08-14T01:12:04.0787327Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-14T01:12:04.0823072Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-14T01:12:04.0853729Z [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-14T01:12:04.1090473Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-14T01:12:04.1118628Z http.https://github.com/.extraheader2026-08-14T01:12:04.1128935Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-14T01:12:04.1158921Z [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-14T01:12:04.1396344Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-14T01:12:04.1455186Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-14T01:12:04.1852186Z Cleaning up orphan processes2026-08-14T01:12:04.2633018Z ##[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/