2026-07-30 20:50:31.045933 | Job console starting
2026-07-30 20:50:31.054844 | Updating git repos
2026-07-30 20:50:33.748337 | Cloning repos into workspace
2026-07-30 20:51:09.229912 | Restoring repo states
2026-07-30 20:51:19.121463 | Merging changes
2026-07-30 20:51:21.519132 | Checking out repos
2026-07-30 20:51:26.163696 | Preparing playbooks
2026-07-30 20:51:30.837645 | Running Ansible setup
2026-07-30 20:51:35.147500 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-30 20:51:35.835088 | 
2026-07-30 20:51:35.835211 | PLAY [localhost]
2026-07-30 20:51:35.842994 | 
2026-07-30 20:51:35.843069 | TASK [Gathering Facts]
2026-07-30 20:51:36.727367 | localhost | ok
2026-07-30 20:51:36.738295 | 
2026-07-30 20:51:36.738410 | TASK [Setup log path fact]
2026-07-30 20:51:36.759073 | localhost | ok
2026-07-30 20:51:36.771428 | 
2026-07-30 20:51:36.771525 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-30 20:51:36.802221 | localhost | ok
2026-07-30 20:51:36.810376 | 
2026-07-30 20:51:36.810473 | TASK [emit-job-header : Print job information]
2026-07-30 20:51:36.871819 | # Job Information
2026-07-30 20:51:36.872006 | Ansible Version: 2.16.18
2026-07-30 20:51:36.872053 | Job: atmosphere-molecule-aio-openvswitch-selective
2026-07-30 20:51:36.872087 | Pipeline: check
2026-07-30 20:51:36.872117 | Executor: 2d72f0692154
2026-07-30 20:51:36.872146 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4212
2026-07-30 20:51:36.872180 | Event ID: c414c3c0-8c55-11f1-9acc-50866d746316
2026-07-30 20:51:36.876167 | 
2026-07-30 20:51:36.876257 | LOOP [emit-job-header : Print node information]
2026-07-30 20:51:36.969194 | localhost | ok:
2026-07-30 20:51:36.969463 | localhost | # Node Information
2026-07-30 20:51:36.969527 | localhost | Inventory Hostname: instance
2026-07-30 20:51:36.969577 | localhost | Hostname: np0000187650
2026-07-30 20:51:36.969622 | localhost | Username: zuul
2026-07-30 20:51:36.969672 | localhost | Distro: Ubuntu 22.04
2026-07-30 20:51:36.969716 | localhost | Provider: yul1
2026-07-30 20:51:36.969760 | localhost | Region: ca-ymq-1
2026-07-30 20:51:36.969801 | localhost | Label: ubuntu-jammy-16
2026-07-30 20:51:36.969841 | localhost | Product Name: OpenStack Nova
2026-07-30 20:51:36.969883 | localhost | Interface IP: 199.204.45.238
2026-07-30 20:51:36.985050 | 
2026-07-30 20:51:36.985180 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-07-30 20:51:37.466876 | localhost -> localhost | changed
2026-07-30 20:51:37.487909 | 
2026-07-30 20:51:37.487985 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-07-30 20:51:38.629495 | localhost -> localhost | changed
2026-07-30 20:51:38.637991 | 
2026-07-30 20:51:38.638059 | PLAY [all]
2026-07-30 20:51:38.647026 | 
2026-07-30 20:51:38.647120 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-07-30 20:51:38.905352 | instance -> localhost | ok
2026-07-30 20:51:38.915997 | 
2026-07-30 20:51:38.916135 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-07-30 20:51:38.948995 | instance | ok
2026-07-30 20:51:38.964245 | instance | included: /var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-07-30 20:51:38.970599 | 
2026-07-30 20:51:38.970662 | TASK [add-build-sshkey : Create Temp SSH key]
2026-07-30 20:51:41.349216 | instance -> localhost | Generating public/private rsa key pair.
2026-07-30 20:51:41.349389 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/work/0919f3f7a0dd4a6384d52ff72ecd0e5b_id_rsa
2026-07-30 20:51:41.349418 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/work/0919f3f7a0dd4a6384d52ff72ecd0e5b_id_rsa.pub
2026-07-30 20:51:41.349441 | instance -> localhost | The key fingerprint is:
2026-07-30 20:51:41.349463 | instance -> localhost | SHA256:z6GrRLHN2MYmvU0kftqoCYGcLWt26eR5b+lyZ+ttPqw zuul-build-sshkey
2026-07-30 20:51:41.349497 | instance -> localhost | The key's randomart image is:
2026-07-30 20:51:41.349518 | instance -> localhost | +---[RSA 3072]----+
2026-07-30 20:51:41.349542 | instance -> localhost | |                 |
2026-07-30 20:51:41.349564 | instance -> localhost | |                 |
2026-07-30 20:51:41.349584 | instance -> localhost | |      . . .      |
2026-07-30 20:51:41.349605 | instance -> localhost | | . +   @ o       |
2026-07-30 20:51:41.349626 | instance -> localhost | |  = o = S +      |
2026-07-30 20:51:41.349647 | instance -> localhost | |   o + + % .     |
2026-07-30 20:51:41.349667 | instance -> localhost | |  + = . =.=.     |
2026-07-30 20:51:41.349687 | instance -> localhost | | o = +oo+.o.+    |
2026-07-30 20:51:41.349710 | instance -> localhost | |    +.+B++E=o.   |
2026-07-30 20:51:41.349731 | instance -> localhost | +----[SHA256]-----+
2026-07-30 20:51:41.349776 | instance -> localhost | ok: Runtime: 0:00:01.947725
2026-07-30 20:51:41.355015 | 
2026-07-30 20:51:41.355082 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-07-30 20:51:41.389886 | instance | ok
2026-07-30 20:51:41.398409 | instance | included: /var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-07-30 20:51:41.405968 | 
2026-07-30 20:51:41.406035 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-07-30 20:51:41.430927 | instance | skipping: Conditional result was False
2026-07-30 20:51:41.442216 | 
2026-07-30 20:51:41.442363 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-07-30 20:51:41.902156 | instance | changed
2026-07-30 20:51:41.908705 | 
2026-07-30 20:51:41.908810 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-07-30 20:51:42.098268 | instance | ok
2026-07-30 20:51:42.104707 | 
2026-07-30 20:51:42.105105 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-07-30 20:51:42.589087 | instance | changed
2026-07-30 20:51:42.599397 | 
2026-07-30 20:51:42.599471 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-07-30 20:51:43.066504 | instance | changed
2026-07-30 20:51:43.211269 | 
2026-07-30 20:51:43.211480 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-07-30 20:51:43.237065 | instance | skipping: Conditional result was False
2026-07-30 20:51:43.243536 | 
2026-07-30 20:51:43.243737 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-07-30 20:51:43.572228 | instance -> localhost | changed
2026-07-30 20:51:43.588079 | 
2026-07-30 20:51:43.588190 | TASK [add-build-sshkey : Add back temp key]
2026-07-30 20:51:43.865811 | instance -> localhost | Identity added: /var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/work/0919f3f7a0dd4a6384d52ff72ecd0e5b_id_rsa (zuul-build-sshkey)
2026-07-30 20:51:43.866068 | instance -> localhost | ok: Runtime: 0:00:00.014223
2026-07-30 20:51:43.874742 | 
2026-07-30 20:51:43.874812 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-07-30 20:51:44.162659 | instance | ok
2026-07-30 20:51:44.169796 | 
2026-07-30 20:51:44.169909 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-07-30 20:51:44.195081 | instance | skipping: Conditional result was False
2026-07-30 20:51:44.210282 | 
2026-07-30 20:51:44.443190 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-07-30 20:51:44.712668 | instance | ok
2026-07-30 20:51:44.720437 | 
2026-07-30 20:51:44.720533 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-07-30 20:51:47.923930 | instance | Output suppressed because no_log was given
2026-07-30 20:51:47.936731 | 
2026-07-30 20:51:47.936895 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-07-30 20:51:48.119775 | instance | ok: "logs"
2026-07-30 20:51:48.120002 | instance | ok: All items complete
2026-07-30 20:51:48.120030 | 
2026-07-30 20:51:48.264271 | instance | ok: "artifacts"
2026-07-30 20:51:48.425335 | instance | ok: "docs"
2026-07-30 20:51:48.435266 | 
2026-07-30 20:51:48.435359 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-07-30 20:51:48.619688 | instance | changed: "logs"
2026-07-30 20:51:48.893754 | instance | changed: "artifacts"
2026-07-30 20:51:48.915904 | instance | changed: "docs"
2026-07-30 20:51:48.925926 | 
2026-07-30 20:51:48.925974 | PLAY RECAP
2026-07-30 20:51:48.926015 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-07-30 20:51:48.926043 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-30 20:51:48.926064 | 
2026-07-30 20:51:49.282777 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-30 20:51:49.300417 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-30 20:51:49.892200 | 
2026-07-30 20:51:49.915206 | PLAY [all]
2026-07-30 20:51:49.931466 | 
2026-07-30 20:51:49.931550 | TASK [setup-uv : Extract archive]
2026-07-30 20:51:52.028229 | instance | changed
2026-07-30 20:51:52.035296 | 
2026-07-30 20:51:52.035424 | TASK [setup-uv : Print version]
2026-07-30 20:51:52.381206 | instance | uv 0.8.13
2026-07-30 20:51:52.582669 | instance | ok: Runtime: 0:00:00.012193
2026-07-30 20:51:52.593314 | 
2026-07-30 20:51:52.593382 | TASK [Install Ansible collection siblings]
2026-07-30 20:52:01.296985 | instance | changed:
2026-07-30 20:52:01.297194 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-07-30 20:52:01.297230 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-07-30 20:52:01.297254 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-07-30 20:52:01.297274 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-07-30 20:52:01.297294 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-07-30 20:52:01.297318 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-07-30 20:52:01.297339 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-07-30 20:52:01.297361 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-07-30 20:52:01.297383 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-07-30 20:52:01.297412 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-07-30 20:52:01.297434 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-07-30 20:52:01.297453 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-07-30 20:52:01.297472 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-07-30 20:52:01.297491 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-07-30 20:52:01.297509 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0
2026-07-30 20:52:01.297528 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-07-30 20:52:01.297546 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-07-30 20:52:01.297565 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-07-30 20:52:01.297583 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-07-30 20:52:01.297606 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-07-30 20:52:01.297632 | instance | Resolved vexxhost.ceph to v4.1.0 for >=3.2.0
2026-07-30 20:52:01.297657 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-07-30 20:52:01.297679 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-30 20:52:01.297711 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-07-30 20:52:01.297731 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0,>=6.0.0
2026-07-30 20:52:01.297749 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-30 20:52:01.297768 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-30 20:52:01.297786 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-30 20:52:01.297804 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-07-30 20:52:01.297821 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-07-30 20:52:01.297839 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-30 20:52:01.297858 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-30 20:52:01.297980 | instance | Checked out ansible.netcommon to 1.2.0
2026-07-30 20:52:01.298019 | 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-30 20:52:01.298047 | instance | Starting galaxy collection install process
2026-07-30 20:52:01.298067 | instance | Process install dependency map
2026-07-30 20:52:01.298087 | instance | Starting collection install process
2026-07-30 20:52:01.298105 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-07-30 20:52:01.298124 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-07-30 20:52:01.298143 | instance | ansible.netcommon:* was installed successfully
2026-07-30 20:52:01.298161 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-07-30 20:52:01.298179 | instance | Creating virtual environment at: .venv
2026-07-30 20:52:01.298198 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-30 20:52:01.298216 | instance | Downloading setuptools (1.1MiB)
2026-07-30 20:52:01.298234 | instance | Downloading rjsonnet (1.2MiB)
2026-07-30 20:52:01.298260 | instance | Downloading kubernetes (1.9MiB)
2026-07-30 20:52:01.298279 | instance | Downloading cryptography (4.2MiB)
2026-07-30 20:52:01.298297 | instance | Downloading pygments (1.2MiB)
2026-07-30 20:52:01.298316 | instance | Downloading netaddr (2.2MiB)
2026-07-30 20:52:01.298335 | instance | Downloading ansible-core (2.1MiB)
2026-07-30 20:52:01.298361 | instance | Downloading openstacksdk (1.7MiB)
2026-07-30 20:52:01.298385 | instance | Downloading pydantic-core (2.0MiB)
2026-07-30 20:52:01.298411 | instance |    Building pyperclip==1.9.0
2026-07-30 20:52:01.298436 | instance |  Downloading rjsonnet
2026-07-30 20:52:01.298456 | instance |  Downloading pydantic-core
2026-07-30 20:52:01.298476 | instance |  Downloading netaddr
2026-07-30 20:52:01.298495 | instance |  Downloading pygments
2026-07-30 20:52:01.298513 | instance |  Downloading cryptography
2026-07-30 20:52:01.298531 | instance |  Downloading setuptools
2026-07-30 20:52:01.298550 | instance |  Downloading kubernetes
2026-07-30 20:52:01.298568 | instance |  Downloading ansible-core
2026-07-30 20:52:01.298586 | instance |  Downloading openstacksdk
2026-07-30 20:52:01.298605 | instance |       Built pyperclip==1.9.0
2026-07-30 20:52:01.298623 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-30 20:52:01.298641 | instance | Installed 87 packages in 38ms
2026-07-30 20:52:01.298659 | instance | Checked out ansible.posix to 1.6.0
2026-07-30 20:52:01.298677 | 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-30 20:52:01.298696 | instance | Starting galaxy collection install process
2026-07-30 20:52:01.298718 | instance | Process install dependency map
2026-07-30 20:52:01.298748 | instance | Starting collection install process
2026-07-30 20:52:01.298770 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-07-30 20:52:01.298789 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-07-30 20:52:01.298808 | instance | ansible.posix:1.6.0 was installed successfully
2026-07-30 20:52:01.298827 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-30 20:52:01.298845 | instance | 2.17.12
2026-07-30 20:52:01.298863 | instance | Checked out ansible.utils to v6.0.3
2026-07-30 20:52:01.298881 | 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-30 20:52:01.298899 | instance | Starting galaxy collection install process
2026-07-30 20:52:01.298918 | instance | Process install dependency map
2026-07-30 20:52:01.298991 | instance | Starting collection install process
2026-07-30 20:52:01.299017 | instance | Installing 'ansible.utils:6.0.3' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-07-30 20:52:01.299038 | instance | Created collection for ansible.utils:6.0.3 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-07-30 20:52:01.299056 | instance | ansible.utils:6.0.3 was installed successfully
2026-07-30 20:52:01.299075 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-30 20:52:01.299093 | instance | 2.17.12
2026-07-30 20:52:01.299112 | instance | Checked out atmosphere.common to v0.7.0
2026-07-30 20:52:01.299145 | 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-30 20:52:01.299164 | instance | Starting galaxy collection install process
2026-07-30 20:52:01.299182 | instance | Process install dependency map
2026-07-30 20:52:01.299200 | instance | Starting collection install process
2026-07-30 20:52:01.299219 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-07-30 20:52:01.299237 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-07-30 20:52:01.299255 | instance | atmosphere.common:0.7.0 was installed successfully
2026-07-30 20:52:01.299273 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-30 20:52:01.299293 | instance | 2.17.12
2026-07-30 20:52:01.299311 | instance | Checked out community.crypto to 2.2.3
2026-07-30 20:52:01.299329 | 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-30 20:52:01.299347 | instance | Starting galaxy collection install process
2026-07-30 20:52:01.299365 | instance | Process install dependency map
2026-07-30 20:52:01.299383 | instance | Starting collection install process
2026-07-30 20:52:01.299402 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-07-30 20:52:01.299420 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-07-30 20:52:01.299438 | instance | community.crypto:2.2.3 was installed successfully
2026-07-30 20:52:01.299456 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-30 20:52:01.299475 | instance | 2.17.12
2026-07-30 20:52:01.299502 | instance | Checked out community.general to 7.3.0
2026-07-30 20:52:01.299530 | 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-30 20:52:01.299568 | instance | Starting galaxy collection install process
2026-07-30 20:52:01.299600 | instance | Process install dependency map
2026-07-30 20:52:01.299631 | instance | Starting collection install process
2026-07-30 20:52:01.299652 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-07-30 20:52:01.299671 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-07-30 20:52:01.299690 | instance | community.general:7.3.0 was installed successfully
2026-07-30 20:52:01.299709 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-30 20:52:01.299728 | instance | 2.17.12
2026-07-30 20:52:01.299747 | instance | Checked out community.mysql to 3.6.0
2026-07-30 20:52:01.299768 | 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-30 20:52:01.299787 | instance | Starting galaxy collection install process
2026-07-30 20:52:01.299805 | instance | Process install dependency map
2026-07-30 20:52:01.299824 | instance | Starting collection install process
2026-07-30 20:52:01.299843 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-07-30 20:52:01.299861 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-07-30 20:52:01.299879 | instance | community.mysql:3.6.0 was installed successfully
2026-07-30 20:52:01.299898 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-30 20:52:01.299915 | instance | 2.17.12
2026-07-30 20:52:01.299934 | instance | Checked out kubernetes.core to 2.4.0
2026-07-30 20:52:01.299953 | 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-30 20:52:01.299971 | instance | Starting galaxy collection install process
2026-07-30 20:52:01.299989 | instance | Process install dependency map
2026-07-30 20:52:01.300008 | instance | Starting collection install process
2026-07-30 20:52:01.300027 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-07-30 20:52:01.300046 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-07-30 20:52:01.300069 | instance | kubernetes.core:2.4.0 was installed successfully
2026-07-30 20:52:01.300096 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-30 20:52:01.300128 | instance | 2.17.12
2026-07-30 20:52:01.300158 | instance | Checked out openstack.cloud to 2.6.0
2026-07-30 20:52:01.300184 | 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-30 20:52:01.300208 | instance | Starting galaxy collection install process
2026-07-30 20:52:01.300234 | instance | Process install dependency map
2026-07-30 20:52:01.300253 | instance | Starting collection install process
2026-07-30 20:52:01.300272 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-07-30 20:52:01.300290 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-07-30 20:52:01.300308 | instance | openstack.cloud:2.6.0 was installed successfully
2026-07-30 20:52:01.300326 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-30 20:52:01.300344 | instance | 2.17.12
2026-07-30 20:52:01.300370 | instance | Checked out vexxhost.ceph to v4.1.0
2026-07-30 20:52:01.300389 | 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-30 20:52:01.300408 | instance | Starting galaxy collection install process
2026-07-30 20:52:01.300426 | instance | Process install dependency map
2026-07-30 20:52:01.300444 | instance | Starting collection install process
2026-07-30 20:52:01.300462 | instance | Installing 'vexxhost.ceph:4.1.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-07-30 20:52:01.300481 | instance | Created collection for vexxhost.ceph:4.1.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-07-30 20:52:01.300499 | instance | vexxhost.ceph:4.1.0 was installed successfully
2026-07-30 20:52:01.300517 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-30 20:52:01.300535 | instance | 2.17.12
2026-07-30 20:52:01.300561 | instance | Checked out vexxhost.containers to v1.6.8
2026-07-30 20:52:01.300582 | 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-30 20:52:01.300601 | instance | Starting galaxy collection install process
2026-07-30 20:52:01.300619 | instance | Process install dependency map
2026-07-30 20:52:01.300637 | instance | Starting collection install process
2026-07-30 20:52:01.300655 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-07-30 20:52:01.300673 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-07-30 20:52:01.300692 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-07-30 20:52:01.300710 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-30 20:52:01.300728 | instance | 2.17.12
2026-07-30 20:52:01.300752 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-07-30 20:52:01.300778 | 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-30 20:52:01.300806 | instance | Starting galaxy collection install process
2026-07-30 20:52:01.300835 | instance | Process install dependency map
2026-07-30 20:52:01.300864 | instance | Starting collection install process
2026-07-30 20:52:01.300967 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-07-30 20:52:01.301007 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-07-30 20:52:01.301029 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-07-30 20:52:01.301048 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-30 20:52:01.301067 | instance | 2.17.12
2026-07-30 20:52:01.307608 | 
2026-07-30 20:52:01.307658 | PLAY RECAP
2026-07-30 20:52:01.307705 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-30 20:52:01.307727 | 
2026-07-30 20:52:01.432336 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-30 20:52:01.444912 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-30 20:52:02.168469 | 
2026-07-30 20:52:02.168600 | PLAY [all]
2026-07-30 20:52:02.180429 | 
2026-07-30 20:52:02.180518 | TASK [Install "jq" for log collection]
2026-07-30 20:52:18.578410 | instance | changed
2026-07-30 20:52:18.580945 | 
2026-07-30 20:52:18.581047 | PLAY RECAP
2026-07-30 20:52:18.581133 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-30 20:52:18.581203 | 
2026-07-30 20:52:18.713709 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-30 20:52:18.726515 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-30 20:52:19.397227 | 
2026-07-30 20:52:19.480811 | PLAY [Prepare selective Molecule plan]
2026-07-30 20:52:19.514387 | 
2026-07-30 20:52:19.514654 | TASK [Generate selective Molecule plan]
2026-07-30 20:52:20.557531 | instance | ok: Runtime: 0:00:00.183513
2026-07-30 20:52:20.562631 | 
2026-07-30 20:52:20.562717 | TASK [Render selective Molecule plan]
2026-07-30 20:52:20.832766 | instance | Selective Molecule plan: selective
2026-07-30 20:52:20.833034 | instance | Changed files:
2026-07-30 20:52:20.833048 | instance |   A roles/lpfc/SELECTIVE_CI_VALIDATION.md
2026-07-30 20:52:20.833058 | instance | Targets: lpfc
2026-07-30 20:52:20.833068 | instance | Job decisions:
2026-07-30 20:52:20.833080 | instance |   RUN  aio-openvswitch: selected by changed components
2026-07-30 20:52:20.833096 | instance |        components: lpfc
2026-07-30 20:52:20.833108 | instance |   SKIP aio-ovn: no changed component requires this job
2026-07-30 20:52:20.833121 | instance |   SKIP csi-local-path-provisioner: no changed component requires this job
2026-07-30 20:52:20.833130 | instance |   SKIP csi-rbd: no changed component requires this job
2026-07-30 20:52:20.833139 | instance |   SKIP keycloak: no changed component requires this job
2026-07-30 20:52:21.096508 | instance | ok: Runtime: 0:00:00.098493
2026-07-30 20:52:21.098294 | 
2026-07-30 20:52:21.098347 | PLAY RECAP
2026-07-30 20:52:21.098394 | instance | ok: 2 changed: 0 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-30 20:52:21.098416 | 
2026-07-30 20:52:21.278748 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-30 20:52:21.292704 | RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-30 20:52:21.932263 | 
2026-07-30 20:52:22.045420 | PLAY [Run selected Molecule scenario]
2026-07-30 20:52:22.063126 | 
2026-07-30 20:52:22.063211 | TASK [Read selective Molecule plan]
2026-07-30 20:52:22.358169 | instance | ok
2026-07-30 20:52:22.362979 | 
2026-07-30 20:52:22.363056 | TASK [Resolve this job decision]
2026-07-30 20:52:22.414293 | instance | ok
2026-07-30 20:52:22.421370 | 
2026-07-30 20:52:22.421433 | TASK [Assert this job exists in the plan]
2026-07-30 20:52:22.453559 | instance | ok: All assertions passed
2026-07-30 20:52:22.465647 | 
2026-07-30 20:52:22.465926 | TASK [Resolve selected scenario inputs]
2026-07-30 20:52:22.500819 | instance | ok
2026-07-30 20:52:22.505901 | 
2026-07-30 20:52:22.506017 | TASK [Report this job decision]
2026-07-30 20:52:22.554068 | instance | ok:
2026-07-30 20:52:22.554211 | instance | Selective Molecule job: aio-openvswitch
2026-07-30 20:52:22.554239 | instance | Decision: RUN
2026-07-30 20:52:22.554264 | instance | Reason: selected by changed components
2026-07-30 20:52:22.554289 | instance | Scenario: aio
2026-07-30 20:52:22.554309 | instance | Targets: lpfc
2026-07-30 20:52:22.554329 | instance | Components: lpfc
2026-07-30 20:52:22.560659 | 
2026-07-30 20:52:22.560752 | LOOP [Check Molecule inventory directories]
2026-07-30 20:52:22.889324 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-07-30 20:52:23.030813 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/aio/inventory"
2026-07-30 20:52:23.185100 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/aio/inventory"
2026-07-30 20:52:23.198438 | 
2026-07-30 20:52:23.198631 | LOOP [Copy Zuul inventory for Molecule]
2026-07-30 20:52:23.756483 | instance | changed:
2026-07-30 20:52:23.756665 | instance | {
2026-07-30 20:52:23.756693 | instance |   "ansible_loop_var": "item",
2026-07-30 20:52:23.756715 | instance |   "changed": false,
2026-07-30 20:52:23.756749 | instance |   "failed": false,
2026-07-30 20:52:23.756770 | instance |   "invocation": {
2026-07-30 20:52:23.756789 | instance |     "module_args": {
2026-07-30 20:52:23.756810 | instance |       "checksum_algorithm": "sha1",
2026-07-30 20:52:23.756831 | instance |       "follow": true,
2026-07-30 20:52:23.756849 | instance |       "get_attributes": true,
2026-07-30 20:52:23.756867 | instance |       "get_checksum": true,
2026-07-30 20:52:23.756885 | instance |       "get_mime": true,
2026-07-30 20:52:23.756903 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-07-30 20:52:23.756922 | instance |     }
2026-07-30 20:52:23.756941 | instance |   },
2026-07-30 20:52:23.756978 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-07-30 20:52:23.756998 | instance |   "stat": {
2026-07-30 20:52:23.757016 | instance |     "atime": 1785444740.7896788,
2026-07-30 20:52:23.757034 | instance |     "attr_flags": "e",
2026-07-30 20:52:23.757051 | instance |     "attributes": [
2026-07-30 20:52:23.757069 | instance |       "extents"
2026-07-30 20:52:23.757087 | instance |     ],
2026-07-30 20:52:23.757104 | instance |     "block_size": 4096,
2026-07-30 20:52:23.757122 | instance |     "blocks": 8,
2026-07-30 20:52:23.757139 | instance |     "charset": "unknown",
2026-07-30 20:52:23.757156 | instance |     "ctime": 1785444740.0376682,
2026-07-30 20:52:23.757174 | instance |     "dev": 64513,
2026-07-30 20:52:23.757192 | instance |     "device_type": 0,
2026-07-30 20:52:23.757210 | instance |     "executable": true,
2026-07-30 20:52:23.757228 | instance |     "exists": true,
2026-07-30 20:52:23.757246 | instance |     "gid": 1000,
2026-07-30 20:52:23.757263 | instance |     "gr_name": "zuul",
2026-07-30 20:52:23.757281 | instance |     "inode": 1048193,
2026-07-30 20:52:23.757298 | instance |     "isblk": false,
2026-07-30 20:52:23.757316 | instance |     "ischr": false,
2026-07-30 20:52:23.757335 | instance |     "isdir": true,
2026-07-30 20:52:23.757354 | instance |     "isfifo": false,
2026-07-30 20:52:23.757372 | instance |     "isgid": false,
2026-07-30 20:52:23.757389 | instance |     "islnk": false,
2026-07-30 20:52:23.757406 | instance |     "isreg": false,
2026-07-30 20:52:23.757424 | instance |     "issock": false,
2026-07-30 20:52:23.757441 | instance |     "isuid": false,
2026-07-30 20:52:23.757459 | instance |     "mimetype": "unknown",
2026-07-30 20:52:23.757477 | instance |     "mode": "0755",
2026-07-30 20:52:23.757495 | instance |     "mtime": 1785444740.0376682,
2026-07-30 20:52:23.757512 | instance |     "nlink": 25,
2026-07-30 20:52:23.757529 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-07-30 20:52:23.757546 | instance |     "pw_name": "zuul",
2026-07-30 20:52:23.757564 | instance |     "readable": true,
2026-07-30 20:52:23.757581 | instance |     "rgrp": true,
2026-07-30 20:52:23.757598 | instance |     "roth": true,
2026-07-30 20:52:23.757615 | instance |     "rusr": true,
2026-07-30 20:52:23.757632 | instance |     "size": 4096,
2026-07-30 20:52:23.757649 | instance |     "uid": 1000,
2026-07-30 20:52:23.757666 | instance |     "version": "760234363",
2026-07-30 20:52:23.757684 | instance |     "wgrp": false,
2026-07-30 20:52:23.757701 | instance |     "woth": false,
2026-07-30 20:52:23.757718 | instance |     "writeable": true,
2026-07-30 20:52:23.757735 | instance |     "wusr": true,
2026-07-30 20:52:23.757752 | instance |     "xgrp": true,
2026-07-30 20:52:23.757769 | instance |     "xoth": true,
2026-07-30 20:52:23.757788 | instance |     "xusr": true
2026-07-30 20:52:23.757809 | instance |   }
2026-07-30 20:52:23.757827 | instance | }
2026-07-30 20:52:23.757860 | instance | ok: All items complete
2026-07-30 20:52:23.757881 | 
2026-07-30 20:52:23.759632 | instance | skipping: Conditional result was False
2026-07-30 20:52:23.766098 | instance | skipping: Conditional result was False
2026-07-30 20:52:23.784025 | 
2026-07-30 20:52:23.784215 | LOOP [Use private addresses in Molecule inventory]
2026-07-30 20:52:24.138177 | instance | changed: 1 replacements made
2026-07-30 20:52:24.210800 | instance | skipping: Conditional result was False
2026-07-30 20:52:24.211928 | instance | skipping: Conditional result was False
2026-07-30 20:52:24.228671 | 
2026-07-30 20:52:24.229228 | TASK [Prepare Molecule command]
2026-07-30 20:52:24.292216 | instance | ok
2026-07-30 20:52:24.297207 | 
2026-07-30 20:52:24.297274 | TASK [Run standard Molecule lifecycle with progress output]
2026-07-30 20:52:24.349615 | instance | ok
2026-07-30 20:52:24.399040 | instance | included: /var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/run-command.yml
2026-07-30 20:52:24.404464 | 
2026-07-30 20:52:24.404524 | TASK [Create Molecule log directory]
2026-07-30 20:52:24.680616 | instance | changed
2026-07-30 20:52:25.024579 | 
2026-07-30 20:52:25.024655 | TASK [Resolve live Molecule log path]
2026-07-30 20:52:25.058020 | instance | ok
2026-07-30 20:52:25.069042 | 
2026-07-30 20:52:25.069121 | TASK [Start Molecule aio (aio-openvswitch)]
2026-07-30 20:52:25.686448 | instance | ok: ERROR (ignored)
2026-07-30 20:52:25.729510 | instance | {
2026-07-30 20:52:25.729602 | instance |   "ansible_job_id": "j531464517711.1597",
2026-07-30 20:52:25.729637 | instance |   "finished": 0,
2026-07-30 20:52:25.729665 | instance |   "results_file": "/home/zuul/.ansible_async/j531464517711.1597",
2026-07-30 20:52:25.729691 | instance |   "started": 1
2026-07-30 20:52:25.729716 | instance | }
2026-07-30 20:52:25.738565 | 
2026-07-30 20:52:25.738661 | TASK [Initialize progress monitor for Molecule aio (aio-openvswitch)]
2026-07-30 20:52:25.789303 | instance | ok
2026-07-30 20:52:25.796120 | 
2026-07-30 20:52:25.796190 | TASK [Bound progress monitor recursion for Molecule aio (aio-openvswitch)]
2026-07-30 20:52:25.825430 | instance | ok
2026-07-30 20:52:25.832616 | 
2026-07-30 20:52:25.832689 | TASK [Calculate progress monitor chunks for Molecule aio (aio-openvswitch)]
2026-07-30 20:52:25.888870 | instance | ok
2026-07-30 20:52:25.897532 | 
2026-07-30 20:52:25.897604 | LOOP [Monitor Molecule aio (aio-openvswitch)]
2026-07-30 20:52:25.962749 | instance | ok: 1
2026-07-30 20:52:25.962997 | instance | changed: All items complete
2026-07-30 20:52:25.963031 | 
2026-07-30 20:52:25.967703 | instance | ok: 2
2026-07-30 20:52:25.980587 | instance | ok: 3
2026-07-30 20:52:25.985626 | instance | ok: 4
2026-07-30 20:52:25.989699 | instance | ok: 5
2026-07-30 20:52:26.008612 | instance | included: /var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-chunk.yml
2026-07-30 20:52:26.011513 | instance | included: /var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-chunk.yml
2026-07-30 20:52:26.012507 | instance | included: /var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-chunk.yml
2026-07-30 20:52:26.013392 | instance | included: /var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-chunk.yml
2026-07-30 20:52:26.014506 | instance | included: /var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-chunk.yml
2026-07-30 20:52:26.022667 | 
2026-07-30 20:52:26.022738 | TASK [Start progress monitor chunk for Molecule aio (aio-openvswitch)]
2026-07-30 20:52:26.088912 | instance | ok
2026-07-30 20:52:26.102138 | instance | included: /var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-command.yml
2026-07-30 20:52:26.108895 | 
2026-07-30 20:52:26.108995 | TASK [Wait before polling Molecule aio (aio-openvswitch)]
2026-07-30 20:52:46.176216 | instance | ok
2026-07-30 20:52:46.182801 | 
2026-07-30 20:52:46.182873 | TASK [Count progress poll for Molecule aio (aio-openvswitch)]
2026-07-30 20:52:46.247956 | instance | ok
2026-07-30 20:52:46.259148 | 
2026-07-30 20:52:46.259284 | TASK [Poll status for Molecule aio (aio-openvswitch)]
2026-07-30 20:52:46.639492 | instance | ok
2026-07-30 20:52:46.661648 | 
2026-07-30 20:52:46.662320 | TASK [Inspect live log for Molecule aio (aio-openvswitch)]
2026-07-30 20:52:46.856282 | instance | ok
2026-07-30 20:52:46.863166 | 
2026-07-30 20:52:46.863239 | TASK [Calculate new output for Molecule aio (aio-openvswitch)]
2026-07-30 20:52:46.919934 | instance | ok
2026-07-30 20:52:46.932700 | 
2026-07-30 20:52:46.932907 | TASK [Read new output for Molecule aio (aio-openvswitch)]
2026-07-30 20:52:47.149499 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-07-30 20:52:47.149697 | instance | INFO     [aio > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-07-30 20:52:47.149718 | instance | INFO     [aio > prerun] Performing prerun with role_name_check=0...
2026-07-30 20:52:47.149728 | instance | INFO     [aio > dependency] Executing
2026-07-30 20:52:47.149738 | instance | WARNING  [aio > dependency] Missing roles requirements file: requirements.yml
2026-07-30 20:52:47.149748 | instance | WARNING  [aio > dependency] Missing collections requirements file: collections.yml
2026-07-30 20:52:47.149760 | instance | WARNING  [aio > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-07-30 20:52:47.149769 | instance | INFO     [aio > cleanup] Executing
2026-07-30 20:52:47.149778 | instance | WARNING  [aio > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-07-30 20:52:47.149787 | instance | INFO     [aio > destroy] Executing
2026-07-30 20:52:47.149796 | instance | WARNING  [aio > destroy] Skipping, '--destroy=never' requested.
2026-07-30 20:52:47.149805 | instance | INFO     [aio > destroy] Executed: Successful
2026-07-30 20:52:47.149813 | instance | INFO     [aio > syntax] Executing
2026-07-30 20:52:47.149822 | instance |
2026-07-30 20:52:47.149835 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/aio/converge.yml
2026-07-30 20:52:47.149845 | instance | INFO     [aio > syntax] Executed: Successful
2026-07-30 20:52:47.149853 | instance | INFO     [aio > create] Executing
2026-07-30 20:52:47.149862 | instance | WARNING  [aio > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-07-30 20:52:47.149871 | instance | INFO     [aio > prepare] Executing
2026-07-30 20:52:47.149879 | instance |
2026-07-30 20:52:47.149888 | instance | PLAY [Prepare] *****************************************************************
2026-07-30 20:52:47.149897 | instance |
2026-07-30 20:52:47.149906 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:52:47.149926 | instance | Thursday 30 July 2026  20:52:41 +0000 (0:00:00.024)       0:00:00.024 *********
2026-07-30 20:52:47.149941 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-07-30 20:52:47.150001 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-07-30 20:52:47.150013 | instance | interpreter could change the meaning of that path. See
2026-07-30 20:52:47.150022 | instance | https://docs.ansible.com/ansible-
2026-07-30 20:52:47.150030 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-07-30 20:52:47.150039 | instance | ok: [instance]
2026-07-30 20:52:47.150048 | instance |
2026-07-30 20:52:47.150057 | instance | TASK [Configure short hostname] ************************************************
2026-07-30 20:52:47.150065 | instance | Thursday 30 July 2026  20:52:42 +0000 (0:00:01.083)       0:00:01.108 *********
2026-07-30 20:52:47.150074 | instance | changed: [instance]
2026-07-30 20:52:47.150083 | instance |
2026-07-30 20:52:47.150091 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-07-30 20:52:47.150100 | instance | Thursday 30 July 2026  20:52:42 +0000 (0:00:00.638)       0:00:01.747 *********
2026-07-30 20:52:47.150108 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-07-30 20:52:47.150117 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-07-30 20:52:47.150126 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-07-30 20:52:47.150134 | instance | changed: [instance]
2026-07-30 20:52:47.150143 | instance |
2026-07-30 20:52:47.150151 | instance | TASK [Install "dirmngr" for GPG keyserver operations] **************************
2026-07-30 20:52:47.150160 | instance | Thursday 30 July 2026  20:52:43 +0000 (0:00:00.247)       0:00:01.994 *********
2026-07-30 20:52:47.150169 | instance | ok: [instance]
2026-07-30 20:52:47.150177 | instance |
2026-07-30 20:52:47.150186 | instance | TASK [Purge "snapd" package] ***************************************************
2026-07-30 20:52:47.150194 | instance | Thursday 30 July 2026  20:52:44 +0000 (0:00:01.061)       0:00:03.055 *********
2026-07-30 20:52:47.150203 | instance | ok: [instance]
2026-07-30 20:52:47.150221 | instance |
2026-07-30 20:52:47.150230 | instance | PLAY [Generate workspace for Atmosphere] ***************************************
2026-07-30 20:52:47.150238 | instance |
2026-07-30 20:52:47.150247 | instance | TASK [Create folders for workspace] ********************************************
2026-07-30 20:52:47.150256 | instance | Thursday 30 July 2026  20:52:44 +0000 (0:00:00.628)       0:00:03.683 *********
2026-07-30 20:52:47.150264 | instance | changed: [localhost] => (item=group_vars)
2026-07-30 20:52:47.150273 | instance | changed: [localhost] => (item=group_vars/all)
2026-07-30 20:52:47.150282 | instance | changed: [localhost] => (item=group_vars/controllers)
2026-07-30 20:52:47.150291 | instance | changed: [localhost] => (item=group_vars/cephs)
2026-07-30 20:52:47.150299 | instance | changed: [localhost] => (item=group_vars/computes)
2026-07-30 20:52:47.150308 | instance | changed: [localhost] => (item=host_vars)
2026-07-30 20:52:47.150317 | instance |
2026-07-30 20:52:47.150325 | instance | PLAY [Generate Ceph control plane configuration for workspace] *****************
2026-07-30 20:52:47.150334 | instance |
2026-07-30 20:52:47.150342 | instance | TASK [Ensure the Ceph control plane configuration file exists] *****************
2026-07-30 20:52:47.150351 | instance | Thursday 30 July 2026  20:52:46 +0000 (0:00:01.314)       0:00:04.998 *********
2026-07-30 20:52:47.150360 | instance | changed: [localhost]
2026-07-30 20:52:47.150368 | instance |
2026-07-30 20:52:47.150377 | instance | TASK [Load the current Ceph control plane configuration into a variable] *******
2026-07-30 20:52:47.150386 | instance | Thursday 30 July 2026  20:52:46 +0000 (0:00:00.264)       0:00:05.263 *********
2026-07-30 20:52:47.150394 | instance | ok: [localhost]
2026-07-30 20:52:47.150403 | instance |
2026-07-30 20:52:47.150411 | instance | TASK [Generate Ceph control plane values for missing variables] ****************
2026-07-30 20:52:47.150420 | instance | Thursday 30 July 2026  20:52:46 +0000 (0:00:00.022)       0:00:05.286 *********
2026-07-30 20:52:47.150429 | instance | ok: [localhost] => (item={'key': 'ceph_fsid', 'value': '4e609b0a-b62e-5fa6-8c42-e46cf3398e4f'})
2026-07-30 20:52:47.150437 | instance | ok: [localhost] => (item={'key': 'ceph_mon_public_network', 'value': '10.96.240.0/24'})
2026-07-30 20:52:47.150446 | instance |
2026-07-30 20:52:47.150462 | instance | TASK [Write new Ceph control plane configuration file to disk] *****************
2026-07-30 20:52:47.150471 | instance | Thursday 30 July 2026  20:52:46 +0000 (0:00:00.042)       0:00:05.328 *********
2026-07-30 20:52:47.476723 | instance | ok: Runtime: 0:00:00.008018
2026-07-30 20:52:47.485330 | 
2026-07-30 20:52:47.485473 | TASK [Track last task for Molecule aio (aio-openvswitch)]
2026-07-30 20:52:47.560764 | instance | ok
2026-07-30 20:52:47.576577 | 
2026-07-30 20:52:47.576799 | TASK [Advance live log offset for Molecule aio (aio-openvswitch)]
2026-07-30 20:52:47.633531 | instance | ok
2026-07-30 20:52:47.652055 | 
2026-07-30 20:52:47.652287 | TASK [Report progress heartbeat for Molecule aio (aio-openvswitch)]
2026-07-30 20:52:47.715732 | instance | ok:
2026-07-30 20:52:47.715899 | instance | Molecule aio (aio-openvswitch) is still running after 20 seconds.
2026-07-30 20:52:47.715929 | instance | Last task: TASK [Write new Ceph control plane configuration file to disk]
2026-07-30 20:52:47.725143 | 
2026-07-30 20:52:47.725230 | TASK [Continue monitoring Molecule aio (aio-openvswitch)]
2026-07-30 20:52:47.798299 | instance | ok
2026-07-30 20:52:47.816408 | instance | included: /var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-command.yml
2026-07-30 20:52:47.831286 | 
2026-07-30 20:52:47.831384 | TASK [Wait before polling Molecule aio (aio-openvswitch)]
2026-07-30 20:53:07.908269 | instance | ok
2026-07-30 20:53:07.914391 | 
2026-07-30 20:53:07.914464 | TASK [Count progress poll for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:07.967210 | instance | ok
2026-07-30 20:53:07.974289 | 
2026-07-30 20:53:07.974358 | TASK [Poll status for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:08.212084 | instance | ok
2026-07-30 20:53:08.218635 | 
2026-07-30 20:53:08.218711 | TASK [Inspect live log for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:08.407018 | instance | ok
2026-07-30 20:53:08.414300 | 
2026-07-30 20:53:08.414369 | TASK [Calculate new output for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:08.469485 | instance | ok
2026-07-30 20:53:08.477620 | 
2026-07-30 20:53:08.477698 | TASK [Read new output for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:08.726622 | instance | changed: [localhost]
2026-07-30 20:53:08.726806 | instance |
2026-07-30 20:53:08.726821 | instance | PLAY [Generate Ceph OSD configuration for workspace] ***************************
2026-07-30 20:53:08.726831 | instance |
2026-07-30 20:53:08.726844 | instance | TASK [Ensure the Ceph OSDs configuration file exists] **************************
2026-07-30 20:53:08.726856 | instance | Thursday 30 July 2026  20:52:47 +0000 (0:00:00.624)       0:00:05.952 *********
2026-07-30 20:53:08.726869 | instance | changed: [localhost]
2026-07-30 20:53:08.726878 | instance |
2026-07-30 20:53:08.726887 | instance | TASK [Load the current Ceph OSDs configuration into a variable] ****************
2026-07-30 20:53:08.726897 | instance | Thursday 30 July 2026  20:52:47 +0000 (0:00:00.218)       0:00:06.171 *********
2026-07-30 20:53:08.726907 | instance | ok: [localhost]
2026-07-30 20:53:08.726916 | instance |
2026-07-30 20:53:08.726925 | instance | TASK [Generate Ceph OSDs values for missing variables] *************************
2026-07-30 20:53:08.726934 | instance | Thursday 30 July 2026  20:52:47 +0000 (0:00:00.023)       0:00:06.195 *********
2026-07-30 20:53:08.726943 | instance | ok: [localhost] => (item={'key': 'ceph_osd_devices', 'value': ['/dev/vdb', '/dev/vdc', '/dev/vdd']})
2026-07-30 20:53:08.726953 | instance |
2026-07-30 20:53:08.726962 | instance | TASK [Write new Ceph OSDs configuration file to disk] **************************
2026-07-30 20:53:08.726971 | instance | Thursday 30 July 2026  20:52:47 +0000 (0:00:00.029)       0:00:06.225 *********
2026-07-30 20:53:08.726979 | instance | changed: [localhost]
2026-07-30 20:53:08.726988 | instance |
2026-07-30 20:53:08.726997 | instance | PLAY [Generate Kubernetes configuration for workspace] *************************
2026-07-30 20:53:08.727006 | instance |
2026-07-30 20:53:08.727018 | instance | TASK [Ensure the Kubernetes configuration file exists] *************************
2026-07-30 20:53:08.727027 | instance | Thursday 30 July 2026  20:52:47 +0000 (0:00:00.440)       0:00:06.665 *********
2026-07-30 20:53:08.727036 | instance | changed: [localhost]
2026-07-30 20:53:08.727045 | instance |
2026-07-30 20:53:08.727054 | instance | TASK [Load the current Kubernetes configuration into a variable] ***************
2026-07-30 20:53:08.727063 | instance | Thursday 30 July 2026  20:52:48 +0000 (0:00:00.221)       0:00:06.886 *********
2026-07-30 20:53:08.727071 | instance | ok: [localhost]
2026-07-30 20:53:08.727080 | instance |
2026-07-30 20:53:08.727089 | instance | TASK [Generate Kubernetes values for missing variables] ************************
2026-07-30 20:53:08.727098 | instance | Thursday 30 July 2026  20:52:48 +0000 (0:00:00.023)       0:00:06.909 *********
2026-07-30 20:53:08.727107 | instance | ok: [localhost] => (item={'key': 'kubernetes_hostname', 'value': '10.96.240.10'})
2026-07-30 20:53:08.727116 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vrid', 'value': 42})
2026-07-30 20:53:08.727125 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vip', 'value': '10.96.240.10'})
2026-07-30 20:53:08.727134 | instance |
2026-07-30 20:53:08.727143 | instance | TASK [Write new Kubernetes configuration file to disk] *************************
2026-07-30 20:53:08.727152 | instance | Thursday 30 July 2026  20:52:48 +0000 (0:00:00.037)       0:00:06.947 *********
2026-07-30 20:53:08.727161 | instance | changed: [localhost]
2026-07-30 20:53:08.727169 | instance |
2026-07-30 20:53:08.727178 | instance | PLAY [Generate Keepalived configuration for workspace] *************************
2026-07-30 20:53:08.727244 | instance |
2026-07-30 20:53:08.727256 | instance | TASK [Ensure the Keeaplived configuration file exists] *************************
2026-07-30 20:53:08.727265 | instance | Thursday 30 July 2026  20:52:48 +0000 (0:00:00.449)       0:00:07.396 *********
2026-07-30 20:53:08.727274 | instance | changed: [localhost]
2026-07-30 20:53:08.727283 | instance |
2026-07-30 20:53:08.727292 | instance | TASK [Load the current Keepalived configuration into a variable] ***************
2026-07-30 20:53:08.727318 | instance | Thursday 30 July 2026  20:52:48 +0000 (0:00:00.224)       0:00:07.621 *********
2026-07-30 20:53:08.727327 | instance | ok: [localhost]
2026-07-30 20:53:08.727336 | instance |
2026-07-30 20:53:08.727345 | instance | TASK [Generate Keepalived values for missing variables] ************************
2026-07-30 20:53:08.727354 | instance | Thursday 30 July 2026  20:52:48 +0000 (0:00:00.023)       0:00:07.644 *********
2026-07-30 20:53:08.727363 | instance | ok: [localhost] => (item={'key': 'keepalived_interface', 'value': 'br-ex'})
2026-07-30 20:53:08.727381 | instance | ok: [localhost] => (item={'key': 'keepalived_vip', 'value': '10.96.250.10'})
2026-07-30 20:53:08.727390 | instance |
2026-07-30 20:53:08.727399 | instance | TASK [Write new Keepalived configuration file to disk] *************************
2026-07-30 20:53:08.727408 | instance | Thursday 30 July 2026  20:52:48 +0000 (0:00:00.032)       0:00:07.677 *********
2026-07-30 20:53:08.727418 | instance | changed: [localhost]
2026-07-30 20:53:08.727426 | instance |
2026-07-30 20:53:08.727435 | instance | PLAY [Generate endpoints for workspace] ****************************************
2026-07-30 20:53:08.727444 | instance |
2026-07-30 20:53:08.727453 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:53:08.727462 | instance | Thursday 30 July 2026  20:52:49 +0000 (0:00:00.438)       0:00:08.115 *********
2026-07-30 20:53:08.727470 | instance | ok: [localhost]
2026-07-30 20:53:08.727479 | instance |
2026-07-30 20:53:08.727488 | instance | TASK [Ensure the endpoints file exists] ****************************************
2026-07-30 20:53:08.727497 | instance | Thursday 30 July 2026  20:52:50 +0000 (0:00:00.828)       0:00:08.943 *********
2026-07-30 20:53:08.727505 | instance | changed: [localhost]
2026-07-30 20:53:08.727514 | instance |
2026-07-30 20:53:08.727523 | instance | TASK [Load the current endpoints into a variable] ******************************
2026-07-30 20:53:08.727532 | instance | Thursday 30 July 2026  20:52:50 +0000 (0:00:00.220)       0:00:09.164 *********
2026-07-30 20:53:08.727540 | instance | ok: [localhost]
2026-07-30 20:53:08.727549 | instance |
2026-07-30 20:53:08.727558 | instance | TASK [Generate endpoint skeleton for missing variables] ************************
2026-07-30 20:53:08.727567 | instance | Thursday 30 July 2026  20:52:50 +0000 (0:00:00.028)       0:00:09.193 *********
2026-07-30 20:53:08.727576 | instance | ok: [localhost] => (item=keycloak_host)
2026-07-30 20:53:08.727585 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_host)
2026-07-30 20:53:08.727594 | instance | ok: [localhost] => (item=kube_prometheus_stack_alertmanager_host)
2026-07-30 20:53:08.727604 | instance | ok: [localhost] => (item=kube_prometheus_stack_prometheus_host)
2026-07-30 20:53:08.727613 | instance | ok: [localhost] => (item=openstack_helm_endpoints_region_name)
2026-07-30 20:53:08.727621 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_api_host)
2026-07-30 20:53:08.727642 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_api_host)
2026-07-30 20:53:08.727652 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_api_host)
2026-07-30 20:53:08.727661 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_api_host)
2026-07-30 20:53:08.727670 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_api_host)
2026-07-30 20:53:08.727679 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_api_host)
2026-07-30 20:53:08.727687 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_api_host)
2026-07-30 20:53:08.727696 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_novnc_host)
2026-07-30 20:53:08.727705 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_api_host)
2026-07-30 20:53:08.727716 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_api_host)
2026-07-30 20:53:08.727725 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_api_host)
2026-07-30 20:53:08.727734 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_api_host)
2026-07-30 20:53:08.727743 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_registry_host)
2026-07-30 20:53:08.727752 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_api_host)
2026-07-30 20:53:08.727761 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_cfn_api_host)
2026-07-30 20:53:08.727769 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_api_host)
2026-07-30 20:53:08.727778 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_host)
2026-07-30 20:53:08.727787 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_api_host)
2026-07-30 20:53:08.727796 | instance |
2026-07-30 20:53:08.727805 | instance | TASK [Write new endpoints file to disk] ****************************************
2026-07-30 20:53:08.727814 | instance | Thursday 30 July 2026  20:52:51 +0000 (0:00:00.743)       0:00:09.936 *********
2026-07-30 20:53:08.727828 | instance | changed: [localhost]
2026-07-30 20:53:08.727838 | instance |
2026-07-30 20:53:08.727847 | instance | TASK [Ensure the endpoints file exists] ****************************************
2026-07-30 20:53:08.727856 | instance | Thursday 30 July 2026  20:52:51 +0000 (0:00:00.454)       0:00:10.391 *********
2026-07-30 20:53:08.727865 | instance | changed: [localhost]
2026-07-30 20:53:08.727874 | instance |
2026-07-30 20:53:08.727882 | instance | PLAY [Generate Neutron configuration for workspace] ****************************
2026-07-30 20:53:08.727891 | instance |
2026-07-30 20:53:08.727900 | instance | TASK [Ensure the Neutron configuration file exists] ****************************
2026-07-30 20:53:08.727910 | instance | Thursday 30 July 2026  20:52:51 +0000 (0:00:00.232)       0:00:10.624 *********
2026-07-30 20:53:08.727919 | instance | changed: [localhost]
2026-07-30 20:53:08.727927 | instance |
2026-07-30 20:53:08.727936 | instance | TASK [Load the current Neutron configuration into a variable] ******************
2026-07-30 20:53:08.727945 | instance | Thursday 30 July 2026  20:52:52 +0000 (0:00:00.228)       0:00:10.853 *********
2026-07-30 20:53:08.727954 | instance | ok: [localhost]
2026-07-30 20:53:08.727963 | instance |
2026-07-30 20:53:08.727971 | instance | TASK [Generate Neutron values for missing variables] ***************************
2026-07-30 20:53:08.727980 | instance | Thursday 30 July 2026  20:52:52 +0000 (0:00:00.028)       0:00:10.881 *********
2026-07-30 20:53:08.727990 | 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-30 20:53:08.728000 | instance |
2026-07-30 20:53:08.728008 | instance | TASK [Write new Neutron configuration file to disk] ****************************
2026-07-30 20:53:08.728017 | instance | Thursday 30 July 2026  20:52:52 +0000 (0:00:00.036)       0:00:10.918 *********
2026-07-30 20:53:08.728026 | instance | changed: [localhost]
2026-07-30 20:53:08.728035 | instance |
2026-07-30 20:53:08.728044 | instance | PLAY [Generate Nova configuration for workspace] *******************************
2026-07-30 20:53:08.728052 | instance |
2026-07-30 20:53:08.728061 | instance | TASK [Ensure the Nova configuration file exists] *******************************
2026-07-30 20:53:08.728070 | instance | Thursday 30 July 2026  20:52:52 +0000 (0:00:00.465)       0:00:11.383 *********
2026-07-30 20:53:08.728079 | instance | changed: [localhost]
2026-07-30 20:53:08.728088 | instance |
2026-07-30 20:53:08.728096 | instance | TASK [Load the current Nova configuration into a variable] *********************
2026-07-30 20:53:08.728105 | instance | Thursday 30 July 2026  20:52:52 +0000 (0:00:00.219)       0:00:11.603 *********
2026-07-30 20:53:08.728114 | instance | ok: [localhost]
2026-07-30 20:53:08.728122 | instance |
2026-07-30 20:53:08.728131 | instance | TASK [Generate Nova values for missing variables] ******************************
2026-07-30 20:53:08.728140 | instance | Thursday 30 July 2026  20:52:52 +0000 (0:00:00.025)       0:00:11.628 *********
2026-07-30 20:53:08.728149 | 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-30 20:53:08.728159 | instance |
2026-07-30 20:53:08.728168 | instance | TASK [Write new Nova configuration file to disk] *******************************
2026-07-30 20:53:08.728176 | instance | Thursday 30 July 2026  20:52:52 +0000 (0:00:00.036)       0:00:11.665 *********
2026-07-30 20:53:08.728185 | instance | changed: [localhost]
2026-07-30 20:53:08.728194 | instance |
2026-07-30 20:53:08.728202 | instance | PLAY [Generate secrets for workspace] ******************************************
2026-07-30 20:53:08.728211 | instance |
2026-07-30 20:53:08.728220 | instance | TASK [Ensure the secrets file exists] ******************************************
2026-07-30 20:53:08.728235 | instance | Thursday 30 July 2026  20:52:53 +0000 (0:00:00.442)       0:00:12.107 *********
2026-07-30 20:53:08.728244 | instance | changed: [localhost]
2026-07-30 20:53:08.728253 | instance |
2026-07-30 20:53:08.728268 | instance | TASK [Load the current secrets into a variable] ********************************
2026-07-30 20:53:08.728277 | instance | Thursday 30 July 2026  20:52:53 +0000 (0:00:00.221)       0:00:12.329 *********
2026-07-30 20:53:08.728286 | instance | ok: [localhost]
2026-07-30 20:53:08.728295 | instance |
2026-07-30 20:53:08.728304 | instance | TASK [Generate secrets for missing variables] **********************************
2026-07-30 20:53:08.728315 | instance | Thursday 30 July 2026  20:52:53 +0000 (0:00:00.027)       0:00:12.356 *********
2026-07-30 20:53:08.728324 | instance | ok: [localhost] => (item=heat_auth_encryption_key)
2026-07-30 20:53:08.728334 | instance | ok: [localhost] => (item=keepalived_password)
2026-07-30 20:53:08.728343 | instance | ok: [localhost] => (item=keycloak_admin_password)
2026-07-30 20:53:08.728355 | instance | ok: [localhost] => (item=keycloak_database_password)
2026-07-30 20:53:08.728364 | instance | ok: [localhost] => (item=keystone_keycloak_client_secret)
2026-07-30 20:53:08.728373 | instance | ok: [localhost] => (item=keystone_oidc_crypto_passphrase)
2026-07-30 20:53:08.728382 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_admin_password)
2026-07-30 20:53:08.728391 | instance | ok: [localhost] => (item=octavia_heartbeat_key)
2026-07-30 20:53:08.728399 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rabbitmq_admin_password)
2026-07-30 20:53:08.728408 | instance | ok: [localhost] => (item=openstack_helm_endpoints_memcached_secret_key)
2026-07-30 20:53:08.728417 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_admin_password)
2026-07-30 20:53:08.728426 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_mariadb_password)
2026-07-30 20:53:08.728435 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_rabbitmq_password)
2026-07-30 20:53:08.728444 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_keystone_password)
2026-07-30 20:53:08.728452 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_mariadb_password)
2026-07-30 20:53:08.728461 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_rabbitmq_password)
2026-07-30 20:53:08.728470 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_keystone_password)
2026-07-30 20:53:08.728479 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_mariadb_password)
2026-07-30 20:53:08.728487 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_rabbitmq_password)
2026-07-30 20:53:08.728496 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_keystone_password)
2026-07-30 20:53:08.728505 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_mariadb_password)
2026-07-30 20:53:08.728514 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_keystone_password)
2026-07-30 20:53:08.728523 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_mariadb_password)
2026-07-30 20:53:08.728531 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_keystone_password)
2026-07-30 20:53:08.728540 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_mariadb_password)
2026-07-30 20:53:08.728549 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_rabbitmq_password)
2026-07-30 20:53:08.728558 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_metadata_secret)
2026-07-30 20:53:08.728567 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_keystone_password)
2026-07-30 20:53:08.728575 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_mariadb_password)
2026-07-30 20:53:08.728584 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_rabbitmq_password)
2026-07-30 20:53:08.728593 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_keystone_password)
2026-07-30 20:53:08.728602 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_mariadb_password)
2026-07-30 20:53:08.728610 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_rabbitmq_password)
2026-07-30 20:53:08.728619 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_keystone_password)
2026-07-30 20:53:08.728633 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_mariadb_password)
2026-07-30 20:53:08.728642 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_rabbitmq_password)
2026-07-30 20:53:08.728651 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_keystone_password)
2026-07-30 20:53:08.728660 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_mariadb_password)
2026-07-30 20:53:08.728668 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_rabbitmq_password)
2026-07-30 20:53:08.728677 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_keystone_password)
2026-07-30 20:53:08.728686 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_mariadb_password)
2026-07-30 20:53:08.728694 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_rabbitmq_password)
2026-07-30 20:53:08.728703 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_keystone_password)
2026-07-30 20:53:08.728712 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_trustee_keystone_password)
2026-07-30 20:53:08.728721 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_stack_user_keystone_password)
2026-07-30 20:53:08.728730 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_mariadb_password)
2026-07-30 20:53:08.728739 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_rabbitmq_password)
2026-07-30 20:53:08.728747 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_mariadb_password)
2026-07-30 20:53:08.728756 | instance | ok: [localhost] => (item=openstack_helm_endpoints_tempest_keystone_password)
2026-07-30 20:53:08.728765 | instance | ok: [localhost] => (item=openstack_helm_endpoints_openstack_exporter_keystone_password)
2026-07-30 20:53:08.728774 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_keystone_password)
2026-07-30 20:53:08.728787 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_keystone_password)
2026-07-30 20:53:08.728796 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_mariadb_password)
2026-07-30 20:53:08.728804 | instance | ok: [localhost] => (item=openstack_helm_endpoints_staffeln_mariadb_password)
2026-07-30 20:53:08.728813 | instance |
2026-07-30 20:53:08.728822 | instance | TASK [Generate base64 encoded secrets] *****************************************
2026-07-30 20:53:08.728834 | instance | Thursday 30 July 2026  20:52:53 +0000 (0:00:00.391)       0:00:12.748 *********
2026-07-30 20:53:08.728843 | instance | ok: [localhost] => (item=barbican_kek)
2026-07-30 20:53:08.728852 | instance |
2026-07-30 20:53:08.728860 | instance | TASK [Generate temporary files for generating keys for missing variables] ******
2026-07-30 20:53:08.728869 | instance | Thursday 30 July 2026  20:52:53 +0000 (0:00:00.041)       0:00:12.789 *********
2026-07-30 20:53:08.728878 | instance | changed: [localhost] => (item=manila_ssh_key)
2026-07-30 20:53:08.728887 | instance | changed: [localhost] => (item=nova_ssh_key)
2026-07-30 20:53:08.728896 | instance |
2026-07-30 20:53:08.728904 | instance | TASK [Generate SSH keys for missing variables] *********************************
2026-07-30 20:53:08.728913 | instance | Thursday 30 July 2026  20:52:54 +0000 (0:00:00.502)       0:00:13.292 *********
2026-07-30 20:53:08.728922 | instance | changed: [localhost] => (item=manila_ssh_key)
2026-07-30 20:53:08.728931 | instance | changed: [localhost] => (item=nova_ssh_key)
2026-07-30 20:53:08.728939 | instance |
2026-07-30 20:53:08.728948 | instance | TASK [Set values for SSH keys] *************************************************
2026-07-30 20:53:08.728957 | instance | Thursday 30 July 2026  20:52:59 +0000 (0:00:05.131)       0:00:18.424 *********
2026-07-30 20:53:08.728966 | instance | ok: [localhost] => (item=manila_ssh_key)
2026-07-30 20:53:08.728975 | instance | ok: [localhost] => (item=nova_ssh_key)
2026-07-30 20:53:08.728983 | instance |
2026-07-30 20:53:08.728992 | instance | TASK [Delete the temporary files generated for SSH keys] ***********************
2026-07-30 20:53:08.729001 | instance | Thursday 30 July 2026  20:52:59 +0000 (0:00:00.049)       0:00:18.473 *********
2026-07-30 20:53:08.729010 | instance | changed: [localhost] => (item=manila_ssh_key)
2026-07-30 20:53:08.729019 | instance | changed: [localhost] => (item=nova_ssh_key)
2026-07-30 20:53:08.729027 | instance |
2026-07-30 20:53:08.729036 | instance | TASK [Write new secrets file to disk] ******************************************
2026-07-30 20:53:08.729050 | instance | Thursday 30 July 2026  20:53:00 +0000 (0:00:00.425)       0:00:18.899 *********
2026-07-30 20:53:08.729059 | instance | changed: [localhost]
2026-07-30 20:53:08.729067 | instance |
2026-07-30 20:53:08.729076 | instance | TASK [Encrypt secrets file with Vault password] ********************************
2026-07-30 20:53:08.729085 | instance | Thursday 30 July 2026  20:53:00 +0000 (0:00:00.437)       0:00:19.336 *********
2026-07-30 20:53:08.729094 | instance | skipping: [localhost]
2026-07-30 20:53:08.729103 | instance |
2026-07-30 20:53:08.729111 | instance | PLAY [Setup networking] ********************************************************
2026-07-30 20:53:08.729120 | instance |
2026-07-30 20:53:08.729129 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:53:08.729138 | instance | Thursday 30 July 2026  20:53:00 +0000 (0:00:00.034)       0:00:19.370 *********
2026-07-30 20:53:08.729147 | instance | ok: [instance]
2026-07-30 20:53:08.729156 | instance |
2026-07-30 20:53:08.729165 | instance | TASK [Create bridge for management network] ************************************
2026-07-30 20:53:08.729173 | instance | Thursday 30 July 2026  20:53:01 +0000 (0:00:00.675)       0:00:20.046 *********
2026-07-30 20:53:08.729182 | instance | ok: [instance]
2026-07-30 20:53:08.729191 | instance |
2026-07-30 20:53:08.729200 | instance | TASK [Create fake interface for management bridge] *****************************
2026-07-30 20:53:08.729208 | instance | Thursday 30 July 2026  20:53:01 +0000 (0:00:00.302)       0:00:20.348 *********
2026-07-30 20:53:08.729217 | instance | ok: [instance]
2026-07-30 20:53:08.729226 | instance |
2026-07-30 20:53:08.729235 | instance | TASK [Assign dummy interface to management bridge] *****************************
2026-07-30 20:53:08.729243 | instance | Thursday 30 July 2026  20:53:01 +0000 (0:00:00.190)       0:00:20.539 *********
2026-07-30 20:53:08.729252 | instance | ok: [instance]
2026-07-30 20:53:08.729261 | instance |
2026-07-30 20:53:08.729269 | instance | TASK [Assign IP address for management bridge] *********************************
2026-07-30 20:53:08.729278 | instance | Thursday 30 July 2026  20:53:01 +0000 (0:00:00.180)       0:00:20.719 *********
2026-07-30 20:53:08.729287 | instance | ok: [instance]
2026-07-30 20:53:08.729296 | instance |
2026-07-30 20:53:08.729304 | instance | TASK [Bring up interfaces] *****************************************************
2026-07-30 20:53:08.729313 | instance | Thursday 30 July 2026  20:53:02 +0000 (0:00:00.192)       0:00:20.912 *********
2026-07-30 20:53:08.729322 | instance | ok: [instance] => (item=br-mgmt)
2026-07-30 20:53:08.729331 | instance | ok: [instance] => (item=dummy0)
2026-07-30 20:53:08.729340 | instance |
2026-07-30 20:53:08.729349 | instance | PLAY [Create devices for Ceph] *************************************************
2026-07-30 20:53:08.729357 | instance |
2026-07-30 20:53:08.729366 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:53:08.729375 | instance | Thursday 30 July 2026  20:53:02 +0000 (0:00:00.357)       0:00:21.270 *********
2026-07-30 20:53:08.729384 | instance | ok: [instance]
2026-07-30 20:53:08.729392 | instance |
2026-07-30 20:53:08.729401 | instance | TASK [Install depedencies] *****************************************************
2026-07-30 20:53:08.729410 | instance | Thursday 30 July 2026  20:53:03 +0000 (0:00:00.689)       0:00:21.959 *********
2026-07-30 20:53:09.080050 | instance | ok: Runtime: 0:00:00.008281
2026-07-30 20:53:09.089910 | 
2026-07-30 20:53:09.089982 | TASK [Track last task for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:09.164455 | instance | ok
2026-07-30 20:53:09.171379 | 
2026-07-30 20:53:09.171455 | TASK [Advance live log offset for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:09.228375 | instance | ok
2026-07-30 20:53:09.234584 | 
2026-07-30 20:53:09.234657 | TASK [Report progress heartbeat for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:09.290405 | instance | ok:
2026-07-30 20:53:09.290579 | instance | Molecule aio (aio-openvswitch) is still running after 40 seconds.
2026-07-30 20:53:09.290823 | instance | Last task: TASK [Install depedencies]
2026-07-30 20:53:09.298502 | 
2026-07-30 20:53:09.298574 | TASK [Continue monitoring Molecule aio (aio-openvswitch)]
2026-07-30 20:53:09.356212 | instance | ok
2026-07-30 20:53:09.367115 | instance | included: /var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-command.yml
2026-07-30 20:53:09.379193 | 
2026-07-30 20:53:09.379281 | TASK [Wait before polling Molecule aio (aio-openvswitch)]
2026-07-30 20:53:29.437973 | instance | ok
2026-07-30 20:53:29.581956 | 
2026-07-30 20:53:29.582070 | TASK [Count progress poll for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:29.649791 | instance | ok
2026-07-30 20:53:29.657621 | 
2026-07-30 20:53:29.657696 | TASK [Poll status for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:29.895113 | instance | ok
2026-07-30 20:53:29.912307 | 
2026-07-30 20:53:29.912422 | TASK [Inspect live log for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:30.116066 | instance | ok
2026-07-30 20:53:30.123142 | 
2026-07-30 20:53:30.123220 | TASK [Calculate new output for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:30.177395 | instance | ok
2026-07-30 20:53:30.187821 | 
2026-07-30 20:53:30.187923 | TASK [Read new output for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:30.392008 | instance | changed: [instance]
2026-07-30 20:53:30.392261 | instance |
2026-07-30 20:53:30.392276 | instance | TASK [Start up service] ********************************************************
2026-07-30 20:53:30.392291 | instance | Thursday 30 July 2026  20:53:21 +0000 (0:00:18.293)       0:00:40.252 *********
2026-07-30 20:53:30.392305 | instance | ok: [instance]
2026-07-30 20:53:30.392314 | instance |
2026-07-30 20:53:30.392325 | instance | TASK [Generate lvm.conf] *******************************************************
2026-07-30 20:53:30.392335 | instance | Thursday 30 July 2026  20:53:21 +0000 (0:00:00.505)       0:00:40.758 *********
2026-07-30 20:53:30.392344 | instance | ok: [instance]
2026-07-30 20:53:30.392353 | instance |
2026-07-30 20:53:30.392363 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-07-30 20:53:30.392373 | instance | Thursday 30 July 2026  20:53:22 +0000 (0:00:00.198)       0:00:40.956 *********
2026-07-30 20:53:30.392382 | instance | changed: [instance]
2026-07-30 20:53:30.392391 | instance |
2026-07-30 20:53:30.392400 | instance | TASK [Get list of all loopback devices] ****************************************
2026-07-30 20:53:30.392462 | instance | Thursday 30 July 2026  20:53:22 +0000 (0:00:00.424)       0:00:41.381 *********
2026-07-30 20:53:30.392474 | instance | ok: [instance]
2026-07-30 20:53:30.392483 | instance |
2026-07-30 20:53:30.392492 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-07-30 20:53:30.392501 | instance | Thursday 30 July 2026  20:53:22 +0000 (0:00:00.182)       0:00:41.564 *********
2026-07-30 20:53:30.392510 | instance | skipping: [instance]
2026-07-30 20:53:30.392519 | instance |
2026-07-30 20:53:30.392528 | instance | TASK [Create devices for Ceph] *************************************************
2026-07-30 20:53:30.392542 | instance | Thursday 30 July 2026  20:53:22 +0000 (0:00:00.021)       0:00:41.585 *********
2026-07-30 20:53:30.392552 | instance | changed: [instance] => (item=osd0)
2026-07-30 20:53:30.392561 | instance | changed: [instance] => (item=osd1)
2026-07-30 20:53:30.392570 | instance | changed: [instance] => (item=osd2)
2026-07-30 20:53:30.392579 | instance |
2026-07-30 20:53:30.392588 | instance | TASK [Set permissions on loopback devices] *************************************
2026-07-30 20:53:30.392597 | instance | Thursday 30 July 2026  20:53:23 +0000 (0:00:00.500)       0:00:42.085 *********
2026-07-30 20:53:30.392605 | instance | changed: [instance] => (item=osd0)
2026-07-30 20:53:30.392614 | instance | changed: [instance] => (item=osd1)
2026-07-30 20:53:30.392623 | instance | changed: [instance] => (item=osd2)
2026-07-30 20:53:30.392632 | instance |
2026-07-30 20:53:30.392641 | instance | TASK [Start loop devices] ******************************************************
2026-07-30 20:53:30.392650 | instance | Thursday 30 July 2026  20:53:23 +0000 (0:00:00.499)       0:00:42.585 *********
2026-07-30 20:53:30.392659 | instance | changed: [instance] => (item=osd0)
2026-07-30 20:53:30.392667 | instance | changed: [instance] => (item=osd1)
2026-07-30 20:53:30.392676 | instance | changed: [instance] => (item=osd2)
2026-07-30 20:53:30.392685 | instance |
2026-07-30 20:53:30.392694 | instance | TASK [Create a volume group for each loop device] ******************************
2026-07-30 20:53:30.392703 | instance | Thursday 30 July 2026  20:53:24 +0000 (0:00:00.633)       0:00:43.218 *********
2026-07-30 20:53:30.392712 | instance | changed: [instance] => (item=osd0)
2026-07-30 20:53:30.392720 | instance | changed: [instance] => (item=osd1)
2026-07-30 20:53:30.392729 | instance | changed: [instance] => (item=osd2)
2026-07-30 20:53:30.392738 | instance |
2026-07-30 20:53:30.392747 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-07-30 20:53:30.392756 | instance | Thursday 30 July 2026  20:53:27 +0000 (0:00:03.129)       0:00:46.348 *********
2026-07-30 20:53:30.392764 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-07-30 20:53:30.392773 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-07-30 20:53:30.392782 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-07-30 20:53:30.392791 | instance |
2026-07-30 20:53:30.392800 | instance | PLAY [controllers] *************************************************************
2026-07-30 20:53:30.392809 | instance |
2026-07-30 20:53:30.392818 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:53:30.392827 | instance | Thursday 30 July 2026  20:53:29 +0000 (0:00:01.826)       0:00:48.174 *********
2026-07-30 20:53:30.729762 | instance | ok: Runtime: 0:00:00.007604
2026-07-30 20:53:30.737972 | 
2026-07-30 20:53:30.738059 | TASK [Track last task for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:30.825502 | instance | ok
2026-07-30 20:53:30.832289 | 
2026-07-30 20:53:30.832366 | TASK [Advance live log offset for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:30.893436 | instance | ok
2026-07-30 20:53:30.901815 | 
2026-07-30 20:53:30.901898 | TASK [Report progress heartbeat for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:30.967133 | instance | ok:
2026-07-30 20:53:31.145855 | instance | Molecule aio (aio-openvswitch) is still running after 60 seconds.
2026-07-30 20:53:31.146044 | instance | Last task: TASK [Gathering Facts]
2026-07-30 20:53:31.156794 | 
2026-07-30 20:53:31.156869 | TASK [Continue monitoring Molecule aio (aio-openvswitch)]
2026-07-30 20:53:31.210744 | instance | ok
2026-07-30 20:53:31.226447 | instance | included: /var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-command.yml
2026-07-30 20:53:31.241791 | 
2026-07-30 20:53:31.241896 | TASK [Wait before polling Molecule aio (aio-openvswitch)]
2026-07-30 20:53:51.308180 | instance | ok
2026-07-30 20:53:51.315867 | 
2026-07-30 20:53:51.315963 | TASK [Count progress poll for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:51.370357 | instance | ok
2026-07-30 20:53:51.377959 | 
2026-07-30 20:53:51.378037 | TASK [Poll status for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:51.600702 | instance | ok
2026-07-30 20:53:51.612175 | 
2026-07-30 20:53:51.612335 | TASK [Inspect live log for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:51.809503 | instance | ok
2026-07-30 20:53:51.818105 | 
2026-07-30 20:53:51.818184 | TASK [Calculate new output for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:51.892849 | instance | ok
2026-07-30 20:53:51.900930 | 
2026-07-30 20:53:51.901044 | TASK [Read new output for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:52.095003 | instance | ok: [instance]
2026-07-30 20:53:52.095080 | instance |
2026-07-30 20:53:52.095094 | instance | TASK [Set masquerade rule] *****************************************************
2026-07-30 20:53:52.095109 | instance | Thursday 30 July 2026  20:53:30 +0000 (0:00:00.797)       0:00:48.972 *********
2026-07-30 20:53:52.095123 | instance | changed: [instance]
2026-07-30 20:53:52.095132 | instance |
2026-07-30 20:53:52.095144 | instance | PLAY RECAP *********************************************************************
2026-07-30 20:53:52.095154 | instance | instance                   : ok=24   changed=10   unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-07-30 20:53:52.095164 | instance | localhost                  : ok=40   changed=21   unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-07-30 20:53:52.095174 | instance |
2026-07-30 20:53:52.095183 | instance | Thursday 30 July 2026  20:53:30 +0000 (0:00:00.444)       0:00:49.416 *********
2026-07-30 20:53:52.095192 | instance | ===============================================================================
2026-07-30 20:53:52.095201 | instance | Install depedencies ---------------------------------------------------- 18.29s
2026-07-30 20:53:52.095210 | instance | Generate SSH keys for missing variables --------------------------------- 5.13s
2026-07-30 20:53:52.095219 | instance | Create a volume group for each loop device ------------------------------ 3.13s
2026-07-30 20:53:52.095228 | instance | Create a logical volume for each loop device ---------------------------- 1.83s
2026-07-30 20:53:52.095242 | instance | Create folders for workspace -------------------------------------------- 1.31s
2026-07-30 20:53:52.095251 | instance | Gathering Facts --------------------------------------------------------- 1.08s
2026-07-30 20:53:52.095260 | instance | Install "dirmngr" for GPG keyserver operations -------------------------- 1.06s
2026-07-30 20:53:52.095269 | instance | Gathering Facts --------------------------------------------------------- 0.83s
2026-07-30 20:53:52.095278 | instance | Gathering Facts --------------------------------------------------------- 0.80s
2026-07-30 20:53:52.095287 | instance | Generate endpoint skeleton for missing variables ------------------------ 0.74s
2026-07-30 20:53:52.095296 | instance | Gathering Facts --------------------------------------------------------- 0.69s
2026-07-30 20:53:52.095305 | instance | Gathering Facts --------------------------------------------------------- 0.68s
2026-07-30 20:53:52.095314 | instance | Configure short hostname ------------------------------------------------ 0.64s
2026-07-30 20:53:52.095323 | instance | Start loop devices ------------------------------------------------------ 0.63s
2026-07-30 20:53:52.095332 | instance | Purge "snapd" package --------------------------------------------------- 0.63s
2026-07-30 20:53:52.095341 | instance | Write new Ceph control plane configuration file to disk ----------------- 0.62s
2026-07-30 20:53:52.095350 | instance | Start up service -------------------------------------------------------- 0.51s
2026-07-30 20:53:52.095359 | instance | Generate temporary files for generating keys for missing variables ------ 0.50s
2026-07-30 20:53:52.095382 | instance | Create devices for Ceph ------------------------------------------------- 0.50s
2026-07-30 20:53:52.095397 | instance | Set permissions on loopback devices ------------------------------------- 0.50s
2026-07-30 20:53:52.095411 | instance | INFO     [aio > prepare] Executed: Successful
2026-07-30 20:53:52.095425 | instance | INFO     [aio > converge] Executing
2026-07-30 20:53:52.095439 | instance |
2026-07-30 20:53:52.095453 | instance | PLAY [all] *********************************************************************
2026-07-30 20:53:52.095467 | instance |
2026-07-30 20:53:52.095481 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-07-30 20:53:52.095494 | instance | Thursday 30 July 2026  20:53:33 +0000 (0:00:00.017)       0:00:00.017 *********
2026-07-30 20:53:52.095508 | instance | ok: [instance]
2026-07-30 20:53:52.095522 | instance |
2026-07-30 20:53:52.095536 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-07-30 20:53:52.095550 | instance |
2026-07-30 20:53:52.095564 | instance | PLAY [Deploy Ceph OSDs] ********************************************************
2026-07-30 20:53:52.095578 | instance |
2026-07-30 20:53:52.095592 | instance | PLAY [Deploy Ceph exporters] ***************************************************
2026-07-30 20:53:52.095659 | instance |
2026-07-30 20:53:52.095672 | instance | PLAY [all] *********************************************************************
2026-07-30 20:53:52.095682 | instance |
2026-07-30 20:53:52.095691 | instance | PLAY [all] *********************************************************************
2026-07-30 20:53:52.095699 | instance |
2026-07-30 20:53:52.095708 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-07-30 20:53:52.095718 | instance | Thursday 30 July 2026  20:53:34 +0000 (0:00:00.590)       0:00:00.607 *********
2026-07-30 20:53:52.095727 | instance | ok: [instance]
2026-07-30 20:53:52.095736 | instance |
2026-07-30 20:53:52.095745 | instance | PLAY [Configure Kubernetes VIP] ************************************************
2026-07-30 20:53:52.095753 | instance |
2026-07-30 20:53:52.095762 | instance | PLAY [Install Kubernetes] ******************************************************
2026-07-30 20:53:52.095771 | instance |
2026-07-30 20:53:52.095780 | instance | PLAY [Install control-plane components] ****************************************
2026-07-30 20:53:52.095789 | instance |
2026-07-30 20:53:52.095798 | instance | PLAY [all] *********************************************************************
2026-07-30 20:53:52.095806 | instance |
2026-07-30 20:53:52.095815 | instance | PLAY [all] *********************************************************************
2026-07-30 20:53:52.095824 | instance |
2026-07-30 20:53:52.095833 | instance | PLAY [controllers] *************************************************************
2026-07-30 20:53:52.095842 | instance |
2026-07-30 20:53:52.095851 | instance | PLAY [Deploy Infrastructure] ***************************************************
2026-07-30 20:53:52.095859 | instance |
2026-07-30 20:53:52.095868 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:53:52.095877 | instance | Thursday 30 July 2026  20:53:34 +0000 (0:00:00.333)       0:00:00.941 *********
2026-07-30 20:53:52.095886 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-07-30 20:53:52.095895 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-07-30 20:53:52.095914 | instance | interpreter could change the meaning of that path. See
2026-07-30 20:53:52.095923 | instance | https://docs.ansible.com/ansible-
2026-07-30 20:53:52.095932 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-07-30 20:53:52.095941 | instance | ok: [instance]
2026-07-30 20:53:52.095950 | instance |
2026-07-30 20:53:52.095959 | instance | PLAY [Deploy Monitoring] *******************************************************
2026-07-30 20:53:52.095968 | instance |
2026-07-30 20:53:52.095976 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:53:52.095986 | instance | Thursday 30 July 2026  20:53:35 +0000 (0:00:01.298)       0:00:02.239 *********
2026-07-30 20:53:52.095994 | instance | ok: [instance]
2026-07-30 20:53:52.096003 | instance |
2026-07-30 20:53:52.096016 | instance | PLAY [Deploy OpenStack] ********************************************************
2026-07-30 20:53:52.096025 | instance |
2026-07-30 20:53:52.096034 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:53:52.096043 | instance | Thursday 30 July 2026  20:53:36 +0000 (0:00:00.991)       0:00:03.230 *********
2026-07-30 20:53:52.096052 | instance | ok: [instance]
2026-07-30 20:53:52.096061 | instance |
2026-07-30 20:53:52.096070 | instance | PLAY [Configure operating system] **********************************************
2026-07-30 20:53:52.096078 | instance |
2026-07-30 20:53:52.096087 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:53:52.096096 | instance | Thursday 30 July 2026  20:53:37 +0000 (0:00:01.219)       0:00:04.449 *********
2026-07-30 20:53:52.096105 | instance | ok: [instance]
2026-07-30 20:53:52.096113 | instance |
2026-07-30 20:53:52.096122 | instance | TASK [vexxhost.atmosphere.lpfc : Detect if the "lpfc" module is loaded] ********
2026-07-30 20:53:52.096131 | instance | Thursday 30 July 2026  20:53:38 +0000 (0:00:00.868)       0:00:05.317 *********
2026-07-30 20:53:52.096140 | instance | ok: [instance]
2026-07-30 20:53:52.096149 | instance |
2026-07-30 20:53:52.096158 | instance | TASK [vexxhost.atmosphere.lpfc : Install the configuration file] ***************
2026-07-30 20:53:52.096173 | instance | Thursday 30 July 2026  20:53:39 +0000 (0:00:00.254)       0:00:05.572 *********
2026-07-30 20:53:52.096182 | instance | skipping: [instance]
2026-07-30 20:53:52.096191 | instance |
2026-07-30 20:53:52.096200 | instance | TASK [vexxhost.atmosphere.lpfc : Get the values for the module parameters] *****
2026-07-30 20:53:52.096209 | instance | Thursday 30 July 2026  20:53:39 +0000 (0:00:00.024)       0:00:05.596 *********
2026-07-30 20:53:52.096217 | instance | skipping: [instance] => (item=lpfc_lun_queue_depth)
2026-07-30 20:53:52.096226 | instance | skipping: [instance] => (item=lpfc_sg_seg_cnt)
2026-07-30 20:53:52.096235 | instance | skipping: [instance] => (item=lpfc_max_luns)
2026-07-30 20:53:52.096244 | instance | skipping: [instance] => (item=lpfc_enable_fc4_type)
2026-07-30 20:53:52.096253 | instance | skipping: [instance]
2026-07-30 20:53:52.096262 | instance |
2026-07-30 20:53:52.096271 | instance | TASK [vexxhost.atmosphere.lpfc : Detect if the run-time module parameters are set correctly] ***
2026-07-30 20:53:52.096280 | instance | Thursday 30 July 2026  20:53:39 +0000 (0:00:00.034)       0:00:05.631 *********
2026-07-30 20:53:52.096289 | instance | skipping: [instance] => (item=lpfc_lun_queue_depth)
2026-07-30 20:53:52.096298 | instance | skipping: [instance] => (item=lpfc_sg_seg_cnt)
2026-07-30 20:53:52.096306 | instance | skipping: [instance] => (item=lpfc_max_luns)
2026-07-30 20:53:52.096315 | instance | skipping: [instance] => (item=lpfc_enable_fc4_type)
2026-07-30 20:53:52.096324 | instance | skipping: [instance]
2026-07-30 20:53:52.096333 | instance |
2026-07-30 20:53:52.096342 | instance | TASK [vexxhost.atmosphere.lpfc : Update "initramfs" if the configuration file has changed] ***
2026-07-30 20:53:52.096351 | instance | Thursday 30 July 2026  20:53:39 +0000 (0:00:00.032)       0:00:05.663 *********
2026-07-30 20:53:52.096360 | instance | skipping: [instance]
2026-07-30 20:53:52.096369 | instance |
2026-07-30 20:53:52.096378 | instance | TASK [Reboot the system if the configuration file has changed] *****************
2026-07-30 20:53:52.096386 | instance | Thursday 30 July 2026  20:53:39 +0000 (0:00:00.022)       0:00:05.686 *********
2026-07-30 20:53:52.096395 | instance | skipping: [instance]
2026-07-30 20:53:52.096404 | instance |
2026-07-30 20:53:52.096413 | instance | PLAY [Deploy SDN] **************************************************************
2026-07-30 20:53:52.096422 | instance |
2026-07-30 20:53:52.096431 | instance | PLAY [controllers[0]] **********************************************************
2026-07-30 20:53:52.096440 | instance |
2026-07-30 20:53:52.096448 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:53:52.096457 | instance | Thursday 30 July 2026  20:53:39 +0000 (0:00:00.161)       0:00:05.847 *********
2026-07-30 20:53:52.096466 | instance | ok: [instance]
2026-07-30 20:53:52.096475 | instance |
2026-07-30 20:53:52.096484 | instance | PLAY [controllers] *************************************************************
2026-07-30 20:53:52.096493 | instance |
2026-07-30 20:53:52.096501 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:53:52.096510 | instance | Thursday 30 July 2026  20:53:40 +0000 (0:00:01.241)       0:00:07.089 *********
2026-07-30 20:53:52.096519 | instance | ok: [instance]
2026-07-30 20:53:52.096528 | instance |
2026-07-30 20:53:52.096536 | instance | PLAY [Configure networking] ****************************************************
2026-07-30 20:53:52.096545 | instance |
2026-07-30 20:53:52.096554 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:53:52.096563 | instance | Thursday 30 July 2026  20:53:41 +0000 (0:00:00.865)       0:00:07.954 *********
2026-07-30 20:53:52.096572 | instance | ok: [instance]
2026-07-30 20:53:52.096580 | instance |
2026-07-30 20:53:52.096589 | instance | TASK [Add IP address to "br-ex"] ***********************************************
2026-07-30 20:53:52.096598 | instance | Thursday 30 July 2026  20:53:42 +0000 (0:00:00.840)       0:00:08.795 *********
2026-07-30 20:53:52.096607 | instance | ok: [instance]
2026-07-30 20:53:52.096616 | instance |
2026-07-30 20:53:52.096625 | instance | TASK [Set "br-ex" interface to "up"] *******************************************
2026-07-30 20:53:52.096634 | instance | Thursday 30 July 2026  20:53:42 +0000 (0:00:00.353)       0:00:09.148 *********
2026-07-30 20:53:52.096642 | instance | ok: [instance]
2026-07-30 20:53:52.096651 | instance |
2026-07-30 20:53:52.096665 | instance | PLAY RECAP *********************************************************************
2026-07-30 20:53:52.096674 | instance | instance                   : ok=12   changed=0    unreachable=0    failed=0    skipped=5    rescued=0    ignored=0
2026-07-30 20:53:52.096683 | instance |
2026-07-30 20:53:52.096692 | instance | Thursday 30 July 2026  20:53:42 +0000 (0:00:00.179)       0:00:09.328 *********
2026-07-30 20:53:52.096701 | instance | ===============================================================================
2026-07-30 20:53:52.096715 | instance | Gathering Facts --------------------------------------------------------- 1.30s
2026-07-30 20:53:52.096724 | instance | Gathering Facts --------------------------------------------------------- 1.24s
2026-07-30 20:53:52.096733 | instance | Gathering Facts --------------------------------------------------------- 1.22s
2026-07-30 20:53:52.096744 | instance | Gathering Facts --------------------------------------------------------- 0.99s
2026-07-30 20:53:52.096754 | instance | Gathering Facts --------------------------------------------------------- 0.87s
2026-07-30 20:53:52.096763 | instance | Gathering Facts --------------------------------------------------------- 0.87s
2026-07-30 20:53:52.096771 | instance | Gathering Facts --------------------------------------------------------- 0.84s
2026-07-30 20:53:52.096780 | instance | Set a fact with the "atmosphere_images" for other plays ----------------- 0.59s
2026-07-30 20:53:52.096789 | instance | Add IP address to "br-ex" ----------------------------------------------- 0.35s
2026-07-30 20:53:52.096798 | instance | Set a fact with the "atmosphere_images" for other plays ----------------- 0.33s
2026-07-30 20:53:52.096807 | instance | vexxhost.atmosphere.lpfc : Detect if the "lpfc" module is loaded -------- 0.25s
2026-07-30 20:53:52.096815 | instance | Set "br-ex" interface to "up" ------------------------------------------- 0.18s
2026-07-30 20:53:52.096824 | instance | Reboot the system if the configuration file has changed ----------------- 0.16s
2026-07-30 20:53:52.096833 | instance | vexxhost.atmosphere.lpfc : Get the values for the module parameters ----- 0.03s
2026-07-30 20:53:52.096842 | instance | vexxhost.atmosphere.lpfc : Detect if the run-time module parameters are set correctly --- 0.03s
2026-07-30 20:53:52.096851 | instance | vexxhost.atmosphere.lpfc : Install the configuration file --------------- 0.02s
2026-07-30 20:53:52.096860 | instance | vexxhost.atmosphere.lpfc : Update "initramfs" if the configuration file has changed --- 0.02s
2026-07-30 20:53:52.096869 | instance | INFO     [aio > converge] Executed: Successful
2026-07-30 20:53:52.096878 | instance | INFO     [aio > idempotence] Executing
2026-07-30 20:53:52.096887 | instance |
2026-07-30 20:53:52.096896 | instance | PLAY [all] *********************************************************************
2026-07-30 20:53:52.096904 | instance |
2026-07-30 20:53:52.096913 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-07-30 20:53:52.096922 | instance | Thursday 30 July 2026  20:53:45 +0000 (0:00:00.017)       0:00:00.017 *********
2026-07-30 20:53:52.096931 | instance | ok: [instance]
2026-07-30 20:53:52.096940 | instance |
2026-07-30 20:53:52.096948 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-07-30 20:53:52.096959 | instance |
2026-07-30 20:53:52.096968 | instance | PLAY [Deploy Ceph OSDs] ********************************************************
2026-07-30 20:53:52.096978 | instance |
2026-07-30 20:53:52.096987 | instance | PLAY [Deploy Ceph exporters] ***************************************************
2026-07-30 20:53:52.096996 | instance |
2026-07-30 20:53:52.097005 | instance | PLAY [all] *********************************************************************
2026-07-30 20:53:52.097014 | instance |
2026-07-30 20:53:52.097022 | instance | PLAY [all] *********************************************************************
2026-07-30 20:53:52.097031 | instance |
2026-07-30 20:53:52.097040 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-07-30 20:53:52.097049 | instance | Thursday 30 July 2026  20:53:46 +0000 (0:00:00.588)       0:00:00.605 *********
2026-07-30 20:53:52.097058 | instance | ok: [instance]
2026-07-30 20:53:52.097066 | instance |
2026-07-30 20:53:52.097075 | instance | PLAY [Configure Kubernetes VIP] ************************************************
2026-07-30 20:53:52.097089 | instance |
2026-07-30 20:53:52.097098 | instance | PLAY [Install Kubernetes] ******************************************************
2026-07-30 20:53:52.097107 | instance |
2026-07-30 20:53:52.097116 | instance | PLAY [Install control-plane components] ****************************************
2026-07-30 20:53:52.097125 | instance |
2026-07-30 20:53:52.097134 | instance | PLAY [all] *********************************************************************
2026-07-30 20:53:52.097143 | instance |
2026-07-30 20:53:52.097151 | instance | PLAY [all] *********************************************************************
2026-07-30 20:53:52.097160 | instance |
2026-07-30 20:53:52.097169 | instance | PLAY [controllers] *************************************************************
2026-07-30 20:53:52.097178 | instance |
2026-07-30 20:53:52.097187 | instance | PLAY [Deploy Infrastructure] ***************************************************
2026-07-30 20:53:52.097195 | instance |
2026-07-30 20:53:52.097228 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:53:52.097238 | instance | Thursday 30 July 2026  20:53:46 +0000 (0:00:00.320)       0:00:00.926 *********
2026-07-30 20:53:52.097248 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-07-30 20:53:52.097256 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-07-30 20:53:52.097265 | instance | interpreter could change the meaning of that path. See
2026-07-30 20:53:52.097274 | instance | https://docs.ansible.com/ansible-
2026-07-30 20:53:52.097283 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-07-30 20:53:52.097292 | instance | ok: [instance]
2026-07-30 20:53:52.097301 | instance |
2026-07-30 20:53:52.097310 | instance | PLAY [Deploy Monitoring] *******************************************************
2026-07-30 20:53:52.097319 | instance |
2026-07-30 20:53:52.097328 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:53:52.097337 | instance | Thursday 30 July 2026  20:53:47 +0000 (0:00:01.296)       0:00:02.222 *********
2026-07-30 20:53:52.097346 | instance | ok: [instance]
2026-07-30 20:53:52.097355 | instance |
2026-07-30 20:53:52.097364 | instance | PLAY [Deploy OpenStack] ********************************************************
2026-07-30 20:53:52.097372 | instance |
2026-07-30 20:53:52.097381 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:53:52.097390 | instance | Thursday 30 July 2026  20:53:48 +0000 (0:00:01.021)       0:00:03.243 *********
2026-07-30 20:53:52.097399 | instance | ok: [instance]
2026-07-30 20:53:52.097408 | instance |
2026-07-30 20:53:52.097417 | instance | PLAY [Configure operating system] **********************************************
2026-07-30 20:53:52.097426 | instance |
2026-07-30 20:53:52.097438 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:53:52.097447 | instance | Thursday 30 July 2026  20:53:50 +0000 (0:00:01.243)       0:00:04.486 *********
2026-07-30 20:53:52.097461 | instance | ok: [instance]
2026-07-30 20:53:52.097470 | instance |
2026-07-30 20:53:52.097478 | instance | TASK [vexxhost.atmosphere.lpfc : Detect if the "lpfc" module is loaded] ********
2026-07-30 20:53:52.097487 | instance | Thursday 30 July 2026  20:53:51 +0000 (0:00:00.856)       0:00:05.342 *********
2026-07-30 20:53:52.097496 | instance | ok: [instance]
2026-07-30 20:53:52.097505 | instance |
2026-07-30 20:53:52.097514 | instance | TASK [vexxhost.atmosphere.lpfc : Install the configuration file] ***************
2026-07-30 20:53:52.097523 | instance | Thursday 30 July 2026  20:53:51 +0000 (0:00:00.250)       0:00:05.593 *********
2026-07-30 20:53:52.097531 | instance | skipping: [instance]
2026-07-30 20:53:52.097540 | instance |
2026-07-30 20:53:52.097549 | instance | TASK [vexxhost.atmosphere.lpfc : Get the values for the module parameters] *****
2026-07-30 20:53:52.097558 | instance | Thursday 30 July 2026  20:53:51 +0000 (0:00:00.026)       0:00:05.620 *********
2026-07-30 20:53:52.097567 | instance | skipping: [instance] => (item=lpfc_lun_queue_depth)
2026-07-30 20:53:52.097576 | instance | skipping: [instance] => (item=lpfc_sg_seg_cnt)
2026-07-30 20:53:52.097584 | instance | skipping: [instance] => (item=lpfc_max_luns)
2026-07-30 20:53:52.097593 | instance | skipping: [instance] => (item=lpfc_enable_fc4_type)
2026-07-30 20:53:52.097602 | instance | skipping: [instance]
2026-07-30 20:53:52.097616 | instance |
2026-07-30 20:53:52.097625 | instance | TASK [vexxhost.atmosphere.lpfc : Detect if the run-time module parameters are set correctly] ***
2026-07-30 20:53:52.097634 | instance | Thursday 30 July 2026  20:53:51 +0000 (0:00:00.034)       0:00:05.654 *********
2026-07-30 20:53:52.097643 | instance | skipping: [instance] => (item=lpfc_lun_queue_depth)
2026-07-30 20:53:52.097652 | instance | skipping: [instance] => (item=lpfc_sg_seg_cnt)
2026-07-30 20:53:52.097661 | instance | skipping: [instance] => (item=lpfc_max_luns)
2026-07-30 20:53:52.097670 | instance | skipping: [instance] => (item=lpfc_enable_fc4_type)
2026-07-30 20:53:52.097678 | instance | skipping: [instance]
2026-07-30 20:53:52.097687 | instance |
2026-07-30 20:53:52.097696 | instance | TASK [vexxhost.atmosphere.lpfc : Update "initramfs" if the configuration file has changed] ***
2026-07-30 20:53:52.097705 | instance | Thursday 30 July 2026  20:53:51 +0000 (0:00:00.034)       0:00:05.688 *********
2026-07-30 20:53:52.097714 | instance | skipping: [instance]
2026-07-30 20:53:52.097723 | instance |
2026-07-30 20:53:52.097732 | instance | TASK [Reboot the system if the configuration file has changed] *****************
2026-07-30 20:53:52.097741 | instance | Thursday 30 July 2026  20:53:51 +0000 (0:00:00.022)       0:00:05.711 *********
2026-07-30 20:53:52.097750 | instance | skipping: [instance]
2026-07-30 20:53:52.097759 | instance |
2026-07-30 20:53:52.097767 | instance | PLAY [Deploy SDN] **************************************************************
2026-07-30 20:53:52.097776 | instance |
2026-07-30 20:53:52.097785 | instance | PLAY [controllers[0]] **********************************************************
2026-07-30 20:53:52.097794 | instance |
2026-07-30 20:53:52.097803 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:53:52.097812 | instance | Thursday 30 July 2026  20:53:51 +0000 (0:00:00.167)       0:00:05.879 *********
2026-07-30 20:53:52.444058 | instance | ok: Runtime: 0:00:00.009292
2026-07-30 20:53:52.455867 | 
2026-07-30 20:53:52.455972 | TASK [Track last task for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:52.520905 | instance | ok
2026-07-30 20:53:52.530302 | 
2026-07-30 20:53:52.530419 | TASK [Advance live log offset for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:52.583481 | instance | ok
2026-07-30 20:53:52.590693 | 
2026-07-30 20:53:52.590768 | TASK [Report progress heartbeat for Molecule aio (aio-openvswitch)]
2026-07-30 20:53:52.645578 | instance | ok:
2026-07-30 20:53:52.645761 | instance | Molecule aio (aio-openvswitch) is still running after 80 seconds.
2026-07-30 20:53:52.645801 | instance | Last task: TASK [Gathering Facts]
2026-07-30 20:53:52.655276 | 
2026-07-30 20:53:52.655348 | TASK [Continue monitoring Molecule aio (aio-openvswitch)]
2026-07-30 20:53:52.824835 | instance | ok
2026-07-30 20:53:52.835838 | instance | included: /var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-command.yml
2026-07-30 20:53:52.851626 | 
2026-07-30 20:53:52.851708 | TASK [Wait before polling Molecule aio (aio-openvswitch)]
2026-07-30 20:54:12.913957 | instance | ok
2026-07-30 20:54:12.921450 | 
2026-07-30 20:54:12.921543 | TASK [Count progress poll for Molecule aio (aio-openvswitch)]
2026-07-30 20:54:12.978258 | instance | ok
2026-07-30 20:54:12.985807 | 
2026-07-30 20:54:12.985884 | TASK [Poll status for Molecule aio (aio-openvswitch)]
2026-07-30 20:54:13.212862 | instance | ok
2026-07-30 20:54:13.219414 | 
2026-07-30 20:54:13.219489 | TASK [Inspect live log for Molecule aio (aio-openvswitch)]
2026-07-30 20:54:13.402864 | instance | ok
2026-07-30 20:54:13.550976 | 
2026-07-30 20:54:13.551093 | TASK [Calculate new output for Molecule aio (aio-openvswitch)]
2026-07-30 20:54:13.606629 | instance | ok
2026-07-30 20:54:13.613989 | 
2026-07-30 20:54:13.614103 | TASK [Read new output for Molecule aio (aio-openvswitch)]
2026-07-30 20:54:13.812888 | instance | ok: [instance]
2026-07-30 20:54:13.813001 | instance |
2026-07-30 20:54:13.813017 | instance | PLAY [controllers] *************************************************************
2026-07-30 20:54:13.813028 | instance |
2026-07-30 20:54:13.813041 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:54:13.813054 | instance | Thursday 30 July 2026  20:53:52 +0000 (0:00:01.295)       0:00:07.174 *********
2026-07-30 20:54:13.813068 | instance | ok: [instance]
2026-07-30 20:54:13.813078 | instance |
2026-07-30 20:54:13.813089 | instance | PLAY [Configure networking] ****************************************************
2026-07-30 20:54:13.813099 | instance |
2026-07-30 20:54:13.813109 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:54:13.813120 | instance | Thursday 30 July 2026  20:53:53 +0000 (0:00:00.894)       0:00:08.069 *********
2026-07-30 20:54:13.813130 | instance | ok: [instance]
2026-07-30 20:54:13.813140 | instance |
2026-07-30 20:54:13.813150 | instance | TASK [Add IP address to "br-ex"] ***********************************************
2026-07-30 20:54:13.813159 | instance | Thursday 30 July 2026  20:53:54 +0000 (0:00:00.850)       0:00:08.919 *********
2026-07-30 20:54:13.813169 | instance | ok: [instance]
2026-07-30 20:54:13.813179 | instance |
2026-07-30 20:54:13.813188 | instance | TASK [Set "br-ex" interface to "up"] *******************************************
2026-07-30 20:54:13.813198 | instance | Thursday 30 July 2026  20:53:54 +0000 (0:00:00.359)       0:00:09.279 *********
2026-07-30 20:54:13.813208 | instance | ok: [instance]
2026-07-30 20:54:13.813217 | instance |
2026-07-30 20:54:13.813227 | instance | PLAY RECAP *********************************************************************
2026-07-30 20:54:13.813242 | instance | instance                   : ok=12   changed=0    unreachable=0    failed=0    skipped=5    rescued=0    ignored=0
2026-07-30 20:54:13.813253 | instance |
2026-07-30 20:54:13.813262 | instance | Thursday 30 July 2026  20:53:55 +0000 (0:00:00.180)       0:00:09.459 *********
2026-07-30 20:54:13.813272 | instance | ===============================================================================
2026-07-30 20:54:13.813282 | instance | Gathering Facts --------------------------------------------------------- 1.30s
2026-07-30 20:54:13.813291 | instance | Gathering Facts --------------------------------------------------------- 1.30s
2026-07-30 20:54:13.813301 | instance | Gathering Facts --------------------------------------------------------- 1.24s
2026-07-30 20:54:13.813310 | instance | Gathering Facts --------------------------------------------------------- 1.02s
2026-07-30 20:54:13.813320 | instance | Gathering Facts --------------------------------------------------------- 0.89s
2026-07-30 20:54:13.813330 | instance | Gathering Facts --------------------------------------------------------- 0.86s
2026-07-30 20:54:13.813339 | instance | Gathering Facts --------------------------------------------------------- 0.85s
2026-07-30 20:54:13.813349 | instance | Set a fact with the "atmosphere_images" for other plays ----------------- 0.59s
2026-07-30 20:54:13.813372 | instance | Add IP address to "br-ex" ----------------------------------------------- 0.36s
2026-07-30 20:54:13.813452 | instance | Set a fact with the "atmosphere_images" for other plays ----------------- 0.32s
2026-07-30 20:54:13.813470 | instance | vexxhost.atmosphere.lpfc : Detect if the "lpfc" module is loaded -------- 0.25s
2026-07-30 20:54:13.813480 | instance | Set "br-ex" interface to "up" ------------------------------------------- 0.18s
2026-07-30 20:54:13.813490 | instance | Reboot the system if the configuration file has changed ----------------- 0.17s
2026-07-30 20:54:13.813500 | instance | vexxhost.atmosphere.lpfc : Detect if the run-time module parameters are set correctly --- 0.03s
2026-07-30 20:54:13.813510 | instance | vexxhost.atmosphere.lpfc : Get the values for the module parameters ----- 0.03s
2026-07-30 20:54:13.813519 | instance | vexxhost.atmosphere.lpfc : Install the configuration file --------------- 0.03s
2026-07-30 20:54:13.813529 | instance | vexxhost.atmosphere.lpfc : Update "initramfs" if the configuration file has changed --- 0.02s
2026-07-30 20:54:13.813540 | instance | INFO     [aio > idempotence] Executed: Successful
2026-07-30 20:54:13.813551 | instance | INFO     [aio > side_effect] Executing
2026-07-30 20:54:13.813560 | instance | WARNING  [aio > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-07-30 20:54:13.813580 | instance | INFO     [aio > verify] Executing
2026-07-30 20:54:13.813590 | instance |
2026-07-30 20:54:13.813600 | instance | PLAY [Run tests] ***************************************************************
2026-07-30 20:54:13.813609 | instance |
2026-07-30 20:54:13.813619 | instance | TASK [Run "stestr" tests] ******************************************************
2026-07-30 20:54:13.813629 | instance | Thursday 30 July 2026  20:53:56 +0000 (0:00:00.022)       0:00:00.022 *********
2026-07-30 20:54:13.813639 | instance | [WARNING]: conditional statements should not include jinja2 templating
2026-07-30 20:54:13.813648 | instance | delimiters such as {{ }} or {% %}. Found: {{   lookup('env',
2026-07-30 20:54:13.813658 | instance | 'ATMOSPHERE_CI_RUN_STESTR')   | default('true', true)   | bool }}
2026-07-30 20:54:13.813668 | instance | skipping: [localhost]
2026-07-30 20:54:13.813677 | instance |
2026-07-30 20:54:13.813687 | instance | PLAY [Verify selected OpenStack APIs] ******************************************
2026-07-30 20:54:13.813696 | instance |
2026-07-30 20:54:13.813706 | instance | PLAY [Run Tempest tests] *******************************************************
2026-07-30 20:54:13.813716 | instance |
2026-07-30 20:54:13.813725 | instance | TASK [Gathering Facts] *********************************************************
2026-07-30 20:54:13.813735 | instance | Thursday 30 July 2026  20:53:56 +0000 (0:00:00.048)       0:00:00.070 *********
2026-07-30 20:54:13.813744 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-07-30 20:54:13.813754 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-07-30 20:54:13.813764 | instance | interpreter could change the meaning of that path. See
2026-07-30 20:54:13.813774 | instance | https://docs.ansible.com/ansible-
2026-07-30 20:54:13.813784 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-07-30 20:54:13.813793 | instance | ok: [instance]
2026-07-30 20:54:13.813803 | instance |
2026-07-30 20:54:13.813813 | instance | TASK [vexxhost.atmosphere.openstacksdk : Install openstacksdk] *****************
2026-07-30 20:54:13.813832 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:01.156)       0:00:01.227 *********
2026-07-30 20:54:13.813843 | instance | skipping: [instance]
2026-07-30 20:54:13.813852 | instance |
2026-07-30 20:54:13.813862 | instance | TASK [vexxhost.atmosphere.openstacksdk : Create openstack config directory] ****
2026-07-30 20:54:13.813871 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:00.036)       0:00:01.263 *********
2026-07-30 20:54:13.813881 | instance | skipping: [instance]
2026-07-30 20:54:13.813891 | instance |
2026-07-30 20:54:13.813900 | instance | TASK [vexxhost.atmosphere.openstacksdk : Generate cloud config file] ***********
2026-07-30 20:54:13.813910 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:00.035)       0:00:01.299 *********
2026-07-30 20:54:13.813920 | instance | skipping: [instance]
2026-07-30 20:54:13.813929 | instance |
2026-07-30 20:54:13.813939 | instance | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Retrieve list of all the needed endpoints] ***
2026-07-30 20:54:13.813949 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:00.044)       0:00:01.344 *********
2026-07-30 20:54:13.813959 | instance | skipping: [instance]
2026-07-30 20:54:13.813969 | instance |
2026-07-30 20:54:13.813978 | instance | TASK [Create RabbitMQ cluster] *************************************************
2026-07-30 20:54:13.813988 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:00.034)       0:00:01.378 *********
2026-07-30 20:54:13.813997 | instance | skipping: [instance]
2026-07-30 20:54:13.814007 | instance |
2026-07-30 20:54:13.814016 | instance | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Grab RabbitMQ cluster secret] ***
2026-07-30 20:54:13.814030 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:00.036)       0:00:01.414 *********
2026-07-30 20:54:13.814040 | instance | skipping: [instance]
2026-07-30 20:54:13.814050 | instance |
2026-07-30 20:54:13.814060 | instance | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Cache fact with RabbitMQ cluster credentials] ***
2026-07-30 20:54:13.814069 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:00.034)       0:00:01.449 *********
2026-07-30 20:54:13.814079 | instance | skipping: [instance]
2026-07-30 20:54:13.814088 | instance |
2026-07-30 20:54:13.814098 | instance | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Grab Percona XtraDB cluster secret] ***
2026-07-30 20:54:13.814114 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:00.034)       0:00:01.483 *********
2026-07-30 20:54:13.814124 | instance | skipping: [instance]
2026-07-30 20:54:13.814133 | instance |
2026-07-30 20:54:13.814143 | instance | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Cache fact with Percona XtraDB password] ***
2026-07-30 20:54:13.814152 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:00.040)       0:00:01.524 *********
2026-07-30 20:54:13.814162 | instance | skipping: [instance]
2026-07-30 20:54:13.814172 | instance |
2026-07-30 20:54:13.814181 | instance | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Reset value for OpenStack_Helm endpoints] ***
2026-07-30 20:54:13.814191 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:00.044)       0:00:01.568 *********
2026-07-30 20:54:13.814201 | instance | skipping: [instance]
2026-07-30 20:54:13.814210 | instance |
2026-07-30 20:54:13.814220 | instance | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Generate OpenStack-Helm endpoints] ***
2026-07-30 20:54:13.814229 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:00.035)       0:00:01.604 *********
2026-07-30 20:54:13.814239 | instance | skipping: [instance]
2026-07-30 20:54:13.814248 | instance |
2026-07-30 20:54:13.814258 | instance | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Clean-up facts] ***********
2026-07-30 20:54:13.814268 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:00.039)       0:00:01.644 *********
2026-07-30 20:54:13.814277 | instance | skipping: [instance]
2026-07-30 20:54:13.814287 | instance |
2026-07-30 20:54:13.814296 | instance | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-07-30 20:54:13.814306 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:00.042)       0:00:01.686 *********
2026-07-30 20:54:13.814315 | instance | skipping: [instance]
2026-07-30 20:54:13.814325 | instance |
2026-07-30 20:54:13.814334 | instance | TASK [Generate OpenStack-Helm endpoints] ***************************************
2026-07-30 20:54:13.814344 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:00.039)       0:00:01.725 *********
2026-07-30 20:54:13.814353 | instance | skipping: [instance]
2026-07-30 20:54:13.814363 | instance |
2026-07-30 20:54:13.814372 | instance | TASK [vexxhost.atmosphere.tempest : Read cluster issuer CA secret] *************
2026-07-30 20:54:13.814382 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:00.038)       0:00:01.763 *********
2026-07-30 20:54:13.814391 | instance | skipping: [instance]
2026-07-30 20:54:13.814401 | instance |
2026-07-30 20:54:13.814410 | instance | TASK [vexxhost.atmosphere.tempest : Copy cluster issuer CA into Tempest namespace] ***
2026-07-30 20:54:13.814420 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:00.038)       0:00:01.802 *********
2026-07-30 20:54:13.814429 | instance | skipping: [instance]
2026-07-30 20:54:13.814439 | instance |
2026-07-30 20:54:13.814448 | instance | TASK [vexxhost.atmosphere.tempest : Get test image object] *********************
2026-07-30 20:54:13.814458 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:00.035)       0:00:01.837 *********
2026-07-30 20:54:13.814467 | instance | skipping: [instance]
2026-07-30 20:54:13.814477 | instance |
2026-07-30 20:54:13.814486 | instance | TASK [vexxhost.atmosphere.tempest : Configure test image ref] ******************
2026-07-30 20:54:13.814496 | instance | Thursday 30 July 2026  20:53:57 +0000 (0:00:00.033)       0:00:01.871 *********
2026-07-30 20:54:13.814506 | instance | skipping: [instance]
2026-07-30 20:54:13.814515 | instance |
2026-07-30 20:54:13.814525 | instance | TASK [vexxhost.atmosphere.tempest : Get test flavor object] ********************
2026-07-30 20:54:13.814534 | instance | Thursday 30 July 2026  20:53:58 +0000 (0:00:00.037)       0:00:01.909 *********
2026-07-30 20:54:13.814544 | instance | skipping: [instance]
2026-07-30 20:54:13.814553 | instance |
2026-07-30 20:54:13.814563 | instance | TASK [vexxhost.atmosphere.tempest : Set test flavor ref] ***********************
2026-07-30 20:54:13.814572 | instance | Thursday 30 July 2026  20:53:58 +0000 (0:00:00.040)       0:00:01.950 *********
2026-07-30 20:54:13.814582 | instance | skipping: [instance]
2026-07-30 20:54:13.814591 | instance |
2026-07-30 20:54:13.814601 | instance | TASK [vexxhost.atmosphere.tempest : Get test network object] *******************
2026-07-30 20:54:13.814611 | instance | Thursday 30 July 2026  20:53:58 +0000 (0:00:00.031)       0:00:01.981 *********
2026-07-30 20:54:13.814626 | instance | skipping: [instance]
2026-07-30 20:54:13.814636 | instance |
2026-07-30 20:54:13.814645 | instance | TASK [vexxhost.atmosphere.tempest : Set test network ref] **********************
2026-07-30 20:54:13.814677 | instance | Thursday 30 July 2026  20:53:58 +0000 (0:00:00.032)       0:00:02.013 *********
2026-07-30 20:54:13.814688 | instance | skipping: [instance]
2026-07-30 20:54:13.814697 | instance |
2026-07-30 20:54:13.814715 | instance | TASK [vexxhost.atmosphere.tempest : Deploy Helm chart] *************************
2026-07-30 20:54:13.814725 | instance | Thursday 30 July 2026  20:53:58 +0000 (0:00:00.028)       0:00:02.042 *********
2026-07-30 20:54:13.814735 | instance | skipping: [instance]
2026-07-30 20:54:13.814745 | instance |
2026-07-30 20:54:13.814758 | instance | TASK [vexxhost.atmosphere.tempest : Get tempest job object] ********************
2026-07-30 20:54:13.814768 | instance | Thursday 30 July 2026  20:53:58 +0000 (0:00:00.024)       0:00:02.067 *********
2026-07-30 20:54:13.814778 | instance | skipping: [instance]
2026-07-30 20:54:13.814787 | instance |
2026-07-30 20:54:13.814797 | instance | TASK [vexxhost.atmosphere.tempest : Get tempest log] ***************************
2026-07-30 20:54:13.814807 | instance | Thursday 30 July 2026  20:53:58 +0000 (0:00:00.026)       0:00:02.094 *********
2026-07-30 20:54:13.814816 | instance | skipping: [instance]
2026-07-30 20:54:13.814826 | instance |
2026-07-30 20:54:13.814835 | instance | TASK [vexxhost.atmosphere.tempest : Print tempest log details] *****************
2026-07-30 20:54:13.814845 | instance | Thursday 30 July 2026  20:53:58 +0000 (0:00:00.025)       0:00:02.119 *********
2026-07-30 20:54:13.814854 | instance | skipping: [instance]
2026-07-30 20:54:13.814864 | instance |
2026-07-30 20:54:13.814873 | instance | TASK [vexxhost.atmosphere.tempest : Fail when tempest result is failed] ********
2026-07-30 20:54:13.814883 | instance | Thursday 30 July 2026  20:53:58 +0000 (0:00:00.025)       0:00:02.145 *********
2026-07-30 20:54:13.814893 | instance | skipping: [instance]
2026-07-30 20:54:13.814902 | instance |
2026-07-30 20:54:13.814912 | instance | PLAY RECAP *********************************************************************
2026-07-30 20:54:13.814921 | instance | instance                   : ok=1    changed=0    unreachable=0    failed=0    skipped=27   rescued=0    ignored=0
2026-07-30 20:54:13.814931 | instance | localhost                  : ok=0    changed=0    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-07-30 20:54:13.814941 | instance |
2026-07-30 20:54:13.814950 | instance | Thursday 30 July 2026  20:53:58 +0000 (0:00:00.025)       0:00:02.171 *********
2026-07-30 20:54:13.814960 | instance | ===============================================================================
2026-07-30 20:54:13.814970 | instance | Gathering Facts --------------------------------------------------------- 1.16s
2026-07-30 20:54:13.814979 | instance | Run "stestr" tests ------------------------------------------------------ 0.05s
2026-07-30 20:54:13.814989 | instance | vexxhost.atmosphere.openstacksdk : Generate cloud config file ----------- 0.04s
2026-07-30 20:54:13.814999 | instance | vexxhost.atmosphere.openstack_helm_endpoints : Cache fact with Percona XtraDB password --- 0.04s
2026-07-30 20:54:13.815008 | instance | vexxhost.atmosphere.openstack_helm_endpoints : Clean-up facts ----------- 0.04s
2026-07-30 20:54:13.815018 | instance | vexxhost.atmosphere.tempest : Get test flavor object -------------------- 0.04s
2026-07-30 20:54:13.815028 | instance | vexxhost.atmosphere.openstack_helm_endpoints : Grab Percona XtraDB cluster secret --- 0.04s
2026-07-30 20:54:13.815037 | instance | vexxhost.atmosphere.openstack_helm_endpoints : Generate OpenStack-Helm endpoints --- 0.04s
2026-07-30 20:54:13.815047 | instance | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s
2026-07-30 20:54:13.815057 | instance | vexxhost.atmosphere.tempest : Read cluster issuer CA secret ------------- 0.04s
2026-07-30 20:54:13.815066 | instance | Generate OpenStack-Helm endpoints --------------------------------------- 0.04s
2026-07-30 20:54:13.815076 | instance | vexxhost.atmosphere.tempest : Configure test image ref ------------------ 0.04s
2026-07-30 20:54:13.815085 | instance | vexxhost.atmosphere.openstacksdk : Install openstacksdk ----------------- 0.04s
2026-07-30 20:54:13.815095 | instance | Create RabbitMQ cluster ------------------------------------------------- 0.04s
2026-07-30 20:54:13.815111 | instance | vexxhost.atmosphere.openstack_helm_endpoints : Reset value for OpenStack_Helm endpoints --- 0.04s
2026-07-30 20:54:13.815121 | instance | vexxhost.atmosphere.openstacksdk : Create openstack config directory ---- 0.04s
2026-07-30 20:54:13.815131 | instance | vexxhost.atmosphere.tempest : Copy cluster issuer CA into Tempest namespace --- 0.04s
2026-07-30 20:54:13.815140 | instance | vexxhost.atmosphere.openstack_helm_endpoints : Grab RabbitMQ cluster secret --- 0.03s
2026-07-30 20:54:13.815150 | instance | vexxhost.atmosphere.openstack_helm_endpoints : Cache fact with RabbitMQ cluster credentials --- 0.03s
2026-07-30 20:54:13.815160 | instance | vexxhost.atmosphere.openstack_helm_endpoints : Retrieve list of all the needed endpoints --- 0.03s
2026-07-30 20:54:13.815170 | instance | INFO     [aio > verify] Executed: Successful
2026-07-30 20:54:13.815179 | instance | INFO     [aio > cleanup] Executing
2026-07-30 20:54:13.815189 | instance | WARNING  [aio > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-07-30 20:54:13.815199 | instance | INFO     [aio > destroy] Executing
2026-07-30 20:54:13.815209 | instance | WARNING  [aio > destroy] Skipping, '--destroy=never' requested.
2026-07-30 20:54:13.815218 | instance | INFO     [aio > destroy] Executed: Successful
2026-07-30 20:54:13.815228 | instance | WARNING  Molecule executed 1 scenario (1 missing files)
2026-07-30 20:54:14.159973 | instance | ok: Runtime: 0:00:00.010421
2026-07-30 20:54:14.170456 | 
2026-07-30 20:54:14.170535 | TASK [Track last task for Molecule aio (aio-openvswitch)]
2026-07-30 20:54:14.243642 | instance | ok
2026-07-30 20:54:14.251609 | 
2026-07-30 20:54:14.251687 | TASK [Advance live log offset for Molecule aio (aio-openvswitch)]
2026-07-30 20:54:14.313746 | instance | ok
2026-07-30 20:54:14.319714 | 
2026-07-30 20:54:14.319784 | TASK [Report progress heartbeat for Molecule aio (aio-openvswitch)]
2026-07-30 20:54:14.374372 | instance | skipping: Conditional result was False
2026-07-30 20:54:14.383321 | 
2026-07-30 20:54:14.383421 | TASK [Continue monitoring Molecule aio (aio-openvswitch)]
2026-07-30 20:54:14.428446 | instance | skipping: Conditional result was False
2026-07-30 20:54:14.435671 | 
2026-07-30 20:54:14.435741 | TASK [Start progress monitor chunk for Molecule aio (aio-openvswitch)]
2026-07-30 20:54:14.481298 | instance | skipping: Conditional result was False
2026-07-30 20:54:14.492222 | 
2026-07-30 20:54:14.492321 | TASK [Start progress monitor chunk for Molecule aio (aio-openvswitch)]
2026-07-30 20:54:14.538034 | instance | skipping: Conditional result was False
2026-07-30 20:54:14.546594 | 
2026-07-30 20:54:14.546706 | TASK [Start progress monitor chunk for Molecule aio (aio-openvswitch)]
2026-07-30 20:54:14.601921 | instance | skipping: Conditional result was False
2026-07-30 20:54:14.615331 | 
2026-07-30 20:54:14.615413 | TASK [Start progress monitor chunk for Molecule aio (aio-openvswitch)]
2026-07-30 20:54:14.660433 | instance | skipping: Conditional result was False
2026-07-30 20:54:14.672075 | 
2026-07-30 20:54:14.672162 | TASK [Clean up async state for Molecule aio (aio-openvswitch)]
2026-07-30 20:54:14.868103 | instance | ok
2026-07-30 20:54:14.874338 | 
2026-07-30 20:54:14.874429 | TASK [Assert success for Molecule aio (aio-openvswitch)]
2026-07-30 20:54:14.931216 | instance | ok: All assertions passed
2026-07-30 20:54:14.932441 | 
2026-07-30 20:54:14.932492 | PLAY RECAP
2026-07-30 20:54:14.932543 | instance | ok: 72 changed: 4 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 0
2026-07-30 20:54:14.932566 | 
2026-07-30 20:54:15.100630 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-30 20:54:15.113706 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-07-30 20:54:15.765280 | 
2026-07-30 20:54:15.765457 | PLAY [Publish selective Molecule plan]
2026-07-30 20:54:15.778616 | 
2026-07-30 20:54:15.778735 | TASK [Check for selective Molecule plan]
2026-07-30 20:54:16.134903 | instance | ok
2026-07-30 20:54:16.140930 | 
2026-07-30 20:54:16.141034 | TASK [Create log directory]
2026-07-30 20:54:16.503007 | instance | ok
2026-07-30 20:54:16.508667 | 
2026-07-30 20:54:16.508750 | TASK [Copy selective Molecule plan to logs]
2026-07-30 20:54:16.995748 | instance | changed
2026-07-30 20:54:16.998234 | 
2026-07-30 20:54:16.998282 | PLAY RECAP
2026-07-30 20:54:16.998329 | instance | ok: 3 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-30 20:54:16.998351 | 
2026-07-30 20:54:17.146283 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-07-30 20:54:17.164415 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-30 20:54:17.955218 | 
2026-07-30 20:54:17.955377 | PLAY [all]
2026-07-30 20:54:17.971359 | 
2026-07-30 20:54:17.971507 | TASK [gather-host-logs : creating directory for system status]
2026-07-30 20:54:18.339056 | instance | changed
2026-07-30 20:54:18.346184 | 
2026-07-30 20:54:18.346287 | TASK [gather-host-logs : Get logs for each host]
2026-07-30 20:54:18.736817 | instance | + systemd-cgls --full --all --no-pager
2026-07-30 20:54:18.749832 | instance | + ip addr
2026-07-30 20:54:18.751375 | instance | + ip route
2026-07-30 20:54:18.752741 | instance | + lsblk
2026-07-30 20:54:18.755369 | instance | + mount
2026-07-30 20:54:18.756773 | instance | + docker images
2026-07-30 20:54:18.757161 | instance | /bin/bash: line 7: docker: command not found
2026-07-30 20:54:18.757396 | instance | + brctl show
2026-07-30 20:54:18.757754 | instance | /bin/bash: line 8: brctl: command not found
2026-07-30 20:54:18.758004 | instance | + ps aux --sort=-%mem
2026-07-30 20:54:18.769006 | instance | + dpkg -l
2026-07-30 20:54:18.780962 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-07-30 20:54:18.781547 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-07-30 20:54:18.781637 | instance | /bin/bash: line 11: docker: command not found
2026-07-30 20:54:18.782032 | instance | + '[' '!' -z '' ']'
2026-07-30 20:54:18.886944 | instance | ok: Runtime: 0:00:00.050856
2026-07-30 20:54:18.894756 | 
2026-07-30 20:54:18.894863 | TASK [gather-host-logs : Downloads logs to executor]
2026-07-30 20:54:19.553115 | instance | changed:
2026-07-30 20:54:19.553286 | instance | created directory /var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/work/logs/instance
2026-07-30 20:54:19.553315 | instance | cd+++++++++ system/
2026-07-30 20:54:19.553338 | instance | >f+++++++++ system/brctl-show.txt
2026-07-30 20:54:19.553358 | instance | >f+++++++++ system/docker-images.txt
2026-07-30 20:54:19.553378 | instance | >f+++++++++ system/ip-addr.txt
2026-07-30 20:54:19.553410 | instance | >f+++++++++ system/ip-route.txt
2026-07-30 20:54:19.553433 | instance | >f+++++++++ system/lsblk.txt
2026-07-30 20:54:19.553454 | instance | >f+++++++++ system/mount.txt
2026-07-30 20:54:19.553475 | instance | >f+++++++++ system/packages.txt
2026-07-30 20:54:19.553495 | instance | >f+++++++++ system/ps.txt
2026-07-30 20:54:19.553514 | instance | >f+++++++++ system/systemd-cgls.txt
2026-07-30 20:54:19.563965 | 
2026-07-30 20:54:19.564076 | LOOP [helm-release-status : creating directory for helm release status]
2026-07-30 20:54:19.756884 | instance | changed: "values"
2026-07-30 20:54:19.925657 | instance | changed: "releases"
2026-07-30 20:54:19.941511 | 
2026-07-30 20:54:19.941679 | TASK [helm-release-status : Gather get release status for helm charts]
2026-07-30 20:54:20.192210 | instance | /bin/bash: line 3: kubectl: command not found
2026-07-30 20:54:20.527237 | instance | ok: Runtime: 0:00:00.006068
2026-07-30 20:54:20.534815 | 
2026-07-30 20:54:20.534929 | TASK [helm-release-status : Downloads logs to executor]
2026-07-30 20:54:21.038662 | instance | changed:
2026-07-30 20:54:21.038961 | instance | cd+++++++++ helm/
2026-07-30 20:54:21.039025 | instance | cd+++++++++ helm/releases/
2026-07-30 20:54:21.039074 | instance | cd+++++++++ helm/values/
2026-07-30 20:54:21.049073 | 
2026-07-30 20:54:21.049137 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-07-30 20:54:21.257125 | instance | changed
2026-07-30 20:54:21.263390 | 
2026-07-30 20:54:21.263490 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-07-30 20:54:21.470973 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-30 20:54:21.471075 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-30 20:54:21.476622 | instance | environment: line 1: kubectl: command not found
2026-07-30 20:54:21.478074 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-30 20:54:21.478600 | instance | environment: line 1: kubectl: command not found
2026-07-30 20:54:21.480088 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-30 20:54:21.481935 | instance | environment: line 1: kubectl: command not found
2026-07-30 20:54:21.483703 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-30 20:54:21.484489 | instance | environment: line 1: kubectl: command not found
2026-07-30 20:54:21.485473 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-30 20:54:21.487459 | instance | environment: line 1: kubectl: command not found
2026-07-30 20:54:21.488844 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-30 20:54:21.799014 | instance | ok: Runtime: 0:00:00.027422
2026-07-30 20:54:21.805919 | 
2026-07-30 20:54:21.805983 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-07-30 20:54:22.002534 | instance | changed
2026-07-30 20:54:22.010258 | 
2026-07-30 20:54:22.010336 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-07-30 20:54:22.211978 | instance | environment: line 5: kubectl: command not found
2026-07-30 20:54:22.213230 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-30 20:54:22.213419 | instance | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-30 20:54:22.213435 | instance |
2026-07-30 20:54:22.546720 | instance | ok: Runtime: 0:00:00.010475
2026-07-30 20:54:22.552378 | 
2026-07-30 20:54:22.552444 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-07-30 20:54:23.060428 | instance | changed:
2026-07-30 20:54:23.060593 | instance | cd+++++++++ objects/
2026-07-30 20:54:23.060622 | instance | cd+++++++++ objects/cluster/
2026-07-30 20:54:23.060644 | instance | cd+++++++++ objects/namespaced/
2026-07-30 20:54:23.069846 | 
2026-07-30 20:54:23.069916 | TASK [gather-pod-logs : creating directory for pod logs]
2026-07-30 20:54:23.531088 | instance | changed
2026-07-30 20:54:23.536007 | 
2026-07-30 20:54:23.536069 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-07-30 20:54:23.748994 | instance | changed
2026-07-30 20:54:23.755112 | 
2026-07-30 20:54:23.755180 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-07-30 20:54:23.975483 | instance | environment: line 3: kubectl: command not found
2026-07-30 20:54:24.289223 | instance | ok: Runtime: 0:00:00.009863
2026-07-30 20:54:24.297212 | 
2026-07-30 20:54:24.297382 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-07-30 20:54:24.774072 | instance | changed:
2026-07-30 20:54:24.774229 | instance | cd+++++++++ pod-logs/
2026-07-30 20:54:24.774256 | instance | cd+++++++++ pod-logs/failed-pods/
2026-07-30 20:54:24.782935 | 
2026-07-30 20:54:24.782996 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-07-30 20:54:24.970407 | instance | changed
2026-07-30 20:54:24.975936 | 
2026-07-30 20:54:24.976000 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-07-30 20:54:25.178208 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-30 20:54:25.514985 | instance | ok: Runtime: 0:00:00.034371
2026-07-30 20:54:25.523026 | 
2026-07-30 20:54:25.523280 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-07-30 20:54:25.768353 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-30 20:54:25.801059 | instance | ceph-mgr endpoints:
2026-07-30 20:54:26.225768 | instance | ok: Runtime: 0:00:00.037647
2026-07-30 20:54:26.231320 | 
2026-07-30 20:54:26.231396 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-07-30 20:54:26.471867 | instance | /bin/bash: line 4: kubectl: command not found
2026-07-30 20:54:26.802427 | instance | ok: Runtime: 0:00:00.036989
2026-07-30 20:54:26.808073 | 
2026-07-30 20:54:26.808160 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-07-30 20:54:27.314558 | instance | changed: cd+++++++++ prometheus/
2026-07-30 20:54:27.330105 | 
2026-07-30 20:54:27.330225 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-07-30 20:54:27.533901 | instance | changed
2026-07-30 20:54:27.540247 | 
2026-07-30 20:54:27.540353 | TASK [gather-selenium-data : Get selenium data]
2026-07-30 20:54:27.758736 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-07-30 20:54:27.760192 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-07-30 20:54:28.142350 | instance | ERROR
2026-07-30 20:54:28.142679 | instance | {
2026-07-30 20:54:28.142763 | instance |   "delta": "0:00:00.006161",
2026-07-30 20:54:28.142817 | instance |   "end": "2026-07-30 20:54:27.760551",
2026-07-30 20:54:28.142864 | instance |   "msg": "non-zero return code",
2026-07-30 20:54:28.142909 | instance |   "rc": 1,
2026-07-30 20:54:28.142938 | instance |   "start": "2026-07-30 20:54:27.754390"
2026-07-30 20:54:28.143032 | instance | }
2026-07-30 20:54:28.143069 | instance | ERROR: Ignoring Errors
2026-07-30 20:54:28.148147 | 
2026-07-30 20:54:28.148222 | TASK [gather-selenium-data : Downloads logs to executor]
2026-07-30 20:54:28.823588 | instance | changed: cd+++++++++ selenium/
2026-07-30 20:54:28.834669 | 
2026-07-30 20:54:28.834784 | PLAY RECAP
2026-07-30 20:54:28.834859 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-07-30 20:54:28.834915 | 
2026-07-30 20:54:29.192713 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-30 20:54:29.271871 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-30 20:54:30.019415 | 
2026-07-30 20:54:30.019538 | PLAY [all]
2026-07-30 20:54:30.031200 | 
2026-07-30 20:54:30.031278 | TASK [fetch-output : Set log path for multiple nodes]
2026-07-30 20:54:30.076896 | instance | skipping: Conditional result was False
2026-07-30 20:54:30.087177 | 
2026-07-30 20:54:30.087255 | TASK [fetch-output : Set log path for single node]
2026-07-30 20:54:30.141396 | instance | ok
2026-07-30 20:54:30.146240 | 
2026-07-30 20:54:30.146313 | LOOP [fetch-output : Ensure local output dirs]
2026-07-30 20:54:30.562361 | instance -> localhost | ok: "/var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/work/logs"
2026-07-30 20:54:31.257584 | instance -> localhost | changed: "/var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/work/artifacts"
2026-07-30 20:54:31.472946 | instance -> localhost | changed: "/var/lib/zuul/builds/0919f3f7a0dd4a6384d52ff72ecd0e5b/work/docs"
2026-07-30 20:54:31.497868 | 
2026-07-30 20:54:31.498009 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-07-30 20:54:32.159876 | instance | changed: .d..t...... ./
2026-07-30 20:54:32.160072 | instance | changed: All items complete
2026-07-30 20:54:32.160104 | 
2026-07-30 20:54:33.000490 | instance | changed: .d..t...... ./
2026-07-30 20:54:34.026662 | instance | changed: .d..t...... ./
2026-07-30 20:54:34.052981 | 
2026-07-30 20:54:34.053149 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-07-30 20:54:34.774233 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007255
2026-07-30 20:54:35.038809 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007343
2026-07-30 20:54:35.058246 | 
2026-07-30 20:54:35.058456 | PLAY [all]
2026-07-30 20:54:35.070569 | 
2026-07-30 20:54:35.071030 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-07-30 20:54:35.460837 | instance | changed
2026-07-30 20:54:35.563846 | 
2026-07-30 20:54:35.563950 | PLAY RECAP
2026-07-30 20:54:35.564003 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-30 20:54:35.564026 | 
2026-07-30 20:54:35.738358 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-30 20:54:35.751333 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-07-30 20:54:36.501667 | 
2026-07-30 20:54:36.501856 | PLAY [localhost]
2026-07-30 20:54:36.513293 | 
2026-07-30 20:54:36.513455 | TASK [Generate Zuul manifest]
2026-07-30 20:54:36.548197 | localhost | ok
2026-07-30 20:54:36.738941 | 
2026-07-30 20:54:36.739135 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-07-30 20:54:37.178554 | localhost | changed
2026-07-30 20:54:37.193410 | 
2026-07-30 20:54:37.193555 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-07-30 20:54:37.483158 | localhost | ok
2026-07-30 20:54:37.649992 | 
2026-07-30 20:54:37.650122 | TASK [Upload logs]
2026-07-30 20:54:37.672340 | localhost | ok
2026-07-30 20:54:37.820216 | 
2026-07-30 20:54:37.820361 | TASK [Set zuul-log-path fact]
2026-07-30 20:54:37.840522 | localhost | ok
2026-07-30 20:54:37.855302 | 
2026-07-30 20:54:37.855424 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-30 20:54:37.887621 | localhost | ok
2026-07-30 20:54:37.898150 | 
2026-07-30 20:54:37.898377 | TASK [upload-logs : Create log directories]
2026-07-30 20:54:38.302633 | localhost | changed
2026-07-30 20:54:38.315761 | 
2026-07-30 20:54:38.315929 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-07-30 20:54:38.889579 | localhost -> localhost | ok: Runtime: 0:00:00.185251
2026-07-30 20:54:38.909322 | 
2026-07-30 20:54:38.909503 | TASK [upload-logs : Upload logs to log server]
2026-07-30 20:54:39.474901 | localhost | Output suppressed because no_log was given
2026-07-30 20:54:39.481079 | 
2026-07-30 20:54:39.481180 | LOOP [upload-logs : Compress console log and json output]
2026-07-30 20:54:39.544490 | localhost | skipping: Conditional result was False
2026-07-30 20:54:39.552830 | localhost | skipping: Conditional result was False
2026-07-30 20:54:39.562542 | 
2026-07-30 20:54:39.562699 | LOOP [upload-logs : Upload compressed console log and json output]
2026-07-30 20:54:39.611113 | localhost | skipping: Conditional result was False
2026-07-30 20:54:39.611553 | 
2026-07-30 20:54:39.616239 | localhost | skipping: Conditional result was False
2026-07-30 20:54:39.629627 | 
2026-07-30 20:54:39.629804 | LOOP [upload-logs : Upload console log and json output]