2026-05-13 01:27:45.183227 | Job console starting 2026-05-13 01:27:45.195866 | Updating git repos 2026-05-13 01:27:45.261827 | Cloning repos into workspace 2026-05-13 01:27:47.382697 | Restoring repo states 2026-05-13 01:27:47.397866 | Merging changes 2026-05-13 01:27:48.147466 | Checking out repos 2026-05-13 01:27:48.326444 | Preparing playbooks 2026-05-13 01:28:00.297287 | Running Ansible setup 2026-05-13 01:28:05.138141 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-13 01:28:05.702293 | 2026-05-13 01:28:05.702411 | PLAY [localhost] 2026-05-13 01:28:05.709800 | 2026-05-13 01:28:05.709871 | TASK [Gathering Facts] 2026-05-13 01:28:06.767375 | localhost | ok 2026-05-13 01:28:06.776327 | 2026-05-13 01:28:06.776401 | TASK [Setup log path fact] 2026-05-13 01:28:06.793851 | localhost | ok 2026-05-13 01:28:06.811202 | 2026-05-13 01:28:06.811280 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-13 01:28:06.840711 | localhost | ok 2026-05-13 01:28:06.848030 | 2026-05-13 01:28:06.848096 | TASK [emit-job-header : Print job information] 2026-05-13 01:28:06.887816 | # Job Information 2026-05-13 01:28:06.888015 | Ansible Version: 2.16.18 2026-05-13 01:28:06.888083 | Job: ansible-collection-kubernetes-molecule-helm 2026-05-13 01:28:06.888131 | Pipeline: check 2026-05-13 01:28:06.888175 | Executor: 2d72f0692154 2026-05-13 01:28:06.888218 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/272 2026-05-13 01:28:06.888267 | Event ID: d32e68d0-4e6a-11f1-9f22-d6104c5a1163 2026-05-13 01:28:06.892789 | 2026-05-13 01:28:06.892849 | LOOP [emit-job-header : Print node information] 2026-05-13 01:28:07.449863 | localhost | ok: 2026-05-13 01:28:07.450034 | localhost | # Node Information 2026-05-13 01:28:07.450063 | localhost | Inventory Hostname: controller 2026-05-13 01:28:07.450086 | localhost | Hostname: np0000173878 2026-05-13 01:28:07.450106 | localhost | Username: zuul 2026-05-13 01:28:07.450132 | localhost | Distro: Debian 13.4 2026-05-13 01:28:07.452813 | localhost | Provider: yul1 2026-05-13 01:28:07.452849 | localhost | Region: ca-ymq-1 2026-05-13 01:28:07.452877 | localhost | Label: debian-trixie 2026-05-13 01:28:07.452904 | localhost | Product Name: OpenStack Nova 2026-05-13 01:28:07.452928 | localhost | Interface IP: 199.204.45.242 2026-05-13 01:28:07.463334 | 2026-05-13 01:28:07.463811 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-13 01:28:07.875181 | localhost -> localhost | changed 2026-05-13 01:28:07.881510 | 2026-05-13 01:28:07.881588 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-13 01:28:09.128683 | localhost -> localhost | changed 2026-05-13 01:28:09.134901 | 2026-05-13 01:28:09.134966 | PLAY [all] 2026-05-13 01:28:09.141219 | 2026-05-13 01:28:09.141289 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-13 01:28:09.357476 | controller -> localhost | ok 2026-05-13 01:28:09.362245 | 2026-05-13 01:28:09.362315 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-13 01:28:09.394028 | controller | ok 2026-05-13 01:28:09.410577 | controller | included: /var/lib/zuul/builds/10b46dbce4e54e12a0a8715473097d0f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-13 01:28:09.415129 | 2026-05-13 01:28:09.415187 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-13 01:28:11.209188 | controller -> localhost | Generating public/private rsa key pair. 2026-05-13 01:28:11.209379 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/10b46dbce4e54e12a0a8715473097d0f/work/10b46dbce4e54e12a0a8715473097d0f_id_rsa 2026-05-13 01:28:11.209409 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/10b46dbce4e54e12a0a8715473097d0f/work/10b46dbce4e54e12a0a8715473097d0f_id_rsa.pub 2026-05-13 01:28:11.209432 | controller -> localhost | The key fingerprint is: 2026-05-13 01:28:11.209455 | controller -> localhost | SHA256:S4lrw5fJvWPGlDxDT5rrcrsCb1aTNJRCyGQEQPLHiJE zuul-build-sshkey 2026-05-13 01:28:11.209492 | controller -> localhost | The key's randomart image is: 2026-05-13 01:28:11.209514 | controller -> localhost | +---[RSA 3072]----+ 2026-05-13 01:28:11.209542 | controller -> localhost | |ooo..=+o. . | 2026-05-13 01:28:11.209564 | controller -> localhost | |E= o .o . o | 2026-05-13 01:28:11.209584 | controller -> localhost | |. o o o | 2026-05-13 01:28:11.209605 | controller -> localhost | | . . .+ . | 2026-05-13 01:28:11.209625 | controller -> localhost | | . S+ O | 2026-05-13 01:28:11.209651 | controller -> localhost | | ..+ =% . | 2026-05-13 01:28:11.209674 | controller -> localhost | | =o*+.= | 2026-05-13 01:28:11.209694 | controller -> localhost | | . o* B. | 2026-05-13 01:28:11.209718 | controller -> localhost | | o B=+ | 2026-05-13 01:28:11.209740 | controller -> localhost | +----[SHA256]-----+ 2026-05-13 01:28:11.209797 | controller -> localhost | ok: Runtime: 0:00:01.331764 2026-05-13 01:28:11.214173 | 2026-05-13 01:28:11.214244 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-13 01:28:11.247763 | controller | ok 2026-05-13 01:28:11.255395 | controller | included: /var/lib/zuul/builds/10b46dbce4e54e12a0a8715473097d0f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-13 01:28:11.264556 | 2026-05-13 01:28:11.264701 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-13 01:28:11.289977 | controller | skipping: Conditional result was False 2026-05-13 01:28:11.295969 | 2026-05-13 01:28:11.296059 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-13 01:28:11.872209 | controller | changed 2026-05-13 01:28:11.878043 | 2026-05-13 01:28:11.878118 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-13 01:28:12.079079 | controller | ok 2026-05-13 01:28:12.083723 | 2026-05-13 01:28:12.083794 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-13 01:28:12.620850 | controller | changed 2026-05-13 01:28:12.627123 | 2026-05-13 01:28:12.627243 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-13 01:28:13.159821 | controller | changed 2026-05-13 01:28:13.165399 | 2026-05-13 01:28:13.165466 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-13 01:28:13.193962 | controller | skipping: Conditional result was False 2026-05-13 01:28:13.201389 | 2026-05-13 01:28:13.201494 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-13 01:28:13.614467 | controller -> localhost | changed 2026-05-13 01:28:13.627386 | 2026-05-13 01:28:13.627535 | TASK [add-build-sshkey : Add back temp key] 2026-05-13 01:28:13.932124 | controller -> localhost | Identity added: /var/lib/zuul/builds/10b46dbce4e54e12a0a8715473097d0f/work/10b46dbce4e54e12a0a8715473097d0f_id_rsa (zuul-build-sshkey) 2026-05-13 01:28:13.932372 | controller -> localhost | ok: Runtime: 0:00:00.014201 2026-05-13 01:28:13.936475 | 2026-05-13 01:28:13.936537 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-13 01:28:14.305041 | controller | ok 2026-05-13 01:28:14.309211 | 2026-05-13 01:28:14.309278 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-13 01:28:14.334057 | controller | skipping: Conditional result was False 2026-05-13 01:28:14.345565 | 2026-05-13 01:28:14.345655 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-05-13 01:28:14.723834 | controller | ok 2026-05-13 01:28:14.730741 | 2026-05-13 01:28:14.730805 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-05-13 01:28:15.790020 | controller | Output suppressed because no_log was given 2026-05-13 01:28:15.799195 | 2026-05-13 01:28:15.799260 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-05-13 01:28:16.021196 | controller | ok: "logs" 2026-05-13 01:28:16.022300 | controller | ok: All items complete 2026-05-13 01:28:16.022382 | 2026-05-13 01:28:16.201456 | controller | ok: "artifacts" 2026-05-13 01:28:16.404803 | controller | ok: "docs" 2026-05-13 01:28:16.418600 | 2026-05-13 01:28:16.418787 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-05-13 01:28:16.628690 | controller | changed: "logs" 2026-05-13 01:28:16.812131 | controller | changed: "artifacts" 2026-05-13 01:28:17.007726 | controller | changed: "docs" 2026-05-13 01:28:17.031340 | 2026-05-13 01:28:17.031484 | PLAY RECAP 2026-05-13 01:28:17.031541 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-05-13 01:28:17.031570 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-13 01:28:17.031593 | 2026-05-13 01:28:17.419741 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-13 01:28:17.422787 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-13 01:28:18.044864 | 2026-05-13 01:28:18.045004 | PLAY [all] 2026-05-13 01:28:18.055722 | 2026-05-13 01:28:18.055804 | TASK [setup-uv : Extract archive] 2026-05-13 01:28:21.554947 | controller | changed 2026-05-13 01:28:21.563026 | 2026-05-13 01:28:21.563148 | TASK [setup-uv : Print version] 2026-05-13 01:28:21.928031 | controller | uv 0.8.13 2026-05-13 01:28:22.265469 | controller | ok: Runtime: 0:00:00.014276 2026-05-13 01:28:22.272381 | 2026-05-13 01:28:22.272470 | PLAY RECAP 2026-05-13 01:28:22.272514 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-13 01:28:22.272537 | 2026-05-13 01:28:22.381559 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-13 01:28:22.384734 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-05-13 01:28:23.071976 | 2026-05-13 01:28:23.072199 | PLAY [all] 2026-05-13 01:28:23.084111 | 2026-05-13 01:28:23.084301 | TASK [Update apt cache] 2026-05-13 01:28:27.797372 | controller | ok 2026-05-13 01:28:27.802457 | 2026-05-13 01:28:27.802542 | TASK [Disable firewalld] 2026-05-13 01:28:27.829641 | controller | skipping: Conditional result was False 2026-05-13 01:28:27.837092 | 2026-05-13 01:28:27.837183 | TASK [Install "jq" for log collection] 2026-05-13 01:28:30.097369 | controller | changed 2026-05-13 01:28:30.099789 | 2026-05-13 01:28:30.099834 | PLAY RECAP 2026-05-13 01:28:30.099875 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-13 01:28:30.099896 | 2026-05-13 01:28:30.201430 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-05-13 01:28:30.202759 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-13 01:28:30.790823 | 2026-05-13 01:28:30.791036 | PLAY [all] 2026-05-13 01:28:30.801423 | 2026-05-13 01:28:30.801497 | TASK [Copy inventory file for Zuul] 2026-05-13 01:28:31.774158 | controller | changed 2026-05-13 01:28:31.778600 | 2026-05-13 01:28:31.778681 | TASK [Switch "ansible_host" to private IP] 2026-05-13 01:28:32.145373 | controller | changed: 1 replacements made 2026-05-13 01:28:32.152200 | 2026-05-13 01:28:32.152293 | TASK [Run Molecule scenario] 2026-05-13 01:28:32.561006 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-05-13 01:28:32.561163 | controller | Creating virtual environment at: .venv 2026-05-13 01:28:32.831267 | controller | Downloading ansible-core (2.3MiB) 2026-05-13 01:28:32.832689 | controller | Downloading pygments (1.2MiB) 2026-05-13 01:28:32.843706 | controller | Downloading cryptography (4.3MiB) 2026-05-13 01:28:33.002902 | controller | Downloading cryptography 2026-05-13 01:28:33.056492 | controller | Downloading pygments 2026-05-13 01:28:33.215143 | controller | Downloading ansible-core 2026-05-13 01:28:33.264079 | controller | Installed 36 packages in 48ms 2026-05-13 01:28:33.982455 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-05-13 01:28:33.982545 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-05-13 01:28:34.896580 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-05-13 01:28:34.896658 | controller | INFO default scenario not found, disabling shared state. 2026-05-13 01:28:34.896939 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-05-13 01:28:34.897110 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-05-13 01:28:50.351904 | controller | INFO [helm > dependency] Executing 2026-05-13 01:28:50.352025 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-05-13 01:28:50.352242 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-05-13 01:28:50.352380 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-05-13 01:28:50.358049 | controller | INFO [helm > cleanup] Executing 2026-05-13 01:28:50.358483 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-13 01:28:50.365930 | controller | INFO [helm > destroy] Executing 2026-05-13 01:28:50.366035 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-05-13 01:28:50.366125 | controller | INFO [helm > destroy] Executed: Successful 2026-05-13 01:28:50.372341 | controller | INFO [helm > syntax] Executing 2026-05-13 01:28:51.322718 | controller | 2026-05-13 01:28:51.322797 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-05-13 01:28:51.420158 | controller | INFO [helm > syntax] Executed: Successful 2026-05-13 01:28:51.429837 | controller | INFO [helm > create] Executing 2026-05-13 01:28:51.431295 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-13 01:28:51.436742 | controller | INFO [helm > prepare] Executing 2026-05-13 01:28:52.349571 | controller | 2026-05-13 01:28:52.349654 | controller | PLAY [Prepare] ***************************************************************** 2026-05-13 01:28:52.349813 | controller | 2026-05-13 01:28:52.350013 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-13 01:28:52.350228 | controller | Wednesday 13 May 2026 01:28:52 +0000 (0:00:00.030) 0:00:00.030 ********* 2026-05-13 01:28:53.641072 | 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-05-13 01:28:53.647096 | controller | ok: [controller] 2026-05-13 01:28:53.647185 | controller | 2026-05-13 01:28:53.647304 | controller | TASK [Install Debian packages] ************************************************* 2026-05-13 01:28:53.647418 | controller | Wednesday 13 May 2026 01:28:53 +0000 (0:00:01.298) 0:00:01.329 ********* 2026-05-13 01:28:55.181698 | controller | ok: [controller] 2026-05-13 01:28:55.181891 | controller | 2026-05-13 01:28:55.182102 | controller | PLAY RECAP ********************************************************************* 2026-05-13 01:28:55.182332 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-13 01:28:55.182519 | controller | 2026-05-13 01:28:55.182732 | controller | 2026-05-13 01:28:55.182936 | controller | TASKS RECAP ******************************************************************** 2026-05-13 01:28:55.183143 | controller | Wednesday 13 May 2026 01:28:55 +0000 (0:00:01.534) 0:00:02.864 ********* 2026-05-13 01:28:55.184250 | controller | =============================================================================== 2026-05-13 01:28:55.184316 | controller | Install Debian packages ------------------------------------------------- 1.53s 2026-05-13 01:28:55.184330 | controller | Gathering Facts --------------------------------------------------------- 1.30s 2026-05-13 01:28:55.290584 | controller | INFO [helm > prepare] Executed: Successful 2026-05-13 01:28:55.301415 | controller | INFO [helm > converge] Executing 2026-05-13 01:28:56.121324 | controller | 2026-05-13 01:28:56.121544 | controller | PLAY [Converge] **************************************************************** 2026-05-13 01:28:56.121823 | controller | 2026-05-13 01:28:56.122031 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-13 01:28:56.122221 | controller | Wednesday 13 May 2026 01:28:56 +0000 (0:00:00.012) 0:00:00.012 ********* 2026-05-13 01:28:57.175009 | 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-05-13 01:28:57.183103 | controller | ok: [controller] 2026-05-13 01:28:57.183234 | controller | 2026-05-13 01:28:57.183429 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-05-13 01:28:57.183618 | controller | Wednesday 13 May 2026 01:28:57 +0000 (0:00:01.061) 0:00:01.074 ********* 2026-05-13 01:28:57.667371 | controller | ok: [controller] 2026-05-13 01:28:57.667441 | controller | 2026-05-13 01:28:57.667645 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-05-13 01:28:57.667833 | controller | Wednesday 13 May 2026 01:28:57 +0000 (0:00:00.484) 0:00:01.558 ********* 2026-05-13 01:28:58.748835 | controller | ok: [controller] 2026-05-13 01:28:58.748918 | controller | 2026-05-13 01:28:58.749097 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-05-13 01:28:58.749296 | controller | Wednesday 13 May 2026 01:28:58 +0000 (0:00:01.080) 0:00:02.639 ********* 2026-05-13 01:28:59.180394 | controller | changed: [controller] 2026-05-13 01:28:59.180513 | controller | 2026-05-13 01:28:59.180730 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-13 01:28:59.180918 | controller | Wednesday 13 May 2026 01:28:59 +0000 (0:00:00.431) 0:00:03.071 ********* 2026-05-13 01:28:59.228819 | controller | ok: [controller] => { 2026-05-13 01:28:59.228970 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-05-13 01:28:59.229266 | controller | } 2026-05-13 01:28:59.229483 | controller | 2026-05-13 01:28:59.229684 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-13 01:28:59.229885 | controller | Wednesday 13 May 2026 01:28:59 +0000 (0:00:00.048) 0:00:03.119 ********* 2026-05-13 01:29:00.362144 | 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-05-13 01:29:00.369847 | controller | changed: [controller] 2026-05-13 01:29:00.369931 | controller | 2026-05-13 01:29:00.370079 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-13 01:29:00.370211 | controller | Wednesday 13 May 2026 01:29:00 +0000 (0:00:01.141) 0:00:04.261 ********* 2026-05-13 01:29:02.427908 | controller | changed: [controller] 2026-05-13 01:29:02.428044 | controller | 2026-05-13 01:29:02.428320 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-05-13 01:29:02.428510 | controller | Wednesday 13 May 2026 01:29:02 +0000 (0:00:02.057) 0:00:06.318 ********* 2026-05-13 01:29:02.972636 | controller | ok: [controller] 2026-05-13 01:29:02.972768 | controller | 2026-05-13 01:29:02.972971 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-05-13 01:29:02.973164 | controller | Wednesday 13 May 2026 01:29:02 +0000 (0:00:00.544) 0:00:06.863 ********* 2026-05-13 01:29:03.402959 | controller | changed: [controller] 2026-05-13 01:29:03.403066 | controller | 2026-05-13 01:29:03.403325 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-05-13 01:29:03.403466 | controller | Wednesday 13 May 2026 01:29:03 +0000 (0:00:00.430) 0:00:07.293 ********* 2026-05-13 01:29:03.848351 | controller | ok: [controller] 2026-05-13 01:29:03.848491 | controller | 2026-05-13 01:29:03.848705 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-05-13 01:29:03.848901 | controller | Wednesday 13 May 2026 01:29:03 +0000 (0:00:00.444) 0:00:07.738 ********* 2026-05-13 01:29:04.143564 | controller | changed: [controller] 2026-05-13 01:29:04.143617 | controller | 2026-05-13 01:29:04.143631 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-05-13 01:29:04.143642 | controller | Wednesday 13 May 2026 01:29:04 +0000 (0:00:00.295) 0:00:08.033 ********* 2026-05-13 01:29:04.442734 | controller | ok: [controller] 2026-05-13 01:29:04.442777 | controller | 2026-05-13 01:29:04.442787 | controller | TASK [Install plugin] ********************************************************** 2026-05-13 01:29:04.442795 | controller | Wednesday 13 May 2026 01:29:04 +0000 (0:00:00.299) 0:00:08.333 ********* 2026-05-13 01:29:04.499542 | controller | included: vexxhost.containers.download_artifact for controller 2026-05-13 01:29:04.499844 | controller | 2026-05-13 01:29:04.500173 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-13 01:29:04.500441 | controller | Wednesday 13 May 2026 01:29:04 +0000 (0:00:00.057) 0:00:08.390 ********* 2026-05-13 01:29:04.548175 | controller | ok: [controller] => { 2026-05-13 01:29:04.549052 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-05-13 01:29:04.550004 | controller | } 2026-05-13 01:29:04.550025 | controller | 2026-05-13 01:29:04.550034 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-13 01:29:04.550045 | controller | Wednesday 13 May 2026 01:29:04 +0000 (0:00:00.048) 0:00:08.439 ********* 2026-05-13 01:29:05.361867 | controller | changed: [controller] 2026-05-13 01:29:05.362161 | controller | 2026-05-13 01:29:05.362425 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-13 01:29:05.362710 | controller | Wednesday 13 May 2026 01:29:05 +0000 (0:00:00.813) 0:00:09.252 ********* 2026-05-13 01:29:07.460593 | controller | changed: [controller] 2026-05-13 01:29:07.460958 | controller | 2026-05-13 01:29:07.461235 | controller | PLAY RECAP ********************************************************************* 2026-05-13 01:29:07.461510 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-13 01:29:07.461772 | controller | 2026-05-13 01:29:07.462028 | controller | 2026-05-13 01:29:07.462301 | controller | TASKS RECAP ******************************************************************** 2026-05-13 01:29:07.462578 | controller | Wednesday 13 May 2026 01:29:07 +0000 (0:00:02.098) 0:00:11.351 ********* 2026-05-13 01:29:07.462825 | controller | =============================================================================== 2026-05-13 01:29:07.463095 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.10s 2026-05-13 01:29:07.463354 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.06s 2026-05-13 01:29:07.463607 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.14s 2026-05-13 01:29:07.463873 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.08s 2026-05-13 01:29:07.464182 | controller | Gathering Facts --------------------------------------------------------- 1.06s 2026-05-13 01:29:07.464454 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.81s 2026-05-13 01:29:07.464706 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.54s 2026-05-13 01:29:07.464999 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.48s 2026-05-13 01:29:07.465282 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.44s 2026-05-13 01:29:07.465600 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.43s 2026-05-13 01:29:07.465999 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.43s 2026-05-13 01:29:07.466294 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-05-13 01:29:07.466584 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.30s 2026-05-13 01:29:07.466769 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-05-13 01:29:07.466945 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-05-13 01:29:07.467105 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-05-13 01:29:07.607066 | controller | INFO [helm > converge] Executed: Successful 2026-05-13 01:29:07.617403 | controller | INFO [helm > idempotence] Executing 2026-05-13 01:29:08.475222 | controller | 2026-05-13 01:29:08.475288 | controller | PLAY [Converge] **************************************************************** 2026-05-13 01:29:08.475306 | controller | 2026-05-13 01:29:08.475370 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-13 01:29:08.475465 | controller | Wednesday 13 May 2026 01:29:08 +0000 (0:00:00.012) 0:00:00.012 ********* 2026-05-13 01:29:09.559868 | 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-05-13 01:29:09.569580 | controller | ok: [controller] 2026-05-13 01:29:09.569629 | controller | 2026-05-13 01:29:09.569639 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-05-13 01:29:09.569649 | controller | Wednesday 13 May 2026 01:29:09 +0000 (0:00:01.089) 0:00:01.102 ********* 2026-05-13 01:29:10.012587 | controller | ok: [controller] 2026-05-13 01:29:10.012665 | controller | 2026-05-13 01:29:10.012679 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-05-13 01:29:10.012782 | controller | Wednesday 13 May 2026 01:29:10 +0000 (0:00:00.446) 0:00:01.548 ********* 2026-05-13 01:29:11.145086 | controller | ok: [controller] 2026-05-13 01:29:11.145128 | controller | 2026-05-13 01:29:11.145134 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-05-13 01:29:11.145139 | controller | Wednesday 13 May 2026 01:29:11 +0000 (0:00:01.133) 0:00:02.681 ********* 2026-05-13 01:29:11.576891 | controller | ok: [controller] 2026-05-13 01:29:11.577195 | controller | 2026-05-13 01:29:11.577534 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-13 01:29:11.577881 | controller | Wednesday 13 May 2026 01:29:11 +0000 (0:00:00.430) 0:00:03.112 ********* 2026-05-13 01:29:11.621063 | controller | ok: [controller] => { 2026-05-13 01:29:11.621172 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-05-13 01:29:11.621288 | controller | } 2026-05-13 01:29:11.621399 | controller | 2026-05-13 01:29:11.621525 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-13 01:29:11.621638 | controller | Wednesday 13 May 2026 01:29:11 +0000 (0:00:00.045) 0:00:03.157 ********* 2026-05-13 01:29:12.148220 | controller | ok: [controller] 2026-05-13 01:29:12.148293 | controller | 2026-05-13 01:29:12.148303 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-13 01:29:12.148409 | controller | Wednesday 13 May 2026 01:29:12 +0000 (0:00:00.527) 0:00:03.685 ********* 2026-05-13 01:29:13.912144 | controller | ok: [controller] 2026-05-13 01:29:13.912214 | controller | 2026-05-13 01:29:13.912232 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-05-13 01:29:13.912373 | controller | Wednesday 13 May 2026 01:29:13 +0000 (0:00:01.760) 0:00:05.445 ********* 2026-05-13 01:29:14.405069 | controller | ok: [controller] 2026-05-13 01:29:14.405108 | controller | 2026-05-13 01:29:14.405112 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-05-13 01:29:14.405117 | controller | Wednesday 13 May 2026 01:29:14 +0000 (0:00:00.492) 0:00:05.938 ********* 2026-05-13 01:29:14.808949 | controller | ok: [controller] 2026-05-13 01:29:14.809246 | controller | 2026-05-13 01:29:14.809517 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-05-13 01:29:14.809770 | controller | Wednesday 13 May 2026 01:29:14 +0000 (0:00:00.404) 0:00:06.343 ********* 2026-05-13 01:29:15.301104 | controller | ok: [controller] 2026-05-13 01:29:15.301171 | controller | 2026-05-13 01:29:15.301194 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-05-13 01:29:15.301346 | controller | Wednesday 13 May 2026 01:29:15 +0000 (0:00:00.491) 0:00:06.834 ********* 2026-05-13 01:29:15.597847 | controller | ok: [controller] 2026-05-13 01:29:15.597916 | controller | 2026-05-13 01:29:15.597925 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-05-13 01:29:15.598037 | controller | Wednesday 13 May 2026 01:29:15 +0000 (0:00:00.299) 0:00:07.134 ********* 2026-05-13 01:29:15.916826 | controller | ok: [controller] 2026-05-13 01:29:15.916890 | controller | 2026-05-13 01:29:15.917040 | controller | TASK [Install plugin] ********************************************************** 2026-05-13 01:29:15.917206 | controller | Wednesday 13 May 2026 01:29:15 +0000 (0:00:00.318) 0:00:07.453 ********* 2026-05-13 01:29:15.976822 | controller | included: vexxhost.containers.download_artifact for controller 2026-05-13 01:29:15.976876 | controller | 2026-05-13 01:29:15.976948 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-13 01:29:15.977027 | controller | Wednesday 13 May 2026 01:29:15 +0000 (0:00:00.057) 0:00:07.510 ********* 2026-05-13 01:29:16.020076 | controller | ok: [controller] => { 2026-05-13 01:29:16.020950 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-05-13 01:29:16.020984 | controller | } 2026-05-13 01:29:16.020990 | controller | 2026-05-13 01:29:16.020996 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-13 01:29:16.021001 | controller | Wednesday 13 May 2026 01:29:16 +0000 (0:00:00.046) 0:00:07.556 ********* 2026-05-13 01:29:16.468999 | controller | ok: [controller] 2026-05-13 01:29:16.469033 | controller | 2026-05-13 01:29:16.469039 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-13 01:29:16.469045 | controller | Wednesday 13 May 2026 01:29:16 +0000 (0:00:00.445) 0:00:08.002 ********* 2026-05-13 01:29:18.100797 | controller | ok: [controller] 2026-05-13 01:29:18.100849 | controller | 2026-05-13 01:29:18.100973 | controller | PLAY RECAP ********************************************************************* 2026-05-13 01:29:18.101104 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-13 01:29:18.101213 | controller | 2026-05-13 01:29:18.101318 | controller | 2026-05-13 01:29:18.101428 | controller | TASKS RECAP ******************************************************************** 2026-05-13 01:29:18.101560 | controller | Wednesday 13 May 2026 01:29:18 +0000 (0:00:01.636) 0:00:09.638 ********* 2026-05-13 01:29:18.101662 | controller | =============================================================================== 2026-05-13 01:29:18.101779 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.76s 2026-05-13 01:29:18.101898 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.64s 2026-05-13 01:29:18.102016 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.13s 2026-05-13 01:29:18.102132 | controller | Gathering Facts --------------------------------------------------------- 1.09s 2026-05-13 01:29:18.102250 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.53s 2026-05-13 01:29:18.102371 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.49s 2026-05-13 01:29:18.102510 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.49s 2026-05-13 01:29:18.102631 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.45s 2026-05-13 01:29:18.102751 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.45s 2026-05-13 01:29:18.102870 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.43s 2026-05-13 01:29:18.102990 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.40s 2026-05-13 01:29:18.103116 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.32s 2026-05-13 01:29:18.103242 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.30s 2026-05-13 01:29:18.103358 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-05-13 01:29:18.103477 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-05-13 01:29:18.103594 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-05-13 01:29:18.196168 | controller | INFO [helm > idempotence] Executed: Successful 2026-05-13 01:29:18.198836 | controller | INFO [helm > side_effect] Executing 2026-05-13 01:29:18.199188 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-13 01:29:18.204498 | controller | INFO [helm > verify] Executing 2026-05-13 01:29:19.009815 | controller | 2026-05-13 01:29:19.010146 | controller | PLAY [Verify] ****************************************************************** 2026-05-13 01:29:19.010378 | controller | 2026-05-13 01:29:19.010622 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-13 01:29:19.010864 | controller | Wednesday 13 May 2026 01:29:19 +0000 (0:00:00.009) 0:00:00.009 ********* 2026-05-13 01:29:20.126901 | 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-05-13 01:29:20.132766 | controller | ok: [controller] 2026-05-13 01:29:20.133012 | controller | 2026-05-13 01:29:20.133267 | controller | TASK [Get the current Helm version] ******************************************** 2026-05-13 01:29:20.133515 | controller | Wednesday 13 May 2026 01:29:20 +0000 (0:00:01.123) 0:00:01.132 ********* 2026-05-13 01:29:20.611335 | controller | changed: [controller] 2026-05-13 01:29:20.611624 | controller | 2026-05-13 01:29:20.611888 | controller | TASK [Assert Helm version] ***************************************************** 2026-05-13 01:29:20.612180 | controller | Wednesday 13 May 2026 01:29:20 +0000 (0:00:00.477) 0:00:01.610 ********* 2026-05-13 01:29:20.639746 | controller | ok: [controller] => { 2026-05-13 01:29:20.640012 | controller | "changed": false, 2026-05-13 01:29:20.640295 | controller | "msg": "All assertions passed" 2026-05-13 01:29:20.640536 | controller | } 2026-05-13 01:29:20.640766 | controller | 2026-05-13 01:29:20.641007 | controller | PLAY RECAP ********************************************************************* 2026-05-13 01:29:20.641272 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-13 01:29:20.641556 | controller | 2026-05-13 01:29:20.641784 | controller | 2026-05-13 01:29:20.642038 | controller | TASKS RECAP ******************************************************************** 2026-05-13 01:29:20.642284 | controller | Wednesday 13 May 2026 01:29:20 +0000 (0:00:00.029) 0:00:01.640 ********* 2026-05-13 01:29:20.642516 | controller | =============================================================================== 2026-05-13 01:29:20.642756 | controller | Gathering Facts --------------------------------------------------------- 1.12s 2026-05-13 01:29:20.643000 | controller | Get the current Helm version -------------------------------------------- 0.48s 2026-05-13 01:29:20.643254 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-05-13 01:29:20.735787 | controller | INFO [helm > verify] Executed: Successful 2026-05-13 01:29:20.747078 | controller | INFO [helm > cleanup] Executing 2026-05-13 01:29:20.747422 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-13 01:29:20.752732 | controller | INFO [helm > destroy] Executing 2026-05-13 01:29:20.752849 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-05-13 01:29:20.752936 | controller | INFO [helm > destroy] Executed: Successful 2026-05-13 01:29:20.753232 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-05-13 01:29:21.221549 | controller | ok: Runtime: 0:00:48.338289 2026-05-13 01:29:21.226820 | 2026-05-13 01:29:21.226869 | PLAY RECAP 2026-05-13 01:29:21.226912 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-13 01:29:21.226932 | 2026-05-13 01:29:21.328305 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-13 01:29:21.331681 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-05-13 01:29:21.946438 | 2026-05-13 01:29:21.946575 | PLAY [all] 2026-05-13 01:29:21.957477 | 2026-05-13 01:29:21.957569 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-05-13 01:29:22.333463 | controller | changed 2026-05-13 01:29:22.340256 | 2026-05-13 01:29:22.340339 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-05-13 01:29:22.696513 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-13 01:29:22.696962 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-13 01:29:22.704380 | controller | environment: line 1: kubectl: command not found 2026-05-13 01:29:22.706165 | controller | environment: line 1: kubectl: command not found 2026-05-13 01:29:22.706557 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-13 01:29:22.707737 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-13 01:29:22.711062 | controller | environment: line 1: kubectl: command not found 2026-05-13 01:29:22.712652 | controller | environment: line 1: kubectl: command not found 2026-05-13 01:29:22.712812 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-13 01:29:22.714410 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-13 01:29:22.716244 | controller | environment: line 1: kubectl: command not found 2026-05-13 01:29:22.718240 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-13 01:29:22.869594 | controller | ok: Runtime: 0:00:00.037379 2026-05-13 01:29:22.875421 | 2026-05-13 01:29:22.875489 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-05-13 01:29:23.120185 | controller | changed 2026-05-13 01:29:23.126328 | 2026-05-13 01:29:23.126402 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-05-13 01:29:23.358403 | controller | environment: line 5: kubectl: command not found 2026-05-13 01:29:23.359547 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-13 01:29:23.359572 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-13 01:29:23.359877 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-13 01:29:23.653211 | controller | ok: Runtime: 0:00:00.013882 2026-05-13 01:29:23.660248 | 2026-05-13 01:29:23.660343 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-05-13 01:29:24.304401 | controller | changed: 2026-05-13 01:29:24.304658 | controller | created directory /var/lib/zuul/builds/10b46dbce4e54e12a0a8715473097d0f/work/logs/controller 2026-05-13 01:29:24.304730 | controller | cd+++++++++ objects/ 2026-05-13 01:29:24.304784 | controller | cd+++++++++ objects/cluster/ 2026-05-13 01:29:24.304838 | controller | cd+++++++++ objects/namespaced/ 2026-05-13 01:29:24.315021 | 2026-05-13 01:29:24.315086 | TASK [gather-pod-logs : creating directory for pod logs] 2026-05-13 01:29:24.560833 | controller | changed 2026-05-13 01:29:24.565702 | 2026-05-13 01:29:24.565770 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-05-13 01:29:24.796806 | controller | changed 2026-05-13 01:29:24.800655 | 2026-05-13 01:29:24.800752 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-05-13 01:29:25.021328 | controller | environment: line 3: kubectl: command not found 2026-05-13 01:29:25.330690 | controller | ok: Runtime: 0:00:00.012298 2026-05-13 01:29:25.338690 | 2026-05-13 01:29:25.338878 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-05-13 01:29:25.858014 | controller | changed: 2026-05-13 01:29:25.858343 | controller | cd+++++++++ pod-logs/ 2026-05-13 01:29:25.858415 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-05-13 01:29:25.865824 | 2026-05-13 01:29:25.865887 | LOOP [helm-release-status : creating directory for helm release status] 2026-05-13 01:29:26.094540 | controller | changed: "values" 2026-05-13 01:29:26.293225 | controller | changed: "releases" 2026-05-13 01:29:26.306174 | 2026-05-13 01:29:26.306540 | TASK [helm-release-status : Gather get release status for helm charts] 2026-05-13 01:29:26.527002 | controller | /bin/bash: line 3: kubectl: command not found 2026-05-13 01:29:26.835459 | controller | ok: Runtime: 0:00:00.008654 2026-05-13 01:29:26.840876 | 2026-05-13 01:29:26.841022 | TASK [helm-release-status : Downloads logs to executor] 2026-05-13 01:29:27.342970 | controller | changed: 2026-05-13 01:29:27.343152 | controller | cd+++++++++ helm/ 2026-05-13 01:29:27.343180 | controller | cd+++++++++ helm/releases/ 2026-05-13 01:29:27.343206 | controller | cd+++++++++ helm/values/ 2026-05-13 01:29:27.347932 | 2026-05-13 01:29:27.347980 | PLAY RECAP 2026-05-13 01:29:27.348025 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-13 01:29:27.348047 | 2026-05-13 01:29:27.456816 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-05-13 01:29:27.459525 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-13 01:29:28.018058 | 2026-05-13 01:29:28.018174 | PLAY [all] 2026-05-13 01:29:28.027681 | 2026-05-13 01:29:28.027753 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-13 01:29:28.072423 | controller | skipping: Conditional result was False 2026-05-13 01:29:28.079141 | 2026-05-13 01:29:28.079247 | TASK [fetch-output : Set log path for single node] 2026-05-13 01:29:28.111560 | controller | ok 2026-05-13 01:29:28.115393 | 2026-05-13 01:29:28.115457 | LOOP [fetch-output : Ensure local output dirs] 2026-05-13 01:29:28.484932 | controller -> localhost | ok: "/var/lib/zuul/builds/10b46dbce4e54e12a0a8715473097d0f/work/logs" 2026-05-13 01:29:28.858230 | controller -> localhost | changed: "/var/lib/zuul/builds/10b46dbce4e54e12a0a8715473097d0f/work/artifacts" 2026-05-13 01:29:29.085266 | controller -> localhost | changed: "/var/lib/zuul/builds/10b46dbce4e54e12a0a8715473097d0f/work/docs" 2026-05-13 01:29:29.100766 | 2026-05-13 01:29:29.100922 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-13 01:29:29.754661 | controller | changed: .d..t...... ./ 2026-05-13 01:29:29.754867 | controller | changed: All items complete 2026-05-13 01:29:29.754894 | 2026-05-13 01:29:30.233104 | controller | changed: .d..t...... ./ 2026-05-13 01:29:30.701369 | controller | changed: .d..t...... ./ 2026-05-13 01:29:30.722850 | 2026-05-13 01:29:30.722971 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-13 01:29:31.123503 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007267 2026-05-13 01:29:31.327606 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007319 2026-05-13 01:29:31.340838 | 2026-05-13 01:29:31.340976 | PLAY [all] 2026-05-13 01:29:31.346878 | 2026-05-13 01:29:31.346940 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-13 01:29:31.782352 | controller | changed 2026-05-13 01:29:31.788334 | 2026-05-13 01:29:31.788400 | PLAY RECAP 2026-05-13 01:29:31.788478 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-13 01:29:31.788517 | 2026-05-13 01:29:31.930993 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-13 01:29:31.932416 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-13 01:29:32.488011 | 2026-05-13 01:29:32.488354 | PLAY [localhost] 2026-05-13 01:29:32.498024 | 2026-05-13 01:29:32.498092 | TASK [Generate Zuul manifest] 2026-05-13 01:29:32.518760 | localhost | ok 2026-05-13 01:29:32.536681 | 2026-05-13 01:29:32.536756 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-13 01:29:32.914416 | localhost | changed 2026-05-13 01:29:32.930105 | 2026-05-13 01:29:32.930279 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-13 01:29:32.965101 | localhost | ok 2026-05-13 01:29:32.975100 | 2026-05-13 01:29:32.975232 | TASK [Upload logs] 2026-05-13 01:29:32.996358 | localhost | ok 2026-05-13 01:29:33.060110 | 2026-05-13 01:29:33.060316 | TASK [Set zuul-log-path fact] 2026-05-13 01:29:33.082861 | localhost | ok 2026-05-13 01:29:33.097438 | 2026-05-13 01:29:33.097521 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-13 01:29:33.130851 | localhost | ok 2026-05-13 01:29:33.141878 | 2026-05-13 01:29:33.141970 | TASK [upload-logs : Create log directories] 2026-05-13 01:29:33.537756 | localhost | changed 2026-05-13 01:29:33.544503 | 2026-05-13 01:29:33.544604 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-13 01:29:33.964283 | localhost -> localhost | ok: Runtime: 0:00:00.006243 2026-05-13 01:29:33.974190 | 2026-05-13 01:29:33.974334 | TASK [upload-logs : Upload logs to log server] 2026-05-13 01:29:34.436619 | localhost | Output suppressed because no_log was given 2026-05-13 01:29:34.442921 | 2026-05-13 01:29:34.443030 | LOOP [upload-logs : Compress console log and json output] 2026-05-13 01:29:34.492925 | localhost | skipping: Conditional result was False 2026-05-13 01:29:34.535903 | localhost | skipping: Conditional result was False 2026-05-13 01:29:34.550452 | 2026-05-13 01:29:34.550637 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-13 01:29:34.595466 | localhost | skipping: Conditional result was False 2026-05-13 01:29:34.595890 | 2026-05-13 01:29:34.599625 | localhost | skipping: Conditional result was False 2026-05-13 01:29:34.618079 | 2026-05-13 01:29:34.618332 | LOOP [upload-logs : Upload console log and json output]