2026-08-31T01:52:18.0095817Z Current runner version: '2.336.0'2026-08-31T01:52:18.0131719Z ##[group]Runner Image Provisioner2026-08-31T01:52:18.0133224Z Hosted Compute Agent2026-08-31T01:52:18.0134312Z Version: 20260819.5862026-08-31T01:52:18.0135385Z Commit: 3cc4a88dfa507ef76119ad1bb3eccc6378bb2b762026-08-31T01:52:18.0136578Z Build Date: 2026-08-18T23:20:18Z2026-08-31T01:52:18.0137886Z Worker ID: {2c8b6e0a-3c4a-4b43-bf9d-7d39412dd035}2026-08-31T01:52:18.0139089Z Azure Region: eastus22026-08-31T01:52:18.0140239Z ##[endgroup]2026-08-31T01:52:18.0142202Z ##[group]Operating System2026-08-31T01:52:18.0143542Z Ubuntu2026-08-31T01:52:18.0144535Z 22.04.52026-08-31T01:52:18.0145375Z LTS2026-08-31T01:52:18.0146209Z ##[endgroup]2026-08-31T01:52:18.0147284Z ##[group]Runner Image2026-08-31T01:52:18.0148273Z Image: ubuntu-22.042026-08-31T01:52:18.0149264Z Version: 20260824.273.32026-08-31T01:52:18.0151356Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260824.273/images/ubuntu/Ubuntu2204-Readme.md2026-08-31T01:52:18.0154225Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260824.2732026-08-31T01:52:18.0155841Z ##[endgroup]2026-08-31T01:52:18.0161800Z ##[group]GITHUB_TOKEN Permissions2026-08-31T01:52:18.0165424Z Actions: write2026-08-31T01:52:18.0166543Z ArtifactMetadata: write2026-08-31T01:52:18.0167566Z Attestations: write2026-08-31T01:52:18.0168452Z Checks: write2026-08-31T01:52:18.0169496Z CodeQuality: write2026-08-31T01:52:18.0170498Z Contents: write2026-08-31T01:52:18.0171596Z CopilotRequests: write2026-08-31T01:52:18.0172814Z Deployments: write2026-08-31T01:52:18.0173730Z Discussions: write2026-08-31T01:52:18.0174872Z Drives: write2026-08-31T01:52:18.0175744Z Issues: write2026-08-31T01:52:18.0176723Z Metadata: read2026-08-31T01:52:18.0177788Z Models: read2026-08-31T01:52:18.0178656Z Packages: write2026-08-31T01:52:18.0179786Z Pages: write2026-08-31T01:52:18.0180656Z PullRequests: write2026-08-31T01:52:18.0181700Z RepositoryProjects: write2026-08-31T01:52:18.0183022Z SecurityEvents: write2026-08-31T01:52:18.0183991Z Statuses: write2026-08-31T01:52:18.0185070Z VulnerabilityAlerts: read2026-08-31T01:52:18.0186063Z ##[endgroup]2026-08-31T01:52:18.0188695Z Secret source: Actions2026-08-31T01:52:18.0190991Z Prepare workflow directory2026-08-31T01:52:18.0646680Z Prepare all required actions2026-08-31T01:52:18.0714878Z Getting action download info2026-08-31T01:52:18.2957488Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-31T01:52:18.4078837Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-31T01:52:18.5721226Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-31T01:52:18.7584698Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-31T01:52:19.0720314Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-31T01:52:19.0727487Z ##[group] Inputs2026-08-31T01:52:19.0728501Z testName: TestOSPoolEP2026-08-31T01:52:19.0730301Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-31T01:52:19.0732225Z setupScript: 2026-08-31T01:52:19.0733280Z setupEnv: {}2026-08-31T01:52:19.0734166Z ##[endgroup]2026-08-31T01:52:19.0735547Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-testing) / Run Tests2026-08-31T01:52:19.1607000Z ##[group]Run actions/checkout@v52026-08-31T01:52:19.1608347Z with:2026-08-31T01:52:19.1609287Z repository: osg-htc/k8s-integration-tests2026-08-31T01:52:19.1617773Z token: ***2026-08-31T01:52:19.1618644Z ssh-strict: true2026-08-31T01:52:19.1619548Z ssh-user: git2026-08-31T01:52:19.1620462Z persist-credentials: true2026-08-31T01:52:19.1621447Z clean: true2026-08-31T01:52:19.1622341Z sparse-checkout-cone-mode: true2026-08-31T01:52:19.1623818Z fetch-depth: 12026-08-31T01:52:19.1624679Z fetch-tags: false2026-08-31T01:52:19.1625586Z show-progress: true2026-08-31T01:52:19.1626494Z lfs: false2026-08-31T01:52:19.1627327Z submodules: false2026-08-31T01:52:19.1628236Z set-safe-directory: true2026-08-31T01:52:19.1629261Z allow-unsafe-pr-checkout: false2026-08-31T01:52:19.1630592Z ##[endgroup]2026-08-31T01:52:19.2752117Z Syncing repository: osg-htc/k8s-integration-tests2026-08-31T01:52:19.2756723Z ##[group]Getting Git version info2026-08-31T01:52:19.2759408Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-31T01:52:19.2763274Z [command]/usr/bin/git version2026-08-31T01:52:19.2808500Z git version 2.55.02026-08-31T01:52:19.2830645Z ##[endgroup]2026-08-31T01:52:19.2845866Z Temporarily overriding HOME='/home/runner/work/_temp/64c0ab36-1713-4c5b-83cb-7aa34424b6d6' before making global git config changes2026-08-31T01:52:19.2850341Z Adding repository directory to the temporary git global config as a safe directory2026-08-31T01:52:19.2854784Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-31T01:52:19.2904922Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-31T01:52:19.2909443Z ##[group]Initializing the repository2026-08-31T01:52:19.2912335Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-31T01:52:19.3028366Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-31T01:52:19.3031795Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-31T01:52:19.3035450Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-31T01:52:19.3038071Z hint: call:2026-08-31T01:52:19.3039500Z hint:2026-08-31T01:52:19.3041250Z hint: git config --global init.defaultBranch <name>2026-08-31T01:52:19.3043538Z hint:2026-08-31T01:52:19.3045548Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-31T01:52:19.3048671Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-31T01:52:19.3051308Z hint:2026-08-31T01:52:19.3052910Z hint: git branch -m <name>2026-08-31T01:52:19.3054600Z hint:2026-08-31T01:52:19.3056767Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-31T01:52:19.3061067Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-31T01:52:19.3067705Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-08-31T01:52:19.3087336Z ##[endgroup]2026-08-31T01:52:19.3089901Z ##[group]Disabling automatic garbage collection2026-08-31T01:52:19.3091896Z [command]/usr/bin/git config --local gc.auto 02026-08-31T01:52:19.3141349Z ##[endgroup]2026-08-31T01:52:19.3143650Z ##[group]Setting up auth2026-08-31T01:52:19.3145674Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-31T01:52:19.3172672Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :"2026-08-31T01:52:19.3588355Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-31T01:52:19.3634600Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :"2026-08-31T01:52:19.3932268Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-31T01:52:19.3976373Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-31T01:52:19.4255220Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-31T01:52:19.4300667Z ##[endgroup]2026-08-31T01:52:19.4309243Z ##[group]Fetching the repository2026-08-31T01:52:19.4311798Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --no-recurse-submodules --depth=1 origin +ecca15d77f3152eb2336d20b91eb226964f888bf:refs/remotes/origin/main2026-08-31T01:52:19.6982900Z From https://github.com/osg-htc/k8s-integration-tests2026-08-31T01:52:19.6984394Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-31T01:52:19.6987325Z ##[endgroup]2026-08-31T01:52:19.6988601Z ##[group]Determining the checkout info2026-08-31T01:52:19.6989951Z ##[endgroup]2026-08-31T01:52:19.6995591Z [command]/usr/bin/git sparse-checkout disable2026-08-31T01:52:19.7050235Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-31T01:52:19.7088509Z ##[group]Checking out the ref2026-08-31T01:52:19.7092354Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-31T01:52:19.7191286Z Switched to a new branch 'main'2026-08-31T01:52:19.7195259Z branch 'main' set up to track 'origin/main'.2026-08-31T01:52:19.7202956Z ##[endgroup]2026-08-31T01:52:19.7257568Z [command]/usr/bin/git log -1 --format=%H2026-08-31T01:52:19.7290570Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-31T01:52:19.7625648Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-31T01:52:19.7626768Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-31T01:52:19.7627752Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-31T01:52:19.7972369Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-31T01:52:19.7973349Z env:2026-08-31T01:52:19.7974152Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-31T01:52:19.7975011Z SETUP_ENV_YAML: {}2026-08-31T01:52:19.7975553Z ##[endgroup]2026-08-31T01:52:20.3414680Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-31T01:52:20.3415397Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-31T01:52:20.3494563Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-31T01:52:20.3494977Z env:2026-08-31T01:52:20.3495493Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-testing", "OSPOOL_EP_CMTag": "25.x-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-31T01:52:20.3496055Z ##[endgroup]2026-08-31T01:52:20.3657206Z ##[group]Run true2026-08-31T01:52:20.3657492Z [36;1mtrue[0m2026-08-31T01:52:20.3733951Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-31T01:52:20.3734369Z ##[endgroup]2026-08-31T01:52:20.3916694Z ##[group]Run medyagh/setup-minikube@latest2026-08-31T01:52:20.3917066Z with:2026-08-31T01:52:20.3917312Z start: true2026-08-31T01:52:20.3917562Z cache: true2026-08-31T01:52:20.3917846Z minikube-version: latest2026-08-31T01:52:20.3918135Z wait: all2026-08-31T01:52:20.3918379Z ##[endgroup]2026-08-31T01:52:20.5280919Z (node:1818) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-31T01:52:20.5282218Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-31T01:52:21.7881151Z [command]/usr/bin/chmod +x /home/runner/work/_temp/de179ae9-864d-4cbe-87d5-2f1f3341417d2026-08-31T01:52:21.9709139Z [command]/home/runner/bin/minikube version --short2026-08-31T01:52:22.0253226Z v1.38.12026-08-31T01:52:22.1119365Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-31T01:52:22.1131341Z Cache hit for: kic-v1.38.1-x642026-08-31T01:52:22.1278638Z (node:1818) [DEP0169] DeprecationWarning: `url.parse()` behavior is not standardized and prone to errors that have security implications. Use the WHATWG URL API instead. CVEs are not issued for `url.parse()` vulnerabilities.2026-08-31T01:52:23.1543406Z Received 109051904 of 224218830 (48.6%), 104.0 MBs/sec2026-08-31T01:52:23.2870105Z Received 134217728 of 544082637 (24.7%), 115.4 MBs/sec2026-08-31T01:52:24.1616340Z Received 224218830 of 224218830 (100.0%), 106.5 MBs/sec2026-08-31T01:52:24.1617142Z Cache Size: ~214 MB (224218830 B)2026-08-31T01:52:24.2366130Z [command]/usr/bin/tar -xf /home/runner/work/_temp/3e29b86b-d14d-4100-8a12-c12f145a3da3/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-31T01:52:24.4048707Z Received 268435456 of 544082637 (49.3%), 115.0 MBs/sec2026-08-31T01:52:25.2078594Z Cache restored successfully2026-08-31T01:52:25.4144424Z Received 452984832 of 544082637 (83.3%), 133.7 MBs/sec2026-08-31T01:52:25.9349108Z Received 544082637 of 544082637 (100.0%), 138.1 MBs/sec2026-08-31T01:52:25.9349865Z Cache Size: ~519 MB (544082637 B)2026-08-31T01:52:25.9383191Z [command]/usr/bin/tar -xf /home/runner/work/_temp/39ab14ea-9830-49d1-a8c9-2f3efc3d5586/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-31T01:52:26.9473637Z Cache restored successfully2026-08-31T01:52:27.0753174Z [command]/home/runner/bin/minikube start --wait all2026-08-31T01:52:27.1447670Z * minikube v1.38.1 on Ubuntu 22.042026-08-31T01:52:32.3817941Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-31T01:52:32.4384990Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-31T01:52:32.4394104Z * Using Docker driver with root privileges2026-08-31T01:52:32.4403288Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-31T01:52:32.4409915Z * Pulling base image v0.0.50 ...2026-08-31T01:53:04.3891887Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-31T01:53:09.5619100Z * Verifying Kubernetes components...2026-08-31T01:53:09.5889858Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-31T01:53:10.3006316Z * Enabled addons: default-storageclass, storage-provisioner2026-08-31T01:53:51.6915660Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-31T01:53:51.7073220Z [command]/home/runner/bin/minikube version --short2026-08-31T01:53:51.7662409Z v1.38.12026-08-31T01:53:51.8222278Z ##[group]Run actions/setup-go@v62026-08-31T01:53:51.8222753Z with:2026-08-31T01:53:51.8222971Z go-version: 1.262026-08-31T01:53:51.8223193Z cache: true2026-08-31T01:53:51.8223427Z cache-dependency-path: go.sum2026-08-31T01:53:51.8223699Z check-latest: false2026-08-31T01:53:51.8226112Z token: ***2026-08-31T01:53:51.8226331Z ##[endgroup]2026-08-31T01:53:51.9608941Z Setup go version spec 1.262026-08-31T01:53:51.9669845Z Found in cache @ /opt/hostedtoolcache/go/1.26.7/x642026-08-31T01:53:51.9672064Z Added go to the path2026-08-31T01:53:51.9675637Z Successfully set up Go version 1.262026-08-31T01:53:52.5875937Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOMODCACHE2026-08-31T01:53:52.5943812Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOCACHE2026-08-31T01:53:52.6024647Z /home/runner/go/pkg/mod2026-08-31T01:53:52.6085009Z /home/runner/.cache/go-build2026-08-31T01:53:52.7080531Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-31T01:53:53.7794446Z Received 192937984 of 251715014 (76.6%), 182.0 MBs/sec2026-08-31T01:53:54.0374315Z Received 251715014 of 251715014 (100.0%), 189.2 MBs/sec2026-08-31T01:53:54.0375756Z Cache Size: ~240 MB (251715014 B)2026-08-31T01:53:54.0461224Z [command]/usr/bin/tar -xf /home/runner/work/_temp/f461752a-e315-4d35-83af-a64748e08588/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-31T01:53:57.1288659Z Cache restored successfully2026-08-31T01:53:57.1906733Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-31T01:53:57.1935558Z go version go1.26.7 linux/amd642026-08-31T01:53:57.1935799Z 2026-08-31T01:53:57.1936135Z ##[group]go env2026-08-31T01:53:57.2909236Z AR='ar'2026-08-31T01:53:57.2909656Z CC='gcc'2026-08-31T01:53:57.2909997Z CGO_CFLAGS='-O2 -g'2026-08-31T01:53:57.2910406Z CGO_CPPFLAGS=''2026-08-31T01:53:57.2910769Z CGO_CXXFLAGS='-O2 -g'2026-08-31T01:53:57.2911126Z CGO_ENABLED='1'2026-08-31T01:53:57.2911464Z CGO_FFLAGS='-O2 -g'2026-08-31T01:53:57.2911798Z CGO_LDFLAGS='-O2 -g'2026-08-31T01:53:57.2912159Z CXX='g++'2026-08-31T01:53:57.2912683Z GCCGO='gccgo'2026-08-31T01:53:57.2913028Z GO111MODULE=''2026-08-31T01:53:57.2913355Z GOAMD64='v1'2026-08-31T01:53:57.2913694Z GOARCH='amd64'2026-08-31T01:53:57.2914004Z GOAUTH='netrc'2026-08-31T01:53:57.2914326Z GOBIN=''2026-08-31T01:53:57.2914666Z GOCACHE='/home/runner/.cache/go-build'2026-08-31T01:53:57.2915119Z GOCACHEPROG=''2026-08-31T01:53:57.2915427Z GODEBUG=''2026-08-31T01:53:57.2915793Z GOENV='/home/runner/.config/go/env'2026-08-31T01:53:57.2916229Z GOEXE=''2026-08-31T01:53:57.2916549Z GOEXPERIMENT=''2026-08-31T01:53:57.2916895Z GOFIPS140='off'2026-08-31T01:53:57.2917227Z GOFLAGS=''2026-08-31T01:53:57.2918290Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build3783483234=/tmp/go-build -gno-record-gcc-switches'2026-08-31T01:53:57.2919363Z GOHOSTARCH='amd64'2026-08-31T01:53:57.2919703Z GOHOSTOS='linux'2026-08-31T01:53:57.2920034Z GOINSECURE=''2026-08-31T01:53:57.2920595Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-31T01:53:57.2921267Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-31T01:53:57.2921668Z GONOPROXY=''2026-08-31T01:53:57.2921992Z GONOSUMDB=''2026-08-31T01:53:57.2922301Z GOOS='linux'2026-08-31T01:53:57.2922886Z GOPATH='/home/runner/go'2026-08-31T01:53:57.2923250Z GOPRIVATE=''2026-08-31T01:53:57.2923678Z GOPROXY='https://proxy.golang.org,direct'2026-08-31T01:53:57.2924213Z GOROOT='/opt/hostedtoolcache/go/1.26.7/x64'2026-08-31T01:53:57.2924698Z GOSUMDB='sum.golang.org'2026-08-31T01:53:57.2925082Z GOTELEMETRY='local'2026-08-31T01:53:57.2925521Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-31T01:53:57.2925998Z GOTMPDIR=''2026-08-31T01:53:57.2926335Z GOTOOLCHAIN='local'2026-08-31T01:53:57.2927264Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.7/x64/pkg/tool/linux_amd64'2026-08-31T01:53:57.2927843Z GOVCS=''2026-08-31T01:53:57.2928165Z GOVERSION='go1.26.7'2026-08-31T01:53:57.2928510Z GOWORK=''2026-08-31T01:53:57.2928830Z PKG_CONFIG='pkg-config'2026-08-31T01:53:57.2929048Z 2026-08-31T01:53:57.2929567Z ##[endgroup]2026-08-31T01:53:57.3226104Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-31T01:53:57.3226658Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-31T01:53:57.3302680Z shell: /usr/bin/bash -e {0}2026-08-31T01:53:57.3302963Z env:2026-08-31T01:53:57.3303190Z GOTOOLCHAIN: local2026-08-31T01:53:57.3303453Z OSPOOL_EP_OSPoolEPTag: 25-testing2026-08-31T01:53:57.3303767Z OSPOOL_EP_CMTag: 25.x-el92026-08-31T01:53:57.3304029Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-31T01:53:57.3304295Z ##[endgroup]2026-08-31T01:54:03.3332398Z === RUN TestOSPoolEP2026-08-31T01:54:03.3333339Z === PAUSE TestOSPoolEP2026-08-31T01:54:03.3333602Z === CONT TestOSPoolEP2026-08-31T01:54:03.3344807Z TestOSPoolEP 2026-08-31T01:54:03Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:03.3453024Z TestOSPoolEP 2026-08-31T01:54:03Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo apply -f /tmp/TestOSPoolEP1701863881]2026-08-31T01:54:04.4990010Z TestOSPoolEP 2026-08-31T01:54:04Z logger.go:67: pod/idtoken-generator created2026-08-31T01:54:04.5049992Z TestOSPoolEP 2026-08-31T01:54:04Z logger.go:67: secret/pool-passwd created2026-08-31T01:54:04.5114880Z TestOSPoolEP 2026-08-31T01:54:04Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-31T01:54:04.5125529Z TestOSPoolEP 2026-08-31T01:54:04Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:04.5139926Z TestOSPoolEP 2026-08-31T01:54:04Z retry.go:103: Wait for pod idtoken-generator to be provisioned. returned an error: Pod idtoken-generator is not available, reason: , message: . Sleeping for 10s and will try again.2026-08-31T01:54:14.5141985Z TestOSPoolEP 2026-08-31T01:54:14Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-31T01:54:14.5143515Z TestOSPoolEP 2026-08-31T01:54:14Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:14.5170960Z TestOSPoolEP 2026-08-31T01:54:14Z logger.go:67: Pod is now available2026-08-31T01:54:14.5173048Z TestOSPoolEP 2026-08-31T01:54:14Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-31T01:54:15.1144461Z TestOSPoolEP 2026-08-31T01:54:15Z logger.go:67: ***2026-08-31T01:54:15.1197869Z TestOSPoolEP 2026-08-31T01:54:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo apply -f /tmp/TestOSPoolEP407626009]2026-08-31T01:54:15.2145304Z TestOSPoolEP 2026-08-31T01:54:15Z logger.go:67: secret/pool-token created2026-08-31T01:54:15.2179139Z TestOSPoolEP 2026-08-31T01:54:15Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-31T01:54:15.2180488Z TestOSPoolEP 2026-08-31T01:54:15Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:15.2199717Z TestOSPoolEP 2026-08-31T01:54:15Z logger.go:67: Secret is now available2026-08-31T01:54:15.2227425Z TestOSPoolEP 2026-08-31T01:54:15Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo apply -k /tmp/kustomize-template-769235407]2026-08-31T01:54:15.3865541Z TestOSPoolEP 2026-08-31T01:54:15Z logger.go:67: service/test-cm created2026-08-31T01:54:15.3946166Z TestOSPoolEP 2026-08-31T01:54:15Z logger.go:67: Warning: spec.template.spec.containers[0].env[8]: hides previous definition of "OSG_SQUID_LOCATION", which may be dropped when using apply2026-08-31T01:54:15.3951197Z TestOSPoolEP 2026-08-31T01:54:15Z logger.go:67: deployment.apps/ospool-ep created2026-08-31T01:54:15.4027316Z TestOSPoolEP 2026-08-31T01:54:15Z logger.go:67: deployment.apps/test-cm created2026-08-31T01:54:15.4088629Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-31T01:54:15.4092747Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:15Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:15.4194227Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:15Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-31T01:54:15.4202071Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:15Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:15.4204819Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:15Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-31T01:54:15.4207109Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:15Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:15.4225944Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:15Z 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-65c844ddbb". Sleeping for 10s and will try again.2026-08-31T01:54:15.4265183Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:15Z 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-5bb545475c". Sleeping for 10s and will try again.2026-08-31T01:54:25.4257724Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:25Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-31T01:54:25.4260581Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:25.4276672Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:25Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-31T01:54:25.4278477Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:25Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:25.4304896Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:25Z logger.go:67: Deployment is now available2026-08-31T01:54:25.4308020Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:25Z 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-65c844ddbb" is progressing.. Sleeping for 10s and will try again.2026-08-31T01:54:35.4316153Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:35Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-31T01:54:35.4317827Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:35.4341158Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:35Z logger.go:67: Deployment is now available2026-08-31T01:54:35.4342242Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-31T01:54:35.4343094Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-31T01:54:35.4343813Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-31T01:54:35.4344302Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-31T01:54:35.4344760Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-31T01:54:35.4345163Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-31T01:54:35.4345973Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-31T01:54:35.4346798Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:54:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:35.4349562Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-31T01:54:35.4350611Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:54:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:35.4370211Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-31T01:54:35.4375701Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-31T01:54:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:35.4378691Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:54:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:35.4381848Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-31T01:54:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:35.4389644Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:54:35Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:35.4414855Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:54:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:54:35.4434372Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:54:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)']2026-08-31T01:54:35.4457360Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-31T01:54:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_SINGULARITY]2026-08-31T01:54:35.6503680Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-31T01:54:35.6506275Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)']' in pod test-cm-5bb545475c-tz8mw failed. Retrying in 10s.2026-08-31T01:54:35.6529268Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-31T01:54:35.6532224Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tz8mw failed. Retrying in 30s.2026-08-31T01:54:35.6580069Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-31T01:54:35.6583598Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-tz8mw failed. Retrying in 10s.2026-08-31T01:54:45.6508118Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:54:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)']2026-08-31T01:54:45.6589581Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-31T01:54:45Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_SINGULARITY]2026-08-31T01:54:45.8160049Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-31T01:54:45.8161452Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)']' in pod test-cm-5bb545475c-tz8mw failed. Retrying in 10s.2026-08-31T01:54:45.8301705Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-31T01:54:45.8303694Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_SINGULARITY]' in pod test-cm-5bb545475c-tz8mw failed. Retrying in 10s.2026-08-31T01:54:55.8178193Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:54:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)']2026-08-31T01:54:55.8311985Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-31T01:54:55Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_SINGULARITY]2026-08-31T01:54:55.9445604Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:54:55Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-31T01:54:55.9447167Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:54:55Z logger.go:67: 2026-08-31T01:54:55.9449545Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:54:55Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-65c844ddbb-7mbnl LINUX X86_64 Unclaimed Idle 0.000 15988 0+00:00:002026-08-31T01:54:55.9451272Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:54:55Z logger.go:67: 2026-08-31T01:54:55.9453040Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:54:55Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-31T01:54:55.9454553Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:54:55Z logger.go:67: 2026-08-31T01:54:55.9456010Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:54:55Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-31T01:54:55.9457397Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:54:55Z logger.go:67: 2026-08-31T01:54:55.9458803Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:54:55Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-31T01:54:55.9472417Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-31T01:54:55Z logger.go:67: true2026-08-31T01:55:05.6536291Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:55:05Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:55:05.7651916Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:55:05Z logger.go:67: undefined2026-08-31T01:55:05.7712010Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-31T01:55:05.7713758Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tz8mw failed. Retrying in 30s.2026-08-31T01:55:35.7724904Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:55:35Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:55:35.9232423Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:55:35Z logger.go:67: undefined2026-08-31T01:55:35.9289022Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tz8mw failed. Retrying in 30s.2026-08-31T01:56:05.9303836Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:56:05Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:56:06.0429649Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:56:06Z logger.go:67: undefined2026-08-31T01:56:06.0485814Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tz8mw failed. Retrying in 30s.2026-08-31T01:56:36.0491578Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:56:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:56:36.1705663Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:56:36Z logger.go:67: undefined2026-08-31T01:56:36.1798759Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tz8mw failed. Retrying in 30s.2026-08-31T01:57:06.1824103Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:57:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:57:06.2960478Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:57:06Z logger.go:67: undefined2026-08-31T01:57:06.3022404Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tz8mw failed. Retrying in 30s.2026-08-31T01:57:36.3024855Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:57:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:57:36.4146395Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:57:36Z logger.go:67: undefined2026-08-31T01:57:36.4201051Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tz8mw failed. Retrying in 30s.2026-08-31T01:58:06.4227037Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:58:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:58:06.5344620Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:58:06Z logger.go:67: undefined2026-08-31T01:58:06.5404031Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tz8mw failed. Retrying in 30s.2026-08-31T01:58:36.5407376Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:58:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:58:36.6508027Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:58:36Z logger.go:67: undefined2026-08-31T01:58:36.6564026Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tz8mw failed. Retrying in 30s.2026-08-31T01:59:06.6590795Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:59:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:59:06.7730944Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:59:06Z logger.go:67: undefined2026-08-31T01:59:06.7780065Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tz8mw failed. Retrying in 30s.2026-08-31T01:59:36.7806028Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:59:36Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:59:36.8922185Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:59:36Z logger.go:67: undefined2026-08-31T01:59:36.8974977Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-5bb545475c-tz8mw failed. Retrying in 30s.2026-08-31T02:00:06.9004139Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T02:00:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo exec test-cm-5bb545475c-tz8mw -- sh -c condor_status -const 'regexp("ospool-ep-65c844ddbb-7mbnl",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T02:00:07.0233250Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T02:00:07Z logger.go:67: true2026-08-31T02:00:07.0294057Z TestOSPoolEP 2026-08-31T02:00:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T02:00:07.0383223Z TestOSPoolEP 2026-08-31T02:00:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T02:00:07.1464385Z TestOSPoolEP 2026-08-31T02:00:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T02:00:07.2385188Z TestOSPoolEP 2026-08-31T02:00:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T02:00:07.3115101Z TestOSPoolEP 2026-08-31T02:00:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T02:00:07.3142432Z === NAME TestOSPoolEP2026-08-31T02:00:07.3143334Z ospool_ep_test.go:101: ---2026-08-31T02:00:07.3144055Z Events for pod idtoken-generator:2026-08-31T02:00:07.3145518Z 2026-08-31 01:54:04 +0000 UTC Normal Successfully assigned test-ospool-ep-nuv9uo/idtoken-generator to minikube2026-08-31T02:00:07.3146933Z 2026-08-31 01:54:05 +0000 UTC Normal Pulling image "htcondor/base"2026-08-31T02:00:07.3149124Z 2026-08-31 01:54:13 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.155s (8.155s including waiting). Image size: 522365028 bytes.2026-08-31T02:00:07.3151357Z 2026-08-31 01:54:13 +0000 UTC Normal Container created2026-08-31T02:00:07.3152936Z 2026-08-31 01:54:13 +0000 UTC Normal Container started2026-08-31T02:00:07.3153975Z 2026-08-31T02:00:07.3154624Z ---2026-08-31T02:00:07.3156127Z TestOSPoolEP 2026-08-31T02:00:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T02:00:07.3175262Z ospool_ep_test.go:101: ---2026-08-31T02:00:07.3180183Z Events for pod ospool-ep-65c844ddbb-7mbnl:2026-08-31T02:00:07.3183250Z 2026-08-31 01:54:15 +0000 UTC Normal Successfully assigned test-ospool-ep-nuv9uo/ospool-ep-65c844ddbb-7mbnl to minikube2026-08-31T02:00:07.3186832Z 2026-08-31 01:54:15 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-31T02:00:07.3190544Z 2026-08-31 01:54:17 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 1.617s (1.617s including waiting). Image size: 5590942 bytes.2026-08-31T02:00:07.3193122Z 2026-08-31 01:54:17 +0000 UTC Normal Container created2026-08-31T02:00:07.3194708Z 2026-08-31 01:54:17 +0000 UTC Normal Container started2026-08-31T02:00:07.3196438Z 2026-08-31 01:54:18 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing"2026-08-31T02:00:07.3201404Z 2026-08-31 01:54:32 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-testing" in 13.806s (13.806s including waiting). Image size: 1290542464 bytes.2026-08-31T02:00:07.3203799Z 2026-08-31 01:54:32 +0000 UTC Normal Container created2026-08-31T02:00:07.3204926Z 2026-08-31 01:54:32 +0000 UTC Normal Container started2026-08-31T02:00:07.3205782Z 2026-08-31T02:00:07.3206446Z ---2026-08-31T02:00:07.3207858Z TestOSPoolEP 2026-08-31T02:00:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T02:00:07.3210419Z ospool_ep_test.go:101: ---2026-08-31T02:00:07.3211372Z Events for pod test-cm-5bb545475c-tz8mw:2026-08-31T02:00:07.3213690Z 2026-08-31 01:54:15 +0000 UTC Normal Successfully assigned test-ospool-ep-nuv9uo/test-cm-5bb545475c-tz8mw to minikube2026-08-31T02:00:07.3215780Z 2026-08-31 01:54:15 +0000 UTC Normal Pulling image "htcondor/cm:25.x-el9"2026-08-31T02:00:07.3218788Z 2026-08-31 01:54:17 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.x-el9" in 450ms (2.051s including waiting). Image size: 522365054 bytes.2026-08-31T02:00:07.3220900Z 2026-08-31 01:54:18 +0000 UTC Normal Container created2026-08-31T02:00:07.3222265Z 2026-08-31 01:54:18 +0000 UTC Normal Container started2026-08-31T02:00:07.3223179Z 2026-08-31T02:00:07.3223800Z ---2026-08-31T02:00:07.3224989Z TestOSPoolEP 2026-08-31T02:00:07Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T02:00:07.3266853Z TestOSPoolEP 2026-08-31T02:00:07Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo delete -f /tmp/TestOSPoolEP4249639893]2026-08-31T02:00:07.3848274Z TestOSPoolEP 2026-08-31T02:00:07Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-nuv9uo namespace2026-08-31T02:00:07.3876827Z TestOSPoolEP 2026-08-31T02:00:07Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-nuv9uo namespace2026-08-31T02:00:09.2959077Z TestOSPoolEP 2026-08-31T02:00:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo delete -f /tmp/TestOSPoolEP1853889774]2026-08-31T02:00:09.3504007Z TestOSPoolEP 2026-08-31T02:00:09Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-nuv9uo namespace2026-08-31T02:00:09.3553149Z TestOSPoolEP 2026-08-31T02:00:09Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-nuv9uo delete -k /tmp/kustomize-template-769235407]2026-08-31T02:00:09.4389973Z TestOSPoolEP 2026-08-31T02:00:09Z logger.go:67: service "test-cm" deleted from test-ospool-ep-nuv9uo namespace2026-08-31T02:00:09.4432729Z TestOSPoolEP 2026-08-31T02:00:09Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-nuv9uo namespace2026-08-31T02:00:09.4458766Z TestOSPoolEP 2026-08-31T02:00:09Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-nuv9uo namespace2026-08-31T02:00:09.4575649Z --- PASS: TestOSPoolEP (34.53s)2026-08-31T02:00:09.4602035Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (20.03s)2026-08-31T02:00:09.4623304Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.52s)2026-08-31T02:00:09.4624849Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.52s)2026-08-31T02:00:09.4634546Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (331.59s)2026-08-31T02:00:09.4649704Z PASS2026-08-31T02:00:09.4674006Z ok github.com/osg-htc/k8s-integration-tests/test 366.143s2026-08-31T02:00:09.5693013Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-31T02:00:09.5693979Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-31T02:00:09.5785331Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-31T02:00:09.5785725Z env:2026-08-31T02:00:09.5785974Z GOTOOLCHAIN: local2026-08-31T02:00:09.5786444Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-testingOSPOOL_EP_CMTag: 25.x-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-31T02:00:09.5786938Z ##[endgroup]2026-08-31T02:00:09.6025210Z Node 20 is being deprecated. This workflow is running with Node 24 by default. If you need to temporarily use Node 20, you can set the ACTIONS_ALLOW_USE_UNSECURE_NODE_VERSION=true environment variable. For more information see: https://github.blog/changelog/2025-09-19-deprecation-of-node-20-on-github-actions-runners/2026-08-31T02:00:09.6027174Z ##[group]Run actions/upload-artifact@v42026-08-31T02:00:09.6027886Z with:2026-08-31T02:00:09.6028463Z name: TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe52026-08-31T02:00:09.6029179Z path: /tmp/k8s-tests2026-08-31T02:00:09.6029531Z retention-days: 52026-08-31T02:00:09.6029884Z if-no-files-found: warn2026-08-31T02:00:09.6030245Z compression-level: 62026-08-31T02:00:09.6030593Z overwrite: false2026-08-31T02:00:09.6030928Z include-hidden-files: false2026-08-31T02:00:09.6031303Z env:2026-08-31T02:00:09.6031594Z GOTOOLCHAIN: local2026-08-31T02:00:09.6031928Z ##[endgroup]2026-08-31T02:00:09.8543199Z (node:17242) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-31T02:00:09.8544576Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-31T02:00:09.8627277Z With the provided path, there will be 6 files uploaded2026-08-31T02:00:09.8653468Z Artifact name is valid!2026-08-31T02:00:09.8653963Z Root directory input is valid!2026-08-31T02:00:10.0968261Z Beginning upload of artifact content to blob storage2026-08-31T02:00:10.1261086Z (node:17242) [DEP0169] DeprecationWarning: `url.parse()` behavior is not standardized and prone to errors that have security implications. Use the WHATWG URL API instead. CVEs are not issued for `url.parse()` vulnerabilities.2026-08-31T02:00:15.1800154Z Uploaded bytes 139902026-08-31T02:00:15.1988937Z Finished uploading artifact content to blob storage!2026-08-31T02:00:15.1990061Z SHA256 digest of uploaded artifact zip is 382dacbf876d14867631f4c8623e9efaf9e35e7538f990afe8f87c03516abaeb2026-08-31T02:00:15.1991886Z Finalizing artifact upload2026-08-31T02:00:15.4236186Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5.zip successfully finalized. Artifact ID 97430404482026-08-31T02:00:15.4237528Z Artifact TestOSPoolEP-83f3fae8a83028eb31b2597512f6f7a53bfc6a7f71d209ee39c64644a27cfbe5 has been successfully uploaded! Final size is 13990 bytes. Artifact ID is 97430404482026-08-31T02:00:15.4244961Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/33348883081/artifacts/97430404482026-08-31T02:00:15.4437842Z Post job cleanup.2026-08-31T02:00:15.5816223Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOMODCACHE2026-08-31T02:00:15.5866614Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOCACHE2026-08-31T02:00:15.5901292Z /home/runner/go/pkg/mod2026-08-31T02:00:15.5928801Z /home/runner/.cache/go-build2026-08-31T02:00:15.5939146Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-31T02:00:15.6146266Z Post job cleanup.2026-08-31T02:00:15.7189406Z [command]/usr/bin/git version2026-08-31T02:00:15.7238815Z git version 2.55.02026-08-31T02:00:15.7282121Z Temporarily overriding HOME='/home/runner/work/_temp/0eea7a62-7e92-4b12-b676-3bfe75d452e1' before making global git config changes2026-08-31T02:00:15.7283494Z Adding repository directory to the temporary git global config as a safe directory2026-08-31T02:00:15.7289985Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-31T02:00:15.7335516Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-31T02:00:15.7378111Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :"2026-08-31T02:00:15.7694715Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-31T02:00:15.7724370Z http.https://github.com/.extraheader2026-08-31T02:00:15.7737834Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-31T02:00:15.7778104Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :"2026-08-31T02:00:15.8076043Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-31T02:00:15.8118888Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-31T02:00:15.8587367Z Cleaning up orphan processes2026-08-31T02:00:15.9376052Z ##[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/