All Test Logs

2026-10-29T03:04:45.9736642Z Current runner version: '2.338.0'2026-10-29T03:04:45.9751653Z ##[group]Runner Image Provisioner2026-10-29T03:04:45.9752248Z Hosted Compute Agent2026-10-29T03:04:45.9752583Z Version: 20261021.6182026-10-29T03:04:45.9752928Z Commit: 21505ad2541d5be6135ed84fc33697146cf75b8e2026-10-29T03:04:45.9753357Z Build Date: 2026-10-21T00:45:21Z2026-10-29T03:04:45.9753739Z Worker ID: {f142951b-9b94-43b6-b4c4-2c039b09b82e}2026-10-29T03:04:45.9754140Z Region: centralus2026-10-29T03:04:45.9754465Z Cloud: Azure2026-10-29T03:04:45.9754771Z ##[endgroup]2026-10-29T03:04:45.9755537Z ##[group]Operating System2026-10-29T03:04:45.9755873Z Ubuntu2026-10-29T03:04:45.9756177Z 22.04.52026-10-29T03:04:45.9756475Z LTS2026-10-29T03:04:45.9756757Z ##[endgroup]2026-10-29T03:04:45.9757087Z ##[group]Runner Image2026-10-29T03:04:45.9757420Z Image: ubuntu-22.042026-10-29T03:04:45.9757726Z Version: 20261025.340.12026-10-29T03:04:45.9758451Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20261025.340/images/ubuntu/Ubuntu2204-Readme.md2026-10-29T03:04:45.9759331Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20261025.3402026-10-29T03:04:45.9759870Z ##[endgroup]2026-10-29T03:04:45.9761944Z ##[group]GITHUB_TOKEN Permissions2026-10-29T03:04:45.9763358Z Actions: write2026-10-29T03:04:45.9763713Z ArtifactMetadata: write2026-10-29T03:04:45.9764063Z Attestations: write2026-10-29T03:04:45.9764381Z Checks: write2026-10-29T03:04:45.9764701Z CodeQuality: write2026-10-29T03:04:45.9765024Z Contents: write2026-10-29T03:04:45.9765327Z CopilotRequests: write2026-10-29T03:04:45.9765694Z Deployments: write2026-10-29T03:04:45.9766005Z Discussions: write2026-10-29T03:04:45.9766331Z Drives: write2026-10-29T03:04:45.9766629Z Issues: write2026-10-29T03:04:45.9766960Z Metadata: read2026-10-29T03:04:45.9767281Z Models: read2026-10-29T03:04:45.9767583Z Packages: write2026-10-29T03:04:45.9767908Z Pages: write2026-10-29T03:04:45.9768221Z PullRequests: write2026-10-29T03:04:45.9768559Z RepositoryProjects: write2026-10-29T03:04:45.9768923Z SecurityEvents: write2026-10-29T03:04:45.9769243Z Statuses: write2026-10-29T03:04:45.9769577Z VulnerabilityAlerts: read2026-10-29T03:04:45.9769914Z ##[endgroup]2026-10-29T03:04:45.9771300Z Secret source: Actions2026-10-29T03:04:45.9771862Z Cache mode: write2026-10-29T03:04:45.9772247Z Prepare workflow directory2026-10-29T03:04:45.9991739Z Prepare all required actions2026-10-29T03:04:46.0021515Z Getting action download info2026-10-29T03:04:51.9141703Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-10-29T03:04:52.1099467Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-10-29T03:04:52.4132801Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-10-29T03:04:52.7862599Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-10-29T03:04:52.9819129Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (63ec080e4eea87fb8a9eae678ab9944ec2461251)2026-10-29T03:04:52.9821977Z ##[group] Inputs2026-10-29T03:04:52.9822239Z   testName: TestOSPoolEP2026-10-29T03:04:52.9822626Z   testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-10-29T03:04:52.9823024Z   setupScript: 2026-10-29T03:04:52.9823240Z   setupEnv: {}2026-10-29T03:04:52.9823449Z ##[endgroup]2026-10-29T03:04:52.9823757Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-testing) / Run Tests2026-10-29T03:04:53.0226731Z ##[group]Run actions/checkout@v52026-10-29T03:04:53.0227077Z with:2026-10-29T03:04:53.0227300Z   repository: osg-htc/k8s-integration-tests2026-10-29T03:04:53.0229056Z   token: ***2026-10-29T03:04:53.0229254Z   ssh-strict: true2026-10-29T03:04:53.0229453Z   ssh-user: git2026-10-29T03:04:53.0229667Z   persist-credentials: true2026-10-29T03:04:53.0229886Z   clean: true2026-10-29T03:04:53.0230237Z   sparse-checkout-cone-mode: true2026-10-29T03:04:53.0230470Z   fetch-depth: 12026-10-29T03:04:53.0230664Z   fetch-tags: false2026-10-29T03:04:53.0230866Z   show-progress: true2026-10-29T03:04:53.0231065Z   lfs: false2026-10-29T03:04:53.0231404Z   submodules: false2026-10-29T03:04:53.0231611Z   set-safe-directory: true2026-10-29T03:04:53.0231849Z   allow-unsafe-pr-checkout: false2026-10-29T03:04:53.0232163Z ##[endgroup]2026-10-29T03:04:53.1358798Z Syncing repository: osg-htc/k8s-integration-tests2026-10-29T03:04:53.1359869Z ##[group]Getting Git version info2026-10-29T03:04:53.1360333Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-29T03:04:53.1360840Z [command]/usr/bin/git version2026-10-29T03:04:53.1390845Z git version 2.56.02026-10-29T03:04:53.1404278Z ##[endgroup]2026-10-29T03:04:53.1414250Z Temporarily overriding HOME='/home/runner/work/_temp/b681cada-6548-4a90-8ac2-3214faf764f4' before making global git config changes2026-10-29T03:04:53.1415282Z Adding repository directory to the temporary git global config as a safe directory2026-10-29T03:04:53.1420402Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-29T03:04:53.1450177Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-10-29T03:04:53.1452922Z ##[group]Initializing the repository2026-10-29T03:04:53.1457043Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-29T03:04:53.1528230Z hint: Using 'master' as the name for the initial branch. This default branch name2026-10-29T03:04:53.1528946Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-10-29T03:04:53.1529571Z hint: to use in all of your new repositories, which will suppress this warning,2026-10-29T03:04:53.1530139Z hint: call:2026-10-29T03:04:53.1530423Z hint:2026-10-29T03:04:53.1530846Z hint: 	git config --global init.defaultBranch <name>2026-10-29T03:04:53.1531417Z hint:2026-10-29T03:04:53.1531827Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-10-29T03:04:53.1532448Z hint: 'development'. The just-created branch can be renamed via this command:2026-10-29T03:04:53.1532941Z hint:2026-10-29T03:04:53.1533246Z hint: 	git branch -m <name>2026-10-29T03:04:53.1533569Z hint:2026-10-29T03:04:53.1534008Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-10-29T03:04:53.1534745Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-10-29T03:04:53.1541703Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-10-29T03:04:53.1560724Z ##[endgroup]2026-10-29T03:04:53.1561420Z ##[group]Disabling automatic garbage collection2026-10-29T03:04:53.1561893Z [command]/usr/bin/git config --local gc.auto 02026-10-29T03:04:53.1583408Z ##[endgroup]2026-10-29T03:04:53.1583850Z ##[group]Setting up auth2026-10-29T03:04:53.1584974Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-29T03:04:53.1602939Z [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-29T03:04:53.1799957Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-29T03:04:53.1821800Z [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-29T03:04:53.1926923Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-29T03:04:53.1944085Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-29T03:04:53.2047652Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-10-29T03:04:53.2069086Z ##[endgroup]2026-10-29T03:04:53.2069836Z ##[group]Fetching the repository2026-10-29T03:04:53.2075422Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +63ec080e4eea87fb8a9eae678ab9944ec2461251:refs/remotes/origin/main2026-10-29T03:04:53.5288296Z From https://github.com/osg-htc/k8s-integration-tests2026-10-29T03:04:53.5288856Z  * [new ref]         63ec080e4eea87fb8a9eae678ab9944ec2461251 -> origin/main2026-10-29T03:04:53.5292098Z ##[endgroup]2026-10-29T03:04:53.5292537Z ##[group]Determining the checkout info2026-10-29T03:04:53.5294040Z ##[endgroup]2026-10-29T03:04:53.5297669Z [command]/usr/bin/git sparse-checkout disable2026-10-29T03:04:53.5484414Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-10-29T03:04:53.5499729Z ##[group]Checking out the ref2026-10-29T03:04:53.5502850Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-10-29T03:04:53.5576457Z Switched to a new branch 'main'2026-10-29T03:04:53.5577037Z branch 'main' set up to track 'origin/main'.2026-10-29T03:04:53.5579890Z ##[endgroup]2026-10-29T03:04:53.5598850Z [command]/usr/bin/git log -1 --format=%H2026-10-29T03:04:53.5610966Z 63ec080e4eea87fb8a9eae678ab9944ec24612512026-10-29T03:04:53.5809187Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-29T03:04:53.5809645Z echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-29T03:04:53.5810018Z echo "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-10-29T03:04:53.5846496Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-29T03:04:53.5846733Z env:2026-10-29T03:04:53.5847024Z   TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-10-29T03:04:53.5847351Z   SETUP_ENV_YAML: {}2026-10-29T03:04:53.5847508Z ##[endgroup]2026-10-29T03:04:53.7561589Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-29T03:04:53.7561988Z echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-10-29T03:04:53.7582961Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-29T03:04:53.7583179Z env:2026-10-29T03:04:53.7583467Z   TEST_ENV: {  "OSPOOL_EP_OSPoolEPTag": "25-testing",  "OSPOOL_EP_CMTag": "25.x-el9",  "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-10-29T03:04:53.7583784Z ##[endgroup]2026-10-29T03:04:53.7644558Z ##[group]Run true2026-10-29T03:04:53.7644725Z true2026-10-29T03:04:53.7664223Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-29T03:04:53.7664446Z ##[endgroup]2026-10-29T03:04:53.7740442Z ##[group]Run medyagh/setup-minikube@latest2026-10-29T03:04:53.7740641Z with:2026-10-29T03:04:53.7740795Z   start: true2026-10-29T03:04:53.7740938Z   cache: true2026-10-29T03:04:53.7741089Z   minikube-version: latest2026-10-29T03:04:53.7741402Z   wait: all2026-10-29T03:04:53.7741541Z ##[endgroup]2026-10-29T03:04:53.8441267Z (node:1908) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-29T03:04:53.8442005Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-29T03:04:55.1576210Z [command]/usr/bin/chmod +x /home/runner/work/_temp/e1569995-39b4-4f9d-a972-476680f147ef2026-10-29T03:04:55.8160196Z [command]/home/runner/bin/minikube version --short2026-10-29T03:04:55.9217993Z v1.39.02026-10-29T03:04:56.0443612Z Cache hit for: kic-v1.39.0-x642026-10-29T03:04:56.0509961Z (node:1908) [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-29T03:04:56.0548421Z Cache hit for: preloaded-tarball-v1.39.0-x64-stable-docker2026-10-29T03:04:57.1624628Z Received 113246208 of 288577004 (39.2%), 107.9 MBs/sec2026-10-29T03:04:57.3055718Z Received 62914560 of 531630645 (11.8%), 60.0 MBs/sec2026-10-29T03:04:58.1633833Z Received 226492416 of 288577004 (78.5%), 107.9 MBs/sec2026-10-29T03:04:58.3055740Z Received 150994944 of 531630645 (28.4%), 72.0 MBs/sec2026-10-29T03:04:58.8194484Z Received 288577004 of 288577004 (100.0%), 103.5 MBs/sec2026-10-29T03:04:58.8194948Z Cache Size: ~275 MB (288577004 B)2026-10-29T03:04:58.8215161Z [command]/usr/bin/tar -xf /home/runner/work/_temp/398c9577-fd8c-4b77-8552-19c735fede41/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-29T03:04:59.2191728Z Cache restored successfully2026-10-29T03:04:59.3060576Z Received 260046848 of 531630645 (48.9%), 82.7 MBs/sec2026-10-29T03:05:00.3074465Z Received 360710144 of 531630645 (67.8%), 86.0 MBs/sec2026-10-29T03:05:01.3081448Z Received 478150656 of 531630645 (89.9%), 91.2 MBs/sec2026-10-29T03:05:02.0134868Z Received 531630645 of 531630645 (100.0%), 88.8 MBs/sec2026-10-29T03:05:02.0135314Z Cache Size: ~507 MB (531630645 B)2026-10-29T03:05:02.0185743Z [command]/usr/bin/tar -xf /home/runner/work/_temp/655a10f0-0f03-403e-8076-5f5582286f02/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-10-29T03:05:02.2913593Z Cache restored successfully2026-10-29T03:05:02.3306992Z [command]/home/runner/bin/minikube start --wait all2026-10-29T03:05:02.3686707Z * minikube v1.39.0 on Ubuntu 22.042026-10-29T03:05:02.6998756Z ! 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-29T03:05:02.7005444Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-10-29T03:05:02.7321037Z * Using Docker driver with root privileges2026-10-29T03:05:02.7328300Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-10-29T03:05:02.7333059Z * Pulling base image v0.0.51 ...2026-10-29T03:05:26.6341394Z * Preparing Kubernetes v1.37.0 on containerd 2.3.4 ...2026-10-29T03:05:32.7424759Z * Configuring CNI (Container Networking Interface) ...2026-10-29T03:05:38.4157511Z * Verifying Kubernetes components...2026-10-29T03:05:38.4297912Z   - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-10-29T03:05:38.7145162Z * Enabled addons: storage-provisioner, default-storageclass2026-10-29T03:05:54.6188018Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-10-29T03:05:54.6262295Z [command]/home/runner/bin/minikube version --short2026-10-29T03:05:54.6501897Z v1.39.02026-10-29T03:05:54.6693909Z ##[group]Run actions/setup-go@v62026-10-29T03:05:54.6694089Z with:2026-10-29T03:05:54.6694220Z   go-version: 1.262026-10-29T03:05:54.6694366Z   cache: true2026-10-29T03:05:54.6694508Z   cache-dependency-path: go.sum2026-10-29T03:05:54.6694664Z   check-latest: false2026-10-29T03:05:54.6696105Z   token: ***2026-10-29T03:05:54.6696235Z ##[endgroup]2026-10-29T03:05:54.7470122Z Setup go version spec 1.262026-10-29T03:05:54.7649053Z Found in cache @ /opt/hostedtoolcache/go/1.26.10/x642026-10-29T03:05:54.7650684Z Added go to the path2026-10-29T03:05:54.7653015Z Successfully set up Go version 1.262026-10-29T03:05:54.9326833Z [command]/opt/hostedtoolcache/go/1.26.10/x64/bin/go env GOMODCACHE2026-10-29T03:05:54.9346222Z [command]/opt/hostedtoolcache/go/1.26.10/x64/bin/go env GOCACHE2026-10-29T03:05:54.9359600Z /home/runner/go/pkg/mod2026-10-29T03:05:54.9370696Z /home/runner/.cache/go-build2026-10-29T03:05:55.0784734Z Cache is not found2026-10-29T03:05:55.0803250Z go version go1.26.10 linux/amd642026-10-29T03:05:55.0803394Z 2026-10-29T03:05:55.0803601Z ##[group]go env2026-10-29T03:05:55.1586357Z AR='ar'2026-10-29T03:05:55.1586627Z CC='gcc'2026-10-29T03:05:55.1587088Z CGO_CFLAGS='-O2 -g'2026-10-29T03:05:55.1587319Z CGO_CPPFLAGS=''2026-10-29T03:05:55.1587536Z CGO_CXXFLAGS='-O2 -g'2026-10-29T03:05:55.1587762Z CGO_ENABLED='1'2026-10-29T03:05:55.1587966Z CGO_FFLAGS='-O2 -g'2026-10-29T03:05:55.1588183Z CGO_LDFLAGS='-O2 -g'2026-10-29T03:05:55.1588388Z CXX='g++'2026-10-29T03:05:55.1588578Z GCCGO='gccgo'2026-10-29T03:05:55.1588775Z GO111MODULE=''2026-10-29T03:05:55.1588964Z GOAMD64='v1'2026-10-29T03:05:55.1589190Z GOARCH='amd64'2026-10-29T03:05:55.1589381Z GOAUTH='netrc'2026-10-29T03:05:55.1589576Z GOBIN=''2026-10-29T03:05:55.1589802Z GOCACHE='/home/runner/.cache/go-build'2026-10-29T03:05:55.1590074Z GOCACHEPROG=''2026-10-29T03:05:55.1590274Z GODEBUG=''2026-10-29T03:05:55.1590521Z GOENV='/home/runner/.config/go/env'2026-10-29T03:05:55.1590756Z GOEXE=''2026-10-29T03:05:55.1590959Z GOEXPERIMENT=''2026-10-29T03:05:55.1591295Z GOFIPS140='off'2026-10-29T03:05:55.1591484Z GOFLAGS=''2026-10-29T03:05:55.1592081Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build2522741574=/tmp/go-build -gno-record-gcc-switches'2026-10-29T03:05:55.1592708Z GOHOSTARCH='amd64'2026-10-29T03:05:55.1592924Z GOHOSTOS='linux'2026-10-29T03:05:55.1593129Z GOINSECURE=''2026-10-29T03:05:55.1593458Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-10-29T03:05:55.1593871Z GOMODCACHE='/home/runner/go/pkg/mod'2026-10-29T03:05:55.1594124Z GONOPROXY=''2026-10-29T03:05:55.1594320Z GONOSUMDB=''2026-10-29T03:05:55.1594514Z GOOS='linux'2026-10-29T03:05:55.1594749Z GOPATH='/home/runner/go'2026-10-29T03:05:55.1594973Z GOPRIVATE=''2026-10-29T03:05:55.1595246Z GOPROXY='https://proxy.golang.org,direct'2026-10-29T03:05:55.1595567Z GOROOT='/opt/hostedtoolcache/go/1.26.10/x64'2026-10-29T03:05:55.1595893Z GOSUMDB='sum.golang.org'2026-10-29T03:05:55.1596127Z GOTELEMETRY='local'2026-10-29T03:05:55.1596387Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-10-29T03:05:55.1596681Z GOTMPDIR=''2026-10-29T03:05:55.1596883Z GOTOOLCHAIN='local'2026-10-29T03:05:55.1597197Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.10/x64/pkg/tool/linux_amd64'2026-10-29T03:05:55.1597547Z GOVCS=''2026-10-29T03:05:55.1597756Z GOVERSION='go1.26.10'2026-10-29T03:05:55.1597974Z GOWORK=''2026-10-29T03:05:55.1598176Z PKG_CONFIG='pkg-config'2026-10-29T03:05:55.1598321Z 2026-10-29T03:05:55.1598708Z ##[endgroup]2026-10-29T03:05:55.1700028Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-29T03:05:55.1700323Z go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-10-29T03:05:55.1726657Z shell: /usr/bin/bash -e {0}2026-10-29T03:05:55.1726818Z env:2026-10-29T03:05:55.1726943Z   GOTOOLCHAIN: local2026-10-29T03:05:55.1727088Z   OSPOOL_EP_OSPoolEPTag: 25-testing2026-10-29T03:05:55.1727255Z   OSPOOL_EP_CMTag: 25.x-el92026-10-29T03:05:55.1727407Z   OSPOOL_EP_CvmfsType: cvmfsexec2026-10-29T03:05:55.1727561Z ##[endgroup]2026-10-29T03:05:55.2723267Z go: downloading github.com/gruntwork-io/terratest v0.56.02026-10-29T03:05:55.3163730Z go: downloading github.com/masterminds/sprig v2.22.0+incompatible2026-10-29T03:05:55.3605246Z go: downloading github.com/stretchr/testify v1.11.12026-10-29T03:05:55.5447585Z go: downloading gopkg.in/yaml.v3 v3.0.12026-10-29T03:05:55.6446896Z go: downloading k8s.io/api v0.35.02026-10-29T03:05:55.6874890Z go: downloading k8s.io/apimachinery v0.35.02026-10-29T03:05:56.7268965Z go: downloading github.com/Masterminds/goutils v1.1.12026-10-29T03:05:56.7819256Z go: downloading github.com/Masterminds/semver v1.5.02026-10-29T03:05:56.8386112Z go: downloading github.com/google/uuid v1.6.02026-10-29T03:05:56.8516749Z go: downloading github.com/huandu/xstrings v1.5.02026-10-29T03:05:56.8941494Z go: downloading github.com/imdario/mergo v0.3.162026-10-29T03:05:56.9064690Z go: downloading github.com/mitchellh/copystructure v1.2.02026-10-29T03:05:56.9514032Z go: downloading golang.org/x/crypto v0.52.02026-10-29T03:05:57.0913505Z go: downloading github.com/gruntwork-io/go-commons v0.8.02026-10-29T03:05:57.1230375Z go: downloading github.com/mitchellh/go-homedir v1.1.02026-10-29T03:05:57.1549383Z go: downloading k8s.io/client-go v0.35.02026-10-29T03:05:57.4570588Z go: downloading sigs.k8s.io/randfill v1.0.02026-10-29T03:05:57.4570921Z go: downloading k8s.io/utils v0.0.0-20251002143259-bc988d571ff42026-10-29T03:05:57.4642344Z go: downloading k8s.io/klog/v2 v2.130.12026-10-29T03:05:58.2700681Z go: downloading github.com/davecgh/go-spew v1.1.12026-10-29T03:05:58.2799703Z go: downloading github.com/pmezard/go-difflib v1.0.02026-10-29T03:05:58.3285897Z go: downloading github.com/mitchellh/reflectwalk v1.0.22026-10-29T03:05:58.5005929Z go: downloading github.com/aws/aws-sdk-go-v2 v1.32.52026-10-29T03:05:58.5204023Z go: downloading github.com/aws/aws-sdk-go-v2/config v1.28.52026-10-29T03:05:58.5629345Z go: downloading github.com/aws/aws-sdk-go-v2/credentials v1.17.462026-10-29T03:05:58.6042915Z go: downloading github.com/aws/aws-sdk-go-v2/feature/s3/manager v1.17.412026-10-29T03:05:58.6303422Z go: downloading github.com/aws/aws-sdk-go-v2/service/acm v1.30.62026-10-29T03:05:58.6304529Z go: downloading github.com/aws/aws-sdk-go-v2/service/autoscaling v1.51.02026-10-29T03:05:58.6744880Z go: downloading github.com/aws/aws-sdk-go-v2/service/cloudwatchlogs v1.44.02026-10-29T03:05:58.6984439Z go: downloading github.com/aws/aws-sdk-go-v2/service/dynamodb v1.37.12026-10-29T03:05:58.7819860Z go: downloading github.com/aws/aws-sdk-go-v2/service/ec2 v1.193.02026-10-29T03:05:58.7926616Z go: downloading github.com/aws/aws-sdk-go-v2/service/ecr v1.36.62026-10-29T03:05:58.8838247Z go: downloading github.com/aws/aws-sdk-go-v2/service/ecs v1.52.02026-10-29T03:05:58.9635818Z go: downloading github.com/aws/aws-sdk-go-v2/service/iam v1.38.12026-10-29T03:05:58.9707035Z go: downloading github.com/aws/aws-sdk-go-v2/service/kms v1.37.62026-10-29T03:05:59.0415455Z go: downloading github.com/aws/aws-sdk-go-v2/service/lambda v1.69.02026-10-29T03:05:59.0588526Z go: downloading github.com/aws/aws-sdk-go-v2/service/rds v1.91.02026-10-29T03:05:59.1522016Z go: downloading github.com/aws/aws-sdk-go-v2/service/route53 v1.46.22026-10-29T03:05:59.1770174Z go: downloading github.com/aws/aws-sdk-go-v2/service/s3 v1.69.02026-10-29T03:05:59.2306254Z go: downloading github.com/aws/aws-sdk-go-v2/service/secretsmanager v1.34.62026-10-29T03:05:59.2307097Z go: downloading github.com/aws/aws-sdk-go-v2/service/sns v1.33.62026-10-29T03:05:59.2754327Z go: downloading github.com/aws/aws-sdk-go-v2/service/sqs v1.37.12026-10-29T03:05:59.3051079Z go: downloading github.com/aws/aws-sdk-go-v2/service/ssm v1.56.02026-10-29T03:05:59.3623823Z go: downloading github.com/aws/aws-sdk-go-v2/service/sts v1.33.12026-10-29T03:05:59.3625896Z go: downloading github.com/go-sql-driver/mysql v1.8.12026-10-29T03:05:59.5068107Z go: downloading github.com/hashicorp/go-multierror v1.1.12026-10-29T03:05:59.5172698Z go: downloading github.com/jackc/pgx/v5 v5.9.02026-10-29T03:05:59.5644815Z go: downloading github.com/pquerna/otp v1.4.02026-10-29T03:05:59.5645185Z go: downloading github.com/mattn/go-zglob v0.0.2-0.20190814121620-e3c9456763262026-10-29T03:05:59.6023044Z go: downloading github.com/go-errors/errors v1.0.2-0.20180813162953-d98b870cc4e02026-10-29T03:05:59.6423547Z go: downloading github.com/urfave/cli v1.22.162026-10-29T03:05:59.6427956Z go: downloading github.com/spf13/pflag v1.0.92026-10-29T03:05:59.6429739Z go: downloading golang.org/x/term v0.43.02026-10-29T03:05:59.7076198Z go: downloading github.com/gorilla/websocket v1.5.4-0.20250319132907-e064f32e36742026-10-29T03:05:59.7419133Z go: downloading gopkg.in/inf.v0 v0.9.12026-10-29T03:05:59.7424661Z go: downloading github.com/munnerz/goautoneg v0.0.0-20191010083416-a7dc8b61c8222026-10-29T03:05:59.7425456Z go: downloading golang.org/x/net v0.54.02026-10-29T03:05:59.7715412Z go: downloading sigs.k8s.io/json v0.0.0-20250730193827-2d320260d7302026-10-29T03:05:59.8460227Z go: downloading k8s.io/kube-openapi v0.0.0-20250910181357-589584f1c9122026-10-29T03:05:59.8573644Z go: downloading sigs.k8s.io/structured-merge-diff/v6 v6.3.02026-10-29T03:05:59.8664518Z go: downloading github.com/go-logr/logr v1.4.32026-10-29T03:06:00.0666968Z go: downloading github.com/aws/aws-sdk-go-v2/feature/ec2/imds v1.16.202026-10-29T03:06:00.0773912Z go: downloading github.com/aws/aws-sdk-go-v2/internal/ini v1.8.12026-10-29T03:06:00.0886317Z go: downloading github.com/aws/aws-sdk-go-v2/service/sso v1.24.62026-10-29T03:06:00.1220342Z go: downloading github.com/aws/aws-sdk-go-v2/service/ssooidc v1.28.52026-10-29T03:06:00.1318214Z go: downloading github.com/aws/smithy-go v1.22.12026-10-29T03:06:00.2081942Z go: downloading github.com/aws/aws-sdk-go-v2/internal/configsources v1.3.242026-10-29T03:06:00.2082633Z go: downloading github.com/jmespath/go-jmespath v0.4.02026-10-29T03:06:00.2097483Z go: downloading github.com/aws/aws-sdk-go-v2/service/internal/accept-encoding v1.12.12026-10-29T03:06:00.2643155Z go: downloading github.com/aws/aws-sdk-go-v2/service/internal/endpoint-discovery v1.10.52026-10-29T03:06:00.2732781Z go: downloading github.com/aws/aws-sdk-go-v2/aws/protocol/eventstream v1.6.72026-10-29T03:06:00.2947838Z go: downloading github.com/aws/aws-sdk-go-v2/service/internal/presigned-url v1.12.52026-10-29T03:06:00.3297646Z go: downloading github.com/aws/aws-sdk-go-v2/internal/v4a v1.3.242026-10-29T03:06:00.3381978Z go: downloading github.com/aws/aws-sdk-go-v2/service/internal/checksum v1.4.52026-10-29T03:06:00.3382430Z go: downloading github.com/aws/aws-sdk-go-v2/service/internal/s3shared v1.18.52026-10-29T03:06:00.3953701Z go: downloading filippo.io/edwards25519 v1.1.02026-10-29T03:06:00.4016215Z go: downloading github.com/hashicorp/errwrap v1.0.02026-10-29T03:06:00.4024943Z go: downloading github.com/google/gnostic-models v0.7.02026-10-29T03:06:00.4025422Z go: downloading google.golang.org/protobuf v1.36.82026-10-29T03:06:00.4519544Z go: downloading golang.org/x/time v0.9.02026-10-29T03:06:00.4552115Z go: downloading github.com/cpuguy83/go-md2man/v2 v2.0.52026-10-29T03:06:00.4795427Z go: downloading github.com/moby/spdystream v0.5.12026-10-29T03:06:00.5093746Z go: downloading golang.org/x/sys v0.45.02026-10-29T03:06:00.5253036Z go: downloading github.com/fxamacker/cbor/v2 v2.9.02026-10-29T03:06:00.5564774Z go: downloading golang.org/x/oauth2 v0.30.02026-10-29T03:06:00.6232229Z go: downloading github.com/json-iterator/go v1.1.122026-10-29T03:06:00.6349251Z go: downloading go.yaml.in/yaml/v2 v2.4.32026-10-29T03:06:00.6863166Z go: downloading github.com/aws/aws-sdk-go-v2/internal/endpoints/v2 v2.6.242026-10-29T03:06:00.6881254Z go: downloading github.com/jackc/pgpassfile v1.0.02026-10-29T03:06:00.6911229Z go: downloading github.com/jackc/pgservicefile v0.0.0-20240606120523-5a60cdf6a7612026-10-29T03:06:00.7417832Z go: downloading golang.org/x/text v0.37.02026-10-29T03:06:00.7438806Z go: downloading github.com/jackc/puddle/v2 v2.2.22026-10-29T03:06:00.7446881Z go: downloading github.com/boombuler/barcode v1.0.1-0.20190219062509-6c824513bacc2026-10-29T03:06:00.8472213Z go: downloading sigs.k8s.io/yaml v1.6.02026-10-29T03:06:00.8472836Z go: downloading go.yaml.in/yaml/v3 v3.0.42026-10-29T03:06:00.8763133Z go: downloading github.com/mxk/go-flowrate v0.0.0-20140419014527-cca7078d478f2026-10-29T03:06:00.9043070Z go: downloading github.com/russross/blackfriday/v2 v2.1.02026-10-29T03:06:00.9081604Z go: downloading github.com/x448/float16 v0.8.42026-10-29T03:06:01.1053558Z go: downloading github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd2026-10-29T03:06:01.1054171Z go: downloading github.com/modern-go/reflect2 v1.0.3-0.20250322232337-35a7c28c31ee2026-10-29T03:06:01.1054610Z go: downloading github.com/go-openapi/swag v0.23.02026-10-29T03:06:01.1057480Z go: downloading github.com/go-openapi/jsonreference v0.20.22026-10-29T03:06:01.1600444Z go: downloading gopkg.in/evanphx/json-patch.v4 v4.13.02026-10-29T03:06:01.1613034Z go: downloading golang.org/x/sync v0.20.02026-10-29T03:06:01.1798600Z go: downloading github.com/emicklei/go-restful/v3 v3.12.22026-10-29T03:06:01.2142892Z go: downloading github.com/go-openapi/jsonpointer v0.21.02026-10-29T03:06:01.2155115Z go: downloading github.com/mailru/easyjson v0.7.72026-10-29T03:06:01.2734436Z go: downloading github.com/josharian/intern v1.0.02026-10-29T03:07:30.7293162Z === RUN   TestOSPoolEP2026-10-29T03:07:30.7293504Z === PAUSE TestOSPoolEP2026-10-29T03:07:30.7293784Z === CONT  TestOSPoolEP2026-10-29T03:07:30.7294535Z TestOSPoolEP 2026-10-29T03:07:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:07:30.7368982Z TestOSPoolEP 2026-10-29T03:07:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx apply -f /tmp/TestOSPoolEP692023132]2026-10-29T03:07:30.9325239Z TestOSPoolEP 2026-10-29T03:07:30Z logger.go:67: pod/idtoken-generator created2026-10-29T03:07:30.9370199Z TestOSPoolEP 2026-10-29T03:07:30Z logger.go:67: secret/pool-passwd created2026-10-29T03:07:30.9401646Z TestOSPoolEP 2026-10-29T03:07:30Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-29T03:07:30.9402468Z TestOSPoolEP 2026-10-29T03:07:30Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:07:30.9437488Z TestOSPoolEP 2026-10-29T03:07:30Z 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-29T03:07:40.9444772Z TestOSPoolEP 2026-10-29T03:07:40Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-10-29T03:07:40.9447324Z TestOSPoolEP 2026-10-29T03:07:40Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:07:40.9467077Z TestOSPoolEP 2026-10-29T03:07:40Z logger.go:67: Pod is now available2026-10-29T03:07:40.9467803Z TestOSPoolEP 2026-10-29T03:07:40Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-10-29T03:07:41.0298326Z TestOSPoolEP 2026-10-29T03:07:41Z logger.go:67: ***2026-10-29T03:07:41.0336016Z TestOSPoolEP 2026-10-29T03:07:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx apply -f /tmp/TestOSPoolEP1907978626]2026-10-29T03:07:41.1455630Z TestOSPoolEP 2026-10-29T03:07:41Z logger.go:67: secret/pool-token created2026-10-29T03:07:41.1470793Z TestOSPoolEP 2026-10-29T03:07:41Z retry.go:91: Wait for secret pool-token to be provisioned.2026-10-29T03:07:41.1471649Z TestOSPoolEP 2026-10-29T03:07:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:07:41.1485843Z TestOSPoolEP 2026-10-29T03:07:41Z logger.go:67: Secret is now available2026-10-29T03:07:41.1494400Z TestOSPoolEP 2026-10-29T03:07:41Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx apply -k /tmp/kustomize-template-268780234]2026-10-29T03:07:41.2926402Z TestOSPoolEP 2026-10-29T03:07:41Z logger.go:67: service/test-cm created2026-10-29T03:07:41.2983204Z TestOSPoolEP 2026-10-29T03:07:41Z 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-29T03:07:41.2984870Z TestOSPoolEP 2026-10-29T03:07:41Z logger.go:67: deployment.apps/ospool-ep created2026-10-29T03:07:41.3061080Z TestOSPoolEP 2026-10-29T03:07:41Z logger.go:67: deployment.apps/test-cm created2026-10-29T03:07:41.3093412Z === RUN   TestOSPoolEP/Confirm_deployments_become_ready.2026-10-29T03:07:41.3097265Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-29T03:07:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:07:41.3122053Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-29T03:07:41Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-29T03:07:41.3137404Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-29T03:07:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:07:41.3138481Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-29T03:07:41Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-29T03:07:41.3139521Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-29T03:07:41Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:07:41.3155923Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-29T03:07:41Z retry.go:103: Wait for deployment test-cm to be provisioned. returned an error: Deployment test-cm is not available as 'Progressing' condition indicates that the Deployment is not complete, status: True, reason: NewReplicaSetCreated, message: Created new replica set "test-cm-5886f7986". Sleeping for 10s and will try again.2026-10-29T03:07:41.3210102Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-29T03:07:41Z 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-29T03:07:51.3169078Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-29T03:07:51Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-10-29T03:07:51.3170144Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-29T03:07:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:07:51.3193075Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-29T03:07:51Z logger.go:67: Deployment is now available2026-10-29T03:07:51.3224292Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-29T03:07:51Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-29T03:07:51.3225380Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-29T03:07:51Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:07:51.3258322Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-29T03:07:51Z 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-29T03:08:01.3265710Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-29T03:08:01Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-10-29T03:08:01.3266653Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-29T03:08:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:08:01.3288681Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-10-29T03:08:01Z logger.go:67: Deployment is now available2026-10-29T03:08:01.3290553Z === RUN   TestOSPoolEP/Confirm_condor_status_lists_the_EP2026-10-29T03:08:01.3295001Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-29T03:08:01Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:08:01.3309831Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-29T03:08:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx cp ../test-configs/ospool-ep/condor_status.sh test-cm-5886f7986-w9lw6:/tmp/condor_status.sh]2026-10-29T03:08:01.4363479Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-29T03:08:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec test-cm-5886f7986-w9lw6 -- chmod +x /tmp/condor_status.sh]2026-10-29T03:08:01.5157983Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-29T03:08:01Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec test-cm-5886f7986-w9lw6 -- sh -c /tmp/condor_status.sh]2026-10-29T03:08:01.6023493Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-29T03:08:01Z logger.go:67: command terminated with exit code 12026-10-29T03:08:01.6037050Z     test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-5886f7986-w9lw6 failed. Retrying in 10s.2026-10-29T03:08:11.6047039Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-29T03:08:11Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec test-cm-5886f7986-w9lw6 -- sh -c /tmp/condor_status.sh]2026-10-29T03:08:11.6932064Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-29T03:08:11Z logger.go:67: command terminated with exit code 12026-10-29T03:08:11.6945544Z     test_utils.go:102: Exec '[sh -c /tmp/condor_status.sh]' in pod test-cm-5886f7986-w9lw6 failed. Retrying in 10s.2026-10-29T03:08:21.6954590Z TestOSPoolEP/Confirm_condor_status_lists_the_EP 2026-10-29T03:08:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec test-cm-5886f7986-w9lw6 -- sh -c /tmp/condor_status.sh]2026-10-29T03:08:21.7788140Z === RUN   TestOSPoolEP/Confirm_EP_container_advertises_singularity2026-10-29T03:08:21.7789260Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-29T03:08:21Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:08:21.7815572Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-29T03:08:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx cp ../test-configs/ospool-ep/has_singularity.sh test-cm-5886f7986-w9lw6:/tmp/has_singularity.sh]2026-10-29T03:08:21.8805767Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-29T03:08:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec test-cm-5886f7986-w9lw6 -- chmod +x /tmp/has_singularity.sh]2026-10-29T03:08:21.9598427Z TestOSPoolEP/Confirm_EP_container_advertises_singularity 2026-10-29T03:08:21Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec test-cm-5886f7986-w9lw6 -- sh -c /tmp/has_singularity.sh]2026-10-29T03:08:22.0474728Z === RUN   TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-10-29T03:08:22.0476858Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:08:22Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:08:22.0492203Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:08:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx cp ../test-configs/ospool-ep/has_cvmfs.sh test-cm-5886f7986-w9lw6:/tmp/has_cvmfs.sh]2026-10-29T03:08:22.1460703Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:08:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec test-cm-5886f7986-w9lw6 -- chmod +x /tmp/has_cvmfs.sh]2026-10-29T03:08:22.2271927Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:08:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec test-cm-5886f7986-w9lw6 -- sh -c /tmp/has_cvmfs.sh]2026-10-29T03:08:22.3166025Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:08:22Z logger.go:67: command terminated with exit code 12026-10-29T03:08:22.3166791Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-w9lw6 failed. Retrying in 30s.2026-10-29T03:08:52.3169697Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:08:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec test-cm-5886f7986-w9lw6 -- sh -c /tmp/has_cvmfs.sh]2026-10-29T03:08:52.4001552Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:08:52Z logger.go:67: command terminated with exit code 12026-10-29T03:08:52.4013206Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-w9lw6 failed. Retrying in 30s.2026-10-29T03:09:22.4019651Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:09:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec test-cm-5886f7986-w9lw6 -- sh -c /tmp/has_cvmfs.sh]2026-10-29T03:09:22.4884273Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:09:22Z logger.go:67: command terminated with exit code 12026-10-29T03:09:22.4896111Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-w9lw6 failed. Retrying in 30s.2026-10-29T03:09:52.4899687Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:09:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec test-cm-5886f7986-w9lw6 -- sh -c /tmp/has_cvmfs.sh]2026-10-29T03:09:52.5751423Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:09:52Z logger.go:67: command terminated with exit code 12026-10-29T03:09:52.5764338Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-w9lw6 failed. Retrying in 30s.2026-10-29T03:10:22.5776477Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:10:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec test-cm-5886f7986-w9lw6 -- sh -c /tmp/has_cvmfs.sh]2026-10-29T03:10:22.6598471Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:10:22Z logger.go:67: command terminated with exit code 12026-10-29T03:10:22.6610542Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-w9lw6 failed. Retrying in 30s.2026-10-29T03:10:52.6617902Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:10:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec test-cm-5886f7986-w9lw6 -- sh -c /tmp/has_cvmfs.sh]2026-10-29T03:10:52.7462354Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:10:52Z logger.go:67: command terminated with exit code 12026-10-29T03:10:52.7474131Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-w9lw6 failed. Retrying in 30s.2026-10-29T03:11:22.7493006Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:11:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec test-cm-5886f7986-w9lw6 -- sh -c /tmp/has_cvmfs.sh]2026-10-29T03:11:22.8314924Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:11:22Z logger.go:67: command terminated with exit code 12026-10-29T03:11:22.8327116Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-w9lw6 failed. Retrying in 30s.2026-10-29T03:11:52.8338575Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:11:52Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec test-cm-5886f7986-w9lw6 -- sh -c /tmp/has_cvmfs.sh]2026-10-29T03:11:52.9219370Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:11:52Z logger.go:67: command terminated with exit code 12026-10-29T03:11:52.9235156Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-w9lw6 failed. Retrying in 30s.2026-10-29T03:12:22.9247435Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:12:22Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec test-cm-5886f7986-w9lw6 -- sh -c /tmp/has_cvmfs.sh]2026-10-29T03:12:23.0175403Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:12:23Z logger.go:67: command terminated with exit code 12026-10-29T03:12:23.0189860Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-w9lw6 failed. Retrying in 30s.2026-10-29T03:12:53.0210010Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:12:53Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx exec test-cm-5886f7986-w9lw6 -- sh -c /tmp/has_cvmfs.sh]2026-10-29T03:12:53.1005945Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-10-29T03:12:53Z logger.go:67: command terminated with exit code 12026-10-29T03:12:53.1019607Z     test_utils.go:102: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-w9lw6 failed. Retrying in 30s.2026-10-29T03:13:23.1021787Z     test_utils.go:105: Exec '[sh -c /tmp/has_cvmfs.sh]' in pod test-cm-5886f7986-w9lw6 did not succeed within {10 30000000000} retries2026-10-29T03:13:23.1024679Z TestOSPoolEP 2026-10-29T03:13:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:13:23.1073298Z TestOSPoolEP 2026-10-29T03:13:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:13:23.1765458Z TestOSPoolEP 2026-10-29T03:13:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:13:23.2442065Z TestOSPoolEP 2026-10-29T03:13:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:13:23.3099766Z TestOSPoolEP 2026-10-29T03:13:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:13:23.3120993Z === NAME  TestOSPoolEP2026-10-29T03:13:23.3121862Z     ospool_ep_test.go:72: ---2026-10-29T03:13:23.3122220Z         Events for pod idtoken-generator:2026-10-29T03:13:23.3123018Z         2026-10-29 03:07:30 +0000 UTC	Normal	Successfully assigned test-ospool-ep-gfqfqx/idtoken-generator to minikube2026-10-29T03:13:23.3123700Z         2026-10-29 03:07:31 +0000 UTC	Normal	Pulling image "htcondor/base"2026-10-29T03:13:23.3124573Z         2026-10-29 03:07:36 +0000 UTC	Normal	Successfully pulled image "htcondor/base" in 5.221s (5.221s including waiting). Image size: 196303183 bytes.2026-10-29T03:13:23.3125266Z         2026-10-29 03:07:36 +0000 UTC	Normal	Container created2026-10-29T03:13:23.3125715Z         2026-10-29 03:07:36 +0000 UTC	Normal	Container started2026-10-29T03:13:23.3126031Z         2026-10-29T03:13:23.3126233Z         ---2026-10-29T03:13:23.3126728Z TestOSPoolEP 2026-10-29T03:13:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:13:23.3136637Z     ospool_ep_test.go:72: ---2026-10-29T03:13:23.3138497Z         Events for pod ospool-ep-6464cb7998-lfgn5:2026-10-29T03:13:23.3139702Z         2026-10-29 03:07:41 +0000 UTC	Normal	Successfully assigned test-ospool-ep-gfqfqx/ospool-ep-6464cb7998-lfgn5 to minikube2026-10-29T03:13:23.3140516Z         2026-10-29 03:07:41 +0000 UTC	Normal	Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-10-29T03:13:23.3141729Z         2026-10-29 03:07:45 +0000 UTC	Normal	Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 4.219s (4.22s including waiting). Image size: 2893600 bytes.2026-10-29T03:13:23.3142494Z         2026-10-29 03:07:46 +0000 UTC	Normal	Container created2026-10-29T03:13:23.3142935Z         2026-10-29 03:07:46 +0000 UTC	Normal	Container started2026-10-29T03:13:23.3143615Z         2026-10-29 03:07:48 +0000 UTC	Normal	Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-10-29T03:13:23.3144788Z         2026-10-29 03:07:58 +0000 UTC	Normal	Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 10.718s (10.718s including waiting). Image size: 543733340 bytes.2026-10-29T03:13:23.3145596Z         2026-10-29 03:07:58 +0000 UTC	Normal	Container created2026-10-29T03:13:23.3146036Z         2026-10-29 03:07:58 +0000 UTC	Normal	Container started2026-10-29T03:13:23.3146333Z         2026-10-29T03:13:23.3146529Z         ---2026-10-29T03:13:23.3147026Z TestOSPoolEP 2026-10-29T03:13:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:13:23.3160601Z     ospool_ep_test.go:72: ---2026-10-29T03:13:23.3161019Z         Events for pod test-cm-5886f7986-w9lw6:2026-10-29T03:13:23.3161897Z         2026-10-29 03:07:41 +0000 UTC	Normal	Successfully assigned test-ospool-ep-gfqfqx/test-cm-5886f7986-w9lw6 to minikube2026-10-29T03:13:23.3162853Z         2026-10-29 03:07:41 +0000 UTC	Normal	Pulling image "htcondor/cm:25.x-el9"2026-10-29T03:13:23.3163798Z         2026-10-29 03:07:48 +0000 UTC	Normal	Successfully pulled image "htcondor/cm:25.x-el9" in 2.127s (6.332s including waiting). Image size: 196304120 bytes.2026-10-29T03:13:23.3164510Z         2026-10-29 03:07:48 +0000 UTC	Normal	Container created2026-10-29T03:13:23.3164947Z         2026-10-29 03:07:48 +0000 UTC	Normal	Container started2026-10-29T03:13:23.3165243Z         2026-10-29T03:13:23.3165439Z         ---2026-10-29T03:13:23.3165802Z TestOSPoolEP 2026-10-29T03:13:23Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-10-29T03:13:23.3194087Z TestOSPoolEP 2026-10-29T03:13:23Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx delete -f /tmp/TestOSPoolEP450200932]2026-10-29T03:13:23.3856585Z TestOSPoolEP 2026-10-29T03:13:23Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-gfqfqx namespace2026-10-29T03:13:23.3913230Z TestOSPoolEP 2026-10-29T03:13:23Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-gfqfqx namespace2026-10-29T03:13:24.7173245Z TestOSPoolEP 2026-10-29T03:13:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx delete -f /tmp/TestOSPoolEP2018476773]2026-10-29T03:13:24.7739291Z TestOSPoolEP 2026-10-29T03:13:24Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-gfqfqx namespace2026-10-29T03:13:24.7767926Z TestOSPoolEP 2026-10-29T03:13:24Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-gfqfqx delete -k /tmp/kustomize-template-268780234]2026-10-29T03:13:24.8556957Z TestOSPoolEP 2026-10-29T03:13:24Z logger.go:67: service "test-cm" deleted from test-ospool-ep-gfqfqx namespace2026-10-29T03:13:24.8607809Z TestOSPoolEP 2026-10-29T03:13:24Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-gfqfqx namespace2026-10-29T03:13:24.8635272Z TestOSPoolEP 2026-10-29T03:13:24Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-gfqfqx namespace2026-10-29T03:13:24.8712880Z --- FAIL: TestOSPoolEP (354.14s)2026-10-29T03:13:24.8713944Z     --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (20.02s)2026-10-29T03:13:24.8714934Z     --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP (20.45s)2026-10-29T03:13:24.8715492Z     --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity (0.27s)2026-10-29T03:13:24.8716025Z     --- FAIL: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (301.06s)2026-10-29T03:13:24.8716363Z FAIL2026-10-29T03:13:24.8759311Z FAIL	github.com/osg-htc/k8s-integration-tests/test	354.155s2026-10-29T03:13:24.8858701Z FAIL2026-10-29T03:13:25.3740586Z ##[error]Process completed with exit code 1.2026-10-29T03:13:25.3793632Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-29T03:13:25.3794015Z echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-10-29T03:13:25.3825289Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-10-29T03:13:25.3825509Z env:2026-10-29T03:13:25.3825657Z   GOTOOLCHAIN: local2026-10-29T03:13:25.3825919Z   TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-10-29T03:13:25.3826193Z ##[endgroup]2026-10-29T03:13:25.3922425Z ##[group]Run actions/upload-artifact@v42026-10-29T03:13:25.3922706Z with:2026-10-29T03:13:25.3923051Z   name: TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe52026-10-29T03:13:25.3923440Z   path: /tmp/k8s-tests2026-10-29T03:13:25.3923642Z   retention-days: 52026-10-29T03:13:25.3923823Z   if-no-files-found: warn2026-10-29T03:13:25.3924045Z   compression-level: 62026-10-29T03:13:25.3924255Z   overwrite: false2026-10-29T03:13:25.3924450Z   include-hidden-files: false2026-10-29T03:13:25.3924836Z env:2026-10-29T03:13:25.3924961Z   GOTOOLCHAIN: local2026-10-29T03:13:25.3925101Z ##[endgroup]2026-10-29T03:13:25.4932904Z (node:23796) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-10-29T03:13:25.4933688Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-10-29T03:13:25.5032628Z With the provided path, there will be 6 files uploaded2026-10-29T03:13:25.5033302Z Artifact name is valid!2026-10-29T03:13:25.5033560Z Root directory input is valid!2026-10-29T03:13:25.7901722Z Beginning upload of artifact content to blob storage2026-10-29T03:13:25.8076053Z (node:23796) [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-29T03:13:25.9662951Z Uploaded bytes 141222026-10-29T03:13:26.0041359Z Finished uploading artifact content to blob storage!2026-10-29T03:13:26.0042014Z SHA256 digest of uploaded artifact zip is 3eb94cae8658ae4b24b3b33563624a9190a206b2dd991538bbf94c2b5a63e9b52026-10-29T03:13:26.0042510Z Finalizing artifact upload2026-10-29T03:13:26.4340905Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5.zip successfully finalized. Artifact ID 128702871842026-10-29T03:13:26.4342186Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5 has been successfully uploaded! Final size is 14122 bytes. Artifact ID is 128702871842026-10-29T03:13:26.4346661Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/40810066524/artifacts/128702871842026-10-29T03:13:26.4477101Z Post job cleanup.2026-10-29T03:13:26.4991755Z [command]/usr/bin/git version2026-10-29T03:13:26.5019757Z git version 2.56.02026-10-29T03:13:26.5045152Z Temporarily overriding HOME='/home/runner/work/_temp/8ea18d37-f698-483e-9682-f317839154a2' before making global git config changes2026-10-29T03:13:26.5045899Z Adding repository directory to the temporary git global config as a safe directory2026-10-29T03:13:26.5049017Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-10-29T03:13:26.5072925Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-10-29T03:13:26.5092022Z [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-29T03:13:26.5214025Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-10-29T03:13:26.5228335Z http.https://github.com/.extraheader2026-10-29T03:13:26.5236221Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-10-29T03:13:26.5265503Z [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-29T03:13:26.5394569Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-10-29T03:13:26.5418518Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-10-29T03:13:26.5630437Z Cleaning up orphan processes2026-10-29T03:13:26.6014693Z ##[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/