2026-05-20 19:41:44.698829 | Job console starting
2026-05-20 19:41:44.710488 | Updating git repos
2026-05-20 19:41:46.541996 | Cloning repos into workspace
2026-05-20 19:42:00.791908 | Restoring repo states
2026-05-20 19:42:12.536538 | Merging changes
2026-05-20 19:42:12.802138 | Checking out repos
2026-05-20 19:42:14.603792 | Preparing playbooks
2026-05-20 19:42:15.528499 | Running Ansible setup
2026-05-20 19:42:19.128106 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-20 19:42:19.755186 | 
2026-05-20 19:42:19.755361 | PLAY [localhost]
2026-05-20 19:42:19.763991 | 
2026-05-20 19:42:19.764064 | TASK [Gathering Facts]
2026-05-20 19:42:21.622977 | localhost | ok
2026-05-20 19:42:21.634438 | 
2026-05-20 19:42:21.634574 | TASK [Setup log path fact]
2026-05-20 19:42:21.654697 | localhost | ok
2026-05-20 19:42:21.670852 | 
2026-05-20 19:42:21.670923 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-20 19:42:21.713615 | localhost | ok
2026-05-20 19:42:21.721225 | 
2026-05-20 19:42:21.721316 | TASK [emit-job-header : Print job information]
2026-05-20 19:42:21.761211 | # Job Information
2026-05-20 19:42:21.761360 | Ansible Version: 2.16.18
2026-05-20 19:42:21.761404 | Job: atmosphere-common-molecule-glance-image
2026-05-20 19:42:21.761434 | Pipeline: check
2026-05-20 19:42:21.761462 | Executor: 2d72f0692154
2026-05-20 19:42:21.761488 | Triggered by: https://github.com/vexxhost/atmosphere.common/pull/111
2026-05-20 19:42:21.761518 | Event ID: c8789270-5483-11f1-8c70-b180132ccc30
2026-05-20 19:42:21.765215 | 
2026-05-20 19:42:21.765304 | LOOP [emit-job-header : Print node information]
2026-05-20 19:42:21.865066 | localhost | ok:
2026-05-20 19:42:21.865294 | localhost | # Node Information
2026-05-20 19:42:21.865334 | localhost | Inventory Hostname: controller
2026-05-20 19:42:21.865366 | localhost | Hostname: np0000175452
2026-05-20 19:42:21.865395 | localhost | Username: zuul
2026-05-20 19:42:21.865431 | localhost | Distro: Ubuntu 24.04
2026-05-20 19:42:21.865460 | localhost | Provider: yul1
2026-05-20 19:42:21.865487 | localhost | Region: ca-ymq-1
2026-05-20 19:42:21.865514 | localhost | Label: ubuntu-noble
2026-05-20 19:42:21.865541 | localhost | Product Name: OpenStack Nova
2026-05-20 19:42:21.865568 | localhost | Interface IP: 199.204.45.49
2026-05-20 19:42:21.887907 | 
2026-05-20 19:42:21.888604 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-05-20 19:42:22.268933 | localhost -> localhost | changed
2026-05-20 19:42:22.279067 | 
2026-05-20 19:42:22.279232 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-05-20 19:42:23.096740 | localhost -> localhost | changed
2026-05-20 19:42:23.107758 | 
2026-05-20 19:42:23.107820 | PLAY [all]
2026-05-20 19:42:23.116776 | 
2026-05-20 19:42:23.116851 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-05-20 19:42:23.335236 | controller -> localhost | ok
2026-05-20 19:42:23.346839 | 
2026-05-20 19:42:23.346946 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-05-20 19:42:23.385518 | controller | ok
2026-05-20 19:42:23.404699 | controller | included: /var/lib/zuul/builds/b219deae56f147539b992af188638d2e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-05-20 19:42:23.413573 | 
2026-05-20 19:42:23.413764 | TASK [add-build-sshkey : Create Temp SSH key]
2026-05-20 19:42:24.522578 | controller -> localhost | Generating public/private rsa key pair.
2026-05-20 19:42:24.522814 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/b219deae56f147539b992af188638d2e/work/b219deae56f147539b992af188638d2e_id_rsa
2026-05-20 19:42:24.522843 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/b219deae56f147539b992af188638d2e/work/b219deae56f147539b992af188638d2e_id_rsa.pub
2026-05-20 19:42:24.522864 | controller -> localhost | The key fingerprint is:
2026-05-20 19:42:24.522886 | controller -> localhost | SHA256:kQkvqfynj6ELg5Hw5+0wBVcS+LGE9Pzig8HSozgimGQ zuul-build-sshkey
2026-05-20 19:42:24.522929 | controller -> localhost | The key's randomart image is:
2026-05-20 19:42:24.522951 | controller -> localhost | +---[RSA 3072]----+
2026-05-20 19:42:24.522977 | controller -> localhost | |   ..o+..        |
2026-05-20 19:42:24.522998 | controller -> localhost | |    ooo* o       |
2026-05-20 19:42:24.523017 | controller -> localhost | |.   .o*o=        |
2026-05-20 19:42:24.523037 | controller -> localhost | |.o + +oo .       |
2026-05-20 19:42:24.523056 | controller -> localhost | |oEo O o S        |
2026-05-20 19:42:24.523076 | controller -> localhost | |+= = O .         |
2026-05-20 19:42:24.523095 | controller -> localhost | |O + = * .        |
2026-05-20 19:42:24.523114 | controller -> localhost | |o. o = *         |
2026-05-20 19:42:24.523136 | controller -> localhost | |    o.+..        |
2026-05-20 19:42:24.523155 | controller -> localhost | +----[SHA256]-----+
2026-05-20 19:42:24.523212 | controller -> localhost | ok: Runtime: 0:00:00.724338
2026-05-20 19:42:24.529016 | 
2026-05-20 19:42:24.529088 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-05-20 19:42:24.556424 | controller | ok
2026-05-20 19:42:24.566821 | controller | included: /var/lib/zuul/builds/b219deae56f147539b992af188638d2e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-05-20 19:42:24.574724 | 
2026-05-20 19:42:24.574783 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-05-20 19:42:24.600386 | controller | skipping: Conditional result was False
2026-05-20 19:42:24.613730 | 
2026-05-20 19:42:24.613822 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-05-20 19:42:25.128571 | controller | changed
2026-05-20 19:42:25.135429 | 
2026-05-20 19:42:25.135494 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-05-20 19:42:25.352217 | controller | ok
2026-05-20 19:42:25.360098 | 
2026-05-20 19:42:25.360162 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-05-20 19:42:25.897314 | controller | changed
2026-05-20 19:42:25.902984 | 
2026-05-20 19:42:25.903050 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-05-20 19:42:26.457217 | controller | changed
2026-05-20 19:42:26.464612 | 
2026-05-20 19:42:26.464695 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-05-20 19:42:26.492336 | controller | skipping: Conditional result was False
2026-05-20 19:42:26.503409 | 
2026-05-20 19:42:26.503502 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-05-20 19:42:26.851265 | controller -> localhost | changed
2026-05-20 19:42:26.865975 | 
2026-05-20 19:42:26.866057 | TASK [add-build-sshkey : Add back temp key]
2026-05-20 19:42:27.195682 | controller -> localhost | Identity added: /var/lib/zuul/builds/b219deae56f147539b992af188638d2e/work/b219deae56f147539b992af188638d2e_id_rsa (zuul-build-sshkey)
2026-05-20 19:42:27.195877 | controller -> localhost | ok: Runtime: 0:00:00.013344
2026-05-20 19:42:27.239559 | 
2026-05-20 19:42:27.239705 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-05-20 19:42:27.538656 | controller | ok
2026-05-20 19:42:27.543653 | 
2026-05-20 19:42:27.543714 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-05-20 19:42:27.566840 | controller | skipping: Conditional result was False
2026-05-20 19:42:27.582979 | 
2026-05-20 19:42:27.583115 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-05-20 19:42:27.922832 | controller | ok
2026-05-20 19:42:27.929620 | 
2026-05-20 19:42:27.929728 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-05-20 19:42:32.368838 | controller | Output suppressed because no_log was given
2026-05-20 19:42:32.380631 | 
2026-05-20 19:42:32.380697 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-05-20 19:42:32.597007 | controller | ok: "logs"
2026-05-20 19:42:32.597250 | controller | ok: All items complete
2026-05-20 19:42:32.597278 | 
2026-05-20 19:42:32.785267 | controller | ok: "artifacts"
2026-05-20 19:42:32.979012 | controller | ok: "docs"
2026-05-20 19:42:32.999164 | 
2026-05-20 19:42:32.999312 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-05-20 19:42:33.218065 | controller | changed: "logs"
2026-05-20 19:42:33.405721 | controller | changed: "artifacts"
2026-05-20 19:42:33.593062 | controller | changed: "docs"
2026-05-20 19:42:33.605720 | 
2026-05-20 19:42:33.605830 | PLAY RECAP
2026-05-20 19:42:33.605878 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-05-20 19:42:33.605907 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-20 19:42:33.605929 | 
2026-05-20 19:42:33.724902 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-20 19:42:33.730371 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-05-20 19:42:34.326368 | 
2026-05-20 19:42:34.326517 | PLAY [all]
2026-05-20 19:42:34.338341 | 
2026-05-20 19:42:34.338427 | TASK [setup-uv : Extract archive]
2026-05-20 19:42:36.914286 | controller | changed
2026-05-20 19:42:36.921298 | 
2026-05-20 19:42:36.921381 | TASK [setup-uv : Print version]
2026-05-20 19:42:37.315507 | controller | uv 0.8.13
2026-05-20 19:42:37.465633 | controller | ok: Runtime: 0:00:00.014684
2026-05-20 19:42:37.477213 | 
2026-05-20 19:42:37.477290 | TASK [Install Ansible collection siblings]
2026-05-20 19:42:43.856765 | controller | changed:
2026-05-20 19:42:43.856989 | controller | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-05-20 19:42:43.857034 | controller | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-05-20 19:42:43.857065 | controller | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-05-20 19:42:43.857093 | controller | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-05-20 19:42:43.857121 | controller | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-05-20 19:42:43.857153 | controller | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-05-20 19:42:43.857182 | controller | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-05-20 19:42:43.857212 | controller | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-05-20 19:42:43.857240 | controller | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-05-20 19:42:43.857267 | controller | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-05-20 19:42:43.857294 | controller | Sibling collection vexxhost.atmosphere at /home/zuul/src/github.com/vexxhost/atmosphere
2026-05-20 19:42:43.857320 | controller | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-05-20 19:42:43.857345 | controller | Resolved kubernetes.core to 6.4.0 for >=2.4.0
2026-05-20 19:42:43.857371 | controller | Resolved openstack.cloud to 2.5.0 for >=2.0.0
2026-05-20 19:42:43.857397 | controller | Resolved vexxhost.kubernetes to v3.1.0 for >=2.5.0
2026-05-20 19:42:43.857424 | controller | Resolved ansible.posix to 2.2.0 for >=1.6.0
2026-05-20 19:42:43.857450 | controller | Resolved community.crypto to 3.2.1 for >=2.2.3
2026-05-20 19:42:43.857476 | controller | Resolved community.general to 13.0.0 for >=4.5.0
2026-05-20 19:42:43.857503 | controller | Resolved kubernetes.core to 6.4.0 for >=2.4.0,>=2.3.2
2026-05-20 19:42:43.857529 | controller | Resolved vexxhost.containers to v1.6.6 for >=1.6.0
2026-05-20 19:42:43.857558 | controller | Checked out ansible.posix to 2.2.0
2026-05-20 19:42:43.857599 | controller | 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-05-20 19:42:43.857636 | controller | Starting galaxy collection install process
2026-05-20 19:42:43.857663 | controller | Process install dependency map
2026-05-20 19:42:43.857690 | controller | Starting collection install process
2026-05-20 19:42:43.857716 | controller | Installing 'ansible.posix:2.2.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-05-20 19:42:43.857743 | controller | Created collection for ansible.posix:2.2.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-05-20 19:42:43.857769 | controller | ansible.posix:2.2.0 was installed successfully
2026-05-20 19:42:43.857795 | controller | Using CPython 3.12.3 interpreter at: /usr/bin/python3
2026-05-20 19:42:43.857821 | controller | Creating virtual environment at: .venv
2026-05-20 19:42:43.857846 | controller | warning: No `requires-python` value found in the workspace. Defaulting to `>=3.12`.
2026-05-20 19:42:43.857872 | controller | Downloading kubernetes (1.9MiB)
2026-05-20 19:42:43.857899 | controller | Downloading cryptography (4.3MiB)
2026-05-20 19:42:43.857924 | controller | Downloading pygments (1.2MiB)
2026-05-20 19:42:43.857949 | controller | Downloading pydantic-core (2.0MiB)
2026-05-20 19:42:43.857986 | controller | Downloading ansible-core (2.1MiB)
2026-05-20 19:42:43.858014 | controller |  Downloading pydantic-core
2026-05-20 19:42:43.858040 | controller |  Downloading cryptography
2026-05-20 19:42:43.858065 | controller |  Downloading pygments
2026-05-20 19:42:43.858091 | controller |  Downloading kubernetes
2026-05-20 19:42:43.858117 | controller |  Downloading ansible-core
2026-05-20 19:42:43.858142 | controller | Installed 52 packages in 47ms
2026-05-20 19:42:43.858168 | controller | Checked out community.crypto to 3.2.1
2026-05-20 19:42:43.858194 | controller | 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-05-20 19:42:43.858220 | controller | Starting galaxy collection install process
2026-05-20 19:42:43.858254 | controller | Process install dependency map
2026-05-20 19:42:43.858281 | controller | Starting collection install process
2026-05-20 19:42:43.858308 | controller | Installing 'community.crypto:3.2.1' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-05-20 19:42:43.858334 | controller | Created collection for community.crypto:3.2.1 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-05-20 19:42:43.858360 | controller | community.crypto:3.2.1 was installed successfully
2026-05-20 19:42:43.858386 | controller | warning: No `requires-python` value found in the workspace. Defaulting to `>=3.12`.
2026-05-20 19:42:43.858413 | controller | Checked out community.general to 13.0.0
2026-05-20 19:42:43.858439 | controller | 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-05-20 19:42:43.858466 | controller | Starting galaxy collection install process
2026-05-20 19:42:43.858492 | controller | Process install dependency map
2026-05-20 19:42:43.858518 | controller | Starting collection install process
2026-05-20 19:42:43.858544 | controller | Installing 'community.general:13.0.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-05-20 19:42:43.858569 | controller | Created collection for community.general:13.0.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-05-20 19:42:43.858595 | controller | community.general:13.0.0 was installed successfully
2026-05-20 19:42:43.858621 | controller | warning: No `requires-python` value found in the workspace. Defaulting to `>=3.12`.
2026-05-20 19:42:43.858647 | controller | Checked out kubernetes.core to 6.4.0
2026-05-20 19:42:43.858841 | controller | 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-05-20 19:42:43.858873 | controller | Starting galaxy collection install process
2026-05-20 19:42:43.858900 | controller | Process install dependency map
2026-05-20 19:42:43.858926 | controller | Starting collection install process
2026-05-20 19:42:43.858952 | controller | Installing 'kubernetes.core:6.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-05-20 19:42:43.858977 | controller | Created collection for kubernetes.core:6.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-05-20 19:42:43.859003 | controller | kubernetes.core:6.4.0 was installed successfully
2026-05-20 19:42:43.859028 | controller | warning: No `requires-python` value found in the workspace. Defaulting to `>=3.12`.
2026-05-20 19:42:43.859054 | controller | Checked out openstack.cloud to 2.5.0
2026-05-20 19:42:43.859080 | controller | 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-05-20 19:42:43.859105 | controller | Starting galaxy collection install process
2026-05-20 19:42:43.859130 | controller | Process install dependency map
2026-05-20 19:42:43.859156 | controller | Starting collection install process
2026-05-20 19:42:43.859181 | controller | Installing 'openstack.cloud:2.5.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-05-20 19:42:43.859206 | controller | Created collection for openstack.cloud:2.5.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-05-20 19:42:43.859230 | controller | openstack.cloud:2.5.0 was installed successfully
2026-05-20 19:42:43.859255 | controller | warning: No `requires-python` value found in the workspace. Defaulting to `>=3.12`.
2026-05-20 19:42:43.859280 | controller | Checked out vexxhost.containers to v1.6.6
2026-05-20 19:42:43.859305 | controller | 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-05-20 19:42:43.859330 | controller | Starting galaxy collection install process
2026-05-20 19:42:43.859356 | controller | Process install dependency map
2026-05-20 19:42:43.859382 | controller | Starting collection install process
2026-05-20 19:42:43.859409 | controller | Installing 'vexxhost.containers:1.6.6' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-05-20 19:42:43.859435 | controller | Created collection for vexxhost.containers:1.6.6 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-05-20 19:42:43.859461 | controller | vexxhost.containers:1.6.6 was installed successfully
2026-05-20 19:42:43.859487 | controller | warning: No `requires-python` value found in the workspace. Defaulting to `>=3.12`.
2026-05-20 19:42:43.859513 | controller | Checked out vexxhost.kubernetes to v3.1.0
2026-05-20 19:42:43.859539 | controller | 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-05-20 19:42:43.859568 | controller | Starting galaxy collection install process
2026-05-20 19:42:43.859596 | controller | Process install dependency map
2026-05-20 19:42:43.859622 | controller | Starting collection install process
2026-05-20 19:42:43.859647 | controller | Installing 'vexxhost.kubernetes:3.1.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-05-20 19:42:43.859673 | controller | Created collection for vexxhost.kubernetes:3.1.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-05-20 19:42:43.859698 | controller | vexxhost.kubernetes:3.1.0 was installed successfully
2026-05-20 19:42:43.859731 | controller | warning: No `requires-python` value found in the workspace. Defaulting to `>=3.12`.
2026-05-20 19:42:43.864969 | 
2026-05-20 19:42:43.865013 | PLAY RECAP
2026-05-20 19:42:43.865058 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-20 19:42:43.865079 | 
2026-05-20 19:42:43.966879 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-05-20 19:42:43.971103 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-05-20 19:42:44.528323 | 
2026-05-20 19:42:44.528442 | PLAY [all]
2026-05-20 19:42:44.539898 | 
2026-05-20 19:42:44.539981 | TASK [Copy inventory file for Zuul]
2026-05-20 19:42:45.488534 | controller | changed
2026-05-20 19:42:45.494217 | 
2026-05-20 19:42:45.494294 | TASK [Switch "ansible_host" to private IP]
2026-05-20 19:42:45.841993 | controller | changed: 1 replacements made
2026-05-20 19:42:45.849318 | 
2026-05-20 19:42:45.849393 | TASK [Run Molecule scenario]
2026-05-20 19:42:46.248879 | controller | warning: No `requires-python` value found in the workspace. Defaulting to `>=3.12`.
2026-05-20 19:42:46.898785 | controller | INFO     Collection 'atmosphere.common' detected.
2026-05-20 19:42:46.898929 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-05-20 19:42:47.298159 | controller | INFO     [glance-image > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-05-20 19:42:47.298304 | controller | INFO     [glance-image > prerun] Performing prerun with role_name_check=0...
2026-05-20 19:42:49.876407 | controller | INFO     [glance-image > dependency] Executing
2026-05-20 19:43:17.886579 | controller | Starting galaxy collection install process
2026-05-20 19:43:17.886701 | controller | Process install dependency map
2026-05-20 19:43:17.886979 | controller | Starting collection install process
2026-05-20 19:43:17.887193 | controller | 'openstack.cloud:2.5.0' is already installed, skipping.
2026-05-20 19:43:17.887415 | controller | 'vexxhost.kubernetes:3.1.0' is already installed, skipping.
2026-05-20 19:43:17.887631 | controller | 'vexxhost.containers:1.6.6' is already installed, skipping.
2026-05-20 19:43:17.887884 | controller | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/vexxhost-atmosphere-7.6.0.tar.gz to /home/zuul/.ansible/tmp/ansible-local-1253as9x5j9g/tmp567xr_gh/vexxhost-atmosphere-7.6.0-93a55nqh
2026-05-20 19:43:17.888111 | controller | Installing 'vexxhost.atmosphere:7.6.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/atmosphere'
2026-05-20 19:43:17.888352 | controller | vexxhost.atmosphere:7.6.0 was installed successfully
2026-05-20 19:43:17.888543 | controller | 'atmosphere.common:0.6.0' is already installed, skipping.
2026-05-20 19:43:17.888830 | controller | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/ansible-posix-1.6.0.tar.gz to /home/zuul/.ansible/tmp/ansible-local-1253as9x5j9g/tmp567xr_gh/ansible-posix-1.6.0-t33k1fkj
2026-05-20 19:43:17.889048 | controller | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-05-20 19:43:17.889252 | controller | ansible.posix:1.6.0 was installed successfully
2026-05-20 19:43:17.889490 | controller | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/community-general-7.3.0.tar.gz to /home/zuul/.ansible/tmp/ansible-local-1253as9x5j9g/tmp567xr_gh/community-general-7.3.0-middd2fg
2026-05-20 19:43:17.889712 | controller | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-05-20 19:43:17.889945 | controller | community.general:7.3.0 was installed successfully
2026-05-20 19:43:17.890174 | controller | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/kubernetes-core-2.4.0.tar.gz to /home/zuul/.ansible/tmp/ansible-local-1253as9x5j9g/tmp567xr_gh/kubernetes-core-2.4.0-g8xgwq47
2026-05-20 19:43:17.890377 | controller | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-05-20 19:43:17.890579 | controller | kubernetes.core:2.4.0 was installed successfully
2026-05-20 19:43:17.890831 | controller | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/community-crypto-2.2.3.tar.gz to /home/zuul/.ansible/tmp/ansible-local-1253as9x5j9g/tmp567xr_gh/community-crypto-2.2.3-iyg9ouwy
2026-05-20 19:43:17.891045 | controller | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-05-20 19:43:17.891245 | controller | community.crypto:2.2.3 was installed successfully
2026-05-20 19:43:17.891469 | controller | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/community-mysql-3.6.0.tar.gz to /home/zuul/.ansible/tmp/ansible-local-1253as9x5j9g/tmp567xr_gh/community-mysql-3.6.0-exq4_kng
2026-05-20 19:43:17.891679 | controller | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-05-20 19:43:17.891917 | controller | community.mysql:3.6.0 was installed successfully
2026-05-20 19:43:17.892138 | controller | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/ansible-netcommon-1.2.0.tar.gz to /home/zuul/.ansible/tmp/ansible-local-1253as9x5j9g/tmp567xr_gh/ansible-netcommon-1.2.0-dss0dgpf
2026-05-20 19:43:17.892394 | controller | Installing 'ansible.netcommon:1.2.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-05-20 19:43:17.892579 | controller | ansible.netcommon:1.2.0 was installed successfully
2026-05-20 19:43:17.892850 | controller | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/vexxhost-ceph-4.0.0.tar.gz to /home/zuul/.ansible/tmp/ansible-local-1253as9x5j9g/tmp567xr_gh/vexxhost-ceph-4.0.0-yeatnc07
2026-05-20 19:43:17.893057 | controller | Installing 'vexxhost.ceph:4.0.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-05-20 19:43:17.893256 | controller | vexxhost.ceph:4.0.0 was installed successfully
2026-05-20 19:43:17.893492 | controller | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/ansible-utils-6.0.2.tar.gz to /home/zuul/.ansible/tmp/ansible-local-1253as9x5j9g/tmp567xr_gh/ansible-utils-6.0.2-sdy84x82
2026-05-20 19:43:17.893699 | controller | Installing 'ansible.utils:6.0.2' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-05-20 19:43:17.893945 | controller | ansible.utils:6.0.2 was installed successfully
2026-05-20 19:43:17.937459 | controller | INFO     [glance-image > dependency] Dependency completed successfully.
2026-05-20 19:43:18.294395 | controller | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-05-20 19:43:18.294559 | controller | 2.18.17
2026-05-20 19:43:18.302260 | controller | Starting galaxy collection install process
2026-05-20 19:43:18.302487 | controller | Nothing to do. All requested collections are already installed. If you want to reinstall them, consider using `--force`.
2026-05-20 19:43:18.346831 | controller | INFO     [glance-image > dependency] Dependency completed successfully.
2026-05-20 19:43:18.347030 | controller | INFO     [glance-image > dependency] Executed: Successful
2026-05-20 19:43:18.360376 | controller | INFO     [glance-image > cleanup] Executing
2026-05-20 19:43:18.360862 | controller | WARNING  [glance-image > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-20 19:43:18.367738 | controller | INFO     [glance-image > destroy] Executing
2026-05-20 19:43:18.367833 | controller | WARNING  [glance-image > destroy] Skipping, '--destroy=never' requested.
2026-05-20 19:43:18.367921 | controller | INFO     [glance-image > destroy] Executed: Successful
2026-05-20 19:43:18.375190 | controller | INFO     [glance-image > syntax] Executing
2026-05-20 19:43:19.266089 | controller |
2026-05-20 19:43:19.266541 | controller | playbook: /home/zuul/src/github.com/vexxhost/atmosphere.common/extensions/molecule/glance-image/converge.yml
2026-05-20 19:43:19.309474 | controller | INFO     [glance-image > syntax] Executed: Successful
2026-05-20 19:43:19.316004 | controller | INFO     [glance-image > create] Executing
2026-05-20 19:43:19.317545 | controller | WARNING  [glance-image > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-20 19:43:19.324557 | controller | INFO     [glance-image > prepare] Executing
2026-05-20 19:43:20.686118 | controller |
2026-05-20 19:43:20.686243 | controller | PLAY [Prepare host packages] ***************************************************
2026-05-20 19:43:20.686255 | controller |
2026-05-20 19:43:20.686443 | controller | TASK [Gathering Facts] *********************************************************
2026-05-20 19:43:20.686632 | controller | Wednesday 20 May 2026  19:43:20 +0000 (0:00:00.038)       0:00:00.038 *********
2026-05-20 19:43:21.992017 | controller | [WARNING]: Platform linux on host controller is using the discovered Python
2026-05-20 19:43:21.992125 | controller | interpreter at /usr/bin/python3.12, but future installation of another Python
2026-05-20 19:43:21.992137 | controller | interpreter could change the meaning of that path. See
2026-05-20 19:43:21.992200 | controller | https://docs.ansible.com/ansible-
2026-05-20 19:43:21.992307 | controller | core/2.18/reference_appendices/interpreter_discovery.html for more information.
2026-05-20 19:43:21.996459 | controller | ok: [controller]
2026-05-20 19:43:21.996552 | controller |
2026-05-20 19:43:21.996698 | controller | TASK [Install Debian packages] *************************************************
2026-05-20 19:43:21.996860 | controller | Wednesday 20 May 2026  19:43:21 +0000 (0:00:01.311)       0:00:01.349 *********
2026-05-20 19:43:33.985077 | controller | changed: [controller]
2026-05-20 19:43:33.985173 | controller |
2026-05-20 19:43:33.985184 | controller | TASK [Install Python packages used by the test] ********************************
2026-05-20 19:43:33.985194 | controller | Wednesday 20 May 2026  19:43:33 +0000 (0:00:11.986)       0:00:13.336 *********
2026-05-20 19:43:41.194487 | controller | changed: [controller]
2026-05-20 19:43:41.194606 | controller |
2026-05-20 19:43:41.194775 | controller | PLAY [all] *********************************************************************
2026-05-20 19:43:41.194997 | controller |
2026-05-20 19:43:41.195196 | controller | TASK [Gathering Facts] *********************************************************
2026-05-20 19:43:41.195403 | controller | Wednesday 20 May 2026  19:43:41 +0000 (0:00:07.211)       0:00:20.547 *********
2026-05-20 19:43:41.998298 | controller | ok: [controller]
2026-05-20 19:43:41.998414 | controller |
2026-05-20 19:43:41.998431 | controller | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-05-20 19:43:41.998448 | controller | Wednesday 20 May 2026  19:43:41 +0000 (0:00:00.803)       0:00:21.351 *********
2026-05-20 19:43:42.133680 | controller | ok: [controller]
2026-05-20 19:43:42.133862 | controller |
2026-05-20 19:43:42.134046 | controller | PLAY [Configure Kubernetes VIP] ************************************************
2026-05-20 19:43:42.134230 | controller |
2026-05-20 19:43:42.134436 | controller | TASK [Gathering Facts] *********************************************************
2026-05-20 19:43:42.134639 | controller | Wednesday 20 May 2026  19:43:42 +0000 (0:00:00.135)       0:00:21.486 *********
2026-05-20 19:43:42.923679 | controller | ok: [controller]
2026-05-20 19:43:42.923723 | controller |
2026-05-20 19:43:42.923732 | controller | TASK [vexxhost.containers.directory : Create directory (/etc/kubernetes/manifests)] ***
2026-05-20 19:43:42.923740 | controller | Wednesday 20 May 2026  19:43:42 +0000 (0:00:00.789)       0:00:22.276 *********
2026-05-20 19:43:43.341054 | controller | changed: [controller]
2026-05-20 19:43:43.341096 | controller |
2026-05-20 19:43:43.341110 | controller | TASK [vexxhost.kubernetes.kube_vip : Uninstall legacy HA stack] ****************
2026-05-20 19:43:43.341122 | controller | Wednesday 20 May 2026  19:43:43 +0000 (0:00:00.415)       0:00:22.691 *********
2026-05-20 19:43:44.413391 | controller | ok: [controller] => (item=/etc/keepalived/keepalived.conf)
2026-05-20 19:43:44.413443 | controller | ok: [controller] => (item=/etc/keepalived/check_apiserver.sh)
2026-05-20 19:43:44.413452 | controller | ok: [controller] => (item=/etc/kubernetes/manifests/keepalived.yaml)
2026-05-20 19:43:44.413461 | controller | ok: [controller] => (item=/etc/haproxy/haproxy.cfg)
2026-05-20 19:43:44.413468 | controller | ok: [controller] => (item=/etc/kubernetes/manifests/haproxy.yaml)
2026-05-20 19:43:44.413476 | controller |
2026-05-20 19:43:44.413484 | controller | TASK [vexxhost.kubernetes.kube_vip : Switch API server to run on port 6443] ****
2026-05-20 19:43:44.413491 | controller | Wednesday 20 May 2026  19:43:44 +0000 (0:00:01.072)       0:00:23.763 *********
2026-05-20 19:43:44.767213 | controller | failed: [controller] (item=/etc/kubernetes/manifests/kube-apiserver.yaml) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/manifests/kube-apiserver.yaml", "msg": "Path /etc/kubernetes/manifests/kube-apiserver.yaml does not exist !", "rc": 257}
2026-05-20 19:43:44.972506 | controller | failed: [controller] (item=/etc/kubernetes/controller-manager.conf) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/controller-manager.conf", "msg": "Path /etc/kubernetes/controller-manager.conf does not exist !", "rc": 257}
2026-05-20 19:43:45.177509 | controller | failed: [controller] (item=/etc/kubernetes/scheduler.conf) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/scheduler.conf", "msg": "Path /etc/kubernetes/scheduler.conf does not exist !", "rc": 257}
2026-05-20 19:43:45.188921 | controller | ...ignoring
2026-05-20 19:43:45.188963 | controller |
2026-05-20 19:43:45.189128 | controller | TASK [vexxhost.kubernetes.kube_vip : Check if super-admin.conf exists] *********
2026-05-20 19:43:45.189337 | controller | Wednesday 20 May 2026  19:43:45 +0000 (0:00:00.775)       0:00:24.539 *********
2026-05-20 19:43:45.567343 | controller | ok: [controller]
2026-05-20 19:43:45.567554 | controller |
2026-05-20 19:43:45.567784 | controller | TASK [vexxhost.kubernetes.kube_vip : Check if kubeadm has already run] *********
2026-05-20 19:43:45.568033 | controller | Wednesday 20 May 2026  19:43:45 +0000 (0:00:00.378)       0:00:24.918 *********
2026-05-20 19:43:45.806872 | controller | ok: [controller]
2026-05-20 19:43:45.807065 | controller |
2026-05-20 19:43:45.807319 | controller | TASK [vexxhost.kubernetes.kube_vip : Set fact with KUBECONFIG path] ************
2026-05-20 19:43:45.807523 | controller | Wednesday 20 May 2026  19:43:45 +0000 (0:00:00.241)       0:00:25.159 *********
2026-05-20 19:43:45.837734 | controller | ok: [controller]
2026-05-20 19:43:45.837965 | controller |
2026-05-20 19:43:45.838213 | controller | TASK [vexxhost.kubernetes.kube_vip : Set fact with KUBECONFIG path (with super-admin.conf)] ***
2026-05-20 19:43:45.838405 | controller | Wednesday 20 May 2026  19:43:45 +0000 (0:00:00.030)       0:00:25.191 *********
2026-05-20 19:43:45.876656 | controller | ok: [controller]
2026-05-20 19:43:45.876834 | controller |
2026-05-20 19:43:45.877079 | controller | TASK [vexxhost.kubernetes.kube_vip : Upload Kubernetes manifest] ***************
2026-05-20 19:43:45.877282 | controller | Wednesday 20 May 2026  19:43:45 +0000 (0:00:00.038)       0:00:25.229 *********
2026-05-20 19:43:46.746293 | controller | ok: [controller]
2026-05-20 19:43:46.746364 | controller |
2026-05-20 19:43:46.746376 | controller | TASK [vexxhost.kubernetes.kube_vip : Ensure kube-vip configuration file] *******
2026-05-20 19:43:46.746385 | controller | Wednesday 20 May 2026  19:43:46 +0000 (0:00:00.862)       0:00:26.092 *********
2026-05-20 19:43:47.086362 | controller | ok: [controller]
2026-05-20 19:43:47.086426 | controller |
2026-05-20 19:43:47.086437 | controller | TASK [vexxhost.kubernetes.kube_vip : Flush handlers] ***************************
2026-05-20 19:43:47.086447 | controller | Wednesday 20 May 2026  19:43:46 +0000 (0:00:00.248)       0:00:26.340 *********
2026-05-20 19:43:47.086456 | controller |
2026-05-20 19:43:47.086464 | controller | PLAY [Install Kubernetes] ******************************************************
2026-05-20 19:43:47.086473 | controller |
2026-05-20 19:43:47.086481 | controller | TASK [Gathering Facts] *********************************************************
2026-05-20 19:43:47.086490 | controller | Wednesday 20 May 2026  19:43:47 +0000 (0:00:00.097)       0:00:26.437 *********
2026-05-20 19:43:47.920934 | controller | ok: [controller]
2026-05-20 19:43:47.920980 | controller |
2026-05-20 19:43:47.920987 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-05-20 19:43:47.920994 | controller | Wednesday 20 May 2026  19:43:47 +0000 (0:00:00.834)       0:00:27.272 *********
2026-05-20 19:43:48.162272 | controller | ok: [controller]
2026-05-20 19:43:48.162339 | controller |
2026-05-20 19:43:48.162407 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-05-20 19:43:48.162515 | controller | Wednesday 20 May 2026  19:43:48 +0000 (0:00:00.241)       0:00:27.514 *********
2026-05-20 19:43:48.208509 | controller | skipping: [controller]
2026-05-20 19:43:48.208597 | controller |
2026-05-20 19:43:48.208709 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-05-20 19:43:48.208821 | controller | Wednesday 20 May 2026  19:43:48 +0000 (0:00:00.046)       0:00:27.560 *********
2026-05-20 19:43:48.472925 | controller | changed: [controller]
2026-05-20 19:43:48.472995 | controller |
2026-05-20 19:43:48.473013 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-20 19:43:48.473170 | controller | Wednesday 20 May 2026  19:43:48 +0000 (0:00:00.263)       0:00:27.824 *********
2026-05-20 19:43:48.549993 | controller | ok: [controller] => {
2026-05-20 19:43:48.550024 | controller |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-05-20 19:43:48.550030 | controller | }
2026-05-20 19:43:48.550034 | controller |
2026-05-20 19:43:48.550099 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-20 19:43:48.550226 | controller | Wednesday 20 May 2026  19:43:48 +0000 (0:00:00.077)       0:00:27.901 *********
2026-05-20 19:43:49.227663 | controller | changed: [controller]
2026-05-20 19:43:49.228110 | controller |
2026-05-20 19:43:49.228419 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-20 19:43:49.228932 | controller | Wednesday 20 May 2026  19:43:49 +0000 (0:00:00.677)       0:00:28.579 *********
2026-05-20 19:43:49.262182 | controller | skipping: [controller]
2026-05-20 19:43:49.262422 | controller |
2026-05-20 19:43:49.262439 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-05-20 19:43:49.262559 | controller | Wednesday 20 May 2026  19:43:49 +0000 (0:00:00.035)       0:00:28.615 *********
2026-05-20 19:43:49.534978 | controller | ok: [controller]
2026-05-20 19:43:49.535037 | controller |
2026-05-20 19:43:49.535048 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-05-20 19:43:49.535275 | controller | Wednesday 20 May 2026  19:43:49 +0000 (0:00:00.271)       0:00:28.886 *********
2026-05-20 19:43:50.537333 | controller | ok: [controller]
2026-05-20 19:43:50.537423 | controller |
2026-05-20 19:43:50.537434 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-20 19:43:50.537458 | controller | Wednesday 20 May 2026  19:43:50 +0000 (0:00:01.002)       0:00:29.889 *********
2026-05-20 19:43:50.607998 | controller | ok: [controller] => {
2026-05-20 19:43:50.608022 | controller |     "msg": "https://github.com/containerd/containerd/releases/download/v2.2.3/containerd-2.2.3-linux-amd64.tar.gz"
2026-05-20 19:43:50.608901 | controller | }
2026-05-20 19:43:50.608962 | controller |
2026-05-20 19:43:50.608973 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-20 19:43:50.608983 | controller | Wednesday 20 May 2026  19:43:50 +0000 (0:00:00.070)       0:00:29.959 *********
2026-05-20 19:43:51.447375 | controller | changed: [controller]
2026-05-20 19:43:51.447441 | controller |
2026-05-20 19:43:51.447452 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-20 19:43:51.447461 | controller | Wednesday 20 May 2026  19:43:51 +0000 (0:00:00.839)       0:00:30.798 *********
2026-05-20 19:43:54.462944 | controller | changed: [controller]
2026-05-20 19:43:54.463005 | controller |
2026-05-20 19:43:54.463022 | controller | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-05-20 19:43:54.463262 | controller | Wednesday 20 May 2026  19:43:54 +0000 (0:00:03.016)       0:00:33.815 *********
2026-05-20 19:43:54.493043 | controller | skipping: [controller]
2026-05-20 19:43:54.493085 | controller |
2026-05-20 19:43:54.493207 | controller | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-05-20 19:43:54.493300 | controller | Wednesday 20 May 2026  19:43:54 +0000 (0:00:00.030)       0:00:33.845 *********
2026-05-20 19:43:54.522197 | controller | skipping: [controller]
2026-05-20 19:43:54.522259 | controller |
2026-05-20 19:43:54.522339 | controller | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-05-20 19:43:54.522435 | controller | Wednesday 20 May 2026  19:43:54 +0000 (0:00:00.029)       0:00:33.875 *********
2026-05-20 19:43:54.551092 | controller | skipping: [controller]
2026-05-20 19:43:54.551154 | controller |
2026-05-20 19:43:54.551440 | controller | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-05-20 19:43:54.551712 | controller | Wednesday 20 May 2026  19:43:54 +0000 (0:00:00.027)       0:00:33.903 *********
2026-05-20 19:44:03.022441 | controller | changed: [controller]
2026-05-20 19:44:03.022970 | controller |
2026-05-20 19:44:03.022988 | controller | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-05-20 19:44:03.022997 | controller | Wednesday 20 May 2026  19:44:03 +0000 (0:00:08.471)       0:00:42.375 *********
2026-05-20 19:44:03.596370 | controller | changed: [controller]
2026-05-20 19:44:03.596435 | controller |
2026-05-20 19:44:03.596540 | controller | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-05-20 19:44:03.596668 | controller | Wednesday 20 May 2026  19:44:03 +0000 (0:00:00.573)       0:00:42.948 *********
2026-05-20 19:44:04.739369 | controller | changed: [controller] => (item={'path': '/etc/containerd'})
2026-05-20 19:44:04.739469 | controller | changed: [controller] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-05-20 19:44:04.739484 | controller | changed: [controller] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-05-20 19:44:04.739496 | controller | changed: [controller] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-05-20 19:44:04.739508 | controller | changed: [controller] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-05-20 19:44:04.739521 | controller |
2026-05-20 19:44:04.739533 | controller | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-05-20 19:44:04.739565 | controller | Wednesday 20 May 2026  19:44:04 +0000 (0:00:01.141)       0:00:44.090 *********
2026-05-20 19:44:05.402991 | controller | changed: [controller]
2026-05-20 19:44:05.403054 | controller |
2026-05-20 19:44:05.403065 | controller | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-05-20 19:44:05.403075 | controller | Wednesday 20 May 2026  19:44:05 +0000 (0:00:00.657)       0:00:44.747 *********
2026-05-20 19:44:05.403090 | controller |
2026-05-20 19:44:05.403207 | controller | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-05-20 19:44:05.403402 | controller | Wednesday 20 May 2026  19:44:05 +0000 (0:00:00.007)       0:00:44.755 *********
2026-05-20 19:44:06.221490 | controller | changed: [controller]
2026-05-20 19:44:06.221637 | controller |
2026-05-20 19:44:06.221887 | controller | RUNNING HANDLER [vexxhost.kubernetes.kubelet : Reload systemd] *****************
2026-05-20 19:44:06.222107 | controller | Wednesday 20 May 2026  19:44:06 +0000 (0:00:00.819)       0:00:45.574 *********
2026-05-20 19:44:07.132451 | controller | ok: [controller]
2026-05-20 19:44:07.132730 | controller |
2026-05-20 19:44:07.133120 | controller | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-05-20 19:44:07.133413 | controller | Wednesday 20 May 2026  19:44:07 +0000 (0:00:00.910)       0:00:46.485 *********
2026-05-20 19:44:07.846988 | controller | changed: [controller]
2026-05-20 19:44:07.847051 | controller |
2026-05-20 19:44:07.847063 | controller | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Retrieve the "kubeadm-config" ConfigMap] ***
2026-05-20 19:44:07.847079 | controller | Wednesday 20 May 2026  19:44:07 +0000 (0:00:00.713)       0:00:47.199 *********
2026-05-20 19:44:08.804772 | controller | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: ansible_collections.kubernetes.core.plugins.module_utils.k8s.exceptions.CoreException: Could not create API client: Invalid kube-config file. No configuration found.
2026-05-20 19:44:08.804878 | controller | fatal: [controller]: FAILED! => {"changed": false, "msg": "Could not create API client: Invalid kube-config file. No configuration found."}
2026-05-20 19:44:08.814679 | controller | ...ignoring
2026-05-20 19:44:08.814736 | controller |
2026-05-20 19:44:08.814748 | controller | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Parse the ClusterConfiguration] ***
2026-05-20 19:44:08.814758 | controller | Wednesday 20 May 2026  19:44:08 +0000 (0:00:00.966)       0:00:48.166 *********
2026-05-20 19:44:08.857938 | controller | skipping: [controller]
2026-05-20 19:44:08.857981 | controller |
2026-05-20 19:44:08.858410 | controller | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Retrieve the current Kubernetes version] ***
2026-05-20 19:44:08.858459 | controller | Wednesday 20 May 2026  19:44:08 +0000 (0:00:00.043)       0:00:48.210 *********
2026-05-20 19:44:08.897874 | controller | skipping: [controller]
2026-05-20 19:44:08.897925 | controller |
2026-05-20 19:44:08.897931 | controller | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Extract major, minor, and patch versions] ***
2026-05-20 19:44:08.897940 | controller | Wednesday 20 May 2026  19:44:08 +0000 (0:00:00.039)       0:00:48.249 *********
2026-05-20 19:44:08.935261 | controller | skipping: [controller]
2026-05-20 19:44:08.935346 | controller |
2026-05-20 19:44:08.935457 | controller | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Fail if we're jumping more than one minor version] ***
2026-05-20 19:44:08.935552 | controller | Wednesday 20 May 2026  19:44:08 +0000 (0:00:00.038)       0:00:48.288 *********
2026-05-20 19:44:08.989011 | controller | skipping: [controller]
2026-05-20 19:44:08.989105 | controller |
2026-05-20 19:44:08.989117 | controller | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Set fact if we need to upgrade] ***
2026-05-20 19:44:08.989135 | controller | Wednesday 20 May 2026  19:44:08 +0000 (0:00:00.038)       0:00:48.326 *********
2026-05-20 19:44:09.016944 | controller | skipping: [controller]
2026-05-20 19:44:09.017018 | controller |
2026-05-20 19:44:09.017029 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-05-20 19:44:09.017039 | controller | Wednesday 20 May 2026  19:44:09 +0000 (0:00:00.042)       0:00:48.369 *********
2026-05-20 19:44:09.256260 | controller | ok: [controller]
2026-05-20 19:44:09.256323 | controller |
2026-05-20 19:44:09.256334 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-20 19:44:09.256365 | controller | Wednesday 20 May 2026  19:44:09 +0000 (0:00:00.238)       0:00:48.607 *********
2026-05-20 19:44:09.292973 | controller | ok: [controller] => {
2026-05-20 19:44:09.293044 | controller |     "msg": "https://dl.k8s.io/release/v1.28.13/bin/linux/amd64/kubeadm"
2026-05-20 19:44:09.293063 | controller | }
2026-05-20 19:44:09.293727 | controller |
2026-05-20 19:44:09.293772 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-20 19:44:09.293783 | controller | Wednesday 20 May 2026  19:44:09 +0000 (0:00:00.037)       0:00:48.644 *********
2026-05-20 19:44:10.090643 | controller | changed: [controller]
2026-05-20 19:44:10.090681 | controller |
2026-05-20 19:44:10.090687 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-20 19:44:10.090702 | controller | Wednesday 20 May 2026  19:44:10 +0000 (0:00:00.797)       0:00:49.442 *********
2026-05-20 19:44:10.127267 | controller | skipping: [controller]
2026-05-20 19:44:10.127343 | controller |
2026-05-20 19:44:10.127442 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-05-20 19:44:10.127542 | controller | Wednesday 20 May 2026  19:44:10 +0000 (0:00:00.037)       0:00:49.480 *********
2026-05-20 19:44:10.370180 | controller | ok: [controller]
2026-05-20 19:44:10.370300 | controller |
2026-05-20 19:44:10.370409 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-20 19:44:10.370537 | controller | Wednesday 20 May 2026  19:44:10 +0000 (0:00:00.240)       0:00:49.720 *********
2026-05-20 19:44:10.409693 | controller | ok: [controller] => {
2026-05-20 19:44:10.409885 | controller |     "msg": "https://dl.k8s.io/release/v1.28.13/bin/linux/amd64/kubectl"
2026-05-20 19:44:10.410062 | controller | }
2026-05-20 19:44:10.410219 | controller |
2026-05-20 19:44:10.410404 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-20 19:44:10.410605 | controller | Wednesday 20 May 2026  19:44:10 +0000 (0:00:00.042)       0:00:49.763 *********
2026-05-20 19:44:11.427059 | controller | changed: [controller]
2026-05-20 19:44:11.427164 | controller |
2026-05-20 19:44:11.427395 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-20 19:44:11.427597 | controller | Wednesday 20 May 2026  19:44:11 +0000 (0:00:01.016)       0:00:50.779 *********
2026-05-20 19:44:11.476450 | controller | skipping: [controller]
2026-05-20 19:44:11.476503 | controller |
2026-05-20 19:44:11.476603 | controller | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-05-20 19:44:11.476698 | controller | Wednesday 20 May 2026  19:44:11 +0000 (0:00:00.048)       0:00:50.828 *********
2026-05-20 19:44:11.510696 | controller | skipping: [controller]
2026-05-20 19:44:11.510852 | controller |
2026-05-20 19:44:11.511132 | controller | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-05-20 19:44:11.511305 | controller | Wednesday 20 May 2026  19:44:11 +0000 (0:00:00.035)       0:00:50.863 *********
2026-05-20 19:44:11.546161 | controller | skipping: [controller]
2026-05-20 19:44:11.546290 | controller |
2026-05-20 19:44:11.546510 | controller | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-05-20 19:44:11.546719 | controller | Wednesday 20 May 2026  19:44:11 +0000 (0:00:00.035)       0:00:50.899 *********
2026-05-20 19:44:11.582636 | controller | skipping: [controller]
2026-05-20 19:44:11.582827 | controller |
2026-05-20 19:44:11.583077 | controller | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-05-20 19:44:11.583268 | controller | Wednesday 20 May 2026  19:44:11 +0000 (0:00:00.036)       0:00:50.936 *********
2026-05-20 19:44:12.569976 | controller | ok: [controller]
2026-05-20 19:44:12.570048 | controller |
2026-05-20 19:44:12.570567 | controller | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-05-20 19:44:12.570633 | controller | Wednesday 20 May 2026  19:44:12 +0000 (0:00:00.986)       0:00:51.922 *********
2026-05-20 19:44:13.122346 | controller | ok: [controller]
2026-05-20 19:44:13.122445 | controller |
2026-05-20 19:44:13.122529 | controller | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-05-20 19:44:13.122662 | controller | Wednesday 20 May 2026  19:44:13 +0000 (0:00:00.552)       0:00:52.475 *********
2026-05-20 19:44:14.291374 | controller | ok: [controller] => (item={'path': '/etc/containerd'})
2026-05-20 19:44:14.291457 | controller | ok: [controller] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-05-20 19:44:14.291468 | controller | ok: [controller] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-05-20 19:44:14.291488 | controller | ok: [controller] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-05-20 19:44:14.291497 | controller | ok: [controller] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-05-20 19:44:14.291507 | controller |
2026-05-20 19:44:14.291516 | controller | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-05-20 19:44:14.291525 | controller | Wednesday 20 May 2026  19:44:14 +0000 (0:00:01.166)       0:00:53.641 *********
2026-05-20 19:44:14.928924 | controller | ok: [controller]
2026-05-20 19:44:14.928988 | controller |
2026-05-20 19:44:14.928999 | controller | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-05-20 19:44:14.929009 | controller | Wednesday 20 May 2026  19:44:14 +0000 (0:00:00.633)       0:00:54.275 *********
2026-05-20 19:44:14.929018 | controller |
2026-05-20 19:44:14.929027 | controller | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-05-20 19:44:14.929035 | controller | Wednesday 20 May 2026  19:44:14 +0000 (0:00:00.005)       0:00:54.280 *********
2026-05-20 19:44:15.379030 | controller | ok: [controller]
2026-05-20 19:44:15.379082 | controller |
2026-05-20 19:44:15.379093 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-05-20 19:44:15.379102 | controller | Wednesday 20 May 2026  19:44:15 +0000 (0:00:00.449)       0:00:54.729 *********
2026-05-20 19:44:15.630348 | controller | ok: [controller]
2026-05-20 19:44:15.630411 | controller |
2026-05-20 19:44:15.630422 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-20 19:44:15.630517 | controller | Wednesday 20 May 2026  19:44:15 +0000 (0:00:00.250)       0:00:54.980 *********
2026-05-20 19:44:15.681056 | controller | ok: [controller] => {
2026-05-20 19:44:15.681147 | controller |     "msg": "https://github.com/kubernetes-sigs/cri-tools/releases/download/v1.35.0/crictl-v1.35.0-linux-amd64.tar.gz"
2026-05-20 19:44:15.681238 | controller | }
2026-05-20 19:44:15.681307 | controller |
2026-05-20 19:44:15.681419 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-20 19:44:15.681499 | controller | Wednesday 20 May 2026  19:44:15 +0000 (0:00:00.054)       0:00:55.034 *********
2026-05-20 19:44:16.338386 | controller | changed: [controller]
2026-05-20 19:44:16.338473 | controller |
2026-05-20 19:44:16.338602 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-20 19:44:16.338720 | controller | Wednesday 20 May 2026  19:44:16 +0000 (0:00:00.656)       0:00:55.691 *********
2026-05-20 19:44:17.886511 | controller | changed: [controller]
2026-05-20 19:44:17.886581 | controller |
2026-05-20 19:44:17.886599 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-20 19:44:17.886700 | controller | Wednesday 20 May 2026  19:44:17 +0000 (0:00:01.547)       0:00:57.238 *********
2026-05-20 19:44:17.946888 | controller | ok: [controller] => {
2026-05-20 19:44:17.946947 | controller |     "msg": "https://github.com/kubernetes-sigs/cri-tools/releases/download/v1.35.0/critest-v1.35.0-linux-amd64.tar.gz"
2026-05-20 19:44:17.946954 | controller | }
2026-05-20 19:44:17.946960 | controller |
2026-05-20 19:44:17.946967 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-20 19:44:17.946973 | controller | Wednesday 20 May 2026  19:44:17 +0000 (0:00:00.060)       0:00:57.299 *********
2026-05-20 19:44:18.569246 | controller | changed: [controller]
2026-05-20 19:44:18.569307 | controller |
2026-05-20 19:44:18.569317 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-20 19:44:18.569327 | controller | Wednesday 20 May 2026  19:44:18 +0000 (0:00:00.621)       0:00:57.920 *********
2026-05-20 19:44:20.151519 | controller | changed: [controller]
2026-05-20 19:44:20.151607 | controller |
2026-05-20 19:44:20.151617 | controller | TASK [vexxhost.containers.cri_tools : Create crictl config] ********************
2026-05-20 19:44:20.151627 | controller | Wednesday 20 May 2026  19:44:20 +0000 (0:00:01.581)       0:00:59.502 *********
2026-05-20 19:44:20.721440 | controller | changed: [controller]
2026-05-20 19:44:20.721493 | controller |
2026-05-20 19:44:20.721527 | controller | TASK [vexxhost.containers.directory : Create directory (/opt/cni/bin)] *********
2026-05-20 19:44:20.721538 | controller | Wednesday 20 May 2026  19:44:20 +0000 (0:00:00.571)       0:01:00.073 *********
2026-05-20 19:44:20.975930 | controller | changed: [controller]
2026-05-20 19:44:20.976004 | controller |
2026-05-20 19:44:20.976016 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-05-20 19:44:20.976026 | controller | Wednesday 20 May 2026  19:44:20 +0000 (0:00:00.252)       0:01:00.325 *********
2026-05-20 19:44:21.222295 | controller | ok: [controller]
2026-05-20 19:44:21.222358 | controller |
2026-05-20 19:44:21.222369 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-20 19:44:21.222378 | controller | Wednesday 20 May 2026  19:44:21 +0000 (0:00:00.247)       0:01:00.573 *********
2026-05-20 19:44:21.286481 | controller | ok: [controller] => {
2026-05-20 19:44:21.286526 | controller |     "msg": "https://github.com/containernetworking/plugins/releases/download/v1.9.1/cni-plugins-linux-amd64-v1.9.1.tgz"
2026-05-20 19:44:21.286536 | controller | }
2026-05-20 19:44:21.286545 | controller |
2026-05-20 19:44:21.286554 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-20 19:44:21.286563 | controller | Wednesday 20 May 2026  19:44:21 +0000 (0:00:00.064)       0:01:00.638 *********
2026-05-20 19:44:22.229764 | controller | changed: [controller]
2026-05-20 19:44:22.229838 | controller |
2026-05-20 19:44:22.229849 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-20 19:44:22.229857 | controller | Wednesday 20 May 2026  19:44:22 +0000 (0:00:00.942)       0:01:01.581 *********
2026-05-20 19:44:25.113058 | controller | changed: [controller]
2026-05-20 19:44:25.113140 | controller |
2026-05-20 19:44:25.113583 | controller | TASK [vexxhost.containers.cni_plugins : Gather variables for each operating system] ***
2026-05-20 19:44:25.113650 | controller | Wednesday 20 May 2026  19:44:25 +0000 (0:00:02.884)       0:01:04.465 *********
2026-05-20 19:44:25.160298 | controller | ok: [controller] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/cni_plugins/vars/debian.yml)
2026-05-20 19:44:25.160351 | controller |
2026-05-20 19:44:25.160360 | controller | TASK [vexxhost.containers.cni_plugins : Install additional packages] ***********
2026-05-20 19:44:25.160370 | controller | Wednesday 20 May 2026  19:44:25 +0000 (0:00:00.047)       0:01:04.512 *********
2026-05-20 19:44:26.152230 | controller | ok: [controller]
2026-05-20 19:44:26.152365 | controller |
2026-05-20 19:44:26.152380 | controller | TASK [vexxhost.containers.cni_plugins : Ensure IPv6 is enabled] ****************
2026-05-20 19:44:26.152393 | controller | Wednesday 20 May 2026  19:44:26 +0000 (0:00:00.991)       0:01:05.504 *********
2026-05-20 19:44:26.501919 | controller | changed: [controller]
2026-05-20 19:44:26.501983 | controller |
2026-05-20 19:44:26.502108 | controller | TASK [vexxhost.containers.cni_plugins : Enable kernel modules on-boot] *********
2026-05-20 19:44:26.502336 | controller | Wednesday 20 May 2026  19:44:26 +0000 (0:00:00.350)       0:01:05.854 *********
2026-05-20 19:44:27.116275 | controller | changed: [controller]
2026-05-20 19:44:27.116466 | controller |
2026-05-20 19:44:27.116697 | controller | TASK [vexxhost.containers.cni_plugins : Enable kernel modules in runtime] ******
2026-05-20 19:44:27.116984 | controller | Wednesday 20 May 2026  19:44:27 +0000 (0:00:00.613)       0:01:06.468 *********
2026-05-20 19:44:28.246592 | controller | changed: [controller] => (item=br_netfilter)
2026-05-20 19:44:28.246662 | controller | ok: [controller] => (item=ip_tables)
2026-05-20 19:44:28.246671 | controller | changed: [controller] => (item=ip6_tables)
2026-05-20 19:44:28.246678 | controller | changed: [controller] => (item=nf_conntrack)
2026-05-20 19:44:28.246685 | controller |
2026-05-20 19:44:28.246693 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-05-20 19:44:28.246768 | controller | Wednesday 20 May 2026  19:44:28 +0000 (0:00:01.129)       0:01:07.598 *********
2026-05-20 19:44:28.501984 | controller | ok: [controller]
2026-05-20 19:44:28.502071 | controller |
2026-05-20 19:44:28.502085 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-20 19:44:28.502098 | controller | Wednesday 20 May 2026  19:44:28 +0000 (0:00:00.254)       0:01:07.852 *********
2026-05-20 19:44:28.536859 | controller | ok: [controller] => {
2026-05-20 19:44:28.537056 | controller |     "msg": "https://dl.k8s.io/release/v1.28.13/bin/linux/amd64/kubelet"
2026-05-20 19:44:28.537248 | controller | }
2026-05-20 19:44:28.537429 | controller |
2026-05-20 19:44:28.537642 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-20 19:44:28.538039 | controller | Wednesday 20 May 2026  19:44:28 +0000 (0:00:00.037)       0:01:07.890 *********
2026-05-20 19:44:30.404288 | controller | changed: [controller]
2026-05-20 19:44:30.404347 | controller |
2026-05-20 19:44:30.404372 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-20 19:44:30.404382 | controller | Wednesday 20 May 2026  19:44:30 +0000 (0:00:01.860)       0:01:09.750 *********
2026-05-20 19:44:30.440499 | controller | skipping: [controller]
2026-05-20 19:44:30.440583 | controller |
2026-05-20 19:44:30.440594 | controller | TASK [vexxhost.kubernetes.kubelet : Gather variables for each operating system] ***
2026-05-20 19:44:30.440603 | controller | Wednesday 20 May 2026  19:44:30 +0000 (0:00:00.041)       0:01:09.791 *********
2026-05-20 19:44:30.493443 | controller | ok: [controller] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/kubelet/vars/debian.yml)
2026-05-20 19:44:30.493486 | controller |
2026-05-20 19:44:30.493607 | controller | TASK [vexxhost.kubernetes.kubelet : Install coreutils] *************************
2026-05-20 19:44:30.493697 | controller | Wednesday 20 May 2026  19:44:30 +0000 (0:00:00.053)       0:01:09.844 *********
2026-05-20 19:44:30.530854 | controller | skipping: [controller]
2026-05-20 19:44:30.530920 | controller |
2026-05-20 19:44:30.531086 | controller | TASK [vexxhost.kubernetes.kubelet : Install additional packages] ***************
2026-05-20 19:44:30.531203 | controller | Wednesday 20 May 2026  19:44:30 +0000 (0:00:00.039)       0:01:09.884 *********
2026-05-20 19:44:35.106313 | controller | changed: [controller]
2026-05-20 19:44:35.106391 | controller |
2026-05-20 19:44:35.106406 | controller | TASK [vexxhost.kubernetes.kubelet : Configure sysctl values] *******************
2026-05-20 19:44:35.106418 | controller | Wednesday 20 May 2026  19:44:35 +0000 (0:00:04.573)       0:01:14.458 *********
2026-05-20 19:44:36.782836 | controller | changed: [controller] => (item={'name': 'net.ipv4.ip_forward', 'value': 1})
2026-05-20 19:44:36.782893 | controller | changed: [controller] => (item={'name': 'net.bridge.bridge-nf-call-iptables', 'value': 1})
2026-05-20 19:44:36.782902 | controller | changed: [controller] => (item={'name': 'net.bridge.bridge-nf-call-ip6tables', 'value': 1})
2026-05-20 19:44:36.782910 | controller | changed: [controller] => (item={'name': 'net.ipv4.conf.all.rp_filter', 'value': 0})
2026-05-20 19:44:36.782917 | controller | changed: [controller] => (item={'name': 'fs.inotify.max_queued_events', 'value': 1048576})
2026-05-20 19:44:36.782925 | controller | changed: [controller] => (item={'name': 'fs.inotify.max_user_instances', 'value': 8192})
2026-05-20 19:44:36.782932 | controller | changed: [controller] => (item={'name': 'fs.inotify.max_user_watches', 'value': 1048576})
2026-05-20 19:44:36.782939 | controller |
2026-05-20 19:44:36.782947 | controller | TASK [vexxhost.kubernetes.kubelet : Create folders for kubernetes configuration] ***
2026-05-20 19:44:36.782955 | controller | Wednesday 20 May 2026  19:44:36 +0000 (0:00:01.674)       0:01:16.132 *********
2026-05-20 19:44:37.515542 | controller | changed: [controller] => (item=/etc/systemd/system/kubelet.service.d)
2026-05-20 19:44:37.515923 | controller | ok: [controller] => (item=/etc/kubernetes)
2026-05-20 19:44:37.516222 | controller | ok: [controller] => (item=/etc/kubernetes/manifests)
2026-05-20 19:44:37.516543 | controller |
2026-05-20 19:44:37.516884 | controller | TASK [vexxhost.kubernetes.kubelet : Add kubelet systemd service config] ********
2026-05-20 19:44:37.517201 | controller | Wednesday 20 May 2026  19:44:37 +0000 (0:00:00.735)       0:01:16.867 *********
2026-05-20 19:44:38.111518 | controller | changed: [controller]
2026-05-20 19:44:38.111562 | controller |
2026-05-20 19:44:38.111571 | controller | TASK [vexxhost.kubernetes.kubelet : Add kubeadm dropin for kubelet systemd service config] ***
2026-05-20 19:44:38.111580 | controller | Wednesday 20 May 2026  19:44:38 +0000 (0:00:00.596)       0:01:17.464 *********
2026-05-20 19:44:38.690905 | controller | changed: [controller]
2026-05-20 19:44:38.690965 | controller |
2026-05-20 19:44:38.690979 | controller | TASK [vexxhost.kubernetes.kubelet : Check swap status] *************************
2026-05-20 19:44:38.690991 | controller | Wednesday 20 May 2026  19:44:38 +0000 (0:00:00.578)       0:01:18.043 *********
2026-05-20 19:44:39.065885 | controller | ok: [controller]
2026-05-20 19:44:39.065931 | controller |
2026-05-20 19:44:39.065942 | controller | TASK [vexxhost.kubernetes.kubelet : Disable swap] ******************************
2026-05-20 19:44:39.065952 | controller | Wednesday 20 May 2026  19:44:39 +0000 (0:00:00.374)       0:01:18.417 *********
2026-05-20 19:44:39.094472 | controller | [DEPRECATION WARNING]: Conditional result at location /home/zuul/.ansible/colle
2026-05-20 19:44:39.094517 | controller | ctions/ansible_collections/vexxhost/kubernetes/roles/kubelet/tasks/main.yml
2026-05-20 19:44:39.094527 | controller | 91:11 was of type 'AnsibleUnsafeText'. Conditional results should only be True
2026-05-20 19:44:39.094535 | controller | or False. The result was interpreted as False. This feature will be removed in
2026-05-20 19:44:39.094544 | controller | version 2.19. Deprecation warnings can be disabled by setting
2026-05-20 19:44:39.094553 | controller | deprecation_warnings=False in ansible.cfg.
2026-05-20 19:44:39.108002 | controller | skipping: [controller]
2026-05-20 19:44:39.108135 | controller |
2026-05-20 19:44:39.108446 | controller | TASK [vexxhost.kubernetes.kubelet : Remove swapfile from /etc/fstab] ***********
2026-05-20 19:44:39.108694 | controller | Wednesday 20 May 2026  19:44:39 +0000 (0:00:00.042)       0:01:18.460 *********
2026-05-20 19:44:39.688917 | controller | ok: [controller] => (item=swap)
2026-05-20 19:44:39.688986 | controller | ok: [controller] => (item=none)
2026-05-20 19:44:39.689680 | controller |
2026-05-20 19:44:39.689734 | controller | TASK [vexxhost.kubernetes.kubelet : Create noswap systemd service config file] ***
2026-05-20 19:44:39.689749 | controller | Wednesday 20 May 2026  19:44:39 +0000 (0:00:00.580)       0:01:19.041 *********
2026-05-20 19:44:40.258307 | controller | changed: [controller]
2026-05-20 19:44:40.258363 | controller |
2026-05-20 19:44:40.258377 | controller | TASK [vexxhost.kubernetes.kubelet : Enable noswap service] *********************
2026-05-20 19:44:40.258392 | controller | Wednesday 20 May 2026  19:44:40 +0000 (0:00:00.567)       0:01:19.609 *********
2026-05-20 19:44:40.941989 | controller | changed: [controller]
2026-05-20 19:44:40.942046 | controller |
2026-05-20 19:44:40.942061 | controller | TASK [vexxhost.kubernetes.kubelet : Force any restarts if necessary] ***********
2026-05-20 19:44:40.942081 | controller | Wednesday 20 May 2026  19:44:40 +0000 (0:00:00.680)       0:01:20.290 *********
2026-05-20 19:44:40.942130 | controller |
2026-05-20 19:44:40.942278 | controller | RUNNING HANDLER [vexxhost.kubernetes.kubelet : Reload systemd] *****************
2026-05-20 19:44:40.942406 | controller | Wednesday 20 May 2026  19:44:40 +0000 (0:00:00.004)       0:01:20.294 *********
2026-05-20 19:44:41.833220 | controller | ok: [controller]
2026-05-20 19:44:41.833298 | controller |
2026-05-20 19:44:41.833351 | controller | TASK [vexxhost.kubernetes.kubelet : Enable and start kubelet service] **********
2026-05-20 19:44:41.833457 | controller | Wednesday 20 May 2026  19:44:41 +0000 (0:00:00.891)       0:01:21.186 *********
2026-05-20 19:44:42.583430 | controller | changed: [controller]
2026-05-20 19:44:42.584136 | controller |
2026-05-20 19:44:42.584198 | controller | TASK [vexxhost.kubernetes.kubelet : Ensure availability of dbus on Debian] *****
2026-05-20 19:44:42.584213 | controller | Wednesday 20 May 2026  19:44:42 +0000 (0:00:00.749)       0:01:21.936 *********
2026-05-20 19:44:43.980719 | controller | ok: [controller]
2026-05-20 19:44:43.980917 | controller |
2026-05-20 19:44:43.980949 | controller | TASK [vexxhost.kubernetes.kubelet : Configure short hostname] ******************
2026-05-20 19:44:43.980963 | controller | Wednesday 20 May 2026  19:44:43 +0000 (0:00:01.396)       0:01:23.332 *********
2026-05-20 19:44:44.798393 | controller | changed: [controller]
2026-05-20 19:44:44.798485 | controller |
2026-05-20 19:44:44.798500 | controller | TASK [vexxhost.kubernetes.kubelet : Ensure hostname inside hosts file] *********
2026-05-20 19:44:44.798513 | controller | Wednesday 20 May 2026  19:44:44 +0000 (0:00:00.817)       0:01:24.150 *********
2026-05-20 19:44:45.164623 | controller | changed: [controller]
2026-05-20 19:44:45.164706 | controller |
2026-05-20 19:44:45.164719 | controller | TASK [vexxhost.kubernetes.kubernetes : Remove kubernetes repository] ***********
2026-05-20 19:44:45.164732 | controller | Wednesday 20 May 2026  19:44:45 +0000 (0:00:00.366)       0:01:24.516 *********
2026-05-20 19:44:45.654392 | controller | ok: [controller]
2026-05-20 19:44:45.654474 | controller |
2026-05-20 19:44:45.654488 | controller | TASK [vexxhost.kubernetes.kubernetes : Setup control plane] ********************
2026-05-20 19:44:45.654532 | controller | Wednesday 20 May 2026  19:44:45 +0000 (0:00:00.489)       0:01:25.006 *********
2026-05-20 19:44:45.766614 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/kubernetes/tasks/control-plane.yml for controller
2026-05-20 19:44:45.766702 | controller |
2026-05-20 19:44:45.766715 | controller | TASK [vexxhost.kubernetes.kubernetes : Bootstrap cluster] **********************
2026-05-20 19:44:45.766725 | controller | Wednesday 20 May 2026  19:44:45 +0000 (0:00:00.112)       0:01:25.118 *********
2026-05-20 19:44:45.841367 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/kubernetes/tasks/bootstrap-cluster.yml for controller
2026-05-20 19:44:45.841429 | controller |
2026-05-20 19:44:45.841441 | controller | TASK [vexxhost.kubernetes.kubernetes : Check if any control plane is bootstrapped] ***
2026-05-20 19:44:45.841451 | controller | Wednesday 20 May 2026  19:44:45 +0000 (0:00:00.074)       0:01:25.193 *********
2026-05-20 19:44:46.103576 | controller | ok: [controller] => (item=controller)
2026-05-20 19:44:46.103657 | controller |
2026-05-20 19:44:46.103669 | controller | TASK [vexxhost.kubernetes.kubernetes : Pick node from pre-existing cluster] ****
2026-05-20 19:44:46.103679 | controller | Wednesday 20 May 2026  19:44:46 +0000 (0:00:00.261)       0:01:25.454 *********
2026-05-20 19:44:46.150585 | controller | skipping: [controller]
2026-05-20 19:44:46.150657 | controller |
2026-05-20 19:44:46.150668 | controller | TASK [vexxhost.kubernetes.kubernetes : Select first node to initialize cluster] ***
2026-05-20 19:44:46.150678 | controller | Wednesday 20 May 2026  19:44:46 +0000 (0:00:00.047)       0:01:25.501 *********
2026-05-20 19:44:46.207042 | controller | ok: [controller]
2026-05-20 19:44:46.207073 | controller |
2026-05-20 19:44:46.207083 | controller | TASK [vexxhost.kubernetes.kubernetes : Print selected bootstrap node] **********
2026-05-20 19:44:46.207092 | controller | Wednesday 20 May 2026  19:44:46 +0000 (0:00:00.057)       0:01:25.558 *********
2026-05-20 19:44:46.254427 | controller | ok: [controller] => {
2026-05-20 19:44:46.254458 | controller |     "msg": "controller"
2026-05-20 19:44:46.254468 | controller | }
2026-05-20 19:44:46.254477 | controller |
2026-05-20 19:44:46.254486 | controller | TASK [vexxhost.kubernetes.kubernetes : Upload cluster configuration for bootstrap node] ***
2026-05-20 19:44:46.254495 | controller | Wednesday 20 May 2026  19:44:46 +0000 (0:00:00.046)       0:01:25.605 *********
2026-05-20 19:44:46.973421 | controller | changed: [controller]
2026-05-20 19:44:46.973480 | controller |
2026-05-20 19:44:46.973491 | controller | TASK [vexxhost.kubernetes.kubernetes : Create pki folder] **********************
2026-05-20 19:44:46.973517 | controller | Wednesday 20 May 2026  19:44:46 +0000 (0:00:00.719)       0:01:26.324 *********
2026-05-20 19:44:47.008982 | controller | skipping: [controller]
2026-05-20 19:44:47.009012 | controller |
2026-05-20 19:44:47.009022 | controller | TASK [vexxhost.kubernetes.kubernetes : Create kubernetes ca key] ***************
2026-05-20 19:44:47.009031 | controller | Wednesday 20 May 2026  19:44:47 +0000 (0:00:00.036)       0:01:26.361 *********
2026-05-20 19:44:47.047928 | controller | skipping: [controller]
2026-05-20 19:44:47.047958 | controller |
2026-05-20 19:44:47.047968 | controller | TASK [vexxhost.kubernetes.kubernetes : Create kubernetes ca cert] **************
2026-05-20 19:44:47.047977 | controller | Wednesday 20 May 2026  19:44:47 +0000 (0:00:00.038)       0:01:26.399 *********
2026-05-20 19:44:47.085938 | controller | skipping: [controller]
2026-05-20 19:44:47.085967 | controller |
2026-05-20 19:44:47.085977 | controller | TASK [vexxhost.kubernetes.kubernetes : Create etcd-ca key] *********************
2026-05-20 19:44:47.085986 | controller | Wednesday 20 May 2026  19:44:47 +0000 (0:00:00.038)       0:01:26.437 *********
2026-05-20 19:44:47.137497 | controller | skipping: [controller]
2026-05-20 19:44:47.137582 | controller |
2026-05-20 19:44:47.137594 | controller | TASK [vexxhost.kubernetes.kubernetes : Create etcd-ca cert] ********************
2026-05-20 19:44:47.137604 | controller | Wednesday 20 May 2026  19:44:47 +0000 (0:00:00.050)       0:01:26.488 *********
2026-05-20 19:44:47.176192 | controller | skipping: [controller]
2026-05-20 19:44:47.176247 | controller |
2026-05-20 19:44:47.176255 | controller | TASK [vexxhost.kubernetes.kubernetes : Create front-proxy-ca key] **************
2026-05-20 19:44:47.176263 | controller | Wednesday 20 May 2026  19:44:47 +0000 (0:00:00.038)       0:01:26.527 *********
2026-05-20 19:44:47.222098 | controller | skipping: [controller]
2026-05-20 19:44:47.222147 | controller |
2026-05-20 19:44:47.222157 | controller | TASK [vexxhost.kubernetes.kubernetes : Create front-proxy-ca cert] *************
2026-05-20 19:44:47.222166 | controller | Wednesday 20 May 2026  19:44:47 +0000 (0:00:00.046)       0:01:26.573 *********
2026-05-20 19:44:47.261992 | controller | skipping: [controller]
2026-05-20 19:44:47.262043 | controller |
2026-05-20 19:44:47.262051 | controller | TASK [vexxhost.kubernetes.kubernetes : Initialize cluster] *********************
2026-05-20 19:44:47.262057 | controller | Wednesday 20 May 2026  19:44:47 +0000 (0:00:00.039)       0:01:26.613 *********
2026-05-20 19:45:13.257391 | controller | changed: [controller]
2026-05-20 19:45:13.257489 | controller |
2026-05-20 19:45:13.257503 | controller | TASK [vexxhost.kubernetes.kubernetes : Check if the node is already part of the cluster] ***
2026-05-20 19:45:13.257516 | controller | Wednesday 20 May 2026  19:45:13 +0000 (0:00:25.995)       0:01:52.608 *********
2026-05-20 19:45:13.514524 | controller | ok: [controller]
2026-05-20 19:45:13.514591 | controller |
2026-05-20 19:45:13.514604 | controller | TASK [vexxhost.kubernetes.kubernetes : Join cluster] ***************************
2026-05-20 19:45:13.514616 | controller | Wednesday 20 May 2026  19:45:13 +0000 (0:00:00.256)       0:01:52.865 *********
2026-05-20 19:45:13.550412 | controller | skipping: [controller]
2026-05-20 19:45:13.550541 | controller |
2026-05-20 19:45:13.550695 | controller | TASK [vexxhost.kubernetes.kubernetes : Create folder for admin configuration] ***
2026-05-20 19:45:13.550854 | controller | Wednesday 20 May 2026  19:45:13 +0000 (0:00:00.036)       0:01:52.902 *********
2026-05-20 19:45:13.821853 | controller | changed: [controller]
2026-05-20 19:45:13.821896 | controller |
2026-05-20 19:45:13.822078 | controller | TASK [vexxhost.kubernetes.kubernetes : Creating a symlink for admin configuration file] ***
2026-05-20 19:45:13.822324 | controller | Wednesday 20 May 2026  19:45:13 +0000 (0:00:00.271)       0:01:53.174 *********
2026-05-20 19:45:14.086782 | controller | changed: [controller]
2026-05-20 19:45:14.086992 | controller |
2026-05-20 19:45:14.087010 | controller | TASK [vexxhost.kubernetes.kubernetes : Add bash autocomplete for kubectl] ******
2026-05-20 19:45:14.087145 | controller | Wednesday 20 May 2026  19:45:14 +0000 (0:00:00.265)       0:01:53.439 *********
2026-05-20 19:45:14.326211 | controller | changed: [controller]
2026-05-20 19:45:14.326406 | controller |
2026-05-20 19:45:14.326638 | controller | TASK [vexxhost.kubernetes.kubernetes : Install PIP] ****************************
2026-05-20 19:45:14.326901 | controller | Wednesday 20 May 2026  19:45:14 +0000 (0:00:00.238)       0:01:53.678 *********
2026-05-20 19:45:14.373616 | controller | skipping: [controller]
2026-05-20 19:45:14.373824 | controller |
2026-05-20 19:45:14.374064 | controller | TASK [vexxhost.kubernetes.kubernetes : Install Kubernetes Python package using pip on supported systems] ***
2026-05-20 19:45:14.374278 | controller | Wednesday 20 May 2026  19:45:14 +0000 (0:00:00.047)       0:01:53.725 *********
2026-05-20 19:45:14.417102 | controller | skipping: [controller]
2026-05-20 19:45:14.417269 | controller |
2026-05-20 19:45:14.417497 | controller | TASK [vexxhost.kubernetes.kubernetes : Enable EPEL repository] *****************
2026-05-20 19:45:14.417698 | controller | Wednesday 20 May 2026  19:45:14 +0000 (0:00:00.044)       0:01:53.770 *********
2026-05-20 19:45:14.461444 | controller | skipping: [controller]
2026-05-20 19:45:14.461552 | controller |
2026-05-20 19:45:14.461862 | controller | TASK [vexxhost.kubernetes.kubernetes : Install Kubernetes Python package using package manager on supported systems] ***
2026-05-20 19:45:14.462041 | controller | Wednesday 20 May 2026  19:45:14 +0000 (0:00:00.044)       0:01:53.814 *********
2026-05-20 19:45:21.255761 | controller | changed: [controller]
2026-05-20 19:45:21.255880 | controller |
2026-05-20 19:45:21.256133 | controller | TASK [vexxhost.kubernetes.kubernetes : Allow workload on control plane node] ***
2026-05-20 19:45:21.256343 | controller | Wednesday 20 May 2026  19:45:21 +0000 (0:00:06.793)       0:02:00.608 *********
2026-05-20 19:45:22.017327 | controller | changed: [controller]
2026-05-20 19:45:22.017394 | controller |
2026-05-20 19:45:22.017415 | controller | TASK [vexxhost.kubernetes.kubernetes : Remove kube-proxy resources] ************
2026-05-20 19:45:22.017516 | controller | Wednesday 20 May 2026  19:45:22 +0000 (0:00:00.761)       0:02:01.369 *********
2026-05-20 19:45:22.060884 | controller | skipping: [controller] => (item=DaemonSet)
2026-05-20 19:45:22.061066 | controller | skipping: [controller] => (item=ConfigMap)
2026-05-20 19:45:22.061190 | controller | skipping: [controller]
2026-05-20 19:45:22.061294 | controller |
2026-05-20 19:45:22.061376 | controller | TASK [vexxhost.kubernetes.kubernetes : Start an upgrade] ***********************
2026-05-20 19:45:22.062937 | controller | Wednesday 20 May 2026  19:45:22 +0000 (0:00:00.044)       0:02:01.414 *********
2026-05-20 19:45:22.105288 | controller | skipping: [controller]
2026-05-20 19:45:22.105448 | controller |
2026-05-20 19:45:22.105666 | controller | TASK [vexxhost.kubernetes.kubernetes : Check if the Kubernetes API services is up to date] ***
2026-05-20 19:45:22.105917 | controller | Wednesday 20 May 2026  19:45:22 +0000 (0:00:00.044)       0:02:01.458 *********
2026-05-20 19:45:22.152270 | controller | skipping: [controller]
2026-05-20 19:45:22.152314 | controller |
2026-05-20 19:45:22.152423 | controller | TASK [vexxhost.kubernetes.kubernetes : Trigger an upgrade of the Kubernetes API services] ***
2026-05-20 19:45:22.153829 | controller | Wednesday 20 May 2026  19:45:22 +0000 (0:00:00.046)       0:02:01.505 *********
2026-05-20 19:45:22.197319 | controller | skipping: [controller]
2026-05-20 19:45:22.197397 | controller |
2026-05-20 19:45:22.197650 | controller | TASK [vexxhost.kubernetes.kubernetes : Setup nodes] ****************************
2026-05-20 19:45:22.197836 | controller | Wednesday 20 May 2026  19:45:22 +0000 (0:00:00.045)       0:02:01.550 *********
2026-05-20 19:45:22.238216 | controller | skipping: [controller]
2026-05-20 19:45:22.238354 | controller |
2026-05-20 19:45:22.238623 | controller | TASK [vexxhost.kubernetes.kubernetes : Upgrade & restart Kubelet node for upgrade (if needed)] ***
2026-05-20 19:45:22.238779 | controller | Wednesday 20 May 2026  19:45:22 +0000 (0:00:00.040)       0:02:01.590 *********
2026-05-20 19:45:22.701733 | controller | ok: [controller]
2026-05-20 19:45:22.701787 | controller |
2026-05-20 19:45:22.701835 | controller | TASK [vexxhost.kubernetes.kubernetes : Set node selector for CoreDNS components] ***
2026-05-20 19:45:22.701845 | controller | Wednesday 20 May 2026  19:45:22 +0000 (0:00:00.463)       0:02:02.053 *********
2026-05-20 19:45:23.794072 | controller | changed: [controller]
2026-05-20 19:45:23.794122 | controller |
2026-05-20 19:45:23.794170 | controller | PLAY [Install control-plane components] ****************************************
2026-05-20 19:45:23.794446 | controller |
2026-05-20 19:45:23.794735 | controller | TASK [Gathering Facts] *********************************************************
2026-05-20 19:45:23.795064 | controller | Wednesday 20 May 2026  19:45:23 +0000 (0:00:01.092)       0:02:03.146 *********
2026-05-20 19:45:25.614097 | controller | ok: [controller]
2026-05-20 19:45:25.614298 | controller |
2026-05-20 19:45:25.614444 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-05-20 19:45:25.614630 | controller | Wednesday 20 May 2026  19:45:25 +0000 (0:00:01.820)       0:02:04.967 *********
2026-05-20 19:45:25.868294 | controller | ok: [controller]
2026-05-20 19:45:25.868376 | controller |
2026-05-20 19:45:25.868388 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-05-20 19:45:25.868407 | controller | Wednesday 20 May 2026  19:45:25 +0000 (0:00:00.253)       0:02:05.220 *********
2026-05-20 19:45:26.869510 | controller | ok: [controller]
2026-05-20 19:45:26.869649 | controller |
2026-05-20 19:45:26.869900 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-05-20 19:45:26.870028 | controller | Wednesday 20 May 2026  19:45:26 +0000 (0:00:01.001)       0:02:06.221 *********
2026-05-20 19:45:27.134016 | controller | ok: [controller]
2026-05-20 19:45:27.134115 | controller |
2026-05-20 19:45:27.134330 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-20 19:45:27.134648 | controller | Wednesday 20 May 2026  19:45:27 +0000 (0:00:00.263)       0:02:06.485 *********
2026-05-20 19:45:27.174086 | controller | ok: [controller] => {
2026-05-20 19:45:27.174292 | controller |     "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz"
2026-05-20 19:45:27.174487 | controller | }
2026-05-20 19:45:27.174671 | controller |
2026-05-20 19:45:27.174960 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-20 19:45:27.175164 | controller | Wednesday 20 May 2026  19:45:27 +0000 (0:00:00.041)       0:02:06.527 *********
2026-05-20 19:45:28.104662 | controller | changed: [controller]
2026-05-20 19:45:28.105303 | controller |
2026-05-20 19:45:28.105364 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-20 19:45:28.105403 | controller | Wednesday 20 May 2026  19:45:28 +0000 (0:00:00.929)       0:02:07.456 *********
2026-05-20 19:45:29.807113 | controller | changed: [controller]
2026-05-20 19:45:29.807175 | controller |
2026-05-20 19:45:29.807186 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] ***********************
2026-05-20 19:45:29.807196 | controller | Wednesday 20 May 2026  19:45:29 +0000 (0:00:01.700)       0:02:09.157 *********
2026-05-20 19:45:30.189524 | controller | ok: [controller]
2026-05-20 19:45:30.189680 | controller |
2026-05-20 19:45:30.189956 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] ***************
2026-05-20 19:45:30.190171 | controller | Wednesday 20 May 2026  19:45:30 +0000 (0:00:00.384)       0:02:09.542 *********
2026-05-20 19:45:30.869449 | controller | changed: [controller]
2026-05-20 19:45:30.869631 | controller |
2026-05-20 19:45:30.869888 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] *************************
2026-05-20 19:45:30.870103 | controller | Wednesday 20 May 2026  19:45:30 +0000 (0:00:00.679)       0:02:10.221 *********
2026-05-20 19:45:31.169503 | controller | ok: [controller]
2026-05-20 19:45:31.169564 | controller |
2026-05-20 19:45:31.169736 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] ***
2026-05-20 19:45:31.170890 | controller | Wednesday 20 May 2026  19:45:31 +0000 (0:00:00.300)       0:02:10.521 *********
2026-05-20 19:45:31.430091 | controller | changed: [controller]
2026-05-20 19:45:31.430167 | controller |
2026-05-20 19:45:31.430179 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] ***
2026-05-20 19:45:31.430188 | controller | Wednesday 20 May 2026  19:45:31 +0000 (0:00:00.260)       0:02:10.782 *********
2026-05-20 19:45:31.682913 | controller | ok: [controller]
2026-05-20 19:45:31.682988 | controller |
2026-05-20 19:45:31.682999 | controller | TASK [Install plugin] **********************************************************
2026-05-20 19:45:31.683009 | controller | Wednesday 20 May 2026  19:45:31 +0000 (0:00:00.252)       0:02:11.034 *********
2026-05-20 19:45:31.734777 | controller | included: vexxhost.containers.download_artifact for controller
2026-05-20 19:45:31.734870 | controller |
2026-05-20 19:45:31.734882 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-20 19:45:31.734900 | controller | Wednesday 20 May 2026  19:45:31 +0000 (0:00:00.052)       0:02:11.087 *********
2026-05-20 19:45:31.775320 | controller | ok: [controller] => {
2026-05-20 19:45:31.776281 | controller |     "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz"
2026-05-20 19:45:31.776294 | controller | }
2026-05-20 19:45:31.776300 | controller |
2026-05-20 19:45:31.776306 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-20 19:45:31.776312 | controller | Wednesday 20 May 2026  19:45:31 +0000 (0:00:00.039)       0:02:11.127 *********
2026-05-20 19:45:32.500834 | controller | changed: [controller]
2026-05-20 19:45:32.500871 | controller |
2026-05-20 19:45:32.500876 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-20 19:45:32.500880 | controller | Wednesday 20 May 2026  19:45:32 +0000 (0:00:00.724)       0:02:11.852 *********
2026-05-20 19:45:34.533345 | controller | changed: [controller]
2026-05-20 19:45:34.533516 | controller |
2026-05-20 19:45:34.533752 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-20 19:45:34.534009 | controller | Wednesday 20 May 2026  19:45:34 +0000 (0:00:02.033)       0:02:13.885 *********
2026-05-20 19:45:34.569628 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-05-20 19:45:34.569819 | controller |
2026-05-20 19:45:34.570080 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-05-20 19:45:34.570289 | controller | Wednesday 20 May 2026  19:45:34 +0000 (0:00:00.036)       0:02:13.922 *********
2026-05-20 19:45:35.279314 | controller | changed: [controller]
2026-05-20 19:45:35.279465 | controller |
2026-05-20 19:45:35.279702 | controller | TASK [vexxhost.kubernetes.cilium : Get current Kubernetes version] *************
2026-05-20 19:45:35.279950 | controller | Wednesday 20 May 2026  19:45:35 +0000 (0:00:00.709)       0:02:14.632 *********
2026-05-20 19:45:36.323570 | controller | ok: [controller]
2026-05-20 19:45:36.323725 | controller |
2026-05-20 19:45:36.324022 | controller | TASK [vexxhost.kubernetes.cilium : Deploy Helm chart] **************************
2026-05-20 19:45:36.324232 | controller | Wednesday 20 May 2026  19:45:36 +0000 (0:00:01.044)       0:02:15.676 *********
2026-05-20 19:45:38.461649 | controller | changed: [controller]
2026-05-20 19:45:38.461700 | controller |
2026-05-20 19:45:38.461709 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-20 19:45:38.461717 | controller | Wednesday 20 May 2026  19:45:38 +0000 (0:00:02.136)       0:02:17.812 *********
2026-05-20 19:45:38.492890 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-05-20 19:45:38.492929 | controller |
2026-05-20 19:45:38.492948 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-05-20 19:45:38.493131 | controller | Wednesday 20 May 2026  19:45:38 +0000 (0:00:00.032)       0:02:17.845 *********
2026-05-20 19:45:39.008837 | controller | changed: [controller]
2026-05-20 19:45:39.008871 | controller |
2026-05-20 19:45:39.008877 | controller | TASK [vexxhost.kubernetes.envoy_gateway : Deploy Helm chart] *******************
2026-05-20 19:45:39.008887 | controller | Wednesday 20 May 2026  19:45:39 +0000 (0:00:00.513)       0:02:18.359 *********
2026-05-20 19:46:09.180535 | controller | changed: [controller]
2026-05-20 19:46:09.180667 | controller |
2026-05-20 19:46:09.180919 | controller | TASK [vexxhost.kubernetes.envoy_gateway : Create GatewayClass] *****************
2026-05-20 19:46:09.181145 | controller | Wednesday 20 May 2026  19:46:09 +0000 (0:00:30.173)       0:02:48.532 *********
2026-05-20 19:46:09.960924 | controller | changed: [controller]
2026-05-20 19:46:09.961092 | controller |
2026-05-20 19:46:09.961372 | controller | PLAY [all] *********************************************************************
2026-05-20 19:46:09.961561 | controller |
2026-05-20 19:46:09.961781 | controller | TASK [Gathering Facts] *********************************************************
2026-05-20 19:46:09.962104 | controller | Wednesday 20 May 2026  19:46:09 +0000 (0:00:00.781)       0:02:49.314 *********
2026-05-20 19:46:10.964957 | controller | ok: [controller]
2026-05-20 19:46:10.965023 | controller |
2026-05-20 19:46:10.965160 | controller | TASK [vexxhost.atmosphere.kubernetes_node_labels : Add labels to node] *********
2026-05-20 19:46:10.965372 | controller | Wednesday 20 May 2026  19:46:10 +0000 (0:00:01.003)       0:02:50.317 *********
2026-05-20 19:46:11.756359 | controller | changed: [controller]
2026-05-20 19:46:11.756509 | controller |
2026-05-20 19:46:11.756929 | controller | PLAY [all] *********************************************************************
2026-05-20 19:46:11.757109 | controller |
2026-05-20 19:46:11.757318 | controller | TASK [Uninstall unattended-upgrades] *******************************************
2026-05-20 19:46:11.757524 | controller | Wednesday 20 May 2026  19:46:11 +0000 (0:00:00.791)       0:02:51.109 *********
2026-05-20 19:46:12.465282 | controller | ok: [controller]
2026-05-20 19:46:12.465454 | controller |
2026-05-20 19:46:12.465675 | controller | PLAY [controllers] *************************************************************
2026-05-20 19:46:12.465903 | controller |
2026-05-20 19:46:12.466122 | controller | TASK [Gathering Facts] *********************************************************
2026-05-20 19:46:12.466338 | controller | Wednesday 20 May 2026  19:46:12 +0000 (0:00:00.708)       0:02:51.818 *********
2026-05-20 19:46:13.491272 | controller | ok: [controller]
2026-05-20 19:46:13.491340 | controller |
2026-05-20 19:46:13.491354 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-20 19:46:13.491460 | controller | Wednesday 20 May 2026  19:46:13 +0000 (0:00:01.026)       0:02:52.844 *********
2026-05-20 19:46:13.528448 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-05-20 19:46:13.528516 | controller |
2026-05-20 19:46:13.528665 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-05-20 19:46:13.528843 | controller | Wednesday 20 May 2026  19:46:13 +0000 (0:00:00.035)       0:02:52.880 *********
2026-05-20 19:46:14.039853 | controller | changed: [controller]
2026-05-20 19:46:14.040060 | controller |
2026-05-20 19:46:14.040285 | controller | TASK [vexxhost.atmosphere.local_path_provisioner : Deploy Helm chart] **********
2026-05-20 19:46:14.040511 | controller | Wednesday 20 May 2026  19:46:14 +0000 (0:00:00.512)       0:02:53.392 *********
2026-05-20 19:46:16.003788 | controller | changed: [controller]
2026-05-20 19:46:16.003872 | controller |
2026-05-20 19:46:16.003886 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-20 19:46:16.003899 | controller | Wednesday 20 May 2026  19:46:15 +0000 (0:00:01.962)       0:02:55.355 *********
2026-05-20 19:46:16.035660 | controller | skipping: [controller]
2026-05-20 19:46:16.035733 | controller |
2026-05-20 19:46:16.036257 | controller | TASK [vexxhost.atmosphere.ceph_csi_rbd : Collect "ceph mon dump" output from a monitor] ***
2026-05-20 19:46:16.036311 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.033)       0:02:55.388 *********
2026-05-20 19:46:16.072888 | controller | skipping: [controller]
2026-05-20 19:46:16.072936 | controller |
2026-05-20 19:46:16.073216 | controller | TASK [vexxhost.atmosphere.ceph_csi_rbd : Generate fact with Ceph FSID] *********
2026-05-20 19:46:16.073320 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.036)       0:02:55.424 *********
2026-05-20 19:46:16.106463 | controller | skipping: [controller]
2026-05-20 19:46:16.106540 | controller |
2026-05-20 19:46:16.106561 | controller | TASK [vexxhost.atmosphere.ceph_csi_rbd : Generate fact with list of Ceph monitors] ***
2026-05-20 19:46:16.106630 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.032)       0:02:55.456 *********
2026-05-20 19:46:16.132101 | controller | skipping: [controller]
2026-05-20 19:46:16.132320 | controller |
2026-05-20 19:46:16.132504 | controller | TASK [vexxhost.atmosphere.ceph_csi_rbd : Create Ceph pool] *********************
2026-05-20 19:46:16.132684 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.028)       0:02:55.485 *********
2026-05-20 19:46:16.175434 | controller | skipping: [controller]
2026-05-20 19:46:16.175494 | controller |
2026-05-20 19:46:16.175664 | controller | TASK [vexxhost.atmosphere.ceph_csi_rbd : Create user client.kube] **************
2026-05-20 19:46:16.175766 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.043)       0:02:55.528 *********
2026-05-20 19:46:16.223967 | controller | skipping: [controller]
2026-05-20 19:46:16.224119 | controller |
2026-05-20 19:46:16.224351 | controller | TASK [vexxhost.atmosphere.ceph_csi_rbd : Retrieve keyring for client.kube] *****
2026-05-20 19:46:16.224510 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.048)       0:02:55.577 *********
2026-05-20 19:46:16.255733 | controller | skipping: [controller]
2026-05-20 19:46:16.255824 | controller |
2026-05-20 19:46:16.255971 | controller | TASK [vexxhost.atmosphere.ceph_csi_rbd : Store keyring inside fact] ************
2026-05-20 19:46:16.256087 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.031)       0:02:55.609 *********
2026-05-20 19:46:16.283016 | controller | skipping: [controller]
2026-05-20 19:46:16.283138 | controller |
2026-05-20 19:46:16.283285 | controller | TASK [vexxhost.atmosphere.ceph_csi_rbd : Deploy Helm chart] ********************
2026-05-20 19:46:16.283416 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.026)       0:02:55.636 *********
2026-05-20 19:46:16.317241 | controller | skipping: [controller]
2026-05-20 19:46:16.317341 | controller |
2026-05-20 19:46:16.317470 | controller | TASK [vexxhost.atmosphere.powerstore_csi : Clone PowerStore CSI from GitHub] ***
2026-05-20 19:46:16.317581 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.034)       0:02:55.670 *********
2026-05-20 19:46:16.347913 | controller | skipping: [controller]
2026-05-20 19:46:16.347970 | controller |
2026-05-20 19:46:16.348120 | controller | TASK [vexxhost.atmosphere.powerstore_csi : Create Secret] **********************
2026-05-20 19:46:16.348291 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.030)       0:02:55.700 *********
2026-05-20 19:46:16.375323 | controller | skipping: [controller]
2026-05-20 19:46:16.375399 | controller |
2026-05-20 19:46:16.375496 | controller | TASK [vexxhost.atmosphere.powerstore_csi : Create StorageClass] ****************
2026-05-20 19:46:16.375612 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.027)       0:02:55.728 *********
2026-05-20 19:46:16.407943 | controller | skipping: [controller]
2026-05-20 19:46:16.408072 | controller |
2026-05-20 19:46:16.408216 | controller | TASK [vexxhost.atmosphere.powerstore_csi : Deploy Helm chart] ******************
2026-05-20 19:46:16.408353 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.031)       0:02:55.760 *********
2026-05-20 19:46:16.440944 | controller | skipping: [controller]
2026-05-20 19:46:16.441142 | controller |
2026-05-20 19:46:16.441374 | controller | TASK [vexxhost.atmosphere.multipathd : Add backports PPA] **********************
2026-05-20 19:46:16.441599 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.033)       0:02:55.794 *********
2026-05-20 19:46:16.472060 | controller | skipping: [controller]
2026-05-20 19:46:16.472346 | controller |
2026-05-20 19:46:16.472565 | controller | TASK [vexxhost.atmosphere.multipathd : Install the multipathd package] *********
2026-05-20 19:46:16.472843 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.030)       0:02:55.824 *********
2026-05-20 19:46:16.501770 | controller | skipping: [controller]
2026-05-20 19:46:16.501972 | controller |
2026-05-20 19:46:16.502210 | controller | TASK [vexxhost.atmosphere.multipathd : Install the configuration file] *********
2026-05-20 19:46:16.502421 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.030)       0:02:55.855 *********
2026-05-20 19:46:16.532371 | controller | skipping: [controller]
2026-05-20 19:46:16.532525 | controller |
2026-05-20 19:46:16.532760 | controller | TASK [vexxhost.atmosphere.portworx : Detect if InitiatorName is set] ***********
2026-05-20 19:46:16.533024 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.030)       0:02:55.885 *********
2026-05-20 19:46:16.564944 | controller | skipping: [controller]
2026-05-20 19:46:16.565074 | controller |
2026-05-20 19:46:16.565294 | controller | TASK [vexxhost.atmosphere.portworx : Generate a new InitiatorName] *************
2026-05-20 19:46:16.565602 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.032)       0:02:55.917 *********
2026-05-20 19:46:16.595134 | controller | skipping: [controller]
2026-05-20 19:46:16.595249 | controller |
2026-05-20 19:46:16.595511 | controller | TASK [vexxhost.atmosphere.portworx : Write the new InitiatorName] **************
2026-05-20 19:46:16.595668 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.030)       0:02:55.948 *********
2026-05-20 19:46:16.622032 | controller | skipping: [controller]
2026-05-20 19:46:16.622177 | controller |
2026-05-20 19:46:16.622381 | controller | TASK [vexxhost.atmosphere.portworx : Create namespace] *************************
2026-05-20 19:46:16.622641 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.025)       0:02:55.974 *********
2026-05-20 19:46:16.650308 | controller | skipping: [controller]
2026-05-20 19:46:16.650483 | controller |
2026-05-20 19:46:16.650687 | controller | TASK [vexxhost.atmosphere.portworx : Install Portworx] *************************
2026-05-20 19:46:16.650927 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.029)       0:02:56.003 *********
2026-05-20 19:46:16.678689 | controller | skipping: [controller]
2026-05-20 19:46:16.678920 | controller |
2026-05-20 19:46:16.679149 | controller | TASK [vexxhost.atmosphere.portworx : Wait till the CRDs are created] ***********
2026-05-20 19:46:16.679370 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.028)       0:02:56.031 *********
2026-05-20 19:46:16.714840 | controller | skipping: [controller]
2026-05-20 19:46:16.715036 | controller |
2026-05-20 19:46:16.715260 | controller | TASK [vexxhost.atmosphere.portworx : Create Portworx Storage Cluster] **********
2026-05-20 19:46:16.715516 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.036)       0:02:56.068 *********
2026-05-20 19:46:16.751089 | controller | skipping: [controller]
2026-05-20 19:46:16.751279 | controller |
2026-05-20 19:46:16.751503 | controller | TASK [vexxhost.atmosphere.storpool_csi : Deploy CSI RBAC] **********************
2026-05-20 19:46:16.751741 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.035)       0:02:56.104 *********
2026-05-20 19:46:16.783919 | controller | skipping: [controller] => (item={'name': 'controllerplugin'})
2026-05-20 19:46:16.784169 | controller | skipping: [controller] => (item={'name': 'nodeplugin'})
2026-05-20 19:46:16.784390 | controller | skipping: [controller]
2026-05-20 19:46:16.784594 | controller |
2026-05-20 19:46:16.784900 | controller | TASK [vexxhost.atmosphere.storpool_csi : Deploy CSI] ***************************
2026-05-20 19:46:16.785130 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.032)       0:02:56.137 *********
2026-05-20 19:46:16.814112 | controller | skipping: [controller]
2026-05-20 19:46:16.814343 | controller |
2026-05-20 19:46:16.814592 | controller | TASK [vexxhost.atmosphere.storpool_csi : Create StorageClass] ******************
2026-05-20 19:46:16.814882 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.029)       0:02:56.166 *********
2026-05-20 19:46:16.848987 | controller | skipping: [controller]
2026-05-20 19:46:16.849151 | controller |
2026-05-20 19:46:16.849362 | controller | TASK [vexxhost.atmosphere.ibm_block_csi_driver : Deploy CSI] *******************
2026-05-20 19:46:16.849567 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.035)       0:02:56.201 *********
2026-05-20 19:46:16.879400 | controller | skipping: [controller]
2026-05-20 19:46:16.879595 | controller |
2026-05-20 19:46:16.879764 | controller | TASK [vexxhost.atmosphere.ibm_block_csi_driver : Create Secret] ****************
2026-05-20 19:46:16.879951 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.030)       0:02:56.232 *********
2026-05-20 19:46:16.908102 | controller | skipping: [controller]
2026-05-20 19:46:16.908281 | controller |
2026-05-20 19:46:16.908492 | controller | TASK [vexxhost.atmosphere.ibm_block_csi_driver : Create StorageClass] **********
2026-05-20 19:46:16.908696 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.028)       0:02:56.261 *********
2026-05-20 19:46:16.973355 | controller | skipping: [controller]
2026-05-20 19:46:16.973532 | controller |
2026-05-20 19:46:16.973778 | controller | PLAY [Deploy minimal OpenStack services for Glance] ****************************
2026-05-20 19:46:16.974014 | controller |
2026-05-20 19:46:16.974228 | controller | TASK [Gathering Facts] *********************************************************
2026-05-20 19:46:16.974439 | controller | Wednesday 20 May 2026  19:46:16 +0000 (0:00:00.065)       0:02:56.326 *********
2026-05-20 19:46:18.217910 | controller | ok: [controller]
2026-05-20 19:46:18.217952 | controller |
2026-05-20 19:46:18.217958 | controller | TASK [Expose OS family for Atmosphere roles] ***********************************
2026-05-20 19:46:18.219067 | controller | Wednesday 20 May 2026  19:46:18 +0000 (0:00:01.243)       0:02:57.570 *********
2026-05-20 19:46:18.264135 | controller | ok: [controller]
2026-05-20 19:46:18.337722 | controller |
2026-05-20 19:46:18.337740 | controller | TASK [Deploy Helm chart] *******************************************************
2026-05-20 19:46:18.337749 | controller | Wednesday 20 May 2026  19:46:18 +0000 (0:00:00.046)       0:02:57.617 *********
2026-05-20 19:46:18.337771 | controller | included: vexxhost.kubernetes.cert_manager for controller
2026-05-20 19:46:18.337779 | controller |
2026-05-20 19:46:18.337787 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-20 19:46:18.337823 | controller | Wednesday 20 May 2026  19:46:18 +0000 (0:00:00.053)       0:02:57.670 *********
2026-05-20 19:46:18.356179 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-05-20 19:46:18.360724 | controller |
2026-05-20 19:46:18.360895 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-05-20 19:46:18.361073 | controller | Wednesday 20 May 2026  19:46:18 +0000 (0:00:00.039)       0:02:57.709 *********
2026-05-20 19:46:18.895632 | controller | changed: [controller]
2026-05-20 19:46:18.895674 | controller |
2026-05-20 19:46:18.895749 | controller | TASK [vexxhost.kubernetes.cert_manager : Deploy Helm chart] ********************
2026-05-20 19:46:18.896017 | controller | Wednesday 20 May 2026  19:46:18 +0000 (0:00:00.538)       0:02:58.248 *********
2026-05-20 19:46:36.740242 | controller | changed: [controller]
2026-05-20 19:46:36.740366 | controller |
2026-05-20 19:46:36.740605 | controller | TASK [vexxhost.atmosphere.cluster_issuer : Create self-signed cluster issuer] ***
2026-05-20 19:46:36.740839 | controller | Wednesday 20 May 2026  19:46:36 +0000 (0:00:17.845)       0:03:16.093 *********
2026-05-20 19:46:37.582979 | controller | changed: [controller]
2026-05-20 19:46:37.583070 | controller |
2026-05-20 19:46:37.583324 | controller | TASK [vexxhost.atmosphere.cluster_issuer : Import tasks for ClusterIssuer type] ***
2026-05-20 19:46:37.583343 | controller | Wednesday 20 May 2026  19:46:37 +0000 (0:00:00.840)       0:03:16.934 *********
2026-05-20 19:46:37.625018 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/atmosphere/roles/cluster_issuer/tasks/type/self-signed/main.yml for controller
2026-05-20 19:46:37.625963 | controller |
2026-05-20 19:46:37.626028 | controller | TASK [vexxhost.atmosphere.cluster_issuer : Create ClusterIssuer] ***************
2026-05-20 19:46:37.626038 | controller | Wednesday 20 May 2026  19:46:37 +0000 (0:00:00.044)       0:03:16.978 *********
2026-05-20 19:46:38.502567 | controller | changed: [controller]
2026-05-20 19:46:38.502754 | controller |
2026-05-20 19:46:38.503026 | controller | TASK [vexxhost.atmosphere.cluster_issuer : Wait till the secret is created] ****
2026-05-20 19:46:38.503247 | controller | Wednesday 20 May 2026  19:46:38 +0000 (0:00:00.877)       0:03:17.855 *********
2026-05-20 19:46:39.286309 | controller | ok: [controller]
2026-05-20 19:46:39.286523 | controller |
2026-05-20 19:46:39.286745 | controller | TASK [vexxhost.atmosphere.cluster_issuer : Copy CA certificate on host] ********
2026-05-20 19:46:39.286992 | controller | Wednesday 20 May 2026  19:46:39 +0000 (0:00:00.783)       0:03:18.639 *********
2026-05-20 19:46:39.907275 | controller | changed: [controller]
2026-05-20 19:46:39.907460 | controller |
2026-05-20 19:46:39.907687 | controller | TASK [vexxhost.atmosphere.cluster_issuer : Flush all handlers] *****************
2026-05-20 19:46:39.907984 | controller | Wednesday 20 May 2026  19:46:39 +0000 (0:00:00.618)       0:03:19.257 *********
2026-05-20 19:46:39.908176 | controller |
2026-05-20 19:46:39.908410 | controller | RUNNING HANDLER [vexxhost.atmosphere.cluster_issuer : Install openssl-perl package] ***
2026-05-20 19:46:39.908604 | controller | Wednesday 20 May 2026  19:46:39 +0000 (0:00:00.002)       0:03:19.260 *********
2026-05-20 19:46:39.945359 | controller | skipping: [controller]
2026-05-20 19:46:39.945549 | controller |
2026-05-20 19:46:39.945774 | controller | RUNNING HANDLER [vexxhost.atmosphere.cluster_issuer : Update CA certificates] ***
2026-05-20 19:46:39.946013 | controller | Wednesday 20 May 2026  19:46:39 +0000 (0:00:00.038)       0:03:19.298 *********
2026-05-20 19:46:42.481364 | controller | changed: [controller]
2026-05-20 19:46:42.481552 | controller |
2026-05-20 19:46:42.481815 | controller | RUNNING HANDLER [vexxhost.atmosphere.cluster_issuer : Rehash CA certificates] ***
2026-05-20 19:46:42.482036 | controller | Wednesday 20 May 2026  19:46:42 +0000 (0:00:02.535)       0:03:21.834 *********
2026-05-20 19:46:52.647118 | controller | changed: [controller]
2026-05-20 19:46:52.647284 | controller |
2026-05-20 19:46:52.647512 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-20 19:46:52.647819 | controller | Wednesday 20 May 2026  19:46:52 +0000 (0:00:10.165)       0:03:32.000 *********
2026-05-20 19:46:52.684781 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-05-20 19:46:52.685006 | controller |
2026-05-20 19:46:52.685275 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-05-20 19:46:52.685513 | controller | Wednesday 20 May 2026  19:46:52 +0000 (0:00:00.037)       0:03:32.038 *********
2026-05-20 19:46:53.253313 | controller | changed: [controller]
2026-05-20 19:46:53.253480 | controller |
2026-05-20 19:46:53.253707 | controller | TASK [vexxhost.atmosphere.ingress_nginx : Deploy Helm chart] *******************
2026-05-20 19:46:53.253957 | controller | Wednesday 20 May 2026  19:46:53 +0000 (0:00:00.567)       0:03:32.606 *********
2026-05-20 19:47:08.092761 | controller | changed: [controller]
2026-05-20 19:47:08.093050 | controller |
2026-05-20 19:47:08.093331 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-20 19:47:08.093583 | controller | Wednesday 20 May 2026  19:47:08 +0000 (0:00:14.839)       0:03:47.445 *********
2026-05-20 19:47:08.129399 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-05-20 19:47:08.129629 | controller |
2026-05-20 19:47:08.129933 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-05-20 19:47:08.130138 | controller | Wednesday 20 May 2026  19:47:08 +0000 (0:00:00.037)       0:03:47.482 *********
2026-05-20 19:47:08.665469 | controller | changed: [controller]
2026-05-20 19:47:08.665633 | controller |
2026-05-20 19:47:08.665888 | controller | TASK [vexxhost.atmosphere.rabbitmq_cluster_operator : Install all CRDs] ********
2026-05-20 19:47:08.666099 | controller | Wednesday 20 May 2026  19:47:08 +0000 (0:00:00.535)       0:03:48.018 *********
2026-05-20 19:47:11.781860 | controller | ok: [controller] => (item=messaging-topology-operator)
2026-05-20 19:47:11.781904 | controller | ok: [controller] => (item=rabbitmq-cluster)
2026-05-20 19:47:11.782047 | controller |
2026-05-20 19:47:11.782298 | controller | TASK [vexxhost.atmosphere.rabbitmq_cluster_operator : Deploy Helm chart] *******
2026-05-20 19:47:11.782554 | controller | Wednesday 20 May 2026  19:47:11 +0000 (0:00:03.115)       0:03:51.134 *********
2026-05-20 19:47:15.427297 | controller | changed: [controller]
2026-05-20 19:47:15.427360 | controller |
2026-05-20 19:47:15.427428 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-20 19:47:15.427525 | controller | Wednesday 20 May 2026  19:47:15 +0000 (0:00:03.643)       0:03:54.778 *********
2026-05-20 19:47:15.461764 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-05-20 19:47:15.461875 | controller |
2026-05-20 19:47:15.462004 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-05-20 19:47:15.462172 | controller | Wednesday 20 May 2026  19:47:15 +0000 (0:00:00.036)       0:03:54.815 *********
2026-05-20 19:47:15.964320 | controller | changed: [controller]
2026-05-20 19:47:15.964364 | controller |
2026-05-20 19:47:15.964374 | controller | TASK [vexxhost.atmosphere.percona_xtradb_cluster_operator : Install all CRDs] ***
2026-05-20 19:47:15.964382 | controller | Wednesday 20 May 2026  19:47:15 +0000 (0:00:00.500)       0:03:55.316 *********
2026-05-20 19:47:18.635742 | controller | ok: [controller]
2026-05-20 19:47:18.636045 | controller |
2026-05-20 19:47:18.636296 | controller | TASK [vexxhost.atmosphere.percona_xtradb_cluster_operator : Deploy Helm chart] ***
2026-05-20 19:47:18.636510 | controller | Wednesday 20 May 2026  19:47:18 +0000 (0:00:02.672)       0:03:57.988 *********
2026-05-20 19:47:21.182563 | controller | changed: [controller]
2026-05-20 19:47:21.182644 | controller |
2026-05-20 19:47:21.182672 | controller | TASK [vexxhost.atmosphere.percona_xtradb_cluster : Check if the Percona XtraDB cluster secret exists] ***
2026-05-20 19:47:21.182680 | controller | Wednesday 20 May 2026  19:47:21 +0000 (0:00:02.546)       0:04:00.535 *********
2026-05-20 19:47:21.947747 | controller | ok: [controller]
2026-05-20 19:47:21.947792 | controller |
2026-05-20 19:47:21.947831 | controller | TASK [vexxhost.atmosphere.percona_xtradb_cluster : Create a secret] ************
2026-05-20 19:47:21.947840 | controller | Wednesday 20 May 2026  19:47:21 +0000 (0:00:00.764)       0:04:01.299 *********
2026-05-20 19:47:22.748327 | controller | changed: [controller]
2026-05-20 19:47:22.748366 | controller |
2026-05-20 19:47:22.748372 | controller | TASK [vexxhost.atmosphere.percona_xtradb_cluster : Check if the Percona XtraDB cluster exists] ***
2026-05-20 19:47:22.748378 | controller | Wednesday 20 May 2026  19:47:22 +0000 (0:00:00.801)       0:04:02.101 *********
2026-05-20 19:47:23.587198 | controller | ok: [controller]
2026-05-20 19:47:23.587247 | controller |
2026-05-20 19:47:23.587356 | controller | TASK [vexxhost.atmosphere.percona_xtradb_cluster : Get current status of the cluster] ***
2026-05-20 19:47:23.587451 | controller | Wednesday 20 May 2026  19:47:23 +0000 (0:00:00.838)       0:04:02.939 *********
2026-05-20 19:47:23.624413 | controller | skipping: [controller]
2026-05-20 19:47:23.624438 | controller |
2026-05-20 19:47:23.624447 | controller | TASK [vexxhost.atmosphere.percona_xtradb_cluster : Assert that the cluster is healthy before upgrade] ***
2026-05-20 19:47:23.624454 | controller | Wednesday 20 May 2026  19:47:23 +0000 (0:00:00.036)       0:04:02.976 *********
2026-05-20 19:47:23.663270 | controller | skipping: [controller]
2026-05-20 19:47:23.663392 | controller |
2026-05-20 19:47:23.663536 | controller | TASK [vexxhost.atmosphere.percona_xtradb_cluster : Stop PXC-operator] **********
2026-05-20 19:47:23.664864 | controller | Wednesday 20 May 2026  19:47:23 +0000 (0:00:00.039)       0:04:03.016 *********
2026-05-20 19:47:23.704837 | controller | skipping: [controller]
2026-05-20 19:47:23.704869 | controller |
2026-05-20 19:47:23.704877 | controller | TASK [vexxhost.atmosphere.percona_xtradb_cluster : Change the cluster Statefulset image to 8.0] ***
2026-05-20 19:47:23.704885 | controller | Wednesday 20 May 2026  19:47:23 +0000 (0:00:00.040)       0:04:03.057 *********
2026-05-20 19:47:23.742321 | controller | skipping: [controller]
2026-05-20 19:47:23.742521 | controller |
2026-05-20 19:47:23.742773 | controller | TASK [vexxhost.atmosphere.percona_xtradb_cluster : Wait until the cluster Statefulset rollout] ***
2026-05-20 19:47:23.743023 | controller | Wednesday 20 May 2026  19:47:23 +0000 (0:00:00.038)       0:04:03.095 *********
2026-05-20 19:47:23.777830 | controller | skipping: [controller]
2026-05-20 19:47:23.778014 | controller |
2026-05-20 19:47:23.778223 | controller | TASK [vexxhost.atmosphere.percona_xtradb_cluster : Update pxc cluster spec] ****
2026-05-20 19:47:23.778455 | controller | Wednesday 20 May 2026  19:47:23 +0000 (0:00:00.035)       0:04:03.131 *********
2026-05-20 19:47:23.817634 | controller | skipping: [controller]
2026-05-20 19:47:23.817750 | controller |
2026-05-20 19:47:23.817994 | controller | TASK [vexxhost.atmosphere.percona_xtradb_cluster : Start PXC-operator] *********
2026-05-20 19:47:23.818142 | controller | Wednesday 20 May 2026  19:47:23 +0000 (0:00:00.039)       0:04:03.171 *********
2026-05-20 19:47:23.852959 | controller | skipping: [controller]
2026-05-20 19:47:23.853131 | controller |
2026-05-20 19:47:23.853394 | controller | TASK [vexxhost.atmosphere.percona_xtradb_cluster : Apply Percona XtraDB cluster] ***
2026-05-20 19:47:23.853613 | controller | Wednesday 20 May 2026  19:47:23 +0000 (0:00:00.035)       0:04:03.206 *********
2026-05-20 19:49:30.196218 | controller | changed: [controller]
2026-05-20 19:49:30.196387 | controller |
2026-05-20 19:49:30.196401 | controller | TASK [vexxhost.atmosphere.percona_xtradb_cluster : Create percona haproxy metric service] ***
2026-05-20 19:49:30.196413 | controller | Wednesday 20 May 2026  19:49:30 +0000 (0:02:06.339)       0:06:09.545 *********
2026-05-20 19:49:31.000762 | controller | changed: [controller]
2026-05-20 19:49:31.000962 | controller |
2026-05-20 19:49:31.001198 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Retrieve list of all the needed endpoints] ***
2026-05-20 19:49:31.001407 | controller | Wednesday 20 May 2026  19:49:30 +0000 (0:00:00.807)       0:06:10.353 *********
2026-05-20 19:49:31.059301 | controller | ok: [controller]
2026-05-20 19:49:31.059514 | controller |
2026-05-20 19:49:31.059730 | controller | TASK [Create RabbitMQ cluster] *************************************************
2026-05-20 19:49:31.059987 | controller | Wednesday 20 May 2026  19:49:31 +0000 (0:00:00.059)       0:06:10.412 *********
2026-05-20 19:49:31.089135 | controller | skipping: [controller]
2026-05-20 19:49:31.089322 | controller |
2026-05-20 19:49:31.089546 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Grab RabbitMQ cluster secret] ***
2026-05-20 19:49:31.089751 | controller | Wednesday 20 May 2026  19:49:31 +0000 (0:00:00.029)       0:06:10.442 *********
2026-05-20 19:49:31.125168 | controller | skipping: [controller]
2026-05-20 19:49:31.125326 | controller |
2026-05-20 19:49:31.125558 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Cache fact with RabbitMQ cluster credentials] ***
2026-05-20 19:49:31.126123 | controller | Wednesday 20 May 2026  19:49:31 +0000 (0:00:00.036)       0:06:10.478 *********
2026-05-20 19:49:31.167285 | controller | skipping: [controller]
2026-05-20 19:49:31.167450 | controller |
2026-05-20 19:49:31.167883 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Grab Percona XtraDB cluster secret] ***
2026-05-20 19:49:31.168001 | controller | Wednesday 20 May 2026  19:49:31 +0000 (0:00:00.042)       0:06:10.520 *********
2026-05-20 19:49:31.200689 | controller | skipping: [controller]
2026-05-20 19:49:31.200902 | controller |
2026-05-20 19:49:31.201144 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Cache fact with Percona XtraDB password] ***
2026-05-20 19:49:31.201355 | controller | Wednesday 20 May 2026  19:49:31 +0000 (0:00:00.033)       0:06:10.553 *********
2026-05-20 19:49:31.230598 | controller | skipping: [controller]
2026-05-20 19:49:31.230759 | controller |
2026-05-20 19:49:31.231037 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Reset value for OpenStack_Helm endpoints] ***
2026-05-20 19:49:31.231255 | controller | Wednesday 20 May 2026  19:49:31 +0000 (0:00:00.029)       0:06:10.583 *********
2026-05-20 19:49:31.268319 | controller | ok: [controller]
2026-05-20 19:49:31.268460 | controller |
2026-05-20 19:49:31.268696 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Generate OpenStack-Helm endpoints] ***
2026-05-20 19:49:31.268967 | controller | Wednesday 20 May 2026  19:49:31 +0000 (0:00:00.037)       0:06:10.621 *********
2026-05-20 19:49:31.320292 | controller | ok: [controller] => (item=oslo_cache)
2026-05-20 19:49:31.320526 | controller |
2026-05-20 19:49:31.320864 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Clean-up facts] ***********
2026-05-20 19:49:31.321137 | controller | Wednesday 20 May 2026  19:49:31 +0000 (0:00:00.052)       0:06:10.673 *********
2026-05-20 19:49:31.366578 | controller | ok: [controller]
2026-05-20 19:49:31.366636 | controller |
2026-05-20 19:49:31.366706 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-20 19:49:31.366807 | controller | Wednesday 20 May 2026  19:49:31 +0000 (0:00:00.046)       0:06:10.719 *********
2026-05-20 19:49:31.403962 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-05-20 19:49:31.404077 | controller |
2026-05-20 19:49:31.404308 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-05-20 19:49:31.404516 | controller | Wednesday 20 May 2026  19:49:31 +0000 (0:00:00.037)       0:06:10.757 *********
2026-05-20 19:49:31.946096 | controller | changed: [controller]
2026-05-20 19:49:31.946168 | controller |
2026-05-20 19:49:31.946324 | controller | TASK [vexxhost.atmosphere.memcached : Deploy Helm chart] ***********************
2026-05-20 19:49:31.946471 | controller | Wednesday 20 May 2026  19:49:31 +0000 (0:00:00.541)       0:06:11.299 *********
2026-05-20 19:49:33.457847 | controller | changed: [controller]
2026-05-20 19:49:33.457957 | controller |
2026-05-20 19:49:33.458012 | controller | TASK [vexxhost.atmosphere.memcached : Apply manifests for monitoring] **********
2026-05-20 19:49:33.458140 | controller | Wednesday 20 May 2026  19:49:33 +0000 (0:00:01.511)       0:06:12.811 *********
2026-05-20 19:49:34.257916 | controller | changed: [controller]
2026-05-20 19:49:34.258117 | controller |
2026-05-20 19:49:34.258437 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Retrieve list of all the needed endpoints] ***
2026-05-20 19:49:34.258723 | controller | Wednesday 20 May 2026  19:49:34 +0000 (0:00:00.799)       0:06:13.610 *********
2026-05-20 19:49:34.298833 | controller | skipping: [controller]
2026-05-20 19:49:34.299053 | controller |
2026-05-20 19:49:34.299287 | controller | TASK [Create RabbitMQ cluster] *************************************************
2026-05-20 19:49:34.299500 | controller | Wednesday 20 May 2026  19:49:34 +0000 (0:00:00.041)       0:06:13.652 *********
2026-05-20 19:49:34.331898 | controller | skipping: [controller]
2026-05-20 19:49:34.332082 | controller |
2026-05-20 19:49:34.332421 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Grab RabbitMQ cluster secret] ***
2026-05-20 19:49:34.332679 | controller | Wednesday 20 May 2026  19:49:34 +0000 (0:00:00.033)       0:06:13.685 *********
2026-05-20 19:49:34.367178 | controller | skipping: [controller]
2026-05-20 19:49:34.367367 | controller |
2026-05-20 19:49:34.367599 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Cache fact with RabbitMQ cluster credentials] ***
2026-05-20 19:49:34.367816 | controller | Wednesday 20 May 2026  19:49:34 +0000 (0:00:00.035)       0:06:13.720 *********
2026-05-20 19:49:34.403422 | controller | skipping: [controller]
2026-05-20 19:49:34.403501 | controller |
2026-05-20 19:49:34.403604 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Grab Percona XtraDB cluster secret] ***
2026-05-20 19:49:34.403697 | controller | Wednesday 20 May 2026  19:49:34 +0000 (0:00:00.036)       0:06:13.756 *********
2026-05-20 19:49:35.241400 | controller | ok: [controller]
2026-05-20 19:49:35.241504 | controller |
2026-05-20 19:49:35.241661 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Cache fact with Percona XtraDB password] ***
2026-05-20 19:49:35.241801 | controller | Wednesday 20 May 2026  19:49:35 +0000 (0:00:00.837)       0:06:14.594 *********
2026-05-20 19:49:35.284422 | controller | ok: [controller]
2026-05-20 19:49:35.284526 | controller |
2026-05-20 19:49:35.284730 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Reset value for OpenStack_Helm endpoints] ***
2026-05-20 19:49:35.284918 | controller | Wednesday 20 May 2026  19:49:35 +0000 (0:00:00.043)       0:06:14.637 *********
2026-05-20 19:49:35.317189 | controller | ok: [controller]
2026-05-20 19:49:35.317620 | controller |
2026-05-20 19:49:35.318158 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Generate OpenStack-Helm endpoints] ***
2026-05-20 19:49:35.318419 | controller | Wednesday 20 May 2026  19:49:35 +0000 (0:00:00.032)       0:06:14.670 *********
2026-05-20 19:49:35.363004 | controller | ok: [controller] => (item=oslo_db)
2026-05-20 19:49:35.364001 | controller |
2026-05-20 19:49:35.364118 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Clean-up facts] ***********
2026-05-20 19:49:35.364309 | controller | Wednesday 20 May 2026  19:49:35 +0000 (0:00:00.045)       0:06:14.716 *********
2026-05-20 19:49:35.399727 | controller | ok: [controller]
2026-05-20 19:49:35.400004 | controller |
2026-05-20 19:49:35.400231 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-20 19:49:35.400437 | controller | Wednesday 20 May 2026  19:49:35 +0000 (0:00:00.036)       0:06:14.752 *********
2026-05-20 19:49:35.434405 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-05-20 19:49:35.434602 | controller |
2026-05-20 19:49:35.434813 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-05-20 19:49:35.435151 | controller | Wednesday 20 May 2026  19:49:35 +0000 (0:00:00.035)       0:06:14.787 *********
2026-05-20 19:49:36.097139 | controller | changed: [controller]
2026-05-20 19:49:36.097320 | controller |
2026-05-20 19:49:36.097539 | controller | TASK [vexxhost.atmosphere.keycloak : Get the Kuberentes service for Percona XtraDB Cluster] ***
2026-05-20 19:49:36.097750 | controller | Wednesday 20 May 2026  19:49:36 +0000 (0:00:00.661)       0:06:15.449 *********
2026-05-20 19:49:36.906400 | controller | ok: [controller]
2026-05-20 19:49:36.906569 | controller |
2026-05-20 19:49:36.906768 | controller | TASK [vexxhost.atmosphere.keycloak : Install MySQL python package] *************
2026-05-20 19:49:36.907673 | controller | Wednesday 20 May 2026  19:49:36 +0000 (0:00:00.809)       0:06:16.259 *********
2026-05-20 19:49:38.280843 | controller | changed: [controller]
2026-05-20 19:49:38.280928 | controller |
2026-05-20 19:49:38.280936 | controller | TASK [vexxhost.atmosphere.keycloak : Check MySQL ready] ************************
2026-05-20 19:49:38.280942 | controller | Wednesday 20 May 2026  19:49:38 +0000 (0:00:01.371)       0:06:17.630 *********
2026-05-20 19:49:38.737207 | controller | ok: [controller]
2026-05-20 19:49:38.737275 | controller |
2026-05-20 19:49:38.737363 | controller | TASK [vexxhost.atmosphere.keycloak : Create Keycloak database] *****************
2026-05-20 19:49:38.737456 | controller | Wednesday 20 May 2026  19:49:38 +0000 (0:00:00.459)       0:06:18.090 *********
2026-05-20 19:49:39.230923 | controller | changed: [controller]
2026-05-20 19:49:39.231009 | controller |
2026-05-20 19:49:39.231456 | controller | TASK [vexxhost.atmosphere.keycloak : Create a Keycloak user] *******************
2026-05-20 19:49:39.231585 | controller | Wednesday 20 May 2026  19:49:39 +0000 (0:00:00.493)       0:06:18.583 *********
2026-05-20 19:49:39.776428 | controller | changed: [controller]
2026-05-20 19:49:39.776494 | controller |
2026-05-20 19:49:39.776774 | controller | TASK [vexxhost.atmosphere.keycloak : Disable pxc strict mode] ******************
2026-05-20 19:49:39.776961 | controller | Wednesday 20 May 2026  19:49:39 +0000 (0:00:00.544)       0:06:19.128 *********
2026-05-20 19:49:40.198694 | controller | ok: [controller]
2026-05-20 19:49:40.198914 | controller |
2026-05-20 19:49:40.199140 | controller | TASK [vexxhost.atmosphere.keycloak : Deploy Helm chart] ************************
2026-05-20 19:49:40.199352 | controller | Wednesday 20 May 2026  19:49:40 +0000 (0:00:00.423)       0:06:19.551 *********
2026-05-20 19:52:13.828990 | controller | changed: [controller]
2026-05-20 19:52:13.829057 | controller |
2026-05-20 19:52:13.829200 | controller | TASK [vexxhost.atmosphere.keycloak : Wait until keycloak ready] ****************
2026-05-20 19:52:13.829412 | controller | Wednesday 20 May 2026  19:52:13 +0000 (0:02:33.630)       0:08:53.181 *********
2026-05-20 19:52:14.739196 | controller | ok: [controller]
2026-05-20 19:52:14.739248 | controller |
2026-05-20 19:52:14.739255 | controller | TASK [Create Keycloak Ingress] *************************************************
2026-05-20 19:52:14.739261 | controller | Wednesday 20 May 2026  19:52:14 +0000 (0:00:00.909)       0:08:54.090 *********
2026-05-20 19:52:14.783294 | controller | included: ingress for controller
2026-05-20 19:52:14.783466 | controller |
2026-05-20 19:52:14.783683 | controller | TASK [vexxhost.atmosphere.ingress : Create Ingress keycloak] *******************
2026-05-20 19:52:14.783927 | controller | Wednesday 20 May 2026  19:52:14 +0000 (0:00:00.045)       0:08:54.136 *********
2026-05-20 19:52:15.765658 | controller | changed: [controller]
2026-05-20 19:52:15.765724 | controller |
2026-05-20 19:52:15.765739 | controller | TASK [vexxhost.atmosphere.keycloak : Enable pxc strict mode] *******************
2026-05-20 19:52:15.765752 | controller | Wednesday 20 May 2026  19:52:15 +0000 (0:00:00.981)       0:08:55.117 *********
2026-05-20 19:52:16.103109 | controller | ok: [controller]
2026-05-20 19:52:16.103183 | controller |
2026-05-20 19:52:16.103331 | controller | TASK [vexxhost.atmosphere.openstacksdk : Install openstacksdk] *****************
2026-05-20 19:52:16.103464 | controller | Wednesday 20 May 2026  19:52:16 +0000 (0:00:00.338)       0:08:55.456 *********
2026-05-20 19:52:17.183914 | controller | ok: [controller]
2026-05-20 19:52:17.183990 | controller |
2026-05-20 19:52:17.184001 | controller | TASK [vexxhost.atmosphere.openstacksdk : Create openstack config directory] ****
2026-05-20 19:52:17.184011 | controller | Wednesday 20 May 2026  19:52:17 +0000 (0:00:01.078)       0:08:56.534 *********
2026-05-20 19:52:17.441241 | controller | changed: [controller]
2026-05-20 19:52:17.441318 | controller |
2026-05-20 19:52:17.441333 | controller | TASK [vexxhost.atmosphere.openstacksdk : Generate cloud config file] ***********
2026-05-20 19:52:17.441449 | controller | Wednesday 20 May 2026  19:52:17 +0000 (0:00:00.259)       0:08:56.793 *********
2026-05-20 19:52:18.048010 | controller | changed: [controller]
2026-05-20 19:52:18.048063 | controller |
2026-05-20 19:52:18.048181 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Retrieve list of all the needed endpoints] ***
2026-05-20 19:52:18.048277 | controller | Wednesday 20 May 2026  19:52:18 +0000 (0:00:00.607)       0:08:57.401 *********
2026-05-20 19:52:18.115875 | controller | ok: [controller]
2026-05-20 19:52:18.116180 | controller |
2026-05-20 19:52:18.116420 | controller | TASK [Create RabbitMQ cluster] *************************************************
2026-05-20 19:52:18.116638 | controller | Wednesday 20 May 2026  19:52:18 +0000 (0:00:00.066)       0:08:57.467 *********
2026-05-20 19:52:18.168655 | controller | included: rabbitmq for controller
2026-05-20 19:52:18.168763 | controller |
2026-05-20 19:52:18.169075 | controller | TASK [vexxhost.atmosphere.rabbitmq : Verify state of current RabbitMQ cluster] ***
2026-05-20 19:52:18.169270 | controller | Wednesday 20 May 2026  19:52:18 +0000 (0:00:00.053)       0:08:57.521 *********
2026-05-20 19:52:19.019552 | controller | ok: [controller]
2026-05-20 19:52:19.019714 | controller |
2026-05-20 19:52:19.019980 | controller | TASK [vexxhost.atmosphere.rabbitmq : Print diff of RabbitMQ cluster spec] ******
2026-05-20 19:52:19.020225 | controller | Wednesday 20 May 2026  19:52:19 +0000 (0:00:00.849)       0:08:58.371 *********
2026-05-20 19:52:19.056423 | controller | skipping: [controller]
2026-05-20 19:52:19.056593 | controller |
2026-05-20 19:52:19.056847 | controller | TASK [vexxhost.atmosphere.rabbitmq : Wait for confirmation of RabbitMQ cluster spec] ***
2026-05-20 19:52:19.057071 | controller | Wednesday 20 May 2026  19:52:19 +0000 (0:00:00.037)       0:08:58.409 *********
2026-05-20 19:52:19.098280 | controller | skipping: [controller]
2026-05-20 19:52:19.098443 | controller |
2026-05-20 19:52:19.098695 | controller | TASK [vexxhost.atmosphere.rabbitmq : Enable all feature flags for upgrade] *****
2026-05-20 19:52:19.098937 | controller | Wednesday 20 May 2026  19:52:19 +0000 (0:00:00.041)       0:08:58.451 *********
2026-05-20 19:52:19.133509 | controller | skipping: [controller]
2026-05-20 19:52:19.133693 | controller |
2026-05-20 19:52:19.133970 | controller | TASK [vexxhost.atmosphere.rabbitmq : Deploy cluster] ***************************
2026-05-20 19:52:19.134177 | controller | Wednesday 20 May 2026  19:52:19 +0000 (0:00:00.035)       0:08:58.486 *********
2026-05-20 19:52:50.106879 | controller | changed: [controller]
2026-05-20 19:52:50.106949 | controller |
2026-05-20 19:52:50.106964 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Grab RabbitMQ cluster secret] ***
2026-05-20 19:52:50.106978 | controller | Wednesday 20 May 2026  19:52:50 +0000 (0:00:30.972)       0:09:29.458 *********
2026-05-20 19:52:50.915217 | controller | ok: [controller]
2026-05-20 19:52:50.915275 | controller |
2026-05-20 19:52:50.915289 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Cache fact with RabbitMQ cluster credentials] ***
2026-05-20 19:52:50.915301 | controller | Wednesday 20 May 2026  19:52:50 +0000 (0:00:00.808)       0:09:30.267 *********
2026-05-20 19:52:50.954293 | controller | ok: [controller]
2026-05-20 19:52:50.954317 | controller |
2026-05-20 19:52:50.954325 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Grab Percona XtraDB cluster secret] ***
2026-05-20 19:52:50.954332 | controller | Wednesday 20 May 2026  19:52:50 +0000 (0:00:00.039)       0:09:30.307 *********
2026-05-20 19:52:50.996939 | controller | skipping: [controller]
2026-05-20 19:52:50.996979 | controller |
2026-05-20 19:52:50.996992 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Cache fact with Percona XtraDB password] ***
2026-05-20 19:52:50.997115 | controller | Wednesday 20 May 2026  19:52:50 +0000 (0:00:00.042)       0:09:30.349 *********
2026-05-20 19:52:51.036654 | controller | skipping: [controller]
2026-05-20 19:52:51.036893 | controller |
2026-05-20 19:52:51.037159 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Reset value for OpenStack_Helm endpoints] ***
2026-05-20 19:52:51.037364 | controller | Wednesday 20 May 2026  19:52:51 +0000 (0:00:00.040)       0:09:30.389 *********
2026-05-20 19:52:51.070968 | controller | ok: [controller]
2026-05-20 19:52:51.071203 | controller |
2026-05-20 19:52:51.071447 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Generate OpenStack-Helm endpoints] ***
2026-05-20 19:52:51.071671 | controller | Wednesday 20 May 2026  19:52:51 +0000 (0:00:00.034)       0:09:30.424 *********
2026-05-20 19:52:51.140521 | controller | ok: [controller] => (item=oslo_db)
2026-05-20 19:52:51.140653 | controller | ok: [controller] => (item=oslo_cache)
2026-05-20 19:52:51.140851 | controller | ok: [controller] => (item=oslo_messaging)
2026-05-20 19:52:51.140927 | controller | ok: [controller] => (item=identity)
2026-05-20 19:52:51.141061 | controller |
2026-05-20 19:52:51.141389 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Clean-up facts] ***********
2026-05-20 19:52:51.141443 | controller | Wednesday 20 May 2026  19:52:51 +0000 (0:00:00.069)       0:09:30.493 *********
2026-05-20 19:52:51.181761 | controller | ok: [controller]
2026-05-20 19:52:51.181864 | controller |
2026-05-20 19:52:51.181980 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-20 19:52:51.182071 | controller | Wednesday 20 May 2026  19:52:51 +0000 (0:00:00.041)       0:09:30.534 *********
2026-05-20 19:52:51.218404 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-05-20 19:52:51.218468 | controller |
2026-05-20 19:52:51.218625 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-05-20 19:52:51.218755 | controller | Wednesday 20 May 2026  19:52:51 +0000 (0:00:00.036)       0:09:30.571 *********
2026-05-20 19:52:51.776499 | controller | changed: [controller]
2026-05-20 19:52:51.776565 | controller |
2026-05-20 19:52:51.776773 | controller | TASK [vexxhost.atmosphere.keystone : Create Keycloak realms] *******************
2026-05-20 19:52:51.776932 | controller | Wednesday 20 May 2026  19:52:51 +0000 (0:00:00.557)       0:09:31.129 *********
2026-05-20 19:52:59.438006 | controller | ok: [controller] => (item=None)
2026-05-20 19:52:59.438995 | controller | ok: [controller]
2026-05-20 19:52:59.439375 | controller |
2026-05-20 19:52:59.439711 | controller | TASK [vexxhost.atmosphere.keystone : Setup Keycloak Authentication Required Actions (MFA)] ***
2026-05-20 19:52:59.440061 | controller | Wednesday 20 May 2026  19:52:59 +0000 (0:00:07.660)       0:09:38.789 *********
2026-05-20 19:53:00.573754 | controller | ok: [controller] => (item=atmosphere)
2026-05-20 19:53:00.573842 | controller |
2026-05-20 19:53:00.573860 | controller | TASK [vexxhost.atmosphere.keystone : Create ConfigMap with all OpenID connect configurations] ***
2026-05-20 19:53:00.573872 | controller | Wednesday 20 May 2026  19:53:00 +0000 (0:00:01.136)       0:09:39.926 *********
2026-05-20 19:53:01.604286 | controller | changed: [controller]
2026-05-20 19:53:01.604349 | controller |
2026-05-20 19:53:01.604363 | controller | TASK [vexxhost.atmosphere.keystone : Create Keycloak clients] ******************
2026-05-20 19:53:01.604375 | controller | Wednesday 20 May 2026  19:53:01 +0000 (0:00:01.030)       0:09:40.956 *********
2026-05-20 19:53:03.137942 | controller | changed: [controller] => (item=None)
2026-05-20 19:53:03.138057 | controller | changed: [controller]
2026-05-20 19:53:03.138073 | controller |
2026-05-20 19:53:03.138096 | controller | TASK [vexxhost.atmosphere.keystone : Assign realm-management roles to service account] ***
2026-05-20 19:53:03.138338 | controller | Wednesday 20 May 2026  19:53:03 +0000 (0:00:01.532)       0:09:42.489 *********
2026-05-20 19:53:04.898224 | controller | changed: [controller] => (item=None)
2026-05-20 19:53:04.898352 | controller | changed: [controller]
2026-05-20 19:53:04.898591 | controller |
2026-05-20 19:53:04.898845 | controller | TASK [vexxhost.atmosphere.keystone : Deploy Helm chart] ************************
2026-05-20 19:53:04.899148 | controller | Wednesday 20 May 2026  19:53:04 +0000 (0:00:01.761)       0:09:44.250 *********
2026-05-20 19:55:49.777109 | controller | changed: [controller]
2026-05-20 19:55:49.777209 | controller |
2026-05-20 19:55:49.777405 | controller | TASK [Create Ingress] **********************************************************
2026-05-20 19:55:49.777625 | controller | Wednesday 20 May 2026  19:55:49 +0000 (0:02:44.878)       0:12:29.129 *********
2026-05-20 19:55:49.843093 | controller | included: openstack_helm_ingress for controller
2026-05-20 19:55:49.843289 | controller |
2026-05-20 19:55:49.843490 | controller | TASK [vexxhost.atmosphere.openstack_helm_ingress : Create certificate] *********
2026-05-20 19:55:49.843732 | controller | Wednesday 20 May 2026  19:55:49 +0000 (0:00:00.066)       0:12:29.196 *********
2026-05-20 19:55:49.889759 | controller | skipping: [controller]
2026-05-20 19:55:49.889907 | controller |
2026-05-20 19:55:49.890171 | controller | TASK [vexxhost.atmosphere.openstack_helm_ingress : Set fact with wildcard certificate] ***
2026-05-20 19:55:49.890358 | controller | Wednesday 20 May 2026  19:55:49 +0000 (0:00:00.046)       0:12:29.242 *********
2026-05-20 19:55:49.932841 | controller | skipping: [controller]
2026-05-20 19:55:49.933053 | controller |
2026-05-20 19:55:49.933295 | controller | TASK [vexxhost.atmosphere.openstack_helm_ingress : Add ClusterIssuer annotations] ***
2026-05-20 19:55:49.933520 | controller | Wednesday 20 May 2026  19:55:49 +0000 (0:00:00.043)       0:12:29.285 *********
2026-05-20 19:55:49.998844 | controller | ok: [controller]
2026-05-20 19:55:49.998887 | controller |
2026-05-20 19:55:49.998891 | controller | TASK [Create Ingress identity] *************************************************
2026-05-20 19:55:49.998896 | controller | Wednesday 20 May 2026  19:55:49 +0000 (0:00:00.064)       0:12:29.350 *********
2026-05-20 19:55:50.046895 | controller | included: ingress for controller
2026-05-20 19:55:50.047097 | controller |
2026-05-20 19:55:50.047319 | controller | TASK [vexxhost.atmosphere.ingress : Create Ingress identity] *******************
2026-05-20 19:55:50.047524 | controller | Wednesday 20 May 2026  19:55:50 +0000 (0:00:00.049)       0:12:29.400 *********
2026-05-20 19:55:51.056331 | controller | changed: [controller]
2026-05-20 19:55:51.056478 | controller |
2026-05-20 19:55:51.056495 | controller | TASK [vexxhost.atmosphere.keystone : Validate if ingress is reachable] *********
2026-05-20 19:55:51.056612 | controller | Wednesday 20 May 2026  19:55:51 +0000 (0:00:01.006)       0:12:30.406 *********
2026-05-20 19:55:54.440146 | controller | FAILED - RETRYING: [controller]: Validate if ingress is reachable (120 retries left).
2026-05-20 19:55:54.440212 | controller | FAILED - RETRYING: [controller]: Validate if ingress is reachable (119 retries left).
2026-05-20 19:55:54.440313 | controller | ok: [controller]
2026-05-20 19:55:54.440401 | controller |
2026-05-20 19:55:54.440511 | controller | TASK [vexxhost.atmosphere.keystone : Wait until identity service ready] ********
2026-05-20 19:55:54.440610 | controller | Wednesday 20 May 2026  19:55:54 +0000 (0:00:03.386)       0:12:33.793 *********
2026-05-20 19:55:55.277490 | controller | ok: [controller]
2026-05-20 19:55:55.277613 | controller |
2026-05-20 19:55:55.277879 | controller | TASK [vexxhost.atmosphere.keystone : Create Keystone domains] ******************
2026-05-20 19:55:55.278089 | controller | Wednesday 20 May 2026  19:55:55 +0000 (0:00:00.837)       0:12:34.630 *********
2026-05-20 19:55:56.447684 | controller | ok: [controller] => (item=atmosphere)
2026-05-20 19:55:56.447834 | controller |
2026-05-20 19:55:56.448110 | controller | TASK [vexxhost.atmosphere.keystone : Create Keystone identity providers] *******
2026-05-20 19:55:56.448325 | controller | Wednesday 20 May 2026  19:55:56 +0000 (0:00:01.170)       0:12:35.800 *********
2026-05-20 19:55:57.697712 | controller | changed: [controller] => (item=atmosphere)
2026-05-20 19:55:57.697901 | controller |
2026-05-20 19:55:57.698112 | controller | TASK [vexxhost.atmosphere.keystone : Create Keystone federation mappings] ******
2026-05-20 19:55:57.698324 | controller | Wednesday 20 May 2026  19:55:57 +0000 (0:00:01.249)       0:12:37.049 *********
2026-05-20 19:55:58.772753 | controller | changed: [controller] => (item=atmosphere)
2026-05-20 19:55:58.772856 | controller |
2026-05-20 19:55:58.772874 | controller | TASK [vexxhost.atmosphere.keystone : Create Keystone federation protocols] *****
2026-05-20 19:55:58.772886 | controller | Wednesday 20 May 2026  19:55:58 +0000 (0:00:01.075)       0:12:38.125 *********
2026-05-20 19:55:59.885442 | controller | changed: [controller] => (item=atmosphere)
2026-05-20 19:55:59.885501 | controller |
2026-05-20 19:55:59.885515 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Retrieve list of all the needed endpoints] ***
2026-05-20 19:55:59.885528 | controller | Wednesday 20 May 2026  19:55:59 +0000 (0:00:01.111)       0:12:39.236 *********
2026-05-20 19:55:59.949391 | controller | ok: [controller]
2026-05-20 19:55:59.949471 | controller |
2026-05-20 19:55:59.949611 | controller | TASK [Create RabbitMQ cluster] *************************************************
2026-05-20 19:55:59.951427 | controller | Wednesday 20 May 2026  19:55:59 +0000 (0:00:00.065)       0:12:39.301 *********
2026-05-20 19:55:59.998405 | controller | included: rabbitmq for controller
2026-05-20 19:55:59.998580 | controller |
2026-05-20 19:55:59.998843 | controller | TASK [vexxhost.atmosphere.rabbitmq : Verify state of current RabbitMQ cluster] ***
2026-05-20 19:55:59.999049 | controller | Wednesday 20 May 2026  19:55:59 +0000 (0:00:00.049)       0:12:39.351 *********
2026-05-20 19:56:00.816501 | controller | ok: [controller]
2026-05-20 19:56:00.816661 | controller |
2026-05-20 19:56:00.816930 | controller | TASK [vexxhost.atmosphere.rabbitmq : Print diff of RabbitMQ cluster spec] ******
2026-05-20 19:56:00.817144 | controller | Wednesday 20 May 2026  19:56:00 +0000 (0:00:00.817)       0:12:40.169 *********
2026-05-20 19:56:00.856835 | controller | skipping: [controller]
2026-05-20 19:56:00.856958 | controller |
2026-05-20 19:56:00.857204 | controller | TASK [vexxhost.atmosphere.rabbitmq : Wait for confirmation of RabbitMQ cluster spec] ***
2026-05-20 19:56:00.857414 | controller | Wednesday 20 May 2026  19:56:00 +0000 (0:00:00.040)       0:12:40.209 *********
2026-05-20 19:56:00.891981 | controller | skipping: [controller]
2026-05-20 19:56:00.892067 | controller |
2026-05-20 19:56:00.892089 | controller | TASK [vexxhost.atmosphere.rabbitmq : Enable all feature flags for upgrade] *****
2026-05-20 19:56:00.892205 | controller | Wednesday 20 May 2026  19:56:00 +0000 (0:00:00.035)       0:12:40.244 *********
2026-05-20 19:56:00.928611 | controller | skipping: [controller]
2026-05-20 19:56:00.928689 | controller |
2026-05-20 19:56:00.928830 | controller | TASK [vexxhost.atmosphere.rabbitmq : Deploy cluster] ***************************
2026-05-20 19:56:00.928926 | controller | Wednesday 20 May 2026  19:56:00 +0000 (0:00:00.036)       0:12:40.281 *********
2026-05-20 19:56:31.889897 | controller | changed: [controller]
2026-05-20 19:56:31.890116 | controller |
2026-05-20 19:56:31.890359 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Grab RabbitMQ cluster secret] ***
2026-05-20 19:56:31.890596 | controller | Wednesday 20 May 2026  19:56:31 +0000 (0:00:30.960)       0:13:11.242 *********
2026-05-20 19:56:32.676343 | controller | ok: [controller]
2026-05-20 19:56:32.676439 | controller |
2026-05-20 19:56:32.676607 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Cache fact with RabbitMQ cluster credentials] ***
2026-05-20 19:56:32.676758 | controller | Wednesday 20 May 2026  19:56:32 +0000 (0:00:00.786)       0:13:12.029 *********
2026-05-20 19:56:32.719967 | controller | ok: [controller]
2026-05-20 19:56:32.720155 | controller |
2026-05-20 19:56:32.720408 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Grab Percona XtraDB cluster secret] ***
2026-05-20 19:56:32.720625 | controller | Wednesday 20 May 2026  19:56:32 +0000 (0:00:00.044)       0:13:12.073 *********
2026-05-20 19:56:32.759321 | controller | skipping: [controller]
2026-05-20 19:56:32.759432 | controller |
2026-05-20 19:56:32.759585 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Cache fact with Percona XtraDB password] ***
2026-05-20 19:56:32.759717 | controller | Wednesday 20 May 2026  19:56:32 +0000 (0:00:00.039)       0:13:12.112 *********
2026-05-20 19:56:32.800276 | controller | skipping: [controller]
2026-05-20 19:56:32.800449 | controller |
2026-05-20 19:56:32.800674 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Reset value for OpenStack_Helm endpoints] ***
2026-05-20 19:56:32.800961 | controller | Wednesday 20 May 2026  19:56:32 +0000 (0:00:00.040)       0:13:12.153 *********
2026-05-20 19:56:32.839089 | controller | ok: [controller]
2026-05-20 19:56:32.839263 | controller |
2026-05-20 19:56:32.839482 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Generate OpenStack-Helm endpoints] ***
2026-05-20 19:56:32.839685 | controller | Wednesday 20 May 2026  19:56:32 +0000 (0:00:00.038)       0:13:12.192 *********
2026-05-20 19:56:32.934505 | controller | ok: [controller] => (item=oslo_cache)
2026-05-20 19:56:32.934697 | controller | ok: [controller] => (item=oslo_messaging)
2026-05-20 19:56:32.934940 | controller | ok: [controller] => (item=image)
2026-05-20 19:56:32.935143 | controller | ok: [controller] => (item=identity)
2026-05-20 19:56:32.935378 | controller | ok: [controller] => (item=oslo_db)
2026-05-20 19:56:32.935578 | controller | ok: [controller] => (item=dashboard)
2026-05-20 19:56:32.935748 | controller |
2026-05-20 19:56:32.936005 | controller | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Clean-up facts] ***********
2026-05-20 19:56:32.936214 | controller | Wednesday 20 May 2026  19:56:32 +0000 (0:00:00.095)       0:13:12.287 *********
2026-05-20 19:56:32.978920 | controller | ok: [controller]
2026-05-20 19:56:32.979097 | controller |
2026-05-20 19:56:32.979316 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-20 19:56:32.979517 | controller | Wednesday 20 May 2026  19:56:32 +0000 (0:00:00.044)       0:13:12.331 *********
2026-05-20 19:56:33.016520 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-05-20 19:56:33.016688 | controller |
2026-05-20 19:56:33.016933 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-05-20 19:56:33.017139 | controller | Wednesday 20 May 2026  19:56:33 +0000 (0:00:00.037)       0:13:12.369 *********
2026-05-20 19:56:33.575556 | controller | changed: [controller]
2026-05-20 19:56:33.575757 | controller |
2026-05-20 19:56:33.576085 | controller | TASK [vexxhost.atmosphere.glance : Generate Helm values (storage)] *************
2026-05-20 19:56:33.576360 | controller | Wednesday 20 May 2026  19:56:33 +0000 (0:00:00.558)       0:13:12.928 *********
2026-05-20 19:56:33.830458 | controller | ok: [controller]
2026-05-20 19:56:33.830526 | controller |
2026-05-20 19:56:33.830829 | controller | TASK [vexxhost.atmosphere.glance : Deploy Helm chart] **************************
2026-05-20 19:56:33.831065 | controller | Wednesday 20 May 2026  19:56:33 +0000 (0:00:00.255)       0:13:13.183 *********
2026-05-20 19:58:44.223235 | controller | changed: [controller]
2026-05-20 19:58:44.223414 | controller |
2026-05-20 19:58:44.223637 | controller | TASK [Create Ingress] **********************************************************
2026-05-20 19:58:44.223889 | controller | Wednesday 20 May 2026  19:58:44 +0000 (0:02:10.392)       0:15:23.575 *********
2026-05-20 19:58:44.280071 | controller | included: openstack_helm_ingress for controller
2026-05-20 19:58:44.280264 | controller |
2026-05-20 19:58:44.280509 | controller | TASK [vexxhost.atmosphere.openstack_helm_ingress : Create certificate] *********
2026-05-20 19:58:44.280722 | controller | Wednesday 20 May 2026  19:58:44 +0000 (0:00:00.057)       0:15:23.633 *********
2026-05-20 19:58:44.320926 | controller | skipping: [controller]
2026-05-20 19:58:44.321050 | controller |
2026-05-20 19:58:44.321196 | controller | TASK [vexxhost.atmosphere.openstack_helm_ingress : Set fact with wildcard certificate] ***
2026-05-20 19:58:44.321344 | controller | Wednesday 20 May 2026  19:58:44 +0000 (0:00:00.040)       0:15:23.674 *********
2026-05-20 19:58:44.361121 | controller | skipping: [controller]
2026-05-20 19:58:44.361278 | controller |
2026-05-20 19:58:44.361502 | controller | TASK [vexxhost.atmosphere.openstack_helm_ingress : Add ClusterIssuer annotations] ***
2026-05-20 19:58:44.361709 | controller | Wednesday 20 May 2026  19:58:44 +0000 (0:00:00.039)       0:15:23.714 *********
2026-05-20 19:58:44.409121 | controller | ok: [controller]
2026-05-20 19:58:44.409296 | controller |
2026-05-20 19:58:44.409505 | controller | TASK [Create Ingress image] ****************************************************
2026-05-20 19:58:44.409714 | controller | Wednesday 20 May 2026  19:58:44 +0000 (0:00:00.047)       0:15:23.762 *********
2026-05-20 19:58:44.454409 | controller | included: ingress for controller
2026-05-20 19:58:44.454582 | controller |
2026-05-20 19:58:44.454829 | controller | TASK [vexxhost.atmosphere.ingress : Create Ingress image] **********************
2026-05-20 19:58:44.455067 | controller | Wednesday 20 May 2026  19:58:44 +0000 (0:00:00.045)       0:15:23.807 *********
2026-05-20 19:58:45.500093 | controller | changed: [controller]
2026-05-20 19:58:45.500187 | controller |
2026-05-20 19:58:45.500202 | controller | TASK [Create images] ***********************************************************
2026-05-20 19:58:45.500319 | controller | Wednesday 20 May 2026  19:58:45 +0000 (0:00:01.045)       0:15:24.853 *********
2026-05-20 19:58:45.542526 | controller | skipping: [controller]
2026-05-20 19:58:45.542633 | controller |
2026-05-20 19:58:45.542643 | controller | PLAY [Prepare local image source] **********************************************
2026-05-20 19:58:45.542719 | controller |
2026-05-20 19:58:45.542815 | controller | TASK [Gathering Facts] *********************************************************
2026-05-20 19:58:45.542954 | controller | Wednesday 20 May 2026  19:58:45 +0000 (0:00:00.041)       0:15:24.894 *********
2026-05-20 19:58:47.111556 | controller | ok: [controller]
2026-05-20 19:58:47.111737 | controller |
2026-05-20 19:58:47.112053 | controller | TASK [Create image source directory] *******************************************
2026-05-20 19:58:47.112285 | controller | Wednesday 20 May 2026  19:58:47 +0000 (0:00:01.569)       0:15:26.464 *********
2026-05-20 19:58:47.351104 | controller | changed: [controller]
2026-05-20 19:58:47.351163 | controller |
2026-05-20 19:58:47.351323 | controller | TASK [Create raw test image] ***************************************************
2026-05-20 19:58:47.351459 | controller | Wednesday 20 May 2026  19:58:47 +0000 (0:00:00.239)       0:15:26.704 *********
2026-05-20 19:58:47.619868 | controller | changed: [controller]
2026-05-20 19:58:47.620058 | controller |
2026-05-20 19:58:47.620272 | controller | TASK [Write initial image ETag] ************************************************
2026-05-20 19:58:47.620481 | controller | Wednesday 20 May 2026  19:58:47 +0000 (0:00:00.268)       0:15:26.972 *********
2026-05-20 19:58:48.173030 | controller | changed: [controller]
2026-05-20 19:58:48.173087 | controller |
2026-05-20 19:58:48.173101 | controller | TASK [Copy ETag-aware image server] ********************************************
2026-05-20 19:58:48.173114 | controller | Wednesday 20 May 2026  19:58:48 +0000 (0:00:00.552)       0:15:27.525 *********
2026-05-20 19:58:48.749479 | controller | changed: [controller]
2026-05-20 19:58:48.749849 | controller |
2026-05-20 19:58:48.749863 | controller | TASK [Check if image source is already listening] ******************************
2026-05-20 19:58:48.749947 | controller | Wednesday 20 May 2026  19:58:48 +0000 (0:00:00.576)       0:15:28.101 *********
2026-05-20 19:58:49.181327 | controller | ok: [controller]
2026-05-20 19:58:49.182139 | controller |
2026-05-20 19:58:49.182163 | controller | TASK [Start ETag-aware image server] *******************************************
2026-05-20 19:58:49.182174 | controller | Wednesday 20 May 2026  19:58:49 +0000 (0:00:00.432)       0:15:28.534 *********
2026-05-20 19:58:49.724636 | controller | ok: [controller]
2026-05-20 19:58:49.724691 | controller |
2026-05-20 19:58:49.724705 | controller | TASK [Wait for image source to answer HEAD requests] ***************************
2026-05-20 19:58:49.724717 | controller | Wednesday 20 May 2026  19:58:49 +0000 (0:00:00.540)       0:15:29.075 *********
2026-05-20 19:58:50.140840 | controller | ok: [controller]
2026-05-20 19:58:50.140885 | controller |
2026-05-20 19:58:50.140891 | controller | PLAY RECAP *********************************************************************
2026-05-20 19:58:50.140898 | controller | controller                 : ok=237  changed=104  unreachable=0    failed=0    skipped=96   rescued=0    ignored=2
2026-05-20 19:58:50.140903 | controller |
2026-05-20 19:58:50.140908 | controller | Wednesday 20 May 2026  19:58:50 +0000 (0:00:00.412)       0:15:29.488 *********
2026-05-20 19:58:50.140913 | controller | ===============================================================================
2026-05-20 19:58:50.140918 | controller | vexxhost.atmosphere.keystone : Deploy Helm chart ---------------------- 164.88s
2026-05-20 19:58:50.140923 | controller | vexxhost.atmosphere.keycloak : Deploy Helm chart ---------------------- 153.63s
2026-05-20 19:58:50.140928 | controller | vexxhost.atmosphere.glance : Deploy Helm chart ------------------------ 130.39s
2026-05-20 19:58:50.140933 | controller | vexxhost.atmosphere.percona_xtradb_cluster : Apply Percona XtraDB cluster - 126.34s
2026-05-20 19:58:50.140938 | controller | vexxhost.atmosphere.rabbitmq : Deploy cluster -------------------------- 30.97s
2026-05-20 19:58:50.140943 | controller | vexxhost.atmosphere.rabbitmq : Deploy cluster -------------------------- 30.96s
2026-05-20 19:58:50.140948 | controller | vexxhost.kubernetes.envoy_gateway : Deploy Helm chart ------------------ 30.17s
2026-05-20 19:58:50.140952 | controller | vexxhost.kubernetes.kubernetes : Initialize cluster -------------------- 26.00s
2026-05-20 19:58:50.140957 | controller | vexxhost.kubernetes.cert_manager : Deploy Helm chart ------------------- 17.85s
2026-05-20 19:58:50.140962 | controller | vexxhost.atmosphere.ingress_nginx : Deploy Helm chart ------------------ 14.84s
2026-05-20 19:58:50.140967 | controller | Install Debian packages ------------------------------------------------ 11.99s
2026-05-20 19:58:50.140972 | controller | vexxhost.atmosphere.cluster_issuer : Rehash CA certificates ------------ 10.17s
2026-05-20 19:58:50.140977 | controller | vexxhost.containers.containerd : Install AppArmor packages -------------- 8.47s
2026-05-20 19:58:50.140982 | controller | vexxhost.atmosphere.keystone : Create Keycloak realms ------------------- 7.66s
2026-05-20 19:58:50.141001 | controller | Install Python packages used by the test -------------------------------- 7.21s
2026-05-20 19:58:50.141005 | controller | vexxhost.kubernetes.kubernetes : Install Kubernetes Python package using package manager on supported systems --- 6.79s
2026-05-20 19:58:50.141009 | controller | vexxhost.kubernetes.kubelet : Install additional packages --------------- 4.57s
2026-05-20 19:58:50.141013 | controller | vexxhost.atmosphere.rabbitmq_cluster_operator : Deploy Helm chart ------- 3.64s
2026-05-20 19:58:50.141016 | controller | vexxhost.atmosphere.keystone : Validate if ingress is reachable --------- 3.39s
2026-05-20 19:58:50.141020 | controller | vexxhost.atmosphere.rabbitmq_cluster_operator : Install all CRDs -------- 3.12s
2026-05-20 19:58:50.290832 | controller | INFO     [glance-image > prepare] Executed: Successful
2026-05-20 19:58:50.296924 | controller | INFO     [glance-image > converge] Executing
2026-05-20 19:58:51.061251 | controller |
2026-05-20 19:58:51.061412 | controller | PLAY [Manage OpenStack Glance image] *******************************************
2026-05-20 19:58:51.061529 | controller |
2026-05-20 19:58:51.061653 | controller | TASK [Gathering Facts] *********************************************************
2026-05-20 19:58:51.061777 | controller | Wednesday 20 May 2026  19:58:51 +0000 (0:00:00.015)       0:00:00.015 *********
2026-05-20 19:58:53.720722 | controller | [WARNING]: Platform linux on host controller is using the discovered Python
2026-05-20 19:58:53.723274 | controller | interpreter at /usr/bin/python3.12, but future installation of another Python
2026-05-20 19:58:53.723287 | controller | interpreter could change the meaning of that path. See
2026-05-20 19:58:53.723291 | controller | https://docs.ansible.com/ansible-
2026-05-20 19:58:53.723295 | controller | core/2.18/reference_appendices/interpreter_discovery.html for more information.
2026-05-20 19:58:53.729997 | controller | ok: [controller]
2026-05-20 19:58:53.730123 | controller |
2026-05-20 19:58:53.730252 | controller | TASK [atmosphere.common.glance_image : Fetch source image metadata from URL] ***
2026-05-20 19:58:53.730375 | controller | Wednesday 20 May 2026  19:58:53 +0000 (0:00:02.668)       0:00:02.684 *********
2026-05-20 19:58:54.224624 | controller | ok: [controller]
2026-05-20 19:58:54.227143 | controller |
2026-05-20 19:58:54.227157 | controller | TASK [atmosphere.common.glance_image : Capture source ETag when available] *****
2026-05-20 19:58:54.227164 | controller | Wednesday 20 May 2026  19:58:54 +0000 (0:00:00.494)       0:00:03.179 *********
2026-05-20 19:58:54.254957 | controller | ok: [controller]
2026-05-20 19:58:54.255099 | controller |
2026-05-20 19:58:54.255230 | controller | TASK [atmosphere.common.glance_image : Check if image exists] ******************
2026-05-20 19:58:54.255357 | controller | Wednesday 20 May 2026  19:58:54 +0000 (0:00:00.030)       0:00:03.209 *********
2026-05-20 19:58:57.770751 | controller | FAILED - RETRYING: [controller]: Check if image exists (120 retries left).
2026-05-20 19:58:57.771214 | controller | ok: [controller]
2026-05-20 19:58:57.772337 | controller |
2026-05-20 19:58:57.772607 | controller | TASK [atmosphere.common.glance_image : Capture existing image and its Atmosphere metadata] ***
2026-05-20 19:58:57.772872 | controller | Wednesday 20 May 2026  19:58:57 +0000 (0:00:03.515)       0:00:06.724 *********
2026-05-20 19:58:57.811445 | controller | ok: [controller]
2026-05-20 19:58:57.811678 | controller |
2026-05-20 19:58:57.811983 | controller | TASK [atmosphere.common.glance_image : Decide whether image upload is required] ***
2026-05-20 19:58:57.812302 | controller | Wednesday 20 May 2026  19:58:57 +0000 (0:00:00.040)       0:00:06.765 *********
2026-05-20 19:58:57.851595 | controller | ok: [controller]
2026-05-20 19:58:57.851821 | controller |
2026-05-20 19:58:57.852052 | controller | TASK [atmosphere.common.glance_image : Generate temporary work directory] ******
2026-05-20 19:58:57.852257 | controller | Wednesday 20 May 2026  19:58:57 +0000 (0:00:00.040)       0:00:06.805 *********
2026-05-20 19:58:58.157432 | controller | changed: [controller]
2026-05-20 19:58:58.157648 | controller |
2026-05-20 19:58:58.158039 | controller | TASK [atmosphere.common.glance_image : Download image] *************************
2026-05-20 19:58:58.158244 | controller | Wednesday 20 May 2026  19:58:58 +0000 (0:00:00.305)       0:00:07.111 *********
2026-05-20 19:58:58.619854 | controller | changed: [controller]
2026-05-20 19:58:58.620072 | controller |
2026-05-20 19:58:58.620328 | controller | TASK [atmosphere.common.glance_image : Get image format] ***********************
2026-05-20 19:58:58.620545 | controller | Wednesday 20 May 2026  19:58:58 +0000 (0:00:00.462)       0:00:07.573 *********
2026-05-20 19:58:58.968292 | controller | ok: [controller]
2026-05-20 19:58:58.968477 | controller |
2026-05-20 19:58:58.968698 | controller | TASK [atmosphere.common.glance_image : Convert file to target disk format] *****
2026-05-20 19:58:58.968945 | controller | Wednesday 20 May 2026  19:58:58 +0000 (0:00:00.348)       0:00:07.921 *********
2026-05-20 19:58:59.008598 | controller | skipping: [controller]
2026-05-20 19:58:59.008764 | controller |
2026-05-20 19:58:59.009022 | controller | TASK [atmosphere.common.glance_image : Wait until image service ready] *********
2026-05-20 19:58:59.009227 | controller | Wednesday 20 May 2026  19:58:59 +0000 (0:00:00.039)       0:00:07.961 *********
2026-05-20 19:59:00.002745 | controller | ok: [controller]
2026-05-20 19:59:00.002778 | controller |
2026-05-20 19:59:00.002783 | controller | TASK [atmosphere.common.glance_image : Compute pending image name] *************
2026-05-20 19:59:00.002787 | controller | Wednesday 20 May 2026  19:58:59 +0000 (0:00:00.993)       0:00:08.955 *********
2026-05-20 19:59:00.036313 | controller | ok: [controller]
2026-05-20 19:59:00.036510 | controller |
2026-05-20 19:59:00.036735 | controller | TASK [atmosphere.common.glance_image : Upload image into Glance] ***************
2026-05-20 19:59:00.036986 | controller | Wednesday 20 May 2026  19:59:00 +0000 (0:00:00.035)       0:00:08.990 *********
2026-05-20 19:59:02.629707 | controller | changed: [controller]
2026-05-20 19:59:02.629934 | controller |
2026-05-20 19:59:02.630176 | controller | TASK [atmosphere.common.glance_image : Rename outdated image to preserve audit trail] ***
2026-05-20 19:59:02.630387 | controller | Wednesday 20 May 2026  19:59:02 +0000 (0:00:02.592)       0:00:11.583 *********
2026-05-20 19:59:02.662523 | controller | skipping: [controller]
2026-05-20 19:59:02.662669 | controller |
2026-05-20 19:59:02.662996 | controller | TASK [atmosphere.common.glance_image : Promote newly uploaded image to canonical name] ***
2026-05-20 19:59:02.663226 | controller | Wednesday 20 May 2026  19:59:02 +0000 (0:00:00.033)       0:00:11.616 *********
2026-05-20 19:59:02.691708 | controller | skipping: [controller]
2026-05-20 19:59:02.691908 | controller |
2026-05-20 19:59:02.692136 | controller | TASK [atmosphere.common.glance_image : Remove work directory] ******************
2026-05-20 19:59:02.692428 | controller | Wednesday 20 May 2026  19:59:02 +0000 (0:00:00.028)       0:00:11.645 *********
2026-05-20 19:59:03.040585 | controller | changed: [controller]
2026-05-20 19:59:03.040748 | controller |
2026-05-20 19:59:03.041014 | controller | PLAY RECAP *********************************************************************
2026-05-20 19:59:03.041252 | controller | controller                 : ok=13   changed=4    unreachable=0    failed=0    skipped=3    rescued=0    ignored=0
2026-05-20 19:59:03.041490 | controller |
2026-05-20 19:59:03.041718 | controller | Wednesday 20 May 2026  19:59:03 +0000 (0:00:00.349)       0:00:11.995 *********
2026-05-20 19:59:03.041976 | controller | ===============================================================================
2026-05-20 19:59:03.042186 | controller | atmosphere.common.glance_image : Check if image exists ------------------ 3.52s
2026-05-20 19:59:03.042403 | controller | Gathering Facts --------------------------------------------------------- 2.67s
2026-05-20 19:59:03.042658 | controller | atmosphere.common.glance_image : Upload image into Glance --------------- 2.59s
2026-05-20 19:59:03.042927 | controller | atmosphere.common.glance_image : Wait until image service ready --------- 0.99s
2026-05-20 19:59:03.043188 | controller | atmosphere.common.glance_image : Fetch source image metadata from URL --- 0.49s
2026-05-20 19:59:03.043410 | controller | atmosphere.common.glance_image : Download image ------------------------- 0.46s
2026-05-20 19:59:03.043654 | controller | atmosphere.common.glance_image : Remove work directory ------------------ 0.35s
2026-05-20 19:59:03.043986 | controller | atmosphere.common.glance_image : Get image format ----------------------- 0.35s
2026-05-20 19:59:03.044328 | controller | atmosphere.common.glance_image : Generate temporary work directory ------ 0.31s
2026-05-20 19:59:03.044633 | controller | atmosphere.common.glance_image : Decide whether image upload is required --- 0.04s
2026-05-20 19:59:03.044931 | controller | atmosphere.common.glance_image : Capture existing image and its Atmosphere metadata --- 0.04s
2026-05-20 19:59:03.045222 | controller | atmosphere.common.glance_image : Convert file to target disk format ----- 0.04s
2026-05-20 19:59:03.046045 | controller | atmosphere.common.glance_image : Compute pending image name ------------- 0.04s
2026-05-20 19:59:03.046063 | controller | atmosphere.common.glance_image : Rename outdated image to preserve audit trail --- 0.03s
2026-05-20 19:59:03.046073 | controller | atmosphere.common.glance_image : Capture source ETag when available ----- 0.03s
2026-05-20 19:59:03.046282 | controller | atmosphere.common.glance_image : Promote newly uploaded image to canonical name --- 0.03s
2026-05-20 19:59:03.144853 | controller | INFO     [glance-image > converge] Executed: Successful
2026-05-20 19:59:03.157923 | controller | INFO     [glance-image > idempotence] Executing
2026-05-20 19:59:03.947951 | controller |
2026-05-20 19:59:03.948015 | controller | PLAY [Manage OpenStack Glance image] *******************************************
2026-05-20 19:59:03.948028 | controller |
2026-05-20 19:59:03.948130 | controller | TASK [Gathering Facts] *********************************************************
2026-05-20 19:59:03.948333 | controller | Wednesday 20 May 2026  19:59:03 +0000 (0:00:00.017)       0:00:00.017 *********
2026-05-20 19:59:05.795259 | controller | [WARNING]: Platform linux on host controller is using the discovered Python
2026-05-20 19:59:05.795382 | controller | interpreter at /usr/bin/python3.12, but future installation of another Python
2026-05-20 19:59:05.795520 | controller | interpreter could change the meaning of that path. See
2026-05-20 19:59:05.795654 | controller | https://docs.ansible.com/ansible-
2026-05-20 19:59:05.795782 | controller | core/2.18/reference_appendices/interpreter_discovery.html for more information.
2026-05-20 19:59:05.806076 | controller | ok: [controller]
2026-05-20 19:59:05.806261 | controller |
2026-05-20 19:59:05.806479 | controller | TASK [atmosphere.common.glance_image : Fetch source image metadata from URL] ***
2026-05-20 19:59:05.806687 | controller | Wednesday 20 May 2026  19:59:05 +0000 (0:00:01.858)       0:00:01.875 *********
2026-05-20 19:59:06.366377 | controller | ok: [controller]
2026-05-20 19:59:06.366557 | controller |
2026-05-20 19:59:06.366820 | controller | TASK [atmosphere.common.glance_image : Capture source ETag when available] *****
2026-05-20 19:59:06.367050 | controller | Wednesday 20 May 2026  19:59:06 +0000 (0:00:00.560)       0:00:02.436 *********
2026-05-20 19:59:06.405274 | controller | ok: [controller]
2026-05-20 19:59:06.405455 | controller |
2026-05-20 19:59:06.405665 | controller | TASK [atmosphere.common.glance_image : Check if image exists] ******************
2026-05-20 19:59:06.405920 | controller | Wednesday 20 May 2026  19:59:06 +0000 (0:00:00.038)       0:00:02.474 *********
2026-05-20 19:59:07.730413 | controller | ok: [controller]
2026-05-20 19:59:07.730604 | controller |
2026-05-20 19:59:07.730844 | controller | TASK [atmosphere.common.glance_image : Capture existing image and its Atmosphere metadata] ***
2026-05-20 19:59:07.731085 | controller | Wednesday 20 May 2026  19:59:07 +0000 (0:00:01.325)       0:00:03.800 *********
2026-05-20 19:59:07.762704 | controller | ok: [controller]
2026-05-20 19:59:07.762831 | controller |
2026-05-20 19:59:07.762951 | controller | TASK [atmosphere.common.glance_image : Decide whether image upload is required] ***
2026-05-20 19:59:07.763075 | controller | Wednesday 20 May 2026  19:59:07 +0000 (0:00:00.032)       0:00:03.832 *********
2026-05-20 19:59:07.807830 | controller | ok: [controller]
2026-05-20 19:59:07.808071 | controller |
2026-05-20 19:59:07.808323 | controller | TASK [atmosphere.common.glance_image : Generate temporary work directory] ******
2026-05-20 19:59:07.808542 | controller | Wednesday 20 May 2026  19:59:07 +0000 (0:00:00.044)       0:00:03.876 *********
2026-05-20 19:59:07.835843 | controller | skipping: [controller]
2026-05-20 19:59:07.836073 | controller |
2026-05-20 19:59:07.836281 | controller | TASK [atmosphere.common.glance_image : Download image] *************************
2026-05-20 19:59:07.836487 | controller | Wednesday 20 May 2026  19:59:07 +0000 (0:00:00.028)       0:00:03.905 *********
2026-05-20 19:59:07.862152 | controller | skipping: [controller]
2026-05-20 19:59:07.862358 | controller |
2026-05-20 19:59:07.862570 | controller | TASK [atmosphere.common.glance_image : Get image format] ***********************
2026-05-20 19:59:07.862774 | controller | Wednesday 20 May 2026  19:59:07 +0000 (0:00:00.026)       0:00:03.931 *********
2026-05-20 19:59:07.889545 | controller | skipping: [controller]
2026-05-20 19:59:07.889721 | controller |
2026-05-20 19:59:07.890036 | controller | TASK [atmosphere.common.glance_image : Convert file to target disk format] *****
2026-05-20 19:59:07.890292 | controller | Wednesday 20 May 2026  19:59:07 +0000 (0:00:00.027)       0:00:03.959 *********
2026-05-20 19:59:07.917591 | controller | skipping: [controller]
2026-05-20 19:59:07.917784 | controller |
2026-05-20 19:59:07.918119 | controller | TASK [atmosphere.common.glance_image : Wait until image service ready] *********
2026-05-20 19:59:07.918366 | controller | Wednesday 20 May 2026  19:59:07 +0000 (0:00:00.027)       0:00:03.987 *********
2026-05-20 19:59:07.944780 | controller | skipping: [controller]
2026-05-20 19:59:07.944998 | controller |
2026-05-20 19:59:07.945211 | controller | TASK [atmosphere.common.glance_image : Compute pending image name] *************
2026-05-20 19:59:07.945413 | controller | Wednesday 20 May 2026  19:59:07 +0000 (0:00:00.027)       0:00:04.014 *********
2026-05-20 19:59:07.972738 | controller | skipping: [controller]
2026-05-20 19:59:07.972955 | controller |
2026-05-20 19:59:07.973193 | controller | TASK [atmosphere.common.glance_image : Upload image into Glance] ***************
2026-05-20 19:59:07.973377 | controller | Wednesday 20 May 2026  19:59:07 +0000 (0:00:00.027)       0:00:04.042 *********
2026-05-20 19:59:08.005286 | controller | skipping: [controller]
2026-05-20 19:59:08.005446 | controller |
2026-05-20 19:59:08.005668 | controller | TASK [atmosphere.common.glance_image : Rename outdated image to preserve audit trail] ***
2026-05-20 19:59:08.005970 | controller | Wednesday 20 May 2026  19:59:08 +0000 (0:00:00.032)       0:00:04.075 *********
2026-05-20 19:59:08.036329 | controller | skipping: [controller]
2026-05-20 19:59:08.036510 | controller |
2026-05-20 19:59:08.036726 | controller | TASK [atmosphere.common.glance_image : Promote newly uploaded image to canonical name] ***
2026-05-20 19:59:08.036974 | controller | Wednesday 20 May 2026  19:59:08 +0000 (0:00:00.031)       0:00:04.106 *********
2026-05-20 19:59:08.063350 | controller | skipping: [controller]
2026-05-20 19:59:08.063539 | controller |
2026-05-20 19:59:08.063759 | controller | TASK [atmosphere.common.glance_image : Remove work directory] ******************
2026-05-20 19:59:08.064007 | controller | Wednesday 20 May 2026  19:59:08 +0000 (0:00:00.026)       0:00:04.133 *********
2026-05-20 19:59:08.092072 | controller | skipping: [controller]
2026-05-20 19:59:08.092241 | controller |
2026-05-20 19:59:08.092436 | controller | PLAY RECAP *********************************************************************
2026-05-20 19:59:08.092656 | controller | controller                 : ok=6    changed=0    unreachable=0    failed=0    skipped=10   rescued=0    ignored=0
2026-05-20 19:59:08.092868 | controller |
2026-05-20 19:59:08.093079 | controller | Wednesday 20 May 2026  19:59:08 +0000 (0:00:00.029)       0:00:04.162 *********
2026-05-20 19:59:08.093256 | controller | ===============================================================================
2026-05-20 19:59:08.093454 | controller | Gathering Facts --------------------------------------------------------- 1.86s
2026-05-20 19:59:08.093698 | controller | atmosphere.common.glance_image : Check if image exists ------------------ 1.33s
2026-05-20 19:59:08.093974 | controller | atmosphere.common.glance_image : Fetch source image metadata from URL --- 0.56s
2026-05-20 19:59:08.094188 | controller | atmosphere.common.glance_image : Decide whether image upload is required --- 0.04s
2026-05-20 19:59:08.094396 | controller | atmosphere.common.glance_image : Capture source ETag when available ----- 0.04s
2026-05-20 19:59:08.094600 | controller | atmosphere.common.glance_image : Upload image into Glance --------------- 0.03s
2026-05-20 19:59:08.094894 | controller | atmosphere.common.glance_image : Capture existing image and its Atmosphere metadata --- 0.03s
2026-05-20 19:59:08.095046 | controller | atmosphere.common.glance_image : Rename outdated image to preserve audit trail --- 0.03s
2026-05-20 19:59:08.095572 | controller | atmosphere.common.glance_image : Remove work directory ------------------ 0.03s
2026-05-20 19:59:08.095840 | controller | atmosphere.common.glance_image : Generate temporary work directory ------ 0.03s
2026-05-20 19:59:08.096157 | controller | atmosphere.common.glance_image : Convert file to target disk format ----- 0.03s
2026-05-20 19:59:08.096423 | controller | atmosphere.common.glance_image : Compute pending image name ------------- 0.03s
2026-05-20 19:59:08.096741 | controller | atmosphere.common.glance_image : Get image format ----------------------- 0.03s
2026-05-20 19:59:08.096998 | controller | atmosphere.common.glance_image : Wait until image service ready --------- 0.03s
2026-05-20 19:59:08.097304 | controller | atmosphere.common.glance_image : Promote newly uploaded image to canonical name --- 0.03s
2026-05-20 19:59:08.097586 | controller | atmosphere.common.glance_image : Download image ------------------------- 0.03s
2026-05-20 19:59:08.165756 | controller | INFO     [glance-image > idempotence] Executed: Successful
2026-05-20 19:59:08.175202 | controller | INFO     [glance-image > side_effect] Executing
2026-05-20 19:59:08.176050 | controller | WARNING  [glance-image > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-20 19:59:08.182603 | controller | INFO     [glance-image > verify] Executing
2026-05-20 19:59:08.930174 | controller |
2026-05-20 19:59:08.930380 | controller | PLAY [Verify Glance image lifecycle] *******************************************
2026-05-20 19:59:08.930572 | controller |
2026-05-20 19:59:08.930826 | controller | TASK [Gathering Facts] *********************************************************
2026-05-20 19:59:08.931030 | controller | Wednesday 20 May 2026  19:59:08 +0000 (0:00:00.007)       0:00:00.007 *********
2026-05-20 19:59:10.795452 | controller | [WARNING]: Platform linux on host controller is using the discovered Python
2026-05-20 19:59:10.795645 | controller | interpreter at /usr/bin/python3.12, but future installation of another Python
2026-05-20 19:59:10.795883 | controller | interpreter could change the meaning of that path. See
2026-05-20 19:59:10.796079 | controller | https://docs.ansible.com/ansible-
2026-05-20 19:59:10.796291 | controller | core/2.18/reference_appendices/interpreter_discovery.html for more information.
2026-05-20 19:59:10.806019 | controller | ok: [controller]
2026-05-20 19:59:10.806082 | controller |
2026-05-20 19:59:10.806185 | controller | TASK [Get initial image] *******************************************************
2026-05-20 19:59:10.806277 | controller | Wednesday 20 May 2026  19:59:10 +0000 (0:00:01.874)       0:00:01.882 *********
2026-05-20 19:59:12.144354 | controller | ok: [controller]
2026-05-20 19:59:12.144418 | controller |
2026-05-20 19:59:12.144507 | controller | TASK [Assert initial image properties] *****************************************
2026-05-20 19:59:12.144600 | controller | Wednesday 20 May 2026  19:59:12 +0000 (0:00:01.338)       0:00:03.221 *********
2026-05-20 19:59:12.191593 | controller | ok: [controller] => {
2026-05-20 19:59:12.191857 | controller |     "changed": false,
2026-05-20 19:59:12.192091 | controller |     "msg": "All assertions passed"
2026-05-20 19:59:12.192297 | controller | }
2026-05-20 19:59:12.192576 | controller |
2026-05-20 19:59:12.192850 | controller | TASK [Run role again with unchanged ETag] **************************************
2026-05-20 19:59:12.193065 | controller | Wednesday 20 May 2026  19:59:12 +0000 (0:00:00.047)       0:00:03.268 *********
2026-05-20 19:59:12.243365 | controller | included: atmosphere.common.glance_image for controller
2026-05-20 19:59:12.243513 | controller |
2026-05-20 19:59:12.243743 | controller | TASK [atmosphere.common.glance_image : Fetch source image metadata from URL] ***
2026-05-20 19:59:12.244020 | controller | Wednesday 20 May 2026  19:59:12 +0000 (0:00:00.052)       0:00:03.320 *********
2026-05-20 19:59:12.783689 | controller | ok: [controller]
2026-05-20 19:59:12.783923 | controller |
2026-05-20 19:59:12.784142 | controller | TASK [atmosphere.common.glance_image : Capture source ETag when available] *****
2026-05-20 19:59:12.784364 | controller | Wednesday 20 May 2026  19:59:12 +0000 (0:00:00.539)       0:00:03.860 *********
2026-05-20 19:59:12.818938 | controller | ok: [controller]
2026-05-20 19:59:12.819138 | controller |
2026-05-20 19:59:12.819356 | controller | TASK [atmosphere.common.glance_image : Check if image exists] ******************
2026-05-20 19:59:12.819616 | controller | Wednesday 20 May 2026  19:59:12 +0000 (0:00:00.034)       0:00:03.895 *********
2026-05-20 19:59:13.762208 | controller | ok: [controller]
2026-05-20 19:59:13.762275 | controller |
2026-05-20 19:59:13.762373 | controller | TASK [atmosphere.common.glance_image : Capture existing image and its Atmosphere metadata] ***
2026-05-20 19:59:13.762473 | controller | Wednesday 20 May 2026  19:59:13 +0000 (0:00:00.943)       0:00:04.839 *********
2026-05-20 19:59:13.805150 | controller | ok: [controller]
2026-05-20 19:59:13.805189 | controller |
2026-05-20 19:59:13.805320 | controller | TASK [atmosphere.common.glance_image : Decide whether image upload is required] ***
2026-05-20 19:59:13.805413 | controller | Wednesday 20 May 2026  19:59:13 +0000 (0:00:00.043)       0:00:04.883 *********
2026-05-20 19:59:13.850593 | controller | ok: [controller]
2026-05-20 19:59:13.850661 | controller |
2026-05-20 19:59:13.850789 | controller | TASK [atmosphere.common.glance_image : Generate temporary work directory] ******
2026-05-20 19:59:13.850918 | controller | Wednesday 20 May 2026  19:59:13 +0000 (0:00:00.043)       0:00:04.926 *********
2026-05-20 19:59:13.872850 | controller | skipping: [controller]
2026-05-20 19:59:13.873051 | controller |
2026-05-20 19:59:13.873266 | controller | TASK [atmosphere.common.glance_image : Download image] *************************
2026-05-20 19:59:13.873472 | controller | Wednesday 20 May 2026  19:59:13 +0000 (0:00:00.023)       0:00:04.950 *********
2026-05-20 19:59:13.900187 | controller | skipping: [controller]
2026-05-20 19:59:13.900380 | controller |
2026-05-20 19:59:13.900595 | controller | TASK [atmosphere.common.glance_image : Get image format] ***********************
2026-05-20 19:59:13.900816 | controller | Wednesday 20 May 2026  19:59:13 +0000 (0:00:00.027)       0:00:04.977 *********
2026-05-20 19:59:13.928053 | controller | skipping: [controller]
2026-05-20 19:59:13.928283 | controller |
2026-05-20 19:59:13.928513 | controller | TASK [atmosphere.common.glance_image : Convert file to target disk format] *****
2026-05-20 19:59:13.928735 | controller | Wednesday 20 May 2026  19:59:13 +0000 (0:00:00.027)       0:00:05.004 *********
2026-05-20 19:59:13.958191 | controller | skipping: [controller]
2026-05-20 19:59:13.958385 | controller |
2026-05-20 19:59:13.958609 | controller | TASK [atmosphere.common.glance_image : Wait until image service ready] *********
2026-05-20 19:59:13.958824 | controller | Wednesday 20 May 2026  19:59:13 +0000 (0:00:00.030)       0:00:05.035 *********
2026-05-20 19:59:13.985151 | controller | skipping: [controller]
2026-05-20 19:59:13.985355 | controller |
2026-05-20 19:59:13.985657 | controller | TASK [atmosphere.common.glance_image : Compute pending image name] *************
2026-05-20 19:59:13.985899 | controller | Wednesday 20 May 2026  19:59:13 +0000 (0:00:00.026)       0:00:05.062 *********
2026-05-20 19:59:14.011518 | controller | skipping: [controller]
2026-05-20 19:59:14.011704 | controller |
2026-05-20 19:59:14.011982 | controller | TASK [atmosphere.common.glance_image : Upload image into Glance] ***************
2026-05-20 19:59:14.012195 | controller | Wednesday 20 May 2026  19:59:14 +0000 (0:00:00.026)       0:00:05.088 *********
2026-05-20 19:59:14.040141 | controller | skipping: [controller]
2026-05-20 19:59:14.040337 | controller |
2026-05-20 19:59:14.040596 | controller | TASK [atmosphere.common.glance_image : Rename outdated image to preserve audit trail] ***
2026-05-20 19:59:14.040830 | controller | Wednesday 20 May 2026  19:59:14 +0000 (0:00:00.028)       0:00:05.117 *********
2026-05-20 19:59:14.068585 | controller | skipping: [controller]
2026-05-20 19:59:14.068824 | controller |
2026-05-20 19:59:14.069169 | controller | TASK [atmosphere.common.glance_image : Promote newly uploaded image to canonical name] ***
2026-05-20 19:59:14.069401 | controller | Wednesday 20 May 2026  19:59:14 +0000 (0:00:00.028)       0:00:05.145 *********
2026-05-20 19:59:14.097470 | controller | skipping: [controller]
2026-05-20 19:59:14.097689 | controller |
2026-05-20 19:59:14.097955 | controller | TASK [atmosphere.common.glance_image : Remove work directory] ******************
2026-05-20 19:59:14.098175 | controller | Wednesday 20 May 2026  19:59:14 +0000 (0:00:00.028)       0:00:05.174 *********
2026-05-20 19:59:14.125016 | controller | skipping: [controller]
2026-05-20 19:59:14.125180 | controller |
2026-05-20 19:59:14.125424 | controller | TASK [Get image after unchanged ETag run] **************************************
2026-05-20 19:59:14.125637 | controller | Wednesday 20 May 2026  19:59:14 +0000 (0:00:00.028)       0:00:05.202 *********
2026-05-20 19:59:15.050995 | controller | ok: [controller]
2026-05-20 19:59:15.051193 | controller |
2026-05-20 19:59:15.051423 | controller | TASK [Assert unchanged ETag does not re-upload] ********************************
2026-05-20 19:59:15.051816 | controller | Wednesday 20 May 2026  19:59:15 +0000 (0:00:00.924)       0:00:06.127 *********
2026-05-20 19:59:15.090632 | controller | ok: [controller] => {
2026-05-20 19:59:15.090899 | controller |     "changed": false,
2026-05-20 19:59:15.091124 | controller |     "msg": "All assertions passed"
2026-05-20 19:59:15.091361 | controller | }
2026-05-20 19:59:15.091563 | controller |
2026-05-20 19:59:15.091785 | controller | TASK [Change source ETag] ******************************************************
2026-05-20 19:59:15.092841 | controller | Wednesday 20 May 2026  19:59:15 +0000 (0:00:00.040)       0:00:06.167 *********
2026-05-20 19:59:15.904572 | controller | changed: [controller]
2026-05-20 19:59:15.904763 | controller |
2026-05-20 19:59:15.905055 | controller | TASK [Run role again with changed ETag] ****************************************
2026-05-20 19:59:15.905355 | controller | Wednesday 20 May 2026  19:59:15 +0000 (0:00:00.813)       0:00:06.981 *********
2026-05-20 19:59:15.957206 | controller | included: atmosphere.common.glance_image for controller
2026-05-20 19:59:15.957387 | controller |
2026-05-20 19:59:15.957613 | controller | TASK [atmosphere.common.glance_image : Fetch source image metadata from URL] ***
2026-05-20 19:59:15.957825 | controller | Wednesday 20 May 2026  19:59:15 +0000 (0:00:00.053)       0:00:07.034 *********
2026-05-20 19:59:16.446697 | controller | ok: [controller]
2026-05-20 19:59:16.446914 | controller |
2026-05-20 19:59:16.447265 | controller | TASK [atmosphere.common.glance_image : Capture source ETag when available] *****
2026-05-20 19:59:16.447362 | controller | Wednesday 20 May 2026  19:59:16 +0000 (0:00:00.488)       0:00:07.523 *********
2026-05-20 19:59:16.490882 | controller | ok: [controller]
2026-05-20 19:59:16.491219 | controller |
2026-05-20 19:59:16.491599 | controller | TASK [atmosphere.common.glance_image : Check if image exists] ******************
2026-05-20 19:59:16.491624 | controller | Wednesday 20 May 2026  19:59:16 +0000 (0:00:00.044)       0:00:07.567 *********
2026-05-20 19:59:17.720285 | controller | ok: [controller]
2026-05-20 19:59:17.720341 | controller |
2026-05-20 19:59:17.720458 | controller | TASK [atmosphere.common.glance_image : Capture existing image and its Atmosphere metadata] ***
2026-05-20 19:59:17.720565 | controller | Wednesday 20 May 2026  19:59:17 +0000 (0:00:01.228)       0:00:08.796 *********
2026-05-20 19:59:17.770692 | controller | ok: [controller]
2026-05-20 19:59:17.770932 | controller |
2026-05-20 19:59:17.771117 | controller | TASK [atmosphere.common.glance_image : Decide whether image upload is required] ***
2026-05-20 19:59:17.771372 | controller | Wednesday 20 May 2026  19:59:17 +0000 (0:00:00.050)       0:00:08.847 *********
2026-05-20 19:59:17.820852 | controller | ok: [controller]
2026-05-20 19:59:17.821019 | controller |
2026-05-20 19:59:17.821310 | controller | TASK [atmosphere.common.glance_image : Generate temporary work directory] ******
2026-05-20 19:59:17.821524 | controller | Wednesday 20 May 2026  19:59:17 +0000 (0:00:00.050)       0:00:08.898 *********
2026-05-20 19:59:18.149437 | controller | changed: [controller]
2026-05-20 19:59:18.149717 | controller |
2026-05-20 19:59:18.150294 | controller | TASK [atmosphere.common.glance_image : Download image] *************************
2026-05-20 19:59:18.150504 | controller | Wednesday 20 May 2026  19:59:18 +0000 (0:00:00.326)       0:00:09.224 *********
2026-05-20 19:59:18.633005 | controller | changed: [controller]
2026-05-20 19:59:18.633105 | controller |
2026-05-20 19:59:18.633220 | controller | TASK [atmosphere.common.glance_image : Get image format] ***********************
2026-05-20 19:59:18.633374 | controller | Wednesday 20 May 2026  19:59:18 +0000 (0:00:00.485)       0:00:09.710 *********
2026-05-20 19:59:18.981783 | controller | ok: [controller]
2026-05-20 19:59:18.982002 | controller |
2026-05-20 19:59:18.982222 | controller | TASK [atmosphere.common.glance_image : Convert file to target disk format] *****
2026-05-20 19:59:18.982462 | controller | Wednesday 20 May 2026  19:59:18 +0000 (0:00:00.348)       0:00:10.058 *********
2026-05-20 19:59:19.015387 | controller | skipping: [controller]
2026-05-20 19:59:19.015500 | controller |
2026-05-20 19:59:19.015626 | controller | TASK [atmosphere.common.glance_image : Wait until image service ready] *********
2026-05-20 19:59:19.015753 | controller | Wednesday 20 May 2026  19:59:19 +0000 (0:00:00.034)       0:00:10.092 *********
2026-05-20 19:59:20.018069 | controller | ok: [controller]
2026-05-20 19:59:20.018134 | controller |
2026-05-20 19:59:20.018223 | controller | TASK [atmosphere.common.glance_image : Compute pending image name] *************
2026-05-20 19:59:20.018307 | controller | Wednesday 20 May 2026  19:59:20 +0000 (0:00:01.002)       0:00:11.095 *********
2026-05-20 19:59:20.070147 | controller | ok: [controller]
2026-05-20 19:59:20.070370 | controller |
2026-05-20 19:59:20.070622 | controller | TASK [atmosphere.common.glance_image : Upload image into Glance] ***************
2026-05-20 19:59:20.070957 | controller | Wednesday 20 May 2026  19:59:20 +0000 (0:00:00.050)       0:00:11.146 *********
2026-05-20 19:59:21.491459 | controller | changed: [controller]
2026-05-20 19:59:21.491672 | controller |
2026-05-20 19:59:21.491960 | controller | TASK [atmosphere.common.glance_image : Rename outdated image to preserve audit trail] ***
2026-05-20 19:59:21.492182 | controller | Wednesday 20 May 2026  19:59:21 +0000 (0:00:01.422)       0:00:12.568 *********
2026-05-20 19:59:22.560597 | controller | changed: [controller]
2026-05-20 19:59:22.560830 | controller |
2026-05-20 19:59:22.561097 | controller | TASK [atmosphere.common.glance_image : Promote newly uploaded image to canonical name] ***
2026-05-20 19:59:22.561335 | controller | Wednesday 20 May 2026  19:59:22 +0000 (0:00:01.068)       0:00:13.636 *********
2026-05-20 19:59:23.955397 | controller | changed: [controller]
2026-05-20 19:59:23.955575 | controller |
2026-05-20 19:59:23.955831 | controller | TASK [atmosphere.common.glance_image : Remove work directory] ******************
2026-05-20 19:59:23.956046 | controller | Wednesday 20 May 2026  19:59:23 +0000 (0:00:01.394)       0:00:15.031 *********
2026-05-20 19:59:24.302417 | controller | changed: [controller]
2026-05-20 19:59:24.302620 | controller |
2026-05-20 19:59:24.302844 | controller | TASK [Get canonical image after ETag update] ***********************************
2026-05-20 19:59:24.303078 | controller | Wednesday 20 May 2026  19:59:24 +0000 (0:00:00.347)       0:00:15.379 *********
2026-05-20 19:59:25.202580 | controller | ok: [controller]
2026-05-20 19:59:25.202741 | controller |
2026-05-20 19:59:25.203004 | controller | TASK [Get obsolete image after ETag update] ************************************
2026-05-20 19:59:25.203221 | controller | Wednesday 20 May 2026  19:59:25 +0000 (0:00:00.899)       0:00:16.279 *********
2026-05-20 19:59:26.139485 | controller | ok: [controller]
2026-05-20 19:59:26.139561 | controller |
2026-05-20 19:59:26.139735 | controller | TASK [Assert image update behavior] ********************************************
2026-05-20 19:59:26.139949 | controller | Wednesday 20 May 2026  19:59:26 +0000 (0:00:00.937)       0:00:17.216 *********
2026-05-20 19:59:26.177347 | controller | fatal: [controller]: FAILED! => {
2026-05-20 19:59:26.177549 | controller |     "assertion": "_obsolete_image.images | length == 1",
2026-05-20 19:59:26.177748 | controller |     "changed": false,
2026-05-20 19:59:26.178058 | controller |     "evaluated_to": false,
2026-05-20 19:59:26.178202 | controller |     "msg": "Assertion failed"
2026-05-20 19:59:26.178397 | controller | }
2026-05-20 19:59:26.179277 | controller |
2026-05-20 19:59:26.179515 | controller | PLAY RECAP *********************************************************************
2026-05-20 19:59:26.179743 | controller | controller                 : ok=29   changed=7    unreachable=0    failed=1    skipped=11   rescued=0    ignored=0
2026-05-20 19:59:26.179972 | controller |
2026-05-20 19:59:26.180182 | controller | Wednesday 20 May 2026  19:59:26 +0000 (0:00:00.040)       0:00:17.257 *********
2026-05-20 19:59:26.180375 | controller | ===============================================================================
2026-05-20 19:59:26.180577 | controller | Gathering Facts --------------------------------------------------------- 1.87s
2026-05-20 19:59:26.180785 | controller | atmosphere.common.glance_image : Upload image into Glance --------------- 1.42s
2026-05-20 19:59:26.181039 | controller | atmosphere.common.glance_image : Promote newly uploaded image to canonical name --- 1.39s
2026-05-20 19:59:26.181269 | controller | Get initial image ------------------------------------------------------- 1.34s
2026-05-20 19:59:26.181479 | controller | atmosphere.common.glance_image : Check if image exists ------------------ 1.23s
2026-05-20 19:59:26.181692 | controller | atmosphere.common.glance_image : Rename outdated image to preserve audit trail --- 1.07s
2026-05-20 19:59:26.181994 | controller | atmosphere.common.glance_image : Wait until image service ready --------- 1.00s
2026-05-20 19:59:26.182210 | controller | atmosphere.common.glance_image : Check if image exists ------------------ 0.94s
2026-05-20 19:59:26.182415 | controller | Get obsolete image after ETag update ------------------------------------ 0.94s
2026-05-20 19:59:26.182611 | controller | Get image after unchanged ETag run -------------------------------------- 0.92s
2026-05-20 19:59:26.182846 | controller | Get canonical image after ETag update ----------------------------------- 0.90s
2026-05-20 19:59:26.183048 | controller | Change source ETag ------------------------------------------------------ 0.81s
2026-05-20 19:59:26.183253 | controller | atmosphere.common.glance_image : Fetch source image metadata from URL --- 0.54s
2026-05-20 19:59:26.183459 | controller | atmosphere.common.glance_image : Fetch source image metadata from URL --- 0.49s
2026-05-20 19:59:26.183663 | controller | atmosphere.common.glance_image : Download image ------------------------- 0.49s
2026-05-20 19:59:26.183908 | controller | atmosphere.common.glance_image : Get image format ----------------------- 0.35s
2026-05-20 19:59:26.184111 | controller | atmosphere.common.glance_image : Remove work directory ------------------ 0.35s
2026-05-20 19:59:26.184316 | controller | atmosphere.common.glance_image : Generate temporary work directory ------ 0.33s
2026-05-20 19:59:26.184521 | controller | Run role again with changed ETag ---------------------------------------- 0.05s
2026-05-20 19:59:26.184724 | controller | Run role again with unchanged ETag -------------------------------------- 0.05s
2026-05-20 19:59:26.259144 | controller | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.z7Jo.glance-image/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere.common/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere.common/extensions/molecule/glance-image/verify.yml
2026-05-20 19:59:26.259312 | controller | ERROR    [glance-image > verify] Executed: Failed
2026-05-20 19:59:26.259448 | controller | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.z7Jo.glance-image/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere.common/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere.common/extensions/molecule/glance-image/verify.yml
2026-05-20 19:59:26.478390 | controller | ERROR
2026-05-20 19:59:26.478632 | controller | {
2026-05-20 19:59:26.478663 | controller |   "delta": "0:16:40.096774",
2026-05-20 19:59:26.478684 | controller |   "end": "2026-05-20 19:59:26.320397",
2026-05-20 19:59:26.478703 | controller |   "msg": "non-zero return code",
2026-05-20 19:59:26.478722 | controller |   "rc": 2,
2026-05-20 19:59:26.478742 | controller |   "start": "2026-05-20 19:42:46.223623"
2026-05-20 19:59:26.478760 | controller | }
failure
2026-05-20 19:59:26.496069 | 
2026-05-20 19:59:26.496126 | PLAY RECAP
2026-05-20 19:59:26.496171 | controller | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-05-20 19:59:26.496192 | 
2026-05-20 19:59:26.607231 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-05-20 19:59:26.612194 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-20 19:59:27.189876 | 
2026-05-20 19:59:27.190289 | PLAY [all]
2026-05-20 19:59:27.202083 | 
2026-05-20 19:59:27.202169 | TASK [fetch-output : Set log path for multiple nodes]
2026-05-20 19:59:27.247015 | controller | skipping: Conditional result was False
2026-05-20 19:59:27.258748 | 
2026-05-20 19:59:27.258829 | TASK [fetch-output : Set log path for single node]
2026-05-20 19:59:27.306503 | controller | ok
2026-05-20 19:59:27.311512 | 
2026-05-20 19:59:27.311592 | LOOP [fetch-output : Ensure local output dirs]
2026-05-20 19:59:27.697513 | controller -> localhost | ok: "/var/lib/zuul/builds/b219deae56f147539b992af188638d2e/work/logs"
2026-05-20 19:59:27.893824 | controller -> localhost | changed: "/var/lib/zuul/builds/b219deae56f147539b992af188638d2e/work/artifacts"
2026-05-20 19:59:28.103372 | controller -> localhost | changed: "/var/lib/zuul/builds/b219deae56f147539b992af188638d2e/work/docs"
2026-05-20 19:59:28.121008 | 
2026-05-20 19:59:28.121131 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-05-20 19:59:28.742555 | controller | ok
2026-05-20 19:59:28.742754 | controller | changed: All items complete
2026-05-20 19:59:28.742783 | 
2026-05-20 19:59:29.212043 | controller | changed: .d..t...... ./
2026-05-20 19:59:29.681332 | controller | changed: .d..t...... ./
2026-05-20 19:59:29.706043 | 
2026-05-20 19:59:29.706132 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-05-20 19:59:30.112971 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007678
2026-05-20 19:59:30.336844 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008242
2026-05-20 19:59:30.351224 | 
2026-05-20 19:59:30.351354 | PLAY [all]
2026-05-20 19:59:30.358037 | 
2026-05-20 19:59:30.358109 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-05-20 19:59:30.840330 | controller | changed
2026-05-20 19:59:30.846452 | 
2026-05-20 19:59:30.846513 | PLAY RECAP
2026-05-20 19:59:30.846569 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-05-20 19:59:30.846594 | 
2026-05-20 19:59:30.975602 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-20 19:59:30.982860 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-05-20 19:59:31.573748 | 
2026-05-20 19:59:31.573864 | PLAY [localhost]
2026-05-20 19:59:31.583523 | 
2026-05-20 19:59:31.583595 | TASK [Generate Zuul manifest]
2026-05-20 19:59:31.605541 | localhost | ok
2026-05-20 19:59:31.623013 | 
2026-05-20 19:59:31.623100 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-05-20 19:59:32.020634 | localhost | changed
2026-05-20 19:59:32.033659 | 
2026-05-20 19:59:32.033751 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-05-20 19:59:32.066520 | localhost | ok
2026-05-20 19:59:32.076170 | 
2026-05-20 19:59:32.076255 | TASK [Upload logs]
2026-05-20 19:59:32.097589 | localhost | ok
2026-05-20 19:59:32.156537 | 
2026-05-20 19:59:32.156651 | TASK [Set zuul-log-path fact]
2026-05-20 19:59:32.189138 | localhost | ok
2026-05-20 19:59:32.203902 | 
2026-05-20 19:59:32.203974 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-20 19:59:32.236635 | localhost | ok
2026-05-20 19:59:32.245369 | 
2026-05-20 19:59:32.245434 | TASK [upload-logs : Create log directories]
2026-05-20 19:59:32.674849 | localhost | changed
2026-05-20 19:59:32.713749 | 
2026-05-20 19:59:32.713869 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-05-20 19:59:33.090986 | localhost -> localhost | ok: Runtime: 0:00:00.005347
2026-05-20 19:59:33.096578 | 
2026-05-20 19:59:33.096646 | TASK [upload-logs : Upload logs to log server]
2026-05-20 19:59:33.501733 | localhost | Output suppressed because no_log was given
2026-05-20 19:59:33.506611 | 
2026-05-20 19:59:33.506698 | LOOP [upload-logs : Compress console log and json output]
2026-05-20 19:59:33.551443 | localhost | skipping: Conditional result was False
2026-05-20 19:59:33.558538 | localhost | skipping: Conditional result was False
2026-05-20 19:59:33.571122 | 
2026-05-20 19:59:33.571318 | LOOP [upload-logs : Upload compressed console log and json output]
2026-05-20 19:59:33.614833 | localhost | skipping: Conditional result was False
2026-05-20 19:59:33.615248 | 
2026-05-20 19:59:33.618888 | localhost | skipping: Conditional result was False
2026-05-20 19:59:33.636827 | 
2026-05-20 19:59:33.637061 | LOOP [upload-logs : Upload console log and json output]