2026-04-22 07:16:50.447283 | Job console starting 2026-04-22 07:16:50.470662 | Updating git repos 2026-04-22 07:16:50.572821 | Cloning repos into workspace 2026-04-22 07:16:50.995611 | Restoring repo states 2026-04-22 07:16:51.016510 | Merging changes 2026-04-22 07:16:55.666418 | Checking out repos 2026-04-22 07:16:55.724931 | Preparing playbooks 2026-04-22 07:17:01.124837 | Running Ansible setup 2026-04-22 07:17:05.700434 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-22 07:17:06.302535 | 2026-04-22 07:17:06.302648 | PLAY [localhost] 2026-04-22 07:17:06.310222 | 2026-04-22 07:17:06.310291 | TASK [Gathering Facts] 2026-04-22 07:17:07.218638 | localhost | ok 2026-04-22 07:17:07.230163 | 2026-04-22 07:17:07.230259 | TASK [Setup log path fact] 2026-04-22 07:17:07.250966 | localhost | ok 2026-04-22 07:17:07.265461 | 2026-04-22 07:17:07.265527 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-22 07:17:07.293989 | localhost | ok 2026-04-22 07:17:07.306638 | 2026-04-22 07:17:07.306730 | TASK [emit-job-header : Print job information] 2026-04-22 07:17:07.351942 | # Job Information 2026-04-22 07:17:07.352073 | Ansible Version: 2.16.16 2026-04-22 07:17:07.352106 | Job: ansible-collection-kubernetes-molecule-helm 2026-04-22 07:17:07.352697 | Pipeline: check 2026-04-22 07:17:07.352725 | Executor: 0a8996d2b663 2026-04-22 07:17:07.352747 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/268 2026-04-22 07:17:07.352769 | Event ID: 0aaa7b60-3e1b-11f1-9b82-7b16981db146 2026-04-22 07:17:07.355466 | 2026-04-22 07:17:07.355532 | LOOP [emit-job-header : Print node information] 2026-04-22 07:17:07.436288 | localhost | ok: 2026-04-22 07:17:07.436472 | localhost | # Node Information 2026-04-22 07:17:07.436501 | localhost | Inventory Hostname: controller 2026-04-22 07:17:07.436523 | localhost | Hostname: np0000169226 2026-04-22 07:17:07.436543 | localhost | Username: zuul 2026-04-22 07:17:07.436570 | localhost | Distro: Debian 13.4 2026-04-22 07:17:07.436606 | localhost | Provider: yul1 2026-04-22 07:17:07.436635 | localhost | Region: ca-ymq-1 2026-04-22 07:17:07.436658 | localhost | Label: debian-trixie 2026-04-22 07:17:07.436677 | localhost | Product Name: OpenStack Nova 2026-04-22 07:17:07.436695 | localhost | Interface IP: 199.204.45.113 2026-04-22 07:17:07.456487 | 2026-04-22 07:17:07.456657 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-22 07:17:07.882690 | localhost -> localhost | changed 2026-04-22 07:17:07.887891 | 2026-04-22 07:17:07.887961 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-22 07:17:08.827327 | localhost -> localhost | changed 2026-04-22 07:17:08.846536 | 2026-04-22 07:17:08.846649 | PLAY [all] 2026-04-22 07:17:08.857778 | 2026-04-22 07:17:08.857862 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-22 07:17:09.095452 | controller -> localhost | ok 2026-04-22 07:17:09.105994 | 2026-04-22 07:17:09.106084 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-22 07:17:09.125375 | controller | ok 2026-04-22 07:17:09.140623 | controller | included: /var/lib/zuul/builds/73529512adca42909128149250014181/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-22 07:17:09.145526 | 2026-04-22 07:17:09.145606 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-22 07:17:10.542735 | controller -> localhost | Generating public/private rsa key pair. 2026-04-22 07:17:10.542940 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/73529512adca42909128149250014181/work/73529512adca42909128149250014181_id_rsa 2026-04-22 07:17:10.542982 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/73529512adca42909128149250014181/work/73529512adca42909128149250014181_id_rsa.pub 2026-04-22 07:17:10.543014 | controller -> localhost | The key fingerprint is: 2026-04-22 07:17:10.543043 | controller -> localhost | SHA256:nPdo3YWZVKrl8qUhixn4K8DkWpqDMouZykZA4JKl43Q zuul-build-sshkey 2026-04-22 07:17:10.543086 | controller -> localhost | The key's randomart image is: 2026-04-22 07:17:10.543116 | controller -> localhost | +---[RSA 3072]----+ 2026-04-22 07:17:10.543149 | controller -> localhost | |o . .| 2026-04-22 07:17:10.543178 | controller -> localhost | |.= o | 2026-04-22 07:17:10.543205 | controller -> localhost | |*o E + | 2026-04-22 07:17:10.543232 | controller -> localhost | |=.. .. o = + | 2026-04-22 07:17:10.543258 | controller -> localhost | |.. + S o + * o| 2026-04-22 07:17:10.543284 | controller -> localhost | | . = o B * = | 2026-04-22 07:17:10.543310 | controller -> localhost | |. . = . * + + | 2026-04-22 07:17:10.543337 | controller -> localhost | |=+. = .. . | 2026-04-22 07:17:10.543367 | controller -> localhost | |O= . .. | 2026-04-22 07:17:10.543394 | controller -> localhost | +----[SHA256]-----+ 2026-04-22 07:17:10.543460 | controller -> localhost | ok: Runtime: 0:00:00.594571 2026-04-22 07:17:10.549128 | 2026-04-22 07:17:10.549214 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-22 07:17:10.583259 | controller | ok 2026-04-22 07:17:10.595277 | controller | included: /var/lib/zuul/builds/73529512adca42909128149250014181/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-22 07:17:10.606193 | 2026-04-22 07:17:10.606320 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-22 07:17:10.631408 | controller | skipping: Conditional result was False 2026-04-22 07:17:10.643568 | 2026-04-22 07:17:10.643686 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-22 07:17:11.161852 | controller | changed 2026-04-22 07:17:11.168396 | 2026-04-22 07:17:11.168493 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-22 07:17:11.380038 | controller | ok 2026-04-22 07:17:11.386206 | 2026-04-22 07:17:11.386293 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-22 07:17:11.946998 | controller | changed 2026-04-22 07:17:11.952860 | 2026-04-22 07:17:11.952946 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-22 07:17:12.490452 | controller | changed 2026-04-22 07:17:12.497464 | 2026-04-22 07:17:12.497551 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-22 07:17:12.521936 | controller | skipping: Conditional result was False 2026-04-22 07:17:12.528758 | 2026-04-22 07:17:12.528922 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-22 07:17:12.901075 | controller -> localhost | changed 2026-04-22 07:17:12.913366 | 2026-04-22 07:17:12.913432 | TASK [add-build-sshkey : Add back temp key] 2026-04-22 07:17:13.187259 | controller -> localhost | Identity added: /var/lib/zuul/builds/73529512adca42909128149250014181/work/73529512adca42909128149250014181_id_rsa (zuul-build-sshkey) 2026-04-22 07:17:13.187482 | controller -> localhost | ok: Runtime: 0:00:00.015343 2026-04-22 07:17:13.194013 | 2026-04-22 07:17:13.194174 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-22 07:17:13.551585 | controller | ok 2026-04-22 07:17:13.556892 | 2026-04-22 07:17:13.556994 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-22 07:17:13.580343 | controller | skipping: Conditional result was False 2026-04-22 07:17:13.592148 | 2026-04-22 07:17:13.592233 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-22 07:17:13.954894 | controller | ok 2026-04-22 07:17:13.959265 | 2026-04-22 07:17:13.959326 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-22 07:17:14.978407 | controller | Output suppressed because no_log was given 2026-04-22 07:17:14.984807 | 2026-04-22 07:17:14.984865 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-22 07:17:15.187824 | controller | ok: "logs" 2026-04-22 07:17:15.969800 | controller | ok: All items complete 2026-04-22 07:17:15.970022 | 2026-04-22 07:17:15.979554 | controller | ok: "artifacts" 2026-04-22 07:17:15.982743 | controller | ok: "docs" 2026-04-22 07:17:15.996946 | 2026-04-22 07:17:15.997115 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-22 07:17:16.236583 | controller | changed: "logs" 2026-04-22 07:17:16.404941 | controller | changed: "artifacts" 2026-04-22 07:17:16.600095 | controller | changed: "docs" 2026-04-22 07:17:16.606369 | 2026-04-22 07:17:16.606422 | PLAY RECAP 2026-04-22 07:17:16.606468 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-22 07:17:16.606498 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-22 07:17:16.606520 | 2026-04-22 07:17:16.745219 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-22 07:17:16.747881 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-22 07:17:17.321829 | 2026-04-22 07:17:17.322152 | PLAY [all] 2026-04-22 07:17:17.331889 | 2026-04-22 07:17:17.331962 | TASK [setup-uv : Extract archive] 2026-04-22 07:17:19.724403 | controller | changed 2026-04-22 07:17:19.732990 | 2026-04-22 07:17:19.733101 | TASK [setup-uv : Print version] 2026-04-22 07:17:20.441369 | controller | uv 0.8.13 2026-04-22 07:17:20.260461 | controller | ok: Runtime: 0:00:00.014375 2026-04-22 07:17:20.266476 | 2026-04-22 07:17:20.266535 | PLAY RECAP 2026-04-22 07:17:20.266588 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-22 07:17:20.266616 | 2026-04-22 07:17:20.412614 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-22 07:17:20.415205 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-04-22 07:17:20.977377 | 2026-04-22 07:17:20.977491 | PLAY [all] 2026-04-22 07:17:20.986788 | 2026-04-22 07:17:20.986856 | TASK [Update apt cache] 2026-04-22 07:17:26.882589 | controller | ok 2026-04-22 07:17:26.889291 | 2026-04-22 07:17:26.889459 | TASK [Disable firewalld] 2026-04-22 07:17:26.914183 | controller | skipping: Conditional result was False 2026-04-22 07:17:26.921299 | 2026-04-22 07:17:26.921455 | TASK [Install "jq" for log collection] 2026-04-22 07:17:29.260511 | controller | changed 2026-04-22 07:17:29.263132 | 2026-04-22 07:17:29.263200 | PLAY RECAP 2026-04-22 07:17:29.263267 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-22 07:17:29.263307 | 2026-04-22 07:17:29.379652 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-04-22 07:17:29.382363 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-22 07:17:29.929564 | 2026-04-22 07:17:29.929671 | PLAY [all] 2026-04-22 07:17:29.939042 | 2026-04-22 07:17:29.939114 | TASK [Copy inventory file for Zuul] 2026-04-22 07:17:30.890463 | controller | changed 2026-04-22 07:17:30.897178 | 2026-04-22 07:17:30.897279 | TASK [Switch "ansible_host" to private IP] 2026-04-22 07:17:31.192632 | controller | changed: 1 replacements made 2026-04-22 07:17:31.199203 | 2026-04-22 07:17:31.199297 | TASK [Run Molecule scenario] 2026-04-22 07:17:31.979070 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-04-22 07:17:31.979193 | controller | Creating virtual environment at: .venv 2026-04-22 07:17:32.511217 | controller | Downloading pygments (1.2MiB) 2026-04-22 07:17:32.512547 | controller | Downloading cryptography (4.3MiB) 2026-04-22 07:17:32.646465 | controller | Downloading cryptography 2026-04-22 07:17:32.706038 | controller | Downloading pygments 2026-04-22 07:17:32.846488 | controller | Downloading ansible-core (2.3MiB) 2026-04-22 07:17:33.127041 | controller | Downloading ansible-core 2026-04-22 07:17:33.171980 | controller | Installed 36 packages in 44ms 2026-04-22 07:17:33.827885 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-04-22 07:17:33.827914 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-04-22 07:17:34.673341 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-22 07:17:34.673475 | controller | INFO default scenario not found, disabling shared state. 2026-04-22 07:17:34.673674 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-22 07:17:34.673776 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-04-22 07:17:52.808246 | controller | INFO [helm > dependency] Executing 2026-04-22 07:17:52.809647 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-04-22 07:17:52.809703 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-04-22 07:17:52.809734 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-22 07:17:52.815450 | controller | INFO [helm > cleanup] Executing 2026-04-22 07:17:52.815778 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-22 07:17:52.820955 | controller | INFO [helm > destroy] Executing 2026-04-22 07:17:52.820974 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-04-22 07:17:52.821078 | controller | INFO [helm > destroy] Executed: Successful 2026-04-22 07:17:52.826230 | controller | INFO [helm > syntax] Executing 2026-04-22 07:17:53.683583 | controller | 2026-04-22 07:17:53.683632 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-04-22 07:17:53.742637 | controller | INFO [helm > syntax] Executed: Successful 2026-04-22 07:17:53.750338 | controller | INFO [helm > create] Executing 2026-04-22 07:17:53.752217 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-22 07:17:53.757460 | controller | INFO [helm > prepare] Executing 2026-04-22 07:17:54.570069 | controller | 2026-04-22 07:17:54.570253 | controller | PLAY [Prepare] ***************************************************************** 2026-04-22 07:17:54.570385 | controller | 2026-04-22 07:17:54.570619 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-22 07:17:54.570769 | controller | Wednesday 22 April 2026 07:17:54 +0000 (0:00:00.028) 0:00:00.028 ******* 2026-04-22 07:17:55.845873 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-04-22 07:17:55.849813 | controller | ok: [controller] 2026-04-22 07:17:55.849823 | controller | 2026-04-22 07:17:55.849827 | controller | TASK [Install Debian packages] ************************************************* 2026-04-22 07:17:55.849831 | controller | Wednesday 22 April 2026 07:17:55 +0000 (0:00:01.280) 0:00:01.309 ******* 2026-04-22 07:17:57.199355 | controller | ok: [controller] 2026-04-22 07:17:57.199637 | controller | 2026-04-22 07:17:57.199894 | controller | PLAY RECAP ********************************************************************* 2026-04-22 07:17:57.200170 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-22 07:17:57.200406 | controller | 2026-04-22 07:17:57.200637 | controller | 2026-04-22 07:17:57.200882 | controller | TASKS RECAP ******************************************************************** 2026-04-22 07:17:57.201159 | controller | Wednesday 22 April 2026 07:17:57 +0000 (0:00:01.349) 0:00:02.658 ******* 2026-04-22 07:17:57.201444 | controller | =============================================================================== 2026-04-22 07:17:57.201743 | controller | Install Debian packages ------------------------------------------------- 1.35s 2026-04-22 07:17:57.201996 | controller | Gathering Facts --------------------------------------------------------- 1.28s 2026-04-22 07:17:57.278263 | controller | INFO [helm > prepare] Executed: Successful 2026-04-22 07:17:57.288583 | controller | INFO [helm > converge] Executing 2026-04-22 07:17:58.173375 | controller | 2026-04-22 07:17:58.173740 | controller | PLAY [Converge] **************************************************************** 2026-04-22 07:17:58.173971 | controller | 2026-04-22 07:17:58.174229 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-22 07:17:58.174479 | controller | Wednesday 22 April 2026 07:17:58 +0000 (0:00:00.013) 0:00:00.014 ******* 2026-04-22 07:17:59.250942 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-04-22 07:17:59.258071 | controller | ok: [controller] 2026-04-22 07:17:59.258090 | controller | 2026-04-22 07:17:59.258097 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-22 07:17:59.258104 | controller | Wednesday 22 April 2026 07:17:59 +0000 (0:00:01.084) 0:00:01.098 ******* 2026-04-22 07:17:59.768181 | controller | ok: [controller] 2026-04-22 07:17:59.768449 | controller | 2026-04-22 07:17:59.768741 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-22 07:17:59.769011 | controller | Wednesday 22 April 2026 07:17:59 +0000 (0:00:00.510) 0:00:01.608 ******* 2026-04-22 07:18:00.734112 | controller | ok: [controller] 2026-04-22 07:18:00.734133 | controller | 2026-04-22 07:18:00.734138 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-22 07:18:00.734142 | controller | Wednesday 22 April 2026 07:18:00 +0000 (0:00:00.963) 0:00:02.571 ******* 2026-04-22 07:18:01.151973 | controller | changed: [controller] 2026-04-22 07:18:01.151994 | controller | 2026-04-22 07:18:01.151998 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-22 07:18:01.152002 | controller | Wednesday 22 April 2026 07:18:01 +0000 (0:00:00.420) 0:00:02.992 ******* 2026-04-22 07:18:01.200477 | controller | ok: [controller] => { 2026-04-22 07:18:01.200755 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-04-22 07:18:01.200999 | controller | } 2026-04-22 07:18:01.201230 | controller | 2026-04-22 07:18:01.201542 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-22 07:18:01.201801 | controller | Wednesday 22 April 2026 07:18:01 +0000 (0:00:00.048) 0:00:03.041 ******* 2026-04-22 07:18:02.182043 | controller | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually 2026-04-22 07:18:02.189978 | controller | changed: [controller] 2026-04-22 07:18:02.190056 | controller | 2026-04-22 07:18:02.190146 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-22 07:18:02.190231 | controller | Wednesday 22 April 2026 07:18:02 +0000 (0:00:00.989) 0:00:04.030 ******* 2026-04-22 07:18:04.174873 | controller | changed: [controller] 2026-04-22 07:18:04.174963 | controller | 2026-04-22 07:18:04.175097 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-04-22 07:18:04.175249 | controller | Wednesday 22 April 2026 07:18:04 +0000 (0:00:01.983) 0:00:06.014 ******* 2026-04-22 07:18:04.695799 | controller | ok: [controller] 2026-04-22 07:18:04.695822 | controller | 2026-04-22 07:18:04.695826 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-04-22 07:18:04.695830 | controller | Wednesday 22 April 2026 07:18:04 +0000 (0:00:00.519) 0:00:06.534 ******* 2026-04-22 07:18:05.090040 | controller | changed: [controller] 2026-04-22 07:18:05.090193 | controller | 2026-04-22 07:18:05.090414 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-04-22 07:18:05.090690 | controller | Wednesday 22 April 2026 07:18:05 +0000 (0:00:00.395) 0:00:06.930 ******* 2026-04-22 07:18:05.545025 | controller | ok: [controller] 2026-04-22 07:18:05.545132 | controller | 2026-04-22 07:18:05.545293 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-04-22 07:18:05.545569 | controller | Wednesday 22 April 2026 07:18:05 +0000 (0:00:00.454) 0:00:07.384 ******* 2026-04-22 07:18:05.839999 | controller | changed: [controller] 2026-04-22 07:18:05.840176 | controller | 2026-04-22 07:18:05.840408 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-04-22 07:18:05.840619 | controller | Wednesday 22 April 2026 07:18:05 +0000 (0:00:00.295) 0:00:07.680 ******* 2026-04-22 07:18:06.135262 | controller | ok: [controller] 2026-04-22 07:18:06.135454 | controller | 2026-04-22 07:18:06.135654 | controller | TASK [Install plugin] ********************************************************** 2026-04-22 07:18:06.135847 | controller | Wednesday 22 April 2026 07:18:06 +0000 (0:00:00.295) 0:00:07.975 ******* 2026-04-22 07:18:06.186596 | controller | included: vexxhost.containers.download_artifact for controller 2026-04-22 07:18:06.186814 | controller | 2026-04-22 07:18:06.187061 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-22 07:18:06.187278 | controller | Wednesday 22 April 2026 07:18:06 +0000 (0:00:00.052) 0:00:08.027 ******* 2026-04-22 07:18:06.232322 | controller | ok: [controller] => { 2026-04-22 07:18:06.232534 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-04-22 07:18:06.232717 | controller | } 2026-04-22 07:18:06.232886 | controller | 2026-04-22 07:18:06.233081 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-22 07:18:06.233275 | controller | Wednesday 22 April 2026 07:18:06 +0000 (0:00:00.045) 0:00:08.073 ******* 2026-04-22 07:18:07.124181 | controller | changed: [controller] 2026-04-22 07:18:07.124329 | controller | 2026-04-22 07:18:07.124536 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-22 07:18:07.124734 | controller | Wednesday 22 April 2026 07:18:07 +0000 (0:00:00.890) 0:00:08.964 ******* 2026-04-22 07:18:09.208153 | controller | changed: [controller] 2026-04-22 07:18:09.208203 | controller | 2026-04-22 07:18:09.208213 | controller | PLAY RECAP ********************************************************************* 2026-04-22 07:18:09.208223 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-22 07:18:09.208231 | controller | 2026-04-22 07:18:09.208239 | controller | 2026-04-22 07:18:09.208246 | controller | TASKS RECAP ******************************************************************** 2026-04-22 07:18:09.208254 | controller | Wednesday 22 April 2026 07:18:09 +0000 (0:00:02.080) 0:00:11.044 ******* 2026-04-22 07:18:09.208262 | controller | =============================================================================== 2026-04-22 07:18:09.208269 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.08s 2026-04-22 07:18:09.208276 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.98s 2026-04-22 07:18:09.208283 | controller | Gathering Facts --------------------------------------------------------- 1.08s 2026-04-22 07:18:09.208290 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.99s 2026-04-22 07:18:09.208298 | controller | vexxhost.containers.package : Update state for tar ---------------------- 0.96s 2026-04-22 07:18:09.208305 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.89s 2026-04-22 07:18:09.208312 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.52s 2026-04-22 07:18:09.208319 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.51s 2026-04-22 07:18:09.208326 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.45s 2026-04-22 07:18:09.208334 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s 2026-04-22 07:18:09.208356 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.40s 2026-04-22 07:18:09.208364 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-04-22 07:18:09.208371 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.30s 2026-04-22 07:18:09.208378 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-04-22 07:18:09.208385 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-22 07:18:09.208392 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-22 07:18:09.315635 | controller | INFO [helm > converge] Executed: Successful 2026-04-22 07:18:09.327795 | controller | INFO [helm > idempotence] Executing 2026-04-22 07:18:10.193613 | controller | 2026-04-22 07:18:10.193926 | controller | PLAY [Converge] **************************************************************** 2026-04-22 07:18:10.194162 | controller | 2026-04-22 07:18:10.194411 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-22 07:18:10.194663 | controller | Wednesday 22 April 2026 07:18:10 +0000 (0:00:00.012) 0:00:00.012 ******* 2026-04-22 07:18:11.264979 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-04-22 07:18:11.270440 | controller | ok: [controller] 2026-04-22 07:18:11.270713 | controller | 2026-04-22 07:18:11.270975 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-22 07:18:11.271226 | controller | Wednesday 22 April 2026 07:18:11 +0000 (0:00:01.076) 0:00:01.089 ******* 2026-04-22 07:18:11.707934 | controller | ok: [controller] 2026-04-22 07:18:11.708264 | controller | 2026-04-22 07:18:11.708567 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-22 07:18:11.708850 | controller | Wednesday 22 April 2026 07:18:11 +0000 (0:00:00.437) 0:00:01.526 ******* 2026-04-22 07:18:12.694435 | controller | ok: [controller] 2026-04-22 07:18:12.694837 | controller | 2026-04-22 07:18:12.695161 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-22 07:18:12.695489 | controller | Wednesday 22 April 2026 07:18:12 +0000 (0:00:00.986) 0:00:02.512 ******* 2026-04-22 07:18:13.118246 | controller | ok: [controller] 2026-04-22 07:18:13.118538 | controller | 2026-04-22 07:18:13.118815 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-22 07:18:13.119131 | controller | Wednesday 22 April 2026 07:18:13 +0000 (0:00:00.424) 0:00:02.936 ******* 2026-04-22 07:18:13.161121 | controller | ok: [controller] => { 2026-04-22 07:18:13.161410 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-04-22 07:18:13.161720 | controller | } 2026-04-22 07:18:13.161971 | controller | 2026-04-22 07:18:13.162294 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-22 07:18:13.162564 | controller | Wednesday 22 April 2026 07:18:13 +0000 (0:00:00.042) 0:00:02.979 ******* 2026-04-22 07:18:13.688024 | controller | ok: [controller] 2026-04-22 07:18:13.688320 | controller | 2026-04-22 07:18:13.688595 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-22 07:18:13.688862 | controller | Wednesday 22 April 2026 07:18:13 +0000 (0:00:00.526) 0:00:03.506 ******* 2026-04-22 07:18:15.412873 | controller | ok: [controller] 2026-04-22 07:18:15.413067 | controller | 2026-04-22 07:18:15.413240 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-04-22 07:18:15.413404 | controller | Wednesday 22 April 2026 07:18:15 +0000 (0:00:01.724) 0:00:05.230 ******* 2026-04-22 07:18:15.934104 | controller | ok: [controller] 2026-04-22 07:18:15.934163 | controller | 2026-04-22 07:18:15.934366 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-04-22 07:18:15.934456 | controller | Wednesday 22 April 2026 07:18:15 +0000 (0:00:00.517) 0:00:05.748 ******* 2026-04-22 07:18:16.343969 | controller | ok: [controller] 2026-04-22 07:18:16.343996 | controller | 2026-04-22 07:18:16.344000 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-04-22 07:18:16.344004 | controller | Wednesday 22 April 2026 07:18:16 +0000 (0:00:00.414) 0:00:06.162 ******* 2026-04-22 07:18:16.801977 | controller | ok: [controller] 2026-04-22 07:18:16.802000 | controller | 2026-04-22 07:18:16.802005 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-04-22 07:18:16.802009 | controller | Wednesday 22 April 2026 07:18:16 +0000 (0:00:00.457) 0:00:06.619 ******* 2026-04-22 07:18:17.099458 | controller | ok: [controller] 2026-04-22 07:18:17.099493 | controller | 2026-04-22 07:18:17.099601 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-04-22 07:18:17.099680 | controller | Wednesday 22 April 2026 07:18:17 +0000 (0:00:00.297) 0:00:06.917 ******* 2026-04-22 07:18:17.400734 | controller | ok: [controller] 2026-04-22 07:18:17.400787 | controller | 2026-04-22 07:18:17.400801 | controller | TASK [Install plugin] ********************************************************** 2026-04-22 07:18:17.400920 | controller | Wednesday 22 April 2026 07:18:17 +0000 (0:00:00.301) 0:00:07.219 ******* 2026-04-22 07:18:17.457686 | controller | included: vexxhost.containers.download_artifact for controller 2026-04-22 07:18:17.457716 | controller | 2026-04-22 07:18:17.457803 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-22 07:18:17.457885 | controller | Wednesday 22 April 2026 07:18:17 +0000 (0:00:00.057) 0:00:07.276 ******* 2026-04-22 07:18:17.509395 | controller | ok: [controller] => { 2026-04-22 07:18:17.509490 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-04-22 07:18:17.509509 | controller | } 2026-04-22 07:18:17.509566 | controller | 2026-04-22 07:18:17.509768 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-22 07:18:17.509795 | controller | Wednesday 22 April 2026 07:18:17 +0000 (0:00:00.048) 0:00:07.325 ******* 2026-04-22 07:18:17.956427 | controller | ok: [controller] 2026-04-22 07:18:17.956457 | controller | 2026-04-22 07:18:17.956463 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-22 07:18:17.956469 | controller | Wednesday 22 April 2026 07:18:17 +0000 (0:00:00.446) 0:00:07.771 ******* 2026-04-22 07:18:19.617825 | controller | ok: [controller] 2026-04-22 07:18:19.618032 | controller | 2026-04-22 07:18:19.618216 | controller | PLAY RECAP ********************************************************************* 2026-04-22 07:18:19.618415 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-22 07:18:19.618571 | controller | 2026-04-22 07:18:19.618715 | controller | 2026-04-22 07:18:19.618872 | controller | TASKS RECAP ******************************************************************** 2026-04-22 07:18:19.619037 | controller | Wednesday 22 April 2026 07:18:19 +0000 (0:00:01.658) 0:00:09.429 ******* 2026-04-22 07:18:19.619190 | controller | =============================================================================== 2026-04-22 07:18:19.619350 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.72s 2026-04-22 07:18:19.619544 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.66s 2026-04-22 07:18:19.619705 | controller | Gathering Facts --------------------------------------------------------- 1.08s 2026-04-22 07:18:19.619886 | controller | vexxhost.containers.package : Update state for tar ---------------------- 0.99s 2026-04-22 07:18:19.620061 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.53s 2026-04-22 07:18:19.620220 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.52s 2026-04-22 07:18:19.620378 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.46s 2026-04-22 07:18:19.620535 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.45s 2026-04-22 07:18:19.620692 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.44s 2026-04-22 07:18:19.620848 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s 2026-04-22 07:18:19.621018 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.41s 2026-04-22 07:18:19.621185 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-04-22 07:18:19.621350 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.30s 2026-04-22 07:18:19.621552 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-04-22 07:18:19.621714 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-22 07:18:19.621877 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-04-22 07:18:19.737245 | controller | INFO [helm > idempotence] Executed: Successful 2026-04-22 07:18:19.746174 | controller | INFO [helm > side_effect] Executing 2026-04-22 07:18:19.746654 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-22 07:18:19.753403 | controller | INFO [helm > verify] Executing 2026-04-22 07:18:20.585312 | controller | 2026-04-22 07:18:20.585702 | controller | PLAY [Verify] ****************************************************************** 2026-04-22 07:18:20.585938 | controller | 2026-04-22 07:18:20.586185 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-22 07:18:20.586430 | controller | Wednesday 22 April 2026 07:18:20 +0000 (0:00:00.010) 0:00:00.010 ******* 2026-04-22 07:18:21.642755 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-04-22 07:18:21.648853 | controller | ok: [controller] 2026-04-22 07:18:21.649104 | controller | 2026-04-22 07:18:21.649359 | controller | TASK [Get the current Helm version] ******************************************** 2026-04-22 07:18:21.649688 | controller | Wednesday 22 April 2026 07:18:21 +0000 (0:00:01.063) 0:00:01.073 ******* 2026-04-22 07:18:22.109269 | controller | changed: [controller] 2026-04-22 07:18:22.111135 | controller | 2026-04-22 07:18:22.112012 | controller | TASK [Assert Helm version] ***************************************************** 2026-04-22 07:18:22.112215 | controller | Wednesday 22 April 2026 07:18:22 +0000 (0:00:00.460) 0:00:01.534 ******* 2026-04-22 07:18:22.140308 | controller | ok: [controller] => { 2026-04-22 07:18:22.140501 | controller | "changed": false, 2026-04-22 07:18:22.140690 | controller | "msg": "All assertions passed" 2026-04-22 07:18:22.140873 | controller | } 2026-04-22 07:18:22.141090 | controller | 2026-04-22 07:18:22.141279 | controller | PLAY RECAP ********************************************************************* 2026-04-22 07:18:22.141532 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-22 07:18:22.141704 | controller | 2026-04-22 07:18:22.141874 | controller | 2026-04-22 07:18:22.142054 | controller | TASKS RECAP ******************************************************************** 2026-04-22 07:18:22.142249 | controller | Wednesday 22 April 2026 07:18:22 +0000 (0:00:00.031) 0:00:01.565 ******* 2026-04-22 07:18:22.142424 | controller | =============================================================================== 2026-04-22 07:18:22.142626 | controller | Gathering Facts --------------------------------------------------------- 1.06s 2026-04-22 07:18:22.142802 | controller | Get the current Helm version -------------------------------------------- 0.46s 2026-04-22 07:18:22.142993 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-04-22 07:18:22.252257 | controller | INFO [helm > verify] Executed: Successful 2026-04-22 07:18:22.261297 | controller | INFO [helm > cleanup] Executing 2026-04-22 07:18:22.261752 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-22 07:18:22.267245 | controller | INFO [helm > destroy] Executing 2026-04-22 07:18:22.267268 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-04-22 07:18:22.267355 | controller | INFO [helm > destroy] Executed: Successful 2026-04-22 07:18:22.267692 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-04-22 07:18:22.623458 | controller | ok: Runtime: 0:00:50.473078 2026-04-22 07:18:22.628771 | 2026-04-22 07:18:22.628843 | PLAY RECAP 2026-04-22 07:18:22.628906 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-22 07:18:22.628937 | 2026-04-22 07:18:22.771628 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-22 07:18:22.773190 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-04-22 07:18:23.352526 | 2026-04-22 07:18:23.352639 | PLAY [all] 2026-04-22 07:18:23.362952 | 2026-04-22 07:18:23.363029 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-22 07:18:23.775965 | controller | changed 2026-04-22 07:18:23.780180 | 2026-04-22 07:18:23.780255 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-22 07:18:24.174650 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-22 07:18:24.174761 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-22 07:18:24.182612 | controller | environment: line 1: kubectl: command not found 2026-04-22 07:18:24.184123 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-22 07:18:24.187027 | controller | environment: line 1: kubectl: command not found 2026-04-22 07:18:24.187043 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-22 07:18:24.191510 | controller | environment: line 1: kubectl: command not found 2026-04-22 07:18:24.192030 | controller | environment: line 1: kubectl: command not found 2026-04-22 07:18:24.192042 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-22 07:18:24.193684 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-22 07:18:24.196115 | controller | environment: line 1: kubectl: command not found 2026-04-22 07:18:24.197533 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-22 07:18:24.307368 | controller | ok: Runtime: 0:00:00.037035 2026-04-22 07:18:24.314390 | 2026-04-22 07:18:24.314561 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-22 07:18:24.552403 | controller | changed 2026-04-22 07:18:24.561907 | 2026-04-22 07:18:24.562020 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-22 07:18:24.804899 | controller | environment: line 5: kubectl: command not found 2026-04-22 07:18:24.806406 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-22 07:18:24.806580 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-22 07:18:24.807611 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-22 07:18:25.094015 | controller | ok: Runtime: 0:00:00.011982 2026-04-22 07:18:25.099627 | 2026-04-22 07:18:25.099718 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-22 07:18:25.792360 | controller | changed: 2026-04-22 07:18:25.792628 | controller | created directory /var/lib/zuul/builds/73529512adca42909128149250014181/work/logs/controller 2026-04-22 07:18:25.792714 | controller | cd+++++++++ objects/ 2026-04-22 07:18:25.792771 | controller | cd+++++++++ objects/cluster/ 2026-04-22 07:18:25.792821 | controller | cd+++++++++ objects/namespaced/ 2026-04-22 07:18:25.800547 | 2026-04-22 07:18:25.800611 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-22 07:18:26.024822 | controller | changed 2026-04-22 07:18:26.030490 | 2026-04-22 07:18:26.030579 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-22 07:18:26.266273 | controller | changed 2026-04-22 07:18:26.272104 | 2026-04-22 07:18:26.272204 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-22 07:18:26.511081 | controller | environment: line 3: kubectl: command not found 2026-04-22 07:18:26.804876 | controller | ok: Runtime: 0:00:00.013636 2026-04-22 07:18:26.813617 | 2026-04-22 07:18:26.813708 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-22 07:18:27.330485 | controller | changed: 2026-04-22 07:18:27.330669 | controller | cd+++++++++ pod-logs/ 2026-04-22 07:18:27.330707 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-04-22 07:18:27.339981 | 2026-04-22 07:18:27.340064 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-22 07:18:27.587395 | controller | changed: "values" 2026-04-22 07:18:27.799234 | controller | changed: "releases" 2026-04-22 07:18:27.811098 | 2026-04-22 07:18:27.811304 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-22 07:18:28.060778 | controller | /bin/bash: line 3: kubectl: command not found 2026-04-22 07:18:28.347957 | controller | ok: Runtime: 0:00:00.008801 2026-04-22 07:18:28.354622 | 2026-04-22 07:18:28.354705 | TASK [helm-release-status : Downloads logs to executor] 2026-04-22 07:18:28.880576 | controller | changed: 2026-04-22 07:18:28.880755 | controller | cd+++++++++ helm/ 2026-04-22 07:18:28.880793 | controller | cd+++++++++ helm/releases/ 2026-04-22 07:18:28.880826 | controller | cd+++++++++ helm/values/ 2026-04-22 07:18:28.886235 | 2026-04-22 07:18:28.886280 | PLAY RECAP 2026-04-22 07:18:28.886322 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-22 07:18:28.886345 | 2026-04-22 07:18:28.985949 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-04-22 07:18:28.988449 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-22 07:18:29.536112 | 2026-04-22 07:18:29.536638 | PLAY [all] 2026-04-22 07:18:29.546269 | 2026-04-22 07:18:29.546357 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-22 07:18:29.591571 | controller | skipping: Conditional result was False 2026-04-22 07:18:29.600760 | 2026-04-22 07:18:29.600861 | TASK [fetch-output : Set log path for single node] 2026-04-22 07:18:29.643264 | controller | ok 2026-04-22 07:18:29.649356 | 2026-04-22 07:18:29.649422 | LOOP [fetch-output : Ensure local output dirs] 2026-04-22 07:18:30.023847 | controller -> localhost | ok: "/var/lib/zuul/builds/73529512adca42909128149250014181/work/logs" 2026-04-22 07:18:30.259620 | controller -> localhost | changed: "/var/lib/zuul/builds/73529512adca42909128149250014181/work/artifacts" 2026-04-22 07:18:30.476484 | controller -> localhost | changed: "/var/lib/zuul/builds/73529512adca42909128149250014181/work/docs" 2026-04-22 07:18:30.488236 | 2026-04-22 07:18:30.488310 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-22 07:18:31.135210 | controller | changed: .d..t...... ./ 2026-04-22 07:18:31.135441 | controller | changed: All items complete 2026-04-22 07:18:31.135474 | 2026-04-22 07:18:31.627969 | controller | changed: .d..t...... ./ 2026-04-22 07:18:32.112358 | controller | changed: .d..t...... ./ 2026-04-22 07:18:32.134268 | 2026-04-22 07:18:32.134411 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-22 07:18:32.536922 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006950 2026-04-22 07:18:32.749623 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006208 2026-04-22 07:18:32.767384 | 2026-04-22 07:18:32.767512 | PLAY [all] 2026-04-22 07:18:32.773024 | 2026-04-22 07:18:32.773102 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-22 07:18:33.219074 | controller | changed 2026-04-22 07:18:33.225209 | 2026-04-22 07:18:33.280868 | PLAY RECAP 2026-04-22 07:18:33.280977 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-22 07:18:33.281014 | 2026-04-22 07:18:33.378122 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-22 07:18:33.380775 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-22 07:18:33.947611 | 2026-04-22 07:18:33.947739 | PLAY [localhost] 2026-04-22 07:18:33.957580 | 2026-04-22 07:18:33.957648 | TASK [Generate Zuul manifest] 2026-04-22 07:18:33.979455 | localhost | ok 2026-04-22 07:18:33.995290 | 2026-04-22 07:18:33.995368 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-22 07:18:34.310264 | localhost | changed 2026-04-22 07:18:34.324705 | 2026-04-22 07:18:34.324812 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-22 07:18:34.355604 | localhost | ok 2026-04-22 07:18:34.364562 | 2026-04-22 07:18:34.364646 | TASK [Upload logs] 2026-04-22 07:18:34.383425 | localhost | ok 2026-04-22 07:18:34.442239 | 2026-04-22 07:18:34.442325 | TASK [Set zuul-log-path fact] 2026-04-22 07:18:34.463245 | localhost | ok 2026-04-22 07:18:34.474677 | 2026-04-22 07:18:34.474741 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-22 07:18:34.505602 | localhost | ok 2026-04-22 07:18:34.514267 | 2026-04-22 07:18:34.514350 | TASK [upload-logs : Create log directories] 2026-04-22 07:18:34.930635 | localhost | changed 2026-04-22 07:18:34.936555 | 2026-04-22 07:18:34.936637 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-22 07:18:35.321419 | localhost -> localhost | ok: Runtime: 0:00:00.005145 2026-04-22 07:18:35.328364 | 2026-04-22 07:18:35.328525 | TASK [upload-logs : Upload logs to log server] 2026-04-22 07:18:35.745210 | localhost | Output suppressed because no_log was given 2026-04-22 07:18:35.750783 | 2026-04-22 07:18:35.750853 | LOOP [upload-logs : Compress console log and json output] 2026-04-22 07:18:35.801482 | localhost | skipping: Conditional result was False 2026-04-22 07:18:35.808639 | localhost | skipping: Conditional result was False 2026-04-22 07:18:35.825915 | 2026-04-22 07:18:35.826063 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-22 07:18:35.869130 | localhost | skipping: Conditional result was False 2026-04-22 07:18:35.869499 | 2026-04-22 07:18:35.873271 | localhost | skipping: Conditional result was False 2026-04-22 07:18:35.890014 | 2026-04-22 07:18:35.890150 | LOOP [upload-logs : Upload console log and json output]