2026-10-28T02:44:27.7789529Z Current runner version: '2.338.0'2026-10-28T02:44:27.7816531Z ##[group]Runner Image Provisioner2026-10-28T02:44:27.7817522Z Hosted Compute Agent2026-10-28T02:44:27.7818142Z Version: 20261021.6182026-10-28T02:44:27.7818904Z Commit: 21505ad2541d5be6135ed84fc33697146cf75b8e2026-10-28T02:44:27.7819688Z Build Date: 2026-10-21T00:45:21Z2026-10-28T02:44:27.7820411Z Worker ID: {47af5bab-4f1e-4ffd-aa52-321e3f19f813}2026-10-28T02:44:27.7821207Z Region: eastus2026-10-28T02:44:27.7821786Z Cloud: Azure2026-10-28T02:44:27.7822321Z ##[endgroup]2026-10-28T02:44:27.7824148Z ##[group]Operating System2026-10-28T02:44:27.7824990Z Ubuntu2026-10-28T02:44:27.7825649Z 22.04.52026-10-28T02:44:27.7826186Z LTS2026-10-28T02:44:27.7826696Z ##[endgroup]2026-10-28T02:44:27.7827401Z ##[group]Runner Image2026-10-28T02:44:27.7828035Z Image: ubuntu-22.042026-10-28T02:44:27.7828676Z Version: 20261025.340.12026-10-28T02:44:27.7830013Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20261025.340/images/ubuntu/Ubuntu2204-Readme.md2026-10-28T02:44:27.7832237Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20261025.3402026-10-28T02:44:27.7833258Z ##[endgroup]2026-10-28T02:44:27.7836829Z ##[group]GITHUB_TOKEN Permissions2026-10-28T02:44:27.7839862Z Actions: write2026-10-28T02:44:27.7840543Z ArtifactMetadata: write2026-10-28T02:44:27.7841211Z Attestations: write2026-10-28T02:44:27.7841864Z Checks: write2026-10-28T02:44:27.7842441Z CodeQuality: write2026-10-28T02:44:27.7843051Z Contents: write2026-10-28T02:44:27.7843709Z CopilotRequests: write2026-10-28T02:44:27.7844598Z Deployments: write2026-10-28T02:44:27.7845292Z Discussions: write2026-10-28T02:44:27.7845887Z Drives: write2026-10-28T02:44:27.7846665Z Issues: write2026-10-28T02:44:27.7847470Z Metadata: read2026-10-28T02:44:27.7848053Z Models: read2026-10-28T02:44:27.7848648Z Packages: write2026-10-28T02:44:27.7849256Z Pages: write2026-10-28T02:44:27.7849804Z PullRequests: write2026-10-28T02:44:27.7850486Z RepositoryProjects: write2026-10-28T02:44:27.7851197Z SecurityEvents: write2026-10-28T02:44:27.7851834Z Statuses: write2026-10-28T02:44:27.7852448Z VulnerabilityAlerts: read2026-10-28T02:44:27.7853052Z ##[endgroup]2026-10-28T02:44:27.7855884Z Secret source: Actions2026-10-28T02:44:27.7856885Z Cache mode: write2026-10-28T02:44:27.7857755Z Prepare workflow directory2026-10-28T02:44:27.8200860Z Prepare all required actions2026-10-28T02:44:27.8250447Z Getting action download info2026-10-28T02:44:28.0530832Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-10-28T02:44:28.2079679Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-10-28T02:44:28.3662346Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-10-28T02:44:28.5190541Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-10-28T02:44:28.7886872Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (63ec080e4eea87fb8a9eae678ab9944ec2461251)2026-10-28T02:44:28.7892874Z ##[group] Inputs2026-10-28T02:44:28.7893571Z testName: TestOSPoolEP2026-10-28T02:44:28.7895355Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-10-28T02:44:28.7896918Z setupScript: 2026-10-28T02:44:28.7897487Z setupEnv: {}2026-10-28T02:44:28.7898047Z ##[endgroup]2026-10-28T02:44:28.7899179Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-10-28T02:44:28.8871580Z ##[group]Run actions/checkout@v52026-10-28T02:44:28.8872696Z with:2026-10-28T02:44:28.8873289Z repository: osg-htc/k8s-integration-tests2026-10-28T02:44:28.8882620Z token: ***2026-10-28T02:44:28.8883156Z ssh-strict: true2026-10-28T02:44:28.8883704Z ssh-user: git2026-10-28T02:44:28.8884425Z persist-credentials: true2026-10-28T02:44:28.8885068Z clean: true2026-10-28T02:44:28.8885941Z sparse-checkout-cone-mode: true2026-10-28T02:44:28.8886648Z fetch-depth: 12026-10-28T02:44:28.8887188Z fetch-tags: false2026-10-28T02:44:28.8887741Z show-progress: true2026-10-28T02:44:28.8888300Z lfs: false2026-10-28T02:44:28.8888795Z submodules: false2026-10-28T02:44:28.8889354Z set-safe-directory: true2026-10-28T02:44:28.8890028Z allow-unsafe-pr-checkout: false2026-10-28T02:44:28.8891046Z ##[endgroup]2026-10-28T02:44:29.1330822Z Syncing repository: osg-htc/k8s-integration-tests2026-10-28T02:44:29.1334375Z ##[group]Getting Git version info2026-10-28T02:44:29.1335732Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-28T02:44:29.1337200Z [command]/usr/bin/git version2026-10-28T02:44:29.1401123Z git version 2.56.02026-10-28T02:44:29.1427464Z ##[endgroup]2026-10-28T02:44:29.1453159Z Temporarily overriding HOME='/home/runner/work/_temp/320cfa75-9b98-4aff-bd4e-d6a215366c4f' before making global git config changes2026-10-28T02:44:29.1455701Z Adding repository directory to the temporary git global config as a safe directory2026-10-28T02:44:29.1461198Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-28T02:44:29.1528777Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-28T02:44:29.1535523Z ##[group]Initializing the repository2026-10-28T02:44:29.1540442Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-28T02:44:29.1658510Z hint: Using 'master' as the name for the initial branch. This default branch name2026-10-28T02:44:29.1661105Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-10-28T02:44:29.1663709Z hint: to use in all of your new repositories, which will suppress this warning,2026-10-28T02:44:29.1666322Z hint: call:2026-10-28T02:44:29.1667981Z hint:2026-10-28T02:44:29.1669733Z hint: git config --global init.defaultBranch <name>2026-10-28T02:44:29.1671766Z hint:2026-10-28T02:44:29.1673639Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-10-28T02:44:29.1676316Z hint: 'development'. The just-created branch can be renamed via this command:2026-10-28T02:44:29.1678373Z hint:2026-10-28T02:44:29.1679971Z hint: git branch -m <name>2026-10-28T02:44:29.1681517Z hint:2026-10-28T02:44:29.1683259Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-10-28T02:44:29.1685929Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-10-28T02:44:29.1690849Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-10-28T02:44:29.1732011Z ##[endgroup]2026-10-28T02:44:29.1735293Z ##[group]Disabling automatic garbage collection2026-10-28T02:44:29.1737330Z [command]/usr/bin/git config --local gc.auto 02026-10-28T02:44:29.1780940Z ##[endgroup]2026-10-28T02:44:29.1783354Z ##[group]Setting up auth2026-10-28T02:44:29.1787772Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-28T02:44:29.1828607Z [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-28T02:44:29.2245460Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-28T02:44:29.2297565Z [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-28T02:44:29.2581896Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-28T02:44:29.2630615Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-28T02:44:29.2907241Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-10-28T02:44:29.2959411Z ##[endgroup]2026-10-28T02:44:29.2969652Z ##[group]Fetching the repository2026-10-28T02:44:29.2971676Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +63ec080e4eea87fb8a9eae678ab9944ec2461251:refs/remotes/origin/main2026-10-28T02:44:29.5273139Z From https://github.com/osg-htc/k8s-integration-tests2026-10-28T02:44:29.5276418Z * [new ref] 63ec080e4eea87fb8a9eae678ab9944ec2461251 -> origin/main2026-10-28T02:44:29.5282561Z ##[endgroup]2026-10-28T02:44:29.5285490Z ##[group]Determining the checkout info2026-10-28T02:44:29.5288358Z ##[endgroup]2026-10-28T02:44:29.5290221Z [command]/usr/bin/git sparse-checkout disable2026-10-28T02:44:29.5345208Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-10-28T02:44:29.5387271Z ##[group]Checking out the ref2026-10-28T02:44:29.5392053Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-10-28T02:44:29.5501361Z Switched to a new branch 'main'2026-10-28T02:44:29.5503516Z branch 'main' set up to track 'origin/main'.2026-10-28T02:44:29.5512083Z ##[endgroup]2026-10-28T02:44:29.5562568Z [command]/usr/bin/git log -1 --format=%H2026-10-28T02:44:29.5595317Z 63ec080e4eea87fb8a9eae678ab9944ec24612512026-10-28T02:44:29.5979374Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-28T02:44:29.5980906Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-28T02:44:29.5982256Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-28T02:44:29.6070121Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-28T02:44:29.6071193Z env:2026-10-28T02:44:29.6072358Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-10-28T02:44:29.6073686Z SETUP_ENV_YAML: {}2026-10-28T02:44:29.6074714Z ##[endgroup]2026-10-28T02:44:33.1417891Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-28T02:44:33.1418590Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-10-28T02:44:33.1484066Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-28T02:44:33.1484516Z env:2026-10-28T02:44:33.1485054Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-10-28T02:44:33.1485679Z ##[endgroup]2026-10-28T02:44:33.1644066Z ##[group]Run true2026-10-28T02:44:33.1644385Z [36;1mtrue[0m2026-10-28T02:44:33.1708453Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-28T02:44:33.1708888Z ##[endgroup]2026-10-28T02:44:33.1895062Z ##[group]Run medyagh/setup-minikube@latest2026-10-28T02:44:33.1895415Z with:2026-10-28T02:44:33.1895633Z start: true2026-10-28T02:44:33.1895825Z cache: true2026-10-28T02:44:33.1896029Z minikube-version: latest2026-10-28T02:44:33.1896297Z wait: all2026-10-28T02:44:33.1896485Z ##[endgroup]2026-10-28T02:44:33.3276560Z (node:2227) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-28T02:44:33.3278510Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-28T02:44:34.0956612Z [command]/usr/bin/chmod +x /home/runner/work/_temp/a6fa77bc-b825-4dc2-a49e-28f82cbd87082026-10-28T02:44:34.2826911Z [command]/home/runner/bin/minikube version --short2026-10-28T02:44:34.3472222Z v1.39.02026-10-28T02:44:34.4219965Z Cache hit for: preloaded-tarball-v1.39.0-x64-stable-docker2026-10-28T02:44:34.4228820Z Cache hit for: kic-v1.39.0-x642026-10-28T02:44:34.4350230Z (node:2227) [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-28T02:44:35.4826563Z Received 88080384 of 288577004 (30.5%), 82.4 MBs/sec2026-10-28T02:44:35.5068597Z Received 96468992 of 531630645 (18.1%), 89.8 MBs/sec2026-10-28T02:44:36.5027549Z Received 188743680 of 288577004 (65.4%), 88.3 MBs/sec2026-10-28T02:44:36.5436916Z Received 192937984 of 531630645 (36.3%), 89.3 MBs/sec2026-10-28T02:44:37.4474627Z Received 288577004 of 288577004 (100.0%), 92.3 MBs/sec2026-10-28T02:44:37.4475536Z Cache Size: ~275 MB (288577004 B)2026-10-28T02:44:37.4708192Z [command]/usr/bin/tar -xf /home/runner/work/_temp/428a2ba7-20a7-4693-8cd1-99d93503d222/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-28T02:44:37.5777181Z Received 306184192 of 531630645 (57.6%), 94.3 MBs/sec2026-10-28T02:44:38.5843632Z Received 478150656 of 531630645 (89.9%), 111.2 MBs/sec2026-10-28T02:44:38.6725066Z Cache restored successfully2026-10-28T02:44:38.8946194Z Received 531630645 of 531630645 (100.0%), 114.9 MBs/sec2026-10-28T02:44:38.8948133Z Cache Size: ~507 MB (531630645 B)2026-10-28T02:44:38.8988772Z [command]/usr/bin/tar -xf /home/runner/work/_temp/63a83935-19fa-4a49-aed5-db9a8d7d06ae/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-28T02:44:39.8567254Z Cache restored successfully2026-10-28T02:44:39.9772595Z [command]/home/runner/bin/minikube start --wait all2026-10-28T02:44:40.0413330Z * minikube v1.39.0 on Ubuntu 22.042026-10-28T02:44:54.8956074Z ! 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-28T02:44:54.8971431Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-10-28T02:44:55.0044418Z * Using Docker driver with root privileges2026-10-28T02:44:55.0053214Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-10-28T02:44:55.0059700Z * Pulling base image v0.0.51 ...2026-10-28T02:45:14.0408899Z * Preparing Kubernetes v1.37.0 on containerd 2.3.4 ...2026-10-28T02:45:21.9976217Z * Configuring CNI (Container Networking Interface) ...2026-10-28T02:45:27.4233843Z * Verifying Kubernetes components...2026-10-28T02:45:27.4585325Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-10-28T02:45:28.1215849Z * Enabled addons: storage-provisioner, default-storageclass2026-10-28T02:46:00.0497116Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-10-28T02:46:00.0675408Z [command]/home/runner/bin/minikube version --short2026-10-28T02:46:00.1293141Z v1.39.02026-10-28T02:46:00.1840817Z ##[group]Run actions/setup-go@v62026-10-28T02:46:00.1841130Z with:2026-10-28T02:46:00.1841334Z go-version: 1.262026-10-28T02:46:00.1841543Z cache: true2026-10-28T02:46:00.1841775Z cache-dependency-path: go.sum2026-10-28T02:46:00.1842058Z check-latest: false2026-10-28T02:46:00.1845401Z token: ***2026-10-28T02:46:00.1845629Z ##[endgroup]2026-10-28T02:46:00.3352328Z Setup go version spec 1.262026-10-28T02:46:00.4354035Z Found in cache @ /opt/hostedtoolcache/go/1.26.10/x642026-10-28T02:46:00.4354679Z Added go to the path2026-10-28T02:46:00.4355080Z Successfully set up Go version 1.262026-10-28T02:46:03.8939018Z [command]/opt/hostedtoolcache/go/1.26.10/x64/bin/go env GOMODCACHE2026-10-28T02:46:03.8981865Z [command]/opt/hostedtoolcache/go/1.26.10/x64/bin/go env GOCACHE2026-10-28T02:46:03.9016591Z /home/runner/go/pkg/mod2026-10-28T02:46:03.9048776Z /home/runner/.cache/go-build2026-10-28T02:46:03.9959363Z Cache is not found2026-10-28T02:46:03.9986293Z go version go1.26.10 linux/amd642026-10-28T02:46:03.9986554Z 2026-10-28T02:46:03.9986904Z ##[group]go env2026-10-28T02:46:04.1564265Z AR='ar'2026-10-28T02:46:04.1564756Z CC='gcc'2026-10-28T02:46:04.1565182Z CGO_CFLAGS='-O2 -g'2026-10-28T02:46:04.1565639Z CGO_CPPFLAGS=''2026-10-28T02:46:04.1566468Z CGO_CXXFLAGS='-O2 -g'2026-10-28T02:46:04.1566966Z CGO_ENABLED='1'2026-10-28T02:46:04.1567421Z CGO_FFLAGS='-O2 -g'2026-10-28T02:46:04.1567878Z CGO_LDFLAGS='-O2 -g'2026-10-28T02:46:04.1568351Z CXX='g++'2026-10-28T02:46:04.1568793Z GCCGO='gccgo'2026-10-28T02:46:04.1569349Z GO111MODULE=''2026-10-28T02:46:04.1569808Z GOAMD64='v1'2026-10-28T02:46:04.1570310Z GOARCH='amd64'2026-10-28T02:46:04.1570737Z GOAUTH='netrc'2026-10-28T02:46:04.1571124Z GOBIN=''2026-10-28T02:46:04.1571588Z GOCACHE='/home/runner/.cache/go-build'2026-10-28T02:46:04.1572176Z GOCACHEPROG=''2026-10-28T02:46:04.1572591Z GODEBUG=''2026-10-28T02:46:04.1573203Z GOENV='/home/runner/.config/go/env'2026-10-28T02:46:04.1574176Z GOEXE=''2026-10-28T02:46:04.1574738Z GOEXPERIMENT=''2026-10-28T02:46:04.1575210Z GOFIPS140='off'2026-10-28T02:46:04.1575603Z GOFLAGS=''2026-10-28T02:46:04.1577100Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build1902902227=/tmp/go-build -gno-record-gcc-switches'2026-10-28T02:46:04.1578257Z GOHOSTARCH='amd64'2026-10-28T02:46:04.1578610Z GOHOSTOS='linux'2026-10-28T02:46:04.1578954Z GOINSECURE=''2026-10-28T02:46:04.1579540Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-10-28T02:46:04.1580281Z GOMODCACHE='/home/runner/go/pkg/mod'2026-10-28T02:46:04.1580737Z GONOPROXY=''2026-10-28T02:46:04.1581067Z GONOSUMDB=''2026-10-28T02:46:04.1581411Z GOOS='linux'2026-10-28T02:46:04.1581771Z GOPATH='/home/runner/go'2026-10-28T02:46:04.1582156Z GOPRIVATE=''2026-10-28T02:46:04.1582613Z GOPROXY='https://proxy.golang.org,direct'2026-10-28T02:46:04.1583208Z GOROOT='/opt/hostedtoolcache/go/1.26.10/x64'2026-10-28T02:46:04.1583773Z GOSUMDB='sum.golang.org'2026-10-28T02:46:04.1584583Z GOTELEMETRY='local'2026-10-28T02:46:04.1585072Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-10-28T02:46:04.1585552Z GOTMPDIR=''2026-10-28T02:46:04.1585838Z GOTOOLCHAIN='local'2026-10-28T02:46:04.1586392Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.10/x64/pkg/tool/linux_amd64'2026-10-28T02:46:04.1587035Z GOVCS=''2026-10-28T02:46:04.1587394Z GOVERSION='go1.26.10'2026-10-28T02:46:04.1587803Z GOWORK=''2026-10-28T02:46:04.1588167Z PKG_CONFIG='pkg-config'2026-10-28T02:46:04.1588419Z 2026-10-28T02:46:04.1588956Z ##[endgroup]2026-10-28T02:46:04.1759176Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-28T02:46:04.1759718Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-10-28T02:46:04.1822175Z shell: /usr/bin/bash -e {0}2026-10-28T02:46:04.1822474Z env:2026-10-28T02:46:04.1822705Z GOTOOLCHAIN: local2026-10-28T02:46:04.1822998Z OSPOOL_EP_OSPoolEPTag: 25-release2026-10-28T02:46:04.1823325Z OSPOOL_EP_CMTag: 25.0-el92026-10-28T02:46:04.1823629Z OSPOOL_EP_CvmfsType: cvmfsexec2026-10-28T02:46:04.1824081Z ##[endgroup]2026-10-28T02:46:04.5400851Z go: downloading github.com/gruntwork-io/terratest v0.56.02026-10-28T02:46:04.7100487Z go: downloading github.com/masterminds/sprig v2.22.0+incompatible2026-10-28T02:46:04.7735506Z go: downloading github.com/stretchr/testify v1.11.12026-10-28T02:46:04.8006502Z go: downloading gopkg.in/yaml.v3 v3.0.12026-10-28T02:46:04.8776616Z go: downloading k8s.io/api v0.35.02026-10-28T02:46:04.8777673Z go: downloading k8s.io/apimachinery v0.35.02026-10-28T02:46:06.8750134Z go: downloading github.com/Masterminds/goutils v1.1.12026-10-28T02:46:06.8872378Z go: downloading github.com/Masterminds/semver v1.5.02026-10-28T02:46:06.9022444Z go: downloading github.com/google/uuid v1.6.02026-10-28T02:46:06.9169295Z go: downloading github.com/huandu/xstrings v1.5.02026-10-28T02:46:06.9291754Z go: downloading github.com/imdario/mergo v0.3.162026-10-28T02:46:06.9481137Z go: downloading github.com/mitchellh/copystructure v1.2.02026-10-28T02:46:06.9592671Z go: downloading golang.org/x/crypto v0.52.02026-10-28T02:46:07.1146091Z go: downloading github.com/gruntwork-io/go-commons v0.8.02026-10-28T02:46:07.1302135Z go: downloading github.com/mitchellh/go-homedir v1.1.02026-10-28T02:46:07.1396756Z go: downloading k8s.io/client-go v0.35.02026-10-28T02:46:07.6952549Z go: downloading k8s.io/utils v0.0.0-20251002143259-bc988d571ff42026-10-28T02:46:07.7028404Z go: downloading sigs.k8s.io/randfill v1.0.02026-10-28T02:46:07.7161868Z go: downloading k8s.io/klog/v2 v2.130.12026-10-28T02:46:08.7618797Z go: downloading github.com/davecgh/go-spew v1.1.12026-10-28T02:46:08.7785381Z go: downloading github.com/pmezard/go-difflib v1.0.02026-10-28T02:46:08.8237685Z go: downloading github.com/mitchellh/reflectwalk v1.0.22026-10-28T02:46:09.2528946Z go: downloading github.com/go-errors/errors v1.0.2-0.20180813162953-d98b870cc4e02026-10-28T02:46:09.2563132Z go: downloading github.com/urfave/cli v1.22.162026-10-28T02:46:09.2792452Z go: downloading github.com/aws/aws-sdk-go-v2 v1.32.52026-10-28T02:46:09.3027520Z go: downloading github.com/aws/aws-sdk-go-v2/config v1.28.52026-10-28T02:46:09.3695613Z go: downloading github.com/aws/aws-sdk-go-v2/credentials v1.17.462026-10-28T02:46:09.3885786Z go: downloading github.com/aws/aws-sdk-go-v2/feature/s3/manager v1.17.412026-10-28T02:46:09.3887162Z go: downloading github.com/aws/aws-sdk-go-v2/service/acm v1.30.62026-10-28T02:46:09.4091521Z go: downloading github.com/aws/aws-sdk-go-v2/service/autoscaling v1.51.02026-10-28T02:46:09.4116035Z go: downloading github.com/aws/aws-sdk-go-v2/service/cloudwatchlogs v1.44.02026-10-28T02:46:09.4541071Z go: downloading github.com/aws/aws-sdk-go-v2/service/dynamodb v1.37.12026-10-28T02:46:09.4956188Z go: downloading github.com/aws/aws-sdk-go-v2/service/ec2 v1.193.02026-10-28T02:46:09.7550020Z go: downloading github.com/aws/aws-sdk-go-v2/service/ecr v1.36.62026-10-28T02:46:09.7869283Z go: downloading github.com/aws/aws-sdk-go-v2/service/ecs v1.52.02026-10-28T02:46:09.8304396Z go: downloading github.com/aws/aws-sdk-go-v2/service/iam v1.38.12026-10-28T02:46:09.9076609Z go: downloading github.com/aws/aws-sdk-go-v2/service/kms v1.37.62026-10-28T02:46:09.9077799Z go: downloading github.com/aws/aws-sdk-go-v2/service/lambda v1.69.02026-10-28T02:46:09.9579488Z go: downloading github.com/aws/aws-sdk-go-v2/service/rds v1.91.02026-10-28T02:46:09.9621266Z go: downloading github.com/aws/aws-sdk-go-v2/service/route53 v1.46.22026-10-28T02:46:10.0113482Z go: downloading github.com/aws/aws-sdk-go-v2/service/s3 v1.69.02026-10-28T02:46:10.0535524Z go: downloading github.com/aws/aws-sdk-go-v2/service/secretsmanager v1.34.62026-10-28T02:46:10.0537065Z go: downloading github.com/aws/aws-sdk-go-v2/service/sns v1.33.62026-10-28T02:46:10.0910223Z go: downloading github.com/aws/aws-sdk-go-v2/service/sqs v1.37.12026-10-28T02:46:10.1032303Z go: downloading github.com/aws/aws-sdk-go-v2/service/ssm v1.56.02026-10-28T02:46:10.1149084Z go: downloading github.com/aws/aws-sdk-go-v2/service/sts v1.33.12026-10-28T02:46:10.1150464Z go: downloading github.com/go-sql-driver/mysql v1.8.12026-10-28T02:46:10.1383213Z go: downloading github.com/hashicorp/go-multierror v1.1.12026-10-28T02:46:10.1388384Z go: downloading github.com/jackc/pgx/v5 v5.9.02026-10-28T02:46:10.1535799Z go: downloading github.com/pquerna/otp v1.4.02026-10-28T02:46:10.1671644Z go: downloading github.com/mattn/go-zglob v0.0.2-0.20190814121620-e3c9456763262026-10-28T02:46:10.1815212Z go: downloading github.com/spf13/pflag v1.0.92026-10-28T02:46:10.1879975Z go: downloading golang.org/x/term v0.43.02026-10-28T02:46:10.1883453Z go: downloading github.com/gorilla/websocket v1.5.4-0.20250319132907-e064f32e36742026-10-28T02:46:10.2054302Z go: downloading github.com/munnerz/goautoneg v0.0.0-20191010083416-a7dc8b61c8222026-10-28T02:46:10.2118461Z go: downloading golang.org/x/net v0.54.02026-10-28T02:46:10.2124530Z go: downloading gopkg.in/inf.v0 v0.9.12026-10-28T02:46:10.3570189Z go: downloading k8s.io/kube-openapi v0.0.0-20250910181357-589584f1c9122026-10-28T02:46:10.3794473Z go: downloading sigs.k8s.io/structured-merge-diff/v6 v6.3.02026-10-28T02:46:10.4098890Z go: downloading sigs.k8s.io/json v0.0.0-20250730193827-2d320260d7302026-10-28T02:46:10.4300160Z go: downloading github.com/go-logr/logr v1.4.32026-10-28T02:46:10.6162629Z go: downloading github.com/cpuguy83/go-md2man/v2 v2.0.52026-10-28T02:46:10.6238339Z go: downloading github.com/aws/smithy-go v1.22.12026-10-28T02:46:10.7280089Z go: downloading github.com/aws/aws-sdk-go-v2/internal/ini v1.8.12026-10-28T02:46:10.7281213Z go: downloading github.com/aws/aws-sdk-go-v2/service/sso v1.24.62026-10-28T02:46:10.7282462Z go: downloading github.com/aws/aws-sdk-go-v2/feature/ec2/imds v1.16.202026-10-28T02:46:10.7432031Z go: downloading github.com/aws/aws-sdk-go-v2/service/ssooidc v1.28.52026-10-28T02:46:10.7503454Z go: downloading github.com/aws/aws-sdk-go-v2/internal/configsources v1.3.242026-10-28T02:46:10.7511339Z go: downloading github.com/jmespath/go-jmespath v0.4.02026-10-28T02:46:10.7582000Z go: downloading github.com/aws/aws-sdk-go-v2/aws/protocol/eventstream v1.6.72026-10-28T02:46:10.7950708Z go: downloading github.com/aws/aws-sdk-go-v2/service/internal/endpoint-discovery v1.10.52026-10-28T02:46:10.7951707Z go: downloading github.com/aws/aws-sdk-go-v2/service/internal/accept-encoding v1.12.12026-10-28T02:46:10.8091982Z go: downloading github.com/aws/aws-sdk-go-v2/service/internal/presigned-url v1.12.52026-10-28T02:46:10.8500979Z go: downloading github.com/aws/aws-sdk-go-v2/internal/v4a v1.3.242026-10-28T02:46:10.8650787Z go: downloading github.com/aws/aws-sdk-go-v2/service/internal/checksum v1.4.52026-10-28T02:46:10.8659047Z go: downloading github.com/aws/aws-sdk-go-v2/service/internal/s3shared v1.18.52026-10-28T02:46:10.8810790Z go: downloading filippo.io/edwards25519 v1.1.02026-10-28T02:46:10.8811719Z go: downloading github.com/hashicorp/errwrap v1.0.02026-10-28T02:46:10.8838946Z go: downloading github.com/google/gnostic-models v0.7.02026-10-28T02:46:10.8900279Z go: downloading google.golang.org/protobuf v1.36.82026-10-28T02:46:10.8968601Z go: downloading golang.org/x/time v0.9.02026-10-28T02:46:10.8971492Z go: downloading github.com/moby/spdystream v0.5.12026-10-28T02:46:10.9184564Z go: downloading golang.org/x/sys v0.45.02026-10-28T02:46:10.9367980Z go: downloading github.com/fxamacker/cbor/v2 v2.9.02026-10-28T02:46:10.9394395Z go: downloading golang.org/x/oauth2 v0.30.02026-10-28T02:46:11.0939981Z go: downloading github.com/json-iterator/go v1.1.122026-10-28T02:46:11.1253613Z go: downloading go.yaml.in/yaml/v2 v2.4.32026-10-28T02:46:11.1685752Z go: downloading github.com/russross/blackfriday/v2 v2.1.02026-10-28T02:46:11.1693434Z go: downloading github.com/aws/aws-sdk-go-v2/internal/endpoints/v2 v2.6.242026-10-28T02:46:11.1903138Z go: downloading github.com/boombuler/barcode v1.0.1-0.20190219062509-6c824513bacc2026-10-28T02:46:11.2140775Z go: downloading sigs.k8s.io/yaml v1.6.02026-10-28T02:46:11.2141542Z go: downloading github.com/mxk/go-flowrate v0.0.0-20140419014527-cca7078d478f2026-10-28T02:46:11.2168024Z go: downloading go.yaml.in/yaml/v3 v3.0.42026-10-28T02:46:11.2249145Z go: downloading github.com/x448/float16 v0.8.42026-10-28T02:46:11.2298117Z go: downloading github.com/jackc/pgpassfile v1.0.02026-10-28T02:46:11.2346911Z go: downloading github.com/jackc/pgservicefile v0.0.0-20240606120523-5a60cdf6a7612026-10-28T02:46:11.2358715Z go: downloading golang.org/x/text v0.37.02026-10-28T02:46:11.2376620Z go: downloading github.com/jackc/puddle/v2 v2.2.22026-10-28T02:46:11.6301592Z go: downloading github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd2026-10-28T02:46:11.6303707Z go: downloading github.com/modern-go/reflect2 v1.0.3-0.20250322232337-35a7c28c31ee2026-10-28T02:46:11.6309005Z go: downloading github.com/go-openapi/swag v0.23.02026-10-28T02:46:11.6448859Z go: downloading github.com/go-openapi/jsonreference v0.20.22026-10-28T02:46:11.6496567Z go: downloading gopkg.in/evanphx/json-patch.v4 v4.13.02026-10-28T02:46:11.6546940Z go: downloading golang.org/x/sync v0.20.02026-10-28T02:46:11.6601057Z go: downloading github.com/emicklei/go-restful/v3 v3.12.22026-10-28T02:46:11.6656567Z go: downloading github.com/mailru/easyjson v0.7.72026-10-28T02:46:11.6811443Z go: downloading github.com/go-openapi/jsonpointer v0.21.02026-10-28T02:46:11.6862283Z go: downloading github.com/josharian/intern v1.0.02026-10-28T02:48:48.8508908Z === RUN TestOSPoolEP2026-10-28T02:48:48.8509633Z === PAUSE TestOSPoolEP2026-10-28T02:48:48.8510407Z === CONT TestOSPoolEP2026-10-28T02:48:48.8511760Z TestOSPoolEP 2026-10-28T02:48:48Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:48:48.8645673Z TestOSPoolEP 2026-10-28T02:48:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 apply -f /tmp/TestOSPoolEP3454749281]2026-10-28T02:48:49.9797932Z TestOSPoolEP 2026-10-28T02:48:49Z logger.go:67: pod/idtoken-generator created2026-10-28T02:48:49.9888315Z TestOSPoolEP 2026-10-28T02:48:49Z logger.go:67: secret/pool-passwd created2026-10-28T02:48:49.9970403Z TestOSPoolEP 2026-10-28T02:48:49Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-28T02:48:49.9972619Z TestOSPoolEP 2026-10-28T02:48:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:48:49.9997173Z TestOSPoolEP 2026-10-28T02:48:49Z 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-28T02:49:00.0006112Z TestOSPoolEP 2026-10-28T02:49:00Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-28T02:49:00.0007792Z TestOSPoolEP 2026-10-28T02:49:00Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:49:00.0035118Z TestOSPoolEP 2026-10-28T02:49:00Z logger.go:67: Pod is now available2026-10-28T02:49:00.0037104Z TestOSPoolEP 2026-10-28T02:49:00Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-10-28T02:49:01.0441441Z TestOSPoolEP 2026-10-28T02:49:01Z logger.go:67: ***2026-10-28T02:49:01.0524108Z TestOSPoolEP 2026-10-28T02:49:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 apply -f /tmp/TestOSPoolEP2680027706]2026-10-28T02:49:01.2643522Z TestOSPoolEP 2026-10-28T02:49:01Z logger.go:67: secret/pool-token created2026-10-28T02:49:01.2694636Z TestOSPoolEP 2026-10-28T02:49:01Z retry.go:91: Wait for secret pool-token to be provisioned.2026-10-28T02:49:01.2696803Z TestOSPoolEP 2026-10-28T02:49:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:49:01.2729515Z TestOSPoolEP 2026-10-28T02:49:01Z logger.go:67: Secret is now available2026-10-28T02:49:01.2764023Z TestOSPoolEP 2026-10-28T02:49:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 apply -k /tmp/kustomize-template-1405410804]2026-10-28T02:49:01.6096527Z TestOSPoolEP 2026-10-28T02:49:01Z logger.go:67: service/test-cm created2026-10-28T02:49:01.6242952Z TestOSPoolEP 2026-10-28T02:49:01Z 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-10-28T02:49:01.6247539Z TestOSPoolEP 2026-10-28T02:49:01Z logger.go:67: deployment.apps/ospool-ep created2026-10-28T02:49:01.6372698Z TestOSPoolEP 2026-10-28T02:49:01Z logger.go:67: deployment.apps/test-cm created2026-10-28T02:49:01.6446430Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-10-28T02:49:01.6448246Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-28T02:49:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:49:01.6496007Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-28T02:49:01Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-28T02:49:01.6514315Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-28T02:49:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:49:01.6519627Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-28T02:49:01Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-28T02:49:01.6524251Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-28T02:49:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:49:01.6640995Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-28T02:49:01Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available, missing 'Progressing' condition. Sleeping for 10s and will try again.2026-10-28T02:49:01.6647362Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-28T02:49:01Z 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-549bffc4dc". Sleeping for 10s and will try again.2026-10-28T02:49:11.6668632Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-28T02:49:11Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-28T02:49:11.6670539Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-28T02:49:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:49:11.6672878Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-28T02:49:11Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-28T02:49:11.6675150Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-28T02:49:11Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:49:11.6705005Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-28T02:49:11Z 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-549bffc4dc" is progressing.. Sleeping for 10s and will try again.2026-10-28T02:49:11.6708918Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-28T02:49:11Z logger.go:67: Deployment is now available2026-10-28T02:49:21.6727830Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-28T02:49:21Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-28T02:49:21.6730911Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-28T02:49:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:49:21.6767231Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-28T02:49:21Z logger.go:67: Deployment is now available2026-10-28T02:49:21.6775963Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP2026-10-28T02:49:21.6777957Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-28T02:49:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:49:21.6810801Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-28T02:49:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 cp ../test-configs/ospool-ep/condor_status.sh test-cm-7f9d786cd6-v4tj9:/tmp/condor_status.sh]2026-10-28T02:49:22.3449012Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-28T02:49:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec test-cm-7f9d786cd6-v4tj9 -- chmod +x /tmp/condor_status.sh]2026-10-28T02:49:22.4987912Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-28T02:49:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec test-cm-7f9d786cd6-v4tj9 -- sh -c /tmp/condor_status.sh]2026-10-28T02:49:22.6678152Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-28T02:49:22Z logger.go:67: command terminated with exit code 12026-10-28T02:49:22.6720611Z test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-7f9d786cd6-v4tj9 failed. Retrying in 10s.2026-10-28T02:49:32.6729161Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-28T02:49:32Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec test-cm-7f9d786cd6-v4tj9 -- sh -c /tmp/condor_status.sh]2026-10-28T02:49:32.8572763Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-28T02:49:32Z logger.go:67: command terminated with exit code 12026-10-28T02:49:32.8619032Z test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-7f9d786cd6-v4tj9 failed. Retrying in 10s.2026-10-28T02:49:42.8621741Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-28T02:49:42Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec test-cm-7f9d786cd6-v4tj9 -- sh -c /tmp/condor_status.sh]2026-10-28T02:49:43.0299831Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity2026-10-28T02:49:43.0302228Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-28T02:49:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:49:43.0335233Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-28T02:49:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 cp ../test-configs/ospool-ep/has_singularity.sh test-cm-7f9d786cd6-v4tj9:/tmp/has_singularity.sh]2026-10-28T02:49:43.2221942Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-28T02:49:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec test-cm-7f9d786cd6-v4tj9 -- chmod +x /tmp/has_singularity.sh]2026-10-28T02:49:43.3739183Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-28T02:49:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec test-cm-7f9d786cd6-v4tj9 -- sh -c /tmp/has_singularity.sh]2026-10-28T02:49:43.5432683Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-10-28T02:49:43.5435000Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:49:43Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:49:43.5466389Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:49:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 cp ../test-configs/ospool-ep/has_cvmfs.sh test-cm-7f9d786cd6-v4tj9:/tmp/has_cvmfs.sh]2026-10-28T02:49:43.7428941Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:49:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec test-cm-7f9d786cd6-v4tj9 -- chmod +x /tmp/has_cvmfs.sh]2026-10-28T02:49:43.8926869Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:49:43Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec test-cm-7f9d786cd6-v4tj9 -- sh -c /tmp/has_cvmfs.sh]2026-10-28T02:49:44.0647174Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:49:44Z logger.go:67: command terminated with exit code 12026-10-28T02:49:44.0683146Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-v4tj9 failed. Retrying in 30s.2026-10-28T02:50:14.0686621Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:50:14Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec test-cm-7f9d786cd6-v4tj9 -- sh -c /tmp/has_cvmfs.sh]2026-10-28T02:50:14.2250823Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:50:14Z logger.go:67: command terminated with exit code 12026-10-28T02:50:14.2286759Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-v4tj9 failed. Retrying in 30s.2026-10-28T02:50:44.2298133Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:50:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec test-cm-7f9d786cd6-v4tj9 -- sh -c /tmp/has_cvmfs.sh]2026-10-28T02:50:44.3906869Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:50:44Z logger.go:67: command terminated with exit code 12026-10-28T02:50:44.3930399Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-v4tj9 failed. Retrying in 30s.2026-10-28T02:51:14.3938185Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:51:14Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec test-cm-7f9d786cd6-v4tj9 -- sh -c /tmp/has_cvmfs.sh]2026-10-28T02:51:14.5574487Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:51:14Z logger.go:67: command terminated with exit code 12026-10-28T02:51:14.5612734Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-v4tj9 failed. Retrying in 30s.2026-10-28T02:51:44.5618363Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:51:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec test-cm-7f9d786cd6-v4tj9 -- sh -c /tmp/has_cvmfs.sh]2026-10-28T02:51:44.7126255Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:51:44Z logger.go:67: command terminated with exit code 12026-10-28T02:51:44.7161800Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-v4tj9 failed. Retrying in 30s.2026-10-28T02:52:14.7172400Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:52:14Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec test-cm-7f9d786cd6-v4tj9 -- sh -c /tmp/has_cvmfs.sh]2026-10-28T02:52:14.8720168Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:52:14Z logger.go:67: command terminated with exit code 12026-10-28T02:52:14.8756536Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-v4tj9 failed. Retrying in 30s.2026-10-28T02:52:44.8810399Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:52:44Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec test-cm-7f9d786cd6-v4tj9 -- sh -c /tmp/has_cvmfs.sh]2026-10-28T02:52:45.0449505Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:52:45Z logger.go:67: command terminated with exit code 12026-10-28T02:52:45.0487138Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-v4tj9 failed. Retrying in 30s.2026-10-28T02:53:15.0529933Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:53:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec test-cm-7f9d786cd6-v4tj9 -- sh -c /tmp/has_cvmfs.sh]2026-10-28T02:53:15.2115798Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:53:15Z logger.go:67: command terminated with exit code 12026-10-28T02:53:15.2164652Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-v4tj9 failed. Retrying in 30s.2026-10-28T02:53:45.2190218Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:53:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec test-cm-7f9d786cd6-v4tj9 -- sh -c /tmp/has_cvmfs.sh]2026-10-28T02:53:45.3776336Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:53:45Z logger.go:67: command terminated with exit code 12026-10-28T02:53:45.3815799Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-v4tj9 failed. Retrying in 30s.2026-10-28T02:54:15.3874354Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:54:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 exec test-cm-7f9d786cd6-v4tj9 -- sh -c /tmp/has_cvmfs.sh]2026-10-28T02:54:15.5427258Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-28T02:54:15Z logger.go:67: command terminated with exit code 12026-10-28T02:54:15.5463627Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-v4tj9 failed. Retrying in 30s.2026-10-28T02:54:45.5467068Z test_utils.go:105: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-7f9d786cd6-v4tj9 did not succeed within {10 30000000000} retries2026-10-28T02:54:45.5480020Z TestOSPoolEP 2026-10-28T02:54:45Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:54:45.5554453Z TestOSPoolEP 2026-10-28T02:54:45Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:54:45.7259718Z TestOSPoolEP 2026-10-28T02:54:45Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:54:45.8589581Z TestOSPoolEP 2026-10-28T02:54:45Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:54:45.9957829Z TestOSPoolEP 2026-10-28T02:54:45Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:54:45.9985943Z === NAME TestOSPoolEP2026-10-28T02:54:45.9986861Z ospool_ep_test.go:72: ---2026-10-28T02:54:45.9987594Z Events for pod idtoken-generator:2026-10-28T02:54:45.9989051Z 2026-10-28 02:48:49 +0000 UTC Normal Successfully assigned test-ospool-ep-wysxv5/idtoken-generator to minikube2026-10-28T02:54:45.9990382Z 2026-10-28 02:48:50 +0000 UTC Normal Pulling image "htcondor/base"2026-10-28T02:54:45.9992136Z 2026-10-28 02:48:56 +0000 UTC Normal Successfully pulled image "htcondor/base" in 6.328s (6.328s including waiting). Image size: 196303183 bytes.2026-10-28T02:54:45.9993516Z 2026-10-28 02:48:56 +0000 UTC Normal Container created2026-10-28T02:54:45.9994706Z 2026-10-28 02:48:56 +0000 UTC Normal Container started2026-10-28T02:54:45.9995367Z 2026-10-28T02:54:45.9995835Z ---2026-10-28T02:54:45.9996917Z TestOSPoolEP 2026-10-28T02:54:45Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:54:46.0011695Z ospool_ep_test.go:72: ---2026-10-28T02:54:46.0012924Z Events for pod ospool-ep-549bffc4dc-nkwc7:2026-10-28T02:54:46.0017269Z 2026-10-28 02:49:01 +0000 UTC Normal Successfully assigned test-ospool-ep-wysxv5/ospool-ep-549bffc4dc-nkwc7 to minikube2026-10-28T02:54:46.0018920Z 2026-10-28 02:49:02 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-10-28T02:54:46.0020883Z 2026-10-28 02:49:03 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.575s (1.575s including waiting). Image size: 2893600 bytes.2026-10-28T02:54:46.0022250Z 2026-10-28 02:49:03 +0000 UTC Normal Container created2026-10-28T02:54:46.0023013Z 2026-10-28 02:49:03 +0000 UTC Normal Container started2026-10-28T02:54:46.0024409Z 2026-10-28 02:49:03 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-10-28T02:54:46.0026571Z 2026-10-28 02:49:19 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 11.517s (15.971s including waiting). Image size: 567517236 bytes.2026-10-28T02:54:46.0028002Z 2026-10-28 02:49:19 +0000 UTC Normal Container created2026-10-28T02:54:46.0028760Z 2026-10-28 02:49:19 +0000 UTC Normal Container started2026-10-28T02:54:46.0029256Z 2026-10-28T02:54:46.0029582Z ---2026-10-28T02:54:46.0030455Z TestOSPoolEP 2026-10-28T02:54:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:54:46.0038618Z ospool_ep_test.go:72: ---2026-10-28T02:54:46.0040256Z Events for pod test-cm-7f9d786cd6-v4tj9:2026-10-28T02:54:46.0041955Z 2026-10-28 02:49:01 +0000 UTC Normal Successfully assigned test-ospool-ep-wysxv5/test-cm-7f9d786cd6-v4tj9 to minikube2026-10-28T02:54:46.0043401Z 2026-10-28 02:49:02 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-10-28T02:54:46.0045930Z 2026-10-28 02:49:08 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 4.675s (6.206s including waiting). Image size: 198153089 bytes.2026-10-28T02:54:46.0047409Z 2026-10-28 02:49:08 +0000 UTC Normal Container created2026-10-28T02:54:46.0048302Z 2026-10-28 02:49:08 +0000 UTC Normal Container started2026-10-28T02:54:46.0048854Z 2026-10-28T02:54:46.0049218Z ---2026-10-28T02:54:46.0050140Z TestOSPoolEP 2026-10-28T02:54:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-28T02:54:46.0103776Z TestOSPoolEP 2026-10-28T02:54:46Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 delete -f /tmp/TestOSPoolEP1774309397]2026-10-28T02:54:46.1192996Z TestOSPoolEP 2026-10-28T02:54:46Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-wysxv5 namespace2026-10-28T02:54:46.1254330Z TestOSPoolEP 2026-10-28T02:54:46Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-wysxv5 namespace2026-10-28T02:54:47.5942619Z TestOSPoolEP 2026-10-28T02:54:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 delete -f /tmp/TestOSPoolEP741210603]2026-10-28T02:54:47.7209975Z TestOSPoolEP 2026-10-28T02:54:47Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-wysxv5 namespace2026-10-28T02:54:47.7248495Z TestOSPoolEP 2026-10-28T02:54:47Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-wysxv5 delete -k /tmp/kustomize-template-1405410804]2026-10-28T02:54:47.8775997Z TestOSPoolEP 2026-10-28T02:54:47Z logger.go:67: service "test-cm" deleted from test-ospool-ep-wysxv5 namespace2026-10-28T02:54:47.8828735Z TestOSPoolEP 2026-10-28T02:54:47Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-wysxv5 namespace2026-10-28T02:54:47.8879086Z TestOSPoolEP 2026-10-28T02:54:47Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-wysxv5 namespace2026-10-28T02:54:47.9027039Z --- FAIL: TestOSPoolEP (359.05s)2026-10-28T02:54:47.9028371Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (20.03s)2026-10-28T02:54:47.9029517Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP (21.35s)2026-10-28T02:54:47.9031404Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity (0.51s)2026-10-28T02:54:47.9032579Z --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (302.00s)2026-10-28T02:54:47.9033368Z FAIL2026-10-28T02:54:47.9088051Z FAIL github.com/osg-htc/k8s-integration-tests/test 359.074s2026-10-28T02:54:47.9259555Z FAIL2026-10-28T02:54:48.6228223Z ##[error]Process completed with exit code 1.2026-10-28T02:54:48.6285302Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-28T02:54:48.6285959Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-10-28T02:54:48.6350149Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-28T02:54:48.6350515Z env:2026-10-28T02:54:48.6350719Z GOTOOLCHAIN: local2026-10-28T02:54:48.6351165Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-10-28T02:54:48.6351648Z ##[endgroup]2026-10-28T02:54:48.6530058Z ##[group]Run actions/upload-artifact@v42026-10-28T02:54:48.6530396Z with:2026-10-28T02:54:48.6530785Z name: TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce72322026-10-28T02:54:48.6531266Z path: /tmp/k8s-tests2026-10-28T02:54:48.6531499Z retention-days: 52026-10-28T02:54:48.6531720Z if-no-files-found: warn2026-10-28T02:54:48.6531958Z compression-level: 62026-10-28T02:54:48.6532174Z overwrite: false2026-10-28T02:54:48.6532390Z include-hidden-files: false2026-10-28T02:54:48.6532632Z env:2026-10-28T02:54:48.6532812Z GOTOOLCHAIN: local2026-10-28T02:54:48.6533028Z ##[endgroup]2026-10-28T02:54:48.8629701Z (node:23968) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-28T02:54:48.8632797Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-28T02:54:48.8824786Z With the provided path, there will be 6 files uploaded2026-10-28T02:54:48.8826147Z Artifact name is valid!2026-10-28T02:54:48.8826772Z Root directory input is valid!2026-10-28T02:54:49.1246407Z Beginning upload of artifact content to blob storage2026-10-28T02:54:49.1559186Z (node:23968) [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-28T02:54:49.1844538Z Uploaded bytes 139752026-10-28T02:54:49.2012859Z Finished uploading artifact content to blob storage!2026-10-28T02:54:49.2014713Z SHA256 digest of uploaded artifact zip is ff97214604b036dde2ae1ecbd98cbc10cec37cb82cabe78cedbba14b4474bb192026-10-28T02:54:49.2016431Z Finalizing artifact upload2026-10-28T02:54:49.5783350Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232.zip successfully finalized. Artifact ID 127882332012026-10-28T02:54:49.5786058Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232 has been successfully uploaded! Final size is 13975 bytes. Artifact ID is 127882332012026-10-28T02:54:49.5791411Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/40622692936/artifacts/127882332012026-10-28T02:54:49.6048551Z Post job cleanup.2026-10-28T02:54:49.7038353Z [command]/usr/bin/git version2026-10-28T02:54:49.7086321Z git version 2.56.02026-10-28T02:54:49.7132355Z Temporarily overriding HOME='/home/runner/work/_temp/885dca31-2984-4f6a-a650-fb2a280cecd1' before making global git config changes2026-10-28T02:54:49.7134549Z Adding repository directory to the temporary git global config as a safe directory2026-10-28T02:54:49.7139710Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-28T02:54:49.7196460Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-28T02:54:49.7245193Z [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-28T02:54:49.7567890Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-28T02:54:49.7600432Z http.https://github.com/.extraheader2026-10-28T02:54:49.7616650Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-10-28T02:54:49.7663910Z [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-28T02:54:49.7988502Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-28T02:54:49.8065656Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-28T02:54:49.8543133Z Cleaning up orphan processes2026-10-28T02:54:49.9307820Z ##[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/