2026-02-27 16:41:26.162609 | Job console starting
2026-02-27 16:41:26.174752 | Updating git repos
2026-02-27 16:41:26.217238 | Cloning repos into workspace
2026-02-27 16:41:26.361355 | Restoring repo states
2026-02-27 16:41:26.385318 | Merging changes
2026-02-27 16:41:27.666835 | Checking out repos
2026-02-27 16:41:27.876404 | Preparing playbooks
2026-02-27 16:41:34.860217 | Running Ansible setup
2026-02-27 16:41:38.285986 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-02-27 16:41:38.982636 | 
2026-02-27 16:41:38.982795 | PLAY [localhost]
2026-02-27 16:41:38.990809 | 
2026-02-27 16:41:38.990884 | TASK [Gathering Facts]
2026-02-27 16:41:39.876290 | localhost | ok
2026-02-27 16:41:39.887049 | 
2026-02-27 16:41:39.887125 | TASK [Setup log path fact]
2026-02-27 16:41:39.915524 | localhost | ok
2026-02-27 16:41:39.932709 | 
2026-02-27 16:41:39.933515 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-27 16:41:39.964472 | localhost | ok
2026-02-27 16:41:39.971836 | 
2026-02-27 16:41:39.971900 | TASK [emit-job-header : Print job information]
2026-02-27 16:41:40.013206 | # Job Information
2026-02-27 16:41:40.013416 | Ansible Version: 2.16.16
2026-02-27 16:41:40.013489 | Job: atmosphere-molecule-aio-ovn
2026-02-27 16:41:40.013538 | Pipeline: check
2026-02-27 16:41:40.013581 | Executor: 0a8996d2b663
2026-02-27 16:41:40.013626 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3590
2026-02-27 16:41:40.013675 | Event ID: 12d62860-13fb-11f1-9a3b-86ec55b09b8c
2026-02-27 16:41:40.017756 | 
2026-02-27 16:41:40.017818 | LOOP [emit-job-header : Print node information]
2026-02-27 16:41:40.106432 | localhost | ok:
2026-02-27 16:41:40.106617 | localhost | # Node Information
2026-02-27 16:41:40.106648 | localhost | Inventory Hostname: instance
2026-02-27 16:41:40.106670 | localhost | Hostname: np0000157329
2026-02-27 16:41:40.106690 | localhost | Username: zuul
2026-02-27 16:41:40.106714 | localhost | Distro: Ubuntu 22.04
2026-02-27 16:41:40.106734 | localhost | Provider: yul1
2026-02-27 16:41:40.106754 | localhost | Region: ca-ymq-1
2026-02-27 16:41:40.106773 | localhost | Label: ubuntu-jammy-16
2026-02-27 16:41:40.106792 | localhost | Product Name: OpenStack Nova
2026-02-27 16:41:40.106811 | localhost | Interface IP: 199.204.45.115
2026-02-27 16:41:40.117804 | 
2026-02-27 16:41:40.117942 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-02-27 16:41:40.614827 | localhost -> localhost | changed
2026-02-27 16:41:40.622945 | 
2026-02-27 16:41:40.623018 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-02-27 16:41:41.552121 | localhost -> localhost | changed
2026-02-27 16:41:41.562379 | 
2026-02-27 16:41:41.562469 | PLAY [all]
2026-02-27 16:41:41.571913 | 
2026-02-27 16:41:41.571980 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-27 16:41:41.790827 | instance -> localhost | ok
2026-02-27 16:41:41.801068 | 
2026-02-27 16:41:41.801173 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-27 16:41:41.837168 | instance | ok
2026-02-27 16:41:41.852726 | instance | included: /var/lib/zuul/builds/3a3cc8bc04ee4225ad1c543ef0934812/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-27 16:41:41.859151 | 
2026-02-27 16:41:41.859256 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-27 16:41:43.040287 | instance -> localhost | Generating public/private rsa key pair.
2026-02-27 16:41:43.040616 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/3a3cc8bc04ee4225ad1c543ef0934812/work/3a3cc8bc04ee4225ad1c543ef0934812_id_rsa
2026-02-27 16:41:43.040696 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/3a3cc8bc04ee4225ad1c543ef0934812/work/3a3cc8bc04ee4225ad1c543ef0934812_id_rsa.pub
2026-02-27 16:41:43.040771 | instance -> localhost | The key fingerprint is:
2026-02-27 16:41:43.040889 | instance -> localhost | SHA256:pv82LwJP0As0yv9IFm3yvUIPt0XwDgrD/484tzJpgKI zuul-build-sshkey
2026-02-27 16:41:43.041005 | instance -> localhost | The key's randomart image is:
2026-02-27 16:41:43.041068 | instance -> localhost | +---[RSA 3072]----+
2026-02-27 16:41:43.041128 | instance -> localhost | |                 |
2026-02-27 16:41:43.041179 | instance -> localhost | |      o   .      |
2026-02-27 16:41:43.041228 | instance -> localhost | |   . + +   o     |
2026-02-27 16:41:43.041272 | instance -> localhost | |    o O + . o    |
2026-02-27 16:41:43.041305 | instance -> localhost | |     o @S+ +     |
2026-02-27 16:41:43.041338 | instance -> localhost | |  . . *oO o o    |
2026-02-27 16:41:43.041372 | instance -> localhost | | . . o.O * +     |
2026-02-27 16:41:43.041405 | instance -> localhost | |E     ..@.X.     |
2026-02-27 16:41:43.041443 | instance -> localhost | |       .oX+*o    |
2026-02-27 16:41:43.041477 | instance -> localhost | +----[SHA256]-----+
2026-02-27 16:41:43.041583 | instance -> localhost | ok: Runtime: 0:00:00.701989
2026-02-27 16:41:43.050476 | 
2026-02-27 16:41:43.050652 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-27 16:41:43.087676 | instance | ok
2026-02-27 16:41:43.098106 | instance | included: /var/lib/zuul/builds/3a3cc8bc04ee4225ad1c543ef0934812/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-27 16:41:43.107480 | 
2026-02-27 16:41:43.107653 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-27 16:41:43.133506 | instance | skipping: Conditional result was False
2026-02-27 16:41:43.144484 | 
2026-02-27 16:41:43.144635 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-27 16:41:43.600517 | instance | changed
2026-02-27 16:41:43.606511 | 
2026-02-27 16:41:43.606603 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-27 16:41:43.796850 | instance | ok
2026-02-27 16:41:43.802388 | 
2026-02-27 16:41:43.802452 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-27 16:41:44.265986 | instance | changed
2026-02-27 16:41:44.272551 | 
2026-02-27 16:41:44.272619 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-27 16:41:44.729969 | instance | changed
2026-02-27 16:41:44.744682 | 
2026-02-27 16:41:44.744943 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-27 16:41:44.776750 | instance | skipping: Conditional result was False
2026-02-27 16:41:44.788476 | 
2026-02-27 16:41:44.788613 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-27 16:41:45.170018 | instance -> localhost | changed
2026-02-27 16:41:45.215895 | 
2026-02-27 16:41:45.216015 | TASK [add-build-sshkey : Add back temp key]
2026-02-27 16:41:45.505639 | instance -> localhost | Identity added: /var/lib/zuul/builds/3a3cc8bc04ee4225ad1c543ef0934812/work/3a3cc8bc04ee4225ad1c543ef0934812_id_rsa (zuul-build-sshkey)
2026-02-27 16:41:45.505880 | instance -> localhost | ok: Runtime: 0:00:00.015224
2026-02-27 16:41:45.512061 | 
2026-02-27 16:41:45.512142 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-27 16:41:45.786730 | instance | ok
2026-02-27 16:41:45.796496 | 
2026-02-27 16:41:45.796724 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-27 16:41:45.824176 | instance | skipping: Conditional result was False
2026-02-27 16:41:45.846126 | 
2026-02-27 16:41:45.846317 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-02-27 16:41:46.126705 | instance | ok
2026-02-27 16:41:46.134615 | 
2026-02-27 16:41:46.134685 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-02-27 16:41:47.720401 | instance | Output suppressed because no_log was given
2026-02-27 16:41:47.734786 | 
2026-02-27 16:41:47.734877 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-02-27 16:41:47.939731 | instance | ok: "logs"
2026-02-27 16:41:47.939976 | instance | ok: All items complete
2026-02-27 16:41:47.940004 | 
2026-02-27 16:41:48.098980 | instance | ok: "artifacts"
2026-02-27 16:41:48.253108 | instance | ok: "docs"
2026-02-27 16:41:48.271207 | 
2026-02-27 16:41:48.271341 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-02-27 16:41:48.472404 | instance | changed: "logs"
2026-02-27 16:41:48.646515 | instance | changed: "artifacts"
2026-02-27 16:41:48.803681 | instance | changed: "docs"
2026-02-27 16:41:48.816887 | 
2026-02-27 16:41:48.817042 | PLAY RECAP
2026-02-27 16:41:48.817111 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-02-27 16:41:48.817152 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-27 16:41:48.817181 | 
2026-02-27 16:41:48.946175 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-02-27 16:41:48.957590 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-02-27 16:41:49.534944 | 
2026-02-27 16:41:49.535063 | PLAY [all]
2026-02-27 16:41:49.546252 | 
2026-02-27 16:41:49.546325 | TASK [setup-uv : Extract archive]
2026-02-27 16:41:50.374499 | instance | ERROR
2026-02-27 16:41:50.374759 | instance | {
2026-02-27 16:41:50.374797 | 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-27 16:41:50.374859 | instance | }
failure
2026-02-27 16:41:50.376140 | 
2026-02-27 16:41:50.376182 | PLAY RECAP
2026-02-27 16:41:50.376224 | instance | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-02-27 16:41:50.376247 | 
2026-02-27 16:41:50.473949 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-02-27 16:41:50.485025 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-02-27 16:41:51.135329 | 
2026-02-27 16:41:51.135497 | PLAY [all]
2026-02-27 16:41:51.147060 | 
2026-02-27 16:41:51.147155 | TASK [fetch-output : Set log path for multiple nodes]
2026-02-27 16:41:51.192041 | instance | skipping: Conditional result was False
2026-02-27 16:41:51.203095 | 
2026-02-27 16:41:51.203223 | TASK [fetch-output : Set log path for single node]
2026-02-27 16:41:51.246298 | instance | ok
2026-02-27 16:41:51.251985 | 
2026-02-27 16:41:51.252054 | LOOP [fetch-output : Ensure local output dirs]
2026-02-27 16:41:51.610111 | instance -> localhost | ok: "/var/lib/zuul/builds/3a3cc8bc04ee4225ad1c543ef0934812/work/logs"
2026-02-27 16:41:51.815744 | instance -> localhost | changed: "/var/lib/zuul/builds/3a3cc8bc04ee4225ad1c543ef0934812/work/artifacts"
2026-02-27 16:41:52.031221 | instance -> localhost | changed: "/var/lib/zuul/builds/3a3cc8bc04ee4225ad1c543ef0934812/work/docs"
2026-02-27 16:41:52.046050 | 
2026-02-27 16:41:52.046227 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-02-27 16:41:52.674107 | instance | changed: .d..t...... ./
2026-02-27 16:41:52.674347 | instance | changed: All items complete
2026-02-27 16:41:52.674385 | 
2026-02-27 16:41:53.164442 | instance | changed: .d..t...... ./
2026-02-27 16:41:53.637864 | instance | changed: .d..t...... ./
2026-02-27 16:41:53.659508 | 
2026-02-27 16:41:53.659675 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-02-27 16:41:54.084719 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006633
2026-02-27 16:41:54.309012 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008436
2026-02-27 16:41:54.329103 | 
2026-02-27 16:41:54.329225 | PLAY [all]
2026-02-27 16:41:54.336340 | 
2026-02-27 16:41:54.336437 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-02-27 16:41:54.767320 | instance | changed
2026-02-27 16:41:54.773501 | 
2026-02-27 16:41:54.773553 | PLAY RECAP
2026-02-27 16:41:54.773599 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-02-27 16:41:54.773622 | 
2026-02-27 16:41:54.902016 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-02-27 16:41:54.914988 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-02-27 16:41:55.473536 | 
2026-02-27 16:41:55.473664 | PLAY [localhost]
2026-02-27 16:41:55.483080 | 
2026-02-27 16:41:55.483149 | TASK [Generate Zuul manifest]
2026-02-27 16:41:55.502862 | localhost | ok
2026-02-27 16:41:55.518854 | 
2026-02-27 16:41:55.518932 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-02-27 16:41:55.895172 | localhost | changed
2026-02-27 16:41:55.907238 | 
2026-02-27 16:41:55.907350 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-02-27 16:41:55.938754 | localhost | ok
2026-02-27 16:41:55.945609 | 
2026-02-27 16:41:55.945671 | TASK [Upload logs]
2026-02-27 16:41:55.965816 | localhost | ok
2026-02-27 16:41:56.108829 | 
2026-02-27 16:41:56.109042 | TASK [Set zuul-log-path fact]
2026-02-27 16:41:56.132353 | localhost | ok
2026-02-27 16:41:56.146853 | 
2026-02-27 16:41:56.146945 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-27 16:41:56.179610 | localhost | ok
2026-02-27 16:41:56.188231 | 
2026-02-27 16:41:56.188305 | TASK [upload-logs : Create log directories]
2026-02-27 16:41:56.595538 | localhost | changed
2026-02-27 16:41:56.604453 | 
2026-02-27 16:41:56.604552 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-02-27 16:41:56.992936 | localhost -> localhost | ok: Runtime: 0:00:00.005852
2026-02-27 16:41:56.999134 | 
2026-02-27 16:41:56.999195 | TASK [upload-logs : Upload logs to log server]
2026-02-27 16:41:57.428679 | localhost | Output suppressed because no_log was given
2026-02-27 16:41:57.433157 | 
2026-02-27 16:41:57.433218 | LOOP [upload-logs : Compress console log and json output]
2026-02-27 16:41:57.492742 | localhost | skipping: Conditional result was False
2026-02-27 16:41:57.500301 | localhost | skipping: Conditional result was False
2026-02-27 16:41:57.516781 | 
2026-02-27 16:41:57.516929 | LOOP [upload-logs : Upload compressed console log and json output]
2026-02-27 16:41:57.561756 | localhost | skipping: Conditional result was False
2026-02-27 16:41:57.562203 | 
2026-02-27 16:41:57.566062 | localhost | skipping: Conditional result was False
2026-02-27 16:41:57.579177 | 
2026-02-27 16:41:57.579270 | LOOP [upload-logs : Upload console log and json output]