2026-04-22 13:31:54.479439 | Job console starting 2026-04-22 13:31:54.488555 | Updating git repos 2026-04-22 13:31:54.549413 | Cloning repos into workspace 2026-04-22 13:31:54.607868 | Restoring repo states 2026-04-22 13:31:54.623103 | Merging changes 2026-04-22 13:31:55.283862 | Checking out repos 2026-04-22 13:31:55.326640 | Preparing playbooks 2026-04-22 13:31:57.941535 | Running Ansible setup 2026-04-22 13:32:02.835138 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-22 13:32:03.542596 | 2026-04-22 13:32:03.543071 | PLAY [localhost] 2026-04-22 13:32:03.552846 | 2026-04-22 13:32:03.552974 | TASK [Gathering Facts] 2026-04-22 13:32:04.517426 | localhost | ok 2026-04-22 13:32:04.527694 | 2026-04-22 13:32:04.527863 | TASK [Setup log path fact] 2026-04-22 13:32:04.548547 | localhost | ok 2026-04-22 13:32:04.564814 | 2026-04-22 13:32:04.564996 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-22 13:32:04.595399 | localhost | ok 2026-04-22 13:32:04.604911 | 2026-04-22 13:32:04.605196 | TASK [emit-job-header : Print job information] 2026-04-22 13:32:04.647130 | # Job Information 2026-04-22 13:32:04.647366 | Ansible Version: 2.16.16 2026-04-22 13:32:04.647442 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart 2026-04-22 13:32:04.647488 | Pipeline: check 2026-04-22 13:32:04.647528 | Executor: 0a8996d2b663 2026-04-22 13:32:04.647559 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/269 2026-04-22 13:32:04.647592 | Event ID: 7dd5fb30-3e4f-11f1-8659-51f495686c8b 2026-04-22 13:32:04.651980 | 2026-04-22 13:32:04.652088 | LOOP [emit-job-header : Print node information] 2026-04-22 13:32:04.737156 | localhost | ok: 2026-04-22 13:32:04.737336 | localhost | # Node Information 2026-04-22 13:32:04.737366 | localhost | Inventory Hostname: controller 2026-04-22 13:32:04.737388 | localhost | Hostname: np0000169447 2026-04-22 13:32:04.737408 | localhost | Username: zuul 2026-04-22 13:32:04.737431 | localhost | Distro: Debian 13.4 2026-04-22 13:32:04.737451 | localhost | Provider: yul1 2026-04-22 13:32:04.737470 | localhost | Region: ca-ymq-1 2026-04-22 13:32:04.737489 | localhost | Label: debian-trixie 2026-04-22 13:32:04.737507 | localhost | Product Name: OpenStack Nova 2026-04-22 13:32:04.737525 | localhost | Interface IP: 199.204.45.74 2026-04-22 13:32:04.747788 | 2026-04-22 13:32:04.747966 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-22 13:32:05.198975 | localhost -> localhost | changed 2026-04-22 13:32:05.207027 | 2026-04-22 13:32:05.207290 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-22 13:32:06.166982 | localhost -> localhost | changed 2026-04-22 13:32:06.175999 | 2026-04-22 13:32:06.176139 | PLAY [all] 2026-04-22 13:32:06.186545 | 2026-04-22 13:32:06.186728 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-22 13:32:06.459192 | controller -> localhost | ok 2026-04-22 13:32:06.468798 | 2026-04-22 13:32:06.468945 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-22 13:32:06.502909 | controller | ok 2026-04-22 13:32:06.518792 | controller | included: /var/lib/zuul/builds/9d4acf20e52942369040c04ffe949703/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-22 13:32:06.524053 | 2026-04-22 13:32:06.524143 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-22 13:32:07.952553 | controller -> localhost | Generating public/private rsa key pair. 2026-04-22 13:32:07.952736 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/9d4acf20e52942369040c04ffe949703/work/9d4acf20e52942369040c04ffe949703_id_rsa 2026-04-22 13:32:07.952767 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/9d4acf20e52942369040c04ffe949703/work/9d4acf20e52942369040c04ffe949703_id_rsa.pub 2026-04-22 13:32:07.952791 | controller -> localhost | The key fingerprint is: 2026-04-22 13:32:07.952813 | controller -> localhost | SHA256:yxncGAhvK5T7nFvAoAA0f/IJsGeyEfW6kdTrJp2XIIA zuul-build-sshkey 2026-04-22 13:32:07.952847 | controller -> localhost | The key's randomart image is: 2026-04-22 13:32:07.952869 | controller -> localhost | +---[RSA 3072]----+ 2026-04-22 13:32:07.952896 | controller -> localhost | |o=... | 2026-04-22 13:32:07.952918 | controller -> localhost | |o * o+ . | 2026-04-22 13:32:07.952938 | controller -> localhost | |E= B+++ . | 2026-04-22 13:32:07.952979 | controller -> localhost | | .OoB=oo + | 2026-04-22 13:32:07.953001 | controller -> localhost | | ..=o=+ S . | 2026-04-22 13:32:07.953022 | controller -> localhost | | *+o+.+ | 2026-04-22 13:32:07.953041 | controller -> localhost | | o =+o= | 2026-04-22 13:32:07.953061 | controller -> localhost | | o .o | 2026-04-22 13:32:07.953084 | controller -> localhost | | . | 2026-04-22 13:32:07.953105 | controller -> localhost | +----[SHA256]-----+ 2026-04-22 13:32:07.953157 | controller -> localhost | ok: Runtime: 0:00:00.952062 2026-04-22 13:32:07.957363 | 2026-04-22 13:32:07.957441 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-22 13:32:07.987814 | controller | ok 2026-04-22 13:32:07.997913 | controller | included: /var/lib/zuul/builds/9d4acf20e52942369040c04ffe949703/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-22 13:32:08.007572 | 2026-04-22 13:32:08.007672 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-22 13:32:08.032769 | controller | skipping: Conditional result was False 2026-04-22 13:32:08.041484 | 2026-04-22 13:32:08.041621 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-22 13:32:08.607974 | controller | changed 2026-04-22 13:32:08.612082 | 2026-04-22 13:32:08.612167 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-22 13:32:08.836547 | controller | ok 2026-04-22 13:32:08.844730 | 2026-04-22 13:32:08.844836 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-22 13:32:09.577985 | controller | changed 2026-04-22 13:32:09.583690 | 2026-04-22 13:32:09.583859 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-22 13:32:10.129835 | controller | changed 2026-04-22 13:32:10.135018 | 2026-04-22 13:32:10.135104 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-22 13:32:10.159541 | controller | skipping: Conditional result was False 2026-04-22 13:32:10.168315 | 2026-04-22 13:32:10.168427 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-22 13:32:10.622005 | controller -> localhost | changed 2026-04-22 13:32:10.633970 | 2026-04-22 13:32:10.634122 | TASK [add-build-sshkey : Add back temp key] 2026-04-22 13:32:10.930778 | controller -> localhost | Identity added: /var/lib/zuul/builds/9d4acf20e52942369040c04ffe949703/work/9d4acf20e52942369040c04ffe949703_id_rsa (zuul-build-sshkey) 2026-04-22 13:32:10.931016 | controller -> localhost | ok: Runtime: 0:00:00.010276 2026-04-22 13:32:10.938106 | 2026-04-22 13:32:10.938271 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-22 13:32:11.318911 | controller | ok 2026-04-22 13:32:11.322903 | 2026-04-22 13:32:11.322988 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-22 13:32:11.356328 | controller | skipping: Conditional result was False 2026-04-22 13:32:11.372267 | 2026-04-22 13:32:11.372392 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-22 13:32:11.820605 | controller | ok 2026-04-22 13:32:11.827478 | 2026-04-22 13:32:11.827645 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-22 13:32:13.171139 | controller | Output suppressed because no_log was given 2026-04-22 13:32:13.180643 | 2026-04-22 13:32:13.180758 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-22 13:32:13.392206 | controller | ok: "logs" 2026-04-22 13:32:13.392528 | controller | ok: All items complete 2026-04-22 13:32:13.392585 | 2026-04-22 13:32:13.582076 | controller | ok: "artifacts" 2026-04-22 13:32:13.758936 | controller | ok: "docs" 2026-04-22 13:32:13.776929 | 2026-04-22 13:32:13.777148 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-22 13:32:13.994004 | controller | changed: "logs" 2026-04-22 13:32:14.179432 | controller | changed: "artifacts" 2026-04-22 13:32:14.364743 | controller | changed: "docs" 2026-04-22 13:32:14.375147 | 2026-04-22 13:32:14.375263 | PLAY RECAP 2026-04-22 13:32:14.375312 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-22 13:32:14.375343 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-22 13:32:14.375366 | 2026-04-22 13:32:14.503858 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-22 13:32:14.505424 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-22 13:32:15.127116 | 2026-04-22 13:32:15.127264 | PLAY [all] 2026-04-22 13:32:15.138492 | 2026-04-22 13:32:15.138618 | TASK [setup-uv : Extract archive] 2026-04-22 13:32:17.904170 | controller | changed 2026-04-22 13:32:17.910597 | 2026-04-22 13:32:17.910724 | TASK [setup-uv : Print version] 2026-04-22 13:32:18.221936 | controller | uv 0.8.13 2026-04-22 13:32:18.430732 | controller | ok: Runtime: 0:00:00.012638 2026-04-22 13:32:18.438190 | 2026-04-22 13:32:18.438280 | PLAY RECAP 2026-04-22 13:32:18.438332 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-22 13:32:18.438356 | 2026-04-22 13:32:18.598978 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-22 13:32:18.601858 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-04-22 13:32:19.281943 | 2026-04-22 13:32:19.282131 | PLAY [all] 2026-04-22 13:32:19.293456 | 2026-04-22 13:32:19.293623 | TASK [Update apt cache] 2026-04-22 13:32:25.147704 | controller | ok 2026-04-22 13:32:25.155994 | 2026-04-22 13:32:25.156172 | TASK [Disable firewalld] 2026-04-22 13:32:25.181050 | controller | skipping: Conditional result was False 2026-04-22 13:32:25.189288 | 2026-04-22 13:32:25.189495 | TASK [Install "jq" for log collection] 2026-04-22 13:32:27.398194 | controller | changed 2026-04-22 13:32:27.401003 | 2026-04-22 13:32:27.401081 | PLAY RECAP 2026-04-22 13:32:27.401154 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-22 13:32:27.401188 | 2026-04-22 13:32:27.558884 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-04-22 13:32:27.560660 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-22 13:32:28.253712 | 2026-04-22 13:32:28.253900 | PLAY [all] 2026-04-22 13:32:28.264889 | 2026-04-22 13:32:28.265035 | TASK [Copy inventory file for Zuul] 2026-04-22 13:32:29.293004 | controller | changed 2026-04-22 13:32:29.300460 | 2026-04-22 13:32:29.300686 | TASK [Switch "ansible_host" to private IP] 2026-04-22 13:32:29.646418 | controller | changed: 1 replacements made 2026-04-22 13:32:29.652943 | 2026-04-22 13:32:29.653068 | TASK [Run Molecule scenario] 2026-04-22 13:32:30.080623 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-04-22 13:32:30.080791 | controller | Creating virtual environment at: .venv 2026-04-22 13:32:30.365380 | controller | Downloading pygments (1.2MiB) 2026-04-22 13:32:30.373731 | controller | Downloading ansible-core (2.3MiB) 2026-04-22 13:32:30.374492 | controller | Downloading cryptography (4.3MiB) 2026-04-22 13:32:30.524688 | controller | Downloading cryptography 2026-04-22 13:32:30.576931 | controller | Downloading pygments 2026-04-22 13:32:30.770488 | controller | Downloading ansible-core 2026-04-22 13:32:30.819765 | controller | Installed 36 packages in 48ms 2026-04-22 13:32:31.575486 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-04-22 13:32:31.575516 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-04-22 13:32:32.532202 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-22 13:32:32.532310 | controller | INFO default scenario not found, disabling shared state. 2026-04-22 13:32:32.532532 | controller | INFO [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-22 13:32:32.532666 | controller | INFO [upload-helm-chart > prerun] Performing prerun with role_name_check=0... 2026-04-22 13:32:50.022523 | controller | INFO [upload-helm-chart > dependency] Executing 2026-04-22 13:32:50.023046 | controller | WARNING [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml 2026-04-22 13:32:50.023400 | controller | WARNING [upload-helm-chart > dependency] Missing collections requirements file: collections.yml 2026-04-22 13:32:50.023659 | controller | WARNING [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-22 13:32:50.030276 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-04-22 13:32:50.030643 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-22 13:32:50.036277 | controller | INFO [upload-helm-chart > destroy] Executing 2026-04-22 13:32:50.036377 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-04-22 13:32:50.036467 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-04-22 13:32:50.041959 | controller | INFO [upload-helm-chart > syntax] Executing 2026-04-22 13:32:51.062008 | controller | 2026-04-22 13:32:51.062496 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml 2026-04-22 13:32:51.129521 | controller | INFO [upload-helm-chart > syntax] Executed: Successful 2026-04-22 13:32:51.844603 | controller | INFO [upload-helm-chart > create] Executing 2026-04-22 13:32:52.135717 | controller | WARNING [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-22 13:32:52.147791 | controller | INFO [upload-helm-chart > prepare] Executing 2026-04-22 13:32:52.148060 | controller | WARNING [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-22 13:32:52.229606 | controller | INFO [upload-helm-chart > converge] Executing 2026-04-22 13:32:53.197206 | controller | 2026-04-22 13:32:53.197283 | controller | PLAY [Converge] **************************************************************** 2026-04-22 13:32:53.197476 | controller | 2026-04-22 13:32:53.197605 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-22 13:32:53.197731 | controller | Wednesday 22 April 2026 13:32:53 +0000 (0:00:00.033) 0:00:00.033 ******* 2026-04-22 13:32:54.505744 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-04-22 13:32:54.514743 | controller | ok: [controller] 2026-04-22 13:32:54.514926 | controller | 2026-04-22 13:32:54.515147 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-04-22 13:32:54.515363 | controller | Wednesday 22 April 2026 13:32:54 +0000 (0:00:01.317) 0:00:01.351 ******* 2026-04-22 13:32:54.601247 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-04-22 13:32:54.601433 | controller | 2026-04-22 13:32:54.601626 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-04-22 13:32:54.601829 | controller | Wednesday 22 April 2026 13:32:54 +0000 (0:00:00.086) 0:00:01.437 ******* 2026-04-22 13:32:55.355129 | controller | changed: [controller] 2026-04-22 13:32:55.355177 | controller | 2026-04-22 13:32:55.355185 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-04-22 13:32:55.355190 | controller | Wednesday 22 April 2026 13:32:55 +0000 (0:00:00.753) 0:00:02.191 ******* 2026-04-22 13:32:55.403355 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-04-22 13:32:55.403403 | controller | 2026-04-22 13:32:55.403409 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-04-22 13:32:55.403414 | controller | Wednesday 22 April 2026 13:32:55 +0000 (0:00:00.048) 0:00:02.240 ******* 2026-04-22 13:32:55.829639 | controller | changed: [controller] 2026-04-22 13:32:55.829938 | controller | 2026-04-22 13:32:55.830237 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-04-22 13:32:55.830507 | controller | Wednesday 22 April 2026 13:32:55 +0000 (0:00:00.426) 0:00:02.666 ******* 2026-04-22 13:32:57.025779 | controller | changed: [controller] 2026-04-22 13:32:57.026232 | controller | 2026-04-22 13:32:57.026607 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-04-22 13:32:57.026950 | controller | Wednesday 22 April 2026 13:32:57 +0000 (0:00:01.196) 0:00:03.862 ******* 2026-04-22 13:32:57.466984 | controller | ok: [controller] 2026-04-22 13:32:57.467299 | controller | 2026-04-22 13:32:57.467594 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-04-22 13:32:57.467858 | controller | Wednesday 22 April 2026 13:32:57 +0000 (0:00:00.440) 0:00:04.303 ******* 2026-04-22 13:32:57.523776 | controller | skipping: [controller] 2026-04-22 13:32:57.524088 | controller | 2026-04-22 13:32:57.524378 | controller | PLAY RECAP ********************************************************************* 2026-04-22 13:32:57.524668 | controller | controller : ok=7 changed=3 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-04-22 13:32:57.524948 | controller | 2026-04-22 13:32:57.525299 | controller | 2026-04-22 13:32:57.525605 | controller | TASKS RECAP ******************************************************************** 2026-04-22 13:32:57.525888 | controller | Wednesday 22 April 2026 13:32:57 +0000 (0:00:00.057) 0:00:04.361 ******* 2026-04-22 13:32:57.526156 | controller | =============================================================================== 2026-04-22 13:32:57.526409 | controller | Gathering Facts --------------------------------------------------------- 1.32s 2026-04-22 13:32:57.526668 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.20s 2026-04-22 13:32:57.526916 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.75s 2026-04-22 13:32:57.527252 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.44s 2026-04-22 13:32:57.527518 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.43s 2026-04-22 13:32:57.527831 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.09s 2026-04-22 13:32:57.528132 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.06s 2026-04-22 13:32:57.528471 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s 2026-04-22 13:32:57.637465 | controller | INFO [upload-helm-chart > converge] Executed: Successful 2026-04-22 13:32:57.645734 | controller | INFO [upload-helm-chart > idempotence] Executing 2026-04-22 13:32:58.533720 | controller | 2026-04-22 13:32:58.533928 | controller | PLAY [Converge] **************************************************************** 2026-04-22 13:32:58.534109 | controller | 2026-04-22 13:32:58.534595 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-22 13:32:58.534715 | controller | Wednesday 22 April 2026 13:32:58 +0000 (0:00:00.010) 0:00:00.010 ******* 2026-04-22 13:32:59.685203 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-04-22 13:32:59.697504 | controller | ok: [controller] 2026-04-22 13:32:59.697547 | controller | 2026-04-22 13:32:59.697554 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-04-22 13:32:59.697559 | controller | Wednesday 22 April 2026 13:32:59 +0000 (0:00:01.161) 0:00:01.171 ******* 2026-04-22 13:32:59.773864 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-04-22 13:32:59.774019 | controller | 2026-04-22 13:32:59.774244 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-04-22 13:32:59.774461 | controller | Wednesday 22 April 2026 13:32:59 +0000 (0:00:00.078) 0:00:01.250 ******* 2026-04-22 13:33:00.554808 | controller | ok: [controller] 2026-04-22 13:33:00.554863 | controller | 2026-04-22 13:33:00.555191 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-04-22 13:33:00.555415 | controller | Wednesday 22 April 2026 13:33:00 +0000 (0:00:00.780) 0:00:02.030 ******* 2026-04-22 13:33:00.603082 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-04-22 13:33:00.603212 | controller | 2026-04-22 13:33:00.603415 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-04-22 13:33:00.603610 | controller | Wednesday 22 April 2026 13:33:00 +0000 (0:00:00.049) 0:00:02.079 ******* 2026-04-22 13:33:01.054707 | controller | ok: [controller] 2026-04-22 13:33:01.054823 | controller | 2026-04-22 13:33:01.055078 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-04-22 13:33:01.055283 | controller | Wednesday 22 April 2026 13:33:01 +0000 (0:00:00.450) 0:00:02.530 ******* 2026-04-22 13:33:02.216204 | controller | ok: [controller] 2026-04-22 13:33:02.216245 | controller | 2026-04-22 13:33:02.216252 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-04-22 13:33:02.216257 | controller | Wednesday 22 April 2026 13:33:02 +0000 (0:00:01.161) 0:00:03.692 ******* 2026-04-22 13:33:02.638199 | controller | ok: [controller] 2026-04-22 13:33:02.638389 | controller | 2026-04-22 13:33:02.638580 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-04-22 13:33:02.638735 | controller | Wednesday 22 April 2026 13:33:02 +0000 (0:00:00.421) 0:00:04.113 ******* 2026-04-22 13:33:02.682035 | controller | skipping: [controller] 2026-04-22 13:33:02.682331 | controller | 2026-04-22 13:33:02.682594 | controller | PLAY RECAP ********************************************************************* 2026-04-22 13:33:02.682868 | controller | controller : ok=7 changed=0 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-04-22 13:33:02.683105 | controller | 2026-04-22 13:33:02.683331 | controller | 2026-04-22 13:33:02.683575 | controller | TASKS RECAP ******************************************************************** 2026-04-22 13:33:02.683824 | controller | Wednesday 22 April 2026 13:33:02 +0000 (0:00:00.044) 0:00:04.158 ******* 2026-04-22 13:33:02.684057 | controller | =============================================================================== 2026-04-22 13:33:02.684314 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.16s 2026-04-22 13:33:02.684592 | controller | Gathering Facts --------------------------------------------------------- 1.16s 2026-04-22 13:33:02.684839 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.78s 2026-04-22 13:33:02.685084 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.45s 2026-04-22 13:33:02.685337 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.42s 2026-04-22 13:33:02.685739 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s 2026-04-22 13:33:02.686014 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s 2026-04-22 13:33:02.686380 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.04s 2026-04-22 13:33:02.788932 | controller | INFO [upload-helm-chart > idempotence] Executed: Successful 2026-04-22 13:33:02.800330 | controller | INFO [upload-helm-chart > side_effect] Executing 2026-04-22 13:33:03.675734 | controller | 2026-04-22 13:33:03.675825 | controller | PLAY [Side effect] ************************************************************* 2026-04-22 13:33:03.675835 | controller | 2026-04-22 13:33:03.675843 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-22 13:33:03.675851 | controller | Wednesday 22 April 2026 13:33:03 +0000 (0:00:00.012) 0:00:00.012 ******* 2026-04-22 13:33:04.769556 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-04-22 13:33:04.777692 | controller | ok: [controller] 2026-04-22 13:33:04.777979 | controller | 2026-04-22 13:33:04.778288 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-04-22 13:33:04.778575 | controller | Wednesday 22 April 2026 13:33:04 +0000 (0:00:01.102) 0:00:01.115 ******* 2026-04-22 13:33:04.861160 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-04-22 13:33:04.861526 | controller | 2026-04-22 13:33:04.861820 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-04-22 13:33:04.862086 | controller | Wednesday 22 April 2026 13:33:04 +0000 (0:00:00.083) 0:00:01.198 ******* 2026-04-22 13:33:05.654229 | controller | changed: [controller] 2026-04-22 13:33:05.654268 | controller | 2026-04-22 13:33:05.654273 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-04-22 13:33:05.654277 | controller | Wednesday 22 April 2026 13:33:05 +0000 (0:00:00.790) 0:00:01.988 ******* 2026-04-22 13:33:05.697698 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-04-22 13:33:05.697733 | controller | 2026-04-22 13:33:05.697738 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-04-22 13:33:05.697742 | controller | Wednesday 22 April 2026 13:33:05 +0000 (0:00:00.046) 0:00:02.035 ******* 2026-04-22 13:33:06.114815 | controller | ok: [controller] 2026-04-22 13:33:06.115018 | controller | 2026-04-22 13:33:06.115183 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-04-22 13:33:06.115342 | controller | Wednesday 22 April 2026 13:33:06 +0000 (0:00:00.417) 0:00:02.452 ******* 2026-04-22 13:33:07.323795 | controller | ok: [controller] 2026-04-22 13:33:07.324013 | controller | 2026-04-22 13:33:07.324198 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-04-22 13:33:07.324371 | controller | Wednesday 22 April 2026 13:33:07 +0000 (0:00:01.208) 0:00:03.661 ******* 2026-04-22 13:33:07.745632 | controller | ok: [controller] 2026-04-22 13:33:07.745715 | controller | 2026-04-22 13:33:07.745725 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-04-22 13:33:07.745843 | controller | Wednesday 22 April 2026 13:33:07 +0000 (0:00:00.422) 0:00:04.083 ******* 2026-04-22 13:33:08.093902 | controller | changed: [controller] => (item=/file) 2026-04-22 13:33:08.093987 | controller | 2026-04-22 13:33:08.093999 | controller | PLAY RECAP ********************************************************************* 2026-04-22 13:33:08.094093 | controller | controller : ok=8 changed=2 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-22 13:33:08.094177 | controller | 2026-04-22 13:33:08.094256 | controller | 2026-04-22 13:33:08.094345 | controller | TASKS RECAP ******************************************************************** 2026-04-22 13:33:08.095308 | controller | Wednesday 22 April 2026 13:33:08 +0000 (0:00:00.345) 0:00:04.428 ******* 2026-04-22 13:33:08.095342 | controller | =============================================================================== 2026-04-22 13:33:08.095346 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.21s 2026-04-22 13:33:08.095350 | controller | Gathering Facts --------------------------------------------------------- 1.10s 2026-04-22 13:33:08.095354 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.79s 2026-04-22 13:33:08.095357 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.42s 2026-04-22 13:33:08.095360 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.42s 2026-04-22 13:33:08.095365 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.35s 2026-04-22 13:33:08.095368 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s 2026-04-22 13:33:08.095372 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s 2026-04-22 13:33:08.217478 | controller | INFO [upload-helm-chart > side_effect] Executed: Successful 2026-04-22 13:33:08.227005 | controller | INFO [upload-helm-chart > verify] Executing 2026-04-22 13:33:09.079504 | controller | 2026-04-22 13:33:09.079851 | controller | PLAY [Verify] ****************************************************************** 2026-04-22 13:33:09.080043 | controller | 2026-04-22 13:33:09.080214 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-22 13:33:09.080425 | controller | Wednesday 22 April 2026 13:33:09 +0000 (0:00:00.009) 0:00:00.009 ******* 2026-04-22 13:33:10.170133 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-04-22 13:33:10.175083 | controller | ok: [controller] 2026-04-22 13:33:10.175358 | controller | 2026-04-22 13:33:10.175635 | controller | TASK [Stat file 1] ************************************************************* 2026-04-22 13:33:10.175911 | controller | Wednesday 22 April 2026 13:33:10 +0000 (0:00:01.095) 0:00:01.105 ******* 2026-04-22 13:33:10.586249 | controller | ok: [controller] 2026-04-22 13:33:10.586301 | controller | 2026-04-22 13:33:10.586310 | controller | TASK [Stat file 2] ************************************************************* 2026-04-22 13:33:10.586318 | controller | Wednesday 22 April 2026 13:33:10 +0000 (0:00:00.409) 0:00:01.515 ******* 2026-04-22 13:33:10.894824 | controller | ok: [controller] 2026-04-22 13:33:10.895119 | controller | 2026-04-22 13:33:10.895439 | controller | TASK [Stat removed file 1] ***************************************************** 2026-04-22 13:33:10.895719 | controller | Wednesday 22 April 2026 13:33:10 +0000 (0:00:00.310) 0:00:01.825 ******* 2026-04-22 13:33:11.201596 | controller | ok: [controller] 2026-04-22 13:33:11.202898 | controller | 2026-04-22 13:33:11.202918 | controller | TASK [Stat removed file 2] ***************************************************** 2026-04-22 13:33:11.202952 | controller | Wednesday 22 April 2026 13:33:11 +0000 (0:00:00.306) 0:00:02.131 ******* 2026-04-22 13:33:11.521417 | controller | ok: [controller] 2026-04-22 13:33:11.522085 | controller | 2026-04-22 13:33:11.522407 | controller | TASK [ansible.builtin.assert] ************************************************** 2026-04-22 13:33:11.522668 | controller | Wednesday 22 April 2026 13:33:11 +0000 (0:00:00.316) 0:00:02.448 ******* 2026-04-22 13:33:11.553993 | controller | ok: [controller] => { 2026-04-22 13:33:11.554197 | controller | "changed": false, 2026-04-22 13:33:11.554361 | controller | "msg": "All assertions passed" 2026-04-22 13:33:11.554518 | controller | } 2026-04-22 13:33:11.554665 | controller | 2026-04-22 13:33:11.554823 | controller | PLAY RECAP ********************************************************************* 2026-04-22 13:33:11.554996 | controller | controller : ok=6 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-22 13:33:11.555143 | controller | 2026-04-22 13:33:11.555298 | controller | 2026-04-22 13:33:11.555450 | controller | TASKS RECAP ******************************************************************** 2026-04-22 13:33:11.555607 | controller | Wednesday 22 April 2026 13:33:11 +0000 (0:00:00.034) 0:00:02.482 ******* 2026-04-22 13:33:11.555754 | controller | =============================================================================== 2026-04-22 13:33:11.555905 | controller | Gathering Facts --------------------------------------------------------- 1.10s 2026-04-22 13:33:11.556055 | controller | Stat file 1 ------------------------------------------------------------- 0.41s 2026-04-22 13:33:11.556206 | controller | Stat removed file 2 ----------------------------------------------------- 0.32s 2026-04-22 13:33:11.556361 | controller | Stat file 2 ------------------------------------------------------------- 0.31s 2026-04-22 13:33:11.556516 | controller | Stat removed file 1 ----------------------------------------------------- 0.31s 2026-04-22 13:33:11.556669 | controller | ansible.builtin.assert -------------------------------------------------- 0.03s 2026-04-22 13:33:11.699854 | controller | INFO [upload-helm-chart > verify] Executed: Successful 2026-04-22 13:33:11.711652 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-04-22 13:33:11.712029 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-22 13:33:11.717521 | controller | INFO [upload-helm-chart > destroy] Executing 2026-04-22 13:33:11.717621 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-04-22 13:33:11.717709 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-04-22 13:33:11.718075 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-04-22 13:33:12.225503 | controller | ok: Runtime: 0:00:41.827642 2026-04-22 13:33:12.230033 | 2026-04-22 13:33:12.230101 | PLAY RECAP 2026-04-22 13:33:12.230168 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-22 13:33:12.230200 | 2026-04-22 13:33:12.385678 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-22 13:33:12.388881 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-04-22 13:33:13.098685 | 2026-04-22 13:33:13.098819 | PLAY [all] 2026-04-22 13:33:13.110419 | 2026-04-22 13:33:13.110521 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-22 13:33:13.549731 | controller | changed 2026-04-22 13:33:13.715434 | 2026-04-22 13:33:13.715631 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-22 13:33:14.125825 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-22 13:33:14.126360 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-22 13:33:14.135256 | controller | environment: line 1: kubectl: command not found 2026-04-22 13:33:14.137130 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-22 13:33:14.139038 | controller | environment: line 1: kubectl: command not found 2026-04-22 13:33:14.140257 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-22 13:33:14.141510 | controller | environment: line 1: kubectl: command not found 2026-04-22 13:33:14.143027 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-22 13:33:14.144098 | controller | environment: line 1: kubectl: command not found 2026-04-22 13:33:14.145995 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-22 13:33:14.147115 | controller | environment: line 1: kubectl: command not found 2026-04-22 13:33:14.148467 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-22 13:33:14.250067 | controller | ok: Runtime: 0:00:00.033788 2026-04-22 13:33:14.256425 | 2026-04-22 13:33:14.256556 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-22 13:33:14.493159 | controller | changed 2026-04-22 13:33:14.499037 | 2026-04-22 13:33:14.499136 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-22 13:33:14.738754 | controller | environment: line 5: kubectl: command not found 2026-04-22 13:33:14.740506 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-22 13:33:14.741164 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-22 13:33:14.741186 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-22 13:33:15.029404 | controller | ok: Runtime: 0:00:00.013686 2026-04-22 13:33:15.036544 | 2026-04-22 13:33:15.036694 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-22 13:33:15.775858 | controller | changed: 2026-04-22 13:33:15.776024 | controller | created directory /var/lib/zuul/builds/9d4acf20e52942369040c04ffe949703/work/logs/controller 2026-04-22 13:33:15.776056 | controller | cd+++++++++ objects/ 2026-04-22 13:33:15.776082 | controller | cd+++++++++ objects/cluster/ 2026-04-22 13:33:15.776108 | controller | cd+++++++++ objects/namespaced/ 2026-04-22 13:33:15.783446 | 2026-04-22 13:33:15.783544 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-22 13:33:16.017411 | controller | changed 2026-04-22 13:33:16.024595 | 2026-04-22 13:33:16.024888 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-22 13:33:16.270540 | controller | changed 2026-04-22 13:33:16.277199 | 2026-04-22 13:33:16.277342 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-22 13:33:16.534809 | controller | environment: line 3: kubectl: command not found 2026-04-22 13:33:16.808411 | controller | ok: Runtime: 0:00:00.014368 2026-04-22 13:33:16.814100 | 2026-04-22 13:33:16.814243 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-22 13:33:17.385405 | controller | changed: 2026-04-22 13:33:17.385640 | controller | cd+++++++++ pod-logs/ 2026-04-22 13:33:17.385686 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-04-22 13:33:17.397404 | 2026-04-22 13:33:17.397588 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-22 13:33:17.642213 | controller | changed: "values" 2026-04-22 13:33:17.868334 | controller | changed: "releases" 2026-04-22 13:33:17.878966 | 2026-04-22 13:33:17.879145 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-22 13:33:18.134265 | controller | /bin/bash: line 3: kubectl: command not found 2026-04-22 13:33:18.409615 | controller | ok: Runtime: 0:00:00.009700 2026-04-22 13:33:18.415746 | 2026-04-22 13:33:18.415910 | TASK [helm-release-status : Downloads logs to executor] 2026-04-22 13:33:18.978066 | controller | changed: 2026-04-22 13:33:18.978298 | controller | cd+++++++++ helm/ 2026-04-22 13:33:18.978341 | controller | cd+++++++++ helm/releases/ 2026-04-22 13:33:18.978377 | controller | cd+++++++++ helm/values/ 2026-04-22 13:33:18.985766 | 2026-04-22 13:33:18.985904 | PLAY RECAP 2026-04-22 13:33:18.985973 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-22 13:33:18.986043 | 2026-04-22 13:33:19.192454 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-04-22 13:33:19.195101 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-22 13:33:19.903866 | 2026-04-22 13:33:19.904049 | PLAY [all] 2026-04-22 13:33:19.916860 | 2026-04-22 13:33:19.917109 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-22 13:33:19.963023 | controller | skipping: Conditional result was False 2026-04-22 13:33:19.971913 | 2026-04-22 13:33:19.972122 | TASK [fetch-output : Set log path for single node] 2026-04-22 13:33:20.015108 | controller | ok 2026-04-22 13:33:20.020747 | 2026-04-22 13:33:20.021137 | LOOP [fetch-output : Ensure local output dirs] 2026-04-22 13:33:20.437938 | controller -> localhost | ok: "/var/lib/zuul/builds/9d4acf20e52942369040c04ffe949703/work/logs" 2026-04-22 13:33:20.653289 | controller -> localhost | changed: "/var/lib/zuul/builds/9d4acf20e52942369040c04ffe949703/work/artifacts" 2026-04-22 13:33:20.867595 | controller -> localhost | changed: "/var/lib/zuul/builds/9d4acf20e52942369040c04ffe949703/work/docs" 2026-04-22 13:33:20.879765 | 2026-04-22 13:33:20.879925 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-22 13:33:21.604168 | controller | changed: .d..t...... ./ 2026-04-22 13:33:21.604436 | controller | changed: All items complete 2026-04-22 13:33:21.604481 | 2026-04-22 13:33:22.122556 | controller | changed: .d..t...... ./ 2026-04-22 13:33:22.656320 | controller | changed: .d..t...... ./ 2026-04-22 13:33:22.678930 | 2026-04-22 13:33:22.679124 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-22 13:33:23.146578 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007178 2026-04-22 13:33:23.399734 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007557 2026-04-22 13:33:23.422720 | 2026-04-22 13:33:23.422892 | PLAY [all] 2026-04-22 13:33:23.428995 | 2026-04-22 13:33:23.429084 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-22 13:33:23.929746 | controller | changed 2026-04-22 13:33:23.936332 | 2026-04-22 13:33:23.936401 | PLAY RECAP 2026-04-22 13:33:23.936463 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-22 13:33:23.936497 | 2026-04-22 13:33:24.162805 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-22 13:33:24.165758 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-22 13:33:24.898378 | 2026-04-22 13:33:24.898635 | PLAY [localhost] 2026-04-22 13:33:24.915357 | 2026-04-22 13:33:24.915572 | TASK [Generate Zuul manifest] 2026-04-22 13:33:24.936596 | localhost | ok 2026-04-22 13:33:24.963647 | 2026-04-22 13:33:24.963905 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-22 13:33:25.311537 | localhost | changed 2026-04-22 13:33:25.325431 | 2026-04-22 13:33:25.325582 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-22 13:33:25.358117 | localhost | ok 2026-04-22 13:33:25.364827 | 2026-04-22 13:33:25.364904 | TASK [Upload logs] 2026-04-22 13:33:25.386120 | localhost | ok 2026-04-22 13:33:25.451488 | 2026-04-22 13:33:25.451627 | TASK [Set zuul-log-path fact] 2026-04-22 13:33:25.472180 | localhost | ok 2026-04-22 13:33:25.491636 | 2026-04-22 13:33:25.491829 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-22 13:33:25.523970 | localhost | ok 2026-04-22 13:33:25.533903 | 2026-04-22 13:33:25.534020 | TASK [upload-logs : Create log directories] 2026-04-22 13:33:25.991770 | localhost | changed 2026-04-22 13:33:26.000547 | 2026-04-22 13:33:26.000736 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-22 13:33:26.456338 | localhost -> localhost | ok: Runtime: 0:00:00.003303 2026-04-22 13:33:26.463435 | 2026-04-22 13:33:26.463551 | TASK [upload-logs : Upload logs to log server] 2026-04-22 13:33:26.962084 | localhost | Output suppressed because no_log was given 2026-04-22 13:33:26.967236 | 2026-04-22 13:33:26.967331 | LOOP [upload-logs : Compress console log and json output] 2026-04-22 13:33:27.025331 | localhost | skipping: Conditional result was False 2026-04-22 13:33:27.033968 | localhost | skipping: Conditional result was False 2026-04-22 13:33:27.053894 | 2026-04-22 13:33:27.054043 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-22 13:33:27.097951 | localhost | skipping: Conditional result was False 2026-04-22 13:33:27.098322 | 2026-04-22 13:33:27.103432 | localhost | skipping: Conditional result was False 2026-04-22 13:33:27.118174 | 2026-04-22 13:33:27.118350 | LOOP [upload-logs : Upload console log and json output]