2026-04-18 17:48:28.855763 | Job console starting 2026-04-18 17:48:28.865285 | Updating git repos 2026-04-18 17:48:28.905574 | Cloning repos into workspace 2026-04-18 17:48:31.006904 | Restoring repo states 2026-04-18 17:48:31.166204 | Merging changes 2026-04-18 17:48:32.075991 | Checking out repos 2026-04-18 17:48:32.366554 | Preparing playbooks 2026-04-18 17:48:53.393837 | Running Ansible setup 2026-04-18 17:49:00.905709 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 17:49:01.625974 | 2026-04-18 17:49:01.740929 | PLAY [localhost] 2026-04-18 17:49:01.762109 | 2026-04-18 17:49:01.762262 | TASK [Gathering Facts] 2026-04-18 17:49:02.672802 | localhost | ok 2026-04-18 17:49:02.683376 | 2026-04-18 17:49:02.683458 | TASK [Setup log path fact] 2026-04-18 17:49:02.723713 | localhost | ok 2026-04-18 17:49:02.736613 | 2026-04-18 17:49:02.736683 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 17:49:02.767089 | localhost | ok 2026-04-18 17:49:02.775618 | 2026-04-18 17:49:02.775689 | TASK [emit-job-header : Print job information] 2026-04-18 17:49:02.823074 | # Job Information 2026-04-18 17:49:02.823253 | Ansible Version: 2.16.16 2026-04-18 17:49:02.823286 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart 2026-04-18 17:49:02.823310 | Pipeline: check 2026-04-18 17:49:02.823330 | Executor: 0a8996d2b663 2026-04-18 17:49:02.823351 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/264 2026-04-18 17:49:02.823373 | Event ID: 4b91b6b0-3b4c-11f1-854e-6828c01faebc 2026-04-18 17:49:02.826752 | 2026-04-18 17:49:02.826824 | LOOP [emit-job-header : Print node information] 2026-04-18 17:49:02.909423 | localhost | ok: 2026-04-18 17:49:02.909593 | localhost | # Node Information 2026-04-18 17:49:02.909621 | localhost | Inventory Hostname: controller 2026-04-18 17:49:02.909643 | localhost | Hostname: np0000167550 2026-04-18 17:49:02.909663 | localhost | Username: zuul 2026-04-18 17:49:02.909686 | localhost | Distro: Debian 13.4 2026-04-18 17:49:02.909706 | localhost | Provider: yul1 2026-04-18 17:49:02.909725 | localhost | Region: ca-ymq-1 2026-04-18 17:49:02.909744 | localhost | Label: debian-trixie 2026-04-18 17:49:02.909763 | localhost | Product Name: OpenStack Nova 2026-04-18 17:49:02.909781 | localhost | Interface IP: 199.204.45.57 2026-04-18 17:49:02.920477 | 2026-04-18 17:49:02.920612 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-18 17:49:03.356894 | localhost -> localhost | changed 2026-04-18 17:49:03.364417 | 2026-04-18 17:49:03.364547 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-18 17:49:04.275587 | localhost -> localhost | changed 2026-04-18 17:49:04.282958 | 2026-04-18 17:49:04.283067 | PLAY [all] 2026-04-18 17:49:04.290320 | 2026-04-18 17:49:04.290394 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-18 17:49:04.573939 | controller -> localhost | ok 2026-04-18 17:49:04.581960 | 2026-04-18 17:49:04.582073 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-18 17:49:04.615506 | controller | ok 2026-04-18 17:49:04.629766 | controller | included: /var/lib/zuul/builds/0d0e78f490574c428c53fd330d1fbb8f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-18 17:49:04.634679 | 2026-04-18 17:49:04.634747 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-18 17:49:05.585101 | controller -> localhost | Generating public/private rsa key pair. 2026-04-18 17:49:05.585478 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/0d0e78f490574c428c53fd330d1fbb8f/work/0d0e78f490574c428c53fd330d1fbb8f_id_rsa 2026-04-18 17:49:05.585512 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/0d0e78f490574c428c53fd330d1fbb8f/work/0d0e78f490574c428c53fd330d1fbb8f_id_rsa.pub 2026-04-18 17:49:05.585537 | controller -> localhost | The key fingerprint is: 2026-04-18 17:49:05.585561 | controller -> localhost | SHA256:MIsPl+DcJXAYFfRRNHFa2VlJPyQ5oHqsgf85vKyNUUg zuul-build-sshkey 2026-04-18 17:49:05.585598 | controller -> localhost | The key's randomart image is: 2026-04-18 17:49:05.585621 | controller -> localhost | +---[RSA 3072]----+ 2026-04-18 17:49:05.585646 | controller -> localhost | | o==..o=o++o=o| 2026-04-18 17:49:05.585670 | controller -> localhost | | .o . ..=.o=..| 2026-04-18 17:49:05.585693 | controller -> localhost | | . +Eo.. ...| 2026-04-18 17:49:05.585714 | controller -> localhost | | o +oB+ .| 2026-04-18 17:49:05.585736 | controller -> localhost | | =.=+S+ | 2026-04-18 17:49:05.585757 | controller -> localhost | | +. = | 2026-04-18 17:49:05.585779 | controller -> localhost | | .+. | 2026-04-18 17:49:05.585799 | controller -> localhost | | *o. | 2026-04-18 17:49:05.585823 | controller -> localhost | | o.*o | 2026-04-18 17:49:05.585845 | controller -> localhost | +----[SHA256]-----+ 2026-04-18 17:49:05.585912 | controller -> localhost | ok: Runtime: 0:00:00.477255 2026-04-18 17:49:05.591380 | 2026-04-18 17:49:05.591451 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-18 17:49:05.623391 | controller | ok 2026-04-18 17:49:05.632199 | controller | included: /var/lib/zuul/builds/0d0e78f490574c428c53fd330d1fbb8f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-18 17:49:05.639306 | 2026-04-18 17:49:05.639366 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-18 17:49:05.665884 | controller | skipping: Conditional result was False 2026-04-18 17:49:05.671976 | 2026-04-18 17:49:05.672059 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-18 17:49:06.210113 | controller | changed 2026-04-18 17:49:07.387048 | 2026-04-18 17:49:07.387178 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-18 17:49:07.610406 | controller | ok 2026-04-18 17:49:07.615891 | 2026-04-18 17:49:07.616046 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-18 17:49:08.174173 | controller | changed 2026-04-18 17:49:08.235554 | 2026-04-18 17:49:08.235654 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-18 17:49:08.768283 | controller | changed 2026-04-18 17:49:08.774352 | 2026-04-18 17:49:08.774440 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-18 17:49:08.807439 | controller | skipping: Conditional result was False 2026-04-18 17:49:08.816034 | 2026-04-18 17:49:08.816131 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-18 17:49:09.198676 | controller -> localhost | changed 2026-04-18 17:49:09.226245 | 2026-04-18 17:49:09.226947 | TASK [add-build-sshkey : Add back temp key] 2026-04-18 17:49:09.568498 | controller -> localhost | Identity added: /var/lib/zuul/builds/0d0e78f490574c428c53fd330d1fbb8f/work/0d0e78f490574c428c53fd330d1fbb8f_id_rsa (zuul-build-sshkey) 2026-04-18 17:49:09.568671 | controller -> localhost | ok: Runtime: 0:00:00.012610 2026-04-18 17:49:09.576262 | 2026-04-18 17:49:09.576336 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-18 17:49:09.962997 | controller | ok 2026-04-18 17:49:09.968689 | 2026-04-18 17:49:09.968756 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-18 17:49:10.001314 | controller | skipping: Conditional result was False 2026-04-18 17:49:10.020033 | 2026-04-18 17:49:10.020203 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-18 17:49:10.411354 | controller | ok 2026-04-18 17:49:10.417563 | 2026-04-18 17:49:10.417672 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-18 17:49:11.455107 | controller | Output suppressed because no_log was given 2026-04-18 17:49:11.464942 | 2026-04-18 17:49:11.465046 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-18 17:49:11.678773 | controller | ok: "logs" 2026-04-18 17:49:11.679110 | controller | ok: All items complete 2026-04-18 17:49:11.679172 | 2026-04-18 17:49:11.865231 | controller | ok: "artifacts" 2026-04-18 17:49:12.046641 | controller | ok: "docs" 2026-04-18 17:49:12.065785 | 2026-04-18 17:49:12.065899 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-18 17:49:12.273323 | controller | changed: "logs" 2026-04-18 17:49:12.464773 | controller | changed: "artifacts" 2026-04-18 17:49:12.670342 | controller | changed: "docs" 2026-04-18 17:49:14.727480 | 2026-04-18 17:49:14.727579 | PLAY RECAP 2026-04-18 17:49:14.727628 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-18 17:49:14.727657 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 17:49:14.727677 | 2026-04-18 17:49:14.904185 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 17:49:14.905948 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-18 17:49:15.547261 | 2026-04-18 17:49:15.547439 | PLAY [all] 2026-04-18 17:49:15.559584 | 2026-04-18 17:49:15.559699 | TASK [setup-uv : Extract archive] 2026-04-18 17:49:18.091234 | controller | changed 2026-04-18 17:49:18.098963 | 2026-04-18 17:49:18.099106 | TASK [setup-uv : Print version] 2026-04-18 17:49:18.518057 | controller | uv 0.8.13 2026-04-18 17:49:18.735464 | controller | ok: Runtime: 0:00:00.015241 2026-04-18 17:49:18.744474 | 2026-04-18 17:49:18.744562 | PLAY RECAP 2026-04-18 17:49:18.744612 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 17:49:18.744636 | 2026-04-18 17:49:18.906049 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-18 17:49:18.911407 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-04-18 17:49:19.509205 | 2026-04-18 17:49:19.509342 | PLAY [all] 2026-04-18 17:49:19.521639 | 2026-04-18 17:49:19.521809 | TASK [Update apt cache] 2026-04-18 17:49:24.906780 | controller | ok 2026-04-18 17:49:24.987724 | 2026-04-18 17:49:24.988006 | TASK [Disable firewalld] 2026-04-18 17:49:25.015459 | controller | skipping: Conditional result was False 2026-04-18 17:49:25.024653 | 2026-04-18 17:49:25.024850 | TASK [Install "jq" for log collection] 2026-04-18 17:49:28.889407 | controller | changed 2026-04-18 17:49:29.368898 | 2026-04-18 17:49:29.369286 | PLAY RECAP 2026-04-18 17:49:29.369737 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-18 17:49:29.369779 | 2026-04-18 17:49:29.489620 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-04-18 17:49:29.491516 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-18 17:49:30.138542 | 2026-04-18 17:49:30.138680 | PLAY [all] 2026-04-18 17:49:30.148384 | 2026-04-18 17:49:30.148459 | TASK [Copy inventory file for Zuul] 2026-04-18 17:49:31.161750 | controller | changed 2026-04-18 17:49:31.252491 | 2026-04-18 17:49:31.252676 | TASK [Switch "ansible_host" to private IP] 2026-04-18 17:49:31.580264 | controller | changed: 1 replacements made 2026-04-18 17:49:31.587019 | 2026-04-18 17:49:31.587158 | TASK [Run Molecule scenario] 2026-04-18 17:49:32.054047 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-04-18 17:49:32.054162 | controller | Creating virtual environment at: .venv 2026-04-18 17:49:32.114554 | controller | Downloading ansible-core (2.3MiB) 2026-04-18 17:49:32.114827 | controller | Downloading pygments (1.2MiB) 2026-04-18 17:49:32.125964 | controller | Downloading cryptography (4.3MiB) 2026-04-18 17:49:32.270327 | controller | Downloading cryptography 2026-04-18 17:49:32.324525 | controller | Downloading pygments 2026-04-18 17:49:32.489496 | controller | Downloading ansible-core 2026-04-18 17:49:32.542017 | controller | Installed 36 packages in 51ms 2026-04-18 17:49:33.234088 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-04-18 17:49:33.234118 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-04-18 17:49:34.095077 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-18 17:49:34.095224 | controller | INFO default scenario not found, disabling shared state. 2026-04-18 17:49:34.095487 | controller | INFO [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-18 17:49:34.095628 | controller | INFO [upload-helm-chart > prerun] Performing prerun with role_name_check=0... 2026-04-18 17:49:49.003570 | controller | INFO [upload-helm-chart > dependency] Executing 2026-04-18 17:49:49.003906 | controller | WARNING [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml 2026-04-18 17:49:49.004145 | controller | WARNING [upload-helm-chart > dependency] Missing collections requirements file: collections.yml 2026-04-18 17:49:49.004304 | controller | WARNING [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-18 17:49:49.009989 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-04-18 17:49:49.010375 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 17:49:49.015928 | controller | INFO [upload-helm-chart > destroy] Executing 2026-04-18 17:49:49.016071 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-04-18 17:49:49.016166 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-04-18 17:49:49.021718 | controller | INFO [upload-helm-chart > syntax] Executing 2026-04-18 17:49:49.902786 | controller | 2026-04-18 17:49:49.903187 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml 2026-04-18 17:49:49.962271 | controller | INFO [upload-helm-chart > syntax] Executed: Successful 2026-04-18 17:49:49.976202 | controller | INFO [upload-helm-chart > create] Executing 2026-04-18 17:49:49.978682 | controller | WARNING [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 17:49:49.985145 | controller | INFO [upload-helm-chart > prepare] Executing 2026-04-18 17:49:49.985551 | controller | WARNING [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 17:49:49.992070 | controller | INFO [upload-helm-chart > converge] Executing 2026-04-18 17:49:50.868932 | controller | 2026-04-18 17:49:50.868958 | controller | PLAY [Converge] **************************************************************** 2026-04-18 17:49:50.868965 | controller | 2026-04-18 17:49:50.868970 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-18 17:49:50.868976 | controller | Saturday 18 April 2026 17:49:50 +0000 (0:00:00.038) 0:00:00.038 ******** 2026-04-18 17:49:52.147872 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-04-18 17:49:52.154846 | controller | ok: [controller] 2026-04-18 17:49:52.154918 | controller | 2026-04-18 17:49:52.155017 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-04-18 17:49:52.155116 | controller | Saturday 18 April 2026 17:49:52 +0000 (0:00:01.287) 0:00:01.325 ******** 2026-04-18 17:49:52.231720 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-04-18 17:49:52.231916 | controller | 2026-04-18 17:49:52.232211 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-04-18 17:49:52.232539 | controller | Saturday 18 April 2026 17:49:52 +0000 (0:00:00.076) 0:00:01.402 ******** 2026-04-18 17:49:52.988017 | controller | changed: [controller] 2026-04-18 17:49:52.988250 | controller | 2026-04-18 17:49:52.988415 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-04-18 17:49:52.988621 | controller | Saturday 18 April 2026 17:49:52 +0000 (0:00:00.755) 0:00:02.158 ******** 2026-04-18 17:49:53.027569 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-04-18 17:49:53.027733 | controller | 2026-04-18 17:49:53.027990 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-04-18 17:49:53.028174 | controller | Saturday 18 April 2026 17:49:53 +0000 (0:00:00.040) 0:00:02.198 ******** 2026-04-18 17:49:53.457413 | controller | changed: [controller] 2026-04-18 17:49:53.458052 | controller | 2026-04-18 17:49:53.458385 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-04-18 17:49:53.458688 | controller | Saturday 18 April 2026 17:49:53 +0000 (0:00:00.428) 0:00:02.627 ******** 2026-04-18 17:49:54.602184 | controller | changed: [controller] 2026-04-18 17:49:54.602437 | controller | 2026-04-18 17:49:54.602692 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-04-18 17:49:54.602922 | controller | Saturday 18 April 2026 17:49:54 +0000 (0:00:01.145) 0:00:03.772 ******** 2026-04-18 17:49:55.035469 | controller | ok: [controller] 2026-04-18 17:49:55.035653 | controller | 2026-04-18 17:49:55.035920 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-04-18 17:49:55.036126 | controller | Saturday 18 April 2026 17:49:55 +0000 (0:00:00.433) 0:00:04.205 ******** 2026-04-18 17:49:55.100011 | controller | skipping: [controller] 2026-04-18 17:49:55.100218 | controller | 2026-04-18 17:49:55.100430 | controller | PLAY RECAP ********************************************************************* 2026-04-18 17:49:55.100673 | controller | controller : ok=7 changed=3 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-04-18 17:49:55.100848 | controller | 2026-04-18 17:49:55.101015 | controller | 2026-04-18 17:49:55.101204 | controller | TASKS RECAP ******************************************************************** 2026-04-18 17:49:55.101395 | controller | Saturday 18 April 2026 17:49:55 +0000 (0:00:00.065) 0:00:04.271 ******** 2026-04-18 17:49:55.101569 | controller | =============================================================================== 2026-04-18 17:49:55.101755 | controller | Gathering Facts --------------------------------------------------------- 1.29s 2026-04-18 17:49:55.101953 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.15s 2026-04-18 17:49:55.102139 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.76s 2026-04-18 17:49:55.102330 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.43s 2026-04-18 17:49:55.102508 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.43s 2026-04-18 17:49:55.102699 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s 2026-04-18 17:49:55.102955 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.07s 2026-04-18 17:49:55.103168 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s 2026-04-18 17:49:55.202787 | controller | INFO [upload-helm-chart > converge] Executed: Successful 2026-04-18 17:49:55.224267 | controller | INFO [upload-helm-chart > idempotence] Executing 2026-04-18 17:49:56.055153 | controller | 2026-04-18 17:49:56.055330 | controller | PLAY [Converge] **************************************************************** 2026-04-18 17:49:56.055568 | controller | 2026-04-18 17:49:56.055773 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-18 17:49:56.056013 | controller | Saturday 18 April 2026 17:49:56 +0000 (0:00:00.012) 0:00:00.012 ******** 2026-04-18 17:49:57.091572 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-04-18 17:49:57.097627 | controller | ok: [controller] 2026-04-18 17:49:57.097801 | controller | 2026-04-18 17:49:57.098033 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-04-18 17:49:57.098462 | controller | Saturday 18 April 2026 17:49:57 +0000 (0:00:01.042) 0:00:01.054 ******** 2026-04-18 17:49:57.171740 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-04-18 17:49:57.171926 | controller | 2026-04-18 17:49:57.172129 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-04-18 17:49:57.172315 | controller | Saturday 18 April 2026 17:49:57 +0000 (0:00:00.074) 0:00:01.128 ******** 2026-04-18 17:49:57.902116 | controller | ok: [controller] 2026-04-18 17:49:57.902268 | controller | 2026-04-18 17:49:57.902547 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-04-18 17:49:57.902738 | controller | Saturday 18 April 2026 17:49:57 +0000 (0:00:00.730) 0:00:01.859 ******** 2026-04-18 17:49:57.944538 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-04-18 17:49:57.944747 | controller | 2026-04-18 17:49:57.944984 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-04-18 17:49:57.945281 | controller | Saturday 18 April 2026 17:49:57 +0000 (0:00:00.042) 0:00:01.901 ******** 2026-04-18 17:49:58.351657 | controller | ok: [controller] 2026-04-18 17:49:58.351781 | controller | 2026-04-18 17:49:58.352124 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-04-18 17:49:58.352256 | controller | Saturday 18 April 2026 17:49:58 +0000 (0:00:00.407) 0:00:02.308 ******** 2026-04-18 17:50:00.440177 | controller | ok: [controller] 2026-04-18 17:50:00.440381 | controller | 2026-04-18 17:50:00.440611 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-04-18 17:50:00.440814 | controller | Saturday 18 April 2026 17:50:00 +0000 (0:00:02.087) 0:00:04.396 ******** 2026-04-18 17:50:00.867925 | controller | ok: [controller] 2026-04-18 17:50:00.868046 | controller | 2026-04-18 17:50:00.868298 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-04-18 17:50:00.868636 | controller | Saturday 18 April 2026 17:50:00 +0000 (0:00:00.428) 0:00:04.824 ******** 2026-04-18 17:50:00.906221 | controller | skipping: [controller] 2026-04-18 17:50:00.906435 | controller | 2026-04-18 17:50:00.906667 | controller | PLAY RECAP ********************************************************************* 2026-04-18 17:50:00.906919 | controller | controller : ok=7 changed=0 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-04-18 17:50:00.907130 | controller | 2026-04-18 17:50:00.907351 | controller | 2026-04-18 17:50:00.907669 | controller | TASKS RECAP ******************************************************************** 2026-04-18 17:50:00.907956 | controller | Saturday 18 April 2026 17:50:00 +0000 (0:00:00.039) 0:00:04.864 ******** 2026-04-18 17:50:00.908187 | controller | =============================================================================== 2026-04-18 17:50:00.908436 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 2.09s 2026-04-18 17:50:00.908672 | controller | Gathering Facts --------------------------------------------------------- 1.04s 2026-04-18 17:50:00.908922 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.73s 2026-04-18 17:50:00.909164 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.43s 2026-04-18 17:50:00.909410 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.41s 2026-04-18 17:50:00.909665 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s 2026-04-18 17:50:00.909915 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s 2026-04-18 17:50:00.910166 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.04s 2026-04-18 17:50:00.991829 | controller | INFO [upload-helm-chart > idempotence] Executed: Successful 2026-04-18 17:50:01.002002 | controller | INFO [upload-helm-chart > side_effect] Executing 2026-04-18 17:50:01.870538 | controller | 2026-04-18 17:50:01.870750 | controller | PLAY [Side effect] ************************************************************* 2026-04-18 17:50:01.870932 | controller | 2026-04-18 17:50:01.871135 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-18 17:50:01.871335 | controller | Saturday 18 April 2026 17:50:01 +0000 (0:00:00.010) 0:00:00.010 ******** 2026-04-18 17:50:02.973442 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-04-18 17:50:02.980053 | controller | ok: [controller] 2026-04-18 17:50:02.980221 | controller | 2026-04-18 17:50:02.980435 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-04-18 17:50:02.980633 | controller | Saturday 18 April 2026 17:50:02 +0000 (0:00:01.109) 0:00:01.120 ******** 2026-04-18 17:50:03.053066 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-04-18 17:50:03.053235 | controller | 2026-04-18 17:50:03.053435 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-04-18 17:50:03.053634 | controller | Saturday 18 April 2026 17:50:03 +0000 (0:00:00.072) 0:00:01.193 ******** 2026-04-18 17:50:03.780019 | controller | changed: [controller] 2026-04-18 17:50:03.780219 | controller | 2026-04-18 17:50:03.780489 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-04-18 17:50:03.780693 | controller | Saturday 18 April 2026 17:50:03 +0000 (0:00:00.726) 0:00:01.919 ******** 2026-04-18 17:50:03.819531 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-04-18 17:50:03.819701 | controller | 2026-04-18 17:50:03.819985 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-04-18 17:50:03.820191 | controller | Saturday 18 April 2026 17:50:03 +0000 (0:00:00.039) 0:00:01.959 ******** 2026-04-18 17:50:04.258170 | controller | ok: [controller] 2026-04-18 17:50:04.258438 | controller | 2026-04-18 17:50:04.258676 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-04-18 17:50:04.258900 | controller | Saturday 18 April 2026 17:50:04 +0000 (0:00:00.438) 0:00:02.397 ******** 2026-04-18 17:50:05.383438 | controller | ok: [controller] 2026-04-18 17:50:05.383493 | controller | 2026-04-18 17:50:05.383597 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-04-18 17:50:05.383687 | controller | Saturday 18 April 2026 17:50:05 +0000 (0:00:01.125) 0:00:03.523 ******** 2026-04-18 17:50:05.808550 | controller | ok: [controller] 2026-04-18 17:50:05.808708 | controller | 2026-04-18 17:50:05.808963 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-04-18 17:50:05.809179 | controller | Saturday 18 April 2026 17:50:05 +0000 (0:00:00.424) 0:00:03.948 ******** 2026-04-18 17:50:06.140424 | controller | changed: [controller] => (item=/file) 2026-04-18 17:50:06.140559 | controller | 2026-04-18 17:50:06.140760 | controller | PLAY RECAP ********************************************************************* 2026-04-18 17:50:06.140979 | controller | controller : ok=8 changed=2 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-18 17:50:06.141198 | controller | 2026-04-18 17:50:06.141335 | controller | 2026-04-18 17:50:06.141537 | controller | TASKS RECAP ******************************************************************** 2026-04-18 17:50:06.141723 | controller | Saturday 18 April 2026 17:50:06 +0000 (0:00:00.332) 0:00:04.280 ******** 2026-04-18 17:50:06.141904 | controller | =============================================================================== 2026-04-18 17:50:06.142116 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.13s 2026-04-18 17:50:06.142296 | controller | Gathering Facts --------------------------------------------------------- 1.11s 2026-04-18 17:50:06.142488 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.73s 2026-04-18 17:50:06.142680 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.44s 2026-04-18 17:50:06.142871 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.42s 2026-04-18 17:50:06.143151 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.33s 2026-04-18 17:50:06.143347 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s 2026-04-18 17:50:06.143542 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s 2026-04-18 17:50:06.220819 | controller | INFO [upload-helm-chart > side_effect] Executed: Successful 2026-04-18 17:50:06.226813 | controller | INFO [upload-helm-chart > verify] Executing 2026-04-18 17:50:07.061596 | controller | 2026-04-18 17:50:07.061688 | controller | PLAY [Verify] ****************************************************************** 2026-04-18 17:50:07.061889 | controller | 2026-04-18 17:50:07.062089 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-18 17:50:07.062284 | controller | Saturday 18 April 2026 17:50:07 +0000 (0:00:00.010) 0:00:00.010 ******** 2026-04-18 17:50:08.123742 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-04-18 17:50:08.127908 | controller | ok: [controller] 2026-04-18 17:50:08.128092 | controller | 2026-04-18 17:50:08.128377 | controller | TASK [Stat file 1] ************************************************************* 2026-04-18 17:50:08.128589 | controller | Saturday 18 April 2026 17:50:08 +0000 (0:00:01.066) 0:00:01.076 ******** 2026-04-18 17:50:08.539716 | controller | ok: [controller] 2026-04-18 17:50:08.539983 | controller | 2026-04-18 17:50:08.540206 | controller | TASK [Stat file 2] ************************************************************* 2026-04-18 17:50:08.540411 | controller | Saturday 18 April 2026 17:50:08 +0000 (0:00:00.411) 0:00:01.487 ******** 2026-04-18 17:50:08.835368 | controller | ok: [controller] 2026-04-18 17:50:08.835514 | controller | 2026-04-18 17:50:08.835715 | controller | TASK [Stat removed file 1] ***************************************************** 2026-04-18 17:50:08.835959 | controller | Saturday 18 April 2026 17:50:08 +0000 (0:00:00.295) 0:00:01.783 ******** 2026-04-18 17:50:09.120205 | controller | ok: [controller] 2026-04-18 17:50:09.120390 | controller | 2026-04-18 17:50:09.120629 | controller | TASK [Stat removed file 2] ***************************************************** 2026-04-18 17:50:09.120871 | controller | Saturday 18 April 2026 17:50:09 +0000 (0:00:00.284) 0:00:02.068 ******** 2026-04-18 17:50:09.409153 | controller | ok: [controller] 2026-04-18 17:50:09.409190 | controller | 2026-04-18 17:50:09.409201 | controller | TASK [ansible.builtin.assert] ************************************************** 2026-04-18 17:50:09.409210 | controller | Saturday 18 April 2026 17:50:09 +0000 (0:00:00.288) 0:00:02.356 ******** 2026-04-18 17:50:09.444257 | controller | ok: [controller] => { 2026-04-18 17:50:09.444414 | controller | "changed": false, 2026-04-18 17:50:09.444537 | controller | "msg": "All assertions passed" 2026-04-18 17:50:09.444651 | controller | } 2026-04-18 17:50:09.444758 | controller | 2026-04-18 17:50:09.444873 | controller | PLAY RECAP ********************************************************************* 2026-04-18 17:50:09.445070 | controller | controller : ok=6 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-18 17:50:09.445217 | controller | 2026-04-18 17:50:09.445342 | controller | 2026-04-18 17:50:09.445455 | controller | TASKS RECAP ******************************************************************** 2026-04-18 17:50:09.445569 | controller | Saturday 18 April 2026 17:50:09 +0000 (0:00:00.035) 0:00:02.392 ******** 2026-04-18 17:50:09.445678 | controller | =============================================================================== 2026-04-18 17:50:09.445791 | controller | Gathering Facts --------------------------------------------------------- 1.07s 2026-04-18 17:50:09.445902 | controller | Stat file 1 ------------------------------------------------------------- 0.41s 2026-04-18 17:50:09.446019 | controller | Stat file 2 ------------------------------------------------------------- 0.30s 2026-04-18 17:50:09.446186 | controller | Stat removed file 2 ----------------------------------------------------- 0.29s 2026-04-18 17:50:09.446317 | controller | Stat removed file 1 ----------------------------------------------------- 0.28s 2026-04-18 17:50:09.446431 | controller | ansible.builtin.assert -------------------------------------------------- 0.04s 2026-04-18 17:50:09.539491 | controller | INFO [upload-helm-chart > verify] Executed: Successful 2026-04-18 17:50:09.549818 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-04-18 17:50:09.550155 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 17:50:09.555491 | controller | INFO [upload-helm-chart > destroy] Executing 2026-04-18 17:50:09.555583 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-04-18 17:50:09.555669 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-04-18 17:50:09.555953 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-04-18 17:50:09.675251 | controller | ok: Runtime: 0:00:37.653327 2026-04-18 17:50:09.678737 | 2026-04-18 17:50:09.678792 | PLAY RECAP 2026-04-18 17:50:09.678841 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 17:50:09.678863 | 2026-04-18 17:50:09.825873 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-18 17:50:10.059736 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-04-18 17:50:10.776835 | 2026-04-18 17:50:10.777034 | PLAY [all] 2026-04-18 17:50:10.797691 | 2026-04-18 17:50:10.797827 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-18 17:50:11.216397 | controller | changed 2026-04-18 17:50:11.344150 | 2026-04-18 17:50:11.344312 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-18 17:50:11.819210 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-18 17:50:11.819369 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-18 17:50:11.827388 | controller | environment: line 1: kubectl: command not found 2026-04-18 17:50:11.829051 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-18 17:50:11.830560 | controller | environment: line 1: kubectl: command not found 2026-04-18 17:50:11.833886 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-18 17:50:11.833903 | controller | environment: line 1: kubectl: command not found 2026-04-18 17:50:11.836276 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-18 17:50:11.837816 | controller | environment: line 1: kubectl: command not found 2026-04-18 17:50:11.839534 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-18 17:50:11.839551 | controller | environment: line 1: kubectl: command not found 2026-04-18 17:50:11.840688 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-18 17:50:11.892820 | controller | ok: Runtime: 0:00:00.051718 2026-04-18 17:50:11.899752 | 2026-04-18 17:50:11.901454 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-18 17:50:12.148082 | controller | changed 2026-04-18 17:50:12.206123 | 2026-04-18 17:50:12.206247 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-18 17:50:12.432555 | controller | environment: line 5: kubectl: command not found 2026-04-18 17:50:12.433494 | controller | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-18 17:50:12.433515 | controller | 2026-04-18 17:50:12.434132 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-18 17:50:12.734817 | controller | ok: Runtime: 0:00:00.011217 2026-04-18 17:50:12.742046 | 2026-04-18 17:50:12.742119 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-18 17:50:13.531608 | controller | changed: 2026-04-18 17:50:13.531758 | controller | created directory /var/lib/zuul/builds/0d0e78f490574c428c53fd330d1fbb8f/work/logs/controller 2026-04-18 17:50:13.531790 | controller | cd+++++++++ objects/ 2026-04-18 17:50:13.531814 | controller | cd+++++++++ objects/cluster/ 2026-04-18 17:50:13.531838 | controller | cd+++++++++ objects/namespaced/ 2026-04-18 17:50:13.539219 | 2026-04-18 17:50:13.539310 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-18 17:50:13.774284 | controller | changed 2026-04-18 17:50:13.778759 | 2026-04-18 17:50:13.778832 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-18 17:50:14.011962 | controller | changed 2026-04-18 17:50:14.018255 | 2026-04-18 17:50:14.018819 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-18 17:50:14.271069 | controller | environment: line 3: kubectl: command not found 2026-04-18 17:50:14.553629 | controller | ok: Runtime: 0:00:00.013262 2026-04-18 17:50:14.560494 | 2026-04-18 17:50:14.560575 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-18 17:50:15.460188 | controller | changed: 2026-04-18 17:50:15.460344 | controller | cd+++++++++ pod-logs/ 2026-04-18 17:50:15.460373 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-04-18 17:50:15.468028 | 2026-04-18 17:50:15.468134 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-18 17:50:15.703686 | controller | changed: "values" 2026-04-18 17:50:15.905384 | controller | changed: "releases" 2026-04-18 17:50:15.922533 | 2026-04-18 17:50:15.922683 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-18 17:50:16.171301 | controller | /bin/bash: line 3: kubectl: command not found 2026-04-18 17:50:16.578509 | controller | ok: Runtime: 0:00:00.008714 2026-04-18 17:50:16.584718 | 2026-04-18 17:50:16.584812 | TASK [helm-release-status : Downloads logs to executor] 2026-04-18 17:50:17.128927 | controller | changed: 2026-04-18 17:50:17.129212 | controller | cd+++++++++ helm/ 2026-04-18 17:50:17.129260 | controller | cd+++++++++ helm/releases/ 2026-04-18 17:50:17.129295 | controller | cd+++++++++ helm/values/ 2026-04-18 17:50:17.145426 | 2026-04-18 17:50:17.146205 | PLAY RECAP 2026-04-18 17:50:17.146485 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 17:50:17.146531 | 2026-04-18 17:50:17.292759 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-04-18 17:50:17.294346 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 17:50:17.951974 | 2026-04-18 17:50:17.952109 | PLAY [all] 2026-04-18 17:50:17.962993 | 2026-04-18 17:50:17.963101 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-18 17:50:18.019940 | controller | skipping: Conditional result was False 2026-04-18 17:50:18.029592 | 2026-04-18 17:50:18.029756 | TASK [fetch-output : Set log path for single node] 2026-04-18 17:50:18.073323 | controller | ok 2026-04-18 17:50:18.079357 | 2026-04-18 17:50:18.079466 | LOOP [fetch-output : Ensure local output dirs] 2026-04-18 17:50:18.585574 | controller -> localhost | ok: "/var/lib/zuul/builds/0d0e78f490574c428c53fd330d1fbb8f/work/logs" 2026-04-18 17:50:18.825689 | controller -> localhost | changed: "/var/lib/zuul/builds/0d0e78f490574c428c53fd330d1fbb8f/work/artifacts" 2026-04-18 17:50:19.091664 | controller -> localhost | changed: "/var/lib/zuul/builds/0d0e78f490574c428c53fd330d1fbb8f/work/docs" 2026-04-18 17:50:19.109078 | 2026-04-18 17:50:19.109283 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-18 17:50:19.793129 | controller | changed: .d..t...... ./ 2026-04-18 17:50:19.793393 | controller | changed: All items complete 2026-04-18 17:50:19.793434 | 2026-04-18 17:50:20.318734 | controller | changed: .d..t...... ./ 2026-04-18 17:50:20.858357 | controller | changed: .d..t...... ./ 2026-04-18 17:50:20.883394 | 2026-04-18 17:50:20.883555 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-18 17:50:21.589843 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.009767 2026-04-18 17:50:21.841532 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006758 2026-04-18 17:50:21.857528 | 2026-04-18 17:50:21.857754 | PLAY [all] 2026-04-18 17:50:21.865954 | 2026-04-18 17:50:21.866072 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-18 17:50:22.348281 | controller | changed 2026-04-18 17:50:22.354750 | 2026-04-18 17:50:22.354859 | PLAY RECAP 2026-04-18 17:50:22.354917 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-18 17:50:22.354945 | 2026-04-18 17:50:22.494977 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 17:50:22.497490 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-18 17:50:23.088257 | 2026-04-18 17:50:23.088683 | PLAY [localhost] 2026-04-18 17:50:23.098471 | 2026-04-18 17:50:23.098553 | TASK [Generate Zuul manifest] 2026-04-18 17:50:23.119204 | localhost | ok 2026-04-18 17:50:23.136280 | 2026-04-18 17:50:23.136385 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-18 17:50:23.481513 | localhost | changed 2026-04-18 17:50:23.492614 | 2026-04-18 17:50:23.492711 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-18 17:50:23.523605 | localhost | ok 2026-04-18 17:50:23.530392 | 2026-04-18 17:50:23.530464 | TASK [Upload logs] 2026-04-18 17:50:23.551681 | localhost | ok 2026-04-18 17:50:23.609920 | 2026-04-18 17:50:23.610046 | TASK [Set zuul-log-path fact] 2026-04-18 17:50:23.628701 | localhost | ok 2026-04-18 17:50:23.642338 | 2026-04-18 17:50:23.642470 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 17:50:23.673824 | localhost | ok 2026-04-18 17:50:23.683702 | 2026-04-18 17:50:23.683903 | TASK [upload-logs : Create log directories] 2026-04-18 17:50:24.102028 | localhost | changed 2026-04-18 17:50:24.109698 | 2026-04-18 17:50:24.109794 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-18 17:50:24.618201 | localhost -> localhost | ok: Runtime: 0:00:00.005348 2026-04-18 17:50:24.624576 | 2026-04-18 17:50:24.624642 | TASK [upload-logs : Upload logs to log server] 2026-04-18 17:50:25.142543 | localhost | Output suppressed because no_log was given 2026-04-18 17:50:25.147845 | 2026-04-18 17:50:25.147943 | LOOP [upload-logs : Compress console log and json output] 2026-04-18 17:50:25.196759 | localhost | skipping: Conditional result was False 2026-04-18 17:50:25.204806 | localhost | skipping: Conditional result was False 2026-04-18 17:50:25.221179 | 2026-04-18 17:50:25.221353 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-18 17:50:25.261481 | localhost | skipping: Conditional result was False 2026-04-18 17:50:25.261837 | 2026-04-18 17:50:25.265763 | localhost | skipping: Conditional result was False 2026-04-18 17:50:25.273573 | 2026-04-18 17:50:25.273770 | LOOP [upload-logs : Upload console log and json output]