2026-03-30 21:25:08.433429 | Job console starting 2026-03-30 21:25:08.759709 | Updating git repos 2026-03-30 21:25:08.850979 | Cloning repos into workspace 2026-03-30 21:25:09.570830 | Restoring repo states 2026-03-30 21:25:09.585745 | Merging changes 2026-03-30 21:25:10.316419 | Checking out repos 2026-03-30 21:25:10.497578 | Preparing playbooks 2026-03-30 21:25:15.738793 | Running Ansible setup 2026-03-30 21:25:19.658580 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-30 21:25:20.265321 | 2026-03-30 21:25:20.265478 | PLAY [localhost] 2026-03-30 21:25:20.275190 | 2026-03-30 21:25:20.275301 | TASK [Gathering Facts] 2026-03-30 21:25:21.175547 | localhost | ok 2026-03-30 21:25:21.183715 | 2026-03-30 21:25:21.183858 | TASK [Setup log path fact] 2026-03-30 21:25:21.204599 | localhost | ok 2026-03-30 21:25:21.220513 | 2026-03-30 21:25:21.220708 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-30 21:25:21.251702 | localhost | ok 2026-03-30 21:25:21.260593 | 2026-03-30 21:25:21.260684 | TASK [emit-job-header : Print job information] 2026-03-30 21:25:21.308267 | # Job Information 2026-03-30 21:25:21.308729 | Ansible Version: 2.16.16 2026-03-30 21:25:21.308789 | Job: ansible-collection-kubernetes-molecule-helm 2026-03-30 21:25:21.308831 | Pipeline: check 2026-03-30 21:25:21.308868 | Executor: 0a8996d2b663 2026-03-30 21:25:21.308904 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/250 2026-03-30 21:25:21.308944 | Event ID: a13543c0-2c7e-11f1-8a5b-4718762136e9 2026-03-30 21:25:21.313210 | 2026-03-30 21:25:21.313309 | LOOP [emit-job-header : Print node information] 2026-03-30 21:25:21.409796 | localhost | ok: 2026-03-30 21:25:21.410001 | localhost | # Node Information 2026-03-30 21:25:21.410029 | localhost | Inventory Hostname: controller 2026-03-30 21:25:21.410051 | localhost | Hostname: np0000161712 2026-03-30 21:25:21.410070 | localhost | Username: zuul 2026-03-30 21:25:21.410093 | localhost | Distro: Debian 13.4 2026-03-30 21:25:21.410112 | localhost | Provider: yul1 2026-03-30 21:25:21.410130 | localhost | Region: ca-ymq-1 2026-03-30 21:25:21.410149 | localhost | Label: debian-trixie 2026-03-30 21:25:21.410167 | localhost | Product Name: OpenStack Nova 2026-03-30 21:25:21.410188 | localhost | Interface IP: 199.204.45.23 2026-03-30 21:25:21.444361 | 2026-03-30 21:25:21.444797 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-30 21:25:21.864342 | localhost -> localhost | changed 2026-03-30 21:25:21.871719 | 2026-03-30 21:25:21.871813 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-30 21:25:22.770194 | localhost -> localhost | changed 2026-03-30 21:25:22.775619 | 2026-03-30 21:25:22.775674 | PLAY [all] 2026-03-30 21:25:22.783812 | 2026-03-30 21:25:22.783885 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-30 21:25:23.051696 | controller -> localhost | ok 2026-03-30 21:25:23.080423 | 2026-03-30 21:25:23.081292 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-30 21:25:23.130020 | controller | ok 2026-03-30 21:25:23.152304 | controller | included: /var/lib/zuul/builds/de37b950976742579547fc1926e54550/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-30 21:25:23.157076 | 2026-03-30 21:25:23.157139 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-30 21:25:24.263760 | controller -> localhost | Generating public/private rsa key pair. 2026-03-30 21:25:24.263947 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/de37b950976742579547fc1926e54550/work/de37b950976742579547fc1926e54550_id_rsa 2026-03-30 21:25:24.263983 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/de37b950976742579547fc1926e54550/work/de37b950976742579547fc1926e54550_id_rsa.pub 2026-03-30 21:25:24.264012 | controller -> localhost | The key fingerprint is: 2026-03-30 21:25:24.264040 | controller -> localhost | SHA256:4sktFci/PkPWQj2XO4xAhV8628ABZkfLTR/lX2zDAHE zuul-build-sshkey 2026-03-30 21:25:24.264084 | controller -> localhost | The key's randomart image is: 2026-03-30 21:25:24.264120 | controller -> localhost | +---[RSA 3072]----+ 2026-03-30 21:25:24.264158 | controller -> localhost | | +=+o+E...| 2026-03-30 21:25:24.264208 | controller -> localhost | | . +oo.+o.o+ | 2026-03-30 21:25:24.264254 | controller -> localhost | | o..+o+...o=| 2026-03-30 21:25:24.264295 | controller -> localhost | | .o.O o .+| 2026-03-30 21:25:24.264326 | controller -> localhost | | ..So X . .| 2026-03-30 21:25:24.264353 | controller -> localhost | | o =+.+ = | 2026-03-30 21:25:24.264382 | controller -> localhost | | =oo. . | 2026-03-30 21:25:24.264457 | controller -> localhost | | oo | 2026-03-30 21:25:24.264496 | controller -> localhost | | .o | 2026-03-30 21:25:24.264530 | controller -> localhost | +----[SHA256]-----+ 2026-03-30 21:25:24.264607 | controller -> localhost | ok: Runtime: 0:00:00.612338 2026-03-30 21:25:24.273445 | 2026-03-30 21:25:24.273536 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-30 21:25:24.302525 | controller | ok 2026-03-30 21:25:24.311669 | controller | included: /var/lib/zuul/builds/de37b950976742579547fc1926e54550/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-30 21:25:24.319619 | 2026-03-30 21:25:24.319687 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-30 21:25:24.344168 | controller | skipping: Conditional result was False 2026-03-30 21:25:24.353408 | 2026-03-30 21:25:24.353473 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-30 21:25:24.944078 | controller | changed 2026-03-30 21:25:24.949935 | 2026-03-30 21:25:24.950017 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-30 21:25:25.175315 | controller | ok 2026-03-30 21:25:25.181067 | 2026-03-30 21:25:25.181133 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-30 21:25:25.750271 | controller | changed 2026-03-30 21:25:25.756927 | 2026-03-30 21:25:25.757054 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-30 21:25:26.338291 | controller | changed 2026-03-30 21:25:26.345044 | 2026-03-30 21:25:26.345121 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-30 21:25:26.370275 | controller | skipping: Conditional result was False 2026-03-30 21:25:26.375700 | 2026-03-30 21:25:26.376018 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-30 21:25:26.806676 | controller -> localhost | changed 2026-03-30 21:25:26.819971 | 2026-03-30 21:25:26.820052 | TASK [add-build-sshkey : Add back temp key] 2026-03-30 21:25:27.164249 | controller -> localhost | Identity added: /var/lib/zuul/builds/de37b950976742579547fc1926e54550/work/de37b950976742579547fc1926e54550_id_rsa (zuul-build-sshkey) 2026-03-30 21:25:27.164481 | controller -> localhost | ok: Runtime: 0:00:00.015500 2026-03-30 21:25:27.171326 | 2026-03-30 21:25:27.171434 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-30 21:25:27.517233 | controller | ok 2026-03-30 21:25:27.521271 | 2026-03-30 21:25:27.521338 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-30 21:25:27.546373 | controller | skipping: Conditional result was False 2026-03-30 21:25:27.559680 | 2026-03-30 21:25:27.559772 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-30 21:25:27.916990 | controller | ok 2026-03-30 21:25:27.922857 | 2026-03-30 21:25:27.922925 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-30 21:25:29.230949 | controller | Output suppressed because no_log was given 2026-03-30 21:25:29.240885 | 2026-03-30 21:25:29.240997 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-30 21:25:29.462671 | controller | ok: "logs" 2026-03-30 21:25:29.463184 | controller | ok: All items complete 2026-03-30 21:25:29.463219 | 2026-03-30 21:25:29.658236 | controller | ok: "artifacts" 2026-03-30 21:25:29.858484 | controller | ok: "docs" 2026-03-30 21:25:29.870945 | 2026-03-30 21:25:29.871138 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-30 21:25:30.084604 | controller | changed: "logs" 2026-03-30 21:25:30.271950 | controller | changed: "artifacts" 2026-03-30 21:25:30.486061 | controller | changed: "docs" 2026-03-30 21:25:30.495640 | 2026-03-30 21:25:30.495761 | PLAY RECAP 2026-03-30 21:25:30.495857 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-30 21:25:30.495887 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-30 21:25:30.495907 | 2026-03-30 21:25:30.673475 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-30 21:25:30.675006 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-30 21:25:31.298136 | 2026-03-30 21:25:31.298316 | PLAY [all] 2026-03-30 21:25:31.309698 | 2026-03-30 21:25:31.309796 | TASK [setup-uv : Extract archive] 2026-03-30 21:25:34.350997 | controller | changed 2026-03-30 21:25:34.359387 | 2026-03-30 21:25:34.359516 | TASK [setup-uv : Print version] 2026-03-30 21:25:34.758996 | controller | uv 0.8.13 2026-03-30 21:25:34.885804 | controller | ok: Runtime: 0:00:00.022295 2026-03-30 21:25:34.893562 | 2026-03-30 21:25:34.893638 | PLAY RECAP 2026-03-30 21:25:34.893696 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-30 21:25:34.893731 | 2026-03-30 21:25:35.115102 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-30 21:25:35.116790 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-30 21:25:35.739673 | 2026-03-30 21:25:35.740054 | PLAY [all] 2026-03-30 21:25:35.751208 | 2026-03-30 21:25:36.010883 | TASK [Update apt cache] 2026-03-30 21:25:42.975449 | controller | ok 2026-03-30 21:25:43.267315 | 2026-03-30 21:25:43.267540 | TASK [Disable firewalld] 2026-03-30 21:25:43.292013 | controller | skipping: Conditional result was False 2026-03-30 21:25:43.300978 | 2026-03-30 21:25:43.301083 | TASK [Install "jq" for log collection] 2026-03-30 21:25:46.251646 | controller | changed 2026-03-30 21:25:46.253984 | 2026-03-30 21:25:46.254050 | PLAY RECAP 2026-03-30 21:25:46.254110 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-30 21:25:46.254247 | 2026-03-30 21:25:46.394380 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-30 21:25:46.397295 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-30 21:25:46.998857 | 2026-03-30 21:25:46.999008 | PLAY [all] 2026-03-30 21:25:47.009437 | 2026-03-30 21:25:47.009520 | TASK [Copy inventory file for Zuul] 2026-03-30 21:25:48.057896 | controller | changed 2026-03-30 21:25:48.063421 | 2026-03-30 21:25:48.063491 | TASK [Switch "ansible_host" to private IP] 2026-03-30 21:25:48.378617 | controller | changed: 1 replacements made 2026-03-30 21:25:48.460511 | 2026-03-30 21:25:48.460643 | TASK [Run Molecule scenario] 2026-03-30 21:25:48.935152 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-30 21:25:48.935272 | controller | Creating virtual environment at: .venv 2026-03-30 21:25:49.331424 | controller | Downloading pygments (1.2MiB) 2026-03-30 21:25:49.331822 | controller | Downloading cryptography (4.3MiB) 2026-03-30 21:25:49.332741 | controller | Downloading ansible-core (2.3MiB) 2026-03-30 21:25:49.502506 | controller | Downloading cryptography 2026-03-30 21:25:49.542522 | controller | Downloading pygments 2026-03-30 21:25:49.714385 | controller | Downloading ansible-core 2026-03-30 21:25:49.776629 | controller | Installed 36 packages in 61ms 2026-03-30 21:25:50.481624 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-30 21:25:50.481681 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-30 21:25:51.461388 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-30 21:25:51.461452 | controller | INFO default scenario not found, disabling shared state. 2026-03-30 21:25:51.461594 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-30 21:25:51.461680 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-03-30 21:26:06.325441 | controller | INFO [helm > dependency] Executing 2026-03-30 21:26:06.325649 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-03-30 21:26:06.326254 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-03-30 21:26:06.326638 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-30 21:26:06.338810 | controller | INFO [helm > cleanup] Executing 2026-03-30 21:26:06.339171 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-30 21:26:06.344783 | controller | INFO [helm > destroy] Executing 2026-03-30 21:26:06.344811 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-30 21:26:06.344860 | controller | INFO [helm > destroy] Executed: Successful 2026-03-30 21:26:06.350408 | controller | INFO [helm > syntax] Executing 2026-03-30 21:26:07.307518 | controller | 2026-03-30 21:26:07.307734 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-03-30 21:26:07.381594 | controller | INFO [helm > syntax] Executed: Successful 2026-03-30 21:26:07.392046 | controller | INFO [helm > create] Executing 2026-03-30 21:26:07.505236 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-30 21:26:07.515060 | controller | INFO [helm > prepare] Executing 2026-03-30 21:26:08.363063 | controller | 2026-03-30 21:26:08.363147 | controller | PLAY [Prepare] ***************************************************************** 2026-03-30 21:26:08.363360 | controller | 2026-03-30 21:26:08.363598 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-30 21:26:08.363850 | controller | Monday 30 March 2026 21:26:08 +0000 (0:00:00.031) 0:00:00.031 ********** 2026-03-30 21:26:09.711272 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-30 21:26:09.718632 | controller | ok: [controller] 2026-03-30 21:26:09.718816 | controller | 2026-03-30 21:26:09.719137 | controller | TASK [Install Debian packages] ************************************************* 2026-03-30 21:26:09.719381 | controller | Monday 30 March 2026 21:26:09 +0000 (0:00:01.356) 0:00:01.387 ********** 2026-03-30 21:26:11.256750 | controller | ok: [controller] 2026-03-30 21:26:11.256878 | controller | 2026-03-30 21:26:11.257065 | controller | PLAY RECAP ********************************************************************* 2026-03-30 21:26:11.257265 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-30 21:26:11.259913 | controller | 2026-03-30 21:26:11.259966 | controller | 2026-03-30 21:26:11.259970 | controller | TASKS RECAP ******************************************************************** 2026-03-30 21:26:11.260001 | controller | Monday 30 March 2026 21:26:11 +0000 (0:00:01.538) 0:00:02.925 ********** 2026-03-30 21:26:11.260005 | controller | =============================================================================== 2026-03-30 21:26:11.260008 | controller | Install Debian packages ------------------------------------------------- 1.54s 2026-03-30 21:26:11.260013 | controller | Gathering Facts --------------------------------------------------------- 1.36s 2026-03-30 21:26:11.362972 | controller | INFO [helm > prepare] Executed: Successful 2026-03-30 21:26:11.371855 | controller | INFO [helm > converge] Executing 2026-03-30 21:26:12.284785 | controller | 2026-03-30 21:26:12.284995 | controller | PLAY [Converge] **************************************************************** 2026-03-30 21:26:12.285181 | controller | 2026-03-30 21:26:12.285391 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-30 21:26:12.285589 | controller | Monday 30 March 2026 21:26:12 +0000 (0:00:00.016) 0:00:00.016 ********** 2026-03-30 21:26:13.386814 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-30 21:26:13.393689 | controller | ok: [controller] 2026-03-30 21:26:13.393864 | controller | 2026-03-30 21:26:13.394071 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-30 21:26:13.394268 | controller | Monday 30 March 2026 21:26:13 +0000 (0:00:01.109) 0:00:01.125 ********** 2026-03-30 21:26:13.898507 | controller | ok: [controller] 2026-03-30 21:26:13.898637 | controller | 2026-03-30 21:26:13.898871 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-30 21:26:13.899074 | controller | Monday 30 March 2026 21:26:13 +0000 (0:00:00.504) 0:00:01.630 ********** 2026-03-30 21:26:15.078486 | controller | ok: [controller] 2026-03-30 21:26:15.078773 | controller | 2026-03-30 21:26:15.079116 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-30 21:26:15.079397 | controller | Monday 30 March 2026 21:26:15 +0000 (0:00:01.179) 0:00:02.809 ********** 2026-03-30 21:26:15.516848 | controller | changed: [controller] 2026-03-30 21:26:15.517009 | controller | 2026-03-30 21:26:15.517222 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-30 21:26:15.517420 | controller | Monday 30 March 2026 21:26:15 +0000 (0:00:00.438) 0:00:03.248 ********** 2026-03-30 21:26:15.566590 | controller | ok: [controller] => { 2026-03-30 21:26:15.566762 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-30 21:26:15.566940 | controller | } 2026-03-30 21:26:15.567115 | controller | 2026-03-30 21:26:15.567319 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-30 21:26:15.567524 | controller | Monday 30 March 2026 21:26:15 +0000 (0:00:00.049) 0:00:03.297 ********** 2026-03-30 21:26:16.381039 | controller | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually 2026-03-30 21:26:16.389693 | controller | changed: [controller] 2026-03-30 21:26:16.389796 | controller | 2026-03-30 21:26:16.389996 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-30 21:26:16.390123 | controller | Monday 30 March 2026 21:26:16 +0000 (0:00:00.824) 0:00:04.121 ********** 2026-03-30 21:26:18.611044 | controller | changed: [controller] 2026-03-30 21:26:18.611152 | controller | 2026-03-30 21:26:18.611371 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-30 21:26:18.611573 | controller | Monday 30 March 2026 21:26:18 +0000 (0:00:02.220) 0:00:06.342 ********** 2026-03-30 21:26:19.170214 | controller | ok: [controller] 2026-03-30 21:26:19.170330 | controller | 2026-03-30 21:26:19.170542 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-30 21:26:19.170741 | controller | Monday 30 March 2026 21:26:19 +0000 (0:00:00.559) 0:00:06.901 ********** 2026-03-30 21:26:19.715104 | controller | changed: [controller] 2026-03-30 21:26:19.716175 | controller | 2026-03-30 21:26:19.716239 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-30 21:26:19.716245 | controller | Monday 30 March 2026 21:26:19 +0000 (0:00:00.545) 0:00:07.446 ********** 2026-03-30 21:26:20.208008 | controller | ok: [controller] 2026-03-30 21:26:20.208035 | controller | 2026-03-30 21:26:20.208039 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-30 21:26:20.208043 | controller | Monday 30 March 2026 21:26:20 +0000 (0:00:00.488) 0:00:07.935 ********** 2026-03-30 21:26:20.511577 | controller | changed: [controller] 2026-03-30 21:26:20.511738 | controller | 2026-03-30 21:26:20.512253 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-30 21:26:20.512480 | controller | Monday 30 March 2026 21:26:20 +0000 (0:00:00.307) 0:00:08.242 ********** 2026-03-30 21:26:20.835667 | controller | ok: [controller] 2026-03-30 21:26:20.835696 | controller | 2026-03-30 21:26:20.835701 | controller | TASK [Install plugin] ********************************************************** 2026-03-30 21:26:20.835705 | controller | Monday 30 March 2026 21:26:20 +0000 (0:00:00.322) 0:00:08.565 ********** 2026-03-30 21:26:20.897205 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-30 21:26:20.897361 | controller | 2026-03-30 21:26:20.897573 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-30 21:26:20.897770 | controller | Monday 30 March 2026 21:26:20 +0000 (0:00:00.063) 0:00:08.628 ********** 2026-03-30 21:26:20.955301 | controller | ok: [controller] => { 2026-03-30 21:26:20.955504 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-30 21:26:20.955694 | controller | } 2026-03-30 21:26:20.956007 | controller | 2026-03-30 21:26:20.956237 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-30 21:26:20.956439 | controller | Monday 30 March 2026 21:26:20 +0000 (0:00:00.058) 0:00:08.686 ********** 2026-03-30 21:26:21.800247 | controller | changed: [controller] 2026-03-30 21:26:21.800468 | controller | 2026-03-30 21:26:21.800721 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-30 21:26:21.800953 | controller | Monday 30 March 2026 21:26:21 +0000 (0:00:00.844) 0:00:09.531 ********** 2026-03-30 21:26:23.911546 | controller | changed: [controller] 2026-03-30 21:26:23.911992 | controller | 2026-03-30 21:26:23.912315 | controller | PLAY RECAP ********************************************************************* 2026-03-30 21:26:23.912628 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-30 21:26:23.912884 | controller | 2026-03-30 21:26:23.913126 | controller | 2026-03-30 21:26:23.913389 | controller | TASKS RECAP ******************************************************************** 2026-03-30 21:26:23.913809 | controller | Monday 30 March 2026 21:26:23 +0000 (0:00:02.111) 0:00:11.643 ********** 2026-03-30 21:26:23.914089 | controller | =============================================================================== 2026-03-30 21:26:23.914281 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.22s 2026-03-30 21:26:23.914439 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.11s 2026-03-30 21:26:23.914597 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.18s 2026-03-30 21:26:23.914797 | controller | Gathering Facts --------------------------------------------------------- 1.11s 2026-03-30 21:26:23.914966 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.84s 2026-03-30 21:26:23.915124 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.82s 2026-03-30 21:26:23.915280 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.56s 2026-03-30 21:26:23.915434 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.55s 2026-03-30 21:26:23.915587 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.50s 2026-03-30 21:26:23.915741 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.49s 2026-03-30 21:26:23.915944 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.44s 2026-03-30 21:26:23.916115 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.32s 2026-03-30 21:26:23.916277 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-03-30 21:26:23.916428 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-30 21:26:23.916581 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s 2026-03-30 21:26:23.916734 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-30 21:26:24.066386 | controller | INFO [helm > converge] Executed: Successful 2026-03-30 21:26:24.076839 | controller | INFO [helm > idempotence] Executing 2026-03-30 21:26:25.037385 | controller | 2026-03-30 21:26:25.037561 | controller | PLAY [Converge] **************************************************************** 2026-03-30 21:26:25.037677 | controller | 2026-03-30 21:26:25.037797 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-30 21:26:25.037915 | controller | Monday 30 March 2026 21:26:25 +0000 (0:00:00.014) 0:00:00.014 ********** 2026-03-30 21:26:26.183723 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-30 21:26:26.188018 | controller | ok: [controller] 2026-03-30 21:26:26.188081 | controller | 2026-03-30 21:26:26.188098 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-30 21:26:26.188296 | controller | Monday 30 March 2026 21:26:26 +0000 (0:00:01.150) 0:00:01.164 ********** 2026-03-30 21:26:26.693386 | controller | ok: [controller] 2026-03-30 21:26:26.693506 | controller | 2026-03-30 21:26:26.693729 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-30 21:26:26.693924 | controller | Monday 30 March 2026 21:26:26 +0000 (0:00:00.505) 0:00:01.669 ********** 2026-03-30 21:26:27.840843 | controller | ok: [controller] 2026-03-30 21:26:27.840885 | controller | 2026-03-30 21:26:27.840894 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-30 21:26:27.840903 | controller | Monday 30 March 2026 21:26:27 +0000 (0:00:01.146) 0:00:02.816 ********** 2026-03-30 21:26:28.271938 | controller | ok: [controller] 2026-03-30 21:26:28.271966 | controller | 2026-03-30 21:26:28.271971 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-30 21:26:28.271975 | controller | Monday 30 March 2026 21:26:28 +0000 (0:00:00.428) 0:00:03.245 ********** 2026-03-30 21:26:28.314753 | controller | ok: [controller] => { 2026-03-30 21:26:28.314823 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-30 21:26:28.314837 | controller | } 2026-03-30 21:26:28.314946 | controller | 2026-03-30 21:26:28.315041 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-30 21:26:28.315124 | controller | Monday 30 March 2026 21:26:28 +0000 (0:00:00.046) 0:00:03.291 ********** 2026-03-30 21:26:28.867948 | controller | ok: [controller] 2026-03-30 21:26:28.868019 | controller | 2026-03-30 21:26:28.868084 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-30 21:26:28.868186 | controller | Monday 30 March 2026 21:26:28 +0000 (0:00:00.553) 0:00:03.844 ********** 2026-03-30 21:26:30.628376 | controller | ok: [controller] 2026-03-30 21:26:30.628444 | controller | 2026-03-30 21:26:30.628455 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-30 21:26:30.631398 | controller | Monday 30 March 2026 21:26:30 +0000 (0:00:01.758) 0:00:05.602 ********** 2026-03-30 21:26:31.171504 | controller | ok: [controller] 2026-03-30 21:26:31.171571 | controller | 2026-03-30 21:26:31.171689 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-30 21:26:31.171825 | controller | Monday 30 March 2026 21:26:31 +0000 (0:00:00.544) 0:00:06.147 ********** 2026-03-30 21:26:31.645261 | controller | ok: [controller] 2026-03-30 21:26:31.645301 | controller | 2026-03-30 21:26:31.645311 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-30 21:26:31.645319 | controller | Monday 30 March 2026 21:26:31 +0000 (0:00:00.470) 0:00:06.618 ********** 2026-03-30 21:26:32.132458 | controller | ok: [controller] 2026-03-30 21:26:32.132515 | controller | 2026-03-30 21:26:32.132660 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-30 21:26:32.132771 | controller | Monday 30 March 2026 21:26:32 +0000 (0:00:00.488) 0:00:07.106 ********** 2026-03-30 21:26:32.462478 | controller | ok: [controller] 2026-03-30 21:26:32.462536 | controller | 2026-03-30 21:26:32.462676 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-30 21:26:32.462839 | controller | Monday 30 March 2026 21:26:32 +0000 (0:00:00.332) 0:00:07.439 ********** 2026-03-30 21:26:32.799323 | controller | ok: [controller] 2026-03-30 21:26:32.799419 | controller | 2026-03-30 21:26:32.799558 | controller | TASK [Install plugin] ********************************************************** 2026-03-30 21:26:32.799694 | controller | Monday 30 March 2026 21:26:32 +0000 (0:00:00.336) 0:00:07.775 ********** 2026-03-30 21:26:32.851845 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-30 21:26:32.851911 | controller | 2026-03-30 21:26:32.851924 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-30 21:26:32.852058 | controller | Monday 30 March 2026 21:26:32 +0000 (0:00:00.052) 0:00:07.828 ********** 2026-03-30 21:26:32.900383 | controller | ok: [controller] => { 2026-03-30 21:26:32.900482 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-30 21:26:32.900548 | controller | } 2026-03-30 21:26:32.900637 | controller | 2026-03-30 21:26:32.900746 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-30 21:26:32.900894 | controller | Monday 30 March 2026 21:26:32 +0000 (0:00:00.045) 0:00:07.874 ********** 2026-03-30 21:26:33.329813 | controller | ok: [controller] 2026-03-30 21:26:33.329876 | controller | 2026-03-30 21:26:33.329997 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-30 21:26:33.330124 | controller | Monday 30 March 2026 21:26:33 +0000 (0:00:00.431) 0:00:08.306 ********** 2026-03-30 21:26:35.060542 | controller | ok: [controller] 2026-03-30 21:26:35.060597 | controller | 2026-03-30 21:26:35.060633 | controller | PLAY RECAP ********************************************************************* 2026-03-30 21:26:35.060655 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-30 21:26:35.060668 | controller | 2026-03-30 21:26:35.063910 | controller | 2026-03-30 21:26:35.063963 | controller | TASKS RECAP ******************************************************************** 2026-03-30 21:26:35.063976 | controller | Monday 30 March 2026 21:26:35 +0000 (0:00:01.730) 0:00:10.036 ********** 2026-03-30 21:26:35.063986 | controller | =============================================================================== 2026-03-30 21:26:35.063996 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.76s 2026-03-30 21:26:35.064006 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.73s 2026-03-30 21:26:35.064016 | controller | Gathering Facts --------------------------------------------------------- 1.15s 2026-03-30 21:26:35.064025 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.15s 2026-03-30 21:26:35.064034 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.55s 2026-03-30 21:26:35.064044 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.54s 2026-03-30 21:26:35.064053 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.51s 2026-03-30 21:26:35.064062 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.49s 2026-03-30 21:26:35.064073 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.47s 2026-03-30 21:26:35.064329 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.43s 2026-03-30 21:26:35.064696 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.43s 2026-03-30 21:26:35.065057 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.34s 2026-03-30 21:26:35.065404 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.33s 2026-03-30 21:26:35.065811 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-03-30 21:26:35.065986 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-30 21:26:35.066129 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-30 21:26:35.173104 | controller | INFO [helm > idempotence] Executed: Successful 2026-03-30 21:26:35.184493 | controller | INFO [helm > side_effect] Executing 2026-03-30 21:26:35.184975 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-30 21:26:35.192010 | controller | INFO [helm > verify] Executing 2026-03-30 21:26:36.098192 | controller | 2026-03-30 21:26:36.098576 | controller | PLAY [Verify] ****************************************************************** 2026-03-30 21:26:36.098820 | controller | 2026-03-30 21:26:36.099074 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-30 21:26:36.099325 | controller | Monday 30 March 2026 21:26:36 +0000 (0:00:00.010) 0:00:00.010 ********** 2026-03-30 21:26:37.225509 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-30 21:26:37.232609 | controller | ok: [controller] 2026-03-30 21:26:37.232896 | controller | 2026-03-30 21:26:37.233223 | controller | TASK [Get the current Helm version] ******************************************** 2026-03-30 21:26:37.233518 | controller | Monday 30 March 2026 21:26:37 +0000 (0:00:01.135) 0:00:01.145 ********** 2026-03-30 21:26:37.694592 | controller | changed: [controller] 2026-03-30 21:26:37.694880 | controller | 2026-03-30 21:26:37.695145 | controller | TASK [Assert Helm version] ***************************************************** 2026-03-30 21:26:37.695442 | controller | Monday 30 March 2026 21:26:37 +0000 (0:00:00.461) 0:00:01.607 ********** 2026-03-30 21:26:37.725920 | controller | ok: [controller] => { 2026-03-30 21:26:37.726224 | controller | "changed": false, 2026-03-30 21:26:37.726501 | controller | "msg": "All assertions passed" 2026-03-30 21:26:37.726766 | controller | } 2026-03-30 21:26:37.727018 | controller | 2026-03-30 21:26:37.727314 | controller | PLAY RECAP ********************************************************************* 2026-03-30 21:26:37.727680 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-30 21:26:37.727973 | controller | 2026-03-30 21:26:37.728204 | controller | 2026-03-30 21:26:37.728443 | controller | TASKS RECAP ******************************************************************** 2026-03-30 21:26:37.728686 | controller | Monday 30 March 2026 21:26:37 +0000 (0:00:00.032) 0:00:01.639 ********** 2026-03-30 21:26:37.728911 | controller | =============================================================================== 2026-03-30 21:26:37.729157 | controller | Gathering Facts --------------------------------------------------------- 1.14s 2026-03-30 21:26:37.729395 | controller | Get the current Helm version -------------------------------------------- 0.46s 2026-03-30 21:26:37.729631 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-03-30 21:26:37.822431 | controller | INFO [helm > verify] Executed: Successful 2026-03-30 21:26:37.833816 | controller | INFO [helm > cleanup] Executing 2026-03-30 21:26:37.834174 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-30 21:26:37.840619 | controller | INFO [helm > destroy] Executing 2026-03-30 21:26:37.840647 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-30 21:26:37.840738 | controller | INFO [helm > destroy] Executed: Successful 2026-03-30 21:26:37.841007 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-30 21:26:38.457835 | controller | ok: Runtime: 0:00:49.065143 2026-03-30 21:26:38.466169 | 2026-03-30 21:26:38.466250 | PLAY RECAP 2026-03-30 21:26:38.466296 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-30 21:26:38.466319 | 2026-03-30 21:26:38.635409 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-30 21:26:38.637546 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-30 21:26:39.243272 | 2026-03-30 21:26:39.243414 | PLAY [all] 2026-03-30 21:26:39.254371 | 2026-03-30 21:26:39.254452 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-30 21:26:39.648743 | controller | changed 2026-03-30 21:26:39.653313 | 2026-03-30 21:26:39.653400 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-30 21:26:40.074650 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 21:26:40.075454 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 21:26:40.082531 | controller | environment: line 1: kubectl: command not found 2026-03-30 21:26:40.086651 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 21:26:40.086668 | controller | environment: line 1: kubectl: command not found 2026-03-30 21:26:40.089174 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 21:26:40.091031 | controller | environment: line 1: kubectl: command not found 2026-03-30 21:26:40.092199 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 21:26:40.093447 | controller | environment: line 1: kubectl: command not found 2026-03-30 21:26:40.095337 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 21:26:40.095576 | controller | environment: line 1: kubectl: command not found 2026-03-30 21:26:40.096878 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 21:26:40.198991 | controller | ok: Runtime: 0:00:00.034522 2026-03-30 21:26:40.205163 | 2026-03-30 21:26:40.205240 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-30 21:26:40.440287 | controller | changed 2026-03-30 21:26:40.446586 | 2026-03-30 21:26:40.446710 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-30 21:26:40.688149 | controller | environment: line 5: kubectl: command not found 2026-03-30 21:26:40.689196 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 21:26:40.689408 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 21:26:40.689432 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 21:26:40.975139 | controller | ok: Runtime: 0:00:00.012244 2026-03-30 21:26:40.983646 | 2026-03-30 21:26:40.983908 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-30 21:26:41.685225 | controller | changed: 2026-03-30 21:26:41.685454 | controller | created directory /var/lib/zuul/builds/de37b950976742579547fc1926e54550/work/logs/controller 2026-03-30 21:26:41.685496 | controller | cd+++++++++ objects/ 2026-03-30 21:26:41.685526 | controller | cd+++++++++ objects/cluster/ 2026-03-30 21:26:41.685558 | controller | cd+++++++++ objects/namespaced/ 2026-03-30 21:26:41.694536 | 2026-03-30 21:26:41.694617 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-30 21:26:41.944328 | controller | changed 2026-03-30 21:26:41.948495 | 2026-03-30 21:26:41.948563 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-30 21:26:42.197192 | controller | changed 2026-03-30 21:26:42.201382 | 2026-03-30 21:26:42.201458 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-30 21:26:42.444267 | controller | environment: line 3: kubectl: command not found 2026-03-30 21:26:42.989850 | controller | ok: Runtime: 0:00:00.015944 2026-03-30 21:26:42.998813 | 2026-03-30 21:26:42.998916 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-30 21:26:43.591805 | controller | changed: 2026-03-30 21:26:43.592252 | controller | cd+++++++++ pod-logs/ 2026-03-30 21:26:43.592349 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-03-30 21:26:43.599868 | 2026-03-30 21:26:43.599944 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-30 21:26:43.856784 | controller | changed: "values" 2026-03-30 21:26:44.065960 | controller | changed: "releases" 2026-03-30 21:26:44.082471 | 2026-03-30 21:26:44.082646 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-30 21:26:44.328297 | controller | /bin/bash: line 3: kubectl: command not found 2026-03-30 21:26:44.616185 | controller | ok: Runtime: 0:00:00.008329 2026-03-30 21:26:44.621787 | 2026-03-30 21:26:44.621870 | TASK [helm-release-status : Downloads logs to executor] 2026-03-30 21:26:45.343231 | controller | changed: 2026-03-30 21:26:45.343537 | controller | cd+++++++++ helm/ 2026-03-30 21:26:45.343603 | controller | cd+++++++++ helm/releases/ 2026-03-30 21:26:45.343657 | controller | cd+++++++++ helm/values/ 2026-03-30 21:26:45.350747 | 2026-03-30 21:26:45.350840 | PLAY RECAP 2026-03-30 21:26:45.350904 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-30 21:26:45.350937 | 2026-03-30 21:26:45.536599 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-30 21:26:45.707326 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-30 21:26:46.325724 | 2026-03-30 21:26:46.325893 | PLAY [all] 2026-03-30 21:26:46.336733 | 2026-03-30 21:26:46.336859 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-30 21:26:46.382691 | controller | skipping: Conditional result was False 2026-03-30 21:26:46.392117 | 2026-03-30 21:26:46.392208 | TASK [fetch-output : Set log path for single node] 2026-03-30 21:26:46.435651 | controller | ok 2026-03-30 21:26:46.440842 | 2026-03-30 21:26:46.440939 | LOOP [fetch-output : Ensure local output dirs] 2026-03-30 21:26:46.966698 | controller -> localhost | ok: "/var/lib/zuul/builds/de37b950976742579547fc1926e54550/work/logs" 2026-03-30 21:26:47.190968 | controller -> localhost | changed: "/var/lib/zuul/builds/de37b950976742579547fc1926e54550/work/artifacts" 2026-03-30 21:26:47.416267 | controller -> localhost | changed: "/var/lib/zuul/builds/de37b950976742579547fc1926e54550/work/docs" 2026-03-30 21:26:47.438872 | 2026-03-30 21:26:47.439027 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-30 21:26:48.169144 | controller | changed: .d..t...... ./ 2026-03-30 21:26:48.282474 | controller | changed: All items complete 2026-03-30 21:26:48.282661 | 2026-03-30 21:26:48.676588 | controller | changed: .d..t...... ./ 2026-03-30 21:26:49.208919 | controller | changed: .d..t...... ./ 2026-03-30 21:26:49.233329 | 2026-03-30 21:26:49.233504 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-30 21:26:49.729463 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007877 2026-03-30 21:26:49.984748 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.005900 2026-03-30 21:26:50.004644 | 2026-03-30 21:26:50.004787 | PLAY [all] 2026-03-30 21:26:50.010656 | 2026-03-30 21:26:50.010722 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-30 21:26:50.490546 | controller | changed 2026-03-30 21:26:50.496771 | 2026-03-30 21:26:50.496845 | PLAY RECAP 2026-03-30 21:26:50.496905 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-30 21:26:50.496935 | 2026-03-30 21:26:50.628858 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-30 21:26:50.631790 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-30 21:26:51.208355 | 2026-03-30 21:26:51.208497 | PLAY [localhost] 2026-03-30 21:26:51.218554 | 2026-03-30 21:26:51.218633 | TASK [Generate Zuul manifest] 2026-03-30 21:26:51.240788 | localhost | ok 2026-03-30 21:26:51.259373 | 2026-03-30 21:26:51.259535 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-30 21:26:51.606104 | localhost | changed 2026-03-30 21:26:51.618441 | 2026-03-30 21:26:51.618544 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-30 21:26:51.651880 | localhost | ok 2026-03-30 21:26:51.661621 | 2026-03-30 21:26:51.661722 | TASK [Upload logs] 2026-03-30 21:26:51.685167 | localhost | ok 2026-03-30 21:26:51.751979 | 2026-03-30 21:26:51.752127 | TASK [Set zuul-log-path fact] 2026-03-30 21:26:51.776018 | localhost | ok 2026-03-30 21:26:51.787922 | 2026-03-30 21:26:51.788007 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-30 21:26:51.822436 | localhost | ok 2026-03-30 21:26:51.830922 | 2026-03-30 21:26:51.830996 | TASK [upload-logs : Create log directories] 2026-03-30 21:26:52.271790 | localhost | changed 2026-03-30 21:26:52.279290 | 2026-03-30 21:26:52.279391 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-30 21:26:52.701538 | localhost -> localhost | ok: Runtime: 0:00:00.006024 2026-03-30 21:26:52.708155 | 2026-03-30 21:26:52.708293 | TASK [upload-logs : Upload logs to log server] 2026-03-30 21:26:53.284708 | localhost | Output suppressed because no_log was given 2026-03-30 21:26:53.290661 | 2026-03-30 21:26:53.290754 | LOOP [upload-logs : Compress console log and json output] 2026-03-30 21:26:53.345778 | localhost | skipping: Conditional result was False 2026-03-30 21:26:53.355525 | localhost | skipping: Conditional result was False 2026-03-30 21:26:53.366755 | 2026-03-30 21:26:53.366887 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-30 21:26:53.415628 | localhost | skipping: Conditional result was False 2026-03-30 21:26:53.416109 | 2026-03-30 21:26:53.422339 | localhost | skipping: Conditional result was False 2026-03-30 21:26:53.439500 | 2026-03-30 21:26:53.439636 | LOOP [upload-logs : Upload console log and json output]