2026-03-30 20:39:39.057678 | Job console starting
2026-03-30 20:39:39.101813 | Updating git repos
2026-03-30 20:39:39.152866 | Cloning repos into workspace
2026-03-30 20:39:39.633703 | Restoring repo states
2026-03-30 20:39:39.648906 | Merging changes
2026-03-30 20:39:40.239726 | Checking out repos
2026-03-30 20:39:40.294658 | Preparing playbooks
2026-03-30 20:39:47.329342 | Running Ansible setup
2026-03-30 20:39:51.431032 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-30 20:39:52.038138 | 
2026-03-30 20:39:52.367185 | PLAY [localhost]
2026-03-30 20:39:52.384056 | 
2026-03-30 20:39:52.384141 | TASK [Gathering Facts]
2026-03-30 20:39:53.273647 | localhost | ok
2026-03-30 20:39:53.281353 | 
2026-03-30 20:39:53.281495 | TASK [Setup log path fact]
2026-03-30 20:39:53.302901 | localhost | ok
2026-03-30 20:39:53.359990 | 
2026-03-30 20:39:53.360133 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-30 20:39:53.397069 | localhost | ok
2026-03-30 20:39:53.404492 | 
2026-03-30 20:39:53.404560 | TASK [emit-job-header : Print job information]
2026-03-30 20:39:53.447103 | # Job Information
2026-03-30 20:39:53.448468 | Ansible Version: 2.16.16
2026-03-30 20:39:53.448538 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart
2026-03-30 20:39:53.448576 | Pipeline: check
2026-03-30 20:39:53.448607 | Executor: 0a8996d2b663
2026-03-30 20:39:53.448639 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/253
2026-03-30 20:39:53.448672 | Event ID: 72ab1b70-2c78-11f1-9d5c-027bdbc6d977
2026-03-30 20:39:53.454971 | 
2026-03-30 20:39:53.455041 | LOOP [emit-job-header : Print node information]
2026-03-30 20:39:53.541724 | localhost | ok:
2026-03-30 20:39:53.603352 | localhost | # Node Information
2026-03-30 20:39:53.603501 | localhost | Inventory Hostname: controller
2026-03-30 20:39:53.603559 | localhost | Hostname: np0000161638
2026-03-30 20:39:53.603605 | localhost | Username: zuul
2026-03-30 20:39:53.603656 | localhost | Distro: Debian 13.4
2026-03-30 20:39:53.603702 | localhost | Provider: yul1
2026-03-30 20:39:53.603744 | localhost | Region: ca-ymq-1
2026-03-30 20:39:53.603787 | localhost | Label: debian-trixie
2026-03-30 20:39:53.603828 | localhost | Product Name: OpenStack Nova
2026-03-30 20:39:53.603868 | localhost | Interface IP: 199.204.45.65
2026-03-30 20:39:53.617496 | 
2026-03-30 20:39:53.617674 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-03-30 20:39:54.027655 | localhost -> localhost | changed
2026-03-30 20:39:54.035234 | 
2026-03-30 20:39:54.035328 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-03-30 20:39:55.156611 | localhost -> localhost | changed
2026-03-30 20:39:55.168281 | 
2026-03-30 20:39:55.168337 | PLAY [all]
2026-03-30 20:39:55.175444 | 
2026-03-30 20:39:55.175517 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-30 20:39:55.425333 | controller -> localhost | ok
2026-03-30 20:39:55.434943 | 
2026-03-30 20:39:55.435048 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-30 20:39:55.458414 | controller | ok
2026-03-30 20:39:55.471784 | controller | included: /var/lib/zuul/builds/54f00d0b890047f5bdd9b21060ab7beb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-30 20:39:55.476638 | 
2026-03-30 20:39:55.476700 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-30 20:39:56.975916 | controller -> localhost | Generating public/private rsa key pair.
2026-03-30 20:39:56.976148 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/54f00d0b890047f5bdd9b21060ab7beb/work/54f00d0b890047f5bdd9b21060ab7beb_id_rsa
2026-03-30 20:39:56.976192 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/54f00d0b890047f5bdd9b21060ab7beb/work/54f00d0b890047f5bdd9b21060ab7beb_id_rsa.pub
2026-03-30 20:39:56.976226 | controller -> localhost | The key fingerprint is:
2026-03-30 20:39:56.976257 | controller -> localhost | SHA256:FnSZnxWCRqc0k9fMsJcoRC11ZwBvxKIgqadsiaQAmWU zuul-build-sshkey
2026-03-30 20:39:56.976304 | controller -> localhost | The key's randomart image is:
2026-03-30 20:39:56.976337 | controller -> localhost | +---[RSA 3072]----+
2026-03-30 20:39:56.976378 | controller -> localhost | | +E    ..oOB*B=oo|
2026-03-30 20:39:56.976411 | controller -> localhost | |+.    o..+B=+B*+ |
2026-03-30 20:39:56.976441 | controller -> localhost | |.    . ..oo=o+=  |
2026-03-30 20:39:56.976471 | controller -> localhost | |. . . .  ...oo   |
2026-03-30 20:39:56.976500 | controller -> localhost | |.o o +  S        |
2026-03-30 20:39:56.976529 | controller -> localhost | |. . =  .         |
2026-03-30 20:39:56.976558 | controller -> localhost | |   .             |
2026-03-30 20:39:56.976587 | controller -> localhost | |                 |
2026-03-30 20:39:56.976620 | controller -> localhost | |                 |
2026-03-30 20:39:56.976650 | controller -> localhost | +----[SHA256]-----+
2026-03-30 20:39:56.976720 | controller -> localhost | ok: Runtime: 0:00:00.826718
2026-03-30 20:39:56.983331 | 
2026-03-30 20:39:56.983416 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-30 20:39:57.018692 | controller | ok
2026-03-30 20:39:57.026749 | controller | included: /var/lib/zuul/builds/54f00d0b890047f5bdd9b21060ab7beb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-30 20:39:57.034557 | 
2026-03-30 20:39:57.034623 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-30 20:39:57.062522 | controller | skipping: Conditional result was False
2026-03-30 20:39:57.068601 | 
2026-03-30 20:39:57.068673 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-30 20:39:57.601049 | controller | changed
2026-03-30 20:39:57.668016 | 
2026-03-30 20:39:57.668134 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-30 20:39:57.881076 | controller | ok
2026-03-30 20:39:57.894796 | 
2026-03-30 20:39:57.894888 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-30 20:39:58.430224 | controller | changed
2026-03-30 20:39:58.436831 | 
2026-03-30 20:39:58.436931 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-30 20:39:58.953264 | controller | changed
2026-03-30 20:39:58.990024 | 
2026-03-30 20:39:58.990094 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-30 20:39:59.015652 | controller | skipping: Conditional result was False
2026-03-30 20:39:59.020366 | 
2026-03-30 20:39:59.020431 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-30 20:39:59.440552 | controller -> localhost | changed
2026-03-30 20:39:59.453442 | 
2026-03-30 20:39:59.453519 | TASK [add-build-sshkey : Add back temp key]
2026-03-30 20:39:59.729130 | controller -> localhost | Identity added: /var/lib/zuul/builds/54f00d0b890047f5bdd9b21060ab7beb/work/54f00d0b890047f5bdd9b21060ab7beb_id_rsa (zuul-build-sshkey)
2026-03-30 20:39:59.729383 | controller -> localhost | ok: Runtime: 0:00:00.013781
2026-03-30 20:39:59.735039 | 
2026-03-30 20:39:59.735127 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-30 20:40:00.118518 | controller | ok
2026-03-30 20:40:00.122681 | 
2026-03-30 20:40:00.122749 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-30 20:40:00.147342 | controller | skipping: Conditional result was False
2026-03-30 20:40:00.156894 | 
2026-03-30 20:40:00.157018 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-03-30 20:40:00.503811 | controller | ok
2026-03-30 20:40:00.510626 | 
2026-03-30 20:40:00.510694 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-03-30 20:40:01.537402 | controller | Output suppressed because no_log was given
2026-03-30 20:40:01.544596 | 
2026-03-30 20:40:01.544663 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-03-30 20:40:01.782410 | controller | ok: "logs"
2026-03-30 20:40:01.782786 | controller | ok: All items complete
2026-03-30 20:40:01.782853 | 
2026-03-30 20:40:01.969051 | controller | ok: "artifacts"
2026-03-30 20:40:02.143151 | controller | ok: "docs"
2026-03-30 20:40:02.161492 | 
2026-03-30 20:40:02.161648 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-03-30 20:40:02.372166 | controller | changed: "logs"
2026-03-30 20:40:02.551680 | controller | changed: "artifacts"
2026-03-30 20:40:02.749026 | controller | changed: "docs"
2026-03-30 20:40:02.769418 | 
2026-03-30 20:40:02.769557 | PLAY RECAP
2026-03-30 20:40:02.769625 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-03-30 20:40:02.769667 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-30 20:40:02.769697 | 
2026-03-30 20:40:02.913101 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-30 20:40:02.914651 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-30 20:40:03.496678 | 
2026-03-30 20:40:03.496812 | PLAY [all]
2026-03-30 20:40:03.507508 | 
2026-03-30 20:40:03.507589 | TASK [setup-uv : Extract archive]
2026-03-30 20:40:05.918644 | controller | changed
2026-03-30 20:40:05.926234 | 
2026-03-30 20:40:05.926330 | TASK [setup-uv : Print version]
2026-03-30 20:40:06.287317 | controller | uv 0.8.13
2026-03-30 20:40:06.453810 | controller | ok: Runtime: 0:00:00.008539
2026-03-30 20:40:06.458881 | 
2026-03-30 20:40:06.458931 | PLAY RECAP
2026-03-30 20:40:06.458976 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-30 20:40:06.459000 | 
2026-03-30 20:40:06.585459 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-30 20:40:06.586944 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-03-30 20:40:07.196528 | 
2026-03-30 20:40:07.196690 | PLAY [all]
2026-03-30 20:40:07.207461 | 
2026-03-30 20:40:07.207657 | TASK [Update apt cache]
2026-03-30 20:40:11.602963 | controller | ok
2026-03-30 20:40:11.608180 | 
2026-03-30 20:40:11.608251 | TASK [Disable firewalld]
2026-03-30 20:40:11.633096 | controller | skipping: Conditional result was False
2026-03-30 20:40:11.639766 | 
2026-03-30 20:40:11.639850 | TASK [Install "jq" for log collection]
2026-03-30 20:40:13.602097 | controller | changed
2026-03-30 20:40:13.604547 | 
2026-03-30 20:40:13.604596 | PLAY RECAP
2026-03-30 20:40:13.604641 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-03-30 20:40:13.604663 | 
2026-03-30 20:40:13.721771 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-03-30 20:40:13.724592 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-03-30 20:40:14.334471 | 
2026-03-30 20:40:14.585197 | PLAY [all]
2026-03-30 20:40:14.602035 | 
2026-03-30 20:40:14.602109 | TASK [Copy inventory file for Zuul]
2026-03-30 20:40:15.573478 | controller | changed
2026-03-30 20:40:15.579006 | 
2026-03-30 20:40:15.579083 | TASK [Switch "ansible_host" to private IP]
2026-03-30 20:40:15.897698 | controller | changed: 1 replacements made
2026-03-30 20:40:15.903544 | 
2026-03-30 20:40:15.903613 | TASK [Run Molecule scenario]
2026-03-30 20:40:16.354291 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-03-30 20:40:16.354352 | controller | Creating virtual environment at: .venv
2026-03-30 20:40:16.644843 | controller | Downloading ansible-core (2.3MiB)
2026-03-30 20:40:16.650668 | controller | Downloading pygments (1.2MiB)
2026-03-30 20:40:16.652705 | controller | Downloading cryptography (4.3MiB)
2026-03-30 20:40:16.819819 | controller |  Downloading cryptography
2026-03-30 20:40:16.878334 | controller |  Downloading pygments
2026-03-30 20:40:17.050841 | controller |  Downloading ansible-core
2026-03-30 20:40:17.098802 | controller | Installed 36 packages in 47ms
2026-03-30 20:40:17.760511 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-03-30 20:40:17.760570 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-03-30 20:40:18.604546 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-03-30 20:40:18.604602 | controller | INFO     default scenario not found, disabling shared state.
2026-03-30 20:40:18.604699 | controller | INFO     [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-03-30 20:40:18.604773 | controller | INFO     [upload-helm-chart > prerun] Performing prerun with role_name_check=0...
2026-03-30 20:40:34.878902 | controller | INFO     [upload-helm-chart > dependency] Executing
2026-03-30 20:40:34.878971 | controller | WARNING  [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml
2026-03-30 20:40:34.879092 | controller | WARNING  [upload-helm-chart > dependency] Missing collections requirements file: collections.yml
2026-03-30 20:40:34.879212 | controller | WARNING  [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-03-30 20:40:34.884631 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-03-30 20:40:34.884982 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-30 20:40:34.890255 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-03-30 20:40:34.890278 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-03-30 20:40:34.890293 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-03-30 20:40:34.895637 | controller | INFO     [upload-helm-chart > syntax] Executing
2026-03-30 20:40:35.774294 | controller |
2026-03-30 20:40:35.774441 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml
2026-03-30 20:40:35.847650 | controller | INFO     [upload-helm-chart > syntax] Executed: Successful
2026-03-30 20:40:35.857062 | controller | INFO     [upload-helm-chart > create] Executing
2026-03-30 20:40:35.859039 | controller | WARNING  [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-30 20:40:35.865426 | controller | INFO     [upload-helm-chart > prepare] Executing
2026-03-30 20:40:35.865672 | controller | WARNING  [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-30 20:40:35.871170 | controller | INFO     [upload-helm-chart > converge] Executing
2026-03-30 20:40:36.772838 | controller |
2026-03-30 20:40:36.772881 | controller | PLAY [Converge] ****************************************************************
2026-03-30 20:40:36.773100 | controller |
2026-03-30 20:40:36.773301 | controller | TASK [Gathering Facts] *********************************************************
2026-03-30 20:40:36.773502 | controller | Monday 30 March 2026  20:40:36 +0000 (0:00:00.036)       0:00:00.036 **********
2026-03-30 20:40:38.015144 | 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-30 20:40:38.021375 | controller | ok: [controller]
2026-03-30 20:40:38.021556 | controller |
2026-03-30 20:40:38.021785 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-30 20:40:38.021983 | controller | Monday 30 March 2026  20:40:38 +0000 (0:00:01.249)       0:00:01.285 **********
2026-03-30 20:40:38.095847 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-30 20:40:38.096003 | controller |
2026-03-30 20:40:38.096214 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-30 20:40:38.096411 | controller | Monday 30 March 2026  20:40:38 +0000 (0:00:00.074)       0:00:01.359 **********
2026-03-30 20:40:38.817610 | controller | changed: [controller]
2026-03-30 20:40:38.817785 | controller |
2026-03-30 20:40:38.818017 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-30 20:40:38.818217 | controller | Monday 30 March 2026  20:40:38 +0000 (0:00:00.721)       0:00:02.081 **********
2026-03-30 20:40:38.864535 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-30 20:40:38.864675 | controller |
2026-03-30 20:40:38.864876 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-30 20:40:38.865069 | controller | Monday 30 March 2026  20:40:38 +0000 (0:00:00.047)       0:00:02.128 **********
2026-03-30 20:40:39.269200 | controller | changed: [controller]
2026-03-30 20:40:39.269222 | controller |
2026-03-30 20:40:39.269228 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-30 20:40:39.269232 | controller | Monday 30 March 2026  20:40:39 +0000 (0:00:00.403)       0:00:02.532 **********
2026-03-30 20:40:40.365364 | controller | changed: [controller]
2026-03-30 20:40:40.365526 | controller |
2026-03-30 20:40:40.365739 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-30 20:40:40.365933 | controller | Monday 30 March 2026  20:40:40 +0000 (0:00:01.096)       0:00:03.628 **********
2026-03-30 20:40:40.772600 | controller | ok: [controller]
2026-03-30 20:40:40.772779 | controller |
2026-03-30 20:40:40.773006 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-30 20:40:40.773212 | controller | Monday 30 March 2026  20:40:40 +0000 (0:00:00.407)       0:00:04.035 **********
2026-03-30 20:40:40.827610 | controller | skipping: [controller]
2026-03-30 20:40:40.827783 | controller |
2026-03-30 20:40:40.828037 | controller | PLAY RECAP *********************************************************************
2026-03-30 20:40:40.828267 | controller | controller                 : ok=7    changed=3    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-03-30 20:40:40.828527 | controller |
2026-03-30 20:40:40.828714 | controller |
2026-03-30 20:40:40.828994 | controller | TASKS RECAP ********************************************************************
2026-03-30 20:40:40.829169 | controller | Monday 30 March 2026  20:40:40 +0000 (0:00:00.056)       0:00:04.092 **********
2026-03-30 20:40:40.829413 | controller | ===============================================================================
2026-03-30 20:40:40.829607 | controller | Gathering Facts --------------------------------------------------------- 1.25s
2026-03-30 20:40:40.829846 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.10s
2026-03-30 20:40:40.830036 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.72s
2026-03-30 20:40:40.830249 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.41s
2026-03-30 20:40:40.830414 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.40s
2026-03-30 20:40:40.830608 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s
2026-03-30 20:40:40.830805 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.06s
2026-03-30 20:40:40.830997 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-03-30 20:40:40.918419 | controller | INFO     [upload-helm-chart > converge] Executed: Successful
2026-03-30 20:40:40.929951 | controller | INFO     [upload-helm-chart > idempotence] Executing
2026-03-30 20:40:41.733149 | controller |
2026-03-30 20:40:41.733198 | controller | PLAY [Converge] ****************************************************************
2026-03-30 20:40:41.733208 | controller |
2026-03-30 20:40:41.733218 | controller | TASK [Gathering Facts] *********************************************************
2026-03-30 20:40:41.733240 | controller | Monday 30 March 2026  20:40:41 +0000 (0:00:00.010)       0:00:00.010 **********
2026-03-30 20:40:42.736868 | 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-30 20:40:42.744691 | controller | ok: [controller]
2026-03-30 20:40:42.744864 | controller |
2026-03-30 20:40:42.745079 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-30 20:40:42.745271 | controller | Monday 30 March 2026  20:40:42 +0000 (0:00:01.011)       0:00:01.022 **********
2026-03-30 20:40:42.819206 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-30 20:40:42.819454 | controller |
2026-03-30 20:40:42.819674 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-30 20:40:42.819877 | controller | Monday 30 March 2026  20:40:42 +0000 (0:00:00.075)       0:00:01.097 **********
2026-03-30 20:40:43.553003 | controller | ok: [controller]
2026-03-30 20:40:43.553137 | controller |
2026-03-30 20:40:43.553350 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-30 20:40:43.553549 | controller | Monday 30 March 2026  20:40:43 +0000 (0:00:00.731)       0:00:01.829 **********
2026-03-30 20:40:43.594416 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-30 20:40:43.594567 | controller |
2026-03-30 20:40:43.594763 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-30 20:40:43.595002 | controller | Monday 30 March 2026  20:40:43 +0000 (0:00:00.043)       0:00:01.872 **********
2026-03-30 20:40:44.009995 | controller | ok: [controller]
2026-03-30 20:40:44.010276 | controller |
2026-03-30 20:40:44.010530 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-30 20:40:44.010739 | controller | Monday 30 March 2026  20:40:44 +0000 (0:00:00.414)       0:00:02.287 **********
2026-03-30 20:40:45.063306 | controller | ok: [controller]
2026-03-30 20:40:45.063340 | controller |
2026-03-30 20:40:45.063344 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-30 20:40:45.063348 | controller | Monday 30 March 2026  20:40:45 +0000 (0:00:01.051)       0:00:03.338 **********
2026-03-30 20:40:45.489831 | controller | ok: [controller]
2026-03-30 20:40:45.489943 | controller |
2026-03-30 20:40:45.490123 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-30 20:40:45.490253 | controller | Monday 30 March 2026  20:40:45 +0000 (0:00:00.428)       0:00:03.767 **********
2026-03-30 20:40:45.529501 | controller | skipping: [controller]
2026-03-30 20:40:45.529602 | controller |
2026-03-30 20:40:45.529721 | controller | PLAY RECAP *********************************************************************
2026-03-30 20:40:45.529837 | controller | controller                 : ok=7    changed=0    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-03-30 20:40:45.529940 | controller |
2026-03-30 20:40:45.530040 | controller |
2026-03-30 20:40:45.530146 | controller | TASKS RECAP ********************************************************************
2026-03-30 20:40:45.530262 | controller | Monday 30 March 2026  20:40:45 +0000 (0:00:00.040)       0:00:03.807 **********
2026-03-30 20:40:45.530376 | controller | ===============================================================================
2026-03-30 20:40:45.530516 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.05s
2026-03-30 20:40:45.530644 | controller | Gathering Facts --------------------------------------------------------- 1.01s
2026-03-30 20:40:45.530767 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.73s
2026-03-30 20:40:45.530883 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.43s
2026-03-30 20:40:45.530998 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.41s
2026-03-30 20:40:45.531121 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-03-30 20:40:45.531266 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s
2026-03-30 20:40:45.531421 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.04s
2026-03-30 20:40:45.624024 | controller | INFO     [upload-helm-chart > idempotence] Executed: Successful
2026-03-30 20:40:45.635477 | controller | INFO     [upload-helm-chart > side_effect] Executing
2026-03-30 20:40:46.440133 | controller |
2026-03-30 20:40:46.440347 | controller | PLAY [Side effect] *************************************************************
2026-03-30 20:40:46.440486 | controller |
2026-03-30 20:40:46.440723 | controller | TASK [Gathering Facts] *********************************************************
2026-03-30 20:40:46.440879 | controller | Monday 30 March 2026  20:40:46 +0000 (0:00:00.010)       0:00:00.010 **********
2026-03-30 20:40:48.467207 | 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-30 20:40:48.472586 | controller | ok: [controller]
2026-03-30 20:40:48.472719 | controller |
2026-03-30 20:40:48.472922 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-30 20:40:48.473115 | controller | Monday 30 March 2026  20:40:48 +0000 (0:00:02.032)       0:00:02.042 **********
2026-03-30 20:40:48.540161 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-30 20:40:48.540277 | controller |
2026-03-30 20:40:48.540470 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-30 20:40:48.540662 | controller | Monday 30 March 2026  20:40:48 +0000 (0:00:00.067)       0:00:02.110 **********
2026-03-30 20:40:49.246243 | controller | changed: [controller]
2026-03-30 20:40:49.246395 | controller |
2026-03-30 20:40:49.246617 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-30 20:40:49.246813 | controller | Monday 30 March 2026  20:40:49 +0000 (0:00:00.705)       0:00:02.815 **********
2026-03-30 20:40:49.287989 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-30 20:40:49.288146 | controller |
2026-03-30 20:40:49.288338 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-30 20:40:49.288529 | controller | Monday 30 March 2026  20:40:49 +0000 (0:00:00.042)       0:00:02.857 **********
2026-03-30 20:40:49.691310 | controller | ok: [controller]
2026-03-30 20:40:49.691337 | controller |
2026-03-30 20:40:49.691346 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-30 20:40:49.691561 | controller | Monday 30 March 2026  20:40:49 +0000 (0:00:00.402)       0:00:03.260 **********
2026-03-30 20:40:50.788998 | controller | ok: [controller]
2026-03-30 20:40:50.789153 | controller |
2026-03-30 20:40:50.789353 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-30 20:40:50.789554 | controller | Monday 30 March 2026  20:40:50 +0000 (0:00:01.097)       0:00:04.358 **********
2026-03-30 20:40:51.187695 | controller | ok: [controller]
2026-03-30 20:40:51.187745 | controller |
2026-03-30 20:40:51.187788 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-30 20:40:51.187951 | controller | Monday 30 March 2026  20:40:51 +0000 (0:00:00.397)       0:00:04.755 **********
2026-03-30 20:40:51.525896 | controller | changed: [controller] => (item=/file)
2026-03-30 20:40:51.525937 | controller |
2026-03-30 20:40:51.526037 | controller | PLAY RECAP *********************************************************************
2026-03-30 20:40:51.531331 | controller | controller                 : ok=8    changed=2    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-03-30 20:40:51.531375 | controller |
2026-03-30 20:40:51.531384 | controller |
2026-03-30 20:40:51.531392 | controller | TASKS RECAP ********************************************************************
2026-03-30 20:40:51.531412 | controller | Monday 30 March 2026  20:40:51 +0000 (0:00:00.340)       0:00:05.096 **********
2026-03-30 20:40:51.531420 | controller | ===============================================================================
2026-03-30 20:40:51.531427 | controller | Gathering Facts --------------------------------------------------------- 2.03s
2026-03-30 20:40:51.531434 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.10s
2026-03-30 20:40:51.531441 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.71s
2026-03-30 20:40:51.531448 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.40s
2026-03-30 20:40:51.531455 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.40s
2026-03-30 20:40:51.531463 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.34s
2026-03-30 20:40:51.531471 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s
2026-03-30 20:40:51.531478 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s
2026-03-30 20:40:51.639369 | controller | INFO     [upload-helm-chart > side_effect] Executed: Successful
2026-03-30 20:40:51.645289 | controller | INFO     [upload-helm-chart > verify] Executing
2026-03-30 20:40:52.451131 | controller |
2026-03-30 20:40:52.451407 | controller | PLAY [Verify] ******************************************************************
2026-03-30 20:40:52.451595 | controller |
2026-03-30 20:40:52.451802 | controller | TASK [Gathering Facts] *********************************************************
2026-03-30 20:40:52.451997 | controller | Monday 30 March 2026  20:40:52 +0000 (0:00:00.009)       0:00:00.009 **********
2026-03-30 20:40:53.548687 | 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-30 20:40:53.553477 | controller | ok: [controller]
2026-03-30 20:40:53.553648 | controller |
2026-03-30 20:40:53.553885 | controller | TASK [Stat file 1] *************************************************************
2026-03-30 20:40:53.554082 | controller | Monday 30 March 2026  20:40:53 +0000 (0:00:01.102)       0:00:01.111 **********
2026-03-30 20:40:53.932790 | controller | ok: [controller]
2026-03-30 20:40:53.932842 | controller |
2026-03-30 20:40:53.932923 | controller | TASK [Stat file 2] *************************************************************
2026-03-30 20:40:53.933025 | controller | Monday 30 March 2026  20:40:53 +0000 (0:00:00.378)       0:00:01.490 **********
2026-03-30 20:40:54.210039 | controller | ok: [controller]
2026-03-30 20:40:54.210182 | controller |
2026-03-30 20:40:54.210389 | controller | TASK [Stat removed file 1] *****************************************************
2026-03-30 20:40:54.210643 | controller | Monday 30 March 2026  20:40:54 +0000 (0:00:00.277)       0:00:01.768 **********
2026-03-30 20:40:54.483952 | controller | ok: [controller]
2026-03-30 20:40:54.483987 | controller |
2026-03-30 20:40:54.483996 | controller | TASK [Stat removed file 2] *****************************************************
2026-03-30 20:40:54.484019 | controller | Monday 30 March 2026  20:40:54 +0000 (0:00:00.273)       0:00:02.041 **********
2026-03-30 20:40:54.760091 | controller | ok: [controller]
2026-03-30 20:40:54.760129 | controller |
2026-03-30 20:40:54.760138 | controller | TASK [ansible.builtin.assert] **************************************************
2026-03-30 20:40:54.760146 | controller | Monday 30 March 2026  20:40:54 +0000 (0:00:00.276)       0:00:02.317 **********
2026-03-30 20:40:54.795899 | controller | ok: [controller] => {
2026-03-30 20:40:54.796012 | controller |     "changed": false,
2026-03-30 20:40:54.796136 | controller |     "msg": "All assertions passed"
2026-03-30 20:40:54.797896 | controller | }
2026-03-30 20:40:54.797934 | controller |
2026-03-30 20:40:54.797940 | controller | PLAY RECAP *********************************************************************
2026-03-30 20:40:54.797946 | controller | controller                 : ok=6    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-03-30 20:40:54.797951 | controller |
2026-03-30 20:40:54.797965 | controller |
2026-03-30 20:40:54.797970 | controller | TASKS RECAP ********************************************************************
2026-03-30 20:40:54.797975 | controller | Monday 30 March 2026  20:40:54 +0000 (0:00:00.034)       0:00:02.352 **********
2026-03-30 20:40:54.797979 | controller | ===============================================================================
2026-03-30 20:40:54.797984 | controller | Gathering Facts --------------------------------------------------------- 1.10s
2026-03-30 20:40:54.797988 | controller | Stat file 1 ------------------------------------------------------------- 0.38s
2026-03-30 20:40:54.797993 | controller | Stat file 2 ------------------------------------------------------------- 0.28s
2026-03-30 20:40:54.797997 | controller | Stat removed file 2 ----------------------------------------------------- 0.28s
2026-03-30 20:40:54.798002 | controller | Stat removed file 1 ----------------------------------------------------- 0.27s
2026-03-30 20:40:54.798006 | controller | ansible.builtin.assert -------------------------------------------------- 0.03s
2026-03-30 20:40:54.900429 | controller | INFO     [upload-helm-chart > verify] Executed: Successful
2026-03-30 20:40:54.911198 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-03-30 20:40:54.911705 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-30 20:40:54.918906 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-03-30 20:40:54.919001 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-03-30 20:40:54.919121 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-03-30 20:40:54.919480 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-03-30 20:40:55.489622 | controller | ok: Runtime: 0:00:38.750930
2026-03-30 20:40:55.496605 | 
2026-03-30 20:40:55.496715 | PLAY RECAP
2026-03-30 20:40:55.496813 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-30 20:40:55.496858 | 
2026-03-30 20:40:55.613955 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-03-30 20:40:55.616030 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-03-30 20:40:56.193940 | 
2026-03-30 20:40:56.194077 | PLAY [all]
2026-03-30 20:40:56.205078 | 
2026-03-30 20:40:56.205187 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-03-30 20:40:56.593802 | controller | changed
2026-03-30 20:40:56.599918 | 
2026-03-30 20:40:56.600034 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-03-30 20:40:57.019138 | controller | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-30 20:40:57.019229 | controller |
2026-03-30 20:40:57.024907 | controller | environment: line 1: kubectl: command not found
2026-03-30 20:40:57.026656 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-30 20:40:57.027635 | controller | environment: line 1: kubectl: command not found
2026-03-30 20:40:57.029927 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-30 20:40:57.032628 | controller | environment: line 1: kubectl: command not found
2026-03-30 20:40:57.035278 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-30 20:40:57.035959 | controller | environment: line 1: kubectl: command not found
2026-03-30 20:40:57.037155 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-30 20:40:57.039469 | controller | environment: line 1: kubectl: command not found
2026-03-30 20:40:57.040967 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-30 20:40:57.131227 | controller | ok: Runtime: 0:00:00.039040
2026-03-30 20:40:57.138734 | 
2026-03-30 20:40:57.138811 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-03-30 20:40:57.373484 | controller | changed
2026-03-30 20:40:57.377685 | 
2026-03-30 20:40:57.377775 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-03-30 20:40:57.620597 | controller | environment: line 5: kubectl: command not found
2026-03-30 20:40:57.620721 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-30 20:40:57.621257 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-30 20:40:57.621935 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-30 20:40:57.907344 | controller | ok: Runtime: 0:00:00.013039
2026-03-30 20:40:57.915753 | 
2026-03-30 20:40:57.915858 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-03-30 20:40:58.589306 | controller | changed:
2026-03-30 20:40:58.589563 | controller | created directory /var/lib/zuul/builds/54f00d0b890047f5bdd9b21060ab7beb/work/logs/controller
2026-03-30 20:40:58.589630 | controller | cd+++++++++ objects/
2026-03-30 20:40:58.589681 | controller | cd+++++++++ objects/cluster/
2026-03-30 20:40:58.589732 | controller | cd+++++++++ objects/namespaced/
2026-03-30 20:40:58.597298 | 
2026-03-30 20:40:58.597365 | TASK [gather-pod-logs : creating directory for pod logs]
2026-03-30 20:40:58.831613 | controller | changed
2026-03-30 20:40:58.836867 | 
2026-03-30 20:40:58.836977 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-03-30 20:40:59.060691 | controller | changed
2026-03-30 20:40:59.064951 | 
2026-03-30 20:40:59.065046 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-03-30 20:40:59.305311 | controller | environment: line 3: kubectl: command not found
2026-03-30 20:40:59.595843 | controller | ok: Runtime: 0:00:00.013535
2026-03-30 20:40:59.601816 | 
2026-03-30 20:40:59.601920 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-03-30 20:41:00.121542 | controller | changed:
2026-03-30 20:41:00.121848 | controller | cd+++++++++ pod-logs/
2026-03-30 20:41:00.121909 | controller | cd+++++++++ pod-logs/failed-pods/
2026-03-30 20:41:00.130296 | 
2026-03-30 20:41:00.130365 | LOOP [helm-release-status : creating directory for helm release status]
2026-03-30 20:41:00.379532 | controller | changed: "values"
2026-03-30 20:41:00.586900 | controller | changed: "releases"
2026-03-30 20:41:00.604742 | 
2026-03-30 20:41:00.604925 | TASK [helm-release-status : Gather get release status for helm charts]
2026-03-30 20:41:00.846997 | controller | /bin/bash: line 3: kubectl: command not found
2026-03-30 20:41:01.136314 | controller | ok: Runtime: 0:00:00.009850
2026-03-30 20:41:01.141933 | 
2026-03-30 20:41:01.142029 | TASK [helm-release-status : Downloads logs to executor]
2026-03-30 20:41:01.683099 | controller | changed:
2026-03-30 20:41:01.683294 | controller | cd+++++++++ helm/
2026-03-30 20:41:01.683333 | controller | cd+++++++++ helm/releases/
2026-03-30 20:41:01.683367 | controller | cd+++++++++ helm/values/
2026-03-30 20:41:01.689684 | 
2026-03-30 20:41:01.689752 | PLAY RECAP
2026-03-30 20:41:01.689811 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-30 20:41:01.689842 | 
2026-03-30 20:41:01.822446 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-03-30 20:41:01.825415 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-30 20:41:02.404729 | 
2026-03-30 20:41:02.404862 | PLAY [all]
2026-03-30 20:41:02.424090 | 
2026-03-30 20:41:02.424286 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-30 20:41:02.470472 | controller | skipping: Conditional result was False
2026-03-30 20:41:02.479700 | 
2026-03-30 20:41:02.479811 | TASK [fetch-output : Set log path for single node]
2026-03-30 20:41:02.519997 | controller | ok
2026-03-30 20:41:02.525391 | 
2026-03-30 20:41:02.525496 | LOOP [fetch-output : Ensure local output dirs]
2026-03-30 20:41:02.907849 | controller -> localhost | ok: "/var/lib/zuul/builds/54f00d0b890047f5bdd9b21060ab7beb/work/logs"
2026-03-30 20:41:03.136972 | controller -> localhost | changed: "/var/lib/zuul/builds/54f00d0b890047f5bdd9b21060ab7beb/work/artifacts"
2026-03-30 20:41:03.347660 | controller -> localhost | changed: "/var/lib/zuul/builds/54f00d0b890047f5bdd9b21060ab7beb/work/docs"
2026-03-30 20:41:03.362825 | 
2026-03-30 20:41:03.362971 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-30 20:41:04.025244 | controller | changed: .d..t...... ./
2026-03-30 20:41:04.025517 | controller | changed: All items complete
2026-03-30 20:41:04.025545 | 
2026-03-30 20:41:04.527545 | controller | changed: .d..t...... ./
2026-03-30 20:41:05.013469 | controller | changed: .d..t...... ./
2026-03-30 20:41:05.035182 | 
2026-03-30 20:41:05.035383 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-03-30 20:41:05.463244 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008945
2026-03-30 20:41:05.698514 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008470
2026-03-30 20:41:05.712850 | 
2026-03-30 20:41:05.713009 | PLAY [all]
2026-03-30 20:41:05.719722 | 
2026-03-30 20:41:05.719789 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-03-30 20:41:06.187034 | controller | changed
2026-03-30 20:41:06.193367 | 
2026-03-30 20:41:06.193484 | PLAY RECAP
2026-03-30 20:41:06.193584 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-03-30 20:41:06.193637 | 
2026-03-30 20:41:06.344238 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-30 20:41:06.347215 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-03-30 20:41:06.891530 | 
2026-03-30 20:41:06.891666 | PLAY [localhost]
2026-03-30 20:41:06.901389 | 
2026-03-30 20:41:06.901462 | TASK [Generate Zuul manifest]
2026-03-30 20:41:06.923095 | localhost | ok
2026-03-30 20:41:06.939920 | 
2026-03-30 20:41:06.940005 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-03-30 20:41:07.261306 | localhost | changed
2026-03-30 20:41:07.274356 | 
2026-03-30 20:41:07.274428 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-03-30 20:41:07.303921 | localhost | ok
2026-03-30 20:41:07.313086 | 
2026-03-30 20:41:07.313150 | TASK [Upload logs]
2026-03-30 20:41:07.333717 | localhost | ok
2026-03-30 20:41:07.391692 | 
2026-03-30 20:41:07.391791 | TASK [Set zuul-log-path fact]
2026-03-30 20:41:07.413181 | localhost | ok
2026-03-30 20:41:07.426161 | 
2026-03-30 20:41:07.426228 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-30 20:41:07.455739 | localhost | ok
2026-03-30 20:41:07.462934 | 
2026-03-30 20:41:07.463001 | TASK [upload-logs : Create log directories]
2026-03-30 20:41:07.856767 | localhost | changed
2026-03-30 20:41:07.863791 | 
2026-03-30 20:41:07.863857 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-03-30 20:41:08.252581 | localhost -> localhost | ok: Runtime: 0:00:00.005324
2026-03-30 20:41:08.257874 | 
2026-03-30 20:41:08.257939 | TASK [upload-logs : Upload logs to log server]
2026-03-30 20:41:08.726044 | localhost | Output suppressed because no_log was given
2026-03-30 20:41:08.730768 | 
2026-03-30 20:41:08.730836 | LOOP [upload-logs : Compress console log and json output]
2026-03-30 20:41:08.775013 | localhost | skipping: Conditional result was False
2026-03-30 20:41:08.780914 | localhost | skipping: Conditional result was False
2026-03-30 20:41:08.796261 | 
2026-03-30 20:41:08.796410 | LOOP [upload-logs : Upload compressed console log and json output]
2026-03-30 20:41:08.841482 | localhost | skipping: Conditional result was False
2026-03-30 20:41:08.841872 | 
2026-03-30 20:41:08.845748 | localhost | skipping: Conditional result was False
2026-03-30 20:41:08.861783 | 
2026-03-30 20:41:08.861976 | LOOP [upload-logs : Upload console log and json output]