2026-08-10T00:56:42.6085044Z Current runner version: '2.336.0'2026-08-10T00:56:42.6110192Z ##[group]Runner Image Provisioner2026-08-10T00:56:42.6111144Z Hosted Compute Agent2026-08-10T00:56:42.6111752Z Version: 20260707.5632026-08-10T00:56:42.6112390Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-08-10T00:56:42.6113212Z Build Date: 2026-07-07T19:33:50Z2026-08-10T00:56:42.6114332Z Worker ID: {2109c4a5-ea2f-4b8c-bb4c-f0074244d978}2026-08-10T00:56:42.6115168Z Azure Region: northcentralus2026-08-10T00:56:42.6115825Z ##[endgroup]2026-08-10T00:56:42.6117337Z ##[group]Operating System2026-08-10T00:56:42.6118128Z Ubuntu2026-08-10T00:56:42.6118637Z 22.04.52026-08-10T00:56:42.6119131Z LTS2026-08-10T00:56:42.6119730Z ##[endgroup]2026-08-10T00:56:42.6120306Z ##[group]Runner Image2026-08-10T00:56:42.6121018Z Image: ubuntu-22.042026-08-10T00:56:42.6121621Z Version: 20260720.234.22026-08-10T00:56:42.6122881Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-08-10T00:56:42.6124864Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-08-10T00:56:42.6125894Z ##[endgroup]2026-08-10T00:56:42.6127172Z ##[group]GITHUB_TOKEN Permissions2026-08-10T00:56:42.6129126Z Contents: read2026-08-10T00:56:42.6129816Z Metadata: read2026-08-10T00:56:42.6130391Z Packages: read2026-08-10T00:56:42.6131421Z ##[endgroup]2026-08-10T00:56:42.6133478Z Secret source: Actions2026-08-10T00:56:42.6135161Z Prepare workflow directory2026-08-10T00:56:42.6476313Z Prepare all required actions2026-08-10T00:56:42.6527046Z Getting action download info2026-08-10T00:56:42.8642971Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-10T00:56:43.2387731Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-10T00:56:43.5099702Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-10T00:56:43.8336309Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-10T00:56:44.0986631Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-10T00:56:44.0993057Z ##[group] Inputs2026-08-10T00:56:44.0994533Z testName: TestOSPoolEP2026-08-10T00:56:44.0996582Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-10T00:56:44.0998446Z setupScript: 2026-08-10T00:56:44.0999252Z setupEnv: {}2026-08-10T00:56:44.1000041Z ##[endgroup]2026-08-10T00:56:44.1001528Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-08-10T00:56:44.1885151Z ##[group]Run actions/checkout@v52026-08-10T00:56:44.1886436Z with:2026-08-10T00:56:44.1887266Z repository: mwestphall/k8s-integration-tests2026-08-10T00:56:44.1896527Z token: ***2026-08-10T00:56:44.1897293Z ssh-strict: true2026-08-10T00:56:44.1898092Z ssh-user: git2026-08-10T00:56:44.1898861Z persist-credentials: true2026-08-10T00:56:44.1899878Z clean: true2026-08-10T00:56:44.1901231Z sparse-checkout-cone-mode: true2026-08-10T00:56:44.1902415Z fetch-depth: 12026-08-10T00:56:44.1903259Z fetch-tags: false2026-08-10T00:56:44.1904644Z show-progress: true2026-08-10T00:56:44.1905519Z lfs: false2026-08-10T00:56:44.1906420Z submodules: false2026-08-10T00:56:44.1907360Z set-safe-directory: true2026-08-10T00:56:44.1908422Z allow-unsafe-pr-checkout: false2026-08-10T00:56:44.1909804Z ##[endgroup]2026-08-10T00:56:44.2988784Z Syncing repository: mwestphall/k8s-integration-tests2026-08-10T00:56:44.2991450Z ##[group]Getting Git version info2026-08-10T00:56:44.2993071Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-10T00:56:44.2995558Z [command]/usr/bin/git version2026-08-10T00:56:44.3046875Z git version 2.54.02026-08-10T00:56:44.3105668Z ##[endgroup]2026-08-10T00:56:44.3122514Z Temporarily overriding HOME='/home/runner/work/_temp/497e9e2d-6c01-4f58-829f-40cbf120c392' before making global git config changes2026-08-10T00:56:44.3127144Z Adding repository directory to the temporary git global config as a safe directory2026-08-10T00:56:44.3131387Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-10T00:56:44.3169658Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-10T00:56:44.3177654Z ##[group]Initializing the repository2026-08-10T00:56:44.3183364Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-10T00:56:44.3290669Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-10T00:56:44.3294210Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-10T00:56:44.3297365Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-10T00:56:44.3299830Z hint: call:2026-08-10T00:56:44.3301128Z hint:2026-08-10T00:56:44.3302704Z hint: git config --global init.defaultBranch <name>2026-08-10T00:56:44.3304999Z hint:2026-08-10T00:56:44.3307177Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-10T00:56:44.3310376Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-10T00:56:44.3312932Z hint:2026-08-10T00:56:44.3314759Z hint: git branch -m <name>2026-08-10T00:56:44.3316339Z hint:2026-08-10T00:56:44.3318413Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-10T00:56:44.3322512Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-10T00:56:44.3329017Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-10T00:56:44.3358634Z ##[endgroup]2026-08-10T00:56:44.3361128Z ##[group]Disabling automatic garbage collection2026-08-10T00:56:44.3363473Z [command]/usr/bin/git config --local gc.auto 02026-08-10T00:56:44.3404571Z ##[endgroup]2026-08-10T00:56:44.3406241Z ##[group]Setting up auth2026-08-10T00:56:44.3412514Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-10T00:56:44.3449221Z [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-10T00:56:44.3892768Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-10T00:56:44.3943159Z [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-10T00:56:44.4189530Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-10T00:56:44.4226985Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-10T00:56:44.4475092Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-10T00:56:44.4515874Z ##[endgroup]2026-08-10T00:56:44.4517192Z ##[group]Fetching the repository2026-08-10T00:56:44.4526226Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-10T00:56:44.7676193Z From https://github.com/mwestphall/k8s-integration-tests2026-08-10T00:56:44.7678713Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-10T00:56:44.7710366Z ##[endgroup]2026-08-10T00:56:44.7712217Z ##[group]Determining the checkout info2026-08-10T00:56:44.7714890Z ##[endgroup]2026-08-10T00:56:44.7723267Z [command]/usr/bin/git sparse-checkout disable2026-08-10T00:56:44.7770705Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-10T00:56:44.7807299Z ##[group]Checking out the ref2026-08-10T00:56:44.7811261Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-10T00:56:44.7907697Z Switched to a new branch 'main'2026-08-10T00:56:44.7911225Z branch 'main' set up to track 'origin/main'.2026-08-10T00:56:44.7919707Z ##[endgroup]2026-08-10T00:56:44.7973101Z [command]/usr/bin/git log -1 --format=%H2026-08-10T00:56:44.8002918Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-10T00:56:44.8377727Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-10T00:56:44.8380071Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-10T00:56:44.8382245Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-10T00:56:44.8508406Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-10T00:56:44.8509732Z env:2026-08-10T00:56:44.8511309Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-10T00:56:44.8513178Z SETUP_ENV_YAML: {}2026-08-10T00:56:44.8514257Z ##[endgroup]2026-08-10T00:56:45.4502150Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-10T00:56:45.4503451Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-10T00:56:45.4565256Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-10T00:56:45.4566071Z env:2026-08-10T00:56:45.4567040Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-10T00:56:45.4568089Z ##[endgroup]2026-08-10T00:56:45.4730341Z ##[group]Run true2026-08-10T00:56:45.4731033Z [36;1mtrue[0m2026-08-10T00:56:45.4789556Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-10T00:56:45.4790398Z ##[endgroup]2026-08-10T00:56:45.5010281Z ##[group]Run medyagh/setup-minikube@latest2026-08-10T00:56:45.5011081Z with:2026-08-10T00:56:45.5011697Z start: true2026-08-10T00:56:45.5012319Z cache: true2026-08-10T00:56:45.5012958Z minikube-version: latest2026-08-10T00:56:45.5013984Z wait: all2026-08-10T00:56:45.5014643Z ##[endgroup]2026-08-10T00:56:45.6334869Z (node:2138) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-10T00:56:45.6337410Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-10T00:56:46.5435859Z [command]/usr/bin/chmod +x /home/runner/work/_temp/c54253af-6df5-4928-8888-21a6ca5647702026-08-10T00:56:46.7111193Z [command]/home/runner/bin/minikube version --short2026-08-10T00:56:46.7521229Z v1.38.12026-08-10T00:56:46.8610237Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-10T00:56:46.8732903Z (node:2138) [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-10T00:56:46.8793877Z Cache hit for: kic-v1.38.1-x642026-08-10T00:56:48.0001408Z Received 134217728 of 224218863 (59.9%), 122.6 MBs/sec2026-08-10T00:56:48.0008883Z Received 121634816 of 544082657 (22.4%), 113.4 MBs/sec2026-08-10T00:56:48.5502094Z Received 224218863 of 224218863 (100.0%), 134.1 MBs/sec2026-08-10T00:56:48.5504376Z Cache Size: ~214 MB (224218863 B)2026-08-10T00:56:48.6075490Z [command]/usr/bin/tar -xf /home/runner/work/_temp/b163a185-ca21-4cb0-ad34-f148e1984129/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-10T00:56:49.0007461Z Received 268435456 of 544082657 (49.3%), 126.5 MBs/sec2026-08-10T00:56:49.2559099Z Cache restored successfully2026-08-10T00:56:50.0018108Z Received 486539264 of 544082657 (89.4%), 153.4 MBs/sec2026-08-10T00:56:50.3612097Z Received 544082657 of 544082657 (100.0%), 153.4 MBs/sec2026-08-10T00:56:50.3613383Z Cache Size: ~519 MB (544082657 B)2026-08-10T00:56:50.3738735Z [command]/usr/bin/tar -xf /home/runner/work/_temp/774cdc2f-d219-45eb-8032-d8a07ba68256/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-10T00:56:51.2640282Z Cache restored successfully2026-08-10T00:56:51.3794496Z [command]/home/runner/bin/minikube start --wait all2026-08-10T00:56:51.4177866Z * minikube v1.38.1 on Ubuntu 22.042026-08-10T00:56:51.5663153Z ! 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-10T00:56:51.8578812Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-10T00:56:51.9158603Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-10T00:56:51.9171326Z * Using Docker driver with root privileges2026-08-10T00:56:51.9182684Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-10T00:56:51.9191589Z * Pulling base image v0.0.50 ...2026-08-10T00:57:24.0108025Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-10T00:57:29.2026762Z * Verifying Kubernetes components...2026-08-10T00:57:29.2276095Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-10T00:57:29.9805412Z * Enabled addons: storage-provisioner, default-storageclass2026-08-10T00:58:12.6722886Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-10T00:58:12.6853925Z [command]/home/runner/bin/minikube version --short2026-08-10T00:58:12.7267883Z v1.38.12026-08-10T00:58:12.7586800Z ##[group]Run actions/setup-go@v62026-08-10T00:58:12.7587100Z with:2026-08-10T00:58:12.7587298Z go-version: 1.262026-08-10T00:58:12.7587503Z cache: true2026-08-10T00:58:12.7587742Z cache-dependency-path: go.sum2026-08-10T00:58:12.7587995Z check-latest: false2026-08-10T00:58:12.7590585Z token: ***2026-08-10T00:58:12.7590793Z ##[endgroup]2026-08-10T00:58:12.9089582Z Setup go version spec 1.262026-08-10T00:58:12.9149043Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-10T00:58:12.9151890Z Added go to the path2026-08-10T00:58:12.9155695Z Successfully set up Go version 1.262026-08-10T00:58:13.5801627Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-10T00:58:13.5843844Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-10T00:58:13.5874766Z /home/runner/go/pkg/mod2026-08-10T00:58:13.5901299Z /home/runner/.cache/go-build2026-08-10T00:58:13.7019196Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-10T00:58:14.8675252Z Received 134217728 of 251839808 (53.3%), 123.2 MBs/sec2026-08-10T00:58:15.4857609Z Received 251839808 of 251839808 (100.0%), 144.8 MBs/sec2026-08-10T00:58:15.4859156Z Cache Size: ~240 MB (251839808 B)2026-08-10T00:58:15.4971262Z [command]/usr/bin/tar -xf /home/runner/work/_temp/391d8b61-c03c-443d-bb21-6cebf8ff36db/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-10T00:58:18.6857768Z Cache restored successfully2026-08-10T00:58:18.7483007Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-10T00:58:18.7509799Z go version go1.26.5 linux/amd642026-08-10T00:58:18.7510025Z 2026-08-10T00:58:18.7510343Z ##[group]go env2026-08-10T00:58:18.7763065Z AR='ar'2026-08-10T00:58:18.7763683Z CC='gcc'2026-08-10T00:58:18.7764105Z CGO_CFLAGS='-O2 -g'2026-08-10T00:58:18.7764562Z CGO_CPPFLAGS=''2026-08-10T00:58:18.7764964Z CGO_CXXFLAGS='-O2 -g'2026-08-10T00:58:18.7765392Z CGO_ENABLED='1'2026-08-10T00:58:18.7765759Z CGO_FFLAGS='-O2 -g'2026-08-10T00:58:18.7766117Z CGO_LDFLAGS='-O2 -g'2026-08-10T00:58:18.7766841Z CXX='g++'2026-08-10T00:58:18.7767206Z GCCGO='gccgo'2026-08-10T00:58:18.7767582Z GO111MODULE=''2026-08-10T00:58:18.7767945Z GOAMD64='v1'2026-08-10T00:58:18.7768323Z GOARCH='amd64'2026-08-10T00:58:18.7768674Z GOAUTH='netrc'2026-08-10T00:58:18.7769008Z GOBIN=''2026-08-10T00:58:18.7769383Z GOCACHE='/home/runner/.cache/go-build'2026-08-10T00:58:18.7789797Z GOCACHEPROG=''2026-08-10T00:58:18.7790353Z GODEBUG=''2026-08-10T00:58:18.7790753Z GOENV='/home/runner/.config/go/env'2026-08-10T00:58:18.7791243Z GOEXE=''2026-08-10T00:58:18.7791594Z GOEXPERIMENT=''2026-08-10T00:58:18.7791963Z GOFIPS140='off'2026-08-10T00:58:18.7792302Z GOFLAGS=''2026-08-10T00:58:18.7793842Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build1297580713=/tmp/go-build -gno-record-gcc-switches'2026-08-10T00:58:18.7794810Z GOHOSTARCH='amd64'2026-08-10T00:58:18.7795070Z GOHOSTOS='linux'2026-08-10T00:58:18.7795296Z GOINSECURE=''2026-08-10T00:58:18.7795716Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-10T00:58:18.7796214Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-10T00:58:18.7796502Z GONOPROXY=''2026-08-10T00:58:18.7796719Z GONOSUMDB=''2026-08-10T00:58:18.7796922Z GOOS='linux'2026-08-10T00:58:18.7797174Z GOPATH='/home/runner/go'2026-08-10T00:58:18.7797422Z GOPRIVATE=''2026-08-10T00:58:18.7797730Z GOPROXY='https://proxy.golang.org,direct'2026-08-10T00:58:18.7798127Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-10T00:58:18.7798467Z GOSUMDB='sum.golang.org'2026-08-10T00:58:18.7798737Z GOTELEMETRY='local'2026-08-10T00:58:18.7799036Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-10T00:58:18.7799382Z GOTMPDIR=''2026-08-10T00:58:18.7799596Z GOTOOLCHAIN='local'2026-08-10T00:58:18.7800220Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-10T00:58:18.7800699Z GOVCS=''2026-08-10T00:58:18.7801064Z GOVERSION='go1.26.5'2026-08-10T00:58:18.7801449Z GOWORK=''2026-08-10T00:58:18.7801688Z PKG_CONFIG='pkg-config'2026-08-10T00:58:18.7801849Z 2026-08-10T00:58:18.7802208Z ##[endgroup]2026-08-10T00:58:18.7978169Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-10T00:58:18.7978703Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-10T00:58:18.8045244Z shell: /usr/bin/bash -e {0}2026-08-10T00:58:18.8045512Z env:2026-08-10T00:58:18.8045718Z GOTOOLCHAIN: local2026-08-10T00:58:18.8045965Z OSPOOL_EP_OSPoolEPTag: 25-release2026-08-10T00:58:18.8046247Z OSPOOL_EP_CMTag: 25.0-el92026-08-10T00:58:18.8046501Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-10T00:58:18.8046755Z ##[endgroup]2026-08-10T00:58:25.5196540Z === RUN TestOSPoolEP2026-08-10T00:58:25.5197089Z === PAUSE TestOSPoolEP2026-08-10T00:58:25.5197472Z === CONT TestOSPoolEP2026-08-10T00:58:25.5198887Z TestOSPoolEP 2026-08-10T00:58:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:58:25.5288578Z TestOSPoolEP 2026-08-10T00:58:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e apply -f /tmp/TestOSPoolEP4140644623]2026-08-10T00:58:25.9718807Z TestOSPoolEP 2026-08-10T00:58:25Z logger.go:67: pod/idtoken-generator created2026-08-10T00:58:25.9798884Z TestOSPoolEP 2026-08-10T00:58:25Z logger.go:67: secret/pool-passwd created2026-08-10T00:58:25.9860781Z TestOSPoolEP 2026-08-10T00:58:25Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-10T00:58:25.9862314Z TestOSPoolEP 2026-08-10T00:58:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:58:25.9884689Z TestOSPoolEP 2026-08-10T00:58:25Z 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-10T00:58:35.9893308Z TestOSPoolEP 2026-08-10T00:58:35Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-10T00:58:35.9898754Z TestOSPoolEP 2026-08-10T00:58:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:58:35.9932828Z TestOSPoolEP 2026-08-10T00:58:35Z 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-10T00:58:45.9943916Z TestOSPoolEP 2026-08-10T00:58:45Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-10T00:58:45.9945343Z TestOSPoolEP 2026-08-10T00:58:45Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:58:45.9970492Z TestOSPoolEP 2026-08-10T00:58:45Z logger.go:67: Pod is now available2026-08-10T00:58:45.9972043Z TestOSPoolEP 2026-08-10T00:58:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-10T00:58:46.4538725Z TestOSPoolEP 2026-08-10T00:58:46Z logger.go:67: ***2026-08-10T00:58:46.4604579Z TestOSPoolEP 2026-08-10T00:58:46Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e apply -f /tmp/TestOSPoolEP2980849381]2026-08-10T00:58:46.6555091Z TestOSPoolEP 2026-08-10T00:58:46Z logger.go:67: secret/pool-token created2026-08-10T00:58:46.6594913Z TestOSPoolEP 2026-08-10T00:58:46Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-10T00:58:46.6596380Z TestOSPoolEP 2026-08-10T00:58:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:58:46.6609228Z TestOSPoolEP 2026-08-10T00:58:46Z logger.go:67: Secret is now available2026-08-10T00:58:46.6628231Z TestOSPoolEP 2026-08-10T00:58:46Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e apply -k /tmp/kustomize-template-3927558117]2026-08-10T00:58:46.9539005Z TestOSPoolEP 2026-08-10T00:58:46Z logger.go:67: service/test-cm created2026-08-10T00:58:46.9638777Z TestOSPoolEP 2026-08-10T00:58:46Z 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-10T00:58:46.9642125Z TestOSPoolEP 2026-08-10T00:58:46Z logger.go:67: deployment.apps/ospool-ep created2026-08-10T00:58:46.9740606Z TestOSPoolEP 2026-08-10T00:58:46Z logger.go:67: deployment.apps/test-cm created2026-08-10T00:58:46.9784964Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-10T00:58:46.9787037Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:58:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:58:46.9862282Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:58:46Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-10T00:58:46.9866734Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:58:46Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-10T00:58:46.9885257Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:58:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:58:46.9898452Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:58:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:58:46.9911302Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:58:46Z 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-10T00:58:46.9915779Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:58:46Z 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-10T00:58:56.9901221Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:58:56Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-10T00:58:56.9903217Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:58:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:58:56.9911635Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:58:56Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-10T00:58:56.9916449Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:58:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:58:56.9950097Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:58:56Z 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-10T00:58:56.9967171Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:58:56Z logger.go:67: Deployment is now available2026-08-10T00:59:06.9955760Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:59:06Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-10T00:59:06.9957643Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:59:06Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:59:07.0007043Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:59:06Z 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-10T00:59:16.9997128Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:59:16Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-10T00:59:17.0000097Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:59:16Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:59:17.0035043Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-10T00:59:17Z logger.go:67: Deployment is now available2026-08-10T00:59:17.0036162Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-10T00:59:17.0036906Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-10T00:59:17.0037695Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-10T00:59:17.0038539Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-10T00:59:17.0039418Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-10T00:59:17.0040005Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-10T00:59:17.0040648Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-10T00:59:17.0042121Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-10T00:59:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:59:17.0060665Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-10T00:59:17.0062850Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T00:59:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:59:17.0064997Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-10T00:59:17.0066852Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-10T00:59:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:59:17.0069918Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-10T00:59:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:59:17.0084653Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T00:59:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:59:17.0097698Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-10T00:59:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e exec test-cm-54b7d49f85-zwsnb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)']2026-08-10T00:59:17.0125177Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-10T00:59:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T00:59:17.0145753Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-10T00:59:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e exec test-cm-54b7d49f85-zwsnb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_SINGULARITY]2026-08-10T00:59:17.0166753Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T00:59:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e exec test-cm-54b7d49f85-zwsnb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-10T00:59:17.3055804Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-10T00:59:17.3057769Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)']' in pod test-cm-54b7d49f85-zwsnb failed. Retrying in 10s.2026-08-10T00:59:17.3128118Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-10T00:59:17.3132314Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-zwsnb failed. Retrying in 10s.2026-08-10T00:59:17.3223613Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-10T00:59:17.3227774Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zwsnb failed. Retrying in 30s.2026-08-10T00:59:27.3064646Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-10T00:59:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e exec test-cm-54b7d49f85-zwsnb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)']2026-08-10T00:59:27.3139227Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-10T00:59:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e exec test-cm-54b7d49f85-zwsnb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_SINGULARITY]2026-08-10T00:59:27.4906073Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-10T00:59:27Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-10T00:59:27.4907598Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-10T00:59:27Z logger.go:67: 2026-08-10T00:59:27.4909422Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-10T00:59:27Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-nb2x9 LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-08-10T00:59:27.4911495Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-10T00:59:27Z logger.go:67: 2026-08-10T00:59:27.4913168Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-10T00:59:27Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-10T00:59:27.4915464Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-10T00:59:27Z logger.go:67: 2026-08-10T00:59:27.4916874Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-10T00:59:27Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-10T00:59:27.4918192Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-10T00:59:27Z logger.go:67: 2026-08-10T00:59:27.4919562Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-10T00:59:27Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-10T00:59:27.5055458Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-10T00:59:27Z logger.go:67: true2026-08-10T00:59:47.3230380Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T00:59:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e exec test-cm-54b7d49f85-zwsnb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-10T00:59:47.4726539Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T00:59:47Z logger.go:67: undefined2026-08-10T00:59:47.4787699Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zwsnb failed. Retrying in 30s.2026-08-10T01:00:17.4800934Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:00:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e exec test-cm-54b7d49f85-zwsnb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-10T01:00:17.6290345Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:00:17Z logger.go:67: undefined2026-08-10T01:00:17.6346819Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zwsnb failed. Retrying in 30s.2026-08-10T01:00:47.6360261Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:00:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e exec test-cm-54b7d49f85-zwsnb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-10T01:00:47.7875948Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:00:47Z logger.go:67: undefined2026-08-10T01:00:47.7939765Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zwsnb failed. Retrying in 30s.2026-08-10T01:01:17.7944459Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:01:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e exec test-cm-54b7d49f85-zwsnb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-10T01:01:17.9425907Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:01:17Z logger.go:67: undefined2026-08-10T01:01:17.9484406Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zwsnb failed. Retrying in 30s.2026-08-10T01:01:47.9505882Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:01:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e exec test-cm-54b7d49f85-zwsnb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-10T01:01:48.1000740Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:01:48Z logger.go:67: undefined2026-08-10T01:01:48.1058718Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zwsnb failed. Retrying in 30s.2026-08-10T01:02:18.1071436Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:02:18Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e exec test-cm-54b7d49f85-zwsnb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-10T01:02:18.2564410Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:02:18Z logger.go:67: undefined2026-08-10T01:02:18.2629433Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zwsnb failed. Retrying in 30s.2026-08-10T01:02:48.2632509Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:02:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e exec test-cm-54b7d49f85-zwsnb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-10T01:02:48.4132377Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:02:48Z logger.go:67: undefined2026-08-10T01:02:48.4192786Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zwsnb failed. Retrying in 30s.2026-08-10T01:03:18.4197923Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:03:18Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e exec test-cm-54b7d49f85-zwsnb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-10T01:03:18.5728392Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:03:18Z logger.go:67: undefined2026-08-10T01:03:18.5778321Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zwsnb failed. Retrying in 30s.2026-08-10T01:03:48.5794776Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:03:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e exec test-cm-54b7d49f85-zwsnb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-10T01:03:48.7319420Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:03:48Z logger.go:67: undefined2026-08-10T01:03:48.7377277Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zwsnb failed. Retrying in 30s.2026-08-10T01:04:18.7402759Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:04:18Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e exec test-cm-54b7d49f85-zwsnb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-10T01:04:18.9341239Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:04:18Z logger.go:67: undefined2026-08-10T01:04:18.9405269Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-zwsnb failed. Retrying in 30s.2026-08-10T01:04:48.9410720Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:04:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e exec test-cm-54b7d49f85-zwsnb -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-nb2x9",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-10T01:04:49.0948519Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-10T01:04:49Z logger.go:67: true2026-08-10T01:04:49.1005692Z TestOSPoolEP 2026-08-10T01:04:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T01:04:49.1078440Z TestOSPoolEP 2026-08-10T01:04:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T01:04:49.2576739Z TestOSPoolEP 2026-08-10T01:04:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T01:04:49.3892864Z TestOSPoolEP 2026-08-10T01:04:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T01:04:49.5049840Z TestOSPoolEP 2026-08-10T01:04:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T01:04:49.5079764Z === NAME TestOSPoolEP2026-08-10T01:04:49.5080380Z ospool_ep_test.go:101: ---2026-08-10T01:04:49.5081015Z Events for pod idtoken-generator:2026-08-10T01:04:49.5082487Z 2026-08-10 00:58:25 +0000 UTC Normal Successfully assigned test-ospool-ep-m4dc1e/idtoken-generator to minikube2026-08-10T01:04:49.5084025Z 2026-08-10 00:58:27 +0000 UTC Normal Pulling image "htcondor/base"2026-08-10T01:04:49.5085040Z 2026-08-10 00:58:36 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.692s (8.692s including waiting). Image size: 560910730 bytes.2026-08-10T01:04:49.5086132Z 2026-08-10 00:58:36 +0000 UTC Normal Container created2026-08-10T01:04:49.5086783Z 2026-08-10 00:58:36 +0000 UTC Normal Container started2026-08-10T01:04:49.5087261Z 2026-08-10T01:04:49.5087543Z ---2026-08-10T01:04:49.5088113Z TestOSPoolEP 2026-08-10T01:04:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T01:04:49.5106640Z ospool_ep_test.go:101: ---2026-08-10T01:04:49.5107544Z Events for pod ospool-ep-6c7d796845-nb2x9:2026-08-10T01:04:49.5111589Z 2026-08-10 00:58:46 +0000 UTC Normal Successfully assigned test-ospool-ep-m4dc1e/ospool-ep-6c7d796845-nb2x9 to minikube2026-08-10T01:04:49.5113397Z 2026-08-10 00:58:47 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-10T01:04:49.5115175Z 2026-08-10 00:58:48 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 802ms (802ms including waiting). Image size: 5590942 bytes.2026-08-10T01:04:49.5116093Z 2026-08-10 00:58:48 +0000 UTC Normal Container created2026-08-10T01:04:49.5116781Z 2026-08-10 00:58:48 +0000 UTC Normal Container started2026-08-10T01:04:49.5117694Z 2026-08-10 00:58:49 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-08-10T01:04:49.5119509Z 2026-08-10 00:59:07 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 13.52s (18.515s including waiting). Image size: 1273000231 bytes.2026-08-10T01:04:49.5120799Z 2026-08-10 00:59:07 +0000 UTC Normal Container created2026-08-10T01:04:49.5121650Z 2026-08-10 00:59:07 +0000 UTC Normal Container started2026-08-10T01:04:49.5122219Z 2026-08-10T01:04:49.5122562Z ---2026-08-10T01:04:49.5123823Z TestOSPoolEP 2026-08-10T01:04:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T01:04:49.5132480Z ospool_ep_test.go:101: ---2026-08-10T01:04:49.5133695Z Events for pod test-cm-54b7d49f85-zwsnb:2026-08-10T01:04:49.5135493Z 2026-08-10 00:58:47 +0000 UTC Normal Successfully assigned test-ospool-ep-m4dc1e/test-cm-54b7d49f85-zwsnb to minikube2026-08-10T01:04:49.5136381Z 2026-08-10 00:58:47 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-08-10T01:04:49.5137559Z 2026-08-10 00:58:54 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 5.768s (6.56s including waiting). Image size: 573055668 bytes.2026-08-10T01:04:49.5139894Z 2026-08-10 00:58:54 +0000 UTC Normal Container created2026-08-10T01:04:49.5140615Z 2026-08-10 00:58:54 +0000 UTC Normal Container started2026-08-10T01:04:49.5140951Z 2026-08-10T01:04:49.5141316Z ---2026-08-10T01:04:49.5141946Z TestOSPoolEP 2026-08-10T01:04:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-10T01:04:49.5171729Z TestOSPoolEP 2026-08-10T01:04:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e delete -f /tmp/TestOSPoolEP1622062479]2026-08-10T01:04:49.6089248Z TestOSPoolEP 2026-08-10T01:04:49Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-m4dc1e namespace2026-08-10T01:04:49.6140558Z TestOSPoolEP 2026-08-10T01:04:49Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-m4dc1e namespace2026-08-10T01:04:51.2437733Z TestOSPoolEP 2026-08-10T01:04:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e delete -f /tmp/TestOSPoolEP4144295742]2026-08-10T01:04:51.3362299Z TestOSPoolEP 2026-08-10T01:04:51Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-m4dc1e namespace2026-08-10T01:04:51.3416514Z TestOSPoolEP 2026-08-10T01:04:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-m4dc1e delete -k /tmp/kustomize-template-3927558117]2026-08-10T01:04:51.4649429Z TestOSPoolEP 2026-08-10T01:04:51Z logger.go:67: service "test-cm" deleted from test-ospool-ep-m4dc1e namespace2026-08-10T01:04:51.4725345Z TestOSPoolEP 2026-08-10T01:04:51Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-m4dc1e namespace2026-08-10T01:04:51.4767198Z TestOSPoolEP 2026-08-10T01:04:51Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-m4dc1e namespace2026-08-10T01:04:51.4861952Z --- PASS: TestOSPoolEP (53.87s)2026-08-10T01:04:51.4863520Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.02s)2026-08-10T01:04:51.4865246Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (10.49s)2026-08-10T01:04:51.4867327Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (10.51s)2026-08-10T01:04:51.4868620Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (332.10s)2026-08-10T01:04:51.4869298Z PASS2026-08-10T01:04:51.4901203Z ok github.com/osg-htc/k8s-integration-tests/test 385.982s2026-08-10T01:04:51.6097761Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-10T01:04:51.6098428Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-10T01:04:51.6157733Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-10T01:04:51.6158355Z env:2026-08-10T01:04:51.6158619Z GOTOOLCHAIN: local2026-08-10T01:04:51.6159357Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-10T01:04:51.6160125Z ##[endgroup]2026-08-10T01:04:51.6351741Z 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-10T01:04:51.6354618Z ##[group]Run actions/upload-artifact@v42026-08-10T01:04:51.6355102Z with:2026-08-10T01:04:51.6355779Z name: TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce72322026-08-10T01:04:51.6356476Z path: /tmp/k8s-tests2026-08-10T01:04:51.6356721Z retention-days: 52026-08-10T01:04:51.6357023Z if-no-files-found: warn2026-08-10T01:04:51.6357434Z compression-level: 62026-08-10T01:04:51.6357683Z overwrite: false2026-08-10T01:04:51.6357904Z include-hidden-files: false2026-08-10T01:04:51.6358142Z env:2026-08-10T01:04:51.6358482Z GOTOOLCHAIN: local2026-08-10T01:04:51.6358872Z ##[endgroup]2026-08-10T01:04:51.9024697Z (node:18211) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-10T01:04:51.9030607Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-10T01:04:51.9189843Z With the provided path, there will be 6 files uploaded2026-08-10T01:04:51.9191717Z Artifact name is valid!2026-08-10T01:04:51.9193338Z Root directory input is valid!2026-08-10T01:04:52.1158029Z Beginning upload of artifact content to blob storage2026-08-10T01:04:52.1468191Z (node:18211) [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-10T01:04:52.2681988Z Uploaded bytes 141182026-08-10T01:04:52.3014839Z Finished uploading artifact content to blob storage!2026-08-10T01:04:52.3015976Z SHA256 digest of uploaded artifact zip is a8a51ca3d7d5775812854b3c9a5ae5c29673ea2a00a00e294c27d85d706f7c762026-08-10T01:04:52.3018747Z Finalizing artifact upload2026-08-10T01:04:52.4762174Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232.zip successfully finalized. Artifact ID 90473786222026-08-10T01:04:52.4764825Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232 has been successfully uploaded! Final size is 14118 bytes. Artifact ID is 90473786222026-08-10T01:04:52.4771202Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/31345772869/artifacts/90473786222026-08-10T01:04:52.4960068Z Post job cleanup.2026-08-10T01:04:52.6241459Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-10T01:04:52.6294773Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-10T01:04:52.6323275Z /home/runner/go/pkg/mod2026-08-10T01:04:52.6349656Z /home/runner/.cache/go-build2026-08-10T01:04:52.6357663Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-10T01:04:52.6529997Z Post job cleanup.2026-08-10T01:04:52.7557120Z [command]/usr/bin/git version2026-08-10T01:04:52.7606642Z git version 2.54.02026-08-10T01:04:52.7651993Z Temporarily overriding HOME='/home/runner/work/_temp/c1a7ea06-dcf9-4864-b6da-755f5a345066' before making global git config changes2026-08-10T01:04:52.7653354Z Adding repository directory to the temporary git global config as a safe directory2026-08-10T01:04:52.7659590Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-10T01:04:52.7700071Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-10T01:04:52.7738519Z [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-10T01:04:52.8037929Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-10T01:04:52.8077296Z http.https://github.com/.extraheader2026-08-10T01:04:52.8092544Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-10T01:04:52.8134938Z [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-10T01:04:52.8430963Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-10T01:04:52.8472899Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-10T01:04:52.8906827Z Cleaning up orphan processes2026-08-10T01:04:52.9687477Z ##[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/