2026-04-18 16:15:59.239835 | Job console starting 2026-04-18 16:15:59.253731 | Updating git repos 2026-04-18 16:15:59.283100 | Cloning repos into workspace 2026-04-18 16:16:00.762692 | Restoring repo states 2026-04-18 16:16:00.770783 | Merging changes 2026-04-18 16:16:01.431930 | Checking out repos 2026-04-18 16:16:01.758735 | Preparing playbooks 2026-04-18 16:16:20.206659 | Running Ansible setup 2026-04-18 16:16:23.965909 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 16:16:24.577084 | 2026-04-18 16:16:24.577627 | PLAY [localhost] 2026-04-18 16:16:24.586872 | 2026-04-18 16:16:24.586975 | TASK [Gathering Facts] 2026-04-18 16:16:25.418733 | localhost | ok 2026-04-18 16:16:25.431489 | 2026-04-18 16:16:25.431597 | TASK [Setup log path fact] 2026-04-18 16:16:25.450090 | localhost | ok 2026-04-18 16:16:25.464189 | 2026-04-18 16:16:25.464296 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 16:16:25.492676 | localhost | ok 2026-04-18 16:16:25.501211 | 2026-04-18 16:16:25.501306 | TASK [emit-job-header : Print job information] 2026-04-18 16:16:25.540777 | # Job Information 2026-04-18 16:16:25.540995 | Ansible Version: 2.16.16 2026-04-18 16:16:25.541046 | Job: ansible-collection-ceph-molecule-aio-ubuntu-noble 2026-04-18 16:16:25.541082 | Pipeline: check 2026-04-18 16:16:25.541113 | Executor: 0a8996d2b663 2026-04-18 16:16:25.541140 | Triggered by: https://github.com/vexxhost/ansible-collection-ceph/pull/103 2026-04-18 16:16:25.541172 | Event ID: bcf0b280-3b41-11f1-9349-0bdc5a4d9f14 2026-04-18 16:16:25.544920 | 2026-04-18 16:16:25.545034 | LOOP [emit-job-header : Print node information] 2026-04-18 16:16:25.659476 | localhost | ok: 2026-04-18 16:16:25.660194 | localhost | # Node Information 2026-04-18 16:16:25.660264 | localhost | Inventory Hostname: aio 2026-04-18 16:16:25.660313 | localhost | Hostname: np0000167279 2026-04-18 16:16:25.660358 | localhost | Username: zuul 2026-04-18 16:16:25.660407 | localhost | Distro: Ubuntu 24.04 2026-04-18 16:16:25.660451 | localhost | Provider: yul1 2026-04-18 16:16:25.660494 | localhost | Region: ca-ymq-1 2026-04-18 16:16:25.660535 | localhost | Label: ubuntu-noble 2026-04-18 16:16:25.660576 | localhost | Product Name: OpenStack Nova 2026-04-18 16:16:25.660617 | localhost | Interface IP: 199.204.45.209 2026-04-18 16:16:25.676565 | 2026-04-18 16:16:25.676736 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-18 16:16:26.035508 | localhost -> localhost | changed 2026-04-18 16:16:26.045601 | 2026-04-18 16:16:26.045757 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-18 16:16:26.849408 | localhost -> localhost | changed 2026-04-18 16:16:26.859274 | 2026-04-18 16:16:26.859351 | PLAY [all] 2026-04-18 16:16:26.867809 | 2026-04-18 16:16:26.867874 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-18 16:16:27.096075 | aio -> localhost | ok 2026-04-18 16:16:27.108483 | 2026-04-18 16:16:27.108572 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-18 16:16:27.127997 | aio | ok 2026-04-18 16:16:27.143483 | aio | included: /var/lib/zuul/builds/2e77e0d484c24e49955cf4988767b521/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-18 16:16:27.149495 | 2026-04-18 16:16:27.149552 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-18 16:16:28.242385 | aio -> localhost | Generating public/private rsa key pair. 2026-04-18 16:16:28.242615 | aio -> localhost | Your identification has been saved in /var/lib/zuul/builds/2e77e0d484c24e49955cf4988767b521/work/2e77e0d484c24e49955cf4988767b521_id_rsa 2026-04-18 16:16:28.242658 | aio -> localhost | Your public key has been saved in /var/lib/zuul/builds/2e77e0d484c24e49955cf4988767b521/work/2e77e0d484c24e49955cf4988767b521_id_rsa.pub 2026-04-18 16:16:28.242691 | aio -> localhost | The key fingerprint is: 2026-04-18 16:16:28.242733 | aio -> localhost | SHA256:mLjTLHMRgSXCGtuYjpHKKZgAS6eGULdlozj3RSlHHXw zuul-build-sshkey 2026-04-18 16:16:28.242791 | aio -> localhost | The key's randomart image is: 2026-04-18 16:16:28.242823 | aio -> localhost | +---[RSA 3072]----+ 2026-04-18 16:16:28.242857 | aio -> localhost | | oo oo*.o+.. | 2026-04-18 16:16:28.242888 | aio -> localhost | |+..=.*.+o o E | 2026-04-18 16:16:28.242918 | aio -> localhost | |=X= + .o. . | 2026-04-18 16:16:28.242947 | aio -> localhost | |@o.o o = | 2026-04-18 16:16:28.242976 | aio -> localhost | |Oo. . = S | 2026-04-18 16:16:28.243006 | aio -> localhost | |*+ + . | 2026-04-18 16:16:28.243035 | aio -> localhost | |. = + | 2026-04-18 16:16:28.243063 | aio -> localhost | | = | 2026-04-18 16:16:28.243096 | aio -> localhost | | | 2026-04-18 16:16:28.243125 | aio -> localhost | +----[SHA256]-----+ 2026-04-18 16:16:28.243204 | aio -> localhost | ok: Runtime: 0:00:00.674852 2026-04-18 16:16:28.250821 | 2026-04-18 16:16:28.250959 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-18 16:16:28.286835 | aio | ok 2026-04-18 16:16:28.296425 | aio | included: /var/lib/zuul/builds/2e77e0d484c24e49955cf4988767b521/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-18 16:16:28.305692 | 2026-04-18 16:16:28.305867 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-18 16:16:28.330387 | aio | skipping: Conditional result was False 2026-04-18 16:16:28.340392 | 2026-04-18 16:16:28.340580 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-18 16:16:28.902431 | aio | changed 2026-04-18 16:16:28.908327 | 2026-04-18 16:16:28.908466 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-18 16:16:29.125185 | aio | ok 2026-04-18 16:16:29.132066 | 2026-04-18 16:16:29.132163 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-18 16:16:29.706153 | aio | changed 2026-04-18 16:16:29.712322 | 2026-04-18 16:16:29.712387 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-18 16:16:30.269172 | aio | changed 2026-04-18 16:16:30.275894 | 2026-04-18 16:16:30.275953 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-18 16:16:30.300927 | aio | skipping: Conditional result was False 2026-04-18 16:16:30.311705 | 2026-04-18 16:16:30.311775 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-18 16:16:30.670686 | aio -> localhost | changed 2026-04-18 16:16:30.684868 | 2026-04-18 16:16:30.684936 | TASK [add-build-sshkey : Add back temp key] 2026-04-18 16:16:30.957621 | aio -> localhost | Identity added: /var/lib/zuul/builds/2e77e0d484c24e49955cf4988767b521/work/2e77e0d484c24e49955cf4988767b521_id_rsa (zuul-build-sshkey) 2026-04-18 16:16:30.957820 | aio -> localhost | ok: Runtime: 0:00:00.016162 2026-04-18 16:16:30.964485 | 2026-04-18 16:16:30.964550 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-18 16:16:31.300623 | aio | ok 2026-04-18 16:16:31.305682 | 2026-04-18 16:16:31.305748 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-18 16:16:31.330364 | aio | skipping: Conditional result was False 2026-04-18 16:16:31.347000 | 2026-04-18 16:16:31.347088 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-18 16:16:31.734313 | aio | ok 2026-04-18 16:16:31.741629 | 2026-04-18 16:16:31.741690 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-18 16:16:32.486426 | aio | Output suppressed because no_log was given 2026-04-18 16:16:32.534118 | 2026-04-18 16:16:32.534266 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-18 16:16:32.759257 | aio | ok: "logs" 2026-04-18 16:16:32.759491 | aio | ok: All items complete 2026-04-18 16:16:32.759519 | 2026-04-18 16:16:32.956658 | aio | ok: "artifacts" 2026-04-18 16:16:33.145213 | aio | ok: "docs" 2026-04-18 16:16:33.160860 | 2026-04-18 16:16:33.161037 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-18 16:16:33.385782 | aio | changed: "logs" 2026-04-18 16:16:33.571913 | aio | changed: "artifacts" 2026-04-18 16:16:33.784198 | aio | changed: "docs" 2026-04-18 16:16:33.796559 | 2026-04-18 16:16:33.796666 | PLAY RECAP 2026-04-18 16:16:33.796710 | aio | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-18 16:16:33.796737 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 16:16:33.796758 | 2026-04-18 16:16:33.909581 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 16:16:33.912873 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-18 16:16:34.544647 | 2026-04-18 16:16:34.544796 | PLAY [all] 2026-04-18 16:16:34.557087 | 2026-04-18 16:16:34.557230 | TASK [setup-uv : Extract archive] 2026-04-18 16:16:43.174902 | aio | changed 2026-04-18 16:16:43.182278 | 2026-04-18 16:16:43.182357 | TASK [setup-uv : Print version] 2026-04-18 16:16:43.550467 | aio | uv 0.8.13 2026-04-18 16:16:43.722419 | aio | ok: Runtime: 0:00:00.014880 2026-04-18 16:16:43.732493 | 2026-04-18 16:16:43.732568 | PLAY RECAP 2026-04-18 16:16:43.732621 | aio | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 16:16:43.732645 | 2026-04-18 16:16:43.851015 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-18 16:16:43.854882 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-18 16:16:44.405873 | 2026-04-18 16:16:44.406006 | PLAY [all] 2026-04-18 16:16:44.417448 | 2026-04-18 16:16:44.417521 | TASK [Copy inventory file for Zuul] 2026-04-18 16:16:45.421802 | aio | changed 2026-04-18 16:16:45.428016 | 2026-04-18 16:16:45.428103 | TASK [Switch "ansible_host" to private IP] 2026-04-18 16:16:45.747564 | aio | changed: 1 replacements made 2026-04-18 16:16:45.753521 | 2026-04-18 16:16:45.753596 | TASK [Run Molecule scenario] 2026-04-18 16:16:46.186695 | aio | Using CPython 3.12.3 interpreter at: /usr/bin/python3 2026-04-18 16:16:46.186834 | aio | Creating virtual environment at: .venv 2026-04-18 16:16:46.467113 | aio | Downloading cryptography (4.3MiB) 2026-04-18 16:16:46.468160 | aio | Downloading pygments (1.2MiB) 2026-04-18 16:16:46.470479 | aio | Downloading ansible-core (2.1MiB) 2026-04-18 16:16:46.470757 | aio | Downloading netaddr (2.2MiB) 2026-04-18 16:16:46.666901 | aio | Downloading netaddr 2026-04-18 16:16:46.677253 | aio | Downloading cryptography 2026-04-18 16:16:46.741016 | aio | Downloading pygments 2026-04-18 16:16:46.939222 | aio | Downloading ansible-core 2026-04-18 16:16:46.986577 | aio | Installed 37 packages in 46ms 2026-04-18 16:16:47.756665 | aio | INFO Collection 'vexxhost.ceph' detected. 2026-04-18 16:16:47.756776 | aio | INFO Scenarios will be used from 'extensions/molecule' 2026-04-18 16:16:48.409806 | aio | INFO [default > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-18 16:16:48.409885 | aio | INFO [default > prerun] Performing prerun with role_name_check=0... 2026-04-18 16:17:01.738099 | aio | INFO [default > dependency] Executing 2026-04-18 16:17:01.738266 | aio | WARNING [default > dependency] Missing roles requirements file: requirements.yml 2026-04-18 16:17:01.738579 | aio | WARNING [default > dependency] Missing collections requirements file: collections.yml 2026-04-18 16:17:01.738766 | aio | WARNING [default > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-18 16:17:01.746584 | aio | INFO [default > cleanup] Executing 2026-04-18 16:17:01.746912 | aio | WARNING [default > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 16:17:01.752627 | aio | INFO [default > destroy] Executing 2026-04-18 16:17:01.752664 | aio | WARNING [default > destroy] Skipping, '--destroy=never' requested. 2026-04-18 16:17:01.752763 | aio | INFO [default > destroy] Executed: Successful 2026-04-18 16:17:01.758411 | aio | INFO [default > syntax] Executing 2026-04-18 16:17:02.821374 | aio | 2026-04-18 16:17:02.821698 | aio | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/converge.yml 2026-04-18 16:17:02.873370 | aio | INFO [default > syntax] Executed: Successful 2026-04-18 16:17:02.884604 | aio | INFO [default > create] Executing 2026-04-18 16:17:02.886693 | aio | WARNING [default > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 16:17:02.894056 | aio | INFO [default > prepare] Executing 2026-04-18 16:17:03.675413 | aio | 2026-04-18 16:17:03.675672 | aio | PLAY [Prepare] ***************************************************************** 2026-04-18 16:17:03.675905 | aio | 2026-04-18 16:17:03.676178 | aio | TASK [Gathering Facts] ********************************************************* 2026-04-18 16:17:03.676482 | aio | Saturday 18 April 2026 16:17:03 +0000 (0:00:00.033) 0:00:00.033 ******** 2026-04-18 16:17:04.933978 | aio | [WARNING]: Platform linux on host aio is using the discovered Python 2026-04-18 16:17:04.934280 | aio | interpreter at /usr/bin/python3.12, but future installation of another Python 2026-04-18 16:17:04.934547 | aio | interpreter could change the meaning of that path. See 2026-04-18 16:17:04.934879 | aio | https://docs.ansible.com/ansible- 2026-04-18 16:17:04.935180 | aio | core/2.18/reference_appendices/interpreter_discovery.html for more information. 2026-04-18 16:17:04.942867 | aio | ok: [aio] 2026-04-18 16:17:04.943129 | aio | 2026-04-18 16:17:04.943421 | aio | TASK [Configure short hostname] ************************************************ 2026-04-18 16:17:04.943696 | aio | Saturday 18 April 2026 16:17:04 +0000 (0:00:01.268) 0:00:01.301 ******** 2026-04-18 16:17:06.745112 | aio | changed: [aio] 2026-04-18 16:17:06.745367 | aio | 2026-04-18 16:17:06.745629 | aio | TASK [Ensure hostname inside hosts file] *************************************** 2026-04-18 16:17:06.745885 | aio | Saturday 18 April 2026 16:17:06 +0000 (0:00:01.802) 0:00:03.103 ******** 2026-04-18 16:17:07.066367 | aio | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-04-18 16:17:07.066547 | aio | with a mode of 0700, this may cause issues when running as another user. To 2026-04-18 16:17:07.066760 | aio | avoid this, create the remote_tmp dir with the correct permissions manually 2026-04-18 16:17:07.076088 | aio | changed: [aio] 2026-04-18 16:17:07.076254 | aio | 2026-04-18 16:17:07.076414 | aio | TASK [Update apt cache] ******************************************************** 2026-04-18 16:17:07.076578 | aio | Saturday 18 April 2026 16:17:07 +0000 (0:00:00.331) 0:00:03.434 ******** 2026-04-18 16:17:15.131635 | aio | changed: [aio] 2026-04-18 16:17:15.131802 | aio | 2026-04-18 16:17:15.132055 | aio | PLAY [Create devices for Ceph] ************************************************* 2026-04-18 16:17:15.132306 | aio | 2026-04-18 16:17:15.132553 | aio | TASK [Gathering Facts] ********************************************************* 2026-04-18 16:17:15.132798 | aio | Saturday 18 April 2026 16:17:15 +0000 (0:00:08.055) 0:00:11.490 ******** 2026-04-18 16:17:15.934975 | aio | ok: [aio] 2026-04-18 16:17:15.935090 | aio | 2026-04-18 16:17:15.935391 | aio | TASK [Install depedencies] ***************************************************** 2026-04-18 16:17:15.935635 | aio | Saturday 18 April 2026 16:17:15 +0000 (0:00:00.803) 0:00:12.293 ******** 2026-04-18 16:17:46.705890 | aio | changed: [aio] 2026-04-18 16:17:46.706065 | aio | 2026-04-18 16:17:46.706353 | aio | TASK [Start up service] ******************************************************** 2026-04-18 16:17:46.706608 | aio | Saturday 18 April 2026 16:17:46 +0000 (0:00:30.771) 0:00:43.064 ******** 2026-04-18 16:17:47.331008 | aio | ok: [aio] 2026-04-18 16:17:47.331082 | aio | 2026-04-18 16:17:47.331170 | aio | TASK [Generate lvm.conf] ******************************************************* 2026-04-18 16:17:47.331317 | aio | Saturday 18 April 2026 16:17:47 +0000 (0:00:00.625) 0:00:43.689 ******** 2026-04-18 16:17:47.662424 | aio | ok: [aio] 2026-04-18 16:17:47.662679 | aio | 2026-04-18 16:17:47.662926 | aio | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-04-18 16:17:47.663225 | aio | Saturday 18 April 2026 16:17:47 +0000 (0:00:00.331) 0:00:44.021 ******** 2026-04-18 16:17:48.417431 | aio | changed: [aio] 2026-04-18 16:17:48.417631 | aio | 2026-04-18 16:17:48.417879 | aio | TASK [Get list of all loopback devices] **************************************** 2026-04-18 16:17:48.418167 | aio | Saturday 18 April 2026 16:17:48 +0000 (0:00:00.754) 0:00:44.776 ******** 2026-04-18 16:17:48.667181 | aio | ok: [aio] 2026-04-18 16:17:48.667209 | aio | 2026-04-18 16:17:48.667215 | aio | TASK [Fail if there is any existing loopback devices] ************************** 2026-04-18 16:17:48.667222 | aio | Saturday 18 April 2026 16:17:48 +0000 (0:00:00.248) 0:00:45.024 ******** 2026-04-18 16:17:48.693667 | aio | skipping: [aio] 2026-04-18 16:17:48.693919 | aio | 2026-04-18 16:17:48.694247 | aio | TASK [Create devices for Ceph] ************************************************* 2026-04-18 16:17:48.694515 | aio | Saturday 18 April 2026 16:17:48 +0000 (0:00:00.028) 0:00:45.052 ******** 2026-04-18 16:17:49.348931 | aio | changed: [aio] => (item=osd0) 2026-04-18 16:17:49.349213 | aio | changed: [aio] => (item=osd1) 2026-04-18 16:17:49.349461 | aio | changed: [aio] => (item=osd2) 2026-04-18 16:17:49.349705 | aio | 2026-04-18 16:17:49.349950 | aio | TASK [Set permissions on loopback devices] ************************************* 2026-04-18 16:17:49.350224 | aio | Saturday 18 April 2026 16:17:49 +0000 (0:00:00.654) 0:00:45.707 ******** 2026-04-18 16:17:50.121263 | aio | changed: [aio] => (item=osd0) 2026-04-18 16:17:50.121526 | aio | changed: [aio] => (item=osd1) 2026-04-18 16:17:50.121771 | aio | changed: [aio] => (item=osd2) 2026-04-18 16:17:50.121995 | aio | 2026-04-18 16:17:50.122303 | aio | TASK [Start loop devices] ****************************************************** 2026-04-18 16:17:50.122590 | aio | Saturday 18 April 2026 16:17:50 +0000 (0:00:00.772) 0:00:46.479 ******** 2026-04-18 16:17:50.922989 | aio | changed: [aio] => (item=osd0) 2026-04-18 16:17:50.923256 | aio | changed: [aio] => (item=osd1) 2026-04-18 16:17:50.923502 | aio | changed: [aio] => (item=osd2) 2026-04-18 16:17:50.923723 | aio | 2026-04-18 16:17:50.923966 | aio | TASK [Create a volume group for each loop device] ****************************** 2026-04-18 16:17:50.924249 | aio | Saturday 18 April 2026 16:17:50 +0000 (0:00:00.800) 0:00:47.280 ******** 2026-04-18 16:17:52.417253 | aio | changed: [aio] => (item=osd0) 2026-04-18 16:17:52.417319 | aio | changed: [aio] => (item=osd1) 2026-04-18 16:17:52.417325 | aio | changed: [aio] => (item=osd2) 2026-04-18 16:17:52.417331 | aio | 2026-04-18 16:17:52.417338 | aio | TASK [Create a logical volume for each loop device] **************************** 2026-04-18 16:17:52.417344 | aio | Saturday 18 April 2026 16:17:52 +0000 (0:00:01.493) 0:00:48.774 ******** 2026-04-18 16:17:53.754043 | aio | changed: [aio] => (item=ceph-aio-osd0) 2026-04-18 16:17:53.754178 | aio | changed: [aio] => (item=ceph-aio-osd1) 2026-04-18 16:17:53.754446 | aio | changed: [aio] => (item=ceph-aio-osd2) 2026-04-18 16:17:53.754691 | aio | 2026-04-18 16:17:53.754972 | aio | PLAY RECAP ********************************************************************* 2026-04-18 16:17:53.755298 | aio | aio : ok=15 changed=10 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-04-18 16:17:53.755564 | aio | 2026-04-18 16:17:53.755824 | aio | 2026-04-18 16:17:53.756037 | aio | TASKS RECAP ******************************************************************** 2026-04-18 16:17:53.756333 | aio | Saturday 18 April 2026 16:17:53 +0000 (0:00:01.338) 0:00:50.113 ******** 2026-04-18 16:17:53.756580 | aio | =============================================================================== 2026-04-18 16:17:53.756836 | aio | Install depedencies ---------------------------------------------------- 30.77s 2026-04-18 16:17:53.757096 | aio | Update apt cache -------------------------------------------------------- 8.06s 2026-04-18 16:17:53.757378 | aio | Configure short hostname ------------------------------------------------ 1.80s 2026-04-18 16:17:53.757640 | aio | Create a volume group for each loop device ------------------------------ 1.49s 2026-04-18 16:17:53.757912 | aio | Create a logical volume for each loop device ---------------------------- 1.34s 2026-04-18 16:17:53.758196 | aio | Gathering Facts --------------------------------------------------------- 1.27s 2026-04-18 16:17:53.758452 | aio | Gathering Facts --------------------------------------------------------- 0.80s 2026-04-18 16:17:53.758705 | aio | Start loop devices ------------------------------------------------------ 0.80s 2026-04-18 16:17:53.758971 | aio | Set permissions on loopback devices ------------------------------------- 0.77s 2026-04-18 16:17:53.759254 | aio | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.75s 2026-04-18 16:17:53.759538 | aio | Create devices for Ceph ------------------------------------------------- 0.65s 2026-04-18 16:17:53.759790 | aio | Start up service -------------------------------------------------------- 0.63s 2026-04-18 16:17:53.760038 | aio | Generate lvm.conf ------------------------------------------------------- 0.33s 2026-04-18 16:17:53.760332 | aio | Ensure hostname inside hosts file --------------------------------------- 0.33s 2026-04-18 16:17:53.760581 | aio | Get list of all loopback devices ---------------------------------------- 0.25s 2026-04-18 16:17:53.760839 | aio | Fail if there is any existing loopback devices -------------------------- 0.03s 2026-04-18 16:17:53.821889 | aio | INFO [default > prepare] Executed: Successful 2026-04-18 16:17:53.832572 | aio | INFO [default > converge] Executing 2026-04-18 16:17:54.772738 | aio | 2026-04-18 16:17:54.772888 | aio | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-04-18 16:17:54.773132 | aio | 2026-04-18 16:17:54.773413 | aio | TASK [Gathering Facts] ********************************************************* 2026-04-18 16:17:54.773641 | aio | Saturday 18 April 2026 16:17:54 +0000 (0:00:00.050) 0:00:00.050 ******** 2026-04-18 16:17:55.930011 | aio | [WARNING]: Platform linux on host aio is using the discovered Python 2026-04-18 16:17:55.930279 | aio | interpreter at /usr/bin/python3.12, but future installation of another Python 2026-04-18 16:17:55.930556 | aio | interpreter could change the meaning of that path. See 2026-04-18 16:17:55.930803 | aio | https://docs.ansible.com/ansible- 2026-04-18 16:17:55.931050 | aio | core/2.18/reference_appendices/interpreter_discovery.html for more information. 2026-04-18 16:17:55.944768 | aio | ok: [aio] 2026-04-18 16:17:55.944947 | aio | 2026-04-18 16:17:55.945272 | aio | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-18 16:17:55.945520 | aio | Saturday 18 April 2026 16:17:55 +0000 (0:00:01.172) 0:00:01.222 ******** 2026-04-18 16:17:56.270007 | aio | ok: [aio] 2026-04-18 16:17:56.270263 | aio | 2026-04-18 16:17:56.270601 | aio | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-18 16:17:56.270886 | aio | Saturday 18 April 2026 16:17:56 +0000 (0:00:00.324) 0:00:01.547 ******** 2026-04-18 16:17:56.313084 | aio | skipping: [aio] 2026-04-18 16:17:56.313373 | aio | 2026-04-18 16:17:56.313650 | aio | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-18 16:17:56.313919 | aio | Saturday 18 April 2026 16:17:56 +0000 (0:00:00.044) 0:00:01.591 ******** 2026-04-18 16:17:56.652329 | aio | changed: [aio] 2026-04-18 16:17:56.652508 | aio | 2026-04-18 16:17:56.652835 | aio | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-18 16:17:56.653112 | aio | Saturday 18 April 2026 16:17:56 +0000 (0:00:00.338) 0:00:01.930 ******** 2026-04-18 16:17:56.752478 | aio | ok: [aio] => { 2026-04-18 16:17:56.752728 | aio | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-04-18 16:17:56.753064 | aio | } 2026-04-18 16:17:56.753208 | aio | 2026-04-18 16:17:56.753504 | aio | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-18 16:17:56.753749 | aio | Saturday 18 April 2026 16:17:56 +0000 (0:00:00.100) 0:00:02.030 ******** 2026-04-18 16:18:28.808445 | aio | fatal: [aio]: FAILED! => {"attempts": 4, "censored": "the output has been hidden due to the fact that 'no_log: true' was specified for this result", "changed": false} 2026-04-18 16:18:28.811578 | aio | FAILED - RETRYING: [aio]: Download item (4 retries left). 2026-04-18 16:18:28.811746 | aio | FAILED - RETRYING: [aio]: Download item (3 retries left). 2026-04-18 16:18:28.811904 | aio | FAILED - RETRYING: [aio]: Download item (2 retries left). 2026-04-18 16:18:28.812070 | aio | FAILED - RETRYING: [aio]: Download item (1 retries left). 2026-04-18 16:18:28.812226 | aio | 2026-04-18 16:18:28.812383 | aio | PLAY RECAP ********************************************************************* 2026-04-18 16:18:28.812536 | aio | aio : ok=4 changed=1 unreachable=0 failed=1 skipped=1 rescued=0 ignored=0 2026-04-18 16:18:28.812672 | aio | 2026-04-18 16:18:28.812807 | aio | 2026-04-18 16:18:28.813194 | aio | TASKS RECAP ******************************************************************** 2026-04-18 16:18:28.813233 | aio | Saturday 18 April 2026 16:18:28 +0000 (0:00:32.059) 0:00:34.089 ******** 2026-04-18 16:18:28.814185 | aio | =============================================================================== 2026-04-18 16:18:28.814232 | aio | vexxhost.containers.download_artifact : Download item ------------------ 32.06s 2026-04-18 16:18:28.814241 | aio | Gathering Facts --------------------------------------------------------- 1.17s 2026-04-18 16:18:28.814248 | aio | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.34s 2026-04-18 16:18:28.814255 | aio | vexxhost.containers.forget_package : Forget package --------------------- 0.32s 2026-04-18 16:18:28.814263 | aio | vexxhost.containers.download_artifact : Starting download of file ------- 0.10s 2026-04-18 16:18:28.814307 | aio | vexxhost.containers.package : Update state for tar ---------------------- 0.04s 2026-04-18 16:18:28.894488 | aio | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.kre9.default/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/inventory.yaml /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/converge.yml 2026-04-18 16:18:28.894736 | aio | ERROR [default > converge] Executed: Failed 2026-04-18 16:18:28.894953 | aio | ERROR Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.kre9.default/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/inventory.yaml /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/converge.yml 2026-04-18 16:18:29.362249 | aio | ERROR 2026-04-18 16:18:29.362473 | aio | { 2026-04-18 16:18:29.362503 | aio | "delta": "0:01:42.853692", 2026-04-18 16:18:29.362524 | aio | "end": "2026-04-18 16:18:28.966182", 2026-04-18 16:18:29.362543 | aio | "msg": "non-zero return code", 2026-04-18 16:18:29.362561 | aio | "rc": 2, 2026-04-18 16:18:29.362581 | aio | "start": "2026-04-18 16:16:46.112490" 2026-04-18 16:18:29.362599 | aio | } failure 2026-04-18 16:18:29.365330 | 2026-04-18 16:18:29.365372 | PLAY RECAP 2026-04-18 16:18:29.365414 | aio | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-18 16:18:29.365450 | 2026-04-18 16:18:29.482036 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-18 16:18:29.485442 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 16:18:30.069934 | 2026-04-18 16:18:30.070081 | PLAY [all] 2026-04-18 16:18:30.081745 | 2026-04-18 16:18:30.081820 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-18 16:18:30.126990 | aio | skipping: Conditional result was False 2026-04-18 16:18:30.133742 | 2026-04-18 16:18:30.133817 | TASK [fetch-output : Set log path for single node] 2026-04-18 16:18:30.173349 | aio | ok 2026-04-18 16:18:30.181203 | 2026-04-18 16:18:30.181290 | LOOP [fetch-output : Ensure local output dirs] 2026-04-18 16:18:30.557311 | aio -> localhost | ok: "/var/lib/zuul/builds/2e77e0d484c24e49955cf4988767b521/work/logs" 2026-04-18 16:18:30.765224 | aio -> localhost | changed: "/var/lib/zuul/builds/2e77e0d484c24e49955cf4988767b521/work/artifacts" 2026-04-18 16:18:30.973342 | aio -> localhost | changed: "/var/lib/zuul/builds/2e77e0d484c24e49955cf4988767b521/work/docs" 2026-04-18 16:18:30.993238 | 2026-04-18 16:18:30.993407 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-18 16:18:31.642490 | aio | ok 2026-04-18 16:18:31.642757 | aio | changed: All items complete 2026-04-18 16:18:31.642785 | 2026-04-18 16:18:32.095365 | aio | changed: .d..t...... ./ 2026-04-18 16:18:32.551207 | aio | changed: .d..t...... ./ 2026-04-18 16:18:32.577761 | 2026-04-18 16:18:32.577964 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-18 16:18:33.035081 | aio -> localhost | ok: Item: artifacts Runtime: 0:00:00.007092 2026-04-18 16:18:33.261606 | aio -> localhost | ok: Item: docs Runtime: 0:00:00.007515 2026-04-18 16:18:33.274926 | 2026-04-18 16:18:33.275057 | PLAY [all] 2026-04-18 16:18:33.281387 | 2026-04-18 16:18:33.281446 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-18 16:18:33.750962 | aio | changed 2026-04-18 16:18:33.757406 | 2026-04-18 16:18:33.757457 | PLAY RECAP 2026-04-18 16:18:33.757501 | aio | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-18 16:18:33.757524 | 2026-04-18 16:18:33.878218 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 16:18:33.882531 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-18 16:18:34.429534 | 2026-04-18 16:18:34.429679 | PLAY [localhost] 2026-04-18 16:18:34.440040 | 2026-04-18 16:18:34.440115 | TASK [Generate Zuul manifest] 2026-04-18 16:18:34.461425 | localhost | ok 2026-04-18 16:18:34.476321 | 2026-04-18 16:18:34.476393 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-18 16:18:34.820266 | localhost | changed 2026-04-18 16:18:34.832838 | 2026-04-18 16:18:34.832921 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-18 16:18:34.864786 | localhost | ok 2026-04-18 16:18:34.871816 | 2026-04-18 16:18:34.871881 | TASK [Upload logs] 2026-04-18 16:18:34.891481 | localhost | ok 2026-04-18 16:18:34.950946 | 2026-04-18 16:18:34.951088 | TASK [Set zuul-log-path fact] 2026-04-18 16:18:34.973956 | localhost | ok 2026-04-18 16:18:34.987842 | 2026-04-18 16:18:34.987908 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 16:18:35.020814 | localhost | ok 2026-04-18 16:18:35.030281 | 2026-04-18 16:18:35.030347 | TASK [upload-logs : Create log directories] 2026-04-18 16:18:35.438002 | localhost | changed 2026-04-18 16:18:35.445170 | 2026-04-18 16:18:35.445274 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-18 16:18:35.883134 | localhost -> localhost | ok: Runtime: 0:00:00.006356 2026-04-18 16:18:35.889612 | 2026-04-18 16:18:35.889686 | TASK [upload-logs : Upload logs to log server] 2026-04-18 16:18:36.368984 | localhost | Output suppressed because no_log was given 2026-04-18 16:18:36.372893 | 2026-04-18 16:18:36.373025 | LOOP [upload-logs : Compress console log and json output] 2026-04-18 16:18:36.423913 | localhost | skipping: Conditional result was False 2026-04-18 16:18:36.431459 | localhost | skipping: Conditional result was False 2026-04-18 16:18:36.448292 | 2026-04-18 16:18:36.448476 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-18 16:18:36.494212 | localhost | skipping: Conditional result was False 2026-04-18 16:18:36.494802 | 2026-04-18 16:18:36.497903 | localhost | skipping: Conditional result was False 2026-04-18 16:18:36.515193 | 2026-04-18 16:18:36.515344 | LOOP [upload-logs : Upload console log and json output]