2026-10-27 18:08:08.283846 | Job console starting
2026-10-27 18:08:08.319781 | Updating git repos
2026-10-27 18:08:17.577619 | Cloning repos into workspace
2026-10-27 18:08:31.025848 | Restoring repo states
2026-10-27 18:08:38.323875 | Merging changes
2026-10-27 18:08:39.145855 | Checking out repos
2026-10-27 18:08:40.320761 | Preparing playbooks
2026-10-27 18:08:43.244411 | Running Ansible setup
2026-10-27 18:08:48.852356 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-10-27 18:08:49.483716 | 
2026-10-27 18:08:49.483841 | PLAY [localhost]
2026-10-27 18:08:49.490578 | 
2026-10-27 18:08:49.490659 | TASK [Gathering Facts]
2026-10-27 18:08:50.530877 | localhost | ok
2026-10-27 18:08:50.559544 | 
2026-10-27 18:08:50.559995 | TASK [Setup log path fact]
2026-10-27 18:08:50.581726 | localhost | ok
2026-10-27 18:08:50.601999 | 
2026-10-27 18:08:50.602134 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-10-27 18:08:50.631235 | localhost | ok
2026-10-27 18:08:50.651917 | 
2026-10-27 18:08:50.652026 | TASK [emit-job-header : Print job information]
2026-10-27 18:08:50.679128 | # Job Information
2026-10-27 18:08:50.679289 | Ansible Version: 2.16.18
2026-10-27 18:08:50.679322 | Job: ansible-collection-kubernetes-molecule-cluster-upgrade
2026-10-27 18:08:50.679344 | Pipeline: check
2026-10-27 18:08:50.679364 | Executor: 2d72f0692154
2026-10-27 18:08:50.679382 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/317
2026-10-27 18:08:50.679403 | Event ID: c16e4040-d22f-11f1-861b-ceae788c834f
2026-10-27 18:08:50.682563 | 
2026-10-27 18:08:50.682626 | LOOP [emit-job-header : Print node information]
2026-10-27 18:08:50.750825 | localhost | ok:
2026-10-27 18:08:50.750985 | localhost | # Node Information
2026-10-27 18:08:50.751012 | localhost | Inventory Hostname: controller-1
2026-10-27 18:08:50.751032 | localhost | Hostname: np0000197311
2026-10-27 18:08:50.751049 | localhost | Username: zuul
2026-10-27 18:08:50.751069 | localhost | Distro: Debian 13.7
2026-10-27 18:08:50.751086 | localhost | Provider: yul1
2026-10-27 18:08:50.751103 | localhost | Region: ca-ymq-1
2026-10-27 18:08:50.751119 | localhost | Label: debian-trixie
2026-10-27 18:08:50.751135 | localhost | Product Name: OpenStack Nova
2026-10-27 18:08:50.751151 | localhost | Interface IP: 162.253.55.45
2026-10-27 18:08:50.782639 | localhost | ok:
2026-10-27 18:08:50.782729 | localhost | # Node Information
2026-10-27 18:08:50.782753 | localhost | Inventory Hostname: controller-2
2026-10-27 18:08:50.782772 | localhost | Hostname: np0000197312
2026-10-27 18:08:50.782789 | localhost | Username: zuul
2026-10-27 18:08:50.782806 | localhost | Distro: Debian 13.7
2026-10-27 18:08:50.782822 | localhost | Provider: yul1
2026-10-27 18:08:50.782838 | localhost | Region: ca-ymq-1
2026-10-27 18:08:50.782854 | localhost | Label: debian-trixie
2026-10-27 18:08:50.782870 | localhost | Product Name: OpenStack Nova
2026-10-27 18:08:50.782886 | localhost | Interface IP: 162.253.55.156
2026-10-27 18:08:50.812998 | localhost | ok:
2026-10-27 18:08:50.813105 | localhost | # Node Information
2026-10-27 18:08:50.813131 | localhost | Inventory Hostname: controller-3
2026-10-27 18:08:50.813150 | localhost | Hostname: np0000197313
2026-10-27 18:08:50.813167 | localhost | Username: zuul
2026-10-27 18:08:50.813185 | localhost | Distro: Debian 13.7
2026-10-27 18:08:50.813201 | localhost | Provider: yul1
2026-10-27 18:08:50.813217 | localhost | Region: ca-ymq-1
2026-10-27 18:08:50.813233 | localhost | Label: debian-trixie
2026-10-27 18:08:50.813251 | localhost | Product Name: OpenStack Nova
2026-10-27 18:08:50.813269 | localhost | Interface IP: 162.253.55.108
2026-10-27 18:08:50.822469 | 
2026-10-27 18:08:50.822830 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-10-27 18:08:51.199683 | localhost -> localhost | changed
2026-10-27 18:08:51.204126 | 
2026-10-27 18:08:51.204201 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-10-27 18:08:51.982902 | localhost -> localhost | changed
2026-10-27 18:08:51.990716 | 
2026-10-27 18:08:51.990837 | PLAY [all]
2026-10-27 18:08:52.004607 | 
2026-10-27 18:08:52.004740 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-10-27 18:08:52.243395 | controller-1 -> localhost | ok
2026-10-27 18:08:52.260604 | 
2026-10-27 18:08:52.260744 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-10-27 18:08:52.293492 | controller-1 | ok
2026-10-27 18:08:52.297038 | controller-2 | ok
2026-10-27 18:08:52.325276 | controller-3 | ok
2026-10-27 18:08:52.344435 | controller-1 | included: /var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-10-27 18:08:52.344547 | controller-2 | included: /var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-10-27 18:08:52.344571 | controller-3 | included: /var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-10-27 18:08:52.351146 | 
2026-10-27 18:08:52.351248 | TASK [add-build-sshkey : Create Temp SSH key]
2026-10-27 18:08:53.775153 | controller-1 -> localhost | Generating public/private rsa key pair.
2026-10-27 18:08:53.775360 | controller-1 -> localhost | Your identification has been saved in /var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/work/b8ef401056074202a6827cfe73a67c8b_id_rsa
2026-10-27 18:08:53.775412 | controller-1 -> localhost | Your public key has been saved in /var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/work/b8ef401056074202a6827cfe73a67c8b_id_rsa.pub
2026-10-27 18:08:53.775451 | controller-1 -> localhost | The key fingerprint is:
2026-10-27 18:08:53.775489 | controller-1 -> localhost | SHA256:NGshMJ29hHa4pt/iFRm/PfnVzw7lVTjmajvxLAeD3/A zuul-build-sshkey
2026-10-27 18:08:53.775525 | controller-1 -> localhost | The key's randomart image is:
2026-10-27 18:08:53.775561 | controller-1 -> localhost | +---[RSA 3072]----+
2026-10-27 18:08:53.775596 | controller-1 -> localhost | |    o. =         |
2026-10-27 18:08:53.775632 | controller-1 -> localhost | |     o* +      . |
2026-10-27 18:08:53.775668 | controller-1 -> localhost | |     ..+=.    + .|
2026-10-27 18:08:53.775702 | controller-1 -> localhost | |      oo.B   o ..|
2026-10-27 18:08:53.775733 | controller-1 -> localhost | |     o  S ..  . o|
2026-10-27 18:08:53.775758 | controller-1 -> localhost | |    .  . ..o=o oo|
2026-10-27 18:08:53.775783 | controller-1 -> localhost | |     . .. ..*X. +|
2026-10-27 18:08:53.775807 | controller-1 -> localhost | |      o..  .++E+.|
2026-10-27 18:08:53.775831 | controller-1 -> localhost | |     ...    .+..+|
2026-10-27 18:08:53.775856 | controller-1 -> localhost | +----[SHA256]-----+
2026-10-27 18:08:53.775915 | controller-1 -> localhost | ok: Runtime: 0:00:01.007645
2026-10-27 18:08:53.781977 | 
2026-10-27 18:08:53.782072 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-10-27 18:08:53.804036 | controller-1 | ok
2026-10-27 18:08:53.817429 | controller-2 | ok
2026-10-27 18:08:53.842539 | controller-3 | ok
2026-10-27 18:08:53.861524 | controller-1 | included: /var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-10-27 18:08:53.861650 | controller-2 | included: /var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-10-27 18:08:53.861678 | controller-3 | included: /var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-10-27 18:08:53.873425 | 
2026-10-27 18:08:53.873530 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-10-27 18:08:53.897284 | controller-1 | skipping: Conditional result was False
2026-10-27 18:08:53.908616 | controller-2 | skipping: Conditional result was False
2026-10-27 18:08:53.908876 | controller-3 | skipping: Conditional result was False
2026-10-27 18:08:53.913599 | 
2026-10-27 18:08:53.913678 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-10-27 18:08:54.477958 | controller-3 | changed
2026-10-27 18:08:54.543157 | controller-1 | changed
2026-10-27 18:08:54.549471 | controller-2 | changed
2026-10-27 18:08:54.557744 | 
2026-10-27 18:08:54.557876 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-10-27 18:08:54.776616 | controller-3 | ok
2026-10-27 18:08:54.779658 | controller-1 | ok
2026-10-27 18:08:54.803872 | controller-2 | ok
2026-10-27 18:08:54.809826 | 
2026-10-27 18:08:54.809910 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-10-27 18:08:55.382714 | controller-2 | changed
2026-10-27 18:08:55.387139 | controller-3 | changed
2026-10-27 18:08:55.391554 | controller-1 | changed
2026-10-27 18:08:55.437817 | 
2026-10-27 18:08:55.437944 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-10-27 18:08:56.002053 | controller-2 | changed
2026-10-27 18:08:56.009731 | controller-1 | changed
2026-10-27 18:08:56.028272 | controller-3 | changed
2026-10-27 18:08:56.038075 | 
2026-10-27 18:08:56.038170 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-10-27 18:08:56.072065 | controller-1 | skipping: Conditional result was False
2026-10-27 18:08:56.083270 | controller-2 | skipping: Conditional result was False
2026-10-27 18:08:56.093702 | controller-3 | skipping: Conditional result was False
2026-10-27 18:08:56.098969 | 
2026-10-27 18:08:56.099057 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-10-27 18:08:56.414494 | controller-1 -> localhost | changed
2026-10-27 18:08:56.455548 | 
2026-10-27 18:08:56.455749 | TASK [add-build-sshkey : Add back temp key]
2026-10-27 18:08:56.768792 | controller-1 -> localhost | Identity added: /var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/work/b8ef401056074202a6827cfe73a67c8b_id_rsa (zuul-build-sshkey)
2026-10-27 18:08:56.768984 | controller-1 -> localhost | ok: Runtime: 0:00:00.011791
2026-10-27 18:08:56.777101 | 
2026-10-27 18:08:56.777177 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-10-27 18:08:57.045550 | controller-2 | ok
2026-10-27 18:08:57.074009 | controller-3 | ok
2026-10-27 18:08:57.089254 | controller-1 | ok
2026-10-27 18:08:57.098074 | 
2026-10-27 18:08:57.098163 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-10-27 18:08:57.137528 | controller-1 | skipping: Conditional result was False
2026-10-27 18:08:57.149006 | controller-2 | skipping: Conditional result was False
2026-10-27 18:08:57.149340 | controller-3 | skipping: Conditional result was False
2026-10-27 18:08:57.173434 | 
2026-10-27 18:08:57.173560 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-10-27 18:08:57.483477 | controller-1 | ok
2026-10-27 18:08:57.489305 | controller-3 | ok
2026-10-27 18:08:57.494826 | controller-2 | ok
2026-10-27 18:08:57.502831 | 
2026-10-27 18:08:57.502965 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-10-27 18:09:01.860922 | controller-2 | Output suppressed because no_log was given
2026-10-27 18:09:01.986443 | controller-3 | Output suppressed because no_log was given
2026-10-27 18:09:02.009773 | controller-1 | Output suppressed because no_log was given
2026-10-27 18:09:02.021953 | 
2026-10-27 18:09:02.022036 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-10-27 18:09:02.256823 | controller-1 | ok: "logs"
2026-10-27 18:09:02.257016 | controller-1 | ok: All items complete
2026-10-27 18:09:02.257042 | 
2026-10-27 18:09:02.259946 | controller-2 | ok: "logs"
2026-10-27 18:09:02.330290 | controller-3 | ok: "logs"
2026-10-27 18:09:02.443476 | controller-2 | ok: "artifacts"
2026-10-27 18:09:02.465307 | controller-1 | ok: "artifacts"
2026-10-27 18:09:02.541562 | controller-3 | ok: "artifacts"
2026-10-27 18:09:02.661010 | controller-1 | ok: "docs"
2026-10-27 18:09:02.715090 | controller-3 | ok: "docs"
2026-10-27 18:09:02.758521 | controller-2 | ok: "docs"
2026-10-27 18:09:02.758628 | controller-2 | ok: All items complete
2026-10-27 18:09:02.758677 | 
2026-10-27 18:09:02.768197 | 
2026-10-27 18:09:02.768330 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-10-27 18:09:02.991608 | controller-1 | changed: "logs"
2026-10-27 18:09:03.009259 | controller-2 | changed: "logs"
2026-10-27 18:09:03.015605 | controller-3 | changed: "logs"
2026-10-27 18:09:03.197326 | controller-1 | changed: "artifacts"
2026-10-27 18:09:03.211960 | controller-2 | changed: "artifacts"
2026-10-27 18:09:03.217484 | controller-3 | changed: "artifacts"
2026-10-27 18:09:03.386643 | controller-3 | changed: "docs"
2026-10-27 18:09:03.391861 | controller-1 | changed: "docs"
2026-10-27 18:09:03.398013 | controller-2 | changed: "docs"
2026-10-27 18:09:03.398082 | controller-2 | changed: All items complete
2026-10-27 18:09:03.398113 | 
2026-10-27 18:09:03.418363 | 
2026-10-27 18:09:03.418454 | PLAY RECAP
2026-10-27 18:09:03.418494 | controller-1 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-10-27 18:09:03.418519 | controller-2 | ok: 11 changed: 5 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-10-27 18:09:03.418541 | controller-3 | ok: 11 changed: 5 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-10-27 18:09:03.418562 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-10-27 18:09:03.418578 | 
2026-10-27 18:09:03.536574 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-10-27 18:09:03.539291 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-10-27 18:09:04.199675 | 
2026-10-27 18:09:04.199903 | PLAY [all]
2026-10-27 18:09:04.210949 | 
2026-10-27 18:09:04.211052 | TASK [setup-uv : Extract archive]
2026-10-27 18:09:06.831207 | controller-1 | changed
2026-10-27 18:09:06.849091 | controller-3 | changed
2026-10-27 18:09:06.968254 | controller-2 | changed
2026-10-27 18:09:06.979557 | 
2026-10-27 18:09:06.979824 | TASK [setup-uv : Print version]
2026-10-27 18:09:07.392968 | controller-1 | uv 0.8.13
2026-10-27 18:09:07.391091 | controller-3 | uv 0.8.13
2026-10-27 18:09:07.417490 | controller-2 | uv 0.8.13
2026-10-27 18:09:07.556811 | controller-1 | ok: Runtime: 0:00:00.011693
2026-10-27 18:09:07.564717 | controller-3 | ok: Runtime: 0:00:00.016793
2026-10-27 18:09:07.571983 | controller-2 | ok: Runtime: 0:00:00.015737
2026-10-27 18:09:07.587570 | 
2026-10-27 18:09:07.587652 | TASK [Install Ansible collection siblings]
2026-10-27 18:09:09.347988 | controller-1 | ERROR
2026-10-27 18:09:09.348266 | controller-1 | {
2026-10-27 18:09:09.348314 | controller-1 |   "log": [
2026-10-27 18:09:09.348343 | controller-1 |     "Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix",
2026-10-27 18:09:09.348382 | controller-1 |     "Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto",
2026-10-27 18:09:09.348407 | controller-1 |     "Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general",
2026-10-27 18:09:09.348429 | controller-1 |     "Sibling collection community.library_inventory_filtering_v1 at /home/zuul/src/github.com/ansible-collections/community.library_inventory_filtering",
2026-10-27 18:09:09.348450 | controller-1 |     "Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core",
2026-10-27 18:09:09.348471 | controller-1 |     "Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers",
2026-10-27 18:09:09.348529 | controller-1 |     "Resolved ansible.posix to 2.2.2 for >=1.6.0",
2026-10-27 18:09:09.348565 | controller-1 |     "Resolved community.crypto to 3.5.1 for >=2.2.3",
2026-10-27 18:09:09.348603 | controller-1 |     "Resolved community.general to 13.5.0 for >=4.5.0",
2026-10-27 18:09:09.348634 | controller-1 |     "Resolved kubernetes.core to 6.6.0 for >=2.3.2",
2026-10-27 18:09:09.348656 | controller-1 |     "Resolved vexxhost.containers to v1.6.8 for >=1.6.0",
2026-10-27 18:09:09.348677 | controller-1 |     "Resolved community.library_inventory_filtering_v1 to 1.1.5 for >=1.0.0",
2026-10-27 18:09:09.348698 | controller-1 |     "Checked out ansible.posix to 2.2.2",
2026-10-27 18:09:09.348719 | controller-1 |     "Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix",
2026-10-27 18:09:09.348745 | controller-1 |     "Using CPython 3.13.5 interpreter at: /usr/bin/python3",
2026-10-27 18:09:09.348768 | controller-1 |     "Creating virtual environment at: .venv",
2026-10-27 18:09:09.348789 | controller-1 |     "Downloading ansible-core (2.3MiB)",
2026-10-27 18:09:09.348811 | controller-1 |     "Downloading pygments (1.2MiB)",
2026-10-27 18:09:09.348831 | controller-1 |     "Downloading cryptography (4.3MiB)",
2026-10-27 18:09:09.348851 | controller-1 |     "Downloading pygments (1.2MiB)",
2026-10-27 18:09:09.348872 | controller-1 |     "Downloading cryptography (4.3MiB)",
2026-10-27 18:09:09.348893 | controller-1 |     "Downloading ansible-core (2.3MiB)",
2026-10-27 18:09:09.348912 | controller-1 |     "  \u00d7 Failed to download `cryptography==46.0.3`",
2026-10-27 18:09:09.348937 | controller-1 |     "  \u251c\u2500\u25b6 Failed to write to the distribution cache",
2026-10-27 18:09:09.348958 | controller-1 |     "  \u251c\u2500\u25b6 error decoding response body",
2026-10-27 18:09:09.348979 | controller-1 |     "  \u251c\u2500\u25b6 request or response body error",
2026-10-27 18:09:09.348999 | controller-1 |     "  \u251c\u2500\u25b6 error reading a body from connection",
2026-10-27 18:09:09.349020 | controller-1 |     "  \u2570\u2500\u25b6 connection reset",
2026-10-27 18:09:09.349040 | controller-1 |     "  help: `cryptography` (v46.0.3) was included because",
2026-10-27 18:09:09.349060 | controller-1 |     "        `ansible-collection-kubernetes` (v3.4.1) depends on `ansible-core`",
2026-10-27 18:09:09.349080 | controller-1 |     "        (v2.20.1) which depends on `cryptography`"
2026-10-27 18:09:09.349101 | controller-1 |   ],
2026-10-27 18:09:09.349121 | controller-1 |   "msg": "Command failed: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix",
2026-10-27 18:09:09.349146 | controller-1 |   "rc": 1
2026-10-27 18:09:09.349169 | controller-1 | }
failure
2026-10-27 18:09:09.352240 | 
2026-10-27 18:09:09.352307 | PLAY RECAP
2026-10-27 18:09:09.352398 | controller-1 | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-10-27 18:09:09.352442 | controller-2 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-10-27 18:09:09.352472 | controller-3 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-10-27 18:09:09.352584 | 
2026-10-27 18:09:09.470151 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-10-27 18:09:09.472859 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-10-27 18:09:10.066773 | 
2026-10-27 18:09:10.066873 | PLAY [all]
2026-10-27 18:09:10.076288 | 
2026-10-27 18:09:10.076356 | TASK [fetch-output : Set log path for multiple nodes]
2026-10-27 18:09:10.137080 | controller-1 | ok
2026-10-27 18:09:10.142112 | controller-2 | ok
2026-10-27 18:09:10.155723 | controller-3 | ok
2026-10-27 18:09:10.159712 | 
2026-10-27 18:09:10.159824 | TASK [fetch-output : Set log path for single node]
2026-10-27 18:09:10.188916 | controller-1 | skipping: Conditional result was False
2026-10-27 18:09:10.199857 | controller-2 | skipping: Conditional result was False
2026-10-27 18:09:10.210273 | controller-3 | skipping: Conditional result was False
2026-10-27 18:09:10.215387 | 
2026-10-27 18:09:10.215489 | LOOP [fetch-output : Ensure local output dirs]
2026-10-27 18:09:10.629335 | controller-3 -> localhost | changed: "/var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/work/logs/controller-3"
2026-10-27 18:09:10.649889 | controller-1 -> localhost | changed: "/var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/work/logs/controller-1"
2026-10-27 18:09:10.698771 | controller-2 -> localhost | changed: "/var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/work/logs/controller-2"
2026-10-27 18:09:10.827499 | controller-3 -> localhost | changed: "/var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/work/artifacts"
2026-10-27 18:09:10.875199 | controller-1 -> localhost | ok: "/var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/work/artifacts"
2026-10-27 18:09:10.904756 | controller-2 -> localhost | ok: "/var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/work/artifacts"
2026-10-27 18:09:11.060315 | controller-3 -> localhost | changed: "/var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/work/docs"
2026-10-27 18:09:11.072573 | controller-1 -> localhost | ok: "/var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/work/docs"
2026-10-27 18:09:11.072654 | controller-1 -> localhost | changed: All items complete
2026-10-27 18:09:11.072677 | 
2026-10-27 18:09:11.113684 | controller-2 -> localhost | ok: "/var/lib/zuul/builds/b8ef401056074202a6827cfe73a67c8b/work/docs"
2026-10-27 18:09:11.126645 | 
2026-10-27 18:09:11.126777 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-10-27 18:09:11.790581 | controller-2 | changed: .d..t...... ./
2026-10-27 18:09:11.790769 | controller-2 | changed: All items complete
2026-10-27 18:09:11.790794 | 
2026-10-27 18:09:11.834496 | controller-3 | changed: .d..t...... ./
2026-10-27 18:09:11.837582 | controller-1 | changed: .d..t...... ./
2026-10-27 18:09:12.284442 | controller-2 | changed: .d..t...... ./
2026-10-27 18:09:12.305227 | controller-1 | ok
2026-10-27 18:09:12.332016 | controller-3 | ok
2026-10-27 18:09:12.730918 | controller-1 | changed: .d..t...... ./
2026-10-27 18:09:12.781557 | controller-2 | ok
2026-10-27 18:09:12.825017 | controller-3 | ok
2026-10-27 18:09:12.825133 | controller-3 | changed: All items complete
2026-10-27 18:09:12.825189 | 
2026-10-27 18:09:12.857163 | 
2026-10-27 18:09:12.857376 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-10-27 18:09:13.393627 | controller-1 -> localhost | ok: Item: artifacts Runtime: 0:00:00.011504
2026-10-27 18:09:13.626410 | controller-1 -> localhost | ok: Item: docs Runtime: 0:00:00.006698
2026-10-27 18:09:13.659618 | 
2026-10-27 18:09:13.659732 | PLAY [all]
2026-10-27 18:09:13.669265 | 
2026-10-27 18:09:13.669360 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-10-27 18:09:14.142904 | controller-1 | changed
2026-10-27 18:09:14.159044 | controller-3 | changed
2026-10-27 18:09:14.164371 | controller-2 | changed
2026-10-27 18:09:14.200700 | 
2026-10-27 18:09:14.200839 | PLAY RECAP
2026-10-27 18:09:14.200924 | controller-1 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-10-27 18:09:14.200978 | controller-2 | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-10-27 18:09:14.201025 | controller-3 | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-10-27 18:09:14.201119 | 
2026-10-27 18:09:14.340044 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-10-27 18:09:14.345035 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-10-27 18:09:14.883997 | 
2026-10-27 18:09:14.884108 | PLAY [localhost]
2026-10-27 18:09:14.892997 | 
2026-10-27 18:09:14.893072 | TASK [Generate Zuul manifest]
2026-10-27 18:09:14.909413 | localhost | ok
2026-10-27 18:09:14.922110 | 
2026-10-27 18:09:14.922197 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-10-27 18:09:15.296130 | localhost | changed
2026-10-27 18:09:15.335506 | 
2026-10-27 18:09:15.335675 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-10-27 18:09:15.396982 | localhost | ok
2026-10-27 18:09:15.409660 | 
2026-10-27 18:09:15.409790 | TASK [Upload logs]
2026-10-27 18:09:15.433539 | localhost | ok
2026-10-27 18:09:15.502889 | 
2026-10-27 18:09:15.503006 | TASK [Set zuul-log-path fact]
2026-10-27 18:09:15.519322 | localhost | ok
2026-10-27 18:09:15.530310 | 
2026-10-27 18:09:15.530407 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-10-27 18:09:15.557363 | localhost | ok
2026-10-27 18:09:15.565616 | 
2026-10-27 18:09:15.565703 | TASK [upload-logs : Create log directories]
2026-10-27 18:09:15.958233 | localhost | changed
2026-10-27 18:09:15.988853 | 
2026-10-27 18:09:15.988957 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-10-27 18:09:16.304480 | localhost -> localhost | ok: Runtime: 0:00:00.003585
2026-10-27 18:09:16.312458 | 
2026-10-27 18:09:16.312588 | TASK [upload-logs : Upload logs to log server]
2026-10-27 18:09:16.748325 | localhost | Output suppressed because no_log was given
2026-10-27 18:09:16.756428 | 
2026-10-27 18:09:16.756708 | LOOP [upload-logs : Compress console log and json output]
2026-10-27 18:09:16.826447 | localhost | skipping: Conditional result was False
2026-10-27 18:09:16.836357 | localhost | skipping: Conditional result was False
2026-10-27 18:09:16.854872 | 
2026-10-27 18:09:16.855049 | LOOP [upload-logs : Upload compressed console log and json output]
2026-10-27 18:09:16.901469 | localhost | skipping: Conditional result was False
2026-10-27 18:09:16.901697 | 
2026-10-27 18:09:16.902344 | localhost | skipping: Conditional result was False
2026-10-27 18:09:16.917972 | 
2026-10-27 18:09:16.918146 | LOOP [upload-logs : Upload console log and json output]