2026-03-30 20:39:51.109877 | Job console starting 2026-03-30 20:39:51.174515 | Updating git repos 2026-03-30 20:39:51.285888 | Cloning repos into workspace 2026-03-30 20:39:51.754693 | Restoring repo states 2026-03-30 20:39:51.780483 | Merging changes 2026-03-30 20:39:53.091598 | Checking out repos 2026-03-30 20:39:53.602213 | Preparing playbooks 2026-03-30 20:40:04.890054 | Running Ansible setup 2026-03-30 20:40:08.462062 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-30 20:40:09.080844 | 2026-03-30 20:40:09.080992 | PLAY [localhost] 2026-03-30 20:40:09.088636 | 2026-03-30 20:40:09.088713 | TASK [Gathering Facts] 2026-03-30 20:40:10.289432 | localhost | ok 2026-03-30 20:40:10.300338 | 2026-03-30 20:40:10.300417 | TASK [Setup log path fact] 2026-03-30 20:40:10.321866 | localhost | ok 2026-03-30 20:40:10.334283 | 2026-03-30 20:40:10.334346 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-30 20:40:10.362587 | localhost | ok 2026-03-30 20:40:10.369329 | 2026-03-30 20:40:10.369410 | TASK [emit-job-header : Print job information] 2026-03-30 20:40:10.411348 | # Job Information 2026-03-30 20:40:10.411500 | Ansible Version: 2.16.16 2026-03-30 20:40:10.411545 | Job: ansible-collection-kubernetes-molecule-helm 2026-03-30 20:40:10.411576 | Pipeline: check 2026-03-30 20:40:10.411604 | Executor: 0a8996d2b663 2026-03-30 20:40:10.411631 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/253 2026-03-30 20:40:10.411661 | Event ID: 72ab1b70-2c78-11f1-9d5c-027bdbc6d977 2026-03-30 20:40:10.417497 | 2026-03-30 20:40:10.417598 | LOOP [emit-job-header : Print node information] 2026-03-30 20:40:10.518061 | localhost | ok: 2026-03-30 20:40:10.518760 | localhost | # Node Information 2026-03-30 20:40:10.518856 | localhost | Inventory Hostname: controller 2026-03-30 20:40:10.518888 | localhost | Hostname: np0000161637 2026-03-30 20:40:10.518969 | localhost | Username: zuul 2026-03-30 20:40:10.519027 | localhost | Distro: Debian 13.4 2026-03-30 20:40:10.519056 | localhost | Provider: yul1 2026-03-30 20:40:10.519076 | localhost | Region: ca-ymq-1 2026-03-30 20:40:10.519094 | localhost | Label: debian-trixie 2026-03-30 20:40:10.519113 | localhost | Product Name: OpenStack Nova 2026-03-30 20:40:10.519231 | localhost | Interface IP: 199.204.45.35 2026-03-30 20:40:10.536763 | 2026-03-30 20:40:10.536876 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-30 20:40:10.938024 | localhost -> localhost | changed 2026-03-30 20:40:10.946254 | 2026-03-30 20:40:10.946360 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-30 20:40:12.042744 | localhost -> localhost | changed 2026-03-30 20:40:12.048865 | 2026-03-30 20:40:12.048926 | PLAY [all] 2026-03-30 20:40:12.055638 | 2026-03-30 20:40:12.055702 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-30 20:40:12.282645 | controller -> localhost | ok 2026-03-30 20:40:12.288978 | 2026-03-30 20:40:12.289388 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-30 20:40:12.321607 | controller | ok 2026-03-30 20:40:12.336789 | controller | included: /var/lib/zuul/builds/d068e32fdd15434ea20618d457e2dae9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-30 20:40:12.341575 | 2026-03-30 20:40:12.341636 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-30 20:40:13.193256 | controller -> localhost | Generating public/private rsa key pair. 2026-03-30 20:40:13.193476 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/d068e32fdd15434ea20618d457e2dae9/work/d068e32fdd15434ea20618d457e2dae9_id_rsa 2026-03-30 20:40:13.193518 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/d068e32fdd15434ea20618d457e2dae9/work/d068e32fdd15434ea20618d457e2dae9_id_rsa.pub 2026-03-30 20:40:13.193549 | controller -> localhost | The key fingerprint is: 2026-03-30 20:40:13.193578 | controller -> localhost | SHA256:/V0hQxnzubH0GL3nSq2F3BxzzFr2xG+GU8RMLYKAvU8 zuul-build-sshkey 2026-03-30 20:40:13.193623 | controller -> localhost | The key's randomart image is: 2026-03-30 20:40:13.193653 | controller -> localhost | +---[RSA 3072]----+ 2026-03-30 20:40:13.193688 | controller -> localhost | | o.. . +o o| 2026-03-30 20:40:13.193719 | controller -> localhost | | . . . o.+=o| 2026-03-30 20:40:13.193747 | controller -> localhost | | . +.B=| 2026-03-30 20:40:13.193775 | controller -> localhost | | ..E +BB| 2026-03-30 20:40:13.193802 | controller -> localhost | | So. .*&| 2026-03-30 20:40:13.193830 | controller -> localhost | | .. o #B| 2026-03-30 20:40:13.193857 | controller -> localhost | | . O @| 2026-03-30 20:40:13.193884 | controller -> localhost | | . B | 2026-03-30 20:40:13.193915 | controller -> localhost | | o | 2026-03-30 20:40:13.193943 | controller -> localhost | +----[SHA256]-----+ 2026-03-30 20:40:13.194003 | controller -> localhost | ok: Runtime: 0:00:00.433526 2026-03-30 20:40:13.199630 | 2026-03-30 20:40:13.199692 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-30 20:40:13.231857 | controller | ok 2026-03-30 20:40:13.239690 | controller | included: /var/lib/zuul/builds/d068e32fdd15434ea20618d457e2dae9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-30 20:40:13.247164 | 2026-03-30 20:40:13.247232 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-30 20:40:13.272548 | controller | skipping: Conditional result was False 2026-03-30 20:40:13.281259 | 2026-03-30 20:40:13.281322 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-30 20:40:13.811175 | controller | changed 2026-03-30 20:40:13.815381 | 2026-03-30 20:40:13.815444 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-30 20:40:14.031391 | controller | ok 2026-03-30 20:40:14.605771 | 2026-03-30 20:40:14.605876 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-30 20:40:15.123704 | controller | changed 2026-03-30 20:40:15.129580 | 2026-03-30 20:40:15.129682 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-30 20:40:15.636884 | controller | changed 2026-03-30 20:40:15.642986 | 2026-03-30 20:40:15.643061 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-30 20:40:15.668304 | controller | skipping: Conditional result was False 2026-03-30 20:40:15.676021 | 2026-03-30 20:40:15.676120 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-30 20:40:16.045636 | controller -> localhost | changed 2026-03-30 20:40:16.062927 | 2026-03-30 20:40:16.063116 | TASK [add-build-sshkey : Add back temp key] 2026-03-30 20:40:16.326229 | controller -> localhost | Identity added: /var/lib/zuul/builds/d068e32fdd15434ea20618d457e2dae9/work/d068e32fdd15434ea20618d457e2dae9_id_rsa (zuul-build-sshkey) 2026-03-30 20:40:16.326534 | controller -> localhost | ok: Runtime: 0:00:00.014699 2026-03-30 20:40:16.331232 | 2026-03-30 20:40:16.331294 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-30 20:40:16.659784 | controller | ok 2026-03-30 20:40:16.666291 | 2026-03-30 20:40:16.666366 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-30 20:40:16.692235 | controller | skipping: Conditional result was False 2026-03-30 20:40:16.712059 | 2026-03-30 20:40:16.712209 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-30 20:40:17.085313 | controller | ok 2026-03-30 20:40:17.091998 | 2026-03-30 20:40:17.092066 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-30 20:40:18.063960 | controller | Output suppressed because no_log was given 2026-03-30 20:40:18.071117 | 2026-03-30 20:40:18.071185 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-30 20:40:20.276579 | controller | ok: "logs" 2026-03-30 20:40:20.277029 | controller | ok: All items complete 2026-03-30 20:40:20.277097 | 2026-03-30 20:40:20.464566 | controller | ok: "artifacts" 2026-03-30 20:40:20.647039 | controller | ok: "docs" 2026-03-30 20:40:20.658350 | 2026-03-30 20:40:20.658512 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-30 20:40:20.876741 | controller | changed: "logs" 2026-03-30 20:40:21.063833 | controller | changed: "artifacts" 2026-03-30 20:40:21.246473 | controller | changed: "docs" 2026-03-30 20:40:21.268520 | 2026-03-30 20:40:21.268660 | PLAY RECAP 2026-03-30 20:40:21.268723 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-30 20:40:21.268763 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-30 20:40:21.268791 | 2026-03-30 20:40:21.408037 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-30 20:40:21.409844 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-30 20:40:22.020407 | 2026-03-30 20:40:22.020981 | PLAY [all] 2026-03-30 20:40:22.033836 | 2026-03-30 20:40:22.033963 | TASK [setup-uv : Extract archive] 2026-03-30 20:40:24.404325 | controller | changed 2026-03-30 20:40:24.412157 | 2026-03-30 20:40:24.412231 | TASK [setup-uv : Print version] 2026-03-30 20:40:24.801211 | controller | uv 0.8.13 2026-03-30 20:40:24.941878 | controller | ok: Runtime: 0:00:00.013865 2026-03-30 20:40:24.949297 | 2026-03-30 20:40:24.949397 | PLAY RECAP 2026-03-30 20:40:24.949442 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-30 20:40:24.949467 | 2026-03-30 20:40:25.098279 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-30 20:40:25.100342 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-30 20:40:25.682736 | 2026-03-30 20:40:25.682889 | PLAY [all] 2026-03-30 20:40:25.693910 | 2026-03-30 20:40:25.694005 | TASK [Update apt cache] 2026-03-30 20:40:30.252490 | controller | ok 2026-03-30 20:40:30.259677 | 2026-03-30 20:40:30.259806 | TASK [Disable firewalld] 2026-03-30 20:40:30.285882 | controller | skipping: Conditional result was False 2026-03-30 20:40:30.293455 | 2026-03-30 20:40:30.293544 | TASK [Install "jq" for log collection] 2026-03-30 20:40:32.299566 | controller | changed 2026-03-30 20:40:32.302165 | 2026-03-30 20:40:32.302237 | PLAY RECAP 2026-03-30 20:40:32.302473 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-30 20:40:32.302503 | 2026-03-30 20:40:32.440860 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-30 20:40:32.443671 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-30 20:40:32.995725 | 2026-03-30 20:40:32.995874 | PLAY [all] 2026-03-30 20:40:33.006526 | 2026-03-30 20:40:33.006600 | TASK [Copy inventory file for Zuul] 2026-03-30 20:40:33.949855 | controller | changed 2026-03-30 20:40:33.955857 | 2026-03-30 20:40:33.955965 | TASK [Switch "ansible_host" to private IP] 2026-03-30 20:40:34.251357 | controller | changed: 1 replacements made 2026-03-30 20:40:34.257618 | 2026-03-30 20:40:34.257706 | TASK [Run Molecule scenario] 2026-03-30 20:40:34.716443 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-30 20:40:34.716589 | controller | Creating virtual environment at: .venv 2026-03-30 20:40:34.978185 | controller | Downloading pygments (1.2MiB) 2026-03-30 20:40:34.978423 | controller | Downloading cryptography (4.3MiB) 2026-03-30 20:40:34.978667 | controller | Downloading ansible-core (2.3MiB) 2026-03-30 20:40:35.135737 | controller | Downloading cryptography 2026-03-30 20:40:35.185048 | controller | Downloading pygments 2026-03-30 20:40:35.338697 | controller | Downloading ansible-core 2026-03-30 20:40:35.386597 | controller | Installed 36 packages in 47ms 2026-03-30 20:40:36.060968 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-30 20:40:36.061047 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-30 20:40:36.906942 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-30 20:40:36.907024 | controller | INFO default scenario not found, disabling shared state. 2026-03-30 20:40:36.907089 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-30 20:40:36.907183 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-03-30 20:40:51.744670 | controller | INFO [helm > dependency] Executing 2026-03-30 20:40:51.744751 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-03-30 20:40:51.744760 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-03-30 20:40:51.744798 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-30 20:40:51.748733 | controller | INFO [helm > cleanup] Executing 2026-03-30 20:40:51.748967 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-30 20:40:51.754316 | controller | INFO [helm > destroy] Executing 2026-03-30 20:40:51.754341 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-30 20:40:51.754392 | controller | INFO [helm > destroy] Executed: Successful 2026-03-30 20:40:51.759632 | controller | INFO [helm > syntax] Executing 2026-03-30 20:40:52.634688 | controller | 2026-03-30 20:40:52.634941 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-03-30 20:40:52.694831 | controller | INFO [helm > syntax] Executed: Successful 2026-03-30 20:40:52.706713 | controller | INFO [helm > create] Executing 2026-03-30 20:40:52.708213 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-30 20:40:52.713506 | controller | INFO [helm > prepare] Executing 2026-03-30 20:40:53.558433 | controller | 2026-03-30 20:40:53.558577 | controller | PLAY [Prepare] ***************************************************************** 2026-03-30 20:40:53.558751 | controller | 2026-03-30 20:40:53.558946 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-30 20:40:53.559139 | controller | Monday 30 March 2026 20:40:53 +0000 (0:00:00.028) 0:00:00.028 ********** 2026-03-30 20:40:54.803539 | 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-30 20:40:54.809724 | controller | ok: [controller] 2026-03-30 20:40:54.809954 | controller | 2026-03-30 20:40:54.810198 | controller | TASK [Install Debian packages] ************************************************* 2026-03-30 20:40:54.810442 | controller | Monday 30 March 2026 20:40:54 +0000 (0:00:01.251) 0:00:01.280 ********** 2026-03-30 20:40:56.146060 | controller | ok: [controller] 2026-03-30 20:40:56.146197 | controller | 2026-03-30 20:40:56.146431 | controller | PLAY RECAP ********************************************************************* 2026-03-30 20:40:56.146676 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-30 20:40:56.146875 | controller | 2026-03-30 20:40:56.147070 | controller | 2026-03-30 20:40:56.147291 | controller | TASKS RECAP ******************************************************************** 2026-03-30 20:40:56.147626 | controller | Monday 30 March 2026 20:40:56 +0000 (0:00:01.336) 0:00:02.616 ********** 2026-03-30 20:40:56.147844 | controller | =============================================================================== 2026-03-30 20:40:56.148072 | controller | Install Debian packages ------------------------------------------------- 1.34s 2026-03-30 20:40:56.148294 | controller | Gathering Facts --------------------------------------------------------- 1.25s 2026-03-30 20:40:56.249777 | controller | INFO [helm > prepare] Executed: Successful 2026-03-30 20:40:56.257760 | controller | INFO [helm > converge] Executing 2026-03-30 20:40:57.123948 | controller | 2026-03-30 20:40:57.124106 | controller | PLAY [Converge] **************************************************************** 2026-03-30 20:40:57.124281 | controller | 2026-03-30 20:40:57.124487 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-30 20:40:57.124680 | controller | Monday 30 March 2026 20:40:57 +0000 (0:00:00.012) 0:00:00.012 ********** 2026-03-30 20:40:58.188057 | 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-30 20:40:58.196351 | controller | ok: [controller] 2026-03-30 20:40:58.196549 | controller | 2026-03-30 20:40:58.196729 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-30 20:40:58.196931 | controller | Monday 30 March 2026 20:40:58 +0000 (0:00:01.069) 0:00:01.082 ********** 2026-03-30 20:40:58.692102 | controller | ok: [controller] 2026-03-30 20:40:58.692159 | controller | 2026-03-30 20:40:58.692349 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-30 20:40:58.692438 | controller | Monday 30 March 2026 20:40:58 +0000 (0:00:00.495) 0:00:01.577 ********** 2026-03-30 20:40:59.716313 | controller | ok: [controller] 2026-03-30 20:40:59.716432 | controller | 2026-03-30 20:40:59.716709 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-30 20:40:59.716902 | controller | Monday 30 March 2026 20:40:59 +0000 (0:00:01.027) 0:00:02.604 ********** 2026-03-30 20:41:00.137037 | controller | changed: [controller] 2026-03-30 20:41:00.137205 | controller | 2026-03-30 20:41:00.137517 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-30 20:41:00.137680 | controller | Monday 30 March 2026 20:41:00 +0000 (0:00:00.420) 0:00:03.025 ********** 2026-03-30 20:41:00.193293 | controller | ok: [controller] => { 2026-03-30 20:41:00.193453 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-30 20:41:00.193651 | controller | } 2026-03-30 20:41:00.193734 | controller | 2026-03-30 20:41:00.193959 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-30 20:41:00.194115 | controller | Monday 30 March 2026 20:41:00 +0000 (0:00:00.056) 0:00:03.081 ********** 2026-03-30 20:41:00.946957 | 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-30 20:41:00.957513 | controller | changed: [controller] 2026-03-30 20:41:00.957700 | controller | 2026-03-30 20:41:00.957884 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-30 20:41:00.958092 | controller | Monday 30 March 2026 20:41:00 +0000 (0:00:00.764) 0:00:03.846 ********** 2026-03-30 20:41:03.011460 | controller | changed: [controller] 2026-03-30 20:41:03.011519 | controller | 2026-03-30 20:41:03.011529 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-30 20:41:03.011537 | controller | Monday 30 March 2026 20:41:03 +0000 (0:00:02.049) 0:00:05.896 ********** 2026-03-30 20:41:03.543441 | controller | ok: [controller] 2026-03-30 20:41:03.543571 | controller | 2026-03-30 20:41:03.543776 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-30 20:41:03.543966 | controller | Monday 30 March 2026 20:41:03 +0000 (0:00:00.535) 0:00:06.431 ********** 2026-03-30 20:41:03.947785 | controller | changed: [controller] 2026-03-30 20:41:03.947852 | controller | 2026-03-30 20:41:03.951372 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-30 20:41:03.951388 | controller | Monday 30 March 2026 20:41:03 +0000 (0:00:00.404) 0:00:06.836 ********** 2026-03-30 20:41:04.415088 | controller | ok: [controller] 2026-03-30 20:41:04.415206 | controller | 2026-03-30 20:41:04.415476 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-30 20:41:04.415698 | controller | Monday 30 March 2026 20:41:04 +0000 (0:00:00.467) 0:00:07.303 ********** 2026-03-30 20:41:04.727144 | controller | changed: [controller] 2026-03-30 20:41:04.727279 | controller | 2026-03-30 20:41:04.727527 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-30 20:41:04.727728 | controller | Monday 30 March 2026 20:41:04 +0000 (0:00:00.311) 0:00:07.615 ********** 2026-03-30 20:41:05.034370 | controller | ok: [controller] 2026-03-30 20:41:05.034418 | controller | 2026-03-30 20:41:05.034427 | controller | TASK [Install plugin] ********************************************************** 2026-03-30 20:41:05.034435 | controller | Monday 30 March 2026 20:41:05 +0000 (0:00:00.306) 0:00:07.922 ********** 2026-03-30 20:41:05.092396 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-30 20:41:05.092417 | controller | 2026-03-30 20:41:05.092426 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-30 20:41:05.092434 | controller | Monday 30 March 2026 20:41:05 +0000 (0:00:00.058) 0:00:07.981 ********** 2026-03-30 20:41:05.145020 | controller | ok: [controller] => { 2026-03-30 20:41:05.145382 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-30 20:41:05.145625 | controller | } 2026-03-30 20:41:05.145875 | controller | 2026-03-30 20:41:05.146125 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-30 20:41:05.146369 | controller | Monday 30 March 2026 20:41:05 +0000 (0:00:00.052) 0:00:08.033 ********** 2026-03-30 20:41:05.872842 | controller | changed: [controller] 2026-03-30 20:41:05.873184 | controller | 2026-03-30 20:41:05.873463 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-30 20:41:05.873723 | controller | Monday 30 March 2026 20:41:05 +0000 (0:00:00.726) 0:00:08.760 ********** 2026-03-30 20:41:08.028024 | controller | changed: [controller] 2026-03-30 20:41:08.028380 | controller | 2026-03-30 20:41:08.028655 | controller | PLAY RECAP ********************************************************************* 2026-03-30 20:41:08.028996 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-30 20:41:08.029257 | controller | 2026-03-30 20:41:08.029399 | controller | 2026-03-30 20:41:08.029553 | controller | TASKS RECAP ******************************************************************** 2026-03-30 20:41:08.029708 | controller | Monday 30 March 2026 20:41:08 +0000 (0:00:02.154) 0:00:10.915 ********** 2026-03-30 20:41:08.029855 | controller | =============================================================================== 2026-03-30 20:41:08.030027 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.15s 2026-03-30 20:41:08.030198 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.05s 2026-03-30 20:41:08.030358 | controller | Gathering Facts --------------------------------------------------------- 1.07s 2026-03-30 20:41:08.030511 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.03s 2026-03-30 20:41:08.030665 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.76s 2026-03-30 20:41:08.030819 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.73s 2026-03-30 20:41:08.030972 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.54s 2026-03-30 20:41:08.031125 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.50s 2026-03-30 20:41:08.031278 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.47s 2026-03-30 20:41:08.031477 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s 2026-03-30 20:41:08.031652 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.40s 2026-03-30 20:41:08.031814 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-03-30 20:41:08.031976 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.31s 2026-03-30 20:41:08.032126 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-30 20:41:08.032285 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s 2026-03-30 20:41:08.032455 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-30 20:41:08.149331 | controller | INFO [helm > converge] Executed: Successful 2026-03-30 20:41:08.159570 | controller | INFO [helm > idempotence] Executing 2026-03-30 20:41:09.013875 | controller | 2026-03-30 20:41:09.013923 | controller | PLAY [Converge] **************************************************************** 2026-03-30 20:41:09.013933 | controller | 2026-03-30 20:41:09.013941 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-30 20:41:09.013949 | controller | Monday 30 March 2026 20:41:09 +0000 (0:00:00.012) 0:00:00.012 ********** 2026-03-30 20:41:10.115387 | 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-30 20:41:10.121145 | controller | ok: [controller] 2026-03-30 20:41:10.121427 | controller | 2026-03-30 20:41:10.121709 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-30 20:41:10.121979 | controller | Monday 30 March 2026 20:41:10 +0000 (0:00:01.108) 0:00:01.121 ********** 2026-03-30 20:41:10.562093 | controller | ok: [controller] 2026-03-30 20:41:10.562389 | controller | 2026-03-30 20:41:10.562707 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-30 20:41:10.562966 | controller | Monday 30 March 2026 20:41:10 +0000 (0:00:00.440) 0:00:01.561 ********** 2026-03-30 20:41:11.600803 | controller | ok: [controller] 2026-03-30 20:41:11.601091 | controller | 2026-03-30 20:41:11.601354 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-30 20:41:11.601600 | controller | Monday 30 March 2026 20:41:11 +0000 (0:00:01.038) 0:00:02.600 ********** 2026-03-30 20:41:12.040972 | controller | ok: [controller] 2026-03-30 20:41:12.041266 | controller | 2026-03-30 20:41:12.041533 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-30 20:41:12.041813 | controller | Monday 30 March 2026 20:41:12 +0000 (0:00:00.440) 0:00:03.040 ********** 2026-03-30 20:41:12.087154 | controller | ok: [controller] => { 2026-03-30 20:41:12.087478 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-30 20:41:12.087740 | controller | } 2026-03-30 20:41:12.087976 | controller | 2026-03-30 20:41:12.088230 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-30 20:41:12.088531 | controller | Monday 30 March 2026 20:41:12 +0000 (0:00:00.046) 0:00:03.086 ********** 2026-03-30 20:41:12.634330 | controller | ok: [controller] 2026-03-30 20:41:12.634650 | controller | 2026-03-30 20:41:12.634921 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-30 20:41:12.635176 | controller | Monday 30 March 2026 20:41:12 +0000 (0:00:00.546) 0:00:03.633 ********** 2026-03-30 20:41:14.367937 | controller | ok: [controller] 2026-03-30 20:41:14.368034 | controller | 2026-03-30 20:41:14.368047 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-30 20:41:14.368120 | controller | Monday 30 March 2026 20:41:14 +0000 (0:00:01.731) 0:00:05.365 ********** 2026-03-30 20:41:14.881865 | controller | ok: [controller] 2026-03-30 20:41:14.881934 | controller | 2026-03-30 20:41:14.881948 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-30 20:41:14.882053 | controller | Monday 30 March 2026 20:41:14 +0000 (0:00:00.514) 0:00:05.880 ********** 2026-03-30 20:41:15.285803 | controller | ok: [controller] 2026-03-30 20:41:15.285869 | controller | 2026-03-30 20:41:15.285973 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-30 20:41:15.286141 | controller | Monday 30 March 2026 20:41:15 +0000 (0:00:00.405) 0:00:06.285 ********** 2026-03-30 20:41:15.747885 | controller | ok: [controller] 2026-03-30 20:41:15.747921 | controller | 2026-03-30 20:41:15.747925 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-30 20:41:15.747930 | controller | Monday 30 March 2026 20:41:15 +0000 (0:00:00.459) 0:00:06.744 ********** 2026-03-30 20:41:16.049399 | controller | ok: [controller] 2026-03-30 20:41:16.049456 | controller | 2026-03-30 20:41:16.049609 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-30 20:41:16.049770 | controller | Monday 30 March 2026 20:41:16 +0000 (0:00:00.304) 0:00:07.049 ********** 2026-03-30 20:41:16.347874 | controller | ok: [controller] 2026-03-30 20:41:16.347960 | controller | 2026-03-30 20:41:16.348100 | controller | TASK [Install plugin] ********************************************************** 2026-03-30 20:41:16.348226 | controller | Monday 30 March 2026 20:41:16 +0000 (0:00:00.296) 0:00:07.345 ********** 2026-03-30 20:41:16.403987 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-30 20:41:16.404015 | controller | 2026-03-30 20:41:16.404140 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-30 20:41:16.404228 | controller | Monday 30 March 2026 20:41:16 +0000 (0:00:00.058) 0:00:07.404 ********** 2026-03-30 20:41:16.455332 | controller | ok: [controller] => { 2026-03-30 20:41:16.455456 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-30 20:41:16.455530 | controller | } 2026-03-30 20:41:16.455613 | controller | 2026-03-30 20:41:16.455697 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-30 20:41:16.455778 | controller | Monday 30 March 2026 20:41:16 +0000 (0:00:00.050) 0:00:07.455 ********** 2026-03-30 20:41:16.895456 | controller | ok: [controller] 2026-03-30 20:41:16.895530 | controller | 2026-03-30 20:41:16.895539 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-30 20:41:16.895662 | controller | Monday 30 March 2026 20:41:16 +0000 (0:00:00.439) 0:00:07.895 ********** 2026-03-30 20:41:18.535915 | controller | ok: [controller] 2026-03-30 20:41:18.535974 | controller | 2026-03-30 20:41:18.539379 | controller | PLAY RECAP ********************************************************************* 2026-03-30 20:41:18.539393 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-30 20:41:18.539401 | controller | 2026-03-30 20:41:18.539409 | controller | 2026-03-30 20:41:18.539416 | controller | TASKS RECAP ******************************************************************** 2026-03-30 20:41:18.539424 | controller | Monday 30 March 2026 20:41:18 +0000 (0:00:01.637) 0:00:09.532 ********** 2026-03-30 20:41:18.539431 | controller | =============================================================================== 2026-03-30 20:41:18.539439 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.73s 2026-03-30 20:41:18.539446 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.64s 2026-03-30 20:41:18.539453 | controller | Gathering Facts --------------------------------------------------------- 1.11s 2026-03-30 20:41:18.539460 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.04s 2026-03-30 20:41:18.539467 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.55s 2026-03-30 20:41:18.539474 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.51s 2026-03-30 20:41:18.539482 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.46s 2026-03-30 20:41:18.539489 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.44s 2026-03-30 20:41:18.539497 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.44s 2026-03-30 20:41:18.539504 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.44s 2026-03-30 20:41:18.539526 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.41s 2026-03-30 20:41:18.539534 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.30s 2026-03-30 20:41:18.539541 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-03-30 20:41:18.539549 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-30 20:41:18.539556 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-30 20:41:18.539563 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-30 20:41:18.674079 | controller | INFO [helm > idempotence] Executed: Successful 2026-03-30 20:41:18.685560 | controller | INFO [helm > side_effect] Executing 2026-03-30 20:41:18.686146 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-30 20:41:18.691542 | controller | INFO [helm > verify] Executing 2026-03-30 20:41:19.524157 | controller | 2026-03-30 20:41:19.524478 | controller | PLAY [Verify] ****************************************************************** 2026-03-30 20:41:19.524710 | controller | 2026-03-30 20:41:19.524965 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-30 20:41:19.525218 | controller | Monday 30 March 2026 20:41:19 +0000 (0:00:00.009) 0:00:00.009 ********** 2026-03-30 20:41:20.629378 | 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-30 20:41:20.635940 | controller | ok: [controller] 2026-03-30 20:41:20.636227 | controller | 2026-03-30 20:41:20.636496 | controller | TASK [Get the current Helm version] ******************************************** 2026-03-30 20:41:20.636755 | controller | Monday 30 March 2026 20:41:20 +0000 (0:00:01.111) 0:00:01.121 ********** 2026-03-30 20:41:21.097618 | controller | changed: [controller] 2026-03-30 20:41:21.097902 | controller | 2026-03-30 20:41:21.098162 | controller | TASK [Assert Helm version] ***************************************************** 2026-03-30 20:41:21.098408 | controller | Monday 30 March 2026 20:41:21 +0000 (0:00:00.461) 0:00:01.582 ********** 2026-03-30 20:41:21.126693 | controller | ok: [controller] => { 2026-03-30 20:41:21.126989 | controller | "changed": false, 2026-03-30 20:41:21.127237 | controller | "msg": "All assertions passed" 2026-03-30 20:41:21.127514 | controller | } 2026-03-30 20:41:21.127740 | controller | 2026-03-30 20:41:21.127978 | controller | PLAY RECAP ********************************************************************* 2026-03-30 20:41:21.128287 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-30 20:41:21.128516 | controller | 2026-03-30 20:41:21.128736 | controller | 2026-03-30 20:41:21.128985 | controller | TASKS RECAP ******************************************************************** 2026-03-30 20:41:21.129252 | controller | Monday 30 March 2026 20:41:21 +0000 (0:00:00.029) 0:00:01.612 ********** 2026-03-30 20:41:21.129503 | controller | =============================================================================== 2026-03-30 20:41:21.129764 | controller | Gathering Facts --------------------------------------------------------- 1.11s 2026-03-30 20:41:21.130023 | controller | Get the current Helm version -------------------------------------------- 0.46s 2026-03-30 20:41:21.130282 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-03-30 20:41:21.239939 | controller | INFO [helm > verify] Executed: Successful 2026-03-30 20:41:21.251163 | controller | INFO [helm > cleanup] Executing 2026-03-30 20:41:21.251554 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-30 20:41:21.256913 | controller | INFO [helm > destroy] Executing 2026-03-30 20:41:21.257012 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-30 20:41:21.257123 | controller | INFO [helm > destroy] Executed: Successful 2026-03-30 20:41:21.257471 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-30 20:41:21.819830 | controller | ok: Runtime: 0:00:46.715734 2026-03-30 20:41:21.827953 | 2026-03-30 20:41:21.828002 | PLAY RECAP 2026-03-30 20:41:21.828045 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-30 20:41:21.828067 | 2026-03-30 20:41:21.940475 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-30 20:41:21.943366 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-30 20:41:22.535454 | 2026-03-30 20:41:22.535597 | PLAY [all] 2026-03-30 20:41:22.547089 | 2026-03-30 20:41:22.547199 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-30 20:41:22.956899 | controller | changed 2026-03-30 20:41:22.963048 | 2026-03-30 20:41:22.963153 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-30 20:41:23.344161 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 20:41:23.344270 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 20:41:23.352120 | controller | environment: line 1: kubectl: command not found 2026-03-30 20:41:23.353350 | controller | environment: line 1: kubectl: command not found 2026-03-30 20:41:23.354051 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 20:41:23.355252 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 20:41:23.359104 | controller | environment: line 1: kubectl: command not found 2026-03-30 20:41:23.360015 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 20:41:23.362474 | controller | environment: line 1: kubectl: command not found 2026-03-30 20:41:23.363980 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 20:41:23.366350 | controller | environment: line 1: kubectl: command not found 2026-03-30 20:41:23.368067 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 20:41:23.494815 | controller | ok: Runtime: 0:00:00.039732 2026-03-30 20:41:23.500820 | 2026-03-30 20:41:23.500911 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-30 20:41:23.735506 | controller | changed 2026-03-30 20:41:23.741769 | 2026-03-30 20:41:23.741871 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-30 20:41:23.993864 | controller | environment: line 5: kubectl: command not found 2026-03-30 20:41:23.995333 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 20:41:23.995663 | controller | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 20:41:23.995679 | controller | 2026-03-30 20:41:24.274460 | controller | ok: Runtime: 0:00:00.014139 2026-03-30 20:41:24.282255 | 2026-03-30 20:41:24.282332 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-30 20:41:24.975222 | controller | changed: 2026-03-30 20:41:24.975533 | controller | created directory /var/lib/zuul/builds/d068e32fdd15434ea20618d457e2dae9/work/logs/controller 2026-03-30 20:41:24.975629 | controller | cd+++++++++ objects/ 2026-03-30 20:41:24.975690 | controller | cd+++++++++ objects/cluster/ 2026-03-30 20:41:24.975748 | controller | cd+++++++++ objects/namespaced/ 2026-03-30 20:41:24.984283 | 2026-03-30 20:41:24.984461 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-30 20:41:25.232176 | controller | changed 2026-03-30 20:41:25.237853 | 2026-03-30 20:41:25.237945 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-30 20:41:25.474880 | controller | changed 2026-03-30 20:41:25.480677 | 2026-03-30 20:41:25.480762 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-30 20:41:25.718457 | controller | environment: line 3: kubectl: command not found 2026-03-30 20:41:26.014752 | controller | ok: Runtime: 0:00:00.013517 2026-03-30 20:41:26.020728 | 2026-03-30 20:41:26.020826 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-30 20:41:26.567508 | controller | changed: 2026-03-30 20:41:26.567694 | controller | cd+++++++++ pod-logs/ 2026-03-30 20:41:26.567724 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-03-30 20:41:26.574698 | 2026-03-30 20:41:26.574770 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-30 20:41:26.804523 | controller | changed: "values" 2026-03-30 20:41:27.020988 | controller | changed: "releases" 2026-03-30 20:41:27.038278 | 2026-03-30 20:41:27.038512 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-30 20:41:27.278011 | controller | /bin/bash: line 3: kubectl: command not found 2026-03-30 20:41:27.571032 | controller | ok: Runtime: 0:00:00.008572 2026-03-30 20:41:27.576131 | 2026-03-30 20:41:27.576199 | TASK [helm-release-status : Downloads logs to executor] 2026-03-30 20:41:28.144153 | controller | changed: 2026-03-30 20:41:28.144358 | controller | cd+++++++++ helm/ 2026-03-30 20:41:28.144397 | controller | cd+++++++++ helm/releases/ 2026-03-30 20:41:28.144429 | controller | cd+++++++++ helm/values/ 2026-03-30 20:41:28.150468 | 2026-03-30 20:41:28.150520 | PLAY RECAP 2026-03-30 20:41:28.150563 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-30 20:41:28.150585 | 2026-03-30 20:41:28.271784 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-30 20:41:28.274521 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-30 20:41:28.879560 | 2026-03-30 20:41:28.879926 | PLAY [all] 2026-03-30 20:41:28.890286 | 2026-03-30 20:41:28.890368 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-30 20:41:28.935972 | controller | skipping: Conditional result was False 2026-03-30 20:41:28.943127 | 2026-03-30 20:41:28.943241 | TASK [fetch-output : Set log path for single node] 2026-03-30 20:41:28.971217 | controller | ok 2026-03-30 20:41:28.978596 | 2026-03-30 20:41:28.978709 | LOOP [fetch-output : Ensure local output dirs] 2026-03-30 20:41:29.359135 | controller -> localhost | ok: "/var/lib/zuul/builds/d068e32fdd15434ea20618d457e2dae9/work/logs" 2026-03-30 20:41:29.594214 | controller -> localhost | changed: "/var/lib/zuul/builds/d068e32fdd15434ea20618d457e2dae9/work/artifacts" 2026-03-30 20:41:29.836292 | controller -> localhost | changed: "/var/lib/zuul/builds/d068e32fdd15434ea20618d457e2dae9/work/docs" 2026-03-30 20:41:29.855555 | 2026-03-30 20:41:29.855720 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-30 20:41:30.541069 | controller | changed: .d..t...... ./ 2026-03-30 20:41:30.541453 | controller | changed: All items complete 2026-03-30 20:41:30.541502 | 2026-03-30 20:41:31.057576 | controller | changed: .d..t...... ./ 2026-03-30 20:41:31.566928 | controller | changed: .d..t...... ./ 2026-03-30 20:41:31.594771 | 2026-03-30 20:41:31.594932 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-30 20:41:32.073296 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008877 2026-03-30 20:41:32.666015 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.350628 2026-03-30 20:41:32.683067 | 2026-03-30 20:41:32.683192 | PLAY [all] 2026-03-30 20:41:32.688461 | 2026-03-30 20:41:32.688564 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-30 20:41:33.158397 | controller | changed 2026-03-30 20:41:33.165446 | 2026-03-30 20:41:33.165512 | PLAY RECAP 2026-03-30 20:41:33.165569 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-30 20:41:33.165600 | 2026-03-30 20:41:33.278457 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-30 20:41:33.281424 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-30 20:41:33.850886 | 2026-03-30 20:41:33.851197 | PLAY [localhost] 2026-03-30 20:41:33.863998 | 2026-03-30 20:41:33.864080 | TASK [Generate Zuul manifest] 2026-03-30 20:41:33.887186 | localhost | ok 2026-03-30 20:41:33.906084 | 2026-03-30 20:41:33.916814 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-30 20:41:34.257697 | localhost | changed 2026-03-30 20:41:34.273027 | 2026-03-30 20:41:34.273129 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-30 20:41:34.376574 | localhost | ok 2026-03-30 20:41:34.385762 | 2026-03-30 20:41:34.385854 | TASK [Upload logs] 2026-03-30 20:41:34.405877 | localhost | ok 2026-03-30 20:41:34.468306 | 2026-03-30 20:41:34.468426 | TASK [Set zuul-log-path fact] 2026-03-30 20:41:34.491607 | localhost | ok 2026-03-30 20:41:34.506639 | 2026-03-30 20:41:34.506709 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-30 20:41:34.536866 | localhost | ok 2026-03-30 20:41:34.545294 | 2026-03-30 20:41:34.545357 | TASK [upload-logs : Create log directories] 2026-03-30 20:41:34.992121 | localhost | changed 2026-03-30 20:41:34.998553 | 2026-03-30 20:41:34.998645 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-30 20:41:35.445627 | localhost -> localhost | ok: Runtime: 0:00:00.024955 2026-03-30 20:41:35.452473 | 2026-03-30 20:41:35.452566 | TASK [upload-logs : Upload logs to log server] 2026-03-30 20:41:35.920732 | localhost | Output suppressed because no_log was given 2026-03-30 20:41:35.925545 | 2026-03-30 20:41:35.925611 | LOOP [upload-logs : Compress console log and json output] 2026-03-30 20:41:35.977671 | localhost | skipping: Conditional result was False 2026-03-30 20:41:35.984507 | localhost | skipping: Conditional result was False 2026-03-30 20:41:36.000262 | 2026-03-30 20:41:36.000440 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-30 20:41:36.039703 | localhost | skipping: Conditional result was False 2026-03-30 20:41:36.040120 | 2026-03-30 20:41:36.043714 | localhost | skipping: Conditional result was False 2026-03-30 20:41:36.054000 | 2026-03-30 20:41:36.054213 | LOOP [upload-logs : Upload console log and json output]