2026-07-29 13:52:12.848718 | Job console starting
2026-07-29 13:52:12.860060 | Updating git repos
2026-07-29 13:52:15.110999 | Cloning repos into workspace
2026-07-29 13:52:35.644696 | Restoring repo states
2026-07-29 13:52:46.471137 | Merging changes
2026-07-29 13:52:47.649974 | Checking out repos
2026-07-29 13:52:49.863481 | Preparing playbooks
2026-07-29 13:52:54.976349 | Running Ansible setup
2026-07-29 13:52:58.740173 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-29 13:52:59.542527 | 
2026-07-29 13:52:59.542697 | PLAY [localhost]
2026-07-29 13:52:59.553390 | 
2026-07-29 13:52:59.553529 | TASK [Gathering Facts]
2026-07-29 13:53:01.415032 | localhost | ok
2026-07-29 13:53:01.424916 | 
2026-07-29 13:53:01.425083 | TASK [Setup log path fact]
2026-07-29 13:53:01.445203 | localhost | ok
2026-07-29 13:53:01.461954 | 
2026-07-29 13:53:01.462065 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-29 13:53:01.503145 | localhost | ok
2026-07-29 13:53:01.512345 | 
2026-07-29 13:53:01.512470 | TASK [emit-job-header : Print job information]
2026-07-29 13:53:01.555051 | # Job Information
2026-07-29 13:53:01.555294 | Ansible Version: 2.16.18
2026-07-29 13:53:01.555370 | Job: atmosphere-molecule-keycloak-selective
2026-07-29 13:53:01.555425 | Pipeline: check
2026-07-29 13:53:01.555472 | Executor: 2d72f0692154
2026-07-29 13:53:01.555519 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4164
2026-07-29 13:53:01.555576 | Event ID: 23580200-8b54-11f1-9fbd-31db3c47621b
2026-07-29 13:53:01.562101 | 
2026-07-29 13:53:01.562245 | LOOP [emit-job-header : Print node information]
2026-07-29 13:53:01.656771 | localhost | ok:
2026-07-29 13:53:01.656917 | localhost | # Node Information
2026-07-29 13:53:01.656948 | localhost | Inventory Hostname: instance
2026-07-29 13:53:01.657018 | localhost | Hostname: np0000187413
2026-07-29 13:53:01.657050 | localhost | Username: zuul
2026-07-29 13:53:01.657078 | localhost | Distro: Ubuntu 22.04
2026-07-29 13:53:01.657100 | localhost | Provider: yul1
2026-07-29 13:53:01.657120 | localhost | Region: ca-ymq-1
2026-07-29 13:53:01.657138 | localhost | Label: ubuntu-jammy
2026-07-29 13:53:01.657156 | localhost | Product Name: OpenStack Nova
2026-07-29 13:53:01.657175 | localhost | Interface IP: 199.19.213.10
2026-07-29 13:53:01.663555 | 
2026-07-29 13:53:01.663641 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-07-29 13:53:02.116106 | localhost -> localhost | changed
2026-07-29 13:53:02.123388 | 
2026-07-29 13:53:02.123551 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-07-29 13:53:03.308576 | localhost -> localhost | changed
2026-07-29 13:53:03.316534 | 
2026-07-29 13:53:03.316621 | PLAY [all]
2026-07-29 13:53:03.324351 | 
2026-07-29 13:53:03.324433 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-07-29 13:53:03.581842 | instance -> localhost | ok
2026-07-29 13:53:03.592252 | 
2026-07-29 13:53:03.592429 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-07-29 13:53:03.626852 | instance | ok
2026-07-29 13:53:03.647895 | instance | included: /var/lib/zuul/builds/7e78381fb3504205b4d4a7024d750ca9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-07-29 13:53:03.655626 | 
2026-07-29 13:53:03.655719 | TASK [add-build-sshkey : Create Temp SSH key]
2026-07-29 13:53:06.018523 | instance -> localhost | Generating public/private rsa key pair.
2026-07-29 13:53:06.018751 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/7e78381fb3504205b4d4a7024d750ca9/work/7e78381fb3504205b4d4a7024d750ca9_id_rsa
2026-07-29 13:53:06.018799 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/7e78381fb3504205b4d4a7024d750ca9/work/7e78381fb3504205b4d4a7024d750ca9_id_rsa.pub
2026-07-29 13:53:06.018834 | instance -> localhost | The key fingerprint is:
2026-07-29 13:53:06.018898 | instance -> localhost | SHA256:MjYLwbqD00BIl+kOsHOdnKc09YDT/uol38ZZWSCNMQ0 zuul-build-sshkey
2026-07-29 13:53:06.018987 | instance -> localhost | The key's randomart image is:
2026-07-29 13:53:06.019045 | instance -> localhost | +---[RSA 3072]----+
2026-07-29 13:53:06.019157 | instance -> localhost | | . .oo    E*     |
2026-07-29 13:53:06.019231 | instance -> localhost | |+ .+o +   o.+    |
2026-07-29 13:53:06.019278 | instance -> localhost | |oo.oo* o   . .   |
2026-07-29 13:53:06.019347 | instance -> localhost | |+..oB.o .     .  |
2026-07-29 13:53:06.019403 | instance -> localhost | |.o+..+=.S    o   |
2026-07-29 13:53:06.019446 | instance -> localhost | | + o.o =.   o    |
2026-07-29 13:53:06.019494 | instance -> localhost | |o +   o... o     |
2026-07-29 13:53:06.019550 | instance -> localhost | | . .  .+ .+      |
2026-07-29 13:53:06.019602 | instance -> localhost | |     .. ...      |
2026-07-29 13:53:06.019649 | instance -> localhost | +----[SHA256]-----+
2026-07-29 13:53:06.019771 | instance -> localhost | ok: Runtime: 0:00:01.945972
2026-07-29 13:53:06.028703 | 
2026-07-29 13:53:06.028852 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-07-29 13:53:06.061076 | instance | ok
2026-07-29 13:53:06.072897 | instance | included: /var/lib/zuul/builds/7e78381fb3504205b4d4a7024d750ca9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-07-29 13:53:06.081383 | 
2026-07-29 13:53:06.081503 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-07-29 13:53:06.105455 | instance | skipping: Conditional result was False
2026-07-29 13:53:06.116680 | 
2026-07-29 13:53:06.116770 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-07-29 13:53:06.606350 | instance | changed
2026-07-29 13:53:06.615402 | 
2026-07-29 13:53:06.615534 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-07-29 13:53:06.802235 | instance | ok
2026-07-29 13:53:06.811977 | 
2026-07-29 13:53:06.812107 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-07-29 13:53:07.324264 | instance | changed
2026-07-29 13:53:07.332316 | 
2026-07-29 13:53:07.398669 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-07-29 13:53:07.923270 | instance | changed
2026-07-29 13:53:07.928229 | 
2026-07-29 13:53:07.928300 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-07-29 13:53:07.951645 | instance | skipping: Conditional result was False
2026-07-29 13:53:07.960200 | 
2026-07-29 13:53:07.960376 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-07-29 13:53:08.341367 | instance -> localhost | changed
2026-07-29 13:53:08.356315 | 
2026-07-29 13:53:08.356448 | TASK [add-build-sshkey : Add back temp key]
2026-07-29 13:53:08.689240 | instance -> localhost | Identity added: /var/lib/zuul/builds/7e78381fb3504205b4d4a7024d750ca9/work/7e78381fb3504205b4d4a7024d750ca9_id_rsa (zuul-build-sshkey)
2026-07-29 13:53:08.689525 | instance -> localhost | ok: Runtime: 0:00:00.014662
2026-07-29 13:53:08.699068 | 
2026-07-29 13:53:08.699225 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-07-29 13:53:09.038602 | instance | ok
2026-07-29 13:53:09.461851 | 
2026-07-29 13:53:09.462005 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-07-29 13:53:09.491688 | instance | skipping: Conditional result was False
2026-07-29 13:53:09.554991 | 
2026-07-29 13:53:09.555140 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-07-29 13:53:09.889350 | instance | ok
2026-07-29 13:53:09.898657 | 
2026-07-29 13:53:09.898776 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-07-29 13:53:13.588025 | instance | Output suppressed because no_log was given
2026-07-29 13:53:13.598125 | 
2026-07-29 13:53:13.598259 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-07-29 13:53:13.788039 | instance | ok: "logs"
2026-07-29 13:53:13.875137 | instance | ok: All items complete
2026-07-29 13:53:13.875555 | 
2026-07-29 13:53:13.945082 | instance | ok: "artifacts"
2026-07-29 13:53:14.132542 | instance | ok: "docs"
2026-07-29 13:53:14.145583 | 
2026-07-29 13:53:14.145779 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-07-29 13:53:14.352377 | instance | changed: "logs"
2026-07-29 13:53:14.503464 | instance | changed: "artifacts"
2026-07-29 13:53:14.655265 | instance | changed: "docs"
2026-07-29 13:53:14.667029 | 
2026-07-29 13:53:14.667118 | PLAY RECAP
2026-07-29 13:53:14.667185 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-07-29 13:53:14.667228 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-29 13:53:14.667263 | 
2026-07-29 13:53:14.840171 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-29 13:53:14.847384 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-29 13:53:15.503680 | 
2026-07-29 13:53:15.818967 | PLAY [all]
2026-07-29 13:53:15.838818 | 
2026-07-29 13:53:15.839073 | TASK [setup-uv : Extract archive]
2026-07-29 13:53:18.193121 | instance | changed
2026-07-29 13:53:18.202195 | 
2026-07-29 13:53:18.202307 | TASK [setup-uv : Print version]
2026-07-29 13:53:18.542877 | instance | uv 0.8.13
2026-07-29 13:53:18.763643 | instance | ok: Runtime: 0:00:00.013356
2026-07-29 13:53:18.773995 | 
2026-07-29 13:53:18.774114 | TASK [Install Ansible collection siblings]
2026-07-29 13:53:28.286461 | instance | changed:
2026-07-29 13:53:28.286642 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-07-29 13:53:28.286682 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-07-29 13:53:28.286713 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-07-29 13:53:28.286741 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-07-29 13:53:28.286768 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-07-29 13:53:28.286800 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-07-29 13:53:28.286829 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-07-29 13:53:28.286859 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-07-29 13:53:28.286886 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-07-29 13:53:28.286914 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-07-29 13:53:28.286941 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-07-29 13:53:28.286967 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-07-29 13:53:28.286993 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-07-29 13:53:28.287020 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-07-29 13:53:28.287045 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0
2026-07-29 13:53:28.287071 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-07-29 13:53:28.287096 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-07-29 13:53:28.287122 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-07-29 13:53:28.287147 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-07-29 13:53:28.287172 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-07-29 13:53:28.287197 | instance | Resolved vexxhost.ceph to v4.1.0 for >=3.2.0
2026-07-29 13:53:28.287222 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-07-29 13:53:28.287250 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-29 13:53:28.287291 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-07-29 13:53:28.287318 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0,>=6.0.0
2026-07-29 13:53:28.287342 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-29 13:53:28.287364 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-29 13:53:28.287387 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-29 13:53:28.287409 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-07-29 13:53:28.287432 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-07-29 13:53:28.287454 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-29 13:53:28.287479 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-29 13:53:28.287502 | instance | Checked out ansible.netcommon to 1.2.0
2026-07-29 13:53:28.287525 | 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:53:28.287555 | instance | Starting galaxy collection install process
2026-07-29 13:53:28.287578 | instance | Process install dependency map
2026-07-29 13:53:28.287602 | instance | Starting collection install process
2026-07-29 13:53:28.287625 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-07-29 13:53:28.287649 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-07-29 13:53:28.287674 | instance | ansible.netcommon:* was installed successfully
2026-07-29 13:53:28.287700 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-07-29 13:53:28.287726 | instance | Creating virtual environment at: .venv
2026-07-29 13:53:28.287751 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-29 13:53:28.287777 | instance | Downloading pygments (1.2MiB)
2026-07-29 13:53:28.287803 | instance | Downloading cryptography (4.2MiB)
2026-07-29 13:53:28.287833 | instance | Downloading kubernetes (1.9MiB)
2026-07-29 13:53:28.287859 | instance | Downloading setuptools (1.1MiB)
2026-07-29 13:53:28.287885 | instance | Downloading rjsonnet (1.2MiB)
2026-07-29 13:53:28.287911 | instance | Downloading ansible-core (2.1MiB)
2026-07-29 13:53:28.287937 | instance | Downloading netaddr (2.2MiB)
2026-07-29 13:53:28.287962 | instance | Downloading pydantic-core (2.0MiB)
2026-07-29 13:53:28.287987 | instance | Downloading openstacksdk (1.7MiB)
2026-07-29 13:53:28.288013 | instance |  Downloading rjsonnet
2026-07-29 13:53:28.288041 | instance |    Building pyperclip==1.9.0
2026-07-29 13:53:28.288068 | instance |  Downloading pydantic-core
2026-07-29 13:53:28.288094 | instance |  Downloading netaddr
2026-07-29 13:53:28.288120 | instance |  Downloading pygments
2026-07-29 13:53:28.288146 | instance |  Downloading cryptography
2026-07-29 13:53:28.288172 | instance |  Downloading setuptools
2026-07-29 13:53:28.288197 | instance |  Downloading kubernetes
2026-07-29 13:53:28.288223 | instance |  Downloading ansible-core
2026-07-29 13:53:28.288249 | instance |  Downloading openstacksdk
2026-07-29 13:53:28.288277 | instance |       Built pyperclip==1.9.0
2026-07-29 13:53:28.288303 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-29 13:53:28.288329 | instance | Installed 87 packages in 75ms
2026-07-29 13:53:28.288355 | instance | Checked out ansible.posix to 1.6.0
2026-07-29 13:53:28.288381 | 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:53:28.288407 | instance | Starting galaxy collection install process
2026-07-29 13:53:28.288433 | instance | Process install dependency map
2026-07-29 13:53:28.288468 | instance | Starting collection install process
2026-07-29 13:53:28.288519 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-07-29 13:53:28.288547 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-07-29 13:53:28.288573 | instance | ansible.posix:1.6.0 was installed successfully
2026-07-29 13:53:28.288599 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:53:28.288625 | instance | 2.17.12
2026-07-29 13:53:28.288651 | instance | Checked out ansible.utils to v6.0.3
2026-07-29 13:53:28.288677 | 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:53:28.288705 | instance | Starting galaxy collection install process
2026-07-29 13:53:28.288731 | instance | Process install dependency map
2026-07-29 13:53:28.288756 | instance | Starting collection install process
2026-07-29 13:53:28.288782 | instance | Installing 'ansible.utils:6.0.3' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-07-29 13:53:28.288809 | instance | Created collection for ansible.utils:6.0.3 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-07-29 13:53:28.288834 | instance | ansible.utils:6.0.3 was installed successfully
2026-07-29 13:53:28.288860 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:53:28.288888 | instance | 2.17.12
2026-07-29 13:53:28.288912 | instance | Checked out atmosphere.common to v0.7.0
2026-07-29 13:53:28.288933 | 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:53:28.288983 | instance | Starting galaxy collection install process
2026-07-29 13:53:28.289007 | instance | Process install dependency map
2026-07-29 13:53:28.289027 | instance | Starting collection install process
2026-07-29 13:53:28.289045 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-07-29 13:53:28.289063 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-07-29 13:53:28.289081 | instance | atmosphere.common:0.7.0 was installed successfully
2026-07-29 13:53:28.289099 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:53:28.289122 | instance | 2.17.12
2026-07-29 13:53:28.289144 | instance | Checked out community.crypto to 2.2.3
2026-07-29 13:53:28.289166 | 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:53:28.289185 | instance | Starting galaxy collection install process
2026-07-29 13:53:28.289202 | instance | Process install dependency map
2026-07-29 13:53:28.289220 | instance | Starting collection install process
2026-07-29 13:53:28.289238 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-07-29 13:53:28.289256 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-07-29 13:53:28.289273 | instance | community.crypto:2.2.3 was installed successfully
2026-07-29 13:53:28.289291 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:53:28.289308 | instance | 2.17.12
2026-07-29 13:53:28.289327 | instance | Checked out community.general to 7.3.0
2026-07-29 13:53:28.289346 | 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:53:28.289370 | instance | Starting galaxy collection install process
2026-07-29 13:53:28.289390 | instance | Process install dependency map
2026-07-29 13:53:28.289408 | instance | Starting collection install process
2026-07-29 13:53:28.289426 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-07-29 13:53:28.289444 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-07-29 13:53:28.289462 | instance | community.general:7.3.0 was installed successfully
2026-07-29 13:53:28.289481 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:53:28.289500 | instance | 2.17.12
2026-07-29 13:53:28.289519 | instance | Checked out community.mysql to 3.6.0
2026-07-29 13:53:28.289540 | 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:53:28.289559 | instance | Starting galaxy collection install process
2026-07-29 13:53:28.289577 | instance | Process install dependency map
2026-07-29 13:53:28.289595 | instance | Starting collection install process
2026-07-29 13:53:28.289613 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-07-29 13:53:28.289632 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-07-29 13:53:28.289650 | instance | community.mysql:3.6.0 was installed successfully
2026-07-29 13:53:28.289668 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:53:28.289686 | instance | 2.17.12
2026-07-29 13:53:28.289704 | instance | Checked out kubernetes.core to 2.4.0
2026-07-29 13:53:28.289723 | 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:53:28.289740 | instance | Starting galaxy collection install process
2026-07-29 13:53:28.289759 | instance | Process install dependency map
2026-07-29 13:53:28.289777 | instance | Starting collection install process
2026-07-29 13:53:28.289796 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-07-29 13:53:28.289815 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-07-29 13:53:28.289834 | instance | kubernetes.core:2.4.0 was installed successfully
2026-07-29 13:53:28.289852 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:53:28.289871 | instance | 2.17.12
2026-07-29 13:53:28.289890 | instance | Checked out openstack.cloud to 2.6.0
2026-07-29 13:53:28.289909 | 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:53:28.289927 | instance | Starting galaxy collection install process
2026-07-29 13:53:28.289945 | instance | Process install dependency map
2026-07-29 13:53:28.289963 | instance | Starting collection install process
2026-07-29 13:53:28.289981 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-07-29 13:53:28.289998 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-07-29 13:53:28.290015 | instance | openstack.cloud:2.6.0 was installed successfully
2026-07-29 13:53:28.290033 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:53:28.290051 | instance | 2.17.12
2026-07-29 13:53:28.290073 | instance | Checked out vexxhost.ceph to v4.1.0
2026-07-29 13:53:28.290093 | 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:53:28.290112 | instance | Starting galaxy collection install process
2026-07-29 13:53:28.290129 | instance | Process install dependency map
2026-07-29 13:53:28.290147 | instance | Starting collection install process
2026-07-29 13:53:28.290164 | instance | Installing 'vexxhost.ceph:4.1.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-07-29 13:53:28.290182 | instance | Created collection for vexxhost.ceph:4.1.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-07-29 13:53:28.290201 | instance | vexxhost.ceph:4.1.0 was installed successfully
2026-07-29 13:53:28.290220 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:53:28.290238 | instance | 2.17.12
2026-07-29 13:53:28.290257 | instance | Checked out vexxhost.containers to v1.6.8
2026-07-29 13:53:28.290275 | 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:53:28.290293 | instance | Starting galaxy collection install process
2026-07-29 13:53:28.290311 | instance | Process install dependency map
2026-07-29 13:53:28.290328 | instance | Starting collection install process
2026-07-29 13:53:28.290346 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-07-29 13:53:28.290363 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-07-29 13:53:28.290381 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-07-29 13:53:28.290399 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:53:28.290418 | instance | 2.17.12
2026-07-29 13:53:28.290438 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-07-29 13:53:28.290456 | 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:53:28.290475 | instance | Starting galaxy collection install process
2026-07-29 13:53:28.290492 | instance | Process install dependency map
2026-07-29 13:53:28.290511 | instance | Starting collection install process
2026-07-29 13:53:28.290529 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-07-29 13:53:28.290567 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-07-29 13:53:28.290587 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-07-29 13:53:28.290606 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-29 13:53:28.290625 | instance | 2.17.12
2026-07-29 13:53:28.296399 | 
2026-07-29 13:53:28.296448 | PLAY RECAP
2026-07-29 13:53:28.296531 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-29 13:53:28.296557 | 
2026-07-29 13:53:28.473240 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-29 13:53:28.476914 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-29 13:53:29.178441 | 
2026-07-29 13:53:29.178649 | PLAY [all]
2026-07-29 13:53:29.191851 | 
2026-07-29 13:53:29.191994 | TASK [Install "jq" for log collection]
2026-07-29 13:53:39.344300 | instance | changed
2026-07-29 13:53:39.416815 | 
2026-07-29 13:53:39.417060 | PLAY RECAP
2026-07-29 13:53:39.417163 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-29 13:53:39.417273 | 
2026-07-29 13:53:39.642599 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-29 13:53:39.646512 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-29 13:53:40.422803 | 
2026-07-29 13:53:40.423146 | PLAY [Prepare selective Molecule plan]
2026-07-29 13:53:40.434950 | 
2026-07-29 13:53:40.435050 | TASK [Generate selective Molecule plan]
2026-07-29 13:53:40.999493 | instance | ok: Runtime: 0:00:00.164886
2026-07-29 13:53:41.310831 | 
2026-07-29 13:53:41.311070 | TASK [Render selective Molecule plan]
2026-07-29 13:53:41.621268 | instance | Selective Molecule plan: selective
2026-07-29 13:53:41.621447 | instance | Changed files:
2026-07-29 13:53:41.621461 | instance |   M roles/glance/README.md
2026-07-29 13:53:41.621471 | instance | Targets: glance
2026-07-29 13:53:41.621480 | instance | Job decisions:
2026-07-29 13:53:41.621492 | instance |   RUN  aio-openvswitch: selected by changed components
2026-07-29 13:53:41.621505 | 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:53:41.621516 | instance |        Tempest include: ^tempest\.api\.image\.
2026-07-29 13:53:41.621526 | instance |   SKIP aio-ovn: no changed component requires this job
2026-07-29 13:53:41.621535 | instance |   SKIP csi-local-path-provisioner: no changed component requires this job
2026-07-29 13:53:41.621544 | instance |   SKIP csi-rbd: no changed component requires this job
2026-07-29 13:53:41.621553 | instance |   SKIP keycloak: no changed component requires this job
2026-07-29 13:53:42.078877 | instance | ok: Runtime: 0:00:00.100883
2026-07-29 13:53:42.081347 | 
2026-07-29 13:53:42.081432 | PLAY RECAP
2026-07-29 13:53:42.081500 | instance | ok: 2 changed: 0 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-29 13:53:42.081533 | 
2026-07-29 13:53:42.216184 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-29 13:53:42.219160 | RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-29 13:53:42.899283 | 
2026-07-29 13:53:43.082402 | PLAY [Run selected Molecule scenario]
2026-07-29 13:53:43.100487 | 
2026-07-29 13:53:43.100665 | TASK [Read selective Molecule plan]
2026-07-29 13:53:43.450322 | instance | ok
2026-07-29 13:53:43.458372 | 
2026-07-29 13:53:43.458497 | TASK [Resolve this job decision]
2026-07-29 13:53:43.515167 | instance | ok
2026-07-29 13:53:43.523254 | 
2026-07-29 13:53:43.523419 | TASK [Assert this job exists in the plan]
2026-07-29 13:53:43.555788 | instance | ok: All assertions passed
2026-07-29 13:53:43.563262 | 
2026-07-29 13:53:43.563391 | TASK [Resolve selected scenario inputs]
2026-07-29 13:53:43.596011 | instance | ok
2026-07-29 13:53:43.603138 | 
2026-07-29 13:53:43.603259 | TASK [Report this job decision]
2026-07-29 13:53:43.658024 | instance | ok:
2026-07-29 13:53:43.658274 | instance | Selective Molecule job: keycloak
2026-07-29 13:53:43.658345 | instance | Decision: SKIP
2026-07-29 13:53:43.658394 | instance | Reason: no changed component requires this job
2026-07-29 13:53:43.658442 | instance | Scenario: keycloak
2026-07-29 13:53:43.658483 | instance | Targets: (none)
2026-07-29 13:53:43.658523 | instance | Components: (full scenario)
2026-07-29 13:53:43.667384 | 
2026-07-29 13:53:43.667533 | LOOP [Check Molecule inventory directories]
2026-07-29 13:53:43.713578 | instance | skipping: Conditional result was False
2026-07-29 13:53:43.714916 | instance | skipping: Conditional result was False
2026-07-29 13:53:43.717607 | instance | skipping: Conditional result was False
2026-07-29 13:53:43.734178 | 
2026-07-29 13:53:43.734378 | LOOP [Copy Zuul inventory for Molecule]
2026-07-29 13:53:43.774201 | instance | skipping: Conditional result was False
2026-07-29 13:53:43.774563 | 
2026-07-29 13:53:43.776500 | instance | skipping: Conditional result was False
2026-07-29 13:53:43.781037 | instance | skipping: Conditional result was False
2026-07-29 13:53:43.800004 | 
2026-07-29 13:53:43.800242 | LOOP [Use private addresses in Molecule inventory]
2026-07-29 13:53:43.851460 | instance | skipping: Conditional result was False
2026-07-29 13:53:43.851875 | 
2026-07-29 13:53:43.854983 | instance | skipping: Conditional result was False
2026-07-29 13:53:43.857962 | instance | skipping: Conditional result was False
2026-07-29 13:53:43.877809 | 
2026-07-29 13:53:43.877967 | TASK [Prepare Molecule command]
2026-07-29 13:53:43.924467 | instance | skipping: Conditional result was False
2026-07-29 13:53:43.935341 | 
2026-07-29 13:53:43.935474 | TASK [Run standard Molecule lifecycle with progress output]
2026-07-29 13:53:43.982479 | instance | skipping: Conditional result was False
2026-07-29 13:53:43.984645 | 
2026-07-29 13:53:43.984733 | PLAY RECAP
2026-07-29 13:53:43.984820 | instance | ok: 5 changed: 0 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-07-29 13:53:43.984864 | 
2026-07-29 13:53:44.119535 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-29 13:53:44.128043 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-07-29 13:53:44.792590 | 
2026-07-29 13:53:44.826388 | PLAY [Publish selective Molecule plan]
2026-07-29 13:53:44.847613 | 
2026-07-29 13:53:44.847808 | TASK [Check for selective Molecule plan]
2026-07-29 13:53:45.215460 | instance | ok
2026-07-29 13:53:45.222591 | 
2026-07-29 13:53:45.222726 | TASK [Create log directory]
2026-07-29 13:53:45.626255 | instance | changed
2026-07-29 13:53:45.636434 | 
2026-07-29 13:53:45.636628 | TASK [Copy selective Molecule plan to logs]
2026-07-29 13:53:46.046372 | instance | changed
2026-07-29 13:53:46.048620 | 
2026-07-29 13:53:46.048704 | PLAY RECAP
2026-07-29 13:53:46.048787 | instance | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-29 13:53:46.048834 | 
2026-07-29 13:53:46.179192 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-07-29 13:53:46.182855 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-29 13:53:46.974520 | 
2026-07-29 13:53:46.974810 | PLAY [all]
2026-07-29 13:53:46.993325 | 
2026-07-29 13:53:46.993565 | TASK [gather-host-logs : creating directory for system status]
2026-07-29 13:53:47.366712 | instance | changed
2026-07-29 13:53:47.376926 | 
2026-07-29 13:53:47.377122 | TASK [gather-host-logs : Get logs for each host]
2026-07-29 13:53:47.780530 | instance | + systemd-cgls --full --all --no-pager
2026-07-29 13:53:47.791060 | instance | + ip addr
2026-07-29 13:53:47.793760 | instance | + ip route
2026-07-29 13:53:47.795896 | instance | + lsblk
2026-07-29 13:53:47.799948 | instance | + mount
2026-07-29 13:53:47.802611 | instance | + docker images
2026-07-29 13:53:47.802990 | instance | /bin/bash: line 7: docker: command not found
2026-07-29 13:53:47.803220 | instance | + brctl show
2026-07-29 13:53:47.803607 | instance | /bin/bash: line 8: brctl: command not found
2026-07-29 13:53:47.803805 | instance | + ps aux --sort=-%mem
2026-07-29 13:53:47.817609 | instance | + dpkg -l
2026-07-29 13:53:47.823206 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-07-29 13:53:47.823453 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-07-29 13:53:47.823498 | instance | /bin/bash: line 11: docker: command not found
2026-07-29 13:53:47.823715 | instance | + '[' '!' -z '' ']'
2026-07-29 13:53:47.930488 | instance | ok: Runtime: 0:00:00.048365
2026-07-29 13:53:47.937340 | 
2026-07-29 13:53:47.937442 | TASK [gather-host-logs : Downloads logs to executor]
2026-07-29 13:53:48.643425 | instance | changed:
2026-07-29 13:53:48.643838 | instance | created directory /var/lib/zuul/builds/7e78381fb3504205b4d4a7024d750ca9/work/logs/instance
2026-07-29 13:53:48.643885 | instance | cd+++++++++ system/
2026-07-29 13:53:48.643925 | instance | >f+++++++++ system/brctl-show.txt
2026-07-29 13:53:48.643999 | instance | >f+++++++++ system/docker-images.txt
2026-07-29 13:53:48.644036 | instance | >f+++++++++ system/ip-addr.txt
2026-07-29 13:53:48.644073 | instance | >f+++++++++ system/ip-route.txt
2026-07-29 13:53:48.644104 | instance | >f+++++++++ system/lsblk.txt
2026-07-29 13:53:48.644133 | instance | >f+++++++++ system/mount.txt
2026-07-29 13:53:48.644164 | instance | >f+++++++++ system/packages.txt
2026-07-29 13:53:48.644192 | instance | >f+++++++++ system/ps.txt
2026-07-29 13:53:48.644220 | instance | >f+++++++++ system/systemd-cgls.txt
2026-07-29 13:53:48.657924 | 
2026-07-29 13:53:48.658055 | LOOP [helm-release-status : creating directory for helm release status]
2026-07-29 13:53:48.851194 | instance | changed: "values"
2026-07-29 13:53:49.040278 | instance | changed: "releases"
2026-07-29 13:53:49.312348 | 
2026-07-29 13:53:49.312500 | TASK [helm-release-status : Gather get release status for helm charts]
2026-07-29 13:53:49.525098 | instance | /bin/bash: line 3: kubectl: command not found
2026-07-29 13:53:49.857821 | instance | ok: Runtime: 0:00:00.006209
2026-07-29 13:53:49.867030 | 
2026-07-29 13:53:49.867382 | TASK [helm-release-status : Downloads logs to executor]
2026-07-29 13:53:50.374124 | instance | changed:
2026-07-29 13:53:50.374282 | instance | cd+++++++++ helm/
2026-07-29 13:53:50.374311 | instance | cd+++++++++ helm/releases/
2026-07-29 13:53:50.374335 | instance | cd+++++++++ helm/values/
2026-07-29 13:53:50.384773 | 
2026-07-29 13:53:50.384888 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-07-29 13:53:50.579069 | instance | changed
2026-07-29 13:53:50.587158 | 
2026-07-29 13:53:50.587301 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-07-29 13:53:50.837912 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-29 13:53:50.838172 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-29 13:53:50.842850 | instance | environment: line 1: kubectl: command not found
2026-07-29 13:53:50.843778 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-29 13:53:50.844229 | instance | environment: line 1: kubectl: command not found
2026-07-29 13:53:50.845669 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-29 13:53:50.847326 | instance | environment: line 1: kubectl: command not found
2026-07-29 13:53:50.848203 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-29 13:53:50.849033 | instance | environment: line 1: kubectl: command not found
2026-07-29 13:53:50.850120 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-29 13:53:50.851107 | instance | environment: line 1: kubectl: command not found
2026-07-29 13:53:50.851959 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-29 13:53:51.162989 | instance | ok: Runtime: 0:00:00.023288
2026-07-29 13:53:51.170414 | 
2026-07-29 13:53:51.170548 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-07-29 13:53:51.370709 | instance | changed
2026-07-29 13:53:51.383732 | 
2026-07-29 13:53:51.383894 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-07-29 13:53:51.599084 | instance | environment: line 5: kubectl: command not found
2026-07-29 13:53:51.599999 | instance | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-29 13:53:51.600031 | instance |
2026-07-29 13:53:51.600417 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-29 13:53:51.926937 | instance | ok: Runtime: 0:00:00.010329
2026-07-29 13:53:51.935711 | 
2026-07-29 13:53:51.935902 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-07-29 13:53:52.432762 | instance | changed:
2026-07-29 13:53:52.432932 | instance | cd+++++++++ objects/
2026-07-29 13:53:52.433011 | instance | cd+++++++++ objects/cluster/
2026-07-29 13:53:52.433056 | instance | cd+++++++++ objects/namespaced/
2026-07-29 13:53:52.444135 | 
2026-07-29 13:53:52.444282 | TASK [gather-pod-logs : creating directory for pod logs]
2026-07-29 13:53:52.649148 | instance | changed
2026-07-29 13:53:52.654840 | 
2026-07-29 13:53:52.654951 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-07-29 13:53:52.840491 | instance | changed
2026-07-29 13:53:52.848277 | 
2026-07-29 13:53:52.848413 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-07-29 13:53:53.070619 | instance | environment: line 3: kubectl: command not found
2026-07-29 13:53:53.394935 | instance | ok: Runtime: 0:00:00.009943
2026-07-29 13:53:53.404493 | 
2026-07-29 13:53:53.404675 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-07-29 13:53:53.970197 | instance | changed:
2026-07-29 13:53:53.970359 | instance | cd+++++++++ pod-logs/
2026-07-29 13:53:53.970391 | instance | cd+++++++++ pod-logs/failed-pods/
2026-07-29 13:53:53.982387 | 
2026-07-29 13:53:53.982477 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-07-29 13:53:54.190576 | instance | changed
2026-07-29 13:53:54.195836 | 
2026-07-29 13:53:54.195919 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-07-29 13:53:54.425756 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-29 13:53:54.739010 | instance | ok: Runtime: 0:00:00.038363
2026-07-29 13:53:54.746475 | 
2026-07-29 13:53:54.746641 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-07-29 13:53:54.975316 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-29 13:53:55.005193 | instance | ceph-mgr endpoints:
2026-07-29 13:53:55.281233 | instance | ok: Runtime: 0:00:00.037487
2026-07-29 13:53:55.288357 | 
2026-07-29 13:53:55.288494 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-07-29 13:53:55.508474 | instance | /bin/bash: line 4: kubectl: command not found
2026-07-29 13:53:55.832248 | instance | ok: Runtime: 0:00:00.036145
2026-07-29 13:53:55.839696 | 
2026-07-29 13:53:55.839812 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-07-29 13:53:56.339851 | instance | changed: cd+++++++++ prometheus/
2026-07-29 13:53:56.349648 | 
2026-07-29 13:53:56.349771 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-07-29 13:53:56.555664 | instance | changed
2026-07-29 13:53:56.563919 | 
2026-07-29 13:53:56.564066 | TASK [gather-selenium-data : Get selenium data]
2026-07-29 13:53:56.799319 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-07-29 13:53:56.800318 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-07-29 13:53:57.138371 | instance | ERROR
2026-07-29 13:53:57.138589 | instance | {
2026-07-29 13:53:57.138639 | instance |   "delta": "0:00:00.006331",
2026-07-29 13:53:57.138671 | instance |   "end": "2026-07-29 13:53:56.800663",
2026-07-29 13:53:57.138698 | instance |   "msg": "non-zero return code",
2026-07-29 13:53:57.138724 | instance |   "rc": 1,
2026-07-29 13:53:57.138749 | instance |   "start": "2026-07-29 13:53:56.794332"
2026-07-29 13:53:57.138802 | instance | }
2026-07-29 13:53:57.138867 | instance | ERROR: Ignoring Errors
2026-07-29 13:53:57.146989 | 
2026-07-29 13:53:57.147123 | TASK [gather-selenium-data : Downloads logs to executor]
2026-07-29 13:53:57.675637 | instance | changed: cd+++++++++ selenium/
2026-07-29 13:53:57.683233 | 
2026-07-29 13:53:57.683301 | PLAY RECAP
2026-07-29 13:53:57.683346 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-07-29 13:53:57.683368 | 
2026-07-29 13:53:57.825346 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-29 13:53:57.832147 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-29 13:53:58.516252 | 
2026-07-29 13:53:58.516403 | PLAY [all]
2026-07-29 13:53:58.528227 | 
2026-07-29 13:53:58.528369 | TASK [fetch-output : Set log path for multiple nodes]
2026-07-29 13:53:58.583596 | instance | skipping: Conditional result was False
2026-07-29 13:53:58.592545 | 
2026-07-29 13:53:58.592728 | TASK [fetch-output : Set log path for single node]
2026-07-29 13:53:58.638650 | instance | ok
2026-07-29 13:53:58.643324 | 
2026-07-29 13:53:58.643401 | LOOP [fetch-output : Ensure local output dirs]
2026-07-29 13:53:59.081307 | instance -> localhost | ok: "/var/lib/zuul/builds/7e78381fb3504205b4d4a7024d750ca9/work/logs"
2026-07-29 13:53:59.333823 | instance -> localhost | changed: "/var/lib/zuul/builds/7e78381fb3504205b4d4a7024d750ca9/work/artifacts"
2026-07-29 13:53:59.578886 | instance -> localhost | changed: "/var/lib/zuul/builds/7e78381fb3504205b4d4a7024d750ca9/work/docs"
2026-07-29 13:53:59.593555 | 
2026-07-29 13:53:59.593733 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-07-29 13:54:00.261447 | instance | changed: .d..t...... ./
2026-07-29 13:54:00.261655 | instance | changed: All items complete
2026-07-29 13:54:00.261683 | 
2026-07-29 13:54:00.733421 | instance | changed: .d..t...... ./
2026-07-29 13:54:01.256888 | instance | changed: .d..t...... ./
2026-07-29 13:54:01.281134 | 
2026-07-29 13:54:01.281364 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-07-29 13:54:01.837657 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007518
2026-07-29 13:54:02.106089 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006184
2026-07-29 13:54:02.117576 | 
2026-07-29 13:54:02.117673 | PLAY [all]
2026-07-29 13:54:02.125122 | 
2026-07-29 13:54:02.125205 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-07-29 13:54:02.552272 | instance | changed
2026-07-29 13:54:02.562546 | 
2026-07-29 13:54:02.562697 | PLAY RECAP
2026-07-29 13:54:02.562796 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-29 13:54:02.562867 | 
2026-07-29 13:54:02.710326 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-29 13:54:02.713449 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-07-29 13:54:03.473722 | 
2026-07-29 13:54:03.473910 | PLAY [localhost]
2026-07-29 13:54:03.491135 | 
2026-07-29 13:54:03.491331 | TASK [Generate Zuul manifest]
2026-07-29 13:54:03.513085 | localhost | ok
2026-07-29 13:54:03.532004 | 
2026-07-29 13:54:03.532148 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-07-29 13:54:03.937679 | localhost | changed
2026-07-29 13:54:03.950528 | 
2026-07-29 13:54:03.950725 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-07-29 13:54:03.994528 | localhost | ok
2026-07-29 13:54:04.006670 | 
2026-07-29 13:54:04.006845 | TASK [Upload logs]
2026-07-29 13:54:04.030909 | localhost | ok
2026-07-29 13:54:04.115059 | 
2026-07-29 13:54:04.115306 | TASK [Set zuul-log-path fact]
2026-07-29 13:54:04.139689 | localhost | ok
2026-07-29 13:54:04.155360 | 
2026-07-29 13:54:04.155580 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-29 13:54:04.200354 | localhost | ok
2026-07-29 13:54:04.211663 | 
2026-07-29 13:54:04.211762 | TASK [upload-logs : Create log directories]
2026-07-29 13:54:04.677662 | localhost | changed
2026-07-29 13:54:04.682670 | 
2026-07-29 13:54:04.682751 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-07-29 13:54:05.091663 | localhost -> localhost | ok: Runtime: 0:00:00.005378
2026-07-29 13:54:05.099263 | 
2026-07-29 13:54:05.099338 | TASK [upload-logs : Upload logs to log server]
2026-07-29 13:54:05.597455 | localhost | Output suppressed because no_log was given
2026-07-29 13:54:05.602531 | 
2026-07-29 13:54:05.602611 | LOOP [upload-logs : Compress console log and json output]
2026-07-29 13:54:05.657982 | localhost | skipping: Conditional result was False
2026-07-29 13:54:05.667876 | localhost | skipping: Conditional result was False
2026-07-29 13:54:05.676627 | 
2026-07-29 13:54:05.676854 | LOOP [upload-logs : Upload compressed console log and json output]
2026-07-29 13:54:05.724223 | localhost | skipping: Conditional result was False
2026-07-29 13:54:05.724802 | 
2026-07-29 13:54:05.728734 | localhost | skipping: Conditional result was False
2026-07-29 13:54:05.743908 | 
2026-07-29 13:54:05.744160 | LOOP [upload-logs : Upload console log and json output]