2026-10-30T03:09:04.9759715Z Current runner version: '2.338.0'2026-10-30T03:09:04.9782762Z ##[group]Runner Image Provisioner2026-10-30T03:09:04.9783716Z Hosted Compute Agent2026-10-30T03:09:04.9784295Z Version: 20261021.6182026-10-30T03:09:04.9785331Z Commit: 21505ad2541d5be6135ed84fc33697146cf75b8e2026-10-30T03:09:04.9786089Z Build Date: 2026-10-21T00:45:21Z2026-10-30T03:09:04.9786756Z Worker ID: {5864e42d-3842-4329-a233-9cbf78d6074b}2026-10-30T03:09:04.9787443Z Region: westcentralus2026-10-30T03:09:04.9788015Z Cloud: Azure2026-10-30T03:09:04.9788526Z ##[endgroup]2026-10-30T03:09:04.9789954Z ##[group]Operating System2026-10-30T03:09:04.9790543Z Ubuntu2026-10-30T03:09:04.9791107Z 22.04.52026-10-30T03:09:04.9791627Z LTS2026-10-30T03:09:04.9792120Z ##[endgroup]2026-10-30T03:09:04.9792673Z ##[group]Runner Image2026-10-30T03:09:04.9793251Z Image: ubuntu-22.042026-10-30T03:09:04.9793773Z Version: 20261025.340.12026-10-30T03:09:04.9795315Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20261025.340/images/ubuntu/Ubuntu2204-Readme.md2026-10-30T03:09:04.9796795Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20261025.3402026-10-30T03:09:04.9797702Z ##[endgroup]2026-10-30T03:09:04.9801189Z ##[group]GITHUB_TOKEN Permissions2026-10-30T03:09:04.9803719Z Actions: write2026-10-30T03:09:04.9804611Z ArtifactMetadata: write2026-10-30T03:09:04.9805242Z Attestations: write2026-10-30T03:09:04.9805828Z Checks: write2026-10-30T03:09:04.9806517Z CodeQuality: write2026-10-30T03:09:04.9807062Z Contents: write2026-10-30T03:09:04.9807580Z CopilotRequests: write2026-10-30T03:09:04.9808216Z Deployments: write2026-10-30T03:09:04.9808744Z Discussions: write2026-10-30T03:09:04.9809299Z Drives: write2026-10-30T03:09:04.9809809Z Issues: write2026-10-30T03:09:04.9810380Z Metadata: read2026-10-30T03:09:04.9810934Z Models: read2026-10-30T03:09:04.9811554Z Packages: write2026-10-30T03:09:04.9812127Z Pages: write2026-10-30T03:09:04.9812673Z PullRequests: write2026-10-30T03:09:04.9813255Z RepositoryProjects: write2026-10-30T03:09:04.9813894Z SecurityEvents: write2026-10-30T03:09:04.9814865Z Statuses: write2026-10-30T03:09:04.9815448Z VulnerabilityAlerts: read2026-10-30T03:09:04.9816029Z ##[endgroup]2026-10-30T03:09:04.9818194Z Secret source: Actions2026-10-30T03:09:04.9819092Z Cache mode: write2026-10-30T03:09:04.9819807Z Prepare workflow directory2026-10-30T03:09:05.0146263Z Prepare all required actions2026-10-30T03:09:05.0193219Z Getting action download info2026-10-30T03:09:05.3929925Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-10-30T03:09:05.5716137Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-10-30T03:09:06.1378581Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-10-30T03:09:06.6785029Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-10-30T03:09:06.9431382Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (63ec080e4eea87fb8a9eae678ab9944ec2461251)2026-10-30T03:09:06.9436929Z ##[group] Inputs2026-10-30T03:09:06.9437563Z testName: TestOSPoolEP2026-10-30T03:09:06.9438593Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-10-30T03:09:06.9439617Z setupScript: 2026-10-30T03:09:06.9440156Z setupEnv: {}2026-10-30T03:09:06.9440670Z ##[endgroup]2026-10-30T03:09:06.9441371Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-testing) / Run Tests2026-10-30T03:09:07.0165740Z ##[group]Run actions/checkout@v52026-10-30T03:09:07.0166559Z with:2026-10-30T03:09:07.0167172Z repository: osg-htc/k8s-integration-tests2026-10-30T03:09:07.0171231Z token: ***2026-10-30T03:09:07.0171802Z ssh-strict: true2026-10-30T03:09:07.0172304Z ssh-user: git2026-10-30T03:09:07.0172819Z persist-credentials: true2026-10-30T03:09:07.0173404Z clean: true2026-10-30T03:09:07.0174143Z sparse-checkout-cone-mode: true2026-10-30T03:09:07.0174902Z fetch-depth: 12026-10-30T03:09:07.0175411Z fetch-tags: false2026-10-30T03:09:07.0175919Z show-progress: true2026-10-30T03:09:07.0176429Z lfs: false2026-10-30T03:09:07.0176894Z submodules: false2026-10-30T03:09:07.0177694Z set-safe-directory: true2026-10-30T03:09:07.0178276Z allow-unsafe-pr-checkout: false2026-10-30T03:09:07.0179098Z ##[endgroup]2026-10-30T03:09:07.2414632Z Syncing repository: osg-htc/k8s-integration-tests2026-10-30T03:09:07.2417791Z ##[group]Getting Git version info2026-10-30T03:09:07.2419445Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-30T03:09:07.2421284Z [command]/usr/bin/git version2026-10-30T03:09:07.2458753Z git version 2.56.02026-10-30T03:09:07.2478095Z ##[endgroup]2026-10-30T03:09:07.2491851Z Temporarily overriding HOME='/home/runner/work/_temp/2e1c5aae-7fa6-4cd1-9bb9-033b66d0ae4e' before making global git config changes2026-10-30T03:09:07.2493924Z Adding repository directory to the temporary git global config as a safe directory2026-10-30T03:09:07.2496889Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-30T03:09:07.2540238Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-30T03:09:07.2546447Z ##[group]Initializing the repository2026-10-30T03:09:07.2549959Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-30T03:09:07.2661746Z hint: Using 'master' as the name for the initial branch. This default branch name2026-10-30T03:09:07.2663924Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-10-30T03:09:07.2666043Z hint: to use in all of your new repositories, which will suppress this warning,2026-10-30T03:09:07.2667789Z hint: call:2026-10-30T03:09:07.2668739Z hint:2026-10-30T03:09:07.2670051Z hint: git config --global init.defaultBranch <name>2026-10-30T03:09:07.2671259Z hint:2026-10-30T03:09:07.2672464Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-10-30T03:09:07.2674300Z hint: 'development'. The just-created branch can be renamed via this command:2026-10-30T03:09:07.2676049Z hint:2026-10-30T03:09:07.2677028Z hint: git branch -m <name>2026-10-30T03:09:07.2678176Z hint:2026-10-30T03:09:07.2679183Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-10-30T03:09:07.2680690Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-10-30T03:09:07.2684241Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-10-30T03:09:07.2720646Z ##[endgroup]2026-10-30T03:09:07.2722348Z ##[group]Disabling automatic garbage collection2026-10-30T03:09:07.2723750Z [command]/usr/bin/git config --local gc.auto 02026-10-30T03:09:07.2754002Z ##[endgroup]2026-10-30T03:09:07.2755652Z ##[group]Setting up auth2026-10-30T03:09:07.2760871Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-30T03:09:07.2791239Z [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-30T03:09:07.3121278Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-30T03:09:07.3152186Z [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-30T03:09:07.3350700Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-30T03:09:07.3379946Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-30T03:09:07.3566652Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-10-30T03:09:07.3607794Z ##[endgroup]2026-10-30T03:09:07.3609400Z ##[group]Fetching the repository2026-10-30T03:09:07.3617355Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +63ec080e4eea87fb8a9eae678ab9944ec2461251:refs/remotes/origin/main2026-10-30T03:09:07.7776178Z From https://github.com/osg-htc/k8s-integration-tests2026-10-30T03:09:07.7778503Z * [new ref] 63ec080e4eea87fb8a9eae678ab9944ec2461251 -> origin/main2026-10-30T03:09:07.7784204Z ##[endgroup]2026-10-30T03:09:07.7786707Z ##[group]Determining the checkout info2026-10-30T03:09:07.7789094Z ##[endgroup]2026-10-30T03:09:07.7790599Z [command]/usr/bin/git sparse-checkout disable2026-10-30T03:09:07.7837166Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-10-30T03:09:07.7867753Z ##[group]Checking out the ref2026-10-30T03:09:07.7870641Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-10-30T03:09:07.7976828Z Switched to a new branch 'main'2026-10-30T03:09:07.7979081Z branch 'main' set up to track 'origin/main'.2026-10-30T03:09:07.7985041Z ##[endgroup]2026-10-30T03:09:07.8013869Z [command]/usr/bin/git log -1 --format=%H2026-10-30T03:09:07.8036171Z 63ec080e4eea87fb8a9eae678ab9944ec24612512026-10-30T03:09:07.8309758Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-30T03:09:07.8312704Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-30T03:09:07.8315489Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-10-30T03:09:07.8374545Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-30T03:09:07.8376211Z env:2026-10-30T03:09:07.8378296Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-10-30T03:09:07.8380725Z SETUP_ENV_YAML: {}2026-10-30T03:09:07.8381809Z ##[endgroup]2026-10-30T03:09:09.6633456Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-30T03:09:09.6634226Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-10-30T03:09:09.6671389Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-30T03:09:09.6671958Z env:2026-10-30T03:09:09.6672554Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-10-30T03:09:09.6673224Z ##[endgroup]2026-10-30T03:09:09.6816496Z ##[group]Run true2026-10-30T03:09:09.6816949Z [36;1mtrue[0m2026-10-30T03:09:09.6850168Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-30T03:09:09.6850803Z ##[endgroup]2026-10-30T03:09:09.7032626Z ##[group]Run medyagh/setup-minikube@latest2026-10-30T03:09:09.7033451Z with:2026-10-30T03:09:09.7034627Z start: true2026-10-30T03:09:09.7035339Z cache: true2026-10-30T03:09:09.7035759Z minikube-version: latest2026-10-30T03:09:09.7036382Z wait: all2026-10-30T03:09:09.7036838Z ##[endgroup]2026-10-30T03:09:09.8300356Z (node:2177) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-30T03:09:09.8301916Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-30T03:09:11.3099989Z [command]/usr/bin/chmod +x /home/runner/work/_temp/8aaf0f62-a77b-4dea-a020-78597bff47732026-10-30T03:09:12.1893744Z [command]/home/runner/bin/minikube version --short2026-10-30T03:09:12.3248622Z v1.39.02026-10-30T03:09:12.5037895Z Cache hit for: preloaded-tarball-v1.39.0-x64-stable-docker2026-10-30T03:09:12.5144824Z (node:2177) [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-30T03:09:12.5343689Z Cache hit for: kic-v1.39.0-x642026-10-30T03:09:13.7075952Z Received 88080384 of 288577004 (30.5%), 83.9 MBs/sec2026-10-30T03:09:13.7863314Z Received 71303168 of 531630645 (13.4%), 67.9 MBs/sec2026-10-30T03:09:14.7108099Z Received 247463936 of 288577004 (85.8%), 117.9 MBs/sec2026-10-30T03:09:14.7865849Z Received 188743680 of 531630645 (35.5%), 89.9 MBs/sec2026-10-30T03:09:15.1917907Z Received 288577004 of 288577004 (100.0%), 110.7 MBs/sec2026-10-30T03:09:15.1918737Z Cache Size: ~275 MB (288577004 B)2026-10-30T03:09:15.2168005Z [command]/usr/bin/tar -xf /home/runner/work/_temp/37d904e1-f06d-4ffb-900f-6f9d10f46661/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-30T03:09:15.7868723Z Received 306184192 of 531630645 (57.6%), 97.3 MBs/sec2026-10-30T03:09:15.9029647Z Cache restored successfully2026-10-30T03:09:16.7876378Z Received 436207616 of 531630645 (82.1%), 103.9 MBs/sec2026-10-30T03:09:17.4437159Z Received 531630645 of 531630645 (100.0%), 108.8 MBs/sec2026-10-30T03:09:17.4437824Z Cache Size: ~507 MB (531630645 B)2026-10-30T03:09:17.4568942Z [command]/usr/bin/tar -xf /home/runner/work/_temp/3de5a2f0-0be9-4a09-9ea2-afc23fac7f82/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-30T03:09:18.0067284Z Cache restored successfully2026-10-30T03:09:18.0752328Z [command]/home/runner/bin/minikube start --wait all2026-10-30T03:09:18.1161425Z * minikube v1.39.0 on Ubuntu 22.042026-10-30T03:09:18.5567428Z ! 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-30T03:09:18.5584282Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-10-30T03:09:18.6171438Z * Using Docker driver with root privileges2026-10-30T03:09:18.6185234Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-10-30T03:09:18.6193386Z * Pulling base image v0.0.51 ...2026-10-30T03:09:48.1441581Z * Preparing Kubernetes v1.37.0 on containerd 2.3.4 ...2026-10-30T03:09:55.2990247Z * Configuring CNI (Container Networking Interface) ...2026-10-30T03:10:00.6012476Z * Verifying Kubernetes components...2026-10-30T03:10:00.6215162Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-10-30T03:10:01.0988429Z * Enabled addons: storage-provisioner, default-storageclass2026-10-30T03:10:32.9235658Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-10-30T03:10:32.9348411Z [command]/home/runner/bin/minikube version --short2026-10-30T03:10:32.9726194Z v1.39.02026-10-30T03:10:32.9987768Z ##[group]Run actions/setup-go@v62026-10-30T03:10:32.9988129Z with:2026-10-30T03:10:32.9988460Z go-version: 1.262026-10-30T03:10:32.9988806Z cache: true2026-10-30T03:10:32.9989136Z cache-dependency-path: go.sum2026-10-30T03:10:32.9989540Z check-latest: false2026-10-30T03:10:32.9992060Z token: ***2026-10-30T03:10:32.9992401Z ##[endgroup]2026-10-30T03:10:33.1266470Z Setup go version spec 1.262026-10-30T03:10:33.1841491Z Found in cache @ /opt/hostedtoolcache/go/1.26.10/x642026-10-30T03:10:33.1843323Z Added go to the path2026-10-30T03:10:33.1847935Z Successfully set up Go version 1.262026-10-30T03:10:35.7380379Z [command]/opt/hostedtoolcache/go/1.26.10/x64/bin/go env GOMODCACHE2026-10-30T03:10:35.7413864Z [command]/opt/hostedtoolcache/go/1.26.10/x64/bin/go env GOCACHE2026-10-30T03:10:35.7438907Z /home/runner/go/pkg/mod2026-10-30T03:10:35.7460085Z /home/runner/.cache/go-build2026-10-30T03:10:35.9386234Z Cache is not found2026-10-30T03:10:35.9409782Z go version go1.26.10 linux/amd642026-10-30T03:10:35.9410103Z 2026-10-30T03:10:35.9410594Z ##[group]go env2026-10-30T03:10:36.1406290Z AR='ar'2026-10-30T03:10:36.1406762Z CC='gcc'2026-10-30T03:10:36.1407195Z CGO_CFLAGS='-O2 -g'2026-10-30T03:10:36.1407805Z CGO_CPPFLAGS=''2026-10-30T03:10:36.1408228Z CGO_CXXFLAGS='-O2 -g'2026-10-30T03:10:36.1408571Z CGO_ENABLED='1'2026-10-30T03:10:36.1408922Z CGO_FFLAGS='-O2 -g'2026-10-30T03:10:36.1409279Z CGO_LDFLAGS='-O2 -g'2026-10-30T03:10:36.1409609Z CXX='g++'2026-10-30T03:10:36.1409936Z GCCGO='gccgo'2026-10-30T03:10:36.1410255Z GO111MODULE=''2026-10-30T03:10:36.1410605Z GOAMD64='v1'2026-10-30T03:10:36.1411417Z GOARCH='amd64'2026-10-30T03:10:36.1411924Z GOAUTH='netrc'2026-10-30T03:10:36.1412358Z GOBIN=''2026-10-30T03:10:36.1412878Z GOCACHE='/home/runner/.cache/go-build'2026-10-30T03:10:36.1413453Z GOCACHEPROG=''2026-10-30T03:10:36.1413868Z GODEBUG=''2026-10-30T03:10:36.1414683Z GOENV='/home/runner/.config/go/env'2026-10-30T03:10:36.1415050Z GOEXE=''2026-10-30T03:10:36.1415504Z GOEXPERIMENT=''2026-10-30T03:10:36.1415891Z GOFIPS140='off'2026-10-30T03:10:36.1416262Z GOFLAGS=''2026-10-30T03:10:36.1417489Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build967796016=/tmp/go-build -gno-record-gcc-switches'2026-10-30T03:10:36.1418657Z GOHOSTARCH='amd64'2026-10-30T03:10:36.1419209Z GOHOSTOS='linux'2026-10-30T03:10:36.1419646Z GOINSECURE=''2026-10-30T03:10:36.1420361Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-10-30T03:10:36.1421201Z GOMODCACHE='/home/runner/go/pkg/mod'2026-10-30T03:10:36.1421750Z GONOPROXY=''2026-10-30T03:10:36.1422282Z GONOSUMDB=''2026-10-30T03:10:36.1422667Z GOOS='linux'2026-10-30T03:10:36.1423115Z GOPATH='/home/runner/go'2026-10-30T03:10:36.1423583Z GOPRIVATE=''2026-10-30T03:10:36.1424148Z GOPROXY='https://proxy.golang.org,direct'2026-10-30T03:10:36.1424950Z GOROOT='/opt/hostedtoolcache/go/1.26.10/x64'2026-10-30T03:10:36.1425511Z GOSUMDB='sum.golang.org'2026-10-30T03:10:36.1426014Z GOTELEMETRY='local'2026-10-30T03:10:36.1426559Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-10-30T03:10:36.1427133Z GOTMPDIR=''2026-10-30T03:10:36.1427505Z GOTOOLCHAIN='local'2026-10-30T03:10:36.1428147Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.10/x64/pkg/tool/linux_amd64'2026-10-30T03:10:36.1428770Z GOVCS=''2026-10-30T03:10:36.1429187Z GOVERSION='go1.26.10'2026-10-30T03:10:36.1429623Z GOWORK=''2026-10-30T03:10:36.1430035Z PKG_CONFIG='pkg-config'2026-10-30T03:10:36.1430281Z 2026-10-30T03:10:36.1430930Z ##[endgroup]2026-10-30T03:10:36.1598775Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-30T03:10:36.1599418Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-10-30T03:10:36.1635183Z shell: /usr/bin/bash -e {0}2026-10-30T03:10:36.1635541Z env:2026-10-30T03:10:36.1635865Z GOTOOLCHAIN: local2026-10-30T03:10:36.1636263Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-10-30T03:10:36.1636631Z OSPOOL_EP_CMTag: 25.x-el92026-10-30T03:10:36.1637060Z OSPOOL_EP_CvmfsType: cvmfsexec2026-10-30T03:10:36.1637417Z ##[endgroup]2026-10-30T03:10:36.3820167Z go: downloading github.com/gruntwork-io/terratest v0.56.02026-10-30T03:10:36.4861463Z go: downloading github.com/masterminds/sprig v2.22.0+incompatible2026-10-30T03:10:36.6370154Z go: downloading github.com/stretchr/testify v1.11.12026-10-30T03:10:36.6617008Z go: downloading gopkg.in/yaml.v3 v3.0.12026-10-30T03:10:36.7570871Z go: downloading k8s.io/api v0.35.02026-10-30T03:10:36.9123655Z go: downloading k8s.io/apimachinery v0.35.02026-10-30T03:10:38.5404950Z go: downloading github.com/Masterminds/goutils v1.1.12026-10-30T03:10:38.5666390Z go: downloading github.com/Masterminds/semver v1.5.02026-10-30T03:10:38.5968361Z go: downloading github.com/google/uuid v1.6.02026-10-30T03:10:38.6102905Z go: downloading github.com/huandu/xstrings v1.5.02026-10-30T03:10:38.6251940Z go: downloading github.com/imdario/mergo v0.3.162026-10-30T03:10:38.6389932Z go: downloading github.com/mitchellh/copystructure v1.2.02026-10-30T03:10:38.6562701Z go: downloading golang.org/x/crypto v0.52.02026-10-30T03:10:38.8815137Z go: downloading github.com/gruntwork-io/go-commons v0.8.02026-10-30T03:10:38.9004215Z go: downloading github.com/mitchellh/go-homedir v1.1.02026-10-30T03:10:38.9124079Z go: downloading k8s.io/client-go v0.35.02026-10-30T03:10:39.3033822Z go: downloading k8s.io/utils v0.0.0-20251002143259-bc988d571ff42026-10-30T03:10:39.3035318Z go: downloading sigs.k8s.io/randfill v1.0.02026-10-30T03:10:39.3036001Z go: downloading k8s.io/klog/v2 v2.130.12026-10-30T03:10:40.2519527Z go: downloading github.com/mitchellh/reflectwalk v1.0.22026-10-30T03:10:40.2958299Z go: downloading github.com/davecgh/go-spew v1.1.12026-10-30T03:10:40.3246688Z go: downloading github.com/pmezard/go-difflib v1.0.02026-10-30T03:10:40.4083017Z go: downloading github.com/aws/aws-sdk-go-v2 v1.32.52026-10-30T03:10:40.4404631Z go: downloading github.com/aws/aws-sdk-go-v2/config v1.28.52026-10-30T03:10:40.5555507Z go: downloading github.com/aws/aws-sdk-go-v2/credentials v1.17.462026-10-30T03:10:40.6489403Z go: downloading github.com/aws/aws-sdk-go-v2/feature/s3/manager v1.17.412026-10-30T03:10:40.6594823Z go: downloading github.com/aws/aws-sdk-go-v2/service/acm v1.30.62026-10-30T03:10:40.6596217Z go: downloading github.com/aws/aws-sdk-go-v2/service/autoscaling v1.51.02026-10-30T03:10:40.8146163Z go: downloading github.com/aws/aws-sdk-go-v2/service/cloudwatchlogs v1.44.02026-10-30T03:10:40.8172713Z go: downloading github.com/aws/aws-sdk-go-v2/service/dynamodb v1.37.12026-10-30T03:10:40.8295619Z go: downloading github.com/aws/aws-sdk-go-v2/service/ec2 v1.193.02026-10-30T03:10:40.8701539Z go: downloading github.com/aws/aws-sdk-go-v2/service/ecr v1.36.62026-10-30T03:10:41.0018675Z go: downloading github.com/aws/aws-sdk-go-v2/service/ecs v1.52.02026-10-30T03:10:41.1291577Z go: downloading github.com/aws/aws-sdk-go-v2/service/iam v1.38.12026-10-30T03:10:41.2839494Z go: downloading github.com/aws/aws-sdk-go-v2/service/kms v1.37.62026-10-30T03:10:41.2840986Z go: downloading github.com/aws/aws-sdk-go-v2/service/lambda v1.69.02026-10-30T03:10:41.3685414Z go: downloading github.com/aws/aws-sdk-go-v2/service/rds v1.91.02026-10-30T03:10:41.4538283Z go: downloading github.com/aws/aws-sdk-go-v2/service/route53 v1.46.22026-10-30T03:10:41.5399208Z go: downloading github.com/aws/aws-sdk-go-v2/service/s3 v1.69.02026-10-30T03:10:41.5455622Z go: downloading github.com/aws/aws-sdk-go-v2/service/sns v1.33.62026-10-30T03:10:41.5457596Z go: downloading github.com/aws/aws-sdk-go-v2/service/secretsmanager v1.34.62026-10-30T03:10:41.7151241Z go: downloading github.com/aws/aws-sdk-go-v2/service/sqs v1.37.12026-10-30T03:10:41.7458809Z go: downloading github.com/aws/aws-sdk-go-v2/service/ssm v1.56.02026-10-30T03:10:41.7515065Z go: downloading github.com/aws/aws-sdk-go-v2/service/sts v1.33.12026-10-30T03:10:41.7516362Z go: downloading github.com/go-sql-driver/mysql v1.8.12026-10-30T03:10:41.7852236Z go: downloading github.com/hashicorp/go-multierror v1.1.12026-10-30T03:10:41.8123121Z go: downloading github.com/jackc/pgx/v5 v5.9.02026-10-30T03:10:41.8877341Z go: downloading github.com/mattn/go-zglob v0.0.2-0.20190814121620-e3c9456763262026-10-30T03:10:41.8878995Z go: downloading github.com/pquerna/otp v1.4.02026-10-30T03:10:41.8917230Z go: downloading github.com/go-errors/errors v1.0.2-0.20180813162953-d98b870cc4e02026-10-30T03:10:41.8959284Z go: downloading github.com/urfave/cli v1.22.162026-10-30T03:10:42.0968535Z go: downloading github.com/spf13/pflag v1.0.92026-10-30T03:10:42.0970679Z go: downloading golang.org/x/term v0.43.02026-10-30T03:10:42.1017097Z go: downloading github.com/gorilla/websocket v1.5.4-0.20250319132907-e064f32e36742026-10-30T03:10:42.1228889Z go: downloading gopkg.in/inf.v0 v0.9.12026-10-30T03:10:42.1248912Z go: downloading github.com/munnerz/goautoneg v0.0.0-20191010083416-a7dc8b61c8222026-10-30T03:10:42.1341712Z go: downloading golang.org/x/net v0.54.02026-10-30T03:10:42.1376711Z go: downloading sigs.k8s.io/json v0.0.0-20250730193827-2d320260d7302026-10-30T03:10:42.1968997Z go: downloading k8s.io/kube-openapi v0.0.0-20250910181357-589584f1c9122026-10-30T03:10:42.2219134Z go: downloading sigs.k8s.io/structured-merge-diff/v6 v6.3.02026-10-30T03:10:42.2251390Z go: downloading github.com/go-logr/logr v1.4.32026-10-30T03:10:42.3229716Z go: downloading github.com/aws/smithy-go v1.22.12026-10-30T03:10:42.3853687Z go: downloading github.com/aws/aws-sdk-go-v2/feature/ec2/imds v1.16.202026-10-30T03:10:42.3855844Z go: downloading github.com/aws/aws-sdk-go-v2/service/sso v1.24.62026-10-30T03:10:42.3856617Z go: downloading github.com/aws/aws-sdk-go-v2/internal/ini v1.8.12026-10-30T03:10:42.3885165Z go: downloading github.com/aws/aws-sdk-go-v2/service/ssooidc v1.28.52026-10-30T03:10:42.4428665Z go: downloading github.com/aws/aws-sdk-go-v2/internal/configsources v1.3.242026-10-30T03:10:42.5212830Z go: downloading github.com/jmespath/go-jmespath v0.4.02026-10-30T03:10:42.5918455Z go: downloading github.com/aws/aws-sdk-go-v2/service/internal/accept-encoding v1.12.12026-10-30T03:10:42.6146438Z go: downloading github.com/aws/aws-sdk-go-v2/service/internal/endpoint-discovery v1.10.52026-10-30T03:10:42.6213522Z go: downloading github.com/aws/aws-sdk-go-v2/aws/protocol/eventstream v1.6.72026-10-30T03:10:42.6298293Z go: downloading github.com/aws/aws-sdk-go-v2/service/internal/presigned-url v1.12.52026-10-30T03:10:42.6415050Z go: downloading github.com/aws/aws-sdk-go-v2/internal/v4a v1.3.242026-10-30T03:10:42.6494157Z go: downloading github.com/aws/aws-sdk-go-v2/service/internal/checksum v1.4.52026-10-30T03:10:42.6495521Z go: downloading github.com/aws/aws-sdk-go-v2/service/internal/s3shared v1.18.52026-10-30T03:10:42.7865303Z go: downloading filippo.io/edwards25519 v1.1.02026-10-30T03:10:42.7931049Z go: downloading github.com/hashicorp/errwrap v1.0.02026-10-30T03:10:42.7996502Z go: downloading github.com/cpuguy83/go-md2man/v2 v2.0.52026-10-30T03:10:42.8496678Z go: downloading github.com/google/gnostic-models v0.7.02026-10-30T03:10:42.8893075Z go: downloading google.golang.org/protobuf v1.36.82026-10-30T03:10:42.9007882Z go: downloading golang.org/x/time v0.9.02026-10-30T03:10:42.9067820Z go: downloading github.com/moby/spdystream v0.5.12026-10-30T03:10:42.9592507Z go: downloading golang.org/x/sys v0.45.02026-10-30T03:10:42.9604970Z go: downloading github.com/fxamacker/cbor/v2 v2.9.02026-10-30T03:10:42.9815429Z go: downloading golang.org/x/oauth2 v0.30.02026-10-30T03:10:43.0510697Z go: downloading github.com/json-iterator/go v1.1.122026-10-30T03:10:43.0776745Z go: downloading go.yaml.in/yaml/v2 v2.4.32026-10-30T03:10:43.1083048Z go: downloading github.com/aws/aws-sdk-go-v2/internal/endpoints/v2 v2.6.242026-10-30T03:10:43.1092860Z go: downloading github.com/jackc/pgpassfile v1.0.02026-10-30T03:10:43.1152433Z go: downloading github.com/jackc/pgservicefile v0.0.0-20240606120523-5a60cdf6a7612026-10-30T03:10:43.1355328Z go: downloading golang.org/x/text v0.37.02026-10-30T03:10:43.1402513Z go: downloading github.com/jackc/puddle/v2 v2.2.22026-10-30T03:10:43.1529591Z go: downloading github.com/boombuler/barcode v1.0.1-0.20190219062509-6c824513bacc2026-10-30T03:10:43.1885465Z go: downloading github.com/russross/blackfriday/v2 v2.1.02026-10-30T03:10:43.2254683Z go: downloading go.yaml.in/yaml/v3 v3.0.42026-10-30T03:10:43.2341055Z go: downloading sigs.k8s.io/yaml v1.6.02026-10-30T03:10:43.2535321Z go: downloading github.com/mxk/go-flowrate v0.0.0-20140419014527-cca7078d478f2026-10-30T03:10:43.2813523Z go: downloading github.com/x448/float16 v0.8.42026-10-30T03:10:43.2832263Z go: downloading github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd2026-10-30T03:10:43.3070612Z go: downloading github.com/modern-go/reflect2 v1.0.3-0.20250322232337-35a7c28c31ee2026-10-30T03:10:43.5407281Z go: downloading golang.org/x/sync v0.20.02026-10-30T03:10:43.5408244Z go: downloading github.com/go-openapi/swag v0.23.02026-10-30T03:10:43.5412698Z go: downloading github.com/go-openapi/jsonreference v0.20.22026-10-30T03:10:43.5715343Z go: downloading gopkg.in/evanphx/json-patch.v4 v4.13.02026-10-30T03:10:43.5786982Z go: downloading github.com/emicklei/go-restful/v3 v3.12.22026-10-30T03:10:43.5814546Z go: downloading github.com/go-openapi/jsonpointer v0.21.02026-10-30T03:10:43.6053334Z go: downloading github.com/mailru/easyjson v0.7.72026-10-30T03:10:43.6503796Z go: downloading github.com/josharian/intern v1.0.02026-10-30T03:12:54.8719631Z === RUN TestOSPoolEP2026-10-30T03:12:54.8720467Z === PAUSE TestOSPoolEP2026-10-30T03:12:54.8721865Z === CONT TestOSPoolEP2026-10-30T03:12:54.8725115Z TestOSPoolEP 2026-10-30T03:12:54Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:12:54.8854292Z TestOSPoolEP 2026-10-30T03:12:54Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx apply -f /tmp/TestOSPoolEP2677856260]2026-10-30T03:12:55.5322213Z TestOSPoolEP 2026-10-30T03:12:55Z logger.go:67: pod/idtoken-generator created2026-10-30T03:12:55.5409362Z TestOSPoolEP 2026-10-30T03:12:55Z logger.go:67: secret/pool-passwd created2026-10-30T03:12:55.5444820Z TestOSPoolEP 2026-10-30T03:12:55Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-30T03:12:55.5447424Z TestOSPoolEP 2026-10-30T03:12:55Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:12:55.5475624Z TestOSPoolEP 2026-10-30T03:12:55Z 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-30T03:13:05.5486327Z TestOSPoolEP 2026-10-30T03:13:05Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-30T03:13:05.5487862Z TestOSPoolEP 2026-10-30T03:13:05Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:13:05.5514547Z TestOSPoolEP 2026-10-30T03:13:05Z logger.go:67: Pod is now available2026-10-30T03:13:05.5516204Z TestOSPoolEP 2026-10-30T03:13:05Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-10-30T03:13:06.3775379Z TestOSPoolEP 2026-10-30T03:13:06Z logger.go:67: ***2026-10-30T03:13:06.3828414Z TestOSPoolEP 2026-10-30T03:13:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx apply -f /tmp/TestOSPoolEP3580550867]2026-10-30T03:13:06.5727443Z TestOSPoolEP 2026-10-30T03:13:06Z logger.go:67: secret/pool-token created2026-10-30T03:13:06.5745773Z TestOSPoolEP 2026-10-30T03:13:06Z retry.go:91: Wait for secret pool-token to be provisioned.2026-10-30T03:13:06.5746783Z TestOSPoolEP 2026-10-30T03:13:06Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:13:06.5766688Z TestOSPoolEP 2026-10-30T03:13:06Z logger.go:67: Secret is now available2026-10-30T03:13:06.5796792Z TestOSPoolEP 2026-10-30T03:13:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx apply -k /tmp/kustomize-template-3531000255]2026-10-30T03:13:07.0437304Z TestOSPoolEP 2026-10-30T03:13:07Z logger.go:67: service/test-cm created2026-10-30T03:13:07.4301899Z TestOSPoolEP 2026-10-30T03:13:07Z 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-30T03:13:07.4320079Z TestOSPoolEP 2026-10-30T03:13:07Z logger.go:67: deployment.apps/ospool-ep created2026-10-30T03:13:07.6975036Z TestOSPoolEP 2026-10-30T03:13:07Z logger.go:67: deployment.apps/test-cm created2026-10-30T03:13:07.7014750Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-10-30T03:13:07.7016515Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03:13:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:13:07.9603400Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03:13:07Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-30T03:13:07.9605038Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03:13:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:13:07.9611013Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03:13:07Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-30T03:13:07.9613294Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03:13:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:13:07.9661462Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03: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: NewReplicaSetCreated, message: Created new replica set "ospool-ep-6464cb7998". Sleeping for 10s and will try again.2026-10-30T03:13:07.9664319Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03:13:07Z 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-30T03:13:17.9693026Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03:13:17Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-30T03:13:17.9694967Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03:13:17Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-30T03:13:17.9696541Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03:13:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:13:17.9698527Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03:13:17Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:13:17.9718910Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03:13:17Z logger.go:67: Deployment is now available2026-10-30T03:13:17.9721110Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03: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-6464cb7998" is progressing.. Sleeping for 10s and will try again.2026-10-30T03:13:27.9750170Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03:13:27Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-30T03:13:27.9751858Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03:13:27Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:13:27.9777707Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03: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-6464cb7998" is progressing.. Sleeping for 10s and will try again.2026-10-30T03:13:37.9798134Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03:13:37Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-30T03:13:37.9799514Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03:13:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:13:37.9849969Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-30T03:13:37Z logger.go:67: Deployment is now available2026-10-30T03:13:37.9851596Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP2026-10-30T03:13:37.9852660Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-30T03:13:37Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:13:37.9871250Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-30T03:13:37Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx cp ../test-configs/ospool-ep/condor_status.sh test-cm-5886f7986-4t8tl:/tmp/condor_status.sh]2026-10-30T03:13:38.4665116Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-30T03:13:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx exec test-cm-5886f7986-4t8tl -- chmod +x /tmp/condor_status.sh]2026-10-30T03:13:38.5922245Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-30T03:13:38Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx exec test-cm-5886f7986-4t8tl -- sh -c /tmp/condor_status.sh]2026-10-30T03:13:38.7246412Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-30T03:13:38Z logger.go:67: command terminated with exit code 12026-10-30T03:13:38.7262939Z test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-5886f7986-4t8tl failed. Retrying in 10s.2026-10-30T03:13:48.7288896Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-30T03:13:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx exec test-cm-5886f7986-4t8tl -- sh -c /tmp/condor_status.sh]2026-10-30T03:13:48.8748410Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity2026-10-30T03:13:48.8750736Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-30T03:13:48Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:13:48.8779788Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-30T03:13:48Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx cp ../test-configs/ospool-ep/has_singularity.sh test-cm-5886f7986-4t8tl:/tmp/has_singularity.sh]2026-10-30T03:13:49.0400742Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-30T03:13:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx exec test-cm-5886f7986-4t8tl -- chmod +x /tmp/has_singularity.sh]2026-10-30T03:13:49.1765611Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-30T03:13:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx exec test-cm-5886f7986-4t8tl -- sh -c /tmp/has_singularity.sh]2026-10-30T03:13:49.3177181Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-10-30T03:13:49.3183064Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:13:49Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:13:49.3205019Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:13:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx cp ../test-configs/ospool-ep/has_cvmfs.sh test-cm-5886f7986-4t8tl:/tmp/has_cvmfs.sh]2026-10-30T03:13:49.4725569Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:13:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx exec test-cm-5886f7986-4t8tl -- chmod +x /tmp/has_cvmfs.sh]2026-10-30T03:13:49.5952209Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:13:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx exec test-cm-5886f7986-4t8tl -- sh -c /tmp/has_cvmfs.sh]2026-10-30T03:13:49.7334937Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:13:49Z logger.go:67: command terminated with exit code 12026-10-30T03:13:49.7351717Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-4t8tl failed. Retrying in 30s.2026-10-30T03:14:19.7363090Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:14:19Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx exec test-cm-5886f7986-4t8tl -- sh -c /tmp/has_cvmfs.sh]2026-10-30T03:14:19.8711334Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:14:19Z logger.go:67: command terminated with exit code 12026-10-30T03:14:19.8731693Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-4t8tl failed. Retrying in 30s.2026-10-30T03:14:49.8739126Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:14:49Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx exec test-cm-5886f7986-4t8tl -- sh -c /tmp/has_cvmfs.sh]2026-10-30T03:14:50.0087273Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:14:50Z logger.go:67: command terminated with exit code 12026-10-30T03:14:50.0107063Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-4t8tl failed. Retrying in 30s.2026-10-30T03:15:20.0110192Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:15:20Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx exec test-cm-5886f7986-4t8tl -- sh -c /tmp/has_cvmfs.sh]2026-10-30T03:15:20.1601102Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:15:20Z logger.go:67: command terminated with exit code 12026-10-30T03:15:20.1623866Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-4t8tl failed. Retrying in 30s.2026-10-30T03:15:50.1627099Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:15:50Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx exec test-cm-5886f7986-4t8tl -- sh -c /tmp/has_cvmfs.sh]2026-10-30T03:15:50.2971405Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:15:50Z logger.go:67: command terminated with exit code 12026-10-30T03:15:50.2989226Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-4t8tl failed. Retrying in 30s.2026-10-30T03:16:20.3031362Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:16:20Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx exec test-cm-5886f7986-4t8tl -- sh -c /tmp/has_cvmfs.sh]2026-10-30T03:16:20.4398787Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:16:20Z logger.go:67: command terminated with exit code 12026-10-30T03:16:20.4417149Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-4t8tl failed. Retrying in 30s.2026-10-30T03:16:50.4461859Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:16:50Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx exec test-cm-5886f7986-4t8tl -- sh -c /tmp/has_cvmfs.sh]2026-10-30T03:16:50.5793983Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:16:50Z logger.go:67: command terminated with exit code 12026-10-30T03:16:50.5814938Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-4t8tl failed. Retrying in 30s.2026-10-30T03:17:20.5866175Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:17:20Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx exec test-cm-5886f7986-4t8tl -- sh -c /tmp/has_cvmfs.sh]2026-10-30T03:17:20.7242203Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:17:20Z logger.go:67: command terminated with exit code 12026-10-30T03:17:20.7253742Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-4t8tl failed. Retrying in 30s.2026-10-30T03:17:50.7259228Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:17:50Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx exec test-cm-5886f7986-4t8tl -- sh -c /tmp/has_cvmfs.sh]2026-10-30T03:17:50.8605729Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:17:50Z logger.go:67: command terminated with exit code 12026-10-30T03:17:50.8628519Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-4t8tl failed. Retrying in 30s.2026-10-30T03:18:20.8659198Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:18:20Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx exec test-cm-5886f7986-4t8tl -- sh -c /tmp/has_cvmfs.sh]2026-10-30T03:18:21.0024869Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-30T03:18:21Z logger.go:67: command terminated with exit code 12026-10-30T03:18:21.0042400Z test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-4t8tl failed. Retrying in 30s.2026-10-30T03:18:51.0089900Z test_utils.go:105: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-4t8tl did not succeed within {10 30000000000} retries2026-10-30T03:18:51.0094069Z TestOSPoolEP 2026-10-30T03:18:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:18:51.0154525Z TestOSPoolEP 2026-10-30T03:18:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:18:51.1729632Z TestOSPoolEP 2026-10-30T03:18:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:18:51.2802343Z TestOSPoolEP 2026-10-30T03:18:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:18:51.3816152Z TestOSPoolEP 2026-10-30T03:18:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:18:51.3847170Z === NAME TestOSPoolEP2026-10-30T03:18:51.3848223Z ospool_ep_test.go:72: ---2026-10-30T03:18:51.3849116Z Events for pod idtoken-generator:2026-10-30T03:18:51.3850599Z 2026-10-30 03:12:55 +0000 UTC Normal Successfully assigned test-ospool-ep-5qdffx/idtoken-generator to minikube2026-10-30T03:18:51.3852055Z 2026-10-30 03:12:55 +0000 UTC Normal Pulling image "htcondor/base"2026-10-30T03:18:51.3853575Z 2026-10-30 03:13:03 +0000 UTC Normal Successfully pulled image "htcondor/base" in 7.773s (7.773s including waiting). Image size: 196303183 bytes.2026-10-30T03:18:51.3855678Z 2026-10-30 03:13:03 +0000 UTC Normal Container created2026-10-30T03:18:51.3856673Z 2026-10-30 03:13:03 +0000 UTC Normal Container started2026-10-30T03:18:51.3857574Z 2026-10-30T03:18:51.3858128Z ---2026-10-30T03:18:51.3859057Z TestOSPoolEP 2026-10-30T03:18:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:18:51.3867175Z ospool_ep_test.go:72: ---2026-10-30T03:18:51.3867827Z Events for pod ospool-ep-6464cb7998-vcszt:2026-10-30T03:18:51.3869095Z 2026-10-30 03:13:07 +0000 UTC Normal Successfully assigned test-ospool-ep-5qdffx/ospool-ep-6464cb7998-vcszt to minikube2026-10-30T03:18:51.3870319Z 2026-10-30 03:13:08 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-10-30T03:18:51.3871957Z 2026-10-30 03:13:10 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 2.478s (2.478s including waiting). Image size: 2893600 bytes.2026-10-30T03:18:51.3873111Z 2026-10-30 03:13:11 +0000 UTC Normal Container created2026-10-30T03:18:51.3873863Z 2026-10-30 03:13:11 +0000 UTC Normal Container started2026-10-30T03:18:51.3875132Z 2026-10-30 03:13:12 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-10-30T03:18:51.3876831Z 2026-10-30 03:13:28 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 15.276s (15.276s including waiting). Image size: 548175760 bytes.2026-10-30T03:18:51.3878146Z 2026-10-30 03:13:28 +0000 UTC Normal Container created2026-10-30T03:18:51.3878845Z 2026-10-30 03:13:28 +0000 UTC Normal Container started2026-10-30T03:18:51.3879415Z 2026-10-30T03:18:51.3879787Z ---2026-10-30T03:18:51.3880593Z TestOSPoolEP 2026-10-30T03:18:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:18:51.3886976Z ospool_ep_test.go:72: ---2026-10-30T03:18:51.3887591Z Events for pod test-cm-5886f7986-4t8tl:2026-10-30T03:18:51.3888988Z 2026-10-30 03:13:08 +0000 UTC Normal Successfully assigned test-ospool-ep-5qdffx/test-cm-5886f7986-4t8tl to minikube2026-10-30T03:18:51.3890137Z 2026-10-30 03:13:08 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-10-30T03:18:51.3891716Z 2026-10-30 03:13:12 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 1.821s (4.166s including waiting). Image size: 196304120 bytes.2026-10-30T03:18:51.3920036Z 2026-10-30 03:13:12 +0000 UTC Normal Container created2026-10-30T03:18:51.3929608Z 2026-10-30 03:13:12 +0000 UTC Normal Container started2026-10-30T03:18:51.3937095Z 2026-10-30T03:18:51.3945478Z ---2026-10-30T03:18:51.3946927Z TestOSPoolEP 2026-10-30T03:18:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-30T03:18:51.3948637Z TestOSPoolEP 2026-10-30T03:18:51Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx delete -f /tmp/TestOSPoolEP2207719992]2026-10-30T03:18:51.4876010Z TestOSPoolEP 2026-10-30T03:18:51Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-5qdffx namespace2026-10-30T03:18:51.4929981Z TestOSPoolEP 2026-10-30T03:18:51Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-5qdffx namespace2026-10-30T03:18:52.6192678Z TestOSPoolEP 2026-10-30T03:18:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx delete -f /tmp/TestOSPoolEP2331649594]2026-10-30T03:18:52.7074686Z TestOSPoolEP 2026-10-30T03:18:52Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-5qdffx namespace2026-10-30T03:18:52.7112053Z TestOSPoolEP 2026-10-30T03:18:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-5qdffx delete -k /tmp/kustomize-template-3531000255]2026-10-30T03:18:52.8201427Z TestOSPoolEP 2026-10-30T03:18:52Z logger.go:67: service "test-cm" deleted from test-ospool-ep-5qdffx namespace2026-10-30T03:18:52.8280673Z TestOSPoolEP 2026-10-30T03:18:52Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-5qdffx namespace2026-10-30T03:18:52.8325908Z TestOSPoolEP 2026-10-30T03:18:52Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-5qdffx namespace2026-10-30T03:18:52.8396634Z --- FAIL: TestOSPoolEP (357.97s)2026-10-30T03:18:52.8398347Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.28s)2026-10-30T03:18:52.8399515Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP (10.89s)2026-10-30T03:18:52.8400730Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity (0.44s)2026-10-30T03:18:52.8401894Z --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (301.69s)2026-10-30T03:18:52.8402696Z FAIL2026-10-30T03:18:52.8445993Z FAIL github.com/osg-htc/k8s-integration-tests/test 357.984s2026-10-30T03:18:52.8588238Z FAIL2026-10-30T03:18:53.6409398Z ##[error]Process completed with exit code 1.2026-10-30T03:18:53.6501373Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-30T03:18:53.6502090Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-10-30T03:18:53.6544450Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-30T03:18:53.6544877Z env:2026-10-30T03:18:53.6545256Z GOTOOLCHAIN: local2026-10-30T03:18:53.6545791Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-10-30T03:18:53.6546323Z ##[endgroup]2026-10-30T03:18:53.6690805Z ##[group]Run actions/upload-artifact@v42026-10-30T03:18:53.6691223Z with:2026-10-30T03:18:53.6691792Z name: TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe52026-10-30T03:18:53.6692325Z path: /tmp/k8s-tests2026-10-30T03:18:53.6692702Z retention-days: 52026-10-30T03:18:53.6693030Z if-no-files-found: warn2026-10-30T03:18:53.6693348Z compression-level: 62026-10-30T03:18:53.6693743Z overwrite: false2026-10-30T03:18:53.6694253Z include-hidden-files: false2026-10-30T03:18:53.6695194Z env:2026-10-30T03:18:53.6695769Z GOTOOLCHAIN: local2026-10-30T03:18:53.6696216Z ##[endgroup]2026-10-30T03:18:53.8509830Z (node:24166) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-30T03:18:53.8548984Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-30T03:18:53.8627757Z With the provided path, there will be 6 files uploaded2026-10-30T03:18:53.8642652Z Artifact name is valid!2026-10-30T03:18:53.8655225Z Root directory input is valid!2026-10-30T03:18:54.2226696Z Beginning upload of artifact content to blob storage2026-10-30T03:18:54.2499200Z (node:24166) [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-30T03:18:54.4843488Z Uploaded bytes 141662026-10-30T03:18:54.5405731Z Finished uploading artifact content to blob storage!2026-10-30T03:18:54.5413328Z SHA256 digest of uploaded artifact zip is 9ed4bb310bf922a9588c8c4778972554099847361a3542b648584fe0398bbc532026-10-30T03:18:54.5414221Z Finalizing artifact upload2026-10-30T03:18:54.9768521Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5.zip successfully finalized. Artifact ID 129521552302026-10-30T03:18:54.9770466Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5 has been successfully uploaded! Final size is 14166 bytes. Artifact ID is 129521552302026-10-30T03:18:54.9775578Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/40995730315/artifacts/129521552302026-10-30T03:18:54.9958088Z Post job cleanup.2026-10-30T03:18:55.0885236Z [command]/usr/bin/git version2026-10-30T03:18:55.0927476Z git version 2.56.02026-10-30T03:18:55.0968720Z Temporarily overriding HOME='/home/runner/work/_temp/11972fea-5b4d-4246-a5fe-9fe2cadd9007' before making global git config changes2026-10-30T03:18:55.0969875Z Adding repository directory to the temporary git global config as a safe directory2026-10-30T03:18:55.0975397Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-30T03:18:55.1015045Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-30T03:18:55.1050291Z [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-30T03:18:55.1291430Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-30T03:18:55.1312688Z http.https://github.com/.extraheader2026-10-30T03:18:55.1325651Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-10-30T03:18:55.1358639Z [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-30T03:18:55.1588655Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-30T03:18:55.1620048Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-30T03:18:55.2086364Z Cleaning up orphan processes2026-10-30T03:18:55.2891063Z ##[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/