2026-08-20 06:09:56.493298 | Job console starting
2026-08-20 06:09:56.504742 | Updating git repos
2026-08-20 06:09:58.169445 | Cloning repos into workspace
2026-08-20 06:10:16.156466 | Restoring repo states
2026-08-20 06:10:24.522219 | Merging changes
2026-08-20 06:10:26.424694 | Checking out repos
2026-08-20 06:10:34.050161 | Preparing playbooks
2026-08-20 06:10:42.112522 | Running Ansible setup
2026-08-20 06:10:46.941468 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-20 06:10:47.615306 | 
2026-08-20 06:10:47.615458 | PLAY [localhost]
2026-08-20 06:10:47.623304 | 
2026-08-20 06:10:47.623382 | TASK [Gathering Facts]
2026-08-20 06:10:48.547660 | localhost | ok
2026-08-20 06:10:48.559064 | 
2026-08-20 06:10:48.559191 | TASK [Setup log path fact]
2026-08-20 06:10:48.581814 | localhost | ok
2026-08-20 06:10:48.595817 | 
2026-08-20 06:10:48.596070 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-20 06:10:48.626932 | localhost | ok
2026-08-20 06:10:48.634499 | 
2026-08-20 06:10:48.634649 | TASK [emit-job-header : Print job information]
2026-08-20 06:10:48.681160 | # Job Information
2026-08-20 06:10:48.681466 | Ansible Version: 2.16.18
2026-08-20 06:10:48.681526 | Job: atmosphere-molecule-csi-rbd
2026-08-20 06:10:48.681565 | Pipeline: check
2026-08-20 06:10:48.681601 | Executor: 2d72f0692154
2026-08-20 06:10:48.681632 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4095
2026-08-20 06:10:48.681667 | Event ID: 37985de0-9c5d-11f1-825a-300e83f8e2ab
2026-08-20 06:10:48.686492 | 
2026-08-20 06:10:48.686601 | LOOP [emit-job-header : Print node information]
2026-08-20 06:10:48.790781 | localhost | ok:
2026-08-20 06:10:48.790930 | localhost | # Node Information
2026-08-20 06:10:48.790959 | localhost | Inventory Hostname: instance
2026-08-20 06:10:48.790982 | localhost | Hostname: np0000190221
2026-08-20 06:10:48.791002 | localhost | Username: zuul
2026-08-20 06:10:48.791034 | localhost | Distro: Ubuntu 22.04
2026-08-20 06:10:48.791056 | localhost | Provider: yul1
2026-08-20 06:10:48.791076 | localhost | Region: ca-ymq-1
2026-08-20 06:10:48.791096 | localhost | Label: ubuntu-jammy
2026-08-20 06:10:48.791115 | localhost | Product Name: OpenStack Nova
2026-08-20 06:10:48.791134 | localhost | Interface IP: 199.19.213.3
2026-08-20 06:10:48.803004 | 
2026-08-20 06:10:48.803181 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-20 06:10:49.278528 | localhost -> localhost | changed
2026-08-20 06:10:49.285101 | 
2026-08-20 06:10:49.285243 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-20 06:10:50.491664 | localhost -> localhost | changed
2026-08-20 06:10:50.500426 | 
2026-08-20 06:10:50.500559 | PLAY [all]
2026-08-20 06:10:50.513931 | 
2026-08-20 06:10:50.514057 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-20 06:10:50.879872 | instance -> localhost | ok
2026-08-20 06:10:51.025187 | 
2026-08-20 06:10:51.025422 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-20 06:10:51.064778 | instance | ok
2026-08-20 06:10:51.085735 | instance | included: /var/lib/zuul/builds/e601b9cfdd91490aa654eb09431e68f4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-20 06:10:51.093477 | 
2026-08-20 06:10:51.093560 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-20 06:10:52.883766 | instance -> localhost | Generating public/private rsa key pair.
2026-08-20 06:10:52.884069 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/e601b9cfdd91490aa654eb09431e68f4/work/e601b9cfdd91490aa654eb09431e68f4_id_rsa
2026-08-20 06:10:52.884125 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/e601b9cfdd91490aa654eb09431e68f4/work/e601b9cfdd91490aa654eb09431e68f4_id_rsa.pub
2026-08-20 06:10:52.884153 | instance -> localhost | The key fingerprint is:
2026-08-20 06:10:52.884175 | instance -> localhost | SHA256:/AlxHluWsCG7+TSglGeA3/Lp6nKfLDoZ1lNo7EgUwLI zuul-build-sshkey
2026-08-20 06:10:52.884213 | instance -> localhost | The key's randomart image is:
2026-08-20 06:10:52.884235 | instance -> localhost | +---[RSA 3072]----+
2026-08-20 06:10:52.884261 | instance -> localhost | | ....o. . o      |
2026-08-20 06:10:52.884305 | instance -> localhost | |. . o  o o + .   |
2026-08-20 06:10:52.884350 | instance -> localhost | | o . ooo* + +    |
2026-08-20 06:10:52.884398 | instance -> localhost | |E   ..*=oB =     |
2026-08-20 06:10:52.884427 | instance -> localhost | |   . =.+S.=      |
2026-08-20 06:10:52.884448 | instance -> localhost | |    + + o= o     |
2026-08-20 06:10:52.884468 | instance -> localhost | |   . o o  +      |
2026-08-20 06:10:52.884489 | instance -> localhost | |    + o...       |
2026-08-20 06:10:52.884531 | instance -> localhost | |    .*o++        |
2026-08-20 06:10:52.884557 | instance -> localhost | +----[SHA256]-----+
2026-08-20 06:10:52.884637 | instance -> localhost | ok: Runtime: 0:00:01.309228
2026-08-20 06:10:52.893833 | 
2026-08-20 06:10:52.893919 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-20 06:10:52.927931 | instance | ok
2026-08-20 06:10:52.937431 | instance | included: /var/lib/zuul/builds/e601b9cfdd91490aa654eb09431e68f4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-20 06:10:52.945798 | 
2026-08-20 06:10:52.945916 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-20 06:10:52.973089 | instance | skipping: Conditional result was False
2026-08-20 06:10:52.982886 | 
2026-08-20 06:10:52.983101 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-20 06:10:53.459229 | instance | changed
2026-08-20 06:10:53.467215 | 
2026-08-20 06:10:53.467292 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-20 06:10:53.671860 | instance | ok
2026-08-20 06:10:53.822784 | 
2026-08-20 06:10:53.822938 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-20 06:10:54.336899 | instance | changed
2026-08-20 06:10:54.342153 | 
2026-08-20 06:10:54.342223 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-20 06:10:54.804269 | instance | changed
2026-08-20 06:10:54.811037 | 
2026-08-20 06:10:54.811107 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-20 06:10:54.836078 | instance | skipping: Conditional result was False
2026-08-20 06:10:54.846105 | 
2026-08-20 06:10:54.846199 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-20 06:10:55.255233 | instance -> localhost | changed
2026-08-20 06:10:55.271386 | 
2026-08-20 06:10:55.271488 | TASK [add-build-sshkey : Add back temp key]
2026-08-20 06:10:55.626863 | instance -> localhost | Identity added: /var/lib/zuul/builds/e601b9cfdd91490aa654eb09431e68f4/work/e601b9cfdd91490aa654eb09431e68f4_id_rsa (zuul-build-sshkey)
2026-08-20 06:10:55.627299 | instance -> localhost | ok: Runtime: 0:00:00.009424
2026-08-20 06:10:55.633045 | 
2026-08-20 06:10:55.633113 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-20 06:10:55.950168 | instance | ok
2026-08-20 06:10:55.954912 | 
2026-08-20 06:10:55.954980 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-20 06:10:55.981106 | instance | skipping: Conditional result was False
2026-08-20 06:10:55.997010 | 
2026-08-20 06:10:55.997140 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-20 06:10:56.363461 | instance | ok
2026-08-20 06:10:56.371664 | 
2026-08-20 06:10:56.371747 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-20 06:10:59.619521 | instance | Output suppressed because no_log was given
2026-08-20 06:10:59.630865 | 
2026-08-20 06:10:59.630935 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-20 06:10:59.837283 | instance | ok: "logs"
2026-08-20 06:10:59.837567 | instance | ok: All items complete
2026-08-20 06:10:59.837606 | 
2026-08-20 06:10:59.995674 | instance | ok: "artifacts"
2026-08-20 06:11:00.170253 | instance | ok: "docs"
2026-08-20 06:11:00.181986 | 
2026-08-20 06:11:00.182165 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-20 06:11:00.364193 | instance | changed: "logs"
2026-08-20 06:11:00.520297 | instance | changed: "artifacts"
2026-08-20 06:11:00.670608 | instance | changed: "docs"
2026-08-20 06:11:00.683359 | 
2026-08-20 06:11:00.683508 | PLAY RECAP
2026-08-20 06:11:00.683575 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-20 06:11:00.683615 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-20 06:11:00.683644 | 
2026-08-20 06:11:00.854971 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-20 06:11:00.859450 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-20 06:11:01.475585 | 
2026-08-20 06:11:01.475764 | PLAY [all]
2026-08-20 06:11:01.486547 | 
2026-08-20 06:11:01.486626 | TASK [setup-uv : Extract archive]
2026-08-20 06:11:03.801533 | instance | changed
2026-08-20 06:11:03.809345 | 
2026-08-20 06:11:03.809423 | TASK [setup-uv : Print version]
2026-08-20 06:11:04.181910 | instance | uv 0.8.13
2026-08-20 06:11:04.346249 | instance | ok: Runtime: 0:00:00.009307
2026-08-20 06:11:04.355774 | 
2026-08-20 06:11:04.355849 | TASK [Install Ansible collection siblings]
2026-08-20 06:11:13.780858 | instance | changed:
2026-08-20 06:11:13.781135 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-20 06:11:13.781177 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-20 06:11:13.781210 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-20 06:11:13.781237 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-20 06:11:13.781265 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-20 06:11:13.781296 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-20 06:11:13.781324 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-20 06:11:13.781354 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-20 06:11:13.781382 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-20 06:11:13.781410 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-20 06:11:13.781437 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-20 06:11:13.781462 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-20 06:11:13.781489 | instance | Resolved ansible.netcommon to v8.6.2 for >=1.2.0
2026-08-20 06:11:13.781516 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-20 06:11:13.781544 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0
2026-08-20 06:11:13.781572 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-20 06:11:13.781599 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-20 06:11:13.781626 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-20 06:11:13.781651 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-20 06:11:13.781677 | instance | Resolved openstack.cloud to 1.7.0 for 1.7.0
2026-08-20 06:11:13.781702 | instance | Resolved atmosphere.common to v0.6.0 for >=0.6.0,<0.7.0
2026-08-20 06:11:13.781727 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2
2026-08-20 06:11:13.781754 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-20 06:11:13.781796 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0,>=6.0.0
2026-08-20 06:11:13.781823 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-20 06:11:13.781850 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-20 06:11:13.781875 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-20 06:11:13.781901 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0,>=6.0.0
2026-08-20 06:11:13.781926 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-20 06:11:13.781950 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-20 06:11:13.781975 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-20 06:11:13.782000 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-20 06:11:13.782026 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-20 06:11:13.782056 | instance | Checked out ansible.netcommon to v8.6.2
2026-08-20 06:11:13.782083 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-20 06:11:13.782115 | instance | Starting galaxy collection install process
2026-08-20 06:11:13.782140 | instance | Process install dependency map
2026-08-20 06:11:13.782165 | instance | Starting collection install process
2026-08-20 06:11:13.782190 | instance | Installing 'ansible.netcommon:8.6.2' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-20 06:11:13.782215 | instance | Created collection for ansible.netcommon:8.6.2 at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-20 06:11:13.782242 | instance | ansible.netcommon:8.6.2 was installed successfully
2026-08-20 06:11:13.782303 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-20 06:11:13.782331 | instance | Creating virtual environment at: .venv
2026-08-20 06:11:13.782357 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-20 06:11:13.782383 | instance | Downloading setuptools (1.1MiB)
2026-08-20 06:11:13.782413 | instance | Downloading netaddr (2.2MiB)
2026-08-20 06:11:13.782438 | instance | Downloading kubernetes (1.9MiB)
2026-08-20 06:11:13.782463 | instance | Downloading openstacksdk (1.7MiB)
2026-08-20 06:11:13.782490 | instance | Downloading rjsonnet (1.2MiB)
2026-08-20 06:11:13.782515 | instance | Downloading ansible-core (2.1MiB)
2026-08-20 06:11:13.782540 | instance | Downloading pygments (1.2MiB)
2026-08-20 06:11:13.782627 | instance | Downloading cryptography (4.2MiB)
2026-08-20 06:11:13.782676 | instance |    Building pyperclip==1.9.0
2026-08-20 06:11:13.782741 | instance |  Downloading rjsonnet
2026-08-20 06:11:13.782777 | instance |  Downloading netaddr
2026-08-20 06:11:13.782805 | instance |  Downloading pygments
2026-08-20 06:11:13.782833 | instance |  Downloading cryptography
2026-08-20 06:11:13.782858 | instance |  Downloading setuptools
2026-08-20 06:11:13.782884 | instance |  Downloading kubernetes
2026-08-20 06:11:13.782908 | instance |  Downloading ansible-core
2026-08-20 06:11:13.782933 | instance |  Downloading openstacksdk
2026-08-20 06:11:13.782957 | instance |       Built pyperclip==1.9.0
2026-08-20 06:11:13.782983 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-20 06:11:13.783009 | instance | Installed 79 packages in 47ms
2026-08-20 06:11:13.783034 | instance | Checked out ansible.posix to 1.6.0
2026-08-20 06:11:13.783059 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-20 06:11:13.783085 | instance | Starting galaxy collection install process
2026-08-20 06:11:13.783109 | instance | Process install dependency map
2026-08-20 06:11:13.783134 | instance | Starting collection install process
2026-08-20 06:11:13.783166 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-20 06:11:13.783193 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-20 06:11:13.783219 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-20 06:11:13.783244 | instance | Checked out ansible.utils to v6.1.0
2026-08-20 06:11:13.783270 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-20 06:11:13.783295 | instance | Starting galaxy collection install process
2026-08-20 06:11:13.783319 | instance | Process install dependency map
2026-08-20 06:11:13.783344 | instance | Starting collection install process
2026-08-20 06:11:13.783368 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-20 06:11:13.783393 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-20 06:11:13.783418 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-20 06:11:13.783444 | instance | Checked out atmosphere.common to v0.6.0
2026-08-20 06:11:13.783528 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-20 06:11:13.783559 | instance | Starting galaxy collection install process
2026-08-20 06:11:13.783584 | instance | Process install dependency map
2026-08-20 06:11:13.783609 | instance | Starting collection install process
2026-08-20 06:11:13.783648 | instance | Installing 'atmosphere.common:0.6.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-20 06:11:13.783684 | instance | Created collection for atmosphere.common:0.6.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-20 06:11:13.783710 | instance | atmosphere.common:0.6.0 was installed successfully
2026-08-20 06:11:13.783735 | instance | Checked out community.crypto to 2.2.3
2026-08-20 06:11:13.783760 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-20 06:11:13.783785 | instance | Starting galaxy collection install process
2026-08-20 06:11:13.783809 | instance | Process install dependency map
2026-08-20 06:11:13.783833 | instance | Starting collection install process
2026-08-20 06:11:13.783857 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-20 06:11:13.783881 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-20 06:11:13.783905 | instance | community.crypto:2.2.3 was installed successfully
2026-08-20 06:11:13.783929 | instance | Checked out community.general to 7.3.0
2026-08-20 06:11:13.783953 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-08-20 06:11:13.783977 | instance | Starting galaxy collection install process
2026-08-20 06:11:13.784001 | instance | Process install dependency map
2026-08-20 06:11:13.784025 | instance | Starting collection install process
2026-08-20 06:11:13.784050 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-20 06:11:13.784075 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-20 06:11:13.784101 | instance | community.general:7.3.0 was installed successfully
2026-08-20 06:11:13.784134 | instance | Checked out community.mysql to 3.6.0
2026-08-20 06:11:13.784159 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-20 06:11:13.784184 | instance | Starting galaxy collection install process
2026-08-20 06:11:13.784209 | instance | Process install dependency map
2026-08-20 06:11:13.784235 | instance | Starting collection install process
2026-08-20 06:11:13.784262 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-20 06:11:13.784287 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-20 06:11:13.784311 | instance | community.mysql:3.6.0 was installed successfully
2026-08-20 06:11:13.784336 | instance | Checked out kubernetes.core to 2.4.0
2026-08-20 06:11:13.784360 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-20 06:11:13.784385 | instance | Starting galaxy collection install process
2026-08-20 06:11:13.784409 | instance | Process install dependency map
2026-08-20 06:11:13.784436 | instance | Starting collection install process
2026-08-20 06:11:13.784460 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-20 06:11:13.784485 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-20 06:11:13.784510 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-20 06:11:13.784534 | instance | Checked out openstack.cloud to 1.7.0
2026-08-20 06:11:13.784559 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-20 06:11:13.784584 | instance | Starting galaxy collection install process
2026-08-20 06:11:13.784609 | instance | Process install dependency map
2026-08-20 06:11:13.784633 | instance | Starting collection install process
2026-08-20 06:11:13.784657 | instance | Installing 'openstack.cloud:1.7.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-20 06:11:13.784683 | instance | Created collection for openstack.cloud:1.7.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-20 06:11:13.784707 | instance | openstack.cloud:1.7.0 was installed successfully
2026-08-20 06:11:13.784733 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-20 06:11:13.784759 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-20 06:11:13.784784 | instance | Starting galaxy collection install process
2026-08-20 06:11:13.784809 | instance | Process install dependency map
2026-08-20 06:11:13.784834 | instance | Starting collection install process
2026-08-20 06:11:13.784859 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-20 06:11:13.784884 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-20 06:11:13.784908 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-20 06:11:13.784933 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-20 06:11:13.784983 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-20 06:11:13.785012 | instance | Starting galaxy collection install process
2026-08-20 06:11:13.785043 | instance | Process install dependency map
2026-08-20 06:11:13.785068 | instance | Starting collection install process
2026-08-20 06:11:13.785092 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-20 06:11:13.785116 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-20 06:11:13.785142 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-20 06:11:13.785166 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-20 06:11:13.785191 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-20 06:11:13.785216 | instance | Starting galaxy collection install process
2026-08-20 06:11:13.785243 | instance | Process install dependency map
2026-08-20 06:11:13.785270 | instance | Starting collection install process
2026-08-20 06:11:13.785295 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-20 06:11:13.785319 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-20 06:11:13.785343 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-20 06:11:13.794288 | 
2026-08-20 06:11:13.794365 | PLAY RECAP
2026-08-20 06:11:13.794427 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-20 06:11:13.794457 | 
2026-08-20 06:11:13.951789 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-20 06:11:13.956471 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-20 06:11:14.559406 | 
2026-08-20 06:11:14.559546 | PLAY [all]
2026-08-20 06:11:14.570761 | 
2026-08-20 06:11:14.570839 | TASK [Install "jq" for log collection]
2026-08-20 06:11:23.907616 | instance | changed
2026-08-20 06:11:23.909645 | 
2026-08-20 06:11:23.909718 | PLAY RECAP
2026-08-20 06:11:23.909790 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-20 06:11:23.909855 | 
2026-08-20 06:11:24.046018 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-20 06:11:24.048442 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-20 06:11:24.657412 | 
2026-08-20 06:11:25.061694 | PLAY [all]
2026-08-20 06:11:25.079344 | 
2026-08-20 06:11:25.079478 | LOOP [Check inventory directories]
2026-08-20 06:11:25.423311 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-20 06:11:25.575539 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-20 06:11:25.732904 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-20 06:11:25.763941 | 
2026-08-20 06:11:25.764150 | LOOP [Copy inventory file for Zuul]
2026-08-20 06:11:26.619790 | instance | changed:
2026-08-20 06:11:26.620036 | instance | {
2026-08-20 06:11:26.620077 | instance |   "ansible_loop_var": "item",
2026-08-20 06:11:26.620109 | instance |   "changed": false,
2026-08-20 06:11:26.620160 | instance |   "failed": false,
2026-08-20 06:11:26.620193 | instance |   "invocation": {
2026-08-20 06:11:26.620220 | instance |     "module_args": {
2026-08-20 06:11:26.620244 | instance |       "checksum_algorithm": "sha1",
2026-08-20 06:11:26.620270 | instance |       "follow": true,
2026-08-20 06:11:26.620295 | instance |       "get_attributes": true,
2026-08-20 06:11:26.620321 | instance |       "get_checksum": true,
2026-08-20 06:11:26.620346 | instance |       "get_mime": true,
2026-08-20 06:11:26.620371 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-20 06:11:26.620396 | instance |     }
2026-08-20 06:11:26.620437 | instance |   },
2026-08-20 06:11:26.620463 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-20 06:11:26.620488 | instance |   "stat": {
2026-08-20 06:11:26.620514 | instance |     "atime": 1787206266.3652585,
2026-08-20 06:11:26.620545 | instance |     "attr_flags": "e",
2026-08-20 06:11:26.620570 | instance |     "attributes": [
2026-08-20 06:11:26.620596 | instance |       "extents"
2026-08-20 06:11:26.620621 | instance |     ],
2026-08-20 06:11:26.620645 | instance |     "block_size": 4096,
2026-08-20 06:11:26.620670 | instance |     "blocks": 8,
2026-08-20 06:11:26.620695 | instance |     "charset": "unknown",
2026-08-20 06:11:26.620722 | instance |     "ctime": 1787206265.2172482,
2026-08-20 06:11:26.620747 | instance |     "dev": 64513,
2026-08-20 06:11:26.620771 | instance |     "device_type": 0,
2026-08-20 06:11:26.620796 | instance |     "executable": true,
2026-08-20 06:11:26.620821 | instance |     "exists": true,
2026-08-20 06:11:26.620846 | instance |     "gid": 1000,
2026-08-20 06:11:26.620870 | instance |     "gr_name": "zuul",
2026-08-20 06:11:26.620895 | instance |     "inode": 1047466,
2026-08-20 06:11:26.620919 | instance |     "isblk": false,
2026-08-20 06:11:26.620946 | instance |     "ischr": false,
2026-08-20 06:11:26.621026 | instance |     "isdir": true,
2026-08-20 06:11:26.621053 | instance |     "isfifo": false,
2026-08-20 06:11:26.621077 | instance |     "isgid": false,
2026-08-20 06:11:26.621102 | instance |     "islnk": false,
2026-08-20 06:11:26.621126 | instance |     "isreg": false,
2026-08-20 06:11:26.621149 | instance |     "issock": false,
2026-08-20 06:11:26.621173 | instance |     "isuid": false,
2026-08-20 06:11:26.621196 | instance |     "mimetype": "unknown",
2026-08-20 06:11:26.621221 | instance |     "mode": "0755",
2026-08-20 06:11:26.621245 | instance |     "mtime": 1787206265.2172482,
2026-08-20 06:11:26.621269 | instance |     "nlink": 21,
2026-08-20 06:11:26.621292 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-20 06:11:26.621316 | instance |     "pw_name": "zuul",
2026-08-20 06:11:26.621341 | instance |     "readable": true,
2026-08-20 06:11:26.621366 | instance |     "rgrp": true,
2026-08-20 06:11:26.621390 | instance |     "roth": true,
2026-08-20 06:11:26.621415 | instance |     "rusr": true,
2026-08-20 06:11:26.621443 | instance |     "size": 4096,
2026-08-20 06:11:26.621510 | instance |     "uid": 1000,
2026-08-20 06:11:26.621558 | instance |     "version": "2970049017",
2026-08-20 06:11:26.621589 | instance |     "wgrp": false,
2026-08-20 06:11:26.621618 | instance |     "woth": false,
2026-08-20 06:11:26.621645 | instance |     "writeable": true,
2026-08-20 06:11:26.621677 | instance |     "wusr": true,
2026-08-20 06:11:26.621703 | instance |     "xgrp": true,
2026-08-20 06:11:26.621729 | instance |     "xoth": true,
2026-08-20 06:11:26.621754 | instance |     "xusr": true
2026-08-20 06:11:26.621780 | instance |   }
2026-08-20 06:11:26.621807 | instance | }
2026-08-20 06:11:26.621858 | instance | ok: All items complete
2026-08-20 06:11:26.621891 | 
2026-08-20 06:11:26.623719 | instance | skipping: Conditional result was False
2026-08-20 06:11:26.624718 | instance | skipping: Conditional result was False
2026-08-20 06:11:26.636672 | 
2026-08-20 06:11:26.636811 | LOOP [Switch "ansible_host" to private IP]
2026-08-20 06:11:26.983473 | instance | changed: 1 replacements made
2026-08-20 06:11:26.985405 | instance | skipping: Conditional result was False
2026-08-20 06:11:26.987195 | instance | skipping: Conditional result was False
2026-08-20 06:11:27.003804 | 
2026-08-20 06:11:27.004003 | TASK [Run Molecule scenario]
2026-08-20 06:11:27.928274 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-20 06:11:28.320477 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-20 06:11:28.320579 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-20 06:11:39.401677 | instance | INFO     [csi > dependency] Executing
2026-08-20 06:11:39.401864 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-20 06:11:39.402073 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-20 06:11:39.402200 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-20 06:11:39.409607 | instance | INFO     [csi > cleanup] Executing
2026-08-20 06:11:39.410507 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-20 06:11:39.417984 | instance | INFO     [csi > destroy] Executing
2026-08-20 06:11:39.418065 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-20 06:11:39.418140 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-20 06:11:39.425398 | instance | INFO     [csi > syntax] Executing
2026-08-20 06:11:41.050555 | instance |
2026-08-20 06:11:41.050793 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-20 06:11:41.110120 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-20 06:11:41.121954 | instance | INFO     [csi > create] Executing
2026-08-20 06:11:41.124355 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-20 06:11:41.132114 | instance | INFO     [csi > prepare] Executing
2026-08-20 06:11:41.912101 | instance |
2026-08-20 06:11:41.912307 | instance | PLAY [Prepare] *****************************************************************
2026-08-20 06:11:41.912568 | instance |
2026-08-20 06:11:41.912816 | instance | TASK [Gathering Facts] *********************************************************
2026-08-20 06:11:41.913077 | instance | Thursday 20 August 2026  06:11:41 +0000 (0:00:00.025)       0:00:00.025 *******
2026-08-20 06:11:43.055214 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-20 06:11:43.055466 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-20 06:11:43.055782 | instance | interpreter could change the meaning of that path. See
2026-08-20 06:11:43.056072 | instance | https://docs.ansible.com/ansible-
2026-08-20 06:11:43.056368 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-20 06:11:43.064928 | instance | ok: [instance]
2026-08-20 06:11:43.065331 | instance |
2026-08-20 06:11:43.065619 | instance | TASK [Configure short hostname] ************************************************
2026-08-20 06:11:43.065905 | instance | Thursday 20 August 2026  06:11:43 +0000 (0:00:01.153)       0:00:01.178 *******
2026-08-20 06:11:43.717004 | instance | changed: [instance]
2026-08-20 06:11:43.717320 | instance |
2026-08-20 06:11:43.717597 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-20 06:11:43.717949 | instance | Thursday 20 August 2026  06:11:43 +0000 (0:00:00.651)       0:00:01.830 *******
2026-08-20 06:11:43.961684 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-20 06:11:43.961781 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-20 06:11:43.962325 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-20 06:11:43.969060 | instance | changed: [instance]
2026-08-20 06:11:43.969381 | instance |
2026-08-20 06:11:43.969667 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-20 06:11:43.969996 | instance | Thursday 20 August 2026  06:11:43 +0000 (0:00:00.252)       0:00:02.082 *******
2026-08-20 06:11:44.789874 | instance | ok: [instance]
2026-08-20 06:11:44.790117 | instance |
2026-08-20 06:11:44.790406 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-20 06:11:44.790667 | instance |
2026-08-20 06:11:44.790984 | instance | TASK [Gathering Facts] *********************************************************
2026-08-20 06:11:44.791265 | instance | Thursday 20 August 2026  06:11:44 +0000 (0:00:00.820)       0:00:02.903 *******
2026-08-20 06:11:45.470698 | instance | ok: [instance]
2026-08-20 06:11:45.470933 | instance |
2026-08-20 06:11:45.471215 | instance | TASK [Install depedencies] *****************************************************
2026-08-20 06:11:45.471495 | instance | Thursday 20 August 2026  06:11:45 +0000 (0:00:00.680)       0:00:03.584 *******
2026-08-20 06:12:07.354681 | instance | changed: [instance]
2026-08-20 06:12:07.354906 | instance |
2026-08-20 06:12:07.355179 | instance | TASK [Start up service] ********************************************************
2026-08-20 06:12:07.355474 | instance | Thursday 20 August 2026  06:12:07 +0000 (0:00:21.884)       0:00:25.468 *******
2026-08-20 06:12:07.885602 | instance | ok: [instance]
2026-08-20 06:12:07.885911 | instance |
2026-08-20 06:12:07.886230 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-20 06:12:07.886536 | instance | Thursday 20 August 2026  06:12:07 +0000 (0:00:00.530)       0:00:25.999 *******
2026-08-20 06:12:08.172079 | instance | ok: [instance]
2026-08-20 06:12:08.172303 | instance |
2026-08-20 06:12:08.172568 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-20 06:12:08.172894 | instance | Thursday 20 August 2026  06:12:08 +0000 (0:00:00.286)       0:00:26.285 *******
2026-08-20 06:12:08.827708 | instance | changed: [instance]
2026-08-20 06:12:08.828054 | instance |
2026-08-20 06:12:08.828436 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-20 06:12:08.828820 | instance | Thursday 20 August 2026  06:12:08 +0000 (0:00:00.655)       0:00:26.941 *******
2026-08-20 06:12:09.014148 | instance | ok: [instance]
2026-08-20 06:12:09.014391 | instance |
2026-08-20 06:12:09.014673 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-20 06:12:09.014951 | instance | Thursday 20 August 2026  06:12:09 +0000 (0:00:00.186)       0:00:27.127 *******
2026-08-20 06:12:09.036643 | instance | skipping: [instance]
2026-08-20 06:12:09.036880 | instance |
2026-08-20 06:12:09.037139 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-20 06:12:09.037447 | instance | Thursday 20 August 2026  06:12:09 +0000 (0:00:00.023)       0:00:27.150 *******
2026-08-20 06:12:09.568124 | instance | changed: [instance] => (item=osd0)
2026-08-20 06:12:09.568362 | instance | changed: [instance] => (item=osd1)
2026-08-20 06:12:09.568639 | instance | changed: [instance] => (item=osd2)
2026-08-20 06:12:09.568903 | instance |
2026-08-20 06:12:09.569245 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-20 06:12:09.569527 | instance | Thursday 20 August 2026  06:12:09 +0000 (0:00:00.530)       0:00:27.681 *******
2026-08-20 06:12:10.149048 | instance | changed: [instance] => (item=osd0)
2026-08-20 06:12:10.149294 | instance | changed: [instance] => (item=osd1)
2026-08-20 06:12:10.149309 | instance | changed: [instance] => (item=osd2)
2026-08-20 06:12:10.149320 | instance |
2026-08-20 06:12:10.149330 | instance | TASK [Start loop devices] ******************************************************
2026-08-20 06:12:10.149341 | instance | Thursday 20 August 2026  06:12:10 +0000 (0:00:00.579)       0:00:28.260 *******
2026-08-20 06:12:10.807483 | instance | changed: [instance] => (item=osd0)
2026-08-20 06:12:10.807567 | instance | changed: [instance] => (item=osd1)
2026-08-20 06:12:10.807756 | instance | changed: [instance] => (item=osd2)
2026-08-20 06:12:10.807992 | instance |
2026-08-20 06:12:10.808202 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-20 06:12:10.808412 | instance | Thursday 20 August 2026  06:12:10 +0000 (0:00:00.660)       0:00:28.921 *******
2026-08-20 06:12:14.042354 | instance | changed: [instance] => (item=osd0)
2026-08-20 06:12:14.042532 | instance | changed: [instance] => (item=osd1)
2026-08-20 06:12:14.042795 | instance | changed: [instance] => (item=osd2)
2026-08-20 06:12:14.043008 | instance |
2026-08-20 06:12:14.043229 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-20 06:12:14.043451 | instance | Thursday 20 August 2026  06:12:14 +0000 (0:00:03.234)       0:00:32.155 *******
2026-08-20 06:12:15.841235 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-20 06:12:15.841531 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-20 06:12:15.841581 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-20 06:12:15.841596 | instance |
2026-08-20 06:12:15.841610 | instance | PLAY RECAP *********************************************************************
2026-08-20 06:12:15.841624 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-20 06:12:15.841639 | instance |
2026-08-20 06:12:15.841653 | instance | Thursday 20 August 2026  06:12:15 +0000 (0:00:01.797)       0:00:33.953 *******
2026-08-20 06:12:15.841674 | instance | ===============================================================================
2026-08-20 06:12:15.841688 | instance | Install depedencies ---------------------------------------------------- 21.88s
2026-08-20 06:12:15.844291 | instance | Create a volume group for each loop device ------------------------------ 3.23s
2026-08-20 06:12:15.844312 | instance | Create a logical volume for each loop device ---------------------------- 1.80s
2026-08-20 06:12:15.844319 | instance | Gathering Facts --------------------------------------------------------- 1.15s
2026-08-20 06:12:15.844324 | instance | Purge "snapd" package --------------------------------------------------- 0.82s
2026-08-20 06:12:15.844330 | instance | Gathering Facts --------------------------------------------------------- 0.68s
2026-08-20 06:12:15.844335 | instance | Start loop devices ------------------------------------------------------ 0.66s
2026-08-20 06:12:15.844341 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.66s
2026-08-20 06:12:15.844346 | instance | Configure short hostname ------------------------------------------------ 0.65s
2026-08-20 06:12:15.844352 | instance | Set permissions on loopback devices ------------------------------------- 0.58s
2026-08-20 06:12:15.844357 | instance | Create devices for Ceph ------------------------------------------------- 0.53s
2026-08-20 06:12:15.844362 | instance | Start up service -------------------------------------------------------- 0.53s
2026-08-20 06:12:15.844367 | instance | Generate lvm.conf ------------------------------------------------------- 0.29s
2026-08-20 06:12:15.844373 | instance | Ensure hostname inside hosts file --------------------------------------- 0.25s
2026-08-20 06:12:15.844378 | instance | Get list of all loopback devices ---------------------------------------- 0.19s
2026-08-20 06:12:15.844384 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-08-20 06:12:15.910076 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-20 06:12:15.920459 | instance | INFO     [csi > converge] Executing
2026-08-20 06:12:17.356024 | instance |
2026-08-20 06:12:17.356443 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-20 06:12:17.356766 | instance |
2026-08-20 06:12:17.357100 | instance | TASK [Gathering Facts] *********************************************************
2026-08-20 06:12:17.357465 | instance | Thursday 20 August 2026  06:12:17 +0000 (0:00:00.007)       0:00:00.007 *******
2026-08-20 06:12:18.289253 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-20 06:12:18.289333 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-20 06:12:18.289423 | instance | interpreter could change the meaning of that path. See
2026-08-20 06:12:18.289679 | instance | https://docs.ansible.com/ansible-
2026-08-20 06:12:18.289937 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-20 06:12:18.301092 | instance | ok: [instance]
2026-08-20 06:12:18.301379 | instance |
2026-08-20 06:12:18.301694 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-20 06:12:18.302010 | instance | Thursday 20 August 2026  06:12:18 +0000 (0:00:00.945)       0:00:00.953 *******
2026-08-20 06:12:18.345770 | instance | ok: [instance] => {
2026-08-20 06:12:18.345857 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-20 06:12:18.345970 | instance | }
2026-08-20 06:12:18.346080 | instance |
2026-08-20 06:12:18.346199 | instance | PLAY [all] *********************************************************************
2026-08-20 06:12:18.346301 | instance |
2026-08-20 06:12:18.346435 | instance | TASK [Gathering Facts] *********************************************************
2026-08-20 06:12:18.346539 | instance | Thursday 20 August 2026  06:12:18 +0000 (0:00:00.045)       0:00:00.998 *******
2026-08-20 06:12:19.186186 | instance | ok: [instance]
2026-08-20 06:12:19.186413 | instance |
2026-08-20 06:12:19.186682 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-20 06:12:19.186953 | instance | Thursday 20 August 2026  06:12:19 +0000 (0:00:00.839)       0:00:01.837 *******
2026-08-20 06:12:19.380089 | instance | ok: [instance]
2026-08-20 06:12:19.380158 | instance |
2026-08-20 06:12:19.380333 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-20 06:12:19.380710 | instance |
2026-08-20 06:12:19.380906 | instance | TASK [Gathering Facts] *********************************************************
2026-08-20 06:12:19.381254 | instance | Thursday 20 August 2026  06:12:19 +0000 (0:00:00.193)       0:00:02.031 *******
2026-08-20 06:12:20.256596 | instance | ok: [instance]
2026-08-20 06:12:20.256666 | instance |
2026-08-20 06:12:20.256678 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-20 06:12:20.256697 | instance | Thursday 20 August 2026  06:12:20 +0000 (0:00:00.876)       0:00:02.907 *******
2026-08-20 06:12:20.532726 | instance | ok: [instance]
2026-08-20 06:12:20.532875 | instance |
2026-08-20 06:12:20.532893 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-20 06:12:20.533057 | instance | Thursday 20 August 2026  06:12:20 +0000 (0:00:00.277)       0:00:03.184 *******
2026-08-20 06:12:20.574874 | instance | skipping: [instance]
2026-08-20 06:12:20.574957 | instance |
2026-08-20 06:12:20.575227 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-20 06:12:20.575271 | instance | Thursday 20 August 2026  06:12:20 +0000 (0:00:00.042)       0:00:03.226 *******
2026-08-20 06:12:20.900782 | instance | changed: [instance]
2026-08-20 06:12:20.900853 | instance |
2026-08-20 06:12:20.900858 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-20 06:12:20.900863 | instance | Thursday 20 August 2026  06:12:20 +0000 (0:00:00.325)       0:00:03.552 *******
2026-08-20 06:12:20.963013 | instance | ok: [instance] => {
2026-08-20 06:12:20.963047 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-20 06:12:20.963052 | instance | }
2026-08-20 06:12:20.963056 | instance |
2026-08-20 06:12:20.963061 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-20 06:12:20.963065 | instance | Thursday 20 August 2026  06:12:20 +0000 (0:00:00.061)       0:00:03.614 *******
2026-08-20 06:12:21.676636 | instance | changed: [instance]
2026-08-20 06:12:21.676883 | instance |
2026-08-20 06:12:21.676916 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-20 06:12:21.676963 | instance | Thursday 20 August 2026  06:12:21 +0000 (0:00:00.714)       0:00:04.328 *******
2026-08-20 06:12:21.723540 | instance | skipping: [instance]
2026-08-20 06:12:21.723596 | instance |
2026-08-20 06:12:21.723720 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-20 06:12:21.723841 | instance | Thursday 20 August 2026  06:12:21 +0000 (0:00:00.047)       0:00:04.375 *******
2026-08-20 06:12:21.764822 | instance | skipping: [instance]
2026-08-20 06:12:21.764885 | instance |
2026-08-20 06:12:21.765129 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-20 06:12:21.765144 | instance | Thursday 20 August 2026  06:12:21 +0000 (0:00:00.041)       0:00:04.417 *******
2026-08-20 06:12:21.970744 | instance | ok: [instance]
2026-08-20 06:12:21.970811 | instance |
2026-08-20 06:12:21.971101 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-20 06:12:21.971146 | instance | Thursday 20 August 2026  06:12:21 +0000 (0:00:00.205)       0:00:04.622 *******
2026-08-20 06:12:23.306604 | instance | ok: [instance]
2026-08-20 06:12:23.306644 | instance |
2026-08-20 06:12:23.306650 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-20 06:12:23.306655 | instance | Thursday 20 August 2026  06:12:23 +0000 (0:00:01.335)       0:00:05.958 *******
2026-08-20 06:12:23.372422 | instance | ok: [instance] => {
2026-08-20 06:12:23.372465 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-20 06:12:23.372483 | instance | }
2026-08-20 06:12:23.372487 | instance |
2026-08-20 06:12:23.372491 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-20 06:12:23.372495 | instance | Thursday 20 August 2026  06:12:23 +0000 (0:00:00.065)       0:00:06.024 *******
2026-08-20 06:12:24.095431 | instance | changed: [instance]
2026-08-20 06:12:24.095527 | instance |
2026-08-20 06:12:24.095767 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-20 06:12:24.095782 | instance | Thursday 20 August 2026  06:12:24 +0000 (0:00:00.723)       0:00:06.747 *******
2026-08-20 06:12:26.854276 | instance | changed: [instance]
2026-08-20 06:12:26.854376 | instance |
2026-08-20 06:12:26.854594 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-20 06:12:26.854640 | instance | Thursday 20 August 2026  06:12:26 +0000 (0:00:02.758)       0:00:09.506 *******
2026-08-20 06:12:26.881731 | instance | skipping: [instance]
2026-08-20 06:12:26.881834 | instance |
2026-08-20 06:12:26.882108 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-20 06:12:26.882259 | instance | Thursday 20 August 2026  06:12:26 +0000 (0:00:00.027)       0:00:09.533 *******
2026-08-20 06:12:26.917493 | instance | skipping: [instance]
2026-08-20 06:12:26.918030 | instance |
2026-08-20 06:12:26.918068 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-20 06:12:26.918081 | instance | Thursday 20 August 2026  06:12:26 +0000 (0:00:00.035)       0:00:09.569 *******
2026-08-20 06:12:26.947903 | instance | skipping: [instance]
2026-08-20 06:12:26.948315 | instance |
2026-08-20 06:12:26.948362 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-20 06:12:26.948367 | instance | Thursday 20 August 2026  06:12:26 +0000 (0:00:00.030)       0:00:09.599 *******
2026-08-20 06:12:31.951425 | instance | changed: [instance]
2026-08-20 06:12:31.951605 | instance |
2026-08-20 06:12:31.951656 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-20 06:12:31.951775 | instance | Thursday 20 August 2026  06:12:31 +0000 (0:00:05.003)       0:00:14.603 *******
2026-08-20 06:12:32.524398 | instance | changed: [instance]
2026-08-20 06:12:32.524475 | instance |
2026-08-20 06:12:32.524782 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-20 06:12:32.524819 | instance | Thursday 20 August 2026  06:12:32 +0000 (0:00:00.573)       0:00:15.176 *******
2026-08-20 06:12:33.427525 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-20 06:12:33.427604 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-20 06:12:33.428390 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-20 06:12:33.428436 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-20 06:12:33.428442 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-20 06:12:33.428447 | instance |
2026-08-20 06:12:33.428456 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-20 06:12:33.428461 | instance | Thursday 20 August 2026  06:12:33 +0000 (0:00:00.902)       0:00:16.079 *******
2026-08-20 06:12:33.998197 | instance | changed: [instance]
2026-08-20 06:12:33.999115 | instance |
2026-08-20 06:12:33.999136 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-20 06:12:33.999143 | instance | Thursday 20 August 2026  06:12:33 +0000 (0:00:00.553)       0:00:16.633 *******
2026-08-20 06:12:33.999149 | instance |
2026-08-20 06:12:33.999154 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-20 06:12:33.999160 | instance | Thursday 20 August 2026  06:12:33 +0000 (0:00:00.016)       0:00:16.650 *******
2026-08-20 06:12:34.892260 | instance | ok: [instance]
2026-08-20 06:12:34.892341 | instance |
2026-08-20 06:12:34.892612 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-20 06:12:34.892649 | instance | Thursday 20 August 2026  06:12:34 +0000 (0:00:00.893)       0:00:17.544 *******
2026-08-20 06:12:35.326519 | instance | changed: [instance]
2026-08-20 06:12:35.326625 | instance |
2026-08-20 06:12:35.326906 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-20 06:12:35.326947 | instance | Thursday 20 August 2026  06:12:35 +0000 (0:00:00.434)       0:00:17.978 *******
2026-08-20 06:12:35.860096 | instance | changed: [instance]
2026-08-20 06:12:35.860171 | instance |
2026-08-20 06:12:35.860471 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-20 06:12:35.860513 | instance | Thursday 20 August 2026  06:12:35 +0000 (0:00:00.533)       0:00:18.512 *******
2026-08-20 06:12:36.063402 | instance | ok: [instance]
2026-08-20 06:12:36.063491 | instance |
2026-08-20 06:12:36.063735 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-20 06:12:36.063777 | instance | Thursday 20 August 2026  06:12:36 +0000 (0:00:00.203)       0:00:18.715 *******
2026-08-20 06:12:36.120416 | instance | ok: [instance] => {
2026-08-20 06:12:36.120483 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-20 06:12:36.120958 | instance | }
2026-08-20 06:12:36.120973 | instance |
2026-08-20 06:12:36.120978 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-20 06:12:36.120983 | instance | Thursday 20 August 2026  06:12:36 +0000 (0:00:00.056)       0:00:18.772 *******
2026-08-20 06:12:36.887487 | instance | changed: [instance]
2026-08-20 06:12:36.887576 | instance |
2026-08-20 06:12:36.887818 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-20 06:12:36.887861 | instance | Thursday 20 August 2026  06:12:36 +0000 (0:00:00.766)       0:00:19.539 *******
2026-08-20 06:12:41.198132 | instance | changed: [instance]
2026-08-20 06:12:41.198200 | instance |
2026-08-20 06:12:41.198471 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-20 06:12:41.198488 | instance | Thursday 20 August 2026  06:12:41 +0000 (0:00:04.311)       0:00:23.850 *******
2026-08-20 06:12:42.441957 | instance | ok: [instance]
2026-08-20 06:12:42.442055 | instance |
2026-08-20 06:12:42.442296 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-20 06:12:42.442312 | instance | Thursday 20 August 2026  06:12:42 +0000 (0:00:01.243)       0:00:25.094 *******
2026-08-20 06:12:42.825832 | instance | changed: [instance]
2026-08-20 06:12:42.826176 | instance |
2026-08-20 06:12:42.826192 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-20 06:12:42.826197 | instance | Thursday 20 August 2026  06:12:42 +0000 (0:00:00.383)       0:00:25.478 *******
2026-08-20 06:12:43.269847 | instance | changed: [instance]
2026-08-20 06:12:43.269948 | instance |
2026-08-20 06:12:43.270190 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-20 06:12:43.270229 | instance | Thursday 20 August 2026  06:12:43 +0000 (0:00:00.443)       0:00:25.921 *******
2026-08-20 06:12:43.815962 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-20 06:12:43.816041 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-20 06:12:43.816576 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-20 06:12:43.816618 | instance |
2026-08-20 06:12:43.816623 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-20 06:12:43.816628 | instance | Thursday 20 August 2026  06:12:43 +0000 (0:00:00.546)       0:00:26.468 *******
2026-08-20 06:12:44.256410 | instance | changed: [instance]
2026-08-20 06:12:44.256447 | instance |
2026-08-20 06:12:44.256452 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-20 06:12:44.256457 | instance | Thursday 20 August 2026  06:12:44 +0000 (0:00:00.440)       0:00:26.908 *******
2026-08-20 06:12:44.713277 | instance | changed: [instance]
2026-08-20 06:12:44.713357 | instance |
2026-08-20 06:12:44.713370 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-20 06:12:44.713388 | instance | Thursday 20 August 2026  06:12:44 +0000 (0:00:00.440)       0:00:27.348 *******
2026-08-20 06:12:44.713398 | instance |
2026-08-20 06:12:44.713671 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-20 06:12:44.713711 | instance | Thursday 20 August 2026  06:12:44 +0000 (0:00:00.016)       0:00:27.365 *******
2026-08-20 06:12:45.397823 | instance | ok: [instance]
2026-08-20 06:12:45.397883 | instance |
2026-08-20 06:12:45.397888 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-20 06:12:45.397899 | instance | Thursday 20 August 2026  06:12:45 +0000 (0:00:00.684)       0:00:28.049 *******
2026-08-20 06:12:46.650365 | instance | changed: [instance]
2026-08-20 06:12:46.650460 | instance |
2026-08-20 06:12:46.650717 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-20 06:12:46.650759 | instance | Thursday 20 August 2026  06:12:46 +0000 (0:00:01.253)       0:00:29.302 *******
2026-08-20 06:12:47.184506 | instance | changed: [instance]
2026-08-20 06:12:47.184535 | instance |
2026-08-20 06:12:47.184540 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-20 06:12:47.184545 | instance | Thursday 20 August 2026  06:12:47 +0000 (0:00:00.533)       0:00:29.836 *******
2026-08-20 06:12:47.232783 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-20 06:12:47.232821 | instance |
2026-08-20 06:12:47.232829 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-20 06:12:47.232835 | instance | Thursday 20 August 2026  06:12:47 +0000 (0:00:00.048)       0:00:29.884 *******
2026-08-20 06:12:52.142948 | instance | changed: [instance]
2026-08-20 06:12:52.143064 | instance |
2026-08-20 06:12:52.143077 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-20 06:12:52.143088 | instance | Thursday 20 August 2026  06:12:52 +0000 (0:00:04.909)       0:00:34.794 *******
2026-08-20 06:12:52.811326 | instance | ok: [instance] => (item=chronyd)
2026-08-20 06:12:52.811438 | instance | ok: [instance] => (item=sshd)
2026-08-20 06:12:52.811472 | instance |
2026-08-20 06:12:52.811795 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-20 06:12:52.811843 | instance | Thursday 20 August 2026  06:12:52 +0000 (0:00:00.669)       0:00:35.463 *******
2026-08-20 06:12:56.974446 | instance | changed: [instance]
2026-08-20 06:12:56.974567 | instance |
2026-08-20 06:12:56.974934 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-20 06:12:56.975091 | instance | Thursday 20 August 2026  06:12:56 +0000 (0:00:04.162)       0:00:39.626 *******
2026-08-20 06:12:57.187069 | instance | ok: [instance]
2026-08-20 06:12:57.187139 | instance |
2026-08-20 06:12:57.187413 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-20 06:12:57.187450 | instance | Thursday 20 August 2026  06:12:57 +0000 (0:00:00.213)       0:00:39.839 *******
2026-08-20 06:12:57.619531 | instance | changed: [instance]
2026-08-20 06:12:57.619639 | instance |
2026-08-20 06:12:57.619921 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-20 06:12:57.619962 | instance | Thursday 20 August 2026  06:12:57 +0000 (0:00:00.432)       0:00:40.271 *******
2026-08-20 06:12:57.954831 | instance | changed: [instance]
2026-08-20 06:12:57.954912 | instance |
2026-08-20 06:12:57.955164 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-20 06:12:57.955209 | instance | Thursday 20 August 2026  06:12:57 +0000 (0:00:00.335)       0:00:40.606 *******
2026-08-20 06:12:58.064851 | instance | ok: [instance]
2026-08-20 06:12:58.064930 | instance |
2026-08-20 06:12:58.065158 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-20 06:12:58.065196 | instance | Thursday 20 August 2026  06:12:58 +0000 (0:00:00.109)       0:00:40.716 *******
2026-08-20 06:12:58.283957 | instance | ok: [instance] => (item=instance)
2026-08-20 06:12:58.284043 | instance |
2026-08-20 06:12:58.284306 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-20 06:12:58.284378 | instance | Thursday 20 August 2026  06:12:58 +0000 (0:00:00.218)       0:00:40.935 *******
2026-08-20 06:12:58.337874 | instance | ok: [instance]
2026-08-20 06:12:58.337944 | instance |
2026-08-20 06:12:58.338219 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-20 06:12:58.338243 | instance | Thursday 20 August 2026  06:12:58 +0000 (0:00:00.054)       0:00:40.989 *******
2026-08-20 06:12:58.416714 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-20 06:12:58.417118 | instance |
2026-08-20 06:12:58.417215 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-20 06:12:58.417224 | instance | Thursday 20 August 2026  06:12:58 +0000 (0:00:00.078)       0:00:41.068 *******
2026-08-20 06:12:58.731405 | instance | changed: [instance]
2026-08-20 06:12:58.731656 | instance |
2026-08-20 06:12:58.731668 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-20 06:12:58.731681 | instance | Thursday 20 August 2026  06:12:58 +0000 (0:00:00.314)       0:00:41.383 *******
2026-08-20 06:12:59.438938 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-20 06:12:59.439058 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-20 06:12:59.439071 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-20 06:12:59.439474 | instance |
2026-08-20 06:12:59.439529 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-20 06:12:59.439536 | instance | Thursday 20 August 2026  06:12:59 +0000 (0:00:00.707)       0:00:42.090 *******
2026-08-20 06:14:32.953104 | instance | ok: [instance]
2026-08-20 06:14:32.953218 | instance |
2026-08-20 06:14:32.953349 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-20 06:14:32.953472 | instance | Thursday 20 August 2026  06:14:32 +0000 (0:01:33.514)       0:02:15.605 *******
2026-08-20 06:14:33.166435 | instance | changed: [instance]
2026-08-20 06:14:33.166529 | instance |
2026-08-20 06:14:33.166654 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-20 06:14:33.166796 | instance | Thursday 20 August 2026  06:14:33 +0000 (0:00:00.213)       0:02:15.818 *******
2026-08-20 06:14:33.243378 | instance | ok: [instance]
2026-08-20 06:14:33.243452 | instance |
2026-08-20 06:14:33.243614 | instance | TASK [Install Ceph host] *******************************************************
2026-08-20 06:14:33.243685 | instance | Thursday 20 August 2026  06:14:33 +0000 (0:00:00.077)       0:02:15.895 *******
2026-08-20 06:14:33.322274 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-20 06:14:33.322346 | instance |
2026-08-20 06:14:33.322485 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-20 06:14:33.322609 | instance | Thursday 20 August 2026  06:14:33 +0000 (0:00:00.079)       0:02:15.974 *******
2026-08-20 06:14:35.872092 | instance | ok: [instance]
2026-08-20 06:14:35.872186 | instance |
2026-08-20 06:14:35.872323 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-20 06:14:35.872545 | instance | Thursday 20 August 2026  06:14:35 +0000 (0:00:02.549)       0:02:18.524 *******
2026-08-20 06:14:35.931841 | instance | ok: [instance] => (item=instance)
2026-08-20 06:14:35.931957 | instance |
2026-08-20 06:14:35.932141 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-20 06:14:35.932351 | instance | Thursday 20 August 2026  06:14:35 +0000 (0:00:00.059)       0:02:18.583 *******
2026-08-20 06:14:36.262650 | instance | ok: [instance]
2026-08-20 06:14:36.262749 | instance |
2026-08-20 06:14:36.262878 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-20 06:14:36.263057 | instance | Thursday 20 August 2026  06:14:36 +0000 (0:00:00.331)       0:02:18.914 *******
2026-08-20 06:14:40.142986 | instance | ok: [instance]
2026-08-20 06:14:40.143062 | instance |
2026-08-20 06:14:40.143349 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-20 06:14:40.143383 | instance | Thursday 20 August 2026  06:14:40 +0000 (0:00:03.880)       0:02:22.795 *******
2026-08-20 06:15:28.953259 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster)
2026-08-20 06:15:28.954194 | instance | fatal: [instance]: FAILED! => {"changed": false, "module_stderr": "Traceback (most recent call last):\n  File \"<stdin>\", line 107, in <module>\n  File \"<stdin>\", line 99, in _ansiballz_main\n  File \"<stdin>\", line 47, in invoke_module\n  File \"/usr/lib/python3.10/runpy.py\", line 224, in run_module\n    return _run_module_code(code, init_globals, run_name, mod_spec)\n  File \"/usr/lib/python3.10/runpy.py\", line 96, in _run_module_code\n    _run_code(code, mod_globals, init_globals,\n  File \"/usr/lib/python3.10/runpy.py\", line 86, in _run_code\n    exec(code, run_globals)\n  File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_qsdq2xs6/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 202, in <module>\n  File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_qsdq2xs6/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 198, in main\n  File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_qsdq2xs6/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 177, in run_module\n  File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_qsdq2xs6/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 120, in apply_spec\nRuntimeError: Inferring config /var/lib/ceph/4837cbf8-4f90-4300-b3f6-726c9b9f89b4/mon.instance/config\n2026-08-20T06:15:28.797+0000 7f61ece76640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAcm4Zqn9nXLiAAr0ChQS8EKO23T4lwOdy8ZGq5P3bUGSCRg/rTwRMykx8=: Malformed input [buffer:3]\n2026-08-20T06:15:28.797+0000 7f61ece76640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T06:15:28.797+0000 7f61ece76640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAcm4Zqn9nXLiAAr0ChQS8EKO23T4lwOdy8ZGq5P3bUGSCRg/rTwRMykx8=: Malformed input [buffer:3]\n2026-08-20T06:15:28.797+0000 7f61ece76640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T06:15:28.797+0000 7f61ece76640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAcm4Zqn9nXLiAAr0ChQS8EKO23T4lwOdy8ZGq5P3bUGSCRg/rTwRMykx8=: Malformed input [buffer:3]\n2026-08-20T06:15:28.797+0000 7f61ece76640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T06:15:28.797+0000 7f61ece76640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}
2026-08-20 06:15:28.957277 | instance |
2026-08-20 06:15:28.961251 | instance | PLAY RECAP *********************************************************************
2026-08-20 06:15:28.961312 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-08-20 06:15:28.961324 | instance |
2026-08-20 06:15:28.961334 | instance | Thursday 20 August 2026  06:15:28 +0000 (0:00:48.814)       0:03:11.609 *******
2026-08-20 06:15:28.961343 | instance | ===============================================================================
2026-08-20 06:15:28.961352 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 93.51s
2026-08-20 06:15:28.961360 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 48.81s
2026-08-20 06:15:28.961369 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.00s
2026-08-20 06:15:28.961378 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.91s
2026-08-20 06:15:28.961386 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.31s
2026-08-20 06:15:28.961395 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 4.16s
2026-08-20 06:15:28.961403 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 3.88s
2026-08-20 06:15:28.961412 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.76s
2026-08-20 06:15:28.961437 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 2.55s
2026-08-20 06:15:28.961446 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.58s
2026-08-20 06:15:28.961454 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.34s
2026-08-20 06:15:28.961463 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.25s
2026-08-20 06:15:28.961472 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.24s
2026-08-20 06:15:28.961480 | instance | Gathering Facts --------------------------------------------------------- 0.95s
2026-08-20 06:15:28.961489 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.90s
2026-08-20 06:15:28.961497 | instance | Gathering Facts --------------------------------------------------------- 0.88s
2026-08-20 06:15:28.961506 | instance | Gathering Facts --------------------------------------------------------- 0.84s
2026-08-20 06:15:28.961522 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.77s
2026-08-20 06:15:28.961532 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.72s
2026-08-20 06:15:28.961540 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.71s
2026-08-20 06:15:29.049112 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-20 06:15:29.049293 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-20 06:15:29.049442 | instance | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-20 06:15:29.378122 | instance | ERROR
2026-08-20 06:15:29.378336 | instance | {
2026-08-20 06:15:29.378365 | instance |   "delta": "0:04:01.752582",
2026-08-20 06:15:29.378385 | instance |   "end": "2026-08-20 06:15:29.104999",
2026-08-20 06:15:29.378404 | instance |   "msg": "non-zero return code",
2026-08-20 06:15:29.378421 | instance |   "rc": 2,
2026-08-20 06:15:29.378439 | instance |   "start": "2026-08-20 06:11:27.352417"
2026-08-20 06:15:29.378456 | instance | }
failure
2026-08-20 06:15:29.383463 | 
2026-08-20 06:15:29.383514 | PLAY RECAP
2026-08-20 06:15:29.383561 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-20 06:15:29.383583 | 
2026-08-20 06:15:29.514470 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-20 06:15:29.517289 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-20 06:15:31.057838 | 
2026-08-20 06:15:31.058002 | PLAY [all]
2026-08-20 06:15:31.075331 | 
2026-08-20 06:15:31.075514 | TASK [gather-host-logs : creating directory for system status]
2026-08-20 06:15:31.423778 | instance | changed
2026-08-20 06:15:31.431929 | 
2026-08-20 06:15:31.432013 | TASK [gather-host-logs : Get logs for each host]
2026-08-20 06:15:31.783942 | instance | + systemd-cgls --full --all --no-pager
2026-08-20 06:15:31.795269 | instance | + ip addr
2026-08-20 06:15:31.797971 | instance | + ip route
2026-08-20 06:15:31.800364 | instance | + lsblk
2026-08-20 06:15:31.805629 | instance | + mount
2026-08-20 06:15:31.808092 | instance | + docker images
2026-08-20 06:15:31.826419 | instance | + brctl show
2026-08-20 06:15:31.826807 | instance | /bin/bash: line 8: brctl: command not found
2026-08-20 06:15:31.827051 | instance | + ps aux --sort=-%mem
2026-08-20 06:15:31.839417 | instance | + dpkg -l
2026-08-20 06:15:31.850668 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-20 06:15:31.851214 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-20 06:15:31.868290 | instance | + '[' '!' -z '' ']'
2026-08-20 06:15:31.965995 | instance | ok: Runtime: 0:00:00.089246
2026-08-20 06:15:31.974435 | 
2026-08-20 06:15:31.974526 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-20 06:15:32.617052 | instance | changed:
2026-08-20 06:15:32.617258 | instance | created directory /var/lib/zuul/builds/e601b9cfdd91490aa654eb09431e68f4/work/logs/instance
2026-08-20 06:15:32.617296 | instance | cd+++++++++ system/
2026-08-20 06:15:32.617327 | instance | >f+++++++++ system/brctl-show.txt
2026-08-20 06:15:32.617356 | instance | >f+++++++++ system/docker-images.txt
2026-08-20 06:15:32.617383 | instance | >f+++++++++ system/ip-addr.txt
2026-08-20 06:15:32.617415 | instance | >f+++++++++ system/ip-route.txt
2026-08-20 06:15:32.617444 | instance | >f+++++++++ system/lsblk.txt
2026-08-20 06:15:32.617472 | instance | >f+++++++++ system/mount.txt
2026-08-20 06:15:32.617499 | instance | >f+++++++++ system/packages.txt
2026-08-20 06:15:32.617524 | instance | >f+++++++++ system/ps.txt
2026-08-20 06:15:32.617553 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-20 06:15:32.628405 | 
2026-08-20 06:15:32.628478 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-20 06:15:32.833827 | instance | changed: "values"
2026-08-20 06:15:32.999195 | instance | changed: "releases"
2026-08-20 06:15:33.017838 | 
2026-08-20 06:15:33.017984 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-20 06:15:33.221497 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-20 06:15:33.556026 | instance | ok: Runtime: 0:00:00.005394
2026-08-20 06:15:33.562863 | 
2026-08-20 06:15:33.562956 | TASK [helm-release-status : Downloads logs to executor]
2026-08-20 06:15:34.052565 | instance | changed:
2026-08-20 06:15:34.052798 | instance | cd+++++++++ helm/
2026-08-20 06:15:34.052826 | instance | cd+++++++++ helm/releases/
2026-08-20 06:15:34.052847 | instance | cd+++++++++ helm/values/
2026-08-20 06:15:34.061777 | 
2026-08-20 06:15:34.061843 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-20 06:15:34.268641 | instance | changed
2026-08-20 06:15:34.276162 | 
2026-08-20 06:15:34.276232 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-20 06:15:34.530524 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-20 06:15:34.530852 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-20 06:15:34.536211 | instance | environment: line 1: kubectl: command not found
2026-08-20 06:15:34.537596 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-20 06:15:34.538871 | instance | environment: line 1: kubectl: command not found
2026-08-20 06:15:34.540234 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-20 06:15:34.541328 | instance | environment: line 1: kubectl: command not found
2026-08-20 06:15:34.542601 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-20 06:15:34.542718 | instance | environment: line 1: kubectl: command not found
2026-08-20 06:15:34.543964 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-20 06:15:34.545420 | instance | environment: line 1: kubectl: command not found
2026-08-20 06:15:34.546068 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-20 06:15:34.811247 | instance | ok: Runtime: 0:00:00.023102
2026-08-20 06:15:34.818939 | 
2026-08-20 06:15:34.819042 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-20 06:15:35.024494 | instance | changed
2026-08-20 06:15:35.031432 | 
2026-08-20 06:15:35.031541 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-20 06:15:35.234443 | instance | environment: line 5: kubectl: command not found
2026-08-20 06:15:35.234839 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-20 06:15:35.235306 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-20 06:15:35.235792 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-20 06:15:35.570564 | instance | ok: Runtime: 0:00:00.009379
2026-08-20 06:15:35.579992 | 
2026-08-20 06:15:35.580105 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-20 06:15:36.070171 | instance | changed:
2026-08-20 06:15:36.070534 | instance | cd+++++++++ objects/
2026-08-20 06:15:36.070608 | instance | cd+++++++++ objects/cluster/
2026-08-20 06:15:36.070663 | instance | cd+++++++++ objects/namespaced/
2026-08-20 06:15:36.079444 | 
2026-08-20 06:15:36.079508 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-20 06:15:36.273749 | instance | changed
2026-08-20 06:15:36.280721 | 
2026-08-20 06:15:36.280811 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-20 06:15:36.478425 | instance | changed
2026-08-20 06:15:36.483211 | 
2026-08-20 06:15:36.483281 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-20 06:15:36.683662 | instance | environment: line 3: kubectl: command not found
2026-08-20 06:15:37.018952 | instance | ok: Runtime: 0:00:00.007527
2026-08-20 06:15:37.024863 | 
2026-08-20 06:15:37.024929 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-20 06:15:37.513691 | instance | changed:
2026-08-20 06:15:37.513947 | instance | cd+++++++++ pod-logs/
2026-08-20 06:15:37.513988 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-20 06:15:37.528099 | 
2026-08-20 06:15:37.528172 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-20 06:15:37.713293 | instance | changed
2026-08-20 06:15:37.720167 | 
2026-08-20 06:15:37.720264 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-20 06:15:37.926643 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-20 06:15:38.259168 | instance | ok: Runtime: 0:00:00.037321
2026-08-20 06:15:38.264114 | 
2026-08-20 06:15:38.264178 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-20 06:15:38.470557 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-20 06:15:38.499191 | instance | ceph-mgr endpoints:
2026-08-20 06:15:38.798979 | instance | ok: Runtime: 0:00:00.034591
2026-08-20 06:15:38.806269 | 
2026-08-20 06:15:38.806358 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-20 06:15:39.004472 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-20 06:15:39.342891 | instance | ok: Runtime: 0:00:00.034741
2026-08-20 06:15:39.351561 | 
2026-08-20 06:15:39.351626 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-20 06:15:39.841022 | instance | changed: cd+++++++++ prometheus/
2026-08-20 06:15:39.853260 | 
2026-08-20 06:15:39.853333 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-20 06:15:40.061816 | instance | changed
2026-08-20 06:15:40.068547 | 
2026-08-20 06:15:40.068641 | TASK [gather-selenium-data : Get selenium data]
2026-08-20 06:15:40.313963 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-20 06:15:40.315382 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-20 06:15:40.601786 | instance | ERROR
2026-08-20 06:15:40.602090 | instance | {
2026-08-20 06:15:40.602154 | instance |   "delta": "0:00:00.005801",
2026-08-20 06:15:40.602184 | instance |   "end": "2026-08-20 06:15:40.315698",
2026-08-20 06:15:40.602213 | instance |   "msg": "non-zero return code",
2026-08-20 06:15:40.602239 | instance |   "rc": 1,
2026-08-20 06:15:40.602264 | instance |   "start": "2026-08-20 06:15:40.309897"
2026-08-20 06:15:40.602288 | instance | }
2026-08-20 06:15:40.602321 | instance | ERROR: Ignoring Errors
2026-08-20 06:15:40.608842 | 
2026-08-20 06:15:40.608927 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-20 06:15:42.091588 | instance | changed: cd+++++++++ selenium/
2026-08-20 06:15:42.099156 | 
2026-08-20 06:15:42.099230 | PLAY RECAP
2026-08-20 06:15:42.099295 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-20 06:15:42.099325 | 
2026-08-20 06:15:42.252734 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-20 06:15:42.255278 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-20 06:15:42.861100 | 
2026-08-20 06:15:42.861241 | PLAY [all]
2026-08-20 06:15:42.872745 | 
2026-08-20 06:15:42.872822 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-20 06:15:42.918528 | instance | skipping: Conditional result was False
2026-08-20 06:15:42.928590 | 
2026-08-20 06:15:42.928667 | TASK [fetch-output : Set log path for single node]
2026-08-20 06:15:42.972318 | instance | ok
2026-08-20 06:15:42.978607 | 
2026-08-20 06:15:42.978695 | LOOP [fetch-output : Ensure local output dirs]
2026-08-20 06:15:43.361071 | instance -> localhost | ok: "/var/lib/zuul/builds/e601b9cfdd91490aa654eb09431e68f4/work/logs"
2026-08-20 06:15:43.564916 | instance -> localhost | changed: "/var/lib/zuul/builds/e601b9cfdd91490aa654eb09431e68f4/work/artifacts"
2026-08-20 06:15:43.780100 | instance -> localhost | changed: "/var/lib/zuul/builds/e601b9cfdd91490aa654eb09431e68f4/work/docs"
2026-08-20 06:15:43.797630 | 
2026-08-20 06:15:43.797780 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-20 06:15:44.440175 | instance | changed: .d..t...... ./
2026-08-20 06:15:44.440432 | instance | changed: All items complete
2026-08-20 06:15:44.440474 | 
2026-08-20 06:15:44.891727 | instance | changed: .d..t...... ./
2026-08-20 06:15:45.344734 | instance | changed: .d..t...... ./
2026-08-20 06:15:45.363453 | 
2026-08-20 06:15:45.363582 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-20 06:15:45.795478 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008508
2026-08-20 06:15:46.008174 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007397
2026-08-20 06:15:46.025212 | 
2026-08-20 06:15:46.025330 | PLAY [all]
2026-08-20 06:15:46.031961 | 
2026-08-20 06:15:46.032026 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-20 06:15:46.434337 | instance | changed
2026-08-20 06:15:46.441703 | 
2026-08-20 06:15:46.441753 | PLAY RECAP
2026-08-20 06:15:46.441801 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-20 06:15:46.441823 | 
2026-08-20 06:15:46.578115 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-20 06:15:46.580303 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-20 06:15:47.277685 | 
2026-08-20 06:15:47.278051 | PLAY [localhost]
2026-08-20 06:15:47.287912 | 
2026-08-20 06:15:47.287983 | TASK [Generate Zuul manifest]
2026-08-20 06:15:47.308729 | localhost | ok
2026-08-20 06:15:47.331019 | 
2026-08-20 06:15:47.331135 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-20 06:15:47.706351 | localhost | changed
2026-08-20 06:15:47.718123 | 
2026-08-20 06:15:47.718210 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-20 06:15:47.750831 | localhost | ok
2026-08-20 06:15:47.759294 | 
2026-08-20 06:15:47.759374 | TASK [Upload logs]
2026-08-20 06:15:47.782406 | localhost | ok
2026-08-20 06:15:47.847305 | 
2026-08-20 06:15:47.847454 | TASK [Set zuul-log-path fact]
2026-08-20 06:15:47.866941 | localhost | ok
2026-08-20 06:15:47.881726 | 
2026-08-20 06:15:47.881845 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-20 06:15:47.912833 | localhost | ok
2026-08-20 06:15:47.921256 | 
2026-08-20 06:15:47.921326 | TASK [upload-logs : Create log directories]
2026-08-20 06:15:48.306781 | localhost | changed
2026-08-20 06:15:48.313206 | 
2026-08-20 06:15:48.313305 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-20 06:15:48.699702 | localhost -> localhost | ok: Runtime: 0:00:00.005730
2026-08-20 06:15:48.705992 | 
2026-08-20 06:15:48.706059 | TASK [upload-logs : Upload logs to log server]
2026-08-20 06:15:49.172865 | localhost | Output suppressed because no_log was given
2026-08-20 06:15:49.209966 | 
2026-08-20 06:15:49.210115 | LOOP [upload-logs : Compress console log and json output]
2026-08-20 06:15:49.255087 | localhost | skipping: Conditional result was False
2026-08-20 06:15:49.262247 | localhost | skipping: Conditional result was False
2026-08-20 06:15:49.272975 | 
2026-08-20 06:15:49.273146 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-20 06:15:49.315412 | localhost | skipping: Conditional result was False
2026-08-20 06:15:49.315817 | 
2026-08-20 06:15:49.319177 | localhost | skipping: Conditional result was False
2026-08-20 06:15:49.337931 | 
2026-08-20 06:15:49.338113 | LOOP [upload-logs : Upload console log and json output]