2026-03-18 10:00:33.365279 | Job console starting 2026-03-18 10:00:33.380115 | Updating git repos 2026-03-18 10:00:33.429661 | Cloning repos into workspace 2026-03-18 10:00:33.530958 | Restoring repo states 2026-03-18 10:00:33.545416 | Merging changes 2026-03-18 10:00:34.115895 | Checking out repos 2026-03-18 10:00:34.190415 | Preparing playbooks 2026-03-18 10:00:42.863932 | Running Ansible setup 2026-03-18 10:00:46.488558 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-18 10:00:47.037907 | 2026-03-18 10:00:47.038030 | PLAY [localhost] 2026-03-18 10:00:47.045843 | 2026-03-18 10:00:47.045915 | TASK [Gathering Facts] 2026-03-18 10:00:48.044525 | localhost | ok 2026-03-18 10:00:48.056938 | 2026-03-18 10:00:48.057028 | TASK [Setup log path fact] 2026-03-18 10:00:48.090086 | localhost | ok 2026-03-18 10:00:48.103427 | 2026-03-18 10:00:48.103777 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-18 10:00:48.137269 | localhost | ok 2026-03-18 10:00:48.148830 | 2026-03-18 10:00:48.148988 | TASK [emit-job-header : Print job information] 2026-03-18 10:00:48.195065 | # Job Information 2026-03-18 10:00:48.195618 | Ansible Version: 2.16.16 2026-03-18 10:00:48.195670 | Job: ansible-collection-kubernetes-molecule-helm 2026-03-18 10:00:48.195704 | Pipeline: check 2026-03-18 10:00:48.195734 | Executor: 0a8996d2b663 2026-03-18 10:00:48.195764 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/238 2026-03-18 10:00:48.195798 | Event ID: f222a020-22b0-11f1-88ac-026452cbc036 2026-03-18 10:00:48.200283 | 2026-03-18 10:00:48.200398 | LOOP [emit-job-header : Print node information] 2026-03-18 10:00:48.292382 | localhost | ok: 2026-03-18 10:00:48.293017 | localhost | # Node Information 2026-03-18 10:00:48.293070 | localhost | Inventory Hostname: controller 2026-03-18 10:00:48.293104 | localhost | Hostname: np0000159794 2026-03-18 10:00:48.293146 | localhost | Username: zuul 2026-03-18 10:00:48.293182 | localhost | Distro: Debian 13.3 2026-03-18 10:00:48.293229 | localhost | Provider: yul1 2026-03-18 10:00:48.293259 | localhost | Region: ca-ymq-1 2026-03-18 10:00:48.293287 | localhost | Label: debian-trixie 2026-03-18 10:00:48.293315 | localhost | Product Name: OpenStack Nova 2026-03-18 10:00:48.293342 | localhost | Interface IP: 199.204.45.144 2026-03-18 10:00:48.313028 | 2026-03-18 10:00:48.313291 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-18 10:00:48.725108 | localhost -> localhost | changed 2026-03-18 10:00:48.735892 | 2026-03-18 10:00:48.735990 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-18 10:00:49.550291 | localhost -> localhost | changed 2026-03-18 10:00:49.558377 | 2026-03-18 10:00:49.558469 | PLAY [all] 2026-03-18 10:00:49.568372 | 2026-03-18 10:00:49.568465 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-18 10:00:49.814859 | controller -> localhost | ok 2026-03-18 10:00:49.823637 | 2026-03-18 10:00:49.823724 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-18 10:00:49.854565 | controller | ok 2026-03-18 10:00:49.869186 | controller | included: /var/lib/zuul/builds/6d01cc9f40ab4476ad51be3daa9fbb80/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-18 10:00:49.873857 | 2026-03-18 10:00:49.873926 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-18 10:00:50.499080 | controller -> localhost | Generating public/private rsa key pair. 2026-03-18 10:00:50.499225 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/6d01cc9f40ab4476ad51be3daa9fbb80/work/6d01cc9f40ab4476ad51be3daa9fbb80_id_rsa 2026-03-18 10:00:50.499255 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/6d01cc9f40ab4476ad51be3daa9fbb80/work/6d01cc9f40ab4476ad51be3daa9fbb80_id_rsa.pub 2026-03-18 10:00:50.499280 | controller -> localhost | The key fingerprint is: 2026-03-18 10:00:50.499303 | controller -> localhost | SHA256:tVB7wiein/zwCLFo7LHiJpoOfM2ZozkUVWFYq8V8G0c zuul-build-sshkey 2026-03-18 10:00:50.499337 | controller -> localhost | The key's randomart image is: 2026-03-18 10:00:50.499361 | controller -> localhost | +---[RSA 3072]----+ 2026-03-18 10:00:50.499387 | controller -> localhost | | +=. .E | 2026-03-18 10:00:50.499411 | controller -> localhost | | o+ .o.. | 2026-03-18 10:00:50.499432 | controller -> localhost | | . =oo*.o | 2026-03-18 10:00:50.499454 | controller -> localhost | | . o..++* | 2026-03-18 10:00:50.499477 | controller -> localhost | | ..o S.. | 2026-03-18 10:00:50.499499 | controller -> localhost | |. oo.o= . | 2026-03-18 10:00:50.499520 | controller -> localhost | |....=*o = | 2026-03-18 10:00:50.499542 | controller -> localhost | |o.++oo.. = | 2026-03-18 10:00:50.499567 | controller -> localhost | |==.++ . o | 2026-03-18 10:00:50.499589 | controller -> localhost | +----[SHA256]-----+ 2026-03-18 10:00:50.499634 | controller -> localhost | ok: Runtime: 0:00:00.232003 2026-03-18 10:00:50.504539 | 2026-03-18 10:00:50.504646 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-18 10:00:50.535656 | controller | ok 2026-03-18 10:00:50.545915 | controller | included: /var/lib/zuul/builds/6d01cc9f40ab4476ad51be3daa9fbb80/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-18 10:00:50.553405 | 2026-03-18 10:00:50.553465 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-18 10:00:50.577475 | controller | skipping: Conditional result was False 2026-03-18 10:00:50.585718 | 2026-03-18 10:00:50.585844 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-18 10:00:51.242858 | controller | changed 2026-03-18 10:00:51.248610 | 2026-03-18 10:00:51.248733 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-18 10:00:51.462190 | controller | ok 2026-03-18 10:00:51.467914 | 2026-03-18 10:00:51.468005 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-18 10:00:52.015710 | controller | changed 2026-03-18 10:00:52.022150 | 2026-03-18 10:00:52.022274 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-18 10:00:52.597752 | controller | changed 2026-03-18 10:00:52.604105 | 2026-03-18 10:00:52.604190 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-18 10:00:52.628839 | controller | skipping: Conditional result was False 2026-03-18 10:00:52.637232 | 2026-03-18 10:00:52.637340 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-18 10:00:53.021034 | controller -> localhost | changed 2026-03-18 10:00:53.036138 | 2026-03-18 10:00:53.036262 | TASK [add-build-sshkey : Add back temp key] 2026-03-18 10:00:53.307463 | controller -> localhost | Identity added: /var/lib/zuul/builds/6d01cc9f40ab4476ad51be3daa9fbb80/work/6d01cc9f40ab4476ad51be3daa9fbb80_id_rsa (zuul-build-sshkey) 2026-03-18 10:00:53.307935 | controller -> localhost | ok: Runtime: 0:00:00.013824 2026-03-18 10:00:53.312017 | 2026-03-18 10:00:53.312075 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-18 10:00:53.636909 | controller | ok 2026-03-18 10:00:53.643266 | 2026-03-18 10:00:53.643362 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-18 10:00:53.668380 | controller | skipping: Conditional result was False 2026-03-18 10:00:53.680661 | 2026-03-18 10:00:53.680763 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-18 10:00:54.073664 | controller | ok 2026-03-18 10:00:54.078098 | 2026-03-18 10:00:54.078157 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-18 10:00:55.161504 | controller | Output suppressed because no_log was given 2026-03-18 10:00:55.168631 | 2026-03-18 10:00:55.168695 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-18 10:00:55.425312 | controller | ok: "logs" 2026-03-18 10:00:55.425535 | controller | ok: All items complete 2026-03-18 10:00:55.425564 | 2026-03-18 10:00:55.643394 | controller | ok: "artifacts" 2026-03-18 10:00:55.845628 | controller | ok: "docs" 2026-03-18 10:00:55.862407 | 2026-03-18 10:00:55.862546 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-18 10:00:56.083575 | controller | changed: "logs" 2026-03-18 10:00:56.283757 | controller | changed: "artifacts" 2026-03-18 10:00:56.487080 | controller | changed: "docs" 2026-03-18 10:00:56.734851 | 2026-03-18 10:00:56.734961 | PLAY RECAP 2026-03-18 10:00:56.735024 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-18 10:00:56.735066 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 10:00:56.735095 | 2026-03-18 10:00:56.839949 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-18 10:00:56.844603 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-18 10:00:57.453237 | 2026-03-18 10:00:57.453362 | PLAY [all] 2026-03-18 10:00:57.463569 | 2026-03-18 10:00:57.463651 | TASK [setup-uv : Extract archive] 2026-03-18 10:00:59.976440 | controller | changed 2026-03-18 10:00:59.984317 | 2026-03-18 10:00:59.984401 | TASK [setup-uv : Print version] 2026-03-18 10:01:00.333199 | controller | uv 0.8.13 2026-03-18 10:01:00.506115 | controller | ok: Runtime: 0:00:00.013696 2026-03-18 10:01:00.536376 | 2026-03-18 10:01:00.536465 | PLAY RECAP 2026-03-18 10:01:00.536526 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 10:01:00.536560 | 2026-03-18 10:01:00.641091 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-18 10:01:00.644340 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-18 10:01:01.242619 | 2026-03-18 10:01:01.242802 | PLAY [all] 2026-03-18 10:01:01.253954 | 2026-03-18 10:01:01.254060 | TASK [Update apt cache] 2026-03-18 10:01:06.348976 | controller | ok 2026-03-18 10:01:06.355395 | 2026-03-18 10:01:06.355471 | TASK [Install "jq" for log collection] 2026-03-18 10:01:08.595733 | controller | changed 2026-03-18 10:01:08.597969 | 2026-03-18 10:01:08.598033 | PLAY RECAP 2026-03-18 10:01:08.598089 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 10:01:08.598120 | 2026-03-18 10:01:08.710513 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-18 10:01:08.713257 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-18 10:01:09.263503 | 2026-03-18 10:01:09.263635 | PLAY [all] 2026-03-18 10:01:09.273521 | 2026-03-18 10:01:09.273601 | TASK [Copy inventory file for Zuul] 2026-03-18 10:01:10.238774 | controller | changed 2026-03-18 10:01:10.245811 | 2026-03-18 10:01:10.245957 | TASK [Switch "ansible_host" to private IP] 2026-03-18 10:01:10.560572 | controller | changed: 1 replacements made 2026-03-18 10:01:10.567333 | 2026-03-18 10:01:10.567406 | TASK [Run Molecule scenario] 2026-03-18 10:01:10.998632 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-18 10:01:10.998741 | controller | Creating virtual environment at: .venv 2026-03-18 10:01:11.271186 | controller | Downloading pygments (1.2MiB) 2026-03-18 10:01:11.272301 | controller | Downloading ansible-core (2.3MiB) 2026-03-18 10:01:11.272749 | controller | Downloading cryptography (4.3MiB) 2026-03-18 10:01:11.441812 | controller | Downloading cryptography 2026-03-18 10:01:11.501383 | controller | Downloading pygments 2026-03-18 10:01:11.686696 | controller | Downloading ansible-core 2026-03-18 10:01:11.736329 | controller | Installed 36 packages in 48ms 2026-03-18 10:01:12.497627 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-18 10:01:12.497700 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-18 10:01:13.486276 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-18 10:01:13.486351 | controller | INFO default scenario not found, disabling shared state. 2026-03-18 10:01:13.486637 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-18 10:01:13.486762 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-03-18 10:02:25.458803 | controller | INFO [helm > dependency] Executing 2026-03-18 10:02:25.458951 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-03-18 10:02:25.459149 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-03-18 10:02:25.459272 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-18 10:02:25.464729 | controller | INFO [helm > cleanup] Executing 2026-03-18 10:02:25.465025 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-18 10:02:25.470304 | controller | INFO [helm > destroy] Executing 2026-03-18 10:02:25.470373 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-18 10:02:25.470440 | controller | INFO [helm > destroy] Executed: Successful 2026-03-18 10:02:25.475769 | controller | INFO [helm > syntax] Executing 2026-03-18 10:02:26.431580 | controller | 2026-03-18 10:02:26.431669 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-03-18 10:02:26.516152 | controller | INFO [helm > syntax] Executed: Successful 2026-03-18 10:02:26.527733 | controller | INFO [helm > create] Executing 2026-03-18 10:02:26.529228 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-18 10:02:26.534910 | controller | INFO [helm > prepare] Executing 2026-03-18 10:02:27.488513 | controller | 2026-03-18 10:02:27.488552 | controller | PLAY [Prepare] ***************************************************************** 2026-03-18 10:02:27.488558 | controller | 2026-03-18 10:02:27.488564 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-18 10:02:27.488570 | controller | Wednesday 18 March 2026 10:02:27 +0000 (0:00:00.043) 0:00:00.043 ******* 2026-03-18 10:02:28.749312 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-18 10:02:28.755801 | controller | ok: [controller] 2026-03-18 10:02:28.755824 | controller | 2026-03-18 10:02:28.755833 | controller | TASK [Install Debian packages] ************************************************* 2026-03-18 10:02:28.755841 | controller | Wednesday 18 March 2026 10:02:28 +0000 (0:00:01.268) 0:00:01.311 ******* 2026-03-18 10:02:30.285068 | controller | ok: [controller] 2026-03-18 10:02:30.285358 | controller | 2026-03-18 10:02:30.285617 | controller | PLAY RECAP ********************************************************************* 2026-03-18 10:02:30.285893 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-18 10:02:30.286127 | controller | 2026-03-18 10:02:30.286353 | controller | 2026-03-18 10:02:30.286598 | controller | TASKS RECAP ******************************************************************** 2026-03-18 10:02:30.286866 | controller | Wednesday 18 March 2026 10:02:30 +0000 (0:00:01.530) 0:00:02.841 ******* 2026-03-18 10:02:30.287100 | controller | =============================================================================== 2026-03-18 10:02:30.287341 | controller | Install Debian packages ------------------------------------------------- 1.53s 2026-03-18 10:02:30.287581 | controller | Gathering Facts --------------------------------------------------------- 1.27s 2026-03-18 10:02:30.386500 | controller | INFO [helm > prepare] Executed: Successful 2026-03-18 10:02:30.398947 | controller | INFO [helm > converge] Executing 2026-03-18 10:02:31.357134 | controller | 2026-03-18 10:02:31.357179 | controller | PLAY [Converge] **************************************************************** 2026-03-18 10:02:31.357189 | controller | 2026-03-18 10:02:31.357198 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-18 10:02:31.357206 | controller | Wednesday 18 March 2026 10:02:31 +0000 (0:00:00.016) 0:00:00.016 ******* 2026-03-18 10:02:33.496775 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-18 10:02:33.502342 | controller | ok: [controller] 2026-03-18 10:02:33.502604 | controller | 2026-03-18 10:02:33.502862 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-18 10:02:33.503110 | controller | Wednesday 18 March 2026 10:02:33 +0000 (0:00:02.146) 0:00:02.162 ******* 2026-03-18 10:02:34.064753 | controller | ok: [controller] 2026-03-18 10:02:34.065035 | controller | 2026-03-18 10:02:34.065299 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-18 10:02:34.065550 | controller | Wednesday 18 March 2026 10:02:34 +0000 (0:00:00.562) 0:00:02.725 ******* 2026-03-18 10:02:35.316877 | controller | ok: [controller] 2026-03-18 10:02:35.317166 | controller | 2026-03-18 10:02:35.317526 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-18 10:02:35.317922 | controller | Wednesday 18 March 2026 10:02:35 +0000 (0:00:01.251) 0:00:03.977 ******* 2026-03-18 10:02:35.735042 | controller | changed: [controller] 2026-03-18 10:02:35.735239 | controller | 2026-03-18 10:02:35.735454 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-18 10:02:35.735634 | controller | Wednesday 18 March 2026 10:02:35 +0000 (0:00:00.417) 0:00:04.395 ******* 2026-03-18 10:02:35.778018 | controller | ok: [controller] => { 2026-03-18 10:02:35.778327 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-18 10:02:35.778572 | controller | } 2026-03-18 10:02:35.778807 | controller | 2026-03-18 10:02:35.779064 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-18 10:02:35.779316 | controller | Wednesday 18 March 2026 10:02:35 +0000 (0:00:00.043) 0:00:04.438 ******* 2026-03-18 10:02:36.566288 | controller | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually 2026-03-18 10:02:36.576100 | controller | changed: [controller] 2026-03-18 10:02:36.576138 | controller | 2026-03-18 10:02:36.576150 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-18 10:02:36.576161 | controller | Wednesday 18 March 2026 10:02:36 +0000 (0:00:00.797) 0:00:05.236 ******* 2026-03-18 10:02:38.653841 | controller | changed: [controller] 2026-03-18 10:02:38.654134 | controller | 2026-03-18 10:02:38.654399 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-18 10:02:38.654647 | controller | Wednesday 18 March 2026 10:02:38 +0000 (0:00:02.078) 0:00:07.314 ******* 2026-03-18 10:02:39.236839 | controller | ok: [controller] 2026-03-18 10:02:39.236890 | controller | 2026-03-18 10:02:39.237022 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-18 10:02:39.237147 | controller | Wednesday 18 March 2026 10:02:39 +0000 (0:00:00.575) 0:00:07.890 ******* 2026-03-18 10:02:39.653327 | controller | changed: [controller] 2026-03-18 10:02:39.653442 | controller | 2026-03-18 10:02:39.653612 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-18 10:02:39.653770 | controller | Wednesday 18 March 2026 10:02:39 +0000 (0:00:00.423) 0:00:08.313 ******* 2026-03-18 10:02:40.107533 | controller | ok: [controller] 2026-03-18 10:02:40.107633 | controller | 2026-03-18 10:02:40.108018 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-18 10:02:40.108034 | controller | Wednesday 18 March 2026 10:02:40 +0000 (0:00:00.454) 0:00:08.768 ******* 2026-03-18 10:02:40.421264 | controller | changed: [controller] 2026-03-18 10:02:40.421465 | controller | 2026-03-18 10:02:40.421656 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-18 10:02:40.421829 | controller | Wednesday 18 March 2026 10:02:40 +0000 (0:00:00.312) 0:00:09.081 ******* 2026-03-18 10:02:40.733946 | controller | ok: [controller] 2026-03-18 10:02:40.734013 | controller | 2026-03-18 10:02:40.734186 | controller | TASK [Install plugin] ********************************************************** 2026-03-18 10:02:40.734316 | controller | Wednesday 18 March 2026 10:02:40 +0000 (0:00:00.311) 0:00:09.392 ******* 2026-03-18 10:02:40.792864 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-18 10:02:40.792921 | controller | 2026-03-18 10:02:40.792982 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-18 10:02:40.793072 | controller | Wednesday 18 March 2026 10:02:40 +0000 (0:00:00.058) 0:00:09.451 ******* 2026-03-18 10:02:40.839145 | controller | ok: [controller] => { 2026-03-18 10:02:40.839177 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-18 10:02:40.839183 | controller | } 2026-03-18 10:02:40.839189 | controller | 2026-03-18 10:02:40.839194 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-18 10:02:40.839200 | controller | Wednesday 18 March 2026 10:02:40 +0000 (0:00:00.047) 0:00:09.498 ******* 2026-03-18 10:02:41.664467 | controller | changed: [controller] 2026-03-18 10:02:41.664531 | controller | 2026-03-18 10:02:41.664546 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-18 10:02:41.664672 | controller | Wednesday 18 March 2026 10:02:41 +0000 (0:00:00.825) 0:00:10.324 ******* 2026-03-18 10:02:43.816421 | controller | changed: [controller] 2026-03-18 10:02:43.816467 | controller | 2026-03-18 10:02:43.816477 | controller | PLAY RECAP ********************************************************************* 2026-03-18 10:02:43.816487 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-18 10:02:43.816495 | controller | 2026-03-18 10:02:43.816502 | controller | 2026-03-18 10:02:43.816509 | controller | TASKS RECAP ******************************************************************** 2026-03-18 10:02:43.816517 | controller | Wednesday 18 March 2026 10:02:43 +0000 (0:00:02.144) 0:00:12.469 ******* 2026-03-18 10:02:43.816524 | controller | =============================================================================== 2026-03-18 10:02:43.816532 | controller | Gathering Facts --------------------------------------------------------- 2.15s 2026-03-18 10:02:43.816541 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.14s 2026-03-18 10:02:43.816551 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.08s 2026-03-18 10:02:43.816560 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.25s 2026-03-18 10:02:43.816569 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.83s 2026-03-18 10:02:43.816579 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.80s 2026-03-18 10:02:43.816588 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.58s 2026-03-18 10:02:43.816597 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.56s 2026-03-18 10:02:43.816888 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.45s 2026-03-18 10:02:43.817149 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.42s 2026-03-18 10:02:43.817421 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s 2026-03-18 10:02:43.817718 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-03-18 10:02:43.817990 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.31s 2026-03-18 10:02:43.818275 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-18 10:02:43.818531 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-18 10:02:43.818806 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-18 10:02:43.918358 | controller | INFO [helm > converge] Executed: Successful 2026-03-18 10:02:43.928766 | controller | INFO [helm > idempotence] Executing 2026-03-18 10:02:44.835100 | controller | 2026-03-18 10:02:44.835504 | controller | PLAY [Converge] **************************************************************** 2026-03-18 10:02:44.835704 | controller | 2026-03-18 10:02:44.835870 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-18 10:02:44.836096 | controller | Wednesday 18 March 2026 10:02:44 +0000 (0:00:00.013) 0:00:00.013 ******* 2026-03-18 10:02:45.902278 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-18 10:02:45.908432 | controller | ok: [controller] 2026-03-18 10:02:45.908675 | controller | 2026-03-18 10:02:45.908902 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-18 10:02:45.909079 | controller | Wednesday 18 March 2026 10:02:45 +0000 (0:00:01.073) 0:00:01.087 ******* 2026-03-18 10:02:46.343775 | controller | ok: [controller] 2026-03-18 10:02:46.344140 | controller | 2026-03-18 10:02:46.344644 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-18 10:02:46.344993 | controller | Wednesday 18 March 2026 10:02:46 +0000 (0:00:00.434) 0:00:01.521 ******* 2026-03-18 10:02:47.489958 | controller | ok: [controller] 2026-03-18 10:02:47.490260 | controller | 2026-03-18 10:02:47.490545 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-18 10:02:47.490814 | controller | Wednesday 18 March 2026 10:02:47 +0000 (0:00:01.146) 0:00:02.668 ******* 2026-03-18 10:02:47.956505 | controller | ok: [controller] 2026-03-18 10:02:47.956550 | controller | 2026-03-18 10:02:47.956667 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-18 10:02:47.956763 | controller | Wednesday 18 March 2026 10:02:47 +0000 (0:00:00.464) 0:00:03.133 ******* 2026-03-18 10:02:47.999131 | controller | ok: [controller] => { 2026-03-18 10:02:47.999215 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-18 10:02:47.999350 | controller | } 2026-03-18 10:02:47.999470 | controller | 2026-03-18 10:02:47.999617 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-18 10:02:47.999755 | controller | Wednesday 18 March 2026 10:02:47 +0000 (0:00:00.044) 0:00:03.177 ******* 2026-03-18 10:02:48.566946 | controller | ok: [controller] 2026-03-18 10:02:48.566998 | controller | 2026-03-18 10:02:48.567227 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-18 10:02:48.567446 | controller | Wednesday 18 March 2026 10:02:48 +0000 (0:00:00.566) 0:00:03.744 ******* 2026-03-18 10:02:50.306606 | controller | ok: [controller] 2026-03-18 10:02:50.306653 | controller | 2026-03-18 10:02:50.306661 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-18 10:02:50.306667 | controller | Wednesday 18 March 2026 10:02:50 +0000 (0:00:01.740) 0:00:05.484 ******* 2026-03-18 10:02:50.937030 | controller | ok: [controller] 2026-03-18 10:02:50.937112 | controller | 2026-03-18 10:02:50.937359 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-18 10:02:50.937393 | controller | Wednesday 18 March 2026 10:02:50 +0000 (0:00:00.628) 0:00:06.113 ******* 2026-03-18 10:02:51.341156 | controller | ok: [controller] 2026-03-18 10:02:51.341431 | controller | 2026-03-18 10:02:51.341688 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-18 10:02:51.341933 | controller | Wednesday 18 March 2026 10:02:51 +0000 (0:00:00.404) 0:00:06.517 ******* 2026-03-18 10:02:51.835733 | controller | ok: [controller] 2026-03-18 10:02:51.835837 | controller | 2026-03-18 10:02:51.835958 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-18 10:02:51.836086 | controller | Wednesday 18 March 2026 10:02:51 +0000 (0:00:00.493) 0:00:07.011 ******* 2026-03-18 10:02:52.134888 | controller | ok: [controller] 2026-03-18 10:02:52.134991 | controller | 2026-03-18 10:02:52.135136 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-18 10:02:52.135286 | controller | Wednesday 18 March 2026 10:02:52 +0000 (0:00:00.301) 0:00:07.313 ******* 2026-03-18 10:02:52.455862 | controller | ok: [controller] 2026-03-18 10:02:52.455922 | controller | 2026-03-18 10:02:52.455933 | controller | TASK [Install plugin] ********************************************************** 2026-03-18 10:02:52.456040 | controller | Wednesday 18 March 2026 10:02:52 +0000 (0:00:00.320) 0:00:07.634 ******* 2026-03-18 10:02:52.523692 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-18 10:02:52.523748 | controller | 2026-03-18 10:02:52.523828 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-18 10:02:52.523944 | controller | Wednesday 18 March 2026 10:02:52 +0000 (0:00:00.066) 0:00:07.700 ******* 2026-03-18 10:02:52.567283 | controller | ok: [controller] => { 2026-03-18 10:02:52.567417 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-18 10:02:52.567541 | controller | } 2026-03-18 10:02:52.567703 | controller | 2026-03-18 10:02:52.567877 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-18 10:02:52.568051 | controller | Wednesday 18 March 2026 10:02:52 +0000 (0:00:00.044) 0:00:07.745 ******* 2026-03-18 10:02:52.986150 | controller | ok: [controller] 2026-03-18 10:02:52.986178 | controller | 2026-03-18 10:02:52.986184 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-18 10:02:52.986190 | controller | Wednesday 18 March 2026 10:02:52 +0000 (0:00:00.418) 0:00:08.164 ******* 2026-03-18 10:02:54.711704 | controller | ok: [controller] 2026-03-18 10:02:54.711905 | controller | 2026-03-18 10:02:54.712082 | controller | PLAY RECAP ********************************************************************* 2026-03-18 10:02:54.712268 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-18 10:02:54.712455 | controller | 2026-03-18 10:02:54.712610 | controller | 2026-03-18 10:02:54.712777 | controller | TASKS RECAP ******************************************************************** 2026-03-18 10:02:54.712949 | controller | Wednesday 18 March 2026 10:02:54 +0000 (0:00:01.726) 0:00:09.890 ******* 2026-03-18 10:02:54.713107 | controller | =============================================================================== 2026-03-18 10:02:54.713327 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.74s 2026-03-18 10:02:54.713497 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.73s 2026-03-18 10:02:54.713660 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.15s 2026-03-18 10:02:54.713820 | controller | Gathering Facts --------------------------------------------------------- 1.07s 2026-03-18 10:02:54.713985 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.63s 2026-03-18 10:02:54.714149 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.57s 2026-03-18 10:02:54.714315 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.49s 2026-03-18 10:02:54.714478 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.46s 2026-03-18 10:02:54.714640 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.43s 2026-03-18 10:02:54.714801 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.42s 2026-03-18 10:02:54.714978 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.40s 2026-03-18 10:02:54.715151 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.32s 2026-03-18 10:02:54.715320 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.30s 2026-03-18 10:02:54.715480 | controller | Install plugin ---------------------------------------------------------- 0.07s 2026-03-18 10:02:54.715642 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-18 10:02:54.715803 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-18 10:02:54.854072 | controller | INFO [helm > idempotence] Executed: Successful 2026-03-18 10:02:54.861971 | controller | INFO [helm > side_effect] Executing 2026-03-18 10:02:54.862465 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-18 10:02:54.871580 | controller | INFO [helm > verify] Executing 2026-03-18 10:02:55.903063 | controller | 2026-03-18 10:02:55.903454 | controller | PLAY [Verify] ****************************************************************** 2026-03-18 10:02:55.903720 | controller | 2026-03-18 10:02:55.904080 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-18 10:02:55.904528 | controller | Wednesday 18 March 2026 10:02:55 +0000 (0:00:00.011) 0:00:00.011 ******* 2026-03-18 10:02:57.078434 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-18 10:02:57.084538 | controller | ok: [controller] 2026-03-18 10:02:57.084716 | controller | 2026-03-18 10:02:57.084944 | controller | TASK [Get the current Helm version] ******************************************** 2026-03-18 10:02:57.085145 | controller | Wednesday 18 March 2026 10:02:57 +0000 (0:00:01.181) 0:00:01.192 ******* 2026-03-18 10:02:57.576563 | controller | changed: [controller] 2026-03-18 10:02:57.576698 | controller | 2026-03-18 10:02:57.576718 | controller | TASK [Assert Helm version] ***************************************************** 2026-03-18 10:02:57.576888 | controller | Wednesday 18 March 2026 10:02:57 +0000 (0:00:00.491) 0:00:01.684 ******* 2026-03-18 10:02:57.608095 | controller | ok: [controller] => { 2026-03-18 10:02:57.608183 | controller | "changed": false, 2026-03-18 10:02:57.608197 | controller | "msg": "All assertions passed" 2026-03-18 10:02:57.608327 | controller | } 2026-03-18 10:02:57.608461 | controller | 2026-03-18 10:02:57.608571 | controller | PLAY RECAP ********************************************************************* 2026-03-18 10:02:57.608759 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-18 10:02:57.608854 | controller | 2026-03-18 10:02:57.608950 | controller | 2026-03-18 10:02:57.609061 | controller | TASKS RECAP ******************************************************************** 2026-03-18 10:02:57.609173 | controller | Wednesday 18 March 2026 10:02:57 +0000 (0:00:00.032) 0:00:01.717 ******* 2026-03-18 10:02:57.609280 | controller | =============================================================================== 2026-03-18 10:02:57.609390 | controller | Gathering Facts --------------------------------------------------------- 1.18s 2026-03-18 10:02:57.609504 | controller | Get the current Helm version -------------------------------------------- 0.49s 2026-03-18 10:02:57.609614 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-03-18 10:02:57.720672 | controller | INFO [helm > verify] Executed: Successful 2026-03-18 10:02:57.730072 | controller | INFO [helm > cleanup] Executing 2026-03-18 10:02:57.730794 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-18 10:02:57.741482 | controller | INFO [helm > destroy] Executing 2026-03-18 10:02:57.741530 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-18 10:02:57.741548 | controller | INFO [helm > destroy] Executed: Successful 2026-03-18 10:02:57.741864 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-18 10:02:58.265471 | controller | ok: Runtime: 0:01:46.934864 2026-03-18 10:02:58.270285 | 2026-03-18 10:02:58.270352 | PLAY RECAP 2026-03-18 10:02:58.270416 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 10:02:58.270452 | 2026-03-18 10:02:58.365024 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-18 10:02:58.366372 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-18 10:02:58.937852 | 2026-03-18 10:02:58.937959 | PLAY [all] 2026-03-18 10:02:58.948315 | 2026-03-18 10:02:58.948398 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-18 10:02:59.377271 | controller | changed 2026-03-18 10:02:59.382935 | 2026-03-18 10:02:59.383016 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-18 10:02:59.937386 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 10:02:59.939666 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 10:02:59.946001 | controller | environment: line 1: kubectl: command not found 2026-03-18 10:02:59.948467 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 10:02:59.949152 | controller | environment: line 1: kubectl: command not found 2026-03-18 10:02:59.950242 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 10:02:59.951908 | controller | environment: line 1: kubectl: command not found 2026-03-18 10:02:59.953406 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 10:02:59.955843 | controller | environment: line 1: kubectl: command not found 2026-03-18 10:02:59.958130 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 10:02:59.959556 | controller | environment: line 1: kubectl: command not found 2026-03-18 10:02:59.961376 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 10:03:00.414514 | controller | ok: Runtime: 0:00:00.207371 2026-03-18 10:03:00.421423 | 2026-03-18 10:03:00.421489 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-18 10:03:00.675635 | controller | changed 2026-03-18 10:03:00.680705 | 2026-03-18 10:03:00.680797 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-18 10:03:00.931867 | controller | environment: line 5: kubectl: command not found 2026-03-18 10:03:00.933194 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 10:03:00.933883 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 10:03:00.934227 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 10:03:01.213712 | controller | ok: Runtime: 0:00:00.014851 2026-03-18 10:03:01.220872 | 2026-03-18 10:03:01.220938 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-18 10:03:01.892408 | controller | changed: 2026-03-18 10:03:01.892612 | controller | created directory /var/lib/zuul/builds/6d01cc9f40ab4476ad51be3daa9fbb80/work/logs/controller 2026-03-18 10:03:01.892661 | controller | cd+++++++++ objects/ 2026-03-18 10:03:01.892696 | controller | cd+++++++++ objects/cluster/ 2026-03-18 10:03:01.892732 | controller | cd+++++++++ objects/namespaced/ 2026-03-18 10:03:01.902011 | 2026-03-18 10:03:01.902100 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-18 10:03:02.146890 | controller | changed 2026-03-18 10:03:02.156351 | 2026-03-18 10:03:02.156486 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-18 10:03:02.399933 | controller | changed 2026-03-18 10:03:02.405479 | 2026-03-18 10:03:02.405580 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-18 10:03:02.654734 | controller | environment: line 3: kubectl: command not found 2026-03-18 10:03:02.935508 | controller | ok: Runtime: 0:00:00.014293 2026-03-18 10:03:02.941986 | 2026-03-18 10:03:02.942089 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-18 10:03:03.482036 | controller | changed: 2026-03-18 10:03:03.482272 | controller | cd+++++++++ pod-logs/ 2026-03-18 10:03:03.482340 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-03-18 10:03:03.489314 | 2026-03-18 10:03:03.489378 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-18 10:03:03.728836 | controller | changed: "values" 2026-03-18 10:03:03.966406 | controller | changed: "releases" 2026-03-18 10:03:03.979277 | 2026-03-18 10:03:03.979457 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-18 10:03:04.228487 | controller | /bin/bash: line 3: kubectl: command not found 2026-03-18 10:03:04.508528 | controller | ok: Runtime: 0:00:00.008650 2026-03-18 10:03:04.526267 | 2026-03-18 10:03:04.577343 | TASK [helm-release-status : Downloads logs to executor] 2026-03-18 10:03:05.085538 | controller | changed: 2026-03-18 10:03:05.085812 | controller | cd+++++++++ helm/ 2026-03-18 10:03:05.085885 | controller | cd+++++++++ helm/releases/ 2026-03-18 10:03:05.085957 | controller | cd+++++++++ helm/values/ 2026-03-18 10:03:05.093016 | 2026-03-18 10:03:05.093104 | PLAY RECAP 2026-03-18 10:03:05.093176 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 10:03:05.093205 | 2026-03-18 10:03:05.189777 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-18 10:03:05.191786 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-18 10:03:05.776355 | 2026-03-18 10:03:05.776487 | PLAY [all] 2026-03-18 10:03:05.787321 | 2026-03-18 10:03:05.787402 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-18 10:03:05.832410 | controller | skipping: Conditional result was False 2026-03-18 10:03:05.847732 | 2026-03-18 10:03:05.847920 | TASK [fetch-output : Set log path for single node] 2026-03-18 10:03:05.891954 | controller | ok 2026-03-18 10:03:05.899090 | 2026-03-18 10:03:05.899223 | LOOP [fetch-output : Ensure local output dirs] 2026-03-18 10:03:06.317379 | controller -> localhost | ok: "/var/lib/zuul/builds/6d01cc9f40ab4476ad51be3daa9fbb80/work/logs" 2026-03-18 10:03:06.541137 | controller -> localhost | changed: "/var/lib/zuul/builds/6d01cc9f40ab4476ad51be3daa9fbb80/work/artifacts" 2026-03-18 10:03:06.762851 | controller -> localhost | changed: "/var/lib/zuul/builds/6d01cc9f40ab4476ad51be3daa9fbb80/work/docs" 2026-03-18 10:03:06.779737 | 2026-03-18 10:03:06.779969 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-18 10:03:07.468181 | controller | changed: .d..t...... ./ 2026-03-18 10:03:07.468460 | controller | changed: All items complete 2026-03-18 10:03:07.468497 | 2026-03-18 10:03:07.987233 | controller | changed: .d..t...... ./ 2026-03-18 10:03:08.477035 | controller | changed: .d..t...... ./ 2026-03-18 10:03:08.496495 | 2026-03-18 10:03:08.496658 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-18 10:03:08.924927 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007177 2026-03-18 10:03:09.146783 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007394 2026-03-18 10:03:09.164782 | 2026-03-18 10:03:09.164897 | PLAY [all] 2026-03-18 10:03:09.170250 | 2026-03-18 10:03:09.170313 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-18 10:03:09.646664 | controller | changed 2026-03-18 10:03:09.651672 | 2026-03-18 10:03:09.651721 | PLAY RECAP 2026-03-18 10:03:09.651762 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-18 10:03:09.651783 | 2026-03-18 10:03:09.743508 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-18 10:03:09.746045 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-18 10:03:10.315256 | 2026-03-18 10:03:10.315520 | PLAY [localhost] 2026-03-18 10:03:10.329902 | 2026-03-18 10:03:10.330025 | TASK [Generate Zuul manifest] 2026-03-18 10:03:10.349242 | localhost | ok 2026-03-18 10:03:10.369447 | 2026-03-18 10:03:10.369561 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-18 10:03:11.179595 | localhost | changed 2026-03-18 10:03:11.195610 | 2026-03-18 10:03:11.195706 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-18 10:03:11.900115 | localhost | ok 2026-03-18 10:03:11.909265 | 2026-03-18 10:03:11.909374 | TASK [Upload logs] 2026-03-18 10:03:11.930349 | localhost | ok 2026-03-18 10:03:11.987866 | 2026-03-18 10:03:11.987957 | TASK [Set zuul-log-path fact] 2026-03-18 10:03:12.005314 | localhost | ok 2026-03-18 10:03:12.019436 | 2026-03-18 10:03:12.019500 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-18 10:03:12.050013 | localhost | ok 2026-03-18 10:03:12.060776 | 2026-03-18 10:03:12.060839 | TASK [upload-logs : Create log directories] 2026-03-18 10:03:12.893062 | localhost | changed 2026-03-18 10:03:12.898881 | 2026-03-18 10:03:12.898960 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-18 10:03:13.596169 | localhost -> localhost | ok: Runtime: 0:00:00.023538 2026-03-18 10:03:13.601989 | 2026-03-18 10:03:13.602052 | TASK [upload-logs : Upload logs to log server] 2026-03-18 10:03:14.045271 | localhost | Output suppressed because no_log was given 2026-03-18 10:03:14.050183 | 2026-03-18 10:03:14.050269 | LOOP [upload-logs : Compress console log and json output] 2026-03-18 10:03:14.101439 | localhost | skipping: Conditional result was False 2026-03-18 10:03:14.108458 | localhost | skipping: Conditional result was False 2026-03-18 10:03:14.122120 | 2026-03-18 10:03:14.122267 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-18 10:03:14.160356 | localhost | skipping: Conditional result was False 2026-03-18 10:03:14.160847 | 2026-03-18 10:03:14.165025 | localhost | skipping: Conditional result was False 2026-03-18 10:03:14.171835 | 2026-03-18 10:03:14.171977 | LOOP [upload-logs : Upload console log and json output]