2026-03-18 13:08:18.441934 | Job console starting 2026-03-18 13:08:18.707358 | Updating git repos 2026-03-18 13:08:18.759934 | Cloning repos into workspace 2026-03-18 13:08:19.647551 | Restoring repo states 2026-03-18 13:08:19.664224 | Merging changes 2026-03-18 13:08:20.634472 | Checking out repos 2026-03-18 13:08:20.855122 | Preparing playbooks 2026-03-18 13:08:25.948294 | Running Ansible setup 2026-03-18 13:08:31.329733 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-18 13:08:32.035253 | 2026-03-18 13:08:32.035762 | PLAY [localhost] 2026-03-18 13:08:32.045602 | 2026-03-18 13:08:32.045755 | TASK [Gathering Facts] 2026-03-18 13:08:33.025716 | localhost | ok 2026-03-18 13:08:33.037173 | 2026-03-18 13:08:33.037295 | TASK [Setup log path fact] 2026-03-18 13:08:33.079214 | localhost | ok 2026-03-18 13:08:33.094323 | 2026-03-18 13:08:33.094448 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-18 13:08:33.125237 | localhost | ok 2026-03-18 13:08:33.133570 | 2026-03-18 13:08:33.133685 | TASK [emit-job-header : Print job information] 2026-03-18 13:08:33.174319 | # Job Information 2026-03-18 13:08:33.174556 | Ansible Version: 2.16.16 2026-03-18 13:08:33.174607 | Job: ansible-collection-kubernetes-molecule-helm 2026-03-18 13:08:33.174780 | Pipeline: check 2026-03-18 13:08:33.174835 | Executor: 0a8996d2b663 2026-03-18 13:08:33.174868 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/241 2026-03-18 13:08:33.174900 | Event ID: 59a4e400-22cb-11f1-8e53-cddb632715d6 2026-03-18 13:08:33.179282 | 2026-03-18 13:08:33.179387 | LOOP [emit-job-header : Print node information] 2026-03-18 13:08:33.279163 | localhost | ok: 2026-03-18 13:08:33.279338 | localhost | # Node Information 2026-03-18 13:08:33.279371 | localhost | Inventory Hostname: controller 2026-03-18 13:08:33.279406 | localhost | Hostname: np0000159849 2026-03-18 13:08:33.279434 | localhost | Username: zuul 2026-03-18 13:08:33.279461 | localhost | Distro: Debian 13.3 2026-03-18 13:08:33.279491 | localhost | Provider: yul1 2026-03-18 13:08:33.279522 | localhost | Region: ca-ymq-1 2026-03-18 13:08:33.279554 | localhost | Label: debian-trixie 2026-03-18 13:08:33.279584 | localhost | Product Name: OpenStack Nova 2026-03-18 13:08:33.279604 | localhost | Interface IP: 199.19.213.79 2026-03-18 13:08:33.296757 | 2026-03-18 13:08:33.296942 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-18 13:08:33.730834 | localhost -> localhost | changed 2026-03-18 13:08:33.743823 | 2026-03-18 13:08:33.743994 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-18 13:08:34.739187 | localhost -> localhost | changed 2026-03-18 13:08:34.749918 | 2026-03-18 13:08:34.750012 | PLAY [all] 2026-03-18 13:08:34.757352 | 2026-03-18 13:08:34.757437 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-18 13:08:35.013817 | controller -> localhost | ok 2026-03-18 13:08:35.024185 | 2026-03-18 13:08:35.024378 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-18 13:08:35.056063 | controller | ok 2026-03-18 13:08:35.072602 | controller | included: /var/lib/zuul/builds/ecec3ef208344839afa7402fbbb7d15e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-18 13:08:35.078775 | 2026-03-18 13:08:35.078869 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-18 13:08:36.717394 | controller -> localhost | Generating public/private rsa key pair. 2026-03-18 13:08:36.717761 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/ecec3ef208344839afa7402fbbb7d15e/work/ecec3ef208344839afa7402fbbb7d15e_id_rsa 2026-03-18 13:08:36.717835 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/ecec3ef208344839afa7402fbbb7d15e/work/ecec3ef208344839afa7402fbbb7d15e_id_rsa.pub 2026-03-18 13:08:36.717888 | controller -> localhost | The key fingerprint is: 2026-03-18 13:08:36.717935 | controller -> localhost | SHA256:wii7Q5EopskeOEbIo3QL71ZRjWhVaiITDNHihJi3+TY zuul-build-sshkey 2026-03-18 13:08:36.718005 | controller -> localhost | The key's randomart image is: 2026-03-18 13:08:36.718115 | controller -> localhost | +---[RSA 3072]----+ 2026-03-18 13:08:36.718177 | controller -> localhost | |o+=. o.+. | 2026-03-18 13:08:36.718225 | controller -> localhost | |+o.o.o o.. | 2026-03-18 13:08:36.718269 | controller -> localhost | |=o.*...o | 2026-03-18 13:08:36.718313 | controller -> localhost | |+O=.o+o | 2026-03-18 13:08:36.718355 | controller -> localhost | |X.*oo + S | 2026-03-18 13:08:36.718398 | controller -> localhost | |*+.=E. . | 2026-03-18 13:08:36.718440 | controller -> localhost | |oo+... | 2026-03-18 13:08:36.718482 | controller -> localhost | | ..+ | 2026-03-18 13:08:36.718531 | controller -> localhost | | o. | 2026-03-18 13:08:36.718576 | controller -> localhost | +----[SHA256]-----+ 2026-03-18 13:08:36.718676 | controller -> localhost | ok: Runtime: 0:00:00.780419 2026-03-18 13:08:36.725291 | 2026-03-18 13:08:36.725405 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-18 13:08:36.756249 | controller | ok 2026-03-18 13:08:36.766621 | controller | included: /var/lib/zuul/builds/ecec3ef208344839afa7402fbbb7d15e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-18 13:08:36.779947 | 2026-03-18 13:08:36.780121 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-18 13:08:36.805419 | controller | skipping: Conditional result was False 2026-03-18 13:08:36.812839 | 2026-03-18 13:08:36.813029 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-18 13:08:37.428290 | controller | changed 2026-03-18 13:08:37.432712 | 2026-03-18 13:08:37.432778 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-18 13:08:37.642799 | controller | ok 2026-03-18 13:08:37.653168 | 2026-03-18 13:08:37.653283 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-18 13:08:38.229507 | controller | changed 2026-03-18 13:08:38.235481 | 2026-03-18 13:08:38.235571 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-18 13:08:38.783113 | controller | changed 2026-03-18 13:08:38.791215 | 2026-03-18 13:08:38.791455 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-18 13:08:38.816790 | controller | skipping: Conditional result was False 2026-03-18 13:08:38.822740 | 2026-03-18 13:08:38.822839 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-18 13:08:39.233345 | controller -> localhost | changed 2026-03-18 13:08:39.241941 | 2026-03-18 13:08:39.242014 | TASK [add-build-sshkey : Add back temp key] 2026-03-18 13:08:39.539133 | controller -> localhost | Identity added: /var/lib/zuul/builds/ecec3ef208344839afa7402fbbb7d15e/work/ecec3ef208344839afa7402fbbb7d15e_id_rsa (zuul-build-sshkey) 2026-03-18 13:08:39.539445 | controller -> localhost | ok: Runtime: 0:00:00.014435 2026-03-18 13:08:39.546027 | 2026-03-18 13:08:39.546152 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-18 13:08:39.914980 | controller | ok 2026-03-18 13:08:39.920249 | 2026-03-18 13:08:39.920321 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-18 13:08:39.947359 | controller | skipping: Conditional result was False 2026-03-18 13:08:39.959269 | 2026-03-18 13:08:39.959408 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-18 13:08:40.334805 | controller | ok 2026-03-18 13:08:40.341721 | 2026-03-18 13:08:40.341859 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-18 13:08:41.459887 | controller | Output suppressed because no_log was given 2026-03-18 13:08:41.466729 | 2026-03-18 13:08:41.466791 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-18 13:08:41.673033 | controller | ok: "logs" 2026-03-18 13:08:41.751431 | controller | ok: All items complete 2026-03-18 13:08:41.751657 | 2026-03-18 13:08:41.863538 | controller | ok: "artifacts" 2026-03-18 13:08:42.059626 | controller | ok: "docs" 2026-03-18 13:08:42.074122 | 2026-03-18 13:08:42.074282 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-18 13:08:42.286942 | controller | changed: "logs" 2026-03-18 13:08:42.462973 | controller | changed: "artifacts" 2026-03-18 13:08:42.649734 | controller | changed: "docs" 2026-03-18 13:08:42.673275 | 2026-03-18 13:08:42.673373 | PLAY RECAP 2026-03-18 13:08:42.673436 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-18 13:08:42.673478 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 13:08:42.673644 | 2026-03-18 13:08:42.832558 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-18 13:08:42.833947 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-18 13:08:43.444420 | 2026-03-18 13:08:43.445204 | PLAY [all] 2026-03-18 13:08:43.456623 | 2026-03-18 13:08:43.456748 | TASK [setup-uv : Extract archive] 2026-03-18 13:08:45.897014 | controller | changed 2026-03-18 13:08:45.904819 | 2026-03-18 13:08:45.904940 | TASK [setup-uv : Print version] 2026-03-18 13:08:46.358024 | controller | uv 0.8.13 2026-03-18 13:08:46.442417 | controller | ok: Runtime: 0:00:00.012777 2026-03-18 13:08:46.451052 | 2026-03-18 13:08:46.451240 | PLAY RECAP 2026-03-18 13:08:46.451318 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 13:08:46.451356 | 2026-03-18 13:08:46.590638 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-18 13:08:46.592792 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-18 13:08:47.217469 | 2026-03-18 13:08:47.217650 | PLAY [all] 2026-03-18 13:08:47.228346 | 2026-03-18 13:08:47.228494 | TASK [Update apt cache] 2026-03-18 13:08:52.273766 | controller | ok 2026-03-18 13:08:52.281575 | 2026-03-18 13:08:52.281796 | TASK [Disable firewalld] 2026-03-18 13:08:52.307241 | controller | skipping: Conditional result was False 2026-03-18 13:08:52.318341 | 2026-03-18 13:08:52.318562 | TASK [Install "jq" for log collection] 2026-03-18 13:08:54.600674 | controller | changed 2026-03-18 13:08:54.607076 | 2026-03-18 13:08:54.607191 | PLAY RECAP 2026-03-18 13:08:54.607291 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-18 13:08:54.607530 | 2026-03-18 13:08:54.793141 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-18 13:08:54.795102 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-18 13:08:55.411170 | 2026-03-18 13:08:55.411361 | PLAY [all] 2026-03-18 13:08:55.423224 | 2026-03-18 13:08:55.423370 | TASK [Copy inventory file for Zuul] 2026-03-18 13:08:56.432274 | controller | changed 2026-03-18 13:08:56.655409 | 2026-03-18 13:08:56.655615 | TASK [Switch "ansible_host" to private IP] 2026-03-18 13:08:56.983658 | controller | changed: 1 replacements made 2026-03-18 13:08:56.990715 | 2026-03-18 13:08:56.990852 | TASK [Run Molecule scenario] 2026-03-18 13:08:57.460552 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-18 13:08:57.460636 | controller | Creating virtual environment at: .venv 2026-03-18 13:08:57.730263 | controller | Downloading cryptography (4.3MiB) 2026-03-18 13:08:57.732465 | controller | Downloading pygments (1.2MiB) 2026-03-18 13:08:57.739119 | controller | Downloading ansible-core (2.3MiB) 2026-03-18 13:08:57.908591 | controller | Downloading cryptography 2026-03-18 13:08:57.968969 | controller | Downloading pygments 2026-03-18 13:08:58.164197 | controller | Downloading ansible-core 2026-03-18 13:08:58.217169 | controller | Installed 36 packages in 52ms 2026-03-18 13:08:58.896109 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-18 13:08:58.896156 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-18 13:08:59.829321 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-18 13:08:59.829358 | controller | INFO default scenario not found, disabling shared state. 2026-03-18 13:08:59.829592 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-18 13:08:59.829688 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-03-18 13:09:17.354241 | controller | INFO [helm > dependency] Executing 2026-03-18 13:09:17.354498 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-03-18 13:09:17.354836 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-03-18 13:09:17.355044 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-18 13:09:17.361478 | controller | INFO [helm > cleanup] Executing 2026-03-18 13:09:17.361767 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-18 13:09:17.367173 | controller | INFO [helm > destroy] Executing 2026-03-18 13:09:17.367223 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-18 13:09:17.367321 | controller | INFO [helm > destroy] Executed: Successful 2026-03-18 13:09:17.372683 | controller | INFO [helm > syntax] Executing 2026-03-18 13:09:18.271160 | controller | 2026-03-18 13:09:18.271271 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-03-18 13:09:18.342314 | controller | INFO [helm > syntax] Executed: Successful 2026-03-18 13:09:18.352351 | controller | INFO [helm > create] Executing 2026-03-18 13:09:18.354548 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-18 13:09:18.360686 | controller | INFO [helm > prepare] Executing 2026-03-18 13:09:19.307589 | controller | 2026-03-18 13:09:19.307749 | controller | PLAY [Prepare] ***************************************************************** 2026-03-18 13:09:19.307951 | controller | 2026-03-18 13:09:19.308217 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-18 13:09:19.308438 | controller | Wednesday 18 March 2026 13:09:19 +0000 (0:00:00.031) 0:00:00.031 ******* 2026-03-18 13:09:20.607901 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-18 13:09:20.615695 | controller | ok: [controller] 2026-03-18 13:09:20.615928 | controller | 2026-03-18 13:09:20.616128 | controller | TASK [Install Debian packages] ************************************************* 2026-03-18 13:09:20.616340 | controller | Wednesday 18 March 2026 13:09:20 +0000 (0:00:01.308) 0:00:01.340 ******* 2026-03-18 13:09:22.237985 | controller | ok: [controller] 2026-03-18 13:09:22.238050 | controller | 2026-03-18 13:09:22.238281 | controller | PLAY RECAP ********************************************************************* 2026-03-18 13:09:22.238518 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-18 13:09:22.238718 | controller | 2026-03-18 13:09:22.238949 | controller | 2026-03-18 13:09:22.239150 | controller | TASKS RECAP ******************************************************************** 2026-03-18 13:09:22.239335 | controller | Wednesday 18 March 2026 13:09:22 +0000 (0:00:01.614) 0:00:02.954 ******* 2026-03-18 13:09:22.239522 | controller | =============================================================================== 2026-03-18 13:09:22.239732 | controller | Install Debian packages ------------------------------------------------- 1.61s 2026-03-18 13:09:22.240071 | controller | Gathering Facts --------------------------------------------------------- 1.31s 2026-03-18 13:09:22.387466 | controller | INFO [helm > prepare] Executed: Successful 2026-03-18 13:09:22.393155 | controller | INFO [helm > converge] Executing 2026-03-18 13:09:23.315043 | controller | 2026-03-18 13:09:23.315234 | controller | PLAY [Converge] **************************************************************** 2026-03-18 13:09:23.315407 | controller | 2026-03-18 13:09:23.315650 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-18 13:09:23.315851 | controller | Wednesday 18 March 2026 13:09:23 +0000 (0:00:00.013) 0:00:00.013 ******* 2026-03-18 13:09:24.472626 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-18 13:09:24.480123 | controller | ok: [controller] 2026-03-18 13:09:24.480142 | controller | 2026-03-18 13:09:24.480149 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-18 13:09:24.480156 | controller | Wednesday 18 March 2026 13:09:24 +0000 (0:00:01.164) 0:00:01.178 ******* 2026-03-18 13:09:25.048659 | controller | ok: [controller] 2026-03-18 13:09:25.048989 | controller | 2026-03-18 13:09:25.049363 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-18 13:09:25.049741 | controller | Wednesday 18 March 2026 13:09:25 +0000 (0:00:00.568) 0:00:01.747 ******* 2026-03-18 13:09:26.350791 | controller | ok: [controller] 2026-03-18 13:09:26.350842 | controller | 2026-03-18 13:09:26.350852 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-18 13:09:26.350863 | controller | Wednesday 18 March 2026 13:09:26 +0000 (0:00:01.299) 0:00:03.046 ******* 2026-03-18 13:09:26.812742 | controller | changed: [controller] 2026-03-18 13:09:26.812894 | controller | 2026-03-18 13:09:26.813111 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-18 13:09:26.813327 | controller | Wednesday 18 March 2026 13:09:26 +0000 (0:00:00.464) 0:00:03.510 ******* 2026-03-18 13:09:26.869024 | controller | ok: [controller] => { 2026-03-18 13:09:26.869130 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-18 13:09:26.869252 | controller | } 2026-03-18 13:09:26.869360 | controller | 2026-03-18 13:09:26.869492 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-18 13:09:26.869617 | controller | Wednesday 18 March 2026 13:09:26 +0000 (0:00:00.056) 0:00:03.567 ******* 2026-03-18 13:09:27.836967 | controller | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually 2026-03-18 13:09:27.847151 | controller | changed: [controller] 2026-03-18 13:09:27.847319 | controller | 2026-03-18 13:09:27.847577 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-18 13:09:27.847794 | controller | Wednesday 18 March 2026 13:09:27 +0000 (0:00:00.978) 0:00:04.545 ******* 2026-03-18 13:09:30.033838 | controller | changed: [controller] 2026-03-18 13:09:30.034013 | controller | 2026-03-18 13:09:30.034244 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-18 13:09:30.034460 | controller | Wednesday 18 March 2026 13:09:30 +0000 (0:00:02.186) 0:00:06.731 ******* 2026-03-18 13:09:30.591017 | controller | ok: [controller] 2026-03-18 13:09:30.591159 | controller | 2026-03-18 13:09:30.591388 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-18 13:09:30.591604 | controller | Wednesday 18 March 2026 13:09:30 +0000 (0:00:00.556) 0:00:07.288 ******* 2026-03-18 13:09:31.045355 | controller | changed: [controller] 2026-03-18 13:09:31.045474 | controller | 2026-03-18 13:09:31.045619 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-18 13:09:31.045743 | controller | Wednesday 18 March 2026 13:09:31 +0000 (0:00:00.454) 0:00:07.743 ******* 2026-03-18 13:09:31.528553 | controller | ok: [controller] 2026-03-18 13:09:31.528794 | controller | 2026-03-18 13:09:31.529146 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-18 13:09:31.529402 | controller | Wednesday 18 March 2026 13:09:31 +0000 (0:00:00.483) 0:00:08.226 ******* 2026-03-18 13:09:31.838548 | controller | changed: [controller] 2026-03-18 13:09:31.838700 | controller | 2026-03-18 13:09:31.838961 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-18 13:09:31.839170 | controller | Wednesday 18 March 2026 13:09:31 +0000 (0:00:00.309) 0:00:08.536 ******* 2026-03-18 13:09:32.154729 | controller | ok: [controller] 2026-03-18 13:09:32.154754 | controller | 2026-03-18 13:09:32.154759 | controller | TASK [Install plugin] ********************************************************** 2026-03-18 13:09:32.154763 | controller | Wednesday 18 March 2026 13:09:32 +0000 (0:00:00.313) 0:00:08.850 ******* 2026-03-18 13:09:32.208893 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-18 13:09:32.208920 | controller | 2026-03-18 13:09:32.208925 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-18 13:09:32.208929 | controller | Wednesday 18 March 2026 13:09:32 +0000 (0:00:00.057) 0:00:08.907 ******* 2026-03-18 13:09:32.248705 | controller | ok: [controller] => { 2026-03-18 13:09:32.248740 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-18 13:09:32.248746 | controller | } 2026-03-18 13:09:32.248752 | controller | 2026-03-18 13:09:32.248757 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-18 13:09:32.248763 | controller | Wednesday 18 March 2026 13:09:32 +0000 (0:00:00.038) 0:00:08.946 ******* 2026-03-18 13:09:33.080377 | controller | changed: [controller] 2026-03-18 13:09:33.080554 | controller | 2026-03-18 13:09:33.080787 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-18 13:09:33.081100 | controller | Wednesday 18 March 2026 13:09:33 +0000 (0:00:00.831) 0:00:09.778 ******* 2026-03-18 13:09:35.286880 | controller | changed: [controller] 2026-03-18 13:09:35.286932 | controller | 2026-03-18 13:09:35.286939 | controller | PLAY RECAP ********************************************************************* 2026-03-18 13:09:35.286946 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-18 13:09:35.286951 | controller | 2026-03-18 13:09:35.286956 | controller | 2026-03-18 13:09:35.286960 | controller | TASKS RECAP ******************************************************************** 2026-03-18 13:09:35.286965 | controller | Wednesday 18 March 2026 13:09:35 +0000 (0:00:02.203) 0:00:11.981 ******* 2026-03-18 13:09:35.286970 | controller | =============================================================================== 2026-03-18 13:09:35.286974 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.20s 2026-03-18 13:09:35.286978 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.19s 2026-03-18 13:09:35.286983 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.30s 2026-03-18 13:09:35.286987 | controller | Gathering Facts --------------------------------------------------------- 1.17s 2026-03-18 13:09:35.286991 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.98s 2026-03-18 13:09:35.286995 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.83s 2026-03-18 13:09:35.287000 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.57s 2026-03-18 13:09:35.287004 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.56s 2026-03-18 13:09:35.287008 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.48s 2026-03-18 13:09:35.287013 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.46s 2026-03-18 13:09:35.287041 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.45s 2026-03-18 13:09:35.288239 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.31s 2026-03-18 13:09:35.288281 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-03-18 13:09:35.288290 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-18 13:09:35.288297 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s 2026-03-18 13:09:35.288305 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-18 13:09:35.399097 | controller | INFO [helm > converge] Executed: Successful 2026-03-18 13:09:35.409521 | controller | INFO [helm > idempotence] Executing 2026-03-18 13:09:36.302781 | controller | 2026-03-18 13:09:36.303132 | controller | PLAY [Converge] **************************************************************** 2026-03-18 13:09:36.303452 | controller | 2026-03-18 13:09:36.303745 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-18 13:09:36.304035 | controller | Wednesday 18 March 2026 13:09:36 +0000 (0:00:00.013) 0:00:00.013 ******* 2026-03-18 13:09:37.408574 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-18 13:09:37.414808 | controller | ok: [controller] 2026-03-18 13:09:37.414881 | controller | 2026-03-18 13:09:37.414973 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-18 13:09:37.415065 | controller | Wednesday 18 March 2026 13:09:37 +0000 (0:00:01.112) 0:00:01.126 ******* 2026-03-18 13:09:37.875986 | controller | ok: [controller] 2026-03-18 13:09:37.876031 | controller | 2026-03-18 13:09:37.876040 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-18 13:09:37.876048 | controller | Wednesday 18 March 2026 13:09:37 +0000 (0:00:00.458) 0:00:01.584 ******* 2026-03-18 13:09:39.094979 | controller | ok: [controller] 2026-03-18 13:09:39.095070 | controller | 2026-03-18 13:09:39.095081 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-18 13:09:39.095185 | controller | Wednesday 18 March 2026 13:09:39 +0000 (0:00:01.218) 0:00:02.803 ******* 2026-03-18 13:09:39.572064 | controller | ok: [controller] 2026-03-18 13:09:39.572147 | controller | 2026-03-18 13:09:39.572157 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-18 13:09:39.572223 | controller | Wednesday 18 March 2026 13:09:39 +0000 (0:00:00.479) 0:00:03.283 ******* 2026-03-18 13:09:39.626144 | controller | ok: [controller] => { 2026-03-18 13:09:39.626215 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-18 13:09:39.626322 | controller | } 2026-03-18 13:09:39.626419 | controller | 2026-03-18 13:09:39.626548 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-18 13:09:39.626717 | controller | Wednesday 18 March 2026 13:09:39 +0000 (0:00:00.053) 0:00:03.336 ******* 2026-03-18 13:09:40.198236 | controller | ok: [controller] 2026-03-18 13:09:40.198309 | controller | 2026-03-18 13:09:40.198332 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-18 13:09:40.198346 | controller | Wednesday 18 March 2026 13:09:40 +0000 (0:00:00.570) 0:00:03.907 ******* 2026-03-18 13:09:42.018996 | controller | ok: [controller] 2026-03-18 13:09:42.019083 | controller | 2026-03-18 13:09:42.019095 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-18 13:09:42.019108 | controller | Wednesday 18 March 2026 13:09:42 +0000 (0:00:01.822) 0:00:05.729 ******* 2026-03-18 13:09:42.555376 | controller | ok: [controller] 2026-03-18 13:09:42.555451 | controller | 2026-03-18 13:09:42.555458 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-18 13:09:42.558746 | controller | Wednesday 18 March 2026 13:09:42 +0000 (0:00:00.536) 0:00:06.266 ******* 2026-03-18 13:09:43.019013 | controller | ok: [controller] 2026-03-18 13:09:43.019096 | controller | 2026-03-18 13:09:43.019288 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-18 13:09:43.019521 | controller | Wednesday 18 March 2026 13:09:43 +0000 (0:00:00.463) 0:00:06.729 ******* 2026-03-18 13:09:43.498477 | controller | ok: [controller] 2026-03-18 13:09:43.498518 | controller | 2026-03-18 13:09:43.498771 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-18 13:09:43.498839 | controller | Wednesday 18 March 2026 13:09:43 +0000 (0:00:00.480) 0:00:07.209 ******* 2026-03-18 13:09:43.823486 | controller | ok: [controller] 2026-03-18 13:09:43.823663 | controller | 2026-03-18 13:09:43.824015 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-18 13:09:43.824249 | controller | Wednesday 18 March 2026 13:09:43 +0000 (0:00:00.324) 0:00:07.533 ******* 2026-03-18 13:09:44.150852 | controller | ok: [controller] 2026-03-18 13:09:44.150906 | controller | 2026-03-18 13:09:44.150916 | controller | TASK [Install plugin] ********************************************************** 2026-03-18 13:09:44.150926 | controller | Wednesday 18 March 2026 13:09:44 +0000 (0:00:00.324) 0:00:07.858 ******* 2026-03-18 13:09:44.211327 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-18 13:09:44.211442 | controller | 2026-03-18 13:09:44.211571 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-18 13:09:44.211718 | controller | Wednesday 18 March 2026 13:09:44 +0000 (0:00:00.060) 0:00:07.918 ******* 2026-03-18 13:09:44.255748 | controller | ok: [controller] => { 2026-03-18 13:09:44.255864 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-18 13:09:44.255974 | controller | } 2026-03-18 13:09:44.256096 | controller | 2026-03-18 13:09:44.256226 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-18 13:09:44.256362 | controller | Wednesday 18 March 2026 13:09:44 +0000 (0:00:00.047) 0:00:07.966 ******* 2026-03-18 13:09:44.706438 | controller | ok: [controller] 2026-03-18 13:09:44.706543 | controller | 2026-03-18 13:09:44.706988 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-18 13:09:44.707033 | controller | Wednesday 18 March 2026 13:09:44 +0000 (0:00:00.450) 0:00:08.416 ******* 2026-03-18 13:09:47.477190 | controller | ok: [controller] 2026-03-18 13:09:47.477216 | controller | 2026-03-18 13:09:47.477221 | controller | PLAY RECAP ********************************************************************* 2026-03-18 13:09:47.477226 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-18 13:09:47.477229 | controller | 2026-03-18 13:09:47.477233 | controller | 2026-03-18 13:09:47.477236 | controller | TASKS RECAP ******************************************************************** 2026-03-18 13:09:47.477239 | controller | Wednesday 18 March 2026 13:09:47 +0000 (0:00:02.765) 0:00:11.182 ******* 2026-03-18 13:09:47.477243 | controller | =============================================================================== 2026-03-18 13:09:47.477246 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.77s 2026-03-18 13:09:47.477249 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.82s 2026-03-18 13:09:47.477252 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.22s 2026-03-18 13:09:47.477255 | controller | Gathering Facts --------------------------------------------------------- 1.11s 2026-03-18 13:09:47.477258 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.57s 2026-03-18 13:09:47.477261 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.54s 2026-03-18 13:09:47.477265 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.48s 2026-03-18 13:09:47.477268 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.48s 2026-03-18 13:09:47.477272 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.46s 2026-03-18 13:09:47.477275 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.46s 2026-03-18 13:09:47.477289 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.45s 2026-03-18 13:09:47.477292 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.33s 2026-03-18 13:09:47.477295 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.32s 2026-03-18 13:09:47.477298 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-18 13:09:47.477302 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-18 13:09:47.477305 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-18 13:09:47.583075 | controller | INFO [helm > idempotence] Executed: Successful 2026-03-18 13:09:47.589529 | controller | INFO [helm > side_effect] Executing 2026-03-18 13:09:47.589913 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-18 13:09:47.595382 | controller | INFO [helm > verify] Executing 2026-03-18 13:09:48.476550 | controller | 2026-03-18 13:09:48.476914 | controller | PLAY [Verify] ****************************************************************** 2026-03-18 13:09:48.477219 | controller | 2026-03-18 13:09:48.477588 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-18 13:09:48.477915 | controller | Wednesday 18 March 2026 13:09:48 +0000 (0:00:00.010) 0:00:00.010 ******* 2026-03-18 13:09:50.615094 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-18 13:09:50.616186 | controller | ok: [controller] 2026-03-18 13:09:50.616353 | controller | 2026-03-18 13:09:50.616524 | controller | TASK [Get the current Helm version] ******************************************** 2026-03-18 13:09:50.616695 | controller | Wednesday 18 March 2026 13:09:50 +0000 (0:00:02.139) 0:00:02.150 ******* 2026-03-18 13:09:51.087627 | controller | changed: [controller] 2026-03-18 13:09:51.087827 | controller | 2026-03-18 13:09:51.087997 | controller | TASK [Assert Helm version] ***************************************************** 2026-03-18 13:09:51.088163 | controller | Wednesday 18 March 2026 13:09:51 +0000 (0:00:00.469) 0:00:02.619 ******* 2026-03-18 13:09:51.117440 | controller | ok: [controller] => { 2026-03-18 13:09:51.117764 | controller | "changed": false, 2026-03-18 13:09:51.118035 | controller | "msg": "All assertions passed" 2026-03-18 13:09:51.118285 | controller | } 2026-03-18 13:09:51.118520 | controller | 2026-03-18 13:09:51.118930 | controller | PLAY RECAP ********************************************************************* 2026-03-18 13:09:51.119274 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-18 13:09:51.119517 | controller | 2026-03-18 13:09:51.119816 | controller | 2026-03-18 13:09:51.120081 | controller | TASKS RECAP ******************************************************************** 2026-03-18 13:09:51.120334 | controller | Wednesday 18 March 2026 13:09:51 +0000 (0:00:00.031) 0:00:02.651 ******* 2026-03-18 13:09:51.120625 | controller | =============================================================================== 2026-03-18 13:09:51.120977 | controller | Gathering Facts --------------------------------------------------------- 2.14s 2026-03-18 13:09:51.121329 | controller | Get the current Helm version -------------------------------------------- 0.47s 2026-03-18 13:09:51.121651 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-03-18 13:09:51.239778 | controller | INFO [helm > verify] Executed: Successful 2026-03-18 13:09:51.249658 | controller | INFO [helm > cleanup] Executing 2026-03-18 13:09:51.250130 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-18 13:09:51.256136 | controller | INFO [helm > destroy] Executing 2026-03-18 13:09:51.256265 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-18 13:09:51.256356 | controller | INFO [helm > destroy] Executed: Successful 2026-03-18 13:09:51.256666 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-18 13:09:51.580898 | controller | ok: Runtime: 0:00:53.966058 2026-03-18 13:09:51.586298 | 2026-03-18 13:09:51.586361 | PLAY RECAP 2026-03-18 13:09:51.586418 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 13:09:51.586448 | 2026-03-18 13:09:51.710879 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-18 13:09:51.712823 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-18 13:09:52.302534 | 2026-03-18 13:09:52.302719 | PLAY [all] 2026-03-18 13:09:52.315450 | 2026-03-18 13:09:52.315584 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-18 13:09:52.728216 | controller | changed 2026-03-18 13:09:52.735057 | 2026-03-18 13:09:52.735251 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-18 13:09:53.162375 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 13:09:53.162527 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 13:09:53.169647 | controller | environment: line 1: kubectl: command not found 2026-03-18 13:09:53.171563 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 13:09:53.172743 | controller | environment: line 1: kubectl: command not found 2026-03-18 13:09:53.173981 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 13:09:53.175803 | controller | environment: line 1: kubectl: command not found 2026-03-18 13:09:53.177084 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 13:09:53.181190 | controller | environment: line 1: kubectl: command not found 2026-03-18 13:09:53.182822 | controller | environment: line 1: kubectl: command not found 2026-03-18 13:09:53.183814 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 13:09:53.184662 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 13:09:53.276083 | controller | ok: Runtime: 0:00:00.036750 2026-03-18 13:09:53.282785 | 2026-03-18 13:09:53.282915 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-18 13:09:53.534764 | controller | changed 2026-03-18 13:09:53.541195 | 2026-03-18 13:09:53.541327 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-18 13:09:53.789184 | controller | environment: line 5: kubectl: command not found 2026-03-18 13:09:53.789331 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 13:09:53.790325 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 13:09:53.790461 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 13:09:54.073778 | controller | ok: Runtime: 0:00:00.012994 2026-03-18 13:09:54.081350 | 2026-03-18 13:09:54.081427 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-18 13:09:54.778905 | controller | changed: 2026-03-18 13:09:54.779166 | controller | created directory /var/lib/zuul/builds/ecec3ef208344839afa7402fbbb7d15e/work/logs/controller 2026-03-18 13:09:54.779225 | controller | cd+++++++++ objects/ 2026-03-18 13:09:54.779261 | controller | cd+++++++++ objects/cluster/ 2026-03-18 13:09:54.779295 | controller | cd+++++++++ objects/namespaced/ 2026-03-18 13:09:54.788618 | 2026-03-18 13:09:54.788730 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-18 13:09:55.035434 | controller | changed 2026-03-18 13:09:55.041493 | 2026-03-18 13:09:55.041604 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-18 13:09:55.297396 | controller | changed 2026-03-18 13:09:55.303516 | 2026-03-18 13:09:55.303680 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-18 13:09:55.566253 | controller | environment: line 3: kubectl: command not found 2026-03-18 13:09:55.838995 | controller | ok: Runtime: 0:00:00.013872 2026-03-18 13:09:55.845035 | 2026-03-18 13:09:55.845126 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-18 13:09:56.405852 | controller | changed: 2026-03-18 13:09:56.406036 | controller | cd+++++++++ pod-logs/ 2026-03-18 13:09:56.406067 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-03-18 13:09:56.413635 | 2026-03-18 13:09:56.413719 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-18 13:09:56.662552 | controller | changed: "values" 2026-03-18 13:09:56.877057 | controller | changed: "releases" 2026-03-18 13:09:56.895402 | 2026-03-18 13:09:56.895597 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-18 13:09:57.147195 | controller | /bin/bash: line 3: kubectl: command not found 2026-03-18 13:09:57.427860 | controller | ok: Runtime: 0:00:00.008252 2026-03-18 13:09:57.434365 | 2026-03-18 13:09:57.434471 | TASK [helm-release-status : Downloads logs to executor] 2026-03-18 13:09:58.014783 | controller | changed: 2026-03-18 13:09:58.015526 | controller | cd+++++++++ helm/ 2026-03-18 13:09:58.015573 | controller | cd+++++++++ helm/releases/ 2026-03-18 13:09:58.015607 | controller | cd+++++++++ helm/values/ 2026-03-18 13:09:58.022757 | 2026-03-18 13:09:58.022857 | PLAY RECAP 2026-03-18 13:09:58.022921 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 13:09:58.022953 | 2026-03-18 13:09:58.158629 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-18 13:09:58.163009 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-18 13:09:58.799421 | 2026-03-18 13:09:58.799588 | PLAY [all] 2026-03-18 13:09:58.813020 | 2026-03-18 13:09:58.813164 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-18 13:09:58.859133 | controller | skipping: Conditional result was False 2026-03-18 13:09:58.867996 | 2026-03-18 13:09:58.868127 | TASK [fetch-output : Set log path for single node] 2026-03-18 13:09:58.912948 | controller | ok 2026-03-18 13:09:58.918636 | 2026-03-18 13:09:58.918716 | LOOP [fetch-output : Ensure local output dirs] 2026-03-18 13:09:59.335390 | controller -> localhost | ok: "/var/lib/zuul/builds/ecec3ef208344839afa7402fbbb7d15e/work/logs" 2026-03-18 13:09:59.558003 | controller -> localhost | changed: "/var/lib/zuul/builds/ecec3ef208344839afa7402fbbb7d15e/work/artifacts" 2026-03-18 13:09:59.786299 | controller -> localhost | changed: "/var/lib/zuul/builds/ecec3ef208344839afa7402fbbb7d15e/work/docs" 2026-03-18 13:09:59.805650 | 2026-03-18 13:09:59.805839 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-18 13:10:00.566871 | controller | changed: .d..t...... ./ 2026-03-18 13:10:00.567307 | controller | changed: All items complete 2026-03-18 13:10:00.567385 | 2026-03-18 13:10:01.094090 | controller | changed: .d..t...... ./ 2026-03-18 13:10:01.629207 | controller | changed: .d..t...... ./ 2026-03-18 13:10:01.653047 | 2026-03-18 13:10:01.653190 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-18 13:10:02.140788 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.009657 2026-03-18 13:10:02.397974 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008439 2026-03-18 13:10:02.407487 | 2026-03-18 13:10:02.407609 | PLAY [all] 2026-03-18 13:10:02.414984 | 2026-03-18 13:10:02.415136 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-18 13:10:02.935192 | controller | changed 2026-03-18 13:10:02.940336 | 2026-03-18 13:10:02.940412 | PLAY RECAP 2026-03-18 13:10:02.940462 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-18 13:10:02.940486 | 2026-03-18 13:10:03.079959 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-18 13:10:03.081902 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-18 13:10:03.698803 | 2026-03-18 13:10:03.699521 | PLAY [localhost] 2026-03-18 13:10:03.709987 | 2026-03-18 13:10:03.710096 | TASK [Generate Zuul manifest] 2026-03-18 13:10:03.731318 | localhost | ok 2026-03-18 13:10:03.750447 | 2026-03-18 13:10:03.750611 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-18 13:10:04.169199 | localhost | changed 2026-03-18 13:10:04.181379 | 2026-03-18 13:10:04.181570 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-18 13:10:04.213875 | localhost | ok 2026-03-18 13:10:04.224013 | 2026-03-18 13:10:04.224159 | TASK [Upload logs] 2026-03-18 13:10:04.243371 | localhost | ok 2026-03-18 13:10:04.307814 | 2026-03-18 13:10:04.307982 | TASK [Set zuul-log-path fact] 2026-03-18 13:10:04.327571 | localhost | ok 2026-03-18 13:10:04.341612 | 2026-03-18 13:10:04.341776 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-18 13:10:04.372576 | localhost | ok 2026-03-18 13:10:04.381138 | 2026-03-18 13:10:04.381277 | TASK [upload-logs : Create log directories] 2026-03-18 13:10:04.821663 | localhost | changed 2026-03-18 13:10:04.828481 | 2026-03-18 13:10:04.828593 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-18 13:10:05.287449 | localhost -> localhost | ok: Runtime: 0:00:00.006134 2026-03-18 13:10:05.294778 | 2026-03-18 13:10:05.294874 | TASK [upload-logs : Upload logs to log server] 2026-03-18 13:10:05.803494 | localhost | Output suppressed because no_log was given 2026-03-18 13:10:05.808404 | 2026-03-18 13:10:05.808491 | LOOP [upload-logs : Compress console log and json output] 2026-03-18 13:10:05.858528 | localhost | skipping: Conditional result was False 2026-03-18 13:10:05.866167 | localhost | skipping: Conditional result was False 2026-03-18 13:10:05.884506 | 2026-03-18 13:10:05.884762 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-18 13:10:05.929644 | localhost | skipping: Conditional result was False 2026-03-18 13:10:05.930051 | 2026-03-18 13:10:05.935141 | localhost | skipping: Conditional result was False 2026-03-18 13:10:05.951039 | 2026-03-18 13:10:05.951216 | LOOP [upload-logs : Upload console log and json output]