2026-07-29 07:44:50.762874 | Job console starting
2026-07-29 07:44:50.777487 | Updating git repos
2026-07-29 07:44:52.422404 | Cloning repos into workspace
2026-07-29 07:46:28.444860 | Restoring repo states
2026-07-29 07:46:37.954037 | Merging changes
2026-07-29 07:46:57.139248 | Checking out repos
2026-07-29 07:47:48.944387 | Preparing playbooks
2026-07-29 07:49:50.858449 | Running Ansible setup
2026-07-29 07:50:01.796531 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-29 07:50:02.528518 | 
2026-07-29 07:50:02.528669 | PLAY [localhost]
2026-07-29 07:50:02.536805 | 
2026-07-29 07:50:02.536895 | TASK [Gathering Facts]
2026-07-29 07:50:03.870378 | localhost | ok
2026-07-29 07:50:03.880234 | 
2026-07-29 07:50:03.880354 | TASK [Setup log path fact]
2026-07-29 07:50:03.902122 | localhost | ok
2026-07-29 07:50:03.916302 | 
2026-07-29 07:50:03.916424 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-29 07:50:03.946572 | localhost | ok
2026-07-29 07:50:03.956874 | 
2026-07-29 07:50:03.957034 | TASK [emit-job-header : Print job information]
2026-07-29 07:50:03.999968 | # Job Information
2026-07-29 07:50:04.000171 | Ansible Version: 2.16.18
2026-07-29 07:50:04.000216 | Job: atmosphere-molecule-aio-ovn-selective
2026-07-29 07:50:04.000249 | Pipeline: check
2026-07-29 07:50:04.000277 | Executor: 2d72f0692154
2026-07-29 07:50:04.000304 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4165
2026-07-29 07:50:04.000336 | Event ID: a6013f70-8b20-11f1-956d-0d6c9cab974f
2026-07-29 07:50:04.004324 | 
2026-07-29 07:50:04.004413 | LOOP [emit-job-header : Print node information]
2026-07-29 07:50:04.110233 | localhost | ok:
2026-07-29 07:50:04.110616 | localhost | # Node Information
2026-07-29 07:50:04.110646 | localhost | Inventory Hostname: instance
2026-07-29 07:50:04.110670 | localhost | Hostname: np0000187363
2026-07-29 07:50:04.110690 | localhost | Username: zuul
2026-07-29 07:50:04.110713 | localhost | Distro: Ubuntu 22.04
2026-07-29 07:50:04.110733 | localhost | Provider: yul1
2026-07-29 07:50:04.110753 | localhost | Region: ca-ymq-1
2026-07-29 07:50:04.110771 | localhost | Label: ubuntu-jammy-16
2026-07-29 07:50:04.110789 | localhost | Product Name: OpenStack Nova
2026-07-29 07:50:04.110807 | localhost | Interface IP: 199.204.45.129
2026-07-29 07:50:04.123483 | 
2026-07-29 07:50:04.123643 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-07-29 07:50:06.640241 | localhost -> localhost | changed
2026-07-29 07:50:06.649998 | 
2026-07-29 07:50:06.650074 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-07-29 07:50:07.907521 | localhost -> localhost | changed
2026-07-29 07:50:07.920276 | 
2026-07-29 07:50:07.920344 | PLAY [all]
2026-07-29 07:50:07.930697 | 
2026-07-29 07:50:07.930786 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-07-29 07:50:08.383198 | instance -> localhost | ok
2026-07-29 07:50:08.391557 | 
2026-07-29 07:50:08.391666 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-07-29 07:50:08.426357 | instance | ok
2026-07-29 07:50:08.439973 | instance | included: /var/lib/zuul/builds/b73e5bc412004916919dda1c5217d1cc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-07-29 07:50:08.445608 | 
2026-07-29 07:50:08.445668 | TASK [add-build-sshkey : Create Temp SSH key]
2026-07-29 07:50:10.923158 | instance -> localhost | Generating public/private rsa key pair.
2026-07-29 07:50:10.923384 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/b73e5bc412004916919dda1c5217d1cc/work/b73e5bc412004916919dda1c5217d1cc_id_rsa
2026-07-29 07:50:10.923432 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/b73e5bc412004916919dda1c5217d1cc/work/b73e5bc412004916919dda1c5217d1cc_id_rsa.pub
2026-07-29 07:50:10.923494 | instance -> localhost | The key fingerprint is:
2026-07-29 07:50:10.923552 | instance -> localhost | SHA256:Hk3Lcj9HtNXiZ5H0QMJdq0MZsDbBG9ntl8tYWDFCI1I zuul-build-sshkey
2026-07-29 07:50:10.923607 | instance -> localhost | The key's randomart image is:
2026-07-29 07:50:10.923642 | instance -> localhost | +---[RSA 3072]----+
2026-07-29 07:50:10.923680 | instance -> localhost | |         .oE*B+=o|
2026-07-29 07:50:10.923715 | instance -> localhost | |          .+=oB+*|
2026-07-29 07:50:10.923747 | instance -> localhost | |          .+oo*+=|
2026-07-29 07:50:10.923778 | instance -> localhost | |         +.oo+.Bo|
2026-07-29 07:50:10.923809 | instance -> localhost | |        S =  oB =|
2026-07-29 07:50:10.923840 | instance -> localhost | |       . + . o.= |
2026-07-29 07:50:10.923870 | instance -> localhost | |        .   o .  |
2026-07-29 07:50:10.923900 | instance -> localhost | |             o   |
2026-07-29 07:50:10.923936 | instance -> localhost | |                 |
2026-07-29 07:50:10.923967 | instance -> localhost | +----[SHA256]-----+
2026-07-29 07:50:10.924047 | instance -> localhost | ok: Runtime: 0:00:01.807747
2026-07-29 07:50:10.933050 | 
2026-07-29 07:50:10.933156 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-07-29 07:50:10.967745 | instance | ok
2026-07-29 07:50:10.980508 | instance | included: /var/lib/zuul/builds/b73e5bc412004916919dda1c5217d1cc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-07-29 07:50:10.988543 | 
2026-07-29 07:50:10.988636 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-07-29 07:50:11.014523 | instance | skipping: Conditional result was False
2026-07-29 07:50:11.023878 | 
2026-07-29 07:50:11.023995 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-07-29 07:50:12.045957 | instance | changed
2026-07-29 07:50:12.109813 | 
2026-07-29 07:50:12.109957 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-07-29 07:50:12.290220 | instance | ok
2026-07-29 07:50:12.295289 | 
2026-07-29 07:50:12.295356 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-07-29 07:50:12.761788 | instance | changed
2026-07-29 07:50:12.768514 | 
2026-07-29 07:50:12.768595 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-07-29 07:50:13.260236 | instance | changed
2026-07-29 07:50:13.266960 | 
2026-07-29 07:50:13.267039 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-07-29 07:50:13.292071 | instance | skipping: Conditional result was False
2026-07-29 07:50:13.303288 | 
2026-07-29 07:50:13.303415 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-07-29 07:50:13.698056 | instance -> localhost | changed
2026-07-29 07:50:13.710857 | 
2026-07-29 07:50:13.710979 | TASK [add-build-sshkey : Add back temp key]
2026-07-29 07:50:14.214014 | instance -> localhost | Identity added: /var/lib/zuul/builds/b73e5bc412004916919dda1c5217d1cc/work/b73e5bc412004916919dda1c5217d1cc_id_rsa (zuul-build-sshkey)
2026-07-29 07:50:14.214243 | instance -> localhost | ok: Runtime: 0:00:00.015123
2026-07-29 07:50:14.220994 | 
2026-07-29 07:50:14.221078 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-07-29 07:50:14.503704 | instance | ok
2026-07-29 07:50:15.157415 | 
2026-07-29 07:50:15.157570 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-07-29 07:50:15.186092 | instance | skipping: Conditional result was False
2026-07-29 07:50:15.199763 | 
2026-07-29 07:50:15.199884 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-07-29 07:50:15.494731 | instance | ok
2026-07-29 07:50:15.500533 | 
2026-07-29 07:50:15.500608 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-07-29 07:50:34.560126 | instance | Output suppressed because no_log was given
2026-07-29 07:50:34.575441 | 
2026-07-29 07:50:34.575616 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-07-29 07:50:34.766916 | instance | ok: "logs"
2026-07-29 07:50:34.767219 | instance | ok: All items complete
2026-07-29 07:50:34.767262 | 
2026-07-29 07:50:34.914652 | instance | ok: "artifacts"
2026-07-29 07:50:35.089648 | instance | ok: "docs"
2026-07-29 07:50:35.108530 | 
2026-07-29 07:50:35.108750 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-07-29 07:50:35.307274 | instance | changed: "logs"
2026-07-29 07:50:35.474272 | instance | changed: "artifacts"
2026-07-29 07:50:35.643037 | instance | changed: "docs"
2026-07-29 07:50:35.657174 | 
2026-07-29 07:50:35.657439 | PLAY RECAP
2026-07-29 07:50:35.657532 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-07-29 07:50:35.657578 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-29 07:50:35.657609 | 
2026-07-29 07:50:36.580828 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-29 07:50:36.592236 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-29 07:50:37.306655 | 
2026-07-29 07:50:37.306804 | PLAY [all]
2026-07-29 07:50:37.381010 | 
2026-07-29 07:50:37.381250 | TASK [setup-uv : Extract archive]
2026-07-29 07:50:40.444666 | instance | changed
2026-07-29 07:50:40.451482 | 
2026-07-29 07:50:40.451561 | TASK [setup-uv : Print version]
2026-07-29 07:50:40.856670 | instance | uv 0.8.13
2026-07-29 07:50:40.990605 | instance | ok: Runtime: 0:00:00.012792
2026-07-29 07:50:41.002705 | 
2026-07-29 07:50:41.002825 | TASK [Install Ansible collection siblings]
2026-07-29 07:50:53.838744 | instance | changed:
2026-07-29 07:50:54.718323 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-07-29 07:50:54.718541 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-07-29 07:50:54.718623 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-07-29 07:50:54.718695 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-07-29 07:50:54.718775 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-07-29 07:50:54.718842 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-07-29 07:50:54.718893 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-07-29 07:50:54.718958 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-07-29 07:50:54.719027 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-07-29 07:50:54.719080 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-07-29 07:50:54.719125 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-07-29 07:50:54.719169 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-07-29 07:50:54.719222 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-07-29 07:50:54.719288 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-07-29 07:50:54.719353 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0
2026-07-29 07:50:54.719419 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-07-29 07:50:54.719483 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-07-29 07:50:54.719549 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-07-29 07:50:54.719695 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-07-29 07:50:54.719778 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-07-29 07:50:54.719829 | instance | Resolved vexxhost.ceph to v4.1.0 for >=3.2.0
2026-07-29 07:50:54.719878 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-07-29 07:50:54.719949 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-29 07:50:54.720020 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-07-29 07:50:54.720067 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0,>=6.0.0
2026-07-29 07:50:54.720110 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-29 07:50:54.720153 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-29 07:50:54.720195 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-29 07:50:54.720245 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-07-29 07:50:54.720310 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-07-29 07:50:54.720376 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-29 07:50:54.720441 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-29 07:50:54.720506 | instance | Checked out ansible.netcommon to 1.2.0
2026-07-29 07:50:54.720569 | 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-29 07:50:54.720638 | instance | Starting galaxy collection install process
2026-07-29 07:50:54.720684 | instance | Process install dependency map
2026-07-29 07:50:54.720729 | instance | Starting collection install process
2026-07-29 07:50:54.720833 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-07-29 07:50:54.720989 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-07-29 07:50:54.721110 | instance | ansible.netcommon:* was installed successfully
2026-07-29 07:50:54.721200 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-07-29 07:50:54.721269 | instance | Creating virtual environment at: .venv
2026-07-29 07:50:54.721320 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-29 07:50:54.721365 | instance | Downloading pygments (1.2MiB)
2026-07-29 07:50:54.721407 | instance | Downloading pydantic-core (2.0MiB)
2026-07-29 07:50:54.721459 | instance | Downloading openstacksdk (1.7MiB)
2026-07-29 07:50:54.721503 | instance | Downloading cryptography (4.2MiB)
2026-07-29 07:50:54.721547 | instance | Downloading setuptools (1.1MiB)
2026-07-29 07:50:54.721591 | instance | Downloading rjsonnet (1.2MiB)
2026-07-29 07:50:54.721642 | instance | Downloading netaddr (2.2MiB)
2026-07-29 07:50:54.721718 | instance | Downloading ansible-core (2.1MiB)
2026-07-29 07:50:54.721838 | instance | Downloading kubernetes (1.9MiB)
2026-07-29 07:50:54.721920 | instance |  Downloading rjsonnet
2026-07-29 07:50:54.721994 | instance |  Downloading pydantic-core
2026-07-29 07:50:54.722068 | instance |  Downloading netaddr
2026-07-29 07:50:54.722140 | instance |  Downloading pygments
2026-07-29 07:50:54.722205 | instance |  Downloading cryptography
2026-07-29 07:50:54.722269 | instance |  Downloading setuptools
2026-07-29 07:50:54.722334 | instance |  Downloading kubernetes
2026-07-29 07:50:54.722398 | instance |  Downloading ansible-core
2026-07-29 07:50:54.722460 | instance |  Downloading openstacksdk
2026-07-29 07:50:54.722520 | instance |    Building pyperclip==1.9.0
2026-07-29 07:50:54.722584 | instance |       Built pyperclip==1.9.0
2026-07-29 07:50:54.722642 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-29 07:50:54.722695 | instance | Installed 87 packages in 683ms
2026-07-29 07:50:54.722746 | instance | Checked out ansible.posix to 1.6.0
2026-07-29 07:50:54.722797 | 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-29 07:50:54.722853 | instance | Starting galaxy collection install process
2026-07-29 07:50:54.722957 | instance | Process install dependency map
2026-07-29 07:50:54.723047 | instance | Starting collection install process
2026-07-29 07:50:54.723126 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-07-29 07:50:54.723204 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-07-29 07:50:54.723281 | instance | ansible.posix:1.6.0 was installed successfully
2026-07-29 07:50:54.723359 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 07:50:54.723438 | instance | 2.17.12
2026-07-29 07:50:54.723516 | instance | Checked out ansible.utils to v6.0.3
2026-07-29 07:50:54.723642 | 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-29 07:50:54.723729 | instance | Starting galaxy collection install process
2026-07-29 07:50:54.723803 | instance | Process install dependency map
2026-07-29 07:50:54.723876 | instance | Starting collection install process
2026-07-29 07:50:54.723958 | instance | Installing 'ansible.utils:6.0.3' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-07-29 07:50:54.724050 | instance | Created collection for ansible.utils:6.0.3 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-07-29 07:50:54.724146 | instance | ansible.utils:6.0.3 was installed successfully
2026-07-29 07:50:54.724230 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 07:50:54.724298 | instance | 2.17.12
2026-07-29 07:50:54.724554 | instance | Checked out atmosphere.common to v0.7.0
2026-07-29 07:50:54.724620 | 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-29 07:50:54.724694 | instance | Starting galaxy collection install process
2026-07-29 07:50:54.724765 | instance | Process install dependency map
2026-07-29 07:50:54.724834 | instance | Starting collection install process
2026-07-29 07:50:54.724902 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-07-29 07:50:54.725018 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-07-29 07:50:54.725100 | instance | atmosphere.common:0.7.0 was installed successfully
2026-07-29 07:50:54.725172 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 07:50:54.725247 | instance | 2.17.12
2026-07-29 07:50:54.725321 | instance | Checked out community.crypto to 2.2.3
2026-07-29 07:50:54.725395 | 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-29 07:50:54.725469 | instance | Starting galaxy collection install process
2026-07-29 07:50:54.725542 | instance | Process install dependency map
2026-07-29 07:50:54.725599 | instance | Starting collection install process
2026-07-29 07:50:54.725644 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-07-29 07:50:54.725686 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-07-29 07:50:54.725728 | instance | community.crypto:2.2.3 was installed successfully
2026-07-29 07:50:54.725779 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 07:50:54.725846 | instance | 2.17.12
2026-07-29 07:50:54.725914 | instance | Checked out community.general to 7.3.0
2026-07-29 07:50:54.725977 | 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-29 07:50:54.726038 | instance | Starting galaxy collection install process
2026-07-29 07:50:54.726085 | instance | Process install dependency map
2026-07-29 07:50:54.726117 | instance | Starting collection install process
2026-07-29 07:50:54.726145 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-07-29 07:50:54.726184 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-07-29 07:50:54.726224 | instance | community.general:7.3.0 was installed successfully
2026-07-29 07:50:54.726267 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 07:50:54.726308 | instance | 2.17.12
2026-07-29 07:50:54.726352 | instance | Checked out community.mysql to 3.6.0
2026-07-29 07:50:54.726404 | 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-29 07:50:54.726447 | instance | Starting galaxy collection install process
2026-07-29 07:50:54.726486 | instance | Process install dependency map
2026-07-29 07:50:54.726524 | instance | Starting collection install process
2026-07-29 07:50:54.726562 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-07-29 07:50:54.726603 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-07-29 07:50:54.726643 | instance | community.mysql:3.6.0 was installed successfully
2026-07-29 07:50:54.726683 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 07:50:54.726726 | instance | 2.17.12
2026-07-29 07:50:54.726768 | instance | Checked out kubernetes.core to 2.4.0
2026-07-29 07:50:54.726809 | 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-29 07:50:54.726848 | instance | Starting galaxy collection install process
2026-07-29 07:50:54.726889 | instance | Process install dependency map
2026-07-29 07:50:54.726937 | instance | Starting collection install process
2026-07-29 07:50:54.726991 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-07-29 07:50:54.727042 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-07-29 07:50:54.727091 | instance | kubernetes.core:2.4.0 was installed successfully
2026-07-29 07:50:54.727136 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 07:50:54.727182 | instance | 2.17.12
2026-07-29 07:50:54.727227 | instance | Checked out openstack.cloud to 2.6.0
2026-07-29 07:50:54.727274 | 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-29 07:50:54.727318 | instance | Starting galaxy collection install process
2026-07-29 07:50:54.727363 | instance | Process install dependency map
2026-07-29 07:50:54.727408 | instance | Starting collection install process
2026-07-29 07:50:54.727454 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-07-29 07:50:54.727496 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-07-29 07:50:54.727539 | instance | openstack.cloud:2.6.0 was installed successfully
2026-07-29 07:50:54.727608 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 07:50:54.727651 | instance | 2.17.12
2026-07-29 07:50:54.727706 | instance | Checked out vexxhost.ceph to v4.1.0
2026-07-29 07:50:54.727747 | 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-29 07:50:54.727789 | instance | Starting galaxy collection install process
2026-07-29 07:50:54.727828 | instance | Process install dependency map
2026-07-29 07:50:54.727867 | instance | Starting collection install process
2026-07-29 07:50:54.727908 | instance | Installing 'vexxhost.ceph:4.1.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-07-29 07:50:54.727954 | instance | Created collection for vexxhost.ceph:4.1.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-07-29 07:50:54.728006 | instance | vexxhost.ceph:4.1.0 was installed successfully
2026-07-29 07:50:54.728056 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 07:50:54.728104 | instance | 2.17.12
2026-07-29 07:50:54.728153 | instance | Checked out vexxhost.containers to v1.6.8
2026-07-29 07:50:54.728195 | 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-29 07:50:54.728235 | instance | Starting galaxy collection install process
2026-07-29 07:50:54.728276 | instance | Process install dependency map
2026-07-29 07:50:54.728315 | instance | Starting collection install process
2026-07-29 07:50:54.728353 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-07-29 07:50:54.728392 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-07-29 07:50:54.728432 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-07-29 07:50:54.728472 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 07:50:54.728511 | instance | 2.17.12
2026-07-29 07:50:54.728554 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-07-29 07:50:54.728603 | 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-29 07:50:54.728647 | instance | Starting galaxy collection install process
2026-07-29 07:50:54.728690 | instance | Process install dependency map
2026-07-29 07:50:54.728735 | instance | Starting collection install process
2026-07-29 07:50:54.728782 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-07-29 07:50:54.728824 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-07-29 07:50:54.728863 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-07-29 07:50:54.728905 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 07:50:54.728944 | instance | 2.17.12
2026-07-29 07:50:54.737431 | 
2026-07-29 07:50:54.737502 | PLAY RECAP
2026-07-29 07:50:54.737561 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-29 07:50:54.737592 | 
2026-07-29 07:50:54.892942 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-29 07:50:55.186493 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-29 07:50:55.843959 | 
2026-07-29 07:50:55.844113 | PLAY [all]
2026-07-29 07:50:55.857332 | 
2026-07-29 07:50:55.857426 | TASK [Install "jq" for log collection]
2026-07-29 07:51:14.975619 | instance | changed
2026-07-29 07:51:14.985971 | 
2026-07-29 07:51:14.986268 | PLAY RECAP
2026-07-29 07:51:14.986392 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-29 07:51:14.986462 | 
2026-07-29 07:51:15.163728 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-29 07:51:15.178131 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-29 07:51:15.879535 | 
2026-07-29 07:51:15.879646 | PLAY [Prepare selective Molecule plan]
2026-07-29 07:51:15.890565 | 
2026-07-29 07:51:15.890638 | TASK [Generate selective Molecule plan]
2026-07-29 07:51:16.924826 | instance | ok: Runtime: 0:00:00.182369
2026-07-29 07:51:16.931469 | 
2026-07-29 07:51:16.931549 | TASK [Render selective Molecule plan]
2026-07-29 07:51:17.238445 | instance | Selective Molecule plan: selective
2026-07-29 07:51:17.238619 | instance | Changed files:
2026-07-29 07:51:17.238638 | instance |   M roles/cinder/README.md
2026-07-29 07:51:17.238653 | instance | Targets: cinder
2026-07-29 07:51:17.238667 | instance | Job decisions:
2026-07-29 07:51:17.238685 | instance |   RUN  aio-openvswitch: selected by changed components
2026-07-29 07:51:17.238731 | instance |        components: ceph, ceph-provisioners, cert-manager, cinder, cluster-issuer, csi, ingress-nginx, keycloak, keystone, kubernetes, memcached, percona-xtradb-cluster, percona-xtradb-cluster-operator, rabbitmq-cluster-operator
2026-07-29 07:51:17.238753 | instance |        Tempest include: ^tempest\.api\.volume\.
2026-07-29 07:51:17.238767 | instance |   SKIP aio-ovn: no changed component requires this job
2026-07-29 07:51:17.238781 | instance |   SKIP csi-local-path-provisioner: no changed component requires this job
2026-07-29 07:51:17.238794 | instance |   SKIP csi-rbd: no changed component requires this job
2026-07-29 07:51:17.238808 | instance |   SKIP keycloak: no changed component requires this job
2026-07-29 07:51:17.472046 | instance | ok: Runtime: 0:00:00.099590
2026-07-29 07:51:17.474285 | 
2026-07-29 07:51:17.474338 | PLAY RECAP
2026-07-29 07:51:17.474390 | instance | ok: 2 changed: 0 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-29 07:51:17.474413 | 
2026-07-29 07:51:17.684757 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-29 07:51:17.693359 | RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-29 07:51:18.379691 | 
2026-07-29 07:51:18.379822 | PLAY [Run selected Molecule scenario]
2026-07-29 07:51:18.391975 | 
2026-07-29 07:51:18.392052 | TASK [Read selective Molecule plan]
2026-07-29 07:51:18.730384 | instance | ok
2026-07-29 07:51:18.744343 | 
2026-07-29 07:51:18.744509 | TASK [Resolve this job decision]
2026-07-29 07:51:18.798868 | instance | ok
2026-07-29 07:51:18.811098 | 
2026-07-29 07:51:18.811204 | TASK [Assert this job exists in the plan]
2026-07-29 07:51:18.845916 | instance | ok: All assertions passed
2026-07-29 07:51:18.852698 | 
2026-07-29 07:51:18.852847 | TASK [Resolve selected scenario inputs]
2026-07-29 07:51:18.885610 | instance | ok
2026-07-29 07:51:18.890925 | 
2026-07-29 07:51:18.891028 | TASK [Report this job decision]
2026-07-29 07:51:18.954677 | instance | ok:
2026-07-29 07:51:18.954827 | instance | Selective Molecule job: aio-ovn
2026-07-29 07:51:18.954857 | instance | Decision: SKIP
2026-07-29 07:51:18.954882 | instance | Reason: no changed component requires this job
2026-07-29 07:51:18.954907 | instance | Scenario: aio
2026-07-29 07:51:18.954928 | instance | Targets: (none)
2026-07-29 07:51:18.954949 | instance | Components: (full scenario)
2026-07-29 07:51:18.962840 | 
2026-07-29 07:51:18.962912 | LOOP [Check Molecule inventory directories]
2026-07-29 07:51:19.007130 | instance | skipping: Conditional result was False
2026-07-29 07:51:19.009011 | instance | skipping: Conditional result was False
2026-07-29 07:51:19.012888 | instance | skipping: Conditional result was False
2026-07-29 07:51:19.034421 | 
2026-07-29 07:51:19.034568 | LOOP [Copy Zuul inventory for Molecule]
2026-07-29 07:51:19.076361 | instance | skipping: Conditional result was False
2026-07-29 07:51:19.076734 | 
2026-07-29 07:51:19.080246 | instance | skipping: Conditional result was False
2026-07-29 07:51:19.083264 | instance | skipping: Conditional result was False
2026-07-29 07:51:19.101171 | 
2026-07-29 07:51:19.101346 | LOOP [Use private addresses in Molecule inventory]
2026-07-29 07:51:19.151332 | instance | skipping: Conditional result was False
2026-07-29 07:51:19.152004 | 
2026-07-29 07:51:19.153068 | instance | skipping: Conditional result was False
2026-07-29 07:51:19.155001 | instance | skipping: Conditional result was False
2026-07-29 07:51:19.174498 | 
2026-07-29 07:51:19.174663 | TASK [Prepare Molecule command]
2026-07-29 07:51:19.218050 | instance | skipping: Conditional result was False
2026-07-29 07:51:19.227130 | 
2026-07-29 07:51:19.227292 | TASK [Run standard Molecule lifecycle with progress output]
2026-07-29 07:51:19.278142 | instance | skipping: Conditional result was False
2026-07-29 07:51:19.280385 | 
2026-07-29 07:51:19.280459 | PLAY RECAP
2026-07-29 07:51:19.280529 | instance | ok: 5 changed: 0 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-07-29 07:51:19.280560 | 
2026-07-29 07:51:19.492852 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-29 07:51:19.509184 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-07-29 07:51:20.262944 | 
2026-07-29 07:51:21.461961 | PLAY [Publish selective Molecule plan]
2026-07-29 07:51:21.481956 | 
2026-07-29 07:51:21.482174 | TASK [Check for selective Molecule plan]
2026-07-29 07:51:21.907299 | instance | ok
2026-07-29 07:51:22.216133 | 
2026-07-29 07:51:22.216347 | TASK [Create log directory]
2026-07-29 07:51:22.628707 | instance | changed
2026-07-29 07:51:23.343162 | 
2026-07-29 07:51:23.343330 | TASK [Copy selective Molecule plan to logs]
2026-07-29 07:51:23.816768 | instance | changed
2026-07-29 07:51:25.172521 | 
2026-07-29 07:51:25.172655 | PLAY RECAP
2026-07-29 07:51:25.172723 | instance | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-29 07:51:25.172780 | 
2026-07-29 07:51:25.382281 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-07-29 07:51:25.434805 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-29 07:51:26.110784 | 
2026-07-29 07:51:26.110918 | PLAY [all]
2026-07-29 07:51:26.125692 | 
2026-07-29 07:51:26.125790 | TASK [gather-host-logs : creating directory for system status]
2026-07-29 07:51:26.538465 | instance | changed
2026-07-29 07:51:26.687099 | 
2026-07-29 07:51:26.687220 | TASK [gather-host-logs : Get logs for each host]
2026-07-29 07:51:27.063794 | instance | + systemd-cgls --full --all --no-pager
2026-07-29 07:51:27.075824 | instance | + ip addr
2026-07-29 07:51:27.077430 | instance | + ip route
2026-07-29 07:51:27.078826 | instance | + lsblk
2026-07-29 07:51:27.081378 | instance | + mount
2026-07-29 07:51:27.082584 | instance | + docker images
2026-07-29 07:51:27.082942 | instance | /bin/bash: line 7: docker: command not found
2026-07-29 07:51:27.083108 | instance | + brctl show
2026-07-29 07:51:27.083419 | instance | /bin/bash: line 8: brctl: command not found
2026-07-29 07:51:27.083601 | instance | + ps aux --sort=-%mem
2026-07-29 07:51:27.093981 | instance | + dpkg -l
2026-07-29 07:51:27.101387 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-07-29 07:51:27.102056 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-07-29 07:51:27.102179 | instance | /bin/bash: line 11: docker: command not found
2026-07-29 07:51:27.102537 | instance | + '[' '!' -z '' ']'
2026-07-29 07:51:27.235544 | instance | ok: Runtime: 0:00:00.044476
2026-07-29 07:51:27.241966 | 
2026-07-29 07:51:27.242042 | TASK [gather-host-logs : Downloads logs to executor]
2026-07-29 07:51:27.967327 | instance | changed:
2026-07-29 07:51:27.967759 | instance | created directory /var/lib/zuul/builds/b73e5bc412004916919dda1c5217d1cc/work/logs/instance
2026-07-29 07:51:27.967836 | instance | cd+++++++++ system/
2026-07-29 07:51:27.967946 | instance | >f+++++++++ system/brctl-show.txt
2026-07-29 07:51:27.968006 | instance | >f+++++++++ system/docker-images.txt
2026-07-29 07:51:27.968072 | instance | >f+++++++++ system/ip-addr.txt
2026-07-29 07:51:27.968126 | instance | >f+++++++++ system/ip-route.txt
2026-07-29 07:51:27.968180 | instance | >f+++++++++ system/lsblk.txt
2026-07-29 07:51:27.968226 | instance | >f+++++++++ system/mount.txt
2026-07-29 07:51:27.968276 | instance | >f+++++++++ system/packages.txt
2026-07-29 07:51:27.968323 | instance | >f+++++++++ system/ps.txt
2026-07-29 07:51:27.968368 | instance | >f+++++++++ system/systemd-cgls.txt
2026-07-29 07:51:27.984911 | 
2026-07-29 07:51:27.985029 | LOOP [helm-release-status : creating directory for helm release status]
2026-07-29 07:51:28.192114 | instance | changed: "values"
2026-07-29 07:51:28.364119 | instance | changed: "releases"
2026-07-29 07:51:28.387724 | 
2026-07-29 07:51:28.388006 | TASK [helm-release-status : Gather get release status for helm charts]
2026-07-29 07:51:28.656843 | instance | /bin/bash: line 3: kubectl: command not found
2026-07-29 07:51:29.001545 | instance | ok: Runtime: 0:00:00.005600
2026-07-29 07:51:29.010903 | 
2026-07-29 07:51:29.011009 | TASK [helm-release-status : Downloads logs to executor]
2026-07-29 07:51:29.565236 | instance | changed:
2026-07-29 07:51:29.565423 | instance | cd+++++++++ helm/
2026-07-29 07:51:29.565463 | instance | cd+++++++++ helm/releases/
2026-07-29 07:51:29.565494 | instance | cd+++++++++ helm/values/
2026-07-29 07:51:29.587269 | 
2026-07-29 07:51:29.587379 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-07-29 07:51:29.818782 | instance | changed
2026-07-29 07:51:29.826857 | 
2026-07-29 07:51:29.826989 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-07-29 07:51:30.038388 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-29 07:51:30.038926 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-29 07:51:30.044260 | instance | environment: line 1: kubectl: command not found
2026-07-29 07:51:30.045066 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-29 07:51:30.047403 | instance | environment: line 1: kubectl: command not found
2026-07-29 07:51:30.048762 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-29 07:51:30.049786 | instance | environment: line 1: kubectl: command not found
2026-07-29 07:51:30.050758 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-29 07:51:30.051385 | instance | environment: line 1: kubectl: command not found
2026-07-29 07:51:30.052944 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-29 07:51:30.053636 | instance | environment: line 1: kubectl: command not found
2026-07-29 07:51:30.055221 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-29 07:51:30.377875 | instance | ok: Runtime: 0:00:00.028154
2026-07-29 07:51:30.384710 | 
2026-07-29 07:51:30.384797 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-07-29 07:51:30.621495 | instance | changed
2026-07-29 07:51:30.630387 | 
2026-07-29 07:51:30.630495 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-07-29 07:51:30.864937 | instance | environment: line 5: kubectl: command not found
2026-07-29 07:51:30.865374 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-29 07:51:30.865931 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-29 07:51:30.866040 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-29 07:51:31.170275 | instance | ok: Runtime: 0:00:00.010619
2026-07-29 07:51:31.177582 | 
2026-07-29 07:51:31.177715 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-07-29 07:51:32.213062 | instance | changed:
2026-07-29 07:51:32.213602 | instance | cd+++++++++ objects/
2026-07-29 07:51:32.213633 | instance | cd+++++++++ objects/cluster/
2026-07-29 07:51:32.213656 | instance | cd+++++++++ objects/namespaced/
2026-07-29 07:51:32.224681 | 
2026-07-29 07:51:32.225121 | TASK [gather-pod-logs : creating directory for pod logs]
2026-07-29 07:51:32.446438 | instance | changed
2026-07-29 07:51:32.453265 | 
2026-07-29 07:51:32.453391 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-07-29 07:51:32.664621 | instance | changed
2026-07-29 07:51:32.672093 | 
2026-07-29 07:51:32.672273 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-07-29 07:51:32.907451 | instance | environment: line 3: kubectl: command not found
2026-07-29 07:51:33.224086 | instance | ok: Runtime: 0:00:00.010819
2026-07-29 07:51:33.230104 | 
2026-07-29 07:51:33.230175 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-07-29 07:51:33.731281 | instance | changed:
2026-07-29 07:51:33.731506 | instance | cd+++++++++ pod-logs/
2026-07-29 07:51:33.731548 | instance | cd+++++++++ pod-logs/failed-pods/
2026-07-29 07:51:33.742079 | 
2026-07-29 07:51:33.742157 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-07-29 07:51:33.955602 | instance | changed
2026-07-29 07:51:33.961132 | 
2026-07-29 07:51:33.961205 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-07-29 07:51:34.176813 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-29 07:51:34.812760 | instance | ok: Runtime: 0:00:00.036513
2026-07-29 07:51:34.823192 | 
2026-07-29 07:51:34.823358 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-07-29 07:51:35.040314 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-29 07:51:35.072307 | instance | ceph-mgr endpoints:
2026-07-29 07:51:36.374212 | instance | ok: Runtime: 0:00:00.039004
2026-07-29 07:51:36.382389 | 
2026-07-29 07:51:36.382509 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-07-29 07:51:36.645734 | instance | /bin/bash: line 4: kubectl: command not found
2026-07-29 07:51:36.973931 | instance | ok: Runtime: 0:00:00.035545
2026-07-29 07:51:36.980650 | 
2026-07-29 07:51:36.980773 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-07-29 07:51:37.487105 | instance | changed: cd+++++++++ prometheus/
2026-07-29 07:51:37.511877 | 
2026-07-29 07:51:37.512049 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-07-29 07:51:37.729941 | instance | changed
2026-07-29 07:51:37.735761 | 
2026-07-29 07:51:37.735830 | TASK [gather-selenium-data : Get selenium data]
2026-07-29 07:51:37.966532 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-07-29 07:51:37.967240 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-07-29 07:51:38.588211 | instance | ERROR
2026-07-29 07:51:38.588485 | instance | {
2026-07-29 07:51:38.588536 | instance |   "delta": "0:00:00.003878",
2026-07-29 07:51:38.588563 | instance |   "end": "2026-07-29 07:51:37.967501",
2026-07-29 07:51:38.588583 | instance |   "msg": "non-zero return code",
2026-07-29 07:51:38.588602 | instance |   "rc": 1,
2026-07-29 07:51:38.588621 | instance |   "start": "2026-07-29 07:51:37.963623"
2026-07-29 07:51:38.588638 | instance | }
2026-07-29 07:51:38.588673 | instance | ERROR: Ignoring Errors
2026-07-29 07:51:38.598304 | 
2026-07-29 07:51:38.598406 | TASK [gather-selenium-data : Downloads logs to executor]
2026-07-29 07:51:39.135245 | instance | changed: cd+++++++++ selenium/
2026-07-29 07:51:39.690885 | 
2026-07-29 07:51:39.691008 | PLAY RECAP
2026-07-29 07:51:39.691070 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-07-29 07:51:39.691103 | 
2026-07-29 07:51:39.885114 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-29 07:51:39.914380 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-29 07:51:41.206123 | 
2026-07-29 07:51:41.206277 | PLAY [all]
2026-07-29 07:51:41.218852 | 
2026-07-29 07:51:41.218973 | TASK [fetch-output : Set log path for multiple nodes]
2026-07-29 07:51:41.265580 | instance | skipping: Conditional result was False
2026-07-29 07:51:41.274924 | 
2026-07-29 07:51:41.275070 | TASK [fetch-output : Set log path for single node]
2026-07-29 07:51:41.318242 | instance | ok
2026-07-29 07:51:41.324419 | 
2026-07-29 07:51:41.324487 | LOOP [fetch-output : Ensure local output dirs]
2026-07-29 07:51:44.157013 | instance -> localhost | ok: "/var/lib/zuul/builds/b73e5bc412004916919dda1c5217d1cc/work/logs"
2026-07-29 07:51:47.799787 | instance -> localhost | changed: "/var/lib/zuul/builds/b73e5bc412004916919dda1c5217d1cc/work/artifacts"
2026-07-29 07:51:48.042414 | instance -> localhost | changed: "/var/lib/zuul/builds/b73e5bc412004916919dda1c5217d1cc/work/docs"
2026-07-29 07:51:48.057849 | 
2026-07-29 07:51:48.058214 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-07-29 07:51:48.713081 | instance | changed: .d..t...... ./
2026-07-29 07:51:48.713316 | instance | changed: All items complete
2026-07-29 07:51:48.713358 | 
2026-07-29 07:51:49.377280 | instance | changed: .d..t...... ./
2026-07-29 07:51:52.849534 | instance | changed: .d..t...... ./
2026-07-29 07:51:52.865842 | 
2026-07-29 07:51:52.866070 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-07-29 07:51:56.213401 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.009734
2026-07-29 07:51:56.509464 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.009059
2026-07-29 07:51:56.530134 | 
2026-07-29 07:51:56.530291 | PLAY [all]
2026-07-29 07:51:56.544395 | 
2026-07-29 07:51:56.544558 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-07-29 07:51:56.972315 | instance | changed
2026-07-29 07:51:56.983509 | 
2026-07-29 07:51:56.983623 | PLAY RECAP
2026-07-29 07:51:56.983688 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-29 07:51:56.983721 | 
2026-07-29 07:51:57.202619 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-29 07:51:57.212742 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-07-29 07:51:57.981867 | 
2026-07-29 07:51:59.020839 | PLAY [localhost]
2026-07-29 07:51:59.040698 | 
2026-07-29 07:51:59.040886 | TASK [Generate Zuul manifest]
2026-07-29 07:51:59.064569 | localhost | ok
2026-07-29 07:51:59.087666 | 
2026-07-29 07:51:59.087892 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-07-29 07:51:59.865918 | localhost | changed
2026-07-29 07:51:59.880877 | 
2026-07-29 07:51:59.881068 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-07-29 07:52:00.040125 | localhost | ok
2026-07-29 07:52:00.050873 | 
2026-07-29 07:52:00.051044 | TASK [Upload logs]
2026-07-29 07:52:00.074666 | localhost | ok
2026-07-29 07:52:00.195168 | 
2026-07-29 07:52:00.195672 | TASK [Set zuul-log-path fact]
2026-07-29 07:52:00.218788 | localhost | ok
2026-07-29 07:52:00.231689 | 
2026-07-29 07:52:00.231765 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-29 07:52:00.263236 | localhost | ok
2026-07-29 07:52:00.273893 | 
2026-07-29 07:52:00.274142 | TASK [upload-logs : Create log directories]
2026-07-29 07:52:00.704818 | localhost | changed
2026-07-29 07:52:00.710002 | 
2026-07-29 07:52:00.710081 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-07-29 07:52:01.294939 | localhost -> localhost | ok: Runtime: 0:00:00.139708
2026-07-29 07:52:01.302843 | 
2026-07-29 07:52:01.302950 | TASK [upload-logs : Upload logs to log server]
2026-07-29 07:52:01.782197 | localhost | Output suppressed because no_log was given
2026-07-29 07:52:01.791519 | 
2026-07-29 07:52:01.791688 | LOOP [upload-logs : Compress console log and json output]
2026-07-29 07:52:01.843412 | localhost | skipping: Conditional result was False
2026-07-29 07:52:01.854479 | localhost | skipping: Conditional result was False
2026-07-29 07:52:01.875400 | 
2026-07-29 07:52:01.875621 | LOOP [upload-logs : Upload compressed console log and json output]
2026-07-29 07:52:01.924940 | localhost | skipping: Conditional result was False
2026-07-29 07:52:01.925313 | 
2026-07-29 07:52:01.930830 | localhost | skipping: Conditional result was False
2026-07-29 07:52:01.946904 | 
2026-07-29 07:52:01.947064 | LOOP [upload-logs : Upload console log and json output]