2026-03-31 20:42:10.048494 | Job console starting 2026-03-31 20:42:10.057321 | Updating git repos 2026-03-31 20:42:10.108691 | Cloning repos into workspace 2026-03-31 20:42:10.157099 | Restoring repo states 2026-03-31 20:42:10.260592 | Merging changes 2026-03-31 20:42:11.025278 | Checking out repos 2026-03-31 20:42:11.276496 | Preparing playbooks 2026-03-31 20:42:13.301739 | Running Ansible setup 2026-03-31 20:42:17.107103 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-31 20:42:17.716035 | 2026-03-31 20:42:17.716184 | PLAY [localhost] 2026-03-31 20:42:17.724518 | 2026-03-31 20:42:17.724637 | TASK [Gathering Facts] 2026-03-31 20:42:18.614380 | localhost | ok 2026-03-31 20:42:18.621519 | 2026-03-31 20:42:18.621645 | TASK [Setup log path fact] 2026-03-31 20:42:18.642016 | localhost | ok 2026-03-31 20:42:18.655225 | 2026-03-31 20:42:18.655298 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-31 20:42:18.686835 | localhost | ok 2026-03-31 20:42:18.695060 | 2026-03-31 20:42:18.695179 | TASK [emit-job-header : Print job information] 2026-03-31 20:42:18.736901 | # Job Information 2026-03-31 20:42:18.737109 | Ansible Version: 2.16.16 2026-03-31 20:42:18.737155 | Job: ansible-collection-kubernetes-molecule-helm 2026-03-31 20:42:18.737185 | Pipeline: check 2026-03-31 20:42:18.737213 | Executor: 0a8996d2b663 2026-03-31 20:42:18.737240 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/257 2026-03-31 20:42:18.737271 | Event ID: edea1060-2d41-11f1-9a8d-d7514915862e 2026-03-31 20:42:18.741192 | 2026-03-31 20:42:18.741284 | LOOP [emit-job-header : Print node information] 2026-03-31 20:42:18.833367 | localhost | ok: 2026-03-31 20:42:18.833641 | localhost | # Node Information 2026-03-31 20:42:18.833671 | localhost | Inventory Hostname: controller 2026-03-31 20:42:18.833694 | localhost | Hostname: np0000161993 2026-03-31 20:42:18.833713 | localhost | Username: zuul 2026-03-31 20:42:18.833735 | localhost | Distro: Debian 13.4 2026-03-31 20:42:18.833755 | localhost | Provider: yul1 2026-03-31 20:42:18.833774 | localhost | Region: ca-ymq-1 2026-03-31 20:42:18.833793 | localhost | Label: debian-trixie 2026-03-31 20:42:18.833812 | localhost | Product Name: OpenStack Nova 2026-03-31 20:42:18.833831 | localhost | Interface IP: 199.19.213.200 2026-03-31 20:42:18.846611 | 2026-03-31 20:42:18.846756 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-31 20:42:19.224355 | localhost -> localhost | changed 2026-03-31 20:42:19.230826 | 2026-03-31 20:42:19.230902 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-31 20:42:20.127860 | localhost -> localhost | changed 2026-03-31 20:42:20.134325 | 2026-03-31 20:42:20.134385 | PLAY [all] 2026-03-31 20:42:20.141567 | 2026-03-31 20:42:20.141633 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-31 20:42:20.368416 | controller -> localhost | ok 2026-03-31 20:42:20.378218 | 2026-03-31 20:42:20.378372 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-31 20:42:20.412852 | controller | ok 2026-03-31 20:42:20.427440 | controller | included: /var/lib/zuul/builds/8cc79ae58ce24b1681573ba41971dedc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-31 20:42:20.432292 | 2026-03-31 20:42:20.432356 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-31 20:42:22.084327 | controller -> localhost | Generating public/private rsa key pair. 2026-03-31 20:42:22.084640 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/8cc79ae58ce24b1681573ba41971dedc/work/8cc79ae58ce24b1681573ba41971dedc_id_rsa 2026-03-31 20:42:22.084706 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/8cc79ae58ce24b1681573ba41971dedc/work/8cc79ae58ce24b1681573ba41971dedc_id_rsa.pub 2026-03-31 20:42:22.084757 | controller -> localhost | The key fingerprint is: 2026-03-31 20:42:22.084805 | controller -> localhost | SHA256:IWHAjWVoAzrj4zkrmftaT3pPS06ZwzMucu7+yOwmzw0 zuul-build-sshkey 2026-03-31 20:42:22.084868 | controller -> localhost | The key's randomart image is: 2026-03-31 20:42:22.084915 | controller -> localhost | +---[RSA 3072]----+ 2026-03-31 20:42:22.085043 | controller -> localhost | | .o.*= | 2026-03-31 20:42:22.085140 | controller -> localhost | | . *o.. | 2026-03-31 20:42:22.085192 | controller -> localhost | |+ . .. . | 2026-03-31 20:42:22.085239 | controller -> localhost | |.o . . | 2026-03-31 20:42:22.085284 | controller -> localhost | | o S | 2026-03-31 20:42:22.085328 | controller -> localhost | |. o . o | 2026-03-31 20:42:22.085372 | controller -> localhost | | *. E @ | 2026-03-31 20:42:22.085416 | controller -> localhost | |+.=B=X = | 2026-03-31 20:42:22.085465 | controller -> localhost | |+=o%%+B | 2026-03-31 20:42:22.085508 | controller -> localhost | +----[SHA256]-----+ 2026-03-31 20:42:22.085607 | controller -> localhost | ok: Runtime: 0:00:01.229644 2026-03-31 20:42:22.091285 | 2026-03-31 20:42:22.091528 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-31 20:42:22.125619 | controller | ok 2026-03-31 20:42:22.134303 | controller | included: /var/lib/zuul/builds/8cc79ae58ce24b1681573ba41971dedc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-31 20:42:22.141382 | 2026-03-31 20:42:22.141446 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-31 20:42:22.165313 | controller | skipping: Conditional result was False 2026-03-31 20:42:22.175756 | 2026-03-31 20:42:22.175907 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-31 20:42:22.786890 | controller | changed 2026-03-31 20:42:22.791669 | 2026-03-31 20:42:22.791742 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-31 20:42:23.015981 | controller | ok 2026-03-31 20:42:23.021392 | 2026-03-31 20:42:23.021460 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-31 20:42:23.552016 | controller | changed 2026-03-31 20:42:23.558566 | 2026-03-31 20:42:23.558639 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-31 20:42:24.125529 | controller | changed 2026-03-31 20:42:24.133765 | 2026-03-31 20:42:24.133845 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-31 20:42:24.159317 | controller | skipping: Conditional result was False 2026-03-31 20:42:24.168619 | 2026-03-31 20:42:24.168759 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-31 20:42:24.537715 | controller -> localhost | changed 2026-03-31 20:42:24.551828 | 2026-03-31 20:42:24.552072 | TASK [add-build-sshkey : Add back temp key] 2026-03-31 20:42:24.826786 | controller -> localhost | Identity added: /var/lib/zuul/builds/8cc79ae58ce24b1681573ba41971dedc/work/8cc79ae58ce24b1681573ba41971dedc_id_rsa (zuul-build-sshkey) 2026-03-31 20:42:24.827038 | controller -> localhost | ok: Runtime: 0:00:00.014279 2026-03-31 20:42:24.832412 | 2026-03-31 20:42:24.832498 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-31 20:42:25.159743 | controller | ok 2026-03-31 20:42:25.165429 | 2026-03-31 20:42:25.165533 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-31 20:42:25.191746 | controller | skipping: Conditional result was False 2026-03-31 20:42:25.204421 | 2026-03-31 20:42:25.204515 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-31 20:42:25.570464 | controller | ok 2026-03-31 20:42:25.575497 | 2026-03-31 20:42:25.575675 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-31 20:42:26.608880 | controller | Output suppressed because no_log was given 2026-03-31 20:42:26.617493 | 2026-03-31 20:42:26.617566 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-31 20:42:26.843448 | controller | ok: "logs" 2026-03-31 20:42:26.843813 | controller | ok: All items complete 2026-03-31 20:42:26.843872 | 2026-03-31 20:42:27.029341 | controller | ok: "artifacts" 2026-03-31 20:42:27.219830 | controller | ok: "docs" 2026-03-31 20:42:27.238040 | 2026-03-31 20:42:27.238195 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-31 20:42:27.461484 | controller | changed: "logs" 2026-03-31 20:42:27.660991 | controller | changed: "artifacts" 2026-03-31 20:42:27.854929 | controller | changed: "docs" 2026-03-31 20:42:27.869568 | 2026-03-31 20:42:27.869731 | PLAY RECAP 2026-03-31 20:42:27.870089 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-31 20:42:27.870145 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 20:42:27.870174 | 2026-03-31 20:42:28.079512 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-31 20:42:28.080827 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-31 20:42:28.655258 | 2026-03-31 20:42:28.655384 | PLAY [all] 2026-03-31 20:42:28.665760 | 2026-03-31 20:42:28.665842 | TASK [setup-uv : Extract archive] 2026-03-31 20:42:31.007732 | controller | changed 2026-03-31 20:42:31.016468 | 2026-03-31 20:42:31.016560 | TASK [setup-uv : Print version] 2026-03-31 20:42:31.394694 | controller | uv 0.8.13 2026-03-31 20:42:31.545419 | controller | ok: Runtime: 0:00:00.014147 2026-03-31 20:42:31.554050 | 2026-03-31 20:42:31.554105 | PLAY RECAP 2026-03-31 20:42:31.554154 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 20:42:31.554179 | 2026-03-31 20:42:31.683506 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-31 20:42:31.686084 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-31 20:42:32.280137 | 2026-03-31 20:42:32.280264 | PLAY [all] 2026-03-31 20:42:32.289875 | 2026-03-31 20:42:32.289944 | TASK [Update apt cache] 2026-03-31 20:42:37.409953 | controller | ok 2026-03-31 20:42:37.416625 | 2026-03-31 20:42:37.416706 | TASK [Disable firewalld] 2026-03-31 20:42:37.442308 | controller | skipping: Conditional result was False 2026-03-31 20:42:37.452504 | 2026-03-31 20:42:37.452574 | TASK [Install "jq" for log collection] 2026-03-31 20:42:40.183979 | controller | changed 2026-03-31 20:42:40.186266 | 2026-03-31 20:42:40.186332 | PLAY RECAP 2026-03-31 20:42:40.186391 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-31 20:42:40.186421 | 2026-03-31 20:42:40.297812 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-31 20:42:40.300586 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-31 20:42:40.868889 | 2026-03-31 20:42:40.869037 | PLAY [all] 2026-03-31 20:42:40.878948 | 2026-03-31 20:42:40.879021 | TASK [Copy inventory file for Zuul] 2026-03-31 20:42:41.826039 | controller | changed 2026-03-31 20:42:41.834024 | 2026-03-31 20:42:41.834171 | TASK [Switch "ansible_host" to private IP] 2026-03-31 20:42:42.155624 | controller | changed: 1 replacements made 2026-03-31 20:42:42.160178 | 2026-03-31 20:42:42.160240 | TASK [Run Molecule scenario] 2026-03-31 20:42:42.617229 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-31 20:42:42.617345 | controller | Creating virtual environment at: .venv 2026-03-31 20:42:43.163223 | controller | Downloading pygments (1.2MiB) 2026-03-31 20:42:43.163393 | controller | Downloading ansible-core (2.3MiB) 2026-03-31 20:42:43.163812 | controller | Downloading cryptography (4.3MiB) 2026-03-31 20:42:43.318721 | controller | Downloading cryptography 2026-03-31 20:42:43.374708 | controller | Downloading pygments 2026-03-31 20:42:43.577200 | controller | Downloading ansible-core 2026-03-31 20:42:43.621900 | controller | Installed 36 packages in 43ms 2026-03-31 20:42:44.278959 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-31 20:42:44.279033 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-31 20:42:45.186611 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-31 20:42:45.186672 | controller | INFO default scenario not found, disabling shared state. 2026-03-31 20:42:45.186788 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-31 20:42:45.186865 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-03-31 20:43:01.987329 | controller | INFO [helm > dependency] Executing 2026-03-31 20:43:01.987403 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-03-31 20:43:01.987610 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-03-31 20:43:01.987744 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-31 20:43:01.993169 | controller | INFO [helm > cleanup] Executing 2026-03-31 20:43:01.993498 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-31 20:43:01.998794 | controller | INFO [helm > destroy] Executing 2026-03-31 20:43:01.998824 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-31 20:43:01.998927 | controller | INFO [helm > destroy] Executed: Successful 2026-03-31 20:43:02.004149 | controller | INFO [helm > syntax] Executing 2026-03-31 20:43:02.968978 | controller | 2026-03-31 20:43:02.969008 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-03-31 20:43:03.043923 | controller | INFO [helm > syntax] Executed: Successful 2026-03-31 20:43:03.055610 | controller | INFO [helm > create] Executing 2026-03-31 20:43:03.057477 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-31 20:43:03.063790 | controller | INFO [helm > prepare] Executing 2026-03-31 20:43:03.925079 | controller | 2026-03-31 20:43:03.925137 | controller | PLAY [Prepare] ***************************************************************** 2026-03-31 20:43:03.925144 | controller | 2026-03-31 20:43:03.925149 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-31 20:43:03.925155 | controller | Tuesday 31 March 2026 20:43:03 +0000 (0:00:00.029) 0:00:00.029 ********* 2026-03-31 20:43:05.195888 | 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-31 20:43:05.202927 | controller | ok: [controller] 2026-03-31 20:43:05.203125 | controller | 2026-03-31 20:43:05.203345 | controller | TASK [Install Debian packages] ************************************************* 2026-03-31 20:43:05.203561 | controller | Tuesday 31 March 2026 20:43:05 +0000 (0:00:01.277) 0:00:01.306 ********* 2026-03-31 20:43:07.019627 | controller | ok: [controller] 2026-03-31 20:43:07.019776 | controller | 2026-03-31 20:43:07.020009 | controller | PLAY RECAP ********************************************************************* 2026-03-31 20:43:07.020234 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-31 20:43:07.020414 | controller | 2026-03-31 20:43:07.020594 | controller | 2026-03-31 20:43:07.020863 | controller | TASKS RECAP ******************************************************************** 2026-03-31 20:43:07.021171 | controller | Tuesday 31 March 2026 20:43:07 +0000 (0:00:01.819) 0:00:03.126 ********* 2026-03-31 20:43:07.021395 | controller | =============================================================================== 2026-03-31 20:43:07.021596 | controller | Install Debian packages ------------------------------------------------- 1.82s 2026-03-31 20:43:07.021821 | controller | Gathering Facts --------------------------------------------------------- 1.28s 2026-03-31 20:43:07.143828 | controller | INFO [helm > prepare] Executed: Successful 2026-03-31 20:43:07.153149 | controller | INFO [helm > converge] Executing 2026-03-31 20:43:08.088151 | controller | 2026-03-31 20:43:08.088232 | controller | PLAY [Converge] **************************************************************** 2026-03-31 20:43:08.088416 | controller | 2026-03-31 20:43:08.088627 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-31 20:43:08.088831 | controller | Tuesday 31 March 2026 20:43:08 +0000 (0:00:00.013) 0:00:00.013 ********* 2026-03-31 20:43:09.160868 | 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-31 20:43:09.167672 | controller | ok: [controller] 2026-03-31 20:43:09.167818 | controller | 2026-03-31 20:43:09.168007 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-31 20:43:09.168197 | controller | Tuesday 31 March 2026 20:43:09 +0000 (0:00:01.079) 0:00:01.093 ********* 2026-03-31 20:43:09.672980 | controller | ok: [controller] 2026-03-31 20:43:09.673015 | controller | 2026-03-31 20:43:09.673020 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-31 20:43:09.673024 | controller | Tuesday 31 March 2026 20:43:09 +0000 (0:00:00.502) 0:00:01.596 ********* 2026-03-31 20:43:11.072780 | controller | ok: [controller] 2026-03-31 20:43:11.072984 | controller | 2026-03-31 20:43:11.073234 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-31 20:43:11.073538 | controller | Tuesday 31 March 2026 20:43:11 +0000 (0:00:01.400) 0:00:02.996 ********* 2026-03-31 20:43:11.519927 | controller | changed: [controller] 2026-03-31 20:43:11.520139 | controller | 2026-03-31 20:43:11.520382 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-31 20:43:11.520604 | controller | Tuesday 31 March 2026 20:43:11 +0000 (0:00:00.448) 0:00:03.445 ********* 2026-03-31 20:43:11.569196 | controller | ok: [controller] => { 2026-03-31 20:43:11.569292 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-31 20:43:11.569435 | controller | } 2026-03-31 20:43:11.569546 | controller | 2026-03-31 20:43:11.569727 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-31 20:43:11.569906 | controller | Tuesday 31 March 2026 20:43:11 +0000 (0:00:00.049) 0:00:03.494 ********* 2026-03-31 20:43:12.645324 | 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-31 20:43:12.654160 | controller | changed: [controller] 2026-03-31 20:43:12.654334 | controller | 2026-03-31 20:43:12.654550 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-31 20:43:12.654748 | controller | Tuesday 31 March 2026 20:43:12 +0000 (0:00:01.084) 0:00:04.579 ********* 2026-03-31 20:43:14.794404 | controller | changed: [controller] 2026-03-31 20:43:14.794448 | controller | 2026-03-31 20:43:14.794458 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-31 20:43:14.794467 | controller | Tuesday 31 March 2026 20:43:14 +0000 (0:00:02.136) 0:00:06.715 ********* 2026-03-31 20:43:15.324999 | controller | ok: [controller] 2026-03-31 20:43:15.325085 | controller | 2026-03-31 20:43:15.325091 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-31 20:43:15.325177 | controller | Tuesday 31 March 2026 20:43:15 +0000 (0:00:00.530) 0:00:07.246 ********* 2026-03-31 20:43:15.765738 | controller | changed: [controller] 2026-03-31 20:43:15.765767 | controller | 2026-03-31 20:43:15.765775 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-31 20:43:15.765782 | controller | Tuesday 31 March 2026 20:43:15 +0000 (0:00:00.442) 0:00:07.688 ********* 2026-03-31 20:43:16.225013 | controller | ok: [controller] 2026-03-31 20:43:16.225108 | controller | 2026-03-31 20:43:16.225255 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-31 20:43:16.225389 | controller | Tuesday 31 March 2026 20:43:16 +0000 (0:00:00.462) 0:00:08.151 ********* 2026-03-31 20:43:16.535945 | controller | changed: [controller] 2026-03-31 20:43:16.536103 | controller | 2026-03-31 20:43:16.536346 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-31 20:43:16.536565 | controller | Tuesday 31 March 2026 20:43:16 +0000 (0:00:00.310) 0:00:08.461 ********* 2026-03-31 20:43:16.830950 | controller | ok: [controller] 2026-03-31 20:43:16.831020 | controller | 2026-03-31 20:43:16.831146 | controller | TASK [Install plugin] ********************************************************** 2026-03-31 20:43:16.831282 | controller | Tuesday 31 March 2026 20:43:16 +0000 (0:00:00.295) 0:00:08.756 ********* 2026-03-31 20:43:16.884287 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-31 20:43:16.884368 | controller | 2026-03-31 20:43:16.884375 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-31 20:43:16.884441 | controller | Tuesday 31 March 2026 20:43:16 +0000 (0:00:00.053) 0:00:08.810 ********* 2026-03-31 20:43:16.932690 | controller | ok: [controller] => { 2026-03-31 20:43:16.932773 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-31 20:43:16.932786 | controller | } 2026-03-31 20:43:16.932955 | controller | 2026-03-31 20:43:16.933266 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-31 20:43:16.933302 | controller | Tuesday 31 March 2026 20:43:16 +0000 (0:00:00.045) 0:00:08.856 ********* 2026-03-31 20:43:17.769564 | controller | changed: [controller] 2026-03-31 20:43:17.769627 | controller | 2026-03-31 20:43:17.769641 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-31 20:43:17.769760 | controller | Tuesday 31 March 2026 20:43:17 +0000 (0:00:00.836) 0:00:09.692 ********* 2026-03-31 20:43:19.940341 | controller | changed: [controller] 2026-03-31 20:43:19.940385 | controller | 2026-03-31 20:43:19.940394 | controller | PLAY RECAP ********************************************************************* 2026-03-31 20:43:19.940405 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-31 20:43:19.940414 | controller | 2026-03-31 20:43:19.940422 | controller | 2026-03-31 20:43:19.940429 | controller | TASKS RECAP ******************************************************************** 2026-03-31 20:43:19.940437 | controller | Tuesday 31 March 2026 20:43:19 +0000 (0:00:02.169) 0:00:11.861 ********* 2026-03-31 20:43:19.940444 | controller | =============================================================================== 2026-03-31 20:43:19.940451 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.17s 2026-03-31 20:43:19.940456 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.14s 2026-03-31 20:43:19.940461 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.40s 2026-03-31 20:43:19.940466 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.08s 2026-03-31 20:43:19.940471 | controller | Gathering Facts --------------------------------------------------------- 1.08s 2026-03-31 20:43:19.940476 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.84s 2026-03-31 20:43:19.940480 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.53s 2026-03-31 20:43:19.940485 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.50s 2026-03-31 20:43:19.940489 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.46s 2026-03-31 20:43:19.940494 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.45s 2026-03-31 20:43:19.940512 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.44s 2026-03-31 20:43:19.940516 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-03-31 20:43:19.940521 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-03-31 20:43:19.940525 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-03-31 20:43:19.940530 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-31 20:43:19.940534 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-31 20:43:20.094694 | controller | INFO [helm > converge] Executed: Successful 2026-03-31 20:43:20.106233 | controller | INFO [helm > idempotence] Executing 2026-03-31 20:43:21.049113 | controller | 2026-03-31 20:43:21.049474 | controller | PLAY [Converge] **************************************************************** 2026-03-31 20:43:21.049724 | controller | 2026-03-31 20:43:21.049979 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-31 20:43:21.050233 | controller | Tuesday 31 March 2026 20:43:21 +0000 (0:00:00.015) 0:00:00.015 ********* 2026-03-31 20:43:22.123873 | 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-31 20:43:22.129164 | controller | ok: [controller] 2026-03-31 20:43:22.129557 | controller | 2026-03-31 20:43:22.129953 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-31 20:43:22.130265 | controller | Tuesday 31 March 2026 20:43:22 +0000 (0:00:01.080) 0:00:01.096 ********* 2026-03-31 20:43:22.581445 | controller | ok: [controller] 2026-03-31 20:43:22.585618 | controller | 2026-03-31 20:43:22.585858 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-31 20:43:22.586057 | controller | Tuesday 31 March 2026 20:43:22 +0000 (0:00:00.451) 0:00:01.548 ********* 2026-03-31 20:43:23.627448 | controller | ok: [controller] 2026-03-31 20:43:23.627737 | controller | 2026-03-31 20:43:23.628012 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-31 20:43:23.628338 | controller | Tuesday 31 March 2026 20:43:23 +0000 (0:00:01.045) 0:00:02.593 ********* 2026-03-31 20:43:24.080656 | controller | ok: [controller] 2026-03-31 20:43:24.080680 | controller | 2026-03-31 20:43:24.080684 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-31 20:43:24.080688 | controller | Tuesday 31 March 2026 20:43:24 +0000 (0:00:00.451) 0:00:03.045 ********* 2026-03-31 20:43:24.120866 | controller | ok: [controller] => { 2026-03-31 20:43:24.121146 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-31 20:43:24.121313 | controller | } 2026-03-31 20:43:24.121469 | controller | 2026-03-31 20:43:24.121637 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-31 20:43:24.121799 | controller | Tuesday 31 March 2026 20:43:24 +0000 (0:00:00.040) 0:00:03.086 ********* 2026-03-31 20:43:24.637476 | controller | ok: [controller] 2026-03-31 20:43:24.637554 | controller | 2026-03-31 20:43:24.637765 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-31 20:43:24.637881 | controller | Tuesday 31 March 2026 20:43:24 +0000 (0:00:00.516) 0:00:03.602 ********* 2026-03-31 20:43:27.393674 | controller | ok: [controller] 2026-03-31 20:43:27.393718 | controller | 2026-03-31 20:43:27.393808 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-31 20:43:27.393912 | controller | Tuesday 31 March 2026 20:43:27 +0000 (0:00:02.757) 0:00:06.359 ********* 2026-03-31 20:43:27.948453 | controller | ok: [controller] 2026-03-31 20:43:27.948504 | controller | 2026-03-31 20:43:27.948655 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-31 20:43:27.948806 | controller | Tuesday 31 March 2026 20:43:27 +0000 (0:00:00.552) 0:00:06.912 ********* 2026-03-31 20:43:28.364553 | controller | ok: [controller] 2026-03-31 20:43:28.364608 | controller | 2026-03-31 20:43:28.364709 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-31 20:43:28.364812 | controller | Tuesday 31 March 2026 20:43:28 +0000 (0:00:00.415) 0:00:07.328 ********* 2026-03-31 20:43:28.853872 | controller | ok: [controller] 2026-03-31 20:43:28.853957 | controller | 2026-03-31 20:43:28.854118 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-31 20:43:28.854249 | controller | Tuesday 31 March 2026 20:43:28 +0000 (0:00:00.491) 0:00:07.820 ********* 2026-03-31 20:43:29.150749 | controller | ok: [controller] 2026-03-31 20:43:29.150799 | controller | 2026-03-31 20:43:29.150910 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-31 20:43:29.151031 | controller | Tuesday 31 March 2026 20:43:29 +0000 (0:00:00.296) 0:00:08.117 ********* 2026-03-31 20:43:29.453350 | controller | ok: [controller] 2026-03-31 20:43:29.453403 | controller | 2026-03-31 20:43:29.453494 | controller | TASK [Install plugin] ********************************************************** 2026-03-31 20:43:29.453602 | controller | Tuesday 31 March 2026 20:43:29 +0000 (0:00:00.300) 0:00:08.418 ********* 2026-03-31 20:43:29.505222 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-31 20:43:29.505277 | controller | 2026-03-31 20:43:29.505384 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-31 20:43:29.505463 | controller | Tuesday 31 March 2026 20:43:29 +0000 (0:00:00.054) 0:00:08.472 ********* 2026-03-31 20:43:29.548834 | controller | ok: [controller] => { 2026-03-31 20:43:29.548896 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-31 20:43:29.549008 | controller | } 2026-03-31 20:43:29.549315 | controller | 2026-03-31 20:43:29.549341 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-31 20:43:29.549346 | controller | Tuesday 31 March 2026 20:43:29 +0000 (0:00:00.043) 0:00:08.515 ********* 2026-03-31 20:43:30.000096 | controller | ok: [controller] 2026-03-31 20:43:30.000144 | controller | 2026-03-31 20:43:30.000204 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-31 20:43:30.000361 | controller | Tuesday 31 March 2026 20:43:29 +0000 (0:00:00.447) 0:00:08.963 ********* 2026-03-31 20:43:32.647382 | controller | ok: [controller] 2026-03-31 20:43:32.647421 | controller | 2026-03-31 20:43:32.647427 | controller | PLAY RECAP ********************************************************************* 2026-03-31 20:43:32.647432 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-31 20:43:32.647437 | controller | 2026-03-31 20:43:32.647441 | controller | 2026-03-31 20:43:32.647445 | controller | TASKS RECAP ******************************************************************** 2026-03-31 20:43:32.647449 | controller | Tuesday 31 March 2026 20:43:32 +0000 (0:00:02.645) 0:00:11.609 ********* 2026-03-31 20:43:32.647453 | controller | =============================================================================== 2026-03-31 20:43:32.647457 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.76s 2026-03-31 20:43:32.647461 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.65s 2026-03-31 20:43:32.647465 | controller | Gathering Facts --------------------------------------------------------- 1.08s 2026-03-31 20:43:32.647469 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.05s 2026-03-31 20:43:32.647472 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.55s 2026-03-31 20:43:32.647475 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.52s 2026-03-31 20:43:32.647478 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.49s 2026-03-31 20:43:32.647481 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.45s 2026-03-31 20:43:32.647486 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.45s 2026-03-31 20:43:32.647489 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.45s 2026-03-31 20:43:32.647503 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.42s 2026-03-31 20:43:32.647506 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-03-31 20:43:32.647509 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.30s 2026-03-31 20:43:32.647512 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-03-31 20:43:32.647515 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-31 20:43:32.647519 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-31 20:43:32.755252 | controller | INFO [helm > idempotence] Executed: Successful 2026-03-31 20:43:32.761389 | controller | INFO [helm > side_effect] Executing 2026-03-31 20:43:32.761741 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-31 20:43:32.767081 | controller | INFO [helm > verify] Executing 2026-03-31 20:43:33.648743 | controller | 2026-03-31 20:43:33.649298 | controller | PLAY [Verify] ****************************************************************** 2026-03-31 20:43:33.649556 | controller | 2026-03-31 20:43:33.649830 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-31 20:43:33.650116 | controller | Tuesday 31 March 2026 20:43:33 +0000 (0:00:00.009) 0:00:00.010 ********* 2026-03-31 20:43:34.695042 | 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-31 20:43:34.702683 | controller | ok: [controller] 2026-03-31 20:43:34.702945 | controller | 2026-03-31 20:43:34.703205 | controller | TASK [Get the current Helm version] ******************************************** 2026-03-31 20:43:34.703460 | controller | Tuesday 31 March 2026 20:43:34 +0000 (0:00:01.051) 0:00:01.061 ********* 2026-03-31 20:43:35.128567 | controller | changed: [controller] 2026-03-31 20:43:35.128973 | controller | 2026-03-31 20:43:35.129324 | controller | TASK [Assert Helm version] ***************************************************** 2026-03-31 20:43:35.129632 | controller | Tuesday 31 March 2026 20:43:35 +0000 (0:00:00.428) 0:00:01.489 ********* 2026-03-31 20:43:35.155644 | controller | ok: [controller] => { 2026-03-31 20:43:35.155937 | controller | "changed": false, 2026-03-31 20:43:35.156215 | controller | "msg": "All assertions passed" 2026-03-31 20:43:35.156477 | controller | } 2026-03-31 20:43:35.156729 | controller | 2026-03-31 20:43:35.157037 | controller | PLAY RECAP ********************************************************************* 2026-03-31 20:43:35.157381 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-31 20:43:35.157715 | controller | 2026-03-31 20:43:35.158053 | controller | 2026-03-31 20:43:35.158409 | controller | TASKS RECAP ******************************************************************** 2026-03-31 20:43:35.158777 | controller | Tuesday 31 March 2026 20:43:35 +0000 (0:00:00.027) 0:00:01.517 ********* 2026-03-31 20:43:35.159047 | controller | =============================================================================== 2026-03-31 20:43:35.159336 | controller | Gathering Facts --------------------------------------------------------- 1.05s 2026-03-31 20:43:35.159626 | controller | Get the current Helm version -------------------------------------------- 0.43s 2026-03-31 20:43:35.159914 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-03-31 20:43:35.256998 | controller | INFO [helm > verify] Executed: Successful 2026-03-31 20:43:35.265153 | controller | INFO [helm > cleanup] Executing 2026-03-31 20:43:35.265483 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-31 20:43:35.270991 | controller | INFO [helm > destroy] Executing 2026-03-31 20:43:35.271100 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-31 20:43:35.271190 | controller | INFO [helm > destroy] Executed: Successful 2026-03-31 20:43:35.271581 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-31 20:43:35.767717 | controller | ok: Runtime: 0:00:52.804487 2026-03-31 20:43:35.774158 | 2026-03-31 20:43:35.774216 | PLAY RECAP 2026-03-31 20:43:35.774267 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 20:43:35.774290 | 2026-03-31 20:43:35.957994 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-31 20:43:35.959341 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-31 20:43:36.571119 | 2026-03-31 20:43:36.571270 | PLAY [all] 2026-03-31 20:43:36.582271 | 2026-03-31 20:43:36.582352 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-31 20:43:36.998832 | controller | changed 2026-03-31 20:43:37.003368 | 2026-03-31 20:43:37.003452 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-31 20:43:37.419309 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuexargs: 2026-03-31 20:43:37.419425 | controller | warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 20:43:37.426996 | controller | environment: line 1: kubectl: command not found 2026-03-31 20:43:37.428219 | controller | environment: line 1: kubectl: command not found 2026-03-31 20:43:37.428786 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 20:43:37.430577 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 20:43:37.433019 | controller | environment: line 1: kubectl: command not found 2026-03-31 20:43:37.433707 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 20:43:37.434681 | controller | environment: line 1: kubectl: command not found 2026-03-31 20:43:37.436369 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 20:43:37.437234 | controller | environment: line 1: kubectl: command not found 2026-03-31 20:43:37.439207 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 20:43:37.535261 | controller | ok: Runtime: 0:00:00.033205 2026-03-31 20:43:37.542401 | 2026-03-31 20:43:37.542532 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-31 20:43:37.788506 | controller | changed 2026-03-31 20:43:37.793789 | 2026-03-31 20:43:37.793915 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-31 20:43:38.034487 | controller | environment: line 5: kubectl: command not found 2026-03-31 20:43:38.035436 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 20:43:38.036321 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 20:43:38.036445 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 20:43:38.324893 | controller | ok: Runtime: 0:00:00.015674 2026-03-31 20:43:38.332518 | 2026-03-31 20:43:38.332589 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-31 20:43:39.043158 | controller | changed: 2026-03-31 20:43:39.043394 | controller | created directory /var/lib/zuul/builds/8cc79ae58ce24b1681573ba41971dedc/work/logs/controller 2026-03-31 20:43:39.043447 | controller | cd+++++++++ objects/ 2026-03-31 20:43:39.043480 | controller | cd+++++++++ objects/cluster/ 2026-03-31 20:43:39.043511 | controller | cd+++++++++ objects/namespaced/ 2026-03-31 20:43:39.052537 | 2026-03-31 20:43:39.052625 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-31 20:43:39.298454 | controller | changed 2026-03-31 20:43:39.303144 | 2026-03-31 20:43:39.303207 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-31 20:43:39.547168 | controller | changed 2026-03-31 20:43:39.552273 | 2026-03-31 20:43:39.552345 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-31 20:43:39.794098 | controller | environment: line 3: kubectl: command not found 2026-03-31 20:43:40.083909 | controller | ok: Runtime: 0:00:00.012787 2026-03-31 20:43:40.089939 | 2026-03-31 20:43:40.090106 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-31 20:43:40.633005 | controller | changed: 2026-03-31 20:43:40.633229 | controller | cd+++++++++ pod-logs/ 2026-03-31 20:43:40.633272 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-03-31 20:43:40.641727 | 2026-03-31 20:43:40.641795 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-31 20:43:40.887749 | controller | changed: "values" 2026-03-31 20:43:41.097826 | controller | changed: "releases" 2026-03-31 20:43:41.109888 | 2026-03-31 20:43:41.110052 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-31 20:43:41.366238 | controller | /bin/bash: line 3: kubectl: command not found 2026-03-31 20:43:41.639377 | controller | ok: Runtime: 0:00:00.009100 2026-03-31 20:43:41.645782 | 2026-03-31 20:43:41.645845 | TASK [helm-release-status : Downloads logs to executor] 2026-03-31 20:43:42.183870 | controller | changed: 2026-03-31 20:43:42.184112 | controller | cd+++++++++ helm/ 2026-03-31 20:43:42.184166 | controller | cd+++++++++ helm/releases/ 2026-03-31 20:43:42.184209 | controller | cd+++++++++ helm/values/ 2026-03-31 20:43:42.191084 | 2026-03-31 20:43:42.191153 | PLAY RECAP 2026-03-31 20:43:42.191216 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 20:43:42.191246 | 2026-03-31 20:43:42.321946 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-31 20:43:42.325075 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-31 20:43:42.918421 | 2026-03-31 20:43:42.918586 | PLAY [all] 2026-03-31 20:43:42.929060 | 2026-03-31 20:43:42.929147 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-31 20:43:42.975516 | controller | skipping: Conditional result was False 2026-03-31 20:43:42.984581 | 2026-03-31 20:43:42.984670 | TASK [fetch-output : Set log path for single node] 2026-03-31 20:43:43.027466 | controller | ok 2026-03-31 20:43:43.032368 | 2026-03-31 20:43:43.032460 | LOOP [fetch-output : Ensure local output dirs] 2026-03-31 20:43:43.432917 | controller -> localhost | ok: "/var/lib/zuul/builds/8cc79ae58ce24b1681573ba41971dedc/work/logs" 2026-03-31 20:43:43.658670 | controller -> localhost | changed: "/var/lib/zuul/builds/8cc79ae58ce24b1681573ba41971dedc/work/artifacts" 2026-03-31 20:43:43.894711 | controller -> localhost | changed: "/var/lib/zuul/builds/8cc79ae58ce24b1681573ba41971dedc/work/docs" 2026-03-31 20:43:43.911414 | 2026-03-31 20:43:43.911615 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-31 20:43:44.604358 | controller | changed: .d..t...... ./ 2026-03-31 20:43:44.604784 | controller | changed: All items complete 2026-03-31 20:43:44.604848 | 2026-03-31 20:43:45.104698 | controller | changed: .d..t...... ./ 2026-03-31 20:43:45.638962 | controller | changed: .d..t...... ./ 2026-03-31 20:43:45.661138 | 2026-03-31 20:43:45.661280 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-31 20:43:46.082136 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.009180 2026-03-31 20:43:46.314411 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.009183 2026-03-31 20:43:46.330265 | 2026-03-31 20:43:46.330399 | PLAY [all] 2026-03-31 20:43:46.336738 | 2026-03-31 20:43:46.336805 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-31 20:43:46.802836 | controller | changed 2026-03-31 20:43:46.808151 | 2026-03-31 20:43:46.808201 | PLAY RECAP 2026-03-31 20:43:46.808247 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-31 20:43:46.808268 | 2026-03-31 20:43:46.915493 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-31 20:43:46.918514 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-31 20:43:47.512431 | 2026-03-31 20:43:47.513067 | PLAY [localhost] 2026-03-31 20:43:47.523130 | 2026-03-31 20:43:47.523206 | TASK [Generate Zuul manifest] 2026-03-31 20:43:47.544269 | localhost | ok 2026-03-31 20:43:47.559730 | 2026-03-31 20:43:47.559865 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-31 20:43:47.933508 | localhost | changed 2026-03-31 20:43:47.946076 | 2026-03-31 20:43:47.946166 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-31 20:43:47.976852 | localhost | ok 2026-03-31 20:43:47.986198 | 2026-03-31 20:43:47.986288 | TASK [Upload logs] 2026-03-31 20:43:48.006138 | localhost | ok 2026-03-31 20:43:48.065132 | 2026-03-31 20:43:48.065257 | TASK [Set zuul-log-path fact] 2026-03-31 20:43:48.084429 | localhost | ok 2026-03-31 20:43:48.098634 | 2026-03-31 20:43:48.098721 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-31 20:43:48.142347 | localhost | ok 2026-03-31 20:43:48.150186 | 2026-03-31 20:43:48.150253 | TASK [upload-logs : Create log directories] 2026-03-31 20:43:48.538752 | localhost | changed 2026-03-31 20:43:48.544095 | 2026-03-31 20:43:48.544165 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-31 20:43:48.941954 | localhost -> localhost | ok: Runtime: 0:00:00.004717 2026-03-31 20:43:48.948941 | 2026-03-31 20:43:48.949076 | TASK [upload-logs : Upload logs to log server] 2026-03-31 20:43:49.448598 | localhost | Output suppressed because no_log was given 2026-03-31 20:43:49.452500 | 2026-03-31 20:43:49.452570 | LOOP [upload-logs : Compress console log and json output] 2026-03-31 20:43:49.495255 | localhost | skipping: Conditional result was False 2026-03-31 20:43:49.508173 | localhost | skipping: Conditional result was False 2026-03-31 20:43:49.529034 | 2026-03-31 20:43:49.529224 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-31 20:43:49.574842 | localhost | skipping: Conditional result was False 2026-03-31 20:43:49.575271 | 2026-03-31 20:43:49.579140 | localhost | skipping: Conditional result was False 2026-03-31 20:43:49.596157 | 2026-03-31 20:43:49.596351 | LOOP [upload-logs : Upload console log and json output]