2026-03-26 14:45:04.207308 | Job console starting
2026-03-26 14:45:04.218802 | Updating git repos
2026-03-26 14:45:04.258201 | Cloning repos into workspace
2026-03-26 14:45:04.358043 | Restoring repo states
2026-03-26 14:45:04.374597 | Merging changes
2026-03-26 14:45:05.324029 | Checking out repos
2026-03-26 14:45:05.647349 | Preparing playbooks
2026-03-26 14:45:11.550049 | Running Ansible setup
2026-03-26 14:45:16.725396 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-26 14:45:17.391644 | 
2026-03-26 14:45:17.391826 | PLAY [localhost]
2026-03-26 14:45:17.400439 | 
2026-03-26 14:45:17.400571 | TASK [Gathering Facts]
2026-03-26 14:45:18.465718 | localhost | ok
2026-03-26 14:45:18.477571 | 
2026-03-26 14:45:18.477728 | TASK [Setup log path fact]
2026-03-26 14:45:18.501171 | localhost | ok
2026-03-26 14:45:18.516845 | 
2026-03-26 14:45:18.516993 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-26 14:45:18.549734 | localhost | ok
2026-03-26 14:45:18.558878 | 
2026-03-26 14:45:18.558978 | TASK [emit-job-header : Print job information]
2026-03-26 14:45:18.601159 | # Job Information
2026-03-26 14:45:18.601335 | Ansible Version: 2.16.16
2026-03-26 14:45:18.601368 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart
2026-03-26 14:45:18.601393 | Pipeline: check
2026-03-26 14:45:18.601440 | Executor: 0a8996d2b663
2026-03-26 14:45:18.601465 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/247
2026-03-26 14:45:18.601489 | Event ID: 36e96b90-2922-11f1-82f5-672ae468ec59
2026-03-26 14:45:18.608272 | 
2026-03-26 14:45:18.608442 | LOOP [emit-job-header : Print node information]
2026-03-26 14:45:18.697662 | localhost | ok:
2026-03-26 14:45:18.697878 | localhost | # Node Information
2026-03-26 14:45:18.697918 | localhost | Inventory Hostname: controller
2026-03-26 14:45:18.697947 | localhost | Hostname: np0000161080
2026-03-26 14:45:18.697974 | localhost | Username: zuul
2026-03-26 14:45:18.698004 | localhost | Distro: Debian 13.4
2026-03-26 14:45:18.698031 | localhost | Provider: yul1
2026-03-26 14:45:18.698058 | localhost | Region: ca-ymq-1
2026-03-26 14:45:18.698084 | localhost | Label: debian-trixie
2026-03-26 14:45:18.698110 | localhost | Product Name: OpenStack Nova
2026-03-26 14:45:18.698251 | localhost | Interface IP: 199.204.45.38
2026-03-26 14:45:18.732553 | 
2026-03-26 14:45:18.732730 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-03-26 14:45:19.180044 | localhost -> localhost | changed
2026-03-26 14:45:19.190142 | 
2026-03-26 14:45:19.190216 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-03-26 14:45:20.393357 | localhost -> localhost | changed
2026-03-26 14:45:20.418233 | 
2026-03-26 14:45:20.418314 | PLAY [all]
2026-03-26 14:45:20.434921 | 
2026-03-26 14:45:20.435103 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-26 14:45:20.673041 | controller -> localhost | ok
2026-03-26 14:45:20.683750 | 
2026-03-26 14:45:20.683829 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-26 14:45:20.715544 | controller | ok
2026-03-26 14:45:20.730826 | controller | included: /var/lib/zuul/builds/a4952991097040708499ef0da71a5f40/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-26 14:45:20.735730 | 
2026-03-26 14:45:20.735796 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-26 14:45:21.556300 | controller -> localhost | Generating public/private rsa key pair.
2026-03-26 14:45:21.556550 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/a4952991097040708499ef0da71a5f40/work/a4952991097040708499ef0da71a5f40_id_rsa
2026-03-26 14:45:21.556598 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/a4952991097040708499ef0da71a5f40/work/a4952991097040708499ef0da71a5f40_id_rsa.pub
2026-03-26 14:45:21.556633 | controller -> localhost | The key fingerprint is:
2026-03-26 14:45:21.556665 | controller -> localhost | SHA256:CA8ShsSpFWYt6N8rxcGA3cZFkt2R+nFbgi3nS3MC6Co zuul-build-sshkey
2026-03-26 14:45:21.556714 | controller -> localhost | The key's randomart image is:
2026-03-26 14:45:21.556746 | controller -> localhost | +---[RSA 3072]----+
2026-03-26 14:45:21.556780 | controller -> localhost | |o+Xoo.=o..o      |
2026-03-26 14:45:21.556807 | controller -> localhost | |oBo+.=.. o       |
2026-03-26 14:45:21.556832 | controller -> localhost | |o...*   o o      |
2026-03-26 14:45:21.556857 | controller -> localhost | |.. . * + = = .   |
2026-03-26 14:45:21.556881 | controller -> localhost | |  . o = S B +    |
2026-03-26 14:45:21.556909 | controller -> localhost | |   . + . . * .   |
2026-03-26 14:45:21.556933 | controller -> localhost | |    . o   . =    |
2026-03-26 14:45:21.556975 | controller -> localhost | |   E o     .     |
2026-03-26 14:45:21.557005 | controller -> localhost | |    o            |
2026-03-26 14:45:21.557029 | controller -> localhost | +----[SHA256]-----+
2026-03-26 14:45:21.557088 | controller -> localhost | ok: Runtime: 0:00:00.411367
2026-03-26 14:45:21.562457 | 
2026-03-26 14:45:21.562609 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-26 14:45:21.594971 | controller | ok
2026-03-26 14:45:21.608415 | controller | included: /var/lib/zuul/builds/a4952991097040708499ef0da71a5f40/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-26 14:45:21.623680 | 
2026-03-26 14:45:21.624097 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-26 14:45:21.650840 | controller | skipping: Conditional result was False
2026-03-26 14:45:21.661094 | 
2026-03-26 14:45:21.661270 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-26 14:45:22.202577 | controller | changed
2026-03-26 14:45:22.209686 | 
2026-03-26 14:45:22.209927 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-26 14:45:22.412571 | controller | ok
2026-03-26 14:45:22.475187 | 
2026-03-26 14:45:22.475300 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-26 14:45:23.037221 | controller | changed
2026-03-26 14:45:23.043071 | 
2026-03-26 14:45:23.043157 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-26 14:45:23.586679 | controller | changed
2026-03-26 14:45:23.593613 | 
2026-03-26 14:45:23.593787 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-26 14:45:23.627584 | controller | skipping: Conditional result was False
2026-03-26 14:45:23.633517 | 
2026-03-26 14:45:23.633639 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-26 14:45:24.084791 | controller -> localhost | changed
2026-03-26 14:45:24.100159 | 
2026-03-26 14:45:24.100337 | TASK [add-build-sshkey : Add back temp key]
2026-03-26 14:45:24.385661 | controller -> localhost | Identity added: /var/lib/zuul/builds/a4952991097040708499ef0da71a5f40/work/a4952991097040708499ef0da71a5f40_id_rsa (zuul-build-sshkey)
2026-03-26 14:45:24.385945 | controller -> localhost | ok: Runtime: 0:00:00.013810
2026-03-26 14:45:24.391092 | 
2026-03-26 14:45:24.391159 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-26 14:45:24.746075 | controller | ok
2026-03-26 14:45:24.753809 | 
2026-03-26 14:45:24.753908 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-26 14:45:24.778889 | controller | skipping: Conditional result was False
2026-03-26 14:45:24.794086 | 
2026-03-26 14:45:24.794303 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-03-26 14:45:25.156733 | controller | ok
2026-03-26 14:45:25.189154 | 
2026-03-26 14:45:25.189290 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-03-26 14:45:26.238996 | controller | Output suppressed because no_log was given
2026-03-26 14:45:26.543650 | 
2026-03-26 14:45:26.543788 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-03-26 14:45:26.766774 | controller | ok: "logs"
2026-03-26 14:45:26.767093 | controller | ok: All items complete
2026-03-26 14:45:26.767155 | 
2026-03-26 14:45:26.960401 | controller | ok: "artifacts"
2026-03-26 14:45:27.158660 | controller | ok: "docs"
2026-03-26 14:45:27.172493 | 
2026-03-26 14:45:27.172630 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-03-26 14:45:27.414028 | controller | changed: "logs"
2026-03-26 14:45:27.612123 | controller | changed: "artifacts"
2026-03-26 14:45:27.817417 | controller | changed: "docs"
2026-03-26 14:45:27.836143 | 
2026-03-26 14:45:27.836227 | PLAY RECAP
2026-03-26 14:45:27.836290 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-03-26 14:45:27.836333 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-26 14:45:27.836363 | 
2026-03-26 14:45:27.964017 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-26 14:45:27.966658 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-26 14:45:28.624483 | 
2026-03-26 14:45:28.624633 | PLAY [all]
2026-03-26 14:45:28.637558 | 
2026-03-26 14:45:28.637704 | TASK [setup-uv : Extract archive]
2026-03-26 14:45:30.986855 | controller | changed
2026-03-26 14:45:31.000729 | 
2026-03-26 14:45:31.000886 | TASK [setup-uv : Print version]
2026-03-26 14:45:31.384468 | controller | uv 0.8.13
2026-03-26 14:45:31.534152 | controller | ok: Runtime: 0:00:00.014414
2026-03-26 14:45:31.541464 | 
2026-03-26 14:45:31.541510 | PLAY RECAP
2026-03-26 14:45:31.541553 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-26 14:45:31.541577 | 
2026-03-26 14:45:31.641801 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-26 14:45:31.644544 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-03-26 14:45:32.230054 | 
2026-03-26 14:45:32.230175 | PLAY [all]
2026-03-26 14:45:32.239971 | 
2026-03-26 14:45:32.240046 | TASK [Update apt cache]
2026-03-26 14:45:37.383521 | controller | ok
2026-03-26 14:45:38.904098 | 
2026-03-26 14:45:38.904290 | TASK [Disable firewalld]
2026-03-26 14:45:38.925048 | controller | skipping: Conditional result was False
2026-03-26 14:45:39.030591 | 
2026-03-26 14:45:39.030782 | TASK [Install "jq" for log collection]
2026-03-26 14:45:41.315664 | controller | changed
2026-03-26 14:45:41.318128 | 
2026-03-26 14:45:41.318184 | PLAY RECAP
2026-03-26 14:45:41.318234 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-03-26 14:45:41.318258 | 
2026-03-26 14:45:41.483293 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-03-26 14:45:41.485855 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-03-26 14:45:42.056603 | 
2026-03-26 14:45:42.056727 | PLAY [all]
2026-03-26 14:45:42.066617 | 
2026-03-26 14:45:42.066708 | TASK [Copy inventory file for Zuul]
2026-03-26 14:45:43.023844 | controller | changed
2026-03-26 14:45:43.029561 | 
2026-03-26 14:45:43.029636 | TASK [Switch "ansible_host" to private IP]
2026-03-26 14:45:43.345117 | controller | changed: 1 replacements made
2026-03-26 14:45:43.351734 | 
2026-03-26 14:45:43.351801 | TASK [Run Molecule scenario]
2026-03-26 14:45:43.785900 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-03-26 14:45:43.786001 | controller | Creating virtual environment at: .venv
2026-03-26 14:45:44.050475 | controller | Downloading cryptography (4.3MiB)
2026-03-26 14:45:44.051066 | controller | Downloading ansible-core (2.3MiB)
2026-03-26 14:45:44.053662 | controller | Downloading pygments (1.2MiB)
2026-03-26 14:45:44.216178 | controller |  Downloading cryptography
2026-03-26 14:45:44.259706 | controller |  Downloading pygments
2026-03-26 14:45:44.459725 | controller |  Downloading ansible-core
2026-03-26 14:45:44.505024 | controller | Installed 36 packages in 44ms
2026-03-26 14:45:45.204059 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-03-26 14:45:45.204107 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-03-26 14:45:46.147945 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-03-26 14:45:46.147997 | controller | INFO     default scenario not found, disabling shared state.
2026-03-26 14:45:46.148017 | controller | INFO     [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-03-26 14:45:46.148026 | controller | INFO     [upload-helm-chart > prerun] Performing prerun with role_name_check=0...
2026-03-26 14:46:07.587158 | controller | INFO     [upload-helm-chart > dependency] Executing
2026-03-26 14:46:07.587285 | controller | WARNING  [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml
2026-03-26 14:46:07.587487 | controller | WARNING  [upload-helm-chart > dependency] Missing collections requirements file: collections.yml
2026-03-26 14:46:07.587657 | controller | WARNING  [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-03-26 14:46:07.593511 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-03-26 14:46:07.593886 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-26 14:46:07.599342 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-03-26 14:46:07.599380 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-03-26 14:46:07.599482 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-03-26 14:46:07.604871 | controller | INFO     [upload-helm-chart > syntax] Executing
2026-03-26 14:46:08.562827 | controller |
2026-03-26 14:46:08.563107 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml
2026-03-26 14:46:08.627081 | controller | INFO     [upload-helm-chart > syntax] Executed: Successful
2026-03-26 14:46:08.637496 | controller | INFO     [upload-helm-chart > create] Executing
2026-03-26 14:46:08.639729 | controller | WARNING  [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-26 14:46:08.645547 | controller | INFO     [upload-helm-chart > prepare] Executing
2026-03-26 14:46:08.645848 | controller | WARNING  [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-26 14:46:08.651387 | controller | INFO     [upload-helm-chart > converge] Executing
2026-03-26 14:46:09.632220 | controller |
2026-03-26 14:46:09.632468 | controller | PLAY [Converge] ****************************************************************
2026-03-26 14:46:09.632717 | controller |
2026-03-26 14:46:09.632925 | controller | TASK [Gathering Facts] *********************************************************
2026-03-26 14:46:09.633275 | controller | Thursday 26 March 2026  14:46:09 +0000 (0:00:00.031)       0:00:00.031 ********
2026-03-26 14:46:10.927058 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-03-26 14:46:10.932191 | controller | ok: [controller]
2026-03-26 14:46:10.932212 | controller |
2026-03-26 14:46:10.932222 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-26 14:46:10.932232 | controller | Thursday 26 March 2026  14:46:10 +0000 (0:00:01.300)       0:00:01.331 ********
2026-03-26 14:46:11.011820 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-26 14:46:11.012124 | controller |
2026-03-26 14:46:11.012399 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-26 14:46:11.012658 | controller | Thursday 26 March 2026  14:46:11 +0000 (0:00:00.079)       0:00:01.411 ********
2026-03-26 14:46:11.742476 | controller | changed: [controller]
2026-03-26 14:46:11.742843 | controller |
2026-03-26 14:46:11.743169 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-26 14:46:11.743604 | controller | Thursday 26 March 2026  14:46:11 +0000 (0:00:00.730)       0:00:02.141 ********
2026-03-26 14:46:11.783998 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-26 14:46:11.784238 | controller |
2026-03-26 14:46:11.784545 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-26 14:46:11.784822 | controller | Thursday 26 March 2026  14:46:11 +0000 (0:00:00.041)       0:00:02.183 ********
2026-03-26 14:46:12.224046 | controller | changed: [controller]
2026-03-26 14:46:12.224395 | controller |
2026-03-26 14:46:12.224748 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-26 14:46:12.225066 | controller | Thursday 26 March 2026  14:46:12 +0000 (0:00:00.439)       0:00:02.623 ********
2026-03-26 14:46:13.379301 | controller | changed: [controller]
2026-03-26 14:46:13.379604 | controller |
2026-03-26 14:46:13.379891 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-26 14:46:13.380159 | controller | Thursday 26 March 2026  14:46:13 +0000 (0:00:01.154)       0:00:03.777 ********
2026-03-26 14:46:13.803741 | controller | ok: [controller]
2026-03-26 14:46:13.803784 | controller |
2026-03-26 14:46:13.803796 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-26 14:46:13.803807 | controller | Thursday 26 March 2026  14:46:13 +0000 (0:00:00.423)       0:00:04.201 ********
2026-03-26 14:46:13.855179 | controller | skipping: [controller]
2026-03-26 14:46:13.855477 | controller |
2026-03-26 14:46:13.855749 | controller | PLAY RECAP *********************************************************************
2026-03-26 14:46:13.856039 | controller | controller                 : ok=7    changed=3    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-03-26 14:46:13.856331 | controller |
2026-03-26 14:46:13.856579 | controller |
2026-03-26 14:46:13.856849 | controller | TASKS RECAP ********************************************************************
2026-03-26 14:46:13.857124 | controller | Thursday 26 March 2026  14:46:13 +0000 (0:00:00.053)       0:00:04.255 ********
2026-03-26 14:46:13.857491 | controller | ===============================================================================
2026-03-26 14:46:13.857763 | controller | Gathering Facts --------------------------------------------------------- 1.30s
2026-03-26 14:46:13.858033 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.15s
2026-03-26 14:46:13.858423 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.73s
2026-03-26 14:46:13.858823 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.44s
2026-03-26 14:46:13.859112 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.42s
2026-03-26 14:46:13.859384 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-03-26 14:46:13.859743 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.05s
2026-03-26 14:46:13.860030 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s
2026-03-26 14:46:13.955109 | controller | INFO     [upload-helm-chart > converge] Executed: Successful
2026-03-26 14:46:13.965570 | controller | INFO     [upload-helm-chart > idempotence] Executing
2026-03-26 14:46:14.878483 | controller |
2026-03-26 14:46:14.878693 | controller | PLAY [Converge] ****************************************************************
2026-03-26 14:46:14.878845 | controller |
2026-03-26 14:46:14.879019 | controller | TASK [Gathering Facts] *********************************************************
2026-03-26 14:46:14.879207 | controller | Thursday 26 March 2026  14:46:14 +0000 (0:00:00.012)       0:00:00.012 ********
2026-03-26 14:46:15.986674 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-03-26 14:46:15.991430 | controller | ok: [controller]
2026-03-26 14:46:15.991449 | controller |
2026-03-26 14:46:15.991456 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-26 14:46:15.991462 | controller | Thursday 26 March 2026  14:46:15 +0000 (0:00:01.112)       0:00:01.125 ********
2026-03-26 14:46:16.068693 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-26 14:46:16.068833 | controller |
2026-03-26 14:46:16.068962 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-26 14:46:16.070337 | controller | Thursday 26 March 2026  14:46:16 +0000 (0:00:00.077)       0:00:01.203 ********
2026-03-26 14:46:16.805703 | controller | ok: [controller]
2026-03-26 14:46:16.806081 | controller |
2026-03-26 14:46:16.806492 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-26 14:46:16.806813 | controller | Thursday 26 March 2026  14:46:16 +0000 (0:00:00.736)       0:00:01.939 ********
2026-03-26 14:46:16.850858 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-26 14:46:16.851153 | controller |
2026-03-26 14:46:16.851635 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-26 14:46:16.851965 | controller | Thursday 26 March 2026  14:46:16 +0000 (0:00:00.045)       0:00:01.985 ********
2026-03-26 14:46:17.279810 | controller | ok: [controller]
2026-03-26 14:46:17.280176 | controller |
2026-03-26 14:46:17.280488 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-26 14:46:17.280802 | controller | Thursday 26 March 2026  14:46:17 +0000 (0:00:00.428)       0:00:02.413 ********
2026-03-26 14:46:18.396757 | controller | ok: [controller]
2026-03-26 14:46:18.397040 | controller |
2026-03-26 14:46:18.397318 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-26 14:46:18.397588 | controller | Thursday 26 March 2026  14:46:18 +0000 (0:00:01.116)       0:00:03.529 ********
2026-03-26 14:46:18.817194 | controller | ok: [controller]
2026-03-26 14:46:18.817500 | controller |
2026-03-26 14:46:18.817965 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-26 14:46:18.818472 | controller | Thursday 26 March 2026  14:46:18 +0000 (0:00:00.421)       0:00:03.951 ********
2026-03-26 14:46:18.861635 | controller | skipping: [controller]
2026-03-26 14:46:18.861808 | controller |
2026-03-26 14:46:18.861962 | controller | PLAY RECAP *********************************************************************
2026-03-26 14:46:18.862123 | controller | controller                 : ok=7    changed=0    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-03-26 14:46:18.862349 | controller |
2026-03-26 14:46:18.862520 | controller |
2026-03-26 14:46:18.862682 | controller | TASKS RECAP ********************************************************************
2026-03-26 14:46:18.862824 | controller | Thursday 26 March 2026  14:46:18 +0000 (0:00:00.045)       0:00:03.996 ********
2026-03-26 14:46:18.862959 | controller | ===============================================================================
2026-03-26 14:46:18.863107 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.12s
2026-03-26 14:46:18.863246 | controller | Gathering Facts --------------------------------------------------------- 1.11s
2026-03-26 14:46:18.863393 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.74s
2026-03-26 14:46:18.863534 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.43s
2026-03-26 14:46:18.863673 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.42s
2026-03-26 14:46:18.863833 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-03-26 14:46:18.863979 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.05s
2026-03-26 14:46:18.864123 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-03-26 14:46:18.974738 | controller | INFO     [upload-helm-chart > idempotence] Executed: Successful
2026-03-26 14:46:18.981002 | controller | INFO     [upload-helm-chart > side_effect] Executing
2026-03-26 14:46:19.884311 | controller |
2026-03-26 14:46:19.884693 | controller | PLAY [Side effect] *************************************************************
2026-03-26 14:46:19.884945 | controller |
2026-03-26 14:46:19.885201 | controller | TASK [Gathering Facts] *********************************************************
2026-03-26 14:46:19.885457 | controller | Thursday 26 March 2026  14:46:19 +0000 (0:00:00.013)       0:00:00.013 ********
2026-03-26 14:46:20.971716 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-03-26 14:46:20.976800 | controller | ok: [controller]
2026-03-26 14:46:20.976987 | controller |
2026-03-26 14:46:20.977188 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-26 14:46:20.977440 | controller | Thursday 26 March 2026  14:46:20 +0000 (0:00:01.092)       0:00:01.105 ********
2026-03-26 14:46:21.053323 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-26 14:46:21.053360 | controller |
2026-03-26 14:46:21.053380 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-26 14:46:21.053400 | controller | Thursday 26 March 2026  14:46:21 +0000 (0:00:00.075)       0:00:01.181 ********
2026-03-26 14:46:21.806480 | controller | changed: [controller]
2026-03-26 14:46:21.806895 | controller |
2026-03-26 14:46:21.807295 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-26 14:46:21.807602 | controller | Thursday 26 March 2026  14:46:21 +0000 (0:00:00.753)       0:00:01.934 ********
2026-03-26 14:46:21.851461 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-26 14:46:21.851757 | controller |
2026-03-26 14:46:21.852041 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-26 14:46:21.852400 | controller | Thursday 26 March 2026  14:46:21 +0000 (0:00:00.045)       0:00:01.980 ********
2026-03-26 14:46:22.296240 | controller | ok: [controller]
2026-03-26 14:46:22.296525 | controller |
2026-03-26 14:46:22.296811 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-26 14:46:22.297063 | controller | Thursday 26 March 2026  14:46:22 +0000 (0:00:00.444)       0:00:02.424 ********
2026-03-26 14:46:23.454224 | controller | ok: [controller]
2026-03-26 14:46:23.454269 | controller |
2026-03-26 14:46:23.454276 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-26 14:46:23.454282 | controller | Thursday 26 March 2026  14:46:23 +0000 (0:00:01.154)       0:00:03.578 ********
2026-03-26 14:46:23.873310 | controller | ok: [controller]
2026-03-26 14:46:23.873655 | controller |
2026-03-26 14:46:23.874005 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-26 14:46:23.874355 | controller | Thursday 26 March 2026  14:46:23 +0000 (0:00:00.423)       0:00:04.001 ********
2026-03-26 14:46:24.186029 | controller | changed: [controller] => (item=/file)
2026-03-26 14:46:24.186269 | controller |
2026-03-26 14:46:24.186449 | controller | PLAY RECAP *********************************************************************
2026-03-26 14:46:24.186637 | controller | controller                 : ok=8    changed=2    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-03-26 14:46:24.186795 | controller |
2026-03-26 14:46:24.186949 | controller |
2026-03-26 14:46:24.187115 | controller | TASKS RECAP ********************************************************************
2026-03-26 14:46:24.187300 | controller | Thursday 26 March 2026  14:46:24 +0000 (0:00:00.313)       0:00:04.315 ********
2026-03-26 14:46:24.187461 | controller | ===============================================================================
2026-03-26 14:46:24.187921 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.15s
2026-03-26 14:46:24.188716 | controller | Gathering Facts --------------------------------------------------------- 1.09s
2026-03-26 14:46:24.188897 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.75s
2026-03-26 14:46:24.189069 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.44s
2026-03-26 14:46:24.189242 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.42s
2026-03-26 14:46:24.189425 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.31s
2026-03-26 14:46:24.189606 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-03-26 14:46:24.189785 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-03-26 14:46:24.301539 | controller | INFO     [upload-helm-chart > side_effect] Executed: Successful
2026-03-26 14:46:24.310630 | controller | INFO     [upload-helm-chart > verify] Executing
2026-03-26 14:46:25.180656 | controller |
2026-03-26 14:46:25.180993 | controller | PLAY [Verify] ******************************************************************
2026-03-26 14:46:25.181245 | controller |
2026-03-26 14:46:25.181509 | controller | TASK [Gathering Facts] *********************************************************
2026-03-26 14:46:25.181771 | controller | Thursday 26 March 2026  14:46:25 +0000 (0:00:00.009)       0:00:00.009 ********
2026-03-26 14:46:26.334426 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-03-26 14:46:26.342262 | controller | ok: [controller]
2026-03-26 14:46:26.342292 | controller |
2026-03-26 14:46:26.342301 | controller | TASK [Stat file 1] *************************************************************
2026-03-26 14:46:26.342505 | controller | Thursday 26 March 2026  14:46:26 +0000 (0:00:01.157)       0:00:01.167 ********
2026-03-26 14:46:26.778368 | controller | ok: [controller]
2026-03-26 14:46:26.778452 | controller |
2026-03-26 14:46:26.778599 | controller | TASK [Stat file 2] *************************************************************
2026-03-26 14:46:26.778744 | controller | Thursday 26 March 2026  14:46:26 +0000 (0:00:00.439)       0:00:01.607 ********
2026-03-26 14:46:27.107031 | controller | ok: [controller]
2026-03-26 14:46:27.107058 | controller |
2026-03-26 14:46:27.107062 | controller | TASK [Stat removed file 1] *****************************************************
2026-03-26 14:46:27.107066 | controller | Thursday 26 March 2026  14:46:27 +0000 (0:00:00.324)       0:00:01.931 ********
2026-03-26 14:46:27.401775 | controller | ok: [controller]
2026-03-26 14:46:27.402041 | controller |
2026-03-26 14:46:27.402238 | controller | TASK [Stat removed file 2] *****************************************************
2026-03-26 14:46:27.402410 | controller | Thursday 26 March 2026  14:46:27 +0000 (0:00:00.298)       0:00:02.230 ********
2026-03-26 14:46:27.694522 | controller | ok: [controller]
2026-03-26 14:46:27.694581 | controller |
2026-03-26 14:46:27.694720 | controller | TASK [ansible.builtin.assert] **************************************************
2026-03-26 14:46:27.694859 | controller | Thursday 26 March 2026  14:46:27 +0000 (0:00:00.292)       0:00:02.523 ********
2026-03-26 14:46:27.730823 | controller | ok: [controller] => {
2026-03-26 14:46:27.731039 | controller |     "changed": false,
2026-03-26 14:46:27.731205 | controller |     "msg": "All assertions passed"
2026-03-26 14:46:27.731476 | controller | }
2026-03-26 14:46:27.731711 | controller |
2026-03-26 14:46:27.731981 | controller | PLAY RECAP *********************************************************************
2026-03-26 14:46:27.732215 | controller | controller                 : ok=6    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-03-26 14:46:27.732454 | controller |
2026-03-26 14:46:27.732695 | controller |
2026-03-26 14:46:27.732923 | controller | TASKS RECAP ********************************************************************
2026-03-26 14:46:27.733177 | controller | Thursday 26 March 2026  14:46:27 +0000 (0:00:00.032)       0:00:02.556 ********
2026-03-26 14:46:27.734228 | controller | ===============================================================================
2026-03-26 14:46:27.734257 | controller | Gathering Facts --------------------------------------------------------- 1.16s
2026-03-26 14:46:27.734261 | controller | Stat file 1 ------------------------------------------------------------- 0.44s
2026-03-26 14:46:27.734265 | controller | Stat file 2 ------------------------------------------------------------- 0.32s
2026-03-26 14:46:27.734272 | controller | Stat removed file 1 ----------------------------------------------------- 0.30s
2026-03-26 14:46:27.734868 | controller | Stat removed file 2 ----------------------------------------------------- 0.29s
2026-03-26 14:46:27.734905 | controller | ansible.builtin.assert -------------------------------------------------- 0.03s
2026-03-26 14:46:27.841159 | controller | INFO     [upload-helm-chart > verify] Executed: Successful
2026-03-26 14:46:27.850392 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-03-26 14:46:27.850919 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-26 14:46:27.858827 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-03-26 14:46:27.859027 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-03-26 14:46:27.859152 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-03-26 14:46:27.859572 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-03-26 14:46:28.008215 | controller | ok: Runtime: 0:00:44.245501
2026-03-26 14:46:28.012630 | 
2026-03-26 14:46:28.012709 | PLAY RECAP
2026-03-26 14:46:28.012769 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-26 14:46:28.012801 | 
2026-03-26 14:46:28.123301 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-03-26 14:46:28.126050 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-03-26 14:46:28.741586 | 
2026-03-26 14:46:28.741816 | PLAY [all]
2026-03-26 14:46:28.753291 | 
2026-03-26 14:46:28.753395 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-03-26 14:46:29.140067 | controller | changed
2026-03-26 14:46:29.144610 | 
2026-03-26 14:46:29.144691 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-03-26 14:46:29.541705 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-26 14:46:29.542043 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-26 14:46:29.548333 | controller | environment: line 1: kubectl: command not found
2026-03-26 14:46:29.550414 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-26 14:46:29.552945 | controller | environment: line 1: kubectl: command not found
2026-03-26 14:46:29.555186 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-26 14:46:29.556023 | controller | environment: line 1: kubectl: command not found
2026-03-26 14:46:29.558191 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-26 14:46:29.558863 | controller | environment: line 1: kubectl: command not found
2026-03-26 14:46:29.559925 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-26 14:46:29.560173 | controller | environment: line 1: kubectl: command not found
2026-03-26 14:46:29.561511 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-26 14:46:29.672427 | controller | ok: Runtime: 0:00:00.035351
2026-03-26 14:46:29.677205 | 
2026-03-26 14:46:29.677271 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-03-26 14:46:29.911287 | controller | changed
2026-03-26 14:46:29.916940 | 
2026-03-26 14:46:29.917060 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-03-26 14:46:30.169802 | controller | environment: line 5: kubectl: command not found
2026-03-26 14:46:30.169904 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-26 14:46:30.171114 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-26 14:46:30.172865 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-26 14:46:30.468848 | controller | ok: Runtime: 0:00:00.012286
2026-03-26 14:46:30.475871 | 
2026-03-26 14:46:30.475967 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-03-26 14:46:31.353603 | controller | changed:
2026-03-26 14:46:31.353806 | controller | created directory /var/lib/zuul/builds/a4952991097040708499ef0da71a5f40/work/logs/controller
2026-03-26 14:46:31.353852 | controller | cd+++++++++ objects/
2026-03-26 14:46:31.353886 | controller | cd+++++++++ objects/cluster/
2026-03-26 14:46:31.353920 | controller | cd+++++++++ objects/namespaced/
2026-03-26 14:46:31.363365 | 
2026-03-26 14:46:31.363463 | TASK [gather-pod-logs : creating directory for pod logs]
2026-03-26 14:46:31.598010 | controller | changed
2026-03-26 14:46:31.605459 | 
2026-03-26 14:46:31.605553 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-03-26 14:46:31.851529 | controller | changed
2026-03-26 14:46:31.855820 | 
2026-03-26 14:46:31.855890 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-03-26 14:46:32.119652 | controller | environment: line 3: kubectl: command not found
2026-03-26 14:46:32.386518 | controller | ok: Runtime: 0:00:00.011991
2026-03-26 14:46:32.391171 | 
2026-03-26 14:46:32.391235 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-03-26 14:46:33.026763 | controller | changed:
2026-03-26 14:46:33.027029 | controller | cd+++++++++ pod-logs/
2026-03-26 14:46:33.027092 | controller | cd+++++++++ pod-logs/failed-pods/
2026-03-26 14:46:33.035572 | 
2026-03-26 14:46:33.035639 | LOOP [helm-release-status : creating directory for helm release status]
2026-03-26 14:46:33.329806 | controller | changed: "values"
2026-03-26 14:46:33.562967 | controller | changed: "releases"
2026-03-26 14:46:33.577133 | 
2026-03-26 14:46:33.577279 | TASK [helm-release-status : Gather get release status for helm charts]
2026-03-26 14:46:33.826266 | controller | /bin/bash: line 3: kubectl: command not found
2026-03-26 14:46:34.112595 | controller | ok: Runtime: 0:00:00.008243
2026-03-26 14:46:34.116825 | 
2026-03-26 14:46:34.116896 | TASK [helm-release-status : Downloads logs to executor]
2026-03-26 14:46:34.665527 | controller | changed:
2026-03-26 14:46:34.665734 | controller | cd+++++++++ helm/
2026-03-26 14:46:34.665777 | controller | cd+++++++++ helm/releases/
2026-03-26 14:46:34.665814 | controller | cd+++++++++ helm/values/
2026-03-26 14:46:34.672563 | 
2026-03-26 14:46:34.672615 | PLAY RECAP
2026-03-26 14:46:34.672661 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-26 14:46:34.672684 | 
2026-03-26 14:46:34.794977 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-03-26 14:46:34.799469 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-26 14:46:35.369345 | 
2026-03-26 14:46:35.369469 | PLAY [all]
2026-03-26 14:46:35.379360 | 
2026-03-26 14:46:35.379436 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-26 14:46:35.424642 | controller | skipping: Conditional result was False
2026-03-26 14:46:35.434865 | 
2026-03-26 14:46:35.435050 | TASK [fetch-output : Set log path for single node]
2026-03-26 14:46:35.468502 | controller | ok
2026-03-26 14:46:35.473641 | 
2026-03-26 14:46:35.473728 | LOOP [fetch-output : Ensure local output dirs]
2026-03-26 14:46:35.935994 | controller -> localhost | ok: "/var/lib/zuul/builds/a4952991097040708499ef0da71a5f40/work/logs"
2026-03-26 14:46:36.335954 | controller -> localhost | changed: "/var/lib/zuul/builds/a4952991097040708499ef0da71a5f40/work/artifacts"
2026-03-26 14:46:36.544454 | controller -> localhost | changed: "/var/lib/zuul/builds/a4952991097040708499ef0da71a5f40/work/docs"
2026-03-26 14:46:36.556804 | 
2026-03-26 14:46:36.556952 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-26 14:46:37.257080 | controller | changed: .d..t...... ./
2026-03-26 14:46:37.257401 | controller | changed: All items complete
2026-03-26 14:46:37.257436 | 
2026-03-26 14:46:37.762613 | controller | changed: .d..t...... ./
2026-03-26 14:46:38.295114 | controller | changed: .d..t...... ./
2026-03-26 14:46:38.311717 | 
2026-03-26 14:46:38.311840 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-03-26 14:46:38.764134 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007885
2026-03-26 14:46:38.979373 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007380
2026-03-26 14:46:38.999035 | 
2026-03-26 14:46:38.999206 | PLAY [all]
2026-03-26 14:46:39.005526 | 
2026-03-26 14:46:39.005591 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-03-26 14:46:39.506719 | controller | changed
2026-03-26 14:46:39.513771 | 
2026-03-26 14:46:39.513833 | PLAY RECAP
2026-03-26 14:46:39.513877 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-03-26 14:46:39.513899 | 
2026-03-26 14:46:39.622664 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-26 14:46:39.624554 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-03-26 14:46:40.256319 | 
2026-03-26 14:46:40.256517 | PLAY [localhost]
2026-03-26 14:46:40.267394 | 
2026-03-26 14:46:40.267482 | TASK [Generate Zuul manifest]
2026-03-26 14:46:40.290224 | localhost | ok
2026-03-26 14:46:40.307864 | 
2026-03-26 14:46:40.307965 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-03-26 14:46:40.636610 | localhost | changed
2026-03-26 14:46:40.648055 | 
2026-03-26 14:46:40.648140 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-03-26 14:46:40.676641 | localhost | ok
2026-03-26 14:46:40.683090 | 
2026-03-26 14:46:40.683156 | TASK [Upload logs]
2026-03-26 14:46:40.702438 | localhost | ok
2026-03-26 14:46:40.763426 | 
2026-03-26 14:46:40.763550 | TASK [Set zuul-log-path fact]
2026-03-26 14:46:40.782743 | localhost | ok
2026-03-26 14:46:40.795959 | 
2026-03-26 14:46:40.796029 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-26 14:46:40.828990 | localhost | ok
2026-03-26 14:46:40.837463 | 
2026-03-26 14:46:40.837540 | TASK [upload-logs : Create log directories]
2026-03-26 14:46:41.288007 | localhost | changed
2026-03-26 14:46:41.294117 | 
2026-03-26 14:46:41.294208 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-03-26 14:46:41.690646 | localhost -> localhost | ok: Runtime: 0:00:00.005523
2026-03-26 14:46:41.697429 | 
2026-03-26 14:46:41.697526 | TASK [upload-logs : Upload logs to log server]
2026-03-26 14:46:42.155485 | localhost | Output suppressed because no_log was given
2026-03-26 14:46:42.160814 | 
2026-03-26 14:46:42.160938 | LOOP [upload-logs : Compress console log and json output]
2026-03-26 14:46:42.203378 | localhost | skipping: Conditional result was False
2026-03-26 14:46:42.210821 | localhost | skipping: Conditional result was False
2026-03-26 14:46:42.226129 | 
2026-03-26 14:46:42.226312 | LOOP [upload-logs : Upload compressed console log and json output]
2026-03-26 14:46:42.264879 | localhost | skipping: Conditional result was False
2026-03-26 14:46:42.265313 | 
2026-03-26 14:46:42.268901 | localhost | skipping: Conditional result was False
2026-03-26 14:46:42.280475 | 
2026-03-26 14:46:42.280647 | LOOP [upload-logs : Upload console log and json output]