2026-08-05T01:39:38.8883705Z Current runner version: '2.336.0'2026-08-05T01:39:38.8911235Z ##[group]Runner Image Provisioner2026-08-05T01:39:38.8912103Z Hosted Compute Agent2026-08-05T01:39:38.8912828Z Version: 20260707.5632026-08-05T01:39:38.8913500Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-08-05T01:39:38.8914276Z Build Date: 2026-07-07T19:33:50Z2026-08-05T01:39:38.8915047Z Worker ID: {a94931a3-d9ea-430e-9a41-c01fd80d2791}2026-08-05T01:39:38.8915811Z Azure Region: centralus2026-08-05T01:39:38.8916485Z ##[endgroup]2026-08-05T01:39:38.8917924Z ##[group]Operating System2026-08-05T01:39:38.8918546Z Ubuntu2026-08-05T01:39:38.8919223Z 22.04.52026-08-05T01:39:38.8919768Z LTS2026-08-05T01:39:38.8920351Z ##[endgroup]2026-08-05T01:39:38.8921124Z ##[group]Runner Image2026-08-05T01:39:38.8921757Z Image: ubuntu-22.042026-08-05T01:39:38.8922430Z Version: 20260720.234.22026-08-05T01:39:38.8923765Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-08-05T01:39:38.8925403Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-08-05T01:39:38.8926390Z ##[endgroup]2026-08-05T01:39:38.8927770Z ##[group]GITHUB_TOKEN Permissions2026-08-05T01:39:38.8931323Z Contents: read2026-08-05T01:39:38.8932598Z Metadata: read2026-08-05T01:39:38.8933505Z Packages: read2026-08-05T01:39:38.8934280Z ##[endgroup]2026-08-05T01:39:38.8937869Z Secret source: Actions2026-08-05T01:39:38.8939512Z Prepare workflow directory2026-08-05T01:39:38.9334025Z Prepare all required actions2026-08-05T01:39:38.9393189Z Getting action download info2026-08-05T01:39:39.1865426Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-05T01:39:39.5838160Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-05T01:39:39.8895003Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-05T01:39:40.2461205Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-05T01:39:40.5199272Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-05T01:39:40.5205522Z ##[group] Inputs2026-08-05T01:39:40.5206522Z testName: TestOSPoolEP2026-08-05T01:39:40.5208276Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-05T01:39:40.5210171Z setupScript: 2026-08-05T01:39:40.5211223Z setupEnv: {}2026-08-05T01:39:40.5212083Z ##[endgroup]2026-08-05T01:39:40.5213456Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-08-05T01:39:40.6106413Z ##[group]Run actions/checkout@v52026-08-05T01:39:40.6107783Z with:2026-08-05T01:39:40.6108747Z repository: mwestphall/k8s-integration-tests2026-08-05T01:39:40.6117158Z token: ***2026-08-05T01:39:40.6118036Z ssh-strict: true2026-08-05T01:39:40.6118961Z ssh-user: git2026-08-05T01:39:40.6119830Z persist-credentials: true2026-08-05T01:39:40.6120915Z clean: true2026-08-05T01:39:40.6121802Z sparse-checkout-cone-mode: true2026-08-05T01:39:40.6122840Z fetch-depth: 12026-08-05T01:39:40.6123702Z fetch-tags: false2026-08-05T01:39:40.6124593Z show-progress: true2026-08-05T01:39:40.6125479Z lfs: false2026-08-05T01:39:40.6126307Z submodules: false2026-08-05T01:39:40.6127187Z set-safe-directory: true2026-08-05T01:39:40.6128188Z allow-unsafe-pr-checkout: false2026-08-05T01:39:40.6129489Z ##[endgroup]2026-08-05T01:39:40.7257129Z Syncing repository: mwestphall/k8s-integration-tests2026-08-05T01:39:40.7261027Z ##[group]Getting Git version info2026-08-05T01:39:40.7263509Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-05T01:39:40.7266395Z [command]/usr/bin/git version2026-08-05T01:39:40.7343223Z git version 2.54.02026-08-05T01:39:40.7388417Z ##[endgroup]2026-08-05T01:39:40.7401225Z Temporarily overriding HOME='/home/runner/work/_temp/28c44e1e-35d3-4053-adfe-0b20c4c28beb' before making global git config changes2026-08-05T01:39:40.7406088Z Adding repository directory to the temporary git global config as a safe directory2026-08-05T01:39:40.7410648Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-05T01:39:40.7441801Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-05T01:39:40.7449314Z ##[group]Initializing the repository2026-08-05T01:39:40.7456093Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-05T01:39:40.7553097Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-05T01:39:40.7556361Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-05T01:39:40.7559461Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-05T01:39:40.7562277Z hint: call:2026-08-05T01:39:40.7563635Z hint:2026-08-05T01:39:40.7565295Z hint: git config --global init.defaultBranch <name>2026-08-05T01:39:40.7567363Z hint:2026-08-05T01:39:40.7569272Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-05T01:39:40.7571595Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-05T01:39:40.7573741Z hint:2026-08-05T01:39:40.7575156Z hint: git branch -m <name>2026-08-05T01:39:40.7576880Z hint:2026-08-05T01:39:40.7578948Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-05T01:39:40.7583091Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-05T01:39:40.7589521Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-05T01:39:40.7610139Z ##[endgroup]2026-08-05T01:39:40.7612692Z ##[group]Disabling automatic garbage collection2026-08-05T01:39:40.7614784Z [command]/usr/bin/git config --local gc.auto 02026-08-05T01:39:40.7651012Z ##[endgroup]2026-08-05T01:39:40.7653086Z ##[group]Setting up auth2026-08-05T01:39:40.7658513Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-05T01:39:40.7700277Z [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-05T01:39:40.8101296Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-05T01:39:40.8145581Z [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-05T01:39:40.8420759Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-05T01:39:40.8461385Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-05T01:39:40.8746024Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-05T01:39:40.8792614Z ##[endgroup]2026-08-05T01:39:40.8794809Z ##[group]Fetching the repository2026-08-05T01:39:40.8805147Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-05T01:39:41.1846417Z From https://github.com/mwestphall/k8s-integration-tests2026-08-05T01:39:41.1848378Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-05T01:39:41.1875437Z ##[endgroup]2026-08-05T01:39:41.1877329Z ##[group]Determining the checkout info2026-08-05T01:39:41.1878958Z ##[endgroup]2026-08-05T01:39:41.1883278Z [command]/usr/bin/git sparse-checkout disable2026-08-05T01:39:41.1933191Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-05T01:39:41.1968433Z ##[group]Checking out the ref2026-08-05T01:39:41.1971514Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-05T01:39:41.2067719Z Switched to a new branch 'main'2026-08-05T01:39:41.2069655Z branch 'main' set up to track 'origin/main'.2026-08-05T01:39:41.2076933Z ##[endgroup]2026-08-05T01:39:41.2118760Z [command]/usr/bin/git log -1 --format=%H2026-08-05T01:39:41.2148906Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-05T01:39:41.2508629Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-05T01:39:41.2511070Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-05T01:39:41.2513185Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-05T01:39:41.2638715Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-05T01:39:41.2640027Z env:2026-08-05T01:39:41.2641741Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-05T01:39:41.2643512Z SETUP_ENV_YAML: {}2026-08-05T01:39:41.2644354Z ##[endgroup]2026-08-05T01:39:41.8234166Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-05T01:39:41.8234887Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-05T01:39:41.8297847Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-05T01:39:41.8298263Z env:2026-08-05T01:39:41.8298772Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-05T01:39:41.8299331Z ##[endgroup]2026-08-05T01:39:41.8446599Z ##[group]Run true2026-08-05T01:39:41.8446918Z [36;1mtrue[0m2026-08-05T01:39:41.8506165Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-05T01:39:41.8506597Z ##[endgroup]2026-08-05T01:39:41.8677524Z ##[group]Run medyagh/setup-minikube@latest2026-08-05T01:39:41.8677877Z with:2026-08-05T01:39:41.8678118Z start: true2026-08-05T01:39:41.8678354Z cache: true2026-08-05T01:39:41.8678607Z minikube-version: latest2026-08-05T01:39:41.8678894Z wait: all2026-08-05T01:39:41.8679139Z ##[endgroup]2026-08-05T01:39:41.9999737Z (node:2207) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-05T01:39:42.0001218Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-05T01:39:42.9569132Z [command]/usr/bin/chmod +x /home/runner/work/_temp/94f1afcf-f97e-4c8b-892c-f1726f5c76e52026-08-05T01:39:43.1259049Z [command]/home/runner/bin/minikube version --short2026-08-05T01:39:43.1660046Z v1.38.12026-08-05T01:39:43.2938184Z Cache hit for: kic-v1.38.1-x642026-08-05T01:39:43.3039924Z (node:2207) [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-05T01:39:43.3150503Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-05T01:39:44.4599100Z Received 96468992 of 224218863 (43.0%), 92.0 MBs/sec2026-08-05T01:39:44.4800696Z Received 117440512 of 544082657 (21.6%), 112.0 MBs/sec2026-08-05T01:39:45.4607431Z Received 213909504 of 224218863 (95.4%), 101.9 MBs/sec2026-08-05T01:39:45.5736859Z Received 268435456 of 544082657 (49.3%), 122.3 MBs/sec2026-08-05T01:39:45.6510588Z Received 224218863 of 224218863 (100.0%), 97.6 MBs/sec2026-08-05T01:39:45.6514903Z Cache Size: ~214 MB (224218863 B)2026-08-05T01:39:45.7198935Z [command]/usr/bin/tar -xf /home/runner/work/_temp/2474bd62-9284-4564-991b-9a1da5fbd6c6/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-05T01:39:46.4083551Z Cache restored successfully2026-08-05T01:39:46.5743834Z Received 440401920 of 544082657 (80.9%), 135.7 MBs/sec2026-08-05T01:39:47.2576459Z Received 544082657 of 544082657 (100.0%), 137.3 MBs/sec2026-08-05T01:39:47.2577584Z Cache Size: ~519 MB (544082657 B)2026-08-05T01:39:47.2730304Z [command]/usr/bin/tar -xf /home/runner/work/_temp/6d91d905-14e4-48d4-a992-227fabced154/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-05T01:39:48.1660341Z Cache restored successfully2026-08-05T01:39:48.2916396Z [command]/home/runner/bin/minikube start --wait all2026-08-05T01:39:48.3395938Z * minikube v1.38.1 on Ubuntu 22.042026-08-05T01:39:48.7833756Z ! 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-05T01:39:48.7844790Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-05T01:39:48.8400129Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-05T01:39:48.8406212Z * Using Docker driver with root privileges2026-08-05T01:39:48.8415525Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-05T01:39:48.8421681Z * Pulling base image v0.0.50 ...2026-08-05T01:40:20.1408767Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-05T01:40:25.3312924Z * Verifying Kubernetes components...2026-08-05T01:40:25.3560206Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-05T01:40:26.0460661Z * Enabled addons: default-storageclass, storage-provisioner2026-08-05T01:41:07.1469374Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-05T01:41:07.1581850Z [command]/home/runner/bin/minikube version --short2026-08-05T01:41:07.2026134Z v1.38.12026-08-05T01:41:07.2354055Z ##[group]Run actions/setup-go@v62026-08-05T01:41:07.2354343Z with:2026-08-05T01:41:07.2354555Z go-version: 1.262026-08-05T01:41:07.2354798Z cache: true2026-08-05T01:41:07.2355031Z cache-dependency-path: go.sum2026-08-05T01:41:07.2355301Z check-latest: false2026-08-05T01:41:07.2358420Z token: ***2026-08-05T01:41:07.2358733Z ##[endgroup]2026-08-05T01:41:07.3696789Z Setup go version spec 1.262026-08-05T01:41:07.3754212Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-05T01:41:07.3756836Z Added go to the path2026-08-05T01:41:07.3760657Z Successfully set up Go version 1.262026-08-05T01:41:07.4392403Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-05T01:41:07.4452376Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-05T01:41:07.4485760Z /home/runner/go/pkg/mod2026-08-05T01:41:07.4512191Z /home/runner/.cache/go-build2026-08-05T01:41:07.5950425Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-05T01:41:08.7643165Z Received 92274688 of 251839808 (36.6%), 87.9 MBs/sec2026-08-05T01:41:09.7650362Z Received 247645504 of 251839808 (98.3%), 118.0 MBs/sec2026-08-05T01:41:09.8567073Z Received 251839808 of 251839808 (100.0%), 114.7 MBs/sec2026-08-05T01:41:09.8568262Z Cache Size: ~240 MB (251839808 B)2026-08-05T01:41:09.8606754Z [command]/usr/bin/tar -xf /home/runner/work/_temp/b324e6ba-981b-4a97-a5e4-ade3a7326bdd/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-05T01:41:12.8021539Z Cache restored successfully2026-08-05T01:41:12.8591919Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-05T01:41:12.8618728Z go version go1.26.5 linux/amd642026-08-05T01:41:12.8618963Z 2026-08-05T01:41:12.8619292Z ##[group]go env2026-08-05T01:41:12.8793045Z AR='ar'2026-08-05T01:41:12.8793367Z CC='gcc'2026-08-05T01:41:12.8793889Z CGO_CFLAGS='-O2 -g'2026-08-05T01:41:12.8794266Z CGO_CPPFLAGS=''2026-08-05T01:41:12.8794520Z CGO_CXXFLAGS='-O2 -g'2026-08-05T01:41:12.8795149Z CGO_ENABLED='1'2026-08-05T01:41:12.8795374Z CGO_FFLAGS='-O2 -g'2026-08-05T01:41:12.8795607Z CGO_LDFLAGS='-O2 -g'2026-08-05T01:41:12.8795844Z CXX='g++'2026-08-05T01:41:12.8796064Z GCCGO='gccgo'2026-08-05T01:41:12.8796290Z GO111MODULE=''2026-08-05T01:41:12.8796749Z GOAMD64='v1'2026-08-05T01:41:12.8797019Z GOARCH='amd64'2026-08-05T01:41:12.8797329Z GOAUTH='netrc'2026-08-05T01:41:12.8797614Z GOBIN=''2026-08-05T01:41:12.8797864Z GOCACHE='/home/runner/.cache/go-build'2026-08-05T01:41:12.8798172Z GOCACHEPROG=''2026-08-05T01:41:12.8798398Z GODEBUG=''2026-08-05T01:41:12.8798631Z GOENV='/home/runner/.config/go/env'2026-08-05T01:41:12.8799061Z GOEXE=''2026-08-05T01:41:12.8799369Z GOEXPERIMENT=''2026-08-05T01:41:12.8799715Z GOFIPS140='off'2026-08-05T01:41:12.8821307Z GOFLAGS=''2026-08-05T01:41:12.8822328Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build1786956305=/tmp/go-build -gno-record-gcc-switches'2026-08-05T01:41:12.8823146Z GOHOSTARCH='amd64'2026-08-05T01:41:12.8823398Z GOHOSTOS='linux'2026-08-05T01:41:12.8823629Z GOINSECURE=''2026-08-05T01:41:12.8824039Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-05T01:41:12.8824486Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-05T01:41:12.8824768Z GONOPROXY=''2026-08-05T01:41:12.8824987Z GONOSUMDB=''2026-08-05T01:41:12.8825186Z GOOS='linux'2026-08-05T01:41:12.8825410Z GOPATH='/home/runner/go'2026-08-05T01:41:12.8825651Z GOPRIVATE=''2026-08-05T01:41:12.8825929Z GOPROXY='https://proxy.golang.org,direct'2026-08-05T01:41:12.8826281Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-05T01:41:12.8826598Z GOSUMDB='sum.golang.org'2026-08-05T01:41:12.8826858Z GOTELEMETRY='local'2026-08-05T01:41:12.8827141Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-05T01:41:12.8827463Z GOTMPDIR=''2026-08-05T01:41:12.8828019Z GOTOOLCHAIN='local'2026-08-05T01:41:12.8828369Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-05T01:41:12.8828750Z GOVCS=''2026-08-05T01:41:12.8828963Z GOVERSION='go1.26.5'2026-08-05T01:41:12.8829209Z GOWORK=''2026-08-05T01:41:12.8829431Z PKG_CONFIG='pkg-config'2026-08-05T01:41:12.8829593Z 2026-08-05T01:41:12.8829978Z ##[endgroup]2026-08-05T01:41:12.9038431Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-05T01:41:12.9038973Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-05T01:41:12.9101788Z shell: /usr/bin/bash -e {0}2026-08-05T01:41:12.9102077Z env:2026-08-05T01:41:12.9102300Z GOTOOLCHAIN: local2026-08-05T01:41:12.9102558Z OSPOOL_EP_OSPoolEPTag: 25-release2026-08-05T01:41:12.9102864Z OSPOOL_EP_CMTag: 25.0-el92026-08-05T01:41:12.9103132Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-05T01:41:12.9103400Z ##[endgroup]2026-08-05T01:41:15.6601835Z === RUN TestOSPoolEP2026-08-05T01:41:15.6602484Z === PAUSE TestOSPoolEP2026-08-05T01:41:15.6603046Z === CONT TestOSPoolEP2026-08-05T01:41:15.6604288Z TestOSPoolEP 2026-08-05T01:41:15Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:41:15.6703373Z TestOSPoolEP 2026-08-05T01:41:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq apply -f /tmp/TestOSPoolEP701945580]2026-08-05T01:41:16.0989451Z TestOSPoolEP 2026-08-05T01:41:16Z logger.go:67: pod/idtoken-generator created2026-08-05T01:41:16.1122510Z TestOSPoolEP 2026-08-05T01:41:16Z logger.go:67: secret/pool-passwd created2026-08-05T01:41:16.1174806Z TestOSPoolEP 2026-08-05T01:41:16Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-05T01:41:16.1176084Z TestOSPoolEP 2026-08-05T01:41:16Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:41:16.1209085Z TestOSPoolEP 2026-08-05T01:41:16Z 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-05T01:41:26.1218147Z TestOSPoolEP 2026-08-05T01:41:26Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-05T01:41:26.1220122Z TestOSPoolEP 2026-08-05T01:41:26Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:41:26.1255520Z TestOSPoolEP 2026-08-05T01:41:26Z 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-05T01:41:36.1259475Z TestOSPoolEP 2026-08-05T01:41:36Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-05T01:41:36.1261074Z TestOSPoolEP 2026-08-05T01:41:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:41:36.1295093Z TestOSPoolEP 2026-08-05T01:41:36Z logger.go:67: Pod is now available2026-08-05T01:41:36.1296925Z TestOSPoolEP 2026-08-05T01:41:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-05T01:41:36.6683471Z TestOSPoolEP 2026-08-05T01:41:36Z logger.go:67: ***2026-08-05T01:41:36.6746967Z TestOSPoolEP 2026-08-05T01:41:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq apply -f /tmp/TestOSPoolEP1070936633]2026-08-05T01:41:36.8511355Z TestOSPoolEP 2026-08-05T01:41:36Z logger.go:67: secret/pool-token created2026-08-05T01:41:36.8547240Z TestOSPoolEP 2026-08-05T01:41:36Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-05T01:41:36.8548564Z TestOSPoolEP 2026-08-05T01:41:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:41:36.8569073Z TestOSPoolEP 2026-08-05T01:41:36Z logger.go:67: Secret is now available2026-08-05T01:41:36.8589240Z TestOSPoolEP 2026-08-05T01:41:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq apply -k /tmp/kustomize-template-2834686655]2026-08-05T01:41:37.1538501Z TestOSPoolEP 2026-08-05T01:41:37Z logger.go:67: service/test-cm created2026-08-05T01:41:37.1635479Z TestOSPoolEP 2026-08-05T01:41:37Z 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-05T01:41:37.1637092Z TestOSPoolEP 2026-08-05T01:41:37Z logger.go:67: deployment.apps/ospool-ep created2026-08-05T01:41:37.1737337Z TestOSPoolEP 2026-08-05T01:41:37Z logger.go:67: deployment.apps/test-cm created2026-08-05T01:41:37.1795712Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-05T01:41:37.1810725Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:41:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:41:37.1922054Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:41:37Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-05T01:41:37.1949480Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:41:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:41:37.1955728Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:41:37Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-05T01:41:37.1957921Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:41:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:41:37.1980468Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:41: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: NewReplicaSetCreated, message: Created new replica set "ospool-ep-6c7d796845". Sleeping for 10s and will try again.2026-08-05T01:41:37.1986801Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:41: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: NewReplicaSetCreated, message: Created new replica set "test-cm-54b7d49f85". Sleeping for 10s and will try again.2026-08-05T01:41:47.1996987Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:41:47Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-05T01:41:47.1998498Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:41:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:41:47.2001069Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:41:47Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-05T01:41:47.2020423Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:41:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:41:47.2021975Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:41:47Z logger.go:67: Deployment is now available2026-08-05T01:41:47.2025192Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:41: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-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-08-05T01:41:57.2022102Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:41:57Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-05T01:41:57.2023763Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:41:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:41:57.2058214Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:41: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-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-08-05T01:42:07.2065833Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:42:07Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-05T01:42:07.2067501Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:42:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:42:07.2094768Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-05T01:42:07Z logger.go:67: Deployment is now available2026-08-05T01:42:07.2114147Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-05T01:42:07.2115037Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-05T01:42:07.2115825Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-05T01:42:07.2116653Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-05T01:42:07.2117335Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-05T01:42:07.2118198Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-05T01:42:07.2118820Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-05T01:42:07.2119986Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-05T01:42:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:42:07.2120786Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-05T01:42:07.2130717Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:42:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:42:07.2132764Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-05T01:42:07.2134193Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-05T01:42:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:42:07.2135672Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:42:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:42:07.2142447Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-05T01:42:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:42:07.2158695Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-05T01:42:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:42:07.2167073Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:42:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-05T01:42:07.2204046Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-05T01:42:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_SINGULARITY]2026-08-05T01:42:07.2226042Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-05T01:42:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)']2026-08-05T01:42:07.5037125Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-05T01:42:07.5052965Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9jmzt failed. Retrying in 30s.2026-08-05T01:42:07.5065269Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-05T01:42:07.5068207Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)']' in pod test-cm-54b7d49f85-9jmzt failed. Retrying in 10s.2026-08-05T01:42:07.5464035Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-05T01:42:07.5465862Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-9jmzt failed. Retrying in 10s.2026-08-05T01:42:17.5078038Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-05T01:42:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)']2026-08-05T01:42:17.5502296Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-05T01:42:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_SINGULARITY]2026-08-05T01:42:17.6835667Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-05T01:42:17.6837614Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)']' in pod test-cm-54b7d49f85-9jmzt failed. Retrying in 10s.2026-08-05T01:42:17.7284897Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-05T01:42:17.7286249Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-9jmzt failed. Retrying in 10s.2026-08-05T01:42:27.6837810Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-05T01:42:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)']2026-08-05T01:42:27.7292861Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-05T01:42:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_SINGULARITY]2026-08-05T01:42:27.8503615Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-05T01:42:27Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-05T01:42:27.8505820Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-05T01:42:27Z logger.go:67: 2026-08-05T01:42:27.8508864Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-05T01:42:27Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-29ztc LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-08-05T01:42:27.8511747Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-05T01:42:27Z logger.go:67: 2026-08-05T01:42:27.8513864Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-05T01:42:27Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-05T01:42:27.8516855Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-05T01:42:27Z logger.go:67: 2026-08-05T01:42:27.8518990Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-05T01:42:27Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-05T01:42:27.8520801Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-05T01:42:27Z logger.go:67: 2026-08-05T01:42:27.8522660Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-05T01:42:27Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-05T01:42:27.8984182Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-05T01:42:27Z logger.go:67: true2026-08-05T01:42:37.5041235Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:42:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-05T01:42:37.6582200Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:42:37Z logger.go:67: undefined2026-08-05T01:42:37.6639186Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-05T01:42:37.6640410Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9jmzt failed. Retrying in 30s.2026-08-05T01:43:07.6643137Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:43:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-05T01:43:07.8119122Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:43:07Z logger.go:67: undefined2026-08-05T01:43:07.8185482Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9jmzt failed. Retrying in 30s.2026-08-05T01:43:37.8196332Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:43:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-05T01:43:37.9700398Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:43:37Z logger.go:67: undefined2026-08-05T01:43:37.9761909Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9jmzt failed. Retrying in 30s.2026-08-05T01:44:07.9768901Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:44:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-05T01:44:08.1264290Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:44:08Z logger.go:67: undefined2026-08-05T01:44:08.1332037Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9jmzt failed. Retrying in 30s.2026-08-05T01:44:38.1334470Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:44:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-05T01:44:38.2806388Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:44:38Z logger.go:67: undefined2026-08-05T01:44:38.2867752Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9jmzt failed. Retrying in 30s.2026-08-05T01:45:08.2879512Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:45:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-05T01:45:08.4385821Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:45:08Z logger.go:67: undefined2026-08-05T01:45:08.4450267Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9jmzt failed. Retrying in 30s.2026-08-05T01:45:38.4477517Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:45:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-05T01:45:38.5970407Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:45:38Z logger.go:67: undefined2026-08-05T01:45:38.6033205Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9jmzt failed. Retrying in 30s.2026-08-05T01:46:08.6036609Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:46:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-05T01:46:08.7568920Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:46:08Z logger.go:67: undefined2026-08-05T01:46:08.7632628Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9jmzt failed. Retrying in 30s.2026-08-05T01:46:38.7634377Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:46:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-05T01:46:38.9179539Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:46:38Z logger.go:67: undefined2026-08-05T01:46:38.9239019Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9jmzt failed. Retrying in 30s.2026-08-05T01:47:08.9268354Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:47:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-05T01:47:09.0810213Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:47:09Z logger.go:67: undefined2026-08-05T01:47:09.0864827Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-9jmzt failed. Retrying in 30s.2026-08-05T01:47:39.0897957Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:47:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq exec test-cm-54b7d49f85-9jmzt -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-29ztc",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-05T01:47:39.2670751Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-05T01:47:39Z logger.go:67: true2026-08-05T01:47:39.2743650Z TestOSPoolEP 2026-08-05T01:47:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:47:39.2838729Z TestOSPoolEP 2026-08-05T01:47:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:47:39.4273156Z TestOSPoolEP 2026-08-05T01:47:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:47:39.5584164Z TestOSPoolEP 2026-08-05T01:47:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:47:39.6800655Z TestOSPoolEP 2026-08-05T01:47:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:47:39.6827606Z === NAME TestOSPoolEP2026-08-05T01:47:39.6830166Z ospool_ep_test.go:101: ---2026-08-05T01:47:39.6831880Z Events for pod idtoken-generator:2026-08-05T01:47:39.6833632Z 2026-08-05 01:41:16 +0000 UTC Normal Successfully assigned test-ospool-ep-aftdsq/idtoken-generator to minikube2026-08-05T01:47:39.6834878Z 2026-08-05 01:41:19 +0000 UTC Normal Pulling image "htcondor/base"2026-08-05T01:47:39.6836479Z 2026-08-05 01:41:27 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.679s (8.679s including waiting). Image size: 560910730 bytes.2026-08-05T01:47:39.6837736Z 2026-08-05 01:41:27 +0000 UTC Normal Container created2026-08-05T01:47:39.6838563Z 2026-08-05 01:41:28 +0000 UTC Normal Container started2026-08-05T01:47:39.6839085Z 2026-08-05T01:47:39.6839430Z ---2026-08-05T01:47:39.6840379Z TestOSPoolEP 2026-08-05T01:47:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:47:39.6856228Z ospool_ep_test.go:101: ---2026-08-05T01:47:39.6857308Z Events for pod ospool-ep-6c7d796845-29ztc:2026-08-05T01:47:39.6858614Z 2026-08-05 01:41:37 +0000 UTC Normal Successfully assigned test-ospool-ep-aftdsq/ospool-ep-6c7d796845-29ztc to minikube2026-08-05T01:47:39.6860067Z 2026-08-05 01:41:37 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-05T01:47:39.6861870Z 2026-08-05 01:41:39 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.485s (1.485s including waiting). Image size: 5590942 bytes.2026-08-05T01:47:39.6863917Z 2026-08-05 01:41:39 +0000 UTC Normal Container created2026-08-05T01:47:39.6864730Z 2026-08-05 01:41:39 +0000 UTC Normal Container started2026-08-05T01:47:39.6865953Z 2026-08-05 01:41:40 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-08-05T01:47:39.6868152Z 2026-08-05 01:41:59 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 14.37s (19.292s including waiting). Image size: 1388522094 bytes.2026-08-05T01:47:39.6869642Z 2026-08-05 01:41:59 +0000 UTC Normal Container created2026-08-05T01:47:39.6870423Z 2026-08-05 01:41:59 +0000 UTC Normal Container started2026-08-05T01:47:39.6871057Z 2026-08-05T01:47:39.6871407Z ---2026-08-05T01:47:39.6872345Z TestOSPoolEP 2026-08-05T01:47:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:47:39.6881960Z ospool_ep_test.go:101: ---2026-08-05T01:47:39.6882744Z Events for pod test-cm-54b7d49f85-9jmzt:2026-08-05T01:47:39.6889336Z 2026-08-05 01:41:37 +0000 UTC Normal Successfully assigned test-ospool-ep-aftdsq/test-cm-54b7d49f85-9jmzt to minikube2026-08-05T01:47:39.6891877Z 2026-08-05 01:41:37 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-08-05T01:47:39.6893863Z 2026-08-05 01:41:45 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 5.873s (7.347s including waiting). Image size: 573055668 bytes.2026-08-05T01:47:39.6897407Z 2026-08-05 01:41:45 +0000 UTC Normal Container created2026-08-05T01:47:39.6900431Z 2026-08-05 01:41:45 +0000 UTC Normal Container started2026-08-05T01:47:39.6901469Z 2026-08-05T01:47:39.6902025Z ---2026-08-05T01:47:39.6903318Z TestOSPoolEP 2026-08-05T01:47:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-05T01:47:39.6946479Z TestOSPoolEP 2026-08-05T01:47:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq delete -f /tmp/TestOSPoolEP3219254090]2026-08-05T01:47:39.7908185Z TestOSPoolEP 2026-08-05T01:47:39Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-aftdsq namespace2026-08-05T01:47:39.8028066Z TestOSPoolEP 2026-08-05T01:47:39Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-aftdsq namespace2026-08-05T01:47:41.1985333Z TestOSPoolEP 2026-08-05T01:47:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq delete -f /tmp/TestOSPoolEP2148572340]2026-08-05T01:47:41.2908906Z TestOSPoolEP 2026-08-05T01:47:41Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-aftdsq namespace2026-08-05T01:47:41.2957823Z TestOSPoolEP 2026-08-05T01:47:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-aftdsq delete -k /tmp/kustomize-template-2834686655]2026-08-05T01:47:41.4374697Z TestOSPoolEP 2026-08-05T01:47:41Z logger.go:67: service "test-cm" deleted from test-ospool-ep-aftdsq namespace2026-08-05T01:47:41.4457212Z TestOSPoolEP 2026-08-05T01:47:41Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-aftdsq namespace2026-08-05T01:47:41.4502351Z TestOSPoolEP 2026-08-05T01:47:41Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-aftdsq namespace2026-08-05T01:47:41.4663528Z --- PASS: TestOSPoolEP (53.74s)2026-08-05T01:47:41.4665114Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.03s)2026-08-05T01:47:41.4672884Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.65s)2026-08-05T01:47:41.4676659Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.69s)2026-08-05T01:47:41.4679977Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (332.06s)2026-08-05T01:47:41.4680785Z PASS2026-08-05T01:47:41.4681733Z ok github.com/osg-htc/k8s-integration-tests/test 385.820s2026-08-05T01:47:41.5922976Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-05T01:47:41.5923868Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-05T01:47:41.5994584Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-05T01:47:41.5995104Z env:2026-08-05T01:47:41.5995392Z GOTOOLCHAIN: local2026-08-05T01:47:41.5996046Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-05T01:47:41.5996743Z ##[endgroup]2026-08-05T01:47:41.6244240Z 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-05T01:47:41.6245950Z ##[group]Run actions/upload-artifact@v42026-08-05T01:47:41.6246358Z with:2026-08-05T01:47:41.6246837Z name: TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce72322026-08-05T01:47:41.6247610Z path: /tmp/k8s-tests2026-08-05T01:47:41.6247847Z retention-days: 52026-08-05T01:47:41.6248089Z if-no-files-found: warn2026-08-05T01:47:41.6248329Z compression-level: 62026-08-05T01:47:41.6248634Z overwrite: false2026-08-05T01:47:41.6249000Z include-hidden-files: false2026-08-05T01:47:41.6249297Z env:2026-08-05T01:47:41.6249606Z GOTOOLCHAIN: local2026-08-05T01:47:41.6249949Z ##[endgroup]2026-08-05T01:47:41.8693326Z (node:17728) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-05T01:47:41.8694752Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-05T01:47:41.8852525Z With the provided path, there will be 6 files uploaded2026-08-05T01:47:41.8858394Z Artifact name is valid!2026-08-05T01:47:41.8859545Z Root directory input is valid!2026-08-05T01:47:42.0964621Z Beginning upload of artifact content to blob storage2026-08-05T01:47:42.1363244Z (node:17728) [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-05T01:47:42.3108493Z Uploaded bytes 139692026-08-05T01:47:42.3555286Z Finished uploading artifact content to blob storage!2026-08-05T01:47:42.3556595Z SHA256 digest of uploaded artifact zip is 07cc0241842464178e55aea91179789d7e8230530f5c4bb8a7b521fb8d25d7182026-08-05T01:47:42.3559498Z Finalizing artifact upload2026-08-05T01:47:42.5221466Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232.zip successfully finalized. Artifact ID 89152636892026-08-05T01:47:42.5223390Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232 has been successfully uploaded! Final size is 13969 bytes. Artifact ID is 89152636892026-08-05T01:47:42.5229619Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/30967038376/artifacts/89152636892026-08-05T01:47:42.5415861Z Post job cleanup.2026-08-05T01:47:42.6782371Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-05T01:47:42.6831474Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-05T01:47:42.6870070Z /home/runner/go/pkg/mod2026-08-05T01:47:42.6895139Z /home/runner/.cache/go-build2026-08-05T01:47:42.6904595Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-05T01:47:42.7147115Z Post job cleanup.2026-08-05T01:47:42.8177794Z [command]/usr/bin/git version2026-08-05T01:47:42.8252279Z git version 2.54.02026-08-05T01:47:42.8295217Z Temporarily overriding HOME='/home/runner/work/_temp/bcebbca1-bb53-4ae9-8c7b-830f714e0564' before making global git config changes2026-08-05T01:47:42.8303532Z Adding repository directory to the temporary git global config as a safe directory2026-08-05T01:47:42.8313532Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-05T01:47:42.8378172Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-05T01:47:42.8428483Z [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-05T01:47:42.8794755Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-05T01:47:42.8825604Z http.https://github.com/.extraheader2026-08-05T01:47:42.8839440Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-05T01:47:42.8878355Z [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-05T01:47:42.9207306Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-05T01:47:42.9254279Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-05T01:47:42.9721424Z Cleaning up orphan processes2026-08-05T01:47:43.0506396Z ##[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/