2026-03-17 20:41:55.305628 | Job console starting
2026-03-17 20:41:55.624338 | Updating git repos
2026-03-17 20:41:55.668052 | Cloning repos into workspace
2026-03-17 20:41:56.243053 | Restoring repo states
2026-03-17 20:41:56.260784 | Merging changes
2026-03-17 20:41:57.100703 | Checking out repos
2026-03-17 20:41:57.363430 | Preparing playbooks
2026-03-17 20:42:09.440773 | Running Ansible setup
2026-03-17 20:42:13.499766 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-17 20:42:14.176538 | 
2026-03-17 20:42:14.177006 | PLAY [localhost]
2026-03-17 20:42:14.187285 | 
2026-03-17 20:42:14.187428 | TASK [Gathering Facts]
2026-03-17 20:42:15.195486 | localhost | ok
2026-03-17 20:42:15.203818 | 
2026-03-17 20:42:15.203924 | TASK [Setup log path fact]
2026-03-17 20:42:15.233308 | localhost | ok
2026-03-17 20:42:15.245891 | 
2026-03-17 20:42:15.310245 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-17 20:42:15.351436 | localhost | ok
2026-03-17 20:42:15.370459 | 
2026-03-17 20:42:15.370598 | TASK [emit-job-header : Print job information]
2026-03-17 20:42:15.411833 | # Job Information
2026-03-17 20:42:15.652585 | Ansible Version: 2.16.16
2026-03-17 20:42:15.652897 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart
2026-03-17 20:42:15.653027 | Pipeline: check
2026-03-17 20:42:15.653134 | Executor: 0a8996d2b663
2026-03-17 20:42:15.653192 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/241
2026-03-17 20:42:15.653247 | Event ID: 98997b10-2241-11f1-82f6-5260d3b98859
2026-03-17 20:42:15.658782 | 
2026-03-17 20:42:15.658885 | LOOP [emit-job-header : Print node information]
2026-03-17 20:42:15.738951 | localhost | ok:
2026-03-17 20:42:15.739120 | localhost | # Node Information
2026-03-17 20:42:15.739173 | localhost | Inventory Hostname: controller
2026-03-17 20:42:15.739202 | localhost | Hostname: np0000159652
2026-03-17 20:42:15.739224 | localhost | Username: zuul
2026-03-17 20:42:15.739247 | localhost | Distro: Debian 13.3
2026-03-17 20:42:15.739268 | localhost | Provider: yul1
2026-03-17 20:42:15.739288 | localhost | Region: ca-ymq-1
2026-03-17 20:42:15.739308 | localhost | Label: debian-trixie
2026-03-17 20:42:15.739327 | localhost | Product Name: OpenStack Nova
2026-03-17 20:42:15.739346 | localhost | Interface IP: 199.19.213.18
2026-03-17 20:42:15.751726 | 
2026-03-17 20:42:15.768586 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-03-17 20:42:16.228491 | localhost -> localhost | changed
2026-03-17 20:42:16.250663 | 
2026-03-17 20:42:16.250774 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-03-17 20:42:17.310622 | localhost -> localhost | changed
2026-03-17 20:42:17.317295 | 
2026-03-17 20:42:17.317381 | PLAY [all]
2026-03-17 20:42:17.329217 | 
2026-03-17 20:42:17.379795 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-17 20:42:17.641241 | controller -> localhost | ok
2026-03-17 20:42:17.647103 | 
2026-03-17 20:42:17.647172 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-17 20:42:17.676473 | controller | ok
2026-03-17 20:42:17.691126 | controller | included: /var/lib/zuul/builds/93ac572dcfc24a4a9b9b412721e402a6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-17 20:42:17.695707 | 
2026-03-17 20:42:17.695768 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-17 20:42:18.692916 | controller -> localhost | Generating public/private rsa key pair.
2026-03-17 20:42:18.693131 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/93ac572dcfc24a4a9b9b412721e402a6/work/93ac572dcfc24a4a9b9b412721e402a6_id_rsa
2026-03-17 20:42:18.693163 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/93ac572dcfc24a4a9b9b412721e402a6/work/93ac572dcfc24a4a9b9b412721e402a6_id_rsa.pub
2026-03-17 20:42:18.693188 | controller -> localhost | The key fingerprint is:
2026-03-17 20:42:18.693211 | controller -> localhost | SHA256:ywl4QCxKNSFOmbOWTrubRyxlv4i1xmcvoI2fX2Hw8wU zuul-build-sshkey
2026-03-17 20:42:18.693246 | controller -> localhost | The key's randomart image is:
2026-03-17 20:42:18.693269 | controller -> localhost | +---[RSA 3072]----+
2026-03-17 20:42:18.693300 | controller -> localhost | | o+=o            |
2026-03-17 20:42:18.693324 | controller -> localhost | |o=o.o            |
2026-03-17 20:42:18.693347 | controller -> localhost | |.o+...   E       |
2026-03-17 20:42:18.693368 | controller -> localhost | |.= o oo   .      |
2026-03-17 20:42:18.693410 | controller -> localhost | |+ = o o=S  .     |
2026-03-17 20:42:18.693433 | controller -> localhost | | + = o.o+o.      |
2026-03-17 20:42:18.693455 | controller -> localhost | |  @ + ..+.       |
2026-03-17 20:42:18.693477 | controller -> localhost | | =.B.=.          |
2026-03-17 20:42:18.693501 | controller -> localhost | | o=o+.o.         |
2026-03-17 20:42:18.693524 | controller -> localhost | +----[SHA256]-----+
2026-03-17 20:42:18.693575 | controller -> localhost | ok: Runtime: 0:00:00.535225
2026-03-17 20:42:18.697667 | 
2026-03-17 20:42:18.697730 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-17 20:42:18.729635 | controller | ok
2026-03-17 20:42:18.739865 | controller | included: /var/lib/zuul/builds/93ac572dcfc24a4a9b9b412721e402a6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-17 20:42:18.747295 | 
2026-03-17 20:42:18.747356 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-17 20:42:18.771180 | controller | skipping: Conditional result was False
2026-03-17 20:42:18.779507 | 
2026-03-17 20:42:18.779594 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-17 20:42:19.325897 | controller | changed
2026-03-17 20:42:19.331992 | 
2026-03-17 20:42:19.332148 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-17 20:42:19.536831 | controller | ok
2026-03-17 20:42:19.540920 | 
2026-03-17 20:42:19.541008 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-17 20:42:20.100093 | controller | changed
2026-03-17 20:42:20.268131 | 
2026-03-17 20:42:20.268297 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-17 20:42:20.809717 | controller | changed
2026-03-17 20:42:20.824909 | 
2026-03-17 20:42:20.825111 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-17 20:42:20.849926 | controller | skipping: Conditional result was False
2026-03-17 20:42:20.859567 | 
2026-03-17 20:42:20.859674 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-17 20:42:21.250529 | controller -> localhost | changed
2026-03-17 20:42:21.262987 | 
2026-03-17 20:42:21.263148 | TASK [add-build-sshkey : Add back temp key]
2026-03-17 20:42:21.673859 | controller -> localhost | Identity added: /var/lib/zuul/builds/93ac572dcfc24a4a9b9b412721e402a6/work/93ac572dcfc24a4a9b9b412721e402a6_id_rsa (zuul-build-sshkey)
2026-03-17 20:42:21.674111 | controller -> localhost | ok: Runtime: 0:00:00.014607
2026-03-17 20:42:21.681515 | 
2026-03-17 20:42:21.681612 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-17 20:42:22.088495 | controller | ok
2026-03-17 20:42:22.092607 | 
2026-03-17 20:42:22.092687 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-17 20:42:22.117690 | controller | skipping: Conditional result was False
2026-03-17 20:42:22.134167 | 
2026-03-17 20:42:22.134339 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-03-17 20:42:22.566772 | controller | ok
2026-03-17 20:42:22.576721 | 
2026-03-17 20:42:22.576812 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-03-17 20:42:23.745630 | controller | Output suppressed because no_log was given
2026-03-17 20:42:23.758173 | 
2026-03-17 20:42:23.758269 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-03-17 20:42:23.984259 | controller | ok: "logs"
2026-03-17 20:42:23.984842 | controller | ok: All items complete
2026-03-17 20:42:23.984903 | 
2026-03-17 20:42:24.181892 | controller | ok: "artifacts"
2026-03-17 20:42:24.397804 | controller | ok: "docs"
2026-03-17 20:42:24.417436 | 
2026-03-17 20:42:24.417642 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-03-17 20:42:24.639214 | controller | changed: "logs"
2026-03-17 20:42:24.825914 | controller | changed: "artifacts"
2026-03-17 20:42:25.002536 | controller | changed: "docs"
2026-03-17 20:42:25.018627 | 
2026-03-17 20:42:25.018744 | PLAY RECAP
2026-03-17 20:42:25.018795 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-03-17 20:42:25.018826 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-17 20:42:25.018845 | 
2026-03-17 20:42:25.224345 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-17 20:42:25.610104 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-17 20:42:26.230526 | 
2026-03-17 20:42:26.444770 | PLAY [all]
2026-03-17 20:42:26.464211 | 
2026-03-17 20:42:26.464357 | TASK [setup-uv : Extract archive]
2026-03-17 20:42:29.099704 | controller | changed
2026-03-17 20:42:29.108312 | 
2026-03-17 20:42:29.108479 | TASK [setup-uv : Print version]
2026-03-17 20:42:29.544018 | controller | uv 0.8.13
2026-03-17 20:42:30.003566 | controller | ok: Runtime: 0:00:00.014309
2026-03-17 20:42:30.010454 | 
2026-03-17 20:42:30.010534 | PLAY RECAP
2026-03-17 20:42:30.010597 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-17 20:42:30.010632 | 
2026-03-17 20:42:30.180207 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-17 20:42:30.181566 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-03-17 20:42:30.805417 | 
2026-03-17 20:42:30.805608 | PLAY [all]
2026-03-17 20:42:30.817841 | 
2026-03-17 20:42:30.817994 | TASK [Update apt cache]
2026-03-17 20:42:35.505207 | controller | ok
2026-03-17 20:42:35.763471 | 
2026-03-17 20:42:35.763676 | TASK [Install "jq" for log collection]
2026-03-17 20:42:38.203209 | controller | changed
2026-03-17 20:42:38.205945 | 
2026-03-17 20:42:38.206035 | PLAY RECAP
2026-03-17 20:42:38.206097 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-17 20:42:38.206132 | 
2026-03-17 20:42:38.348827 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-03-17 20:42:38.350742 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-03-17 20:42:38.989999 | 
2026-03-17 20:42:38.990337 | PLAY [all]
2026-03-17 20:42:39.000464 | 
2026-03-17 20:42:39.000539 | TASK [Copy inventory file for Zuul]
2026-03-17 20:42:39.971527 | controller | changed
2026-03-17 20:42:42.500190 | 
2026-03-17 20:42:42.500391 | TASK [Switch "ansible_host" to private IP]
2026-03-17 20:42:42.794531 | controller | changed: 1 replacements made
2026-03-17 20:42:42.801784 | 
2026-03-17 20:42:42.801936 | TASK [Run Molecule scenario]
2026-03-17 20:42:43.256976 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-03-17 20:42:43.257102 | controller | Creating virtual environment at: .venv
2026-03-17 20:42:43.563167 | controller | Downloading ansible-core (2.3MiB)
2026-03-17 20:42:43.564779 | controller | Downloading pygments (1.2MiB)
2026-03-17 20:42:43.565424 | controller | Downloading cryptography (4.3MiB)
2026-03-17 20:42:43.736751 | controller |  Downloading cryptography
2026-03-17 20:42:43.801458 | controller |  Downloading pygments
2026-03-17 20:42:44.014577 | controller |  Downloading ansible-core
2026-03-17 20:42:44.063951 | controller | Installed 36 packages in 48ms
2026-03-17 20:42:44.777422 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-03-17 20:42:44.777482 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-03-17 20:42:45.662104 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-03-17 20:42:45.662157 | controller | INFO     default scenario not found, disabling shared state.
2026-03-17 20:42:45.662245 | controller | INFO     [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-03-17 20:42:45.662347 | controller | INFO     [upload-helm-chart > prerun] Performing prerun with role_name_check=0...
2026-03-17 20:43:04.125271 | controller | INFO     [upload-helm-chart > dependency] Executing
2026-03-17 20:43:04.125436 | controller | WARNING  [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml
2026-03-17 20:43:04.125641 | controller | WARNING  [upload-helm-chart > dependency] Missing collections requirements file: collections.yml
2026-03-17 20:43:04.125761 | controller | WARNING  [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-03-17 20:43:04.131401 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-03-17 20:43:04.131723 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-17 20:43:04.137582 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-03-17 20:43:04.137657 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-03-17 20:43:04.137756 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-03-17 20:43:04.143217 | controller | INFO     [upload-helm-chart > syntax] Executing
2026-03-17 20:43:05.057715 | controller |
2026-03-17 20:43:05.057975 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml
2026-03-17 20:43:05.126559 | controller | INFO     [upload-helm-chart > syntax] Executed: Successful
2026-03-17 20:43:05.139543 | controller | INFO     [upload-helm-chart > create] Executing
2026-03-17 20:43:05.141481 | controller | WARNING  [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-17 20:43:05.146793 | controller | INFO     [upload-helm-chart > prepare] Executing
2026-03-17 20:43:05.147069 | controller | WARNING  [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-17 20:43:05.152469 | controller | INFO     [upload-helm-chart > converge] Executing
2026-03-17 20:43:06.042150 | controller |
2026-03-17 20:43:06.042362 | controller | PLAY [Converge] ****************************************************************
2026-03-17 20:43:06.042546 | controller |
2026-03-17 20:43:06.042755 | controller | TASK [Gathering Facts] *********************************************************
2026-03-17 20:43:06.042959 | controller | Tuesday 17 March 2026  20:43:06 +0000 (0:00:00.030)       0:00:00.030 *********
2026-03-17 20:43:08.315396 | 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-17 20:43:08.323771 | controller | ok: [controller]
2026-03-17 20:43:08.324091 | controller |
2026-03-17 20:43:08.324405 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-17 20:43:08.324715 | controller | Tuesday 17 March 2026  20:43:08 +0000 (0:00:02.281)       0:00:02.312 *********
2026-03-17 20:43:08.412092 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-17 20:43:08.412275 | controller |
2026-03-17 20:43:08.412495 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-17 20:43:08.412688 | controller | Tuesday 17 March 2026  20:43:08 +0000 (0:00:00.088)       0:00:02.400 *********
2026-03-17 20:43:09.118763 | controller | changed: [controller]
2026-03-17 20:43:09.119027 | controller |
2026-03-17 20:43:09.119295 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-17 20:43:09.119605 | controller | Tuesday 17 March 2026  20:43:09 +0000 (0:00:00.706)       0:00:03.107 *********
2026-03-17 20:43:09.165315 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-17 20:43:09.165514 | controller |
2026-03-17 20:43:09.165761 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-17 20:43:09.166004 | controller | Tuesday 17 March 2026  20:43:09 +0000 (0:00:00.046)       0:00:03.154 *********
2026-03-17 20:43:09.580469 | controller | changed: [controller]
2026-03-17 20:43:09.580496 | controller |
2026-03-17 20:43:09.580582 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-17 20:43:09.580757 | controller | Tuesday 17 March 2026  20:43:09 +0000 (0:00:00.412)       0:00:03.566 *********
2026-03-17 20:43:10.734478 | controller | changed: [controller]
2026-03-17 20:43:10.734561 | controller |
2026-03-17 20:43:10.734721 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-17 20:43:10.734867 | controller | Tuesday 17 March 2026  20:43:10 +0000 (0:00:01.155)       0:00:04.722 *********
2026-03-17 20:43:11.164183 | controller | ok: [controller]
2026-03-17 20:43:11.164237 | controller |
2026-03-17 20:43:11.164360 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-17 20:43:11.164466 | controller | Tuesday 17 March 2026  20:43:11 +0000 (0:00:00.429)       0:00:05.151 *********
2026-03-17 20:43:11.222477 | controller | skipping: [controller]
2026-03-17 20:43:11.222566 | controller |
2026-03-17 20:43:11.222741 | controller | PLAY RECAP *********************************************************************
2026-03-17 20:43:11.222930 | controller | controller                 : ok=7    changed=3    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-03-17 20:43:11.223055 | controller |
2026-03-17 20:43:11.223192 | controller |
2026-03-17 20:43:11.223344 | controller | TASKS RECAP ********************************************************************
2026-03-17 20:43:11.223488 | controller | Tuesday 17 March 2026  20:43:11 +0000 (0:00:00.059)       0:00:05.211 *********
2026-03-17 20:43:11.223685 | controller | ===============================================================================
2026-03-17 20:43:11.223803 | controller | Gathering Facts --------------------------------------------------------- 2.28s
2026-03-17 20:43:11.223985 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.16s
2026-03-17 20:43:11.224116 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.71s
2026-03-17 20:43:11.224281 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.43s
2026-03-17 20:43:11.224403 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.41s
2026-03-17 20:43:11.224549 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.09s
2026-03-17 20:43:11.224698 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.06s
2026-03-17 20:43:11.224844 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-03-17 20:43:11.324615 | controller | INFO     [upload-helm-chart > converge] Executed: Successful
2026-03-17 20:43:11.333606 | controller | INFO     [upload-helm-chart > idempotence] Executing
2026-03-17 20:43:12.224009 | controller |
2026-03-17 20:43:12.224100 | controller | PLAY [Converge] ****************************************************************
2026-03-17 20:43:12.224241 | controller |
2026-03-17 20:43:12.224410 | controller | TASK [Gathering Facts] *********************************************************
2026-03-17 20:43:12.224589 | controller | Tuesday 17 March 2026  20:43:12 +0000 (0:00:00.011)       0:00:00.011 *********
2026-03-17 20:43:13.283035 | 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-17 20:43:13.286846 | controller | ok: [controller]
2026-03-17 20:43:13.286986 | controller |
2026-03-17 20:43:13.287183 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-17 20:43:13.287372 | controller | Tuesday 17 March 2026  20:43:13 +0000 (0:00:01.063)       0:00:01.075 *********
2026-03-17 20:43:13.360698 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-17 20:43:13.360742 | controller |
2026-03-17 20:43:13.360846 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-17 20:43:13.360950 | controller | Tuesday 17 March 2026  20:43:13 +0000 (0:00:00.073)       0:00:01.148 *********
2026-03-17 20:43:14.105159 | controller | ok: [controller]
2026-03-17 20:43:14.105207 | controller |
2026-03-17 20:43:14.105307 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-17 20:43:14.105415 | controller | Tuesday 17 March 2026  20:43:14 +0000 (0:00:00.744)       0:00:01.893 *********
2026-03-17 20:43:14.142590 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-17 20:43:14.142741 | controller |
2026-03-17 20:43:14.142951 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-17 20:43:14.143150 | controller | Tuesday 17 March 2026  20:43:14 +0000 (0:00:00.037)       0:00:01.930 *********
2026-03-17 20:43:14.575580 | controller | ok: [controller]
2026-03-17 20:43:14.575670 | controller |
2026-03-17 20:43:14.575821 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-17 20:43:14.579384 | controller | Tuesday 17 March 2026  20:43:14 +0000 (0:00:00.432)       0:00:02.363 *********
2026-03-17 20:43:15.653761 | controller | ok: [controller]
2026-03-17 20:43:15.654171 | controller |
2026-03-17 20:43:15.654521 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-17 20:43:15.654812 | controller | Tuesday 17 March 2026  20:43:15 +0000 (0:00:01.077)       0:00:03.441 *********
2026-03-17 20:43:16.104220 | controller | ok: [controller]
2026-03-17 20:43:16.104766 | controller |
2026-03-17 20:43:16.104782 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-17 20:43:16.104790 | controller | Tuesday 17 March 2026  20:43:16 +0000 (0:00:00.448)       0:00:03.889 *********
2026-03-17 20:43:16.152429 | controller | skipping: [controller]
2026-03-17 20:43:16.152639 | controller |
2026-03-17 20:43:16.152788 | controller | PLAY RECAP *********************************************************************
2026-03-17 20:43:16.152936 | controller | controller                 : ok=7    changed=0    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-03-17 20:43:16.153058 | controller |
2026-03-17 20:43:16.153177 | controller |
2026-03-17 20:43:16.153305 | controller | TASKS RECAP ********************************************************************
2026-03-17 20:43:16.153436 | controller | Tuesday 17 March 2026  20:43:16 +0000 (0:00:00.051)       0:00:03.940 *********
2026-03-17 20:43:16.153559 | controller | ===============================================================================
2026-03-17 20:43:16.153697 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.08s
2026-03-17 20:43:16.153825 | controller | Gathering Facts --------------------------------------------------------- 1.06s
2026-03-17 20:43:16.153956 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.74s
2026-03-17 20:43:16.154086 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.45s
2026-03-17 20:43:16.154217 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.43s
2026-03-17 20:43:16.154367 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s
2026-03-17 20:43:16.154503 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.05s
2026-03-17 20:43:16.154636 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s
2026-03-17 20:43:16.243927 | controller | INFO     [upload-helm-chart > idempotence] Executed: Successful
2026-03-17 20:43:16.248080 | controller | INFO     [upload-helm-chart > side_effect] Executing
2026-03-17 20:43:17.153041 | controller |
2026-03-17 20:43:17.153203 | controller | PLAY [Side effect] *************************************************************
2026-03-17 20:43:17.153357 | controller |
2026-03-17 20:43:17.153514 | controller | TASK [Gathering Facts] *********************************************************
2026-03-17 20:43:17.153677 | controller | Tuesday 17 March 2026  20:43:17 +0000 (0:00:00.016)       0:00:00.016 *********
2026-03-17 20:43:18.230985 | 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-17 20:43:18.240016 | controller | ok: [controller]
2026-03-17 20:43:18.240143 | controller |
2026-03-17 20:43:18.240294 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-17 20:43:18.240472 | controller | Tuesday 17 March 2026  20:43:18 +0000 (0:00:01.083)       0:00:01.100 *********
2026-03-17 20:43:18.324159 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-17 20:43:18.324213 | controller |
2026-03-17 20:43:18.324520 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-17 20:43:18.324550 | controller | Tuesday 17 March 2026  20:43:18 +0000 (0:00:00.083)       0:00:01.184 *********
2026-03-17 20:43:19.012374 | controller | changed: [controller]
2026-03-17 20:43:19.012444 | controller |
2026-03-17 20:43:19.012458 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-17 20:43:19.012517 | controller | Tuesday 17 March 2026  20:43:19 +0000 (0:00:00.690)       0:00:01.874 *********
2026-03-17 20:43:19.053379 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-17 20:43:19.053432 | controller |
2026-03-17 20:43:19.053544 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-17 20:43:19.053654 | controller | Tuesday 17 March 2026  20:43:19 +0000 (0:00:00.042)       0:00:01.916 *********
2026-03-17 20:43:19.443424 | controller | ok: [controller]
2026-03-17 20:43:19.443563 | controller |
2026-03-17 20:43:19.443769 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-17 20:43:19.444086 | controller | Tuesday 17 March 2026  20:43:19 +0000 (0:00:00.389)       0:00:02.306 *********
2026-03-17 20:43:20.507397 | controller | ok: [controller]
2026-03-17 20:43:20.507448 | controller |
2026-03-17 20:43:20.507560 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-17 20:43:20.507660 | controller | Tuesday 17 March 2026  20:43:20 +0000 (0:00:01.060)       0:00:03.366 *********
2026-03-17 20:43:20.948231 | controller | ok: [controller]
2026-03-17 20:43:20.948279 | controller |
2026-03-17 20:43:20.948394 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-17 20:43:20.951878 | controller | Tuesday 17 March 2026  20:43:20 +0000 (0:00:00.444)       0:00:03.811 *********
2026-03-17 20:43:21.265497 | controller | changed: [controller] => (item=/file)
2026-03-17 20:43:21.265678 | controller |
2026-03-17 20:43:21.265918 | controller | PLAY RECAP *********************************************************************
2026-03-17 20:43:21.266255 | controller | controller                 : ok=8    changed=2    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-03-17 20:43:21.266440 | controller |
2026-03-17 20:43:21.266600 | controller |
2026-03-17 20:43:21.266785 | controller | TASKS RECAP ********************************************************************
2026-03-17 20:43:21.266986 | controller | Tuesday 17 March 2026  20:43:21 +0000 (0:00:00.317)       0:00:04.129 *********
2026-03-17 20:43:21.267174 | controller | ===============================================================================
2026-03-17 20:43:21.267357 | controller | Gathering Facts --------------------------------------------------------- 1.08s
2026-03-17 20:43:21.267553 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.06s
2026-03-17 20:43:21.267741 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.69s
2026-03-17 20:43:21.267974 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.44s
2026-03-17 20:43:21.268190 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.39s
2026-03-17 20:43:21.268388 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.32s
2026-03-17 20:43:21.268578 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-03-17 20:43:21.268766 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s
2026-03-17 20:43:21.350518 | controller | INFO     [upload-helm-chart > side_effect] Executed: Successful
2026-03-17 20:43:21.363097 | controller | INFO     [upload-helm-chart > verify] Executing
2026-03-17 20:43:22.199271 | controller |
2026-03-17 20:43:22.199326 | controller | PLAY [Verify] ******************************************************************
2026-03-17 20:43:22.199447 | controller |
2026-03-17 20:43:22.199570 | controller | TASK [Gathering Facts] *********************************************************
2026-03-17 20:43:22.199693 | controller | Tuesday 17 March 2026  20:43:22 +0000 (0:00:00.009)       0:00:00.009 *********
2026-03-17 20:43:24.259525 | 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-17 20:43:24.265148 | controller | ok: [controller]
2026-03-17 20:43:24.265367 | controller |
2026-03-17 20:43:24.265603 | controller | TASK [Stat file 1] *************************************************************
2026-03-17 20:43:24.265851 | controller | Tuesday 17 March 2026  20:43:24 +0000 (0:00:02.065)       0:00:02.075 *********
2026-03-17 20:43:24.652668 | controller | ok: [controller]
2026-03-17 20:43:24.652862 | controller |
2026-03-17 20:43:24.653081 | controller | TASK [Stat file 2] *************************************************************
2026-03-17 20:43:24.653279 | controller | Tuesday 17 March 2026  20:43:24 +0000 (0:00:00.384)       0:00:02.459 *********
2026-03-17 20:43:24.940934 | controller | ok: [controller]
2026-03-17 20:43:24.940978 | controller |
2026-03-17 20:43:24.941070 | controller | TASK [Stat removed file 1] *****************************************************
2026-03-17 20:43:24.941162 | controller | Tuesday 17 March 2026  20:43:24 +0000 (0:00:00.291)       0:00:02.750 *********
2026-03-17 20:43:25.226794 | controller | ok: [controller]
2026-03-17 20:43:25.226862 | controller |
2026-03-17 20:43:25.227001 | controller | TASK [Stat removed file 2] *****************************************************
2026-03-17 20:43:25.227155 | controller | Tuesday 17 March 2026  20:43:25 +0000 (0:00:00.285)       0:00:03.035 *********
2026-03-17 20:43:25.506373 | controller | ok: [controller]
2026-03-17 20:43:25.506409 | controller |
2026-03-17 20:43:25.506419 | controller | TASK [ansible.builtin.assert] **************************************************
2026-03-17 20:43:25.506428 | controller | Tuesday 17 March 2026  20:43:25 +0000 (0:00:00.279)       0:00:03.315 *********
2026-03-17 20:43:25.536188 | controller | ok: [controller] => {
2026-03-17 20:43:25.536278 | controller |     "changed": false,
2026-03-17 20:43:25.536373 | controller |     "msg": "All assertions passed"
2026-03-17 20:43:25.536463 | controller | }
2026-03-17 20:43:25.536534 | controller |
2026-03-17 20:43:25.536632 | controller | PLAY RECAP *********************************************************************
2026-03-17 20:43:25.536740 | controller | controller                 : ok=6    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-03-17 20:43:25.538091 | controller |
2026-03-17 20:43:25.538129 | controller |
2026-03-17 20:43:25.538136 | controller | TASKS RECAP ********************************************************************
2026-03-17 20:43:25.538142 | controller | Tuesday 17 March 2026  20:43:25 +0000 (0:00:00.029)       0:00:03.345 *********
2026-03-17 20:43:25.538147 | controller | ===============================================================================
2026-03-17 20:43:25.538152 | controller | Gathering Facts --------------------------------------------------------- 2.07s
2026-03-17 20:43:25.538157 | controller | Stat file 1 ------------------------------------------------------------- 0.38s
2026-03-17 20:43:25.538161 | controller | Stat file 2 ------------------------------------------------------------- 0.29s
2026-03-17 20:43:25.538166 | controller | Stat removed file 1 ----------------------------------------------------- 0.29s
2026-03-17 20:43:25.538171 | controller | Stat removed file 2 ----------------------------------------------------- 0.28s
2026-03-17 20:43:25.538175 | controller | ansible.builtin.assert -------------------------------------------------- 0.03s
2026-03-17 20:43:25.620472 | controller | INFO     [upload-helm-chart > verify] Executed: Successful
2026-03-17 20:43:25.632681 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-03-17 20:43:25.633040 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-17 20:43:25.638522 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-03-17 20:43:25.638624 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-03-17 20:43:25.638714 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-03-17 20:43:25.639022 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-03-17 20:43:25.873059 | controller | ok: Runtime: 0:00:42.529542
2026-03-17 20:43:25.877737 | 
2026-03-17 20:43:26.193861 | PLAY RECAP
2026-03-17 20:43:26.194070 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-17 20:43:26.194111 | 
2026-03-17 20:43:26.349916 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-03-17 20:43:26.351349 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-03-17 20:43:27.114615 | 
2026-03-17 20:43:27.254997 | PLAY [all]
2026-03-17 20:43:27.272753 | 
2026-03-17 20:43:27.272897 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-03-17 20:43:27.710414 | controller | changed
2026-03-17 20:43:27.718347 | 
2026-03-17 20:43:27.718455 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-03-17 20:43:28.193256 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-17 20:43:28.193362 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-17 20:43:28.199568 | controller | environment: line 1: kubectl: command not found
2026-03-17 20:43:28.203228 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-17 20:43:28.203250 | controller | environment: line 1: kubectl: command not found
2026-03-17 20:43:28.204194 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-17 20:43:28.206958 | controller | environment: line 1: kubectl: command not found
2026-03-17 20:43:28.208182 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-17 20:43:28.209050 | controller | environment: line 1: kubectl: command not found
2026-03-17 20:43:28.209988 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-17 20:43:28.211487 | controller | environment: line 1: kubectl: command not found
2026-03-17 20:43:28.212690 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-17 20:43:28.261741 | controller | ok: Runtime: 0:00:00.031674
2026-03-17 20:43:28.267097 | 
2026-03-17 20:43:28.267189 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-03-17 20:43:28.514390 | controller | changed
2026-03-17 20:43:28.520872 | 
2026-03-17 20:43:28.521071 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-03-17 20:43:28.770259 | controller | environment: line 5: kubectl: command not found
2026-03-17 20:43:28.770710 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-17 20:43:28.771042 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-17 20:43:28.771467 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-17 20:43:29.048752 | controller | ok: Runtime: 0:00:00.014231
2026-03-17 20:43:29.056084 | 
2026-03-17 20:43:29.056178 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-03-17 20:43:29.813219 | controller | changed:
2026-03-17 20:43:29.813424 | controller | created directory /var/lib/zuul/builds/93ac572dcfc24a4a9b9b412721e402a6/work/logs/controller
2026-03-17 20:43:29.813469 | controller | cd+++++++++ objects/
2026-03-17 20:43:29.813503 | controller | cd+++++++++ objects/cluster/
2026-03-17 20:43:29.813537 | controller | cd+++++++++ objects/namespaced/
2026-03-17 20:43:29.821335 | 
2026-03-17 20:43:29.821438 | TASK [gather-pod-logs : creating directory for pod logs]
2026-03-17 20:43:30.076583 | controller | changed
2026-03-17 20:43:30.081041 | 
2026-03-17 20:43:30.081119 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-03-17 20:43:30.326885 | controller | changed
2026-03-17 20:43:30.332867 | 
2026-03-17 20:43:30.332945 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-03-17 20:43:30.564237 | controller | environment: line 3: kubectl: command not found
2026-03-17 20:43:30.862432 | controller | ok: Runtime: 0:00:00.009636
2026-03-17 20:43:30.868466 | 
2026-03-17 20:43:30.868571 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-03-17 20:43:31.578472 | controller | changed:
2026-03-17 20:43:31.580210 | controller | cd+++++++++ pod-logs/
2026-03-17 20:43:31.580364 | controller | cd+++++++++ pod-logs/failed-pods/
2026-03-17 20:43:31.589923 | 
2026-03-17 20:43:31.590009 | LOOP [helm-release-status : creating directory for helm release status]
2026-03-17 20:43:31.853713 | controller | changed: "values"
2026-03-17 20:43:32.063938 | controller | changed: "releases"
2026-03-17 20:43:32.075059 | 
2026-03-17 20:43:32.075265 | TASK [helm-release-status : Gather get release status for helm charts]
2026-03-17 20:43:32.315637 | controller | /bin/bash: line 3: kubectl: command not found
2026-03-17 20:43:32.620513 | controller | ok: Runtime: 0:00:00.008492
2026-03-17 20:43:32.625396 | 
2026-03-17 20:43:32.625474 | TASK [helm-release-status : Downloads logs to executor]
2026-03-17 20:43:33.167527 | controller | changed:
2026-03-17 20:43:33.168217 | controller | cd+++++++++ helm/
2026-03-17 20:43:33.168263 | controller | cd+++++++++ helm/releases/
2026-03-17 20:43:33.168296 | controller | cd+++++++++ helm/values/
2026-03-17 20:43:33.175269 | 
2026-03-17 20:43:33.175328 | PLAY RECAP
2026-03-17 20:43:33.175394 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-17 20:43:33.175491 | 
2026-03-17 20:43:33.373725 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-03-17 20:43:33.376400 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-17 20:43:34.034146 | 
2026-03-17 20:43:43.410286 | PLAY [all]
2026-03-17 20:43:43.430900 | 
2026-03-17 20:43:43.431277 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-17 20:43:43.476127 | controller | skipping: Conditional result was False
2026-03-17 20:43:43.482513 | 
2026-03-17 20:43:43.482651 | TASK [fetch-output : Set log path for single node]
2026-03-17 20:43:43.512675 | controller | ok
2026-03-17 20:43:43.516684 | 
2026-03-17 20:43:43.516758 | LOOP [fetch-output : Ensure local output dirs]
2026-03-17 20:43:43.918675 | controller -> localhost | ok: "/var/lib/zuul/builds/93ac572dcfc24a4a9b9b412721e402a6/work/logs"
2026-03-17 20:43:44.184342 | controller -> localhost | changed: "/var/lib/zuul/builds/93ac572dcfc24a4a9b9b412721e402a6/work/artifacts"
2026-03-17 20:43:44.941468 | controller -> localhost | changed: "/var/lib/zuul/builds/93ac572dcfc24a4a9b9b412721e402a6/work/docs"
2026-03-17 20:43:44.953859 | 
2026-03-17 20:43:44.953997 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-17 20:43:45.644195 | controller | changed: .d..t...... ./
2026-03-17 20:43:45.644499 | controller | changed: All items complete
2026-03-17 20:43:45.644547 | 
2026-03-17 20:43:46.149285 | controller | changed: .d..t...... ./
2026-03-17 20:43:46.651185 | controller | changed: .d..t...... ./
2026-03-17 20:43:46.671641 | 
2026-03-17 20:43:46.671846 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-03-17 20:43:47.149781 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008213
2026-03-17 20:43:47.384222 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006289
2026-03-17 20:43:47.404340 | 
2026-03-17 20:43:47.404466 | PLAY [all]
2026-03-17 20:43:47.409590 | 
2026-03-17 20:43:47.409664 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-03-17 20:43:47.909204 | controller | changed
2026-03-17 20:43:47.916322 | 
2026-03-17 20:43:47.916441 | PLAY RECAP
2026-03-17 20:43:47.916515 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-03-17 20:43:47.916549 | 
2026-03-17 20:43:48.118647 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-17 20:43:48.121069 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-03-17 20:43:48.730915 | 
2026-03-17 20:43:48.731069 | PLAY [localhost]
2026-03-17 20:43:48.741281 | 
2026-03-17 20:43:48.741368 | TASK [Generate Zuul manifest]
2026-03-17 20:43:48.763746 | localhost | ok
2026-03-17 20:43:48.780556 | 
2026-03-17 20:43:48.780762 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-03-17 20:43:49.174734 | localhost | changed
2026-03-17 20:43:49.186358 | 
2026-03-17 20:43:49.186434 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-03-17 20:43:50.521095 | localhost | ok
2026-03-17 20:43:50.528823 | 
2026-03-17 20:43:50.528936 | TASK [Upload logs]
2026-03-17 20:43:50.562164 | localhost | ok
2026-03-17 20:43:50.633064 | 
2026-03-17 20:43:50.633212 | TASK [Set zuul-log-path fact]
2026-03-17 20:43:50.655713 | localhost | ok
2026-03-17 20:43:50.667514 | 
2026-03-17 20:43:50.667586 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-17 20:43:50.695747 | localhost | ok
2026-03-17 20:43:50.702629 | 
2026-03-17 20:43:50.702697 | TASK [upload-logs : Create log directories]
2026-03-17 20:43:51.145367 | localhost | changed
2026-03-17 20:43:51.151128 | 
2026-03-17 20:43:51.151228 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-03-17 20:43:51.577691 | localhost -> localhost | ok: Runtime: 0:00:00.010284
2026-03-17 20:43:51.583299 | 
2026-03-17 20:43:51.583382 | TASK [upload-logs : Upload logs to log server]
2026-03-17 20:43:52.092372 | localhost | Output suppressed because no_log was given
2026-03-17 20:43:52.097866 | 
2026-03-17 20:43:52.097975 | LOOP [upload-logs : Compress console log and json output]
2026-03-17 20:43:52.146895 | localhost | skipping: Conditional result was False
2026-03-17 20:43:52.153291 | localhost | skipping: Conditional result was False
2026-03-17 20:43:52.165851 | 
2026-03-17 20:43:52.166091 | LOOP [upload-logs : Upload compressed console log and json output]
2026-03-17 20:43:52.211153 | localhost | skipping: Conditional result was False
2026-03-17 20:43:52.211553 | 
2026-03-17 20:43:52.225576 | localhost | skipping: Conditional result was False
2026-03-17 20:43:52.245089 | 
2026-03-17 20:43:52.245305 | LOOP [upload-logs : Upload console log and json output]