2026-08-31T01:52:18.6411192Z Current runner version: '2.336.0'2026-08-31T01:52:18.6436639Z ##[group]Runner Image Provisioner2026-08-31T01:52:18.6437569Z Hosted Compute Agent2026-08-31T01:52:18.6438180Z Version: 20260819.5862026-08-31T01:52:18.6438941Z Commit: 3cc4a88dfa507ef76119ad1bb3eccc6378bb2b762026-08-31T01:52:18.6439687Z Build Date: 2026-08-18T23:20:18Z2026-08-31T01:52:18.6440407Z Worker ID: {37758879-1f7c-4c3f-b3cc-9fcbf50c6b1c}2026-08-31T01:52:18.6441263Z Azure Region: westus22026-08-31T01:52:18.6441868Z ##[endgroup]2026-08-31T01:52:18.6443473Z ##[group]Operating System2026-08-31T01:52:18.6444156Z Ubuntu2026-08-31T01:52:18.6445009Z 22.04.52026-08-31T01:52:18.6445660Z LTS2026-08-31T01:52:18.6446216Z ##[endgroup]2026-08-31T01:52:18.6446851Z ##[group]Runner Image2026-08-31T01:52:18.6447503Z Image: ubuntu-22.042026-08-31T01:52:18.6448102Z Version: 20260824.273.32026-08-31T01:52:18.6449449Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20260824.273/images/ubuntu/Ubuntu2204-Readme.md2026-08-31T01:52:18.6451109Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20260824.2732026-08-31T01:52:18.6452136Z ##[endgroup]2026-08-31T01:52:18.6455498Z ##[group]GITHUB_TOKEN Permissions2026-08-31T01:52:18.6457966Z Actions: write2026-08-31T01:52:18.6458930Z ArtifactMetadata: write2026-08-31T01:52:18.6459707Z Attestations: write2026-08-31T01:52:18.6460440Z Checks: write2026-08-31T01:52:18.6461051Z CodeQuality: write2026-08-31T01:52:18.6461652Z Contents: write2026-08-31T01:52:18.6462274Z CopilotRequests: write2026-08-31T01:52:18.6462955Z Deployments: write2026-08-31T01:52:18.6463557Z Discussions: write2026-08-31T01:52:18.6464161Z Drives: write2026-08-31T01:52:18.6465068Z Issues: write2026-08-31T01:52:18.6465657Z Metadata: read2026-08-31T01:52:18.6466396Z Models: read2026-08-31T01:52:18.6466987Z Packages: write2026-08-31T01:52:18.6467639Z Pages: write2026-08-31T01:52:18.6468240Z PullRequests: write2026-08-31T01:52:18.6468852Z RepositoryProjects: write2026-08-31T01:52:18.6469556Z SecurityEvents: write2026-08-31T01:52:18.6470173Z Statuses: write2026-08-31T01:52:18.6470739Z VulnerabilityAlerts: read2026-08-31T01:52:18.6471439Z ##[endgroup]2026-08-31T01:52:18.6473541Z Secret source: Actions2026-08-31T01:52:18.6475137Z Prepare workflow directory2026-08-31T01:52:18.6863526Z Prepare all required actions2026-08-31T01:52:18.6936595Z Getting action download info2026-08-31T01:52:19.0235565Z Download action repository 'actions/checkout@v5' (SHA:fbc6f3992d24b796d5a048ff273f7fcc4a7b6c09)2026-08-31T01:52:19.1357846Z Download action repository 'medyagh/setup-minikube@latest' (SHA:e9e035a86bbc3caea26a450bd4dbf9d0c453682e)2026-08-31T01:52:19.3305810Z Download action repository 'actions/setup-go@v6' (SHA:924ae3a1cded613372ab5595356fb5720e22ba16)2026-08-31T01:52:19.5640283Z Download action repository 'actions/upload-artifact@v4' (SHA:ea165f8d65b6e75b540449e92b4886f43607fa02)2026-08-31T01:52:19.8274949Z Uses: osg-htc/k8s-integration-tests/.github/workflows/test-harness.yaml@refs/heads/main (ecca15d77f3152eb2336d20b91eb226964f888bf)2026-08-31T01:52:19.8281019Z ##[group] Inputs2026-08-31T01:52:19.8281689Z testName: TestOSPoolEP2026-08-31T01:52:19.8283049Z testEnv: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-31T01:52:19.8285047Z setupScript: 2026-08-31T01:52:19.8285596Z setupEnv: {}2026-08-31T01:52:19.8286130Z ##[endgroup]2026-08-31T01:52:19.8287124Z Complete job name: ospool-ep / Run OSPool EP test (cvmfsexec, 25-release) / Run Tests2026-08-31T01:52:19.9138025Z ##[group]Run actions/checkout@v52026-08-31T01:52:19.9139108Z with:2026-08-31T01:52:19.9139714Z repository: osg-htc/k8s-integration-tests2026-08-31T01:52:19.9148365Z token: ***2026-08-31T01:52:19.9149157Z ssh-strict: true2026-08-31T01:52:19.9149733Z ssh-user: git2026-08-31T01:52:19.9150344Z persist-credentials: true2026-08-31T01:52:19.9151000Z clean: true2026-08-31T01:52:19.9151572Z sparse-checkout-cone-mode: true2026-08-31T01:52:19.9152580Z fetch-depth: 12026-08-31T01:52:19.9153123Z fetch-tags: false2026-08-31T01:52:19.9153706Z show-progress: true2026-08-31T01:52:19.9154474Z lfs: false2026-08-31T01:52:19.9155013Z submodules: false2026-08-31T01:52:19.9155620Z set-safe-directory: true2026-08-31T01:52:19.9156313Z allow-unsafe-pr-checkout: false2026-08-31T01:52:19.9157373Z ##[endgroup]2026-08-31T01:52:20.0262676Z Syncing repository: osg-htc/k8s-integration-tests2026-08-31T01:52:20.0266240Z ##[group]Getting Git version info2026-08-31T01:52:20.0267783Z Working directory is '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-31T01:52:20.0270772Z [command]/usr/bin/git version2026-08-31T01:52:20.0339107Z git version 2.55.02026-08-31T01:52:20.0365191Z ##[endgroup]2026-08-31T01:52:20.0389258Z Temporarily overriding HOME='/home/runner/work/_temp/9c508532-1583-4ef0-98c0-c88bfab59a64' before making global git config changes2026-08-31T01:52:20.0393539Z Adding repository directory to the temporary git global config as a safe directory2026-08-31T01:52:20.0397261Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-31T01:52:20.0438127Z Deleting the contents of '/home/runner/work/k8s-integration-tests/k8s-integration-tests'2026-08-31T01:52:20.0442935Z ##[group]Initializing the repository2026-08-31T01:52:20.0450488Z [command]/usr/bin/git init /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-31T01:52:20.0573168Z hint: Using 'master' as the name for the initial branch. This default branch name2026-08-31T01:52:20.0576003Z hint: will change to "main" in Git 3.0. To configure the initial branch name2026-08-31T01:52:20.0580879Z hint: to use in all of your new repositories, which will suppress this warning,2026-08-31T01:52:20.0582817Z hint: call:2026-08-31T01:52:20.0584612Z hint:2026-08-31T01:52:20.0585904Z hint: git config --global init.defaultBranch <name>2026-08-31T01:52:20.0587116Z hint:2026-08-31T01:52:20.0587950Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and2026-08-31T01:52:20.0589410Z hint: 'development'. The just-created branch can be renamed via this command:2026-08-31T01:52:20.0590499Z hint:2026-08-31T01:52:20.0590996Z hint: git branch -m <name>2026-08-31T01:52:20.0591597Z hint:2026-08-31T01:52:20.0592471Z hint: Disable this message with "git config set advice.defaultBranchName false"2026-08-31T01:52:20.0595903Z Initialized empty Git repository in /home/runner/work/k8s-integration-tests/k8s-integration-tests/.git/2026-08-31T01:52:20.0600877Z [command]/usr/bin/git remote add origin https://github.com/osg-htc/k8s-integration-tests2026-08-31T01:52:20.0632303Z ##[endgroup]2026-08-31T01:52:20.0634696Z ##[group]Disabling automatic garbage collection2026-08-31T01:52:20.0636408Z [command]/usr/bin/git config --local gc.auto 02026-08-31T01:52:20.0674956Z ##[endgroup]2026-08-31T01:52:20.0677228Z ##[group]Setting up auth2026-08-31T01:52:20.0683406Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-31T01:52:20.0725711Z [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:20.1159221Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-31T01:52:20.1235002Z [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:20.1499633Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-31T01:52:20.1539730Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-31T01:52:20.1823276Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***2026-08-31T01:52:20.1872625Z ##[endgroup]2026-08-31T01:52:20.1875373Z ##[group]Fetching the repository2026-08-31T01:52:20.1884660Z [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:20.6219519Z From https://github.com/osg-htc/k8s-integration-tests2026-08-31T01:52:20.6221156Z * [new ref] ecca15d77f3152eb2336d20b91eb226964f888bf -> origin/main2026-08-31T01:52:20.6226435Z ##[endgroup]2026-08-31T01:52:20.6228523Z ##[group]Determining the checkout info2026-08-31T01:52:20.6230713Z ##[endgroup]2026-08-31T01:52:20.6236174Z [command]/usr/bin/git sparse-checkout disable2026-08-31T01:52:20.6289182Z [command]/usr/bin/git config --local --unset-all extensions.worktreeConfig2026-08-31T01:52:20.6327765Z ##[group]Checking out the ref2026-08-31T01:52:20.6331873Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main2026-08-31T01:52:20.6431064Z Switched to a new branch 'main'2026-08-31T01:52:20.6434916Z branch 'main' set up to track 'origin/main'.2026-08-31T01:52:20.6442554Z ##[endgroup]2026-08-31T01:52:20.6496115Z [command]/usr/bin/git log -1 --format=%H2026-08-31T01:52:20.6528120Z ecca15d77f3152eb2336d20b91eb226964f888bf2026-08-31T01:52:20.6863928Z ##[group]Run echo "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT2026-08-31T01:52:20.6865644Z [36;1mecho "TEST_ENV=$(echo "$TEST_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-31T01:52:20.6867056Z [36;1mecho "SETUP_ENV=$(echo "$SETUP_ENV_YAML" | yq -o json | tr -d '\n')" >> $GITHUB_OUTPUT[0m2026-08-31T01:52:20.7213019Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-31T01:52:20.7214108Z env:2026-08-31T01:52:20.7215701Z TEST_ENV_YAML: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-31T01:52:20.7216971Z SETUP_ENV_YAML: {}2026-08-31T01:52:20.7217833Z ##[endgroup]2026-08-31T01:52:21.3091907Z ##[group]Run echo "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT2026-08-31T01:52:21.3093300Z [36;1mecho "TEST_ENV=$(echo -n "$TEST_ENV" | tr '\n' ' ' | sed 's/\s\+/ /g')" >> $GITHUB_OUTPUT[0m2026-08-31T01:52:21.3171276Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-31T01:52:21.3172226Z env:2026-08-31T01:52:21.3173320Z TEST_ENV: { "OSPOOL_EP_OSPoolEPTag": "25-release", "OSPOOL_EP_CMTag": "25.0-el9", "OSPOOL_EP_CvmfsType": "cvmfsexec"}2026-08-31T01:52:21.3174831Z ##[endgroup]2026-08-31T01:52:21.3363120Z ##[group]Run true2026-08-31T01:52:21.3363895Z [36;1mtrue[0m2026-08-31T01:52:21.3439935Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-31T01:52:21.3440871Z ##[endgroup]2026-08-31T01:52:21.3694138Z ##[group]Run medyagh/setup-minikube@latest2026-08-31T01:52:21.3695282Z with:2026-08-31T01:52:21.3695955Z start: true2026-08-31T01:52:21.3696637Z cache: true2026-08-31T01:52:21.3697363Z minikube-version: latest2026-08-31T01:52:21.3698108Z wait: all2026-08-31T01:52:21.3698789Z ##[endgroup]2026-08-31T01:52:21.5061968Z (node:1855) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-31T01:52:21.5063703Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-31T01:52:22.4760011Z [command]/usr/bin/chmod +x /home/runner/work/_temp/5ea7323b-a824-4c22-8c27-ddc23a54e2352026-08-31T01:52:22.6439434Z [command]/home/runner/bin/minikube version --short2026-08-31T01:52:22.6934937Z v1.38.12026-08-31T01:52:22.9459654Z Cache hit for: preloaded-tarball-v1.38.1-x64-stable-docker2026-08-31T01:52:22.9573070Z (node:1855) [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:22.9580618Z Cache hit for: kic-v1.38.1-x642026-08-31T01:52:24.2461050Z Received 16777216 of 224218830 (7.5%), 16.0 MBs/sec2026-08-31T01:52:24.2681624Z Received 16777216 of 544082637 (3.1%), 16.0 MBs/sec2026-08-31T01:52:25.2552386Z Received 125829120 of 224218830 (56.1%), 59.7 MBs/sec2026-08-31T01:52:25.3632262Z Received 134217728 of 544082637 (24.7%), 61.1 MBs/sec2026-08-31T01:52:26.1304780Z Received 224218830 of 224218830 (100.0%), 74.1 MBs/sec2026-08-31T01:52:26.1306200Z Cache Size: ~214 MB (224218830 B)2026-08-31T01:52:26.1767824Z [command]/usr/bin/tar -xf /home/runner/work/_temp/45772114-e6fa-4b43-bc02-4b88e6fcd886/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-31T01:52:26.3655333Z Received 268435456 of 544082637 (49.3%), 82.7 MBs/sec2026-08-31T01:52:26.8825788Z Cache restored successfully2026-08-31T01:52:27.4255588Z Received 402653184 of 544082637 (74.0%), 92.4 MBs/sec2026-08-31T01:52:28.4253468Z Received 536870912 of 544082637 (98.7%), 99.3 MBs/sec2026-08-31T01:52:28.5096691Z Received 544082637 of 544082637 (100.0%), 99.0 MBs/sec2026-08-31T01:52:28.5098075Z Cache Size: ~519 MB (544082637 B)2026-08-31T01:52:28.5232140Z [command]/usr/bin/tar -xf /home/runner/work/_temp/2e95f4c2-688c-4d31-b221-ac97a85a2a67/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-31T01:52:29.4528790Z Cache restored successfully2026-08-31T01:52:29.5755176Z [command]/home/runner/bin/minikube start --wait all2026-08-31T01:52:29.6203569Z * minikube v1.38.1 on Ubuntu 22.042026-08-31T01:52:36.2363810Z * Automatically selected the docker driver. Other choices: podman, none, ssh2026-08-31T01:52:36.3197889Z ! Starting v1.39.0, minikube will default to "containerd" container runtime. See #21973 for more info.2026-08-31T01:52:36.3206306Z * Using Docker driver with root privileges2026-08-31T01:52:36.3216549Z * Starting "minikube" primary control-plane node in "minikube" cluster2026-08-31T01:52:36.3223435Z * Pulling base image v0.0.50 ...2026-08-31T01:53:05.4485485Z * Configuring bridge CNI (Container Networking Interface) ...2026-08-31T01:53:10.1052575Z * Verifying Kubernetes components...2026-08-31T01:53:10.1423009Z - Using image gcr.io/k8s-minikube/storage-provisioner:v52026-08-31T01:53:10.8059207Z * Enabled addons: storage-provisioner, default-storageclass2026-08-31T01:53:50.9642601Z * Done! kubectl is now configured to use "minikube" cluster and "default" namespace by default2026-08-31T01:53:50.9764838Z [command]/home/runner/bin/minikube version --short2026-08-31T01:53:51.0287786Z v1.38.12026-08-31T01:53:51.0631351Z ##[group]Run actions/setup-go@v62026-08-31T01:53:51.0631733Z with:2026-08-31T01:53:51.0631933Z go-version: 1.262026-08-31T01:53:51.0632141Z cache: true2026-08-31T01:53:51.0632356Z cache-dependency-path: go.sum2026-08-31T01:53:51.0632621Z check-latest: false2026-08-31T01:53:51.0635388Z token: ***2026-08-31T01:53:51.0635612Z ##[endgroup]2026-08-31T01:53:51.2019712Z Setup go version spec 1.262026-08-31T01:53:51.2655725Z Found in cache @ /opt/hostedtoolcache/go/1.26.7/x642026-08-31T01:53:51.2659037Z Added go to the path2026-08-31T01:53:51.2662977Z Successfully set up Go version 1.262026-08-31T01:53:52.2380814Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOMODCACHE2026-08-31T01:53:52.2419423Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOCACHE2026-08-31T01:53:52.2469091Z /home/runner/go/pkg/mod2026-08-31T01:53:52.2491705Z /home/runner/.cache/go-build2026-08-31T01:53:52.5020711Z Cache hit for: setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-31T01:53:53.7930552Z Received 12582912 of 251715014 (5.0%), 12.0 MBs/sec2026-08-31T01:53:54.8312351Z Received 134217728 of 251715014 (53.3%), 62.8 MBs/sec2026-08-31T01:53:55.7691453Z Received 251715014 of 251715014 (100.0%), 80.7 MBs/sec2026-08-31T01:53:55.7692697Z Cache Size: ~240 MB (251715014 B)2026-08-31T01:53:55.7730232Z [command]/usr/bin/tar -xf /home/runner/work/_temp/c22d2d98-a491-4704-ab2c-e77f9403b323/cache.tzst -P -C /home/runner/work/k8s-integration-tests/k8s-integration-tests --use-compress-program unzstd2026-08-31T01:53:59.0180063Z Cache restored successfully2026-08-31T01:53:59.0740397Z Cache restored from key: setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a02026-08-31T01:53:59.0767637Z go version go1.26.7 linux/amd642026-08-31T01:53:59.0767952Z 2026-08-31T01:53:59.0768399Z ##[group]go env2026-08-31T01:53:59.1490586Z AR='ar'2026-08-31T01:53:59.1491008Z CC='gcc'2026-08-31T01:53:59.1491418Z CGO_CFLAGS='-O2 -g'2026-08-31T01:53:59.1491863Z CGO_CPPFLAGS=''2026-08-31T01:53:59.1492924Z CGO_CXXFLAGS='-O2 -g'2026-08-31T01:53:59.1493346Z CGO_ENABLED='1'2026-08-31T01:53:59.1493712Z CGO_FFLAGS='-O2 -g'2026-08-31T01:53:59.1494089Z CGO_LDFLAGS='-O2 -g'2026-08-31T01:53:59.1494740Z CXX='g++'2026-08-31T01:53:59.1495083Z GCCGO='gccgo'2026-08-31T01:53:59.1495467Z GO111MODULE=''2026-08-31T01:53:59.1495815Z GOAMD64='v1'2026-08-31T01:53:59.1496170Z GOARCH='amd64'2026-08-31T01:53:59.1496503Z GOAUTH='netrc'2026-08-31T01:53:59.1496837Z GOBIN=''2026-08-31T01:53:59.1497223Z GOCACHE='/home/runner/.cache/go-build'2026-08-31T01:53:59.1497731Z GOCACHEPROG=''2026-08-31T01:53:59.1498092Z GODEBUG=''2026-08-31T01:53:59.1498457Z GOENV='/home/runner/.config/go/env'2026-08-31T01:53:59.1498914Z GOEXE=''2026-08-31T01:53:59.1499249Z GOEXPERIMENT=''2026-08-31T01:53:59.1499612Z GOFIPS140='off'2026-08-31T01:53:59.1499948Z GOFLAGS=''2026-08-31T01:53:59.1501085Z GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build2194344453=/tmp/go-build -gno-record-gcc-switches'2026-08-31T01:53:59.1502192Z GOHOSTARCH='amd64'2026-08-31T01:53:59.1502556Z GOHOSTOS='linux'2026-08-31T01:53:59.1502892Z GOINSECURE=''2026-08-31T01:53:59.1503485Z GOMOD='/home/runner/work/k8s-integration-tests/k8s-integration-tests/go.mod'2026-08-31T01:53:59.1504201Z GOMODCACHE='/home/runner/go/pkg/mod'2026-08-31T01:53:59.1504883Z GONOPROXY=''2026-08-31T01:53:59.1505222Z GONOSUMDB=''2026-08-31T01:53:59.1505549Z GOOS='linux'2026-08-31T01:53:59.1505890Z GOPATH='/home/runner/go'2026-08-31T01:53:59.1506285Z GOPRIVATE=''2026-08-31T01:53:59.1506716Z GOPROXY='https://proxy.golang.org,direct'2026-08-31T01:53:59.1507298Z GOROOT='/opt/hostedtoolcache/go/1.26.7/x64'2026-08-31T01:53:59.1507800Z GOSUMDB='sum.golang.org'2026-08-31T01:53:59.1508213Z GOTELEMETRY='local'2026-08-31T01:53:59.1508676Z GOTELEMETRYDIR='/home/runner/.config/go/telemetry'2026-08-31T01:53:59.1509196Z GOTMPDIR=''2026-08-31T01:53:59.1509917Z GOTOOLCHAIN='local'2026-08-31T01:53:59.1510472Z GOTOOLDIR='/opt/hostedtoolcache/go/1.26.7/x64/pkg/tool/linux_amd64'2026-08-31T01:53:59.1511275Z GOVCS=''2026-08-31T01:53:59.1511625Z GOVERSION='go1.26.7'2026-08-31T01:53:59.1512005Z GOWORK=''2026-08-31T01:53:59.1512366Z PKG_CONFIG='pkg-config'2026-08-31T01:53:59.1512623Z 2026-08-31T01:53:59.1513127Z ##[endgroup]2026-08-31T01:53:59.1875258Z ##[group]Run go test ./test -v -count 1 -run TestOSPoolEP -timeout 15m2026-08-31T01:53:59.1875833Z [36;1mgo test ./test -v -count 1 -run TestOSPoolEP -timeout 15m[0m2026-08-31T01:53:59.1956751Z shell: /usr/bin/bash -e {0}2026-08-31T01:53:59.1957196Z env:2026-08-31T01:53:59.1957426Z GOTOOLCHAIN: local2026-08-31T01:53:59.1957696Z OSPOOL_EP_OSPoolEPTag: 25-release2026-08-31T01:53:59.1957993Z OSPOOL_EP_CMTag: 25.0-el92026-08-31T01:53:59.1958272Z OSPOOL_EP_CvmfsType: cvmfsexec2026-08-31T01:53:59.1958544Z ##[endgroup]2026-08-31T01:54:04.9861815Z === RUN TestOSPoolEP2026-08-31T01:54:04.9865099Z === PAUSE TestOSPoolEP2026-08-31T01:54:04.9865610Z === CONT TestOSPoolEP2026-08-31T01:54:04.9866753Z 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:05.0207634Z TestOSPoolEP 2026-08-31T01:54:05Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu apply -f /tmp/TestOSPoolEP43578950]2026-08-31T01:54:05.8158013Z TestOSPoolEP 2026-08-31T01:54:05Z logger.go:67: pod/idtoken-generator created2026-08-31T01:54:05.9300776Z TestOSPoolEP 2026-08-31T01:54:05Z logger.go:67: secret/pool-passwd created2026-08-31T01:54:05.9349753Z TestOSPoolEP 2026-08-31T01:54:05Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-31T01:54:05.9352604Z TestOSPoolEP 2026-08-31T01:54:05Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:05.9755078Z TestOSPoolEP 2026-08-31T01:54:05Z 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:15.9773660Z TestOSPoolEP 2026-08-31T01:54:15Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-31T01:54:15.9777084Z 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.9802974Z TestOSPoolEP 2026-08-31T01:54:15Z 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:25.9808574Z TestOSPoolEP 2026-08-31T01:54:25Z retry.go:91: Wait for pod idtoken-generator to be provisioned.2026-08-31T01:54:25.9810364Z TestOSPoolEP 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.9839533Z TestOSPoolEP 2026-08-31T01:54:25Z logger.go:67: Pod is now available2026-08-31T01:54:25.9841584Z TestOSPoolEP 2026-08-31T01:54:25Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec idtoken-generator -- condor_token_create -authz READ -authz ADVERTISE_STARTD -authz ADVERTISE_MASTER -identity condor@test-cm]2026-08-31T01:54:26.3524946Z TestOSPoolEP 2026-08-31T01:54:26Z logger.go:67: ***2026-08-31T01:54:26.3583970Z TestOSPoolEP 2026-08-31T01:54:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu apply -f /tmp/TestOSPoolEP4152433952]2026-08-31T01:54:26.4619709Z TestOSPoolEP 2026-08-31T01:54:26Z logger.go:67: secret/pool-token created2026-08-31T01:54:26.4653449Z TestOSPoolEP 2026-08-31T01:54:26Z retry.go:91: Wait for secret pool-token to be provisioned.2026-08-31T01:54:26.4654988Z TestOSPoolEP 2026-08-31T01:54:26Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:26.4673325Z TestOSPoolEP 2026-08-31T01:54:26Z logger.go:67: Secret is now available2026-08-31T01:54:26.4695689Z TestOSPoolEP 2026-08-31T01:54:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu apply -k /tmp/kustomize-template-2059240550]2026-08-31T01:54:26.6317987Z TestOSPoolEP 2026-08-31T01:54:26Z logger.go:67: service/test-cm created2026-08-31T01:54:26.6405924Z TestOSPoolEP 2026-08-31T01:54:26Z 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:26.6408004Z TestOSPoolEP 2026-08-31T01:54:26Z logger.go:67: deployment.apps/ospool-ep created2026-08-31T01:54:26.6595179Z TestOSPoolEP 2026-08-31T01:54:26Z logger.go:67: deployment.apps/test-cm created2026-08-31T01:54:26.6629799Z === RUN TestOSPoolEP/Confirm_deployments_become_ready.2026-08-31T01:54:26.6633639Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:26Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:26.6847002Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:26Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-31T01:54:26.6878957Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:26Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:26.6884000Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:26Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-31T01:54:26.6890206Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:26Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:26.6946535Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:26Z 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-54b7d49f85". Sleeping for 10s and will try again.2026-08-31T01:54:26.6986207Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:26Z 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-6c7d796845". Sleeping for 10s and will try again.2026-08-31T01:54:36.6948493Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:36Z retry.go:91: Wait for deployment test-cm to be provisioned.2026-08-31T01:54:36.6949620Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:36.6973645Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:36Z logger.go:67: Deployment is now available2026-08-31T01:54:36.6984206Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:36Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-31T01:54:36.6985740Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:36Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:36.7004112Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:36Z 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-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-08-31T01:54:46.7013038Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:46Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-31T01:54:46.7015170Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:46Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:46.7036452Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:46Z 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-6c7d796845" is progressing.. Sleeping for 10s and will try again.2026-08-31T01:54:56.7037751Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:56Z retry.go:91: Wait for deployment ospool-ep to be provisioned.2026-08-31T01:54:56.7040194Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:56.7067546Z TestOSPoolEP/Confirm_deployments_become_ready. 2026-08-31T01:54:56Z logger.go:67: Deployment is now available2026-08-31T01:54:56.7068286Z === RUN TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-31T01:54:56.7070438Z === PAUSE TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-31T01:54:56.7071416Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-31T01:54:56.7072303Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-31T01:54:56.7073518Z === RUN TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-31T01:54:56.7074107Z === PAUSE TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-31T01:54:56.7075041Z === CONT TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-31T01:54:56.7076354Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:54:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:56.7077966Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-31T01:54:56.7079772Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:54:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:56.7080710Z === CONT TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-31T01:54:56.7081814Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-31T01:54:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:56.7102006Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:54:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:56.7104650Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:54:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:56.7107083Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-31T01:54:56Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T01:54:56.7139570Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:54:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:54:56.7169250Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:54:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)']2026-08-31T01:54:56.7173778Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-31T01:54:56Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_SINGULARITY]2026-08-31T01:54:56.8928931Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-31T01:54:56.8933327Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-kpm42 failed. Retrying in 30s.2026-08-31T01:54:56.9250846Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-31T01:54:56.9252538Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-kpm42 failed. Retrying in 10s.2026-08-31T01:54:56.9344678Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-31T01:54:56.9345795Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)']' in pod test-cm-54b7d49f85-kpm42 failed. Retrying in 10s.2026-08-31T01:55:06.9259290Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-31T01:55:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_SINGULARITY]2026-08-31T01:55:06.9355296Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:55:06Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)']2026-08-31T01:55:07.0895064Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_singularity.2026-08-31T01:55:07.0896392Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_SINGULARITY]' in pod test-cm-54b7d49f85-kpm42 failed. Retrying in 10s.2026-08-31T01:55:07.0956138Z === NAME TestOSPoolEP/Confirm_condor_status_lists_the_EP.2026-08-31T01:55:07.0957173Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)']' in pod test-cm-54b7d49f85-kpm42 failed. Retrying in 10s.2026-08-31T01:55:17.0899283Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-31T01:55:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_SINGULARITY]2026-08-31T01:55:17.0961511Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:55:17Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)']2026-08-31T01:55:17.2192743Z TestOSPoolEP/Confirm_EP_container_advertises_singularity. 2026-08-31T01:55:17Z logger.go:67: true2026-08-31T01:55:17.2203846Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:55:17Z logger.go:67: Name OpSys Arch State Activity LoadAv Mem ActvtyTime2026-08-31T01:55:17.2209095Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:55:17Z logger.go:67: 2026-08-31T01:55:17.2214772Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:55:17Z logger.go:67: slot1@CHTC-DEV-EP-mwestphall.ospool-ep-6c7d796845-qxc9v LINUX X86_64 Unclaimed Idle 0.000 15988 0+00:00:002026-08-31T01:55:17.2226962Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:55:17Z logger.go:67: 2026-08-31T01:55:17.2228968Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:55:17Z logger.go:67: Total Owner Claimed Unclaimed Matched Preempting Drain Backfill BkIdle2026-08-31T01:55:17.2230835Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:55:17Z logger.go:67: 2026-08-31T01:55:17.2232917Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:55:17Z logger.go:67: X86_64/LINUX 1 0 0 1 0 0 0 0 02026-08-31T01:55:17.2234942Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:55:17Z logger.go:67: 2026-08-31T01:55:17.2237977Z TestOSPoolEP/Confirm_condor_status_lists_the_EP. 2026-08-31T01:55:17Z logger.go:67: Total 1 0 0 1 0 0 0 0 02026-08-31T01:55:26.8938347Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:55:26Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:55:27.0026990Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:55:27Z logger.go:67: undefined2026-08-31T01:55:27.0081365Z === NAME TestOSPoolEP/Confirm_EP_container_advertises_CVMFS2026-08-31T01:55:27.0083004Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-kpm42 failed. Retrying in 30s.2026-08-31T01:55:57.0085784Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:55:57Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:55:57.1217865Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:55:57Z logger.go:67: undefined2026-08-31T01:55:57.1278720Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-kpm42 failed. Retrying in 30s.2026-08-31T01:56:27.1281472Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:56:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:56:27.2372243Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:56:27Z logger.go:67: undefined2026-08-31T01:56:27.2426546Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-kpm42 failed. Retrying in 30s.2026-08-31T01:56:57.2437506Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:56:57Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:56:57.3664078Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:56:57Z logger.go:67: undefined2026-08-31T01:56:57.3729348Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-kpm42 failed. Retrying in 30s.2026-08-31T01:57:27.3739427Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:57:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:57:27.5022909Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:57:27Z logger.go:67: undefined2026-08-31T01:57:27.5069742Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-kpm42 failed. Retrying in 30s.2026-08-31T01:57:57.5095621Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:57:57Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:57:57.6604367Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:57:57Z logger.go:67: undefined2026-08-31T01:57:57.6662854Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-kpm42 failed. Retrying in 30s.2026-08-31T01:58:27.6684960Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:58:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:58:27.7806599Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:58:27Z logger.go:67: undefined2026-08-31T01:58:27.7870129Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-kpm42 failed. Retrying in 30s.2026-08-31T01:58:57.7876997Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:58:57Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:58:57.8963461Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:58:57Z logger.go:67: undefined2026-08-31T01:58:57.9016600Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-kpm42 failed. Retrying in 30s.2026-08-31T01:59:27.9039624Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:59:27Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:59:28.0109095Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:59:28Z logger.go:67: undefined2026-08-31T01:59:28.0163201Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-kpm42 failed. Retrying in 30s.2026-08-31T01:59:58.0190174Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:59:58Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T01:59:58.1281017Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T01:59:58Z logger.go:67: undefined2026-08-31T01:59:58.1337369Z test_utils.go:102: Exec '[sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]' in pod test-cm-54b7d49f85-kpm42 failed. Retrying in 30s.2026-08-31T02:00:28.1361522Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T02:00:28Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu exec test-cm-54b7d49f85-kpm42 -- sh -c condor_status -const 'regexp("ospool-ep-6c7d796845-qxc9v",Machine)' -af HAS_CVMFS_singularity_opensciencegrid_org]2026-08-31T02:00:28.2701818Z TestOSPoolEP/Confirm_EP_container_advertises_CVMFS 2026-08-31T02:00:28Z logger.go:67: true2026-08-31T02:00:28.2760899Z TestOSPoolEP 2026-08-31T02:00:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T02:00:28.2848673Z TestOSPoolEP 2026-08-31T02:00:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T02:00:28.4532456Z TestOSPoolEP 2026-08-31T02:00:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T02:00:28.5513366Z TestOSPoolEP 2026-08-31T02:00:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T02:00:28.6530114Z TestOSPoolEP 2026-08-31T02:00:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T02:00:28.6561547Z === NAME TestOSPoolEP2026-08-31T02:00:28.6562540Z ospool_ep_test.go:101: ---2026-08-31T02:00:28.6563204Z Events for pod idtoken-generator:2026-08-31T02:00:28.6565081Z 2026-08-31 01:54:05 +0000 UTC Normal Successfully assigned test-ospool-ep-dsdzqu/idtoken-generator to minikube2026-08-31T02:00:28.6567127Z 2026-08-31 01:54:07 +0000 UTC Normal Pulling image "htcondor/base"2026-08-31T02:00:28.6569357Z 2026-08-31 01:54:15 +0000 UTC Normal Successfully pulled image "htcondor/base" in 8.754s (8.754s including waiting). Image size: 522365028 bytes.2026-08-31T02:00:28.6571763Z 2026-08-31 01:54:15 +0000 UTC Normal Container created2026-08-31T02:00:28.6572855Z 2026-08-31 01:54:16 +0000 UTC Normal Container started2026-08-31T02:00:28.6573437Z 2026-08-31T02:00:28.6573825Z ---2026-08-31T02:00:28.6575106Z TestOSPoolEP 2026-08-31T02:00:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T02:00:28.6596394Z ospool_ep_test.go:101: ---2026-08-31T02:00:28.6597481Z Events for pod ospool-ep-6c7d796845-qxc9v:2026-08-31T02:00:28.6603810Z 2026-08-31 01:54:26 +0000 UTC Normal Successfully assigned test-ospool-ep-dsdzqu/ospool-ep-6c7d796845-qxc9v to minikube2026-08-31T02:00:28.6605989Z 2026-08-31 01:54:27 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/library/alpine:3"2026-08-31T02:00:28.6609302Z 2026-08-31 01:54:29 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/library/alpine:3" in 2.792s (2.792s including waiting). Image size: 5590942 bytes.2026-08-31T02:00:28.6611239Z 2026-08-31 01:54:29 +0000 UTC Normal Container created2026-08-31T02:00:28.6612137Z 2026-08-31 01:54:30 +0000 UTC Normal Container started2026-08-31T02:00:28.6613502Z 2026-08-31 01:54:30 +0000 UTC Normal Pulling image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release"2026-08-31T02:00:28.6616203Z 2026-08-31 01:54:51 +0000 UTC Normal Successfully pulled image "hub.opensciencegrid.org/osg-htc/ospool-ep:25-release" in 15.794s (21.464s including waiting). Image size: 1290304444 bytes.2026-08-31T02:00:28.6617790Z 2026-08-31 01:54:51 +0000 UTC Normal Container created2026-08-31T02:00:28.6618952Z 2026-08-31 01:54:51 +0000 UTC Normal Container started2026-08-31T02:00:28.6619471Z 2026-08-31T02:00:28.6619814Z ---2026-08-31T02:00:28.6620722Z TestOSPoolEP 2026-08-31T02:00:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T02:00:28.6623485Z ospool_ep_test.go:101: ---2026-08-31T02:00:28.6663589Z Events for pod test-cm-54b7d49f85-kpm42:2026-08-31T02:00:28.6666386Z 2026-08-31 01:54:26 +0000 UTC Normal Successfully assigned test-ospool-ep-dsdzqu/test-cm-54b7d49f85-kpm42 to minikube2026-08-31T02:00:28.6681806Z 2026-08-31 01:54:27 +0000 UTC Normal Pulling image "htcondor/cm:25.0-el9"2026-08-31T02:00:28.6683772Z 2026-08-31 01:54:36 +0000 UTC Normal Successfully pulled image "htcondor/cm:25.0-el9" in 6.106s (8.869s including waiting). Image size: 534362849 bytes.2026-08-31T02:00:28.6685547Z 2026-08-31 01:54:36 +0000 UTC Normal Container created2026-08-31T02:00:28.6689105Z 2026-08-31 01:54:36 +0000 UTC Normal Container started2026-08-31T02:00:28.6689872Z 2026-08-31T02:00:28.6690426Z ---2026-08-31T02:00:28.6691561Z TestOSPoolEP 2026-08-31T02:00:28Z logger.go:67: Configuring Kubernetes client using config file /home/runner/.kube/config with context 2026-08-31T02:00:28.6693578Z TestOSPoolEP 2026-08-31T02:00:28Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu delete -f /tmp/TestOSPoolEP3171434967]2026-08-31T02:00:28.7451571Z TestOSPoolEP 2026-08-31T02:00:28Z logger.go:67: pod "idtoken-generator" deleted from test-ospool-ep-dsdzqu namespace2026-08-31T02:00:28.7514836Z TestOSPoolEP 2026-08-31T02:00:28Z logger.go:67: secret "pool-passwd" deleted from test-ospool-ep-dsdzqu namespace2026-08-31T02:00:30.4954982Z TestOSPoolEP 2026-08-31T02:00:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu delete -f /tmp/TestOSPoolEP1934042578]2026-08-31T02:00:30.5669049Z TestOSPoolEP 2026-08-31T02:00:30Z logger.go:67: secret "pool-token" deleted from test-ospool-ep-dsdzqu namespace2026-08-31T02:00:30.5714725Z TestOSPoolEP 2026-08-31T02:00:30Z logger.go:67: Running command kubectl with args [--namespace test-ospool-ep-dsdzqu delete -k /tmp/kustomize-template-2059240550]2026-08-31T02:00:30.6623940Z TestOSPoolEP 2026-08-31T02:00:30Z logger.go:67: service "test-cm" deleted from test-ospool-ep-dsdzqu namespace2026-08-31T02:00:30.6704571Z TestOSPoolEP 2026-08-31T02:00:30Z logger.go:67: deployment.apps "ospool-ep" deleted from test-ospool-ep-dsdzqu namespace2026-08-31T02:00:30.6780310Z TestOSPoolEP 2026-08-31T02:00:30Z logger.go:67: deployment.apps "test-cm" deleted from test-ospool-ep-dsdzqu namespace2026-08-31T02:00:30.6916464Z --- PASS: TestOSPoolEP (54.14s)2026-08-31T02:00:30.6937228Z --- PASS: TestOSPoolEP/Confirm_deployments_become_ready. (30.04s)2026-08-31T02:00:30.6956764Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_singularity. (20.52s)2026-08-31T02:00:30.6965574Z --- PASS: TestOSPoolEP/Confirm_condor_status_lists_the_EP. (20.52s)2026-08-31T02:00:30.6970444Z --- PASS: TestOSPoolEP/Confirm_EP_container_advertises_CVMFS (331.57s)2026-08-31T02:00:30.6971317Z PASS2026-08-31T02:00:30.6972116Z ok github.com/osg-htc/k8s-integration-tests/test 385.742s2026-08-31T02:00:30.8003840Z ##[group]Run echo "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT2026-08-31T02:00:30.8004809Z [36;1mecho "HASH=$(echo -n "$TEST_ENV" | sha256sum | cut -d ' ' -f 1)" >> $GITHUB_OUTPUT[0m2026-08-31T02:00:30.8093376Z shell: /usr/bin/bash --noprofile --norc -e -o pipefail {0}2026-08-31T02:00:30.8094015Z env:2026-08-31T02:00:30.8094733Z GOTOOLCHAIN: local2026-08-31T02:00:30.8095409Z TEST_ENV: OSPOOL_EP_OSPoolEPTag: 25-releaseOSPOOL_EP_CMTag: 25.0-el9OSPOOL_EP_CvmfsType: cvmfsexec2026-08-31T02:00:30.8095969Z ##[endgroup]2026-08-31T02:00:30.8392375Z 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:30.8394711Z ##[group]Run actions/upload-artifact@v42026-08-31T02:00:30.8395157Z with:2026-08-31T02:00:30.8395762Z name: TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce72322026-08-31T02:00:30.8396508Z path: /tmp/k8s-tests2026-08-31T02:00:30.8396867Z retention-days: 52026-08-31T02:00:30.8397223Z if-no-files-found: warn2026-08-31T02:00:30.8397602Z compression-level: 62026-08-31T02:00:30.8397959Z overwrite: false2026-08-31T02:00:30.8398326Z include-hidden-files: false2026-08-31T02:00:30.8398712Z env:2026-08-31T02:00:30.8399006Z GOTOOLCHAIN: local2026-08-31T02:00:30.8399345Z ##[endgroup]2026-08-31T02:00:31.0654853Z (node:17460) [DEP0040] DeprecationWarning: The `punycode` module is deprecated. Please use a userland alternative instead.2026-08-31T02:00:31.0656375Z (Use `node --trace-deprecation ...` to show where the warning was created)2026-08-31T02:00:31.0794326Z With the provided path, there will be 6 files uploaded2026-08-31T02:00:31.0796078Z Artifact name is valid!2026-08-31T02:00:31.0797042Z Root directory input is valid!2026-08-31T02:00:31.4551351Z Beginning upload of artifact content to blob storage2026-08-31T02:00:31.4995811Z (node:17460) [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:31.8511327Z Uploaded bytes 139822026-08-31T02:00:31.9304654Z Finished uploading artifact content to blob storage!2026-08-31T02:00:31.9305878Z SHA256 digest of uploaded artifact zip is 663ca73181d502c5485fc7cbb8a7cb208ef1374ab9a3356bb45ab0ad0e2198e52026-08-31T02:00:31.9306876Z Finalizing artifact upload2026-08-31T02:00:32.1953697Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232.zip successfully finalized. Artifact ID 97430448902026-08-31T02:00:32.1956519Z Artifact TestOSPoolEP-4209b6e6ca3892f0c35b39cc3f79d8ed7c833a027d74e27ee4db89bbc1ce7232 has been successfully uploaded! Final size is 13982 bytes. Artifact ID is 97430448902026-08-31T02:00:32.1962264Z Artifact download URL: https://github.com/osg-htc/k8s-integration-tests/actions/runs/33348883081/artifacts/97430448902026-08-31T02:00:32.2148365Z Post job cleanup.2026-08-31T02:00:32.3560103Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOMODCACHE2026-08-31T02:00:32.3610561Z [command]/opt/hostedtoolcache/go/1.26.7/x64/bin/go env GOCACHE2026-08-31T02:00:32.3645945Z /home/runner/go/pkg/mod2026-08-31T02:00:32.3677488Z /home/runner/.cache/go-build2026-08-31T02:00:32.3686890Z Cache hit occurred on the primary key setup-go-Linux-x64-ubuntu22-go-1.26.7-45f66c1d266a58b1f936914236dfb6a4ee1f407b6f36668ccfaf557ac52c82a0, not saving cache.2026-08-31T02:00:32.3847659Z Post job cleanup.2026-08-31T02:00:32.4938685Z [command]/usr/bin/git version2026-08-31T02:00:32.5025400Z git version 2.55.02026-08-31T02:00:32.5083495Z Temporarily overriding HOME='/home/runner/work/_temp/438d9c01-3fd6-441b-bc99-3244a4a4d202' before making global git config changes2026-08-31T02:00:32.5107145Z Adding repository directory to the temporary git global config as a safe directory2026-08-31T02:00:32.5113203Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/k8s-integration-tests/k8s-integration-tests2026-08-31T02:00:32.5159028Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand2026-08-31T02:00:32.5240425Z [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:32.5677345Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader2026-08-31T02:00:32.5710650Z http.https://github.com/.extraheader2026-08-31T02:00:32.5725567Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader2026-08-31T02:00:32.5775911Z [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:32.6118901Z [command]/usr/bin/git config --local --name-only --get-regexp ^includeIf\.gitdir:2026-08-31T02:00:32.6166881Z [command]/usr/bin/git submodule foreach --recursive git config --local --show-origin --name-only --get-regexp remote.origin.url2026-08-31T02:00:32.6621628Z Cleaning up orphan processes2026-08-31T02:00:32.7477726Z ##[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/