2026-08-18 08:52:16.269751 | Job console starting
2026-08-18 08:52:16.286729 | Updating git repos
2026-08-18 08:52:16.326724 | Cloning repos into workspace
2026-08-18 08:52:16.364789 | Restoring repo states
2026-08-18 08:52:16.371106 | Merging changes
2026-08-18 08:52:16.695881 | Checking out repos
2026-08-18 08:52:16.735212 | Preparing playbooks
2026-08-18 08:52:17.922766 | Running Ansible setup
2026-08-18 08:52:22.230731 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-18 08:52:22.841987 | 
2026-08-18 08:52:22.842117 | PLAY [localhost]
2026-08-18 08:52:22.849672 | 
2026-08-18 08:52:22.849752 | TASK [Gathering Facts]
2026-08-18 08:52:23.688232 | localhost | ok
2026-08-18 08:52:23.699199 | 
2026-08-18 08:52:23.702880 | TASK [Setup log path fact]
2026-08-18 08:52:23.722199 | localhost | ok
2026-08-18 08:52:23.737152 | 
2026-08-18 08:52:23.737320 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-18 08:52:23.769652 | localhost | ok
2026-08-18 08:52:23.776972 | 
2026-08-18 08:52:23.777058 | TASK [emit-job-header : Print job information]
2026-08-18 08:52:23.816484 | # Job Information
2026-08-18 08:52:23.816688 | Ansible Version: 2.16.18
2026-08-18 08:52:23.816738 | Job: ansible-collection-ceph-molecule-ha-ubuntu-jammy
2026-08-18 08:52:23.816775 | Pipeline: check
2026-08-18 08:52:23.816808 | Executor: 2d72f0692154
2026-08-18 08:52:23.816839 | Triggered by: https://github.com/vexxhost/ansible-collection-ceph/pull/123
2026-08-18 08:52:23.816875 | Event ID: 913b7cb0-9ae1-11f1-9ea3-3b773e1fc601
2026-08-18 08:52:23.820926 | 
2026-08-18 08:52:23.821083 | LOOP [emit-job-header : Print node information]
2026-08-18 08:52:23.915667 | localhost | ok:
2026-08-18 08:52:23.915944 | localhost | # Node Information
2026-08-18 08:52:23.915993 | localhost | Inventory Hostname: mon1
2026-08-18 08:52:23.916036 | localhost | Hostname: np0000189948
2026-08-18 08:52:23.916067 | localhost | Username: zuul
2026-08-18 08:52:23.916107 | localhost | Distro: Ubuntu 22.04
2026-08-18 08:52:23.916137 | localhost | Provider: yul1
2026-08-18 08:52:23.916167 | localhost | Region: ca-ymq-1
2026-08-18 08:52:23.916194 | localhost | Label: ubuntu-jammy
2026-08-18 08:52:23.916282 | localhost | Product Name: OpenStack Nova
2026-08-18 08:52:23.916319 | localhost | Interface IP: 199.204.45.109
2026-08-18 08:52:23.957552 | localhost | ok:
2026-08-18 08:52:23.957625 | localhost | # Node Information
2026-08-18 08:52:23.957664 | localhost | Inventory Hostname: osd1
2026-08-18 08:52:23.957695 | localhost | Hostname: np0000189949
2026-08-18 08:52:23.957723 | localhost | Username: zuul
2026-08-18 08:52:23.957750 | localhost | Distro: Ubuntu 22.04
2026-08-18 08:52:23.957777 | localhost | Provider: yul1
2026-08-18 08:52:23.957803 | localhost | Region: ca-ymq-1
2026-08-18 08:52:23.957829 | localhost | Label: ubuntu-jammy
2026-08-18 08:52:23.957854 | localhost | Product Name: OpenStack Nova
2026-08-18 08:52:23.957881 | localhost | Interface IP: 199.204.45.210
2026-08-18 08:52:23.969011 | 
2026-08-18 08:52:23.969171 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-18 08:52:24.369727 | localhost -> localhost | changed
2026-08-18 08:52:24.374442 | 
2026-08-18 08:52:24.374680 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-18 08:52:25.220074 | localhost -> localhost | changed
2026-08-18 08:52:25.231683 | 
2026-08-18 08:52:25.232228 | PLAY [all]
2026-08-18 08:52:25.241335 | 
2026-08-18 08:52:25.241415 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-18 08:52:25.478890 | mon1 -> localhost | ok
2026-08-18 08:52:25.489793 | 
2026-08-18 08:52:25.489882 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-18 08:52:25.522667 | mon1 | ok
2026-08-18 08:52:25.528186 | osd1 | ok
2026-08-18 08:52:25.546044 | mon1 | included: /var/lib/zuul/builds/84547f19230746d1808d3224455c000b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-18 08:52:25.546121 | osd1 | included: /var/lib/zuul/builds/84547f19230746d1808d3224455c000b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-18 08:52:25.552118 | 
2026-08-18 08:52:25.552183 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-18 08:52:26.326075 | mon1 -> localhost | Generating public/private rsa key pair.
2026-08-18 08:52:26.326275 | mon1 -> localhost | Your identification has been saved in /var/lib/zuul/builds/84547f19230746d1808d3224455c000b/work/84547f19230746d1808d3224455c000b_id_rsa
2026-08-18 08:52:26.326322 | mon1 -> localhost | Your public key has been saved in /var/lib/zuul/builds/84547f19230746d1808d3224455c000b/work/84547f19230746d1808d3224455c000b_id_rsa.pub
2026-08-18 08:52:26.326357 | mon1 -> localhost | The key fingerprint is:
2026-08-18 08:52:26.326390 | mon1 -> localhost | SHA256:plu1WLj3T5AHIco4RW42DIe3hBkQ19zW+Kbo07Ucprg zuul-build-sshkey
2026-08-18 08:52:26.326422 | mon1 -> localhost | The key's randomart image is:
2026-08-18 08:52:26.326452 | mon1 -> localhost | +---[RSA 3072]----+
2026-08-18 08:52:26.326482 | mon1 -> localhost | |    oo+O+..o.    |
2026-08-18 08:52:26.326512 | mon1 -> localhost | |     .+O=.+...   |
2026-08-18 08:52:26.326542 | mon1 -> localhost | |      ooOo ..    |
2026-08-18 08:52:26.326577 | mon1 -> localhost | |       +.o  oo   |
2026-08-18 08:52:26.326614 | mon1 -> localhost | |        S.ooo .  |
2026-08-18 08:52:26.326648 | mon1 -> localhost | |       o.=..+o   |
2026-08-18 08:52:26.326680 | mon1 -> localhost | |      ..+oo= o.  |
2026-08-18 08:52:26.326712 | mon1 -> localhost | |       o+.o.o.   |
2026-08-18 08:52:26.326744 | mon1 -> localhost | |      . Eo  ...  |
2026-08-18 08:52:26.326774 | mon1 -> localhost | +----[SHA256]-----+
2026-08-18 08:52:26.326836 | mon1 -> localhost | ok: Runtime: 0:00:00.354645
2026-08-18 08:52:26.333347 | 
2026-08-18 08:52:26.333412 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-18 08:52:26.365339 | mon1 | ok
2026-08-18 08:52:26.371534 | osd1 | ok
2026-08-18 08:52:26.383436 | mon1 | included: /var/lib/zuul/builds/84547f19230746d1808d3224455c000b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-18 08:52:26.383488 | osd1 | included: /var/lib/zuul/builds/84547f19230746d1808d3224455c000b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-18 08:52:26.395850 | 
2026-08-18 08:52:26.395938 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-18 08:52:26.421457 | mon1 | skipping: Conditional result was False
2026-08-18 08:52:26.433234 | osd1 | skipping: Conditional result was False
2026-08-18 08:52:26.444523 | 
2026-08-18 08:52:26.444613 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-18 08:52:26.907016 | osd1 | changed
2026-08-18 08:52:26.913270 | mon1 | changed
2026-08-18 08:52:26.918066 | 
2026-08-18 08:52:26.918131 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-18 08:52:27.108947 | mon1 | ok
2026-08-18 08:52:27.115067 | osd1 | ok
2026-08-18 08:52:27.120029 | 
2026-08-18 08:52:27.120110 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-18 08:52:27.579332 | mon1 | changed
2026-08-18 08:52:27.596498 | osd1 | changed
2026-08-18 08:52:27.603414 | 
2026-08-18 08:52:27.603483 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-18 08:52:28.172389 | osd1 | changed
2026-08-18 08:52:28.176932 | mon1 | changed
2026-08-18 08:52:28.181429 | 
2026-08-18 08:52:28.181490 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-18 08:52:28.205289 | mon1 | skipping: Conditional result was False
2026-08-18 08:52:28.216419 | osd1 | skipping: Conditional result was False
2026-08-18 08:52:28.227472 | 
2026-08-18 08:52:28.227613 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-18 08:52:28.545649 | mon1 -> localhost | changed
2026-08-18 08:52:28.565000 | 
2026-08-18 08:52:28.565083 | TASK [add-build-sshkey : Add back temp key]
2026-08-18 08:52:28.872729 | mon1 -> localhost | Identity added: /var/lib/zuul/builds/84547f19230746d1808d3224455c000b/work/84547f19230746d1808d3224455c000b_id_rsa (zuul-build-sshkey)
2026-08-18 08:52:28.873028 | mon1 -> localhost | ok: Runtime: 0:00:00.015244
2026-08-18 08:52:28.880151 | 
2026-08-18 08:52:28.880235 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-18 08:52:29.152805 | osd1 | ok
2026-08-18 08:52:29.159128 | mon1 | ok
2026-08-18 08:52:29.163589 | 
2026-08-18 08:52:29.163657 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-18 08:52:29.189179 | mon1 | skipping: Conditional result was False
2026-08-18 08:52:29.200135 | osd1 | skipping: Conditional result was False
2026-08-18 08:52:29.218813 | 
2026-08-18 08:52:29.218882 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-18 08:52:29.492981 | mon1 | ok
2026-08-18 08:52:29.498066 | osd1 | ok
2026-08-18 08:52:29.503413 | 
2026-08-18 08:52:29.503479 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-18 08:52:30.175357 | mon1 | Output suppressed because no_log was given
2026-08-18 08:52:30.195697 | osd1 | Output suppressed because no_log was given
2026-08-18 08:52:30.210845 | 
2026-08-18 08:52:30.210917 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-18 08:52:30.390101 | mon1 | ok: "logs"
2026-08-18 08:52:30.390400 | mon1 | ok: All items complete
2026-08-18 08:52:30.390445 | 
2026-08-18 08:52:30.400515 | osd1 | ok: "logs"
2026-08-18 08:52:30.573991 | osd1 | ok: "artifacts"
2026-08-18 08:52:30.587492 | mon1 | ok: "artifacts"
2026-08-18 08:52:30.742777 | mon1 | ok: "docs"
2026-08-18 08:52:30.748084 | osd1 | ok: "docs"
2026-08-18 08:52:30.755684 | 
2026-08-18 08:52:30.755759 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-18 08:52:30.947968 | mon1 | changed: "logs"
2026-08-18 08:52:30.948233 | mon1 | ok: All items complete
2026-08-18 08:52:30.948267 | 
2026-08-18 08:52:30.961555 | osd1 | changed: "logs"
2026-08-18 08:52:31.107362 | mon1 | changed: "artifacts"
2026-08-18 08:52:31.134966 | osd1 | changed: "artifacts"
2026-08-18 08:52:31.267914 | mon1 | changed: "docs"
2026-08-18 08:52:31.307045 | osd1 | changed: "docs"
2026-08-18 08:52:31.326096 | 
2026-08-18 08:52:31.326224 | PLAY RECAP
2026-08-18 08:52:31.326274 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-18 08:52:31.326305 | mon1 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-18 08:52:31.326331 | osd1 | ok: 11 changed: 5 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-18 08:52:31.326351 | 
2026-08-18 08:52:31.495039 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-18 08:52:31.499893 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-18 08:52:32.116423 | 
2026-08-18 08:52:32.116629 | PLAY [all]
2026-08-18 08:52:32.127984 | 
2026-08-18 08:52:32.128068 | TASK [setup-uv : Extract archive]
2026-08-18 08:52:34.375399 | mon1 | changed
2026-08-18 08:52:34.444792 | osd1 | changed
2026-08-18 08:52:34.452614 | 
2026-08-18 08:52:34.452696 | TASK [setup-uv : Print version]
2026-08-18 08:52:34.823869 | mon1 | uv 0.8.13
2026-08-18 08:52:34.810394 | osd1 | uv 0.8.13
2026-08-18 08:52:35.013779 | mon1 | ok: Runtime: 0:00:00.013287
2026-08-18 08:52:35.025534 | osd1 | ok: Runtime: 0:00:00.011262
2026-08-18 08:52:35.039397 | 
2026-08-18 08:52:35.039467 | TASK [Install Ansible collection siblings]
2026-08-18 08:52:35.418707 | mon1 | ok:
2026-08-18 08:52:35.418940 | mon1 | Skipping community.docker: no checked-out sibling
2026-08-18 08:52:35.418983 | mon1 | Skipping community.general: no checked-out sibling
2026-08-18 08:52:35.419014 | mon1 | Skipping ansible.utils: no checked-out sibling
2026-08-18 08:52:35.419049 | mon1 | Skipping vexxhost.containers: no checked-out sibling
2026-08-18 08:52:35.421498 | 
2026-08-18 08:52:35.421568 | PLAY RECAP
2026-08-18 08:52:35.421639 | mon1 | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-18 08:52:35.421696 | osd1 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-18 08:52:35.421725 | 
2026-08-18 08:52:35.564421 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-18 08:52:35.568649 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-18 08:52:36.154492 | 
2026-08-18 08:52:36.154640 | PLAY [all]
2026-08-18 08:52:36.165839 | 
2026-08-18 08:52:36.165911 | LOOP [Check inventory directories]
2026-08-18 08:52:36.491063 | mon1 | ok: "src/github.com/vexxhost/ansible-collection-ceph"
2026-08-18 08:52:36.648062 | mon1 | ok: "src/github.com/vexxhost/ansible-collection-ceph/molecule/default/inventory"
2026-08-18 08:52:36.797522 | mon1 | ok: "src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/inventory"
2026-08-18 08:52:36.810913 | 
2026-08-18 08:52:36.811221 | LOOP [Copy inventory file for Zuul]
2026-08-18 08:52:37.581816 | mon1 | changed:
2026-08-18 08:52:37.582103 | mon1 | {
2026-08-18 08:52:37.582155 | mon1 |   "ansible_loop_var": "item",
2026-08-18 08:52:37.582234 | mon1 |   "changed": false,
2026-08-18 08:52:37.582281 | mon1 |   "failed": false,
2026-08-18 08:52:37.582322 | mon1 |   "invocation": {
2026-08-18 08:52:37.582355 | mon1 |     "module_args": {
2026-08-18 08:52:37.582387 | mon1 |       "checksum_algorithm": "sha1",
2026-08-18 08:52:37.582418 | mon1 |       "follow": true,
2026-08-18 08:52:37.582449 | mon1 |       "get_attributes": true,
2026-08-18 08:52:37.582482 | mon1 |       "get_checksum": true,
2026-08-18 08:52:37.582512 | mon1 |       "get_mime": true,
2026-08-18 08:52:37.582542 | mon1 |       "path": "src/github.com/vexxhost/ansible-collection-ceph"
2026-08-18 08:52:37.582573 | mon1 |     }
2026-08-18 08:52:37.582604 | mon1 |   },
2026-08-18 08:52:37.582634 | mon1 |   "item": "src/github.com/vexxhost/ansible-collection-ceph",
2026-08-18 08:52:37.582664 | mon1 |   "stat": {
2026-08-18 08:52:37.582695 | mon1 |     "atime": 1787043150.0601428,
2026-08-18 08:52:37.582727 | mon1 |     "attr_flags": "e",
2026-08-18 08:52:37.582757 | mon1 |     "attributes": [
2026-08-18 08:52:37.582786 | mon1 |       "extents"
2026-08-18 08:52:37.582815 | mon1 |     ],
2026-08-18 08:52:37.582845 | mon1 |     "block_size": 4096,
2026-08-18 08:52:37.582875 | mon1 |     "blocks": 8,
2026-08-18 08:52:37.582905 | mon1 |     "charset": "unknown",
2026-08-18 08:52:37.582937 | mon1 |     "ctime": 1787043150.0681427,
2026-08-18 08:52:37.582967 | mon1 |     "dev": 64513,
2026-08-18 08:52:37.582997 | mon1 |     "device_type": 0,
2026-08-18 08:52:37.583027 | mon1 |     "executable": true,
2026-08-18 08:52:37.583057 | mon1 |     "exists": true,
2026-08-18 08:52:37.583086 | mon1 |     "gid": 1000,
2026-08-18 08:52:37.583116 | mon1 |     "gr_name": "zuul",
2026-08-18 08:52:37.583145 | mon1 |     "inode": 1042461,
2026-08-18 08:52:37.583174 | mon1 |     "isblk": false,
2026-08-18 08:52:37.583205 | mon1 |     "ischr": false,
2026-08-18 08:52:37.583234 | mon1 |     "isdir": true,
2026-08-18 08:52:37.583264 | mon1 |     "isfifo": false,
2026-08-18 08:52:37.583293 | mon1 |     "isgid": false,
2026-08-18 08:52:37.583322 | mon1 |     "islnk": false,
2026-08-18 08:52:37.583351 | mon1 |     "isreg": false,
2026-08-18 08:52:37.583403 | mon1 |     "issock": false,
2026-08-18 08:52:37.583434 | mon1 |     "isuid": false,
2026-08-18 08:52:37.583463 | mon1 |     "mimetype": "unknown",
2026-08-18 08:52:37.583492 | mon1 |     "mode": "0755",
2026-08-18 08:52:37.583649 | mon1 |     "mtime": 1787043136.6557732,
2026-08-18 08:52:37.583707 | mon1 |     "nlink": 10,
2026-08-18 08:52:37.583737 | mon1 |     "path": "src/github.com/vexxhost/ansible-collection-ceph",
2026-08-18 08:52:37.583764 | mon1 |     "pw_name": "zuul",
2026-08-18 08:52:37.583794 | mon1 |     "readable": true,
2026-08-18 08:52:37.583818 | mon1 |     "rgrp": true,
2026-08-18 08:52:37.583842 | mon1 |     "roth": true,
2026-08-18 08:52:37.583867 | mon1 |     "rusr": true,
2026-08-18 08:52:37.583911 | mon1 |     "size": 4096,
2026-08-18 08:52:37.583937 | mon1 |     "uid": 1000,
2026-08-18 08:52:37.583961 | mon1 |     "version": "831699238",
2026-08-18 08:52:37.583985 | mon1 |     "wgrp": false,
2026-08-18 08:52:37.584009 | mon1 |     "woth": false,
2026-08-18 08:52:37.584027 | mon1 |     "writeable": true,
2026-08-18 08:52:37.584044 | mon1 |     "wusr": true,
2026-08-18 08:52:37.584061 | mon1 |     "xgrp": true,
2026-08-18 08:52:37.584077 | mon1 |     "xoth": true,
2026-08-18 08:52:37.584093 | mon1 |     "xusr": true
2026-08-18 08:52:37.584110 | mon1 |   }
2026-08-18 08:52:37.584128 | mon1 | }
2026-08-18 08:52:37.584168 | mon1 | ok: All items complete
2026-08-18 08:52:37.584189 | 
2026-08-18 08:52:37.585568 | mon1 | skipping: Conditional result was False
2026-08-18 08:52:37.586177 | mon1 | skipping: Conditional result was False
2026-08-18 08:52:37.608521 | 
2026-08-18 08:52:37.608683 | LOOP [Switch "ansible_host" to private IP]
2026-08-18 08:52:37.946761 | mon1 | changed: 2 replacements made
2026-08-18 08:52:37.948542 | mon1 | skipping: Conditional result was False
2026-08-18 08:52:37.949809 | mon1 | skipping: Conditional result was False
2026-08-18 08:52:37.965209 | 
2026-08-18 08:52:37.965382 | TASK [Run Molecule scenario]
2026-08-18 08:52:38.547606 | mon1 | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB)
2026-08-18 08:52:39.286985 | mon1 |  Downloading cpython-3.13.7-linux-x86_64-gnu (download)
2026-08-18 08:52:39.456957 | mon1 | Using CPython 3.13.7
2026-08-18 08:52:39.457043 | mon1 | Creating virtual environment at: .venv
2026-08-18 08:52:39.500366 | mon1 | Downloading cryptography (4.3MiB)
2026-08-18 08:52:39.501769 | mon1 | Downloading ansible-core (2.1MiB)
2026-08-18 08:52:39.507412 | mon1 | Downloading pygments (1.2MiB)
2026-08-18 08:52:39.508014 | mon1 | Downloading netaddr (2.2MiB)
2026-08-18 08:52:39.741288 | mon1 |  Downloading netaddr
2026-08-18 08:52:39.751418 | mon1 |  Downloading cryptography
2026-08-18 08:52:39.798677 | mon1 |  Downloading pygments
2026-08-18 08:52:39.926583 | mon1 |  Downloading ansible-core
2026-08-18 08:52:39.954929 | mon1 | Installed 42 packages in 27ms
2026-08-18 08:52:41.062081 | mon1 | INFO     Collection 'vexxhost.ceph' detected.
2026-08-18 08:52:41.062198 | mon1 | INFO     Scenarios will be used from 'extensions/molecule'
2026-08-18 08:52:41.686804 | mon1 | INFO     [default > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-18 08:52:41.686954 | mon1 | INFO     [default > prerun] Performing prerun with role_name_check=0...
2026-08-18 08:52:58.176746 | mon1 | INFO     [default > dependency] Executing
2026-08-18 08:52:58.176954 | mon1 | WARNING  [default > dependency] Missing roles requirements file: requirements.yml
2026-08-18 08:52:58.177219 | mon1 | WARNING  [default > dependency] Missing collections requirements file: collections.yml
2026-08-18 08:52:58.177383 | mon1 | WARNING  [default > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-18 08:52:58.184581 | mon1 | INFO     [default > cleanup] Executing
2026-08-18 08:52:58.184954 | mon1 | WARNING  [default > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-18 08:52:58.191059 | mon1 | INFO     [default > destroy] Executing
2026-08-18 08:52:58.191095 | mon1 | WARNING  [default > destroy] Skipping, '--destroy=never' requested.
2026-08-18 08:52:58.191171 | mon1 | INFO     [default > destroy] Executed: Successful
2026-08-18 08:52:58.196560 | mon1 | INFO     [default > syntax] Executing
2026-08-18 08:52:59.301389 | mon1 |
2026-08-18 08:52:59.301635 | mon1 | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/converge.yml
2026-08-18 08:52:59.360698 | mon1 | INFO     [default > syntax] Executed: Successful
2026-08-18 08:52:59.371187 | mon1 | INFO     [default > create] Executing
2026-08-18 08:52:59.373031 | mon1 | WARNING  [default > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-18 08:52:59.380335 | mon1 | INFO     [default > prepare] Executing
2026-08-18 08:53:00.067032 | mon1 |
2026-08-18 08:53:00.067118 | mon1 | PLAY [Prepare] *****************************************************************
2026-08-18 08:53:00.067202 | mon1 |
2026-08-18 08:53:00.067303 | mon1 | TASK [Gathering Facts] *********************************************************
2026-08-18 08:53:00.067422 | mon1 | Tuesday 18 August 2026  08:53:00 +0000 (0:00:00.031)       0:00:00.031 ********
2026-08-18 08:53:01.184640 | mon1 | [WARNING]: Platform linux on host mon1 is using the discovered Python
2026-08-18 08:53:01.184748 | mon1 | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-18 08:53:01.184759 | mon1 | interpreter could change the meaning of that path. See
2026-08-18 08:53:01.184908 | mon1 | https://docs.ansible.com/ansible-
2026-08-18 08:53:01.185044 | mon1 | core/2.18/reference_appendices/interpreter_discovery.html for more information.
2026-08-18 08:53:01.248667 | mon1 | [WARNING]: Platform linux on host osd1 is using the discovered Python
2026-08-18 08:53:01.248773 | mon1 | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-18 08:53:01.248950 | mon1 | interpreter could change the meaning of that path. See
2026-08-18 08:53:01.249154 | mon1 | https://docs.ansible.com/ansible-
2026-08-18 08:53:01.249356 | mon1 | core/2.18/reference_appendices/interpreter_discovery.html for more information.
2026-08-18 08:53:01.255000 | mon1 | ok: [mon1]
2026-08-18 08:53:01.255225 | mon1 | ok: [osd1]
2026-08-18 08:53:01.255410 | mon1 |
2026-08-18 08:53:01.255615 | mon1 | TASK [Configure short hostname] ************************************************
2026-08-18 08:53:01.255860 | mon1 | Tuesday 18 August 2026  08:53:01 +0000 (0:00:01.188)       0:00:01.219 ********
2026-08-18 08:53:01.939422 | mon1 | changed: [mon1]
2026-08-18 08:53:01.939604 | mon1 | changed: [osd1]
2026-08-18 08:53:01.939775 | mon1 |
2026-08-18 08:53:01.939982 | mon1 | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-18 08:53:01.940195 | mon1 | Tuesday 18 August 2026  08:53:01 +0000 (0:00:00.683)       0:00:01.903 ********
2026-08-18 08:53:02.207121 | mon1 | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-18 08:53:02.207337 | mon1 | with a mode of 0700, this may cause issues when running as another user. To
2026-08-18 08:53:02.207588 | mon1 | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-18 08:53:02.222409 | mon1 | changed: [mon1]
2026-08-18 08:53:02.222642 | mon1 | changed: [osd1]
2026-08-18 08:53:02.222867 | mon1 |
2026-08-18 08:53:02.223067 | mon1 | TASK [Update apt cache] ********************************************************
2026-08-18 08:53:02.223268 | mon1 | Tuesday 18 August 2026  08:53:02 +0000 (0:00:00.283)       0:00:02.186 ********
2026-08-18 08:53:09.459459 | mon1 | changed: [mon1]
2026-08-18 08:53:09.459602 | mon1 | changed: [osd1]
2026-08-18 08:53:09.459623 | mon1 |
2026-08-18 08:53:09.459664 | mon1 | PLAY [Create devices for Ceph] *************************************************
2026-08-18 08:53:09.459684 | mon1 |
2026-08-18 08:53:09.459808 | mon1 | TASK [Gathering Facts] *********************************************************
2026-08-18 08:53:09.459891 | mon1 | Tuesday 18 August 2026  08:53:09 +0000 (0:00:07.237)       0:00:09.424 ********
2026-08-18 08:53:10.150715 | mon1 | ok: [osd1]
2026-08-18 08:53:10.151457 | mon1 |
2026-08-18 08:53:10.151479 | mon1 | TASK [Install depedencies] *****************************************************
2026-08-18 08:53:10.151491 | mon1 | Tuesday 18 August 2026  08:53:10 +0000 (0:00:00.690)       0:00:10.115 ********
2026-08-18 08:53:34.784111 | mon1 | changed: [osd1]
2026-08-18 08:53:34.784186 | mon1 |
2026-08-18 08:53:34.784196 | mon1 | TASK [Start up service] ********************************************************
2026-08-18 08:53:34.784205 | mon1 | Tuesday 18 August 2026  08:53:34 +0000 (0:00:24.632)       0:00:34.747 ********
2026-08-18 08:53:35.321989 | mon1 | ok: [osd1]
2026-08-18 08:53:35.322152 | mon1 |
2026-08-18 08:53:35.322370 | mon1 | TASK [Generate lvm.conf] *******************************************************
2026-08-18 08:53:35.322577 | mon1 | Tuesday 18 August 2026  08:53:35 +0000 (0:00:00.538)       0:00:35.286 ********
2026-08-18 08:53:35.668355 | mon1 | ok: [osd1]
2026-08-18 08:53:35.668611 | mon1 |
2026-08-18 08:53:35.668992 | mon1 | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-18 08:53:35.669364 | mon1 | Tuesday 18 August 2026  08:53:35 +0000 (0:00:00.346)       0:00:35.633 ********
2026-08-18 08:53:36.339692 | mon1 | changed: [osd1]
2026-08-18 08:53:36.339779 | mon1 |
2026-08-18 08:53:36.339917 | mon1 | TASK [Get list of all loopback devices] ****************************************
2026-08-18 08:53:36.340051 | mon1 | Tuesday 18 August 2026  08:53:36 +0000 (0:00:00.671)       0:00:36.304 ********
2026-08-18 08:53:36.551006 | mon1 | ok: [osd1]
2026-08-18 08:53:36.551180 | mon1 |
2026-08-18 08:53:36.551422 | mon1 | TASK [Fail if there is any existing loopback devices] **************************
2026-08-18 08:53:36.551732 | mon1 | Tuesday 18 August 2026  08:53:36 +0000 (0:00:00.211)       0:00:36.515 ********
2026-08-18 08:53:36.569637 | mon1 | skipping: [osd1]
2026-08-18 08:53:36.569851 | mon1 |
2026-08-18 08:53:36.570055 | mon1 | TASK [Create devices for Ceph] *************************************************
2026-08-18 08:53:36.570284 | mon1 | Tuesday 18 August 2026  08:53:36 +0000 (0:00:00.018)       0:00:36.534 ********
2026-08-18 08:53:37.119649 | mon1 | changed: [osd1] => (item=osd0)
2026-08-18 08:53:37.119823 | mon1 | changed: [osd1] => (item=osd1)
2026-08-18 08:53:37.120033 | mon1 | changed: [osd1] => (item=osd2)
2026-08-18 08:53:37.120224 | mon1 |
2026-08-18 08:53:37.120434 | mon1 | TASK [Set permissions on loopback devices] *************************************
2026-08-18 08:53:37.120674 | mon1 | Tuesday 18 August 2026  08:53:37 +0000 (0:00:00.549)       0:00:37.083 ********
2026-08-18 08:53:37.743830 | mon1 | changed: [osd1] => (item=osd0)
2026-08-18 08:53:37.744026 | mon1 | changed: [osd1] => (item=osd1)
2026-08-18 08:53:37.744264 | mon1 | changed: [osd1] => (item=osd2)
2026-08-18 08:53:37.744476 | mon1 |
2026-08-18 08:53:37.744717 | mon1 | TASK [Start loop devices] ******************************************************
2026-08-18 08:53:37.744948 | mon1 | Tuesday 18 August 2026  08:53:37 +0000 (0:00:00.624)       0:00:37.707 ********
2026-08-18 08:53:38.451562 | mon1 | changed: [osd1] => (item=osd0)
2026-08-18 08:53:38.451820 | mon1 | changed: [osd1] => (item=osd1)
2026-08-18 08:53:38.452062 | mon1 | changed: [osd1] => (item=osd2)
2026-08-18 08:53:38.452265 | mon1 |
2026-08-18 08:53:38.452503 | mon1 | TASK [Create a volume group for each loop device] ******************************
2026-08-18 08:53:38.452724 | mon1 | Tuesday 18 August 2026  08:53:38 +0000 (0:00:00.707)       0:00:38.415 ********
2026-08-18 08:53:41.614469 | mon1 | changed: [osd1] => (item=osd0)
2026-08-18 08:53:41.614673 | mon1 | changed: [osd1] => (item=osd1)
2026-08-18 08:53:41.614953 | mon1 | changed: [osd1] => (item=osd2)
2026-08-18 08:53:41.615121 | mon1 |
2026-08-18 08:53:41.615337 | mon1 | TASK [Create a logical volume for each loop device] ****************************
2026-08-18 08:53:41.615549 | mon1 | Tuesday 18 August 2026  08:53:41 +0000 (0:00:03.163)       0:00:41.579 ********
2026-08-18 08:53:43.459188 | mon1 | changed: [osd1] => (item=ceph-osd1-osd0)
2026-08-18 08:53:43.459414 | mon1 | changed: [osd1] => (item=ceph-osd1-osd1)
2026-08-18 08:53:43.459648 | mon1 | changed: [osd1] => (item=ceph-osd1-osd2)
2026-08-18 08:53:43.459860 | mon1 |
2026-08-18 08:53:43.460084 | mon1 | PLAY RECAP *********************************************************************
2026-08-18 08:53:43.460334 | mon1 | mon1                       : ok=4    changed=3    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-08-18 08:53:43.460574 | mon1 | osd1                       : ok=15   changed=10   unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-18 08:53:43.460776 | mon1 |
2026-08-18 08:53:43.460978 | mon1 |
2026-08-18 08:53:43.461190 | mon1 | TASKS RECAP ********************************************************************
2026-08-18 08:53:43.461412 | mon1 | Tuesday 18 August 2026  08:53:43 +0000 (0:00:01.844)       0:00:43.423 ********
2026-08-18 08:53:43.461616 | mon1 | ===============================================================================
2026-08-18 08:53:43.461830 | mon1 | Install depedencies ---------------------------------------------------- 24.63s
2026-08-18 08:53:43.462048 | mon1 | Update apt cache -------------------------------------------------------- 7.24s
2026-08-18 08:53:43.462262 | mon1 | Create a volume group for each loop device ------------------------------ 3.16s
2026-08-18 08:53:43.462479 | mon1 | Create a logical volume for each loop device ---------------------------- 1.84s
2026-08-18 08:53:43.462729 | mon1 | Gathering Facts --------------------------------------------------------- 1.19s
2026-08-18 08:53:43.462993 | mon1 | Start loop devices ------------------------------------------------------ 0.71s
2026-08-18 08:53:43.463196 | mon1 | Gathering Facts --------------------------------------------------------- 0.69s
2026-08-18 08:53:43.463395 | mon1 | Configure short hostname ------------------------------------------------ 0.68s
2026-08-18 08:53:43.463592 | mon1 | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.67s
2026-08-18 08:53:43.463789 | mon1 | Set permissions on loopback devices ------------------------------------- 0.62s
2026-08-18 08:53:43.463974 | mon1 | Create devices for Ceph ------------------------------------------------- 0.55s
2026-08-18 08:53:43.464164 | mon1 | Start up service -------------------------------------------------------- 0.54s
2026-08-18 08:53:43.464358 | mon1 | Generate lvm.conf ------------------------------------------------------- 0.35s
2026-08-18 08:53:43.464553 | mon1 | Ensure hostname inside hosts file --------------------------------------- 0.28s
2026-08-18 08:53:43.464756 | mon1 | Get list of all loopback devices ---------------------------------------- 0.21s
2026-08-18 08:53:43.464957 | mon1 | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-08-18 08:53:43.520727 | mon1 | INFO     [default > prepare] Executed: Successful
2026-08-18 08:53:43.529397 | mon1 | INFO     [default > converge] Executing
2026-08-18 08:53:44.581358 | mon1 |
2026-08-18 08:53:44.581560 | mon1 | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-18 08:53:44.581757 | mon1 |
2026-08-18 08:53:44.581965 | mon1 | TASK [Gathering Facts] *********************************************************
2026-08-18 08:53:44.582248 | mon1 | Tuesday 18 August 2026  08:53:44 +0000 (0:00:00.052)       0:00:00.052 ********
2026-08-18 08:53:45.513593 | mon1 | [WARNING]: Platform linux on host mon1 is using the discovered Python
2026-08-18 08:53:45.513808 | mon1 | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-18 08:53:45.514020 | mon1 | interpreter could change the meaning of that path. See
2026-08-18 08:53:45.514231 | mon1 | https://docs.ansible.com/ansible-
2026-08-18 08:53:45.514442 | mon1 | core/2.18/reference_appendices/interpreter_discovery.html for more information.
2026-08-18 08:53:45.536970 | mon1 | ok: [mon1]
2026-08-18 08:53:45.537160 | mon1 |
2026-08-18 08:53:45.537383 | mon1 | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-18 08:53:45.537599 | mon1 | Tuesday 18 August 2026  08:53:45 +0000 (0:00:00.955)       0:00:01.008 ********
2026-08-18 08:53:45.851734 | mon1 | ok: [mon1]
2026-08-18 08:53:45.851938 | mon1 |
2026-08-18 08:53:45.852176 | mon1 | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-18 08:53:45.852373 | mon1 | Tuesday 18 August 2026  08:53:45 +0000 (0:00:00.314)       0:00:01.322 ********
2026-08-18 08:53:45.884770 | mon1 | skipping: [mon1]
2026-08-18 08:53:45.884841 | mon1 |
2026-08-18 08:53:45.884904 | mon1 | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-18 08:53:45.884987 | mon1 | Tuesday 18 August 2026  08:53:45 +0000 (0:00:00.033)       0:00:01.356 ********
2026-08-18 08:53:46.215485 | mon1 | changed: [mon1]
2026-08-18 08:53:46.215738 | mon1 |
2026-08-18 08:53:46.216004 | mon1 | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-18 08:53:46.216225 | mon1 | Tuesday 18 August 2026  08:53:46 +0000 (0:00:00.330)       0:00:01.686 ********
2026-08-18 08:53:46.353864 | mon1 | ok: [mon1] => {
2026-08-18 08:53:46.354120 | mon1 |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-18 08:53:46.354330 | mon1 | }
2026-08-18 08:53:46.354516 | mon1 |
2026-08-18 08:53:46.354726 | mon1 | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-18 08:53:46.354956 | mon1 | Tuesday 18 August 2026  08:53:46 +0000 (0:00:00.138)       0:00:01.824 ********
2026-08-18 08:53:47.043708 | mon1 | changed: [mon1]
2026-08-18 08:53:47.043880 | mon1 |
2026-08-18 08:53:47.044105 | mon1 | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-18 08:53:47.044318 | mon1 | Tuesday 18 August 2026  08:53:47 +0000 (0:00:00.689)       0:00:02.514 ********
2026-08-18 08:53:47.087406 | mon1 | skipping: [mon1]
2026-08-18 08:53:47.087598 | mon1 |
2026-08-18 08:53:47.087832 | mon1 | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-18 08:53:47.088039 | mon1 | Tuesday 18 August 2026  08:53:47 +0000 (0:00:00.043)       0:00:02.558 ********
2026-08-18 08:53:47.128707 | mon1 | skipping: [mon1]
2026-08-18 08:53:47.128824 | mon1 |
2026-08-18 08:53:47.129033 | mon1 | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-18 08:53:47.129237 | mon1 | Tuesday 18 August 2026  08:53:47 +0000 (0:00:00.041)       0:00:02.600 ********
2026-08-18 08:53:47.345214 | mon1 | ok: [mon1]
2026-08-18 08:53:47.345383 | mon1 |
2026-08-18 08:53:47.345617 | mon1 | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-18 08:53:47.345872 | mon1 | Tuesday 18 August 2026  08:53:47 +0000 (0:00:00.216)       0:00:02.816 ********
2026-08-18 08:53:48.421267 | mon1 | ok: [mon1]
2026-08-18 08:53:48.421478 | mon1 |
2026-08-18 08:53:48.421708 | mon1 | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-18 08:53:48.421937 | mon1 | Tuesday 18 August 2026  08:53:48 +0000 (0:00:01.075)       0:00:03.892 ********
2026-08-18 08:53:48.488292 | mon1 | ok: [mon1] => {
2026-08-18 08:53:48.488507 | mon1 |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-18 08:53:48.488713 | mon1 | }
2026-08-18 08:53:48.488911 | mon1 |
2026-08-18 08:53:48.489274 | mon1 | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-18 08:53:48.489483 | mon1 | Tuesday 18 August 2026  08:53:48 +0000 (0:00:00.067)       0:00:03.959 ********
2026-08-18 08:53:49.126128 | mon1 | changed: [mon1]
2026-08-18 08:53:49.126319 | mon1 |
2026-08-18 08:53:49.126545 | mon1 | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-18 08:53:49.126765 | mon1 | Tuesday 18 August 2026  08:53:49 +0000 (0:00:00.637)       0:00:04.597 ********
2026-08-18 08:53:51.909071 | mon1 | changed: [mon1]
2026-08-18 08:53:51.909135 | mon1 |
2026-08-18 08:53:51.909146 | mon1 | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-18 08:53:51.909156 | mon1 | Tuesday 18 August 2026  08:53:51 +0000 (0:00:02.782)       0:00:07.379 ********
2026-08-18 08:53:51.934459 | mon1 | skipping: [mon1]
2026-08-18 08:53:51.934523 | mon1 |
2026-08-18 08:53:51.934739 | mon1 | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-18 08:53:51.934781 | mon1 | Tuesday 18 August 2026  08:53:51 +0000 (0:00:00.026)       0:00:07.405 ********
2026-08-18 08:53:51.960884 | mon1 | skipping: [mon1]
2026-08-18 08:53:51.961326 | mon1 |
2026-08-18 08:53:51.961353 | mon1 | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-18 08:53:51.961359 | mon1 | Tuesday 18 August 2026  08:53:51 +0000 (0:00:00.026)       0:00:07.432 ********
2026-08-18 08:53:51.991066 | mon1 | skipping: [mon1]
2026-08-18 08:53:51.991140 | mon1 |
2026-08-18 08:53:51.991386 | mon1 | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-18 08:53:51.991433 | mon1 | Tuesday 18 August 2026  08:53:51 +0000 (0:00:00.030)       0:00:07.462 ********
2026-08-18 08:53:57.574401 | mon1 | changed: [mon1]
2026-08-18 08:53:57.574454 | mon1 |
2026-08-18 08:53:57.574691 | mon1 | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-18 08:53:57.574728 | mon1 | Tuesday 18 August 2026  08:53:57 +0000 (0:00:05.583)       0:00:13.045 ********
2026-08-18 08:53:58.088970 | mon1 | changed: [mon1]
2026-08-18 08:53:58.089057 | mon1 |
2026-08-18 08:53:58.089266 | mon1 | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-18 08:53:58.089380 | mon1 | Tuesday 18 August 2026  08:53:58 +0000 (0:00:00.514)       0:00:13.560 ********
2026-08-18 08:53:58.942157 | mon1 | changed: [mon1] => (item={'path': '/etc/containerd'})
2026-08-18 08:53:58.942222 | mon1 | changed: [mon1] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-18 08:53:58.942322 | mon1 | changed: [mon1] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-18 08:53:58.942956 | mon1 | changed: [mon1] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-18 08:53:58.943027 | mon1 | changed: [mon1] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-18 08:53:58.943039 | mon1 |
2026-08-18 08:53:58.943049 | mon1 | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-18 08:53:58.943066 | mon1 | Tuesday 18 August 2026  08:53:58 +0000 (0:00:00.853)       0:00:14.413 ********
2026-08-18 08:53:59.483968 | mon1 | changed: [mon1]
2026-08-18 08:53:59.484020 | mon1 |
2026-08-18 08:53:59.484508 | mon1 | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-18 08:53:59.484524 | mon1 | Tuesday 18 August 2026  08:53:59 +0000 (0:00:00.535)       0:00:14.949 ********
2026-08-18 08:53:59.484529 | mon1 |
2026-08-18 08:53:59.484533 | mon1 | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-18 08:53:59.484537 | mon1 | Tuesday 18 August 2026  08:53:59 +0000 (0:00:00.006)       0:00:14.955 ********
2026-08-18 08:54:00.320367 | mon1 | ok: [mon1]
2026-08-18 08:54:00.320778 | mon1 |
2026-08-18 08:54:00.320818 | mon1 | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-18 08:54:00.320824 | mon1 | Tuesday 18 August 2026  08:54:00 +0000 (0:00:00.836)       0:00:15.791 ********
2026-08-18 08:54:00.755084 | mon1 | changed: [mon1]
2026-08-18 08:54:00.755193 | mon1 |
2026-08-18 08:54:00.755209 | mon1 | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-18 08:54:00.755347 | mon1 | Tuesday 18 August 2026  08:54:00 +0000 (0:00:00.434)       0:00:16.226 ********
2026-08-18 08:54:01.247895 | mon1 | changed: [mon1]
2026-08-18 08:54:01.247959 | mon1 |
2026-08-18 08:54:01.248048 | mon1 | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-18 08:54:01.248208 | mon1 | Tuesday 18 August 2026  08:54:01 +0000 (0:00:00.492)       0:00:16.719 ********
2026-08-18 08:54:01.437318 | mon1 | ok: [mon1]
2026-08-18 08:54:01.437361 | mon1 |
2026-08-18 08:54:01.437367 | mon1 | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-18 08:54:01.437371 | mon1 | Tuesday 18 August 2026  08:54:01 +0000 (0:00:00.189)       0:00:16.908 ********
2026-08-18 08:54:01.501826 | mon1 | ok: [mon1] => {
2026-08-18 08:54:01.501871 | mon1 |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-18 08:54:01.501877 | mon1 | }
2026-08-18 08:54:01.501881 | mon1 |
2026-08-18 08:54:01.501886 | mon1 | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-18 08:54:01.501890 | mon1 | Tuesday 18 August 2026  08:54:01 +0000 (0:00:00.064)       0:00:16.972 ********
2026-08-18 08:54:02.279814 | mon1 | changed: [mon1]
2026-08-18 08:54:02.279910 | mon1 |
2026-08-18 08:54:02.280244 | mon1 | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-18 08:54:02.280293 | mon1 | Tuesday 18 August 2026  08:54:02 +0000 (0:00:00.778)       0:00:17.751 ********
2026-08-18 08:54:06.545447 | mon1 | changed: [mon1]
2026-08-18 08:54:06.545504 | mon1 |
2026-08-18 08:54:06.545596 | mon1 | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-18 08:54:06.545739 | mon1 | Tuesday 18 August 2026  08:54:06 +0000 (0:00:04.265)       0:00:22.016 ********
2026-08-18 08:54:07.543468 | mon1 | ok: [mon1]
2026-08-18 08:54:07.543548 | mon1 |
2026-08-18 08:54:07.543610 | mon1 | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-18 08:54:07.543740 | mon1 | Tuesday 18 August 2026  08:54:07 +0000 (0:00:00.997)       0:00:23.014 ********
2026-08-18 08:54:08.512313 | mon1 | changed: [mon1]
2026-08-18 08:54:08.512389 | mon1 |
2026-08-18 08:54:08.512473 | mon1 | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-18 08:54:08.512607 | mon1 | Tuesday 18 August 2026  08:54:08 +0000 (0:00:00.968)       0:00:23.983 ********
2026-08-18 08:54:08.941596 | mon1 | changed: [mon1]
2026-08-18 08:54:08.941663 | mon1 |
2026-08-18 08:54:08.941880 | mon1 | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-18 08:54:08.941926 | mon1 | Tuesday 18 August 2026  08:54:08 +0000 (0:00:00.429)       0:00:24.413 ********
2026-08-18 08:54:09.467314 | mon1 | changed: [mon1] => (item={'path': '/etc/docker'})
2026-08-18 08:54:09.467392 | mon1 | changed: [mon1] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-18 08:54:09.467906 | mon1 | changed: [mon1] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-18 08:54:09.467952 | mon1 |
2026-08-18 08:54:09.467959 | mon1 | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-18 08:54:09.467965 | mon1 | Tuesday 18 August 2026  08:54:09 +0000 (0:00:00.525)       0:00:24.938 ********
2026-08-18 08:54:09.899150 | mon1 | changed: [mon1]
2026-08-18 08:54:09.899214 | mon1 |
2026-08-18 08:54:09.899350 | mon1 | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-18 08:54:09.899393 | mon1 | Tuesday 18 August 2026  08:54:09 +0000 (0:00:00.431)       0:00:25.370 ********
2026-08-18 08:54:10.325029 | mon1 | changed: [mon1]
2026-08-18 08:54:10.325088 | mon1 |
2026-08-18 08:54:10.325183 | mon1 | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-18 08:54:10.325554 | mon1 | Tuesday 18 August 2026  08:54:10 +0000 (0:00:00.418)       0:00:25.789 ********
2026-08-18 08:54:10.325570 | mon1 |
2026-08-18 08:54:10.325575 | mon1 | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-18 08:54:10.325587 | mon1 | Tuesday 18 August 2026  08:54:10 +0000 (0:00:00.007)       0:00:25.796 ********
2026-08-18 08:54:10.961102 | mon1 | ok: [mon1]
2026-08-18 08:54:10.961144 | mon1 |
2026-08-18 08:54:10.961150 | mon1 | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-18 08:54:10.961155 | mon1 | Tuesday 18 August 2026  08:54:10 +0000 (0:00:00.634)       0:00:26.431 ********
2026-08-18 08:54:11.955985 | mon1 | changed: [mon1]
2026-08-18 08:54:11.956053 | mon1 |
2026-08-18 08:54:11.956136 | mon1 | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-18 08:54:11.956265 | mon1 | Tuesday 18 August 2026  08:54:11 +0000 (0:00:00.996)       0:00:27.427 ********
2026-08-18 08:54:12.482503 | mon1 | changed: [mon1]
2026-08-18 08:54:12.482619 | mon1 |
2026-08-18 08:54:12.482685 | mon1 | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-18 08:54:12.482921 | mon1 | Tuesday 18 August 2026  08:54:12 +0000 (0:00:00.526)       0:00:27.953 ********
2026-08-18 08:54:12.510430 | mon1 | ok: [mon1] => {
2026-08-18 08:54:12.510502 | mon1 |     "msg": "https://download.ceph.com/rpm-20.2.3/el9/noarch/cephadm"
2026-08-18 08:54:12.510578 | mon1 | }
2026-08-18 08:54:12.510916 | mon1 |
2026-08-18 08:54:12.510975 | mon1 | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-18 08:54:12.510986 | mon1 | Tuesday 18 August 2026  08:54:12 +0000 (0:00:00.028)       0:00:27.981 ********
2026-08-18 08:54:14.364548 | mon1 | changed: [mon1]
2026-08-18 08:54:14.364613 | mon1 |
2026-08-18 08:54:14.364810 | mon1 | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-18 08:54:14.364963 | mon1 | Tuesday 18 August 2026  08:54:14 +0000 (0:00:01.854)       0:00:29.835 ********
2026-08-18 08:54:14.399056 | mon1 | skipping: [mon1]
2026-08-18 08:54:14.399150 | mon1 |
2026-08-18 08:54:14.399401 | mon1 | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-18 08:54:14.399428 | mon1 | Tuesday 18 August 2026  08:54:14 +0000 (0:00:00.034)       0:00:29.870 ********
2026-08-18 08:54:14.438113 | mon1 | ok: [mon1] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-18 08:54:14.438173 | mon1 |
2026-08-18 08:54:14.438348 | mon1 | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-18 08:54:14.438367 | mon1 | Tuesday 18 August 2026  08:54:14 +0000 (0:00:00.039)       0:00:29.909 ********
2026-08-18 08:54:38.761995 | mon1 | changed: [mon1]
2026-08-18 08:54:38.762107 | mon1 |
2026-08-18 08:54:38.762412 | mon1 | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-18 08:54:38.762464 | mon1 | Tuesday 18 August 2026  08:54:38 +0000 (0:00:24.323)       0:00:54.233 ********
2026-08-18 08:54:39.413368 | mon1 | ok: [mon1] => (item=chronyd)
2026-08-18 08:54:39.413444 | mon1 | ok: [mon1] => (item=sshd)
2026-08-18 08:54:39.413736 | mon1 |
2026-08-18 08:54:39.413782 | mon1 | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-18 08:54:39.413788 | mon1 | Tuesday 18 August 2026  08:54:39 +0000 (0:00:00.651)       0:00:54.884 ********
2026-08-18 08:54:39.609461 | mon1 | ok: [mon1]
2026-08-18 08:54:39.609558 | mon1 |
2026-08-18 08:54:39.609786 | mon1 | TASK [vexxhost.ceph.cephadm : Ensure the cephadm SSH user exists] **************
2026-08-18 08:54:39.609828 | mon1 | Tuesday 18 August 2026  08:54:39 +0000 (0:00:00.195)       0:00:55.080 ********
2026-08-18 08:54:40.063852 | mon1 | changed: [mon1]
2026-08-18 08:54:40.063955 | mon1 |
2026-08-18 08:54:40.064285 | mon1 | TASK [vexxhost.ceph.cephadm : Grant passwordless sudo to the cephadm SSH user] ***
2026-08-18 08:54:40.064337 | mon1 | Tuesday 18 August 2026  08:54:40 +0000 (0:00:00.454)       0:00:55.535 ********
2026-08-18 08:54:40.505012 | mon1 | changed: [mon1]
2026-08-18 08:54:40.505079 | mon1 |
2026-08-18 08:54:40.505396 | mon1 | TASK [vexxhost.ceph.cephadm : Log in to the container registry] ****************
2026-08-18 08:54:40.505445 | mon1 | Tuesday 18 August 2026  08:54:40 +0000 (0:00:00.441)       0:00:55.976 ********
2026-08-18 08:54:40.535933 | mon1 | skipping: [mon1]
2026-08-18 08:54:40.535996 | mon1 |
2026-08-18 08:54:40.536308 | mon1 | TASK [vexxhost.ceph.cephadm : Pre-pull the Ceph image] *************************
2026-08-18 08:54:40.536350 | mon1 | Tuesday 18 August 2026  08:54:40 +0000 (0:00:00.030)       0:00:56.007 ********
2026-08-18 08:55:19.260189 | mon1 | changed: [mon1]
2026-08-18 08:55:19.260266 | mon1 |
2026-08-18 08:55:19.260476 | mon1 | TASK [vexxhost.ceph.cephadm : Pin CEPHADM_IMAGE for interactive login shells] ***
2026-08-18 08:55:19.260515 | mon1 | Tuesday 18 August 2026  08:55:19 +0000 (0:00:38.724)       0:01:34.731 ********
2026-08-18 08:55:19.716186 | mon1 | changed: [mon1]
2026-08-18 08:55:19.716254 | mon1 |
2026-08-18 08:55:19.716483 | mon1 | TASK [vexxhost.ceph.mon : Find this monitor's addresses on the public network] ***
2026-08-18 08:55:19.716524 | mon1 | Tuesday 18 August 2026  08:55:19 +0000 (0:00:00.456)       0:01:35.187 ********
2026-08-18 08:55:19.823347 | mon1 | ok: [mon1]
2026-08-18 08:55:19.823425 | mon1 |
2026-08-18 08:55:19.823505 | mon1 | TASK [vexxhost.ceph.mon : Assert exactly one address matches the public network] ***
2026-08-18 08:55:19.823634 | mon1 | Tuesday 18 August 2026  08:55:19 +0000 (0:00:00.107)       0:01:35.294 ********
2026-08-18 08:55:19.858160 | mon1 | ok: [mon1] => {
2026-08-18 08:55:19.858218 | mon1 |     "changed": false,
2026-08-18 08:55:19.858310 | mon1 |     "msg": "All assertions passed"
2026-08-18 08:55:19.858691 | mon1 | }
2026-08-18 08:55:19.858724 | mon1 |
2026-08-18 08:55:19.858729 | mon1 | TASK [vexxhost.ceph.mon : Set this monitor's Ceph public IP] *******************
2026-08-18 08:55:19.858734 | mon1 | Tuesday 18 August 2026  08:55:19 +0000 (0:00:00.034)       0:01:35.329 ********
2026-08-18 08:55:19.893393 | mon1 | ok: [mon1]
2026-08-18 08:55:19.893469 | mon1 |
2026-08-18 08:55:19.893692 | mon1 | TASK [vexxhost.ceph.mon : Check whether any monitor is already bootstrapped] ***
2026-08-18 08:55:19.893729 | mon1 | Tuesday 18 August 2026  08:55:19 +0000 (0:00:00.034)       0:01:35.364 ********
2026-08-18 08:55:20.089028 | mon1 | ok: [mon1] => (item=mon1)
2026-08-18 08:55:20.089096 | mon1 |
2026-08-18 08:55:20.089196 | mon1 | TASK [vexxhost.ceph.mon : Select the bootstrap node (existing one, else the first monitor)] ***
2026-08-18 08:55:20.089307 | mon1 | Tuesday 18 August 2026  08:55:20 +0000 (0:00:00.195)       0:01:35.560 ********
2026-08-18 08:55:20.130755 | mon1 | ok: [mon1]
2026-08-18 08:55:20.130811 | mon1 |
2026-08-18 08:55:20.131108 | mon1 | TASK [vexxhost.ceph.mon : Bootstrap the cluster] *******************************
2026-08-18 08:55:20.131150 | mon1 | Tuesday 18 August 2026  08:55:20 +0000 (0:00:00.041)       0:01:35.602 ********
2026-08-18 08:55:20.169942 | mon1 | 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:55:20.170189 | mon1 | fatal: [mon1]: 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:55:20.171449 | mon1 |
2026-08-18 08:55:20.171550 | mon1 | PLAY RECAP *********************************************************************
2026-08-18 08:55:20.171658 | mon1 | mon1                       : ok=45   changed=25   unreachable=0    failed=1    skipped=8    rescued=0    ignored=0
2026-08-18 08:55:20.171746 | mon1 |
2026-08-18 08:55:20.171830 | mon1 |
2026-08-18 08:55:20.173867 | mon1 | TASKS RECAP ********************************************************************
2026-08-18 08:55:20.173910 | mon1 | Tuesday 18 August 2026  08:55:20 +0000 (0:00:00.041)       0:01:35.643 ********
2026-08-18 08:55:20.173915 | mon1 | ===============================================================================
2026-08-18 08:55:20.173919 | mon1 | vexxhost.ceph.cephadm : Pre-pull the Ceph image ------------------------ 38.72s
2026-08-18 08:55:20.173923 | mon1 | vexxhost.ceph.cephadm : Install packages ------------------------------- 24.32s
2026-08-18 08:55:20.173927 | mon1 | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.58s
2026-08-18 08:55:20.173931 | mon1 | vexxhost.containers.download_artifact : Extract archive ----------------- 4.27s
2026-08-18 08:55:20.173935 | mon1 | vexxhost.containers.download_artifact : Extract archive ----------------- 2.78s
2026-08-18 08:55:20.173939 | mon1 | vexxhost.containers.download_artifact : Download item ------------------- 1.85s
2026-08-18 08:55:20.173954 | mon1 | vexxhost.containers.containerd : Reload systemd ------------------------- 1.47s
2026-08-18 08:55:20.173958 | mon1 | vexxhost.containers.package : Update state for tar ---------------------- 1.08s
2026-08-18 08:55:20.173962 | mon1 | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.00s
2026-08-18 08:55:20.173966 | mon1 | vexxhost.containers.docker : Restart docker ----------------------------- 1.00s
2026-08-18 08:55:20.173970 | mon1 | vexxhost.containers.docker : Ensure group "docker" exists --------------- 0.97s
2026-08-18 08:55:20.173974 | mon1 | Gathering Facts --------------------------------------------------------- 0.96s
2026-08-18 08:55:20.173978 | mon1 | vexxhost.containers.containerd : Create folders for configuration ------- 0.85s
2026-08-18 08:55:20.173982 | mon1 | vexxhost.containers.download_artifact : Download item ------------------- 0.78s
2026-08-18 08:55:20.173985 | mon1 | vexxhost.containers.download_artifact : Download item ------------------- 0.69s
2026-08-18 08:55:20.173989 | mon1 | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.65s
2026-08-18 08:55:20.173994 | mon1 | vexxhost.containers.download_artifact : Download item ------------------- 0.64s
2026-08-18 08:55:20.173998 | mon1 | vexxhost.containers.containerd : Create containerd config file ---------- 0.54s
2026-08-18 08:55:20.174002 | mon1 | vexxhost.containers.docker : Enable and start service ------------------- 0.53s
2026-08-18 08:55:20.174006 | mon1 | vexxhost.containers.docker : Create folders for configuration ----------- 0.53s
2026-08-18 08:55:20.258920 | mon1 | 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:55:20.258981 | mon1 | ERROR    [default > converge] Executed: Failed
2026-08-18 08:55:20.258998 | mon1 | 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:55:30.582463 | mon1 | ERROR
2026-08-18 08:55:30.582717 | mon1 | {
2026-08-18 08:55:30.582765 | mon1 |   "delta": "0:02:42.004313",
2026-08-18 08:55:30.582799 | mon1 |   "end": "2026-08-18 08:55:20.322790",
2026-08-18 08:55:30.582829 | mon1 |   "msg": "non-zero return code",
2026-08-18 08:55:30.582858 | mon1 |   "rc": 2,
2026-08-18 08:55:30.582887 | mon1 |   "start": "2026-08-18 08:52:38.318477"
2026-08-18 08:55:30.582916 | mon1 | }
failure
2026-08-18 08:55:30.588801 | 
2026-08-18 08:55:30.588857 | PLAY RECAP
2026-08-18 08:55:30.588910 | mon1 | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-18 08:55:30.588982 | 
2026-08-18 08:55:30.739347 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-18 08:55:30.745437 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-18 08:55:31.383583 | 
2026-08-18 08:55:31.383767 | PLAY [all]
2026-08-18 08:55:31.396673 | 
2026-08-18 08:55:31.396783 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-18 08:55:31.450656 | mon1 | ok
2026-08-18 08:55:31.456983 | osd1 | ok
2026-08-18 08:55:31.462437 | 
2026-08-18 08:55:31.462517 | TASK [fetch-output : Set log path for single node]
2026-08-18 08:55:31.485758 | mon1 | skipping: Conditional result was False
2026-08-18 08:55:31.496675 | osd1 | skipping: Conditional result was False
2026-08-18 08:55:31.505756 | 
2026-08-18 08:55:31.505838 | LOOP [fetch-output : Ensure local output dirs]
2026-08-18 08:55:31.877575 | mon1 -> localhost | changed: "/var/lib/zuul/builds/84547f19230746d1808d3224455c000b/work/logs/mon1"
2026-08-18 08:55:31.883483 | osd1 -> localhost | changed: "/var/lib/zuul/builds/84547f19230746d1808d3224455c000b/work/logs/osd1"
2026-08-18 08:55:32.081509 | osd1 -> localhost | changed: "/var/lib/zuul/builds/84547f19230746d1808d3224455c000b/work/artifacts"
2026-08-18 08:55:32.125851 | mon1 -> localhost | ok: "/var/lib/zuul/builds/84547f19230746d1808d3224455c000b/work/artifacts"
2026-08-18 08:55:32.297982 | osd1 -> localhost | changed: "/var/lib/zuul/builds/84547f19230746d1808d3224455c000b/work/docs"
2026-08-18 08:55:32.360031 | mon1 -> localhost | ok: "/var/lib/zuul/builds/84547f19230746d1808d3224455c000b/work/docs"
2026-08-18 08:55:32.360149 | mon1 -> localhost | changed: All items complete
2026-08-18 08:55:32.360209 | 
2026-08-18 08:55:32.376726 | 
2026-08-18 08:55:32.376887 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-18 08:55:33.022995 | mon1 | changed: .d..t...... ./
2026-08-18 08:55:33.056360 | osd1 | changed: .d..t...... ./
2026-08-18 08:55:33.460268 | mon1 | changed: .d..t...... ./
2026-08-18 08:55:33.499810 | osd1 | ok
2026-08-18 08:55:33.912927 | mon1 | changed: .d..t...... ./
2026-08-18 08:55:33.964125 | osd1 | ok
2026-08-18 08:55:33.964271 | osd1 | changed: All items complete
2026-08-18 08:55:33.964314 | 
2026-08-18 08:55:33.992184 | 
2026-08-18 08:55:33.992360 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-18 08:55:34.411502 | mon1 -> localhost | ok: Item: artifacts Runtime: 0:00:00.007447
2026-08-18 08:55:34.644941 | mon1 -> localhost | ok: Item: docs Runtime: 0:00:00.007599
2026-08-18 08:55:34.660647 | 
2026-08-18 08:55:34.660795 | PLAY [all]
2026-08-18 08:55:34.668191 | 
2026-08-18 08:55:34.668257 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-18 08:55:35.095395 | mon1 | changed
2026-08-18 08:55:35.288748 | osd1 | changed
2026-08-18 08:55:35.302023 | 
2026-08-18 08:55:35.302078 | PLAY RECAP
2026-08-18 08:55:35.302128 | mon1 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-18 08:55:35.302159 | osd1 | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-18 08:55:35.302179 | 
2026-08-18 08:55:35.487993 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-18 08:55:35.493235 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-18 08:55:36.087588 | 
2026-08-18 08:55:36.087730 | PLAY [localhost]
2026-08-18 08:55:36.097678 | 
2026-08-18 08:55:36.097752 | TASK [Generate Zuul manifest]
2026-08-18 08:55:36.118119 | localhost | ok
2026-08-18 08:55:36.136363 | 
2026-08-18 08:55:36.136449 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-18 08:55:36.500636 | localhost | changed
2026-08-18 08:55:36.516653 | 
2026-08-18 08:55:36.516941 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-18 08:55:36.658026 | localhost | ok
2026-08-18 08:55:36.696658 | 
2026-08-18 08:55:36.696752 | TASK [Upload logs]
2026-08-18 08:55:36.716708 | localhost | ok
2026-08-18 08:55:36.784613 | 
2026-08-18 08:55:36.784778 | TASK [Set zuul-log-path fact]
2026-08-18 08:55:36.802870 | localhost | ok
2026-08-18 08:55:36.816887 | 
2026-08-18 08:55:36.816991 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-18 08:55:36.847750 | localhost | ok
2026-08-18 08:55:36.854826 | 
2026-08-18 08:55:36.854893 | TASK [upload-logs : Create log directories]
2026-08-18 08:55:37.268936 | localhost | changed
2026-08-18 08:55:37.275293 | 
2026-08-18 08:55:37.275388 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-18 08:55:37.682327 | localhost -> localhost | ok: Runtime: 0:00:00.003623
2026-08-18 08:55:37.691459 | 
2026-08-18 08:55:37.691529 | TASK [upload-logs : Upload logs to log server]
2026-08-18 08:55:38.175405 | localhost | Output suppressed because no_log was given
2026-08-18 08:55:38.179006 | 
2026-08-18 08:55:38.179073 | LOOP [upload-logs : Compress console log and json output]
2026-08-18 08:55:38.257896 | localhost | skipping: Conditional result was False
2026-08-18 08:55:38.265290 | localhost | skipping: Conditional result was False
2026-08-18 08:55:38.279747 | 
2026-08-18 08:55:38.279871 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-18 08:55:38.363110 | localhost | skipping: Conditional result was False
2026-08-18 08:55:38.363515 | 
2026-08-18 08:55:38.367212 | localhost | skipping: Conditional result was False
2026-08-18 08:55:38.414729 | 
2026-08-18 08:55:38.414872 | LOOP [upload-logs : Upload console log and json output]