2026-06-08 07:44:07.169936 | Job console starting
2026-06-08 07:44:07.179578 | Updating git repos
2026-06-08 07:44:07.651025 | Cloning repos into workspace
2026-06-08 07:44:25.737498 | Restoring repo states
2026-06-08 07:44:37.884391 | Merging changes
2026-06-08 07:44:40.934571 | Checking out repos
2026-06-08 07:44:42.512295 | Preparing playbooks
2026-06-08 07:44:47.544725 | Running Ansible setup
2026-06-08 07:44:51.069160 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-06-08 07:44:51.761552 | 
2026-06-08 07:44:51.761712 | PLAY [localhost]
2026-06-08 07:44:51.770048 | 
2026-06-08 07:44:51.770141 | TASK [Gathering Facts]
2026-06-08 07:44:52.745825 | localhost | ok
2026-06-08 07:44:52.759007 | 
2026-06-08 07:44:52.759163 | TASK [Setup log path fact]
2026-06-08 07:44:52.778243 | localhost | ok
2026-06-08 07:44:52.790954 | 
2026-06-08 07:44:52.791024 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-08 07:44:52.822856 | localhost | ok
2026-06-08 07:44:52.831244 | 
2026-06-08 07:44:52.831335 | TASK [emit-job-header : Print job information]
2026-06-08 07:44:52.873377 | # Job Information
2026-06-08 07:44:52.873659 | Ansible Version: 2.16.18
2026-06-08 07:44:52.873733 | Job: atmosphere-molecule-aio-openvswitch
2026-06-08 07:44:52.873783 | Pipeline: check
2026-06-08 07:44:52.873828 | Executor: 2d72f0692154
2026-06-08 07:44:52.873874 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4002
2026-06-08 07:44:52.873926 | Event ID: 7407a9e0-630d-11f1-8eff-003ad6dab313
2026-06-08 07:44:52.877663 | 
2026-06-08 07:44:52.877739 | LOOP [emit-job-header : Print node information]
2026-06-08 07:44:52.973524 | localhost | ok:
2026-06-08 07:44:52.973830 | localhost | # Node Information
2026-06-08 07:44:52.973894 | localhost | Inventory Hostname: instance
2026-06-08 07:44:52.973944 | localhost | Hostname: np0000178874
2026-06-08 07:44:52.973989 | localhost | Username: zuul
2026-06-08 07:44:52.974039 | localhost | Distro: Ubuntu 22.04
2026-06-08 07:44:52.974083 | localhost | Provider: yul1
2026-06-08 07:44:52.974127 | localhost | Region: ca-ymq-1
2026-06-08 07:44:52.974169 | localhost | Label: ubuntu-jammy-16
2026-06-08 07:44:52.974211 | localhost | Product Name: OpenStack Nova
2026-06-08 07:44:52.974253 | localhost | Interface IP: 199.19.213.140
2026-06-08 07:44:52.993035 | 
2026-06-08 07:44:52.993251 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-06-08 07:44:53.413387 | localhost -> localhost | changed
2026-06-08 07:44:53.419160 | 
2026-06-08 07:44:53.419249 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-06-08 07:44:54.349421 | localhost -> localhost | changed
2026-06-08 07:44:54.358254 | 
2026-06-08 07:44:54.358315 | PLAY [all]
2026-06-08 07:44:54.366892 | 
2026-06-08 07:44:54.367071 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-06-08 07:44:54.606412 | instance -> localhost | ok
2026-06-08 07:44:54.618044 | 
2026-06-08 07:44:54.618166 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-06-08 07:44:54.652528 | instance | ok
2026-06-08 07:44:54.667099 | instance | included: /var/lib/zuul/builds/30213e815a4147ceb93f56e7321300eb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-06-08 07:44:54.672798 | 
2026-06-08 07:44:54.672870 | TASK [add-build-sshkey : Create Temp SSH key]
2026-06-08 07:44:56.492232 | instance -> localhost | Generating public/private rsa key pair.
2026-06-08 07:44:56.492478 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/30213e815a4147ceb93f56e7321300eb/work/30213e815a4147ceb93f56e7321300eb_id_rsa
2026-06-08 07:44:56.492522 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/30213e815a4147ceb93f56e7321300eb/work/30213e815a4147ceb93f56e7321300eb_id_rsa.pub
2026-06-08 07:44:56.492555 | instance -> localhost | The key fingerprint is:
2026-06-08 07:44:56.492587 | instance -> localhost | SHA256:0xhecFzti9XE7xeg0emsp6OL+CntoXBr1W3cesDyPqo zuul-build-sshkey
2026-06-08 07:44:56.492638 | instance -> localhost | The key's randomart image is:
2026-06-08 07:44:56.492669 | instance -> localhost | +---[RSA 3072]----+
2026-06-08 07:44:56.492709 | instance -> localhost | |        ....o... |
2026-06-08 07:44:56.492741 | instance -> localhost | |         o.. +. o|
2026-06-08 07:44:56.492771 | instance -> localhost | |        . . =..o.|
2026-06-08 07:44:56.492800 | instance -> localhost | |       . = . oo.o|
2026-06-08 07:44:56.492829 | instance -> localhost | |        S = oo o.|
2026-06-08 07:44:56.492858 | instance -> localhost | |       . + B.o. o|
2026-06-08 07:44:56.492886 | instance -> localhost | |   . .o.  + =   .|
2026-06-08 07:44:56.492914 | instance -> localhost | |    oo+.+  * .   |
2026-06-08 07:44:56.492947 | instance -> localhost | |    .++E.+=.+    |
2026-06-08 07:44:56.493016 | instance -> localhost | +----[SHA256]-----+
2026-06-08 07:44:56.493094 | instance -> localhost | ok: Runtime: 0:00:01.401927
2026-06-08 07:44:56.499287 | 
2026-06-08 07:44:56.499375 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-06-08 07:44:56.535481 | instance | ok
2026-06-08 07:44:56.546025 | instance | included: /var/lib/zuul/builds/30213e815a4147ceb93f56e7321300eb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-06-08 07:44:56.556320 | 
2026-06-08 07:44:56.556496 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-06-08 07:44:56.582491 | instance | skipping: Conditional result was False
2026-06-08 07:44:56.594070 | 
2026-06-08 07:44:56.594206 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-06-08 07:44:57.023531 | instance | changed
2026-06-08 07:44:57.031018 | 
2026-06-08 07:44:57.031147 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-06-08 07:44:57.265190 | instance | ok
2026-06-08 07:44:57.270582 | 
2026-06-08 07:44:57.270693 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-06-08 07:44:57.743471 | instance | changed
2026-06-08 07:44:57.750599 | 
2026-06-08 07:44:57.750713 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-06-08 07:44:58.212396 | instance | changed
2026-06-08 07:44:58.219284 | 
2026-06-08 07:44:58.219360 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-06-08 07:44:58.243668 | instance | skipping: Conditional result was False
2026-06-08 07:44:58.258587 | 
2026-06-08 07:44:58.258691 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-06-08 07:44:58.598836 | instance -> localhost | changed
2026-06-08 07:44:58.612949 | 
2026-06-08 07:44:58.613154 | TASK [add-build-sshkey : Add back temp key]
2026-06-08 07:44:58.891071 | instance -> localhost | Identity added: /var/lib/zuul/builds/30213e815a4147ceb93f56e7321300eb/work/30213e815a4147ceb93f56e7321300eb_id_rsa (zuul-build-sshkey)
2026-06-08 07:44:58.891342 | instance -> localhost | ok: Runtime: 0:00:00.015197
2026-06-08 07:44:58.897622 | 
2026-06-08 07:44:58.897735 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-06-08 07:44:59.176247 | instance | ok
2026-06-08 07:44:59.182331 | 
2026-06-08 07:44:59.182398 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-06-08 07:44:59.207056 | instance | skipping: Conditional result was False
2026-06-08 07:44:59.230807 | 
2026-06-08 07:44:59.231018 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-06-08 07:44:59.510433 | instance | ok
2026-06-08 07:44:59.517989 | 
2026-06-08 07:44:59.518051 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-06-08 07:45:02.539810 | instance | Output suppressed because no_log was given
2026-06-08 07:45:02.548669 | 
2026-06-08 07:45:02.548731 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-06-08 07:45:02.729548 | instance | ok: "logs"
2026-06-08 07:45:02.729782 | instance | ok: All items complete
2026-06-08 07:45:02.729811 | 
2026-06-08 07:45:02.888103 | instance | ok: "artifacts"
2026-06-08 07:45:03.044624 | instance | ok: "docs"
2026-06-08 07:45:03.057597 | 
2026-06-08 07:45:03.057694 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-06-08 07:45:03.235980 | instance | changed: "logs"
2026-06-08 07:45:03.392574 | instance | changed: "artifacts"
2026-06-08 07:45:03.537175 | instance | changed: "docs"
2026-06-08 07:45:03.558249 | 
2026-06-08 07:45:03.558311 | PLAY RECAP
2026-06-08 07:45:03.558356 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-06-08 07:45:03.558385 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-08 07:45:03.558408 | 
2026-06-08 07:45:03.753750 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-06-08 07:45:03.760430 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-06-08 07:45:04.372203 | 
2026-06-08 07:45:04.372332 | PLAY [all]
2026-06-08 07:45:04.393849 | 
2026-06-08 07:45:04.394052 | TASK [setup-uv : Extract archive]
2026-06-08 07:45:15.360199 | instance | ERROR
2026-06-08 07:45:15.360521 | instance | {
2026-06-08 07:45:15.360576 | instance |   "msg": "Failure downloading https://github.com/astral-sh/uv/releases/download/0.8.13/uv-x86_64-unknown-linux-gnu.tar.gz, Connection failure: The read operation timed out"
2026-06-08 07:45:15.360618 | instance | }
failure
2026-06-08 07:45:15.362209 | 
2026-06-08 07:45:15.362267 | PLAY RECAP
2026-06-08 07:45:15.362327 | instance | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-06-08 07:45:15.362360 | 
2026-06-08 07:45:15.508256 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-06-08 07:45:15.522224 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-06-08 07:45:16.144492 | 
2026-06-08 07:45:16.144633 | PLAY [all]
2026-06-08 07:45:16.155894 | 
2026-06-08 07:45:16.155973 | TASK [fetch-output : Set log path for multiple nodes]
2026-06-08 07:45:16.200863 | instance | skipping: Conditional result was False
2026-06-08 07:45:16.207044 | 
2026-06-08 07:45:16.207151 | TASK [fetch-output : Set log path for single node]
2026-06-08 07:45:16.252307 | instance | ok
2026-06-08 07:45:16.256906 | 
2026-06-08 07:45:16.256977 | LOOP [fetch-output : Ensure local output dirs]
2026-06-08 07:45:16.651203 | instance -> localhost | ok: "/var/lib/zuul/builds/30213e815a4147ceb93f56e7321300eb/work/logs"
2026-06-08 07:45:16.861208 | instance -> localhost | changed: "/var/lib/zuul/builds/30213e815a4147ceb93f56e7321300eb/work/artifacts"
2026-06-08 07:45:17.077852 | instance -> localhost | changed: "/var/lib/zuul/builds/30213e815a4147ceb93f56e7321300eb/work/docs"
2026-06-08 07:45:17.100048 | 
2026-06-08 07:45:17.100239 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-06-08 07:45:17.718076 | instance | ok
2026-06-08 07:45:17.718844 | instance | changed: All items complete
2026-06-08 07:45:17.718886 | 
2026-06-08 07:45:18.167495 | instance | changed: .d..t...... ./
2026-06-08 07:45:18.642970 | instance | changed: .d..t...... ./
2026-06-08 07:45:18.667092 | 
2026-06-08 07:45:18.667297 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-06-08 07:45:19.129382 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006561
2026-06-08 07:45:19.365556 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008390
2026-06-08 07:45:19.384640 | 
2026-06-08 07:45:19.384777 | PLAY [all]
2026-06-08 07:45:19.392015 | 
2026-06-08 07:45:19.392092 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-06-08 07:45:19.813360 | instance | changed
2026-06-08 07:45:19.819158 | 
2026-06-08 07:45:19.819213 | PLAY RECAP
2026-06-08 07:45:19.819260 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-08 07:45:19.819281 | 
2026-06-08 07:45:19.956520 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-06-08 07:45:19.964756 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-06-08 07:45:20.600287 | 
2026-06-08 07:45:20.600451 | PLAY [localhost]
2026-06-08 07:45:20.611029 | 
2026-06-08 07:45:20.611159 | TASK [Generate Zuul manifest]
2026-06-08 07:45:20.629584 | localhost | ok
2026-06-08 07:45:20.644228 | 
2026-06-08 07:45:20.644376 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-06-08 07:45:21.006482 | localhost | changed
2026-06-08 07:45:21.017860 | 
2026-06-08 07:45:21.017952 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-06-08 07:45:21.046464 | localhost | ok
2026-06-08 07:45:21.053314 | 
2026-06-08 07:45:21.053432 | TASK [Upload logs]
2026-06-08 07:45:21.073416 | localhost | ok
2026-06-08 07:45:21.206058 | 
2026-06-08 07:45:21.206213 | TASK [Set zuul-log-path fact]
2026-06-08 07:45:21.227646 | localhost | ok
2026-06-08 07:45:21.241625 | 
2026-06-08 07:45:21.241708 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-08 07:45:21.275961 | localhost | ok
2026-06-08 07:45:21.284764 | 
2026-06-08 07:45:21.284840 | TASK [upload-logs : Create log directories]
2026-06-08 07:45:21.650618 | localhost | changed
2026-06-08 07:45:21.655800 | 
2026-06-08 07:45:21.655873 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-06-08 07:45:22.039078 | localhost -> localhost | ok: Runtime: 0:00:00.006279
2026-06-08 07:45:22.047016 | 
2026-06-08 07:45:22.047117 | TASK [upload-logs : Upload logs to log server]
2026-06-08 07:45:22.509122 | localhost | Output suppressed because no_log was given
2026-06-08 07:45:22.514545 | 
2026-06-08 07:45:22.514642 | LOOP [upload-logs : Compress console log and json output]
2026-06-08 07:45:22.561589 | localhost | skipping: Conditional result was False
2026-06-08 07:45:22.568396 | localhost | skipping: Conditional result was False
2026-06-08 07:45:22.580783 | 
2026-06-08 07:45:22.580969 | LOOP [upload-logs : Upload compressed console log and json output]
2026-06-08 07:45:22.623431 | localhost | skipping: Conditional result was False
2026-06-08 07:45:22.623805 | 
2026-06-08 07:45:22.628297 | localhost | skipping: Conditional result was False
2026-06-08 07:45:22.646152 | 
2026-06-08 07:45:22.646294 | LOOP [upload-logs : Upload console log and json output]