2026-08-14T01:03:02.8974008Z Current runner version: '2.336.0'2026-08-14T01:03:02.9002100Z ##[group]Runner Image Provisioner2026-08-14T01:03:02.9003306Z Hosted Compute Agent2026-08-14T01:03:02.9004036Z Version: 20260707.5632026-08-14T01:03:02.9004748Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-08-14T01:03:02.9005498Z Build Date: 2026-07-07T19:33:50Z2026-08-14T01:03:02.9006332Z Worker ID: {6739a18d-c5f4-4f7e-8a49-d5a9e3126006}2026-08-14T01:03:02.9007093Z Azure Region: centralus2026-08-14T01:03:02.9007684Z ##[endgroup]2026-08-14T01:03:02.9009698Z ##[group]Operating System2026-08-14T01:03:02.9010368Z Ubuntu2026-08-14T01:03:02.9011019Z 22.04.52026-08-14T01:03:02.9011613Z LTS2026-08-14T01:03:02.9012159Z ##[endgroup]2026-08-14T01:03:02.9013223Z ##[group]Runner Image2026-08-14T01:03:02.9013872Z Image: ubuntu-22.042026-08-14T01:03:02.9014475Z Version: 20260720.234.22026-08-14T01:03:02.9015961Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-08-14T01:03:02.9017670Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-08-14T01:03:02.9018683Z ##[endgroup]2026-08-14T01:03:02.9019981Z ##[group]GITHUB_TOKEN Permissions2026-08-14T01:03:02.9022405Z Contents: read2026-08-14T01:03:02.9023180Z Metadata: read2026-08-14T01:03:02.9023958Z Packages: read2026-08-14T01:03:02.9024544Z ##[endgroup]2026-08-14T01:03:02.9028181Z Secret source: Actions2026-08-14T01:03:02.9029872Z Prepare workflow directory2026-08-14T01:03:02.9382115Z Prepare all required actions2026-08-14T01:03:02.9433088Z Getting action download info2026-08-14T01:03:03.2029965Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-14T01:03:04.1327921Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-14T01:03:04.5169978Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-14T01:03:04.8654973Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-14T01:03:05.1966238Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-14T01:03:05.1972092Z ##[group] Inputs2026-08-14T01:03:05.1973344Z testName: TestOSPoolEP2026-08-14T01:03:05.1975046Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-14T01:03:05.1976886Z setupScript: 2026-08-14T01:03:05.1977728Z setupEnv: {}2026-08-14T01:03:05.1978552Z ##[endgroup]2026-08-14T01:03:05.1979862Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-testing) / Run Tests2026-08-14T01:03:05.2846302Z ##[group]Run actions/checkout@v52026-08-14T01:03:05.2847617Z with:2026-08-14T01:03:05.2848540Z repository: mwestphall/k8s-integration-tests2026-08-14T01:03:05.2857825Z token: ***2026-08-14T01:03:05.2858666Z ssh-strict: true2026-08-14T01:03:05.2859534Z ssh-user: git2026-08-14T01:03:05.2860396Z persist-credentials: true2026-08-14T01:03:05.2861343Z clean: true2026-08-14T01:03:05.2862205Z sparse-checkout-cone-mode: true2026-08-14T01:03:05.2863354Z fetch-depth: 12026-08-14T01:03:05.2864199Z fetch-tags: false2026-08-14T01:03:05.2865067Z show-progress: true2026-08-14T01:03:05.2865945Z lfs: false2026-08-14T01:03:05.2866757Z submodules: false2026-08-14T01:03:05.2867641Z set-safe-directory: true2026-08-14T01:03:05.2868619Z allow-unsafe-pr-checkout: false2026-08-14T01:03:05.2869839Z ##[endgroup]2026-08-14T01:03:05.3970078Z Syncing repository: mwestphall/k8s-integration-tests2026-08-14T01:03:05.3974211Z ##[group]Getting Git version info2026-08-14T01:03:05.3976786Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-14T01:03:05.3980284Z [command]/usr/bin/git version2026-08-14T01:03:05.5144111Z git version 2.54.02026-08-14T01:03:05.5165518Z ##[endgroup]2026-08-14T01:03:05.5180801Z Temporarily overriding HOME='/home/runner/work/_temp/87fb771f-4113-4f44-85bf-2652427cb3b7' before making global git config changes2026-08-14T01:03:05.5186701Z Adding repository directory to the temporary git global config as a safe directory2026-08-14T01:03:05.5189173Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-14T01:03:05.5231019Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-14T01:03:05.5235210Z ##[group]Initializing the repository2026-08-14T01:03:05.5240134Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-14T01:03:05.5752032Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-14T01:03:05.5754674Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-14T01:03:05.5756943Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-14T01:03:05.5758392Z hint: call:2026-08-14T01:03:05.5759144Z hint:2026-08-14T01:03:05.5760115Z hint: git config --global init.defaultBranch <name>2026-08-14T01:03:05.5761592Z hint:2026-08-14T01:03:05.5763359Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-14T01:03:05.5765337Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-14T01:03:05.5766740Z hint:2026-08-14T01:03:05.5767508Z hint: git branch -m <name>2026-08-14T01:03:05.5768395Z hint:2026-08-14T01:03:05.5769560Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-14T01:03:05.5771715Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-14T01:03:05.5775668Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-14T01:03:05.5852909Z ##[endgroup]2026-08-14T01:03:05.5854470Z ##[group]Disabling automatic garbage collection2026-08-14T01:03:05.5856105Z [command]/usr/bin/git config --local gc.auto 02026-08-14T01:03:05.5893985Z ##[endgroup]2026-08-14T01:03:05.5895309Z ##[group]Setting up auth2026-08-14T01:03:05.5900175Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-14T01:03:05.5938879Z [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:05.7820372Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-14T01:03:05.7865470Z [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:05.8134731Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-14T01:03:05.8176730Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-14T01:03:05.8455779Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-14T01:03:05.8497720Z ##[endgroup]2026-08-14T01:03:05.8498565Z ##[group]Fetching the repository2026-08-14T01:03:05.8506640Z [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:06.3480903Z From https://github.com/mwestphall/k8s-integration-tests2026-08-14T01:03:06.3481542Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-14T01:03:06.3516815Z ##[endgroup]2026-08-14T01:03:06.3517528Z ##[group]Determining the checkout info2026-08-14T01:03:06.3520157Z ##[endgroup]2026-08-14T01:03:06.3528744Z [command]/usr/bin/git sparse-checkout disable2026-08-14T01:03:06.3627891Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-14T01:03:06.3665826Z ##[group]Checking out the ref2026-08-14T01:03:06.3671107Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-14T01:03:06.3815697Z Switched to a new branch 'main'2026-08-14T01:03:06.3818202Z branch 'main' set up to track 'origin/main'.2026-08-14T01:03:06.3824394Z ##[endgroup]2026-08-14T01:03:06.3910323Z [command]/usr/bin/git log -1 --format=%H2026-08-14T01:03:06.3942173Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-14T01:03:06.4264551Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-14T01:03:06.4265316Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-14T01:03:06.4265897Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-14T01:03:06.4795840Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-14T01:03:06.4796290Z env:2026-08-14T01:03:06.4796736Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-14T01:03:06.4797234Z SETUP_ENV_YAML: {}2026-08-14T01:03:06.4797458Z ##[endgroup]2026-08-14T01:03:07.0545838Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-14T01:03:07.0546505Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-14T01:03:07.0607473Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-14T01:03:07.0607840Z env:2026-08-14T01:03:07.0608307Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-14T01:03:07.0608833Z ##[endgroup]2026-08-14T01:03:07.0757695Z ##[group]Run true2026-08-14T01:03:07.0757967Z [36;1mtrue[0m2026-08-14T01:03:07.0820546Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-14T01:03:07.0820947Z ##[endgroup]2026-08-14T01:03:07.0989171Z ##[group]Run medyagh/setup-minikube@latest2026-08-14T01:03:07.0989493Z with:2026-08-14T01:03:07.0989689Z start: true2026-08-14T01:03:07.0989883Z cache: true2026-08-14T01:03:07.0990091Z minikube-version: latest2026-08-14T01:03:07.0990329Z wait: all2026-08-14T01:03:07.0990526Z ##[endgroup]2026-08-14T01:03:07.2340742Z (node:2155) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-14T01:03:07.2341538Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-14T01:03:08.2728191Z [command]/usr/bin/chmod +x /home/runner/work/_temp/8513d3cc-c706-465e-857f-afd059e883c82026-08-14T01:03:08.4327768Z [command]/home/runner/bin/minikube version --short2026-08-14T01:03:08.4760595Z v1.38.12026-08-14T01:03:08.6246267Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-14T01:03:08.6346310Z (node:2155) [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:08.6451823Z Cache hit for: kic-v1.38.1-x642026-08-14T01:03:09.7731288Z Received 100663296 of 544082657 (18.5%), 96.0 MBs/sec2026-08-14T01:03:09.7932292Z Received 92274688 of 224218863 (41.2%), 87.9 MBs/sec2026-08-14T01:03:10.7747370Z Received 218103808 of 544082657 (40.1%), 103.9 MBs/sec2026-08-14T01:03:10.7928638Z Received 201326592 of 224218863 (89.8%), 96.0 MBs/sec2026-08-14T01:03:10.9347927Z Received 224218863 of 224218863 (100.0%), 99.8 MBs/sec2026-08-14T01:03:10.9349014Z Cache Size: ~214 MB (224218863 B)2026-08-14T01:03:10.9943361Z [command]/usr/bin/tar -xf /home/runner/work/_temp/7d564edc-aeae-47de-8c95-4efc1c3cd520/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-14T01:03:11.6098913Z Cache restored successfully2026-08-14T01:03:11.7754861Z Received 385875968 of 544082657 (70.9%), 122.5 MBs/sec2026-08-14T01:03:12.8664116Z Received 536870912 of 544082657 (98.7%), 125.1 MBs/sec2026-08-14T01:03:13.0715581Z Received 544082657 of 544082657 (100.0%), 120.7 MBs/sec2026-08-14T01:03:13.0719131Z Cache Size: ~519 MB (544082657 B)2026-08-14T01:03:13.0874403Z [command]/usr/bin/tar -xf /home/runner/work/_temp/237529d8-de7c-42a1-b548-465f459f4a1c/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-14T01:03:14.0478125Z Cache restored successfully2026-08-14T01:03:14.1780409Z [command]/home/runner/bin/minikube start --wait all2026-08-14T01:03:14.2246021Z * minikube v1.38.1 on Ubuntu 22.042026-08-14T01:03:17.9088859Z ! 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:17.9094611Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-14T01:03:17.9774773Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-14T01:03:17.9781276Z * Using Docker driver with root privileges2026-08-14T01:03:17.9791993Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-14T01:03:17.9798133Z * Pulling base image v0.0.50 ...2026-08-14T01:03:49.8847941Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-14T01:03:55.0380115Z * Verifying Kubernetes components...2026-08-14T01:03:55.0656253Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-14T01:03:55.6857352Z * Enabled addons: storage-provisioner, default-storageclass2026-08-14T01:04:37.8302188Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-14T01:04:37.8406868Z [command]/home/runner/bin/minikube version --short2026-08-14T01:04:37.8797126Z v1.38.12026-08-14T01:04:37.9121221Z ##[group]Run actions/setup-go@v62026-08-14T01:04:37.9121527Z with:2026-08-14T01:04:37.9121729Z go-version: 1.262026-08-14T01:04:37.9121941Z cache: true2026-08-14T01:04:37.9122170Z cache-dependency-path: go.sum2026-08-14T01:04:37.9122433Z check-latest: false2026-08-14T01:04:37.9125785Z token: ***2026-08-14T01:04:37.9126004Z ##[endgroup]2026-08-14T01:04:38.0480665Z Setup go version spec 1.262026-08-14T01:04:38.0839359Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-14T01:04:38.0839928Z Added go to the path2026-08-14T01:04:38.0840305Z Successfully set up Go version 1.262026-08-14T01:04:38.6980980Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-14T01:04:38.7021055Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-14T01:04:38.7051927Z /home/runner/go/pkg/mod2026-08-14T01:04:38.7077284Z /home/runner/.cache/go-build2026-08-14T01:04:38.8557389Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-14T01:04:40.0329907Z Received 100663296 of 251839808 (40.0%), 96.0 MBs/sec2026-08-14T01:04:40.9845873Z Received 251839808 of 251839808 (100.0%), 123.0 MBs/sec2026-08-14T01:04:40.9847479Z Cache Size: ~240 MB (251839808 B)2026-08-14T01:04:40.9917000Z [command]/usr/bin/tar -xf /home/runner/work/_temp/0a9a0d10-2568-4063-b20c-e61db05655c6/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-14T01:04:44.0343308Z Cache restored successfully2026-08-14T01:04:44.0924603Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-14T01:04:44.0952511Z go version go1.26.5 linux/amd642026-08-14T01:04:44.0953007Z 2026-08-14T01:04:44.0953347Z ##[group]go env2026-08-14T01:04:44.1716434Z AR='ar'2026-08-14T01:04:44.1716815Z CC='gcc'2026-08-14T01:04:44.1717545Z CGO_CFLAGS='-O2 -g'2026-08-14T01:04:44.1718103Z CGO_CPPFLAGS=''2026-08-14T01:04:44.1718361Z CGO_CXXFLAGS='-O2 -g'2026-08-14T01:04:44.1719054Z CGO_ENABLED='1'2026-08-14T01:04:44.1719276Z CGO_FFLAGS='-O2 -g'2026-08-14T01:04:44.1719504Z CGO_LDFLAGS='-O2 -g'2026-08-14T01:04:44.1719745Z CXX='g++'2026-08-14T01:04:44.1719966Z GCCGO='gccgo'2026-08-14T01:04:44.1741217Z GO111MODULE=''2026-08-14T01:04:44.1741615Z GOAMD64='v1'2026-08-14T01:04:44.1741933Z GOARCH='amd64'2026-08-14T01:04:44.1742250Z GOAUTH='netrc'2026-08-14T01:04:44.1742741Z GOBIN=''2026-08-14T01:04:44.1743097Z GOCACHE='/home/runner/.cache/go-build'2026-08-14T01:04:44.1743517Z GOCACHEPROG=''2026-08-14T01:04:44.1743747Z GODEBUG=''2026-08-14T01:04:44.1743983Z GOENV='/home/runner/.config/go/env'2026-08-14T01:04:44.1744256Z GOEXE=''2026-08-14T01:04:44.1744472Z GOEXPERIMENT=''2026-08-14T01:04:44.1744691Z GOFIPS140='off'2026-08-14T01:04:44.1744911Z GOFLAGS=''2026-08-14T01:04:44.1745621Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build2991633759=/tmp/go-build -gno-record-gcc-switches'2026-08-14T01:04:44.1746305Z GOHOSTARCH='amd64'2026-08-14T01:04:44.1746542Z GOHOSTOS='linux'2026-08-14T01:04:44.1746762Z GOINSECURE=''2026-08-14T01:04:44.1747142Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-14T01:04:44.1747574Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-14T01:04:44.1747866Z GONOPROXY=''2026-08-14T01:04:44.1748076Z GONOSUMDB=''2026-08-14T01:04:44.1748279Z GOOS='linux'2026-08-14T01:04:44.1748499Z GOPATH='/home/runner/go'2026-08-14T01:04:44.1748742Z GOPRIVATE=''2026-08-14T01:04:44.1749028Z GOPROXY='https://proxy.golang.org,direct'2026-08-14T01:04:44.1749381Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-14T01:04:44.1749697Z GOSUMDB='sum.golang.org'2026-08-14T01:04:44.1749943Z GOTELEMETRY='local'2026-08-14T01:04:44.1750242Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-14T01:04:44.1750566Z GOTMPDIR=''2026-08-14T01:04:44.1750781Z GOTOOLCHAIN='local'2026-08-14T01:04:44.1751453Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-14T01:04:44.1751828Z GOVCS=''2026-08-14T01:04:44.1752042Z GOVERSION='go1.26.5'2026-08-14T01:04:44.1752274Z GOWORK=''2026-08-14T01:04:44.1752503Z PKG_CONFIG='pkg-config'2026-08-14T01:04:44.1752970Z 2026-08-14T01:04:44.1753360Z ##[endgroup]2026-08-14T01:04:44.1937915Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-14T01:04:44.1938428Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-14T01:04:44.2003233Z shell: /usr/bin/bash -e {0}2026-08-14T01:04:44.2003608Z env:2026-08-14T01:04:44.2003923Z GOTOOLCHAIN: local2026-08-14T01:04:44.2004279Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-08-14T01:04:44.2004713Z OSPOOL_EP_CMTag: 25.x-el92026-08-14T01:04:44.2005070Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-14T01:04:44.2005486Z ##[endgroup]2026-08-14T01:04:50.8756683Z === RUN TestOSPoolEP2026-08-14T01:04:50.8759393Z === PAUSE TestOSPoolEP2026-08-14T01:04:50.8759820Z === CONT TestOSPoolEP2026-08-14T01:04:50.8760861Z TestOSPoolEP 2026-08-14T01:04:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:04:51.1242350Z TestOSPoolEP 2026-08-14T01:04:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs apply -f /tmp/TestOSPoolEP3011572851]2026-08-14T01:04:51.5712274Z TestOSPoolEP 2026-08-14T01:04:51Z logger.go:67: pod/idtoken-generator created2026-08-14T01:04:51.5792259Z TestOSPoolEP 2026-08-14T01:04:51Z logger.go:67: secret/pool-passwd created2026-08-14T01:04:51.5852140Z TestOSPoolEP 2026-08-14T01:04:51Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-14T01:04:51.5853621Z TestOSPoolEP 2026-08-14T01:04:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:04:51.5875434Z TestOSPoolEP 2026-08-14T01:04:51Z 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:01.5883915Z TestOSPoolEP 2026-08-14T01:05:01Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-14T01:05:01.5887260Z TestOSPoolEP 2026-08-14T01:05:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:01.5912806Z TestOSPoolEP 2026-08-14T01:05:01Z 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:11.5919046Z TestOSPoolEP 2026-08-14T01:05:11Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-14T01:05:11.5919930Z TestOSPoolEP 2026-08-14T01:05:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:11.5945774Z TestOSPoolEP 2026-08-14T01:05:11Z logger.go:67: Pod is now available2026-08-14T01:05:11.5947611Z TestOSPoolEP 2026-08-14T01:05:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-14T01:05:12.0559641Z TestOSPoolEP 2026-08-14T01:05:12Z logger.go:67: ***2026-08-14T01:05:12.0624044Z TestOSPoolEP 2026-08-14T01:05:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs apply -f /tmp/TestOSPoolEP4172199492]2026-08-14T01:05:12.2435095Z TestOSPoolEP 2026-08-14T01:05:12Z logger.go:67: secret/pool-token created2026-08-14T01:05:12.2468290Z TestOSPoolEP 2026-08-14T01:05:12Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-14T01:05:12.2469426Z TestOSPoolEP 2026-08-14T01:05:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:12.2488164Z TestOSPoolEP 2026-08-14T01:05:12Z logger.go:67: Secret is now available2026-08-14T01:05:12.2506024Z TestOSPoolEP 2026-08-14T01:05:12Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs apply -k /tmp/kustomize-template-2961008726]2026-08-14T01:05:12.5193993Z TestOSPoolEP 2026-08-14T01:05:12Z logger.go:67: service/test-cm created2026-08-14T01:05:12.5276248Z TestOSPoolEP 2026-08-14T01:05:12Z 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-14T01:05:12.5282031Z TestOSPoolEP 2026-08-14T01:05:12Z logger.go:67: deployment.apps/ospool-ep created2026-08-14T01:05:12.5354479Z TestOSPoolEP 2026-08-14T01:05:12Z logger.go:67: deployment.apps/test-cm created2026-08-14T01:05:12.5438813Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-14T01:05:12.5443360Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:12.5497601Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:12Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-14T01:05:12.5508003Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:12.5509759Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:12Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-14T01:05:12.5513722Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:12Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:12.5565332Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:12Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available, missing 'Progressing' condition. Sleeping for 10s and will try again.2026-08-14T01:05:12.5601143Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:12Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-65c844ddbb". Sleeping for 10s and will try again.2026-08-14T01:05:22.5592385Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:22Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-14T01:05:22.5594509Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:22.5600788Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:22Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-14T01:05:22.5611484Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:22.5640362Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:22Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-65c844ddbb" is progressing.. Sleeping for 10s and will try again.2026-08-14T01:05:22.5689759Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:22Z logger.go:67: Deployment is now available2026-08-14T01:05:32.5646481Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:32Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-14T01:05:32.5648123Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:32.5678117Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-14T01:05:32Z logger.go:67: Deployment is now available2026-08-14T01:05:32.5679310Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-14T01:05:32.5680286Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-14T01:05:32.5681854Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-14T01:05:32.5683055Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-14T01:05:32.5684297Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-14T01:05:32.5685310Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-14T01:05:32.5686163Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-14T01:05:32.5686983Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-14T01:05:32.5688472Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:05:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:32.5690736Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:05:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:32.5692449Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-14T01:05:32.5694719Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-14T01:05:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:32.5718358Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:05:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:32.5722417Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:05:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:32.5742883Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-14T01:05:32Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:05:32.5761652Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-14T01:05:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_SINGULARITY]2026-08-14T01:05:32.5801627Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:05:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:05:32.5823192Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:05:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)']2026-08-14T01:05:32.8557560Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-m4dns failed. Retrying in 10s.2026-08-14T01:05:32.8560362Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-14T01:05:32.8565384Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-m4dns failed. Retrying in 30s.2026-08-14T01:05:32.8595747Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-14T01:05:32.8597478Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)']' in pod test-cm-5bb545475c-m4dns failed. Retrying in 10s.2026-08-14T01:05:42.8569848Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-14T01:05:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_SINGULARITY]2026-08-14T01:05:42.8603286Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:05:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)']2026-08-14T01:05:43.0439663Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)']' in pod test-cm-5bb545475c-m4dns failed. Retrying in 10s.2026-08-14T01:05:43.0441093Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-14T01:05:43.0442150Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-m4dns failed. Retrying in 10s.2026-08-14T01:05:53.0460242Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:05:53Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)']2026-08-14T01:05:53.0463000Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-14T01:05:53Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_SINGULARITY]2026-08-14T01:05:53.2252793Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:05:53Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-14T01:05:53.2254118Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:05:53Z logger.go:67: 2026-08-14T01:05:53.2255239Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:05:53Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-65c844ddbb-xw6kp LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-08-14T01:05:53.2257272Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:05:53Z logger.go:67: 2026-08-14T01:05:53.2258580Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:05:53Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-14T01:05:53.2259864Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:05:53Z logger.go:67: 2026-08-14T01:05:53.2261070Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:05:53Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-14T01:05:53.2262160Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:05:53Z logger.go:67: 2026-08-14T01:05:53.2263595Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-14T01:05:53Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-14T01:05:53.2269675Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-14T01:05:53Z logger.go:67: true2026-08-14T01:06:02.8571432Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:06:02Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:06:03.0001512Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:06:02Z logger.go:67: undefined2026-08-14T01:06:03.0059556Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-14T01:06:03.0061074Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-m4dns failed. Retrying in 30s.2026-08-14T01:06:33.0062358Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:06:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:06:33.1593906Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:06:33Z logger.go:67: undefined2026-08-14T01:06:33.1673255Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-m4dns failed. Retrying in 30s.2026-08-14T01:07:03.1678216Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:07:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:07:03.3152445Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:07:03Z logger.go:67: undefined2026-08-14T01:07:03.3215472Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-m4dns failed. Retrying in 30s.2026-08-14T01:07:33.3220610Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:07:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:07:33.4698610Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:07:33Z logger.go:67: undefined2026-08-14T01:07:33.4758411Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-m4dns failed. Retrying in 30s.2026-08-14T01:08:03.4760364Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:08:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:08:03.6259893Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:08:03Z logger.go:67: undefined2026-08-14T01:08:03.6320334Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-m4dns failed. Retrying in 30s.2026-08-14T01:08:33.6346346Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:08:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:08:33.7808492Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:08:33Z logger.go:67: undefined2026-08-14T01:08:33.7867434Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-m4dns failed. Retrying in 30s.2026-08-14T01:09:03.7871856Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:09:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:09:03.9329243Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:09:03Z logger.go:67: undefined2026-08-14T01:09:03.9387789Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-m4dns failed. Retrying in 30s.2026-08-14T01:09:33.9393291Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:09:33Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:09:34.0861900Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:09:34Z logger.go:67: undefined2026-08-14T01:09:34.0918748Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-m4dns failed. Retrying in 30s.2026-08-14T01:10:04.0921870Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:10:04Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:10:04.2416525Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:10:04Z logger.go:67: undefined2026-08-14T01:10:04.2471651Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-m4dns failed. Retrying in 30s.2026-08-14T01:10:34.2497042Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:10:34Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:10:34.3999488Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:10:34Z logger.go:67: undefined2026-08-14T01:10:34.4061581Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-m4dns failed. Retrying in 30s.2026-08-14T01:11:04.4075511Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:11:04Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs exec test-cm-5bb545475c-m4dns -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-xw6kp",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-14T01:11:04.5750726Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-14T01:11:04Z logger.go:67: true2026-08-14T01:11:04.5835796Z TestOSPoolEP 2026-08-14T01:11:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:04.5927787Z TestOSPoolEP 2026-08-14T01:11:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:04.7484032Z TestOSPoolEP 2026-08-14T01:11:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:04.8728862Z TestOSPoolEP 2026-08-14T01:11:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:04.9886556Z TestOSPoolEP 2026-08-14T01:11:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:04.9918913Z === NAME TestOSPoolEP2026-08-14T01:11:04.9919324Z ospool_ep_test.go:101: ---2026-08-14T01:11:04.9919847Z Events for pod idtoken-generator:2026-08-14T01:11:04.9920812Z 2026-08-14 01:04:51 +0000 UTC Normal Successfully assigned test-ospool-ep-p1jxzs/idtoken-generator to minikube2026-08-14T01:11:04.9921683Z 2026-08-14 01:04:52 +0000 UTC Normal Pulling image "htcondor/base"2026-08-14T01:11:04.9923154Z 2026-08-14 01:05:00 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.246s (8.246s including waiting). Image size: 560910730 bytes.2026-08-14T01:11:04.9924253Z 2026-08-14 01:05:00 +0000 UTC Normal Container created2026-08-14T01:11:04.9924995Z 2026-08-14 01:05:00 +0000 UTC Normal Container started2026-08-14T01:11:04.9925540Z 2026-08-14T01:11:04.9925838Z ---2026-08-14T01:11:04.9930035Z TestOSPoolEP 2026-08-14T01:11:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:04.9945091Z ospool_ep_test.go:101: ---2026-08-14T01:11:04.9945689Z Events for pod ospool-ep-65c844ddbb-xw6kp:2026-08-14T01:11:04.9946643Z 2026-08-14 01:05:12 +0000 UTC Normal Successfully assigned test-ospool-ep-p1jxzs/ospool-ep-65c844ddbb-xw6kp to minikube2026-08-14T01:11:04.9947664Z 2026-08-14 01:05:13 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-14T01:11:04.9949063Z 2026-08-14 01:05:14 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.511s (1.511s including waiting). Image size: 5590942 bytes.2026-08-14T01:11:04.9950006Z 2026-08-14 01:05:14 +0000 UTC Normal Container created2026-08-14T01:11:04.9950688Z 2026-08-14 01:05:14 +0000 UTC Normal Container started2026-08-14T01:11:04.9951893Z 2026-08-14 01:05:14 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-08-14T01:11:04.9954254Z 2026-08-14 01:05:29 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 14.722s (15.247s including waiting). Image size: 1273054585 bytes.2026-08-14T01:11:04.9955737Z 2026-08-14 01:05:29 +0000 UTC Normal Container created2026-08-14T01:11:04.9956494Z 2026-08-14 01:05:30 +0000 UTC Normal Container started2026-08-14T01:11:04.9956996Z 2026-08-14T01:11:04.9957330Z ---2026-08-14T01:11:04.9958227Z TestOSPoolEP 2026-08-14T01:11:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:04.9973499Z ospool_ep_test.go:101: ---2026-08-14T01:11:04.9974262Z Events for pod test-cm-5bb545475c-m4dns:2026-08-14T01:11:04.9976074Z 2026-08-14 01:05:12 +0000 UTC Normal Successfully assigned test-ospool-ep-p1jxzs/test-cm-5bb545475c-m4dns to minikube2026-08-14T01:11:04.9977224Z 2026-08-14 01:05:13 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-08-14T01:11:04.9978800Z 2026-08-14 01:05:15 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 689ms (2.183s including waiting). Image size: 560910756 bytes.2026-08-14T01:11:04.9980208Z 2026-08-14 01:05:15 +0000 UTC Normal Container created2026-08-14T01:11:04.9980978Z 2026-08-14 01:05:15 +0000 UTC Normal Container started2026-08-14T01:11:04.9981502Z 2026-08-14T01:11:04.9986152Z ---2026-08-14T01:11:04.9986825Z TestOSPoolEP 2026-08-14T01:11:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-14T01:11:05.0010230Z TestOSPoolEP 2026-08-14T01:11:05Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs delete -f /tmp/TestOSPoolEP2058751477]2026-08-14T01:11:05.1000428Z TestOSPoolEP 2026-08-14T01:11:05Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-p1jxzs namespace2026-08-14T01:11:05.1074533Z TestOSPoolEP 2026-08-14T01:11:05Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-p1jxzs namespace2026-08-14T01:11:06.7863778Z TestOSPoolEP 2026-08-14T01:11:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs delete -f /tmp/TestOSPoolEP3045276836]2026-08-14T01:11:06.8730009Z TestOSPoolEP 2026-08-14T01:11:06Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-p1jxzs namespace2026-08-14T01:11:06.8772548Z TestOSPoolEP 2026-08-14T01:11:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-p1jxzs delete -k /tmp/kustomize-template-2961008726]2026-08-14T01:11:06.9865141Z TestOSPoolEP 2026-08-14T01:11:06Z logger.go:67: service "test-cm" deleted from test-ospool-ep-p1jxzs namespace2026-08-14T01:11:06.9909708Z TestOSPoolEP 2026-08-14T01:11:06Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-p1jxzs namespace2026-08-14T01:11:06.9940482Z TestOSPoolEP 2026-08-14T01:11:06Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-p1jxzs namespace2026-08-14T01:11:07.0035504Z --- PASS: TestOSPoolEP (44.11s)2026-08-14T01:11:07.0036474Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (20.03s)2026-08-14T01:11:07.0037331Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.66s)2026-08-14T01:11:07.0038293Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.66s)2026-08-14T01:11:07.0039231Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (332.01s)2026-08-14T01:11:07.0039807Z PASS2026-08-14T01:11:07.0094728Z ok github.com/osg-htc/k8s-integration-tests/test 376.143s2026-08-14T01:11:07.1173844Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-14T01:11:07.1174482Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-14T01:11:07.1236967Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-14T01:11:07.1237327Z env:2026-08-14T01:11:07.1237557Z GOTOOLCHAIN: local2026-08-14T01:11:07.1238014Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-14T01:11:07.1238485Z ##[endgroup]2026-08-14T01:11:07.1492974Z 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:11:07.1495102Z ##[group]Run actions/upload-artifact@v42026-08-14T01:11:07.1495606Z with:2026-08-14T01:11:07.1496259Z name: TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe52026-08-14T01:11:07.1497350Z path: /tmp/k8s-tests2026-08-14T01:11:07.1498006Z retention-days: 52026-08-14T01:11:07.1498413Z if-no-files-found: warn2026-08-14T01:11:07.1499372Z compression-level: 62026-08-14T01:11:07.1499923Z overwrite: false2026-08-14T01:11:07.1500645Z include-hidden-files: false2026-08-14T01:11:07.1501253Z env:2026-08-14T01:11:07.1501952Z GOTOOLCHAIN: local2026-08-14T01:11:07.1502539Z ##[endgroup]2026-08-14T01:11:07.3675519Z (node:18296) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-14T01:11:07.3676943Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-14T01:11:07.3828279Z With the provided path, there will be 6 files uploaded2026-08-14T01:11:07.3834565Z Artifact name is valid!2026-08-14T01:11:07.3885346Z Root directory input is valid!2026-08-14T01:11:07.5820015Z Beginning upload of artifact content to blob storage2026-08-14T01:11:07.6110410Z (node:18296) [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:11:07.7816085Z Uploaded bytes 139872026-08-14T01:11:07.8278320Z Finished uploading artifact content to blob storage!2026-08-14T01:11:07.8279441Z SHA256 digest of uploaded artifact zip is c558cf486fe4a9c7b98f6cc27e91d445bf2510aa7fe37c03cfb497b439cdb8472026-08-14T01:11:07.8280329Z Finalizing artifact upload2026-08-14T01:11:07.9842477Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5.zip successfully finalized. Artifact ID 92041485032026-08-14T01:11:07.9844910Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5 has been successfully uploaded! Final size is 13987 bytes. Artifact ID is 92041485032026-08-14T01:11:07.9850495Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/31759369059/artifacts/92041485032026-08-14T01:11:08.0045356Z Post job cleanup.2026-08-14T01:11:08.1555767Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-14T01:11:08.1651348Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-14T01:11:08.1704310Z /home/runner/go/pkg/mod2026-08-14T01:11:08.1724130Z /home/runner/.cache/go-build2026-08-14T01:11:08.1734552Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-14T01:11:08.1923415Z Post job cleanup.2026-08-14T01:11:08.2879181Z [command]/usr/bin/git version2026-08-14T01:11:08.2924552Z git version 2.54.02026-08-14T01:11:08.2963324Z Temporarily overriding HOME='/home/runner/work/_temp/4892ff75-2aef-492f-86fe-049c089a82b1' before making global git config changes2026-08-14T01:11:08.2964655Z Adding repository directory to the temporary git global config as a safe directory2026-08-14T01:11:08.2969879Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-14T01:11:08.3019753Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-14T01:11:08.3065591Z [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:11:08.3420887Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-14T01:11:08.3457250Z http.https://github.com/.extraheader2026-08-14T01:11:08.3470602Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-14T01:11:08.3513176Z [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:11:08.3880772Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-14T01:11:08.3924615Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-14T01:11:08.4389312Z Cleaning up orphan processes2026-08-14T01:11:08.5193722Z ##[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/