2026-08-18 08:51:36.715519 | Job console starting 2026-08-18 08:51:36.724010 | Updating git repos 2026-08-18 08:51:36.748973 | Cloning repos into workspace 2026-08-18 08:51:41.744089 | Restoring repo states 2026-08-18 08:51:41.752187 | Merging changes 2026-08-18 08:51:42.393436 | Checking out repos 2026-08-18 08:51:42.778507 | Preparing playbooks 2026-08-18 08:51:46.304757 | Running Ansible setup 2026-08-18 08:51:52.628005 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-18 08:51:53.271819 | 2026-08-18 08:51:53.271951 | PLAY [localhost] 2026-08-18 08:51:53.279234 | 2026-08-18 08:51:53.279304 | TASK [Gathering Facts] 2026-08-18 08:51:54.275644 | localhost | ok 2026-08-18 08:51:54.286102 | 2026-08-18 08:51:54.286181 | TASK [Setup log path fact] 2026-08-18 08:51:54.305724 | localhost | ok 2026-08-18 08:51:54.319912 | 2026-08-18 08:51:54.319981 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-18 08:51:54.352099 | localhost | ok 2026-08-18 08:51:54.360162 | 2026-08-18 08:51:54.360256 | TASK [emit-job-header : Print job information] 2026-08-18 08:51:54.401124 | # Job Information 2026-08-18 08:51:54.401314 | Ansible Version: 2.16.18 2026-08-18 08:51:54.401360 | Job: ansible-collection-ceph-molecule-aio-ubuntu-noble 2026-08-18 08:51:54.401392 | Pipeline: check 2026-08-18 08:51:54.401421 | Executor: 2d72f0692154 2026-08-18 08:51:54.401449 | Triggered by: https://github.com/vexxhost/ansible-collection-ceph/pull/123 2026-08-18 08:51:54.401488 | Event ID: 913b7cb0-9ae1-11f1-9ea3-3b773e1fc601 2026-08-18 08:51:54.406749 | 2026-08-18 08:51:54.406823 | LOOP [emit-job-header : Print node information] 2026-08-18 08:51:54.507284 | localhost | ok: 2026-08-18 08:51:54.507560 | localhost | # Node Information 2026-08-18 08:51:54.507937 | localhost | Inventory Hostname: aio 2026-08-18 08:51:54.508019 | localhost | Hostname: np0000189943 2026-08-18 08:51:54.508120 | localhost | Username: zuul 2026-08-18 08:51:54.508272 | localhost | Distro: Ubuntu 24.04 2026-08-18 08:51:54.508353 | localhost | Provider: yul1 2026-08-18 08:51:54.508391 | localhost | Region: ca-ymq-1 2026-08-18 08:51:54.508438 | localhost | Label: ubuntu-noble 2026-08-18 08:51:54.508487 | localhost | Product Name: OpenStack Nova 2026-08-18 08:51:54.508537 | localhost | Interface IP: 199.204.45.169 2026-08-18 08:51:54.533036 | 2026-08-18 08:51:54.533260 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-18 08:51:54.943761 | localhost -> localhost | changed 2026-08-18 08:51:54.953254 | 2026-08-18 08:51:54.953327 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-18 08:51:56.114978 | localhost -> localhost | changed 2026-08-18 08:51:56.123601 | 2026-08-18 08:51:56.123657 | PLAY [all] 2026-08-18 08:51:56.142631 | 2026-08-18 08:51:56.142729 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-18 08:51:56.369987 | aio -> localhost | ok 2026-08-18 08:51:56.380294 | 2026-08-18 08:51:56.380378 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-18 08:51:56.416612 | aio | ok 2026-08-18 08:51:56.432290 | aio | included: /var/lib/zuul/builds/a9c626d5e28e4e13865b77d803f1310e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-18 08:51:56.441524 | 2026-08-18 08:51:56.441589 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-18 08:51:57.938196 | aio -> localhost | Generating public/private rsa key pair. 2026-08-18 08:51:57.938437 | aio -> localhost | Your identification has been saved in /var/lib/zuul/builds/a9c626d5e28e4e13865b77d803f1310e/work/a9c626d5e28e4e13865b77d803f1310e_id_rsa 2026-08-18 08:51:57.938481 | aio -> localhost | Your public key has been saved in /var/lib/zuul/builds/a9c626d5e28e4e13865b77d803f1310e/work/a9c626d5e28e4e13865b77d803f1310e_id_rsa.pub 2026-08-18 08:51:57.938515 | aio -> localhost | The key fingerprint is: 2026-08-18 08:51:57.938548 | aio -> localhost | SHA256:Q6dr3IXdtTpTg2aEg5lqc9v5FZhSGv5+WEAvqqmOHS8 zuul-build-sshkey 2026-08-18 08:51:57.938612 | aio -> localhost | The key's randomart image is: 2026-08-18 08:51:57.938649 | aio -> localhost | +---[RSA 3072]----+ 2026-08-18 08:51:57.938696 | aio -> localhost | | | 2026-08-18 08:51:57.938729 | aio -> localhost | | + .. | 2026-08-18 08:51:57.938764 | aio -> localhost | | .+.+.o. .| 2026-08-18 08:51:57.938797 | aio -> localhost | | ..o.o*++o.| 2026-08-18 08:51:57.938827 | aio -> localhost | | +S..++*+= | 2026-08-18 08:51:57.938856 | aio -> localhost | | ..o+oo* o.o| 2026-08-18 08:51:57.938884 | aio -> localhost | | .+.+o =o. | 2026-08-18 08:51:57.938913 | aio -> localhost | | oEoo o.+. | 2026-08-18 08:51:57.938946 | aio -> localhost | | ..+o. o. | 2026-08-18 08:51:57.938975 | aio -> localhost | +----[SHA256]-----+ 2026-08-18 08:51:57.939051 | aio -> localhost | ok: Runtime: 0:00:01.053128 2026-08-18 08:51:57.946329 | 2026-08-18 08:51:57.946406 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-18 08:51:57.981674 | aio | ok 2026-08-18 08:51:57.991188 | aio | included: /var/lib/zuul/builds/a9c626d5e28e4e13865b77d803f1310e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-18 08:51:57.999915 | 2026-08-18 08:51:57.999995 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-18 08:51:58.025666 | aio | skipping: Conditional result was False 2026-08-18 08:51:58.042621 | 2026-08-18 08:51:58.043077 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-18 08:51:58.575901 | aio | changed 2026-08-18 08:51:58.581636 | 2026-08-18 08:51:58.581704 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-18 08:51:58.808510 | aio | ok 2026-08-18 08:51:58.815744 | 2026-08-18 08:51:58.815814 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-18 08:51:59.386651 | aio | changed 2026-08-18 08:51:59.579044 | 2026-08-18 08:51:59.579206 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-18 08:52:00.145189 | aio | changed 2026-08-18 08:52:00.151110 | 2026-08-18 08:52:00.151176 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-18 08:52:00.177021 | aio | skipping: Conditional result was False 2026-08-18 08:52:00.188775 | 2026-08-18 08:52:00.188871 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-18 08:52:00.569404 | aio -> localhost | changed 2026-08-18 08:52:00.581138 | 2026-08-18 08:52:00.581220 | TASK [add-build-sshkey : Add back temp key] 2026-08-18 08:52:00.922135 | aio -> localhost | Identity added: /var/lib/zuul/builds/a9c626d5e28e4e13865b77d803f1310e/work/a9c626d5e28e4e13865b77d803f1310e_id_rsa (zuul-build-sshkey) 2026-08-18 08:52:00.922342 | aio -> localhost | ok: Runtime: 0:00:00.037970 2026-08-18 08:52:00.928157 | 2026-08-18 08:52:00.928242 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-18 08:52:01.273539 | aio | ok 2026-08-18 08:52:01.280783 | 2026-08-18 08:52:01.280865 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-18 08:52:01.305145 | aio | skipping: Conditional result was False 2026-08-18 08:52:01.321873 | 2026-08-18 08:52:01.322006 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-18 08:52:01.739416 | aio | ok 2026-08-18 08:52:01.745378 | 2026-08-18 08:52:01.745445 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-18 08:52:02.491639 | aio | Output suppressed because no_log was given 2026-08-18 08:52:02.503106 | 2026-08-18 08:52:02.503189 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-18 08:52:02.751618 | aio | ok: "logs" 2026-08-18 08:52:02.751879 | aio | ok: All items complete 2026-08-18 08:52:02.751907 | 2026-08-18 08:52:02.966811 | aio | ok: "artifacts" 2026-08-18 08:52:03.178367 | aio | ok: "docs" 2026-08-18 08:52:03.194507 | 2026-08-18 08:52:03.194728 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-18 08:52:03.441103 | aio | changed: "logs" 2026-08-18 08:52:03.639732 | aio | changed: "artifacts" 2026-08-18 08:52:03.831130 | aio | changed: "docs" 2026-08-18 08:52:03.846646 | 2026-08-18 08:52:03.846789 | PLAY RECAP 2026-08-18 08:52:03.846842 | aio | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-18 08:52:03.846873 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-18 08:52:03.846899 | 2026-08-18 08:52:04.038388 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-18 08:52:04.040464 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-18 08:52:04.623272 | 2026-08-18 08:52:04.623810 | PLAY [all] 2026-08-18 08:52:04.635678 | 2026-08-18 08:52:04.635760 | TASK [setup-uv : Extract archive] 2026-08-18 08:52:07.056529 | aio | changed 2026-08-18 08:52:07.064235 | 2026-08-18 08:52:07.064320 | TASK [setup-uv : Print version] 2026-08-18 08:52:07.456695 | aio | uv 0.8.13 2026-08-18 08:52:07.604543 | aio | ok: Runtime: 0:00:00.016660 2026-08-18 08:52:07.617734 | 2026-08-18 08:52:07.617869 | TASK [Install Ansible collection siblings] 2026-08-18 08:52:08.020721 | aio | ok: 2026-08-18 08:52:08.021039 | aio | Skipping community.docker: no checked-out sibling 2026-08-18 08:52:08.021119 | aio | Skipping community.general: no checked-out sibling 2026-08-18 08:52:08.021162 | aio | Skipping ansible.utils: no checked-out sibling 2026-08-18 08:52:08.021187 | aio | Skipping vexxhost.containers: no checked-out sibling 2026-08-18 08:52:08.023025 | 2026-08-18 08:52:08.023076 | PLAY RECAP 2026-08-18 08:52:08.023123 | aio | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-18 08:52:08.023146 | 2026-08-18 08:52:08.144546 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-18 08:52:08.148159 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-18 08:52:08.768852 | 2026-08-18 08:52:08.769022 | PLAY [all] 2026-08-18 08:52:08.780582 | 2026-08-18 08:52:08.780663 | LOOP [Check inventory directories] 2026-08-18 08:52:09.148388 | aio | ok: "src/github.com/vexxhost/ansible-collection-ceph" 2026-08-18 08:52:09.327720 | aio | ok: "src/github.com/vexxhost/ansible-collection-ceph/molecule/default/inventory" 2026-08-18 08:52:09.515424 | aio | ok: "src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/inventory" 2026-08-18 08:52:09.537960 | 2026-08-18 08:52:09.538128 | LOOP [Copy inventory file for Zuul] 2026-08-18 08:52:10.473717 | aio | changed: 2026-08-18 08:52:10.473911 | aio | { 2026-08-18 08:52:10.473941 | aio | "ansible_loop_var": "item", 2026-08-18 08:52:10.473965 | aio | "changed": false, 2026-08-18 08:52:10.473986 | aio | "failed": false, 2026-08-18 08:52:10.474008 | aio | "invocation": { 2026-08-18 08:52:10.474028 | aio | "module_args": { 2026-08-18 08:52:10.474047 | aio | "checksum_algorithm": "sha1", 2026-08-18 08:52:10.474066 | aio | "follow": true, 2026-08-18 08:52:10.474085 | aio | "get_attributes": true, 2026-08-18 08:52:10.474106 | aio | "get_checksum": true, 2026-08-18 08:52:10.474125 | aio | "get_mime": true, 2026-08-18 08:52:10.474143 | aio | "path": "src/github.com/vexxhost/ansible-collection-ceph" 2026-08-18 08:52:10.474161 | aio | } 2026-08-18 08:52:10.474180 | aio | }, 2026-08-18 08:52:10.474198 | aio | "item": "src/github.com/vexxhost/ansible-collection-ceph", 2026-08-18 08:52:10.474217 | aio | "stat": { 2026-08-18 08:52:10.474235 | aio | "atime": 1787043122.3940086, 2026-08-18 08:52:10.474253 | aio | "attr_flags": "e", 2026-08-18 08:52:10.474272 | aio | "attributes": [ 2026-08-18 08:52:10.474289 | aio | "extents" 2026-08-18 08:52:10.474307 | aio | ], 2026-08-18 08:52:10.474325 | aio | "block_size": 4096, 2026-08-18 08:52:10.474343 | aio | "blocks": 8, 2026-08-18 08:52:10.474362 | aio | "charset": "unknown", 2026-08-18 08:52:10.474394 | aio | "ctime": 1787043122.4060109, 2026-08-18 08:52:10.474414 | aio | "dev": 64769, 2026-08-18 08:52:10.474432 | aio | "device_type": 0, 2026-08-18 08:52:10.474450 | aio | "executable": true, 2026-08-18 08:52:10.474468 | aio | "exists": true, 2026-08-18 08:52:10.474486 | aio | "gid": 1000, 2026-08-18 08:52:10.474504 | aio | "gr_name": "zuul", 2026-08-18 08:52:10.474522 | aio | "inode": 1034272, 2026-08-18 08:52:10.474540 | aio | "isblk": false, 2026-08-18 08:52:10.474558 | aio | "ischr": false, 2026-08-18 08:52:10.474576 | aio | "isdir": true, 2026-08-18 08:52:10.474594 | aio | "isfifo": false, 2026-08-18 08:52:10.474612 | aio | "isgid": false, 2026-08-18 08:52:10.474629 | aio | "islnk": false, 2026-08-18 08:52:10.474647 | aio | "isreg": false, 2026-08-18 08:52:10.474664 | aio | "issock": false, 2026-08-18 08:52:10.474682 | aio | "isuid": false, 2026-08-18 08:52:10.474699 | aio | "mimetype": "unknown", 2026-08-18 08:52:10.474717 | aio | "mode": "0755", 2026-08-18 08:52:10.474735 | aio | "mtime": 1787043102.1590052, 2026-08-18 08:52:10.474752 | aio | "nlink": 10, 2026-08-18 08:52:10.474769 | aio | "path": "src/github.com/vexxhost/ansible-collection-ceph", 2026-08-18 08:52:10.474787 | aio | "pw_name": "zuul", 2026-08-18 08:52:10.474806 | aio | "readable": true, 2026-08-18 08:52:10.474823 | aio | "rgrp": true, 2026-08-18 08:52:10.474841 | aio | "roth": true, 2026-08-18 08:52:10.474859 | aio | "rusr": true, 2026-08-18 08:52:10.474877 | aio | "size": 4096, 2026-08-18 08:52:10.474895 | aio | "uid": 1000, 2026-08-18 08:52:10.474913 | aio | "version": "2465106745", 2026-08-18 08:52:10.474943 | aio | "wgrp": false, 2026-08-18 08:52:10.474969 | aio | "woth": false, 2026-08-18 08:52:10.474993 | aio | "writeable": true, 2026-08-18 08:52:10.475015 | aio | "wusr": true, 2026-08-18 08:52:10.475037 | aio | "xgrp": true, 2026-08-18 08:52:10.475061 | aio | "xoth": true, 2026-08-18 08:52:10.475081 | aio | "xusr": true 2026-08-18 08:52:10.475102 | aio | } 2026-08-18 08:52:10.475123 | aio | } 2026-08-18 08:52:10.475166 | aio | ok: All items complete 2026-08-18 08:52:10.475194 | 2026-08-18 08:52:10.476443 | aio | skipping: Conditional result was False 2026-08-18 08:52:10.479986 | aio | skipping: Conditional result was False 2026-08-18 08:52:10.495233 | 2026-08-18 08:52:10.495400 | LOOP [Switch "ansible_host" to private IP] 2026-08-18 08:52:10.872547 | aio | changed: 1 replacements made 2026-08-18 08:52:10.874247 | aio | skipping: Conditional result was False 2026-08-18 08:52:10.874836 | aio | skipping: Conditional result was False 2026-08-18 08:52:10.896474 | 2026-08-18 08:52:10.896633 | TASK [Run Molecule scenario] 2026-08-18 08:52:11.350664 | aio | Using CPython 3.12.3 interpreter at: /usr/bin/python3 2026-08-18 08:52:11.350737 | aio | Creating virtual environment at: .venv 2026-08-18 08:52:11.407988 | aio | Downloading pygments (1.2MiB) 2026-08-18 08:52:11.408556 | aio | Downloading cryptography (4.3MiB) 2026-08-18 08:52:11.409240 | aio | Downloading netaddr (2.2MiB) 2026-08-18 08:52:11.409522 | aio | Downloading ansible-core (2.1MiB) 2026-08-18 08:52:11.654924 | aio | Downloading netaddr 2026-08-18 08:52:11.664474 | aio | Downloading cryptography 2026-08-18 08:52:11.720331 | aio | Downloading pygments 2026-08-18 08:52:11.857165 | aio | Downloading ansible-core 2026-08-18 08:52:11.899585 | aio | Installed 43 packages in 41ms 2026-08-18 08:52:12.646047 | aio | INFO Collection 'vexxhost.ceph' detected. 2026-08-18 08:52:12.646130 | aio | INFO Scenarios will be used from 'extensions/molecule' 2026-08-18 08:52:13.281419 | aio | INFO [default > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-18 08:52:13.281495 | aio | INFO [default > prerun] Performing prerun with role_name_check=0... 2026-08-18 08:52:38.142721 | aio | INFO [default > dependency] Executing 2026-08-18 08:52:38.142871 | aio | WARNING [default > dependency] Missing roles requirements file: requirements.yml 2026-08-18 08:52:38.142884 | aio | WARNING [default > dependency] Missing collections requirements file: collections.yml 2026-08-18 08:52:38.143086 | aio | WARNING [default > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-18 08:52:38.148699 | aio | INFO [default > cleanup] Executing 2026-08-18 08:52:38.149012 | aio | WARNING [default > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-18 08:52:38.154534 | aio | INFO [default > destroy] Executing 2026-08-18 08:52:38.154569 | aio | WARNING [default > destroy] Skipping, '--destroy=never' requested. 2026-08-18 08:52:38.154665 | aio | INFO [default > destroy] Executed: Successful 2026-08-18 08:52:38.160245 | aio | INFO [default > syntax] Executing 2026-08-18 08:52:39.479650 | aio | 2026-08-18 08:52:39.479928 | aio | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/converge.yml 2026-08-18 08:52:39.571130 | aio | INFO [default > syntax] Executed: Successful 2026-08-18 08:52:39.581660 | aio | INFO [default > create] Executing 2026-08-18 08:52:39.583159 | aio | WARNING [default > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-18 08:52:39.588859 | aio | INFO [default > prepare] Executing 2026-08-18 08:52:40.337552 | aio | 2026-08-18 08:52:40.337755 | aio | PLAY [Prepare] ***************************************************************** 2026-08-18 08:52:40.338061 | aio | 2026-08-18 08:52:40.338311 | aio | TASK [Gathering Facts] ********************************************************* 2026-08-18 08:52:40.338555 | aio | Tuesday 18 August 2026 08:52:40 +0000 (0:00:00.032) 0:00:00.032 ******** 2026-08-18 08:52:41.581684 | aio | [WARNING]: Platform linux on host aio is using the discovered Python 2026-08-18 08:52:41.581746 | aio | interpreter at /usr/bin/python3.12, but future installation of another Python 2026-08-18 08:52:41.581867 | aio | interpreter could change the meaning of that path. See 2026-08-18 08:52:41.581999 | aio | https://docs.ansible.com/ansible- 2026-08-18 08:52:41.582114 | aio | core/2.18/reference_appendices/interpreter_discovery.html for more information. 2026-08-18 08:52:41.590529 | aio | ok: [aio] 2026-08-18 08:52:41.590649 | aio | 2026-08-18 08:52:41.590807 | aio | TASK [Configure short hostname] ************************************************ 2026-08-18 08:52:41.590997 | aio | Tuesday 18 August 2026 08:52:41 +0000 (0:00:01.253) 0:00:01.285 ******** 2026-08-18 08:52:42.329412 | aio | changed: [aio] 2026-08-18 08:52:42.329606 | aio | 2026-08-18 08:52:42.329865 | aio | TASK [Ensure hostname inside hosts file] *************************************** 2026-08-18 08:52:42.330191 | aio | Tuesday 18 August 2026 08:52:42 +0000 (0:00:00.738) 0:00:02.023 ******** 2026-08-18 08:52:42.641800 | aio | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-08-18 08:52:42.642089 | aio | with a mode of 0700, this may cause issues when running as another user. To 2026-08-18 08:52:42.642363 | aio | avoid this, create the remote_tmp dir with the correct permissions manually 2026-08-18 08:52:42.651337 | aio | changed: [aio] 2026-08-18 08:52:42.651554 | aio | 2026-08-18 08:52:42.651812 | aio | TASK [Update apt cache] ******************************************************** 2026-08-18 08:52:42.652123 | aio | Tuesday 18 August 2026 08:52:42 +0000 (0:00:00.322) 0:00:02.346 ******** 2026-08-18 08:52:48.888751 | aio | changed: [aio] 2026-08-18 08:52:48.888857 | aio | 2026-08-18 08:52:48.889152 | aio | PLAY [Create devices for Ceph] ************************************************* 2026-08-18 08:52:48.889380 | aio | 2026-08-18 08:52:48.889630 | aio | TASK [Gathering Facts] ********************************************************* 2026-08-18 08:52:48.889872 | aio | Tuesday 18 August 2026 08:52:48 +0000 (0:00:06.237) 0:00:08.583 ******** 2026-08-18 08:52:50.687286 | aio | ok: [aio] 2026-08-18 08:52:50.687448 | aio | 2026-08-18 08:52:50.687796 | aio | TASK [Install depedencies] ***************************************************** 2026-08-18 08:52:50.687977 | aio | Tuesday 18 August 2026 08:52:50 +0000 (0:00:01.798) 0:00:10.381 ******** 2026-08-18 08:53:08.725407 | aio | changed: [aio] 2026-08-18 08:53:08.725570 | aio | 2026-08-18 08:53:08.725831 | aio | TASK [Start up service] ******************************************************** 2026-08-18 08:53:08.726146 | aio | Tuesday 18 August 2026 08:53:08 +0000 (0:00:18.038) 0:00:28.420 ******** 2026-08-18 08:53:09.362052 | aio | ok: [aio] 2026-08-18 08:53:09.362107 | aio | 2026-08-18 08:53:09.362127 | aio | TASK [Generate lvm.conf] ******************************************************* 2026-08-18 08:53:09.362311 | aio | Tuesday 18 August 2026 08:53:09 +0000 (0:00:00.636) 0:00:29.056 ******** 2026-08-18 08:53:09.703691 | aio | ok: [aio] 2026-08-18 08:53:09.703755 | aio | 2026-08-18 08:53:09.703873 | aio | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-08-18 08:53:09.704026 | aio | Tuesday 18 August 2026 08:53:09 +0000 (0:00:00.342) 0:00:29.399 ******** 2026-08-18 08:53:10.426005 | aio | changed: [aio] 2026-08-18 08:53:10.426037 | aio | 2026-08-18 08:53:10.426046 | aio | TASK [Get list of all loopback devices] **************************************** 2026-08-18 08:53:10.426054 | aio | Tuesday 18 August 2026 08:53:10 +0000 (0:00:00.721) 0:00:30.120 ******** 2026-08-18 08:53:10.669651 | aio | ok: [aio] 2026-08-18 08:53:10.669848 | aio | 2026-08-18 08:53:10.670177 | aio | TASK [Fail if there is any existing loopback devices] ************************** 2026-08-18 08:53:10.670431 | aio | Tuesday 18 August 2026 08:53:10 +0000 (0:00:00.244) 0:00:30.364 ******** 2026-08-18 08:53:10.695889 | aio | skipping: [aio] 2026-08-18 08:53:10.696139 | aio | 2026-08-18 08:53:10.696392 | aio | TASK [Create devices for Ceph] ************************************************* 2026-08-18 08:53:10.696653 | aio | Tuesday 18 August 2026 08:53:10 +0000 (0:00:00.026) 0:00:30.391 ******** 2026-08-18 08:53:11.370437 | aio | changed: [aio] => (item=osd0) 2026-08-18 08:53:11.370580 | aio | changed: [aio] => (item=osd1) 2026-08-18 08:53:11.370755 | aio | changed: [aio] => (item=osd2) 2026-08-18 08:53:11.370898 | aio | 2026-08-18 08:53:11.371090 | aio | TASK [Set permissions on loopback devices] ************************************* 2026-08-18 08:53:11.371276 | aio | Tuesday 18 August 2026 08:53:11 +0000 (0:00:00.672) 0:00:31.063 ******** 2026-08-18 08:53:12.100830 | aio | changed: [aio] => (item=osd0) 2026-08-18 08:53:12.102123 | aio | changed: [aio] => (item=osd1) 2026-08-18 08:53:12.102187 | aio | changed: [aio] => (item=osd2) 2026-08-18 08:53:12.102201 | aio | 2026-08-18 08:53:12.102228 | aio | TASK [Start loop devices] ****************************************************** 2026-08-18 08:53:12.102249 | aio | Tuesday 18 August 2026 08:53:12 +0000 (0:00:00.731) 0:00:31.795 ******** 2026-08-18 08:53:12.933044 | aio | changed: [aio] => (item=osd0) 2026-08-18 08:53:12.933262 | aio | changed: [aio] => (item=osd1) 2026-08-18 08:53:12.933506 | aio | changed: [aio] => (item=osd2) 2026-08-18 08:53:12.933728 | aio | 2026-08-18 08:53:12.934000 | aio | TASK [Create a volume group for each loop device] ****************************** 2026-08-18 08:53:12.934248 | aio | Tuesday 18 August 2026 08:53:12 +0000 (0:00:00.832) 0:00:32.627 ******** 2026-08-18 08:53:14.424052 | aio | changed: [aio] => (item=osd0) 2026-08-18 08:53:14.424115 | aio | changed: [aio] => (item=osd1) 2026-08-18 08:53:14.424247 | aio | changed: [aio] => (item=osd2) 2026-08-18 08:53:14.424353 | aio | 2026-08-18 08:53:14.424470 | aio | TASK [Create a logical volume for each loop device] **************************** 2026-08-18 08:53:14.424575 | aio | Tuesday 18 August 2026 08:53:14 +0000 (0:00:01.490) 0:00:34.118 ******** 2026-08-18 08:53:15.887580 | aio | changed: [aio] => (item=ceph-aio-osd0) 2026-08-18 08:53:15.887882 | aio | changed: [aio] => (item=ceph-aio-osd1) 2026-08-18 08:53:15.888141 | aio | changed: [aio] => (item=ceph-aio-osd2) 2026-08-18 08:53:15.888406 | aio | 2026-08-18 08:53:15.888691 | aio | PLAY RECAP ********************************************************************* 2026-08-18 08:53:15.889108 | aio | aio : ok=15 changed=10 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-18 08:53:15.889383 | aio | 2026-08-18 08:53:15.889612 | aio | 2026-08-18 08:53:15.889863 | aio | TASKS RECAP ******************************************************************** 2026-08-18 08:53:15.890145 | aio | Tuesday 18 August 2026 08:53:15 +0000 (0:00:01.463) 0:00:35.582 ******** 2026-08-18 08:53:15.890367 | aio | =============================================================================== 2026-08-18 08:53:15.890624 | aio | Install depedencies ---------------------------------------------------- 18.04s 2026-08-18 08:53:15.890862 | aio | Update apt cache -------------------------------------------------------- 6.24s 2026-08-18 08:53:15.891168 | aio | Gathering Facts --------------------------------------------------------- 1.80s 2026-08-18 08:53:15.891521 | aio | Create a volume group for each loop device ------------------------------ 1.49s 2026-08-18 08:53:15.891784 | aio | Create a logical volume for each loop device ---------------------------- 1.46s 2026-08-18 08:53:15.892059 | aio | Gathering Facts --------------------------------------------------------- 1.25s 2026-08-18 08:53:15.892305 | aio | Start loop devices ------------------------------------------------------ 0.83s 2026-08-18 08:53:15.892544 | aio | Configure short hostname ------------------------------------------------ 0.74s 2026-08-18 08:53:15.892788 | aio | Set permissions on loopback devices ------------------------------------- 0.73s 2026-08-18 08:53:15.893070 | aio | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.72s 2026-08-18 08:53:15.893359 | aio | Create devices for Ceph ------------------------------------------------- 0.67s 2026-08-18 08:53:15.893593 | aio | Start up service -------------------------------------------------------- 0.64s 2026-08-18 08:53:15.893896 | aio | Generate lvm.conf ------------------------------------------------------- 0.34s 2026-08-18 08:53:15.894076 | aio | Ensure hostname inside hosts file --------------------------------------- 0.32s 2026-08-18 08:53:15.894236 | aio | Get list of all loopback devices ---------------------------------------- 0.24s 2026-08-18 08:53:15.894386 | aio | Fail if there is any existing loopback devices -------------------------- 0.03s 2026-08-18 08:53:15.960245 | aio | INFO [default > prepare] Executed: Successful 2026-08-18 08:53:15.971445 | aio | INFO [default > converge] Executing 2026-08-18 08:53:17.091296 | aio | 2026-08-18 08:53:17.091486 | aio | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-08-18 08:53:17.091699 | aio | 2026-08-18 08:53:17.091937 | aio | TASK [Gathering Facts] ********************************************************* 2026-08-18 08:53:17.092227 | aio | Tuesday 18 August 2026 08:53:17 +0000 (0:00:00.057) 0:00:00.057 ******** 2026-08-18 08:53:18.286244 | aio | [WARNING]: Platform linux on host aio is using the discovered Python 2026-08-18 08:53:18.286448 | aio | interpreter at /usr/bin/python3.12, but future installation of another Python 2026-08-18 08:53:18.286687 | aio | interpreter could change the meaning of that path. See 2026-08-18 08:53:18.286971 | aio | https://docs.ansible.com/ansible- 2026-08-18 08:53:18.287242 | aio | core/2.18/reference_appendices/interpreter_discovery.html for more information. 2026-08-18 08:53:18.314273 | aio | ok: [aio] 2026-08-18 08:53:18.314459 | aio | 2026-08-18 08:53:18.314700 | aio | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-18 08:53:18.314966 | aio | Tuesday 18 August 2026 08:53:18 +0000 (0:00:01.223) 0:00:01.280 ******** 2026-08-18 08:53:18.640980 | aio | ok: [aio] 2026-08-18 08:53:18.641174 | aio | 2026-08-18 08:53:18.641425 | aio | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-18 08:53:18.641666 | aio | Tuesday 18 August 2026 08:53:18 +0000 (0:00:00.326) 0:00:01.606 ******** 2026-08-18 08:53:18.686621 | aio | skipping: [aio] 2026-08-18 08:53:18.686664 | aio | 2026-08-18 08:53:18.686788 | aio | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-08-18 08:53:18.686923 | aio | Tuesday 18 August 2026 08:53:18 +0000 (0:00:00.046) 0:00:01.653 ******** 2026-08-18 08:53:19.040010 | aio | changed: [aio] 2026-08-18 08:53:19.040051 | aio | 2026-08-18 08:53:19.040062 | aio | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-18 08:53:19.040260 | aio | Tuesday 18 August 2026 08:53:19 +0000 (0:00:00.352) 0:00:02.005 ******** 2026-08-18 08:53:19.141068 | aio | ok: [aio] => { 2026-08-18 08:53:19.141191 | aio | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-08-18 08:53:19.141323 | aio | } 2026-08-18 08:53:19.141448 | aio | 2026-08-18 08:53:19.141597 | aio | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-18 08:53:19.141740 | aio | Tuesday 18 August 2026 08:53:19 +0000 (0:00:00.101) 0:00:02.106 ******** 2026-08-18 08:53:20.009004 | aio | changed: [aio] 2026-08-18 08:53:20.009182 | aio | 2026-08-18 08:53:20.009456 | aio | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-18 08:53:20.009688 | aio | Tuesday 18 August 2026 08:53:20 +0000 (0:00:00.868) 0:00:02.974 ******** 2026-08-18 08:53:20.060517 | aio | skipping: [aio] 2026-08-18 08:53:20.060674 | aio | 2026-08-18 08:53:20.060921 | aio | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-18 08:53:20.061264 | aio | Tuesday 18 August 2026 08:53:20 +0000 (0:00:00.051) 0:00:03.026 ******** 2026-08-18 08:53:20.110590 | aio | skipping: [aio] 2026-08-18 08:53:20.110742 | aio | 2026-08-18 08:53:20.111036 | aio | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-18 08:53:20.111276 | aio | Tuesday 18 August 2026 08:53:20 +0000 (0:00:00.050) 0:00:03.076 ******** 2026-08-18 08:53:20.356660 | aio | ok: [aio] 2026-08-18 08:53:20.356731 | aio | 2026-08-18 08:53:20.356815 | aio | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-18 08:53:20.356926 | aio | Tuesday 18 August 2026 08:53:20 +0000 (0:00:00.245) 0:00:03.322 ******** 2026-08-18 08:53:21.425525 | aio | ok: [aio] 2026-08-18 08:53:21.425602 | aio | 2026-08-18 08:53:21.425678 | aio | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-18 08:53:21.425791 | aio | Tuesday 18 August 2026 08:53:21 +0000 (0:00:01.068) 0:00:04.391 ******** 2026-08-18 08:53:21.650087 | aio | ok: [aio] => { 2026-08-18 08:53:21.650208 | aio | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-08-18 08:53:21.650311 | aio | } 2026-08-18 08:53:21.650410 | aio | 2026-08-18 08:53:21.650515 | aio | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-18 08:53:21.650623 | aio | Tuesday 18 August 2026 08:53:21 +0000 (0:00:00.224) 0:00:04.616 ******** 2026-08-18 08:53:22.761725 | aio | changed: [aio] 2026-08-18 08:53:22.761759 | aio | 2026-08-18 08:53:22.761764 | aio | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-18 08:53:22.761769 | aio | Tuesday 18 August 2026 08:53:22 +0000 (0:00:01.111) 0:00:05.727 ******** 2026-08-18 08:53:25.887610 | aio | changed: [aio] 2026-08-18 08:53:25.887684 | aio | 2026-08-18 08:53:25.887695 | aio | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-08-18 08:53:25.887726 | aio | Tuesday 18 August 2026 08:53:25 +0000 (0:00:03.124) 0:00:08.852 ******** 2026-08-18 08:53:25.924234 | aio | skipping: [aio] 2026-08-18 08:53:25.924265 | aio | 2026-08-18 08:53:25.924275 | aio | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-08-18 08:53:25.924284 | aio | Tuesday 18 August 2026 08:53:25 +0000 (0:00:00.036) 0:00:08.888 ******** 2026-08-18 08:53:25.958365 | aio | skipping: [aio] 2026-08-18 08:53:25.958459 | aio | 2026-08-18 08:53:25.958575 | aio | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-08-18 08:53:25.958688 | aio | Tuesday 18 August 2026 08:53:25 +0000 (0:00:00.034) 0:00:08.923 ******** 2026-08-18 08:53:25.996311 | aio | skipping: [aio] 2026-08-18 08:53:25.996349 | aio | 2026-08-18 08:53:25.996359 | aio | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-08-18 08:53:25.996368 | aio | Tuesday 18 August 2026 08:53:25 +0000 (0:00:00.038) 0:00:08.961 ******** 2026-08-18 08:53:32.837503 | aio | changed: [aio] 2026-08-18 08:53:32.837560 | aio | 2026-08-18 08:53:32.837570 | aio | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-08-18 08:53:32.837580 | aio | Tuesday 18 August 2026 08:53:32 +0000 (0:00:06.840) 0:00:15.802 ******** 2026-08-18 08:53:33.529533 | aio | changed: [aio] 2026-08-18 08:53:33.529568 | aio | 2026-08-18 08:53:33.529573 | aio | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-08-18 08:53:33.529578 | aio | Tuesday 18 August 2026 08:53:33 +0000 (0:00:00.691) 0:00:16.493 ******** 2026-08-18 08:53:34.737777 | aio | changed: [aio] => (item={'path': '/etc/containerd'}) 2026-08-18 08:53:34.737857 | aio | changed: [aio] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-08-18 08:53:34.737925 | aio | changed: [aio] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-08-18 08:53:34.738504 | aio | changed: [aio] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-08-18 08:53:34.738541 | aio | changed: [aio] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-08-18 08:53:34.738548 | aio | 2026-08-18 08:53:34.738553 | aio | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-08-18 08:53:34.738559 | aio | Tuesday 18 August 2026 08:53:34 +0000 (0:00:01.210) 0:00:17.704 ******** 2026-08-18 08:53:35.472284 | aio | changed: [aio] 2026-08-18 08:53:35.472335 | aio | 2026-08-18 08:53:35.472349 | aio | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-08-18 08:53:35.472361 | aio | Tuesday 18 August 2026 08:53:35 +0000 (0:00:00.723) 0:00:18.427 ******** 2026-08-18 08:53:35.472373 | aio | 2026-08-18 08:53:35.472385 | aio | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-18 08:53:35.472396 | aio | Tuesday 18 August 2026 08:53:35 +0000 (0:00:00.008) 0:00:18.435 ******** 2026-08-18 08:53:36.541870 | aio | ok: [aio] 2026-08-18 08:53:36.542722 | aio | 2026-08-18 08:53:36.542770 | aio | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-08-18 08:53:36.542785 | aio | Tuesday 18 August 2026 08:53:36 +0000 (0:00:01.071) 0:00:19.507 ******** 2026-08-18 08:53:37.100563 | aio | changed: [aio] 2026-08-18 08:53:37.100651 | aio | 2026-08-18 08:53:37.100665 | aio | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-08-18 08:53:37.100678 | aio | Tuesday 18 August 2026 08:53:37 +0000 (0:00:00.558) 0:00:20.065 ******** 2026-08-18 08:53:38.803607 | aio | changed: [aio] 2026-08-18 08:53:38.803662 | aio | 2026-08-18 08:53:38.803677 | aio | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-18 08:53:38.803691 | aio | Tuesday 18 August 2026 08:53:38 +0000 (0:00:01.702) 0:00:21.768 ******** 2026-08-18 08:53:39.051092 | aio | ok: [aio] 2026-08-18 08:53:39.051180 | aio | 2026-08-18 08:53:39.051557 | aio | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-18 08:53:39.051611 | aio | Tuesday 18 August 2026 08:53:39 +0000 (0:00:00.248) 0:00:22.016 ******** 2026-08-18 08:53:39.131261 | aio | ok: [aio] => { 2026-08-18 08:53:39.131342 | aio | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-08-18 08:53:39.131353 | aio | } 2026-08-18 08:53:39.131362 | aio | 2026-08-18 08:53:39.131372 | aio | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-18 08:53:39.131381 | aio | Tuesday 18 August 2026 08:53:39 +0000 (0:00:00.079) 0:00:22.095 ******** 2026-08-18 08:53:40.097612 | aio | changed: [aio] 2026-08-18 08:53:40.097669 | aio | 2026-08-18 08:53:40.097681 | aio | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-18 08:53:40.097691 | aio | Tuesday 18 August 2026 08:53:40 +0000 (0:00:00.966) 0:00:23.061 ******** 2026-08-18 08:53:44.670609 | aio | changed: [aio] 2026-08-18 08:53:44.670656 | aio | 2026-08-18 08:53:44.670667 | aio | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-08-18 08:53:44.670676 | aio | Tuesday 18 August 2026 08:53:44 +0000 (0:00:04.572) 0:00:27.634 ******** 2026-08-18 08:53:45.563675 | aio | ok: [aio] 2026-08-18 08:53:45.563751 | aio | 2026-08-18 08:53:45.563780 | aio | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-08-18 08:53:45.563793 | aio | Tuesday 18 August 2026 08:53:45 +0000 (0:00:00.893) 0:00:28.527 ******** 2026-08-18 08:53:45.955667 | aio | changed: [aio] 2026-08-18 08:53:45.955736 | aio | 2026-08-18 08:53:45.955815 | aio | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-08-18 08:53:45.955927 | aio | Tuesday 18 August 2026 08:53:45 +0000 (0:00:00.390) 0:00:28.918 ******** 2026-08-18 08:53:46.541442 | aio | changed: [aio] 2026-08-18 08:53:46.541472 | aio | 2026-08-18 08:53:46.541478 | aio | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-08-18 08:53:46.541484 | aio | Tuesday 18 August 2026 08:53:46 +0000 (0:00:00.589) 0:00:29.507 ******** 2026-08-18 08:53:47.213875 | aio | changed: [aio] => (item={'path': '/etc/docker'}) 2026-08-18 08:53:47.213980 | aio | changed: [aio] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-08-18 08:53:47.214172 | aio | changed: [aio] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-08-18 08:53:47.214235 | aio | 2026-08-18 08:53:47.214282 | aio | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-08-18 08:53:47.214414 | aio | Tuesday 18 August 2026 08:53:47 +0000 (0:00:00.672) 0:00:30.180 ******** 2026-08-18 08:53:47.774367 | aio | changed: [aio] 2026-08-18 08:53:47.774432 | aio | 2026-08-18 08:53:47.774551 | aio | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-08-18 08:53:47.774686 | aio | Tuesday 18 August 2026 08:53:47 +0000 (0:00:00.559) 0:00:30.739 ******** 2026-08-18 08:53:48.336093 | aio | changed: [aio] 2026-08-18 08:53:48.336140 | aio | 2026-08-18 08:53:48.337010 | aio | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-08-18 08:53:48.337046 | aio | Tuesday 18 August 2026 08:53:48 +0000 (0:00:00.553) 0:00:31.292 ******** 2026-08-18 08:53:48.337052 | aio | 2026-08-18 08:53:48.337061 | aio | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-18 08:53:48.337384 | aio | Tuesday 18 August 2026 08:53:48 +0000 (0:00:00.007) 0:00:31.300 ******** 2026-08-18 08:53:49.218407 | aio | ok: [aio] 2026-08-18 08:53:49.218477 | aio | 2026-08-18 08:53:49.218557 | aio | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-08-18 08:53:49.218667 | aio | Tuesday 18 August 2026 08:53:49 +0000 (0:00:00.883) 0:00:32.184 ******** 2026-08-18 08:53:50.445628 | aio | changed: [aio] 2026-08-18 08:53:50.445699 | aio | 2026-08-18 08:53:50.445712 | aio | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-08-18 08:53:50.445725 | aio | Tuesday 18 August 2026 08:53:50 +0000 (0:00:01.225) 0:00:33.409 ******** 2026-08-18 08:53:51.151667 | aio | changed: [aio] 2026-08-18 08:53:51.151720 | aio | 2026-08-18 08:53:51.151734 | aio | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-18 08:53:51.151747 | aio | Tuesday 18 August 2026 08:53:51 +0000 (0:00:00.706) 0:00:34.116 ******** 2026-08-18 08:53:51.190037 | aio | ok: [aio] => { 2026-08-18 08:53:51.190091 | aio | "msg": "https://download.ceph.com/rpm-20.2.3/el9/noarch/cephadm" 2026-08-18 08:53:51.190101 | aio | } 2026-08-18 08:53:51.190111 | aio | 2026-08-18 08:53:51.190120 | aio | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-18 08:53:51.190128 | aio | Tuesday 18 August 2026 08:53:51 +0000 (0:00:00.037) 0:00:34.154 ******** 2026-08-18 08:53:52.753041 | aio | changed: [aio] 2026-08-18 08:53:52.753124 | aio | 2026-08-18 08:53:52.753129 | aio | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-18 08:53:52.753134 | aio | Tuesday 18 August 2026 08:53:52 +0000 (0:00:01.563) 0:00:35.717 ******** 2026-08-18 08:53:52.796516 | aio | skipping: [aio] 2026-08-18 08:53:52.796602 | aio | 2026-08-18 08:53:52.796624 | aio | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-08-18 08:53:52.796826 | aio | Tuesday 18 August 2026 08:53:52 +0000 (0:00:00.043) 0:00:35.761 ******** 2026-08-18 08:53:52.855718 | aio | ok: [aio] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/debian.yml) 2026-08-18 08:53:52.855777 | aio | 2026-08-18 08:53:52.855788 | aio | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-08-18 08:53:52.855799 | aio | Tuesday 18 August 2026 08:53:52 +0000 (0:00:00.058) 0:00:35.819 ******** 2026-08-18 08:53:53.814428 | aio | ok: [aio] 2026-08-18 08:53:53.814479 | aio | 2026-08-18 08:53:53.814545 | aio | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-08-18 08:53:53.814676 | aio | Tuesday 18 August 2026 08:53:53 +0000 (0:00:00.959) 0:00:36.779 ******** 2026-08-18 08:53:54.630411 | aio | ok: [aio] => (item=systemd-timesyncd) 2026-08-18 08:53:54.633358 | aio | ok: [aio] => (item=ssh) 2026-08-18 08:53:54.633373 | aio | 2026-08-18 08:53:54.633378 | aio | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-08-18 08:53:54.633383 | aio | Tuesday 18 August 2026 08:53:54 +0000 (0:00:00.816) 0:00:37.595 ******** 2026-08-18 08:53:54.894391 | aio | ok: [aio] 2026-08-18 08:53:54.894551 | aio | 2026-08-18 08:53:54.894698 | aio | TASK [vexxhost.ceph.cephadm : Ensure the cephadm SSH user exists] ************** 2026-08-18 08:53:54.894839 | aio | Tuesday 18 August 2026 08:53:54 +0000 (0:00:00.264) 0:00:37.860 ******** 2026-08-18 08:53:55.419393 | aio | changed: [aio] 2026-08-18 08:53:55.419556 | aio | 2026-08-18 08:53:55.419707 | aio | TASK [vexxhost.ceph.cephadm : Grant passwordless sudo to the cephadm SSH user] *** 2026-08-18 08:53:55.419849 | aio | Tuesday 18 August 2026 08:53:55 +0000 (0:00:00.524) 0:00:38.384 ******** 2026-08-18 08:53:56.009782 | aio | changed: [aio] 2026-08-18 08:53:56.010212 | aio | 2026-08-18 08:53:56.010577 | aio | TASK [vexxhost.ceph.cephadm : Log in to the container registry] **************** 2026-08-18 08:53:56.010901 | aio | Tuesday 18 August 2026 08:53:56 +0000 (0:00:00.590) 0:00:38.974 ******** 2026-08-18 08:53:56.053780 | aio | skipping: [aio] 2026-08-18 08:53:56.054193 | aio | 2026-08-18 08:53:56.054579 | aio | TASK [vexxhost.ceph.cephadm : Pre-pull the Ceph image] ************************* 2026-08-18 08:53:56.054910 | aio | Tuesday 18 August 2026 08:53:56 +0000 (0:00:00.044) 0:00:39.019 ******** 2026-08-18 08:54:35.873968 | aio | changed: [aio] 2026-08-18 08:54:35.874252 | aio | 2026-08-18 08:54:35.874675 | aio | TASK [vexxhost.ceph.cephadm : Pin CEPHADM_IMAGE for interactive login shells] *** 2026-08-18 08:54:35.874971 | aio | Tuesday 18 August 2026 08:54:35 +0000 (0:00:39.819) 0:01:18.838 ******** 2026-08-18 08:54:36.475388 | aio | changed: [aio] 2026-08-18 08:54:36.475449 | aio | 2026-08-18 08:54:36.475572 | aio | TASK [vexxhost.ceph.mon : Find this monitor's addresses on the public network] *** 2026-08-18 08:54:36.475684 | aio | Tuesday 18 August 2026 08:54:36 +0000 (0:00:00.602) 0:01:19.441 ******** 2026-08-18 08:54:36.600686 | aio | ok: [aio] 2026-08-18 08:54:36.600883 | aio | 2026-08-18 08:54:36.601999 | aio | TASK [vexxhost.ceph.mon : Assert exactly one address matches the public network] *** 2026-08-18 08:54:36.602028 | aio | Tuesday 18 August 2026 08:54:36 +0000 (0:00:00.125) 0:01:19.566 ******** 2026-08-18 08:54:36.642158 | aio | ok: [aio] => { 2026-08-18 08:54:36.642214 | aio | "changed": false, 2026-08-18 08:54:36.642225 | aio | "msg": "All assertions passed" 2026-08-18 08:54:36.642240 | aio | } 2026-08-18 08:54:36.642467 | aio | 2026-08-18 08:54:36.642756 | aio | TASK [vexxhost.ceph.mon : Set this monitor's Ceph public IP] ******************* 2026-08-18 08:54:36.643074 | aio | Tuesday 18 August 2026 08:54:36 +0000 (0:00:00.041) 0:01:19.607 ******** 2026-08-18 08:54:36.684644 | aio | ok: [aio] 2026-08-18 08:54:36.684799 | aio | 2026-08-18 08:54:36.685090 | aio | TASK [vexxhost.ceph.mon : Check whether any monitor is already bootstrapped] *** 2026-08-18 08:54:36.685329 | aio | Tuesday 18 August 2026 08:54:36 +0000 (0:00:00.043) 0:01:19.650 ******** 2026-08-18 08:54:36.936499 | aio | ok: [aio] => (item=aio) 2026-08-18 08:54:36.936561 | aio | 2026-08-18 08:54:36.936675 | aio | TASK [vexxhost.ceph.mon : Select the bootstrap node (existing one, else the first monitor)] *** 2026-08-18 08:54:36.936789 | aio | Tuesday 18 August 2026 08:54:36 +0000 (0:00:00.251) 0:01:19.902 ******** 2026-08-18 08:54:36.983695 | aio | ok: [aio] 2026-08-18 08:54:36.983824 | aio | 2026-08-18 08:54:36.984012 | aio | TASK [vexxhost.ceph.mon : Bootstrap the cluster] ******************************* 2026-08-18 08:54:36.984179 | aio | Tuesday 18 August 2026 08:54:36 +0000 (0:00:00.046) 0:01:19.949 ******** 2026-08-18 08:54:37.024439 | aio | ERROR! Could not find or access '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/playbooks/bootstrap.yml' on the Ansible Controller. 2026-08-18 08:54:37.024764 | aio | fatal: [aio]: FAILED! => {"changed": false, "include": "bootstrap.yml", "reason": "Could not find or access '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/playbooks/bootstrap.yml' on the Ansible Controller."} 2026-08-18 08:54:37.025985 | aio | 2026-08-18 08:54:37.026218 | aio | PLAY RECAP ********************************************************************* 2026-08-18 08:54:37.026525 | aio | aio : ok=45 changed=24 unreachable=0 failed=1 skipped=8 rescued=0 ignored=0 2026-08-18 08:54:37.026767 | aio | 2026-08-18 08:54:37.027149 | aio | 2026-08-18 08:54:37.027373 | aio | TASKS RECAP ******************************************************************** 2026-08-18 08:54:37.027640 | aio | Tuesday 18 August 2026 08:54:37 +0000 (0:00:00.043) 0:01:19.992 ******** 2026-08-18 08:54:37.027896 | aio | =============================================================================== 2026-08-18 08:54:37.028284 | aio | vexxhost.ceph.cephadm : Pre-pull the Ceph image ------------------------ 39.82s 2026-08-18 08:54:37.028495 | aio | vexxhost.containers.containerd : Install AppArmor packages -------------- 6.84s 2026-08-18 08:54:37.028737 | aio | vexxhost.containers.download_artifact : Extract archive ----------------- 4.57s 2026-08-18 08:54:37.029149 | aio | vexxhost.containers.download_artifact : Extract archive ----------------- 3.12s 2026-08-18 08:54:37.029340 | aio | vexxhost.containers.containerd : Reload systemd ------------------------- 1.95s 2026-08-18 08:54:37.029599 | aio | vexxhost.containers.containerd : Enable and start service --------------- 1.70s 2026-08-18 08:54:37.029843 | aio | vexxhost.containers.download_artifact : Download item ------------------- 1.56s 2026-08-18 08:54:37.030184 | aio | vexxhost.containers.docker : Restart docker ----------------------------- 1.23s 2026-08-18 08:54:37.030363 | aio | Gathering Facts --------------------------------------------------------- 1.22s 2026-08-18 08:54:37.030600 | aio | vexxhost.containers.containerd : Create folders for configuration ------- 1.21s 2026-08-18 08:54:37.030840 | aio | vexxhost.containers.download_artifact : Download item ------------------- 1.11s 2026-08-18 08:54:37.031231 | aio | vexxhost.containers.package : Update state for tar ---------------------- 1.07s 2026-08-18 08:54:37.031419 | aio | vexxhost.containers.download_artifact : Download item ------------------- 0.97s 2026-08-18 08:54:37.031658 | aio | vexxhost.ceph.cephadm : Install packages -------------------------------- 0.96s 2026-08-18 08:54:37.031897 | aio | vexxhost.containers.docker : Install AppArmor packages ------------------ 0.89s 2026-08-18 08:54:37.032077 | aio | vexxhost.containers.download_artifact : Download item ------------------- 0.87s 2026-08-18 08:54:37.032229 | aio | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.82s 2026-08-18 08:54:37.032378 | aio | vexxhost.containers.containerd : Create containerd config file ---------- 0.72s 2026-08-18 08:54:37.032542 | aio | vexxhost.containers.docker : Enable and start service ------------------- 0.71s 2026-08-18 08:54:37.032687 | aio | vexxhost.containers.containerd : Create systemd service file for containerd --- 0.69s 2026-08-18 08:54:37.120862 | 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-08-18 08:54:37.121042 | aio | ERROR [default > converge] Executed: Failed 2026-08-18 08:54:37.121174 | 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-08-18 08:54:37.544088 | aio | ERROR 2026-08-18 08:54:37.544307 | aio | { 2026-08-18 08:54:37.544347 | aio | "delta": "0:02:25.915211", 2026-08-18 08:54:37.544376 | aio | "end": "2026-08-18 08:54:37.187410", 2026-08-18 08:54:37.544405 | aio | "msg": "non-zero return code", 2026-08-18 08:54:37.544430 | aio | "rc": 2, 2026-08-18 08:54:37.544455 | aio | "start": "2026-08-18 08:52:11.272199" 2026-08-18 08:54:37.544480 | aio | } failure 2026-08-18 08:54:37.550021 | 2026-08-18 08:54:37.550075 | PLAY RECAP 2026-08-18 08:54:37.550121 | aio | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-18 08:54:37.550143 | 2026-08-18 08:54:37.721327 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-18 08:54:37.725591 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-18 08:54:38.293977 | 2026-08-18 08:54:38.294094 | PLAY [all] 2026-08-18 08:54:38.305533 | 2026-08-18 08:54:38.305610 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-18 08:54:38.349539 | aio | skipping: Conditional result was False 2026-08-18 08:54:38.360801 | 2026-08-18 08:54:38.360935 | TASK [fetch-output : Set log path for single node] 2026-08-18 08:54:38.407893 | aio | ok 2026-08-18 08:54:38.413102 | 2026-08-18 08:54:38.413173 | LOOP [fetch-output : Ensure local output dirs] 2026-08-18 08:54:38.785753 | aio -> localhost | ok: "/var/lib/zuul/builds/a9c626d5e28e4e13865b77d803f1310e/work/logs" 2026-08-18 08:54:38.990816 | aio -> localhost | changed: "/var/lib/zuul/builds/a9c626d5e28e4e13865b77d803f1310e/work/artifacts" 2026-08-18 08:54:39.216843 | aio -> localhost | changed: "/var/lib/zuul/builds/a9c626d5e28e4e13865b77d803f1310e/work/docs" 2026-08-18 08:54:39.240107 | 2026-08-18 08:54:39.240263 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-18 08:54:39.916136 | aio | ok 2026-08-18 08:54:39.916343 | aio | changed: All items complete 2026-08-18 08:54:39.916371 | 2026-08-18 08:54:40.389130 | aio | changed: .d..t...... ./ 2026-08-18 08:54:40.857859 | aio | changed: .d..t...... ./ 2026-08-18 08:54:40.884453 | 2026-08-18 08:54:40.884593 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-18 08:54:41.282779 | aio -> localhost | ok: Item: artifacts Runtime: 0:00:00.008193 2026-08-18 08:54:41.691091 | aio -> localhost | ok: Item: docs Runtime: 0:00:00.007545 2026-08-18 08:54:41.712795 | 2026-08-18 08:54:41.712989 | PLAY [all] 2026-08-18 08:54:41.719437 | 2026-08-18 08:54:41.719499 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-18 08:54:42.175584 | aio | changed 2026-08-18 08:54:42.182441 | 2026-08-18 08:54:42.182493 | PLAY RECAP 2026-08-18 08:54:42.182543 | aio | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-18 08:54:42.182567 | 2026-08-18 08:54:42.317253 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-18 08:54:42.323288 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-18 08:54:42.907444 | 2026-08-18 08:54:42.907864 | PLAY [localhost] 2026-08-18 08:54:42.918036 | 2026-08-18 08:54:42.918111 | TASK [Generate Zuul manifest] 2026-08-18 08:54:42.938856 | localhost | ok 2026-08-18 08:54:42.954348 | 2026-08-18 08:54:42.954429 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-18 08:54:43.301621 | localhost | changed 2026-08-18 08:54:43.314916 | 2026-08-18 08:54:43.314997 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-18 08:54:43.528606 | localhost | ok 2026-08-18 08:54:43.539336 | 2026-08-18 08:54:43.539407 | TASK [Upload logs] 2026-08-18 08:54:43.558511 | localhost | ok 2026-08-18 08:54:43.616355 | 2026-08-18 08:54:43.616474 | TASK [Set zuul-log-path fact] 2026-08-18 08:54:43.638090 | localhost | ok 2026-08-18 08:54:43.651246 | 2026-08-18 08:54:43.651317 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-18 08:54:43.682597 | localhost | ok 2026-08-18 08:54:43.691959 | 2026-08-18 08:54:43.692023 | TASK [upload-logs : Create log directories] 2026-08-18 08:54:44.109699 | localhost | changed 2026-08-18 08:54:44.115060 | 2026-08-18 08:54:44.115129 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-18 08:54:44.523901 | localhost -> localhost | ok: Runtime: 0:00:00.004291 2026-08-18 08:54:44.531402 | 2026-08-18 08:54:44.531572 | TASK [upload-logs : Upload logs to log server] 2026-08-18 08:54:44.995640 | localhost | Output suppressed because no_log was given 2026-08-18 08:54:45.000555 | 2026-08-18 08:54:45.000643 | LOOP [upload-logs : Compress console log and json output] 2026-08-18 08:54:45.042271 | localhost | skipping: Conditional result was False 2026-08-18 08:54:45.092127 | localhost | skipping: Conditional result was False 2026-08-18 08:54:45.106881 | 2026-08-18 08:54:45.107117 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-18 08:54:45.150984 | localhost | skipping: Conditional result was False 2026-08-18 08:54:45.151472 | 2026-08-18 08:54:45.155392 | localhost | skipping: Conditional result was False 2026-08-18 08:54:45.173435 | 2026-08-18 08:54:45.173675 | LOOP [upload-logs : Upload console log and json output]