2026-04-23 04:38:10.102634 | Job console starting
2026-04-23 04:38:10.116893 | Updating git repos
2026-04-23 04:38:10.198077 | Cloning repos into workspace
2026-04-23 04:38:10.744757 | Restoring repo states
2026-04-23 04:38:10.760411 | Merging changes
2026-04-23 04:38:11.653248 | Checking out repos
2026-04-23 04:38:11.858813 | Preparing playbooks
2026-04-23 04:38:18.844858 | Running Ansible setup
2026-04-23 04:38:24.676966 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-23 04:38:25.398255 | 
2026-04-23 04:38:25.398418 | PLAY [localhost]
2026-04-23 04:38:25.422500 | 
2026-04-23 04:38:25.422668 | TASK [Gathering Facts]
2026-04-23 04:38:26.759846 | localhost | ok
2026-04-23 04:38:26.774140 | 
2026-04-23 04:38:26.774326 | TASK [Setup log path fact]
2026-04-23 04:38:26.808541 | localhost | ok
2026-04-23 04:38:26.819604 | 
2026-04-23 04:38:26.819711 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-23 04:38:26.862945 | localhost | ok
2026-04-23 04:38:26.868883 | 
2026-04-23 04:38:26.868974 | TASK [emit-job-header : Print job information]
2026-04-23 04:38:26.916235 | # Job Information
2026-04-23 04:38:26.916387 | Ansible Version: 2.16.16
2026-04-23 04:38:26.916419 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart
2026-04-23 04:38:26.916442 | Pipeline: check
2026-04-23 04:38:26.916473 | Executor: 0a8996d2b663
2026-04-23 04:38:26.916495 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/268
2026-04-23 04:38:26.916518 | Event ID: 1370a310-3ece-11f1-8cb2-08168b2742d0
2026-04-23 04:38:26.919257 | 
2026-04-23 04:38:26.919324 | LOOP [emit-job-header : Print node information]
2026-04-23 04:38:27.018631 | localhost | ok:
2026-04-23 04:38:27.018984 | localhost | # Node Information
2026-04-23 04:38:27.019024 | localhost | Inventory Hostname: controller
2026-04-23 04:38:27.019048 | localhost | Hostname: np0000169669
2026-04-23 04:38:27.019068 | localhost | Username: zuul
2026-04-23 04:38:27.019097 | localhost | Distro: Debian 13.4
2026-04-23 04:38:27.019118 | localhost | Provider: yul1
2026-04-23 04:38:27.019138 | localhost | Region: ca-ymq-1
2026-04-23 04:38:27.019158 | localhost | Label: debian-trixie
2026-04-23 04:38:27.019176 | localhost | Product Name: OpenStack Nova
2026-04-23 04:38:27.019196 | localhost | Interface IP: 199.204.45.109
2026-04-23 04:38:27.035521 | 
2026-04-23 04:38:27.035661 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-23 04:38:27.466572 | localhost -> localhost | changed
2026-04-23 04:38:27.473147 | 
2026-04-23 04:38:27.473259 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-23 04:38:28.489330 | localhost -> localhost | changed
2026-04-23 04:38:28.505765 | 
2026-04-23 04:38:28.505856 | PLAY [all]
2026-04-23 04:38:28.518988 | 
2026-04-23 04:38:28.519073 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-23 04:38:28.809074 | controller -> localhost | ok
2026-04-23 04:38:28.814561 | 
2026-04-23 04:38:28.814625 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-23 04:38:28.852581 | controller | ok
2026-04-23 04:38:28.870322 | controller | included: /var/lib/zuul/builds/247438141a1f472ea1f3f0d2863aa4a4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-23 04:38:28.875039 | 
2026-04-23 04:38:28.875104 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-23 04:38:29.816922 | controller -> localhost | Generating public/private rsa key pair.
2026-04-23 04:38:29.817108 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/247438141a1f472ea1f3f0d2863aa4a4/work/247438141a1f472ea1f3f0d2863aa4a4_id_rsa
2026-04-23 04:38:29.817142 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/247438141a1f472ea1f3f0d2863aa4a4/work/247438141a1f472ea1f3f0d2863aa4a4_id_rsa.pub
2026-04-23 04:38:29.817165 | controller -> localhost | The key fingerprint is:
2026-04-23 04:38:29.817186 | controller -> localhost | SHA256:liwEpxF1XryDpweP7HKCYl4w0Vyeu+PcHUFKmiOf5jE zuul-build-sshkey
2026-04-23 04:38:29.817219 | controller -> localhost | The key's randomart image is:
2026-04-23 04:38:29.817240 | controller -> localhost | +---[RSA 3072]----+
2026-04-23 04:38:29.817263 | controller -> localhost | |    +o+ ...      |
2026-04-23 04:38:29.817285 | controller -> localhost | |   o B + ..      |
2026-04-23 04:38:29.817305 | controller -> localhost | |  . + + o...     |
2026-04-23 04:38:29.817325 | controller -> localhost | |   . . *o++      |
2026-04-23 04:38:29.817345 | controller -> localhost | |  o . *.S*..     |
2026-04-23 04:38:29.817365 | controller -> localhost | |   o o *+ o.     |
2026-04-23 04:38:29.817384 | controller -> localhost | |    ..E. ..      |
2026-04-23 04:38:29.817404 | controller -> localhost | |  o..=o=o. .     |
2026-04-23 04:38:29.817426 | controller -> localhost | | o..  ++. .      |
2026-04-23 04:38:29.817446 | controller -> localhost | +----[SHA256]-----+
2026-04-23 04:38:29.817493 | controller -> localhost | ok: Runtime: 0:00:00.455490
2026-04-23 04:38:29.821557 | 
2026-04-23 04:38:29.821618 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-23 04:38:29.839161 | controller | ok
2026-04-23 04:38:29.851393 | controller | included: /var/lib/zuul/builds/247438141a1f472ea1f3f0d2863aa4a4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-23 04:38:29.866107 | 
2026-04-23 04:38:29.866184 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-23 04:38:29.889976 | controller | skipping: Conditional result was False
2026-04-23 04:38:29.897699 | 
2026-04-23 04:38:29.897806 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-23 04:38:30.478093 | controller | changed
2026-04-23 04:38:30.494639 | 
2026-04-23 04:38:30.494803 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-23 04:38:30.705524 | controller | ok
2026-04-23 04:38:30.709687 | 
2026-04-23 04:38:30.709762 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-23 04:38:31.227687 | controller | changed
2026-04-23 04:38:31.378834 | 
2026-04-23 04:38:31.378993 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-23 04:38:31.947800 | controller | changed
2026-04-23 04:38:31.952890 | 
2026-04-23 04:38:31.953018 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-23 04:38:31.976436 | controller | skipping: Conditional result was False
2026-04-23 04:38:31.980801 | 
2026-04-23 04:38:31.980875 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-23 04:38:32.502654 | controller -> localhost | changed
2026-04-23 04:38:32.513304 | 
2026-04-23 04:38:32.513422 | TASK [add-build-sshkey : Add back temp key]
2026-04-23 04:38:32.851934 | controller -> localhost | Identity added: /var/lib/zuul/builds/247438141a1f472ea1f3f0d2863aa4a4/work/247438141a1f472ea1f3f0d2863aa4a4_id_rsa (zuul-build-sshkey)
2026-04-23 04:38:32.852150 | controller -> localhost | ok: Runtime: 0:00:00.011744
2026-04-23 04:38:32.857826 | 
2026-04-23 04:38:32.857917 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-23 04:38:33.191215 | controller | ok
2026-04-23 04:38:33.574660 | 
2026-04-23 04:38:33.574753 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-23 04:38:33.598792 | controller | skipping: Conditional result was False
2026-04-23 04:38:33.618355 | 
2026-04-23 04:38:33.618589 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-23 04:38:34.007778 | controller | ok
2026-04-23 04:38:34.018128 | 
2026-04-23 04:38:34.018249 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-23 04:38:35.199234 | controller | Output suppressed because no_log was given
2026-04-23 04:38:35.205789 | 
2026-04-23 04:38:35.205849 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-23 04:38:35.412868 | controller | ok: "logs"
2026-04-23 04:38:35.520108 | controller | ok: All items complete
2026-04-23 04:38:35.520308 | 
2026-04-23 04:38:35.602483 | controller | ok: "artifacts"
2026-04-23 04:38:35.800699 | controller | ok: "docs"
2026-04-23 04:38:35.807937 | 
2026-04-23 04:38:35.808051 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-23 04:38:36.013004 | controller | changed: "logs"
2026-04-23 04:38:36.186457 | controller | changed: "artifacts"
2026-04-23 04:38:36.363689 | controller | changed: "docs"
2026-04-23 04:38:36.380134 | 
2026-04-23 04:38:36.380222 | PLAY RECAP
2026-04-23 04:38:36.380268 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-23 04:38:36.380297 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-23 04:38:36.380317 | 
2026-04-23 04:38:36.549742 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-23 04:38:36.790385 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-23 04:38:37.430599 | 
2026-04-23 04:38:37.430731 | PLAY [all]
2026-04-23 04:38:37.441388 | 
2026-04-23 04:38:37.441484 | TASK [setup-uv : Extract archive]
2026-04-23 04:38:39.783840 | controller | changed
2026-04-23 04:38:39.790442 | 
2026-04-23 04:38:39.790579 | TASK [setup-uv : Print version]
2026-04-23 04:38:40.216977 | controller | uv 0.8.13
2026-04-23 04:38:40.339961 | controller | ok: Runtime: 0:00:00.015170
2026-04-23 04:38:40.349148 | 
2026-04-23 04:38:40.349301 | PLAY RECAP
2026-04-23 04:38:40.349355 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-23 04:38:40.349379 | 
2026-04-23 04:38:40.532998 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-23 04:38:40.534280 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-04-23 04:38:41.148776 | 
2026-04-23 04:38:41.148923 | PLAY [all]
2026-04-23 04:38:41.159647 | 
2026-04-23 04:38:41.159746 | TASK [Update apt cache]
2026-04-23 04:38:45.908493 | controller | ok
2026-04-23 04:38:45.915441 | 
2026-04-23 04:38:45.915586 | TASK [Disable firewalld]
2026-04-23 04:38:45.940144 | controller | skipping: Conditional result was False
2026-04-23 04:38:45.946130 | 
2026-04-23 04:38:45.946223 | TASK [Install "jq" for log collection]
2026-04-23 04:38:48.393765 | controller | changed
2026-04-23 04:38:48.425567 | 
2026-04-23 04:38:48.425677 | PLAY RECAP
2026-04-23 04:38:48.425742 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-23 04:38:48.425776 | 
2026-04-23 04:38:48.536215 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-04-23 04:38:48.537946 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-04-23 04:38:49.153922 | 
2026-04-23 04:38:49.154260 | PLAY [all]
2026-04-23 04:38:49.164007 | 
2026-04-23 04:38:49.164101 | TASK [Copy inventory file for Zuul]
2026-04-23 04:38:50.095820 | controller | changed
2026-04-23 04:38:50.101104 | 
2026-04-23 04:38:50.101266 | TASK [Switch "ansible_host" to private IP]
2026-04-23 04:38:50.413446 | controller | changed: 1 replacements made
2026-04-23 04:38:50.417986 | 
2026-04-23 04:38:50.418053 | TASK [Run Molecule scenario]
2026-04-23 04:38:50.858175 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-04-23 04:38:50.858264 | controller | Creating virtual environment at: .venv
2026-04-23 04:38:51.131557 | controller | Downloading cryptography (4.3MiB)
2026-04-23 04:38:51.131889 | controller | Downloading ansible-core (2.3MiB)
2026-04-23 04:38:51.132299 | controller | Downloading pygments (1.2MiB)
2026-04-23 04:38:51.302485 | controller |  Downloading cryptography
2026-04-23 04:38:51.357266 | controller |  Downloading pygments
2026-04-23 04:38:51.513856 | controller |  Downloading ansible-core
2026-04-23 04:38:51.558838 | controller | Installed 36 packages in 44ms
2026-04-23 04:38:52.222413 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-04-23 04:38:52.222484 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-04-23 04:38:53.062962 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-04-23 04:38:53.063026 | controller | INFO     default scenario not found, disabling shared state.
2026-04-23 04:38:53.063046 | controller | INFO     [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-04-23 04:38:53.063117 | controller | INFO     [upload-helm-chart > prerun] Performing prerun with role_name_check=0...
2026-04-23 04:39:08.624507 | controller | INFO     [upload-helm-chart > dependency] Executing
2026-04-23 04:39:08.624581 | controller | WARNING  [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml
2026-04-23 04:39:08.624801 | controller | WARNING  [upload-helm-chart > dependency] Missing collections requirements file: collections.yml
2026-04-23 04:39:08.624927 | controller | WARNING  [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-04-23 04:39:08.630321 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-04-23 04:39:08.630602 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-04-23 04:39:08.635942 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-04-23 04:39:08.635986 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-04-23 04:39:08.636094 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-04-23 04:39:08.641345 | controller | INFO     [upload-helm-chart > syntax] Executing
2026-04-23 04:39:09.549604 | controller |
2026-04-23 04:39:09.549745 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml
2026-04-23 04:39:09.640689 | controller | INFO     [upload-helm-chart > syntax] Executed: Successful
2026-04-23 04:39:09.651155 | controller | INFO     [upload-helm-chart > create] Executing
2026-04-23 04:39:09.652595 | controller | WARNING  [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-04-23 04:39:09.657909 | controller | INFO     [upload-helm-chart > prepare] Executing
2026-04-23 04:39:09.658180 | controller | WARNING  [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-04-23 04:39:09.663394 | controller | INFO     [upload-helm-chart > converge] Executing
2026-04-23 04:39:10.583761 | controller |
2026-04-23 04:39:10.583849 | controller | PLAY [Converge] ****************************************************************
2026-04-23 04:39:10.583980 | controller |
2026-04-23 04:39:10.584112 | controller | TASK [Gathering Facts] *********************************************************
2026-04-23 04:39:10.584238 | controller | Thursday 23 April 2026  04:39:10 +0000 (0:00:00.056)       0:00:00.056 ********
2026-04-23 04:39:11.896476 | 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-23 04:39:11.902842 | controller | ok: [controller]
2026-04-23 04:39:11.902954 | controller |
2026-04-23 04:39:11.903085 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-04-23 04:39:11.903212 | controller | Thursday 23 April 2026  04:39:11 +0000 (0:00:01.338)       0:00:01.394 ********
2026-04-23 04:39:11.988233 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-04-23 04:39:11.988439 | controller |
2026-04-23 04:39:11.988723 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-04-23 04:39:11.988985 | controller | Thursday 23 April 2026  04:39:11 +0000 (0:00:00.084)       0:00:01.479 ********
2026-04-23 04:39:12.756838 | controller | changed: [controller]
2026-04-23 04:39:12.756966 | controller |
2026-04-23 04:39:12.757181 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-04-23 04:39:12.757375 | controller | Thursday 23 April 2026  04:39:12 +0000 (0:00:00.768)       0:00:02.248 ********
2026-04-23 04:39:12.803354 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-04-23 04:39:12.803399 | controller |
2026-04-23 04:39:12.803409 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-04-23 04:39:12.803417 | controller | Thursday 23 April 2026  04:39:12 +0000 (0:00:00.046)       0:00:02.294 ********
2026-04-23 04:39:13.262738 | controller | changed: [controller]
2026-04-23 04:39:13.262781 | controller |
2026-04-23 04:39:13.262791 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-04-23 04:39:13.262800 | controller | Thursday 23 April 2026  04:39:13 +0000 (0:00:00.458)       0:00:02.753 ********
2026-04-23 04:39:14.428193 | controller | changed: [controller]
2026-04-23 04:39:14.428480 | controller |
2026-04-23 04:39:14.428756 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-04-23 04:39:14.429013 | controller | Thursday 23 April 2026  04:39:14 +0000 (0:00:01.166)       0:00:03.920 ********
2026-04-23 04:39:14.864324 | controller | ok: [controller]
2026-04-23 04:39:14.864627 | controller |
2026-04-23 04:39:14.864918 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-04-23 04:39:14.865184 | controller | Thursday 23 April 2026  04:39:14 +0000 (0:00:00.435)       0:00:04.355 ********
2026-04-23 04:39:14.918843 | controller | skipping: [controller]
2026-04-23 04:39:14.919149 | controller |
2026-04-23 04:39:14.919423 | controller | PLAY RECAP *********************************************************************
2026-04-23 04:39:14.919718 | controller | controller                 : ok=7    changed=3    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-04-23 04:39:14.919969 | controller |
2026-04-23 04:39:14.920213 | controller |
2026-04-23 04:39:14.920480 | controller | TASKS RECAP ********************************************************************
2026-04-23 04:39:14.920747 | controller | Thursday 23 April 2026  04:39:14 +0000 (0:00:00.055)       0:00:04.411 ********
2026-04-23 04:39:14.920998 | controller | ===============================================================================
2026-04-23 04:39:14.921258 | controller | Gathering Facts --------------------------------------------------------- 1.34s
2026-04-23 04:39:14.921620 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.17s
2026-04-23 04:39:14.921956 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.77s
2026-04-23 04:39:14.922246 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.46s
2026-04-23 04:39:14.922575 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.44s
2026-04-23 04:39:14.922865 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-04-23 04:39:14.923142 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.06s
2026-04-23 04:39:14.923413 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-04-23 04:39:15.024795 | controller | INFO     [upload-helm-chart > converge] Executed: Successful
2026-04-23 04:39:15.034993 | controller | INFO     [upload-helm-chart > idempotence] Executing
2026-04-23 04:39:15.891534 | controller |
2026-04-23 04:39:15.891761 | controller | PLAY [Converge] ****************************************************************
2026-04-23 04:39:15.891957 | controller |
2026-04-23 04:39:15.892171 | controller | TASK [Gathering Facts] *********************************************************
2026-04-23 04:39:15.892387 | controller | Thursday 23 April 2026  04:39:15 +0000 (0:00:00.011)       0:00:00.011 ********
2026-04-23 04:39:16.915670 | 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-23 04:39:16.921276 | controller | ok: [controller]
2026-04-23 04:39:16.921449 | controller |
2026-04-23 04:39:16.921711 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-04-23 04:39:16.921922 | controller | Thursday 23 April 2026  04:39:16 +0000 (0:00:01.030)       0:00:01.041 ********
2026-04-23 04:39:16.992589 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-04-23 04:39:16.992699 | controller |
2026-04-23 04:39:16.992913 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-04-23 04:39:16.993118 | controller | Thursday 23 April 2026  04:39:16 +0000 (0:00:00.071)       0:00:01.113 ********
2026-04-23 04:39:17.735496 | controller | ok: [controller]
2026-04-23 04:39:17.735640 | controller |
2026-04-23 04:39:17.735937 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-04-23 04:39:17.736160 | controller | Thursday 23 April 2026  04:39:17 +0000 (0:00:00.742)       0:00:01.855 ********
2026-04-23 04:39:17.772408 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-04-23 04:39:17.772649 | controller |
2026-04-23 04:39:17.772862 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-04-23 04:39:17.773059 | controller | Thursday 23 April 2026  04:39:17 +0000 (0:00:00.037)       0:00:01.892 ********
2026-04-23 04:39:18.178866 | controller | ok: [controller]
2026-04-23 04:39:18.179052 | controller |
2026-04-23 04:39:18.179310 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-04-23 04:39:18.179548 | controller | Thursday 23 April 2026  04:39:18 +0000 (0:00:00.405)       0:00:02.297 ********
2026-04-23 04:39:20.286712 | controller | ok: [controller]
2026-04-23 04:39:20.286788 | controller |
2026-04-23 04:39:20.286798 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-04-23 04:39:20.286805 | controller | Thursday 23 April 2026  04:39:20 +0000 (0:00:02.105)       0:00:04.403 ********
2026-04-23 04:39:20.702765 | controller | ok: [controller]
2026-04-23 04:39:20.702840 | controller |
2026-04-23 04:39:20.702850 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-04-23 04:39:20.702953 | controller | Thursday 23 April 2026  04:39:20 +0000 (0:00:00.418)       0:00:04.822 ********
2026-04-23 04:39:20.740774 | controller | skipping: [controller]
2026-04-23 04:39:20.740865 | controller |
2026-04-23 04:39:20.741007 | controller | PLAY RECAP *********************************************************************
2026-04-23 04:39:20.741176 | controller | controller                 : ok=7    changed=0    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-04-23 04:39:20.741286 | controller |
2026-04-23 04:39:20.741386 | controller |
2026-04-23 04:39:20.741508 | controller | TASKS RECAP ********************************************************************
2026-04-23 04:39:20.741642 | controller | Thursday 23 April 2026  04:39:20 +0000 (0:00:00.038)       0:00:04.861 ********
2026-04-23 04:39:20.741805 | controller | ===============================================================================
2026-04-23 04:39:20.741919 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 2.11s
2026-04-23 04:39:20.742039 | controller | Gathering Facts --------------------------------------------------------- 1.03s
2026-04-23 04:39:20.742166 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.74s
2026-04-23 04:39:20.742293 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.42s
2026-04-23 04:39:20.742417 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.41s
2026-04-23 04:39:20.742555 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s
2026-04-23 04:39:20.742696 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.04s
2026-04-23 04:39:20.742813 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s
2026-04-23 04:39:20.860823 | controller | INFO     [upload-helm-chart > idempotence] Executed: Successful
2026-04-23 04:39:20.871879 | controller | INFO     [upload-helm-chart > side_effect] Executing
2026-04-23 04:39:21.720662 | controller |
2026-04-23 04:39:21.720956 | controller | PLAY [Side effect] *************************************************************
2026-04-23 04:39:21.721172 | controller |
2026-04-23 04:39:21.721382 | controller | TASK [Gathering Facts] *********************************************************
2026-04-23 04:39:21.721655 | controller | Thursday 23 April 2026  04:39:21 +0000 (0:00:00.010)       0:00:00.010 ********
2026-04-23 04:39:22.802761 | 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-23 04:39:22.808377 | controller | ok: [controller]
2026-04-23 04:39:22.808574 | controller |
2026-04-23 04:39:22.808849 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-04-23 04:39:22.809149 | controller | Thursday 23 April 2026  04:39:22 +0000 (0:00:01.087)       0:00:01.098 ********
2026-04-23 04:39:22.887865 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-04-23 04:39:22.887974 | controller |
2026-04-23 04:39:22.888175 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-04-23 04:39:22.888366 | controller | Thursday 23 April 2026  04:39:22 +0000 (0:00:00.079)       0:00:01.178 ********
2026-04-23 04:39:23.669151 | controller | changed: [controller]
2026-04-23 04:39:23.669347 | controller |
2026-04-23 04:39:23.669670 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-04-23 04:39:23.669959 | controller | Thursday 23 April 2026  04:39:23 +0000 (0:00:00.780)       0:00:01.958 ********
2026-04-23 04:39:23.715838 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-04-23 04:39:23.715997 | controller |
2026-04-23 04:39:23.716202 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-04-23 04:39:23.716400 | controller | Thursday 23 April 2026  04:39:23 +0000 (0:00:00.047)       0:00:02.006 ********
2026-04-23 04:39:24.144606 | controller | ok: [controller]
2026-04-23 04:39:24.144797 | controller |
2026-04-23 04:39:24.145024 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-04-23 04:39:24.145229 | controller | Thursday 23 April 2026  04:39:24 +0000 (0:00:00.428)       0:00:02.434 ********
2026-04-23 04:39:25.275552 | controller | ok: [controller]
2026-04-23 04:39:25.275590 | controller |
2026-04-23 04:39:25.275600 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-04-23 04:39:25.275608 | controller | Thursday 23 April 2026  04:39:25 +0000 (0:00:01.130)       0:00:03.565 ********
2026-04-23 04:39:25.702033 | controller | ok: [controller]
2026-04-23 04:39:25.702079 | controller |
2026-04-23 04:39:25.702930 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-04-23 04:39:25.702946 | controller | Thursday 23 April 2026  04:39:25 +0000 (0:00:00.423)       0:00:03.988 ********
2026-04-23 04:39:26.014484 | controller | changed: [controller] => (item=/file)
2026-04-23 04:39:26.014776 | controller |
2026-04-23 04:39:26.015034 | controller | PLAY RECAP *********************************************************************
2026-04-23 04:39:26.015332 | controller | controller                 : ok=8    changed=2    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-04-23 04:39:26.015565 | controller |
2026-04-23 04:39:26.015786 | controller |
2026-04-23 04:39:26.016050 | controller | TASKS RECAP ********************************************************************
2026-04-23 04:39:26.016319 | controller | Thursday 23 April 2026  04:39:26 +0000 (0:00:00.315)       0:00:04.304 ********
2026-04-23 04:39:26.016553 | controller | ===============================================================================
2026-04-23 04:39:26.016805 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.13s
2026-04-23 04:39:26.017043 | controller | Gathering Facts --------------------------------------------------------- 1.09s
2026-04-23 04:39:26.017284 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.78s
2026-04-23 04:39:26.017565 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.43s
2026-04-23 04:39:26.017849 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.42s
2026-04-23 04:39:26.018104 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.32s
2026-04-23 04:39:26.018352 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-04-23 04:39:26.018596 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-04-23 04:39:26.133027 | controller | INFO     [upload-helm-chart > side_effect] Executed: Successful
2026-04-23 04:39:26.143944 | controller | INFO     [upload-helm-chart > verify] Executing
2026-04-23 04:39:27.034902 | controller |
2026-04-23 04:39:27.035069 | controller | PLAY [Verify] ******************************************************************
2026-04-23 04:39:27.035176 | controller |
2026-04-23 04:39:27.035287 | controller | TASK [Gathering Facts] *********************************************************
2026-04-23 04:39:27.035399 | controller | Thursday 23 April 2026  04:39:27 +0000 (0:00:00.009)       0:00:00.009 ********
2026-04-23 04:39:29.072883 | 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-23 04:39:29.077730 | controller | ok: [controller]
2026-04-23 04:39:29.077972 | controller |
2026-04-23 04:39:29.078214 | controller | TASK [Stat file 1] *************************************************************
2026-04-23 04:39:29.078455 | controller | Thursday 23 April 2026  04:39:29 +0000 (0:00:02.043)       0:00:02.053 ********
2026-04-23 04:39:29.467789 | controller | ok: [controller]
2026-04-23 04:39:29.468062 | controller |
2026-04-23 04:39:29.468352 | controller | TASK [Stat file 2] *************************************************************
2026-04-23 04:39:29.468603 | controller | Thursday 23 April 2026  04:39:29 +0000 (0:00:00.388)       0:00:02.442 ********
2026-04-23 04:39:29.762236 | controller | ok: [controller]
2026-04-23 04:39:29.762498 | controller |
2026-04-23 04:39:29.762753 | controller | TASK [Stat removed file 1] *****************************************************
2026-04-23 04:39:29.763043 | controller | Thursday 23 April 2026  04:39:29 +0000 (0:00:00.294)       0:00:02.737 ********
2026-04-23 04:39:30.037118 | controller | ok: [controller]
2026-04-23 04:39:30.037333 | controller |
2026-04-23 04:39:30.037497 | controller | TASK [Stat removed file 2] *****************************************************
2026-04-23 04:39:30.037740 | controller | Thursday 23 April 2026  04:39:30 +0000 (0:00:00.275)       0:00:03.012 ********
2026-04-23 04:39:30.331854 | controller | ok: [controller]
2026-04-23 04:39:30.332133 | controller |
2026-04-23 04:39:30.332390 | controller | TASK [ansible.builtin.assert] **************************************************
2026-04-23 04:39:30.332644 | controller | Thursday 23 April 2026  04:39:30 +0000 (0:00:00.294)       0:00:03.307 ********
2026-04-23 04:39:30.366285 | controller | ok: [controller] => {
2026-04-23 04:39:30.366472 | controller |     "changed": false,
2026-04-23 04:39:30.366673 | controller |     "msg": "All assertions passed"
2026-04-23 04:39:30.366815 | controller | }
2026-04-23 04:39:30.368496 | controller |
2026-04-23 04:39:30.368526 | controller | PLAY RECAP *********************************************************************
2026-04-23 04:39:30.368533 | controller | controller                 : ok=6    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-04-23 04:39:30.368538 | controller |
2026-04-23 04:39:30.368551 | controller |
2026-04-23 04:39:30.368556 | controller | TASKS RECAP ********************************************************************
2026-04-23 04:39:30.368561 | controller | Thursday 23 April 2026  04:39:30 +0000 (0:00:00.031)       0:00:03.339 ********
2026-04-23 04:39:30.368566 | controller | ===============================================================================
2026-04-23 04:39:30.368571 | controller | Gathering Facts --------------------------------------------------------- 2.04s
2026-04-23 04:39:30.368576 | controller | Stat file 1 ------------------------------------------------------------- 0.39s
2026-04-23 04:39:30.368581 | controller | Stat file 2 ------------------------------------------------------------- 0.29s
2026-04-23 04:39:30.368585 | controller | Stat removed file 2 ----------------------------------------------------- 0.29s
2026-04-23 04:39:30.368590 | controller | Stat removed file 1 ----------------------------------------------------- 0.28s
2026-04-23 04:39:30.368595 | controller | ansible.builtin.assert -------------------------------------------------- 0.03s
2026-04-23 04:39:30.472501 | controller | INFO     [upload-helm-chart > verify] Executed: Successful
2026-04-23 04:39:30.483153 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-04-23 04:39:30.483639 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-04-23 04:39:30.490060 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-04-23 04:39:30.490153 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-04-23 04:39:30.490266 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-04-23 04:39:30.490543 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-04-23 04:39:31.002215 | controller | ok: Runtime: 0:00:39.797559
2026-04-23 04:39:31.006429 | 
2026-04-23 04:39:31.006519 | PLAY RECAP
2026-04-23 04:39:31.006576 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-23 04:39:31.006608 | 
2026-04-23 04:39:31.149971 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-04-23 04:39:31.151966 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-04-23 04:39:31.816851 | 
2026-04-23 04:39:31.817030 | PLAY [all]
2026-04-23 04:39:31.829917 | 
2026-04-23 04:39:31.830068 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-04-23 04:39:32.240708 | controller | changed
2026-04-23 04:39:32.247029 | 
2026-04-23 04:39:32.247139 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-04-23 04:39:32.660809 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-23 04:39:32.661450 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-23 04:39:32.668538 | controller | environment: line 1: kubectl: command not found
2026-04-23 04:39:32.669531 | controller | environment: line 1: kubectl: command not found
2026-04-23 04:39:32.670656 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-23 04:39:32.670822 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-23 04:39:32.673670 | controller | environment: line 1: kubectl: command not found
2026-04-23 04:39:32.674625 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-23 04:39:32.675205 | controller | environment: line 1: kubectl: command not found
2026-04-23 04:39:32.677286 | controller | environment: line 1: kubectl: command not found
2026-04-23 04:39:32.677319 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-23 04:39:32.678736 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-23 04:39:32.776188 | controller | ok: Runtime: 0:00:00.031377
2026-04-23 04:39:32.783120 | 
2026-04-23 04:39:32.783273 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-04-23 04:39:33.005429 | controller | changed
2026-04-23 04:39:33.011384 | 
2026-04-23 04:39:33.011519 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-04-23 04:39:33.253701 | controller | environment: line 5: kubectl: command not found
2026-04-23 04:39:33.254836 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-23 04:39:33.255055 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-23 04:39:33.255358 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-23 04:39:33.543505 | controller | ok: Runtime: 0:00:00.017373
2026-04-23 04:39:33.551399 | 
2026-04-23 04:39:33.551552 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-04-23 04:39:34.343473 | controller | changed:
2026-04-23 04:39:34.343681 | controller | created directory /var/lib/zuul/builds/247438141a1f472ea1f3f0d2863aa4a4/work/logs/controller
2026-04-23 04:39:34.343735 | controller | cd+++++++++ objects/
2026-04-23 04:39:34.343773 | controller | cd+++++++++ objects/cluster/
2026-04-23 04:39:34.343808 | controller | cd+++++++++ objects/namespaced/
2026-04-23 04:39:34.355596 | 
2026-04-23 04:39:34.355766 | TASK [gather-pod-logs : creating directory for pod logs]
2026-04-23 04:39:34.609031 | controller | changed
2026-04-23 04:39:34.614835 | 
2026-04-23 04:39:34.614967 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-04-23 04:39:34.838546 | controller | changed
2026-04-23 04:39:34.844828 | 
2026-04-23 04:39:34.845004 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-04-23 04:39:35.092270 | controller | environment: line 3: kubectl: command not found
2026-04-23 04:39:35.377901 | controller | ok: Runtime: 0:00:00.012792
2026-04-23 04:39:35.384055 | 
2026-04-23 04:39:35.384194 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-04-23 04:39:35.939296 | controller | changed:
2026-04-23 04:39:35.939479 | controller | cd+++++++++ pod-logs/
2026-04-23 04:39:35.939512 | controller | cd+++++++++ pod-logs/failed-pods/
2026-04-23 04:39:35.949302 | 
2026-04-23 04:39:35.949446 | LOOP [helm-release-status : creating directory for helm release status]
2026-04-23 04:39:36.184520 | controller | changed: "values"
2026-04-23 04:39:36.414028 | controller | changed: "releases"
2026-04-23 04:39:36.422866 | 
2026-04-23 04:39:36.423023 | TASK [helm-release-status : Gather get release status for helm charts]
2026-04-23 04:39:36.669143 | controller | /bin/bash: line 3: kubectl: command not found
2026-04-23 04:39:36.959062 | controller | ok: Runtime: 0:00:00.009922
2026-04-23 04:39:36.965499 | 
2026-04-23 04:39:36.965626 | TASK [helm-release-status : Downloads logs to executor]
2026-04-23 04:39:37.495168 | controller | changed:
2026-04-23 04:39:37.495452 | controller | cd+++++++++ helm/
2026-04-23 04:39:37.495498 | controller | cd+++++++++ helm/releases/
2026-04-23 04:39:37.495536 | controller | cd+++++++++ helm/values/
2026-04-23 04:39:37.504088 | 
2026-04-23 04:39:37.504253 | PLAY RECAP
2026-04-23 04:39:37.504335 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-23 04:39:37.504376 | 
2026-04-23 04:39:37.745178 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-04-23 04:39:37.746826 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-23 04:39:38.520272 | 
2026-04-23 04:39:38.520430 | PLAY [all]
2026-04-23 04:39:38.532115 | 
2026-04-23 04:39:38.532250 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-23 04:39:38.576893 | controller | skipping: Conditional result was False
2026-04-23 04:39:38.583942 | 
2026-04-23 04:39:38.584159 | TASK [fetch-output : Set log path for single node]
2026-04-23 04:39:38.625633 | controller | ok
2026-04-23 04:39:38.631360 | 
2026-04-23 04:39:38.631485 | LOOP [fetch-output : Ensure local output dirs]
2026-04-23 04:39:39.044616 | controller -> localhost | ok: "/var/lib/zuul/builds/247438141a1f472ea1f3f0d2863aa4a4/work/logs"
2026-04-23 04:39:39.315037 | controller -> localhost | changed: "/var/lib/zuul/builds/247438141a1f472ea1f3f0d2863aa4a4/work/artifacts"
2026-04-23 04:39:39.583150 | controller -> localhost | changed: "/var/lib/zuul/builds/247438141a1f472ea1f3f0d2863aa4a4/work/docs"
2026-04-23 04:39:39.602528 | 
2026-04-23 04:39:39.602666 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-23 04:39:40.320122 | controller | changed: .d..t...... ./
2026-04-23 04:39:40.320369 | controller | changed: All items complete
2026-04-23 04:39:40.320409 | 
2026-04-23 04:39:40.828285 | controller | changed: .d..t...... ./
2026-04-23 04:39:41.398161 | controller | changed: .d..t...... ./
2026-04-23 04:39:41.420635 | 
2026-04-23 04:39:41.421210 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-23 04:39:41.930043 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007488
2026-04-23 04:39:42.205321 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006476
2026-04-23 04:39:42.224289 | 
2026-04-23 04:39:42.224431 | PLAY [all]
2026-04-23 04:39:42.232577 | 
2026-04-23 04:39:42.232769 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-23 04:39:42.760887 | controller | changed
2026-04-23 04:39:42.767101 | 
2026-04-23 04:39:42.767185 | PLAY RECAP
2026-04-23 04:39:42.767240 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-23 04:39:42.767270 | 
2026-04-23 04:39:42.903311 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-23 04:39:42.905516 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-23 04:39:43.503540 | 
2026-04-23 04:39:43.503693 | PLAY [localhost]
2026-04-23 04:39:43.514264 | 
2026-04-23 04:39:43.514518 | TASK [Generate Zuul manifest]
2026-04-23 04:39:43.536131 | localhost | ok
2026-04-23 04:39:43.554949 | 
2026-04-23 04:39:43.555109 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-23 04:39:43.884372 | localhost | changed
2026-04-23 04:39:43.896914 | 
2026-04-23 04:39:43.897096 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-23 04:39:43.926082 | localhost | ok
2026-04-23 04:39:43.935328 | 
2026-04-23 04:39:43.935465 | TASK [Upload logs]
2026-04-23 04:39:43.954300 | localhost | ok
2026-04-23 04:39:44.036683 | 
2026-04-23 04:39:44.036841 | TASK [Set zuul-log-path fact]
2026-04-23 04:39:44.057143 | localhost | ok
2026-04-23 04:39:44.071811 | 
2026-04-23 04:39:44.071940 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-23 04:39:44.101887 | localhost | ok
2026-04-23 04:39:44.110401 | 
2026-04-23 04:39:44.110522 | TASK [upload-logs : Create log directories]
2026-04-23 04:39:44.535813 | localhost | changed
2026-04-23 04:39:44.543187 | 
2026-04-23 04:39:44.543338 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-23 04:39:44.969054 | localhost -> localhost | ok: Runtime: 0:00:00.004505
2026-04-23 04:39:44.975913 | 
2026-04-23 04:39:44.976048 | TASK [upload-logs : Upload logs to log server]
2026-04-23 04:39:45.506563 | localhost | Output suppressed because no_log was given
2026-04-23 04:39:45.511518 | 
2026-04-23 04:39:45.511623 | LOOP [upload-logs : Compress console log and json output]
2026-04-23 04:39:45.570051 | localhost | skipping: Conditional result was False
2026-04-23 04:39:45.580247 | localhost | skipping: Conditional result was False
2026-04-23 04:39:45.594716 | 
2026-04-23 04:39:45.594847 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-23 04:39:45.640016 | localhost | skipping: Conditional result was False
2026-04-23 04:39:45.640341 | 
2026-04-23 04:39:45.647773 | localhost | skipping: Conditional result was False
2026-04-23 04:39:45.661406 | 
2026-04-23 04:39:45.661603 | LOOP [upload-logs : Upload console log and json output]