2026-03-31 00:35:17.229817 | Job console starting
2026-03-31 00:35:17.243096 | Updating git repos
2026-03-31 00:35:17.282283 | Cloning repos into workspace
2026-03-31 00:35:17.348912 | Restoring repo states
2026-03-31 00:35:17.362938 | Merging changes
2026-03-31 00:35:18.139282 | Checking out repos
2026-03-31 00:35:18.349746 | Preparing playbooks
2026-03-31 00:35:26.928445 | Running Ansible setup
2026-03-31 00:35:30.847564 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-31 00:35:31.558457 | 
2026-03-31 00:35:31.558597 | PLAY [localhost]
2026-03-31 00:35:31.566863 | 
2026-03-31 00:35:31.566937 | TASK [Gathering Facts]
2026-03-31 00:35:32.529645 | localhost | ok
2026-03-31 00:35:32.540585 | 
2026-03-31 00:35:32.599532 | TASK [Setup log path fact]
2026-03-31 00:35:32.631116 | localhost | ok
2026-03-31 00:35:32.650951 | 
2026-03-31 00:35:32.651104 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-31 00:35:32.686606 | localhost | ok
2026-03-31 00:35:32.702282 | 
2026-03-31 00:35:32.702415 | TASK [emit-job-header : Print job information]
2026-03-31 00:35:32.751542 | # Job Information
2026-03-31 00:35:32.751770 | Ansible Version: 2.16.16
2026-03-31 00:35:32.751816 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart
2026-03-31 00:35:32.751850 | Pipeline: check
2026-03-31 00:35:32.751879 | Executor: 0a8996d2b663
2026-03-31 00:35:32.751906 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/249
2026-03-31 00:35:32.751938 | Event ID: 61500a90-2c99-11f1-8b8a-3f95ba85df2f
2026-03-31 00:35:32.756227 | 
2026-03-31 00:35:32.756328 | LOOP [emit-job-header : Print node information]
2026-03-31 00:35:32.845344 | localhost | ok:
2026-03-31 00:35:32.845541 | localhost | # Node Information
2026-03-31 00:35:32.845572 | localhost | Inventory Hostname: controller
2026-03-31 00:35:32.845595 | localhost | Hostname: np0000161794
2026-03-31 00:35:32.845617 | localhost | Username: zuul
2026-03-31 00:35:32.845642 | localhost | Distro: Debian 13.4
2026-03-31 00:35:32.845663 | localhost | Provider: yul1
2026-03-31 00:35:32.845684 | localhost | Region: ca-ymq-1
2026-03-31 00:35:32.845704 | localhost | Label: debian-trixie
2026-03-31 00:35:32.845724 | localhost | Product Name: OpenStack Nova
2026-03-31 00:35:32.845743 | localhost | Interface IP: 162.253.55.221
2026-03-31 00:35:32.855558 | 
2026-03-31 00:35:32.855757 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-03-31 00:35:33.372389 | localhost -> localhost | changed
2026-03-31 00:35:33.383305 | 
2026-03-31 00:35:33.383499 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-03-31 00:35:34.474995 | localhost -> localhost | changed
2026-03-31 00:35:34.486956 | 
2026-03-31 00:35:34.487016 | PLAY [all]
2026-03-31 00:35:34.496662 | 
2026-03-31 00:35:34.572112 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-31 00:35:34.803700 | controller -> localhost | ok
2026-03-31 00:35:34.815801 | 
2026-03-31 00:35:34.815897 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-31 00:35:34.846422 | controller | ok
2026-03-31 00:35:34.939594 | controller | included: /var/lib/zuul/builds/b24afae4bec8445993815c52a235af17/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-31 00:35:34.948447 | 
2026-03-31 00:35:34.948702 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-31 00:35:35.655323 | controller -> localhost | Generating public/private rsa key pair.
2026-03-31 00:35:35.726660 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/b24afae4bec8445993815c52a235af17/work/b24afae4bec8445993815c52a235af17_id_rsa
2026-03-31 00:35:35.726858 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/b24afae4bec8445993815c52a235af17/work/b24afae4bec8445993815c52a235af17_id_rsa.pub
2026-03-31 00:35:35.726929 | controller -> localhost | The key fingerprint is:
2026-03-31 00:35:35.726968 | controller -> localhost | SHA256:uklb0hZ2bxph6PLQ/fEh/NdvZYt04dFGcnw0eVB42Z0 zuul-build-sshkey
2026-03-31 00:35:35.727043 | controller -> localhost | The key's randomart image is:
2026-03-31 00:35:35.727106 | controller -> localhost | +---[RSA 3072]----+
2026-03-31 00:35:35.727178 | controller -> localhost | |              .BO|
2026-03-31 00:35:35.727217 | controller -> localhost | |              oE@|
2026-03-31 00:35:35.727277 | controller -> localhost | |               =+|
2026-03-31 00:35:35.727329 | controller -> localhost | |         .     oo|
2026-03-31 00:35:35.727368 | controller -> localhost | |        S +   ..o|
2026-03-31 00:35:35.727421 | controller -> localhost | |       * = + . oo|
2026-03-31 00:35:35.727457 | controller -> localhost | |      * * o B +.+|
2026-03-31 00:35:35.727512 | controller -> localhost | |     . @   = * o+|
2026-03-31 00:35:35.727590 | controller -> localhost | |      + . . . ooo|
2026-03-31 00:35:35.727627 | controller -> localhost | +----[SHA256]-----+
2026-03-31 00:35:35.727798 | controller -> localhost | ok: Runtime: 0:00:00.244438
2026-03-31 00:35:35.736023 | 
2026-03-31 00:35:35.736126 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-31 00:35:35.766900 | controller | ok
2026-03-31 00:35:35.776423 | controller | included: /var/lib/zuul/builds/b24afae4bec8445993815c52a235af17/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-31 00:35:35.783921 | 
2026-03-31 00:35:35.783988 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-31 00:35:35.808575 | controller | skipping: Conditional result was False
2026-03-31 00:35:35.819317 | 
2026-03-31 00:35:35.819410 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-31 00:35:36.382874 | controller | changed
2026-03-31 00:35:36.390814 | 
2026-03-31 00:35:36.390902 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-31 00:35:36.615264 | controller | ok
2026-03-31 00:35:36.627883 | 
2026-03-31 00:35:36.628451 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-31 00:35:37.198462 | controller | changed
2026-03-31 00:35:37.203307 | 
2026-03-31 00:35:37.203375 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-31 00:35:37.734364 | controller | changed
2026-03-31 00:35:37.741107 | 
2026-03-31 00:35:37.741264 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-31 00:35:37.766840 | controller | skipping: Conditional result was False
2026-03-31 00:35:37.932604 | 
2026-03-31 00:35:37.932795 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-31 00:35:38.425853 | controller -> localhost | changed
2026-03-31 00:35:38.438682 | 
2026-03-31 00:35:38.438764 | TASK [add-build-sshkey : Add back temp key]
2026-03-31 00:35:38.850173 | controller -> localhost | Identity added: /var/lib/zuul/builds/b24afae4bec8445993815c52a235af17/work/b24afae4bec8445993815c52a235af17_id_rsa (zuul-build-sshkey)
2026-03-31 00:35:38.850435 | controller -> localhost | ok: Runtime: 0:00:00.016086
2026-03-31 00:35:38.856467 | 
2026-03-31 00:35:38.856635 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-31 00:35:39.205611 | controller | ok
2026-03-31 00:35:39.328332 | 
2026-03-31 00:35:39.328472 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-31 00:35:39.354190 | controller | skipping: Conditional result was False
2026-03-31 00:35:39.365378 | 
2026-03-31 00:35:39.365534 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-03-31 00:35:39.763258 | controller | ok
2026-03-31 00:35:39.768191 | 
2026-03-31 00:35:39.768258 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-03-31 00:35:40.848572 | controller | Output suppressed because no_log was given
2026-03-31 00:35:40.856541 | 
2026-03-31 00:35:40.856615 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-03-31 00:35:41.076658 | controller | ok: "logs"
2026-03-31 00:35:41.076905 | controller | ok: All items complete
2026-03-31 00:35:41.076947 | 
2026-03-31 00:35:41.253674 | controller | ok: "artifacts"
2026-03-31 00:35:41.431494 | controller | ok: "docs"
2026-03-31 00:35:41.634066 | 
2026-03-31 00:35:41.634229 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-03-31 00:35:41.837791 | controller | changed: "logs"
2026-03-31 00:35:42.020579 | controller | changed: "artifacts"
2026-03-31 00:35:42.207259 | controller | changed: "docs"
2026-03-31 00:35:42.223214 | 
2026-03-31 00:35:42.223442 | PLAY RECAP
2026-03-31 00:35:42.223926 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-03-31 00:35:42.224019 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-31 00:35:42.224070 | 
2026-03-31 00:35:42.446554 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-31 00:35:42.450197 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-31 00:35:43.100848 | 
2026-03-31 00:35:43.101028 | PLAY [all]
2026-03-31 00:35:43.118151 | 
2026-03-31 00:35:43.484187 | TASK [setup-uv : Extract archive]
2026-03-31 00:35:45.987205 | controller | changed
2026-03-31 00:35:45.993747 | 
2026-03-31 00:35:45.993828 | TASK [setup-uv : Print version]
2026-03-31 00:35:46.380250 | controller | uv 0.8.13
2026-03-31 00:35:46.541147 | controller | ok: Runtime: 0:00:00.013574
2026-03-31 00:35:46.561468 | 
2026-03-31 00:35:46.562523 | PLAY RECAP
2026-03-31 00:35:46.563122 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-31 00:35:46.563467 | 
2026-03-31 00:35:46.708680 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-31 00:35:46.711415 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-03-31 00:35:47.411504 | 
2026-03-31 00:35:47.411694 | PLAY [all]
2026-03-31 00:35:47.423303 | 
2026-03-31 00:35:47.423432 | TASK [Update apt cache]
2026-03-31 00:35:52.527998 | controller | ok
2026-03-31 00:35:52.536691 | 
2026-03-31 00:35:52.536850 | TASK [Disable firewalld]
2026-03-31 00:35:52.565703 | controller | skipping: Conditional result was False
2026-03-31 00:35:52.579163 | 
2026-03-31 00:35:52.579324 | TASK [Install "jq" for log collection]
2026-03-31 00:35:54.973209 | controller | changed
2026-03-31 00:35:54.975169 | 
2026-03-31 00:35:54.975649 | PLAY RECAP
2026-03-31 00:35:54.975704 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-03-31 00:35:54.975727 | 
2026-03-31 00:35:55.115695 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-03-31 00:35:55.117901 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-03-31 00:35:55.709923 | 
2026-03-31 00:35:55.710056 | PLAY [all]
2026-03-31 00:35:55.719828 | 
2026-03-31 00:35:55.719901 | TASK [Copy inventory file for Zuul]
2026-03-31 00:35:56.736403 | controller | changed
2026-03-31 00:35:56.741982 | 
2026-03-31 00:35:56.742057 | TASK [Switch "ansible_host" to private IP]
2026-03-31 00:35:57.113853 | controller | changed: 1 replacements made
2026-03-31 00:35:57.120890 | 
2026-03-31 00:35:57.124475 | TASK [Run Molecule scenario]
2026-03-31 00:35:57.686895 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-03-31 00:35:57.686965 | controller | Creating virtual environment at: .venv
2026-03-31 00:35:57.759733 | controller | Downloading pygments (1.2MiB)
2026-03-31 00:35:57.761095 | controller | Downloading ansible-core (2.3MiB)
2026-03-31 00:35:57.761272 | controller | Downloading cryptography (4.3MiB)
2026-03-31 00:35:57.939491 | controller |  Downloading cryptography
2026-03-31 00:35:57.981029 | controller |  Downloading pygments
2026-03-31 00:35:58.165297 | controller |  Downloading ansible-core
2026-03-31 00:35:58.213503 | controller | Installed 36 packages in 47ms
2026-03-31 00:35:58.925074 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-03-31 00:35:58.925148 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-03-31 00:35:59.788556 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-03-31 00:35:59.788624 | controller | INFO     default scenario not found, disabling shared state.
2026-03-31 00:35:59.788686 | controller | INFO     [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-03-31 00:35:59.788777 | controller | INFO     [upload-helm-chart > prerun] Performing prerun with role_name_check=0...
2026-03-31 00:36:17.876215 | controller | INFO     [upload-helm-chart > dependency] Executing
2026-03-31 00:36:17.876311 | controller | WARNING  [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml
2026-03-31 00:36:17.876320 | controller | WARNING  [upload-helm-chart > dependency] Missing collections requirements file: collections.yml
2026-03-31 00:36:17.876352 | controller | WARNING  [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-03-31 00:36:17.881303 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-03-31 00:36:17.881627 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-31 00:36:17.886921 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-03-31 00:36:17.886951 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-03-31 00:36:17.887001 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-03-31 00:36:17.892566 | controller | INFO     [upload-helm-chart > syntax] Executing
2026-03-31 00:36:18.753983 | controller |
2026-03-31 00:36:18.754180 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml
2026-03-31 00:36:18.811185 | controller | INFO     [upload-helm-chart > syntax] Executed: Successful
2026-03-31 00:36:18.821208 | controller | INFO     [upload-helm-chart > create] Executing
2026-03-31 00:36:18.822650 | controller | WARNING  [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-31 00:36:18.827838 | controller | INFO     [upload-helm-chart > prepare] Executing
2026-03-31 00:36:18.828104 | controller | WARNING  [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-31 00:36:18.833285 | controller | INFO     [upload-helm-chart > converge] Executing
2026-03-31 00:36:19.683391 | controller |
2026-03-31 00:36:19.683431 | controller | PLAY [Converge] ****************************************************************
2026-03-31 00:36:19.683440 | controller |
2026-03-31 00:36:19.683448 | controller | TASK [Gathering Facts] *********************************************************
2026-03-31 00:36:19.683457 | controller | Tuesday 31 March 2026  00:36:19 +0000 (0:00:00.029)       0:00:00.029 *********
2026-03-31 00:36:21.002451 | 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-31 00:36:21.003425 | controller | ok: [controller]
2026-03-31 00:36:21.003607 | controller |
2026-03-31 00:36:21.003908 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-31 00:36:21.004123 | controller | Tuesday 31 March 2026  00:36:20 +0000 (0:00:01.321)       0:00:01.351 *********
2026-03-31 00:36:21.083989 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-31 00:36:21.084143 | controller |
2026-03-31 00:36:21.084341 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-31 00:36:21.084527 | controller | Tuesday 31 March 2026  00:36:21 +0000 (0:00:00.080)       0:00:01.432 *********
2026-03-31 00:36:21.817564 | controller | changed: [controller]
2026-03-31 00:36:21.817670 | controller |
2026-03-31 00:36:21.817906 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-31 00:36:21.818104 | controller | Tuesday 31 March 2026  00:36:21 +0000 (0:00:00.732)       0:00:02.164 *********
2026-03-31 00:36:21.860143 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-31 00:36:21.860276 | controller |
2026-03-31 00:36:21.860537 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-31 00:36:21.860743 | controller | Tuesday 31 March 2026  00:36:21 +0000 (0:00:00.043)       0:00:02.208 *********
2026-03-31 00:36:22.269200 | controller | changed: [controller]
2026-03-31 00:36:22.269345 | controller |
2026-03-31 00:36:22.269589 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-31 00:36:22.269790 | controller | Tuesday 31 March 2026  00:36:22 +0000 (0:00:00.408)       0:00:02.616 *********
2026-03-31 00:36:23.444739 | controller | changed: [controller]
2026-03-31 00:36:23.444864 | controller |
2026-03-31 00:36:23.445073 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-31 00:36:23.445261 | controller | Tuesday 31 March 2026  00:36:23 +0000 (0:00:01.175)       0:00:03.791 *********
2026-03-31 00:36:23.852474 | controller | ok: [controller]
2026-03-31 00:36:23.852502 | controller |
2026-03-31 00:36:23.852512 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-31 00:36:23.852587 | controller | Tuesday 31 March 2026  00:36:23 +0000 (0:00:00.407)       0:00:04.199 *********
2026-03-31 00:36:23.902231 | controller | skipping: [controller]
2026-03-31 00:36:23.902309 | controller |
2026-03-31 00:36:23.902479 | controller | PLAY RECAP *********************************************************************
2026-03-31 00:36:23.902603 | controller | controller                 : ok=7    changed=3    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-03-31 00:36:23.902694 | controller |
2026-03-31 00:36:23.902785 | controller |
2026-03-31 00:36:23.902892 | controller | TASKS RECAP ********************************************************************
2026-03-31 00:36:23.903000 | controller | Tuesday 31 March 2026  00:36:23 +0000 (0:00:00.051)       0:00:04.250 *********
2026-03-31 00:36:23.903098 | controller | ===============================================================================
2026-03-31 00:36:23.903199 | controller | Gathering Facts --------------------------------------------------------- 1.32s
2026-03-31 00:36:23.903307 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.18s
2026-03-31 00:36:23.903411 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.73s
2026-03-31 00:36:23.903528 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.41s
2026-03-31 00:36:23.903618 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.41s
2026-03-31 00:36:23.903726 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-03-31 00:36:23.903836 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.05s
2026-03-31 00:36:23.903984 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s
2026-03-31 00:36:24.036822 | controller | INFO     [upload-helm-chart > converge] Executed: Successful
2026-03-31 00:36:24.045594 | controller | INFO     [upload-helm-chart > idempotence] Executing
2026-03-31 00:36:24.857517 | controller |
2026-03-31 00:36:24.857661 | controller | PLAY [Converge] ****************************************************************
2026-03-31 00:36:24.857830 | controller |
2026-03-31 00:36:24.858023 | controller | TASK [Gathering Facts] *********************************************************
2026-03-31 00:36:24.858289 | controller | Tuesday 31 March 2026  00:36:24 +0000 (0:00:00.010)       0:00:00.011 *********
2026-03-31 00:36:25.931797 | 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-31 00:36:25.937775 | controller | ok: [controller]
2026-03-31 00:36:25.937964 | controller |
2026-03-31 00:36:25.938175 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-31 00:36:25.938375 | controller | Tuesday 31 March 2026  00:36:25 +0000 (0:00:01.080)       0:00:01.091 *********
2026-03-31 00:36:26.014122 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-31 00:36:26.014268 | controller |
2026-03-31 00:36:26.014510 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-31 00:36:26.014699 | controller | Tuesday 31 March 2026  00:36:26 +0000 (0:00:00.076)       0:00:01.167 *********
2026-03-31 00:36:26.761241 | controller | ok: [controller]
2026-03-31 00:36:26.761298 | controller |
2026-03-31 00:36:26.761412 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-31 00:36:26.761543 | controller | Tuesday 31 March 2026  00:36:26 +0000 (0:00:00.740)       0:00:01.907 *********
2026-03-31 00:36:26.801839 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-31 00:36:26.802033 | controller |
2026-03-31 00:36:26.802211 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-31 00:36:26.802420 | controller | Tuesday 31 March 2026  00:36:26 +0000 (0:00:00.047)       0:00:01.955 *********
2026-03-31 00:36:27.250459 | controller | ok: [controller]
2026-03-31 00:36:27.250491 | controller |
2026-03-31 00:36:27.250497 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-31 00:36:27.250504 | controller | Tuesday 31 March 2026  00:36:27 +0000 (0:00:00.444)       0:00:02.400 *********
2026-03-31 00:36:28.341855 | controller | ok: [controller]
2026-03-31 00:36:28.341994 | controller |
2026-03-31 00:36:28.342197 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-31 00:36:28.342471 | controller | Tuesday 31 March 2026  00:36:28 +0000 (0:00:01.094)       0:00:03.494 *********
2026-03-31 00:36:28.760512 | controller | ok: [controller]
2026-03-31 00:36:28.760658 | controller |
2026-03-31 00:36:28.760890 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-31 00:36:28.761099 | controller | Tuesday 31 March 2026  00:36:28 +0000 (0:00:00.418)       0:00:03.913 *********
2026-03-31 00:36:28.806070 | controller | skipping: [controller]
2026-03-31 00:36:28.806167 | controller |
2026-03-31 00:36:28.806395 | controller | PLAY RECAP *********************************************************************
2026-03-31 00:36:28.806666 | controller | controller                 : ok=7    changed=0    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-03-31 00:36:28.806863 | controller |
2026-03-31 00:36:28.807000 | controller |
2026-03-31 00:36:28.807187 | controller | TASKS RECAP ********************************************************************
2026-03-31 00:36:28.807374 | controller | Tuesday 31 March 2026  00:36:28 +0000 (0:00:00.046)       0:00:03.959 *********
2026-03-31 00:36:28.807559 | controller | ===============================================================================
2026-03-31 00:36:28.807730 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.09s
2026-03-31 00:36:28.807911 | controller | Gathering Facts --------------------------------------------------------- 1.08s
2026-03-31 00:36:28.808094 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.74s
2026-03-31 00:36:28.808275 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.44s
2026-03-31 00:36:28.808460 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.42s
2026-03-31 00:36:28.808654 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-03-31 00:36:28.808840 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-03-31 00:36:28.809032 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.05s
2026-03-31 00:36:28.936605 | controller | INFO     [upload-helm-chart > idempotence] Executed: Successful
2026-03-31 00:36:28.946843 | controller | INFO     [upload-helm-chart > side_effect] Executing
2026-03-31 00:36:29.792180 | controller |
2026-03-31 00:36:29.792254 | controller | PLAY [Side effect] *************************************************************
2026-03-31 00:36:29.792410 | controller |
2026-03-31 00:36:29.792631 | controller | TASK [Gathering Facts] *********************************************************
2026-03-31 00:36:29.792818 | controller | Tuesday 31 March 2026  00:36:29 +0000 (0:00:00.011)       0:00:00.011 *********
2026-03-31 00:36:30.855547 | 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-31 00:36:30.862685 | controller | ok: [controller]
2026-03-31 00:36:30.862859 | controller |
2026-03-31 00:36:30.863070 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-31 00:36:30.863266 | controller | Tuesday 31 March 2026  00:36:30 +0000 (0:00:01.070)       0:00:01.081 *********
2026-03-31 00:36:30.936262 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-31 00:36:30.936418 | controller |
2026-03-31 00:36:30.936621 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-31 00:36:30.936812 | controller | Tuesday 31 March 2026  00:36:30 +0000 (0:00:00.073)       0:00:01.155 *********
2026-03-31 00:36:31.678986 | controller | changed: [controller]
2026-03-31 00:36:31.679027 | controller |
2026-03-31 00:36:31.679165 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-31 00:36:31.679284 | controller | Tuesday 31 March 2026  00:36:31 +0000 (0:00:00.740)       0:00:01.896 *********
2026-03-31 00:36:31.729260 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-31 00:36:31.729310 | controller |
2026-03-31 00:36:31.729614 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-31 00:36:31.729884 | controller | Tuesday 31 March 2026  00:36:31 +0000 (0:00:00.051)       0:00:01.947 *********
2026-03-31 00:36:32.197196 | controller | ok: [controller]
2026-03-31 00:36:32.197234 | controller |
2026-03-31 00:36:32.197244 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-31 00:36:32.197252 | controller | Tuesday 31 March 2026  00:36:32 +0000 (0:00:00.467)       0:00:02.415 *********
2026-03-31 00:36:34.327413 | controller | ok: [controller]
2026-03-31 00:36:34.327441 | controller |
2026-03-31 00:36:34.327447 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-31 00:36:34.327453 | controller | Tuesday 31 March 2026  00:36:34 +0000 (0:00:02.127)       0:00:04.542 *********
2026-03-31 00:36:34.731969 | controller | ok: [controller]
2026-03-31 00:36:34.731998 | controller |
2026-03-31 00:36:34.732004 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-31 00:36:34.732008 | controller | Tuesday 31 March 2026  00:36:34 +0000 (0:00:00.408)       0:00:04.950 *********
2026-03-31 00:36:35.041152 | controller | changed: [controller] => (item=/file)
2026-03-31 00:36:35.041203 | controller |
2026-03-31 00:36:35.041273 | controller | PLAY RECAP *********************************************************************
2026-03-31 00:36:35.042476 | controller | controller                 : ok=8    changed=2    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-03-31 00:36:35.042516 | controller |
2026-03-31 00:36:35.042520 | controller |
2026-03-31 00:36:35.042524 | controller | TASKS RECAP ********************************************************************
2026-03-31 00:36:35.042540 | controller | Tuesday 31 March 2026  00:36:35 +0000 (0:00:00.309)       0:00:05.260 *********
2026-03-31 00:36:35.042544 | controller | ===============================================================================
2026-03-31 00:36:35.042547 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 2.13s
2026-03-31 00:36:35.042551 | controller | Gathering Facts --------------------------------------------------------- 1.07s
2026-03-31 00:36:35.042554 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.74s
2026-03-31 00:36:35.042557 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.47s
2026-03-31 00:36:35.042561 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.41s
2026-03-31 00:36:35.042565 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.31s
2026-03-31 00:36:35.042569 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s
2026-03-31 00:36:35.042572 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-03-31 00:36:35.162749 | controller | INFO     [upload-helm-chart > side_effect] Executed: Successful
2026-03-31 00:36:35.173260 | controller | INFO     [upload-helm-chart > verify] Executing
2026-03-31 00:36:35.996160 | controller |
2026-03-31 00:36:35.996492 | controller | PLAY [Verify] ******************************************************************
2026-03-31 00:36:35.996724 | controller |
2026-03-31 00:36:35.996975 | controller | TASK [Gathering Facts] *********************************************************
2026-03-31 00:36:35.997221 | controller | Tuesday 31 March 2026  00:36:35 +0000 (0:00:00.009)       0:00:00.009 *********
2026-03-31 00:36:37.052318 | 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-31 00:36:37.057122 | controller | ok: [controller]
2026-03-31 00:36:37.057364 | controller |
2026-03-31 00:36:37.057610 | controller | TASK [Stat file 1] *************************************************************
2026-03-31 00:36:37.057876 | controller | Tuesday 31 March 2026  00:36:37 +0000 (0:00:01.061)       0:00:01.070 *********
2026-03-31 00:36:37.443110 | controller | ok: [controller]
2026-03-31 00:36:37.443244 | controller |
2026-03-31 00:36:37.443384 | controller | TASK [Stat file 2] *************************************************************
2026-03-31 00:36:37.443500 | controller | Tuesday 31 March 2026  00:36:37 +0000 (0:00:00.385)       0:00:01.456 *********
2026-03-31 00:36:37.731658 | controller | ok: [controller]
2026-03-31 00:36:37.732085 | controller |
2026-03-31 00:36:37.732353 | controller | TASK [Stat removed file 1] *****************************************************
2026-03-31 00:36:37.732605 | controller | Tuesday 31 March 2026  00:36:37 +0000 (0:00:00.288)       0:00:01.744 *********
2026-03-31 00:36:38.017862 | controller | ok: [controller]
2026-03-31 00:36:38.018142 | controller |
2026-03-31 00:36:38.018433 | controller | TASK [Stat removed file 2] *****************************************************
2026-03-31 00:36:38.018700 | controller | Tuesday 31 March 2026  00:36:38 +0000 (0:00:00.285)       0:00:02.030 *********
2026-03-31 00:36:38.315171 | controller | ok: [controller]
2026-03-31 00:36:38.315458 | controller |
2026-03-31 00:36:38.315721 | controller | TASK [ansible.builtin.assert] **************************************************
2026-03-31 00:36:38.316009 | controller | Tuesday 31 March 2026  00:36:38 +0000 (0:00:00.297)       0:00:02.328 *********
2026-03-31 00:36:38.347061 | controller | ok: [controller] => {
2026-03-31 00:36:38.350204 | controller |     "changed": false,
2026-03-31 00:36:38.350241 | controller |     "msg": "All assertions passed"
2026-03-31 00:36:38.350251 | controller | }
2026-03-31 00:36:38.350260 | controller |
2026-03-31 00:36:38.350268 | controller | PLAY RECAP *********************************************************************
2026-03-31 00:36:38.350277 | controller | controller                 : ok=6    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-03-31 00:36:38.350285 | controller |
2026-03-31 00:36:38.350302 | controller |
2026-03-31 00:36:38.350310 | controller | TASKS RECAP ********************************************************************
2026-03-31 00:36:38.350317 | controller | Tuesday 31 March 2026  00:36:38 +0000 (0:00:00.029)       0:00:02.358 *********
2026-03-31 00:36:38.350325 | controller | ===============================================================================
2026-03-31 00:36:38.350332 | controller | Gathering Facts --------------------------------------------------------- 1.06s
2026-03-31 00:36:38.350339 | controller | Stat file 1 ------------------------------------------------------------- 0.39s
2026-03-31 00:36:38.350346 | controller | Stat removed file 2 ----------------------------------------------------- 0.30s
2026-03-31 00:36:38.350353 | controller | Stat file 2 ------------------------------------------------------------- 0.29s
2026-03-31 00:36:38.350360 | controller | Stat removed file 1 ----------------------------------------------------- 0.29s
2026-03-31 00:36:38.350408 | controller | ansible.builtin.assert -------------------------------------------------- 0.03s
2026-03-31 00:36:38.445018 | controller | INFO     [upload-helm-chart > verify] Executed: Successful
2026-03-31 00:36:38.457096 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-03-31 00:36:38.457572 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-31 00:36:38.464430 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-03-31 00:36:38.464555 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-03-31 00:36:38.464641 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-03-31 00:36:38.464984 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-03-31 00:36:38.752762 | controller | ok: Runtime: 0:00:40.963785
2026-03-31 00:36:38.757675 | 
2026-03-31 00:36:38.757727 | PLAY RECAP
2026-03-31 00:36:38.757770 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-31 00:36:38.757792 | 
2026-03-31 00:36:38.883605 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-03-31 00:36:38.886300 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-03-31 00:36:39.480774 | 
2026-03-31 00:36:39.480899 | PLAY [all]
2026-03-31 00:36:39.491810 | 
2026-03-31 00:36:39.491892 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-03-31 00:36:39.889344 | controller | changed
2026-03-31 00:36:39.895403 | 
2026-03-31 00:36:39.895521 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-03-31 00:36:40.324840 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-31 00:36:40.325488 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-31 00:36:40.332687 | controller | environment: line 1: kubectl: command not found
2026-03-31 00:36:40.333087 | controller | environment: line 1: kubectl: command not found
2026-03-31 00:36:40.334774 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-31 00:36:40.335151 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-31 00:36:40.338874 | controller | environment: line 1: kubectl: command not found
2026-03-31 00:36:40.340628 | controller | environment: line 1: kubectl: command not found
2026-03-31 00:36:40.340643 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-31 00:36:40.340648 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-31 00:36:40.343151 | controller | environment: line 1: kubectl: command not found
2026-03-31 00:36:40.344504 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-31 00:36:40.425097 | controller | ok: Runtime: 0:00:00.033587
2026-03-31 00:36:40.432243 | 
2026-03-31 00:36:40.432339 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-03-31 00:36:40.667539 | controller | changed
2026-03-31 00:36:40.671822 | 
2026-03-31 00:36:40.671906 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-03-31 00:36:40.917153 | controller | environment: line 5: kubectl: command not found
2026-03-31 00:36:40.918529 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-31 00:36:40.919119 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-31 00:36:40.920297 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-31 00:36:41.202209 | controller | ok: Runtime: 0:00:00.011920
2026-03-31 00:36:41.211739 | 
2026-03-31 00:36:41.211896 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-03-31 00:36:41.879927 | controller | changed:
2026-03-31 00:36:41.880233 | controller | created directory /var/lib/zuul/builds/b24afae4bec8445993815c52a235af17/work/logs/controller
2026-03-31 00:36:41.880306 | controller | cd+++++++++ objects/
2026-03-31 00:36:41.880358 | controller | cd+++++++++ objects/cluster/
2026-03-31 00:36:41.880411 | controller | cd+++++++++ objects/namespaced/
2026-03-31 00:36:41.891826 | 
2026-03-31 00:36:41.891896 | TASK [gather-pod-logs : creating directory for pod logs]
2026-03-31 00:36:42.132620 | controller | changed
2026-03-31 00:36:42.138165 | 
2026-03-31 00:36:42.138257 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-03-31 00:36:42.392914 | controller | changed
2026-03-31 00:36:42.398306 | 
2026-03-31 00:36:42.398378 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-03-31 00:36:42.642802 | controller | environment: line 3: kubectl: command not found
2026-03-31 00:36:42.928384 | controller | ok: Runtime: 0:00:00.012255
2026-03-31 00:36:42.934411 | 
2026-03-31 00:36:42.934475 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-03-31 00:36:43.468718 | controller | changed:
2026-03-31 00:36:43.469059 | controller | cd+++++++++ pod-logs/
2026-03-31 00:36:43.469128 | controller | cd+++++++++ pod-logs/failed-pods/
2026-03-31 00:36:43.477747 | 
2026-03-31 00:36:43.477832 | LOOP [helm-release-status : creating directory for helm release status]
2026-03-31 00:36:43.707480 | controller | changed: "values"
2026-03-31 00:36:43.909894 | controller | changed: "releases"
2026-03-31 00:36:43.930300 | 
2026-03-31 00:36:43.930486 | TASK [helm-release-status : Gather get release status for helm charts]
2026-03-31 00:36:44.167308 | controller | /bin/bash: line 3: kubectl: command not found
2026-03-31 00:36:44.462092 | controller | ok: Runtime: 0:00:00.008568
2026-03-31 00:36:44.468141 | 
2026-03-31 00:36:44.468209 | TASK [helm-release-status : Downloads logs to executor]
2026-03-31 00:36:45.062570 | controller | changed:
2026-03-31 00:36:45.062842 | controller | cd+++++++++ helm/
2026-03-31 00:36:45.062929 | controller | cd+++++++++ helm/releases/
2026-03-31 00:36:45.062984 | controller | cd+++++++++ helm/values/
2026-03-31 00:36:45.070151 | 
2026-03-31 00:36:45.070204 | PLAY RECAP
2026-03-31 00:36:45.070247 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-31 00:36:45.070269 | 
2026-03-31 00:36:45.199442 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-03-31 00:36:45.202190 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-31 00:36:45.792052 | 
2026-03-31 00:36:45.792196 | PLAY [all]
2026-03-31 00:36:45.802524 | 
2026-03-31 00:36:45.802597 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-31 00:36:45.847592 | controller | skipping: Conditional result was False
2026-03-31 00:36:45.859232 | 
2026-03-31 00:36:45.859466 | TASK [fetch-output : Set log path for single node]
2026-03-31 00:36:45.902680 | controller | ok
2026-03-31 00:36:45.908178 | 
2026-03-31 00:36:45.908277 | LOOP [fetch-output : Ensure local output dirs]
2026-03-31 00:36:46.284575 | controller -> localhost | ok: "/var/lib/zuul/builds/b24afae4bec8445993815c52a235af17/work/logs"
2026-03-31 00:36:46.482467 | controller -> localhost | changed: "/var/lib/zuul/builds/b24afae4bec8445993815c52a235af17/work/artifacts"
2026-03-31 00:36:46.683426 | controller -> localhost | changed: "/var/lib/zuul/builds/b24afae4bec8445993815c52a235af17/work/docs"
2026-03-31 00:36:46.705794 | 
2026-03-31 00:36:46.705879 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-31 00:36:47.376128 | controller | changed: .d..t...... ./
2026-03-31 00:36:47.376340 | controller | changed: All items complete
2026-03-31 00:36:47.376368 | 
2026-03-31 00:36:47.864936 | controller | changed: .d..t...... ./
2026-03-31 00:36:48.344651 | controller | changed: .d..t...... ./
2026-03-31 00:36:48.363989 | 
2026-03-31 00:36:48.364083 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-03-31 00:36:48.781355 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007311
2026-03-31 00:36:49.016803 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007509
2026-03-31 00:36:49.036998 | 
2026-03-31 00:36:49.037145 | PLAY [all]
2026-03-31 00:36:49.044274 | 
2026-03-31 00:36:49.044367 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-03-31 00:36:49.526594 | controller | changed
2026-03-31 00:36:49.533541 | 
2026-03-31 00:36:49.533594 | PLAY RECAP
2026-03-31 00:36:49.533642 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-03-31 00:36:49.533664 | 
2026-03-31 00:36:49.677294 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-31 00:36:49.678717 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-03-31 00:36:50.262998 | 
2026-03-31 00:36:50.263127 | PLAY [localhost]
2026-03-31 00:36:50.272790 | 
2026-03-31 00:36:50.272866 | TASK [Generate Zuul manifest]
2026-03-31 00:36:50.291511 | localhost | ok
2026-03-31 00:36:50.306741 | 
2026-03-31 00:36:50.306842 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-03-31 00:36:50.662452 | localhost | changed
2026-03-31 00:36:50.679420 | 
2026-03-31 00:36:50.679708 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-03-31 00:36:50.723923 | localhost | ok
2026-03-31 00:36:50.733565 | 
2026-03-31 00:36:50.733658 | TASK [Upload logs]
2026-03-31 00:36:50.757568 | localhost | ok
2026-03-31 00:36:50.818523 | 
2026-03-31 00:36:50.818614 | TASK [Set zuul-log-path fact]
2026-03-31 00:36:50.841801 | localhost | ok
2026-03-31 00:36:50.855804 | 
2026-03-31 00:36:50.855869 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-31 00:36:50.888154 | localhost | ok
2026-03-31 00:36:50.897254 | 
2026-03-31 00:36:50.897344 | TASK [upload-logs : Create log directories]
2026-03-31 00:36:51.326614 | localhost | changed
2026-03-31 00:36:51.334091 | 
2026-03-31 00:36:51.334164 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-03-31 00:36:51.749757 | localhost -> localhost | ok: Runtime: 0:00:00.005603
2026-03-31 00:36:51.755351 | 
2026-03-31 00:36:51.755456 | TASK [upload-logs : Upload logs to log server]
2026-03-31 00:36:52.242246 | localhost | Output suppressed because no_log was given
2026-03-31 00:36:52.247291 | 
2026-03-31 00:36:52.247446 | LOOP [upload-logs : Compress console log and json output]
2026-03-31 00:36:52.298143 | localhost | skipping: Conditional result was False
2026-03-31 00:36:52.304852 | localhost | skipping: Conditional result was False
2026-03-31 00:36:52.317766 | 
2026-03-31 00:36:52.318055 | LOOP [upload-logs : Upload compressed console log and json output]
2026-03-31 00:36:52.360197 | localhost | skipping: Conditional result was False
2026-03-31 00:36:52.360577 | 
2026-03-31 00:36:52.364664 | localhost | skipping: Conditional result was False
2026-03-31 00:36:52.380991 | 
2026-03-31 00:36:52.381185 | LOOP [upload-logs : Upload console log and json output]