2026-07-29 13:53:53.804279 | Job console starting
2026-07-29 13:53:53.825670 | Updating git repos
2026-07-29 13:53:55.718498 | Cloning repos into workspace
2026-07-29 13:54:14.333455 | Restoring repo states
2026-07-29 13:54:15.487515 | Merging changes
2026-07-29 13:54:16.928474 | Checking out repos
2026-07-29 13:54:22.418356 | Preparing playbooks
2026-07-29 13:54:27.615177 | Running Ansible setup
2026-07-29 13:54:34.886653 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-29 13:54:35.627681 | 
2026-07-29 13:54:35.628020 | PLAY [localhost]
2026-07-29 13:54:35.636326 | 
2026-07-29 13:54:35.636414 | TASK [Gathering Facts]
2026-07-29 13:54:36.722418 | localhost | ok
2026-07-29 13:54:36.731659 | 
2026-07-29 13:54:36.731821 | TASK [Setup log path fact]
2026-07-29 13:54:36.749966 | localhost | ok
2026-07-29 13:54:36.763669 | 
2026-07-29 13:54:36.763791 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-29 13:54:36.792398 | localhost | ok
2026-07-29 13:54:36.800997 | 
2026-07-29 13:54:36.801119 | TASK [emit-job-header : Print job information]
2026-07-29 13:54:36.840130 | # Job Information
2026-07-29 13:54:36.840316 | Ansible Version: 2.16.18
2026-07-29 13:54:36.840364 | Job: atmosphere-molecule-aio-ovn-selective
2026-07-29 13:54:36.840396 | Pipeline: check
2026-07-29 13:54:36.840425 | Executor: 2d72f0692154
2026-07-29 13:54:36.840490 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4164
2026-07-29 13:54:36.840539 | Event ID: 23580200-8b54-11f1-9fbd-31db3c47621b
2026-07-29 13:54:36.844726 | 
2026-07-29 13:54:36.844865 | LOOP [emit-job-header : Print node information]
2026-07-29 13:54:36.942704 | localhost | ok:
2026-07-29 13:54:36.942906 | localhost | # Node Information
2026-07-29 13:54:36.942960 | localhost | Inventory Hostname: instance
2026-07-29 13:54:36.942994 | localhost | Hostname: np0000187418
2026-07-29 13:54:36.943067 | localhost | Username: zuul
2026-07-29 13:54:36.943102 | localhost | Distro: Ubuntu 22.04
2026-07-29 13:54:36.943130 | localhost | Provider: yul1
2026-07-29 13:54:36.943157 | localhost | Region: ca-ymq-1
2026-07-29 13:54:36.943184 | localhost | Label: ubuntu-jammy-16
2026-07-29 13:54:36.943214 | localhost | Product Name: OpenStack Nova
2026-07-29 13:54:36.943241 | localhost | Interface IP: 162.253.55.222
2026-07-29 13:54:36.957419 | 
2026-07-29 13:54:36.957541 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-07-29 13:54:37.564267 | localhost -> localhost | changed
2026-07-29 13:54:37.572229 | 
2026-07-29 13:54:37.572565 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-07-29 13:54:38.678134 | localhost -> localhost | changed
2026-07-29 13:54:38.689335 | 
2026-07-29 13:54:38.689469 | PLAY [all]
2026-07-29 13:54:38.700373 | 
2026-07-29 13:54:38.700470 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-07-29 13:54:38.989866 | instance -> localhost | ok
2026-07-29 13:54:38.999153 | 
2026-07-29 13:54:38.999322 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-07-29 13:54:39.035078 | instance | ok
2026-07-29 13:54:39.056388 | instance | included: /var/lib/zuul/builds/d02ae239752949deb22249711c0121df/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-07-29 13:54:39.065247 | 
2026-07-29 13:54:39.065359 | TASK [add-build-sshkey : Create Temp SSH key]
2026-07-29 13:54:39.834671 | instance -> localhost | Generating public/private rsa key pair.
2026-07-29 13:54:39.834869 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/d02ae239752949deb22249711c0121df/work/d02ae239752949deb22249711c0121df_id_rsa
2026-07-29 13:54:39.834915 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/d02ae239752949deb22249711c0121df/work/d02ae239752949deb22249711c0121df_id_rsa.pub
2026-07-29 13:54:39.834949 | instance -> localhost | The key fingerprint is:
2026-07-29 13:54:39.834982 | instance -> localhost | SHA256:J79axovcs+MtJ+xkNgq4sVdmn7biAgugz2S8ATv2zCw zuul-build-sshkey
2026-07-29 13:54:39.835027 | instance -> localhost | The key's randomart image is:
2026-07-29 13:54:39.835681 | instance -> localhost | +---[RSA 3072]----+
2026-07-29 13:54:39.835729 | instance -> localhost | |                 |
2026-07-29 13:54:39.835764 | instance -> localhost | |                 |
2026-07-29 13:54:39.835795 | instance -> localhost | |                 |
2026-07-29 13:54:39.835826 | instance -> localhost | |o                |
2026-07-29 13:54:39.835856 | instance -> localhost | |.=      S .      |
2026-07-29 13:54:39.835888 | instance -> localhost | |+.* ..  +=       |
2026-07-29 13:54:39.835919 | instance -> localhost | |.*=+oo.+ oX.     |
2026-07-29 13:54:39.835950 | instance -> localhost | | E+=.+oo.XX=.    |
2026-07-29 13:54:39.835986 | instance -> localhost | |  . o. o**OO.    |
2026-07-29 13:54:39.836018 | instance -> localhost | +----[SHA256]-----+
2026-07-29 13:54:39.836098 | instance -> localhost | ok: Runtime: 0:00:00.362590
2026-07-29 13:54:39.844032 | 
2026-07-29 13:54:39.844158 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-07-29 13:54:39.878933 | instance | ok
2026-07-29 13:54:39.892759 | instance | included: /var/lib/zuul/builds/d02ae239752949deb22249711c0121df/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-07-29 13:54:39.902454 | 
2026-07-29 13:54:39.902574 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-07-29 13:54:39.925904 | instance | skipping: Conditional result was False
2026-07-29 13:54:39.935828 | 
2026-07-29 13:54:39.935976 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-07-29 13:54:40.388421 | instance | changed
2026-07-29 13:54:40.435289 | 
2026-07-29 13:54:40.435412 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-07-29 13:54:40.618146 | instance | ok
2026-07-29 13:54:40.629002 | 
2026-07-29 13:54:40.629169 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-07-29 13:54:41.128492 | instance | changed
2026-07-29 13:54:41.134914 | 
2026-07-29 13:54:41.135111 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-07-29 13:54:41.599875 | instance | changed
2026-07-29 13:54:41.722645 | 
2026-07-29 13:54:41.722965 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-07-29 13:54:41.747089 | instance | skipping: Conditional result was False
2026-07-29 13:54:41.760341 | 
2026-07-29 13:54:41.760553 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-07-29 13:54:42.103329 | instance -> localhost | changed
2026-07-29 13:54:42.117689 | 
2026-07-29 13:54:42.117809 | TASK [add-build-sshkey : Add back temp key]
2026-07-29 13:54:43.107523 | instance -> localhost | Identity added: /var/lib/zuul/builds/d02ae239752949deb22249711c0121df/work/d02ae239752949deb22249711c0121df_id_rsa (zuul-build-sshkey)
2026-07-29 13:54:43.107779 | instance -> localhost | ok: Runtime: 0:00:00.011521
2026-07-29 13:54:43.117126 | 
2026-07-29 13:54:43.117301 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-07-29 13:54:43.428527 | instance | ok
2026-07-29 13:54:43.433715 | 
2026-07-29 13:54:43.433810 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-07-29 13:54:43.460070 | instance | skipping: Conditional result was False
2026-07-29 13:54:43.472941 | 
2026-07-29 13:54:43.473109 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-07-29 13:54:43.777677 | instance | ok
2026-07-29 13:54:43.787824 | 
2026-07-29 13:54:43.788030 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-07-29 13:54:48.526201 | instance | Output suppressed because no_log was given
2026-07-29 13:54:48.537846 | 
2026-07-29 13:54:48.537958 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-07-29 13:54:48.731797 | instance | ok: "logs"
2026-07-29 13:54:48.732045 | instance | ok: All items complete
2026-07-29 13:54:48.732081 | 
2026-07-29 13:54:48.885746 | instance | ok: "artifacts"
2026-07-29 13:54:49.042036 | instance | ok: "docs"
2026-07-29 13:54:49.053263 | 
2026-07-29 13:54:49.053382 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-07-29 13:54:49.241234 | instance | changed: "logs"
2026-07-29 13:54:49.411693 | instance | changed: "artifacts"
2026-07-29 13:54:49.558085 | instance | changed: "docs"
2026-07-29 13:54:49.574898 | 
2026-07-29 13:54:49.574991 | PLAY RECAP
2026-07-29 13:54:49.575055 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-07-29 13:54:49.575097 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-29 13:54:49.575129 | 
2026-07-29 13:54:49.739528 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-29 13:54:49.752514 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-29 13:54:50.442040 | 
2026-07-29 13:54:50.442206 | PLAY [all]
2026-07-29 13:54:50.454774 | 
2026-07-29 13:54:50.454938 | TASK [setup-uv : Extract archive]
2026-07-29 13:54:52.840304 | instance | changed
2026-07-29 13:54:52.846819 | 
2026-07-29 13:54:52.846955 | TASK [setup-uv : Print version]
2026-07-29 13:54:53.201678 | instance | uv 0.8.13
2026-07-29 13:54:53.398044 | instance | ok: Runtime: 0:00:00.009476
2026-07-29 13:54:53.408145 | 
2026-07-29 13:54:53.408229 | TASK [Install Ansible collection siblings]
2026-07-29 13:55:02.813960 | instance | changed:
2026-07-29 13:55:02.814135 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-07-29 13:55:02.814169 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-07-29 13:55:02.814211 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-07-29 13:55:02.814254 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-07-29 13:55:02.814284 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-07-29 13:55:02.814318 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-07-29 13:55:02.814351 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-07-29 13:55:02.814383 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-07-29 13:55:02.814410 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-07-29 13:55:02.814437 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-07-29 13:55:02.814462 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-07-29 13:55:02.814483 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-07-29 13:55:02.814503 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-07-29 13:55:02.814523 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-07-29 13:55:02.814544 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0
2026-07-29 13:55:02.814565 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-07-29 13:55:02.814586 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-07-29 13:55:02.814606 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-07-29 13:55:02.814626 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-07-29 13:55:02.814645 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-07-29 13:55:02.814664 | instance | Resolved vexxhost.ceph to v4.1.0 for >=3.2.0
2026-07-29 13:55:02.814684 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-07-29 13:55:02.814704 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-29 13:55:02.814737 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-07-29 13:55:02.814764 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0,>=6.0.0
2026-07-29 13:55:02.814792 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-29 13:55:02.814824 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-29 13:55:02.814853 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-29 13:55:02.814874 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-07-29 13:55:02.814892 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-07-29 13:55:02.814911 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-29 13:55:02.814935 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-29 13:55:02.814964 | instance | Checked out ansible.netcommon to 1.2.0
2026-07-29 13:55:02.814990 | 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 13:55:02.815042 | instance | Starting galaxy collection install process
2026-07-29 13:55:02.815068 | instance | Process install dependency map
2026-07-29 13:55:02.815089 | instance | Starting collection install process
2026-07-29 13:55:02.815109 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-07-29 13:55:02.815128 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-07-29 13:55:02.815173 | instance | ansible.netcommon:* was installed successfully
2026-07-29 13:55:02.815212 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-07-29 13:55:02.815241 | instance | Creating virtual environment at: .venv
2026-07-29 13:55:02.815268 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-29 13:55:02.815290 | instance | Downloading netaddr (2.2MiB)
2026-07-29 13:55:02.815309 | instance | Downloading kubernetes (1.9MiB)
2026-07-29 13:55:02.815328 | instance | Downloading pydantic-core (2.0MiB)
2026-07-29 13:55:02.815347 | instance | Downloading setuptools (1.1MiB)
2026-07-29 13:55:02.815365 | instance | Downloading pygments (1.2MiB)
2026-07-29 13:55:02.815384 | instance | Downloading ansible-core (2.1MiB)
2026-07-29 13:55:02.815402 | instance | Downloading openstacksdk (1.7MiB)
2026-07-29 13:55:02.815421 | instance | Downloading cryptography (4.2MiB)
2026-07-29 13:55:02.815440 | instance | Downloading rjsonnet (1.2MiB)
2026-07-29 13:55:02.815458 | instance |    Building pyperclip==1.9.0
2026-07-29 13:55:02.815478 | instance |  Downloading rjsonnet
2026-07-29 13:55:02.815497 | instance |  Downloading pydantic-core
2026-07-29 13:55:02.815515 | instance |  Downloading netaddr
2026-07-29 13:55:02.815534 | instance |  Downloading pygments
2026-07-29 13:55:02.815553 | instance |  Downloading cryptography
2026-07-29 13:55:02.815573 | instance |  Downloading setuptools
2026-07-29 13:55:02.815599 | instance |  Downloading kubernetes
2026-07-29 13:55:02.815628 | instance |  Downloading ansible-core
2026-07-29 13:55:02.815657 | instance |  Downloading openstacksdk
2026-07-29 13:55:02.815678 | instance |       Built pyperclip==1.9.0
2026-07-29 13:55:02.815698 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-29 13:55:02.815718 | instance | Installed 87 packages in 63ms
2026-07-29 13:55:02.815737 | instance | Checked out ansible.posix to 1.6.0
2026-07-29 13:55:02.815756 | 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 13:55:02.815775 | instance | Starting galaxy collection install process
2026-07-29 13:55:02.815794 | instance | Process install dependency map
2026-07-29 13:55:02.815819 | instance | Starting collection install process
2026-07-29 13:55:02.815847 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-07-29 13:55:02.815875 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-07-29 13:55:02.815900 | instance | ansible.posix:1.6.0 was installed successfully
2026-07-29 13:55:02.815919 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:55:02.815939 | instance | 2.17.12
2026-07-29 13:55:02.815957 | instance | Checked out ansible.utils to v6.0.3
2026-07-29 13:55:02.815976 | 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 13:55:02.815996 | instance | Starting galaxy collection install process
2026-07-29 13:55:02.816031 | instance | Process install dependency map
2026-07-29 13:55:02.816066 | instance | Starting collection install process
2026-07-29 13:55:02.816089 | instance | Installing 'ansible.utils:6.0.3' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-07-29 13:55:02.816110 | instance | Created collection for ansible.utils:6.0.3 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-07-29 13:55:02.816129 | instance | ansible.utils:6.0.3 was installed successfully
2026-07-29 13:55:02.816149 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:55:02.816168 | instance | 2.17.12
2026-07-29 13:55:02.816187 | instance | Checked out atmosphere.common to v0.7.0
2026-07-29 13:55:02.816206 | 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 13:55:02.816226 | instance | Starting galaxy collection install process
2026-07-29 13:55:02.816245 | instance | Process install dependency map
2026-07-29 13:55:02.816264 | instance | Starting collection install process
2026-07-29 13:55:02.816283 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-07-29 13:55:02.816301 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-07-29 13:55:02.816319 | instance | atmosphere.common:0.7.0 was installed successfully
2026-07-29 13:55:02.816338 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:55:02.816356 | instance | 2.17.12
2026-07-29 13:55:02.816375 | instance | Checked out community.crypto to 2.2.3
2026-07-29 13:55:02.816395 | 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 13:55:02.816413 | instance | Starting galaxy collection install process
2026-07-29 13:55:02.816431 | instance | Process install dependency map
2026-07-29 13:55:02.816449 | instance | Starting collection install process
2026-07-29 13:55:02.816487 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-07-29 13:55:02.816520 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-07-29 13:55:02.816541 | instance | community.crypto:2.2.3 was installed successfully
2026-07-29 13:55:02.816562 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:55:02.816581 | instance | 2.17.12
2026-07-29 13:55:02.816601 | instance | Checked out community.general to 7.3.0
2026-07-29 13:55:02.816619 | 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 13:55:02.816647 | instance | Starting galaxy collection install process
2026-07-29 13:55:02.816667 | instance | Process install dependency map
2026-07-29 13:55:02.816686 | instance | Starting collection install process
2026-07-29 13:55:02.816704 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-07-29 13:55:02.816722 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-07-29 13:55:02.816740 | instance | community.general:7.3.0 was installed successfully
2026-07-29 13:55:02.816759 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:55:02.816778 | instance | 2.17.12
2026-07-29 13:55:02.816798 | instance | Checked out community.mysql to 3.6.0
2026-07-29 13:55:02.816818 | 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 13:55:02.816838 | instance | Starting galaxy collection install process
2026-07-29 13:55:02.816859 | instance | Process install dependency map
2026-07-29 13:55:02.816886 | instance | Starting collection install process
2026-07-29 13:55:02.816913 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-07-29 13:55:02.816934 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-07-29 13:55:02.817037 | instance | community.mysql:3.6.0 was installed successfully
2026-07-29 13:55:02.817089 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:55:02.817114 | instance | 2.17.12
2026-07-29 13:55:02.817134 | instance | Checked out kubernetes.core to 2.4.0
2026-07-29 13:55:02.817155 | 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 13:55:02.817175 | instance | Starting galaxy collection install process
2026-07-29 13:55:02.817194 | instance | Process install dependency map
2026-07-29 13:55:02.817214 | instance | Starting collection install process
2026-07-29 13:55:02.817262 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-07-29 13:55:02.817294 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-07-29 13:55:02.817324 | instance | kubernetes.core:2.4.0 was installed successfully
2026-07-29 13:55:02.817347 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:55:02.817367 | instance | 2.17.12
2026-07-29 13:55:02.817392 | instance | Checked out openstack.cloud to 2.6.0
2026-07-29 13:55:02.817421 | 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 13:55:02.817449 | instance | Starting galaxy collection install process
2026-07-29 13:55:02.817469 | instance | Process install dependency map
2026-07-29 13:55:02.817488 | instance | Starting collection install process
2026-07-29 13:55:02.817506 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-07-29 13:55:02.817581 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-07-29 13:55:02.817606 | instance | openstack.cloud:2.6.0 was installed successfully
2026-07-29 13:55:02.817626 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:55:02.817644 | instance | 2.17.12
2026-07-29 13:55:02.817670 | instance | Checked out vexxhost.ceph to v4.1.0
2026-07-29 13:55:02.817690 | 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 13:55:02.817709 | instance | Starting galaxy collection install process
2026-07-29 13:55:02.817727 | instance | Process install dependency map
2026-07-29 13:55:02.817745 | instance | Starting collection install process
2026-07-29 13:55:02.817763 | instance | Installing 'vexxhost.ceph:4.1.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-07-29 13:55:02.817781 | instance | Created collection for vexxhost.ceph:4.1.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-07-29 13:55:02.817799 | instance | vexxhost.ceph:4.1.0 was installed successfully
2026-07-29 13:55:02.817817 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:55:02.817835 | instance | 2.17.12
2026-07-29 13:55:02.817853 | instance | Checked out vexxhost.containers to v1.6.8
2026-07-29 13:55:02.817872 | 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 13:55:02.817891 | instance | Starting galaxy collection install process
2026-07-29 13:55:02.817917 | instance | Process install dependency map
2026-07-29 13:55:02.817946 | instance | Starting collection install process
2026-07-29 13:55:02.817966 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-07-29 13:55:02.817985 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-07-29 13:55:02.818003 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-07-29 13:55:02.818037 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:55:02.818088 | instance | 2.17.12
2026-07-29 13:55:02.818116 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-07-29 13:55:02.818144 | 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 13:55:02.818183 | instance | Starting galaxy collection install process
2026-07-29 13:55:02.818207 | instance | Process install dependency map
2026-07-29 13:55:02.818236 | instance | Starting collection install process
2026-07-29 13:55:02.818283 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-07-29 13:55:02.818309 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-07-29 13:55:02.818328 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-07-29 13:55:02.818347 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:55:02.818366 | instance | 2.17.12
2026-07-29 13:55:02.829334 | 
2026-07-29 13:55:02.829611 | PLAY RECAP
2026-07-29 13:55:02.829766 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-29 13:55:02.829854 | 
2026-07-29 13:55:03.052400 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-29 13:55:03.062470 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-29 13:55:03.857938 | 
2026-07-29 13:55:03.858143 | PLAY [all]
2026-07-29 13:55:03.886867 | 
2026-07-29 13:55:03.887091 | TASK [Install "jq" for log collection]
2026-07-29 13:55:17.170264 | instance | changed
2026-07-29 13:55:17.172980 | 
2026-07-29 13:55:17.173091 | PLAY RECAP
2026-07-29 13:55:17.173154 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-29 13:55:17.173235 | 
2026-07-29 13:55:17.373549 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-29 13:55:17.386681 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-29 13:55:18.140326 | 
2026-07-29 13:55:18.140474 | PLAY [Prepare selective Molecule plan]
2026-07-29 13:55:18.154317 | 
2026-07-29 13:55:18.154477 | TASK [Generate selective Molecule plan]
2026-07-29 13:55:19.200402 | instance | ok: Runtime: 0:00:00.169497
2026-07-29 13:55:19.205815 | 
2026-07-29 13:55:19.205952 | TASK [Render selective Molecule plan]
2026-07-29 13:55:19.523800 | instance | Selective Molecule plan: selective
2026-07-29 13:55:19.524009 | instance | Changed files:
2026-07-29 13:55:19.524023 | instance |   M roles/glance/README.md
2026-07-29 13:55:19.524033 | instance | Targets: glance
2026-07-29 13:55:19.524042 | instance | Job decisions:
2026-07-29 13:55:19.524055 | instance |   RUN  aio-openvswitch: selected by changed components
2026-07-29 13:55:19.524069 | instance |        components: ceph, ceph-provisioners, cert-manager, cluster-issuer, csi, glance, ingress-nginx, keycloak, keystone, kubernetes, memcached, percona-xtradb-cluster, percona-xtradb-cluster-operator, rabbitmq-cluster-operator
2026-07-29 13:55:19.524081 | instance |        Tempest include: ^tempest\.api\.image\.
2026-07-29 13:55:19.524090 | instance |   SKIP aio-ovn: no changed component requires this job
2026-07-29 13:55:19.524100 | instance |   SKIP csi-local-path-provisioner: no changed component requires this job
2026-07-29 13:55:19.524109 | instance |   SKIP csi-rbd: no changed component requires this job
2026-07-29 13:55:19.524118 | instance |   SKIP keycloak: no changed component requires this job
2026-07-29 13:55:19.744160 | instance | ok: Runtime: 0:00:00.115914
2026-07-29 13:55:19.745699 | 
2026-07-29 13:55:19.745744 | PLAY RECAP
2026-07-29 13:55:19.745785 | instance | ok: 2 changed: 0 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-29 13:55:19.745806 | 
2026-07-29 13:55:19.886343 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-29 13:55:19.897777 | RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-29 13:55:20.620915 | 
2026-07-29 13:55:20.621145 | PLAY [Run selected Molecule scenario]
2026-07-29 13:55:20.637015 | 
2026-07-29 13:55:20.637170 | TASK [Read selective Molecule plan]
2026-07-29 13:55:20.983877 | instance | ok
2026-07-29 13:55:20.990415 | 
2026-07-29 13:55:20.990522 | TASK [Resolve this job decision]
2026-07-29 13:55:21.054189 | instance | ok
2026-07-29 13:55:21.062956 | 
2026-07-29 13:55:21.063093 | TASK [Assert this job exists in the plan]
2026-07-29 13:55:21.094104 | instance | ok: All assertions passed
2026-07-29 13:55:21.100620 | 
2026-07-29 13:55:21.100737 | TASK [Resolve selected scenario inputs]
2026-07-29 13:55:21.131717 | instance | ok
2026-07-29 13:55:21.138107 | 
2026-07-29 13:55:21.138249 | TASK [Report this job decision]
2026-07-29 13:55:21.192801 | instance | ok:
2026-07-29 13:55:21.193141 | instance | Selective Molecule job: aio-ovn
2026-07-29 13:55:21.193195 | instance | Decision: SKIP
2026-07-29 13:55:21.193229 | instance | Reason: no changed component requires this job
2026-07-29 13:55:21.193263 | instance | Scenario: aio
2026-07-29 13:55:21.193293 | instance | Targets: (none)
2026-07-29 13:55:21.193324 | instance | Components: (full scenario)
2026-07-29 13:55:21.200548 | 
2026-07-29 13:55:21.200661 | LOOP [Check Molecule inventory directories]
2026-07-29 13:55:21.249639 | instance | skipping: Conditional result was False
2026-07-29 13:55:21.250938 | instance | skipping: Conditional result was False
2026-07-29 13:55:21.253724 | instance | skipping: Conditional result was False
2026-07-29 13:55:21.262827 | 
2026-07-29 13:55:21.262992 | LOOP [Copy Zuul inventory for Molecule]
2026-07-29 13:55:21.301334 | instance | skipping: Conditional result was False
2026-07-29 13:55:21.302016 | 
2026-07-29 13:55:21.303357 | instance | skipping: Conditional result was False
2026-07-29 13:55:21.304751 | instance | skipping: Conditional result was False
2026-07-29 13:55:21.321420 | 
2026-07-29 13:55:21.321618 | LOOP [Use private addresses in Molecule inventory]
2026-07-29 13:55:21.362760 | instance | skipping: Conditional result was False
2026-07-29 13:55:21.363270 | 
2026-07-29 13:55:21.364994 | instance | skipping: Conditional result was False
2026-07-29 13:55:21.369321 | instance | skipping: Conditional result was False
2026-07-29 13:55:21.388249 | 
2026-07-29 13:55:21.388449 | TASK [Prepare Molecule command]
2026-07-29 13:55:21.445710 | instance | skipping: Conditional result was False
2026-07-29 13:55:21.455026 | 
2026-07-29 13:55:21.455171 | TASK [Run standard Molecule lifecycle with progress output]
2026-07-29 13:55:21.510524 | instance | skipping: Conditional result was False
2026-07-29 13:55:21.543209 | 
2026-07-29 13:55:21.543327 | PLAY RECAP
2026-07-29 13:55:21.543429 | instance | ok: 5 changed: 0 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-07-29 13:55:21.543481 | 
2026-07-29 13:55:21.720703 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-29 13:55:21.728155 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-07-29 13:55:22.536417 | 
2026-07-29 13:55:22.536580 | PLAY [Publish selective Molecule plan]
2026-07-29 13:55:22.548890 | 
2026-07-29 13:55:22.549003 | TASK [Check for selective Molecule plan]
2026-07-29 13:55:22.947547 | instance | ok
2026-07-29 13:55:22.952621 | 
2026-07-29 13:55:22.952704 | TASK [Create log directory]
2026-07-29 13:55:23.309259 | instance | changed
2026-07-29 13:55:23.316017 | 
2026-07-29 13:55:23.316133 | TASK [Copy selective Molecule plan to logs]
2026-07-29 13:55:23.780041 | instance | changed
2026-07-29 13:55:23.782691 | 
2026-07-29 13:55:23.782780 | PLAY RECAP
2026-07-29 13:55:23.782860 | instance | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-29 13:55:23.782904 | 
2026-07-29 13:55:24.049962 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-07-29 13:55:24.059921 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-29 13:55:24.832223 | 
2026-07-29 13:55:24.832422 | PLAY [all]
2026-07-29 13:55:24.849299 | 
2026-07-29 13:55:24.849535 | TASK [gather-host-logs : creating directory for system status]
2026-07-29 13:55:25.211197 | instance | changed
2026-07-29 13:55:25.218001 | 
2026-07-29 13:55:25.218159 | TASK [gather-host-logs : Get logs for each host]
2026-07-29 13:55:25.563715 | instance | + systemd-cgls --full --all --no-pager
2026-07-29 13:55:25.574364 | instance | + ip addr
2026-07-29 13:55:25.576248 | instance | + ip route
2026-07-29 13:55:25.577399 | instance | + lsblk
2026-07-29 13:55:25.579754 | instance | + mount
2026-07-29 13:55:25.581039 | instance | + docker images
2026-07-29 13:55:25.581419 | instance | /bin/bash: line 7: docker: command not found
2026-07-29 13:55:25.581602 | instance | + brctl show
2026-07-29 13:55:25.581959 | instance | /bin/bash: line 8: brctl: command not found
2026-07-29 13:55:25.582162 | instance | + ps aux --sort=-%mem
2026-07-29 13:55:25.598517 | instance | + dpkg -l
2026-07-29 13:55:25.611375 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-07-29 13:55:25.612047 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-07-29 13:55:25.612172 | instance | /bin/bash: line 11: docker: command not found
2026-07-29 13:55:25.612621 | instance | + '[' '!' -z '' ']'
2026-07-29 13:55:25.804292 | instance | ok: Runtime: 0:00:00.053614
2026-07-29 13:55:25.813208 | 
2026-07-29 13:55:25.813353 | TASK [gather-host-logs : Downloads logs to executor]
2026-07-29 13:55:26.560027 | instance | changed:
2026-07-29 13:55:26.560374 | instance | created directory /var/lib/zuul/builds/d02ae239752949deb22249711c0121df/work/logs/instance
2026-07-29 13:55:26.560429 | instance | cd+++++++++ system/
2026-07-29 13:55:26.560465 | instance | >f+++++++++ system/brctl-show.txt
2026-07-29 13:55:26.560497 | instance | >f+++++++++ system/docker-images.txt
2026-07-29 13:55:26.560540 | instance | >f+++++++++ system/ip-addr.txt
2026-07-29 13:55:26.560606 | instance | >f+++++++++ system/ip-route.txt
2026-07-29 13:55:26.560643 | instance | >f+++++++++ system/lsblk.txt
2026-07-29 13:55:26.560674 | instance | >f+++++++++ system/mount.txt
2026-07-29 13:55:26.560708 | instance | >f+++++++++ system/packages.txt
2026-07-29 13:55:26.560783 | instance | >f+++++++++ system/ps.txt
2026-07-29 13:55:26.560939 | instance | >f+++++++++ system/systemd-cgls.txt
2026-07-29 13:55:26.574953 | 
2026-07-29 13:55:26.575122 | LOOP [helm-release-status : creating directory for helm release status]
2026-07-29 13:55:26.778117 | instance | changed: "values"
2026-07-29 13:55:26.963522 | instance | changed: "releases"
2026-07-29 13:55:26.982707 | 
2026-07-29 13:55:26.984224 | TASK [helm-release-status : Gather get release status for helm charts]
2026-07-29 13:55:27.256230 | instance | /bin/bash: line 3: kubectl: command not found
2026-07-29 13:55:27.567933 | instance | ok: Runtime: 0:00:00.008562
2026-07-29 13:55:27.577021 | 
2026-07-29 13:55:27.577224 | TASK [helm-release-status : Downloads logs to executor]
2026-07-29 13:55:28.126273 | instance | changed:
2026-07-29 13:55:28.126423 | instance | cd+++++++++ helm/
2026-07-29 13:55:28.126452 | instance | cd+++++++++ helm/releases/
2026-07-29 13:55:28.126476 | instance | cd+++++++++ helm/values/
2026-07-29 13:55:28.136477 | 
2026-07-29 13:55:28.136589 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-07-29 13:55:28.341468 | instance | changed
2026-07-29 13:55:28.365216 | 
2026-07-29 13:55:28.365393 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-07-29 13:55:28.593539 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-29 13:55:28.593789 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-29 13:55:28.598950 | instance | environment: line 1: kubectl: command not found
2026-07-29 13:55:28.600630 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-29 13:55:28.601843 | instance | environment: line 1: kubectl: command not found
2026-07-29 13:55:28.603027 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-29 13:55:28.603876 | instance | environment: line 1: kubectl: command not found
2026-07-29 13:55:28.605101 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-29 13:55:28.606769 | instance | environment: line 1: kubectl: command not found
2026-07-29 13:55:28.607644 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-29 13:55:28.608627 | instance | environment: line 1: kubectl: command not found
2026-07-29 13:55:28.609988 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-29 13:55:28.979291 | instance | ok: Runtime: 0:00:00.027164
2026-07-29 13:55:28.986668 | 
2026-07-29 13:55:28.986793 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-07-29 13:55:29.195961 | instance | changed
2026-07-29 13:55:29.205768 | 
2026-07-29 13:55:29.205893 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-07-29 13:55:29.421210 | instance | environment: line 5: kubectl: command not found
2026-07-29 13:55:29.422060 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-29 13:55:29.422531 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-29 13:55:29.422631 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-29 13:55:29.746007 | instance | ok: Runtime: 0:00:00.010993
2026-07-29 13:55:29.753727 | 
2026-07-29 13:55:29.753797 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-07-29 13:55:30.273133 | instance | changed:
2026-07-29 13:55:30.273389 | instance | cd+++++++++ objects/
2026-07-29 13:55:30.273450 | instance | cd+++++++++ objects/cluster/
2026-07-29 13:55:30.273499 | instance | cd+++++++++ objects/namespaced/
2026-07-29 13:55:30.287522 | 
2026-07-29 13:55:30.287620 | TASK [gather-pod-logs : creating directory for pod logs]
2026-07-29 13:55:30.499030 | instance | changed
2026-07-29 13:55:30.506835 | 
2026-07-29 13:55:30.506960 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-07-29 13:55:30.698936 | instance | changed
2026-07-29 13:55:30.704015 | 
2026-07-29 13:55:30.704082 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-07-29 13:55:30.917394 | instance | environment: line 3: kubectl: command not found
2026-07-29 13:55:31.238706 | instance | ok: Runtime: 0:00:00.006381
2026-07-29 13:55:31.246682 | 
2026-07-29 13:55:31.246883 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-07-29 13:55:31.741111 | instance | changed:
2026-07-29 13:55:31.741305 | instance | cd+++++++++ pod-logs/
2026-07-29 13:55:31.741346 | instance | cd+++++++++ pod-logs/failed-pods/
2026-07-29 13:55:31.752688 | 
2026-07-29 13:55:31.752772 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-07-29 13:55:31.951217 | instance | changed
2026-07-29 13:55:31.958959 | 
2026-07-29 13:55:31.959102 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-07-29 13:55:32.175322 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-29 13:55:32.497814 | instance | ok: Runtime: 0:00:00.038401
2026-07-29 13:55:32.505572 | 
2026-07-29 13:55:32.505656 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-07-29 13:55:32.722688 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-29 13:55:32.752002 | instance | ceph-mgr endpoints:
2026-07-29 13:55:33.043376 | instance | ok: Runtime: 0:00:00.035213
2026-07-29 13:55:33.053854 | 
2026-07-29 13:55:33.053966 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-07-29 13:55:33.312865 | instance | /bin/bash: line 4: kubectl: command not found
2026-07-29 13:55:33.647876 | instance | ok: Runtime: 0:00:00.034541
2026-07-29 13:55:33.656202 | 
2026-07-29 13:55:33.656429 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-07-29 13:55:34.153730 | instance | changed: cd+++++++++ prometheus/
2026-07-29 13:55:34.164628 | 
2026-07-29 13:55:34.164776 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-07-29 13:55:34.373275 | instance | changed
2026-07-29 13:55:34.380329 | 
2026-07-29 13:55:34.380404 | TASK [gather-selenium-data : Get selenium data]
2026-07-29 13:55:34.619930 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-07-29 13:55:34.620961 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-07-29 13:55:34.919234 | instance | ERROR
2026-07-29 13:55:34.919593 | instance | {
2026-07-29 13:55:34.919698 | instance |   "delta": "0:00:00.005277",
2026-07-29 13:55:34.919740 | instance |   "end": "2026-07-29 13:55:34.621236",
2026-07-29 13:55:34.919772 | instance |   "msg": "non-zero return code",
2026-07-29 13:55:34.919802 | instance |   "rc": 1,
2026-07-29 13:55:34.919831 | instance |   "start": "2026-07-29 13:55:34.615959"
2026-07-29 13:55:34.919857 | instance | }
2026-07-29 13:55:34.919907 | instance | ERROR: Ignoring Errors
2026-07-29 13:55:34.925128 | 
2026-07-29 13:55:34.925199 | TASK [gather-selenium-data : Downloads logs to executor]
2026-07-29 13:55:35.427389 | instance | changed: cd+++++++++ selenium/
2026-07-29 13:55:35.437239 | 
2026-07-29 13:55:35.437321 | PLAY RECAP
2026-07-29 13:55:35.437367 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-07-29 13:55:35.437392 | 
2026-07-29 13:55:35.594442 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-29 13:55:35.604056 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-29 13:55:36.438282 | 
2026-07-29 13:55:36.438460 | PLAY [all]
2026-07-29 13:55:36.455162 | 
2026-07-29 13:55:36.455321 | TASK [fetch-output : Set log path for multiple nodes]
2026-07-29 13:55:36.500867 | instance | skipping: Conditional result was False
2026-07-29 13:55:36.514372 | 
2026-07-29 13:55:36.514608 | TASK [fetch-output : Set log path for single node]
2026-07-29 13:55:36.554604 | instance | ok
2026-07-29 13:55:36.560088 | 
2026-07-29 13:55:36.560161 | LOOP [fetch-output : Ensure local output dirs]
2026-07-29 13:55:37.003194 | instance -> localhost | ok: "/var/lib/zuul/builds/d02ae239752949deb22249711c0121df/work/logs"
2026-07-29 13:55:37.242639 | instance -> localhost | changed: "/var/lib/zuul/builds/d02ae239752949deb22249711c0121df/work/artifacts"
2026-07-29 13:55:37.454249 | instance -> localhost | changed: "/var/lib/zuul/builds/d02ae239752949deb22249711c0121df/work/docs"
2026-07-29 13:55:37.468522 | 
2026-07-29 13:55:37.469106 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-07-29 13:55:38.132870 | instance | changed: .d..t...... ./
2026-07-29 13:55:38.133151 | instance | changed: All items complete
2026-07-29 13:55:38.133193 | 
2026-07-29 13:55:38.615136 | instance | changed: .d..t...... ./
2026-07-29 13:55:39.102247 | instance | changed: .d..t...... ./
2026-07-29 13:55:39.131343 | 
2026-07-29 13:55:39.131487 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-07-29 13:55:39.594515 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007077
2026-07-29 13:55:39.835853 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008795
2026-07-29 13:55:39.854038 | 
2026-07-29 13:55:39.854152 | PLAY [all]
2026-07-29 13:55:39.860556 | 
2026-07-29 13:55:39.860630 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-07-29 13:55:40.311257 | instance | changed
2026-07-29 13:55:40.319464 | 
2026-07-29 13:55:40.319576 | PLAY RECAP
2026-07-29 13:55:40.319631 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-29 13:55:40.319662 | 
2026-07-29 13:55:40.478622 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-29 13:55:40.493062 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-07-29 13:55:41.311652 | 
2026-07-29 13:55:41.311858 | PLAY [localhost]
2026-07-29 13:55:41.323873 | 
2026-07-29 13:55:41.324067 | TASK [Generate Zuul manifest]
2026-07-29 13:55:41.349779 | localhost | ok
2026-07-29 13:55:41.371732 | 
2026-07-29 13:55:41.371996 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-07-29 13:55:41.837746 | localhost | changed
2026-07-29 13:55:41.860879 | 
2026-07-29 13:55:41.861149 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-07-29 13:55:41.891651 | localhost | ok
2026-07-29 13:55:41.901111 | 
2026-07-29 13:55:41.901197 | TASK [Upload logs]
2026-07-29 13:55:41.921050 | localhost | ok
2026-07-29 13:55:42.033502 | 
2026-07-29 13:55:42.033638 | TASK [Set zuul-log-path fact]
2026-07-29 13:55:42.066226 | localhost | ok
2026-07-29 13:55:42.081809 | 
2026-07-29 13:55:42.081922 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-29 13:55:42.113192 | localhost | ok
2026-07-29 13:55:42.123128 | 
2026-07-29 13:55:42.123263 | TASK [upload-logs : Create log directories]
2026-07-29 13:55:42.520566 | localhost | changed
2026-07-29 13:55:42.525906 | 
2026-07-29 13:55:42.526004 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-07-29 13:55:42.955461 | localhost -> localhost | ok: Runtime: 0:00:00.006677
2026-07-29 13:55:42.963072 | 
2026-07-29 13:55:42.963206 | TASK [upload-logs : Upload logs to log server]
2026-07-29 13:55:43.482533 | localhost | Output suppressed because no_log was given
2026-07-29 13:55:43.487491 | 
2026-07-29 13:55:43.487563 | LOOP [upload-logs : Compress console log and json output]
2026-07-29 13:55:43.536594 | localhost | skipping: Conditional result was False
2026-07-29 13:55:43.544185 | localhost | skipping: Conditional result was False
2026-07-29 13:55:43.557556 | 
2026-07-29 13:55:43.557684 | LOOP [upload-logs : Upload compressed console log and json output]
2026-07-29 13:55:43.597455 | localhost | skipping: Conditional result was False
2026-07-29 13:55:43.597742 | 
2026-07-29 13:55:43.603379 | localhost | skipping: Conditional result was False
2026-07-29 13:55:43.619063 | 
2026-07-29 13:55:43.619232 | LOOP [upload-logs : Upload console log and json output]