2026-02-25 16:36:11.696098 | Job console starting
2026-02-25 16:36:11.706747 | Updating git repos
2026-02-25 16:36:11.759330 | Cloning repos into workspace
2026-02-25 16:36:11.845110 | Restoring repo states
2026-02-25 16:36:11.863596 | Merging changes
2026-02-25 16:36:12.744553 | Checking out repos
2026-02-25 16:36:13.138853 | Preparing playbooks
2026-02-25 16:36:15.544682 | Running Ansible setup
2026-02-25 16:36:19.398087 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-02-25 16:36:20.080244 | 
2026-02-25 16:36:20.080365 | PLAY [localhost]
2026-02-25 16:36:20.087633 | 
2026-02-25 16:36:20.087709 | TASK [Gathering Facts]
2026-02-25 16:36:20.972559 | localhost | ok
2026-02-25 16:36:20.981963 | 
2026-02-25 16:36:20.982076 | TASK [Setup log path fact]
2026-02-25 16:36:21.001532 | localhost | ok
2026-02-25 16:36:21.013843 | 
2026-02-25 16:36:21.013941 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-25 16:36:21.045118 | localhost | ok
2026-02-25 16:36:21.053598 | 
2026-02-25 16:36:21.053704 | TASK [emit-job-header : Print job information]
2026-02-25 16:36:21.095812 | # Job Information
2026-02-25 16:36:21.096103 | Ansible Version: 2.16.16
2026-02-25 16:36:21.096175 | Job: atmosphere-molecule-aio-openvswitch
2026-02-25 16:36:21.096225 | Pipeline: check
2026-02-25 16:36:21.096269 | Executor: 0a8996d2b663
2026-02-25 16:36:21.096304 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3443
2026-02-25 16:36:21.096349 | Event ID: 03ee3e80-1268-11f1-8e4b-7fff7fd8dc05
2026-02-25 16:36:21.101764 | 
2026-02-25 16:36:21.101897 | LOOP [emit-job-header : Print node information]
2026-02-25 16:36:21.197115 | localhost | ok:
2026-02-25 16:36:21.197350 | localhost | # Node Information
2026-02-25 16:36:21.197390 | localhost | Inventory Hostname: instance
2026-02-25 16:36:21.197420 | localhost | Hostname: np0000156981
2026-02-25 16:36:21.197447 | localhost | Username: zuul
2026-02-25 16:36:21.197478 | localhost | Distro: Ubuntu 22.04
2026-02-25 16:36:21.197505 | localhost | Provider: yul1
2026-02-25 16:36:21.197531 | localhost | Region: ca-ymq-1
2026-02-25 16:36:21.197557 | localhost | Label: ubuntu-jammy-16
2026-02-25 16:36:21.197583 | localhost | Product Name: OpenStack Nova
2026-02-25 16:36:21.197608 | localhost | Interface IP: 199.204.45.216
2026-02-25 16:36:21.213720 | 
2026-02-25 16:36:21.213892 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-02-25 16:36:21.618733 | localhost -> localhost | changed
2026-02-25 16:36:21.625541 | 
2026-02-25 16:36:21.625650 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-02-25 16:36:22.489225 | localhost -> localhost | changed
2026-02-25 16:36:22.498283 | 
2026-02-25 16:36:22.498383 | PLAY [all]
2026-02-25 16:36:22.509478 | 
2026-02-25 16:36:22.509663 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-25 16:36:22.739066 | instance -> localhost | ok
2026-02-25 16:36:22.747581 | 
2026-02-25 16:36:22.747707 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-25 16:36:22.780167 | instance | ok
2026-02-25 16:36:22.798503 | instance | included: /var/lib/zuul/builds/728c21620382450c9e2f11638c9353c8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-25 16:36:22.805266 | 
2026-02-25 16:36:22.805343 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-25 16:36:23.759888 | instance -> localhost | Generating public/private rsa key pair.
2026-02-25 16:36:23.760058 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/728c21620382450c9e2f11638c9353c8/work/728c21620382450c9e2f11638c9353c8_id_rsa
2026-02-25 16:36:23.760088 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/728c21620382450c9e2f11638c9353c8/work/728c21620382450c9e2f11638c9353c8_id_rsa.pub
2026-02-25 16:36:23.760112 | instance -> localhost | The key fingerprint is:
2026-02-25 16:36:23.760134 | instance -> localhost | SHA256:yhUPUasqa1c9OHuglgtkUT+/o0tTNsrzTVfRLVzQ/Dc zuul-build-sshkey
2026-02-25 16:36:23.760171 | instance -> localhost | The key's randomart image is:
2026-02-25 16:36:23.760192 | instance -> localhost | +---[RSA 3072]----+
2026-02-25 16:36:23.760216 | instance -> localhost | |      . ...   .+.|
2026-02-25 16:36:23.760237 | instance -> localhost | |     . . . . . .=|
2026-02-25 16:36:23.760257 | instance -> localhost | |    .   = .   o.+|
2026-02-25 16:36:23.760277 | instance -> localhost | |     .   B     E+|
2026-02-25 16:36:23.760296 | instance -> localhost | |    o   So*     +|
2026-02-25 16:36:23.760316 | instance -> localhost | |   o . ==+oo   . |
2026-02-25 16:36:23.760336 | instance -> localhost | |    o ++*+o.. .  |
2026-02-25 16:36:23.760355 | instance -> localhost | |    .+=..=.+ .   |
2026-02-25 16:36:23.760377 | instance -> localhost | |   ..o..oo. .    |
2026-02-25 16:36:23.760397 | instance -> localhost | +----[SHA256]-----+
2026-02-25 16:36:23.760443 | instance -> localhost | ok: Runtime: 0:00:00.553679
2026-02-25 16:36:23.765412 | 
2026-02-25 16:36:23.765476 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-25 16:36:23.798183 | instance | ok
2026-02-25 16:36:23.808280 | instance | included: /var/lib/zuul/builds/728c21620382450c9e2f11638c9353c8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-25 16:36:23.815627 | 
2026-02-25 16:36:23.815697 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-25 16:36:23.840591 | instance | skipping: Conditional result was False
2026-02-25 16:36:23.850676 | 
2026-02-25 16:36:23.850822 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-25 16:36:24.281229 | instance | changed
2026-02-25 16:36:24.286425 | 
2026-02-25 16:36:24.286491 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-25 16:36:24.461066 | instance | ok
2026-02-25 16:36:24.467977 | 
2026-02-25 16:36:24.468041 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-25 16:36:24.918561 | instance | changed
2026-02-25 16:36:24.925065 | 
2026-02-25 16:36:24.925146 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-25 16:36:25.466886 | instance | changed
2026-02-25 16:36:25.472305 | 
2026-02-25 16:36:25.472372 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-25 16:36:25.496737 | instance | skipping: Conditional result was False
2026-02-25 16:36:25.506011 | 
2026-02-25 16:36:25.506107 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-25 16:36:25.836684 | instance -> localhost | changed
2026-02-25 16:36:25.851390 | 
2026-02-25 16:36:25.851473 | TASK [add-build-sshkey : Add back temp key]
2026-02-25 16:36:26.150858 | instance -> localhost | Identity added: /var/lib/zuul/builds/728c21620382450c9e2f11638c9353c8/work/728c21620382450c9e2f11638c9353c8_id_rsa (zuul-build-sshkey)
2026-02-25 16:36:26.151077 | instance -> localhost | ok: Runtime: 0:00:00.012085
2026-02-25 16:36:26.158386 | 
2026-02-25 16:36:26.158464 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-25 16:36:26.437109 | instance | ok
2026-02-25 16:36:26.443197 | 
2026-02-25 16:36:26.443291 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-25 16:36:26.467909 | instance | skipping: Conditional result was False
2026-02-25 16:36:26.482693 | 
2026-02-25 16:36:26.482810 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-02-25 16:36:26.771396 | instance | ok
2026-02-25 16:36:26.779989 | 
2026-02-25 16:36:26.780056 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-02-25 16:36:28.396429 | instance | Output suppressed because no_log was given
2026-02-25 16:36:28.406769 | 
2026-02-25 16:36:28.406988 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-02-25 16:36:28.602443 | instance | ok: "logs"
2026-02-25 16:36:28.603382 | instance | ok: All items complete
2026-02-25 16:36:28.603432 | 
2026-02-25 16:36:28.752873 | instance | ok: "artifacts"
2026-02-25 16:36:28.909714 | instance | ok: "docs"
2026-02-25 16:36:28.925075 | 
2026-02-25 16:36:28.925250 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-02-25 16:36:29.102498 | instance | changed: "logs"
2026-02-25 16:36:29.261527 | instance | changed: "artifacts"
2026-02-25 16:36:29.409761 | instance | changed: "docs"
2026-02-25 16:36:29.426353 | 
2026-02-25 16:36:29.426517 | PLAY RECAP
2026-02-25 16:36:29.426590 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-02-25 16:36:29.426633 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-25 16:36:29.426659 | 
2026-02-25 16:36:29.610276 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-02-25 16:36:29.622233 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-02-25 16:36:30.277235 | 
2026-02-25 16:36:30.277489 | PLAY [all]
2026-02-25 16:36:30.291015 | 
2026-02-25 16:36:30.291099 | TASK [setup-uv : Extract archive]
2026-02-25 16:36:31.247072 | instance | ERROR
2026-02-25 16:36:31.247325 | instance | {
2026-02-25 16:36:31.247363 | 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: Remote end closed connection without response"
2026-02-25 16:36:31.247393 | instance | }
failure
2026-02-25 16:36:31.248762 | 
2026-02-25 16:36:31.248807 | PLAY RECAP
2026-02-25 16:36:31.248851 | instance | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-02-25 16:36:31.248875 | 
2026-02-25 16:36:31.357987 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-02-25 16:36:31.367038 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-02-25 16:36:32.055503 | 
2026-02-25 16:36:32.055661 | PLAY [all]
2026-02-25 16:36:32.068028 | 
2026-02-25 16:36:32.068128 | TASK [fetch-output : Set log path for multiple nodes]
2026-02-25 16:36:32.113992 | instance | skipping: Conditional result was False
2026-02-25 16:36:32.123859 | 
2026-02-25 16:36:32.123942 | TASK [fetch-output : Set log path for single node]
2026-02-25 16:36:32.167124 | instance | ok
2026-02-25 16:36:32.172954 | 
2026-02-25 16:36:32.173042 | LOOP [fetch-output : Ensure local output dirs]
2026-02-25 16:36:32.566958 | instance -> localhost | ok: "/var/lib/zuul/builds/728c21620382450c9e2f11638c9353c8/work/logs"
2026-02-25 16:36:32.807048 | instance -> localhost | changed: "/var/lib/zuul/builds/728c21620382450c9e2f11638c9353c8/work/artifacts"
2026-02-25 16:36:33.040791 | instance -> localhost | changed: "/var/lib/zuul/builds/728c21620382450c9e2f11638c9353c8/work/docs"
2026-02-25 16:36:33.063384 | 
2026-02-25 16:36:33.063568 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-02-25 16:36:33.701700 | instance | changed: .d..t...... ./
2026-02-25 16:36:33.701929 | instance | changed: All items complete
2026-02-25 16:36:33.701967 | 
2026-02-25 16:36:34.180395 | instance | changed: .d..t...... ./
2026-02-25 16:36:34.637347 | instance | changed: .d..t...... ./
2026-02-25 16:36:34.662595 | 
2026-02-25 16:36:34.662758 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-02-25 16:36:35.099275 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007597
2026-02-25 16:36:35.322344 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007487
2026-02-25 16:36:35.342409 | 
2026-02-25 16:36:35.342682 | PLAY [all]
2026-02-25 16:36:35.356045 | 
2026-02-25 16:36:35.356213 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-02-25 16:36:35.762513 | instance | changed
2026-02-25 16:36:35.768484 | 
2026-02-25 16:36:35.768575 | PLAY RECAP
2026-02-25 16:36:35.768626 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-02-25 16:36:35.768648 | 
2026-02-25 16:36:35.922469 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-02-25 16:36:35.936216 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-02-25 16:36:36.572638 | 
2026-02-25 16:36:36.572825 | PLAY [localhost]
2026-02-25 16:36:36.584853 | 
2026-02-25 16:36:36.584983 | TASK [Generate Zuul manifest]
2026-02-25 16:36:36.606886 | localhost | ok
2026-02-25 16:36:36.623037 | 
2026-02-25 16:36:36.623131 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-02-25 16:36:37.006968 | localhost | changed
2026-02-25 16:36:37.018264 | 
2026-02-25 16:36:37.018374 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-02-25 16:36:37.051682 | localhost | ok
2026-02-25 16:36:37.061468 | 
2026-02-25 16:36:37.061558 | TASK [Upload logs]
2026-02-25 16:36:37.083831 | localhost | ok
2026-02-25 16:36:37.183398 | 
2026-02-25 16:36:37.183534 | TASK [Set zuul-log-path fact]
2026-02-25 16:36:37.202959 | localhost | ok
2026-02-25 16:36:37.215959 | 
2026-02-25 16:36:37.216031 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-25 16:36:37.249206 | localhost | ok
2026-02-25 16:36:37.257039 | 
2026-02-25 16:36:37.257103 | TASK [upload-logs : Create log directories]
2026-02-25 16:36:37.673060 | localhost | changed
2026-02-25 16:36:37.678505 | 
2026-02-25 16:36:37.678581 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-02-25 16:36:38.055166 | localhost -> localhost | ok: Runtime: 0:00:00.005955
2026-02-25 16:36:38.063153 | 
2026-02-25 16:36:38.063277 | TASK [upload-logs : Upload logs to log server]
2026-02-25 16:36:38.495868 | localhost | Output suppressed because no_log was given
2026-02-25 16:36:38.501880 | 
2026-02-25 16:36:38.501955 | LOOP [upload-logs : Compress console log and json output]
2026-02-25 16:36:38.549392 | localhost | skipping: Conditional result was False
2026-02-25 16:36:38.556291 | localhost | skipping: Conditional result was False
2026-02-25 16:36:38.566291 | 
2026-02-25 16:36:38.566464 | LOOP [upload-logs : Upload compressed console log and json output]
2026-02-25 16:36:38.606715 | localhost | skipping: Conditional result was False
2026-02-25 16:36:38.607133 | 
2026-02-25 16:36:38.610745 | localhost | skipping: Conditional result was False
2026-02-25 16:36:38.621123 | 
2026-02-25 16:36:38.621324 | LOOP [upload-logs : Upload console log and json output]