2026-10-23T02:11:07.0504334Z Current runner version: '2.338.0'2026-10-23T02:11:07.0532619Z ##[group]Runner Image Provisioner2026-10-23T02:11:07.0533918Z Hosted Compute Agent2026-10-23T02:11:07.0534720Z Version: 20261012.6012026-10-23T02:11:07.0535480Z Commit: f3dc54e1fb89da6852db922499a0233137369e1d2026-10-23T02:11:07.0537006Z Build Date: 2026-10-12T17:48:21Z2026-10-23T02:11:07.0537886Z Worker ID: {1c0d827c-7a0e-46a6-8d82-0f730197a01d}2026-10-23T02:11:07.0538827Z Region: eastus2026-10-23T02:11:07.0539566Z Cloud: Azure2026-10-23T02:11:07.0540344Z ##[endgroup]2026-10-23T02:11:07.0542121Z ##[group]Operating System2026-10-23T02:11:07.0542900Z Ubuntu2026-10-23T02:11:07.0544313Z 22.04.52026-10-23T02:11:07.0544972Z LTS2026-10-23T02:11:07.0545605Z ##[endgroup]2026-10-23T02:11:07.0546381Z ##[group]Runner Image2026-10-23T02:11:07.0547162Z Image: ubuntu-22.042026-10-23T02:11:07.0547957Z Version: 20261012.322.12026-10-23T02:11:07.0549551Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20261012.322/images/ubuntu/Ubuntu2204-Readme.md2026-10-23T02:11:07.0551695Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20261012.3222026-10-23T02:11:07.0552947Z ##[endgroup]2026-10-23T02:11:07.0557392Z ##[group]GITHUB_TOKEN Permissions2026-10-23T02:11:07.0560157Z Actions: write2026-10-23T02:11:07.0560942Z ArtifactMetadata: write2026-10-23T02:11:07.0561803Z Attestations: write2026-10-23T02:11:07.0562536Z Checks: write2026-10-23T02:11:07.0563464Z CodeQuality: write2026-10-23T02:11:07.0564323Z Contents: write2026-10-23T02:11:07.0565109Z CopilotRequests: write2026-10-23T02:11:07.0565989Z Deployments: write2026-10-23T02:11:07.0566712Z Discussions: write2026-10-23T02:11:07.0567413Z Drives: write2026-10-23T02:11:07.0568220Z Issues: write2026-10-23T02:11:07.0568996Z Metadata: read2026-10-23T02:11:07.0569825Z Models: read2026-10-23T02:11:07.0570536Z Packages: write2026-10-23T02:11:07.0571258Z Pages: write2026-10-23T02:11:07.0572069Z PullRequests: write2026-10-23T02:11:07.0572841Z RepositoryProjects: write2026-10-23T02:11:07.0573959Z SecurityEvents: write2026-10-23T02:11:07.0574717Z Statuses: write2026-10-23T02:11:07.0575425Z VulnerabilityAlerts: read2026-10-23T02:11:07.0576194Z ##[endgroup]2026-10-23T02:11:07.0578511Z Secret source: Actions2026-10-23T02:11:07.0579749Z Cache mode: write2026-10-23T02:11:07.0580846Z Prepare workflow directory2026-10-23T02:11:07.0947460Z Prepare all required actions2026-10-23T02:11:07.1003380Z Getting action download info2026-10-23T02:11:07.2664932Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-10-23T02:11:08.0805699Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-10-23T02:11:08.2264704Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-10-23T02:11:08.4058671Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-10-23T02:11:08.8865032Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (63ec080e4eea87fb8a9eae678ab9944ec2461251)2026-10-23T02:11:08.8868703Z ##[group] Inputs2026-10-23T02:11:08.8868990Z testName: TestOSPoolEP2026-10-23T02:11:08.8869431Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-23T02:11:08.8869891Z setupScript: 2026-10-23T02:11:08.8870108Z setupEnv: {}2026-10-23T02:11:08.8870322Z ##[endgroup]2026-10-23T02:11:08.8870656Z Complete job name: ospool-ep / Run OSPool EP test (cvmfs-bind, 25-release) / Run Tests2026-10-23T02:11:08.9410902Z ##[group]Run actions/checkout@v52026-10-23T02:11:08.9411385Z with:2026-10-23T02:11:08.9411624Z repository: osg-htc/k8s-integration-tests2026-10-23T02:11:08.9414245Z token: ***2026-10-23T02:11:08.9414471Z ssh-strict: true2026-10-23T02:11:08.9414683Z ssh-user: git2026-10-23T02:11:08.9414899Z persist-credentials: true2026-10-23T02:11:08.9415136Z clean: true2026-10-23T02:11:08.9415593Z sparse-checkout-cone-mode: true2026-10-23T02:11:08.9415839Z fetch-depth: 12026-10-23T02:11:08.9416052Z fetch-tags: false2026-10-23T02:11:08.9416263Z show-progress: true2026-10-23T02:11:08.9416485Z lfs: false2026-10-23T02:11:08.9416680Z submodules: false2026-10-23T02:11:08.9416899Z set-safe-directory: true2026-10-23T02:11:08.9417142Z allow-unsafe-pr-checkout: false2026-10-23T02:11:08.9417596Z ##[endgroup]2026-10-23T02:11:09.0242502Z Syncing repository: osg-htc/k8s-integration-tests2026-10-23T02:11:09.0244523Z ##[group]Getting Git version info2026-10-23T02:11:09.0246146Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-23T02:11:09.0253879Z [command]/usr/bin/git version2026-10-23T02:11:09.1051782Z git version 2.55.02026-10-23T02:11:09.1067440Z ##[endgroup]2026-10-23T02:11:09.1079510Z Temporarily overriding HOME='/home/runner/work/_temp/237ff836-4c9f-4ee3-9796-ea7fc3bb27a6' before making global git config changes2026-10-23T02:11:09.1084321Z Adding repository directory to the temporary git global config as a safe directory2026-10-23T02:11:09.1085222Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-23T02:11:09.1119936Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-23T02:11:09.1124196Z ##[group]Initializing the repository2026-10-23T02:11:09.1127930Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-23T02:11:09.2341919Z hint: Using 'master' as the name for the initial branch. This default branch name2026-10-23T02:11:09.2342610Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-10-23T02:11:09.2343242Z hint: to use in all of your new repositories, which will suppress this warning,2026-10-23T02:11:09.2343595Z hint: call:2026-10-23T02:11:09.2343799Z hint:2026-10-23T02:11:09.2344259Z hint: git config --global init.defaultBranch <name>2026-10-23T02:11:09.2344735Z hint:2026-10-23T02:11:09.2345064Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-10-23T02:11:09.2345512Z hint: 'development'. The just-created branch can be renamed via this command:2026-10-23T02:11:09.2345852Z hint:2026-10-23T02:11:09.2346067Z hint: git branch -m <name>2026-10-23T02:11:09.2346294Z hint:2026-10-23T02:11:09.2346592Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-10-23T02:11:09.2347132Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-10-23T02:11:09.2350060Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-10-23T02:11:09.2387343Z ##[endgroup]2026-10-23T02:11:09.2387770Z ##[group]Disabling automatic garbage collection2026-10-23T02:11:09.2390304Z [command]/usr/bin/git config --local gc.auto 02026-10-23T02:11:09.2421791Z ##[endgroup]2026-10-23T02:11:09.2422163Z ##[group]Setting up auth2026-10-23T02:11:09.2427638Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-23T02:11:09.2458903Z [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-10-23T02:11:09.7435836Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-23T02:11:09.7470391Z [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-10-23T02:11:09.7687736Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-23T02:11:09.7721115Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-23T02:11:09.7937630Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-10-23T02:11:09.7976091Z ##[endgroup]2026-10-23T02:11:09.7976705Z ##[group]Fetching the repository2026-10-23T02:11:09.7982826Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +63ec080e4eea87fb8a9eae678ab9944ec2461251:refs/remotes/origin/main2026-10-23T02:11:10.2350611Z From https://github.com/osg-htc/k8s-integration-tests2026-10-23T02:11:10.2351261Z * [new ref] 63ec080e4eea87fb8a9eae678ab9944ec2461251 -> origin/main2026-10-23T02:11:10.2355507Z ##[endgroup]2026-10-23T02:11:10.2356062Z ##[group]Determining the checkout info2026-10-23T02:11:10.2358028Z ##[endgroup]2026-10-23T02:11:10.2364216Z [command]/usr/bin/git sparse-checkout disable2026-10-23T02:11:10.2409853Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-10-23T02:11:10.3109970Z ##[group]Checking out the ref2026-10-23T02:11:10.3116219Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-10-23T02:11:10.3203734Z Switched to a new branch 'main'2026-10-23T02:11:10.3206563Z branch 'main' set up to track 'origin/main'.2026-10-23T02:11:10.3212782Z ##[endgroup]2026-10-23T02:11:10.3254131Z [command]/usr/bin/git log -1 --format=%H2026-10-23T02:11:10.3280652Z 63ec080e4eea87fb8a9eae678ab9944ec24612512026-10-23T02:11:10.3547630Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-23T02:11:10.3548228Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-23T02:11:10.3548695Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-23T02:11:10.5572163Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-23T02:11:10.5572493Z env:2026-10-23T02:11:10.5572857Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-23T02:11:10.5573498Z SETUP_ENV_YAML: {}2026-10-23T02:11:10.5573685Z ##[endgroup]2026-10-23T02:11:11.0141353Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-23T02:11:11.0141840Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-10-23T02:11:11.0202015Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-23T02:11:11.0202307Z env:2026-10-23T02:11:11.0202668Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfs-bind"}2026-10-23T02:11:11.0203222Z ##[endgroup]2026-10-23T02:11:11.0324126Z ##[group]Run true2026-10-23T02:11:11.0324343Z [36;1mtrue[0m2026-10-23T02:11:11.0376674Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-23T02:11:11.0376964Z ##[endgroup]2026-10-23T02:11:11.0508693Z ##[group]Run medyagh/setup-minikube@latest2026-10-23T02:11:11.0508934Z with:2026-10-23T02:11:11.0509107Z start: true2026-10-23T02:11:11.0509262Z cache: true2026-10-23T02:11:11.0509434Z minikube-version: latest2026-10-23T02:11:11.0509628Z wait: all2026-10-23T02:11:11.0509784Z ##[endgroup]2026-10-23T02:11:11.1514195Z (node:1854) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-23T02:11:11.1514866Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-23T02:11:11.9415514Z [command]/usr/bin/chmod +x /home/runner/work/_temp/a3fb920d-4bea-47c5-8ef8-ca129d9ea25a2026-10-23T02:11:12.6601751Z [command]/home/runner/bin/minikube version --short2026-10-23T02:11:12.7310058Z v1.39.02026-10-23T02:11:12.7949964Z Cache hit for: preloaded-tarball-v1.39.0-x64-stable-docker2026-10-23T02:11:12.8030621Z (node:1854) [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-10-23T02:11:12.8056149Z Cache hit for: kic-v1.39.0-x642026-10-23T02:11:13.8984723Z Received 159383552 of 531630645 (30.0%), 143.5 MBs/sec2026-10-23T02:11:13.8992662Z Received 134217728 of 288577004 (46.5%), 122.7 MBs/sec2026-10-23T02:11:14.8324233Z Received 288577004 of 288577004 (100.0%), 139.5 MBs/sec2026-10-23T02:11:14.8333344Z Cache Size: ~275 MB (288577004 B)2026-10-23T02:11:14.8817620Z [command]/usr/bin/tar -xf /home/runner/work/_temp/1ebf960f-ef8f-4946-9c94-8a34dc7ecd95/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-23T02:11:14.9021878Z Received 339738624 of 531630645 (63.9%), 156.9 MBs/sec2026-10-23T02:11:15.6016709Z Cache restored successfully2026-10-23T02:11:15.7485014Z Received 531630645 of 531630645 (100.0%), 174.1 MBs/sec2026-10-23T02:11:15.7485914Z Cache Size: ~507 MB (531630645 B)2026-10-23T02:11:15.7512585Z [command]/usr/bin/tar -xf /home/runner/work/_temp/b72f544e-7522-41ee-a9e8-577c401e07d9/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-23T02:11:16.4284600Z Cache restored successfully2026-10-23T02:11:16.9606507Z [command]/home/runner/bin/minikube start --wait all2026-10-23T02:11:17.0600792Z * minikube v1.39.0 on Ubuntu 22.042026-10-23T02:11:17.4978814Z ! 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-10-23T02:11:17.5356985Z * Automatically selected the docker driver. Other choices: podman, ssh, none2026-10-23T02:11:17.6398751Z * Using Docker driver with root privileges2026-10-23T02:11:17.6435900Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-10-23T02:11:17.6696262Z * Pulling base image v0.0.51 ...2026-10-23T02:11:46.4663168Z * Preparing Kubernetes v1.37.0 on containerd 2.3.4 ...2026-10-23T02:11:53.7297719Z * Configuring CNI (Container Networking Interface) ...2026-10-23T02:11:59.2505500Z * Verifying Kubernetes components...2026-10-23T02:11:59.2708123Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-10-23T02:11:59.8102063Z * Enabled addons: storage-provisioner, default-storageclass2026-10-23T02:12:16.6222523Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-10-23T02:12:16.6340789Z [command]/home/runner/bin/minikube version --short2026-10-23T02:12:16.6860810Z v1.39.02026-10-23T02:12:16.7404647Z ##[group]Run actions/setup-go@v62026-10-23T02:12:16.7405014Z with:2026-10-23T02:12:16.7405232Z go-version: 1.262026-10-23T02:12:16.7405403Z cache: true2026-10-23T02:12:16.7405590Z cache-dependency-path: go.sum2026-10-23T02:12:16.7405803Z check-latest: false2026-10-23T02:12:16.7408132Z token: ***2026-10-23T02:12:16.7408306Z ##[endgroup]2026-10-23T02:12:16.8454788Z Setup go version spec 1.262026-10-23T02:12:16.8498409Z Found in cache @ /opt/hostedtoolcache/go/1.26.9/x642026-10-23T02:12:16.8500605Z Added go to the path2026-10-23T02:12:16.8503634Z Successfully set up Go version 1.262026-10-23T02:12:17.0545409Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOMODCACHE2026-10-23T02:12:17.0613259Z [command]/opt/hostedtoolcache/go/1.26.9/x64/bin/go env GOCACHE2026-10-23T02:12:17.0636179Z /home/runner/go/pkg/mod2026-10-23T02:12:17.0654754Z /home/runner/.cache/go-build2026-10-23T02:12:17.1409561Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-23T02:12:23.2399883Z Received 249167808 of 249167808 (100.0%), 224.6 MBs/sec2026-10-23T02:12:23.2401297Z Cache Size: ~238 MB (249167808 B)2026-10-23T02:12:23.2431584Z [command]/usr/bin/tar -xf /home/runner/work/_temp/4817784e-f0ef-4aa9-a1fb-460da80d09f1/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-23T02:12:25.6678706Z Cache restored successfully2026-10-23T02:12:25.7142361Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.9-299a3d6de4053fc48484c540e47e841abc5bdca78f4893479137318058315b412026-10-23T02:12:25.7162290Z go version go1.26.9 linux/amd642026-10-23T02:12:25.7162474Z 2026-10-23T02:12:25.7162746Z ##[group]go env2026-10-23T02:12:25.7331618Z AR='ar'2026-10-23T02:12:25.7331921Z CC='gcc'2026-10-23T02:12:25.7332213Z CGO_CFLAGS='-O2 -g'2026-10-23T02:12:25.7332524Z CGO_CPPFLAGS=''2026-10-23T02:12:25.7332810Z CGO_CXXFLAGS='-O2 -g'2026-10-23T02:12:25.7333275Z CGO_ENABLED='1'2026-10-23T02:12:25.7333580Z CGO_FFLAGS='-O2 -g'2026-10-23T02:12:25.7333865Z CGO_LDFLAGS='-O2 -g'2026-10-23T02:12:25.7334162Z CXX='g++'2026-10-23T02:12:25.7334428Z GCCGO='gccgo'2026-10-23T02:12:25.7334704Z GO111MODULE=''2026-10-23T02:12:25.7334975Z GOAMD64='v1'2026-10-23T02:12:25.7335282Z GOARCH='amd64'2026-10-23T02:12:25.7335540Z GOAUTH='netrc'2026-10-23T02:12:25.7335803Z GOBIN=''2026-10-23T02:12:25.7336092Z GOCACHE='/home/runner/.cache/go-build'2026-10-23T02:12:25.7336438Z GOCACHEPROG=''2026-10-23T02:12:25.7336616Z GODEBUG=''2026-10-23T02:12:25.7336852Z GOENV='/home/runner/.config/go/env'2026-10-23T02:12:25.7337184Z GOEXE=''2026-10-23T02:12:25.7337449Z GOEXPERIMENT=''2026-10-23T02:12:25.7337713Z GOFIPS140='off'2026-10-23T02:12:25.7337974Z GOFLAGS=''2026-10-23T02:12:25.7338754Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build1096721464=/tmp/go-build -gno-record-gcc-switches'2026-10-23T02:12:25.7339604Z GOHOSTARCH='amd64'2026-10-23T02:12:25.7339876Z GOHOSTOS='linux'2026-10-23T02:12:25.7340151Z GOINSECURE=''2026-10-23T02:12:25.7340609Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-10-23T02:12:25.7341137Z GOMODCACHE='/home/runner/go/pkg/mod'2026-10-23T02:12:25.7341474Z GONOPROXY=''2026-10-23T02:12:25.7341729Z GONOSUMDB=''2026-10-23T02:12:25.7341978Z GOOS='linux'2026-10-23T02:12:25.7342264Z GOPATH='/home/runner/go'2026-10-23T02:12:25.7342575Z GOPRIVATE=''2026-10-23T02:12:25.7342910Z GOPROXY='https://proxy.golang.org,direct'2026-10-23T02:12:25.7343556Z GOROOT='/opt/hostedtoolcache/go/1.26.9/x64'2026-10-23T02:12:25.7343939Z GOSUMDB='sum.golang.org'2026-10-23T02:12:25.7344256Z GOTELEMETRY='local'2026-10-23T02:12:25.7344604Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-10-23T02:12:25.7344995Z GOTMPDIR=''2026-10-23T02:12:25.7345258Z GOTOOLCHAIN='local'2026-10-23T02:12:25.7345669Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.9/x64/pkg/tool/linux_amd64'2026-10-23T02:12:25.7346383Z GOVCS=''2026-10-23T02:12:25.7346652Z GOVERSION='go1.26.9'2026-10-23T02:12:25.7346932Z GOWORK=''2026-10-23T02:12:25.7347205Z PKG_CONFIG='pkg-config'2026-10-23T02:12:25.7347400Z 2026-10-23T02:12:25.7347752Z ##[endgroup]2026-10-23T02:12:25.7807344Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-23T02:12:25.7808002Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-10-23T02:12:25.7875649Z shell: /usr/bin/bash -e {0}2026-10-23T02:12:25.7875902Z env:2026-10-23T02:12:25.7876095Z GOTOOLCHAIN: local2026-10-23T02:12:25.7876321Z OSPOOL_EP_OSPoolEPTag: 25-release2026-10-23T02:12:25.7876563Z OSPOOL_EP_CMTag: 25.0-el92026-10-23T02:12:25.7876789Z OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-23T02:12:25.7877015Z ##[endgroup]2026-10-23T02:12:36.3764038Z === RUN TestOSPoolEP2026-10-23T02:12:36.3766039Z === PAUSE TestOSPoolEP2026-10-23T02:12:36.3766362Z === CONT TestOSPoolEP2026-10-23T02:12:36.3766921Z TestOSPoolEP 2026-10-23T02:12:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:36.3884960Z TestOSPoolEP 2026-10-23T02:12:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c apply -f /tmp/TestOSPoolEP125063008]2026-10-23T02:12:36.7992033Z TestOSPoolEP 2026-10-23T02:12:36Z logger.go:67: pod/idtoken-generator created2026-10-23T02:12:36.8801430Z TestOSPoolEP 2026-10-23T02:12:36Z logger.go:67: secret/pool-passwd created2026-10-23T02:12:36.8883071Z TestOSPoolEP 2026-10-23T02:12:36Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-23T02:12:36.8884211Z TestOSPoolEP 2026-10-23T02:12:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:36.8888399Z TestOSPoolEP 2026-10-23T02:12:36Z 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-10-23T02:12:46.8896701Z TestOSPoolEP 2026-10-23T02:12:46Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-23T02:12:46.8899875Z TestOSPoolEP 2026-10-23T02:12:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:46.8923554Z TestOSPoolEP 2026-10-23T02:12:46Z logger.go:67: Pod is now available2026-10-23T02:12:46.8925128Z TestOSPoolEP 2026-10-23T02:12:46Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-10-23T02:12:47.0093883Z TestOSPoolEP 2026-10-23T02:12:47Z logger.go:67: ***2026-10-23T02:12:47.0149010Z TestOSPoolEP 2026-10-23T02:12:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c apply -f /tmp/TestOSPoolEP2379993792]2026-10-23T02:12:47.2326904Z TestOSPoolEP 2026-10-23T02:12:47Z logger.go:67: secret/pool-token created2026-10-23T02:12:47.2360710Z TestOSPoolEP 2026-10-23T02:12:47Z retry.go:91: Wait for secret pool-token to be provisioned.2026-10-23T02:12:47.2362051Z TestOSPoolEP 2026-10-23T02:12:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:47.2377580Z TestOSPoolEP 2026-10-23T02:12:47Z logger.go:67: Secret is now available2026-10-23T02:12:47.2400608Z TestOSPoolEP 2026-10-23T02:12:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c apply -k /tmp/kustomize-template-2136696857]2026-10-23T02:12:47.5858932Z TestOSPoolEP 2026-10-23T02:12:47Z logger.go:67: serviceaccount/cvmfs-nodeplugin created2026-10-23T02:12:47.5945327Z TestOSPoolEP 2026-10-23T02:12:47Z logger.go:67: service/frontier-squid created2026-10-23T02:12:47.5996798Z TestOSPoolEP 2026-10-23T02:12:47Z logger.go:67: service/test-cm created2026-10-23T02:12:47.6061961Z TestOSPoolEP 2026-10-23T02:12:47Z logger.go:67: deployment.apps/cvmfs-nodeplugin created2026-10-23T02:12:47.6138038Z TestOSPoolEP 2026-10-23T02:12:47Z logger.go:67: deployment.apps/frontier-squid created2026-10-23T02:12:47.6302455Z TestOSPoolEP 2026-10-23T02:12:47Z logger.go:67: Warning: spec.template.spec.containers[0].env[6]: hides previous definition of "OSG_SQUID_LOCATION", which may be dropped when using apply2026-10-23T02:12:47.6311212Z TestOSPoolEP 2026-10-23T02:12:47Z logger.go:67: deployment.apps/ospool-ep created2026-10-23T02:12:47.6630722Z TestOSPoolEP 2026-10-23T02:12:47Z logger.go:67: deployment.apps/test-cm created2026-10-23T02:12:47.6694735Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-10-23T02:12:47.6701043Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:47.6841013Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:47Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-23T02:12:47.6874051Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:47.6878742Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:47Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-23T02:12:47.6880312Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:47.6886588Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:47Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-23T02:12:47.6887938Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:47.6889213Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:47Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-23T02:12:47.6890518Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:47Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:47.6948676Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12: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-7f9d786cd6" is progressing.. Sleeping for 10s and will try again.2026-10-23T02:12:47.6952804Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:47Z retry.go:103: Wait for deployment frontier-squid to be provisioned. returned an error: Deployment frontier-squid is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "frontier-squid-65f85c968" is progressing.. Sleeping for 10s and will try again.2026-10-23T02:12:47.6965056Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12: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-cc75b66b9" is progressing.. Sleeping for 10s and will try again.2026-10-23T02:12:47.6972194Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:47Z retry.go:103: Wait for deployment cvmfs-nodeplugin to be provisioned. returned an error: Deployment cvmfs-nodeplugin is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "cvmfs-nodeplugin-5cd89c7cfd" is progressing.. Sleeping for 10s and will try again.2026-10-23T02:12:57.6957803Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:57Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-23T02:12:57.6992389Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:57.7009977Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:57Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-23T02:12:57.7011655Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:57.7013492Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:57Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-23T02:12:57.7015149Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:57.7016695Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:57Z retry.go:91: Wait for deployment cvmfs-nodeplugin to be provisioned.2026-10-23T02:12:57.7018275Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:57Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:12:57.7191284Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12: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-cc75b66b9" is progressing.. Sleeping for 10s and will try again.2026-10-23T02:12:57.7195530Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:57Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "test-cm-7f9d786cd6" is progressing.. Sleeping for 10s and will try again.2026-10-23T02:12:57.7198511Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:57Z logger.go:67: Deployment is now available2026-10-23T02:12:57.7201178Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:12:57Z retry.go:103: Wait for deployment frontier-squid to be provisioned. returned an error: Deployment frontier-squid is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "frontier-squid-65f85c968" is progressing.. Sleeping for 10s and will try again.2026-10-23T02:13:07.7196080Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:07Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-23T02:13:07.7198082Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:07.7199844Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:07Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-23T02:13:07.7201435Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:07.7203155Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:07Z retry.go:91: Wait for deployment frontier-squid to be provisioned.2026-10-23T02:13:07.7204850Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:07.7227495Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:07Z logger.go:67: Deployment is now available2026-10-23T02:13:07.7229325Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:07Z 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-7f9d786cd6" is progressing.. Sleeping for 10s and will try again.2026-10-23T02:13:07.7231661Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:07Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-cc75b66b9" is progressing.. Sleeping for 10s and will try again.2026-10-23T02:13:17.7236482Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:17Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-23T02:13:17.7241981Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:17.7243772Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:17Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-23T02:13:17.7246136Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:17.7259446Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:17Z logger.go:67: Deployment is now available2026-10-23T02:13:17.7262022Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:17Z retry.go:103: Wait for deployment ospool-ep to be provisioned. returned an error: Deployment ospool-ep is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: ReplicaSetUpdated, message: ReplicaSet "ospool-ep-cc75b66b9" is progressing.. Sleeping for 10s and will try again.2026-10-23T02:13:27.7266866Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:27Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-23T02:13:27.7267792Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:27.7293841Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:27Z 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-cc75b66b9" is progressing.. Sleeping for 10s and will try again.2026-10-23T02:13:37.7315698Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:37Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-23T02:13:37.7318051Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:37.7335790Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-23T02:13:37Z logger.go:67: Deployment is now available2026-10-23T02:13:37.7348201Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP2026-10-23T02:13:37.7349346Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-23T02:13:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:37.7384352Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-23T02:13:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c cp ../test-configs/ospool-ep/condor_status.sh test-cm-7f9d786cd6-9tzfm:/tmp/condor_status.sh]2026-10-23T02:13:38.0986397Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-23T02:13:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c exec test-cm-7f9d786cd6-9tzfm -- chmod +x /tmp/condor_status.sh]2026-10-23T02:13:38.2155087Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-23T02:13:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c exec test-cm-7f9d786cd6-9tzfm -- sh -c /tmp/condor_status.sh]2026-10-23T02:13:38.3503483Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-23T02:13:38Z logger.go:67: command terminated with exit code 12026-10-23T02:13:38.3531230Z test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-7f9d786cd6-9tzfm failed. Retrying in 10s.2026-10-23T02:13:48.3547159Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-23T02:13:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c exec test-cm-7f9d786cd6-9tzfm -- sh -c /tmp/condor_status.sh]2026-10-23T02:13:48.4999477Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity2026-10-23T02:13:48.5001039Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-23T02:13:48Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:48.5023692Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-23T02:13:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c cp ../test-configs/ospool-ep/has_singularity.sh test-cm-7f9d786cd6-9tzfm:/tmp/has_singularity.sh]2026-10-23T02:13:48.6644369Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-23T02:13:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c exec test-cm-7f9d786cd6-9tzfm -- chmod +x /tmp/has_singularity.sh]2026-10-23T02:13:48.7879097Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-23T02:13:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c exec test-cm-7f9d786cd6-9tzfm -- sh -c /tmp/has_singularity.sh]2026-10-23T02:13:48.9328712Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-10-23T02:13:48.9329931Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:13:48Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:13:48.9352443Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:13:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c cp ../test-configs/ospool-ep/has_cvmfs.sh test-cm-7f9d786cd6-9tzfm:/tmp/has_cvmfs.sh]2026-10-23T02:13:49.1813697Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:13:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c exec test-cm-7f9d786cd6-9tzfm -- chmod +x /tmp/has_cvmfs.sh]2026-10-23T02:13:49.3042913Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:13:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c exec test-cm-7f9d786cd6-9tzfm -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:13:49.4372163Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:13:49Z logger.go:67: command terminated with exit code 12026-10-23T02:13:49.4399048Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-9tzfm failed. Retrying in 30s.2026-10-23T02:14:19.4402040Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:14:19Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c exec test-cm-7f9d786cd6-9tzfm -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:14:19.5852476Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:14:19Z logger.go:67: command terminated with exit code 12026-10-23T02:14:19.5880891Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-9tzfm failed. Retrying in 30s.2026-10-23T02:14:49.5887331Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:14:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c exec test-cm-7f9d786cd6-9tzfm -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:14:49.7165029Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:14:49Z logger.go:67: command terminated with exit code 12026-10-23T02:14:49.7180169Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-9tzfm failed. Retrying in 30s.2026-10-23T02:15:19.7185137Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:15:19Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c exec test-cm-7f9d786cd6-9tzfm -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:15:19.8367007Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:15:19Z logger.go:67: command terminated with exit code 12026-10-23T02:15:19.8394190Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-9tzfm failed. Retrying in 30s.2026-10-23T02:15:49.8405952Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:15:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c exec test-cm-7f9d786cd6-9tzfm -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:15:49.9790205Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:15:49Z logger.go:67: command terminated with exit code 12026-10-23T02:15:49.9823998Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-9tzfm failed. Retrying in 30s.2026-10-23T02:16:19.9830888Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:16:19Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c exec test-cm-7f9d786cd6-9tzfm -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:16:20.1342529Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:16:20Z logger.go:67: command terminated with exit code 12026-10-23T02:16:20.1370025Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-9tzfm failed. Retrying in 30s.2026-10-23T02:16:50.1402117Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:16:50Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c exec test-cm-7f9d786cd6-9tzfm -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:16:50.2571626Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:16:50Z logger.go:67: command terminated with exit code 12026-10-23T02:16:50.2599969Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-9tzfm failed. Retrying in 30s.2026-10-23T02:17:20.2626994Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:17:20Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c exec test-cm-7f9d786cd6-9tzfm -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:17:20.3806727Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:17:20Z logger.go:67: command terminated with exit code 12026-10-23T02:17:20.3836165Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-9tzfm failed. Retrying in 30s.2026-10-23T02:17:50.3840013Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:17:50Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c exec test-cm-7f9d786cd6-9tzfm -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:17:50.6031161Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:17:50Z logger.go:67: command terminated with exit code 12026-10-23T02:17:50.6061140Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-9tzfm failed. Retrying in 30s.2026-10-23T02:18:20.6109127Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:18:20Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c exec test-cm-7f9d786cd6-9tzfm -- sh -c /tmp/has_cvmfs.sh]2026-10-23T02:18:20.7455735Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-23T02:18:20Z logger.go:67: command terminated with exit code 12026-10-23T02:18:20.7484860Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-9tzfm failed. Retrying in 30s.2026-10-23T02:18:50.7488119Z test_utils.go:105: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-9tzfm did not succeed within {10 30000000000} retries2026-10-23T02:18:50.7489847Z TestOSPoolEP 2026-10-23T02:18:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:50.7574665Z TestOSPoolEP 2026-10-23T02:18:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:50.8691215Z TestOSPoolEP 2026-10-23T02:18:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:50.9677038Z TestOSPoolEP 2026-10-23T02:18:50Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:51.0598983Z TestOSPoolEP 2026-10-23T02:18:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:51.1554065Z TestOSPoolEP 2026-10-23T02:18:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:51.2445963Z TestOSPoolEP 2026-10-23T02:18:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:51.2479065Z === NAME TestOSPoolEP2026-10-23T02:18:51.2480819Z ospool_ep_test.go:72: ---2026-10-23T02:18:51.2481756Z Events for pod cvmfs-nodeplugin-5cd89c7cfd-kkgfd:2026-10-23T02:18:51.2483797Z 2026-10-23 02:12:47 +0000 UTC Normal Successfully assigned test-ospool-ep-ysof7c/cvmfs-nodeplugin-5cd89c7cfd-kkgfd to minikube2026-10-23T02:18:51.2485345Z 2026-10-23 02:12:48 +0000 UTC Normal Pulling image "opensciencegrid/cvmfs-nodeplugin:fresh"2026-10-23T02:18:51.2486919Z 2026-10-23 02:12:52 +0000 UTC Normal Successfully pulled image "opensciencegrid/cvmfs-nodeplugin:fresh" in 4.509s (4.509s including waiting). Image size: 155940803 bytes.2026-10-23T02:18:51.2488022Z 2026-10-23 02:12:52 +0000 UTC Normal Container created2026-10-23T02:18:51.2488632Z 2026-10-23 02:12:52 +0000 UTC Normal Container started2026-10-23T02:18:51.2489050Z 2026-10-23T02:18:51.2489317Z ---2026-10-23T02:18:51.2490053Z TestOSPoolEP 2026-10-23T02:18:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:51.2500392Z ospool_ep_test.go:72: ---2026-10-23T02:18:51.2501039Z Events for pod frontier-squid-65f85c968-vxkvn:2026-10-23T02:18:51.2502146Z 2026-10-23 02:12:47 +0000 UTC Normal Successfully assigned test-ospool-ep-ysof7c/frontier-squid-65f85c968-vxkvn to minikube2026-10-23T02:18:51.2503467Z 2026-10-23 02:12:48 +0000 UTC Normal Pulling image "opensciencegrid/frontier-squid:fresh"2026-10-23T02:18:51.2505100Z 2026-10-23 02:13:03 +0000 UTC Normal Successfully pulled image "opensciencegrid/frontier-squid:fresh" in 10.899s (15.392s including waiting). Image size: 453187319 bytes.2026-10-23T02:18:51.2506272Z 2026-10-23 02:13:03 +0000 UTC Normal Container created2026-10-23T02:18:51.2507209Z 2026-10-23 02:13:03 +0000 UTC Normal Container started2026-10-23T02:18:51.2507834Z 2026-10-23T02:18:51.2508275Z ---2026-10-23T02:18:51.2509177Z TestOSPoolEP 2026-10-23T02:18:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:51.2522799Z ospool_ep_test.go:72: ---2026-10-23T02:18:51.2523461Z Events for pod idtoken-generator:2026-10-23T02:18:51.2524208Z 2026-10-23 02:12:36 +0000 UTC Normal Successfully assigned test-ospool-ep-ysof7c/idtoken-generator to minikube2026-10-23T02:18:51.2524810Z 2026-10-23 02:12:37 +0000 UTC Normal Pulling image "htcondor/base"2026-10-23T02:18:51.2525665Z 2026-10-23 02:12:45 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.127s (8.127s including waiting). Image size: 196303183 bytes.2026-10-23T02:18:51.2526419Z 2026-10-23 02:12:45 +0000 UTC Normal Container created2026-10-23T02:18:51.2526991Z 2026-10-23 02:12:45 +0000 UTC Normal Container started2026-10-23T02:18:51.2527404Z 2026-10-23T02:18:51.2527673Z ---2026-10-23T02:18:51.2528813Z TestOSPoolEP 2026-10-23T02:18:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:51.2551416Z ospool_ep_test.go:72: ---2026-10-23T02:18:51.2552136Z Events for pod ospool-ep-cc75b66b9-shl5p:2026-10-23T02:18:51.2553388Z 2026-10-23 02:12:47 +0000 UTC Normal Successfully assigned test-ospool-ep-ysof7c/ospool-ep-cc75b66b9-shl5p to minikube2026-10-23T02:18:51.2554856Z 2026-10-23 02:12:48 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-10-23T02:18:51.2557288Z 2026-10-23 02:13:05 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 2.4s (17.785s including waiting). Image size: 2893600 bytes.2026-10-23T02:18:51.2558932Z 2026-10-23 02:13:06 +0000 UTC Normal Container created2026-10-23T02:18:51.2560171Z 2026-10-23 02:13:06 +0000 UTC Normal Container started2026-10-23T02:18:51.2561703Z 2026-10-23 02:13:08 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-10-23T02:18:51.2564029Z 2026-10-23 02:13:29 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 17.37s (20.27s including waiting). Image size: 537931704 bytes.2026-10-23T02:18:51.2566245Z 2026-10-23 02:13:29 +0000 UTC Normal Container created2026-10-23T02:18:51.2567582Z 2026-10-23 02:13:29 +0000 UTC Normal Container started2026-10-23T02:18:51.2593490Z 2026-10-23T02:18:51.2593770Z ---2026-10-23T02:18:51.2594661Z TestOSPoolEP 2026-10-23T02:18:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:51.2596059Z ospool_ep_test.go:72: ---2026-10-23T02:18:51.2596840Z Events for pod test-cm-7f9d786cd6-9tzfm:2026-10-23T02:18:51.2598310Z 2026-10-23 02:12:47 +0000 UTC Normal Successfully assigned test-ospool-ep-ysof7c/test-cm-7f9d786cd6-9tzfm to minikube2026-10-23T02:18:51.2599523Z 2026-10-23 02:12:48 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-10-23T02:18:51.2601102Z 2026-10-23 02:13:11 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 5.885s (23.473s including waiting). Image size: 198153089 bytes.2026-10-23T02:18:51.2602477Z 2026-10-23 02:13:11 +0000 UTC Normal Container created2026-10-23T02:18:51.2603430Z 2026-10-23 02:13:11 +0000 UTC Normal Container started2026-10-23T02:18:51.2604111Z 2026-10-23T02:18:51.2604353Z ---2026-10-23T02:18:51.2605195Z TestOSPoolEP 2026-10-23T02:18:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-23T02:18:51.2624049Z TestOSPoolEP 2026-10-23T02:18:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c delete -f /tmp/TestOSPoolEP724770147]2026-10-23T02:18:51.3530658Z TestOSPoolEP 2026-10-23T02:18:51Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-ysof7c namespace2026-10-23T02:18:51.3613399Z TestOSPoolEP 2026-10-23T02:18:51Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-ysof7c namespace2026-10-23T02:18:52.9160786Z TestOSPoolEP 2026-10-23T02:18:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c delete -f /tmp/TestOSPoolEP325044786]2026-10-23T02:18:53.0056600Z TestOSPoolEP 2026-10-23T02:18:53Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-ysof7c namespace2026-10-23T02:18:53.0111590Z TestOSPoolEP 2026-10-23T02:18:53Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-ysof7c delete -k /tmp/kustomize-template-2136696857]2026-10-23T02:18:53.1274550Z TestOSPoolEP 2026-10-23T02:18:53Z logger.go:67: serviceaccount "cvmfs-nodeplugin" deleted from test-ospool-ep-ysof7c namespace2026-10-23T02:18:53.1391657Z TestOSPoolEP 2026-10-23T02:18:53Z logger.go:67: service "frontier-squid" deleted from test-ospool-ep-ysof7c namespace2026-10-23T02:18:53.1471174Z TestOSPoolEP 2026-10-23T02:18:53Z logger.go:67: service "test-cm" deleted from test-ospool-ep-ysof7c namespace2026-10-23T02:18:53.1514657Z TestOSPoolEP 2026-10-23T02:18:53Z logger.go:67: deployment.apps "cvmfs-nodeplugin" deleted from test-ospool-ep-ysof7c namespace2026-10-23T02:18:53.1546329Z TestOSPoolEP 2026-10-23T02:18:53Z logger.go:67: deployment.apps "frontier-squid" deleted from test-ospool-ep-ysof7c namespace2026-10-23T02:18:53.1687051Z TestOSPoolEP 2026-10-23T02:18:53Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-ysof7c namespace2026-10-23T02:18:53.1771509Z TestOSPoolEP 2026-10-23T02:18:53Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-ysof7c namespace2026-10-23T02:18:53.2164840Z --- FAIL: TestOSPoolEP (376.84s)2026-10-23T02:18:53.2166312Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (50.06s)2026-10-23T02:18:53.2167685Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP (10.77s)2026-10-23T02:18:53.2169005Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity (0.43s)2026-10-23T02:18:53.2170362Z --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (301.82s)2026-10-23T02:18:53.2171179Z FAIL2026-10-23T02:18:53.2197976Z FAIL github.com/osg-htc/k8s-integration-tests/test 376.855s2026-10-23T02:18:53.2314616Z FAIL2026-10-23T02:18:53.3158686Z ##[error]Process completed with exit code 1.2026-10-23T02:18:53.3237270Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-23T02:18:53.3238043Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-10-23T02:18:53.3338349Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-23T02:18:53.3338831Z env:2026-10-23T02:18:53.3339452Z GOTOOLCHAIN: local2026-10-23T02:18:53.3340198Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfs-bind2026-10-23T02:18:53.3341136Z ##[endgroup]2026-10-23T02:18:53.3614148Z ##[group]Run actions/upload-artifact@v42026-10-23T02:18:53.3614624Z with:2026-10-23T02:18:53.3615210Z name: TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f02026-10-23T02:18:53.3616610Z path: /tmp/k8s-tests2026-10-23T02:18:53.3616975Z retention-days: 52026-10-23T02:18:53.3617530Z if-no-files-found: warn2026-10-23T02:18:53.3617836Z compression-level: 62026-10-23T02:18:53.3618322Z overwrite: false2026-10-23T02:18:53.3618667Z include-hidden-files: false2026-10-23T02:18:53.3619199Z env:2026-10-23T02:18:53.3619637Z GOTOOLCHAIN: local2026-10-23T02:18:53.3619915Z ##[endgroup]2026-10-23T02:18:53.5945941Z (node:16199) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-23T02:18:53.5947678Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-23T02:18:53.6225685Z With the provided path, there will be 10 files uploaded2026-10-23T02:18:53.6226453Z Artifact name is valid!2026-10-23T02:18:53.6226803Z Root directory input is valid!2026-10-23T02:18:53.8323574Z Beginning upload of artifact content to blob storage2026-10-23T02:18:53.8635426Z (node:16199) [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-10-23T02:18:53.9133786Z Uploaded bytes 163642026-10-23T02:18:53.9296632Z Finished uploading artifact content to blob storage!2026-10-23T02:18:53.9297577Z SHA256 digest of uploaded artifact zip is dd23b8436db0c64dc72b5ecc0abf0f1b95479a33baf0e6348ce06812f6a800c72026-10-23T02:18:53.9298910Z Finalizing artifact upload2026-10-23T02:18:54.3602087Z Artifact TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f0.zip successfully finalized. Artifact ID 124738022802026-10-23T02:18:54.3603488Z Artifact TestOSPoolEP-453ff0386a89f9cc593301c90f85319da2ad2fffb5e278ec6e14843bf75bc1f0 has been successfully uploaded! Final size is 16364 bytes. Artifact ID is 124738022802026-10-23T02:18:54.3608956Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/39888173727/artifacts/124738022802026-10-23T02:18:54.3795350Z Post job cleanup.2026-10-23T02:18:54.4575688Z [command]/usr/bin/git version2026-10-23T02:18:54.4613799Z git version 2.55.02026-10-23T02:18:54.4646663Z Temporarily overriding HOME='/home/runner/work/_temp/9b1d9e40-1c33-4a7d-9943-a24934f7f76f' before making global git config changes2026-10-23T02:18:54.4647535Z Adding repository directory to the temporary git global config as a safe directory2026-10-23T02:18:54.4651931Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-23T02:18:54.4688785Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-23T02:18:54.4720531Z [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-10-23T02:18:54.4961447Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-23T02:18:54.4988110Z http.https://github.com/.extraheader2026-10-23T02:18:54.5004381Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-10-23T02:18:54.5035118Z [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-10-23T02:18:54.5277468Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-23T02:18:54.5315997Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-23T02:18:54.5690385Z Cleaning up orphan processes2026-10-23T02:18:54.6461029Z ##[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/