2026-07-25 06:17:40.832349 | Job console starting
2026-07-25 06:17:40.841509 | Updating git repos
2026-07-25 06:17:42.522716 | Cloning repos into workspace
2026-07-25 06:17:58.102158 | Restoring repo states
2026-07-25 06:18:08.510385 | Merging changes
2026-07-25 06:18:09.445177 | Checking out repos
2026-07-25 06:18:11.215053 | Preparing playbooks
2026-07-25 06:18:15.269843 | Running Ansible setup
2026-07-25 06:18:18.959573 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-25 06:18:19.610479 | 
2026-07-25 06:18:19.610626 | PLAY [localhost]
2026-07-25 06:18:19.618670 | 
2026-07-25 06:18:19.618755 | TASK [Gathering Facts]
2026-07-25 06:18:20.572274 | localhost | ok
2026-07-25 06:18:20.584657 | 
2026-07-25 06:18:20.584786 | TASK [Setup log path fact]
2026-07-25 06:18:20.642080 | localhost | ok
2026-07-25 06:18:20.980244 | 
2026-07-25 06:18:20.980387 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-25 06:18:21.011188 | localhost | ok
2026-07-25 06:18:21.019528 | 
2026-07-25 06:18:21.019634 | TASK [emit-job-header : Print job information]
2026-07-25 06:18:21.060677 | # Job Information
2026-07-25 06:18:21.060883 | Ansible Version: 2.16.18
2026-07-25 06:18:21.060929 | Job: atmosphere-molecule-aio-ovn-selective
2026-07-25 06:18:21.060986 | Pipeline: check
2026-07-25 06:18:21.061018 | Executor: 2d72f0692154
2026-07-25 06:18:21.061045 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4152
2026-07-25 06:18:21.061077 | Event ID: f28bd5a0-87ef-11f1-845c-41e8079008c6
2026-07-25 06:18:21.065183 | 
2026-07-25 06:18:21.065284 | LOOP [emit-job-header : Print node information]
2026-07-25 06:18:21.186288 | localhost | ok:
2026-07-25 06:18:21.186498 | localhost | # Node Information
2026-07-25 06:18:21.186539 | localhost | Inventory Hostname: instance
2026-07-25 06:18:21.186571 | localhost | Hostname: np0000186752
2026-07-25 06:18:21.186600 | localhost | Username: zuul
2026-07-25 06:18:21.186633 | localhost | Distro: Ubuntu 22.04
2026-07-25 06:18:21.186660 | localhost | Provider: yul1
2026-07-25 06:18:21.186686 | localhost | Region: ca-ymq-1
2026-07-25 06:18:21.186713 | localhost | Label: ubuntu-jammy-16
2026-07-25 06:18:21.186739 | localhost | Product Name: OpenStack Nova
2026-07-25 06:18:21.186763 | localhost | Interface IP: 199.204.45.109
2026-07-25 06:18:21.202156 | 
2026-07-25 06:18:21.202316 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-07-25 06:18:21.634002 | localhost -> localhost | changed
2026-07-25 06:18:21.639250 | 
2026-07-25 06:18:21.639348 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-07-25 06:18:22.602526 | localhost -> localhost | changed
2026-07-25 06:18:22.615320 | 
2026-07-25 06:18:22.615397 | PLAY [all]
2026-07-25 06:18:22.623284 | 
2026-07-25 06:18:22.623352 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-07-25 06:18:22.870078 | instance -> localhost | ok
2026-07-25 06:18:22.880878 | 
2026-07-25 06:18:22.881013 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-07-25 06:18:22.912277 | instance | ok
2026-07-25 06:18:22.927699 | instance | included: /var/lib/zuul/builds/ecad6995163d4891ab12063f97fac982/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-07-25 06:18:22.933412 | 
2026-07-25 06:18:22.933471 | TASK [add-build-sshkey : Create Temp SSH key]
2026-07-25 06:18:24.807775 | instance -> localhost | Generating public/private rsa key pair.
2026-07-25 06:18:24.808001 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/ecad6995163d4891ab12063f97fac982/work/ecad6995163d4891ab12063f97fac982_id_rsa
2026-07-25 06:18:24.808045 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/ecad6995163d4891ab12063f97fac982/work/ecad6995163d4891ab12063f97fac982_id_rsa.pub
2026-07-25 06:18:24.808081 | instance -> localhost | The key fingerprint is:
2026-07-25 06:18:24.808114 | instance -> localhost | SHA256:eRGcUr/1bJoxbuhapxyW4eIGDLcGrQPe873e9QgwfD4 zuul-build-sshkey
2026-07-25 06:18:24.808165 | instance -> localhost | The key's randomart image is:
2026-07-25 06:18:24.808197 | instance -> localhost | +---[RSA 3072]----+
2026-07-25 06:18:24.808232 | instance -> localhost | |         oo.     |
2026-07-25 06:18:24.808264 | instance -> localhost | |        . oo     |
2026-07-25 06:18:24.808296 | instance -> localhost | |       . .. . .  |
2026-07-25 06:18:24.808326 | instance -> localhost | |    . o oo . o o |
2026-07-25 06:18:24.808356 | instance -> localhost | |   . o *S.= + o +|
2026-07-25 06:18:24.808386 | instance -> localhost | |    . = =. * = * |
2026-07-25 06:18:24.808416 | instance -> localhost | |       = o. E B  |
2026-07-25 06:18:24.808446 | instance -> localhost | |        ..oB O o |
2026-07-25 06:18:24.808479 | instance -> localhost | |         o=o= . .|
2026-07-25 06:18:24.808510 | instance -> localhost | +----[SHA256]-----+
2026-07-25 06:18:24.808586 | instance -> localhost | ok: Runtime: 0:00:01.462508
2026-07-25 06:18:24.815822 | 
2026-07-25 06:18:24.815934 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-07-25 06:18:24.849297 | instance | ok
2026-07-25 06:18:24.860469 | instance | included: /var/lib/zuul/builds/ecad6995163d4891ab12063f97fac982/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-07-25 06:18:24.870662 | 
2026-07-25 06:18:24.870795 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-07-25 06:18:24.895472 | instance | skipping: Conditional result was False
2026-07-25 06:18:24.905842 | 
2026-07-25 06:18:24.905930 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-07-25 06:18:25.337074 | instance | changed
2026-07-25 06:18:25.344583 | 
2026-07-25 06:18:25.344657 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-07-25 06:18:25.568079 | instance | ok
2026-07-25 06:18:25.572996 | 
2026-07-25 06:18:25.573060 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-07-25 06:18:26.063699 | instance | changed
2026-07-25 06:18:26.071131 | 
2026-07-25 06:18:26.071206 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-07-25 06:18:26.531679 | instance | changed
2026-07-25 06:18:26.538666 | 
2026-07-25 06:18:26.538760 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-07-25 06:18:26.563180 | instance | skipping: Conditional result was False
2026-07-25 06:18:26.574048 | 
2026-07-25 06:18:26.574141 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-07-25 06:18:26.902859 | instance -> localhost | changed
2026-07-25 06:18:26.913301 | 
2026-07-25 06:18:26.913467 | TASK [add-build-sshkey : Add back temp key]
2026-07-25 06:18:27.199177 | instance -> localhost | Identity added: /var/lib/zuul/builds/ecad6995163d4891ab12063f97fac982/work/ecad6995163d4891ab12063f97fac982_id_rsa (zuul-build-sshkey)
2026-07-25 06:18:27.199453 | instance -> localhost | ok: Runtime: 0:00:00.012228
2026-07-25 06:18:27.206723 | 
2026-07-25 06:18:27.206811 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-07-25 06:18:27.491977 | instance | ok
2026-07-25 06:18:27.498976 | 
2026-07-25 06:18:27.499049 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-07-25 06:18:27.524807 | instance | skipping: Conditional result was False
2026-07-25 06:18:27.542184 | 
2026-07-25 06:18:27.542337 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-07-25 06:18:27.854580 | instance | ok
2026-07-25 06:18:27.866877 | 
2026-07-25 06:18:27.867184 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-07-25 06:18:31.281309 | instance | Output suppressed because no_log was given
2026-07-25 06:18:31.294098 | 
2026-07-25 06:18:31.294251 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-07-25 06:18:31.494911 | instance | ok: "logs"
2026-07-25 06:18:31.495194 | instance | ok: All items complete
2026-07-25 06:18:31.495244 | 
2026-07-25 06:18:31.651580 | instance | ok: "artifacts"
2026-07-25 06:18:31.806261 | instance | ok: "docs"
2026-07-25 06:18:31.817671 | 
2026-07-25 06:18:31.817897 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-07-25 06:18:31.998367 | instance | changed: "logs"
2026-07-25 06:18:32.159870 | instance | changed: "artifacts"
2026-07-25 06:18:32.335263 | instance | changed: "docs"
2026-07-25 06:18:32.348670 | 
2026-07-25 06:18:32.348813 | PLAY RECAP
2026-07-25 06:18:32.348879 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-07-25 06:18:32.348921 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-25 06:18:32.348969 | 
2026-07-25 06:18:32.520370 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-25 06:18:32.533099 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-25 06:18:33.173817 | 
2026-07-25 06:18:33.173958 | PLAY [all]
2026-07-25 06:18:33.187128 | 
2026-07-25 06:18:33.187276 | TASK [setup-uv : Extract archive]
2026-07-25 06:18:35.553319 | instance | changed
2026-07-25 06:18:35.559334 | 
2026-07-25 06:18:35.559417 | TASK [setup-uv : Print version]
2026-07-25 06:18:35.929473 | instance | uv 0.8.13
2026-07-25 06:18:36.097292 | instance | ok: Runtime: 0:00:00.013325
2026-07-25 06:18:36.109680 | 
2026-07-25 06:18:36.109811 | TASK [Install Ansible collection siblings]
2026-07-25 06:18:44.982141 | instance | changed:
2026-07-25 06:18:44.982419 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-07-25 06:18:44.982483 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-07-25 06:18:44.982531 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-07-25 06:18:44.982571 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-07-25 06:18:44.982592 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-07-25 06:18:44.982615 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-07-25 06:18:44.982636 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-07-25 06:18:44.982657 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-07-25 06:18:44.982677 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-07-25 06:18:44.982697 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-07-25 06:18:44.982715 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-07-25 06:18:44.982734 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-07-25 06:18:44.982752 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-07-25 06:18:44.982771 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-07-25 06:18:44.982789 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0
2026-07-25 06:18:44.982808 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-07-25 06:18:44.982826 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-07-25 06:18:44.982845 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-07-25 06:18:44.982862 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-07-25 06:18:44.982880 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-07-25 06:18:44.982898 | instance | Resolved vexxhost.ceph to v4.1.0 for >=3.2.0
2026-07-25 06:18:44.982916 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-07-25 06:18:44.982936 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-25 06:18:44.982969 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-07-25 06:18:44.982988 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0,>=6.0.0
2026-07-25 06:18:44.983007 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-25 06:18:44.983025 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-25 06:18:44.983043 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-25 06:18:44.983061 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-07-25 06:18:44.983079 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-07-25 06:18:44.983097 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-25 06:18:44.983115 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-25 06:18:44.983134 | instance | Checked out ansible.netcommon to 1.2.0
2026-07-25 06:18:44.983151 | 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-07-25 06:18:44.983174 | instance | Starting galaxy collection install process
2026-07-25 06:18:44.983192 | instance | Process install dependency map
2026-07-25 06:18:44.983210 | instance | Starting collection install process
2026-07-25 06:18:44.983228 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-07-25 06:18:44.983245 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-07-25 06:18:44.983263 | instance | ansible.netcommon:* was installed successfully
2026-07-25 06:18:44.983280 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-07-25 06:18:44.983298 | instance | Creating virtual environment at: .venv
2026-07-25 06:18:44.983316 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-25 06:18:44.983333 | instance | Downloading kubernetes (1.9MiB)
2026-07-25 06:18:44.983352 | instance | Downloading setuptools (1.1MiB)
2026-07-25 06:18:44.983370 | instance | Downloading netaddr (2.2MiB)
2026-07-25 06:18:44.983388 | instance | Downloading cryptography (4.2MiB)
2026-07-25 06:18:44.983406 | instance | Downloading ansible-core (2.1MiB)
2026-07-25 06:18:44.983424 | instance | Downloading openstacksdk (1.7MiB)
2026-07-25 06:18:44.983442 | instance | Downloading pydantic-core (2.0MiB)
2026-07-25 06:18:44.983460 | instance | Downloading pygments (1.2MiB)
2026-07-25 06:18:44.983478 | instance | Downloading rjsonnet (1.2MiB)
2026-07-25 06:18:44.983496 | instance |    Building pyperclip==1.9.0
2026-07-25 06:18:44.983515 | instance |  Downloading rjsonnet
2026-07-25 06:18:44.983534 | instance |  Downloading pydantic-core
2026-07-25 06:18:44.983551 | instance |  Downloading netaddr
2026-07-25 06:18:44.983569 | instance |  Downloading pygments
2026-07-25 06:18:44.983587 | instance |  Downloading cryptography
2026-07-25 06:18:44.983605 | instance |  Downloading setuptools
2026-07-25 06:18:44.983622 | instance |  Downloading kubernetes
2026-07-25 06:18:44.983640 | instance |  Downloading ansible-core
2026-07-25 06:18:44.983658 | instance |  Downloading openstacksdk
2026-07-25 06:18:44.983676 | instance |       Built pyperclip==1.9.0
2026-07-25 06:18:44.983694 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-25 06:18:44.983712 | instance | Installed 83 packages in 41ms
2026-07-25 06:18:44.983730 | instance | Checked out ansible.posix to 1.6.0
2026-07-25 06:18:44.983748 | 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-07-25 06:18:44.983766 | instance | Starting galaxy collection install process
2026-07-25 06:18:44.983783 | instance | Process install dependency map
2026-07-25 06:18:44.983806 | instance | Starting collection install process
2026-07-25 06:18:44.983824 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-07-25 06:18:44.983842 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-07-25 06:18:44.983859 | instance | ansible.posix:1.6.0 was installed successfully
2026-07-25 06:18:44.983877 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 06:18:44.983894 | instance | 2.17.12
2026-07-25 06:18:44.983912 | instance | Checked out ansible.utils to v6.0.3
2026-07-25 06:18:44.983930 | 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-07-25 06:18:44.983948 | instance | Starting galaxy collection install process
2026-07-25 06:18:44.983966 | instance | Process install dependency map
2026-07-25 06:18:44.983983 | instance | Starting collection install process
2026-07-25 06:18:44.984001 | instance | Installing 'ansible.utils:6.0.3' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-07-25 06:18:44.984020 | instance | Created collection for ansible.utils:6.0.3 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-07-25 06:18:44.984038 | instance | ansible.utils:6.0.3 was installed successfully
2026-07-25 06:18:44.984056 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 06:18:44.984074 | instance | 2.17.12
2026-07-25 06:18:44.984092 | instance | Checked out atmosphere.common to v0.7.0
2026-07-25 06:18:44.984110 | 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-07-25 06:18:44.984128 | instance | Starting galaxy collection install process
2026-07-25 06:18:44.984146 | instance | Process install dependency map
2026-07-25 06:18:44.984163 | instance | Starting collection install process
2026-07-25 06:18:44.984181 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-07-25 06:18:44.984199 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-07-25 06:18:44.984222 | instance | atmosphere.common:0.7.0 was installed successfully
2026-07-25 06:18:44.984240 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 06:18:44.984258 | instance | 2.17.12
2026-07-25 06:18:44.984276 | instance | Checked out community.crypto to 2.2.3
2026-07-25 06:18:44.984294 | 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-07-25 06:18:44.984312 | instance | Starting galaxy collection install process
2026-07-25 06:18:44.984330 | instance | Process install dependency map
2026-07-25 06:18:44.984348 | instance | Starting collection install process
2026-07-25 06:18:44.984366 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-07-25 06:18:44.984384 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-07-25 06:18:44.984402 | instance | community.crypto:2.2.3 was installed successfully
2026-07-25 06:18:44.984420 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 06:18:44.984437 | instance | 2.17.12
2026-07-25 06:18:44.984456 | instance | Checked out community.general to 7.3.0
2026-07-25 06:18:44.984473 | 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-07-25 06:18:44.984496 | instance | Starting galaxy collection install process
2026-07-25 06:18:44.984515 | instance | Process install dependency map
2026-07-25 06:18:44.984533 | instance | Starting collection install process
2026-07-25 06:18:44.984551 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-07-25 06:18:44.984572 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-07-25 06:18:44.984592 | instance | community.general:7.3.0 was installed successfully
2026-07-25 06:18:44.984610 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 06:18:44.984628 | instance | 2.17.12
2026-07-25 06:18:44.984646 | instance | Checked out community.mysql to 3.6.0
2026-07-25 06:18:44.984666 | 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-07-25 06:18:44.984685 | instance | Starting galaxy collection install process
2026-07-25 06:18:44.984703 | instance | Process install dependency map
2026-07-25 06:18:44.984721 | instance | Starting collection install process
2026-07-25 06:18:44.984739 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-07-25 06:18:44.984757 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-07-25 06:18:44.984775 | instance | community.mysql:3.6.0 was installed successfully
2026-07-25 06:18:44.984793 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 06:18:44.984811 | instance | 2.17.12
2026-07-25 06:18:44.984829 | instance | Checked out kubernetes.core to 2.4.0
2026-07-25 06:18:44.984847 | 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-07-25 06:18:44.984865 | instance | Starting galaxy collection install process
2026-07-25 06:18:44.984883 | instance | Process install dependency map
2026-07-25 06:18:44.984901 | instance | Starting collection install process
2026-07-25 06:18:44.984919 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-07-25 06:18:44.984936 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-07-25 06:18:44.984968 | instance | kubernetes.core:2.4.0 was installed successfully
2026-07-25 06:18:44.984989 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 06:18:44.985008 | instance | 2.17.12
2026-07-25 06:18:44.985026 | instance | Checked out openstack.cloud to 2.6.0
2026-07-25 06:18:44.985044 | 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-07-25 06:18:44.985062 | instance | Starting galaxy collection install process
2026-07-25 06:18:44.985080 | instance | Process install dependency map
2026-07-25 06:18:44.985098 | instance | Starting collection install process
2026-07-25 06:18:44.985115 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-07-25 06:18:44.985132 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-07-25 06:18:44.985149 | instance | openstack.cloud:2.6.0 was installed successfully
2026-07-25 06:18:44.985168 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 06:18:44.985185 | instance | 2.17.12
2026-07-25 06:18:44.985211 | instance | Checked out vexxhost.ceph to v4.1.0
2026-07-25 06:18:44.985230 | 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-07-25 06:18:44.985248 | instance | Starting galaxy collection install process
2026-07-25 06:18:44.985265 | instance | Process install dependency map
2026-07-25 06:18:44.985282 | instance | Starting collection install process
2026-07-25 06:18:44.985300 | instance | Installing 'vexxhost.ceph:4.1.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-07-25 06:18:44.985318 | instance | Created collection for vexxhost.ceph:4.1.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-07-25 06:18:44.985335 | instance | vexxhost.ceph:4.1.0 was installed successfully
2026-07-25 06:18:44.985353 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 06:18:44.985370 | instance | 2.17.12
2026-07-25 06:18:44.985388 | instance | Checked out vexxhost.containers to v1.6.8
2026-07-25 06:18:44.985406 | 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-07-25 06:18:44.985424 | instance | Starting galaxy collection install process
2026-07-25 06:18:44.985442 | instance | Process install dependency map
2026-07-25 06:18:44.985460 | instance | Starting collection install process
2026-07-25 06:18:44.985477 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-07-25 06:18:44.985494 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-07-25 06:18:44.985512 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-07-25 06:18:44.985530 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 06:18:44.985547 | instance | 2.17.12
2026-07-25 06:18:44.985565 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-07-25 06:18:44.985584 | 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-07-25 06:18:44.985601 | instance | Starting galaxy collection install process
2026-07-25 06:18:44.985639 | instance | Process install dependency map
2026-07-25 06:18:44.985660 | instance | Starting collection install process
2026-07-25 06:18:44.985678 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-07-25 06:18:44.985696 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-07-25 06:18:44.985714 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-07-25 06:18:44.985732 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 06:18:44.985750 | instance | 2.17.12
2026-07-25 06:18:44.991279 | 
2026-07-25 06:18:44.991324 | PLAY RECAP
2026-07-25 06:18:44.991366 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-25 06:18:44.991386 | 
2026-07-25 06:18:45.114263 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-25 06:18:45.125156 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-25 06:18:45.784241 | 
2026-07-25 06:18:45.784387 | PLAY [all]
2026-07-25 06:18:45.796633 | 
2026-07-25 06:18:45.796715 | TASK [Install "jq" for log collection]
2026-07-25 06:18:56.601897 | instance | changed
2026-07-25 06:18:56.604721 | 
2026-07-25 06:18:56.604807 | PLAY RECAP
2026-07-25 06:18:56.604878 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-25 06:18:56.604996 | 
2026-07-25 06:18:56.772070 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-25 06:18:56.787740 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-25 06:18:57.413303 | 
2026-07-25 06:18:57.413444 | PLAY [Prepare Molecule dependencies]
2026-07-25 06:18:57.424611 | 
2026-07-25 06:18:57.441546 | TASK [Install jq for log collection]
2026-07-25 06:18:59.944801 | instance | ok
2026-07-25 06:18:59.950264 | 
2026-07-25 06:18:59.950354 | PLAY [Install Go for the Atmosphere deployment binary]
2026-07-25 06:18:59.962714 | 
2026-07-25 06:18:59.962864 | TASK [ensure-go : Check installed go version]
2026-07-25 06:19:00.498850 | instance | ok: ERROR (ignored)
2026-07-25 06:19:00.499215 | instance | {
2026-07-25 06:19:00.499277 | instance |   "failed_when_result": false,
2026-07-25 06:19:00.499321 | instance |   "msg": "[Errno 2] No such file or directory: b'go'",
2026-07-25 06:19:00.499367 | instance |   "rc": 2
2026-07-25 06:19:00.499388 | instance | }
2026-07-25 06:19:00.506156 | 
2026-07-25 06:19:00.506255 | TASK [ensure-go : Skip if correct version of go is installed]
2026-07-25 06:19:00.559116 | instance | ok
2026-07-25 06:19:00.566941 | instance | included: /var/lib/zuul/builds/ecad6995163d4891ab12063f97fac982/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-go/tasks/install-go.yaml
2026-07-25 06:19:00.572354 | 
2026-07-25 06:19:00.572439 | TASK [ensure-go : Create temp directory]
2026-07-25 06:19:00.868642 | instance | changed
2026-07-25 06:19:01.153303 | 
2026-07-25 06:19:01.153485 | TASK [ensure-go : Get archive checksum]
2026-07-25 06:19:01.801704 | instance | ok: OK (64 bytes)
2026-07-25 06:19:01.808169 | 
2026-07-25 06:19:01.808241 | TASK [ensure-go : Download go archive]
2026-07-25 06:19:03.689123 | instance | changed: OK (78559214 bytes)
2026-07-25 06:19:03.699626 | 
2026-07-25 06:19:03.780624 | TASK [ensure-go : Install go]
2026-07-25 06:19:09.649263 | instance | changed
2026-07-25 06:19:09.658399 | 
2026-07-25 06:19:09.663147 | PLAY [Prepare selective Molecule execution plan]
2026-07-25 06:19:09.669084 | 
2026-07-25 06:19:09.669174 | TASK [Build atmosphere binary]
2026-07-25 06:19:09.930318 | instance | go: downloading github.com/spf13/cobra v1.9.1
2026-07-25 06:19:09.935025 | instance | go: downloading golang.org/x/sync v0.18.0
2026-07-25 06:19:09.947293 | instance | go: downloading github.com/goccy/go-yaml v1.18.0
2026-07-25 06:19:10.222173 | instance | go: downloading github.com/spf13/pflag v1.0.7
2026-07-25 06:19:17.256638 | instance | ok: Runtime: 0:00:07.132148
2026-07-25 06:19:17.324548 | 
2026-07-25 06:19:17.324665 | TASK [Generate selective CI plan]
2026-07-25 06:19:17.861772 | instance | ok: Runtime: 0:00:00.024900
2026-07-25 06:19:17.868550 | 
2026-07-25 06:19:17.868626 | TASK [Explain selective CI plan]
2026-07-25 06:19:18.098666 | instance | CI plan mode: full
2026-07-25 06:19:18.098901 | instance | Changed files:
2026-07-25 06:19:18.098915 | instance |   M	.ansible-lint
2026-07-25 06:19:18.098926 | instance |   M	.gitignore
2026-07-25 06:19:18.098935 | instance |   A	.goreleaser.yml
2026-07-25 06:19:18.098945 | instance |   M	.zuul.yaml
2026-07-25 06:19:18.098957 | instance |   A	ci/molecule-plan.yaml
2026-07-25 06:19:18.098966 | instance |   A	cmd/atmosphere/ci.go
2026-07-25 06:19:18.098976 | instance |   A	cmd/atmosphere/deploy.go
2026-07-25 06:19:18.098989 | instance |   A	cmd/atmosphere/deploy_test.go
2026-07-25 06:19:18.099001 | instance |   A	cmd/atmosphere/main.go
2026-07-25 06:19:18.099010 | instance |   M	doc/source/admin/upgrading.rst
2026-07-25 06:19:18.099023 | instance |   M	doc/source/deploy/deployment.rst
2026-07-25 06:19:18.099033 | instance |   M	doc/source/deploy/index.rst
2026-07-25 06:19:18.099041 | instance |   A	doc/source/deploy/parallel.rst
2026-07-25 06:19:18.099051 | instance |   A	doc/source/deploy/selective-ci.rst
2026-07-25 06:19:18.099060 | instance |   A	internal/ciplan/changes.go
2026-07-25 06:19:18.099070 | instance |   A	internal/ciplan/config.go
2026-07-25 06:19:18.099079 | instance |   A	internal/ciplan/glob.go
2026-07-25 06:19:18.099088 | instance |   A	internal/ciplan/output.go
2026-07-25 06:19:18.099097 | instance |   A	internal/ciplan/planner.go
2026-07-25 06:19:18.099106 | instance |   A	internal/ciplan/planner_test.go
2026-07-25 06:19:18.099115 | instance |   A	internal/ciplan/types.go
2026-07-25 06:19:18.099123 | instance |   A	internal/deploy/bootstrap_test.go
2026-07-25 06:19:18.099132 | instance |   A	internal/deploy/completion.go
2026-07-25 06:19:18.099141 | instance |   A	internal/deploy/completion_test.go
2026-07-25 06:19:18.099150 | instance |   A	internal/deploy/component.go
2026-07-25 06:19:18.099159 | instance |   A	internal/deploy/component_test.go
2026-07-25 06:19:18.099167 | instance |   A	internal/deploy/deployer.go
2026-07-25 06:19:18.099176 | instance |   A	internal/deploy/deployer_test.go
2026-07-25 06:19:18.099185 | instance |   A	internal/deploy/orchestrator.go
2026-07-25 06:19:18.099194 | instance |   A	internal/deploy/orchestrator_subgraph_pregate_test.go
2026-07-25 06:19:18.099207 | instance |   A	internal/deploy/orchestrator_test.go
2026-07-25 06:19:18.099216 | instance |   A	internal/deploy/resource.go
2026-07-25 06:19:18.099225 | instance |   A	internal/deploy/resource_concurrency_test.go
2026-07-25 06:19:18.099234 | instance |   A	internal/deploy/resource_test.go
2026-07-25 06:19:18.099242 | instance |   A	internal/deploy/subprocess_linux_test.go
2026-07-25 06:19:18.099251 | instance |   M	molecule/aio/converge.yml
2026-07-25 06:19:18.099260 | instance |   M	molecule/csi/converge.yml
2026-07-25 06:19:18.099269 | instance |   M	molecule/default/converge.yml
2026-07-25 06:19:18.099278 | instance |   M	molecule/keycloak/converge.yml
2026-07-25 06:19:18.099287 | instance |   M	molecule/pxc/converge.yml
2026-07-25 06:19:18.099295 | instance |   M	molecule/shared/molecule.yml
2026-07-25 06:19:18.099304 | instance |   A	pkg/dag/dag.go
2026-07-25 06:19:18.099313 | instance |   A	pkg/dag/dag_test.go
2026-07-25 06:19:18.099322 | instance |   A	playbooks/image_warmup.yml
2026-07-25 06:19:18.099336 | instance |   M	playbooks/kubernetes.yml
2026-07-25 06:19:18.099346 | instance |   M	playbooks/openstack.yml
2026-07-25 06:19:18.099355 | instance |   M	playbooks/site.yml
2026-07-25 06:19:18.099364 | instance |   A	releasenotes/notes/dag-critical-path-scheduling-d2d5f1dc4ca5bf70.yaml
2026-07-25 06:19:18.099374 | instance |   A	releasenotes/notes/dag-edge-removal-phase1-439694be3dac4d84.yaml
2026-07-25 06:19:18.099383 | instance |   A	releasenotes/notes/dag-event-driven-scheduler-297ecebcb0455852.yaml
2026-07-25 06:19:18.099392 | instance |   A	releasenotes/notes/deploy-perf-tier1-d8f993d67122d060.yaml
2026-07-25 06:19:18.099401 | instance |   A	releasenotes/notes/deploy-perf-tier2-613c7bac4183c8bd.yaml
2026-07-25 06:19:18.099410 | instance |   A	releasenotes/notes/parallel-deployment-orchestrator-7808f907bf1ecd23.yaml
2026-07-25 06:19:18.099419 | instance |   A	releasenotes/notes/selective-molecule-ci-96c6c8b19ed8ab7b.yaml
2026-07-25 06:19:18.099428 | instance |   M	roles/cluster_issuer/handlers/main.yml
2026-07-25 06:19:18.099437 | instance |   M	roles/glance/tasks/main.yml
2026-07-25 06:19:18.099446 | instance |   A	roles/glance_images/README.md
2026-07-25 06:19:18.099454 | instance |   A	roles/glance_images/defaults/main.yml
2026-07-25 06:19:18.099463 | instance |   A	roles/glance_images/meta/main.yml
2026-07-25 06:19:18.099472 | instance |   A	roles/glance_images/tasks/main.yml
2026-07-25 06:19:18.099481 | instance |   A	roles/image_warmup/README.md
2026-07-25 06:19:18.099498 | instance |   A	roles/image_warmup/defaults/main.yml
2026-07-25 06:19:18.099507 | instance |   A	roles/image_warmup/meta/main.yml
2026-07-25 06:19:18.099516 | instance |   A	roles/image_warmup/tasks/main.yml
2026-07-25 06:19:18.099525 | instance |   M	roles/iscsi/tasks/main.yml
2026-07-25 06:19:18.099534 | instance |   M	roles/keepalived/tasks/main.yml
2026-07-25 06:19:18.099543 | instance |   M	roles/keystone/tasks/main.yml
2026-07-25 06:19:18.099551 | instance |   A	roles/keystone_pre/README.md
2026-07-25 06:19:18.099560 | instance |   A	roles/keystone_pre/defaults/main.yml
2026-07-25 06:19:18.099569 | instance |   A	roles/keystone_pre/meta/main.yml
2026-07-25 06:19:18.099578 | instance |   A	roles/keystone_pre/tasks/main.yml
2026-07-25 06:19:18.099587 | instance |   A	roles/keystone_pre/templates/configmap-openid-metadata.yml.j2
2026-07-25 06:19:18.099596 | instance |   M	roles/magnum/tasks/main.yml
2026-07-25 06:19:18.099605 | instance |   A	roles/magnum_pre/README.md
2026-07-25 06:19:18.099613 | instance |   A	roles/magnum_pre/defaults/main.yml
2026-07-25 06:19:18.099622 | instance |   A	roles/magnum_pre/meta/main.yml
2026-07-25 06:19:18.099631 | instance |   A	roles/magnum_pre/tasks/main.yml
2026-07-25 06:19:18.099640 | instance |   A	roles/magnum_pre/vars/main.yml
2026-07-25 06:19:18.099649 | instance |   M	roles/manila/tasks/main.yml
2026-07-25 06:19:18.099657 | instance |   M	roles/multipathd/tasks/main.yml
2026-07-25 06:19:18.099666 | instance |   M	roles/neutron/meta/main.yml
2026-07-25 06:19:18.099675 | instance |   M	roles/neutron/tasks/main.yml
2026-07-25 06:19:18.099684 | instance |   A	roles/neutron_pre/README.md
2026-07-25 06:19:18.099693 | instance |   A	roles/neutron_pre/defaults/main.yml
2026-07-25 06:19:18.099702 | instance |   A	roles/neutron_pre/meta/main.yml
2026-07-25 06:19:18.099710 | instance |   A	roles/neutron_pre/tasks/main.yml
2026-07-25 06:19:18.099719 | instance |   A	roles/neutron_pre/vars/main.yml
2026-07-25 06:19:18.099728 | instance |   M	roles/octavia/tasks/main.yml
2026-07-25 06:19:18.099737 | instance |   A	roles/octavia_pre/README.md
2026-07-25 06:19:18.099746 | instance |   A	roles/octavia_pre/defaults/main.yml
2026-07-25 06:19:18.099755 | instance |   A	roles/octavia_pre/meta/main.yml
2026-07-25 06:19:18.099763 | instance |   A	roles/octavia_pre/tasks/main.yml
2026-07-25 06:19:18.099772 | instance |   M	roles/openstack_cli/tasks/main.yml
2026-07-25 06:19:18.099781 | instance |   M	roles/openstack_helm_endpoints/tasks/main.yml
2026-07-25 06:19:18.099790 | instance |   M	roles/reboot/tasks/main.yml
2026-07-25 06:19:18.099799 | instance |   M	roles/rook_ceph_cluster/tasks/main.yml
2026-07-25 06:19:18.099811 | instance |   M	roles/tempest/defaults/main.yml
2026-07-25 06:19:18.099823 | instance |   M	roles/tempest/tasks/main.yml
2026-07-25 06:19:18.099833 | instance |   M	roles/tempest/vars/main.yml
2026-07-25 06:19:18.099842 | instance |   A	test-playbooks/go-test/run.yml
2026-07-25 06:19:18.099851 | instance |   A	test-playbooks/molecule/prepare.yml
2026-07-25 06:19:18.099860 | instance |   A	test-playbooks/molecule/run.yml
2026-07-25 06:19:18.099869 | instance |   A	test-playbooks/molecule/selective-run.yml
2026-07-25 06:19:18.099878 | instance | Matches:
2026-07-25 06:19:18.099887 | instance |   .ansible-lint: unclassified (full)
2026-07-25 06:19:18.099896 | instance |   .gitignore: non-runtime (ignore)
2026-07-25 06:19:18.099905 | instance |   .goreleaser.yml: unclassified (full)
2026-07-25 06:19:18.099914 | instance |   .zuul.yaml: planner-policy (full)
2026-07-25 06:19:18.099922 | instance |   ci/molecule-plan.yaml: planner-policy (full)
2026-07-25 06:19:18.099931 | instance |   cmd/atmosphere/ci.go: planner-policy (full)
2026-07-25 06:19:18.099940 | instance |   cmd/atmosphere/deploy.go: planner-policy (full)
2026-07-25 06:19:18.099949 | instance |   cmd/atmosphere/deploy_test.go: unclassified (full)
2026-07-25 06:19:18.099958 | instance |   cmd/atmosphere/main.go: planner-policy (full)
2026-07-25 06:19:18.099966 | instance |   doc/source/admin/upgrading.rst: non-runtime (ignore)
2026-07-25 06:19:18.099975 | instance |   doc/source/deploy/deployment.rst: non-runtime (ignore)
2026-07-25 06:19:18.099984 | instance |   doc/source/deploy/index.rst: non-runtime (ignore)
2026-07-25 06:19:18.099993 | instance |   doc/source/deploy/parallel.rst: non-runtime (ignore)
2026-07-25 06:19:18.100002 | instance |   doc/source/deploy/selective-ci.rst: non-runtime (ignore)
2026-07-25 06:19:18.100036 | instance |   internal/ciplan/changes.go: planner-policy (full)
2026-07-25 06:19:18.100047 | instance |   internal/ciplan/config.go: planner-policy (full)
2026-07-25 06:19:18.100056 | instance |   internal/ciplan/glob.go: planner-policy (full)
2026-07-25 06:19:18.100072 | instance |   internal/ciplan/output.go: planner-policy (full)
2026-07-25 06:19:18.100081 | instance |   internal/ciplan/planner.go: planner-policy (full)
2026-07-25 06:19:18.100093 | instance |   internal/ciplan/planner_test.go: planner-policy (full)
2026-07-25 06:19:18.100102 | instance |   internal/ciplan/types.go: planner-policy (full)
2026-07-25 06:19:18.100111 | instance |   internal/deploy/bootstrap_test.go: unclassified (full)
2026-07-25 06:19:18.100120 | instance |   internal/deploy/completion.go: unclassified (full)
2026-07-25 06:19:18.100128 | instance |   internal/deploy/completion_test.go: unclassified (full)
2026-07-25 06:19:18.100137 | instance |   internal/deploy/component.go: planner-policy (full)
2026-07-25 06:19:18.100146 | instance |   internal/deploy/component_test.go: unclassified (full)
2026-07-25 06:19:18.100155 | instance |   internal/deploy/deployer.go: unclassified (full)
2026-07-25 06:19:18.100163 | instance |   internal/deploy/deployer_test.go: unclassified (full)
2026-07-25 06:19:18.100172 | instance |   internal/deploy/orchestrator.go: planner-policy (full)
2026-07-25 06:19:18.100181 | instance |   internal/deploy/orchestrator_subgraph_pregate_test.go: unclassified (full)
2026-07-25 06:19:18.100190 | instance |   internal/deploy/orchestrator_test.go: unclassified (full)
2026-07-25 06:19:18.100199 | instance |   internal/deploy/resource.go: unclassified (full)
2026-07-25 06:19:18.100216 | instance |   internal/deploy/resource_concurrency_test.go: unclassified (full)
2026-07-25 06:19:18.100225 | instance |   internal/deploy/resource_test.go: unclassified (full)
2026-07-25 06:19:18.100234 | instance |   internal/deploy/subprocess_linux_test.go: unclassified (full)
2026-07-25 06:19:18.100244 | instance |   molecule/aio/converge.yml: planner-policy (full)
2026-07-25 06:19:18.100253 | instance |   molecule/csi/converge.yml: unclassified (full)
2026-07-25 06:19:18.100263 | instance |   molecule/default/converge.yml: unclassified (full)
2026-07-25 06:19:18.100272 | instance |   molecule/keycloak/converge.yml: unclassified (full)
2026-07-25 06:19:18.100281 | instance |   molecule/pxc/converge.yml: unclassified (full)
2026-07-25 06:19:18.100290 | instance |   molecule/shared/molecule.yml: shared-deployment-code (full)
2026-07-25 06:19:18.100299 | instance |   pkg/dag/dag.go: planner-policy (full)
2026-07-25 06:19:18.100307 | instance |   pkg/dag/dag_test.go: planner-policy (full)
2026-07-25 06:19:18.100316 | instance |   playbooks/image_warmup.yml: unclassified (full)
2026-07-25 06:19:18.100325 | instance |   playbooks/kubernetes.yml: component:kubernetes (targets) -> kubernetes
2026-07-25 06:19:18.100334 | instance |   playbooks/openstack.yml: shared-deployment-code (full)
2026-07-25 06:19:18.100343 | instance |   playbooks/site.yml: shared-deployment-code (full)
2026-07-25 06:19:18.100352 | instance |   releasenotes/notes/dag-critical-path-scheduling-d2d5f1dc4ca5bf70.yaml: non-runtime (ignore)
2026-07-25 06:19:18.100361 | instance |   releasenotes/notes/dag-edge-removal-phase1-439694be3dac4d84.yaml: non-runtime (ignore)
2026-07-25 06:19:18.100370 | instance |   releasenotes/notes/dag-event-driven-scheduler-297ecebcb0455852.yaml: non-runtime (ignore)
2026-07-25 06:19:18.100379 | instance |   releasenotes/notes/deploy-perf-tier1-d8f993d67122d060.yaml: non-runtime (ignore)
2026-07-25 06:19:18.100388 | instance |   releasenotes/notes/deploy-perf-tier2-613c7bac4183c8bd.yaml: non-runtime (ignore)
2026-07-25 06:19:18.100397 | instance |   releasenotes/notes/parallel-deployment-orchestrator-7808f907bf1ecd23.yaml: non-runtime (ignore)
2026-07-25 06:19:18.100406 | instance |   releasenotes/notes/selective-molecule-ci-96c6c8b19ed8ab7b.yaml: non-runtime (ignore)
2026-07-25 06:19:18.100415 | instance |   roles/cluster_issuer/handlers/main.yml: component:cluster-issuer (targets) -> cluster-issuer
2026-07-25 06:19:18.100424 | instance |   roles/glance/tasks/main.yml: component:glance (targets) -> glance
2026-07-25 06:19:18.100433 | instance |   roles/glance_images/README.md: component:glance-images (targets) -> glance-images
2026-07-25 06:19:18.100478 | instance |   roles/glance_images/defaults/main.yml: component:glance-images (targets) -> glance-images
2026-07-25 06:19:18.100487 | instance |   roles/glance_images/meta/main.yml: component:glance-images (targets) -> glance-images
2026-07-25 06:19:18.100503 | instance |   roles/glance_images/tasks/main.yml: component:glance-images (targets) -> glance-images
2026-07-25 06:19:18.100640 | instance |   roles/image_warmup/README.md: component:image-warmup (targets) -> image-warmup
2026-07-25 06:19:18.100660 | instance |   roles/image_warmup/defaults/main.yml: component:image-warmup (targets) -> image-warmup
2026-07-25 06:19:18.100669 | instance |   roles/image_warmup/meta/main.yml: component:image-warmup (targets) -> image-warmup
2026-07-25 06:19:18.100678 | instance |   roles/image_warmup/tasks/main.yml: component:image-warmup (targets) -> image-warmup
2026-07-25 06:19:18.100688 | instance |   roles/iscsi/tasks/main.yml: component:iscsi (targets) -> iscsi
2026-07-25 06:19:18.100697 | instance |   roles/keepalived/tasks/main.yml: component:keepalived (targets) -> keepalived
2026-07-25 06:19:18.100705 | instance |   roles/keystone/tasks/main.yml: component:keystone (targets) -> keystone
2026-07-25 06:19:18.100714 | instance |   roles/keystone_pre/README.md: component:keystone (targets) -> keystone
2026-07-25 06:19:18.100723 | instance |   roles/keystone_pre/defaults/main.yml: component:keystone (targets) -> keystone
2026-07-25 06:19:18.100732 | instance |   roles/keystone_pre/meta/main.yml: component:keystone (targets) -> keystone
2026-07-25 06:19:18.100741 | instance |   roles/keystone_pre/tasks/main.yml: component:keystone (targets) -> keystone
2026-07-25 06:19:18.100750 | instance |   roles/keystone_pre/templates/configmap-openid-metadata.yml.j2: component:keystone (targets) -> keystone
2026-07-25 06:19:18.100759 | instance |   roles/magnum/tasks/main.yml: component:magnum (targets) -> magnum
2026-07-25 06:19:18.100768 | instance |   roles/magnum_pre/README.md: component:magnum (targets) -> magnum
2026-07-25 06:19:18.100777 | instance |   roles/magnum_pre/defaults/main.yml: component:magnum (targets) -> magnum
2026-07-25 06:19:18.100786 | instance |   roles/magnum_pre/meta/main.yml: component:magnum (targets) -> magnum
2026-07-25 06:19:18.100794 | instance |   roles/magnum_pre/tasks/main.yml: component:magnum (targets) -> magnum
2026-07-25 06:19:18.100807 | instance |   roles/magnum_pre/vars/main.yml: component:magnum (targets) -> magnum
2026-07-25 06:19:18.100816 | instance |   roles/manila/tasks/main.yml: component:manila (targets) -> manila
2026-07-25 06:19:18.100825 | instance |   roles/multipathd/tasks/main.yml: component:multipathd (targets) -> multipathd
2026-07-25 06:19:18.100834 | instance |   roles/neutron/meta/main.yml: component:neutron (targets) -> neutron
2026-07-25 06:19:18.100870 | instance |   roles/neutron/tasks/main.yml: component:neutron (targets) -> neutron
2026-07-25 06:19:18.100879 | instance |   roles/neutron_pre/README.md: component:neutron (targets) -> neutron
2026-07-25 06:19:18.100888 | instance |   roles/neutron_pre/defaults/main.yml: component:neutron (targets) -> neutron
2026-07-25 06:19:18.100897 | instance |   roles/neutron_pre/meta/main.yml: component:neutron (targets) -> neutron
2026-07-25 06:19:18.100906 | instance |   roles/neutron_pre/tasks/main.yml: component:neutron (targets) -> neutron
2026-07-25 06:19:18.100914 | instance |   roles/neutron_pre/vars/main.yml: component:neutron (targets) -> neutron
2026-07-25 06:19:18.100923 | instance |   roles/octavia/tasks/main.yml: component:octavia (targets) -> octavia
2026-07-25 06:19:18.100939 | instance |   roles/octavia_pre/README.md: component:octavia (targets) -> octavia
2026-07-25 06:19:18.100948 | instance |   roles/octavia_pre/defaults/main.yml: component:octavia (targets) -> octavia
2026-07-25 06:19:18.100957 | instance |   roles/octavia_pre/meta/main.yml: component:octavia (targets) -> octavia
2026-07-25 06:19:18.100966 | instance |   roles/octavia_pre/tasks/main.yml: component:octavia (targets) -> octavia
2026-07-25 06:19:18.100975 | instance |   roles/openstack_cli/tasks/main.yml: component:openstack-cli (targets) -> openstack-cli
2026-07-25 06:19:18.100984 | instance |   roles/openstack_helm_endpoints/tasks/main.yml: shared-deployment-code (full)
2026-07-25 06:19:18.100993 | instance |   roles/reboot/tasks/main.yml: unclassified (full)
2026-07-25 06:19:18.101002 | instance |   roles/rook_ceph_cluster/tasks/main.yml: component:rook-ceph-cluster (targets) -> rook-ceph-cluster
2026-07-25 06:19:18.101011 | instance |   roles/tempest/defaults/main.yml: shared-deployment-code (full)
2026-07-25 06:19:18.101020 | instance |   roles/tempest/tasks/main.yml: shared-deployment-code (full)
2026-07-25 06:19:18.101029 | instance |   roles/tempest/vars/main.yml: shared-deployment-code (full)
2026-07-25 06:19:18.101038 | instance |   test-playbooks/go-test/run.yml: unclassified (full)
2026-07-25 06:19:18.101053 | instance |   test-playbooks/molecule/prepare.yml: planner-policy (full)
2026-07-25 06:19:18.101062 | instance |   test-playbooks/molecule/run.yml: planner-policy (full)
2026-07-25 06:19:18.101071 | instance |   test-playbooks/molecule/selective-run.yml: planner-policy (full)
2026-07-25 06:19:18.101080 | instance | Verification profiles: full
2026-07-25 06:19:18.101097 | instance | Variant openvswitch (49 components): barbican, ceph, ceph-provisioners, cert-manager, cinder, cluster-issuer, coredns, csi, frr-k8s, glance, glance-images, goldpinger, heat, horizon, image-warmup, ingress-nginx, ipmi-exporter, iscsi, keepalived, keycloak, keystone, kube-prometheus-stack, kubernetes, libvirt, loki, lpfc, magnum, manila, memcached, multipathd, neutron, node-feature-discovery, nova, octavia, openstack-cli, openstack-exporter, openvswitch, ovn, percona-xtradb-cluster, percona-xtradb-cluster-operator, placement, prometheus-pushgateway, rabbitmq-cluster-operator, rook-ceph, rook-ceph-cluster, staffeln, udev, valkey, vector
2026-07-25 06:19:18.101109 | instance | Variant ovn (49 components): barbican, ceph, ceph-provisioners, cert-manager, cinder, cluster-issuer, coredns, csi, frr-k8s, glance, glance-images, goldpinger, heat, horizon, image-warmup, ingress-nginx, ipmi-exporter, iscsi, keepalived, keycloak, keystone, kube-prometheus-stack, kubernetes, libvirt, loki, lpfc, magnum, manila, memcached, multipathd, neutron, node-feature-discovery, nova, octavia, openstack-cli, openstack-exporter, openvswitch, ovn, percona-xtradb-cluster, percona-xtradb-cluster-operator, placement, prometheus-pushgateway, rabbitmq-cluster-operator, rook-ceph, rook-ceph-cluster, staffeln, udev, valkey, vector
2026-07-25 06:19:18.101119 | instance | Molecule jobs:
2026-07-25 06:19:18.101128 | instance |   aio-openvswitch: run (49 components) - full fallback runs every Molecule job
2026-07-25 06:19:18.101137 | instance |   aio-ovn: run (49 components) - full fallback runs every Molecule job
2026-07-25 06:19:18.101146 | instance |   csi-local-path-provisioner: run - full fallback runs every Molecule job
2026-07-25 06:19:18.101155 | instance |   csi-rbd: run - full fallback runs every Molecule job
2026-07-25 06:19:18.101164 | instance |   keycloak: run - full fallback runs every Molecule job
2026-07-25 06:19:18.101173 | instance | Reasons:
2026-07-25 06:19:18.101182 | instance |   - unclassified runtime path ".ansible-lint" requires the full fallback
2026-07-25 06:19:18.101191 | instance |   - unclassified runtime path ".goreleaser.yml" requires the full fallback
2026-07-25 06:19:18.101200 | instance |   - .zuul.yaml: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101209 | instance |   - ci/molecule-plan.yaml: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101220 | instance |   - cmd/atmosphere/ci.go: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101229 | instance |   - cmd/atmosphere/deploy.go: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101238 | instance |   - unclassified runtime path "cmd/atmosphere/deploy_test.go" requires the full fallback
2026-07-25 06:19:18.101247 | instance |   - cmd/atmosphere/main.go: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101256 | instance |   - internal/ciplan/changes.go: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101265 | instance |   - internal/ciplan/config.go: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101274 | instance |   - internal/ciplan/glob.go: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101283 | instance |   - internal/ciplan/output.go: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101292 | instance |   - internal/ciplan/planner.go: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101300 | instance |   - internal/ciplan/planner_test.go: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101314 | instance |   - internal/ciplan/types.go: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101332 | instance |   - unclassified runtime path "internal/deploy/bootstrap_test.go" requires the full fallback
2026-07-25 06:19:18.101341 | instance |   - unclassified runtime path "internal/deploy/completion.go" requires the full fallback
2026-07-25 06:19:18.101350 | instance |   - unclassified runtime path "internal/deploy/completion_test.go" requires the full fallback
2026-07-25 06:19:18.101359 | instance |   - internal/deploy/component.go: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101368 | instance |   - unclassified runtime path "internal/deploy/component_test.go" requires the full fallback
2026-07-25 06:19:18.101377 | instance |   - unclassified runtime path "internal/deploy/deployer.go" requires the full fallback
2026-07-25 06:19:18.101386 | instance |   - unclassified runtime path "internal/deploy/deployer_test.go" requires the full fallback
2026-07-25 06:19:18.101395 | instance |   - internal/deploy/orchestrator.go: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101404 | instance |   - unclassified runtime path "internal/deploy/orchestrator_subgraph_pregate_test.go" requires the full fallback
2026-07-25 06:19:18.101413 | instance |   - unclassified runtime path "internal/deploy/orchestrator_test.go" requires the full fallback
2026-07-25 06:19:18.101421 | instance |   - unclassified runtime path "internal/deploy/resource.go" requires the full fallback
2026-07-25 06:19:18.101430 | instance |   - unclassified runtime path "internal/deploy/resource_concurrency_test.go" requires the full fallback
2026-07-25 06:19:18.101439 | instance |   - unclassified runtime path "internal/deploy/resource_test.go" requires the full fallback
2026-07-25 06:19:18.101448 | instance |   - unclassified runtime path "internal/deploy/subprocess_linux_test.go" requires the full fallback
2026-07-25 06:19:18.101457 | instance |   - molecule/aio/converge.yml: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101466 | instance |   - unclassified runtime path "molecule/csi/converge.yml" requires the full fallback
2026-07-25 06:19:18.101475 | instance |   - unclassified runtime path "molecule/default/converge.yml" requires the full fallback
2026-07-25 06:19:18.101483 | instance |   - unclassified runtime path "molecule/keycloak/converge.yml" requires the full fallback
2026-07-25 06:19:18.101492 | instance |   - unclassified runtime path "molecule/pxc/converge.yml" requires the full fallback
2026-07-25 06:19:18.101501 | instance |   - molecule/shared/molecule.yml: shared deployment code can affect multiple unrelated components
2026-07-25 06:19:18.101510 | instance |   - pkg/dag/dag.go: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101519 | instance |   - pkg/dag/dag_test.go: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101528 | instance |   - unclassified runtime path "playbooks/image_warmup.yml" requires the full fallback
2026-07-25 06:19:18.101536 | instance |   - playbooks/openstack.yml: shared deployment code can affect multiple unrelated components
2026-07-25 06:19:18.101545 | instance |   - playbooks/site.yml: shared deployment code can affect multiple unrelated components
2026-07-25 06:19:18.101557 | instance |   - roles/openstack_helm_endpoints/tasks/main.yml: shared deployment code can affect multiple unrelated components
2026-07-25 06:19:18.101566 | instance |   - unclassified runtime path "roles/reboot/tasks/main.yml" requires the full fallback
2026-07-25 06:19:18.101576 | instance |   - roles/tempest/defaults/main.yml: shared deployment code can affect multiple unrelated components
2026-07-25 06:19:18.101584 | instance |   - roles/tempest/tasks/main.yml: shared deployment code can affect multiple unrelated components
2026-07-25 06:19:18.101593 | instance |   - roles/tempest/vars/main.yml: shared deployment code can affect multiple unrelated components
2026-07-25 06:19:18.101602 | instance |   - unclassified runtime path "test-playbooks/go-test/run.yml" requires the full fallback
2026-07-25 06:19:18.101611 | instance |   - test-playbooks/molecule/prepare.yml: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101620 | instance |   - test-playbooks/molecule/run.yml: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.101634 | instance |   - test-playbooks/molecule/selective-run.yml: CI selection policy changed and must validate its conservative fallback
2026-07-25 06:19:18.412704 | instance | ok: Runtime: 0:00:00.031976
2026-07-25 06:19:18.423549 | 
2026-07-25 06:19:18.423661 | TASK [Print selective CI plan]
2026-07-25 06:19:18.467450 | instance | ok
2026-07-25 06:19:18.475750 | 
2026-07-25 06:19:18.475834 | TASK [Report conservative fallback]
2026-07-25 06:19:18.500443 | instance | skipping: Conditional result was False
2026-07-25 06:19:18.508811 | 
2026-07-25 06:19:18.508903 | TASK [Create selective CI plan log directory]
2026-07-25 06:19:18.876658 | instance | changed
2026-07-25 06:19:18.882005 | 
2026-07-25 06:19:18.882073 | TASK [Publish selective CI plan with job logs]
2026-07-25 06:19:19.293592 | instance | changed
2026-07-25 06:19:19.294712 | 
2026-07-25 06:19:19.294753 | PLAY RECAP
2026-07-25 06:19:19.294795 | instance | ok: 13 changed: 5 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-25 06:19:19.294819 | 
2026-07-25 06:19:19.421128 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-25 06:19:19.434359 | RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-25 06:19:20.046235 | 
2026-07-25 06:19:20.046377 | PLAY [Run selected Molecule deployment and verification]
2026-07-25 06:19:20.058606 | 
2026-07-25 06:19:20.058721 | TASK [Check for selective CI plan]
2026-07-25 06:19:20.391293 | instance | ok
2026-07-25 06:19:20.396872 | 
2026-07-25 06:19:20.396946 | TASK [Validate selective CI plan]
2026-07-25 06:19:20.928050 | instance | ok: Runtime: 0:00:00.032753
2026-07-25 06:19:20.933499 | 
2026-07-25 06:19:20.933576 | TASK [Resolve selective CI plan availability]
2026-07-25 06:19:20.985221 | instance | ok
2026-07-25 06:19:20.992104 | 
2026-07-25 06:19:20.992196 | TASK [Read selective CI plan]
2026-07-25 06:19:21.305472 | instance | ok
2026-07-25 06:19:21.313638 | 
2026-07-25 06:19:21.313753 | TASK [Load selective CI plan or full fallback]
2026-07-25 06:19:21.413208 | instance | ok
2026-07-25 06:19:21.428170 | 
2026-07-25 06:19:21.428240 | TASK [Find this job in the selective CI plan]
2026-07-25 06:19:21.492181 | instance | ok
2026-07-25 06:19:21.497144 | 
2026-07-25 06:19:21.497215 | TASK [Resolve this job or use full fallback]
2026-07-25 06:19:21.629194 | instance | ok
2026-07-25 06:19:21.634131 | 
2026-07-25 06:19:21.634200 | TASK [Resolve deployment and verification inputs]
2026-07-25 06:19:21.698654 | instance | ok
2026-07-25 06:19:21.706289 | 
2026-07-25 06:19:21.706356 | TASK [Resolve deployment tags]
2026-07-25 06:19:21.758343 | instance | ok
2026-07-25 06:19:21.765073 | 
2026-07-25 06:19:21.765188 | TASK [Report Molecule job decision]
2026-07-25 06:19:21.810280 | instance | ok: {'job': 'aio-ovn', 'mode': 'full', 'run': True, 'reason': 'full fallback runs every Molecule job', 'network_backend': 'ovn', 'components': ['barbican', 'ceph', 'ceph-provisioners', 'cert-manager', 'cinder', 'cluster-issuer', 'coredns', 'csi', 'frr-k8s', 'glance', 'glance-images', 'goldpinger', 'heat', 'horizon', 'image-warmup', 'ingress-nginx', 'ipmi-exporter', 'iscsi', 'keepalived', 'keycloak', 'keystone', 'kube-prometheus-stack', 'kubernetes', 'libvirt', 'loki', 'lpfc', 'magnum', 'manila', 'memcached', 'multipathd', 'neutron', 'node-feature-discovery', 'nova', 'octavia', 'openstack-cli', 'openstack-exporter', 'openvswitch', 'ovn', 'percona-xtradb-cluster', 'percona-xtradb-cluster-operator', 'placement', 'prometheus-pushgateway', 'rabbitmq-cluster-operator', 'rook-ceph', 'rook-ceph-cluster', 'staffeln', 'udev', 'valkey', 'vector'], 'verification_profiles': ['full']}
2026-07-25 06:19:21.818019 | 
2026-07-25 06:19:21.818111 | TASK [Copy inventory file for Zuul]
2026-07-25 06:19:22.379457 | instance | changed
2026-07-25 06:19:22.384399 | 
2026-07-25 06:19:22.384462 | TASK [Switch ansible_host to private IP]
2026-07-25 06:19:22.646591 | instance | changed: 1 replacements made
2026-07-25 06:19:22.651446 | 
2026-07-25 06:19:22.651578 | TASK [Prepare Molecule scenario]
2026-07-25 06:19:23.486502 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-07-25 06:19:23.893689 | instance | INFO     [aio > discovery] scenario test matrix: prepare
2026-07-25 06:19:23.893793 | instance | INFO     [aio > prerun] Performing prerun with role_name_check=0...
2026-07-25 06:19:35.228808 | instance | INFO     [aio > prepare] Executing
2026-07-25 06:19:36.205800 | instance |
2026-07-25 06:19:36.206396 | instance | PLAY [Prepare] *****************************************************************
2026-07-25 06:19:36.206688 | instance |
2026-07-25 06:19:36.206938 | instance | TASK [Gathering Facts] *********************************************************
2026-07-25 06:19:36.207217 | instance | Saturday 25 July 2026  06:19:36 +0000 (0:00:00.026)       0:00:00.026 *********
2026-07-25 06:19:37.346089 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-07-25 06:19:37.346491 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-07-25 06:19:37.346897 | instance | interpreter could change the meaning of that path. See
2026-07-25 06:19:37.347300 | instance | https://docs.ansible.com/ansible-
2026-07-25 06:19:37.347734 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-07-25 06:19:37.355873 | instance | ok: [instance]
2026-07-25 06:19:37.355975 | instance |
2026-07-25 06:19:37.356218 | instance | TASK [Configure short hostname] ************************************************
2026-07-25 06:19:37.356347 | instance | Saturday 25 July 2026  06:19:37 +0000 (0:00:01.151)       0:00:01.177 *********
2026-07-25 06:19:38.060414 | instance | changed: [instance]
2026-07-25 06:19:38.060592 | instance |
2026-07-25 06:19:38.060832 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-07-25 06:19:38.061069 | instance | Saturday 25 July 2026  06:19:38 +0000 (0:00:00.703)       0:00:01.881 *********
2026-07-25 06:19:38.308739 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-07-25 06:19:38.309127 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-07-25 06:19:38.309549 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-07-25 06:19:38.318893 | instance | changed: [instance]
2026-07-25 06:19:38.319175 | instance |
2026-07-25 06:19:38.319458 | instance | TASK [Install "dirmngr" for GPG keyserver operations] **************************
2026-07-25 06:19:38.319826 | instance | Saturday 25 July 2026  06:19:38 +0000 (0:00:00.258)       0:00:02.140 *********
2026-07-25 06:19:39.578976 | instance | ok: [instance]
2026-07-25 06:19:39.579065 | instance |
2026-07-25 06:19:39.579078 | instance | TASK [Purge "snapd" package] ***************************************************
2026-07-25 06:19:39.579091 | instance | Saturday 25 July 2026  06:19:39 +0000 (0:00:01.258)       0:00:03.398 *********
2026-07-25 06:19:40.409761 | instance | ok: [instance]
2026-07-25 06:19:40.409826 | instance |
2026-07-25 06:19:40.409834 | instance | PLAY [Generate workspace for Atmosphere] ***************************************
2026-07-25 06:19:40.409841 | instance |
2026-07-25 06:19:40.409847 | instance | TASK [Create folders for workspace] ********************************************
2026-07-25 06:19:40.409855 | instance | Saturday 25 July 2026  06:19:40 +0000 (0:00:00.830)       0:00:04.229 *********
2026-07-25 06:19:41.418799 | instance | changed: [localhost] => (item=group_vars)
2026-07-25 06:19:41.418887 | instance | changed: [localhost] => (item=group_vars/all)
2026-07-25 06:19:41.419931 | instance | changed: [localhost] => (item=group_vars/controllers)
2026-07-25 06:19:41.419980 | instance | changed: [localhost] => (item=group_vars/cephs)
2026-07-25 06:19:41.419986 | instance | changed: [localhost] => (item=group_vars/computes)
2026-07-25 06:19:41.419992 | instance | changed: [localhost] => (item=host_vars)
2026-07-25 06:19:41.419997 | instance |
2026-07-25 06:19:41.420002 | instance | PLAY [Generate Ceph control plane configuration for workspace] *****************
2026-07-25 06:19:41.420021 | instance |
2026-07-25 06:19:41.420027 | instance | TASK [Ensure the Ceph control plane configuration file exists] *****************
2026-07-25 06:19:41.420031 | instance | Saturday 25 July 2026  06:19:41 +0000 (0:00:01.011)       0:00:05.240 *********
2026-07-25 06:19:41.594253 | instance | changed: [localhost]
2026-07-25 06:19:41.595175 | instance |
2026-07-25 06:19:41.595227 | instance | TASK [Load the current Ceph control plane configuration into a variable] *******
2026-07-25 06:19:41.595244 | instance | Saturday 25 July 2026  06:19:41 +0000 (0:00:00.174)       0:00:05.414 *********
2026-07-25 06:19:41.623435 | instance | ok: [localhost]
2026-07-25 06:19:41.623953 | instance |
2026-07-25 06:19:41.623981 | instance | TASK [Generate Ceph control plane values for missing variables] ****************
2026-07-25 06:19:41.623990 | instance | Saturday 25 July 2026  06:19:41 +0000 (0:00:00.029)       0:00:05.444 *********
2026-07-25 06:19:41.679302 | instance | ok: [localhost] => (item={'key': 'ceph_fsid', 'value': '60e5ba29-cd90-5e35-9c05-4586f4bdbbc7'})
2026-07-25 06:19:41.679498 | instance | ok: [localhost] => (item={'key': 'ceph_mon_public_network', 'value': '10.96.240.0/24'})
2026-07-25 06:19:41.679770 | instance |
2026-07-25 06:19:41.680034 | instance | TASK [Write new Ceph control plane configuration file to disk] *****************
2026-07-25 06:19:41.680275 | instance | Saturday 25 July 2026  06:19:41 +0000 (0:00:00.055)       0:00:05.499 *********
2026-07-25 06:19:42.243652 | instance | changed: [localhost]
2026-07-25 06:19:42.243735 | instance |
2026-07-25 06:19:42.244155 | instance | PLAY [Generate Ceph OSD configuration for workspace] ***************************
2026-07-25 06:19:42.244363 | instance |
2026-07-25 06:19:42.244377 | instance | TASK [Ensure the Ceph OSDs configuration file exists] **************************
2026-07-25 06:19:42.244393 | instance | Saturday 25 July 2026  06:19:42 +0000 (0:00:00.564)       0:00:06.064 *********
2026-07-25 06:19:42.425914 | instance | changed: [localhost]
2026-07-25 06:19:42.426894 | instance |
2026-07-25 06:19:42.426967 | instance | TASK [Load the current Ceph OSDs configuration into a variable] ****************
2026-07-25 06:19:42.426980 | instance | Saturday 25 July 2026  06:19:42 +0000 (0:00:00.181)       0:00:06.246 *********
2026-07-25 06:19:42.457281 | instance | ok: [localhost]
2026-07-25 06:19:42.457790 | instance |
2026-07-25 06:19:42.457818 | instance | TASK [Generate Ceph OSDs values for missing variables] *************************
2026-07-25 06:19:42.457827 | instance | Saturday 25 July 2026  06:19:42 +0000 (0:00:00.031)       0:00:06.278 *********
2026-07-25 06:19:42.493567 | instance | ok: [localhost] => (item={'key': 'ceph_osd_devices', 'value': ['/dev/vdb', '/dev/vdc', '/dev/vdd']})
2026-07-25 06:19:42.493837 | instance |
2026-07-25 06:19:42.494227 | instance | TASK [Write new Ceph OSDs configuration file to disk] **************************
2026-07-25 06:19:42.494649 | instance | Saturday 25 July 2026  06:19:42 +0000 (0:00:00.035)       0:00:06.314 *********
2026-07-25 06:19:42.848940 | instance | changed: [localhost]
2026-07-25 06:19:42.849175 | instance |
2026-07-25 06:19:42.849564 | instance | PLAY [Generate Kubernetes configuration for workspace] *************************
2026-07-25 06:19:42.849876 | instance |
2026-07-25 06:19:42.850206 | instance | TASK [Ensure the Kubernetes configuration file exists] *************************
2026-07-25 06:19:42.850597 | instance | Saturday 25 July 2026  06:19:42 +0000 (0:00:00.355)       0:00:06.669 *********
2026-07-25 06:19:43.037131 | instance | changed: [localhost]
2026-07-25 06:19:43.037543 | instance |
2026-07-25 06:19:43.037890 | instance | TASK [Load the current Kubernetes configuration into a variable] ***************
2026-07-25 06:19:43.038227 | instance | Saturday 25 July 2026  06:19:43 +0000 (0:00:00.186)       0:00:06.856 *********
2026-07-25 06:19:43.064751 | instance | ok: [localhost]
2026-07-25 06:19:43.065059 | instance |
2026-07-25 06:19:43.065229 | instance | TASK [Generate Kubernetes values for missing variables] ************************
2026-07-25 06:19:43.065384 | instance | Saturday 25 July 2026  06:19:43 +0000 (0:00:00.028)       0:00:06.885 *********
2026-07-25 06:19:43.113230 | instance | ok: [localhost] => (item={'key': 'kubernetes_hostname', 'value': '10.96.240.10'})
2026-07-25 06:19:43.113659 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vrid', 'value': 42})
2026-07-25 06:19:43.114029 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vip', 'value': '10.96.240.10'})
2026-07-25 06:19:43.114437 | instance |
2026-07-25 06:19:43.114788 | instance | TASK [Write new Kubernetes configuration file to disk] *************************
2026-07-25 06:19:43.115121 | instance | Saturday 25 July 2026  06:19:43 +0000 (0:00:00.046)       0:00:06.932 *********
2026-07-25 06:19:43.461367 | instance | changed: [localhost]
2026-07-25 06:19:43.461787 | instance |
2026-07-25 06:19:43.462138 | instance | PLAY [Generate Keepalived configuration for workspace] *************************
2026-07-25 06:19:43.462577 | instance |
2026-07-25 06:19:43.462926 | instance | TASK [Ensure the Keeaplived configuration file exists] *************************
2026-07-25 06:19:43.463311 | instance | Saturday 25 July 2026  06:19:43 +0000 (0:00:00.348)       0:00:07.281 *********
2026-07-25 06:19:43.632252 | instance | changed: [localhost]
2026-07-25 06:19:43.632360 | instance |
2026-07-25 06:19:43.632420 | instance | TASK [Load the current Keepalived configuration into a variable] ***************
2026-07-25 06:19:43.632606 | instance | Saturday 25 July 2026  06:19:43 +0000 (0:00:00.168)       0:00:07.450 *********
2026-07-25 06:19:43.656672 | instance | ok: [localhost]
2026-07-25 06:19:43.656911 | instance |
2026-07-25 06:19:43.657190 | instance | TASK [Generate Keepalived values for missing variables] ************************
2026-07-25 06:19:43.657457 | instance | Saturday 25 July 2026  06:19:43 +0000 (0:00:00.027)       0:00:07.477 *********
2026-07-25 06:19:43.699021 | instance | ok: [localhost] => (item={'key': 'keepalived_interface', 'value': 'br-ex'})
2026-07-25 06:19:43.699365 | instance | ok: [localhost] => (item={'key': 'keepalived_vip', 'value': '10.96.250.10'})
2026-07-25 06:19:43.699616 | instance |
2026-07-25 06:19:43.699890 | instance | TASK [Write new Keepalived configuration file to disk] *************************
2026-07-25 06:19:43.700221 | instance | Saturday 25 July 2026  06:19:43 +0000 (0:00:00.041)       0:00:07.519 *********
2026-07-25 06:19:44.059321 | instance | changed: [localhost]
2026-07-25 06:19:44.059551 | instance |
2026-07-25 06:19:44.059845 | instance | PLAY [Generate endpoints for workspace] ****************************************
2026-07-25 06:19:44.060108 | instance |
2026-07-25 06:19:44.060386 | instance | TASK [Gathering Facts] *********************************************************
2026-07-25 06:19:44.060657 | instance | Saturday 25 July 2026  06:19:44 +0000 (0:00:00.360)       0:00:07.880 *********
2026-07-25 06:19:44.758804 | instance | ok: [localhost]
2026-07-25 06:19:44.759056 | instance |
2026-07-25 06:19:44.759342 | instance | TASK [Ensure the endpoints file exists] ****************************************
2026-07-25 06:19:44.759620 | instance | Saturday 25 July 2026  06:19:44 +0000 (0:00:00.699)       0:00:08.579 *********
2026-07-25 06:19:44.938846 | instance | changed: [localhost]
2026-07-25 06:19:44.939075 | instance |
2026-07-25 06:19:44.939352 | instance | TASK [Load the current endpoints into a variable] ******************************
2026-07-25 06:19:44.939623 | instance | Saturday 25 July 2026  06:19:44 +0000 (0:00:00.179)       0:00:08.759 *********
2026-07-25 06:19:44.970584 | instance | ok: [localhost]
2026-07-25 06:19:44.970820 | instance |
2026-07-25 06:19:44.971166 | instance | TASK [Generate endpoint skeleton for missing variables] ************************
2026-07-25 06:19:44.971439 | instance | Saturday 25 July 2026  06:19:44 +0000 (0:00:00.031)       0:00:08.791 *********
2026-07-25 06:19:45.701090 | instance | ok: [localhost] => (item=keycloak_host)
2026-07-25 06:19:45.701340 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_host)
2026-07-25 06:19:45.701608 | instance | ok: [localhost] => (item=kube_prometheus_stack_alertmanager_host)
2026-07-25 06:19:45.702028 | instance | ok: [localhost] => (item=kube_prometheus_stack_prometheus_host)
2026-07-25 06:19:45.702310 | instance | ok: [localhost] => (item=openstack_helm_endpoints_region_name)
2026-07-25 06:19:45.702578 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_api_host)
2026-07-25 06:19:45.702842 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_api_host)
2026-07-25 06:19:45.703102 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_api_host)
2026-07-25 06:19:45.703364 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_api_host)
2026-07-25 06:19:45.703635 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_api_host)
2026-07-25 06:19:45.703893 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_api_host)
2026-07-25 06:19:45.704202 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_api_host)
2026-07-25 06:19:45.704464 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_novnc_host)
2026-07-25 06:19:45.704733 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_api_host)
2026-07-25 06:19:45.704993 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_api_host)
2026-07-25 06:19:45.705257 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_api_host)
2026-07-25 06:19:45.705522 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_api_host)
2026-07-25 06:19:45.705850 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_registry_host)
2026-07-25 06:19:45.706114 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_api_host)
2026-07-25 06:19:45.706336 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_cfn_api_host)
2026-07-25 06:19:45.706535 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_api_host)
2026-07-25 06:19:45.706860 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_host)
2026-07-25 06:19:45.707037 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_api_host)
2026-07-25 06:19:45.707203 | instance |
2026-07-25 06:19:45.707388 | instance | TASK [Write new endpoints file to disk] ****************************************
2026-07-25 06:19:45.707561 | instance | Saturday 25 July 2026  06:19:45 +0000 (0:00:00.730)       0:00:09.521 *********
2026-07-25 06:19:46.044931 | instance | changed: [localhost]
2026-07-25 06:19:46.045166 | instance |
2026-07-25 06:19:46.045441 | instance | TASK [Ensure the endpoints file exists] ****************************************
2026-07-25 06:19:46.045777 | instance | Saturday 25 July 2026  06:19:46 +0000 (0:00:00.344)       0:00:09.866 *********
2026-07-25 06:19:46.226055 | instance | changed: [localhost]
2026-07-25 06:19:46.226305 | instance |
2026-07-25 06:19:46.226584 | instance | PLAY [Generate Neutron configuration for workspace] ****************************
2026-07-25 06:19:46.226834 | instance |
2026-07-25 06:19:46.227107 | instance | TASK [Ensure the Neutron configuration file exists] ****************************
2026-07-25 06:19:46.227374 | instance | Saturday 25 July 2026  06:19:46 +0000 (0:00:00.181)       0:00:10.047 *********
2026-07-25 06:19:46.414358 | instance | changed: [localhost]
2026-07-25 06:19:46.414547 | instance |
2026-07-25 06:19:46.414825 | instance | TASK [Load the current Neutron configuration into a variable] ******************
2026-07-25 06:19:46.415104 | instance | Saturday 25 July 2026  06:19:46 +0000 (0:00:00.188)       0:00:10.235 *********
2026-07-25 06:19:46.447705 | instance | ok: [localhost]
2026-07-25 06:19:46.447901 | instance |
2026-07-25 06:19:46.448234 | instance | TASK [Generate Neutron values for missing variables] ***************************
2026-07-25 06:19:46.448501 | instance | Saturday 25 July 2026  06:19:46 +0000 (0:00:00.033)       0:00:10.268 *********
2026-07-25 06:19:46.492484 | instance | ok: [localhost] => (item={'key': 'neutron_networks', 'value': [{'name': 'public', 'external': True, 'shared': True, 'mtu_size': 1500, 'port_security_enabled': True, 'provider_network_type': 'flat', 'provider_physical_network': 'external', 'subnets': [{'name': 'public-subnet', 'cidr': '10.96.250.0/24', 'gateway_ip': '10.96.250.10', 'allocation_pool_start': '10.96.250.200', 'allocation_pool_end': '10.96.250.220', 'enable_dhcp': True}]}]})
2026-07-25 06:19:46.492703 | instance |
2026-07-25 06:19:46.492974 | instance | TASK [Write new Neutron configuration file to disk] ****************************
2026-07-25 06:19:46.493241 | instance | Saturday 25 July 2026  06:19:46 +0000 (0:00:00.044)       0:00:10.313 *********
2026-07-25 06:19:46.842128 | instance | changed: [localhost]
2026-07-25 06:19:46.842349 | instance |
2026-07-25 06:19:46.842636 | instance | PLAY [Generate Nova configuration for workspace] *******************************
2026-07-25 06:19:46.842915 | instance |
2026-07-25 06:19:46.843192 | instance | TASK [Ensure the Nova configuration file exists] *******************************
2026-07-25 06:19:46.843470 | instance | Saturday 25 July 2026  06:19:46 +0000 (0:00:00.350)       0:00:10.663 *********
2026-07-25 06:19:47.017739 | instance | changed: [localhost]
2026-07-25 06:19:47.017912 | instance |
2026-07-25 06:19:47.018229 | instance | TASK [Load the current Nova configuration into a variable] *********************
2026-07-25 06:19:47.018508 | instance | Saturday 25 July 2026  06:19:47 +0000 (0:00:00.175)       0:00:10.838 *********
2026-07-25 06:19:47.048729 | instance | ok: [localhost]
2026-07-25 06:19:47.049117 | instance |
2026-07-25 06:19:47.049498 | instance | TASK [Generate Nova values for missing variables] ******************************
2026-07-25 06:19:47.049834 | instance | Saturday 25 July 2026  06:19:47 +0000 (0:00:00.031)       0:00:10.870 *********
2026-07-25 06:19:47.097131 | instance | ok: [localhost] => (item={'key': 'nova_flavors', 'value': [{'name': 'm1.tiny', 'ram': 512, 'disk': 1, 'vcpus': 1}, {'name': 'm1.small', 'ram': 2048, 'disk': 20, 'vcpus': 1}, {'name': 'm1.medium', 'ram': 4096, 'disk': 40, 'vcpus': 2}, {'name': 'm1.large', 'ram': 8192, 'disk': 80, 'vcpus': 4}, {'name': 'm1.xlarge', 'ram': 16384, 'disk': 160, 'vcpus': 8}]})
2026-07-25 06:19:47.097434 | instance |
2026-07-25 06:19:47.098005 | instance | TASK [Write new Nova configuration file to disk] *******************************
2026-07-25 06:19:47.098350 | instance | Saturday 25 July 2026  06:19:47 +0000 (0:00:00.045)       0:00:10.915 *********
2026-07-25 06:19:47.454588 | instance | changed: [localhost]
2026-07-25 06:19:47.454845 | instance |
2026-07-25 06:19:47.455082 | instance | PLAY [Generate secrets for workspace] ******************************************
2026-07-25 06:19:47.455285 | instance |
2026-07-25 06:19:47.455497 | instance | TASK [Ensure the secrets file exists] ******************************************
2026-07-25 06:19:47.455707 | instance | Saturday 25 July 2026  06:19:47 +0000 (0:00:00.358)       0:00:11.274 *********
2026-07-25 06:19:47.631535 | instance | changed: [localhost]
2026-07-25 06:19:47.631557 | instance |
2026-07-25 06:19:47.631562 | instance | TASK [Load the current secrets into a variable] ********************************
2026-07-25 06:19:47.631567 | instance | Saturday 25 July 2026  06:19:47 +0000 (0:00:00.178)       0:00:11.452 *********
2026-07-25 06:19:47.655583 | instance | ok: [localhost]
2026-07-25 06:19:47.655632 | instance |
2026-07-25 06:19:47.655639 | instance | TASK [Generate secrets for missing variables] **********************************
2026-07-25 06:19:47.655646 | instance | Saturday 25 July 2026  06:19:47 +0000 (0:00:00.023)       0:00:11.476 *********
2026-07-25 06:19:48.063501 | instance | ok: [localhost] => (item=heat_auth_encryption_key)
2026-07-25 06:19:48.063564 | instance | ok: [localhost] => (item=keepalived_password)
2026-07-25 06:19:48.063570 | instance | ok: [localhost] => (item=keycloak_admin_password)
2026-07-25 06:19:48.063582 | instance | ok: [localhost] => (item=keycloak_database_password)
2026-07-25 06:19:48.063587 | instance | ok: [localhost] => (item=keystone_keycloak_client_secret)
2026-07-25 06:19:48.063591 | instance | ok: [localhost] => (item=keystone_oidc_crypto_passphrase)
2026-07-25 06:19:48.063596 | instance | skipping: [localhost] => (item=keystone_keycloak_client_secret)
2026-07-25 06:19:48.063600 | instance | skipping: [localhost] => (item=keystone_oidc_crypto_passphrase)
2026-07-25 06:19:48.063605 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_admin_password)
2026-07-25 06:19:48.063610 | instance | ok: [localhost] => (item=octavia_heartbeat_key)
2026-07-25 06:19:48.063615 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rabbitmq_admin_password)
2026-07-25 06:19:48.063619 | instance | ok: [localhost] => (item=openstack_helm_endpoints_memcached_secret_key)
2026-07-25 06:19:48.063624 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_admin_password)
2026-07-25 06:19:48.063628 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_mariadb_password)
2026-07-25 06:19:48.063633 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_rabbitmq_password)
2026-07-25 06:19:48.063637 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_keystone_password)
2026-07-25 06:19:48.063641 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_mariadb_password)
2026-07-25 06:19:48.063645 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_rabbitmq_password)
2026-07-25 06:19:48.063649 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_keystone_password)
2026-07-25 06:19:48.063654 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_mariadb_password)
2026-07-25 06:19:48.063658 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_rabbitmq_password)
2026-07-25 06:19:48.063662 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_keystone_password)
2026-07-25 06:19:48.063667 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_mariadb_password)
2026-07-25 06:19:48.063671 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_keystone_password)
2026-07-25 06:19:48.063676 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_mariadb_password)
2026-07-25 06:19:48.063694 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_keystone_password)
2026-07-25 06:19:48.063698 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_mariadb_password)
2026-07-25 06:19:48.063702 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_rabbitmq_password)
2026-07-25 06:19:48.063706 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_metadata_secret)
2026-07-25 06:19:48.063710 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_keystone_password)
2026-07-25 06:19:48.063714 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_mariadb_password)
2026-07-25 06:19:48.063718 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_rabbitmq_password)
2026-07-25 06:19:48.063721 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_keystone_password)
2026-07-25 06:19:48.063725 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_mariadb_password)
2026-07-25 06:19:48.063729 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_rabbitmq_password)
2026-07-25 06:19:48.063733 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_keystone_password)
2026-07-25 06:19:48.063737 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_mariadb_password)
2026-07-25 06:19:48.063741 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_rabbitmq_password)
2026-07-25 06:19:48.063745 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_keystone_password)
2026-07-25 06:19:48.063749 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_mariadb_password)
2026-07-25 06:19:48.063752 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_rabbitmq_password)
2026-07-25 06:19:48.063756 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_keystone_password)
2026-07-25 06:19:48.063760 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_mariadb_password)
2026-07-25 06:19:48.063764 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_rabbitmq_password)
2026-07-25 06:19:48.063768 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_keystone_password)
2026-07-25 06:19:48.063772 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_trustee_keystone_password)
2026-07-25 06:19:48.063776 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_stack_user_keystone_password)
2026-07-25 06:19:48.063781 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_mariadb_password)
2026-07-25 06:19:48.063785 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_rabbitmq_password)
2026-07-25 06:19:48.063789 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_mariadb_password)
2026-07-25 06:19:48.063793 | instance | ok: [localhost] => (item=openstack_helm_endpoints_tempest_keystone_password)
2026-07-25 06:19:48.063797 | instance | ok: [localhost] => (item=openstack_helm_endpoints_openstack_exporter_keystone_password)
2026-07-25 06:19:48.063801 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_keystone_password)
2026-07-25 06:19:48.063805 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_keystone_password)
2026-07-25 06:19:48.063809 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_mariadb_password)
2026-07-25 06:19:48.063813 | instance | ok: [localhost] => (item=openstack_helm_endpoints_staffeln_mariadb_password)
2026-07-25 06:19:48.063817 | instance |
2026-07-25 06:19:48.063827 | instance | TASK [Generate base64 encoded secrets] *****************************************
2026-07-25 06:19:48.063831 | instance | Saturday 25 July 2026  06:19:48 +0000 (0:00:00.401)       0:00:11.877 *********
2026-07-25 06:19:48.120572 | instance | ok: [localhost] => (item=barbican_kek)
2026-07-25 06:19:48.120922 | instance |
2026-07-25 06:19:48.121294 | instance | TASK [Generate temporary files for generating keys for missing variables] ******
2026-07-25 06:19:48.121630 | instance | Saturday 25 July 2026  06:19:48 +0000 (0:00:00.063)       0:00:11.941 *********
2026-07-25 06:19:48.554833 | instance | changed: [localhost] => (item=manila_ssh_key)
2026-07-25 06:19:48.555258 | instance | changed: [localhost] => (item=nova_ssh_key)
2026-07-25 06:19:48.555577 | instance |
2026-07-25 06:19:48.555911 | instance | TASK [Generate SSH keys for missing variables] *********************************
2026-07-25 06:19:48.556320 | instance | Saturday 25 July 2026  06:19:48 +0000 (0:00:00.433)       0:00:12.375 *********
2026-07-25 06:19:55.228124 | instance | changed: [localhost] => (item=manila_ssh_key)
2026-07-25 06:19:55.228200 | instance | changed: [localhost] => (item=nova_ssh_key)
2026-07-25 06:19:55.228212 | instance |
2026-07-25 06:19:55.228229 | instance | TASK [Set values for SSH keys] *************************************************
2026-07-25 06:19:55.228656 | instance | Saturday 25 July 2026  06:19:55 +0000 (0:00:06.672)       0:00:19.048 *********
2026-07-25 06:19:55.288932 | instance | ok: [localhost] => (item=manila_ssh_key)
2026-07-25 06:19:55.289028 | instance | ok: [localhost] => (item=nova_ssh_key)
2026-07-25 06:19:55.289598 | instance |
2026-07-25 06:19:55.289770 | instance | TASK [Delete the temporary files generated for SSH keys] ***********************
2026-07-25 06:19:55.289780 | instance | Saturday 25 July 2026  06:19:55 +0000 (0:00:00.061)       0:00:19.109 *********
2026-07-25 06:19:55.630258 | instance | changed: [localhost] => (item=manila_ssh_key)
2026-07-25 06:19:55.630360 | instance | changed: [localhost] => (item=nova_ssh_key)
2026-07-25 06:19:55.630373 | instance |
2026-07-25 06:19:55.630654 | instance | TASK [Write new secrets file to disk] ******************************************
2026-07-25 06:19:55.630710 | instance | Saturday 25 July 2026  06:19:55 +0000 (0:00:00.341)       0:00:19.451 *********
2026-07-25 06:19:55.995618 | instance | changed: [localhost]
2026-07-25 06:19:55.995736 | instance |
2026-07-25 06:19:55.996169 | instance | TASK [Encrypt secrets file with Vault password] ********************************
2026-07-25 06:19:55.996233 | instance | Saturday 25 July 2026  06:19:55 +0000 (0:00:00.365)       0:00:19.816 *********
2026-07-25 06:19:56.030439 | instance | skipping: [localhost]
2026-07-25 06:19:56.030538 | instance |
2026-07-25 06:19:56.031067 | instance | PLAY [Setup networking] ********************************************************
2026-07-25 06:19:56.031141 | instance |
2026-07-25 06:19:56.031149 | instance | TASK [Gathering Facts] *********************************************************
2026-07-25 06:19:56.031155 | instance | Saturday 25 July 2026  06:19:56 +0000 (0:00:00.034)       0:00:19.851 *********
2026-07-25 06:19:56.737989 | instance | ok: [instance]
2026-07-25 06:19:56.738774 | instance |
2026-07-25 06:19:56.738834 | instance | TASK [Create bridge for management network] ************************************
2026-07-25 06:19:56.738846 | instance | Saturday 25 July 2026  06:19:56 +0000 (0:00:00.706)       0:00:20.558 *********
2026-07-25 06:19:57.085521 | instance | ok: [instance]
2026-07-25 06:19:57.085609 | instance |
2026-07-25 06:19:57.086018 | instance | TASK [Create fake interface for management bridge] *****************************
2026-07-25 06:19:57.086065 | instance | Saturday 25 July 2026  06:19:57 +0000 (0:00:00.348)       0:00:20.906 *********
2026-07-25 06:19:57.300742 | instance | ok: [instance]
2026-07-25 06:19:57.300797 | instance |
2026-07-25 06:19:57.300805 | instance | TASK [Assign dummy interface to management bridge] *****************************
2026-07-25 06:19:57.300812 | instance | Saturday 25 July 2026  06:19:57 +0000 (0:00:00.214)       0:00:21.121 *********
2026-07-25 06:19:57.505187 | instance | ok: [instance]
2026-07-25 06:19:57.505314 | instance |
2026-07-25 06:19:57.505699 | instance | TASK [Assign IP address for management bridge] *********************************
2026-07-25 06:19:57.505904 | instance | Saturday 25 July 2026  06:19:57 +0000 (0:00:00.204)       0:00:21.326 *********
2026-07-25 06:19:57.699448 | instance | ok: [instance]
2026-07-25 06:19:57.700110 | instance |
2026-07-25 06:19:57.700179 | instance | TASK [Bring up interfaces] *****************************************************
2026-07-25 06:19:57.700191 | instance | Saturday 25 July 2026  06:19:57 +0000 (0:00:00.193)       0:00:21.520 *********
2026-07-25 06:19:58.091994 | instance | ok: [instance] => (item=br-mgmt)
2026-07-25 06:19:58.092327 | instance | ok: [instance] => (item=dummy0)
2026-07-25 06:19:58.092606 | instance |
2026-07-25 06:19:58.092897 | instance | PLAY [Create devices for Ceph] *************************************************
2026-07-25 06:19:58.093161 | instance |
2026-07-25 06:19:58.093447 | instance | TASK [Gathering Facts] *********************************************************
2026-07-25 06:19:58.093733 | instance | Saturday 25 July 2026  06:19:58 +0000 (0:00:00.392)       0:00:21.913 *********
2026-07-25 06:19:58.866879 | instance | ok: [instance]
2026-07-25 06:19:58.867113 | instance |
2026-07-25 06:19:58.867414 | instance | TASK [Install depedencies] *****************************************************
2026-07-25 06:19:58.867672 | instance | Saturday 25 July 2026  06:19:58 +0000 (0:00:00.774)       0:00:22.687 *********
2026-07-25 06:20:26.150899 | instance | changed: [instance]
2026-07-25 06:20:26.151285 | instance |
2026-07-25 06:20:26.151622 | instance | TASK [Start up service] ********************************************************
2026-07-25 06:20:26.152088 | instance | Saturday 25 July 2026  06:20:26 +0000 (0:00:27.283)       0:00:49.971 *********
2026-07-25 06:20:26.721655 | instance | ok: [instance]
2026-07-25 06:20:26.721734 | instance |
2026-07-25 06:20:26.721909 | instance | TASK [Generate lvm.conf] *******************************************************
2026-07-25 06:20:26.722093 | instance | Saturday 25 July 2026  06:20:26 +0000 (0:00:00.566)       0:00:50.538 *********
2026-07-25 06:20:26.936469 | instance | ok: [instance]
2026-07-25 06:20:26.936594 | instance |
2026-07-25 06:20:26.936759 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-07-25 06:20:26.936923 | instance | Saturday 25 July 2026  06:20:26 +0000 (0:00:00.218)       0:00:50.757 *********
2026-07-25 06:20:27.410483 | instance | changed: [instance]
2026-07-25 06:20:27.410702 | instance |
2026-07-25 06:20:27.410970 | instance | TASK [Get list of all loopback devices] ****************************************
2026-07-25 06:20:27.411235 | instance | Saturday 25 July 2026  06:20:27 +0000 (0:00:00.473)       0:00:51.231 *********
2026-07-25 06:20:27.616255 | instance | ok: [instance]
2026-07-25 06:20:27.616481 | instance |
2026-07-25 06:20:27.616773 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-07-25 06:20:27.617047 | instance | Saturday 25 July 2026  06:20:27 +0000 (0:00:00.205)       0:00:51.436 *********
2026-07-25 06:20:27.642501 | instance | skipping: [instance]
2026-07-25 06:20:27.642741 | instance |
2026-07-25 06:20:27.643012 | instance | TASK [Create devices for Ceph] *************************************************
2026-07-25 06:20:27.643269 | instance | Saturday 25 July 2026  06:20:27 +0000 (0:00:00.027)       0:00:51.464 *********
2026-07-25 06:20:28.191624 | instance | changed: [instance] => (item=osd0)
2026-07-25 06:20:28.191897 | instance | changed: [instance] => (item=osd1)
2026-07-25 06:20:28.192242 | instance | changed: [instance] => (item=osd2)
2026-07-25 06:20:28.192496 | instance |
2026-07-25 06:20:28.192858 | instance | TASK [Set permissions on loopback devices] *************************************
2026-07-25 06:20:28.193139 | instance | Saturday 25 July 2026  06:20:28 +0000 (0:00:00.548)       0:00:52.012 *********
2026-07-25 06:20:28.756312 | instance | changed: [instance] => (item=osd0)
2026-07-25 06:20:28.756520 | instance | changed: [instance] => (item=osd1)
2026-07-25 06:20:28.756672 | instance | changed: [instance] => (item=osd2)
2026-07-25 06:20:28.756828 | instance |
2026-07-25 06:20:28.756981 | instance | TASK [Start loop devices] ******************************************************
2026-07-25 06:20:28.757134 | instance | Saturday 25 July 2026  06:20:28 +0000 (0:00:00.561)       0:00:52.574 *********
2026-07-25 06:20:29.539158 | instance | changed: [instance] => (item=osd0)
2026-07-25 06:20:29.539566 | instance | changed: [instance] => (item=osd1)
2026-07-25 06:20:29.539899 | instance | changed: [instance] => (item=osd2)
2026-07-25 06:20:29.540250 | instance |
2026-07-25 06:20:29.540585 | instance | TASK [Create a volume group for each loop device] ******************************
2026-07-25 06:20:29.540914 | instance | Saturday 25 July 2026  06:20:29 +0000 (0:00:00.785)       0:00:53.360 *********
2026-07-25 06:20:32.814549 | instance | changed: [instance] => (item=osd0)
2026-07-25 06:20:32.814979 | instance | changed: [instance] => (item=osd1)
2026-07-25 06:20:32.815329 | instance | changed: [instance] => (item=osd2)
2026-07-25 06:20:32.815657 | instance |
2026-07-25 06:20:32.816097 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-07-25 06:20:32.816473 | instance | Saturday 25 July 2026  06:20:32 +0000 (0:00:03.275)       0:00:56.635 *********
2026-07-25 06:20:34.648228 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-07-25 06:20:34.648305 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-07-25 06:20:34.648316 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-07-25 06:20:34.648325 | instance |
2026-07-25 06:20:34.648343 | instance | PLAY [controllers] *************************************************************
2026-07-25 06:20:34.648732 | instance |
2026-07-25 06:20:34.648791 | instance | TASK [Gathering Facts] *********************************************************
2026-07-25 06:20:34.649081 | instance | Saturday 25 July 2026  06:20:34 +0000 (0:00:01.832)       0:00:58.468 *********
2026-07-25 06:20:35.625356 | instance | ok: [instance]
2026-07-25 06:20:35.625432 | instance |
2026-07-25 06:20:35.625863 | instance | TASK [Set masquerade rule] *****************************************************
2026-07-25 06:20:35.625917 | instance | Saturday 25 July 2026  06:20:35 +0000 (0:00:00.978)       0:00:59.446 *********
2026-07-25 06:20:36.091345 | instance | changed: [instance]
2026-07-25 06:20:36.091640 | instance |
2026-07-25 06:20:36.092110 | instance | PLAY RECAP *********************************************************************
2026-07-25 06:20:36.092485 | instance | instance                   : ok=24   changed=10   unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-07-25 06:20:36.092829 | instance | localhost                  : ok=40   changed=21   unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-07-25 06:20:36.093137 | instance |
2026-07-25 06:20:36.093545 | instance | Saturday 25 July 2026  06:20:36 +0000 (0:00:00.466)       0:00:59.912 *********
2026-07-25 06:20:36.093889 | instance | ===============================================================================
2026-07-25 06:20:36.094216 | instance | Install depedencies ---------------------------------------------------- 27.28s
2026-07-25 06:20:36.094522 | instance | Generate SSH keys for missing variables --------------------------------- 6.67s
2026-07-25 06:20:36.094679 | instance | Create a volume group for each loop device ------------------------------ 3.28s
2026-07-25 06:20:36.094825 | instance | Create a logical volume for each loop device ---------------------------- 1.83s
2026-07-25 06:20:36.094971 | instance | Install "dirmngr" for GPG keyserver operations -------------------------- 1.26s
2026-07-25 06:20:36.095115 | instance | Gathering Facts --------------------------------------------------------- 1.15s
2026-07-25 06:20:36.095268 | instance | Create folders for workspace -------------------------------------------- 1.01s
2026-07-25 06:20:36.095413 | instance | Gathering Facts --------------------------------------------------------- 0.98s
2026-07-25 06:20:36.095557 | instance | Purge "snapd" package --------------------------------------------------- 0.83s
2026-07-25 06:20:36.095701 | instance | Start loop devices ------------------------------------------------------ 0.79s
2026-07-25 06:20:36.095843 | instance | Gathering Facts --------------------------------------------------------- 0.77s
2026-07-25 06:20:36.095988 | instance | Generate endpoint skeleton for missing variables ------------------------ 0.73s
2026-07-25 06:20:36.096151 | instance | Gathering Facts --------------------------------------------------------- 0.71s
2026-07-25 06:20:36.096298 | instance | Configure short hostname ------------------------------------------------ 0.70s
2026-07-25 06:20:36.096442 | instance | Gathering Facts --------------------------------------------------------- 0.70s
2026-07-25 06:20:36.096585 | instance | Start up service -------------------------------------------------------- 0.57s
2026-07-25 06:20:36.096731 | instance | Write new Ceph control plane configuration file to disk ----------------- 0.57s
2026-07-25 06:20:36.096876 | instance | Set permissions on loopback devices ------------------------------------- 0.56s
2026-07-25 06:20:36.097021 | instance | Create devices for Ceph ------------------------------------------------- 0.55s
2026-07-25 06:20:36.097165 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.47s
2026-07-25 06:20:36.180068 | instance | INFO     [aio > prepare] Executed: Successful
2026-07-25 06:20:36.180741 | instance | INFO     Molecule executed 1 scenario (1 successful)
2026-07-25 06:20:36.295601 | instance | ok: Runtime: 0:01:13.383249
2026-07-25 06:20:36.311154 | 
2026-07-25 06:20:36.311390 | TASK [Build deployment command]
2026-07-25 06:20:36.367208 | instance | ok
2026-07-25 06:20:36.372063 | 
2026-07-25 06:20:36.372128 | TASK [Deploy with parallel orchestrator]
2026-07-25 06:20:36.581206 | instance | ==> Running preflight checks
2026-07-25 06:20:36.581926 | instance | Error: starting preflight checks: exec: "ansible-playbook": executable file not found in $PATH
2026-07-25 06:20:36.582057 | instance | Usage:
2026-07-25 06:20:36.582071 | instance |   atmosphere deploy [flags]
2026-07-25 06:20:36.582082 | instance |
2026-07-25 06:20:36.582091 | instance | Flags:
2026-07-25 06:20:36.582104 | instance |       --concurrency int             Max concurrent deployments per wave (0 = unlimited)
2026-07-25 06:20:36.582115 | instance |       --dependency-option strings   Dependency option in key=value form (for example csi_driver=local-path-provisioner)
2026-07-25 06:20:36.582131 | instance |   -h, --help                        help for deploy
2026-07-25 06:20:36.582142 | instance |   -i, --inventory string            Path to Ansible inventory file (required)
2026-07-25 06:20:36.582153 | instance |   -t, --tags string                 Comma-separated list of component tags to deploy
2026-07-25 06:20:36.582163 | instance |       --with-dependencies           Include transitive dependencies needed by a fresh environment
2026-07-25 06:20:36.582172 | instance |
2026-07-25 06:20:36.582181 | instance | starting preflight checks: exec: "ansible-playbook": executable file not found in $PATH
2026-07-25 06:20:36.910463 | instance | ERROR
2026-07-25 06:20:36.910840 | instance | {
2026-07-25 06:20:36.910910 | instance |   "delta": "0:00:00.008051",
2026-07-25 06:20:36.910959 | instance |   "end": "2026-07-25 06:20:36.582750",
2026-07-25 06:20:36.911022 | instance |   "msg": "non-zero return code",
2026-07-25 06:20:36.911065 | instance |   "rc": 1,
2026-07-25 06:20:36.911106 | instance |   "start": "2026-07-25 06:20:36.574699"
2026-07-25 06:20:36.911146 | instance | }
failure
2026-07-25 06:20:36.912781 | 
2026-07-25 06:20:36.912825 | PLAY RECAP
2026-07-25 06:20:36.912872 | instance | ok: 14 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-07-25 06:20:36.912894 | 
2026-07-25 06:20:37.057216 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-25 06:20:37.072801 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-25 06:20:37.699291 | 
2026-07-25 06:20:37.699429 | PLAY [all]
2026-07-25 06:20:37.713690 | 
2026-07-25 06:20:37.713771 | TASK [gather-host-logs : creating directory for system status]
2026-07-25 06:20:38.066495 | instance | ok
2026-07-25 06:20:38.072080 | 
2026-07-25 06:20:38.072164 | TASK [gather-host-logs : Get logs for each host]
2026-07-25 06:20:38.472332 | instance | + systemd-cgls --full --all --no-pager
2026-07-25 06:20:38.484367 | instance | + ip addr
2026-07-25 06:20:38.487517 | instance | + ip route
2026-07-25 06:20:38.489814 | instance | + lsblk
2026-07-25 06:20:38.494043 | instance | + mount
2026-07-25 06:20:38.496207 | instance | + docker images
2026-07-25 06:20:38.496671 | instance | /bin/bash: line 7: docker: command not found
2026-07-25 06:20:38.496910 | instance | + brctl show
2026-07-25 06:20:38.497354 | instance | /bin/bash: line 8: brctl: command not found
2026-07-25 06:20:38.497612 | instance | + ps aux --sort=-%mem
2026-07-25 06:20:38.513561 | instance | + dpkg -l
2026-07-25 06:20:38.519764 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-07-25 06:20:38.520365 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-07-25 06:20:38.520464 | instance | /bin/bash: line 11: docker: command not found
2026-07-25 06:20:38.520794 | instance | + '[' '!' -z '' ']'
2026-07-25 06:20:38.610742 | instance | ok: Runtime: 0:00:00.054413
2026-07-25 06:20:38.623391 | 
2026-07-25 06:20:38.623543 | TASK [gather-host-logs : Downloads logs to executor]
2026-07-25 06:20:39.266881 | instance | ERROR
2026-07-25 06:20:39.267128 | instance | {
2026-07-25 06:20:39.267161 | instance |   "msg": "Warning: Permanently added '199.204.45.109' (ED25519) to the list of known hosts.\r\nrsync: [generator] chown \"/var/lib/zuul/builds/ecad6995163d4891ab12063f97fac982/work/logs/instance/system\" failed: Invalid argument (22)\nrsync: [receiver] chown \"/var/lib/zuul/builds/ecad6995163d4891ab12063f97fac982/work/logs/instance/system/.ci-plan.json.reB53K\" failed: Invalid argument (22)\nrsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1865) [generator=3.2.7]\n",
2026-07-25 06:20:39.267187 | instance |   "rc": 23
2026-07-25 06:20:39.267207 | instance | }
2026-07-25 06:20:39.267236 | instance | ERROR: Ignoring Errors
2026-07-25 06:20:39.276446 | 
2026-07-25 06:20:39.276516 | LOOP [helm-release-status : creating directory for helm release status]
2026-07-25 06:20:39.470999 | instance | changed: "values"
2026-07-25 06:20:39.653215 | instance | changed: "releases"
2026-07-25 06:20:39.667032 | 
2026-07-25 06:20:39.667238 | TASK [helm-release-status : Gather get release status for helm charts]
2026-07-25 06:20:39.918258 | instance | /bin/bash: line 3: kubectl: command not found
2026-07-25 06:20:40.205683 | instance | ok: Runtime: 0:00:00.005998
2026-07-25 06:20:40.212949 | 
2026-07-25 06:20:40.213063 | TASK [helm-release-status : Downloads logs to executor]
2026-07-25 06:20:40.956482 | instance | changed:
2026-07-25 06:20:40.956784 | instance | cd+++++++++ helm/
2026-07-25 06:20:40.956921 | instance | cd+++++++++ helm/releases/
2026-07-25 06:20:40.957028 | instance | cd+++++++++ helm/values/
2026-07-25 06:20:40.967677 | 
2026-07-25 06:20:40.967767 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-07-25 06:20:41.167924 | instance | changed
2026-07-25 06:20:41.174334 | 
2026-07-25 06:20:41.174413 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-07-25 06:20:41.407861 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-25 06:20:41.408313 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-25 06:20:41.414291 | instance | environment: line 1: kubectl: command not found
2026-07-25 06:20:41.415355 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-25 06:20:41.418067 | instance | environment: line 1: kubectl: command not found
2026-07-25 06:20:41.419301 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-25 06:20:41.419496 | instance | environment: line 1: kubectl: command not found
2026-07-25 06:20:41.420979 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-25 06:20:41.422928 | instance | environment: line 1: kubectl: command not found
2026-07-25 06:20:41.424425 | instance | environment: line 1: kubectl: command not found
2026-07-25 06:20:41.424614 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-25 06:20:41.425615 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-25 06:20:41.711951 | instance | ok: Runtime: 0:00:00.027264
2026-07-25 06:20:41.720362 | 
2026-07-25 06:20:41.720459 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-07-25 06:20:41.917910 | instance | changed
2026-07-25 06:20:41.923310 | 
2026-07-25 06:20:41.923396 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-07-25 06:20:42.137499 | instance | environment: line 5: kubectl: command not found
2026-07-25 06:20:42.138283 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-25 06:20:42.138675 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuexargs:
2026-07-25 06:20:42.138694 | instance | warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-25 06:20:42.456774 | instance | ok: Runtime: 0:00:00.010553
2026-07-25 06:20:42.463985 | 
2026-07-25 06:20:42.464104 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-07-25 06:20:42.953478 | instance | changed:
2026-07-25 06:20:42.953711 | instance | cd+++++++++ objects/
2026-07-25 06:20:42.953752 | instance | cd+++++++++ objects/cluster/
2026-07-25 06:20:42.953783 | instance | cd+++++++++ objects/namespaced/
2026-07-25 06:20:42.964739 | 
2026-07-25 06:20:42.964811 | TASK [gather-pod-logs : creating directory for pod logs]
2026-07-25 06:20:43.162153 | instance | changed
2026-07-25 06:20:43.168805 | 
2026-07-25 06:20:43.168877 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-07-25 06:20:43.377842 | instance | changed
2026-07-25 06:20:43.385018 | 
2026-07-25 06:20:43.385117 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-07-25 06:20:43.605069 | instance | environment: line 3: kubectl: command not found
2026-07-25 06:20:43.924606 | instance | ok: Runtime: 0:00:00.009850
2026-07-25 06:20:43.931895 | 
2026-07-25 06:20:43.931990 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-07-25 06:20:44.436082 | instance | changed:
2026-07-25 06:20:44.436346 | instance | cd+++++++++ pod-logs/
2026-07-25 06:20:44.436411 | instance | cd+++++++++ pod-logs/failed-pods/
2026-07-25 06:20:44.446174 | 
2026-07-25 06:20:44.446238 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-07-25 06:20:44.641279 | instance | changed
2026-07-25 06:20:44.647877 | 
2026-07-25 06:20:44.647965 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-07-25 06:20:44.860833 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-25 06:20:45.185736 | instance | ok: Runtime: 0:00:00.035889
2026-07-25 06:20:45.191749 | 
2026-07-25 06:20:45.191818 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-07-25 06:20:45.414789 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-25 06:20:45.442057 | instance | ceph-mgr endpoints:
2026-07-25 06:20:45.725905 | instance | ok: Runtime: 0:00:00.033908
2026-07-25 06:20:45.732735 | 
2026-07-25 06:20:45.732832 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-07-25 06:20:45.998018 | instance | /bin/bash: line 4: kubectl: command not found
2026-07-25 06:20:46.270553 | instance | ok: Runtime: 0:00:00.039700
2026-07-25 06:20:46.278205 | 
2026-07-25 06:20:46.278332 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-07-25 06:20:46.767693 | instance | changed: cd+++++++++ prometheus/
2026-07-25 06:20:46.778832 | 
2026-07-25 06:20:46.778905 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-07-25 06:20:46.974724 | instance | changed
2026-07-25 06:20:46.980976 | 
2026-07-25 06:20:46.981076 | TASK [gather-selenium-data : Get selenium data]
2026-07-25 06:20:47.192843 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-07-25 06:20:47.194299 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-07-25 06:20:47.519447 | instance | ERROR
2026-07-25 06:20:47.519681 | instance | {
2026-07-25 06:20:47.519716 | instance |   "delta": "0:00:00.006524",
2026-07-25 06:20:47.519738 | instance |   "end": "2026-07-25 06:20:47.194647",
2026-07-25 06:20:47.519758 | instance |   "msg": "non-zero return code",
2026-07-25 06:20:47.519777 | instance |   "rc": 1,
2026-07-25 06:20:47.519797 | instance |   "start": "2026-07-25 06:20:47.188123"
2026-07-25 06:20:47.519816 | instance | }
2026-07-25 06:20:47.519851 | instance | ERROR: Ignoring Errors
2026-07-25 06:20:47.525204 | 
2026-07-25 06:20:47.525271 | TASK [gather-selenium-data : Downloads logs to executor]
2026-07-25 06:20:48.026555 | instance | changed: cd+++++++++ selenium/
2026-07-25 06:20:48.034896 | 
2026-07-25 06:20:48.034950 | PLAY RECAP
2026-07-25 06:20:48.034998 | instance | ok: 23 changed: 21 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 2
2026-07-25 06:20:48.035021 | 
2026-07-25 06:20:48.186430 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-25 06:20:48.198262 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-25 06:20:48.851808 | 
2026-07-25 06:20:48.851946 | PLAY [all]
2026-07-25 06:20:48.863508 | 
2026-07-25 06:20:48.863638 | TASK [fetch-output : Set log path for multiple nodes]
2026-07-25 06:20:48.908742 | instance | skipping: Conditional result was False
2026-07-25 06:20:48.920332 | 
2026-07-25 06:20:48.920415 | TASK [fetch-output : Set log path for single node]
2026-07-25 06:20:48.964552 | instance | ok
2026-07-25 06:20:48.971257 | 
2026-07-25 06:20:48.971361 | LOOP [fetch-output : Ensure local output dirs]
2026-07-25 06:20:49.350563 | instance -> localhost | ok: "/var/lib/zuul/builds/ecad6995163d4891ab12063f97fac982/work/logs"
2026-07-25 06:20:49.591660 | instance -> localhost | changed: "/var/lib/zuul/builds/ecad6995163d4891ab12063f97fac982/work/artifacts"
2026-07-25 06:20:49.802993 | instance -> localhost | changed: "/var/lib/zuul/builds/ecad6995163d4891ab12063f97fac982/work/docs"
2026-07-25 06:20:49.820615 | 
2026-07-25 06:20:49.820801 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-07-25 06:20:50.447445 | instance | changed: .d..t...... ./
2026-07-25 06:20:50.447698 | instance | changed: All items complete
2026-07-25 06:20:50.447754 | 
2026-07-25 06:20:50.893254 | instance | changed: .d..t...... ./
2026-07-25 06:20:51.340634 | instance | changed: .d..t...... ./
2026-07-25 06:20:51.367072 | 
2026-07-25 06:20:51.367248 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-07-25 06:20:51.792774 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007580
2026-07-25 06:20:52.020346 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008055
2026-07-25 06:20:52.041539 | 
2026-07-25 06:20:52.041931 | PLAY [all]
2026-07-25 06:20:52.048061 | 
2026-07-25 06:20:52.048131 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-07-25 06:20:52.476927 | instance | changed
2026-07-25 06:20:52.484631 | 
2026-07-25 06:20:52.484712 | PLAY RECAP
2026-07-25 06:20:52.484757 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-25 06:20:52.484779 | 
2026-07-25 06:20:52.631931 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-25 06:20:52.644610 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-07-25 06:20:53.278949 | 
2026-07-25 06:20:53.279100 | PLAY [localhost]
2026-07-25 06:20:53.289556 | 
2026-07-25 06:20:53.289653 | TASK [Generate Zuul manifest]
2026-07-25 06:20:53.311590 | localhost | ok
2026-07-25 06:20:53.331450 | 
2026-07-25 06:20:53.331580 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-07-25 06:20:53.726183 | localhost | changed
2026-07-25 06:20:53.739213 | 
2026-07-25 06:20:53.739365 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-07-25 06:20:53.770794 | localhost | ok
2026-07-25 06:20:53.780101 | 
2026-07-25 06:20:53.780187 | TASK [Upload logs]
2026-07-25 06:20:53.802480 | localhost | ok
2026-07-25 06:20:53.900615 | 
2026-07-25 06:20:53.900755 | TASK [Set zuul-log-path fact]
2026-07-25 06:20:53.919212 | localhost | ok
2026-07-25 06:20:53.932711 | 
2026-07-25 06:20:53.932784 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-25 06:20:53.964372 | localhost | ok
2026-07-25 06:20:53.973533 | 
2026-07-25 06:20:53.973623 | TASK [upload-logs : Create log directories]
2026-07-25 06:20:54.366744 | localhost | changed
2026-07-25 06:20:54.373916 | 
2026-07-25 06:20:54.373990 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-07-25 06:20:54.760380 | localhost -> localhost | ok: Runtime: 0:00:00.006394
2026-07-25 06:20:54.766304 | 
2026-07-25 06:20:54.766380 | TASK [upload-logs : Upload logs to log server]
2026-07-25 06:20:55.213152 | localhost | Output suppressed because no_log was given
2026-07-25 06:20:55.218105 | 
2026-07-25 06:20:55.218171 | LOOP [upload-logs : Compress console log and json output]
2026-07-25 06:20:55.271421 | localhost | skipping: Conditional result was False
2026-07-25 06:20:55.280013 | localhost | skipping: Conditional result was False
2026-07-25 06:20:55.291814 | 
2026-07-25 06:20:55.291955 | LOOP [upload-logs : Upload compressed console log and json output]
2026-07-25 06:20:55.333206 | localhost | skipping: Conditional result was False
2026-07-25 06:20:55.333599 | 
2026-07-25 06:20:55.337442 | localhost | skipping: Conditional result was False
2026-07-25 06:20:55.353099 | 
2026-07-25 06:20:55.353303 | LOOP [upload-logs : Upload console log and json output]