2026-07-25 10:26:41.788122 | Job console starting
2026-07-25 10:26:41.796138 | Updating git repos
2026-07-25 10:26:44.385622 | Cloning repos into workspace
2026-07-25 10:27:08.036001 | Restoring repo states
2026-07-25 10:27:09.742305 | Merging changes
2026-07-25 10:27:12.246343 | Checking out repos
2026-07-25 10:27:16.077208 | Preparing playbooks
2026-07-25 10:27:21.182390 | Running Ansible setup
2026-07-25 10:27:24.654105 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-25 10:27:25.332759 | 
2026-07-25 10:27:25.332894 | PLAY [localhost]
2026-07-25 10:27:25.340271 | 
2026-07-25 10:27:25.340355 | TASK [Gathering Facts]
2026-07-25 10:27:26.243535 | localhost | ok
2026-07-25 10:27:26.254905 | 
2026-07-25 10:27:26.255040 | TASK [Setup log path fact]
2026-07-25 10:27:26.273064 | localhost | ok
2026-07-25 10:27:26.285496 | 
2026-07-25 10:27:26.285600 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-25 10:27:26.312598 | localhost | ok
2026-07-25 10:27:26.322003 | 
2026-07-25 10:27:26.322117 | TASK [emit-job-header : Print job information]
2026-07-25 10:27:26.369220 | # Job Information
2026-07-25 10:27:26.369385 | Ansible Version: 2.16.18
2026-07-25 10:27:26.369441 | Job: atmosphere-molecule-aio-ovn-selective
2026-07-25 10:27:26.369477 | Pipeline: check
2026-07-25 10:27:26.369508 | Executor: 2d72f0692154
2026-07-25 10:27:26.369540 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4163
2026-07-25 10:27:26.369578 | Event ID: 0d8e45e0-8813-11f1-9fa9-2d3248036fbe
2026-07-25 10:27:26.373703 | 
2026-07-25 10:27:26.373790 | LOOP [emit-job-header : Print node information]
2026-07-25 10:27:26.464347 | localhost | ok:
2026-07-25 10:27:26.464517 | localhost | # Node Information
2026-07-25 10:27:26.464557 | localhost | Inventory Hostname: instance
2026-07-25 10:27:26.464589 | localhost | Hostname: np0000186805
2026-07-25 10:27:26.464618 | localhost | Username: zuul
2026-07-25 10:27:26.464650 | localhost | Distro: Ubuntu 22.04
2026-07-25 10:27:26.464678 | localhost | Provider: yul1
2026-07-25 10:27:26.464706 | localhost | Region: ca-ymq-1
2026-07-25 10:27:26.464733 | localhost | Label: ubuntu-jammy-16
2026-07-25 10:27:26.464759 | localhost | Product Name: OpenStack Nova
2026-07-25 10:27:26.464786 | localhost | Interface IP: 199.204.45.144
2026-07-25 10:27:26.480057 | 
2026-07-25 10:27:26.480167 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-07-25 10:27:26.838734 | localhost -> localhost | changed
2026-07-25 10:27:26.843791 | 
2026-07-25 10:27:26.843888 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-07-25 10:27:27.828350 | localhost -> localhost | changed
2026-07-25 10:27:27.834465 | 
2026-07-25 10:27:27.834524 | PLAY [all]
2026-07-25 10:27:27.842219 | 
2026-07-25 10:27:27.842296 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-07-25 10:27:28.101870 | instance -> localhost | ok
2026-07-25 10:27:28.108596 | 
2026-07-25 10:27:28.108674 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-07-25 10:27:28.137166 | instance | ok
2026-07-25 10:27:28.152460 | instance | included: /var/lib/zuul/builds/2739c1d6482143f59316ba36adc5e445/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-07-25 10:27:28.158376 | 
2026-07-25 10:27:28.158455 | TASK [add-build-sshkey : Create Temp SSH key]
2026-07-25 10:27:29.174757 | instance -> localhost | Generating public/private rsa key pair.
2026-07-25 10:27:29.174932 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/2739c1d6482143f59316ba36adc5e445/work/2739c1d6482143f59316ba36adc5e445_id_rsa
2026-07-25 10:27:29.174973 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/2739c1d6482143f59316ba36adc5e445/work/2739c1d6482143f59316ba36adc5e445_id_rsa.pub
2026-07-25 10:27:29.175005 | instance -> localhost | The key fingerprint is:
2026-07-25 10:27:29.175035 | instance -> localhost | SHA256:o/0S53M8KG4MqST02AwAHmpLNqpMIN8o1vhk20T8jiM zuul-build-sshkey
2026-07-25 10:27:29.175075 | instance -> localhost | The key's randomart image is:
2026-07-25 10:27:29.175105 | instance -> localhost | +---[RSA 3072]----+
2026-07-25 10:27:29.175140 | instance -> localhost | |o.               |
2026-07-25 10:27:29.175170 | instance -> localhost | |+ . .            |
2026-07-25 10:27:29.175198 | instance -> localhost | |+B   o           |
2026-07-25 10:27:29.175226 | instance -> localhost | |B.Bo. .          |
2026-07-25 10:27:29.175253 | instance -> localhost | |o*oX.. oS        |
2026-07-25 10:27:29.175281 | instance -> localhost | |=.* O =o...      |
2026-07-25 10:27:29.175308 | instance -> localhost | |.. E =.+.+ o     |
2026-07-25 10:27:29.175335 | instance -> localhost | |    o . =.+ +    |
2026-07-25 10:27:29.175366 | instance -> localhost | |       o.o.o .   |
2026-07-25 10:27:29.175394 | instance -> localhost | +----[SHA256]-----+
2026-07-25 10:27:29.175453 | instance -> localhost | ok: Runtime: 0:00:00.598801
2026-07-25 10:27:29.182096 | 
2026-07-25 10:27:29.182154 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-07-25 10:27:29.215724 | instance | ok
2026-07-25 10:27:29.813373 | instance | included: /var/lib/zuul/builds/2739c1d6482143f59316ba36adc5e445/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-07-25 10:27:29.821369 | 
2026-07-25 10:27:29.821432 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-07-25 10:27:29.844814 | instance | skipping: Conditional result was False
2026-07-25 10:27:29.857712 | 
2026-07-25 10:27:29.857901 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-07-25 10:27:30.305276 | instance | changed
2026-07-25 10:27:30.312127 | 
2026-07-25 10:27:30.312191 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-07-25 10:27:30.537999 | instance | ok
2026-07-25 10:27:30.542834 | 
2026-07-25 10:27:30.542893 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-07-25 10:27:30.986019 | instance | changed
2026-07-25 10:27:30.995456 | 
2026-07-25 10:27:30.995524 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-07-25 10:27:31.457435 | instance | changed
2026-07-25 10:27:31.466841 | 
2026-07-25 10:27:31.466907 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-07-25 10:27:31.490300 | instance | skipping: Conditional result was False
2026-07-25 10:27:31.502947 | 
2026-07-25 10:27:31.503035 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-07-25 10:27:31.809904 | instance -> localhost | changed
2026-07-25 10:27:31.820122 | 
2026-07-25 10:27:31.820229 | TASK [add-build-sshkey : Add back temp key]
2026-07-25 10:27:32.116955 | instance -> localhost | Identity added: /var/lib/zuul/builds/2739c1d6482143f59316ba36adc5e445/work/2739c1d6482143f59316ba36adc5e445_id_rsa (zuul-build-sshkey)
2026-07-25 10:27:32.117142 | instance -> localhost | ok: Runtime: 0:00:00.015512
2026-07-25 10:27:32.121913 | 
2026-07-25 10:27:32.121974 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-07-25 10:27:32.394051 | instance | ok
2026-07-25 10:27:32.402318 | 
2026-07-25 10:27:32.402379 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-07-25 10:27:32.426874 | instance | skipping: Conditional result was False
2026-07-25 10:27:32.440354 | 
2026-07-25 10:27:32.440417 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-07-25 10:27:32.731018 | instance | ok
2026-07-25 10:27:32.738956 | 
2026-07-25 10:27:32.739079 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-07-25 10:27:36.712324 | instance | Output suppressed because no_log was given
2026-07-25 10:27:36.720850 | 
2026-07-25 10:27:36.720950 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-07-25 10:27:36.905128 | instance | ok: "logs"
2026-07-25 10:27:36.905421 | instance | ok: All items complete
2026-07-25 10:27:36.905465 | 
2026-07-25 10:27:37.048748 | instance | ok: "artifacts"
2026-07-25 10:27:37.203543 | instance | ok: "docs"
2026-07-25 10:27:37.224847 | 
2026-07-25 10:27:37.224954 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-07-25 10:27:37.400857 | instance | changed: "logs"
2026-07-25 10:27:37.549922 | instance | changed: "artifacts"
2026-07-25 10:27:37.709420 | instance | changed: "docs"
2026-07-25 10:27:37.723483 | 
2026-07-25 10:27:37.723560 | PLAY RECAP
2026-07-25 10:27:37.723602 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-07-25 10:27:37.723631 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-25 10:27:37.723653 | 
2026-07-25 10:27:37.834812 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-25 10:27:37.841545 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-25 10:27:38.494224 | 
2026-07-25 10:27:38.494327 | PLAY [all]
2026-07-25 10:27:38.504800 | 
2026-07-25 10:27:38.504874 | TASK [setup-uv : Extract archive]
2026-07-25 10:27:40.838838 | instance | changed
2026-07-25 10:27:40.847445 | 
2026-07-25 10:27:40.847642 | TASK [setup-uv : Print version]
2026-07-25 10:27:41.200710 | instance | uv 0.8.13
2026-07-25 10:27:41.396627 | instance | ok: Runtime: 0:00:00.012438
2026-07-25 10:27:41.407132 | 
2026-07-25 10:27:41.407198 | TASK [Install Ansible collection siblings]
2026-07-25 10:27:50.033877 | instance | changed:
2026-07-25 10:27:50.034089 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-07-25 10:27:50.034120 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-07-25 10:27:50.034143 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-07-25 10:27:50.034163 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-07-25 10:27:50.034182 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-07-25 10:27:50.034205 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-07-25 10:27:50.034225 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-07-25 10:27:50.034246 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-07-25 10:27:50.034266 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-07-25 10:27:50.034284 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-07-25 10:27:50.034303 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-07-25 10:27:50.034322 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-07-25 10:27:50.034339 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-07-25 10:27:50.034358 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-07-25 10:27:50.034377 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0
2026-07-25 10:27:50.034402 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-07-25 10:27:50.034427 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-07-25 10:27:50.034450 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-07-25 10:27:50.034468 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-07-25 10:27:50.034487 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-07-25 10:27:50.034505 | instance | Resolved vexxhost.ceph to v4.1.0 for >=3.2.0
2026-07-25 10:27:50.034523 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-07-25 10:27:50.034542 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-25 10:27:50.034575 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-07-25 10:27:50.034594 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0,>=6.0.0
2026-07-25 10:27:50.034612 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-25 10:27:50.034630 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-25 10:27:50.034647 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-25 10:27:50.034665 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-07-25 10:27:50.034683 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-07-25 10:27:50.034700 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-25 10:27:50.034718 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-25 10:27:50.034736 | instance | Checked out ansible.netcommon to 1.2.0
2026-07-25 10:27:50.034754 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-07-25 10:27:50.034778 | instance | Starting galaxy collection install process
2026-07-25 10:27:50.034796 | instance | Process install dependency map
2026-07-25 10:27:50.034815 | instance | Starting collection install process
2026-07-25 10:27:50.034839 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-07-25 10:27:50.034859 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-07-25 10:27:50.034877 | instance | ansible.netcommon:* was installed successfully
2026-07-25 10:27:50.034895 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-07-25 10:27:50.034913 | instance | Creating virtual environment at: .venv
2026-07-25 10:27:50.034930 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-25 10:27:50.034948 | instance | Downloading netaddr (2.2MiB)
2026-07-25 10:27:50.034966 | instance | Downloading rjsonnet (1.2MiB)
2026-07-25 10:27:50.034988 | instance | Downloading ansible-core (2.1MiB)
2026-07-25 10:27:50.035006 | instance | Downloading setuptools (1.1MiB)
2026-07-25 10:27:50.035024 | instance | Downloading cryptography (4.2MiB)
2026-07-25 10:27:50.035041 | instance | Downloading pydantic-core (2.0MiB)
2026-07-25 10:27:50.035060 | instance | Downloading openstacksdk (1.7MiB)
2026-07-25 10:27:50.035078 | instance | Downloading kubernetes (1.9MiB)
2026-07-25 10:27:50.035096 | instance | Downloading pygments (1.2MiB)
2026-07-25 10:27:50.035114 | instance |    Building pyperclip==1.9.0
2026-07-25 10:27:50.035133 | instance |  Downloading rjsonnet
2026-07-25 10:27:50.035151 | instance |  Downloading pydantic-core
2026-07-25 10:27:50.035169 | instance |  Downloading netaddr
2026-07-25 10:27:50.035187 | instance |  Downloading pygments
2026-07-25 10:27:50.035205 | instance |  Downloading cryptography
2026-07-25 10:27:50.035222 | instance |  Downloading setuptools
2026-07-25 10:27:50.035240 | instance |  Downloading kubernetes
2026-07-25 10:27:50.035258 | instance |  Downloading ansible-core
2026-07-25 10:27:50.035276 | instance |  Downloading openstacksdk
2026-07-25 10:27:50.035294 | instance |       Built pyperclip==1.9.0
2026-07-25 10:27:50.035313 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-25 10:27:50.035331 | instance | Installed 83 packages in 32ms
2026-07-25 10:27:50.035349 | instance | Checked out ansible.posix to 1.6.0
2026-07-25 10:27:50.035368 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-07-25 10:27:50.035386 | instance | Starting galaxy collection install process
2026-07-25 10:27:50.035404 | instance | Process install dependency map
2026-07-25 10:27:50.035427 | instance | Starting collection install process
2026-07-25 10:27:50.035446 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-07-25 10:27:50.035464 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-07-25 10:27:50.035482 | instance | ansible.posix:1.6.0 was installed successfully
2026-07-25 10:27:50.035500 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 10:27:50.035518 | instance | 2.17.12
2026-07-25 10:27:50.035536 | instance | Checked out ansible.utils to v6.0.3
2026-07-25 10:27:50.035554 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-07-25 10:27:50.035572 | instance | Starting galaxy collection install process
2026-07-25 10:27:50.035589 | instance | Process install dependency map
2026-07-25 10:27:50.035609 | instance | Starting collection install process
2026-07-25 10:27:50.035630 | instance | Installing 'ansible.utils:6.0.3' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-07-25 10:27:50.035649 | instance | Created collection for ansible.utils:6.0.3 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-07-25 10:27:50.035667 | instance | ansible.utils:6.0.3 was installed successfully
2026-07-25 10:27:50.035685 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 10:27:50.035703 | instance | 2.17.12
2026-07-25 10:27:50.035721 | instance | Checked out atmosphere.common to v0.7.0
2026-07-25 10:27:50.035738 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-07-25 10:27:50.035757 | instance | Starting galaxy collection install process
2026-07-25 10:27:50.035775 | instance | Process install dependency map
2026-07-25 10:27:50.035792 | instance | Starting collection install process
2026-07-25 10:27:50.035810 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-07-25 10:27:50.035828 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-07-25 10:27:50.035846 | instance | atmosphere.common:0.7.0 was installed successfully
2026-07-25 10:27:50.035864 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 10:27:50.035882 | instance | 2.17.12
2026-07-25 10:27:50.035899 | instance | Checked out community.crypto to 2.2.3
2026-07-25 10:27:50.035917 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-07-25 10:27:50.035935 | instance | Starting galaxy collection install process
2026-07-25 10:27:50.035952 | instance | Process install dependency map
2026-07-25 10:27:50.035970 | instance | Starting collection install process
2026-07-25 10:27:50.035987 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-07-25 10:27:50.036005 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-07-25 10:27:50.036022 | instance | community.crypto:2.2.3 was installed successfully
2026-07-25 10:27:50.036040 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 10:27:50.036058 | instance | 2.17.12
2026-07-25 10:27:50.036075 | instance | Checked out community.general to 7.3.0
2026-07-25 10:27:50.036093 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-07-25 10:27:50.036116 | instance | Starting galaxy collection install process
2026-07-25 10:27:50.036134 | instance | Process install dependency map
2026-07-25 10:27:50.036152 | instance | Starting collection install process
2026-07-25 10:27:50.036170 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-07-25 10:27:50.036188 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-07-25 10:27:50.036206 | instance | community.general:7.3.0 was installed successfully
2026-07-25 10:27:50.036224 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 10:27:50.036242 | instance | 2.17.12
2026-07-25 10:27:50.036260 | instance | Checked out community.mysql to 3.6.0
2026-07-25 10:27:50.036280 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-07-25 10:27:50.036299 | instance | Starting galaxy collection install process
2026-07-25 10:27:50.036318 | instance | Process install dependency map
2026-07-25 10:27:50.036336 | instance | Starting collection install process
2026-07-25 10:27:50.036357 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-07-25 10:27:50.036379 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-07-25 10:27:50.036398 | instance | community.mysql:3.6.0 was installed successfully
2026-07-25 10:27:50.036416 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 10:27:50.036435 | instance | 2.17.12
2026-07-25 10:27:50.036456 | instance | Checked out kubernetes.core to 2.4.0
2026-07-25 10:27:50.036475 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-07-25 10:27:50.036493 | instance | Starting galaxy collection install process
2026-07-25 10:27:50.036511 | instance | Process install dependency map
2026-07-25 10:27:50.036529 | instance | Starting collection install process
2026-07-25 10:27:50.036547 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-07-25 10:27:50.036565 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-07-25 10:27:50.036584 | instance | kubernetes.core:2.4.0 was installed successfully
2026-07-25 10:27:50.036603 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 10:27:50.036621 | instance | 2.17.12
2026-07-25 10:27:50.036639 | instance | Checked out openstack.cloud to 2.6.0
2026-07-25 10:27:50.036658 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-07-25 10:27:50.036676 | instance | Starting galaxy collection install process
2026-07-25 10:27:50.036694 | instance | Process install dependency map
2026-07-25 10:27:50.036712 | instance | Starting collection install process
2026-07-25 10:27:50.036730 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-07-25 10:27:50.036748 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-07-25 10:27:50.036767 | instance | openstack.cloud:2.6.0 was installed successfully
2026-07-25 10:27:50.036785 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 10:27:50.036803 | instance | 2.17.12
2026-07-25 10:27:50.036826 | instance | Checked out vexxhost.ceph to v4.1.0
2026-07-25 10:27:50.036845 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-07-25 10:27:50.036864 | instance | Starting galaxy collection install process
2026-07-25 10:27:50.036881 | instance | Process install dependency map
2026-07-25 10:27:50.036899 | instance | Starting collection install process
2026-07-25 10:27:50.036917 | instance | Installing 'vexxhost.ceph:4.1.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-07-25 10:27:50.036935 | instance | Created collection for vexxhost.ceph:4.1.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-07-25 10:27:50.036952 | instance | vexxhost.ceph:4.1.0 was installed successfully
2026-07-25 10:27:50.036987 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 10:27:50.037007 | instance | 2.17.12
2026-07-25 10:27:50.037026 | instance | Checked out vexxhost.containers to v1.6.8
2026-07-25 10:27:50.037044 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-07-25 10:27:50.037062 | instance | Starting galaxy collection install process
2026-07-25 10:27:50.037080 | instance | Process install dependency map
2026-07-25 10:27:50.037099 | instance | Starting collection install process
2026-07-25 10:27:50.037117 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-07-25 10:27:50.037145 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-07-25 10:27:50.037191 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-07-25 10:27:50.037222 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 10:27:50.037250 | instance | 2.17.12
2026-07-25 10:27:50.037271 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-07-25 10:27:50.037292 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-07-25 10:27:50.037311 | instance | Starting galaxy collection install process
2026-07-25 10:27:50.037330 | instance | Process install dependency map
2026-07-25 10:27:50.037349 | instance | Starting collection install process
2026-07-25 10:27:50.037367 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-07-25 10:27:50.037386 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-07-25 10:27:50.037404 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-07-25 10:27:50.037425 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-25 10:27:50.037452 | instance | 2.17.12
2026-07-25 10:27:50.049731 | 
2026-07-25 10:27:50.049798 | PLAY RECAP
2026-07-25 10:27:50.049848 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-25 10:27:50.049870 | 
2026-07-25 10:27:50.158161 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-25 10:27:50.168763 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-25 10:27:50.788691 | 
2026-07-25 10:27:51.035209 | PLAY [all]
2026-07-25 10:27:51.052760 | 
2026-07-25 10:27:51.052845 | TASK [Install "jq" for log collection]
2026-07-25 10:28:02.206820 | instance | changed
2026-07-25 10:28:02.208669 | 
2026-07-25 10:28:02.208730 | PLAY RECAP
2026-07-25 10:28:02.208781 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-25 10:28:02.208842 | 
2026-07-25 10:28:02.316460 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-25 10:28:02.323352 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-25 10:28:02.945324 | 
2026-07-25 10:28:02.945691 | PLAY [Prepare Molecule dependencies]
2026-07-25 10:28:02.956485 | 
2026-07-25 10:28:02.956563 | TASK [Install jq for log collection]
2026-07-25 10:28:05.159891 | instance | ok
2026-07-25 10:28:05.162742 | 
2026-07-25 10:28:05.162830 | PLAY [Install Go for the Atmosphere deployment binary]
2026-07-25 10:28:05.170123 | 
2026-07-25 10:28:05.170208 | TASK [ensure-go : Check installed go version]
2026-07-25 10:28:05.703882 | instance | ok: ERROR (ignored)
2026-07-25 10:28:05.704215 | instance | {
2026-07-25 10:28:05.704288 | instance |   "failed_when_result": false,
2026-07-25 10:28:05.704340 | instance |   "msg": "[Errno 2] No such file or directory: b'go'",
2026-07-25 10:28:05.704384 | instance |   "rc": 2
2026-07-25 10:28:05.704426 | instance | }
2026-07-25 10:28:05.711883 | 
2026-07-25 10:28:05.711951 | TASK [ensure-go : Skip if correct version of go is installed]
2026-07-25 10:28:05.761620 | instance | ok
2026-07-25 10:28:05.770497 | instance | included: /var/lib/zuul/builds/2739c1d6482143f59316ba36adc5e445/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-go/tasks/install-go.yaml
2026-07-25 10:28:05.775247 | 
2026-07-25 10:28:05.775308 | TASK [ensure-go : Create temp directory]
2026-07-25 10:28:06.094825 | instance | changed
2026-07-25 10:28:06.103680 | 
2026-07-25 10:28:06.103745 | TASK [ensure-go : Get archive checksum]
2026-07-25 10:28:06.710443 | instance | ok: OK (64 bytes)
2026-07-25 10:28:06.717115 | 
2026-07-25 10:28:06.717195 | TASK [ensure-go : Download go archive]
2026-07-25 10:28:08.016019 | instance | changed: OK (78559214 bytes)
2026-07-25 10:28:08.052137 | 
2026-07-25 10:28:08.052261 | TASK [ensure-go : Install go]
2026-07-25 10:28:13.843341 | instance | changed
2026-07-25 10:28:13.849752 | 
2026-07-25 10:28:13.849808 | PLAY [Prepare selective Molecule execution plan]
2026-07-25 10:28:13.855918 | 
2026-07-25 10:28:13.855983 | TASK [Build atmosphere binary]
2026-07-25 10:28:14.106831 | instance | go: downloading golang.org/x/sync v0.18.0
2026-07-25 10:28:14.107126 | instance | go: downloading github.com/spf13/cobra v1.9.1
2026-07-25 10:28:14.108604 | instance | go: downloading github.com/goccy/go-yaml v1.18.0
2026-07-25 10:28:14.370738 | instance | go: downloading github.com/spf13/pflag v1.0.7
2026-07-25 10:28:20.928269 | instance | ok: Runtime: 0:00:06.685847
2026-07-25 10:28:20.934994 | 
2026-07-25 10:28:20.935058 | TASK [Generate selective CI plan]
2026-07-25 10:28:21.476861 | instance | ok: Runtime: 0:00:00.019620
2026-07-25 10:28:21.482880 | 
2026-07-25 10:28:21.482950 | TASK [Explain selective CI plan]
2026-07-25 10:28:21.689167 | instance | CI plan mode: selective
2026-07-25 10:28:21.689385 | instance | Changed files:
2026-07-25 10:28:21.689402 | instance |   A	roles/keystone/.ci-selective-test
2026-07-25 10:28:21.689413 | instance | Matches:
2026-07-25 10:28:21.689427 | instance |   roles/keystone/.ci-selective-test: component:keystone (targets) -> keystone
2026-07-25 10:28:21.689509 | instance | Direct targets: keystone
2026-07-25 10:28:21.689523 | instance | Deployment roots: keystone
2026-07-25 10:28:21.689535 | instance | Verification profiles: identity, keycloak-federation
2026-07-25 10:28:21.689549 | instance | Variant openvswitch (12 components): ceph, cert-manager, cluster-issuer, csi, ingress-nginx, keycloak, keystone, kubernetes, memcached, percona-xtradb-cluster, percona-xtradb-cluster-operator, rabbitmq-cluster-operator
2026-07-25 10:28:21.689564 | instance | Molecule jobs:
2026-07-25 10:28:21.689575 | instance |   aio-openvswitch: run (12 components) - executes the openvswitch deployment variant
2026-07-25 10:28:21.689586 | instance |   aio-ovn: skip - plan has no ovn deployment variant
2026-07-25 10:28:21.689598 | instance |   csi-local-path-provisioner: skip - none of the job's verification profiles were requested
2026-07-25 10:28:21.689608 | instance |   csi-rbd: skip - none of the job's verification profiles were requested
2026-07-25 10:28:21.689618 | instance |   keycloak: run - requested verification profiles: keycloak-federation
2026-07-25 10:28:22.020796 | instance | ok: Runtime: 0:00:00.023477
2026-07-25 10:28:22.028150 | 
2026-07-25 10:28:22.028250 | TASK [Print selective CI plan]
2026-07-25 10:28:22.062641 | instance | ok
2026-07-25 10:28:22.069214 | 
2026-07-25 10:28:22.069298 | TASK [Report conservative fallback]
2026-07-25 10:28:22.093080 | instance | skipping: Conditional result was False
2026-07-25 10:28:22.104783 | 
2026-07-25 10:28:22.104927 | TASK [Create selective CI plan log directory]
2026-07-25 10:28:22.504326 | instance | changed
2026-07-25 10:28:22.510317 | 
2026-07-25 10:28:22.512112 | TASK [Publish selective CI plan with job logs]
2026-07-25 10:28:22.958777 | instance | changed
2026-07-25 10:28:22.960547 | 
2026-07-25 10:28:22.960594 | PLAY RECAP
2026-07-25 10:28:22.960639 | instance | ok: 13 changed: 5 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-25 10:28:22.960661 | 
2026-07-25 10:28:23.085690 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-25 10:28:23.097813 | RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-25 10:28:23.692880 | 
2026-07-25 10:28:23.693019 | PLAY [Run selected Molecule deployment and verification]
2026-07-25 10:28:23.703873 | 
2026-07-25 10:28:23.703964 | TASK [Check for selective CI plan]
2026-07-25 10:28:24.019373 | instance | ok
2026-07-25 10:28:24.027481 | 
2026-07-25 10:28:24.027559 | TASK [Validate selective CI plan]
2026-07-25 10:28:24.564617 | instance | ok: Runtime: 0:00:00.031168
2026-07-25 10:28:24.569921 | 
2026-07-25 10:28:24.569984 | TASK [Resolve selective CI plan availability]
2026-07-25 10:28:24.623293 | instance | ok
2026-07-25 10:28:24.630500 | 
2026-07-25 10:28:24.630587 | TASK [Read selective CI plan]
2026-07-25 10:28:24.926854 | instance | ok
2026-07-25 10:28:24.933172 | 
2026-07-25 10:28:24.933247 | TASK [Load selective CI plan or full fallback]
2026-07-25 10:28:24.976269 | instance | ok
2026-07-25 10:28:24.984771 | 
2026-07-25 10:28:24.984833 | TASK [Find this job in the selective CI plan]
2026-07-25 10:28:25.032279 | instance | ok
2026-07-25 10:28:25.036726 | 
2026-07-25 10:28:25.036790 | TASK [Resolve this job or use full fallback]
2026-07-25 10:28:25.088063 | instance | ok
2026-07-25 10:28:25.093992 | 
2026-07-25 10:28:25.094057 | TASK [Resolve deployment and verification inputs]
2026-07-25 10:28:25.187539 | instance | ok
2026-07-25 10:28:25.228817 | 
2026-07-25 10:28:25.228977 | TASK [Resolve deployment tags]
2026-07-25 10:28:25.281687 | instance | ok
2026-07-25 10:28:25.286331 | 
2026-07-25 10:28:25.286404 | TASK [Report Molecule job decision]
2026-07-25 10:28:25.317699 | instance | ok: {'job': 'aio-ovn', 'mode': 'selective', 'run': False, 'reason': 'plan has no ovn deployment variant', 'network_backend': 'ovn', 'csi_driver': 'rbd', 'components': [], 'verification_profiles': ['identity', 'keycloak-federation']}
2026-07-25 10:28:25.324317 | 
2026-07-25 10:28:25.324400 | TASK [Copy inventory file for Zuul]
2026-07-25 10:28:25.348301 | instance | skipping: Conditional result was False
2026-07-25 10:28:25.356501 | 
2026-07-25 10:28:25.356607 | TASK [Switch ansible_host to private IP]
2026-07-25 10:28:25.379795 | instance | skipping: Conditional result was False
2026-07-25 10:28:25.391506 | 
2026-07-25 10:28:25.391602 | TASK [Prepare Molecule scenario]
2026-07-25 10:28:25.921236 | instance | skipping: Conditional result was False
2026-07-25 10:28:25.932948 | 
2026-07-25 10:28:25.933029 | TASK [Build deployment command]
2026-07-25 10:28:25.956638 | instance | skipping: Conditional result was False
2026-07-25 10:28:25.965820 | 
2026-07-25 10:28:25.965925 | TASK [Deploy with parallel orchestrator]
2026-07-25 10:28:26.494168 | instance | skipping: Conditional result was False
2026-07-25 10:28:26.503656 | 
2026-07-25 10:28:26.503989 | TASK [Re-deploy to verify idempotent execution]
2026-07-25 10:28:27.030667 | instance | skipping: Conditional result was False
2026-07-25 10:28:27.035850 | 
2026-07-25 10:28:27.035916 | TASK [Add IP address to br-ex]
2026-07-25 10:28:27.562877 | instance | skipping: Conditional result was False
2026-07-25 10:28:27.571267 | 
2026-07-25 10:28:27.571362 | TASK [Set br-ex interface up]
2026-07-25 10:28:28.098105 | instance | skipping: Conditional result was False
2026-07-25 10:28:28.105744 | 
2026-07-25 10:28:28.105817 | TASK [Verify Molecule scenario]
2026-07-25 10:28:28.632739 | instance | skipping: Conditional result was False
2026-07-25 10:28:28.634282 | 
2026-07-25 10:28:28.634338 | PLAY RECAP
2026-07-25 10:28:28.634395 | instance | ok: 10 changed: 0 unreachable: 0 failed: 0 skipped: 9 rescued: 0 ignored: 0
2026-07-25 10:28:28.634423 | 
2026-07-25 10:28:28.757680 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-25 10:28:28.769305 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-25 10:28:29.391664 | 
2026-07-25 10:28:29.391771 | PLAY [all]
2026-07-25 10:28:29.404818 | 
2026-07-25 10:28:29.404892 | TASK [gather-host-logs : creating directory for system status]
2026-07-25 10:28:29.734746 | instance | ok
2026-07-25 10:28:29.740910 | 
2026-07-25 10:28:29.741001 | TASK [gather-host-logs : Get logs for each host]
2026-07-25 10:28:30.097273 | instance | + systemd-cgls --full --all --no-pager
2026-07-25 10:28:30.113602 | instance | + ip addr
2026-07-25 10:28:30.115782 | instance | + ip route
2026-07-25 10:28:30.117103 | instance | + lsblk
2026-07-25 10:28:30.119851 | instance | + mount
2026-07-25 10:28:30.121321 | instance | + docker images
2026-07-25 10:28:30.121889 | instance | /bin/bash: line 7: docker: command not found
2026-07-25 10:28:30.122036 | instance | + brctl show
2026-07-25 10:28:30.122519 | instance | /bin/bash: line 8: brctl: command not found
2026-07-25 10:28:30.122748 | instance | + ps aux --sort=-%mem
2026-07-25 10:28:30.137811 | instance | + dpkg -l
2026-07-25 10:28:30.147260 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-07-25 10:28:30.147817 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-07-25 10:28:30.147860 | instance | /bin/bash: line 11: docker: command not found
2026-07-25 10:28:30.148237 | instance | + '[' '!' -z '' ']'
2026-07-25 10:28:30.278554 | instance | ok: Runtime: 0:00:00.057741
2026-07-25 10:28:30.285773 | 
2026-07-25 10:28:30.285838 | TASK [gather-host-logs : Downloads logs to executor]
2026-07-25 10:28:31.212232 | instance | ERROR
2026-07-25 10:28:31.212491 | instance | {
2026-07-25 10:28:31.212537 | instance |   "msg": "Warning: Permanently added '199.204.45.144' (ED25519) to the list of known hosts.\r\nrsync: [generator] chown \"/var/lib/zuul/builds/2739c1d6482143f59316ba36adc5e445/work/logs/instance/system\" failed: Invalid argument (22)\nrsync: [receiver] chown \"/var/lib/zuul/builds/2739c1d6482143f59316ba36adc5e445/work/logs/instance/system/.ci-plan.json.DNuSkQ\" failed: Invalid argument (22)\nrsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1865) [generator=3.2.7]\n",
2026-07-25 10:28:31.212573 | instance |   "rc": 23
2026-07-25 10:28:31.212602 | instance | }
2026-07-25 10:28:31.212641 | instance | ERROR: Ignoring Errors
2026-07-25 10:28:31.224862 | 
2026-07-25 10:28:31.224934 | LOOP [helm-release-status : creating directory for helm release status]
2026-07-25 10:28:31.428235 | instance | changed: "values"
2026-07-25 10:28:31.584987 | instance | changed: "releases"
2026-07-25 10:28:31.619085 | 
2026-07-25 10:28:31.619377 | TASK [helm-release-status : Gather get release status for helm charts]
2026-07-25 10:28:31.867136 | instance | /bin/bash: line 3: kubectl: command not found
2026-07-25 10:28:32.159303 | instance | ok: Runtime: 0:00:00.005816
2026-07-25 10:28:32.164414 | 
2026-07-25 10:28:32.164479 | TASK [helm-release-status : Downloads logs to executor]
2026-07-25 10:28:32.642182 | instance | changed:
2026-07-25 10:28:32.642405 | instance | cd+++++++++ helm/
2026-07-25 10:28:32.642454 | instance | cd+++++++++ helm/releases/
2026-07-25 10:28:32.642493 | instance | cd+++++++++ helm/values/
2026-07-25 10:28:32.658812 | 
2026-07-25 10:28:32.658987 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-07-25 10:28:32.857883 | instance | changed
2026-07-25 10:28:32.863854 | 
2026-07-25 10:28:32.863960 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-07-25 10:28:33.067288 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-25 10:28:33.067480 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-25 10:28:33.071945 | instance | environment: line 1: kubectl: command not found
2026-07-25 10:28:33.073266 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-25 10:28:33.075637 | instance | environment: line 1: kubectl: command not found
2026-07-25 10:28:33.077516 | instance | environment: line 1: kubectl: command not found
2026-07-25 10:28:33.077765 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-25 10:28:33.079485 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-25 10:28:33.081541 | instance | environment: line 1: kubectl: command not found
2026-07-25 10:28:33.081843 | instance | environment: line 1: kubectl: command not found
2026-07-25 10:28:33.082793 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-25 10:28:33.083439 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-25 10:28:33.398099 | instance | ok: Runtime: 0:00:00.025647
2026-07-25 10:28:33.405843 | 
2026-07-25 10:28:33.405948 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-07-25 10:28:33.601734 | instance | changed
2026-07-25 10:28:33.609125 | 
2026-07-25 10:28:33.609196 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-07-25 10:28:33.824500 | instance | environment: line 5: kubectl: command not found
2026-07-25 10:28:33.825314 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-25 10:28:33.825657 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-25 10:28:33.826002 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-25 10:28:34.143636 | instance | ok: Runtime: 0:00:00.010277
2026-07-25 10:28:34.170671 | 
2026-07-25 10:28:34.170838 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-07-25 10:28:34.657787 | instance | changed:
2026-07-25 10:28:34.658048 | instance | cd+++++++++ objects/
2026-07-25 10:28:34.658109 | instance | cd+++++++++ objects/cluster/
2026-07-25 10:28:34.658161 | instance | cd+++++++++ objects/namespaced/
2026-07-25 10:28:34.672196 | 
2026-07-25 10:28:34.672292 | TASK [gather-pod-logs : creating directory for pod logs]
2026-07-25 10:28:34.858621 | instance | changed
2026-07-25 10:28:34.865068 | 
2026-07-25 10:28:34.865156 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-07-25 10:28:35.061637 | instance | changed
2026-07-25 10:28:35.066858 | 
2026-07-25 10:28:35.066926 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-07-25 10:28:35.271699 | instance | environment: line 3: kubectl: command not found
2026-07-25 10:28:35.602372 | instance | ok: Runtime: 0:00:00.008694
2026-07-25 10:28:35.607268 | 
2026-07-25 10:28:35.607330 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-07-25 10:28:36.103257 | instance | changed:
2026-07-25 10:28:36.103446 | instance | cd+++++++++ pod-logs/
2026-07-25 10:28:36.103484 | instance | cd+++++++++ pod-logs/failed-pods/
2026-07-25 10:28:36.114794 | 
2026-07-25 10:28:36.114876 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-07-25 10:28:36.312599 | instance | changed
2026-07-25 10:28:36.321117 | 
2026-07-25 10:28:36.321184 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-07-25 10:28:36.529932 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-25 10:28:36.858905 | instance | ok: Runtime: 0:00:00.038650
2026-07-25 10:28:36.863910 | 
2026-07-25 10:28:36.863980 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-07-25 10:28:37.082399 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-25 10:28:37.111054 | instance | ceph-mgr endpoints:
2026-07-25 10:28:37.401021 | instance | ok: Runtime: 0:00:00.037098
2026-07-25 10:28:37.406298 | 
2026-07-25 10:28:37.406363 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-07-25 10:28:37.660221 | instance | /bin/bash: line 4: kubectl: command not found
2026-07-25 10:28:37.977597 | instance | ok: Runtime: 0:00:00.038049
2026-07-25 10:28:37.984972 | 
2026-07-25 10:28:37.985037 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-07-25 10:28:38.466496 | instance | changed: cd+++++++++ prometheus/
2026-07-25 10:28:38.478453 | 
2026-07-25 10:28:38.478532 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-07-25 10:28:38.677507 | instance | changed
2026-07-25 10:28:38.684214 | 
2026-07-25 10:28:38.684288 | TASK [gather-selenium-data : Get selenium data]
2026-07-25 10:28:38.886280 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-07-25 10:28:38.887199 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-07-25 10:28:39.217903 | instance | ERROR
2026-07-25 10:28:39.218091 | instance | {
2026-07-25 10:28:39.218138 | instance |   "delta": "0:00:00.004748",
2026-07-25 10:28:39.218174 | instance |   "end": "2026-07-25 10:28:38.887577",
2026-07-25 10:28:39.218251 | instance |   "msg": "non-zero return code",
2026-07-25 10:28:39.218302 | instance |   "rc": 1,
2026-07-25 10:28:39.218334 | instance |   "start": "2026-07-25 10:28:38.882829"
2026-07-25 10:28:39.218362 | instance | }
2026-07-25 10:28:39.218395 | instance | ERROR: Ignoring Errors
2026-07-25 10:28:39.225293 | 
2026-07-25 10:28:39.225398 | TASK [gather-selenium-data : Downloads logs to executor]
2026-07-25 10:28:39.705271 | instance | changed: cd+++++++++ selenium/
2026-07-25 10:28:39.712598 | 
2026-07-25 10:28:39.712651 | PLAY RECAP
2026-07-25 10:28:39.712696 | instance | ok: 23 changed: 21 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 2
2026-07-25 10:28:39.712717 | 
2026-07-25 10:28:39.833602 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-25 10:28:39.846311 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-25 10:28:40.591447 | 
2026-07-25 10:28:40.591582 | PLAY [all]
2026-07-25 10:28:40.603394 | 
2026-07-25 10:28:40.603527 | TASK [fetch-output : Set log path for multiple nodes]
2026-07-25 10:28:40.648316 | instance | skipping: Conditional result was False
2026-07-25 10:28:40.654836 | 
2026-07-25 10:28:40.654961 | TASK [fetch-output : Set log path for single node]
2026-07-25 10:28:40.697397 | instance | ok
2026-07-25 10:28:40.704123 | 
2026-07-25 10:28:40.704244 | LOOP [fetch-output : Ensure local output dirs]
2026-07-25 10:28:41.091260 | instance -> localhost | ok: "/var/lib/zuul/builds/2739c1d6482143f59316ba36adc5e445/work/logs"
2026-07-25 10:28:41.286477 | instance -> localhost | changed: "/var/lib/zuul/builds/2739c1d6482143f59316ba36adc5e445/work/artifacts"
2026-07-25 10:28:41.510183 | instance -> localhost | changed: "/var/lib/zuul/builds/2739c1d6482143f59316ba36adc5e445/work/docs"
2026-07-25 10:28:41.526479 | 
2026-07-25 10:28:41.526605 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-07-25 10:28:42.152736 | instance | changed: .d..t...... ./
2026-07-25 10:28:42.153087 | instance | changed: All items complete
2026-07-25 10:28:42.153125 | 
2026-07-25 10:28:42.627628 | instance | changed: .d..t...... ./
2026-07-25 10:28:43.075304 | instance | changed: .d..t...... ./
2026-07-25 10:28:43.093210 | 
2026-07-25 10:28:43.093355 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-07-25 10:28:43.506133 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007424
2026-07-25 10:28:43.714824 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.005654
2026-07-25 10:28:43.735527 | 
2026-07-25 10:28:43.735659 | PLAY [all]
2026-07-25 10:28:43.742787 | 
2026-07-25 10:28:43.742867 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-07-25 10:28:44.217874 | instance | changed
2026-07-25 10:28:44.225353 | 
2026-07-25 10:28:44.225400 | PLAY RECAP
2026-07-25 10:28:44.225441 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-25 10:28:44.225461 | 
2026-07-25 10:28:44.324948 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-25 10:28:44.337124 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-07-25 10:28:44.951394 | 
2026-07-25 10:28:44.951502 | PLAY [localhost]
2026-07-25 10:28:44.960899 | 
2026-07-25 10:28:44.960972 | TASK [Generate Zuul manifest]
2026-07-25 10:28:44.981341 | localhost | ok
2026-07-25 10:28:44.997623 | 
2026-07-25 10:28:44.997704 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-07-25 10:28:45.336644 | localhost | changed
2026-07-25 10:28:45.350699 | 
2026-07-25 10:28:45.350847 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-07-25 10:28:45.384178 | localhost | ok
2026-07-25 10:28:45.393834 | 
2026-07-25 10:28:45.394005 | TASK [Upload logs]
2026-07-25 10:28:45.417292 | localhost | ok
2026-07-25 10:28:45.580616 | 
2026-07-25 10:28:45.580789 | TASK [Set zuul-log-path fact]
2026-07-25 10:28:45.602803 | localhost | ok
2026-07-25 10:28:45.618521 | 
2026-07-25 10:28:45.618606 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-25 10:28:45.652383 | localhost | ok
2026-07-25 10:28:45.662071 | 
2026-07-25 10:28:45.662175 | TASK [upload-logs : Create log directories]
2026-07-25 10:28:46.031940 | localhost | changed
2026-07-25 10:28:46.038689 | 
2026-07-25 10:28:46.038786 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-07-25 10:28:46.387963 | localhost -> localhost | ok: Runtime: 0:00:00.004083
2026-07-25 10:28:46.394791 | 
2026-07-25 10:28:46.394858 | TASK [upload-logs : Upload logs to log server]
2026-07-25 10:28:46.824712 | localhost | Output suppressed because no_log was given
2026-07-25 10:28:46.829579 | 
2026-07-25 10:28:46.829670 | LOOP [upload-logs : Compress console log and json output]
2026-07-25 10:28:46.888434 | localhost | skipping: Conditional result was False
2026-07-25 10:28:46.895695 | localhost | skipping: Conditional result was False
2026-07-25 10:28:46.903373 | 
2026-07-25 10:28:46.903555 | LOOP [upload-logs : Upload compressed console log and json output]
2026-07-25 10:28:46.942489 | localhost | skipping: Conditional result was False
2026-07-25 10:28:46.942966 | 
2026-07-25 10:28:46.946398 | localhost | skipping: Conditional result was False
2026-07-25 10:28:46.958254 | 
2026-07-25 10:28:46.958524 | LOOP [upload-logs : Upload console log and json output]