2026-06-08 07:48:56.615772 | Job console starting 2026-06-08 07:48:56.627627 | Updating git repos 2026-06-08 07:49:00.532141 | Cloning repos into workspace 2026-06-08 07:49:14.916524 | Restoring repo states 2026-06-08 07:49:23.903168 | Merging changes 2026-06-08 07:49:25.396407 | Checking out repos 2026-06-08 07:49:28.496404 | Preparing playbooks 2026-06-08 07:49:32.135980 | Running Ansible setup 2026-06-08 07:49:36.208122 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-08 07:49:36.824802 | 2026-06-08 07:49:36.825217 | PLAY [localhost] 2026-06-08 07:49:36.833110 | 2026-06-08 07:49:36.833194 | TASK [Gathering Facts] 2026-06-08 07:49:37.736401 | localhost | ok 2026-06-08 07:49:37.743282 | 2026-06-08 07:49:37.743372 | TASK [Setup log path fact] 2026-06-08 07:49:37.762465 | localhost | ok 2026-06-08 07:49:37.774431 | 2026-06-08 07:49:37.774556 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-08 07:49:37.806246 | localhost | ok 2026-06-08 07:49:37.814768 | 2026-06-08 07:49:37.814891 | TASK [emit-job-header : Print job information] 2026-06-08 07:49:37.854955 | # Job Information 2026-06-08 07:49:37.855174 | Ansible Version: 2.16.18 2026-06-08 07:49:37.855221 | Job: atmosphere-molecule-csi-local-path-provisioner 2026-06-08 07:49:37.855255 | Pipeline: check 2026-06-08 07:49:37.855285 | Executor: 2d72f0692154 2026-06-08 07:49:37.855316 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3501 2026-06-08 07:49:37.855349 | Event ID: 59b915f0-630e-11f1-844a-bb8d5b758fe7 2026-06-08 07:49:37.859017 | 2026-06-08 07:49:37.859108 | LOOP [emit-job-header : Print node information] 2026-06-08 07:49:37.957713 | localhost | ok: 2026-06-08 07:49:37.957930 | localhost | # Node Information 2026-06-08 07:49:37.957967 | localhost | Inventory Hostname: instance 2026-06-08 07:49:37.957996 | localhost | Hostname: np0000178879 2026-06-08 07:49:37.958021 | localhost | Username: zuul 2026-06-08 07:49:37.958050 | localhost | Distro: Ubuntu 22.04 2026-06-08 07:49:37.958076 | localhost | Provider: yul1 2026-06-08 07:49:37.958101 | localhost | Region: ca-ymq-1 2026-06-08 07:49:37.958126 | localhost | Label: ubuntu-jammy 2026-06-08 07:49:37.958150 | localhost | Product Name: OpenStack Nova 2026-06-08 07:49:37.958174 | localhost | Interface IP: 199.204.45.132 2026-06-08 07:49:37.971517 | 2026-06-08 07:49:37.971660 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-08 07:49:38.350976 | localhost -> localhost | changed 2026-06-08 07:49:38.358322 | 2026-06-08 07:49:38.358419 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-08 07:49:39.349447 | localhost -> localhost | changed 2026-06-08 07:49:39.361088 | 2026-06-08 07:49:39.361166 | PLAY [all] 2026-06-08 07:49:39.372266 | 2026-06-08 07:49:39.372360 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-08 07:49:39.611564 | instance -> localhost | ok 2026-06-08 07:49:39.625147 | 2026-06-08 07:49:39.625260 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-08 07:49:39.656981 | instance | ok 2026-06-08 07:49:39.683324 | instance | included: /var/lib/zuul/builds/6d72f943fbae4ab09528b718b67c1186/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-08 07:49:39.709570 | 2026-06-08 07:49:39.709640 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-08 07:49:40.442772 | instance -> localhost | Generating public/private rsa key pair. 2026-06-08 07:49:40.442969 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/6d72f943fbae4ab09528b718b67c1186/work/6d72f943fbae4ab09528b718b67c1186_id_rsa 2026-06-08 07:49:40.443000 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/6d72f943fbae4ab09528b718b67c1186/work/6d72f943fbae4ab09528b718b67c1186_id_rsa.pub 2026-06-08 07:49:40.443024 | instance -> localhost | The key fingerprint is: 2026-06-08 07:49:40.443047 | instance -> localhost | SHA256:+NIwvmNWRoYmBRlrT+uIFVIp75kqFQdQ5hg7yL9+3vE zuul-build-sshkey 2026-06-08 07:49:40.443088 | instance -> localhost | The key's randomart image is: 2026-06-08 07:49:40.443111 | instance -> localhost | +---[RSA 3072]----+ 2026-06-08 07:49:40.443142 | instance -> localhost | |ooo += | 2026-06-08 07:49:40.443165 | instance -> localhost | |o*o.o.. | 2026-06-08 07:49:40.443186 | instance -> localhost | |=.o++... | 2026-06-08 07:49:40.443207 | instance -> localhost | | .oo++ooo | 2026-06-08 07:49:40.443228 | instance -> localhost | | =.=*oS | 2026-06-08 07:49:40.443248 | instance -> localhost | | .o=+ =o | 2026-06-08 07:49:40.443269 | instance -> localhost | | ..o. ++o | 2026-06-08 07:49:40.443289 | instance -> localhost | |. o .=oo | 2026-06-08 07:49:40.443311 | instance -> localhost | | . .o+.o E | 2026-06-08 07:49:40.443332 | instance -> localhost | +----[SHA256]-----+ 2026-06-08 07:49:40.443380 | instance -> localhost | ok: Runtime: 0:00:00.284374 2026-06-08 07:49:40.466043 | 2026-06-08 07:49:40.466179 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-08 07:49:40.507593 | instance | ok 2026-06-08 07:49:40.516732 | instance | included: /var/lib/zuul/builds/6d72f943fbae4ab09528b718b67c1186/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-08 07:49:40.524096 | 2026-06-08 07:49:40.524159 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-08 07:49:40.549445 | instance | skipping: Conditional result was False 2026-06-08 07:49:40.568403 | 2026-06-08 07:49:40.568722 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-08 07:49:41.050413 | instance | changed 2026-06-08 07:49:41.058742 | 2026-06-08 07:49:41.058831 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-08 07:49:41.248715 | instance | ok 2026-06-08 07:49:41.254413 | 2026-06-08 07:49:41.254502 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-08 07:49:41.757957 | instance | changed 2026-06-08 07:49:41.765443 | 2026-06-08 07:49:41.765546 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-08 07:49:42.247423 | instance | changed 2026-06-08 07:49:42.257870 | 2026-06-08 07:49:42.258035 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-08 07:49:42.284937 | instance | skipping: Conditional result was False 2026-06-08 07:49:42.294131 | 2026-06-08 07:49:42.294277 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-08 07:49:42.664763 | instance -> localhost | changed 2026-06-08 07:49:42.681951 | 2026-06-08 07:49:42.682037 | TASK [add-build-sshkey : Add back temp key] 2026-06-08 07:49:42.990480 | instance -> localhost | Identity added: /var/lib/zuul/builds/6d72f943fbae4ab09528b718b67c1186/work/6d72f943fbae4ab09528b718b67c1186_id_rsa (zuul-build-sshkey) 2026-06-08 07:49:42.990789 | instance -> localhost | ok: Runtime: 0:00:00.014557 2026-06-08 07:49:42.998525 | 2026-06-08 07:49:42.998668 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-08 07:49:43.341824 | instance | ok 2026-06-08 07:49:43.349194 | 2026-06-08 07:49:43.349317 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-08 07:49:43.375592 | instance | skipping: Conditional result was False 2026-06-08 07:49:43.394614 | 2026-06-08 07:49:43.394734 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-06-08 07:49:43.766023 | instance | ok 2026-06-08 07:49:43.773795 | 2026-06-08 07:49:43.773892 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-06-08 07:49:47.089672 | instance | Output suppressed because no_log was given 2026-06-08 07:49:47.100450 | 2026-06-08 07:49:47.100518 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-08 07:49:47.292555 | instance | ok: "logs" 2026-06-08 07:49:47.292807 | instance | ok: All items complete 2026-06-08 07:49:47.292835 | 2026-06-08 07:49:47.458349 | instance | ok: "artifacts" 2026-06-08 07:49:47.639468 | instance | ok: "docs" 2026-06-08 07:49:47.657872 | 2026-06-08 07:49:47.658046 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-08 07:49:47.882882 | instance | changed: "logs" 2026-06-08 07:49:48.053956 | instance | changed: "artifacts" 2026-06-08 07:49:48.209836 | instance | changed: "docs" 2026-06-08 07:49:48.230453 | 2026-06-08 07:49:48.230587 | PLAY RECAP 2026-06-08 07:49:48.230650 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-06-08 07:49:48.230691 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-08 07:49:48.230722 | 2026-06-08 07:49:48.383562 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-08 07:49:48.387632 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-08 07:49:48.967361 | 2026-06-08 07:49:48.967490 | PLAY [all] 2026-06-08 07:49:48.978055 | 2026-06-08 07:49:48.978131 | TASK [setup-uv : Extract archive] 2026-06-08 07:49:59.898516 | instance | ERROR 2026-06-08 07:49:59.899461 | instance | { 2026-06-08 07:49:59.899531 | 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:49:59.899586 | instance | } failure 2026-06-08 07:49:59.900899 | 2026-06-08 07:49:59.900946 | PLAY RECAP 2026-06-08 07:49:59.901020 | instance | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-06-08 07:49:59.901048 | 2026-06-08 07:50:00.032858 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-08 07:50:00.037066 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-08 07:50:00.665125 | 2026-06-08 07:50:00.665339 | PLAY [all] 2026-06-08 07:50:00.679773 | 2026-06-08 07:50:00.679926 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-08 07:50:00.726543 | instance | skipping: Conditional result was False 2026-06-08 07:50:00.737797 | 2026-06-08 07:50:00.737909 | TASK [fetch-output : Set log path for single node] 2026-06-08 07:50:00.782859 | instance | ok 2026-06-08 07:50:00.789063 | 2026-06-08 07:50:00.789132 | LOOP [fetch-output : Ensure local output dirs] 2026-06-08 07:50:01.193493 | instance -> localhost | ok: "/var/lib/zuul/builds/6d72f943fbae4ab09528b718b67c1186/work/logs" 2026-06-08 07:50:01.413224 | instance -> localhost | changed: "/var/lib/zuul/builds/6d72f943fbae4ab09528b718b67c1186/work/artifacts" 2026-06-08 07:50:01.635482 | instance -> localhost | changed: "/var/lib/zuul/builds/6d72f943fbae4ab09528b718b67c1186/work/docs" 2026-06-08 07:50:01.657025 | 2026-06-08 07:50:01.657202 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-08 07:50:02.297260 | instance | changed: .d..t...... ./ 2026-06-08 07:50:02.297524 | instance | changed: All items complete 2026-06-08 07:50:02.297563 | 2026-06-08 07:50:02.759070 | instance | changed: .d..t...... ./ 2026-06-08 07:50:03.210008 | instance | changed: .d..t...... ./ 2026-06-08 07:50:03.231592 | 2026-06-08 07:50:03.232145 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-08 07:50:03.653336 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007195 2026-06-08 07:50:03.890225 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007734 2026-06-08 07:50:03.904355 | 2026-06-08 07:50:03.904523 | PLAY [all] 2026-06-08 07:50:03.910774 | 2026-06-08 07:50:03.910849 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-08 07:50:04.351084 | instance | changed 2026-06-08 07:50:04.358411 | 2026-06-08 07:50:04.358463 | PLAY RECAP 2026-06-08 07:50:04.358515 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-08 07:50:04.358537 | 2026-06-08 07:50:04.513416 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-08 07:50:04.517708 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-08 07:50:05.142805 | 2026-06-08 07:50:05.142969 | PLAY [localhost] 2026-06-08 07:50:05.153535 | 2026-06-08 07:50:05.153647 | TASK [Generate Zuul manifest] 2026-06-08 07:50:05.175572 | localhost | ok 2026-06-08 07:50:05.194835 | 2026-06-08 07:50:05.194942 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-08 07:50:05.574859 | localhost | changed 2026-06-08 07:50:05.589107 | 2026-06-08 07:50:05.589212 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-08 07:50:05.620301 | localhost | ok 2026-06-08 07:50:05.629430 | 2026-06-08 07:50:05.629515 | TASK [Upload logs] 2026-06-08 07:50:05.651588 | localhost | ok 2026-06-08 07:50:05.714573 | 2026-06-08 07:50:05.714734 | TASK [Set zuul-log-path fact] 2026-06-08 07:50:05.733769 | localhost | ok 2026-06-08 07:50:05.748744 | 2026-06-08 07:50:05.748893 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-08 07:50:05.780640 | localhost | ok 2026-06-08 07:50:05.790580 | 2026-06-08 07:50:05.790670 | TASK [upload-logs : Create log directories] 2026-06-08 07:50:06.225507 | localhost | changed 2026-06-08 07:50:06.230239 | 2026-06-08 07:50:06.230304 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-08 07:50:06.634033 | localhost -> localhost | ok: Runtime: 0:00:00.005140 2026-06-08 07:50:06.639206 | 2026-06-08 07:50:06.639271 | TASK [upload-logs : Upload logs to log server] 2026-06-08 07:50:07.111823 | localhost | Output suppressed because no_log was given 2026-06-08 07:50:07.165046 | 2026-06-08 07:50:07.165196 | LOOP [upload-logs : Compress console log and json output] 2026-06-08 07:50:07.209198 | localhost | skipping: Conditional result was False 2026-06-08 07:50:07.218543 | localhost | skipping: Conditional result was False 2026-06-08 07:50:07.230012 | 2026-06-08 07:50:07.230229 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-08 07:50:07.270859 | localhost | skipping: Conditional result was False 2026-06-08 07:50:07.271182 | 2026-06-08 07:50:07.276364 | localhost | skipping: Conditional result was False 2026-06-08 07:50:07.285083 | 2026-06-08 07:50:07.285235 | LOOP [upload-logs : Upload console log and json output]