2026-08-26 20:48:54.355046 | Job console starting 2026-08-26 20:48:54.370565 | Updating git repos 2026-08-26 20:48:54.404437 | Cloning repos into workspace 2026-08-26 20:48:54.578487 | Restoring repo states 2026-08-26 20:48:54.587700 | Merging changes 2026-08-26 20:48:54.920528 | Checking out repos 2026-08-26 20:48:54.952562 | Preparing playbooks 2026-08-26 20:48:56.140116 | Running Ansible setup 2026-08-26 20:49:01.343073 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-26 20:49:02.001507 | 2026-08-26 20:49:02.001670 | PLAY [localhost] 2026-08-26 20:49:02.009880 | 2026-08-26 20:49:02.009956 | TASK [Gathering Facts] 2026-08-26 20:49:02.923451 | localhost | ok 2026-08-26 20:49:02.935875 | 2026-08-26 20:49:02.935962 | TASK [Setup log path fact] 2026-08-26 20:49:02.956750 | localhost | ok 2026-08-26 20:49:02.970729 | 2026-08-26 20:49:02.970842 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-26 20:49:03.001538 | localhost | ok 2026-08-26 20:49:03.007983 | 2026-08-26 20:49:03.008052 | TASK [emit-job-header : Print job information] 2026-08-26 20:49:03.050405 | # Job Information 2026-08-26 20:49:03.050577 | Ansible Version: 2.16.18 2026-08-26 20:49:03.050624 | Job: ansible-collection-ceph-molecule-ha-ubuntu-jammy 2026-08-26 20:49:03.050657 | Pipeline: check 2026-08-26 20:49:03.050753 | Executor: 2d72f0692154 2026-08-26 20:49:03.050808 | Triggered by: https://github.com/vexxhost/ansible-collection-ceph/pull/117 2026-08-26 20:49:03.050845 | Event ID: 67c110d0-a18e-11f1-96e8-dbebb464ef4a 2026-08-26 20:49:03.055097 | 2026-08-26 20:49:03.055190 | LOOP [emit-job-header : Print node information] 2026-08-26 20:49:03.156543 | localhost | ok: 2026-08-26 20:49:03.156983 | localhost | # Node Information 2026-08-26 20:49:03.157036 | localhost | Inventory Hostname: mon1 2026-08-26 20:49:03.157074 | localhost | Hostname: np0000191293 2026-08-26 20:49:03.157106 | localhost | Username: zuul 2026-08-26 20:49:03.157142 | localhost | Distro: Ubuntu 22.04 2026-08-26 20:49:03.157174 | localhost | Provider: yul1 2026-08-26 20:49:03.157204 | localhost | Region: ca-ymq-1 2026-08-26 20:49:03.157235 | localhost | Label: ubuntu-jammy 2026-08-26 20:49:03.157267 | localhost | Product Name: OpenStack Nova 2026-08-26 20:49:03.157300 | localhost | Interface IP: 162.253.55.193 2026-08-26 20:49:03.204926 | localhost | ok: 2026-08-26 20:49:03.205242 | localhost | # Node Information 2026-08-26 20:49:03.205300 | localhost | Inventory Hostname: osd1 2026-08-26 20:49:03.205340 | localhost | Hostname: np0000191294 2026-08-26 20:49:03.205378 | localhost | Username: zuul 2026-08-26 20:49:03.205414 | localhost | Distro: Ubuntu 22.04 2026-08-26 20:49:03.205451 | localhost | Provider: yul1 2026-08-26 20:49:03.205486 | localhost | Region: ca-ymq-1 2026-08-26 20:49:03.205521 | localhost | Label: ubuntu-jammy 2026-08-26 20:49:03.205557 | localhost | Product Name: OpenStack Nova 2026-08-26 20:49:03.205592 | localhost | Interface IP: 162.253.55.81 2026-08-26 20:49:03.226472 | 2026-08-26 20:49:03.226661 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-26 20:49:03.682759 | localhost -> localhost | changed 2026-08-26 20:49:03.691245 | 2026-08-26 20:49:03.691637 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-26 20:49:04.559052 | localhost -> localhost | changed 2026-08-26 20:49:04.569760 | 2026-08-26 20:49:04.569839 | PLAY [all] 2026-08-26 20:49:04.579841 | 2026-08-26 20:49:04.579909 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-26 20:49:04.981242 | mon1 -> localhost | ok 2026-08-26 20:49:04.989671 | 2026-08-26 20:49:04.989739 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-26 20:49:05.024877 | mon1 | ok 2026-08-26 20:49:05.028876 | osd1 | ok 2026-08-26 20:49:05.048441 | mon1 | included: /var/lib/zuul/builds/0f7d9781fac245e8803d06886ffb7ece/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-26 20:49:05.048496 | osd1 | included: /var/lib/zuul/builds/0f7d9781fac245e8803d06886ffb7ece/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-26 20:49:05.054861 | 2026-08-26 20:49:05.054922 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-26 20:49:06.580839 | mon1 -> localhost | Generating public/private rsa key pair. 2026-08-26 20:49:06.581087 | mon1 -> localhost | Your identification has been saved in /var/lib/zuul/builds/0f7d9781fac245e8803d06886ffb7ece/work/0f7d9781fac245e8803d06886ffb7ece_id_rsa 2026-08-26 20:49:06.581133 | mon1 -> localhost | Your public key has been saved in /var/lib/zuul/builds/0f7d9781fac245e8803d06886ffb7ece/work/0f7d9781fac245e8803d06886ffb7ece_id_rsa.pub 2026-08-26 20:49:06.581166 | mon1 -> localhost | The key fingerprint is: 2026-08-26 20:49:06.581198 | mon1 -> localhost | SHA256:BmbwvOmDZGwCGA9fZ6siwpzf809Lung2J/iGn6/6dQs zuul-build-sshkey 2026-08-26 20:49:06.581228 | mon1 -> localhost | The key's randomart image is: 2026-08-26 20:49:06.581257 | mon1 -> localhost | +---[RSA 3072]----+ 2026-08-26 20:49:06.581285 | mon1 -> localhost | |o o o | 2026-08-26 20:49:06.581314 | mon1 -> localhost | |.= . * . | 2026-08-26 20:49:06.581341 | mon1 -> localhost | |o o B | 2026-08-26 20:49:06.581369 | mon1 -> localhost | |o... + + | 2026-08-26 20:49:06.581396 | mon1 -> localhost | |o+o * o S | 2026-08-26 20:49:06.581423 | mon1 -> localhost | |...*.o . | 2026-08-26 20:49:06.581449 | mon1 -> localhost | | ..o= E . | 2026-08-26 20:49:06.581476 | mon1 -> localhost | | o+B*.+ . | 2026-08-26 20:49:06.581502 | mon1 -> localhost | | oOXO+ . | 2026-08-26 20:49:06.581529 | mon1 -> localhost | +----[SHA256]-----+ 2026-08-26 20:49:06.581642 | mon1 -> localhost | ok: Runtime: 0:00:01.040017 2026-08-26 20:49:06.589042 | 2026-08-26 20:49:06.589106 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-26 20:49:06.622352 | mon1 | ok 2026-08-26 20:49:06.641492 | osd1 | ok 2026-08-26 20:49:06.661655 | mon1 | included: /var/lib/zuul/builds/0f7d9781fac245e8803d06886ffb7ece/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-26 20:49:06.661770 | osd1 | included: /var/lib/zuul/builds/0f7d9781fac245e8803d06886ffb7ece/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-26 20:49:06.673614 | 2026-08-26 20:49:06.673758 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-26 20:49:06.701372 | mon1 | skipping: Conditional result was False 2026-08-26 20:49:06.712368 | osd1 | skipping: Conditional result was False 2026-08-26 20:49:06.717941 | 2026-08-26 20:49:06.718022 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-26 20:49:07.159436 | osd1 | changed 2026-08-26 20:49:07.190040 | mon1 | changed 2026-08-26 20:49:07.197985 | 2026-08-26 20:49:07.198077 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-26 20:49:07.387327 | mon1 | ok 2026-08-26 20:49:07.417511 | osd1 | ok 2026-08-26 20:49:07.424300 | 2026-08-26 20:49:07.424389 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-26 20:49:07.952897 | osd1 | changed 2026-08-26 20:49:07.957525 | mon1 | changed 2026-08-26 20:49:07.962444 | 2026-08-26 20:49:07.962563 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-26 20:49:08.525497 | osd1 | changed 2026-08-26 20:49:08.530053 | mon1 | changed 2026-08-26 20:49:08.535107 | 2026-08-26 20:49:08.535170 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-26 20:49:08.560396 | mon1 | skipping: Conditional result was False 2026-08-26 20:49:08.572125 | osd1 | skipping: Conditional result was False 2026-08-26 20:49:08.579693 | 2026-08-26 20:49:08.579785 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-26 20:49:08.881309 | mon1 -> localhost | changed 2026-08-26 20:49:08.902688 | 2026-08-26 20:49:08.902800 | TASK [add-build-sshkey : Add back temp key] 2026-08-26 20:49:09.188907 | mon1 -> localhost | Identity added: /var/lib/zuul/builds/0f7d9781fac245e8803d06886ffb7ece/work/0f7d9781fac245e8803d06886ffb7ece_id_rsa (zuul-build-sshkey) 2026-08-26 20:49:09.189489 | mon1 -> localhost | ok: Runtime: 0:00:00.016392 2026-08-26 20:49:09.197379 | 2026-08-26 20:49:09.197468 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-26 20:49:09.489453 | osd1 | ok 2026-08-26 20:49:09.497865 | mon1 | ok 2026-08-26 20:49:09.502934 | 2026-08-26 20:49:09.503002 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-26 20:49:09.530593 | mon1 | skipping: Conditional result was False 2026-08-26 20:49:09.562392 | osd1 | skipping: Conditional result was False 2026-08-26 20:49:09.585833 | 2026-08-26 20:49:09.585913 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-26 20:49:09.893837 | osd1 | ok 2026-08-26 20:49:09.898678 | mon1 | ok 2026-08-26 20:49:09.905225 | 2026-08-26 20:49:09.905298 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-26 20:49:10.616655 | mon1 | Output suppressed because no_log was given 2026-08-26 20:49:10.655939 | osd1 | Output suppressed because no_log was given 2026-08-26 20:49:10.672005 | 2026-08-26 20:49:10.672073 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-26 20:49:10.880038 | mon1 | ok: "logs" 2026-08-26 20:49:10.880352 | mon1 | ok: All items complete 2026-08-26 20:49:10.880382 | 2026-08-26 20:49:10.892053 | osd1 | ok: "logs" 2026-08-26 20:49:11.056721 | mon1 | ok: "artifacts" 2026-08-26 20:49:11.073021 | osd1 | ok: "artifacts" 2026-08-26 20:49:11.239095 | osd1 | ok: "docs" 2026-08-26 20:49:11.246973 | mon1 | ok: "docs" 2026-08-26 20:49:11.256074 | 2026-08-26 20:49:11.256248 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-26 20:49:11.459960 | osd1 | changed: "logs" 2026-08-26 20:49:11.460277 | osd1 | ok: All items complete 2026-08-26 20:49:11.460318 | 2026-08-26 20:49:11.471887 | mon1 | changed: "logs" 2026-08-26 20:49:11.605446 | osd1 | changed: "artifacts" 2026-08-26 20:49:11.640632 | mon1 | changed: "artifacts" 2026-08-26 20:49:11.743287 | osd1 | changed: "docs" 2026-08-26 20:49:11.793965 | mon1 | changed: "docs" 2026-08-26 20:49:11.822560 | 2026-08-26 20:49:11.822720 | PLAY RECAP 2026-08-26 20:49:11.822782 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-26 20:49:11.822818 | mon1 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-26 20:49:11.822853 | osd1 | ok: 11 changed: 5 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-26 20:49:11.822875 | 2026-08-26 20:49:12.020718 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-26 20:49:12.025872 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-26 20:49:12.619561 | 2026-08-26 20:49:12.619737 | PLAY [all] 2026-08-26 20:49:12.631299 | 2026-08-26 20:49:12.631389 | TASK [setup-uv : Extract archive] 2026-08-26 20:49:17.776733 | mon1 | ERROR 2026-08-26 20:49:17.777018 | mon1 | { 2026-08-26 20:49:17.777065 | mon1 | "msg": "Failure downloading https://github.com/astral-sh/uv/releases/download/0.8.13/uv-x86_64-unknown-linux-gnu.tar.gz, Request failed: " 2026-08-26 20:49:17.777096 | mon1 | } failure 2026-08-26 20:49:19.073337 | osd1 | changed 2026-08-26 20:49:19.081237 | 2026-08-26 20:49:19.081342 | TASK [setup-uv : Print version] 2026-08-26 20:49:19.453409 | osd1 | uv 0.8.13 2026-08-26 20:49:29.653909 | osd1 | ok: Runtime: 0:00:00.013326 2026-08-26 20:49:29.665049 | 2026-08-26 20:49:29.665113 | TASK [Install Ansible collection siblings] 2026-08-26 20:49:30.041885 | osd1 | ok: 2026-08-26 20:49:30.042082 | osd1 | Skipping community.general: no checked-out sibling 2026-08-26 20:49:30.042124 | osd1 | Skipping ansible.utils: no checked-out sibling 2026-08-26 20:49:30.042158 | osd1 | Skipping vexxhost.containers: no checked-out sibling 2026-08-26 20:49:30.044279 | 2026-08-26 20:49:30.044341 | PLAY RECAP 2026-08-26 20:49:30.044402 | mon1 | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-26 20:49:30.044439 | osd1 | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-26 20:49:30.044464 | 2026-08-26 20:49:30.163451 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-26 20:49:30.166607 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-26 20:49:30.792882 | 2026-08-26 20:49:30.793119 | PLAY [all] 2026-08-26 20:49:30.805169 | 2026-08-26 20:49:30.805251 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-26 20:49:30.859650 | mon1 | ok 2026-08-26 20:49:30.866470 | osd1 | ok 2026-08-26 20:49:30.871722 | 2026-08-26 20:49:30.871803 | TASK [fetch-output : Set log path for single node] 2026-08-26 20:49:30.897531 | mon1 | skipping: Conditional result was False 2026-08-26 20:49:30.918770 | osd1 | skipping: Conditional result was False 2026-08-26 20:49:30.929659 | 2026-08-26 20:49:30.929799 | LOOP [fetch-output : Ensure local output dirs] 2026-08-26 20:49:31.339708 | osd1 -> localhost | changed: "/var/lib/zuul/builds/0f7d9781fac245e8803d06886ffb7ece/work/logs/osd1" 2026-08-26 20:49:31.369043 | mon1 -> localhost | changed: "/var/lib/zuul/builds/0f7d9781fac245e8803d06886ffb7ece/work/logs/mon1" 2026-08-26 20:49:31.574129 | osd1 -> localhost | changed: "/var/lib/zuul/builds/0f7d9781fac245e8803d06886ffb7ece/work/artifacts" 2026-08-26 20:49:31.625353 | mon1 -> localhost | ok: "/var/lib/zuul/builds/0f7d9781fac245e8803d06886ffb7ece/work/artifacts" 2026-08-26 20:49:31.810948 | osd1 -> localhost | changed: "/var/lib/zuul/builds/0f7d9781fac245e8803d06886ffb7ece/work/docs" 2026-08-26 20:49:31.868572 | mon1 -> localhost | ok: "/var/lib/zuul/builds/0f7d9781fac245e8803d06886ffb7ece/work/docs" 2026-08-26 20:49:31.868749 | mon1 -> localhost | changed: All items complete 2026-08-26 20:49:31.868808 | 2026-08-26 20:49:31.891563 | 2026-08-26 20:49:31.891660 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-26 20:49:32.593903 | mon1 | changed: .d..t...... ./ 2026-08-26 20:49:32.599975 | osd1 | changed: .d..t...... ./ 2026-08-26 20:49:33.071364 | osd1 | changed: .d..t...... ./ 2026-08-26 20:49:33.097825 | mon1 | ok 2026-08-26 20:49:33.544670 | osd1 | changed: .d..t...... ./ 2026-08-26 20:49:33.608143 | mon1 | ok 2026-08-26 20:49:33.608351 | mon1 | changed: All items complete 2026-08-26 20:49:33.608425 | 2026-08-26 20:49:33.628838 | 2026-08-26 20:49:33.629015 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-26 20:49:34.064767 | mon1 -> localhost | ok: Item: artifacts Runtime: 0:00:00.008223 2026-08-26 20:49:34.285622 | mon1 -> localhost | ok: Item: docs Runtime: 0:00:00.007437 2026-08-26 20:49:34.310787 | 2026-08-26 20:49:34.310933 | PLAY [all] 2026-08-26 20:49:34.318215 | 2026-08-26 20:49:34.318286 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-26 20:49:34.737704 | osd1 | changed 2026-08-26 20:49:34.743802 | mon1 | changed 2026-08-26 20:49:34.754209 | 2026-08-26 20:49:34.754262 | PLAY RECAP 2026-08-26 20:49:34.754315 | mon1 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-26 20:49:34.754344 | osd1 | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-26 20:49:34.754364 | 2026-08-26 20:49:34.910888 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-26 20:49:34.917166 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-26 20:49:35.538624 | 2026-08-26 20:49:35.538809 | PLAY [localhost] 2026-08-26 20:49:35.550142 | 2026-08-26 20:49:35.550218 | TASK [Generate Zuul manifest] 2026-08-26 20:49:35.570998 | localhost | ok 2026-08-26 20:49:35.589374 | 2026-08-26 20:49:35.589467 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-26 20:49:35.986544 | localhost | changed 2026-08-26 20:49:35.998989 | 2026-08-26 20:49:35.999070 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-26 20:49:36.043311 | localhost | ok 2026-08-26 20:49:36.052736 | 2026-08-26 20:49:36.052805 | TASK [Upload logs] 2026-08-26 20:49:36.071465 | localhost | ok 2026-08-26 20:49:36.129577 | 2026-08-26 20:49:36.129722 | TASK [Set zuul-log-path fact] 2026-08-26 20:49:36.153189 | localhost | ok 2026-08-26 20:49:36.165498 | 2026-08-26 20:49:36.165568 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-26 20:49:36.196805 | localhost | ok 2026-08-26 20:49:36.205858 | 2026-08-26 20:49:36.205948 | TASK [upload-logs : Create log directories] 2026-08-26 20:49:36.621554 | localhost | changed 2026-08-26 20:49:36.628115 | 2026-08-26 20:49:36.628192 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-26 20:49:37.056135 | localhost -> localhost | ok: Runtime: 0:00:00.005709 2026-08-26 20:49:37.061608 | 2026-08-26 20:49:37.061677 | TASK [upload-logs : Upload logs to log server] 2026-08-26 20:49:37.523744 | localhost | Output suppressed because no_log was given 2026-08-26 20:49:37.530094 | 2026-08-26 20:49:37.530186 | LOOP [upload-logs : Compress console log and json output] 2026-08-26 20:49:37.638119 | localhost | skipping: Conditional result was False 2026-08-26 20:49:37.645505 | localhost | skipping: Conditional result was False 2026-08-26 20:49:37.658811 | 2026-08-26 20:49:37.659159 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-26 20:49:37.752246 | localhost | skipping: Conditional result was False 2026-08-26 20:49:37.752557 | 2026-08-26 20:49:37.756565 | localhost | skipping: Conditional result was False 2026-08-26 20:49:37.831208 | 2026-08-26 20:49:37.831390 | LOOP [upload-logs : Upload console log and json output]