2026-07-09 16:32:46.403707 | Job console starting
2026-07-09 16:32:46.416995 | Updating git repos
2026-07-09 16:32:52.399925 | Cloning repos into workspace
2026-07-09 16:33:34.864906 | Restoring repo states
2026-07-09 16:33:41.981012 | Merging changes
2026-07-09 16:33:46.266869 | Checking out repos
2026-07-09 16:33:53.431815 | Preparing playbooks
2026-07-09 16:34:03.243343 | Running Ansible setup
2026-07-09 16:34:07.987928 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-09 16:34:08.871191 | 
2026-07-09 16:34:09.024880 | PLAY [localhost]
2026-07-09 16:34:09.053949 | 
2026-07-09 16:34:09.054413 | TASK [Gathering Facts]
2026-07-09 16:34:10.309983 | localhost | ok
2026-07-09 16:34:10.317649 | 
2026-07-09 16:34:10.317848 | TASK [Setup log path fact]
2026-07-09 16:34:10.338446 | localhost | ok
2026-07-09 16:34:10.353302 | 
2026-07-09 16:34:10.353448 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-09 16:34:10.391766 | localhost | ok
2026-07-09 16:34:10.397943 | 
2026-07-09 16:34:10.398025 | TASK [emit-job-header : Print job information]
2026-07-09 16:34:10.439205 | # Job Information
2026-07-09 16:34:10.439401 | Ansible Version: 2.16.18
2026-07-09 16:34:10.439448 | Job: atmosphere-molecule-csi-local-path-provisioner
2026-07-09 16:34:10.439482 | Pipeline: check
2026-07-09 16:34:10.439510 | Executor: 2d72f0692154
2026-07-09 16:34:10.439534 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4093
2026-07-09 16:34:10.439559 | Event ID: 42520530-7bb3-11f1-9707-0f66710dac21
2026-07-09 16:34:10.443436 | 
2026-07-09 16:34:10.443543 | LOOP [emit-job-header : Print node information]
2026-07-09 16:34:10.721394 | localhost | ok:
2026-07-09 16:34:10.721662 | localhost | # Node Information
2026-07-09 16:34:10.721702 | localhost | Inventory Hostname: instance
2026-07-09 16:34:10.721725 | localhost | Hostname: np0000184752
2026-07-09 16:34:10.721745 | localhost | Username: zuul
2026-07-09 16:34:10.721769 | localhost | Distro: Ubuntu 22.04
2026-07-09 16:34:10.721790 | localhost | Provider: yul1
2026-07-09 16:34:10.721810 | localhost | Region: ca-ymq-1
2026-07-09 16:34:10.721829 | localhost | Label: ubuntu-jammy
2026-07-09 16:34:10.721847 | localhost | Product Name: OpenStack Nova
2026-07-09 16:34:10.721866 | localhost | Interface IP: 199.19.213.156
2026-07-09 16:34:10.729467 | 
2026-07-09 16:34:10.729651 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-07-09 16:34:11.274517 | localhost -> localhost | changed
2026-07-09 16:34:11.279614 | 
2026-07-09 16:34:11.279685 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-07-09 16:34:13.469765 | localhost -> localhost | changed
2026-07-09 16:34:13.488647 | 
2026-07-09 16:34:13.488916 | PLAY [all]
2026-07-09 16:34:13.503906 | 
2026-07-09 16:34:13.504133 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-07-09 16:34:13.783819 | instance -> localhost | ok
2026-07-09 16:34:13.791987 | 
2026-07-09 16:34:13.792079 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-07-09 16:34:13.828490 | instance | ok
2026-07-09 16:34:13.842856 | instance | included: /var/lib/zuul/builds/7b2e4136f2014bf5abbee1bf2c53df9e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-07-09 16:34:13.849218 | 
2026-07-09 16:34:13.849329 | TASK [add-build-sshkey : Create Temp SSH key]
2026-07-09 16:34:14.971235 | instance -> localhost | Generating public/private rsa key pair.
2026-07-09 16:34:14.971514 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/7b2e4136f2014bf5abbee1bf2c53df9e/work/7b2e4136f2014bf5abbee1bf2c53df9e_id_rsa
2026-07-09 16:34:14.971558 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/7b2e4136f2014bf5abbee1bf2c53df9e/work/7b2e4136f2014bf5abbee1bf2c53df9e_id_rsa.pub
2026-07-09 16:34:14.971590 | instance -> localhost | The key fingerprint is:
2026-07-09 16:34:14.971620 | instance -> localhost | SHA256:hPLf5bx2MDxVLjZqFwOwMxx053fFCU3magV67dtAvc4 zuul-build-sshkey
2026-07-09 16:34:14.971671 | instance -> localhost | The key's randomart image is:
2026-07-09 16:34:14.971702 | instance -> localhost | +---[RSA 3072]----+
2026-07-09 16:34:14.971741 | instance -> localhost | |         .+..o=+o|
2026-07-09 16:34:14.971774 | instance -> localhost | |       . . +oo=++|
2026-07-09 16:34:14.971804 | instance -> localhost | |    . . . =. oo*+|
2026-07-09 16:34:14.971832 | instance -> localhost | |     o .   o..@.+|
2026-07-09 16:34:14.971863 | instance -> localhost | |      . S  ..*.B |
2026-07-09 16:34:14.971903 | instance -> localhost | |       . . +O +.o|
2026-07-09 16:34:14.971932 | instance -> localhost | |        . ..o= E.|
2026-07-09 16:34:14.971959 | instance -> localhost | |            ...  |
2026-07-09 16:34:14.971990 | instance -> localhost | |           ...   |
2026-07-09 16:34:14.972019 | instance -> localhost | +----[SHA256]-----+
2026-07-09 16:34:14.972094 | instance -> localhost | ok: Runtime: 0:00:00.600723
2026-07-09 16:34:14.980518 | 
2026-07-09 16:34:14.980597 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-07-09 16:34:15.020924 | instance | ok
2026-07-09 16:34:15.032293 | instance | included: /var/lib/zuul/builds/7b2e4136f2014bf5abbee1bf2c53df9e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-07-09 16:34:15.040313 | 
2026-07-09 16:34:15.040384 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-07-09 16:34:15.066928 | instance | skipping: Conditional result was False
2026-07-09 16:34:15.077104 | 
2026-07-09 16:34:15.077281 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-07-09 16:34:15.534230 | instance | changed
2026-07-09 16:34:15.541171 | 
2026-07-09 16:34:15.541283 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-07-09 16:34:15.728457 | instance | ok
2026-07-09 16:34:15.737551 | 
2026-07-09 16:34:15.737749 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-07-09 16:34:16.331880 | instance | changed
2026-07-09 16:34:16.431563 | 
2026-07-09 16:34:16.431788 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-07-09 16:34:16.933619 | instance | changed
2026-07-09 16:34:17.023201 | 
2026-07-09 16:34:17.023340 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-07-09 16:34:17.048508 | instance | skipping: Conditional result was False
2026-07-09 16:34:17.060334 | 
2026-07-09 16:34:17.060452 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-07-09 16:34:18.663297 | instance -> localhost | changed
2026-07-09 16:34:18.695605 | 
2026-07-09 16:34:18.695742 | TASK [add-build-sshkey : Add back temp key]
2026-07-09 16:34:19.075553 | instance -> localhost | Identity added: /var/lib/zuul/builds/7b2e4136f2014bf5abbee1bf2c53df9e/work/7b2e4136f2014bf5abbee1bf2c53df9e_id_rsa (zuul-build-sshkey)
2026-07-09 16:34:19.075773 | instance -> localhost | ok: Runtime: 0:00:00.013354
2026-07-09 16:34:19.087497 | 
2026-07-09 16:34:19.087594 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-07-09 16:34:19.399922 | instance | ok
2026-07-09 16:34:19.454231 | 
2026-07-09 16:34:19.454379 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-07-09 16:34:19.491528 | instance | skipping: Conditional result was False
2026-07-09 16:34:19.511471 | 
2026-07-09 16:34:19.511693 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-07-09 16:34:19.889726 | instance | ok
2026-07-09 16:34:19.899234 | 
2026-07-09 16:34:19.899333 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-07-09 16:34:24.258813 | instance | Output suppressed because no_log was given
2026-07-09 16:34:24.306556 | 
2026-07-09 16:34:24.306771 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-07-09 16:34:24.536514 | instance | ok: "logs"
2026-07-09 16:34:24.617918 | instance | ok: All items complete
2026-07-09 16:34:24.618049 | 
2026-07-09 16:34:24.702670 | instance | ok: "artifacts"
2026-07-09 16:34:24.857921 | instance | ok: "docs"
2026-07-09 16:34:24.873404 | 
2026-07-09 16:34:24.873541 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-07-09 16:34:25.081846 | instance | changed: "logs"
2026-07-09 16:34:25.240858 | instance | changed: "artifacts"
2026-07-09 16:34:25.407444 | instance | changed: "docs"
2026-07-09 16:34:25.426232 | 
2026-07-09 16:34:25.426308 | PLAY RECAP
2026-07-09 16:34:25.426369 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-07-09 16:34:25.426436 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-09 16:34:25.426480 | 
2026-07-09 16:34:25.570134 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-09 16:34:25.574057 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-09 16:34:26.256585 | 
2026-07-09 16:34:26.256884 | PLAY [all]
2026-07-09 16:34:26.275038 | 
2026-07-09 16:34:26.275211 | TASK [setup-uv : Extract archive]
2026-07-09 16:34:37.359031 | instance | ERROR
2026-07-09 16:34:37.359337 | instance | {
2026-07-09 16:34:37.359396 | 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-07-09 16:34:37.359462 | instance | }
failure
2026-07-09 16:34:37.361325 | 
2026-07-09 16:34:37.361399 | PLAY RECAP
2026-07-09 16:34:37.361461 | instance | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-07-09 16:34:37.361494 | 
2026-07-09 16:34:37.504540 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-09 16:34:39.800140 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-09 16:34:40.497988 | 
2026-07-09 16:34:40.525681 | PLAY [all]
2026-07-09 16:34:40.543002 | 
2026-07-09 16:34:40.543126 | TASK [fetch-output : Set log path for multiple nodes]
2026-07-09 16:34:40.598612 | instance | skipping: Conditional result was False
2026-07-09 16:34:40.608675 | 
2026-07-09 16:34:40.608841 | TASK [fetch-output : Set log path for single node]
2026-07-09 16:34:40.656627 | instance | ok
2026-07-09 16:34:40.664112 | 
2026-07-09 16:34:40.664239 | LOOP [fetch-output : Ensure local output dirs]
2026-07-09 16:34:41.414310 | instance -> localhost | ok: "/var/lib/zuul/builds/7b2e4136f2014bf5abbee1bf2c53df9e/work/logs"
2026-07-09 16:34:41.673962 | instance -> localhost | changed: "/var/lib/zuul/builds/7b2e4136f2014bf5abbee1bf2c53df9e/work/artifacts"
2026-07-09 16:34:41.930492 | instance -> localhost | changed: "/var/lib/zuul/builds/7b2e4136f2014bf5abbee1bf2c53df9e/work/docs"
2026-07-09 16:34:41.944047 | 
2026-07-09 16:34:41.944250 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-07-09 16:34:42.602092 | instance | ok
2026-07-09 16:34:42.709360 | instance | changed: All items complete
2026-07-09 16:34:42.709518 | 
2026-07-09 16:34:43.219890 | instance | changed: .d..t...... ./
2026-07-09 16:34:44.447116 | instance | changed: .d..t...... ./
2026-07-09 16:34:44.471421 | 
2026-07-09 16:34:44.471575 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-07-09 16:34:45.225494 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.282834
2026-07-09 16:34:45.527209 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.011444
2026-07-09 16:34:45.541732 | 
2026-07-09 16:34:45.541834 | PLAY [all]
2026-07-09 16:34:45.550415 | 
2026-07-09 16:34:45.550483 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-07-09 16:34:45.981321 | instance | changed
2026-07-09 16:34:46.010485 | 
2026-07-09 16:34:46.010540 | PLAY RECAP
2026-07-09 16:34:46.010585 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-09 16:34:46.010607 | 
2026-07-09 16:34:46.162681 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-09 16:34:46.282733 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-07-09 16:34:46.992695 | 
2026-07-09 16:34:46.992910 | PLAY [localhost]
2026-07-09 16:34:47.004333 | 
2026-07-09 16:34:47.004416 | TASK [Generate Zuul manifest]
2026-07-09 16:34:47.024829 | localhost | ok
2026-07-09 16:34:47.045380 | 
2026-07-09 16:34:47.045494 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-07-09 16:34:47.796412 | localhost | changed
2026-07-09 16:34:47.808309 | 
2026-07-09 16:34:47.808456 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-07-09 16:34:47.854257 | localhost | ok
2026-07-09 16:34:47.872365 | 
2026-07-09 16:34:47.872566 | TASK [Upload logs]
2026-07-09 16:34:47.908487 | localhost | ok
2026-07-09 16:34:47.989504 | 
2026-07-09 16:34:47.989664 | TASK [Set zuul-log-path fact]
2026-07-09 16:34:48.012339 | localhost | ok
2026-07-09 16:34:48.031385 | 
2026-07-09 16:34:48.031596 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-09 16:34:48.073583 | localhost | ok
2026-07-09 16:34:48.083777 | 
2026-07-09 16:34:48.083855 | TASK [upload-logs : Create log directories]
2026-07-09 16:34:48.663669 | localhost | changed
2026-07-09 16:34:48.670098 | 
2026-07-09 16:34:48.670179 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-07-09 16:34:49.521666 | localhost -> localhost | ok: Runtime: 0:00:00.006018
2026-07-09 16:34:49.530193 | 
2026-07-09 16:34:49.530363 | TASK [upload-logs : Upload logs to log server]
2026-07-09 16:34:50.062417 | localhost | Output suppressed because no_log was given
2026-07-09 16:34:50.102372 | 
2026-07-09 16:34:50.102492 | LOOP [upload-logs : Compress console log and json output]
2026-07-09 16:34:50.146018 | localhost | skipping: Conditional result was False
2026-07-09 16:34:50.153642 | localhost | skipping: Conditional result was False
2026-07-09 16:34:50.168512 | 
2026-07-09 16:34:50.168653 | LOOP [upload-logs : Upload compressed console log and json output]
2026-07-09 16:34:50.210395 | localhost | skipping: Conditional result was False
2026-07-09 16:34:50.210732 | 
2026-07-09 16:34:50.215922 | localhost | skipping: Conditional result was False
2026-07-09 16:34:50.234269 | 
2026-07-09 16:34:50.234463 | LOOP [upload-logs : Upload console log and json output]