2026-08-04T01:25:30.5791802Z Current runner version: '2.336.0'2026-08-04T01:25:30.5829893Z ##[group]Runner Image Provisioner2026-08-04T01:25:30.5831311Z Hosted Compute Agent2026-08-04T01:25:30.5832246Z Version: 20260707.5632026-08-04T01:25:30.5833331Z Commit: 02667638d2b423fbc733a8e32a88b44996a3ba6e2026-08-04T01:25:30.5834655Z Build Date: 2026-07-07T19:33:50Z2026-08-04T01:25:30.5835758Z Worker ID: {01dc0485-2802-45e5-abb5-75e074362957}2026-08-04T01:25:30.5837165Z Azure Region: eastus22026-08-04T01:25:30.5838303Z ##[endgroup]2026-08-04T01:25:30.5840720Z ##[group]Operating System2026-08-04T01:25:30.5841895Z Ubuntu2026-08-04T01:25:30.5842752Z 22.04.52026-08-04T01:25:30.5843599Z LTS2026-08-04T01:25:30.5844541Z ##[endgroup]2026-08-04T01:25:30.5845428Z ##[group]Runner Image2026-08-04T01:25:30.5846858Z Image: ubuntu-22.042026-08-04T01:25:30.5847903Z Version: 20260720.234.22026-08-04T01:25:30.5850027Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260720.234/images/ubuntu/Ubuntu2204-Readme.md2026-08-04T01:25:30.5852681Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260720.2342026-08-04T01:25:30.5854595Z ##[endgroup]2026-08-04T01:25:30.5857086Z ##[group]GITHUB_TOKEN Permissions2026-08-04T01:25:30.5860815Z Contents: read2026-08-04T01:25:30.5861906Z Metadata: read2026-08-04T01:25:30.5862978Z Packages: read2026-08-04T01:25:30.5864119Z ##[endgroup]2026-08-04T01:25:30.5867529Z Secret source: Actions2026-08-04T01:25:30.5869402Z Prepare workflow directory2026-08-04T01:25:30.6362152Z Prepare all required actions2026-08-04T01:25:30.6434718Z Getting action download info2026-08-04T01:25:30.8399252Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-04T01:25:31.1169339Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-04T01:25:31.2826160Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-04T01:25:31.4615347Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-04T01:25:31.7768878Z Uses: mwestphall/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-04T01:25:31.7774829Z ##[group] Inputs2026-08-04T01:25:31.7775505Z testName: TestOSPoolEP2026-08-04T01:25:31.7777243Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-04T01:25:31.7778811Z setupScript: 2026-08-04T01:25:31.7779344Z setupEnv: {}2026-08-04T01:25:31.7779852Z ##[endgroup]2026-08-04T01:25:31.7780821Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-08-04T01:25:31.8653213Z ##[group]Run actions/checkout@v52026-08-04T01:25:31.8654263Z with:2026-08-04T01:25:31.8654856Z repository: mwestphall/k8s-integration-tests2026-08-04T01:25:31.8662769Z token: ***2026-08-04T01:25:31.8663277Z ssh-strict: true2026-08-04T01:25:31.8663820Z ssh-user: git2026-08-04T01:25:31.8664331Z persist-credentials: true2026-08-04T01:25:31.8664931Z clean: true2026-08-04T01:25:31.8665444Z sparse-checkout-cone-mode: true2026-08-04T01:25:31.8666134Z fetch-depth: 12026-08-04T01:25:31.8666840Z fetch-tags: false2026-08-04T01:25:31.8667378Z show-progress: true2026-08-04T01:25:31.8667924Z lfs: false2026-08-04T01:25:31.8668413Z submodules: false2026-08-04T01:25:31.8668965Z set-safe-directory: true2026-08-04T01:25:31.8669595Z allow-unsafe-pr-checkout: false2026-08-04T01:25:31.8670544Z ##[endgroup]2026-08-04T01:25:31.9798680Z Syncing repository: mwestphall/k8s-integration-tests2026-08-04T01:25:31.9802156Z ##[group]Getting Git version info2026-08-04T01:25:31.9804393Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-04T01:25:31.9807627Z [command]/usr/bin/git version2026-08-04T01:25:31.9837331Z git version 2.54.02026-08-04T01:25:31.9862116Z ##[endgroup]2026-08-04T01:25:31.9879856Z Temporarily overriding HOME='/home/runner/work/_temp/e55833b0-780f-4ab4-aca6-5762d39ef0f2' before making global git config changes2026-08-04T01:25:31.9884540Z Adding repository directory to the temporary git global config as a safe directory2026-08-04T01:25:31.9888500Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-04T01:25:31.9933560Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-04T01:25:31.9938796Z ##[group]Initializing the repository2026-08-04T01:25:31.9944524Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-04T01:25:32.0051895Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-04T01:25:32.0054932Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-04T01:25:32.0058006Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-04T01:25:32.0060107Z hint: call:2026-08-04T01:25:32.0061377Z hint:2026-08-04T01:25:32.0062813Z hint: git config --global init.defaultBranch <name>2026-08-04T01:25:32.0064684Z hint:2026-08-04T01:25:32.0066230Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-04T01:25:32.0069179Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-04T01:25:32.0071375Z hint:2026-08-04T01:25:32.0072562Z hint: git branch -m <name>2026-08-04T01:25:32.0073673Z hint:2026-08-04T01:25:32.0075211Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-04T01:25:32.0079271Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-04T01:25:32.0084827Z [command]/usr/bin/git remote add origin https://github.com/mwestphall/k8s-integration-tests2026-08-04T01:25:32.0112987Z ##[endgroup]2026-08-04T01:25:32.0114884Z ##[group]Disabling automatic garbage collection2026-08-04T01:25:32.0117968Z [command]/usr/bin/git config --local gc.auto 02026-08-04T01:25:32.0158093Z ##[endgroup]2026-08-04T01:25:32.0159952Z ##[group]Setting up auth2026-08-04T01:25:32.0165591Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-04T01:25:32.0205029Z [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-04T01:25:32.0603749Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-04T01:25:32.0646143Z [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-04T01:25:32.0915975Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-04T01:25:32.0954394Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-04T01:25:32.1208910Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-04T01:25:32.1251143Z ##[endgroup]2026-08-04T01:25:32.1252260Z ##[group]Fetching the repository2026-08-04T01:25:32.1261643Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-04T01:25:32.3193941Z From https://github.com/mwestphall/k8s-integration-tests2026-08-04T01:25:32.3196293Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-04T01:25:32.3234308Z ##[endgroup]2026-08-04T01:25:32.3235878Z ##[group]Determining the checkout info2026-08-04T01:25:32.3239256Z ##[endgroup]2026-08-04T01:25:32.3248518Z [command]/usr/bin/git sparse-checkout disable2026-08-04T01:25:32.3310173Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-04T01:25:32.3352621Z ##[group]Checking out the ref2026-08-04T01:25:32.3356315Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-04T01:25:32.3454884Z Switched to a new branch 'main'2026-08-04T01:25:32.3457695Z branch 'main' set up to track 'origin/main'.2026-08-04T01:25:32.3465848Z ##[endgroup]2026-08-04T01:25:32.3521906Z [command]/usr/bin/git log -1 --format=%H2026-08-04T01:25:32.3551447Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-04T01:25:32.3833114Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-04T01:25:32.3835607Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-04T01:25:32.3838810Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-04T01:25:32.3969182Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-04T01:25:32.3970676Z env:2026-08-04T01:25:32.3972413Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-04T01:25:32.3974512Z SETUP_ENV_YAML: {}2026-08-04T01:25:32.3975480Z ##[endgroup]2026-08-04T01:25:32.8988203Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-04T01:25:32.8990324Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-04T01:25:32.9054220Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-04T01:25:32.9055470Z env:2026-08-04T01:25:32.9057168Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-04T01:25:32.9058977Z ##[endgroup]2026-08-04T01:25:32.9249444Z ##[group]Run true2026-08-04T01:25:32.9250306Z [36;1mtrue[0m2026-08-04T01:25:32.9315014Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-04T01:25:32.9316262Z ##[endgroup]2026-08-04T01:25:32.9590920Z ##[group]Run medyagh/setup-minikube@latest2026-08-04T01:25:32.9592020Z with:2026-08-04T01:25:32.9592767Z start: true2026-08-04T01:25:32.9593542Z cache: true2026-08-04T01:25:32.9594338Z minikube-version: latest2026-08-04T01:25:32.9595288Z wait: all2026-08-04T01:25:32.9596046Z ##[endgroup]2026-08-04T01:25:33.0919150Z (node:2056) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-04T01:25:33.0922852Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-04T01:25:34.0518759Z [command]/usr/bin/chmod +x /home/runner/work/_temp/d4799524-4c4f-4954-9f1e-040ac121cbad2026-08-04T01:25:34.2216169Z [command]/home/runner/bin/minikube version --short2026-08-04T01:25:34.2712453Z v1.38.12026-08-04T01:25:34.3626720Z Cache hit for: kic-v1.38.1-x642026-08-04T01:25:34.3740319Z (node:2056) [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-04T01:25:34.3748675Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-04T01:25:35.4182439Z Received 159383552 of 544082657 (29.3%), 152.0 MBs/sec2026-08-04T01:25:35.4395011Z Received 113246208 of 224218863 (50.5%), 107.9 MBs/sec2026-08-04T01:25:36.3870925Z Received 224218863 of 224218863 (100.0%), 109.8 MBs/sec2026-08-04T01:25:36.3872223Z Cache Size: ~214 MB (224218863 B)2026-08-04T01:25:36.4193848Z Received 310378496 of 544082657 (57.0%), 147.9 MBs/sec2026-08-04T01:25:36.4303994Z [command]/usr/bin/tar -xf /home/runner/work/_temp/c91895ae-e664-4239-9fa1-f4fb1a5b4e2d/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-04T01:25:37.0846161Z Cache restored successfully2026-08-04T01:25:37.4218178Z Received 520093696 of 544082657 (95.6%), 165.2 MBs/sec2026-08-04T01:25:37.7394946Z Received 544082657 of 544082657 (100.0%), 156.2 MBs/sec2026-08-04T01:25:37.7457428Z Cache Size: ~519 MB (544082657 B)2026-08-04T01:25:37.7532765Z [command]/usr/bin/tar -xf /home/runner/work/_temp/60cbcf1e-8625-48a5-80cd-c168df2d7f5d/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-04T01:25:38.5217243Z Cache restored successfully2026-08-04T01:25:38.6386918Z [command]/home/runner/bin/minikube start --wait all2026-08-04T01:25:38.6815625Z * minikube v1.38.1 on Ubuntu 22.042026-08-04T01:25:39.1517472Z ! 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-04T01:25:39.1563476Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-04T01:25:39.2074294Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-04T01:25:39.2079006Z * Using Docker driver with root privileges2026-08-04T01:25:39.2091369Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-04T01:25:39.2099571Z * Pulling base image v0.0.50 ...2026-08-04T01:26:11.8398643Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-04T01:26:17.0510595Z * Verifying Kubernetes components...2026-08-04T01:26:17.0867887Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-04T01:26:17.7946291Z * Enabled addons: storage-provisioner, default-storageclass2026-08-04T01:27:03.3972573Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-04T01:27:03.4080471Z [command]/home/runner/bin/minikube version --short2026-08-04T01:27:03.4488472Z v1.38.12026-08-04T01:27:03.4844674Z ##[group]Run actions/setup-go@v62026-08-04T01:27:03.4844959Z with:2026-08-04T01:27:03.4845151Z go-version: 1.262026-08-04T01:27:03.4845364Z cache: true2026-08-04T01:27:03.4845590Z cache-dependency-path: go.sum2026-08-04T01:27:03.4845837Z check-latest: false2026-08-04T01:27:03.4848308Z token: ***2026-08-04T01:27:03.4848513Z ##[endgroup]2026-08-04T01:27:03.6175986Z Setup go version spec 1.262026-08-04T01:27:03.6403394Z Found in cache @ /opt/hostedtoolcache/go/1.26.5/x642026-08-04T01:27:03.6406115Z Added go to the path2026-08-04T01:27:03.6410028Z Successfully set up Go version 1.262026-08-04T01:27:04.1967136Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-04T01:27:04.2008473Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-04T01:27:04.2042489Z /home/runner/go/pkg/mod2026-08-04T01:27:04.2069289Z /home/runner/.cache/go-build2026-08-04T01:27:04.3016741Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-04T01:27:05.3602831Z Received 155189248 of 251839808 (61.6%), 146.7 MBs/sec2026-08-04T01:27:05.7517643Z Received 251839808 of 251839808 (100.0%), 170.9 MBs/sec2026-08-04T01:27:05.7519478Z Cache Size: ~240 MB (251839808 B)2026-08-04T01:27:05.7590708Z [command]/usr/bin/tar -xf /home/runner/work/_temp/73a7fa88-cc30-45c3-adc1-62e60b289304/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-04T01:27:08.9192030Z Cache restored successfully2026-08-04T01:27:08.9773506Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-04T01:27:08.9801252Z go version go1.26.5 linux/amd642026-08-04T01:27:08.9801471Z 2026-08-04T01:27:08.9801787Z ##[group]go env2026-08-04T01:27:09.0133025Z AR='ar'2026-08-04T01:27:09.0133361Z CC='gcc'2026-08-04T01:27:09.0133639Z CGO_CFLAGS='-O2 -g'2026-08-04T01:27:09.0134457Z CGO_CPPFLAGS=''2026-08-04T01:27:09.0134964Z CGO_CXXFLAGS='-O2 -g'2026-08-04T01:27:09.0135478Z CGO_ENABLED='1'2026-08-04T01:27:09.0135893Z CGO_FFLAGS='-O2 -g'2026-08-04T01:27:09.0136345Z CGO_LDFLAGS='-O2 -g'2026-08-04T01:27:09.0138854Z CXX='g++'2026-08-04T01:27:09.0139274Z GCCGO='gccgo'2026-08-04T01:27:09.0139688Z GO111MODULE=''2026-08-04T01:27:09.0140013Z GOAMD64='v1'2026-08-04T01:27:09.0140322Z GOARCH='amd64'2026-08-04T01:27:09.0140599Z GOAUTH='netrc'2026-08-04T01:27:09.0140855Z GOBIN=''2026-08-04T01:27:09.0141143Z GOCACHE='/home/runner/.cache/go-build'2026-08-04T01:27:09.0141506Z GOCACHEPROG=''2026-08-04T01:27:09.0141767Z GODEBUG=''2026-08-04T01:27:09.0142066Z GOENV='/home/runner/.config/go/env'2026-08-04T01:27:09.0142398Z GOEXE=''2026-08-04T01:27:09.0142653Z GOEXPERIMENT=''2026-08-04T01:27:09.0142928Z GOFIPS140='off'2026-08-04T01:27:09.0143185Z GOFLAGS=''2026-08-04T01:27:09.0144079Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build2360071705=/tmp/go-build -gno-record-gcc-switches'2026-08-04T01:27:09.0144968Z GOHOSTARCH='amd64'2026-08-04T01:27:09.0145250Z GOHOSTOS='linux'2026-08-04T01:27:09.0145517Z GOINSECURE=''2026-08-04T01:27:09.0145967Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-04T01:27:09.0146837Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-04T01:27:09.0147299Z GONOPROXY=''2026-08-04T01:27:09.0147554Z GONOSUMDB=''2026-08-04T01:27:09.0147823Z GOOS='linux'2026-08-04T01:27:09.0148093Z GOPATH='/home/runner/go'2026-08-04T01:27:09.0148390Z GOPRIVATE=''2026-08-04T01:27:09.0148721Z GOPROXY='https://proxy.golang.org,direct'2026-08-04T01:27:09.0149167Z GOROOT='/opt/hostedtoolcache/go/1.26.5/x64'2026-08-04T01:27:09.0149561Z GOSUMDB='sum.golang.org'2026-08-04T01:27:09.0149865Z GOTELEMETRY='local'2026-08-04T01:27:09.0150211Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-04T01:27:09.0150618Z GOTMPDIR=''2026-08-04T01:27:09.0150880Z GOTOOLCHAIN='local'2026-08-04T01:27:09.0151573Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.5/x64/pkg/tool/linux_amd64'2026-08-04T01:27:09.0151956Z GOVCS=''2026-08-04T01:27:09.0152160Z GOVERSION='go1.26.5'2026-08-04T01:27:09.0152372Z GOWORK=''2026-08-04T01:27:09.0152578Z PKG_CONFIG='pkg-config'2026-08-04T01:27:09.0152726Z 2026-08-04T01:27:09.0153080Z ##[endgroup]2026-08-04T01:27:09.0353057Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-04T01:27:09.0353577Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-04T01:27:09.0412691Z shell: /usr/bin/bash -e {0}2026-08-04T01:27:09.0413028Z env:2026-08-04T01:27:09.0413242Z GOTOOLCHAIN: local2026-08-04T01:27:09.0413655Z OSPOOL_EP_OSPoolEPTag: 25-release2026-08-04T01:27:09.0414086Z OSPOOL_EP_CMTag: 25.0-el92026-08-04T01:27:09.0414485Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-04T01:27:09.0414856Z ##[endgroup]2026-08-04T01:27:15.5012527Z === RUN TestOSPoolEP2026-08-04T01:27:15.5013885Z === PAUSE TestOSPoolEP2026-08-04T01:27:15.5014352Z === CONT TestOSPoolEP2026-08-04T01:27:15.5016002Z TestOSPoolEP 2026-08-04T01:27:15Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:15.5244424Z TestOSPoolEP 2026-08-04T01:27:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd apply -f /tmp/TestOSPoolEP3195527719]2026-08-04T01:27:16.4674258Z TestOSPoolEP 2026-08-04T01:27:16Z logger.go:67: pod/idtoken-generator created2026-08-04T01:27:16.4775488Z TestOSPoolEP 2026-08-04T01:27:16Z logger.go:67: secret/pool-passwd created2026-08-04T01:27:16.4814940Z TestOSPoolEP 2026-08-04T01:27:16Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-04T01:27:16.4816880Z TestOSPoolEP 2026-08-04T01:27:16Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:16.4854087Z TestOSPoolEP 2026-08-04T01:27:16Z retry.go:103: Wait for pod idtoken-generator to be provisioned. returned an error: Pod idtoken-generator is not available, reason: , message: . Sleeping for 10s and will try again.2026-08-04T01:27:26.4864519Z TestOSPoolEP 2026-08-04T01:27:26Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-04T01:27:26.4866055Z TestOSPoolEP 2026-08-04T01:27:26Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:26.4897158Z TestOSPoolEP 2026-08-04T01:27:26Z retry.go:103: Wait for pod idtoken-generator to be provisioned. returned an error: Pod idtoken-generator is not available, reason: , message: . Sleeping for 10s and will try again.2026-08-04T01:27:36.4897251Z TestOSPoolEP 2026-08-04T01:27:36Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-04T01:27:36.4899383Z TestOSPoolEP 2026-08-04T01:27:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:36.4925191Z TestOSPoolEP 2026-08-04T01:27:36Z logger.go:67: Pod is now available2026-08-04T01:27:36.4927155Z TestOSPoolEP 2026-08-04T01:27:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-04T01:27:36.9174366Z TestOSPoolEP 2026-08-04T01:27:36Z logger.go:67: ***2026-08-04T01:27:36.9244914Z TestOSPoolEP 2026-08-04T01:27:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd apply -f /tmp/TestOSPoolEP2557040782]2026-08-04T01:27:37.1175118Z TestOSPoolEP 2026-08-04T01:27:37Z logger.go:67: secret/pool-token created2026-08-04T01:27:37.1211718Z TestOSPoolEP 2026-08-04T01:27:37Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-04T01:27:37.1213102Z TestOSPoolEP 2026-08-04T01:27:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:37.1234474Z TestOSPoolEP 2026-08-04T01:27:37Z logger.go:67: Secret is now available2026-08-04T01:27:37.1257400Z TestOSPoolEP 2026-08-04T01:27:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd apply -k /tmp/kustomize-template-2425283032]2026-08-04T01:27:37.4328146Z TestOSPoolEP 2026-08-04T01:27:37Z logger.go:67: service/test-cm created2026-08-04T01:27:37.4427365Z TestOSPoolEP 2026-08-04T01:27:37Z logger.go:67: Warning: spec.template.spec.containers[0].env[8]: hides previous definition of "OSG_SQUID_LOCATION", which may be dropped when using apply2026-08-04T01:27:37.4430886Z TestOSPoolEP 2026-08-04T01:27:37Z logger.go:67: deployment.apps/ospool-ep created2026-08-04T01:27:37.4558478Z TestOSPoolEP 2026-08-04T01:27:37Z logger.go:67: deployment.apps/test-cm created2026-08-04T01:27:37.4644022Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-04T01:27:37.4659428Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:37.4754055Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:37Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-04T01:27:37.4769921Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:37.4771895Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:37Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-04T01:27:37.4773996Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:37.4798819Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:37Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "ospool-ep-6c7d796845". Sleeping for 10s and will try again.2026-08-04T01:27:37.4812480Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:37Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "test-cm-54b7d49f85". Sleeping for 10s and will try again.2026-08-04T01:27:47.4810509Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:47Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-04T01:27:47.4812616Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:47.4814819Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:47Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-04T01:27:47.4816909Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:47.4842284Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:47Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "test-cm-54b7d49f85" is progressing.. Sleeping for 10s and will try again.2026-08-04T01:27:47.4845081Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:47Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-08-04T01:27:57.4851927Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:57Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-04T01:27:57.4854894Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:57Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-04T01:27:57.4859034Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:57.4861323Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:27:57.4881626Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:57Z logger.go:67: Deployment is now available2026-08-04T01:27:57.4885420Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:27:57Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-08-04T01:28:07.4890094Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:28:07Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-04T01:28:07.4892901Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:28:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:28:07.4930488Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-04T01:28:07Z logger.go:67: Deployment is now available2026-08-04T01:28:07.4931628Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-04T01:28:07.4932341Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-04T01:28:07.4933118Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-04T01:28:07.4933935Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-04T01:28:07.4934720Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-04T01:28:07.4936181Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-04T01:28:07.4937130Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-04T01:28:07.4939557Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:28:07.4940816Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-04T01:28:07.4941818Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:28:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:28:07.4942824Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-04T01:28:07.4943871Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-04T01:28:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:28:07.4970241Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:28:07.4977602Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-04T01:28:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:28:07.4981921Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:28:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:28:07.4995830Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)']2026-08-04T01:28:07.5023116Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:28:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:28:07.5040659Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-04T01:28:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_SINGULARITY]2026-08-04T01:28:07.7371604Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-04T01:28:07.7373519Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)']' in pod test-cm-54b7d49f85-f8757 failed. Retrying in 10s.2026-08-04T01:28:07.7884578Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-04T01:28:07.7887123Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-f8757 failed. Retrying in 10s.2026-08-04T01:28:07.8044100Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-04T01:28:07.8046194Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-f8757 failed. Retrying in 30s.2026-08-04T01:28:17.7390907Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)']2026-08-04T01:28:17.7903860Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-04T01:28:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_SINGULARITY]2026-08-04T01:28:17.9323102Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-04T01:28:17.9324798Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)']' in pod test-cm-54b7d49f85-f8757 failed. Retrying in 10s.2026-08-04T01:28:17.9839152Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-04T01:28:17.9840529Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-f8757 failed. Retrying in 10s.2026-08-04T01:28:27.9333995Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)']2026-08-04T01:28:27.9851624Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-04T01:28:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_SINGULARITY]2026-08-04T01:28:28.1880651Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:28Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-04T01:28:28.1884265Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:28Z logger.go:67: 2026-08-04T01:28:28.1886429Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:28Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-jj5w5 LINUX X86_64 Unclaimed Idle 0.000 15991 0+00:00:002026-08-04T01:28:28.1888537Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:28Z logger.go:67: 2026-08-04T01:28:28.1890101Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:28Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-04T01:28:28.1892015Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:28Z logger.go:67: 2026-08-04T01:28:28.1893495Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:28Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-04T01:28:28.1894926Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:28Z logger.go:67: 2026-08-04T01:28:28.1896352Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-04T01:28:28Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-04T01:28:28.2506229Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-04T01:28:28Z logger.go:67: true2026-08-04T01:28:37.8050469Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:28:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:28:37.9529518Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:28:37Z logger.go:67: undefined2026-08-04T01:28:37.9586376Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-04T01:28:37.9588082Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-f8757 failed. Retrying in 30s.2026-08-04T01:29:07.9589844Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:29:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:29:08.1128597Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:29:08Z logger.go:67: undefined2026-08-04T01:29:08.1193287Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-f8757 failed. Retrying in 30s.2026-08-04T01:29:38.1203551Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:29:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:29:38.2769263Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:29:38Z logger.go:67: undefined2026-08-04T01:29:38.2840171Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-f8757 failed. Retrying in 30s.2026-08-04T01:30:08.2845572Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:30:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:30:08.4383204Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:30:08Z logger.go:67: undefined2026-08-04T01:30:08.4443903Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-f8757 failed. Retrying in 30s.2026-08-04T01:30:38.4474804Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:30:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:30:38.5986142Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:30:38Z logger.go:67: undefined2026-08-04T01:30:38.6046276Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-f8757 failed. Retrying in 30s.2026-08-04T01:31:08.6049201Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:31:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:31:08.7501342Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:31:08Z logger.go:67: undefined2026-08-04T01:31:08.7559959Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-f8757 failed. Retrying in 30s.2026-08-04T01:31:38.7589961Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:31:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:31:38.9228384Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:31:38Z logger.go:67: undefined2026-08-04T01:31:38.9298408Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-f8757 failed. Retrying in 30s.2026-08-04T01:32:08.9303035Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:32:08Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:32:09.0916044Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:32:09Z logger.go:67: undefined2026-08-04T01:32:09.0996383Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-f8757 failed. Retrying in 30s.2026-08-04T01:32:39.1020604Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:32:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:32:39.2597007Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:32:39Z logger.go:67: undefined2026-08-04T01:32:39.2658159Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-f8757 failed. Retrying in 30s.2026-08-04T01:33:09.2688709Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:33:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:33:09.4199996Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:33:09Z logger.go:67: undefined2026-08-04T01:33:09.4266725Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-f8757 failed. Retrying in 30s.2026-08-04T01:33:39.4294665Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:33:39Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd exec test-cm-54b7d49f85-f8757 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-jj5w5",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-04T01:33:39.5962971Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-04T01:33:39Z logger.go:67: true2026-08-04T01:33:39.6032963Z TestOSPoolEP 2026-08-04T01:33:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:33:39.6115438Z TestOSPoolEP 2026-08-04T01:33:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:33:39.7493440Z TestOSPoolEP 2026-08-04T01:33:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:33:39.8949678Z TestOSPoolEP 2026-08-04T01:33:39Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:33:40.0095310Z TestOSPoolEP 2026-08-04T01:33:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:33:40.0129970Z === NAME TestOSPoolEP2026-08-04T01:33:40.0130643Z ospool_ep_test.go:101: ---2026-08-04T01:33:40.0131243Z Events for pod idtoken-generator:2026-08-04T01:33:40.0132612Z 2026-08-04 01:27:16 +0000 UTC Normal Successfully assigned test-ospool-ep-umsjcd/idtoken-generator to minikube2026-08-04T01:33:40.0133898Z 2026-08-04 01:27:17 +0000 UTC Normal Pulling image "htcondor/base"2026-08-04T01:33:40.0137984Z 2026-08-04 01:27:25 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.525s (8.525s including waiting). Image size: 560910730 bytes.2026-08-04T01:33:40.0139330Z 2026-08-04 01:27:25 +0000 UTC Normal Container created2026-08-04T01:33:40.0140131Z 2026-08-04 01:27:25 +0000 UTC Normal Container started2026-08-04T01:33:40.0140691Z 2026-08-04T01:33:40.0141047Z ---2026-08-04T01:33:40.0142009Z TestOSPoolEP 2026-08-04T01:33:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:33:40.0158315Z ospool_ep_test.go:101: ---2026-08-04T01:33:40.0159130Z Events for pod ospool-ep-6c7d796845-jj5w5:2026-08-04T01:33:40.0160652Z 2026-08-04 01:27:37 +0000 UTC Normal Successfully assigned test-ospool-ep-umsjcd/ospool-ep-6c7d796845-jj5w5 to minikube2026-08-04T01:33:40.0162203Z 2026-08-04 01:27:37 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-04T01:33:40.0164383Z 2026-08-04 01:27:39 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.523s (1.523s including waiting). Image size: 5590942 bytes.2026-08-04T01:33:40.0165808Z 2026-08-04 01:27:39 +0000 UTC Normal Container created2026-08-04T01:33:40.0166961Z 2026-08-04 01:27:39 +0000 UTC Normal Container started2026-08-04T01:33:40.0168181Z 2026-08-04 01:27:39 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-08-04T01:33:40.0170506Z 2026-08-04 01:28:02 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 15.659s (22.663s including waiting). Image size: 1383210994 bytes.2026-08-04T01:33:40.0172061Z 2026-08-04 01:28:02 +0000 UTC Normal Container created2026-08-04T01:33:40.0172887Z 2026-08-04 01:28:02 +0000 UTC Normal Container started2026-08-04T01:33:40.0173391Z 2026-08-04T01:33:40.0173726Z ---2026-08-04T01:33:40.0174702Z TestOSPoolEP 2026-08-04T01:33:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:33:40.0184331Z ospool_ep_test.go:101: ---2026-08-04T01:33:40.0185185Z Events for pod test-cm-54b7d49f85-f8757:2026-08-04T01:33:40.0187678Z 2026-08-04 01:27:37 +0000 UTC Normal Successfully assigned test-ospool-ep-umsjcd/test-cm-54b7d49f85-f8757 to minikube2026-08-04T01:33:40.0189208Z 2026-08-04 01:27:37 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-08-04T01:33:40.0191592Z 2026-08-04 01:27:46 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 7.232s (8.732s including waiting). Image size: 573055668 bytes.2026-08-04T01:33:40.0193363Z 2026-08-04 01:27:46 +0000 UTC Normal Container created2026-08-04T01:33:40.0194659Z 2026-08-04 01:27:46 +0000 UTC Normal Container started2026-08-04T01:33:40.0195697Z 2026-08-04T01:33:40.0200774Z ---2026-08-04T01:33:40.0202058Z TestOSPoolEP 2026-08-04T01:33:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-04T01:33:40.0233926Z TestOSPoolEP 2026-08-04T01:33:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd delete -f /tmp/TestOSPoolEP1355572446]2026-08-04T01:33:40.1374693Z TestOSPoolEP 2026-08-04T01:33:40Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-umsjcd namespace2026-08-04T01:33:40.1485978Z TestOSPoolEP 2026-08-04T01:33:40Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-umsjcd namespace2026-08-04T01:33:41.1822979Z TestOSPoolEP 2026-08-04T01:33:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd delete -f /tmp/TestOSPoolEP4095259746]2026-08-04T01:33:41.2752220Z TestOSPoolEP 2026-08-04T01:33:41Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-umsjcd namespace2026-08-04T01:33:41.2801501Z TestOSPoolEP 2026-08-04T01:33:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-umsjcd delete -k /tmp/kustomize-template-2425283032]2026-08-04T01:33:41.4298520Z TestOSPoolEP 2026-08-04T01:33:41Z logger.go:67: service "test-cm" deleted from test-ospool-ep-umsjcd namespace2026-08-04T01:33:41.4340624Z TestOSPoolEP 2026-08-04T01:33:41Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-umsjcd namespace2026-08-04T01:33:41.4395405Z TestOSPoolEP 2026-08-04T01:33:41Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-umsjcd namespace2026-08-04T01:33:41.4534857Z --- PASS: TestOSPoolEP (53.84s)2026-08-04T01:33:41.4554882Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.03s)2026-08-04T01:33:41.4556510Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.71s)2026-08-04T01:33:41.4558664Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.77s)2026-08-04T01:33:41.4560270Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (332.11s)2026-08-04T01:33:41.4562371Z PASS2026-08-04T01:33:41.4572123Z ok github.com/osg-htc/k8s-integration-tests/test 385.968s2026-08-04T01:33:41.5807655Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-04T01:33:41.5808706Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-04T01:33:41.5889450Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-04T01:33:41.5889819Z env:2026-08-04T01:33:41.5890045Z GOTOOLCHAIN: local2026-08-04T01:33:41.5890486Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-04T01:33:41.5890984Z ##[endgroup]2026-08-04T01:33:41.6134322Z 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-04T01:33:41.6135665Z ##[group]Run actions/upload-artifact@v42026-08-04T01:33:41.6136009Z with:2026-08-04T01:33:41.6136401Z name: TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce72322026-08-04T01:33:41.6137294Z path: /tmp/k8s-tests2026-08-04T01:33:41.6137552Z retention-days: 52026-08-04T01:33:41.6137843Z if-no-files-found: warn2026-08-04T01:33:41.6138217Z compression-level: 62026-08-04T01:33:41.6138478Z overwrite: false2026-08-04T01:33:41.6138720Z include-hidden-files: false2026-08-04T01:33:41.6139001Z env:2026-08-04T01:33:41.6139221Z GOTOOLCHAIN: local2026-08-04T01:33:41.6139451Z ##[endgroup]2026-08-04T01:33:41.8290757Z (node:17611) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-04T01:33:41.8292221Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-04T01:33:41.8457121Z With the provided path, there will be 6 files uploaded2026-08-04T01:33:41.8458487Z Artifact name is valid!2026-08-04T01:33:41.8459100Z Root directory input is valid!2026-08-04T01:33:41.9945954Z Beginning upload of artifact content to blob storage2026-08-04T01:33:42.0267492Z (node:17611) [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-04T01:33:42.0741775Z Uploaded bytes 139692026-08-04T01:33:42.0947210Z Finished uploading artifact content to blob storage!2026-08-04T01:33:42.0948463Z SHA256 digest of uploaded artifact zip is 5a0f29849479fea579d277bdcc7228868a37f20b0379d391422511fb17c726142026-08-04T01:33:42.0950610Z Finalizing artifact upload2026-08-04T01:33:42.2851642Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232.zip successfully finalized. Artifact ID 88772022822026-08-04T01:33:42.2854115Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232 has been successfully uploaded! Final size is 13969 bytes. Artifact ID is 88772022822026-08-04T01:33:42.2860238Z Artifact download URL: https://github.com/mwestphall/k8s-integration-tests/actions/runs/30868701385/artifacts/88772022822026-08-04T01:33:42.3031510Z Post job cleanup.2026-08-04T01:33:42.4762538Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOMODCACHE2026-08-04T01:33:42.4828036Z [command]/opt/hostedtoolcache/go/1.26.5/x64/bin/go env GOCACHE2026-08-04T01:33:42.4877576Z /home/runner/go/pkg/mod2026-08-04T01:33:42.4890607Z /home/runner/.cache/go-build2026-08-04T01:33:42.4907660Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.5-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-04T01:33:42.5259596Z Post job cleanup.2026-08-04T01:33:42.6460657Z [command]/usr/bin/git version2026-08-04T01:33:42.6531492Z git version 2.54.02026-08-04T01:33:42.6574971Z Temporarily overriding HOME='/home/runner/work/_temp/bddc1beb-b957-4d87-a101-b74c3de9c1de' before making global git config changes2026-08-04T01:33:42.6576352Z Adding repository directory to the temporary git global config as a safe directory2026-08-04T01:33:42.6583789Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-04T01:33:42.6640454Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-04T01:33:42.6709090Z [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-04T01:33:42.7006673Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-04T01:33:42.7040426Z http.https://github.com/.extraheader2026-08-04T01:33:42.7064565Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-04T01:33:42.7095817Z [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-04T01:33:42.7394607Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-04T01:33:42.7451390Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-04T01:33:42.8000799Z Cleaning up orphan processes2026-08-04T01:33:42.8772960Z ##[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/