2026-04-18 17:48:27.033626 | Job console starting 2026-04-18 17:48:27.044924 | Updating git repos 2026-04-18 17:48:27.080112 | Cloning repos into workspace 2026-04-18 17:48:30.873486 | Restoring repo states 2026-04-18 17:48:30.993578 | Merging changes 2026-04-18 17:48:32.101112 | Checking out repos 2026-04-18 17:48:32.380406 | Preparing playbooks 2026-04-18 17:48:52.178479 | Running Ansible setup 2026-04-18 17:48:59.601541 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 17:49:00.229949 | 2026-04-18 17:49:00.230076 | PLAY [localhost] 2026-04-18 17:49:00.237725 | 2026-04-18 17:49:00.237802 | TASK [Gathering Facts] 2026-04-18 17:49:01.726946 | localhost | ok 2026-04-18 17:49:01.738901 | 2026-04-18 17:49:01.739049 | TASK [Setup log path fact] 2026-04-18 17:49:01.759897 | localhost | ok 2026-04-18 17:49:01.771346 | 2026-04-18 17:49:01.771447 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 17:49:01.808805 | localhost | ok 2026-04-18 17:49:01.817283 | 2026-04-18 17:49:01.817404 | TASK [emit-job-header : Print job information] 2026-04-18 17:49:01.858202 | # Job Information 2026-04-18 17:49:01.858430 | Ansible Version: 2.16.16 2026-04-18 17:49:01.858479 | Job: ansible-collection-kubernetes-molecule-helm 2026-04-18 17:49:01.858512 | Pipeline: check 2026-04-18 17:49:01.858543 | Executor: 0a8996d2b663 2026-04-18 17:49:01.858573 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/264 2026-04-18 17:49:01.858607 | Event ID: 4b91b6b0-3b4c-11f1-854e-6828c01faebc 2026-04-18 17:49:01.862997 | 2026-04-18 17:49:01.863107 | LOOP [emit-job-header : Print node information] 2026-04-18 17:49:01.948105 | localhost | ok: 2026-04-18 17:49:01.948306 | localhost | # Node Information 2026-04-18 17:49:01.948351 | localhost | Inventory Hostname: controller 2026-04-18 17:49:01.948378 | localhost | Hostname: np0000167549 2026-04-18 17:49:01.948599 | localhost | Username: zuul 2026-04-18 17:49:01.948644 | localhost | Distro: Debian 13.4 2026-04-18 17:49:01.948675 | localhost | Provider: yul1 2026-04-18 17:49:01.948701 | localhost | Region: ca-ymq-1 2026-04-18 17:49:01.948726 | localhost | Label: debian-trixie 2026-04-18 17:49:01.948749 | localhost | Product Name: OpenStack Nova 2026-04-18 17:49:01.948770 | localhost | Interface IP: 199.204.45.113 2026-04-18 17:49:01.960897 | 2026-04-18 17:49:01.961311 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-18 17:49:02.402514 | localhost -> localhost | changed 2026-04-18 17:49:02.409569 | 2026-04-18 17:49:02.409666 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-18 17:49:03.302795 | localhost -> localhost | changed 2026-04-18 17:49:03.313052 | 2026-04-18 17:49:03.313161 | PLAY [all] 2026-04-18 17:49:03.321660 | 2026-04-18 17:49:03.321751 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-18 17:49:03.611368 | controller -> localhost | ok 2026-04-18 17:49:03.616984 | 2026-04-18 17:49:03.617051 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-18 17:49:03.650541 | controller | ok 2026-04-18 17:49:03.665210 | controller | included: /var/lib/zuul/builds/5b7269cb552841099be6baf637de3187/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-18 17:49:03.670035 | 2026-04-18 17:49:03.670110 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-18 17:49:05.363706 | controller -> localhost | Generating public/private rsa key pair. 2026-04-18 17:49:05.363918 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/5b7269cb552841099be6baf637de3187/work/5b7269cb552841099be6baf637de3187_id_rsa 2026-04-18 17:49:05.363951 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/5b7269cb552841099be6baf637de3187/work/5b7269cb552841099be6baf637de3187_id_rsa.pub 2026-04-18 17:49:05.363974 | controller -> localhost | The key fingerprint is: 2026-04-18 17:49:05.363996 | controller -> localhost | SHA256:YxOD2sYLqwV4I3FWh5NZpR7zlizmDHlJa5b77txdoGs zuul-build-sshkey 2026-04-18 17:49:05.364030 | controller -> localhost | The key's randomart image is: 2026-04-18 17:49:05.364052 | controller -> localhost | +---[RSA 3072]----+ 2026-04-18 17:49:05.364076 | controller -> localhost | | .=o.. | 2026-04-18 17:49:05.364098 | controller -> localhost | | .=. o | 2026-04-18 17:49:05.364118 | controller -> localhost | |. o .* o | 2026-04-18 17:49:05.364138 | controller -> localhost | | = B O + | 2026-04-18 17:49:05.364162 | controller -> localhost | |o + = # S . | 2026-04-18 17:49:05.364186 | controller -> localhost | | o o % * o . . | 2026-04-18 17:49:05.364206 | controller -> localhost | | o = . . | 2026-04-18 17:49:05.364225 | controller -> localhost | | o o .Eo . | 2026-04-18 17:49:05.364248 | controller -> localhost | | . o=.o . | 2026-04-18 17:49:05.364268 | controller -> localhost | +----[SHA256]-----+ 2026-04-18 17:49:05.364325 | controller -> localhost | ok: Runtime: 0:00:01.271914 2026-04-18 17:49:05.369595 | 2026-04-18 17:49:05.369714 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-18 17:49:05.397645 | controller | ok 2026-04-18 17:49:05.405780 | controller | included: /var/lib/zuul/builds/5b7269cb552841099be6baf637de3187/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-18 17:49:05.414116 | 2026-04-18 17:49:05.414255 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-18 17:49:05.438905 | controller | skipping: Conditional result was False 2026-04-18 17:49:05.445753 | 2026-04-18 17:49:05.445927 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-18 17:49:05.972131 | controller | changed 2026-04-18 17:49:07.381784 | 2026-04-18 17:49:07.381988 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-18 17:49:07.603952 | controller | ok 2026-04-18 17:49:07.607917 | 2026-04-18 17:49:07.607978 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-18 17:49:08.159478 | controller | changed 2026-04-18 17:49:08.240416 | 2026-04-18 17:49:08.240562 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-18 17:49:08.790170 | controller | changed 2026-04-18 17:49:08.795520 | 2026-04-18 17:49:08.795596 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-18 17:49:08.820291 | controller | skipping: Conditional result was False 2026-04-18 17:49:08.830519 | 2026-04-18 17:49:08.830647 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-18 17:49:09.220061 | controller -> localhost | changed 2026-04-18 17:49:09.230830 | 2026-04-18 17:49:09.230925 | TASK [add-build-sshkey : Add back temp key] 2026-04-18 17:49:09.569928 | controller -> localhost | Identity added: /var/lib/zuul/builds/5b7269cb552841099be6baf637de3187/work/5b7269cb552841099be6baf637de3187_id_rsa (zuul-build-sshkey) 2026-04-18 17:49:09.570180 | controller -> localhost | ok: Runtime: 0:00:00.013779 2026-04-18 17:49:09.576273 | 2026-04-18 17:49:09.576338 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-18 17:49:09.920690 | controller | ok 2026-04-18 17:49:09.924664 | 2026-04-18 17:49:09.924729 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-18 17:49:09.949323 | controller | skipping: Conditional result was False 2026-04-18 17:49:09.964689 | 2026-04-18 17:49:09.964787 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-18 17:49:10.363189 | controller | ok 2026-04-18 17:49:10.371632 | 2026-04-18 17:49:10.371706 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-18 17:49:11.479868 | controller | Output suppressed because no_log was given 2026-04-18 17:49:11.495816 | 2026-04-18 17:49:11.496031 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-18 17:49:11.712795 | controller | ok: "logs" 2026-04-18 17:49:11.713039 | controller | ok: All items complete 2026-04-18 17:49:11.713068 | 2026-04-18 17:49:11.911954 | controller | ok: "artifacts" 2026-04-18 17:49:12.096192 | controller | ok: "docs" 2026-04-18 17:49:12.243370 | 2026-04-18 17:49:12.243529 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-18 17:49:12.461333 | controller | changed: "logs" 2026-04-18 17:49:12.648118 | controller | changed: "artifacts" 2026-04-18 17:49:14.719108 | controller | changed: "docs" 2026-04-18 17:49:14.736361 | 2026-04-18 17:49:14.736479 | PLAY RECAP 2026-04-18 17:49:14.736561 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-18 17:49:14.736606 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 17:49:14.736636 | 2026-04-18 17:49:14.907525 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 17:49:14.910995 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-18 17:49:15.561953 | 2026-04-18 17:49:15.562084 | PLAY [all] 2026-04-18 17:49:15.579371 | 2026-04-18 17:49:15.579513 | TASK [setup-uv : Extract archive] 2026-04-18 17:49:18.097814 | controller | changed 2026-04-18 17:49:18.103652 | 2026-04-18 17:49:18.103735 | TASK [setup-uv : Print version] 2026-04-18 17:49:18.522441 | controller | uv 0.8.13 2026-04-18 17:49:18.725865 | controller | ok: Runtime: 0:00:00.015456 2026-04-18 17:49:18.734048 | 2026-04-18 17:49:18.734182 | PLAY RECAP 2026-04-18 17:49:18.734248 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 17:49:18.734285 | 2026-04-18 17:49:18.864924 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-18 17:49:18.866730 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-04-18 17:49:19.575209 | 2026-04-18 17:49:20.016747 | PLAY [all] 2026-04-18 17:49:20.034392 | 2026-04-18 17:49:20.034559 | TASK [Update apt cache] 2026-04-18 17:49:28.430579 | controller | ok 2026-04-18 17:49:28.435913 | 2026-04-18 17:49:28.436002 | TASK [Disable firewalld] 2026-04-18 17:49:28.461171 | controller | skipping: Conditional result was False 2026-04-18 17:49:28.466048 | 2026-04-18 17:49:28.466194 | TASK [Install "jq" for log collection] 2026-04-18 17:49:31.144357 | controller | changed 2026-04-18 17:49:31.244388 | 2026-04-18 17:49:31.244504 | PLAY RECAP 2026-04-18 17:49:31.244568 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-18 17:49:31.244607 | 2026-04-18 17:49:31.382869 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-04-18 17:49:31.390911 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-18 17:49:31.985208 | 2026-04-18 17:49:32.053158 | PLAY [all] 2026-04-18 17:49:32.074267 | 2026-04-18 17:49:32.074440 | TASK [Copy inventory file for Zuul] 2026-04-18 17:49:33.073805 | controller | changed 2026-04-18 17:49:33.079470 | 2026-04-18 17:49:33.079551 | TASK [Switch "ansible_host" to private IP] 2026-04-18 17:49:33.426472 | controller | changed: 1 replacements made 2026-04-18 17:49:33.638725 | 2026-04-18 17:49:33.638834 | TASK [Run Molecule scenario] 2026-04-18 17:49:34.099091 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-04-18 17:49:34.099206 | controller | Creating virtual environment at: .venv 2026-04-18 17:49:34.148870 | controller | Downloading pygments (1.2MiB) 2026-04-18 17:49:34.155311 | controller | Downloading ansible-core (2.3MiB) 2026-04-18 17:49:34.155997 | controller | Downloading cryptography (4.3MiB) 2026-04-18 17:49:34.322253 | controller | Downloading cryptography 2026-04-18 17:49:34.381457 | controller | Downloading pygments 2026-04-18 17:49:34.571389 | controller | Downloading ansible-core 2026-04-18 17:49:34.622249 | controller | Installed 36 packages in 49ms 2026-04-18 17:49:35.322935 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-04-18 17:49:35.323022 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-04-18 17:49:36.336431 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-18 17:49:36.336475 | controller | INFO default scenario not found, disabling shared state. 2026-04-18 17:49:36.336622 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-18 17:49:36.336699 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-04-18 17:49:54.969620 | controller | INFO [helm > dependency] Executing 2026-04-18 17:49:54.969703 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-04-18 17:49:54.969942 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-04-18 17:49:54.970088 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-18 17:49:55.008778 | controller | INFO [helm > cleanup] Executing 2026-04-18 17:49:55.009191 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 17:49:55.112252 | controller | INFO [helm > destroy] Executing 2026-04-18 17:49:55.112320 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-04-18 17:49:55.112327 | controller | INFO [helm > destroy] Executed: Successful 2026-04-18 17:49:55.130780 | controller | INFO [helm > syntax] Executing 2026-04-18 17:49:56.064528 | controller | 2026-04-18 17:49:56.064823 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-04-18 17:49:56.138262 | controller | INFO [helm > syntax] Executed: Successful 2026-04-18 17:49:56.149956 | controller | INFO [helm > create] Executing 2026-04-18 17:49:56.151445 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 17:49:56.156940 | controller | INFO [helm > prepare] Executing 2026-04-18 17:49:57.094766 | controller | 2026-04-18 17:49:57.094946 | controller | PLAY [Prepare] ***************************************************************** 2026-04-18 17:49:57.095133 | controller | 2026-04-18 17:49:57.095333 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-18 17:49:57.095591 | controller | Saturday 18 April 2026 17:49:57 +0000 (0:00:00.039) 0:00:00.039 ******** 2026-04-18 17:49:58.379278 | 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-04-18 17:49:58.387222 | controller | ok: [controller] 2026-04-18 17:49:58.387386 | controller | 2026-04-18 17:49:58.387626 | controller | TASK [Install Debian packages] ************************************************* 2026-04-18 17:49:58.387818 | controller | Saturday 18 April 2026 17:49:58 +0000 (0:00:01.294) 0:00:01.334 ******** 2026-04-18 17:49:59.824133 | controller | ok: [controller] 2026-04-18 17:49:59.824252 | controller | 2026-04-18 17:49:59.824399 | controller | PLAY RECAP ********************************************************************* 2026-04-18 17:49:59.824554 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-18 17:49:59.824678 | controller | 2026-04-18 17:49:59.824803 | controller | 2026-04-18 17:49:59.824963 | controller | TASKS RECAP ******************************************************************** 2026-04-18 17:49:59.825104 | controller | Saturday 18 April 2026 17:49:59 +0000 (0:00:01.436) 0:00:02.771 ******** 2026-04-18 17:49:59.825227 | controller | =============================================================================== 2026-04-18 17:49:59.825353 | controller | Install Debian packages ------------------------------------------------- 1.44s 2026-04-18 17:49:59.825480 | controller | Gathering Facts --------------------------------------------------------- 1.29s 2026-04-18 17:49:59.914152 | controller | INFO [helm > prepare] Executed: Successful 2026-04-18 17:49:59.922967 | controller | INFO [helm > converge] Executing 2026-04-18 17:50:00.868306 | controller | 2026-04-18 17:50:00.868527 | controller | PLAY [Converge] **************************************************************** 2026-04-18 17:50:00.868759 | controller | 2026-04-18 17:50:00.869073 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-18 17:50:00.869293 | controller | Saturday 18 April 2026 17:50:00 +0000 (0:00:00.012) 0:00:00.012 ******** 2026-04-18 17:50:02.011563 | 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-04-18 17:50:02.016023 | controller | ok: [controller] 2026-04-18 17:50:02.016265 | controller | 2026-04-18 17:50:02.016565 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-18 17:50:02.016813 | controller | Saturday 18 April 2026 17:50:02 +0000 (0:00:01.147) 0:00:01.160 ******** 2026-04-18 17:50:02.524167 | controller | ok: [controller] 2026-04-18 17:50:02.524245 | controller | 2026-04-18 17:50:02.524264 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-18 17:50:02.524268 | controller | Saturday 18 April 2026 17:50:02 +0000 (0:00:00.506) 0:00:01.667 ******** 2026-04-18 17:50:03.781807 | controller | ok: [controller] 2026-04-18 17:50:03.781869 | controller | 2026-04-18 17:50:03.783535 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-18 17:50:03.783559 | controller | Saturday 18 April 2026 17:50:03 +0000 (0:00:01.259) 0:00:02.926 ******** 2026-04-18 17:50:04.218407 | controller | changed: [controller] 2026-04-18 17:50:04.218568 | controller | 2026-04-18 17:50:04.218781 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-18 17:50:04.218983 | controller | Saturday 18 April 2026 17:50:04 +0000 (0:00:00.436) 0:00:03.363 ******** 2026-04-18 17:50:04.269803 | controller | ok: [controller] => { 2026-04-18 17:50:04.270152 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-04-18 17:50:04.270407 | controller | } 2026-04-18 17:50:04.270643 | controller | 2026-04-18 17:50:04.270909 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-18 17:50:04.271180 | controller | Saturday 18 April 2026 17:50:04 +0000 (0:00:00.051) 0:00:03.414 ******** 2026-04-18 17:50:05.282377 | 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-04-18 17:50:05.291890 | controller | changed: [controller] 2026-04-18 17:50:05.292089 | controller | 2026-04-18 17:50:05.292470 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-18 17:50:05.292814 | controller | Saturday 18 April 2026 17:50:05 +0000 (0:00:01.022) 0:00:04.436 ******** 2026-04-18 17:50:07.434392 | controller | changed: [controller] 2026-04-18 17:50:07.434638 | controller | 2026-04-18 17:50:07.434936 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-04-18 17:50:07.435264 | controller | Saturday 18 April 2026 17:50:07 +0000 (0:00:02.142) 0:00:06.579 ******** 2026-04-18 17:50:07.991599 | controller | ok: [controller] 2026-04-18 17:50:07.991777 | controller | 2026-04-18 17:50:07.992003 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-04-18 17:50:07.992207 | controller | Saturday 18 April 2026 17:50:07 +0000 (0:00:00.556) 0:00:07.135 ******** 2026-04-18 17:50:08.443772 | controller | changed: [controller] 2026-04-18 17:50:08.443819 | controller | 2026-04-18 17:50:08.443830 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-04-18 17:50:08.443839 | controller | Saturday 18 April 2026 17:50:08 +0000 (0:00:00.452) 0:00:07.587 ******** 2026-04-18 17:50:08.927317 | controller | ok: [controller] 2026-04-18 17:50:08.927398 | controller | 2026-04-18 17:50:08.927577 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-04-18 17:50:08.927733 | controller | Saturday 18 April 2026 17:50:08 +0000 (0:00:00.484) 0:00:08.071 ******** 2026-04-18 17:50:09.247812 | controller | changed: [controller] 2026-04-18 17:50:09.247890 | controller | 2026-04-18 17:50:09.247963 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-04-18 17:50:09.248111 | controller | Saturday 18 April 2026 17:50:09 +0000 (0:00:00.317) 0:00:08.389 ******** 2026-04-18 17:50:09.551007 | controller | ok: [controller] 2026-04-18 17:50:09.551088 | controller | 2026-04-18 17:50:09.552334 | controller | TASK [Install plugin] ********************************************************** 2026-04-18 17:50:09.552356 | controller | Saturday 18 April 2026 17:50:09 +0000 (0:00:00.303) 0:00:08.693 ******** 2026-04-18 17:50:09.604223 | controller | included: vexxhost.containers.download_artifact for controller 2026-04-18 17:50:09.604241 | controller | 2026-04-18 17:50:09.604246 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-18 17:50:09.604250 | controller | Saturday 18 April 2026 17:50:09 +0000 (0:00:00.053) 0:00:08.747 ******** 2026-04-18 17:50:09.650275 | controller | ok: [controller] => { 2026-04-18 17:50:09.650484 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-04-18 17:50:09.650634 | controller | } 2026-04-18 17:50:09.651668 | controller | 2026-04-18 17:50:09.651817 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-18 17:50:09.651956 | controller | Saturday 18 April 2026 17:50:09 +0000 (0:00:00.047) 0:00:08.795 ******** 2026-04-18 17:50:10.527009 | controller | changed: [controller] 2026-04-18 17:50:10.527115 | controller | 2026-04-18 17:50:10.527376 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-18 17:50:10.527392 | controller | Saturday 18 April 2026 17:50:10 +0000 (0:00:00.876) 0:00:09.671 ******** 2026-04-18 17:50:12.659672 | controller | changed: [controller] 2026-04-18 17:50:12.659743 | controller | 2026-04-18 17:50:12.659755 | controller | PLAY RECAP ********************************************************************* 2026-04-18 17:50:12.659863 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-18 17:50:12.659943 | controller | 2026-04-18 17:50:12.660024 | controller | 2026-04-18 17:50:12.660118 | controller | TASKS RECAP ******************************************************************** 2026-04-18 17:50:12.661867 | controller | Saturday 18 April 2026 17:50:12 +0000 (0:00:02.132) 0:00:11.804 ******** 2026-04-18 17:50:12.661906 | controller | =============================================================================== 2026-04-18 17:50:12.661910 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.14s 2026-04-18 17:50:12.661914 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.13s 2026-04-18 17:50:12.661918 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.26s 2026-04-18 17:50:12.661922 | controller | Gathering Facts --------------------------------------------------------- 1.15s 2026-04-18 17:50:12.661926 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.02s 2026-04-18 17:50:12.661929 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.88s 2026-04-18 17:50:12.661933 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.56s 2026-04-18 17:50:12.661936 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.51s 2026-04-18 17:50:12.661941 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.48s 2026-04-18 17:50:12.661945 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.45s 2026-04-18 17:50:12.661960 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.44s 2026-04-18 17:50:12.661963 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.32s 2026-04-18 17:50:12.661967 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-04-18 17:50:12.661971 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-04-18 17:50:12.661975 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-18 17:50:12.661978 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-18 17:50:12.791406 | controller | INFO [helm > converge] Executed: Successful 2026-04-18 17:50:12.800061 | controller | INFO [helm > idempotence] Executing 2026-04-18 17:50:13.699792 | controller | 2026-04-18 17:50:13.700530 | controller | PLAY [Converge] **************************************************************** 2026-04-18 17:50:13.700932 | controller | 2026-04-18 17:50:13.701199 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-18 17:50:13.701464 | controller | Saturday 18 April 2026 17:50:13 +0000 (0:00:00.012) 0:00:00.012 ******** 2026-04-18 17:50:15.832687 | 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-04-18 17:50:15.837565 | controller | ok: [controller] 2026-04-18 17:50:15.837818 | controller | 2026-04-18 17:50:15.838081 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-18 17:50:15.838331 | controller | Saturday 18 April 2026 17:50:15 +0000 (0:00:02.138) 0:00:02.151 ******** 2026-04-18 17:50:16.295240 | controller | ok: [controller] 2026-04-18 17:50:16.295462 | controller | 2026-04-18 17:50:16.295692 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-18 17:50:16.295873 | controller | Saturday 18 April 2026 17:50:16 +0000 (0:00:00.457) 0:00:02.608 ******** 2026-04-18 17:50:17.341728 | controller | ok: [controller] 2026-04-18 17:50:17.342094 | controller | 2026-04-18 17:50:17.342386 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-18 17:50:17.342652 | controller | Saturday 18 April 2026 17:50:17 +0000 (0:00:01.045) 0:00:03.654 ******** 2026-04-18 17:50:17.806704 | controller | ok: [controller] 2026-04-18 17:50:17.806798 | controller | 2026-04-18 17:50:17.806809 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-18 17:50:17.806821 | controller | Saturday 18 April 2026 17:50:17 +0000 (0:00:00.463) 0:00:04.117 ******** 2026-04-18 17:50:17.850094 | controller | ok: [controller] => { 2026-04-18 17:50:17.850249 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-04-18 17:50:17.850438 | controller | } 2026-04-18 17:50:17.850547 | controller | 2026-04-18 17:50:17.850642 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-18 17:50:17.850723 | controller | Saturday 18 April 2026 17:50:17 +0000 (0:00:00.044) 0:00:04.162 ******** 2026-04-18 17:50:18.461441 | controller | ok: [controller] 2026-04-18 17:50:18.461516 | controller | 2026-04-18 17:50:18.461637 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-18 17:50:18.461763 | controller | Saturday 18 April 2026 17:50:18 +0000 (0:00:00.611) 0:00:04.774 ******** 2026-04-18 17:50:20.224125 | controller | ok: [controller] 2026-04-18 17:50:20.224201 | controller | 2026-04-18 17:50:20.224298 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-04-18 17:50:20.224433 | controller | Saturday 18 April 2026 17:50:20 +0000 (0:00:01.761) 0:00:06.535 ******** 2026-04-18 17:50:20.792501 | controller | ok: [controller] 2026-04-18 17:50:20.792561 | controller | 2026-04-18 17:50:20.792718 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-04-18 17:50:20.792850 | controller | Saturday 18 April 2026 17:50:20 +0000 (0:00:00.570) 0:00:07.105 ******** 2026-04-18 17:50:21.213967 | controller | ok: [controller] 2026-04-18 17:50:21.214044 | controller | 2026-04-18 17:50:21.214220 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-04-18 17:50:21.214392 | controller | Saturday 18 April 2026 17:50:21 +0000 (0:00:00.420) 0:00:07.526 ******** 2026-04-18 17:50:21.687040 | controller | ok: [controller] 2026-04-18 17:50:21.687112 | controller | 2026-04-18 17:50:21.687161 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-04-18 17:50:21.687262 | controller | Saturday 18 April 2026 17:50:21 +0000 (0:00:00.470) 0:00:07.997 ******** 2026-04-18 17:50:22.026714 | controller | ok: [controller] 2026-04-18 17:50:22.026771 | controller | 2026-04-18 17:50:22.026857 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-04-18 17:50:22.026947 | controller | Saturday 18 April 2026 17:50:22 +0000 (0:00:00.342) 0:00:08.340 ******** 2026-04-18 17:50:22.324679 | controller | ok: [controller] 2026-04-18 17:50:22.324706 | controller | 2026-04-18 17:50:22.324712 | controller | TASK [Install plugin] ********************************************************** 2026-04-18 17:50:22.324718 | controller | Saturday 18 April 2026 17:50:22 +0000 (0:00:00.297) 0:00:08.637 ******** 2026-04-18 17:50:22.387366 | controller | included: vexxhost.containers.download_artifact for controller 2026-04-18 17:50:22.387405 | controller | 2026-04-18 17:50:22.387410 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-18 17:50:22.387414 | controller | Saturday 18 April 2026 17:50:22 +0000 (0:00:00.059) 0:00:08.697 ******** 2026-04-18 17:50:22.436045 | controller | ok: [controller] => { 2026-04-18 17:50:22.436297 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-04-18 17:50:22.436459 | controller | } 2026-04-18 17:50:22.436609 | controller | 2026-04-18 17:50:22.436774 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-18 17:50:22.436937 | controller | Saturday 18 April 2026 17:50:22 +0000 (0:00:00.050) 0:00:08.747 ******** 2026-04-18 17:50:22.863265 | controller | ok: [controller] 2026-04-18 17:50:22.863342 | controller | 2026-04-18 17:50:22.863466 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-18 17:50:22.863655 | controller | Saturday 18 April 2026 17:50:22 +0000 (0:00:00.428) 0:00:09.176 ******** 2026-04-18 17:50:24.531673 | controller | ok: [controller] 2026-04-18 17:50:24.531731 | controller | 2026-04-18 17:50:24.531742 | controller | PLAY RECAP ********************************************************************* 2026-04-18 17:50:24.531751 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-18 17:50:24.531759 | controller | 2026-04-18 17:50:24.531766 | controller | 2026-04-18 17:50:24.531773 | controller | TASKS RECAP ******************************************************************** 2026-04-18 17:50:24.531781 | controller | Saturday 18 April 2026 17:50:24 +0000 (0:00:01.666) 0:00:10.843 ******** 2026-04-18 17:50:24.531789 | controller | =============================================================================== 2026-04-18 17:50:24.531796 | controller | Gathering Facts --------------------------------------------------------- 2.14s 2026-04-18 17:50:24.531813 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.76s 2026-04-18 17:50:24.531958 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.67s 2026-04-18 17:50:24.532273 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.05s 2026-04-18 17:50:24.532544 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.61s 2026-04-18 17:50:24.532813 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.57s 2026-04-18 17:50:24.533146 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.47s 2026-04-18 17:50:24.533429 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.46s 2026-04-18 17:50:24.533696 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.46s 2026-04-18 17:50:24.533875 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.43s 2026-04-18 17:50:24.534071 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.42s 2026-04-18 17:50:24.534261 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.34s 2026-04-18 17:50:24.534450 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-04-18 17:50:24.534627 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-04-18 17:50:24.534808 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-18 17:50:24.534984 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-18 17:50:24.639588 | controller | INFO [helm > idempotence] Executed: Successful 2026-04-18 17:50:24.648381 | controller | INFO [helm > side_effect] Executing 2026-04-18 17:50:24.648905 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 17:50:24.654794 | controller | INFO [helm > verify] Executing 2026-04-18 17:50:25.494339 | controller | 2026-04-18 17:50:25.494567 | controller | PLAY [Verify] ****************************************************************** 2026-04-18 17:50:25.494762 | controller | 2026-04-18 17:50:25.494969 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-18 17:50:25.495245 | controller | Saturday 18 April 2026 17:50:25 +0000 (0:00:00.009) 0:00:00.009 ******** 2026-04-18 17:50:26.580834 | 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-04-18 17:50:26.590425 | controller | ok: [controller] 2026-04-18 17:50:26.590612 | controller | 2026-04-18 17:50:26.590880 | controller | TASK [Get the current Helm version] ******************************************** 2026-04-18 17:50:26.591087 | controller | Saturday 18 April 2026 17:50:26 +0000 (0:00:01.094) 0:00:01.103 ******** 2026-04-18 17:50:27.056737 | controller | changed: [controller] 2026-04-18 17:50:27.056828 | controller | 2026-04-18 17:50:27.056986 | controller | TASK [Assert Helm version] ***************************************************** 2026-04-18 17:50:27.057145 | controller | Saturday 18 April 2026 17:50:27 +0000 (0:00:00.467) 0:00:01.571 ******** 2026-04-18 17:50:27.086926 | controller | ok: [controller] => { 2026-04-18 17:50:27.087082 | controller | "changed": false, 2026-04-18 17:50:27.087311 | controller | "msg": "All assertions passed" 2026-04-18 17:50:27.087401 | controller | } 2026-04-18 17:50:27.087628 | controller | 2026-04-18 17:50:27.087768 | controller | PLAY RECAP ********************************************************************* 2026-04-18 17:50:27.087938 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-18 17:50:27.088073 | controller | 2026-04-18 17:50:27.088209 | controller | 2026-04-18 17:50:27.088358 | controller | TASKS RECAP ******************************************************************** 2026-04-18 17:50:27.088516 | controller | Saturday 18 April 2026 17:50:27 +0000 (0:00:00.030) 0:00:01.602 ******** 2026-04-18 17:50:27.088661 | controller | =============================================================================== 2026-04-18 17:50:27.088813 | controller | Gathering Facts --------------------------------------------------------- 1.09s 2026-04-18 17:50:27.088967 | controller | Get the current Helm version -------------------------------------------- 0.47s 2026-04-18 17:50:27.089119 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-04-18 17:50:27.171778 | controller | INFO [helm > verify] Executed: Successful 2026-04-18 17:50:27.181630 | controller | INFO [helm > cleanup] Executing 2026-04-18 17:50:27.182030 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 17:50:27.188889 | controller | INFO [helm > destroy] Executing 2026-04-18 17:50:27.188915 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-04-18 17:50:27.188986 | controller | INFO [helm > destroy] Executed: Successful 2026-04-18 17:50:27.189234 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-04-18 17:50:27.726852 | controller | ok: Runtime: 0:00:53.252074 2026-04-18 17:50:28.290041 | 2026-04-18 17:50:28.290182 | PLAY RECAP 2026-04-18 17:50:28.290232 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 17:50:28.290256 | 2026-04-18 17:50:28.431519 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-18 17:50:28.435305 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-04-18 17:50:29.090800 | 2026-04-18 17:50:29.090963 | PLAY [all] 2026-04-18 17:50:29.104326 | 2026-04-18 17:50:29.104440 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-18 17:50:29.558025 | controller | changed 2026-04-18 17:50:29.562625 | 2026-04-18 17:50:29.562710 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-18 17:50:29.952506 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-18 17:50:29.952975 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-18 17:50:29.959135 | controller | environment: line 1: kubectl: command not found 2026-04-18 17:50:29.960278 | controller | environment: line 1: kubectl: command not found 2026-04-18 17:50:29.960353 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-18 17:50:29.962526 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-18 17:50:29.965072 | controller | environment: line 1: kubectl: command not found 2026-04-18 17:50:29.966060 | controller | environment: line 1: kubectl: command not found 2026-04-18 17:50:29.966066 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-18 17:50:29.968171 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-18 17:50:29.970577 | controller | environment: line 1: kubectl: command not found 2026-04-18 17:50:29.972309 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-18 17:50:30.108442 | controller | ok: Runtime: 0:00:00.034483 2026-04-18 17:50:30.112885 | 2026-04-18 17:50:30.112980 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-18 17:50:30.346705 | controller | changed 2026-04-18 17:50:30.354789 | 2026-04-18 17:50:30.354907 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-18 17:50:30.613204 | controller | environment: line 5: kubectl: command not found 2026-04-18 17:50:30.615005 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-18 17:50:30.615151 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-18 17:50:30.615869 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-18 17:50:30.890014 | controller | ok: Runtime: 0:00:00.013401 2026-04-18 17:50:30.901478 | 2026-04-18 17:50:30.901637 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-18 17:50:31.572775 | controller | changed: 2026-04-18 17:50:31.573055 | controller | created directory /var/lib/zuul/builds/5b7269cb552841099be6baf637de3187/work/logs/controller 2026-04-18 17:50:31.573109 | controller | cd+++++++++ objects/ 2026-04-18 17:50:31.573143 | controller | cd+++++++++ objects/cluster/ 2026-04-18 17:50:31.573175 | controller | cd+++++++++ objects/namespaced/ 2026-04-18 17:50:31.583872 | 2026-04-18 17:50:31.583948 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-18 17:50:31.831022 | controller | changed 2026-04-18 17:50:31.836489 | 2026-04-18 17:50:31.836558 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-18 17:50:32.069096 | controller | changed 2026-04-18 17:50:32.075611 | 2026-04-18 17:50:32.075765 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-18 17:50:32.321450 | controller | environment: line 3: kubectl: command not found 2026-04-18 17:50:32.607772 | controller | ok: Runtime: 0:00:00.013810 2026-04-18 17:50:32.613590 | 2026-04-18 17:50:32.613679 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-18 17:50:33.146024 | controller | changed: 2026-04-18 17:50:33.146196 | controller | cd+++++++++ pod-logs/ 2026-04-18 17:50:33.146225 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-04-18 17:50:33.156606 | 2026-04-18 17:50:33.156683 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-18 17:50:33.399155 | controller | changed: "values" 2026-04-18 17:50:33.626037 | controller | changed: "releases" 2026-04-18 17:50:33.640449 | 2026-04-18 17:50:33.640605 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-18 17:50:33.881495 | controller | /bin/bash: line 3: kubectl: command not found 2026-04-18 17:50:34.167384 | controller | ok: Runtime: 0:00:00.008740 2026-04-18 17:50:34.173390 | 2026-04-18 17:50:34.173510 | TASK [helm-release-status : Downloads logs to executor] 2026-04-18 17:50:34.800621 | controller | changed: 2026-04-18 17:50:34.800815 | controller | cd+++++++++ helm/ 2026-04-18 17:50:34.800856 | controller | cd+++++++++ helm/releases/ 2026-04-18 17:50:34.800892 | controller | cd+++++++++ helm/values/ 2026-04-18 17:50:34.807858 | 2026-04-18 17:50:34.807939 | PLAY RECAP 2026-04-18 17:50:34.808006 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 17:50:34.808038 | 2026-04-18 17:50:34.955349 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-04-18 17:50:34.957444 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 17:50:35.642570 | 2026-04-18 17:50:35.642772 | PLAY [all] 2026-04-18 17:50:35.659013 | 2026-04-18 17:50:35.659219 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-18 17:50:35.707821 | controller | skipping: Conditional result was False 2026-04-18 17:50:35.715049 | 2026-04-18 17:50:35.715148 | TASK [fetch-output : Set log path for single node] 2026-04-18 17:50:35.756867 | controller | ok 2026-04-18 17:50:35.763600 | 2026-04-18 17:50:35.763724 | LOOP [fetch-output : Ensure local output dirs] 2026-04-18 17:50:36.976746 | controller -> localhost | ok: "/var/lib/zuul/builds/5b7269cb552841099be6baf637de3187/work/logs" 2026-04-18 17:50:37.176276 | controller -> localhost | changed: "/var/lib/zuul/builds/5b7269cb552841099be6baf637de3187/work/artifacts" 2026-04-18 17:50:37.406339 | controller -> localhost | changed: "/var/lib/zuul/builds/5b7269cb552841099be6baf637de3187/work/docs" 2026-04-18 17:50:37.415758 | 2026-04-18 17:50:37.415899 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-18 17:50:38.094951 | controller | changed: .d..t...... ./ 2026-04-18 17:50:38.095240 | controller | changed: All items complete 2026-04-18 17:50:38.095281 | 2026-04-18 17:50:38.608716 | controller | changed: .d..t...... ./ 2026-04-18 17:50:39.118553 | controller | changed: .d..t...... ./ 2026-04-18 17:50:39.132653 | 2026-04-18 17:50:39.132785 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-18 17:50:39.753283 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.139019 2026-04-18 17:50:39.973078 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007392 2026-04-18 17:50:39.987031 | 2026-04-18 17:50:39.987177 | PLAY [all] 2026-04-18 17:50:39.992577 | 2026-04-18 17:50:39.992646 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-18 17:50:40.553200 | controller | changed 2026-04-18 17:50:40.558961 | 2026-04-18 17:50:40.559010 | PLAY RECAP 2026-04-18 17:50:40.559056 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-18 17:50:40.559079 | 2026-04-18 17:50:40.713094 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 17:50:40.719535 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-18 17:50:41.296831 | 2026-04-18 17:50:41.690314 | PLAY [localhost] 2026-04-18 17:50:41.706853 | 2026-04-18 17:50:41.707027 | TASK [Generate Zuul manifest] 2026-04-18 17:50:41.730879 | localhost | ok 2026-04-18 17:50:41.750511 | 2026-04-18 17:50:41.750656 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-18 17:50:42.108257 | localhost | changed 2026-04-18 17:50:42.123927 | 2026-04-18 17:50:42.124057 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-18 17:50:42.178140 | localhost | ok 2026-04-18 17:50:42.185879 | 2026-04-18 17:50:42.185984 | TASK [Upload logs] 2026-04-18 17:50:42.206788 | localhost | ok 2026-04-18 17:50:42.281871 | 2026-04-18 17:50:42.282032 | TASK [Set zuul-log-path fact] 2026-04-18 17:50:42.307009 | localhost | ok 2026-04-18 17:50:42.322199 | 2026-04-18 17:50:42.322335 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 17:50:42.354938 | localhost | ok 2026-04-18 17:50:42.366546 | 2026-04-18 17:50:42.366661 | TASK [upload-logs : Create log directories] 2026-04-18 17:50:42.880176 | localhost | changed 2026-04-18 17:50:42.888835 | 2026-04-18 17:50:42.889068 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-18 17:50:43.286817 | localhost -> localhost | ok: Runtime: 0:00:00.003057 2026-04-18 17:50:43.297759 | 2026-04-18 17:50:43.297851 | TASK [upload-logs : Upload logs to log server] 2026-04-18 17:50:44.782980 | localhost | Output suppressed because no_log was given 2026-04-18 17:50:44.786940 | 2026-04-18 17:50:44.787006 | LOOP [upload-logs : Compress console log and json output] 2026-04-18 17:50:44.827678 | localhost | skipping: Conditional result was False 2026-04-18 17:50:44.834666 | localhost | skipping: Conditional result was False 2026-04-18 17:50:44.850469 | 2026-04-18 17:50:44.850623 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-18 17:50:44.892834 | localhost | skipping: Conditional result was False 2026-04-18 17:50:44.896144 | 2026-04-18 17:50:44.903914 | localhost | skipping: Conditional result was False 2026-04-18 17:50:44.913440 | 2026-04-18 17:50:44.913604 | LOOP [upload-logs : Upload console log and json output]