2026-03-30 20:36:21.981658 | Job console starting
2026-03-30 20:36:22.171034 | Updating git repos
2026-03-30 20:36:22.313716 | Cloning repos into workspace
2026-03-30 20:36:23.223870 | Restoring repo states
2026-03-30 20:36:23.401057 | Merging changes
2026-03-30 20:36:24.847250 | Checking out repos
2026-03-30 20:36:25.074547 | Preparing playbooks
2026-03-30 20:36:30.907550 | Running Ansible setup
2026-03-30 20:36:36.093356 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-30 20:36:36.709004 | 
2026-03-30 20:36:36.709145 | PLAY [localhost]
2026-03-30 20:36:36.717183 | 
2026-03-30 20:36:36.717254 | TASK [Gathering Facts]
2026-03-30 20:36:37.701889 | localhost | ok
2026-03-30 20:36:37.712453 | 
2026-03-30 20:36:37.712655 | TASK [Setup log path fact]
2026-03-30 20:36:37.731629 | localhost | ok
2026-03-30 20:36:37.746950 | 
2026-03-30 20:36:37.747018 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-30 20:36:37.775488 | localhost | ok
2026-03-30 20:36:37.783318 | 
2026-03-30 20:36:37.783385 | TASK [emit-job-header : Print job information]
2026-03-30 20:36:37.821944 | # Job Information
2026-03-30 20:36:37.822182 | Ansible Version: 2.16.16
2026-03-30 20:36:37.822253 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart
2026-03-30 20:36:37.822303 | Pipeline: check
2026-03-30 20:36:37.822348 | Executor: 0a8996d2b663
2026-03-30 20:36:37.822392 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/249
2026-03-30 20:36:37.822442 | Event ID: e7734e60-2c77-11f1-8ad3-afb618d27ccd
2026-03-30 20:36:37.828582 | 
2026-03-30 20:36:37.828716 | LOOP [emit-job-header : Print node information]
2026-03-30 20:36:37.909575 | localhost | ok:
2026-03-30 20:36:37.909769 | localhost | # Node Information
2026-03-30 20:36:37.909799 | localhost | Inventory Hostname: controller
2026-03-30 20:36:37.909821 | localhost | Hostname: np0000161627
2026-03-30 20:36:37.909840 | localhost | Username: zuul
2026-03-30 20:36:37.909862 | localhost | Distro: Debian 13.4
2026-03-30 20:36:37.909882 | localhost | Provider: yul1
2026-03-30 20:36:37.909900 | localhost | Region: ca-ymq-1
2026-03-30 20:36:37.909918 | localhost | Label: debian-trixie
2026-03-30 20:36:37.909936 | localhost | Product Name: OpenStack Nova
2026-03-30 20:36:37.909954 | localhost | Interface IP: 199.204.45.250
2026-03-30 20:36:37.927888 | 
2026-03-30 20:36:37.928028 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-03-30 20:36:38.323099 | localhost -> localhost | changed
2026-03-30 20:36:38.329982 | 
2026-03-30 20:36:38.330080 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-03-30 20:36:39.261350 | localhost -> localhost | changed
2026-03-30 20:36:39.274479 | 
2026-03-30 20:36:39.274591 | PLAY [all]
2026-03-30 20:36:39.282374 | 
2026-03-30 20:36:39.282443 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-30 20:36:39.675767 | controller -> localhost | ok
2026-03-30 20:36:39.681195 | 
2026-03-30 20:36:39.681262 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-30 20:36:39.711874 | controller | ok
2026-03-30 20:36:39.728668 | controller | included: /var/lib/zuul/builds/1493160b8fbe4568be214618ccaeec5f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-30 20:36:39.733478 | 
2026-03-30 20:36:39.733542 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-30 20:36:40.915145 | controller -> localhost | Generating public/private rsa key pair.
2026-03-30 20:36:40.915390 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/1493160b8fbe4568be214618ccaeec5f/work/1493160b8fbe4568be214618ccaeec5f_id_rsa
2026-03-30 20:36:40.915433 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/1493160b8fbe4568be214618ccaeec5f/work/1493160b8fbe4568be214618ccaeec5f_id_rsa.pub
2026-03-30 20:36:40.915465 | controller -> localhost | The key fingerprint is:
2026-03-30 20:36:40.915494 | controller -> localhost | SHA256:ixBy7O4TWv3zVBtfXG2IVnSmLkeJmwgtSshIuDJMwM0 zuul-build-sshkey
2026-03-30 20:36:40.915539 | controller -> localhost | The key's randomart image is:
2026-03-30 20:36:40.915569 | controller -> localhost | +---[RSA 3072]----+
2026-03-30 20:36:40.915605 | controller -> localhost | |+.+          .o o|
2026-03-30 20:36:40.915634 | controller -> localhost | |.+ E .   .   + *.|
2026-03-30 20:36:40.915661 | controller -> localhost | |o.o * . o . + = +|
2026-03-30 20:36:40.915689 | controller -> localhost | |+. + o . o o = o.|
2026-03-30 20:36:40.915716 | controller -> localhost | |..  o.. S . * o o|
2026-03-30 20:36:40.915743 | controller -> localhost | |   .o... . . * . |
2026-03-30 20:36:40.915770 | controller -> localhost | |   o..... . . .  |
2026-03-30 20:36:40.915797 | controller -> localhost | |  ...   o.       |
2026-03-30 20:36:40.915828 | controller -> localhost | |    ..   o.      |
2026-03-30 20:36:40.915855 | controller -> localhost | +----[SHA256]-----+
2026-03-30 20:36:40.915915 | controller -> localhost | ok: Runtime: 0:00:00.208016
2026-03-30 20:36:40.921780 | 
2026-03-30 20:36:40.921866 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-30 20:36:40.951548 | controller | ok
2026-03-30 20:36:40.960486 | controller | included: /var/lib/zuul/builds/1493160b8fbe4568be214618ccaeec5f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-30 20:36:40.969277 | 
2026-03-30 20:36:40.969339 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-30 20:36:40.995120 | controller | skipping: Conditional result was False
2026-03-30 20:36:41.003463 | 
2026-03-30 20:36:41.003549 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-30 20:36:41.641972 | controller | changed
2026-03-30 20:36:41.647765 | 
2026-03-30 20:36:41.647853 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-30 20:36:41.854053 | controller | ok
2026-03-30 20:36:41.860618 | 
2026-03-30 20:36:41.860706 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-30 20:36:42.406193 | controller | changed
2026-03-30 20:36:42.417100 | 
2026-03-30 20:36:42.417296 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-30 20:36:42.941048 | controller | changed
2026-03-30 20:36:42.948551 | 
2026-03-30 20:36:42.948666 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-30 20:36:42.985173 | controller | skipping: Conditional result was False
2026-03-30 20:36:42.994454 | 
2026-03-30 20:36:42.994528 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-30 20:36:43.356750 | controller -> localhost | changed
2026-03-30 20:36:43.365184 | 
2026-03-30 20:36:43.365251 | TASK [add-build-sshkey : Add back temp key]
2026-03-30 20:36:43.703630 | controller -> localhost | Identity added: /var/lib/zuul/builds/1493160b8fbe4568be214618ccaeec5f/work/1493160b8fbe4568be214618ccaeec5f_id_rsa (zuul-build-sshkey)
2026-03-30 20:36:43.703853 | controller -> localhost | ok: Runtime: 0:00:00.015184
2026-03-30 20:36:43.707962 | 
2026-03-30 20:36:43.708048 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-30 20:36:44.062099 | controller | ok
2026-03-30 20:36:44.067685 | 
2026-03-30 20:36:44.067811 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-30 20:36:44.123342 | controller | skipping: Conditional result was False
2026-03-30 20:36:44.140172 | 
2026-03-30 20:36:44.140430 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-03-30 20:36:44.553202 | controller | ok
2026-03-30 20:36:44.558196 | 
2026-03-30 20:36:44.558269 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-03-30 20:36:45.669559 | controller | Output suppressed because no_log was given
2026-03-30 20:36:45.676419 | 
2026-03-30 20:36:45.676484 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-03-30 20:36:45.885349 | controller | ok: "logs"
2026-03-30 20:36:45.885629 | controller | ok: All items complete
2026-03-30 20:36:45.885670 | 
2026-03-30 20:36:46.079855 | controller | ok: "artifacts"
2026-03-30 20:36:46.257581 | controller | ok: "docs"
2026-03-30 20:36:46.276539 | 
2026-03-30 20:36:46.276698 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-03-30 20:36:46.496353 | controller | changed: "logs"
2026-03-30 20:36:46.684588 | controller | changed: "artifacts"
2026-03-30 20:36:46.901076 | controller | changed: "docs"
2026-03-30 20:36:46.919635 | 
2026-03-30 20:36:46.919763 | PLAY RECAP
2026-03-30 20:36:46.919814 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-03-30 20:36:46.919843 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-30 20:36:46.919864 | 
2026-03-30 20:36:47.136629 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-30 20:36:47.138406 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-30 20:36:47.709211 | 
2026-03-30 20:36:47.709350 | PLAY [all]
2026-03-30 20:36:47.719471 | 
2026-03-30 20:36:47.719545 | TASK [setup-uv : Extract archive]
2026-03-30 20:36:50.027627 | controller | changed
2026-03-30 20:36:50.035358 | 
2026-03-30 20:36:50.035448 | TASK [setup-uv : Print version]
2026-03-30 20:36:50.432044 | controller | uv 0.8.13
2026-03-30 20:36:50.565188 | controller | ok: Runtime: 0:00:00.013808
2026-03-30 20:36:50.573157 | 
2026-03-30 20:36:50.573225 | PLAY RECAP
2026-03-30 20:36:50.573283 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-30 20:36:50.573315 | 
2026-03-30 20:36:50.694941 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-30 20:36:50.696593 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-03-30 20:36:51.269396 | 
2026-03-30 20:36:51.269536 | PLAY [all]
2026-03-30 20:36:51.279737 | 
2026-03-30 20:36:51.279827 | TASK [Update apt cache]
2026-03-30 20:36:56.154652 | controller | ok
2026-03-30 20:36:56.161903 | 
2026-03-30 20:36:56.162004 | TASK [Disable firewalld]
2026-03-30 20:36:56.188211 | controller | skipping: Conditional result was False
2026-03-30 20:36:56.194000 | 
2026-03-30 20:36:56.194088 | TASK [Install "jq" for log collection]
2026-03-30 20:36:58.393515 | controller | changed
2026-03-30 20:36:58.397260 | 
2026-03-30 20:36:58.397370 | PLAY RECAP
2026-03-30 20:36:58.397464 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-03-30 20:36:58.397515 | 
2026-03-30 20:36:58.543072 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-03-30 20:36:58.545840 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-03-30 20:36:59.119776 | 
2026-03-30 20:36:59.119904 | PLAY [all]
2026-03-30 20:36:59.130902 | 
2026-03-30 20:36:59.130973 | TASK [Copy inventory file for Zuul]
2026-03-30 20:37:00.070876 | controller | changed
2026-03-30 20:37:00.078287 | 
2026-03-30 20:37:00.078366 | TASK [Switch "ansible_host" to private IP]
2026-03-30 20:37:00.367758 | controller | changed: 1 replacements made
2026-03-30 20:37:00.372665 | 
2026-03-30 20:37:00.372737 | TASK [Run Molecule scenario]
2026-03-30 20:37:00.838147 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-03-30 20:37:00.838251 | controller | Creating virtual environment at: .venv
2026-03-30 20:37:00.894008 | controller | Downloading ansible-core (2.3MiB)
2026-03-30 20:37:00.894878 | controller | Downloading pygments (1.2MiB)
2026-03-30 20:37:00.895112 | controller | Downloading cryptography (4.3MiB)
2026-03-30 20:37:01.058748 | controller |  Downloading cryptography
2026-03-30 20:37:01.113335 | controller |  Downloading pygments
2026-03-30 20:37:01.283824 | controller |  Downloading ansible-core
2026-03-30 20:37:01.327252 | controller | Installed 36 packages in 42ms
2026-03-30 20:37:02.045776 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-03-30 20:37:02.045851 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-03-30 20:37:02.957049 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-03-30 20:37:02.957126 | controller | INFO     default scenario not found, disabling shared state.
2026-03-30 20:37:02.957145 | 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:37:02.957265 | controller | INFO     [upload-helm-chart > prerun] Performing prerun with role_name_check=0...
2026-03-30 20:37:18.093780 | controller | INFO     [upload-helm-chart > dependency] Executing
2026-03-30 20:37:18.093858 | controller | WARNING  [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml
2026-03-30 20:37:18.094100 | controller | WARNING  [upload-helm-chart > dependency] Missing collections requirements file: collections.yml
2026-03-30 20:37:18.094217 | controller | WARNING  [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-03-30 20:37:18.099582 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-03-30 20:37:18.099908 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-30 20:37:18.105187 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-03-30 20:37:18.105241 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-03-30 20:37:18.105334 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-03-30 20:37:18.110554 | controller | INFO     [upload-helm-chart > syntax] Executing
2026-03-30 20:37:18.974682 | controller |
2026-03-30 20:37:18.974926 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml
2026-03-30 20:37:19.033049 | controller | INFO     [upload-helm-chart > syntax] Executed: Successful
2026-03-30 20:37:19.043089 | controller | INFO     [upload-helm-chart > create] Executing
2026-03-30 20:37:19.045300 | controller | WARNING  [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-30 20:37:19.051904 | controller | INFO     [upload-helm-chart > prepare] Executing
2026-03-30 20:37:19.052264 | controller | WARNING  [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-30 20:37:19.057761 | controller | INFO     [upload-helm-chart > converge] Executing
2026-03-30 20:37:19.998889 | controller |
2026-03-30 20:37:19.999015 | controller | PLAY [Converge] ****************************************************************
2026-03-30 20:37:19.999236 | controller |
2026-03-30 20:37:19.999507 | controller | TASK [Gathering Facts] *********************************************************
2026-03-30 20:37:19.999673 | controller | Monday 30 March 2026  20:37:19 +0000 (0:00:00.031)       0:00:00.031 **********
2026-03-30 20:37:21.376707 | 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:37:21.383046 | controller | ok: [controller]
2026-03-30 20:37:21.383131 | controller |
2026-03-30 20:37:21.383234 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-30 20:37:21.383335 | controller | Monday 30 March 2026  20:37:21 +0000 (0:00:01.385)       0:00:01.416 **********
2026-03-30 20:37:21.457403 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-30 20:37:21.457610 | controller |
2026-03-30 20:37:21.457894 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-30 20:37:21.458129 | controller | Monday 30 March 2026  20:37:21 +0000 (0:00:00.074)       0:00:01.490 **********
2026-03-30 20:37:22.200776 | controller | changed: [controller]
2026-03-30 20:37:22.201495 | controller |
2026-03-30 20:37:22.201826 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-30 20:37:22.202052 | controller | Monday 30 March 2026  20:37:22 +0000 (0:00:00.742)       0:00:02.233 **********
2026-03-30 20:37:22.246178 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-30 20:37:22.246355 | controller |
2026-03-30 20:37:22.246560 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-30 20:37:22.246756 | controller | Monday 30 March 2026  20:37:22 +0000 (0:00:00.046)       0:00:02.279 **********
2026-03-30 20:37:22.660032 | controller | changed: [controller]
2026-03-30 20:37:22.660067 | controller |
2026-03-30 20:37:22.660074 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-30 20:37:22.660081 | controller | Monday 30 March 2026  20:37:22 +0000 (0:00:00.411)       0:00:02.691 **********
2026-03-30 20:37:23.769068 | controller | changed: [controller]
2026-03-30 20:37:23.769149 | controller |
2026-03-30 20:37:23.769351 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-30 20:37:23.769496 | controller | Monday 30 March 2026  20:37:23 +0000 (0:00:01.110)       0:00:03.801 **********
2026-03-30 20:37:24.163940 | controller | ok: [controller]
2026-03-30 20:37:24.164050 | controller |
2026-03-30 20:37:24.164275 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-30 20:37:24.164480 | controller | Monday 30 March 2026  20:37:24 +0000 (0:00:00.394)       0:00:04.196 **********
2026-03-30 20:37:24.210671 | controller | skipping: [controller]
2026-03-30 20:37:24.210768 | controller |
2026-03-30 20:37:24.210969 | controller | PLAY RECAP *********************************************************************
2026-03-30 20:37:24.211182 | controller | controller                 : ok=7    changed=3    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-03-30 20:37:24.211356 | controller |
2026-03-30 20:37:24.211530 | controller |
2026-03-30 20:37:24.211720 | controller | TASKS RECAP ********************************************************************
2026-03-30 20:37:24.211903 | controller | Monday 30 March 2026  20:37:24 +0000 (0:00:00.047)       0:00:04.244 **********
2026-03-30 20:37:24.212079 | controller | ===============================================================================
2026-03-30 20:37:24.212266 | controller | Gathering Facts --------------------------------------------------------- 1.39s
2026-03-30 20:37:24.212463 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.11s
2026-03-30 20:37:24.212721 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.74s
2026-03-30 20:37:24.212917 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.41s
2026-03-30 20:37:24.213094 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.39s
2026-03-30 20:37:24.213297 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s
2026-03-30 20:37:24.213565 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.05s
2026-03-30 20:37:24.213825 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-03-30 20:37:24.301345 | controller | INFO     [upload-helm-chart > converge] Executed: Successful
2026-03-30 20:37:24.311253 | controller | INFO     [upload-helm-chart > idempotence] Executing
2026-03-30 20:37:25.117241 | controller |
2026-03-30 20:37:25.117403 | controller | PLAY [Converge] ****************************************************************
2026-03-30 20:37:25.117572 | controller |
2026-03-30 20:37:25.117791 | controller | TASK [Gathering Facts] *********************************************************
2026-03-30 20:37:25.117989 | controller | Monday 30 March 2026  20:37:25 +0000 (0:00:00.010)       0:00:00.010 **********
2026-03-30 20:37:27.204382 | 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:37:27.212504 | controller | ok: [controller]
2026-03-30 20:37:27.212648 | controller |
2026-03-30 20:37:27.212787 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-30 20:37:27.212912 | controller | Monday 30 March 2026  20:37:27 +0000 (0:00:02.095)       0:00:02.105 **********
2026-03-30 20:37:27.291519 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-30 20:37:27.291554 | controller |
2026-03-30 20:37:27.291700 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-30 20:37:27.291816 | controller | Monday 30 March 2026  20:37:27 +0000 (0:00:00.079)       0:00:02.184 **********
2026-03-30 20:37:28.025968 | controller | ok: [controller]
2026-03-30 20:37:28.026005 | controller |
2026-03-30 20:37:28.026015 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-30 20:37:28.026023 | controller | Monday 30 March 2026  20:37:28 +0000 (0:00:00.730)       0:00:02.915 **********
2026-03-30 20:37:28.065478 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-30 20:37:28.065729 | controller |
2026-03-30 20:37:28.065989 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-30 20:37:28.066240 | controller | Monday 30 March 2026  20:37:28 +0000 (0:00:00.043)       0:00:02.958 **********
2026-03-30 20:37:28.508126 | controller | ok: [controller]
2026-03-30 20:37:28.508417 | controller |
2026-03-30 20:37:28.508743 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-30 20:37:28.509035 | controller | Monday 30 March 2026  20:37:28 +0000 (0:00:00.441)       0:00:03.400 **********
2026-03-30 20:37:30.564880 | controller | ok: [controller]
2026-03-30 20:37:30.565165 | controller |
2026-03-30 20:37:30.565428 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-30 20:37:30.565680 | controller | Monday 30 March 2026  20:37:30 +0000 (0:00:02.056)       0:00:05.457 **********
2026-03-30 20:37:30.966148 | controller | ok: [controller]
2026-03-30 20:37:30.966425 | controller |
2026-03-30 20:37:30.966705 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-30 20:37:30.966955 | controller | Monday 30 March 2026  20:37:30 +0000 (0:00:00.401)       0:00:05.858 **********
2026-03-30 20:37:31.004619 | controller | skipping: [controller]
2026-03-30 20:37:31.004882 | controller |
2026-03-30 20:37:31.005134 | controller | PLAY RECAP *********************************************************************
2026-03-30 20:37:31.005400 | controller | controller                 : ok=7    changed=0    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-03-30 20:37:31.005629 | controller |
2026-03-30 20:37:31.005851 | controller |
2026-03-30 20:37:31.006093 | controller | TASKS RECAP ********************************************************************
2026-03-30 20:37:31.006342 | controller | Monday 30 March 2026  20:37:30 +0000 (0:00:00.039)       0:00:05.898 **********
2026-03-30 20:37:31.006577 | controller | ===============================================================================
2026-03-30 20:37:31.006821 | controller | Gathering Facts --------------------------------------------------------- 2.10s
2026-03-30 20:37:31.007075 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 2.06s
2026-03-30 20:37:31.007356 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.73s
2026-03-30 20:37:31.007603 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.44s
2026-03-30 20:37:31.007855 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.40s
2026-03-30 20:37:31.008124 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-03-30 20:37:31.008378 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s
2026-03-30 20:37:31.008685 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.04s
2026-03-30 20:37:31.102292 | controller | INFO     [upload-helm-chart > idempotence] Executed: Successful
2026-03-30 20:37:31.113856 | controller | INFO     [upload-helm-chart > side_effect] Executing
2026-03-30 20:37:31.944667 | controller |
2026-03-30 20:37:31.944715 | controller | PLAY [Side effect] *************************************************************
2026-03-30 20:37:31.944725 | controller |
2026-03-30 20:37:31.944846 | controller | TASK [Gathering Facts] *********************************************************
2026-03-30 20:37:31.945098 | controller | Monday 30 March 2026  20:37:31 +0000 (0:00:00.010)       0:00:00.010 **********
2026-03-30 20:37:33.052114 | 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:37:33.058796 | controller | ok: [controller]
2026-03-30 20:37:33.058828 | controller |
2026-03-30 20:37:33.058837 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-30 20:37:33.058845 | controller | Monday 30 March 2026  20:37:33 +0000 (0:00:01.113)       0:00:01.124 **********
2026-03-30 20:37:33.145543 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-30 20:37:33.145822 | controller |
2026-03-30 20:37:33.146079 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-30 20:37:33.146323 | controller | Monday 30 March 2026  20:37:33 +0000 (0:00:00.086)       0:00:01.211 **********
2026-03-30 20:37:33.879070 | controller | changed: [controller]
2026-03-30 20:37:33.879349 | controller |
2026-03-30 20:37:33.879627 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-30 20:37:33.879877 | controller | Monday 30 March 2026  20:37:33 +0000 (0:00:00.731)       0:00:01.942 **********
2026-03-30 20:37:33.923087 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-30 20:37:33.923272 | controller |
2026-03-30 20:37:33.923441 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-30 20:37:33.923605 | controller | Monday 30 March 2026  20:37:33 +0000 (0:00:00.047)       0:00:01.989 **********
2026-03-30 20:37:34.351406 | controller | ok: [controller]
2026-03-30 20:37:34.351694 | controller |
2026-03-30 20:37:34.351971 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-30 20:37:34.352248 | controller | Monday 30 March 2026  20:37:34 +0000 (0:00:00.422)       0:00:02.411 **********
2026-03-30 20:37:35.487139 | controller | ok: [controller]
2026-03-30 20:37:35.487281 | controller |
2026-03-30 20:37:35.487405 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-30 20:37:35.487521 | controller | Monday 30 March 2026  20:37:35 +0000 (0:00:01.141)       0:00:03.553 **********
2026-03-30 20:37:35.928861 | controller | ok: [controller]
2026-03-30 20:37:35.929024 | controller |
2026-03-30 20:37:35.929151 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-30 20:37:35.929267 | controller | Monday 30 March 2026  20:37:35 +0000 (0:00:00.438)       0:00:03.991 **********
2026-03-30 20:37:36.249593 | controller | changed: [controller] => (item=/file)
2026-03-30 20:37:36.249902 | controller |
2026-03-30 20:37:36.250165 | controller | PLAY RECAP *********************************************************************
2026-03-30 20:37:36.250442 | controller | controller                 : ok=8    changed=2    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-03-30 20:37:36.250673 | controller |
2026-03-30 20:37:36.250895 | controller |
2026-03-30 20:37:36.251140 | controller | TASKS RECAP ********************************************************************
2026-03-30 20:37:36.251412 | controller | Monday 30 March 2026  20:37:36 +0000 (0:00:00.323)       0:00:04.314 **********
2026-03-30 20:37:36.251644 | controller | ===============================================================================
2026-03-30 20:37:36.251951 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.14s
2026-03-30 20:37:36.252292 | controller | Gathering Facts --------------------------------------------------------- 1.11s
2026-03-30 20:37:36.252613 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.73s
2026-03-30 20:37:36.252879 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.44s
2026-03-30 20:37:36.253125 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.42s
2026-03-30 20:37:36.253383 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.32s
2026-03-30 20:37:36.253632 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.09s
2026-03-30 20:37:36.253881 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-03-30 20:37:36.364632 | controller | INFO     [upload-helm-chart > side_effect] Executed: Successful
2026-03-30 20:37:36.374117 | controller | INFO     [upload-helm-chart > verify] Executing
2026-03-30 20:37:37.166634 | controller |
2026-03-30 20:37:37.168718 | controller | PLAY [Verify] ******************************************************************
2026-03-30 20:37:37.168772 | controller |
2026-03-30 20:37:37.168782 | controller | TASK [Gathering Facts] *********************************************************
2026-03-30 20:37:37.168791 | controller | Monday 30 March 2026  20:37:37 +0000 (0:00:00.009)       0:00:00.009 **********
2026-03-30 20:37:38.273653 | 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:37:38.278483 | controller | ok: [controller]
2026-03-30 20:37:38.278645 | controller |
2026-03-30 20:37:38.278833 | controller | TASK [Stat file 1] *************************************************************
2026-03-30 20:37:38.279026 | controller | Monday 30 March 2026  20:37:38 +0000 (0:00:01.111)       0:00:01.121 **********
2026-03-30 20:37:38.734222 | controller | ok: [controller]
2026-03-30 20:37:38.734274 | controller |
2026-03-30 20:37:38.734384 | controller | TASK [Stat file 2] *************************************************************
2026-03-30 20:37:38.734505 | controller | Monday 30 March 2026  20:37:38 +0000 (0:00:00.455)       0:00:01.576 **********
2026-03-30 20:37:39.049020 | controller | ok: [controller]
2026-03-30 20:37:39.049158 | controller |
2026-03-30 20:37:39.049355 | controller | TASK [Stat removed file 1] *****************************************************
2026-03-30 20:37:39.049554 | controller | Monday 30 March 2026  20:37:39 +0000 (0:00:00.313)       0:00:01.890 **********
2026-03-30 20:37:39.345644 | controller | ok: [controller]
2026-03-30 20:37:39.345683 | controller |
2026-03-30 20:37:39.345692 | controller | TASK [Stat removed file 2] *****************************************************
2026-03-30 20:37:39.345716 | controller | Monday 30 March 2026  20:37:39 +0000 (0:00:00.297)       0:00:02.187 **********
2026-03-30 20:37:39.633173 | controller | ok: [controller]
2026-03-30 20:37:39.633214 | controller |
2026-03-30 20:37:39.633331 | controller | TASK [ansible.builtin.assert] **************************************************
2026-03-30 20:37:39.633425 | controller | Monday 30 March 2026  20:37:39 +0000 (0:00:00.287)       0:00:02.475 **********
2026-03-30 20:37:39.674499 | controller | ok: [controller] => {
2026-03-30 20:37:39.674509 | controller |     "changed": false,
2026-03-30 20:37:39.674513 | controller |     "msg": "All assertions passed"
2026-03-30 20:37:39.674517 | controller | }
2026-03-30 20:37:39.674521 | controller |
2026-03-30 20:37:39.674525 | controller | PLAY RECAP *********************************************************************
2026-03-30 20:37:39.674529 | controller | controller                 : ok=6    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-03-30 20:37:39.674532 | controller |
2026-03-30 20:37:39.674546 | controller |
2026-03-30 20:37:39.674550 | controller | TASKS RECAP ********************************************************************
2026-03-30 20:37:39.674553 | controller | Monday 30 March 2026  20:37:39 +0000 (0:00:00.037)       0:00:02.512 **********
2026-03-30 20:37:39.674556 | controller | ===============================================================================
2026-03-30 20:37:39.674560 | controller | Gathering Facts --------------------------------------------------------- 1.11s
2026-03-30 20:37:39.674563 | controller | Stat file 1 ------------------------------------------------------------- 0.46s
2026-03-30 20:37:39.674566 | controller | Stat file 2 ------------------------------------------------------------- 0.31s
2026-03-30 20:37:39.674570 | controller | Stat removed file 1 ----------------------------------------------------- 0.30s
2026-03-30 20:37:39.674573 | controller | Stat removed file 2 ----------------------------------------------------- 0.29s
2026-03-30 20:37:39.674576 | controller | ansible.builtin.assert -------------------------------------------------- 0.04s
2026-03-30 20:37:39.805276 | controller | INFO     [upload-helm-chart > verify] Executed: Successful
2026-03-30 20:37:39.817192 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-03-30 20:37:39.817538 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-30 20:37:39.822934 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-03-30 20:37:39.823061 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-03-30 20:37:39.823153 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-03-30 20:37:39.823437 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-03-30 20:37:39.957235 | controller | ok: Runtime: 0:00:39.145237
2026-03-30 20:37:39.960936 | 
2026-03-30 20:37:39.960997 | PLAY RECAP
2026-03-30 20:37:39.961045 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-30 20:37:39.961067 | 
2026-03-30 20:37:40.122208 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-03-30 20:37:40.125146 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-03-30 20:37:40.733877 | 
2026-03-30 20:37:40.734011 | PLAY [all]
2026-03-30 20:37:40.744973 | 
2026-03-30 20:37:40.745059 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-03-30 20:37:41.123001 | controller | changed
2026-03-30 20:37:41.128822 | 
2026-03-30 20:37:41.128928 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-03-30 20:37:41.522746 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-30 20:37:41.522912 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-30 20:37:41.529726 | controller | environment: line 1: kubectl: command not found
2026-03-30 20:37:41.531755 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-30 20:37:41.532760 | controller | environment: line 1: kubectl: command not found
2026-03-30 20:37:41.535312 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-30 20:37:41.535464 | controller | environment: line 1: kubectl: command not found
2026-03-30 20:37:41.538293 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-30 20:37:41.539254 | controller | environment: line 1: kubectl: command not found
2026-03-30 20:37:41.541372 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-30 20:37:41.541987 | controller | environment: line 1: kubectl: command not found
2026-03-30 20:37:41.543226 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-30 20:37:41.657318 | controller | ok: Runtime: 0:00:00.036924
2026-03-30 20:37:41.662968 | 
2026-03-30 20:37:41.663064 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-03-30 20:37:41.904906 | controller | changed
2026-03-30 20:37:41.913032 | 
2026-03-30 20:37:41.913819 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-03-30 20:37:42.166302 | controller | environment: line 5: kubectl: command not found
2026-03-30 20:37:42.168244 | 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:37:42.168295 | controller |
2026-03-30 20:37:42.168537 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-30 20:37:42.451789 | controller | ok: Runtime: 0:00:00.013383
2026-03-30 20:37:42.459964 | 
2026-03-30 20:37:42.460039 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-03-30 20:37:43.120948 | controller | changed:
2026-03-30 20:37:43.121265 | controller | created directory /var/lib/zuul/builds/1493160b8fbe4568be214618ccaeec5f/work/logs/controller
2026-03-30 20:37:43.121332 | controller | cd+++++++++ objects/
2026-03-30 20:37:43.121383 | controller | cd+++++++++ objects/cluster/
2026-03-30 20:37:43.121433 | controller | cd+++++++++ objects/namespaced/
2026-03-30 20:37:43.129659 | 
2026-03-30 20:37:43.129725 | TASK [gather-pod-logs : creating directory for pod logs]
2026-03-30 20:37:43.364055 | controller | changed
2026-03-30 20:37:43.370552 | 
2026-03-30 20:37:43.370643 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-03-30 20:37:43.616405 | controller | changed
2026-03-30 20:37:43.622001 | 
2026-03-30 20:37:43.622107 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-03-30 20:37:43.862069 | controller | environment: line 3: kubectl: command not found
2026-03-30 20:37:44.153649 | controller | ok: Runtime: 0:00:00.012720
2026-03-30 20:37:44.159297 | 
2026-03-30 20:37:44.159368 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-03-30 20:37:44.708457 | controller | changed:
2026-03-30 20:37:44.708869 | controller | cd+++++++++ pod-logs/
2026-03-30 20:37:44.708981 | controller | cd+++++++++ pod-logs/failed-pods/
2026-03-30 20:37:44.718983 | 
2026-03-30 20:37:44.719046 | LOOP [helm-release-status : creating directory for helm release status]
2026-03-30 20:37:44.961941 | controller | changed: "values"
2026-03-30 20:37:45.168946 | controller | changed: "releases"
2026-03-30 20:37:45.178037 | 
2026-03-30 20:37:45.178204 | TASK [helm-release-status : Gather get release status for helm charts]
2026-03-30 20:37:45.413149 | controller | /bin/bash: line 3: kubectl: command not found
2026-03-30 20:37:45.709727 | controller | ok: Runtime: 0:00:00.009340
2026-03-30 20:37:45.718008 | 
2026-03-30 20:37:45.718080 | TASK [helm-release-status : Downloads logs to executor]
2026-03-30 20:37:46.240596 | controller | changed:
2026-03-30 20:37:46.240781 | controller | cd+++++++++ helm/
2026-03-30 20:37:46.240815 | controller | cd+++++++++ helm/releases/
2026-03-30 20:37:46.240843 | controller | cd+++++++++ helm/values/
2026-03-30 20:37:46.245825 | 
2026-03-30 20:37:46.245877 | PLAY RECAP
2026-03-30 20:37:46.245921 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-30 20:37:46.245943 | 
2026-03-30 20:37:46.381302 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-03-30 20:37:46.382732 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-30 20:37:46.961591 | 
2026-03-30 20:37:46.961735 | PLAY [all]
2026-03-30 20:37:46.971894 | 
2026-03-30 20:37:46.971971 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-30 20:37:47.018163 | controller | skipping: Conditional result was False
2026-03-30 20:37:47.027583 | 
2026-03-30 20:37:47.027694 | TASK [fetch-output : Set log path for single node]
2026-03-30 20:37:47.070050 | controller | ok
2026-03-30 20:37:47.075649 | 
2026-03-30 20:37:47.075731 | LOOP [fetch-output : Ensure local output dirs]
2026-03-30 20:37:47.446458 | controller -> localhost | ok: "/var/lib/zuul/builds/1493160b8fbe4568be214618ccaeec5f/work/logs"
2026-03-30 20:37:47.654970 | controller -> localhost | changed: "/var/lib/zuul/builds/1493160b8fbe4568be214618ccaeec5f/work/artifacts"
2026-03-30 20:37:47.859197 | controller -> localhost | changed: "/var/lib/zuul/builds/1493160b8fbe4568be214618ccaeec5f/work/docs"
2026-03-30 20:37:47.874788 | 
2026-03-30 20:37:47.874919 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-30 20:37:48.530632 | controller | changed: .d..t...... ./
2026-03-30 20:37:48.531001 | controller | changed: All items complete
2026-03-30 20:37:48.531044 | 
2026-03-30 20:37:49.012515 | controller | changed: .d..t...... ./
2026-03-30 20:37:49.492491 | controller | changed: .d..t...... ./
2026-03-30 20:37:49.507710 | 
2026-03-30 20:37:49.507888 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-03-30 20:37:49.939873 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008195
2026-03-30 20:37:50.165120 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007566
2026-03-30 20:37:50.186446 | 
2026-03-30 20:37:50.186601 | PLAY [all]
2026-03-30 20:37:50.191614 | 
2026-03-30 20:37:50.191685 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-03-30 20:37:50.650145 | controller | changed
2026-03-30 20:37:50.656699 | 
2026-03-30 20:37:50.656776 | PLAY RECAP
2026-03-30 20:37:50.656842 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-03-30 20:37:50.656864 | 
2026-03-30 20:37:50.789174 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-30 20:37:50.791948 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-03-30 20:37:51.406116 | 
2026-03-30 20:37:51.406586 | PLAY [localhost]
2026-03-30 20:37:51.416351 | 
2026-03-30 20:37:51.416421 | TASK [Generate Zuul manifest]
2026-03-30 20:37:51.439580 | localhost | ok
2026-03-30 20:37:51.457331 | 
2026-03-30 20:37:51.457410 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-03-30 20:37:51.774424 | localhost | changed
2026-03-30 20:37:51.788627 | 
2026-03-30 20:37:51.788707 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-03-30 20:37:51.820950 | localhost | ok
2026-03-30 20:37:51.830557 | 
2026-03-30 20:37:51.830647 | TASK [Upload logs]
2026-03-30 20:37:51.850555 | localhost | ok
2026-03-30 20:37:51.913018 | 
2026-03-30 20:37:51.913158 | TASK [Set zuul-log-path fact]
2026-03-30 20:37:51.936868 | localhost | ok
2026-03-30 20:37:51.949959 | 
2026-03-30 20:37:51.950033 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-30 20:37:51.994337 | localhost | ok
2026-03-30 20:37:52.003370 | 
2026-03-30 20:37:52.003444 | TASK [upload-logs : Create log directories]
2026-03-30 20:37:52.428137 | localhost | changed
2026-03-30 20:37:52.434710 | 
2026-03-30 20:37:52.434783 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-03-30 20:37:52.842809 | localhost -> localhost | ok: Runtime: 0:00:00.005488
2026-03-30 20:37:52.850187 | 
2026-03-30 20:37:52.850274 | TASK [upload-logs : Upload logs to log server]
2026-03-30 20:37:53.318679 | localhost | Output suppressed because no_log was given
2026-03-30 20:37:53.323684 | 
2026-03-30 20:37:53.323750 | LOOP [upload-logs : Compress console log and json output]
2026-03-30 20:37:53.373372 | localhost | skipping: Conditional result was False
2026-03-30 20:37:53.380441 | localhost | skipping: Conditional result was False
2026-03-30 20:37:53.401155 | 
2026-03-30 20:37:53.401456 | LOOP [upload-logs : Upload compressed console log and json output]
2026-03-30 20:37:53.445745 | localhost | skipping: Conditional result was False
2026-03-30 20:37:53.446133 | 
2026-03-30 20:37:53.449834 | localhost | skipping: Conditional result was False
2026-03-30 20:37:53.466689 | 
2026-03-30 20:37:53.466881 | LOOP [upload-logs : Upload console log and json output]