PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Tuesday 17 March 2026 11:04:14 +0000 (0:00:00.024) 0:00:00.024 *********
ok: [instance]
TASK [Create custom basedir] ***************************************************
Tuesday 17 March 2026 11:04:14 +0000 (0:00:00.819) 0:00:00.843 *********
changed: [instance]
TASK [test_deps : Gather facts if they don't exist] ****************************
Tuesday 17 March 2026 11:04:15 +0000 (0:00:00.290) 0:00:01.134 *********
skipping: [instance]
TASK [test_deps : Gather variables for each operating system] ******************
Tuesday 17 March 2026 11:04:15 +0000 (0:00:00.016) 0:00:01.151 *********
ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml)
TASK [test_deps : Detect mirrors file] *****************************************
Tuesday 17 March 2026 11:04:15 +0000 (0:00:00.039) 0:00:01.190 *********
ok: [instance]
TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Tuesday 17 March 2026 11:04:15 +0000 (0:00:00.253) 0:00:01.444 *********
ok: [instance]
TASK [test_deps : Disable ubi 9 repos] *****************************************
Tuesday 17 March 2026 11:04:15 +0000 (0:00:00.205) 0:00:01.649 *********
ok: [instance] => (item=ubi-9-appstream)
ok: [instance] => (item=ubi-9-baseos)
ok: [instance] => (item=ubi-9-codeready-builder)
TASK [Deploy repo-setup] *******************************************************
Tuesday 17 March 2026 11:04:16 +0000 (0:00:00.651) 0:00:02.301 *********
TASK [repo_setup : Ensure directories are present] *****************************
Tuesday 17 March 2026 11:04:16 +0000 (0:00:00.058) 0:00:02.359 *********
changed: [instance] => (item=tmp)
changed: [instance] => (item=artifacts/repositories)
changed: [instance] => (item=venv/repo_setup)
TASK [repo_setup : Make sure git-core package is installed] ********************
Tuesday 17 March 2026 11:04:17 +0000 (0:00:00.506) 0:00:02.865 *********
ok: [instance]
TASK [repo_setup : Get repo-setup repository] **********************************
Tuesday 17 March 2026 11:04:17 +0000 (0:00:00.778) 0:00:03.643 *********
changed: [instance]
TASK [repo_setup : Initialize python venv and install requirements] ************
Tuesday 17 March 2026 11:04:18 +0000 (0:00:01.069) 0:00:04.712 *********
changed: [instance]
TASK [repo_setup : Install repo-setup package] *********************************
Tuesday 17 March 2026 11:04:26 +0000 (0:00:07.389) 0:00:12.102 *********
changed: [instance]
TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Tuesday 17 March 2026 11:04:26 +0000 (0:00:00.678) 0:00:12.781 *********
skipping: [instance]
TASK [repo_setup : Run repo-setup] *********************************************
Tuesday 17 March 2026 11:04:26 +0000 (0:00:00.023) 0:00:12.804 *********
changed: [instance]
TASK [repo_setup : Get component repo] *****************************************
Tuesday 17 March 2026 11:04:27 +0000 (0:00:00.798) 0:00:13.603 *********
skipping: [instance]
TASK [repo_setup : Rename component repo] **************************************
Tuesday 17 March 2026 11:04:27 +0000 (0:00:00.035) 0:00:13.639 *********
skipping: [instance]
TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Tuesday 17 March 2026 11:04:27 +0000 (0:00:00.035) 0:00:13.674 *********
skipping: [instance]
TASK [repo_setup : Run repo-setup-get-hash] ************************************
Tuesday 17 March 2026 11:04:27 +0000 (0:00:00.034) 0:00:13.709 *********
changed: [instance]
TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Tuesday 17 March 2026 11:04:28 +0000 (0:00:00.530) 0:00:14.239 *********
changed: [instance]
TASK [repo_setup : Dump current-podified hash] *********************************
Tuesday 17 March 2026 11:04:28 +0000 (0:00:00.441) 0:00:14.680 *********
skipping: [instance]
TASK [repo_setup : Slurp current podified hash] ********************************
Tuesday 17 March 2026 11:04:28 +0000 (0:00:00.028) 0:00:14.709 *********
skipping: [instance]
TASK [repo_setup : Update the value of full_hash] ******************************
Tuesday 17 March 2026 11:04:28 +0000 (0:00:00.027) 0:00:14.736 *********
skipping: [instance]
TASK [repo_setup : Export hashes facts for further use] ************************
Tuesday 17 March 2026 11:04:28 +0000 (0:00:00.027) 0:00:14.764 *********
ok: [instance]
TASK [repo_setup : Create download directory] **********************************
Tuesday 17 March 2026 11:04:28 +0000 (0:00:00.039) 0:00:14.803 *********
skipping: [instance]
TASK [repo_setup : Print the URL to request] ***********************************
Tuesday 17 March 2026 11:04:28 +0000 (0:00:00.026) 0:00:14.829 *********
skipping: [instance]
TASK [Download the RPM] ********************************************************
Tuesday 17 March 2026 11:04:28 +0000 (0:00:00.025) 0:00:14.855 *********
skipping: [instance]
TASK [repo_setup : Install RHOS Release tool] **********************************
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.026) 0:00:14.882 *********
skipping: [instance]
TASK [repo_setup : Get rhos-release tool version] ******************************
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.025) 0:00:14.907 *********
skipping: [instance]
TASK [repo_setup : Print rhos-release tool version] ****************************
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.027) 0:00:14.935 *********
skipping: [instance]
TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.027) 0:00:14.963 *********
skipping: [instance]
TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.025) 0:00:14.989 *********
ok: [instance]
TASK [repo_setup : Use RDO proxy mirrors] **************************************
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.181) 0:00:15.170 *********
changed: [instance]
TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.213) 0:00:15.383 *********
changed: [instance]
TASK [repo_setup : Check for gating.repo file on content provider] *************
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.222) 0:00:15.605 *********
skipping: [instance]
TASK [repo_setup : Populate gating repo from content provider ip] **************
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.020) 0:00:15.626 *********
skipping: [instance]
TASK [repo_setup : Check for DLRN repo at the destination] *********************
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.021) 0:00:15.648 *********
skipping: [instance]
TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.020) 0:00:15.669 *********
skipping: [instance]
TASK [repo_setup : Check for DLRN component repo] ******************************
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.021) 0:00:15.690 *********
skipping: [instance]
TASK [repo_setup : Lower the priority of component repos to allow installation from gating repo] ***
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.021) 0:00:15.711 *********
skipping: [instance]
TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.020) 0:00:15.732 *********
skipping: [instance]
TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.017) 0:00:15.749 *********
skipping: [instance]
TASK [repo_setup : Cleanup existing metadata] **********************************
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.028) 0:00:15.778 *********
skipping: [instance]
TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.017) 0:00:15.795 *********
skipping: [instance]
TASK [test_deps : Look for redhat-release rpm] *********************************
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.020) 0:00:15.815 *********
skipping: [instance]
TASK [test_deps : Remove redhat-release] ***************************************
Tuesday 17 March 2026 11:04:29 +0000 (0:00:00.029) 0:00:15.845 *********
skipping: [instance]
TASK [test_deps : Install centos-stream-release] *******************************
Tuesday 17 March 2026 11:04:30 +0000 (0:00:00.030) 0:00:15.875 *********
skipping: [instance]
TASK [test_deps : Install additional packages] *********************************
Tuesday 17 March 2026 11:04:30 +0000 (0:00:00.030) 0:00:15.905 *********
skipping: [instance]
TASK [test_deps : Install selinux python libs] *********************************
Tuesday 17 March 2026 11:04:30 +0000 (0:00:00.028) 0:00:15.934 *********
ok: [instance]
TASK [test_deps : Install python yaml libs] ************************************
Tuesday 17 March 2026 11:05:31 +0000 (0:01:01.112) 0:01:17.047 *********
ok: [instance]
TASK [test_deps : Install extra packages] **************************************
Tuesday 17 March 2026 11:05:32 +0000 (0:00:01.159) 0:01:18.207 *********
skipping: [instance]
TASK [ci_setup : Gather variables for each operating system] *******************
Tuesday 17 March 2026 11:05:32 +0000 (0:00:00.032) 0:01:18.239 *********
ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_setup/vars/redhat.yml)
TASK [ci_setup : List packages to install] *************************************
Tuesday 17 March 2026 11:05:32 +0000 (0:00:00.041) 0:01:18.281 *********
ok: [instance] =>
cifmw_ci_setup_packages:
- bash-completion
- ca-certificates
- git-core
- make
- tar
- tmux
- python3-pip
TASK [ci_setup : Install needed packages] **************************************
Tuesday 17 March 2026 11:05:32 +0000 (0:00:00.018) 0:01:18.299 *********
changed: [instance]
TASK [ci_setup : Gather version of openshift client] ***************************
Tuesday 17 March 2026 11:05:36 +0000 (0:00:04.008) 0:01:22.308 *********
ok: [instance]
TASK [ci_setup : Ensure openshift client install path is present] **************
Tuesday 17 March 2026 11:05:36 +0000 (0:00:00.179) 0:01:22.487 *********
changed: [instance]
TASK [ci_setup : Install openshift client] *************************************
Tuesday 17 March 2026 11:05:36 +0000 (0:00:00.203) 0:01:22.691 *********
changed: [instance]
TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
Tuesday 17 March 2026 11:05:42 +0000 (0:00:05.878) 0:01:28.569 *********
ok: [instance]
TASK [ci_setup : Create completion file] ***************************************
Tuesday 17 March 2026 11:05:42 +0000 (0:00:00.035) 0:01:28.604 *********
changed: [instance]
TASK [ci_setup : Source completion from within .bashrc] ************************
Tuesday 17 March 2026 11:05:42 +0000 (0:00:00.252) 0:01:28.856 *********
changed: [instance]
TASK [ci_setup : Check rhsm status] ********************************************
Tuesday 17 March 2026 11:05:43 +0000 (0:00:00.268) 0:01:29.125 *********
skipping: [instance]
TASK [ci_setup : Gather the repos to be enabled] *******************************
Tuesday 17 March 2026 11:05:43 +0000 (0:00:00.016) 0:01:29.142 *********
skipping: [instance]
TASK [ci_setup : Enabling the required repositories.] **************************
Tuesday 17 March 2026 11:05:43 +0000 (0:00:00.016) 0:01:29.159 *********
skipping: [instance]
TASK [ci_setup : Get current /etc/redhat-release] ******************************
Tuesday 17 March 2026 11:05:43 +0000 (0:00:00.016) 0:01:29.176 *********
skipping: [instance]
TASK [ci_setup : Print current /etc/redhat-release] ****************************
Tuesday 17 March 2026 11:05:43 +0000 (0:00:00.016) 0:01:29.192 *********
skipping: [instance]
TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
Tuesday 17 March 2026 11:05:43 +0000 (0:00:00.016) 0:01:29.208 *********
skipping: [instance]
TASK [ci_setup : Manage directories] *******************************************
Tuesday 17 March 2026 11:05:43 +0000 (0:00:00.020) 0:01:29.229 *********
changed: [instance] => (item=/opt/basedir/artifacts/manifests/openstack/cr)
changed: [instance] => (item=/opt/basedir/logs)
ok: [instance] => (item=/opt/basedir/tmp)
changed: [instance] => (item=/opt/basedir/volumes)
changed: [instance] => (item=/opt/basedir/artifacts/parameters)
TASK [libvirt_manager : Get installed packages list] ***************************
Tuesday 17 March 2026 11:05:44 +0000 (0:00:00.943) 0:01:30.173 *********
ok: [instance]
TASK [libvirt_manager : Populate service facts] ********************************
Tuesday 17 March 2026 11:05:44 +0000 (0:00:00.686) 0:01:30.859 *********
ok: [instance]
TASK [libvirt_manager : Start virtqemud socket service] ************************
Tuesday 17 March 2026 11:05:46 +0000 (0:00:01.704) 0:01:32.564 *********
skipping: [instance] => (item=virtqemud.service)
skipping: [instance] => (item=virtqemud.socket)
skipping: [instance]
TASK [libvirt_manager : Start virtnetworkd socket service] *********************
Tuesday 17 March 2026 11:05:46 +0000 (0:00:00.057) 0:01:32.622 *********
skipping: [instance] => (item=virtnetworkd.service)
skipping: [instance] => (item=virtnetworkd.socket)
skipping: [instance]
TASK [libvirt_manager : Start virtstoraged socket service] *********************
Tuesday 17 March 2026 11:05:46 +0000 (0:00:00.056) 0:01:32.679 *********
skipping: [instance] => (item=virtstoraged.service)
skipping: [instance] => (item=virtstoraged.socket)
skipping: [instance]
TASK [libvirt_manager : Set _is_deepscrub internal fact] ***********************
Tuesday 17 March 2026 11:05:46 +0000 (0:00:00.057) 0:01:32.736 *********
ok: [instance]
TASK [libvirt_manager : List all of the existing virtual machines] *************
Tuesday 17 March 2026 11:05:46 +0000 (0:00:00.044) 0:01:32.781 *********
skipping: [instance]
TASK [libvirt_manager : Get pool configuration] ********************************
Tuesday 17 March 2026 11:05:46 +0000 (0:00:00.077) 0:01:32.858 *********
skipping: [instance]
TASK [libvirt_manager : Filter out target environment] *************************
Tuesday 17 March 2026 11:05:47 +0000 (0:00:00.056) 0:01:32.915 *********
skipping: [instance]
TASK [libvirt_manager : Expose cleanup list] ***********************************
Tuesday 17 March 2026 11:05:47 +0000 (0:00:00.055) 0:01:32.970 *********
skipping: [instance]
TASK [libvirt_manager : Clean ssh known_hosts] *********************************
Tuesday 17 March 2026 11:05:47 +0000 (0:00:00.057) 0:01:33.028 *********
skipping: [instance]
TASK [libvirt_manager : Destroy machine] ***************************************
Tuesday 17 March 2026 11:05:47 +0000 (0:00:00.057) 0:01:33.085 *********
skipping: [instance]
TASK [libvirt_manager : Undefine machine] **************************************
Tuesday 17 March 2026 11:05:47 +0000 (0:00:00.055) 0:01:33.141 *********
skipping: [instance]
TASK [libvirt_manager : (localhost) Clean ssh jumpers] *************************
Tuesday 17 March 2026 11:05:47 +0000 (0:00:00.056) 0:01:33.198 *********
skipping: [instance]
TASK [libvirt_manager : (instance) Clean ssh jumpers] **************************
Tuesday 17 March 2026 11:05:47 +0000 (0:00:00.059) 0:01:33.258 *********
skipping: [instance]
TASK [libvirt_manager : Get network list] **************************************
Tuesday 17 March 2026 11:05:47 +0000 (0:00:00.056) 0:01:33.314 *********
skipping: [instance]
TASK [libvirt_manager : Filter out target nets] ********************************
Tuesday 17 March 2026 11:05:47 +0000 (0:00:00.055) 0:01:33.370 *********
skipping: [instance]
TASK [libvirt_manager : Expose cleanup list] ***********************************
Tuesday 17 March 2026 11:05:47 +0000 (0:00:00.055) 0:01:33.425 *********
skipping: [instance]
TASK [Remove dnsmasq network bits] *********************************************
Tuesday 17 March 2026 11:05:47 +0000 (0:00:00.054) 0:01:33.480 *********
skipping: [instance]
TASK [libvirt_manager : Destroy networks] **************************************
Tuesday 17 March 2026 11:05:47 +0000 (0:00:00.056) 0:01:33.536 *********
skipping: [instance]
TASK [libvirt_manager : Undefine networks] *************************************
Tuesday 17 March 2026 11:05:47 +0000 (0:00:00.056) 0:01:33.592 *********
skipping: [instance]
TASK [libvirt_manager : Ensure no trace of networks lays in nmcli] *************
Tuesday 17 March 2026 11:05:47 +0000 (0:00:00.107) 0:01:33.699 *********
skipping: [instance]
TASK [libvirt_manager : Find dummy interface connection files] *****************
Tuesday 17 March 2026 11:05:47 +0000 (0:00:00.057) 0:01:33.757 *********
skipping: [instance]
TASK [libvirt_manager : Remove dummy interface connections] ********************
Tuesday 17 March 2026 11:05:47 +0000 (0:00:00.057) 0:01:33.814 *********
skipping: [instance]
TASK [libvirt_manager : Clean firewalld libvirt zone] **************************
Tuesday 17 March 2026 11:05:48 +0000 (0:00:00.054) 0:01:33.869 *********
skipping: [instance]
TASK [libvirt_manager : Ensure firewalld is enabled and started] ***************
Tuesday 17 March 2026 11:05:48 +0000 (0:00:00.057) 0:01:33.926 *********
skipping: [instance]
TASK [libvirt_manager : Disable masquerade in firewalld default zone] **********
Tuesday 17 March 2026 11:05:48 +0000 (0:00:00.057) 0:01:33.984 *********
skipping: [instance]
TASK [libvirt_manager : Disable forward in firewalld libvirt zone] *************
Tuesday 17 March 2026 11:05:48 +0000 (0:00:00.056) 0:01:34.040 *********
skipping: [instance]
TASK [libvirt_manager : Remove cifmw storage pool] *****************************
Tuesday 17 March 2026 11:05:48 +0000 (0:00:00.057) 0:01:34.098 *********
skipping: [instance]
TASK [libvirt_manager : Remove overlay images from ocp_volume pools if exists] ***
Tuesday 17 March 2026 11:05:48 +0000 (0:00:00.056) 0:01:34.155 *********
skipping: [instance]
TASK [libvirt_manager : Remove ocp_volumes storage pool] ***********************
Tuesday 17 March 2026 11:05:48 +0000 (0:00:00.041) 0:01:34.196 *********
skipping: [instance]
TASK [libvirt_manager : Refresh all pools after actions] ***********************
Tuesday 17 March 2026 11:05:48 +0000 (0:00:00.058) 0:01:34.255 *********
skipping: [instance]
TASK [libvirt_manager : Get temporary key status] ******************************
Tuesday 17 March 2026 11:05:48 +0000 (0:00:00.057) 0:01:34.312 *********
ok: [instance]
TASK [libvirt_manager : Get public key] ****************************************
Tuesday 17 March 2026 11:05:48 +0000 (0:00:00.176) 0:01:34.488 *********
skipping: [instance]
TASK [libvirt_manager : Remove public key] *************************************
Tuesday 17 March 2026 11:05:48 +0000 (0:00:00.056) 0:01:34.544 *********
skipping: [instance]
TASK [libvirt_manager : Remove keypair] ****************************************
Tuesday 17 March 2026 11:05:48 +0000 (0:00:00.032) 0:01:34.576 *********
skipping: [instance] => (item=cifmw_reproducer_key.pub)
skipping: [instance] => (item=cifmw_reproducer_key)
skipping: [instance]
TASK [libvirt_manager : List libvirt logs] *************************************
Tuesday 17 March 2026 11:05:48 +0000 (0:00:00.034) 0:01:34.611 *********
[WARNING]: Skipped '/var/log/libvirt/qemu/' path due to this access issue:
'/var/log/libvirt/qemu/' is not a directory
ok: [instance]
TASK [libvirt_manager : Remove detected logs] **********************************
Tuesday 17 March 2026 11:05:49 +0000 (0:00:00.275) 0:01:34.886 *********
skipping: [instance]
TASK [libvirt_manager : Remove workload and volumes] ***************************
Tuesday 17 March 2026 11:05:49 +0000 (0:00:00.029) 0:01:34.915 *********
ok: [instance] => (item=workload)
changed: [instance] => (item=volumes)
ok: [instance] => (item=artifacts/debug_network_data.yml)
ok: [instance] => (item=artifacts/debug_pub_net_value.txt)
ok: [instance] => (item=artifacts/debug_cifmw_libvirt_manager_layout.yml)
ok: [instance] => (item=artifacts/interfaces-info.yml)
ok: [instance] => (item=artifacts/libvirt-uuids.yml)
ok: [instance] => (item=artifacts/net-map-def-patch.yml)
TASK [libvirt_manager : Deepscrub data] ****************************************
Tuesday 17 March 2026 11:05:50 +0000 (0:00:01.278) 0:01:36.194 *********
ok: [instance] => (item=images)
ok: [instance] => (item=artifacts/virtual-nodes.yml)
TASK [podman : Ensure podman is installed] *************************************
Tuesday 17 March 2026 11:05:50 +0000 (0:00:00.360) 0:01:36.554 *********
ok: [instance]
TASK [podman : Enable loginctl linger for ansible_user_id] *********************
Tuesday 17 March 2026 11:05:51 +0000 (0:00:01.150) 0:01:37.705 *********
changed: [instance]
TASK [podman : Ensure subordinate UID entry exists for zuul] *******************
Tuesday 17 March 2026 11:05:52 +0000 (0:00:00.307) 0:01:38.013 *********
skipping: [instance]
TASK [podman : Ensure subordinate GID entry exists for zuul] *******************
Tuesday 17 March 2026 11:05:52 +0000 (0:00:00.037) 0:01:38.050 *********
skipping: [instance]
TASK [podman : Run podman system migrate if subuid/subgid files were changed] ***
Tuesday 17 March 2026 11:05:52 +0000 (0:00:00.033) 0:01:38.083 *********
skipping: [instance]
TASK [virtualbmc : Stop and remove vbmc container] *****************************
Tuesday 17 March 2026 11:05:52 +0000 (0:00:00.048) 0:01:38.132 *********
ok: [instance]
TASK [virtualbmc : Remove vbmc container image] ********************************
Tuesday 17 March 2026 11:05:52 +0000 (0:00:00.581) 0:01:38.714 *********
ok: [instance]
TASK [virtualbmc : Check if VBMC key exists] ***********************************
Tuesday 17 March 2026 11:05:53 +0000 (0:00:00.421) 0:01:39.135 *********
ok: [instance]
TASK [virtualbmc : Slurp key] **************************************************
Tuesday 17 March 2026 11:05:53 +0000 (0:00:00.176) 0:01:39.311 *********
skipping: [instance]
TASK [virtualbmc : Revoke VBMC SSH access] *************************************
Tuesday 17 March 2026 11:05:53 +0000 (0:00:00.028) 0:01:39.340 *********
skipping: [instance]
TASK [virtualbmc : Remove vbmc files] ******************************************
Tuesday 17 March 2026 11:05:53 +0000 (0:00:00.028) 0:01:39.368 *********
ok: [instance] => (item=/home/zuul/.ssh/vbmc-key)
ok: [instance] => (item=/home/zuul/.ssh/vbmc-key.pub)
ok: [instance] => (item=/home/zuul/.ssh/virtualbmc.conf)
ok: [instance] => (item=/home/zuul/.ssh/vbmcd.sh)
TASK [Clean remote ssh config] *************************************************
Tuesday 17 March 2026 11:05:54 +0000 (0:00:00.696) 0:01:40.065 *********
TASK [ssh_jumper : Remove Include cifmw_ssh_config.d] **************************
Tuesday 17 March 2026 11:05:54 +0000 (0:00:00.077) 0:01:40.142 *********
ok: [instance]
TASK [ssh_jumper : Remove cifmw_ssh_config.d directory] ************************
Tuesday 17 March 2026 11:05:54 +0000 (0:00:00.299) 0:01:40.441 *********
ok: [instance]
TASK [Clean local ssh config] **************************************************
Tuesday 17 March 2026 11:05:54 +0000 (0:00:00.227) 0:01:40.668 *********
TASK [ssh_jumper : Remove Include cifmw_ssh_config.d] **************************
Tuesday 17 March 2026 11:05:54 +0000 (0:00:00.072) 0:01:40.741 *********
ok: [instance -> localhost]
TASK [ssh_jumper : Remove cifmw_ssh_config.d directory] ************************
Tuesday 17 March 2026 11:05:55 +0000 (0:00:00.191) 0:01:40.933 *********
ok: [instance -> localhost]
TASK [dnsmasq : Cleaning dnsmasq] **********************************************
Tuesday 17 March 2026 11:05:55 +0000 (0:00:00.201) 0:01:41.134 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/configure.yml for instance
TASK [dnsmasq : Install needed packages] ***************************************
Tuesday 17 March 2026 11:05:55 +0000 (0:00:00.056) 0:01:41.191 *********
changed: [instance]
TASK [dnsmasq : Ensure SELinux knows about the new files and directories] ******
Tuesday 17 March 2026 11:05:58 +0000 (0:00:03.618) 0:01:44.810 *********
ok: [instance] => (item={'target': '/etc/cifmw-dnsmasq.conf', 'setype': 'dnsmasq_etc_t'})
ok: [instance] => (item={'target': '/etc/cifmw-dnsmasq.d(/.*)?', 'setype': 'dnsmasq_etc_t'})
ok: [instance] => (item={'target': '/var/run/cifmw-dnsmasq.pid', 'setype': 'dnsmasq_var_run_t'})
TASK [dnsmasq : Manage configuration directory] ********************************
Tuesday 17 March 2026 11:06:00 +0000 (0:00:01.223) 0:01:46.034 *********
ok: [instance]
TASK [dnsmasq : Manage systemd unit file] **************************************
Tuesday 17 March 2026 11:06:00 +0000 (0:00:00.206) 0:01:46.240 *********
skipping: [instance]
TASK [dnsmasq : Manage base configuration file] ********************************
Tuesday 17 March 2026 11:06:00 +0000 (0:00:00.030) 0:01:46.271 *********
skipping: [instance]
TASK [dnsmasq : Render listener configuration] *********************************
Tuesday 17 March 2026 11:06:00 +0000 (0:00:00.048) 0:01:46.320 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/listener.yml for instance
TASK [dnsmasq : Create listener configuration file] ****************************
Tuesday 17 March 2026 11:06:00 +0000 (0:00:00.051) 0:01:46.371 *********
skipping: [instance]
TASK [dnsmasq : Remove listener configuration file] ****************************
Tuesday 17 March 2026 11:06:00 +0000 (0:00:00.030) 0:01:46.402 *********
ok: [instance]
TASK [dnsmasq : Render dns configuration] **************************************
Tuesday 17 March 2026 11:06:00 +0000 (0:00:00.205) 0:01:46.608 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/dns.yml for instance
TASK [dnsmasq : Create dns configuration file] *********************************
Tuesday 17 March 2026 11:06:00 +0000 (0:00:00.049) 0:01:46.658 *********
skipping: [instance]
TASK [dnsmasq : Remove dns configuration file] *********************************
Tuesday 17 March 2026 11:06:00 +0000 (0:00:00.029) 0:01:46.688 *********
ok: [instance]
TASK [dnsmasq : Add localhost addresses from defined dnsmasq listen addresses to loopback interface] ***
Tuesday 17 March 2026 11:06:01 +0000 (0:00:00.201) 0:01:46.889 *********
skipping: [instance]
TASK [dnsmasq : Enable and start service] **************************************
Tuesday 17 March 2026 11:06:01 +0000 (0:00:00.028) 0:01:46.918 *********
skipping: [instance]
TASK [dnsmasq : Stop service] **************************************************
Tuesday 17 March 2026 11:06:01 +0000 (0:00:00.030) 0:01:46.948 *********
ok: [instance]
TASK [dnsmasq : Remove unit file] **********************************************
Tuesday 17 March 2026 11:06:01 +0000 (0:00:00.505) 0:01:47.453 *********
ok: [instance]
TASK [dnsmasq : Remove main configuration files] *******************************
Tuesday 17 March 2026 11:06:01 +0000 (0:00:00.206) 0:01:47.659 *********
ok: [instance] => (item=/etc/cifmw-dnsmasq.conf)
ok: [instance] => (item=/etc/cifmw-dnsmasq.d)
TASK [dnsmasq : Remove lease file] *********************************************
Tuesday 17 March 2026 11:06:02 +0000 (0:00:00.365) 0:01:48.024 *********
ok: [instance]
TASK [radvd : Gather package facts] ********************************************
Tuesday 17 March 2026 11:06:02 +0000 (0:00:00.212) 0:01:48.237 *********
ok: [instance]
TASK [radvd : Stop and disable radvd service] **********************************
Tuesday 17 March 2026 11:06:02 +0000 (0:00:00.470) 0:01:48.707 *********
skipping: [instance]
TASK [radvd : Remove radvd configuration file] *********************************
Tuesday 17 March 2026 11:06:02 +0000 (0:00:00.037) 0:01:48.744 *********
ok: [instance]
TASK [radvd : Remove configuration directory] **********************************
Tuesday 17 March 2026 11:06:03 +0000 (0:00:00.202) 0:01:48.946 *********
ok: [instance]
TASK [radvd : Remove radvd package] ********************************************
Tuesday 17 March 2026 11:06:03 +0000 (0:00:00.221) 0:01:49.168 *********
skipping: [instance]
TASK [libvirt_manager : Ensure output directory exists] ************************
Tuesday 17 March 2026 11:06:03 +0000 (0:00:00.062) 0:01:49.231 *********
ok: [instance]
TASK [libvirt_manager : Get vmx/svm extensions from /proc/cpuinfo] *************
Tuesday 17 March 2026 11:06:03 +0000 (0:00:00.184) 0:01:49.416 *********
changed: [instance]
TASK [libvirt_manager : Check if KVM is enabled] *******************************
Tuesday 17 March 2026 11:06:03 +0000 (0:00:00.180) 0:01:49.596 *********
ok: [instance]
TASK [libvirt_manager : Fail if KVM not enabled] *******************************
Tuesday 17 March 2026 11:06:03 +0000 (0:00:00.198) 0:01:49.795 *********
skipping: [instance]
TASK [libvirt_manager : Check if VMX virtualization] ***************************
Tuesday 17 March 2026 11:06:03 +0000 (0:00:00.034) 0:01:49.829 *********
skipping: [instance]
TASK [libvirt_manager : Check if SVM virtualization] ***************************
Tuesday 17 March 2026 11:06:04 +0000 (0:00:00.031) 0:01:49.860 *********
ok: [instance]
TASK [libvirt_manager : Enable VMX virtualization] *****************************
Tuesday 17 March 2026 11:06:04 +0000 (0:00:00.034) 0:01:49.895 *********
skipping: [instance]
TASK [libvirt_manager : Install packages required for using KVM] ***************
Tuesday 17 March 2026 11:06:04 +0000 (0:00:00.032) 0:01:49.927 *********
changed: [instance]
TASK [libvirt_manager : Create rules.d polkit folder] **************************
Tuesday 17 March 2026 11:07:12 +0000 (0:01:08.759) 0:02:58.686 *********
changed: [instance]
TASK [libvirt_manager : Enable UNIX socket PolicyKit auth] *********************
Tuesday 17 March 2026 11:07:13 +0000 (0:00:00.209) 0:02:58.896 *********
changed: [instance]
TASK [libvirt_manager : Restart service polkit service] ************************
Tuesday 17 March 2026 11:07:13 +0000 (0:00:00.383) 0:02:59.280 *********
changed: [instance]
TASK [libvirt_manager : Remove directory for service override] *****************
Tuesday 17 March 2026 11:07:13 +0000 (0:00:00.565) 0:02:59.846 *********
ok: [instance]
TASK [libvirt_manager : Reload systemctl and start/enable virtproxyd.service] ***
Tuesday 17 March 2026 11:07:14 +0000 (0:00:00.200) 0:03:00.046 *********
ok: [instance]
TASK [libvirt_manager : Ensure firewalld service is up] ************************
Tuesday 17 March 2026 11:07:14 +0000 (0:00:00.495) 0:03:00.542 *********
changed: [instance]
TASK [libvirt_manager : Ensure libvirt modular driver daemons are started.] ****
Tuesday 17 March 2026 11:07:15 +0000 (0:00:00.755) 0:03:01.297 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/drivers.yml for instance => (item=qemu)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/drivers.yml for instance => (item=interface)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/drivers.yml for instance => (item=network)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/drivers.yml for instance => (item=nodedev)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/drivers.yml for instance => (item=nwfilter)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/drivers.yml for instance => (item=secret)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/drivers.yml for instance => (item=storage)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/drivers.yml for instance => (item=proxy)
TASK [libvirt_manager : Ensure read-write socket is enabled for qemu.] *********
Tuesday 17 March 2026 11:07:15 +0000 (0:00:00.177) 0:03:01.475 *********
changed: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for qemu.] **********
Tuesday 17 March 2026 11:07:16 +0000 (0:00:00.390) 0:03:01.865 *********
changed: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for qemu.] **************
Tuesday 17 March 2026 11:07:16 +0000 (0:00:00.390) 0:03:02.255 *********
changed: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for interface.] ****
Tuesday 17 March 2026 11:07:16 +0000 (0:00:00.407) 0:03:02.663 *********
changed: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for interface.] *****
Tuesday 17 March 2026 11:07:17 +0000 (0:00:00.398) 0:03:03.062 *********
changed: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for interface.] *********
Tuesday 17 March 2026 11:07:17 +0000 (0:00:00.386) 0:03:03.448 *********
changed: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for network.] ******
Tuesday 17 March 2026 11:07:18 +0000 (0:00:00.417) 0:03:03.866 *********
changed: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for network.] *******
Tuesday 17 March 2026 11:07:18 +0000 (0:00:00.492) 0:03:04.358 *********
changed: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for network.] ***********
Tuesday 17 March 2026 11:07:18 +0000 (0:00:00.411) 0:03:04.770 *********
changed: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for nodedev.] ******
Tuesday 17 March 2026 11:07:19 +0000 (0:00:00.436) 0:03:05.206 *********
changed: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for nodedev.] *******
Tuesday 17 March 2026 11:07:19 +0000 (0:00:00.386) 0:03:05.592 *********
changed: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for nodedev.] ***********
Tuesday 17 March 2026 11:07:20 +0000 (0:00:00.407) 0:03:05.999 *********
changed: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for nwfilter.] *****
Tuesday 17 March 2026 11:07:20 +0000 (0:00:00.404) 0:03:06.404 *********
changed: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for nwfilter.] ******
Tuesday 17 March 2026 11:07:21 +0000 (0:00:01.394) 0:03:07.799 *********
changed: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for nwfilter.] **********
Tuesday 17 March 2026 11:07:22 +0000 (0:00:00.387) 0:03:08.186 *********
changed: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for secret.] *******
Tuesday 17 March 2026 11:07:22 +0000 (0:00:00.400) 0:03:08.587 *********
changed: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for secret.] ********
Tuesday 17 March 2026 11:07:23 +0000 (0:00:00.397) 0:03:08.984 *********
changed: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for secret.] ************
Tuesday 17 March 2026 11:07:23 +0000 (0:00:00.433) 0:03:09.418 *********
changed: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for storage.] ******
Tuesday 17 March 2026 11:07:23 +0000 (0:00:00.425) 0:03:09.843 *********
changed: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for storage.] *******
Tuesday 17 March 2026 11:07:24 +0000 (0:00:00.407) 0:03:10.251 *********
changed: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for storage.] ***********
Tuesday 17 March 2026 11:07:24 +0000 (0:00:00.402) 0:03:10.654 *********
changed: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for proxy.] ********
Tuesday 17 March 2026 11:07:25 +0000 (0:00:00.421) 0:03:11.075 *********
changed: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for proxy.] *********
Tuesday 17 March 2026 11:07:25 +0000 (0:00:00.390) 0:03:11.466 *********
changed: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for proxy.] *************
Tuesday 17 March 2026 11:07:26 +0000 (0:00:00.406) 0:03:11.872 *********
changed: [instance]
TASK [libvirt_manager : Manage service for older releases] *********************
Tuesday 17 March 2026 11:07:26 +0000 (0:00:00.377) 0:03:12.250 *********
skipping: [instance]
TASK [libvirt_manager : Get libvirt group users] *******************************
Tuesday 17 March 2026 11:07:26 +0000 (0:00:00.155) 0:03:12.405 *********
ok: [instance]
TASK [libvirt_manager : Add user if not exists in libvirt group] ***************
Tuesday 17 March 2026 11:07:26 +0000 (0:00:00.320) 0:03:12.725 *********
changed: [instance]
TASK [libvirt_manager : Allow QEMU on home directory for the storage access] ***
Tuesday 17 March 2026 11:07:27 +0000 (0:00:00.532) 0:03:13.258 *********
changed: [instance]
TASK [libvirt_manager : Inject system connection parameters in bashrc] *********
Tuesday 17 March 2026 11:07:27 +0000 (0:00:00.372) 0:03:13.631 *********
[WARNING]: Reset is not implemented for this connection
changed: [instance]
TASK [libvirt_manager : Ensure we reload user env] *****************************
Tuesday 17 March 2026 11:07:27 +0000 (0:00:00.229) 0:03:13.860 *********
TASK [libvirt_manager : Deactivate default] ************************************
Tuesday 17 March 2026 11:07:28 +0000 (0:00:00.054) 0:03:13.915 *********
ok: [instance]
TASK [libvirt_manager : Removing default] **************************************
Tuesday 17 March 2026 11:07:29 +0000 (0:00:01.223) 0:03:15.139 *********
ok: [instance]
TASK [Ensure we use dnsmasq for NetworkManager resolver] ***********************
Tuesday 17 March 2026 11:07:29 +0000 (0:00:00.328) 0:03:15.467 *********
changed: [instance]
TASK [Ensure we delegate .utility zone to our own instance] ********************
Tuesday 17 March 2026 11:07:30 +0000 (0:00:00.422) 0:03:15.890 *********
changed: [instance]
TASK [Restart NetworkManager] **************************************************
Tuesday 17 March 2026 11:07:30 +0000 (0:00:00.428) 0:03:16.318 *********
changed: [instance]
TASK [Ensure ocp_volumes exists] ***********************************************
Tuesday 17 March 2026 11:07:30 +0000 (0:00:00.488) 0:03:16.807 *********
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=115 changed=56 unreachable=0 failed=0 skipped=86 rescued=0 ignored=0
Tuesday 17 March 2026 11:07:31 +0000 (0:00:00.324) 0:03:17.131 *********
===============================================================================
libvirt_manager : Install packages required for using KVM -------------- 68.76s
test_deps : Install selinux python libs -------------------------------- 61.11s
repo_setup : Initialize python venv and install requirements ------------ 7.39s
ci_setup : Install openshift client ------------------------------------- 5.88s
ci_setup : Install needed packages -------------------------------------- 4.01s
dnsmasq : Install needed packages --------------------------------------- 3.62s
libvirt_manager : Populate service facts -------------------------------- 1.70s
libvirt_manager : Ensure read-write socket is enabled for nwfilter. ----- 1.39s
libvirt_manager : Remove workload and volumes --------------------------- 1.28s
libvirt_manager : Deactivate default ------------------------------------ 1.22s
dnsmasq : Ensure SELinux knows about the new files and directories ------ 1.22s
test_deps : Install python yaml libs ------------------------------------ 1.16s
podman : Ensure podman is installed ------------------------------------- 1.15s
repo_setup : Get repo-setup repository ---------------------------------- 1.07s
ci_setup : Manage directories ------------------------------------------- 0.94s
Gathering Facts --------------------------------------------------------- 0.82s
repo_setup : Run repo-setup --------------------------------------------- 0.80s
repo_setup : Make sure git-core package is installed -------------------- 0.78s
libvirt_manager : Ensure firewalld service is up ------------------------ 0.76s
virtualbmc : Remove vbmc files ------------------------------------------ 0.70s
PLAY [Test boot_order configuration] *******************************************
TASK [Gathering Facts] *********************************************************
Tuesday 17 March 2026 11:07:31 +0000 (0:00:00.039) 0:00:00.039 *********
ok: [instance]
TASK [Load networking definition] **********************************************
Tuesday 17 March 2026 11:07:32 +0000 (0:00:01.009) 0:00:01.049 *********
ok: [instance]
TASK [libvirt_manager : Import layout generator if needed] *********************
Tuesday 17 March 2026 11:07:32 +0000 (0:00:00.043) 0:00:01.092 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/generate_layout.yml for instance
TASK [libvirt_manager : Chose right parameter for layout definition] ***********
Tuesday 17 March 2026 11:07:32 +0000 (0:00:00.072) 0:00:01.165 *********
ok: [instance]
TASK [libvirt_manager : Patch the layout if needed] ****************************
Tuesday 17 March 2026 11:07:33 +0000 (0:00:00.128) 0:00:01.294 *********
skipping: [instance]
TASK [libvirt_manager : Enable forwarding in the libvirt zone] *****************
Tuesday 17 March 2026 11:07:33 +0000 (0:00:00.121) 0:00:01.416 *********
changed: [instance]
TASK [libvirt_manager : Enable masquerading for public traffic] ****************
Tuesday 17 March 2026 11:07:33 +0000 (0:00:00.550) 0:00:01.966 *********
changed: [instance]
TASK [libvirt_manager : Ensure firewalld is restarts] **************************
Tuesday 17 March 2026 11:07:34 +0000 (0:00:00.547) 0:00:02.514 *********
RUNNING HANDLER [libvirt_manager : Restart firewalld] **************************
Tuesday 17 March 2026 11:07:34 +0000 (0:00:00.076) 0:00:02.590 *********
changed: [instance]
TASK [Deploy virtualbmc] *******************************************************
Tuesday 17 March 2026 11:07:35 +0000 (0:00:00.915) 0:00:03.505 *********
skipping: [instance]
TASK [libvirt_manager : Let the project know we have vbmc available] ***********
Tuesday 17 March 2026 11:07:35 +0000 (0:00:00.061) 0:00:03.567 *********
skipping: [instance]
TASK [libvirt_manager : Create needed workload directory] **********************
Tuesday 17 March 2026 11:07:35 +0000 (0:00:00.116) 0:00:03.683 *********
changed: [instance] => (item=workload)
changed: [instance] => (item=reproducer-inventory)
changed: [instance] => (item=volumes)
TASK [libvirt_manager : Allow QEMU on workload directory] **********************
Tuesday 17 March 2026 11:07:36 +0000 (0:00:00.688) 0:00:04.371 *********
changed: [instance] => (item=workload)
changed: [instance] => (item=volumes)
TASK [libvirt_manager : Generate networking data] ******************************
Tuesday 17 March 2026 11:07:36 +0000 (0:00:00.601) 0:00:04.973 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/generate_networking_data.yml for instance
TASK [libvirt_manager : Ensure fact is existing, and empty] ********************
Tuesday 17 March 2026 11:07:36 +0000 (0:00:00.170) 0:00:05.143 *********
ok: [instance]
TASK [libvirt_manager : Check if we get an existing interfaces-info.yml] *******
Tuesday 17 March 2026 11:07:36 +0000 (0:00:00.045) 0:00:05.189 *********
ok: [instance]
TASK [libvirt_manager : Load file if exists] ***********************************
Tuesday 17 March 2026 11:07:37 +0000 (0:00:00.311) 0:00:05.500 *********
skipping: [instance]
TASK [libvirt_manager : Update fact with existing content] *********************
Tuesday 17 March 2026 11:07:37 +0000 (0:00:00.055) 0:00:05.556 *********
skipping: [instance]
TASK [libvirt_manager : Generate VM list] **************************************
Tuesday 17 March 2026 11:07:37 +0000 (0:00:00.061) 0:00:05.618 *********
ok: [instance]
TASK [libvirt_manager : Generate/update mapping all nodes] *********************
Tuesday 17 March 2026 11:07:37 +0000 (0:00:00.154) 0:00:05.772 *********
ok: [instance] => (item={'key': 'disk-first-0', 'value': 'disk_first'})
ok: [instance] => (item={'key': 'net-first-0', 'value': 'net_first'})
ok: [instance] => (item={'key': 'net-only-0', 'value': 'net_only'})
ok: [instance] => (item={'key': 'no-boot-order-0', 'value': 'no_boot_order'})
TASK [libvirt_manager : Append baremetal nodes if needed] **********************
Tuesday 17 March 2026 11:07:37 +0000 (0:00:00.181) 0:00:05.953 *********
skipping: [instance]
TASK [libvirt_manager : Dump MAC mapping] **************************************
Tuesday 17 March 2026 11:07:37 +0000 (0:00:00.065) 0:00:06.018 *********
changed: [instance]
TASK [libvirt_manager : Inject all VMs in the inventory] ***********************
Tuesday 17 March 2026 11:07:38 +0000 (0:00:00.526) 0:00:06.545 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/add_vm_to_inventory.yml for instance => (item=Adding disk-first-0 to disk_firsts)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/add_vm_to_inventory.yml for instance => (item=Adding net-first-0 to net_firsts)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/add_vm_to_inventory.yml for instance => (item=Adding net-only-0 to net_onlys)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/add_vm_to_inventory.yml for instance => (item=Adding no-boot-order-0 to no_boot_orders)
TASK [libvirt_manager : Add host to runtime inventory] *************************
Tuesday 17 March 2026 11:07:38 +0000 (0:00:00.192) 0:00:06.738 *********
changed: [instance]
TASK [libvirt_manager : Ensure group section exists] ***************************
Tuesday 17 March 2026 11:07:38 +0000 (0:00:00.086) 0:00:06.824 *********
changed: [instance]
TASK [libvirt_manager : Append host under proper group] ************************
Tuesday 17 March 2026 11:07:38 +0000 (0:00:00.325) 0:00:07.150 *********
changed: [instance]
TASK [libvirt_manager : daniel debug] ******************************************
Tuesday 17 March 2026 11:07:39 +0000 (0:00:00.255) 0:00:07.406 *********
changed: [instance]
TASK [libvirt_manager : Add host to runtime inventory] *************************
Tuesday 17 March 2026 11:07:39 +0000 (0:00:00.437) 0:00:07.843 *********
changed: [instance]
TASK [libvirt_manager : Ensure group section exists] ***************************
Tuesday 17 March 2026 11:07:39 +0000 (0:00:00.146) 0:00:07.990 *********
changed: [instance]
TASK [libvirt_manager : Append host under proper group] ************************
Tuesday 17 March 2026 11:07:40 +0000 (0:00:00.262) 0:00:08.252 *********
changed: [instance]
TASK [libvirt_manager : daniel debug] ******************************************
Tuesday 17 March 2026 11:07:40 +0000 (0:00:00.265) 0:00:08.518 *********
changed: [instance]
TASK [libvirt_manager : Add host to runtime inventory] *************************
Tuesday 17 March 2026 11:07:40 +0000 (0:00:00.431) 0:00:08.950 *********
changed: [instance]
TASK [libvirt_manager : Ensure group section exists] ***************************
Tuesday 17 March 2026 11:07:40 +0000 (0:00:00.142) 0:00:09.092 *********
changed: [instance]
TASK [libvirt_manager : Append host under proper group] ************************
Tuesday 17 March 2026 11:07:41 +0000 (0:00:00.244) 0:00:09.337 *********
changed: [instance]
TASK [libvirt_manager : daniel debug] ******************************************
Tuesday 17 March 2026 11:07:41 +0000 (0:00:00.258) 0:00:09.595 *********
changed: [instance]
TASK [libvirt_manager : Add host to runtime inventory] *************************
Tuesday 17 March 2026 11:07:41 +0000 (0:00:00.427) 0:00:10.022 *********
changed: [instance]
TASK [libvirt_manager : Ensure group section exists] ***************************
Tuesday 17 March 2026 11:07:41 +0000 (0:00:00.128) 0:00:10.151 *********
changed: [instance]
TASK [libvirt_manager : Append host under proper group] ************************
Tuesday 17 March 2026 11:07:42 +0000 (0:00:00.319) 0:00:10.470 *********
changed: [instance]
TASK [libvirt_manager : daniel debug] ******************************************
Tuesday 17 March 2026 11:07:42 +0000 (0:00:00.261) 0:00:10.732 *********
changed: [instance]
TASK [libvirt_manager : Check if ini inventory file exists] ********************
Tuesday 17 March 2026 11:07:42 +0000 (0:00:00.447) 0:00:11.180 *********
ok: [instance]
TASK [libvirt_manager : Test] **************************************************
Tuesday 17 March 2026 11:07:43 +0000 (0:00:00.218) 0:00:11.398 *********
changed: [instance]
TASK [libvirt_manager : Convert ini inventory file into yaml] ******************
Tuesday 17 March 2026 11:07:43 +0000 (0:00:00.662) 0:00:12.061 *********
fatal: [instance]: FAILED! => changed=true
cmd: |-
/usr/local/bin/ansible-inventory -i /home/zuul/libvirt_inventory.ini -y --list > /home/zuul/libvirt_inventory.yaml
delta: '0:00:00.005593'
end: '2026-03-17 11:07:44.044919'
msg: non-zero return code
rc: 127
start: '2026-03-17 11:07:44.039326'
stderr: '/bin/sh: line 1: /usr/local/bin/ansible-inventory: No such file or directory'
stderr_lines: <omitted>
stdout: ''
stdout_lines: <omitted>
...ignoring
TASK [networking_mapper : Check for Networking Definition file existence] ******
Tuesday 17 March 2026 11:07:44 +0000 (0:00:00.231) 0:00:12.292 *********
skipping: [instance]
TASK [networking_mapper : Load the Networking Definition from file] ************
Tuesday 17 March 2026 11:07:44 +0000 (0:00:00.050) 0:00:12.343 *********
skipping: [instance]
TASK [networking_mapper : Check for interfaces info file existence] ************
Tuesday 17 March 2026 11:07:44 +0000 (0:00:00.053) 0:00:12.396 *********
skipping: [instance]
TASK [networking_mapper : Load the interfaces info from file] ******************
Tuesday 17 March 2026 11:07:44 +0000 (0:00:00.063) 0:00:12.460 *********
skipping: [instance]
TASK [networking_mapper : Ensure local fact is empty] **************************
Tuesday 17 March 2026 11:07:44 +0000 (0:00:00.087) 0:00:12.547 *********
ok: [instance]
TASK [networking_mapper : Set the input Networking Definition and patch it if needed] ***
Tuesday 17 March 2026 11:07:44 +0000 (0:00:00.047) 0:00:12.595 *********
ok: [instance] => (item={'networks': {'ctlplane': {'network': '192.168.140.0/24', 'gateway': '192.168.140.1', 'mtu': 1500}}, 'group-templates': {'disk_firsts': {'network-template': {'range': {'start': 10, 'length': 1}}, 'networks': {'ctlplane': {}}}, 'net_firsts': {'network-template': {'range': {'start': 20, 'length': 1}}, 'networks': {'ctlplane': {}}}, 'net_onlys': {'network-template': {'range': {'start': 30, 'length': 1}}, 'networks': {'ctlplane': {}}}, 'no_boot_orders': {'network-template': {'range': {'start': 40, 'length': 1}}, 'networks': {'ctlplane': {}}}}})
TASK [networking_mapper : Gather facts if requested] ***************************
Tuesday 17 March 2026 11:07:44 +0000 (0:00:00.143) 0:00:12.739 *********
skipping: [instance]
TASK [networking_mapper : Ensure CI infrastructure dir exists] *****************
Tuesday 17 March 2026 11:07:44 +0000 (0:00:00.049) 0:00:12.788 *********
changed: [instance]
TASK [networking_mapper : Write the Networking Definition to file] *************
Tuesday 17 March 2026 11:07:44 +0000 (0:00:00.249) 0:00:13.038 *********
changed: [instance]
TASK [networking_mapper : Call the networking mapper] **************************
Tuesday 17 March 2026 11:07:45 +0000 (0:00:00.490) 0:00:13.529 *********
ok: [instance]
TASK [networking_mapper : Set networking mapper facts] *************************
Tuesday 17 March 2026 11:07:45 +0000 (0:00:00.114) 0:00:13.643 *********
ok: [instance]
TASK [networking_mapper : Write the Networking Environment Definition to file] ***
Tuesday 17 March 2026 11:07:45 +0000 (0:00:00.054) 0:00:13.698 *********
changed: [instance]
TASK [libvirt_manager : Manage networks if needed] *****************************
Tuesday 17 March 2026 11:07:45 +0000 (0:00:00.482) 0:00:14.180 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/create_networks.yml for instance
TASK [libvirt_manager : Define the localized variables for performing the tasks here.] ***
Tuesday 17 March 2026 11:07:46 +0000 (0:00:00.167) 0:00:14.348 *********
ok: [instance] => (item=public)
ok: [instance] => (item=osp_trunk)
TASK [libvirt_manager : Ensure networks are defined] ***************************
Tuesday 17 March 2026 11:07:46 +0000 (0:00:00.078) 0:00:14.426 *********
changed: [instance] => (item=cifmw-public)
changed: [instance] => (item=cifmw-osp_trunk)
TASK [libvirt_manager : Ensure networks are created/started] *******************
Tuesday 17 March 2026 11:07:46 +0000 (0:00:00.624) 0:00:15.051 *********
ok: [instance] => (item=cifmw-public)
ok: [instance] => (item=cifmw-osp_trunk)
TASK [libvirt_manager : Ensure networks are active] ****************************
Tuesday 17 March 2026 11:07:47 +0000 (0:00:00.782) 0:00:15.834 *********
ok: [instance] => (item=cifmw-public)
ok: [instance] => (item=cifmw-osp_trunk)
TASK [libvirt_manager : Ensure networks enabled to autostart] ******************
Tuesday 17 March 2026 11:07:48 +0000 (0:00:00.555) 0:00:16.389 *********
changed: [instance] => (item=cifmw-public)
changed: [instance] => (item=cifmw-osp_trunk)
TASK [libvirt_manager : Add a dummy interface to bridges if required] **********
Tuesday 17 March 2026 11:07:48 +0000 (0:00:00.541) 0:00:16.930 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/create_networks_dummy_interfaces.yml for instance
TASK [libvirt_manager : Fetch present bridge interfaces] ***********************
Tuesday 17 March 2026 11:07:48 +0000 (0:00:00.174) 0:00:17.105 *********
ok: [instance]
TASK [libvirt_manager : Fetch bridges ports link info] *************************
Tuesday 17 March 2026 11:07:49 +0000 (0:00:00.251) 0:00:17.357 *********
ok: [instance] => (item=cifmw-public)
ok: [instance] => (item=cifmw-osp_trunk)
TASK [Create dummy interfaces to ensure bridges are UP] ************************
Tuesday 17 March 2026 11:07:49 +0000 (0:00:00.459) 0:00:17.817 *********
TASK [ci_nmstate : Ensure we have needed facts] ********************************
Tuesday 17 March 2026 11:07:49 +0000 (0:00:00.126) 0:00:17.943 *********
skipping: [instance]
TASK [ci_nmstate : Install required packages on instance] **********************
Tuesday 17 March 2026 11:07:50 +0000 (0:00:00.258) 0:00:18.201 *********
changed: [instance]
TASK [ci_nmstate : Create the target NMstate dump directory] *******************
Tuesday 17 March 2026 11:08:00 +0000 (0:00:10.961) 0:00:29.163 *********
changed: [instance]
TASK [ci_nmstate : Save nmstate state for instance] ****************************
Tuesday 17 March 2026 11:08:01 +0000 (0:00:00.252) 0:00:29.416 *********
changed: [instance]
TASK [ci_nmstate : Apply the desidered state on instance] **********************
Tuesday 17 March 2026 11:08:01 +0000 (0:00:00.458) 0:00:29.875 *********
changed: [instance]
TASK [ci_nmstate : Save nmstate debugging data for instance] *******************
Tuesday 17 March 2026 11:08:03 +0000 (0:00:01.952) 0:00:31.827 *********
changed: [instance]
TASK [Create extra network configuration] **************************************
Tuesday 17 March 2026 11:08:04 +0000 (0:00:00.417) 0:00:32.244 *********
skipping: [instance]
TASK [libvirt_manager : Ensure extra networks is in correct zone] **************
Tuesday 17 March 2026 11:08:04 +0000 (0:00:00.057) 0:00:32.301 *********
skipping: [instance]
TASK [libvirt_manager : Refresh networking facts on host] **********************
Tuesday 17 March 2026 11:08:04 +0000 (0:00:00.058) 0:00:32.359 *********
ok: [instance]
TASK [libvirt_manager : Build needed network/dnsmasq related content] **********
Tuesday 17 March 2026 11:08:04 +0000 (0:00:00.498) 0:00:32.858 *********
ok: [instance] => (item=cifmw-public)
ok: [instance] => (item=cifmw-osp_trunk)
TASK [dnsmasq : Install needed packages] ***************************************
Tuesday 17 March 2026 11:08:04 +0000 (0:00:00.243) 0:00:33.101 *********
ok: [instance]
TASK [dnsmasq : Ensure SELinux knows about the new files and directories] ******
Tuesday 17 March 2026 11:08:06 +0000 (0:00:01.380) 0:00:34.482 *********
changed: [instance] => (item={'target': '/etc/cifmw-dnsmasq.conf', 'setype': 'dnsmasq_etc_t'})
changed: [instance] => (item={'target': '/etc/cifmw-dnsmasq.d(/.*)?', 'setype': 'dnsmasq_etc_t'})
changed: [instance] => (item={'target': '/var/run/cifmw-dnsmasq.pid', 'setype': 'dnsmasq_var_run_t'})
TASK [dnsmasq : Manage configuration directory] ********************************
Tuesday 17 March 2026 11:08:09 +0000 (0:00:03.618) 0:00:38.100 *********
changed: [instance]
TASK [dnsmasq : Manage systemd unit file] **************************************
Tuesday 17 March 2026 11:08:10 +0000 (0:00:00.311) 0:00:38.412 *********
changed: [instance]
TASK [dnsmasq : Manage base configuration file] ********************************
Tuesday 17 March 2026 11:08:10 +0000 (0:00:00.413) 0:00:38.825 *********
changed: [instance]
TASK [dnsmasq : Render listener configuration] *********************************
Tuesday 17 March 2026 11:08:11 +0000 (0:00:00.453) 0:00:39.279 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/listener.yml for instance
TASK [dnsmasq : Create listener configuration file] ****************************
Tuesday 17 March 2026 11:08:11 +0000 (0:00:00.073) 0:00:39.353 *********
changed: [instance]
TASK [dnsmasq : Remove listener configuration file] ****************************
Tuesday 17 March 2026 11:08:11 +0000 (0:00:00.489) 0:00:39.843 *********
skipping: [instance]
TASK [dnsmasq : Render dns configuration] **************************************
Tuesday 17 March 2026 11:08:11 +0000 (0:00:00.044) 0:00:39.887 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/dns.yml for instance
TASK [dnsmasq : Create dns configuration file] *********************************
Tuesday 17 March 2026 11:08:11 +0000 (0:00:00.080) 0:00:39.968 *********
changed: [instance]
TASK [dnsmasq : Remove dns configuration file] *********************************
Tuesday 17 March 2026 11:08:12 +0000 (0:00:00.460) 0:00:40.428 *********
skipping: [instance]
TASK [dnsmasq : Add localhost addresses from defined dnsmasq listen addresses to loopback interface] ***
Tuesday 17 March 2026 11:08:12 +0000 (0:00:00.045) 0:00:40.474 *********
ok: [instance] => (item=127.0.0.2)
TASK [dnsmasq : Enable and start service] **************************************
Tuesday 17 March 2026 11:08:12 +0000 (0:00:00.262) 0:00:40.736 *********
changed: [instance]
TASK [dnsmasq : Stop service] **************************************************
Tuesday 17 March 2026 11:08:13 +0000 (0:00:00.773) 0:00:41.510 *********
skipping: [instance]
TASK [dnsmasq : Remove unit file] **********************************************
Tuesday 17 March 2026 11:08:13 +0000 (0:00:00.048) 0:00:41.558 *********
skipping: [instance]
TASK [dnsmasq : Remove main configuration files] *******************************
Tuesday 17 March 2026 11:08:13 +0000 (0:00:00.081) 0:00:41.640 *********
skipping: [instance] => (item=/etc/cifmw-dnsmasq.conf)
skipping: [instance] => (item=/etc/cifmw-dnsmasq.d)
skipping: [instance]
TASK [Create dnsmasq networks] *************************************************
Tuesday 17 March 2026 11:08:13 +0000 (0:00:00.076) 0:00:41.716 *********
TASK [dnsmasq : Assert mandatory parameter] ************************************
Tuesday 17 March 2026 11:08:13 +0000 (0:00:00.145) 0:00:41.862 *********
ok: [instance] => changed=false
msg: All assertions passed
TASK [dnsmasq : Assert mandatory parameters for new network] *******************
Tuesday 17 March 2026 11:08:13 +0000 (0:00:00.100) 0:00:41.963 *********
ok: [instance] => changed=false
msg: All assertions passed
TASK [dnsmasq : Create network] ************************************************
Tuesday 17 March 2026 11:08:13 +0000 (0:00:00.064) 0:00:42.027 *********
changed: [instance]
TASK [dnsmasq : Remove network] ************************************************
Tuesday 17 March 2026 11:08:14 +0000 (0:00:00.519) 0:00:42.547 *********
skipping: [instance]
TASK [dnsmasq : Remove dhcp host files] ****************************************
Tuesday 17 March 2026 11:08:14 +0000 (0:00:00.046) 0:00:42.594 *********
skipping: [instance]
TASK [dnsmasq : Assert mandatory parameter] ************************************
Tuesday 17 March 2026 11:08:14 +0000 (0:00:00.072) 0:00:42.666 *********
ok: [instance] => changed=false
msg: All assertions passed
TASK [dnsmasq : Assert mandatory parameters for new network] *******************
Tuesday 17 March 2026 11:08:14 +0000 (0:00:00.095) 0:00:42.762 *********
ok: [instance] => changed=false
msg: All assertions passed
TASK [dnsmasq : Create network] ************************************************
Tuesday 17 March 2026 11:08:14 +0000 (0:00:00.062) 0:00:42.825 *********
changed: [instance]
TASK [dnsmasq : Remove network] ************************************************
Tuesday 17 March 2026 11:08:15 +0000 (0:00:00.459) 0:00:43.284 *********
skipping: [instance]
TASK [dnsmasq : Remove dhcp host files] ****************************************
Tuesday 17 March 2026 11:08:15 +0000 (0:00:00.043) 0:00:43.327 *********
skipping: [instance]
TASK [Deploy radvd for IPv6 router advertisements] *****************************
Tuesday 17 March 2026 11:08:15 +0000 (0:00:00.108) 0:00:43.435 *********
skipping: [instance]
TASK [libvirt_manager : Ensure network is in correct zone] *********************
Tuesday 17 March 2026 11:08:15 +0000 (0:00:00.055) 0:00:43.491 *********
changed: [instance] => (item=cifmw-public)
changed: [instance] => (item=cifmw-osp_trunk)
TASK [libvirt_manager : Extract IP address from network bridges] ***************
Tuesday 17 March 2026 11:08:15 +0000 (0:00:00.508) 0:00:44.000 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/network_bridge_info_gen.yml for instance => (item=cifmw-public)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/network_bridge_info_gen.yml for instance => (item=cifmw-osp_trunk)
TASK [libvirt_manager : Extract IP address from network bridges] ***************
Tuesday 17 March 2026 11:08:15 +0000 (0:00:00.091) 0:00:44.092 *********
ok: [instance]
TASK [libvirt_manager : Set network_bridge_info fact with network and address] ***
Tuesday 17 March 2026 11:08:16 +0000 (0:00:00.458) 0:00:44.550 *********
ok: [instance]
TASK [libvirt_manager : Extract IP address from network bridges] ***************
Tuesday 17 March 2026 11:08:16 +0000 (0:00:00.063) 0:00:44.613 *********
ok: [instance]
TASK [libvirt_manager : Set network_bridge_info fact with network and address] ***
Tuesday 17 March 2026 11:08:16 +0000 (0:00:00.233) 0:00:44.846 *********
ok: [instance]
TASK [libvirt_manager : Output _network_data] **********************************
Tuesday 17 March 2026 11:08:16 +0000 (0:00:00.060) 0:00:44.906 *********
changed: [instance]
TASK [libvirt_manager : Output pub_net] ****************************************
Tuesday 17 March 2026 11:08:17 +0000 (0:00:00.348) 0:00:45.255 *********
changed: [instance]
TASK [libvirt_manager : Output _cifmw_libvirt_manager_layout] ******************
Tuesday 17 March 2026 11:08:17 +0000 (0:00:00.348) 0:00:45.603 *********
changed: [instance]
TASK [libvirt_manager : Expose patch for networking_mapper] ********************
Tuesday 17 March 2026 11:08:17 +0000 (0:00:00.356) 0:00:45.960 *********
ok: [instance]
TASK [libvirt_manager : Save networking_mapper patch] **************************
Tuesday 17 March 2026 11:08:17 +0000 (0:00:00.117) 0:00:46.078 *********
changed: [instance]
TASK [networking_mapper : Check for Networking Definition file existence] ******
Tuesday 17 March 2026 11:08:18 +0000 (0:00:00.362) 0:00:46.440 *********
skipping: [instance]
TASK [networking_mapper : Load the Networking Definition from file] ************
Tuesday 17 March 2026 11:08:18 +0000 (0:00:00.082) 0:00:46.523 *********
skipping: [instance]
TASK [networking_mapper : Check for interfaces info file existence] ************
Tuesday 17 March 2026 11:08:18 +0000 (0:00:00.050) 0:00:46.573 *********
skipping: [instance]
TASK [networking_mapper : Load the interfaces info from file] ******************
Tuesday 17 March 2026 11:08:18 +0000 (0:00:00.047) 0:00:46.621 *********
skipping: [instance]
TASK [networking_mapper : Ensure local fact is empty] **************************
Tuesday 17 March 2026 11:08:18 +0000 (0:00:00.047) 0:00:46.669 *********
ok: [instance]
TASK [networking_mapper : Set the input Networking Definition and patch it if needed] ***
Tuesday 17 March 2026 11:08:18 +0000 (0:00:00.042) 0:00:46.711 *********
ok: [instance] => (item={'networks': {'ctlplane': {'network': '192.168.140.0/24', 'gateway': '192.168.140.1', 'mtu': 1500}}, 'group-templates': {'disk_firsts': {'network-template': {'range': {'start': 10, 'length': 1}}, 'networks': {'ctlplane': {}}}, 'net_firsts': {'network-template': {'range': {'start': 20, 'length': 1}}, 'networks': {'ctlplane': {}}}, 'net_onlys': {'network-template': {'range': {'start': 30, 'length': 1}}, 'networks': {'ctlplane': {}}}, 'no_boot_orders': {'network-template': {'range': {'start': 40, 'length': 1}}, 'networks': {'ctlplane': {}}}}})
ok: [instance] => (item={'networks': {'public': {'network-v4': '192.168.110.0/24'}}, 'group-templates': {'disk_firsts': {'networks': {'public': None}}, 'net_firsts': {'networks': {'public': None}}, 'net_onlys': {'networks': {'public': None}}, 'no_boot_orders': {'networks': {'public': None}}}})
TASK [networking_mapper : Gather facts if requested] ***************************
Tuesday 17 March 2026 11:08:18 +0000 (0:00:00.179) 0:00:46.891 *********
skipping: [instance]
TASK [networking_mapper : Ensure CI infrastructure dir exists] *****************
Tuesday 17 March 2026 11:08:18 +0000 (0:00:00.085) 0:00:46.976 *********
ok: [instance]
TASK [networking_mapper : Write the Networking Definition to file] *************
Tuesday 17 March 2026 11:08:19 +0000 (0:00:00.234) 0:00:47.211 *********
changed: [instance]
TASK [networking_mapper : Call the networking mapper] **************************
Tuesday 17 March 2026 11:08:19 +0000 (0:00:00.429) 0:00:47.640 *********
ok: [instance]
TASK [networking_mapper : Set networking mapper facts] *************************
Tuesday 17 March 2026 11:08:19 +0000 (0:00:00.100) 0:00:47.741 *********
ok: [instance]
TASK [networking_mapper : Write the Networking Environment Definition to file] ***
Tuesday 17 March 2026 11:08:19 +0000 (0:00:00.049) 0:00:47.791 *********
changed: [instance]
TASK [libvirt_manager : Be sure to save current state of networking_mapper environment] ***
Tuesday 17 March 2026 11:08:20 +0000 (0:00:00.444) 0:00:48.235 *********
ok: [instance]
TASK [libvirt_manager : Unset patch] *******************************************
Tuesday 17 March 2026 11:08:20 +0000 (0:00:00.048) 0:00:48.283 *********
ok: [instance]
TASK [libvirt_manager : Initialize empty _lm_dhcp_entries fact] ****************
Tuesday 17 March 2026 11:08:20 +0000 (0:00:00.041) 0:00:48.325 *********
ok: [instance]
TASK [libvirt_manager : Reserve IPs on networks] *******************************
Tuesday 17 March 2026 11:08:20 +0000 (0:00:00.042) 0:00:48.367 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/reserve_dnsmasq_ips.yml for instance => (item=ctlplane)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/reserve_dnsmasq_ips.yml for instance => (item=public)
TASK [libvirt_manager : Loop on host IPs] **************************************
Tuesday 17 March 2026 11:08:20 +0000 (0:00:00.117) 0:00:48.484 *********
ok: [instance] => (item=disk-first-0 - ctlplane)
ok: [instance] => (item=net-first-0 - ctlplane)
ok: [instance] => (item=net-only-0 - ctlplane)
ok: [instance] => (item=no-boot-order-0 - ctlplane)
TASK [libvirt_manager : Loop on host IPs] **************************************
Tuesday 17 March 2026 11:08:20 +0000 (0:00:00.182) 0:00:48.667 *********
ok: [instance] => (item=disk-first-0 - public)
ok: [instance] => (item=net-first-0 - public)
ok: [instance] => (item=net-only-0 - public)
ok: [instance] => (item=no-boot-order-0 - public)
TASK [Inject DHCP entries for net {{ net_name }}] ******************************
Tuesday 17 March 2026 11:08:20 +0000 (0:00:00.207) 0:00:48.874 *********
TASK [dnsmasq : Ensure we have the right data and type] ************************
Tuesday 17 March 2026 11:08:20 +0000 (0:00:00.094) 0:00:48.968 *********
ok: [instance]
TASK [dnsmasq : Assert we have needed host data] *******************************
Tuesday 17 March 2026 11:08:20 +0000 (0:00:00.099) 0:00:49.068 *********
ok: [instance] => (item={'network': 'osp_trunk', 'name': 'disk-first-0', 'state': 'present', 'mac': '52:54:00:1d:72:48', 'ips': ['192.168.140.10', ''], 'tag': 'disk_first'})
ok: [instance] => (item={'network': 'osp_trunk', 'name': 'net-first-0', 'state': 'present', 'mac': '52:54:01:8b:1b:d6', 'ips': ['192.168.140.20', ''], 'tag': 'net_first'})
ok: [instance] => (item={'network': 'osp_trunk', 'name': 'net-only-0', 'state': 'present', 'mac': '52:54:00:36:cb:6d', 'ips': ['192.168.140.30', ''], 'tag': 'net_only'})
ok: [instance] => (item={'network': 'osp_trunk', 'name': 'no-boot-order-0', 'state': 'present', 'mac': '52:54:00:6e:30:bb', 'ips': ['192.168.140.40', ''], 'tag': 'no_boot_order'})
ok: [instance] => (item={'network': 'public', 'name': 'disk-first-0', 'state': 'present', 'mac': '52:54:00:c1:0c:43', 'ips': ['192.168.110.10', ''], 'tag': 'disk_first'})
ok: [instance] => (item={'network': 'public', 'name': 'net-first-0', 'state': 'present', 'mac': '52:54:01:90:3c:b9', 'ips': ['192.168.110.20', ''], 'tag': 'net_first'})
ok: [instance] => (item={'network': 'public', 'name': 'net-only-0', 'state': 'present', 'mac': '52:54:02:20:dc:92', 'ips': ['192.168.110.30', ''], 'tag': 'net_only'})
ok: [instance] => (item={'network': 'public', 'name': 'no-boot-order-0', 'state': 'present', 'mac': '52:54:03:c9:2a:c8', 'ips': ['192.168.110.40', ''], 'tag': 'no_boot_order'})
TASK [dnsmasq : Ensure networks exists] ****************************************
Tuesday 17 March 2026 11:08:21 +0000 (0:00:00.139) 0:00:49.208 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/_check_net_status.yml for instance => (item=osp_trunk)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/_check_net_status.yml for instance => (item=public)
TASK [dnsmasq : Check network file status] *************************************
Tuesday 17 March 2026 11:08:21 +0000 (0:00:00.089) 0:00:49.297 *********
ok: [instance]
TASK [dnsmasq : Assert network exists] *****************************************
Tuesday 17 March 2026 11:08:21 +0000 (0:00:00.217) 0:00:49.514 *********
ok: [instance]
TASK [dnsmasq : Check network file status] *************************************
Tuesday 17 March 2026 11:08:21 +0000 (0:00:00.085) 0:00:49.600 *********
ok: [instance]
TASK [dnsmasq : Assert network exists] *****************************************
Tuesday 17 March 2026 11:08:21 +0000 (0:00:00.196) 0:00:49.796 *********
ok: [instance]
TASK [dnsmasq : Initialize empty dhcp_host_entries] ****************************
Tuesday 17 March 2026 11:08:21 +0000 (0:00:00.046) 0:00:49.842 *********
ok: [instance]
TASK [dnsmasq : Compute entry] *************************************************
Tuesday 17 March 2026 11:08:21 +0000 (0:00:00.041) 0:00:49.884 *********
ok: [instance] => (item={'network': 'osp_trunk', 'name': 'disk-first-0', 'state': 'present', 'mac': '52:54:00:1d:72:48', 'ips': ['192.168.140.10', ''], 'tag': 'disk_first'})
ok: [instance] => (item={'network': 'osp_trunk', 'name': 'net-first-0', 'state': 'present', 'mac': '52:54:01:8b:1b:d6', 'ips': ['192.168.140.20', ''], 'tag': 'net_first'})
ok: [instance] => (item={'network': 'osp_trunk', 'name': 'net-only-0', 'state': 'present', 'mac': '52:54:00:36:cb:6d', 'ips': ['192.168.140.30', ''], 'tag': 'net_only'})
ok: [instance] => (item={'network': 'osp_trunk', 'name': 'no-boot-order-0', 'state': 'present', 'mac': '52:54:00:6e:30:bb', 'ips': ['192.168.140.40', ''], 'tag': 'no_boot_order'})
ok: [instance] => (item={'network': 'public', 'name': 'disk-first-0', 'state': 'present', 'mac': '52:54:00:c1:0c:43', 'ips': ['192.168.110.10', ''], 'tag': 'disk_first'})
ok: [instance] => (item={'network': 'public', 'name': 'net-first-0', 'state': 'present', 'mac': '52:54:01:90:3c:b9', 'ips': ['192.168.110.20', ''], 'tag': 'net_first'})
ok: [instance] => (item={'network': 'public', 'name': 'net-only-0', 'state': 'present', 'mac': '52:54:02:20:dc:92', 'ips': ['192.168.110.30', ''], 'tag': 'net_only'})
ok: [instance] => (item={'network': 'public', 'name': 'no-boot-order-0', 'state': 'present', 'mac': '52:54:03:c9:2a:c8', 'ips': ['192.168.110.40', ''], 'tag': 'no_boot_order'})
TASK [dnsmasq : Create add/remove sets] ****************************************
Tuesday 17 March 2026 11:08:21 +0000 (0:00:00.225) 0:00:50.109 *********
ok: [instance]
TASK [dnsmasq : Add DHCP entries] **********************************************
Tuesday 17 March 2026 11:08:21 +0000 (0:00:00.060) 0:00:50.170 *********
changed: [instance] => (item={'file': 'osp_trunk_disk-first-0_52:54:00:1d:72:48', 'entry': 'set:disk_first,52:54:00:1d:72:48,192.168.140.10,disk-first-0', 'state': 'present'})
changed: [instance] => (item={'file': 'osp_trunk_net-first-0_52:54:01:8b:1b:d6', 'entry': 'set:net_first,52:54:01:8b:1b:d6,192.168.140.20,net-first-0', 'state': 'present'})
changed: [instance] => (item={'file': 'osp_trunk_net-only-0_52:54:00:36:cb:6d', 'entry': 'set:net_only,52:54:00:36:cb:6d,192.168.140.30,net-only-0', 'state': 'present'})
changed: [instance] => (item={'file': 'osp_trunk_no-boot-order-0_52:54:00:6e:30:bb', 'entry': 'set:no_boot_order,52:54:00:6e:30:bb,192.168.140.40,no-boot-order-0', 'state': 'present'})
changed: [instance] => (item={'file': 'public_disk-first-0_52:54:00:c1:0c:43', 'entry': 'set:disk_first,52:54:00:c1:0c:43,192.168.110.10,disk-first-0', 'state': 'present'})
changed: [instance] => (item={'file': 'public_net-first-0_52:54:01:90:3c:b9', 'entry': 'set:net_first,52:54:01:90:3c:b9,192.168.110.20,net-first-0', 'state': 'present'})
changed: [instance] => (item={'file': 'public_net-only-0_52:54:02:20:dc:92', 'entry': 'set:net_only,52:54:02:20:dc:92,192.168.110.30,net-only-0', 'state': 'present'})
changed: [instance] => (item={'file': 'public_no-boot-order-0_52:54:03:c9:2a:c8', 'entry': 'set:no_boot_order,52:54:03:c9:2a:c8,192.168.110.40,no-boot-order-0', 'state': 'present'})
TASK [dnsmasq : Remove DHCP entries] *******************************************
Tuesday 17 March 2026 11:08:24 +0000 (0:00:02.828) 0:00:52.998 *********
skipping: [instance]
TASK [libvirt_manager : Create per-network and .utility DNS entries] ***********
Tuesday 17 March 2026 11:08:24 +0000 (0:00:00.094) 0:00:53.092 *********
ok: [instance] => (item=disk-first-0)
ok: [instance] => (item=net-first-0)
ok: [instance] => (item=net-only-0)
ok: [instance] => (item=no-boot-order-0)
TASK [Inject VMs in the .utility zone] *****************************************
Tuesday 17 March 2026 11:08:25 +0000 (0:00:00.233) 0:00:53.326 *********
TASK [dnsmasq : Assert we have needed host record data] ************************
Tuesday 17 March 2026 11:08:25 +0000 (0:00:00.098) 0:00:53.425 *********
ok: [instance]
TASK [dnsmasq : Assert each address element have needed data] ******************
Tuesday 17 March 2026 11:08:25 +0000 (0:00:00.063) 0:00:53.488 *********
ok: [instance] => (item={'names': ['disk-first-0.utility', 'disk-first-0.instance', 'disk_first-0.utility', 'disk_first-0.instance'], 'ips': ['192.168.140.10', ''], 'state': 'present'})
ok: [instance] => (item={'names': ['disk-first-0.ctlplane.local', 'disk_first-0.ctlplane.local'], 'ips': ['192.168.140.10', ''], 'state': 'present'})
ok: [instance] => (item={'names': ['disk-first-0.public.local', 'disk_first-0.public.local'], 'ips': ['192.168.110.10', ''], 'state': 'present'})
ok: [instance] => (item={'names': ['net-first-0.utility', 'net-first-0.instance', 'net_first-0.utility', 'net_first-0.instance'], 'ips': ['192.168.140.20', ''], 'state': 'present'})
ok: [instance] => (item={'names': ['net-first-0.ctlplane.local', 'net_first-0.ctlplane.local'], 'ips': ['192.168.140.20', ''], 'state': 'present'})
ok: [instance] => (item={'names': ['net-first-0.public.local', 'net_first-0.public.local'], 'ips': ['192.168.110.20', ''], 'state': 'present'})
ok: [instance] => (item={'names': ['net-only-0.utility', 'net-only-0.instance', 'net_only-0.utility', 'net_only-0.instance'], 'ips': ['192.168.140.30', ''], 'state': 'present'})
ok: [instance] => (item={'names': ['net-only-0.ctlplane.local', 'net_only-0.ctlplane.local'], 'ips': ['192.168.140.30', ''], 'state': 'present'})
ok: [instance] => (item={'names': ['net-only-0.public.local', 'net_only-0.public.local'], 'ips': ['192.168.110.30', ''], 'state': 'present'})
ok: [instance] => (item={'names': ['no-boot-order-0.utility', 'no-boot-order-0.instance', 'no_boot_order-0.utility', 'no_boot_order-0.instance'], 'ips': ['192.168.140.40', ''], 'state': 'present'})
ok: [instance] => (item={'names': ['no-boot-order-0.ctlplane.local', 'no_boot_order-0.ctlplane.local'], 'ips': ['192.168.140.40', ''], 'state': 'present'})
ok: [instance] => (item={'names': ['no-boot-order-0.public.local', 'no_boot_order-0.public.local'], 'ips': ['192.168.110.40', ''], 'state': 'present'})
TASK [dnsmasq : Add/Remove address] ********************************************
Tuesday 17 March 2026 11:08:25 +0000 (0:00:00.222) 0:00:53.711 *********
changed: [instance] => (item={'names': ['disk-first-0.utility', 'disk-first-0.instance', 'disk_first-0.utility', 'disk_first-0.instance'], 'ips': ['192.168.140.10', ''], 'state': 'present'})
changed: [instance] => (item={'names': ['disk-first-0.ctlplane.local', 'disk_first-0.ctlplane.local'], 'ips': ['192.168.140.10', ''], 'state': 'present'})
changed: [instance] => (item={'names': ['disk-first-0.public.local', 'disk_first-0.public.local'], 'ips': ['192.168.110.10', ''], 'state': 'present'})
changed: [instance] => (item={'names': ['net-first-0.utility', 'net-first-0.instance', 'net_first-0.utility', 'net_first-0.instance'], 'ips': ['192.168.140.20', ''], 'state': 'present'})
changed: [instance] => (item={'names': ['net-first-0.ctlplane.local', 'net_first-0.ctlplane.local'], 'ips': ['192.168.140.20', ''], 'state': 'present'})
changed: [instance] => (item={'names': ['net-first-0.public.local', 'net_first-0.public.local'], 'ips': ['192.168.110.20', ''], 'state': 'present'})
changed: [instance] => (item={'names': ['net-only-0.utility', 'net-only-0.instance', 'net_only-0.utility', 'net_only-0.instance'], 'ips': ['192.168.140.30', ''], 'state': 'present'})
changed: [instance] => (item={'names': ['net-only-0.ctlplane.local', 'net_only-0.ctlplane.local'], 'ips': ['192.168.140.30', ''], 'state': 'present'})
changed: [instance] => (item={'names': ['net-only-0.public.local', 'net_only-0.public.local'], 'ips': ['192.168.110.30', ''], 'state': 'present'})
changed: [instance] => (item={'names': ['no-boot-order-0.utility', 'no-boot-order-0.instance', 'no_boot_order-0.utility', 'no_boot_order-0.instance'], 'ips': ['192.168.140.40', ''], 'state': 'present'})
changed: [instance] => (item={'names': ['no-boot-order-0.ctlplane.local', 'no_boot_order-0.ctlplane.local'], 'ips': ['192.168.140.40', ''], 'state': 'present'})
changed: [instance] => (item={'names': ['no-boot-order-0.public.local', 'no_boot_order-0.public.local'], 'ips': ['192.168.110.40', ''], 'state': 'present'})
TASK [dnsmasq : Add controller-0 short hostname record when 'utility' in the name into /etc/hosts] ***
Tuesday 17 March 2026 11:08:28 +0000 (0:00:02.534) 0:00:56.245 *********
skipping: [instance] => (item={'names': ['disk-first-0.utility', 'disk-first-0.instance', 'disk_first-0.utility', 'disk_first-0.instance'], 'ips': ['192.168.140.10', ''], 'state': 'present'})
skipping: [instance] => (item={'names': ['disk-first-0.ctlplane.local', 'disk_first-0.ctlplane.local'], 'ips': ['192.168.140.10', ''], 'state': 'present'})
skipping: [instance] => (item={'names': ['disk-first-0.public.local', 'disk_first-0.public.local'], 'ips': ['192.168.110.10', ''], 'state': 'present'})
skipping: [instance] => (item={'names': ['net-first-0.utility', 'net-first-0.instance', 'net_first-0.utility', 'net_first-0.instance'], 'ips': ['192.168.140.20', ''], 'state': 'present'})
skipping: [instance] => (item={'names': ['net-first-0.ctlplane.local', 'net_first-0.ctlplane.local'], 'ips': ['192.168.140.20', ''], 'state': 'present'})
skipping: [instance] => (item={'names': ['net-first-0.public.local', 'net_first-0.public.local'], 'ips': ['192.168.110.20', ''], 'state': 'present'})
skipping: [instance] => (item={'names': ['net-only-0.utility', 'net-only-0.instance', 'net_only-0.utility', 'net_only-0.instance'], 'ips': ['192.168.140.30', ''], 'state': 'present'})
skipping: [instance] => (item={'names': ['net-only-0.ctlplane.local', 'net_only-0.ctlplane.local'], 'ips': ['192.168.140.30', ''], 'state': 'present'})
skipping: [instance] => (item={'names': ['net-only-0.public.local', 'net_only-0.public.local'], 'ips': ['192.168.110.30', ''], 'state': 'present'})
skipping: [instance] => (item={'names': ['no-boot-order-0.utility', 'no-boot-order-0.instance', 'no_boot_order-0.utility', 'no_boot_order-0.instance'], 'ips': ['192.168.140.40', ''], 'state': 'present'})
skipping: [instance] => (item={'names': ['no-boot-order-0.ctlplane.local', 'no_boot_order-0.ctlplane.local'], 'ips': ['192.168.140.40', ''], 'state': 'present'})
skipping: [instance] => (item={'names': ['no-boot-order-0.public.local', 'no_boot_order-0.public.local'], 'ips': ['192.168.110.40', ''], 'state': 'present'})
skipping: [instance]
TASK [dnsmasq : Remove crc.testing from host_records] **************************
Tuesday 17 March 2026 11:08:28 +0000 (0:00:00.153) 0:00:56.398 *********
skipping: [instance]
TASK [libvirt_manager : Initialize empty _lm_dhcp_options fact] ****************
Tuesday 17 March 2026 11:08:28 +0000 (0:00:00.078) 0:00:56.476 *********
ok: [instance]
TASK [libvirt_manager : Collect DHCP options from VM definitions] **************
Tuesday 17 March 2026 11:08:28 +0000 (0:00:00.041) 0:00:56.518 *********
skipping: [instance] => (item=disk_first)
skipping: [instance] => (item=net_first)
skipping: [instance] => (item=net_only)
skipping: [instance] => (item=no_boot_order)
skipping: [instance]
TASK [libvirt_manager : Generate DHCP option configuration for VM types] *******
Tuesday 17 March 2026 11:08:28 +0000 (0:00:00.064) 0:00:56.582 *********
skipping: [instance]
TASK [libvirt_manager : Ensure some domains are local] *************************
Tuesday 17 March 2026 11:08:28 +0000 (0:00:00.093) 0:00:56.676 *********
changed: [instance]
TASK [libvirt_manager : Ensure dnsmasq is reloaded now] ************************
Tuesday 17 March 2026 11:08:28 +0000 (0:00:00.383) 0:00:57.059 *********
RUNNING HANDLER [libvirt_manager : Restart firewalld] **************************
Tuesday 17 March 2026 11:08:28 +0000 (0:00:00.059) 0:00:57.119 *********
changed: [instance]
RUNNING HANDLER [dnsmasq : Restart dnsmasq] ************************************
Tuesday 17 March 2026 11:08:29 +0000 (0:00:00.675) 0:00:57.794 *********
changed: [instance]
RUNNING HANDLER [dnsmasq : Reload dnsmasq] *************************************
Tuesday 17 March 2026 11:08:30 +0000 (0:00:00.427) 0:00:58.222 *********
changed: [instance]
TASK [libvirt_manager : Create group inventories] ******************************
Tuesday 17 March 2026 11:08:30 +0000 (0:00:00.397) 0:00:58.619 *********
changed: [instance] => (item=disk_first)
changed: [instance] => (item=net_first)
changed: [instance] => (item=net_only)
changed: [instance] => (item=no_boot_order)
TASK [libvirt_manager : Create "all" group inventory file] *********************
Tuesday 17 March 2026 11:08:32 +0000 (0:00:01.663) 0:01:00.282 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/create_all_group_inventory.yml for instance
TASK [libvirt_manager : Check if all-group.yml already exists] *****************
Tuesday 17 March 2026 11:08:32 +0000 (0:00:00.118) 0:01:00.401 *********
ok: [instance]
TASK [libvirt_manager : Slurp existing all-group.yml if it exists] *************
Tuesday 17 March 2026 11:08:32 +0000 (0:00:00.238) 0:01:00.639 *********
skipping: [instance]
TASK [libvirt_manager : Create new "all" group inventory file from template] ***
Tuesday 17 March 2026 11:08:32 +0000 (0:00:00.043) 0:01:00.683 *********
changed: [instance]
TASK [libvirt_manager : Slurp newly created all-group.yml] *********************
Tuesday 17 March 2026 11:08:32 +0000 (0:00:00.484) 0:01:01.167 *********
skipping: [instance]
TASK [libvirt_manager : Write merged all-group.yml] ****************************
Tuesday 17 March 2026 11:08:33 +0000 (0:00:00.047) 0:01:01.214 *********
skipping: [instance]
TASK [libvirt_manager : Ensure storage pool is present.] ***********************
Tuesday 17 March 2026 11:08:33 +0000 (0:00:00.045) 0:01:01.260 *********
skipping: [instance]
TASK [libvirt_manager : Ensure images are present] *****************************
Tuesday 17 March 2026 11:08:33 +0000 (0:00:00.062) 0:01:01.323 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/get_image.yml for instance => (item=disk_first)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/get_image.yml for instance => (item=net_first)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/get_image.yml for instance => (item=net_only)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/get_image.yml for instance => (item=no_boot_order)
TASK [libvirt_manager : Ensure directory exists] *******************************
Tuesday 17 March 2026 11:08:33 +0000 (0:00:00.141) 0:01:01.465 *********
skipping: [instance]
TASK [libvirt_manager : Check if base image exists] ****************************
Tuesday 17 March 2026 11:08:33 +0000 (0:00:00.110) 0:01:01.575 *********
skipping: [instance]
TASK [libvirt_manager : Download base image] ***********************************
Tuesday 17 March 2026 11:08:33 +0000 (0:00:00.046) 0:01:01.622 *********
skipping: [instance]
TASK [libvirt_manager : Check image] *******************************************
Tuesday 17 March 2026 11:08:33 +0000 (0:00:00.044) 0:01:01.666 *********
skipping: [instance]
TASK [libvirt_manager : Assert image status] ***********************************
Tuesday 17 March 2026 11:08:33 +0000 (0:00:00.043) 0:01:01.710 *********
skipping: [instance]
TASK [libvirt_manager : Ensure image access rights] ****************************
Tuesday 17 March 2026 11:08:33 +0000 (0:00:00.040) 0:01:01.750 *********
skipping: [instance]
TASK [libvirt_manager : Ensure directory exists] *******************************
Tuesday 17 March 2026 11:08:33 +0000 (0:00:00.042) 0:01:01.792 *********
skipping: [instance]
TASK [libvirt_manager : Check if base image exists] ****************************
Tuesday 17 March 2026 11:08:33 +0000 (0:00:00.093) 0:01:01.886 *********
skipping: [instance]
TASK [libvirt_manager : Download base image] ***********************************
Tuesday 17 March 2026 11:08:33 +0000 (0:00:00.045) 0:01:01.931 *********
skipping: [instance]
TASK [libvirt_manager : Check image] *******************************************
Tuesday 17 March 2026 11:08:33 +0000 (0:00:00.040) 0:01:01.972 *********
skipping: [instance]
TASK [libvirt_manager : Assert image status] ***********************************
Tuesday 17 March 2026 11:08:33 +0000 (0:00:00.044) 0:01:02.017 *********
skipping: [instance]
TASK [libvirt_manager : Ensure image access rights] ****************************
Tuesday 17 March 2026 11:08:33 +0000 (0:00:00.041) 0:01:02.058 *********
skipping: [instance]
TASK [libvirt_manager : Ensure directory exists] *******************************
Tuesday 17 March 2026 11:08:33 +0000 (0:00:00.043) 0:01:02.101 *********
skipping: [instance]
TASK [libvirt_manager : Check if base image exists] ****************************
Tuesday 17 March 2026 11:08:34 +0000 (0:00:00.094) 0:01:02.196 *********
skipping: [instance]
TASK [libvirt_manager : Download base image] ***********************************
Tuesday 17 March 2026 11:08:34 +0000 (0:00:00.046) 0:01:02.242 *********
skipping: [instance]
TASK [libvirt_manager : Check image] *******************************************
Tuesday 17 March 2026 11:08:34 +0000 (0:00:00.043) 0:01:02.286 *********
skipping: [instance]
TASK [libvirt_manager : Assert image status] ***********************************
Tuesday 17 March 2026 11:08:34 +0000 (0:00:00.042) 0:01:02.328 *********
skipping: [instance]
TASK [libvirt_manager : Ensure image access rights] ****************************
Tuesday 17 March 2026 11:08:34 +0000 (0:00:00.045) 0:01:02.373 *********
skipping: [instance]
TASK [libvirt_manager : Ensure directory exists] *******************************
Tuesday 17 March 2026 11:08:34 +0000 (0:00:00.044) 0:01:02.418 *********
skipping: [instance]
TASK [libvirt_manager : Check if base image exists] ****************************
Tuesday 17 March 2026 11:08:34 +0000 (0:00:00.102) 0:01:02.520 *********
skipping: [instance]
TASK [libvirt_manager : Download base image] ***********************************
Tuesday 17 March 2026 11:08:34 +0000 (0:00:00.046) 0:01:02.566 *********
skipping: [instance]
TASK [libvirt_manager : Check image] *******************************************
Tuesday 17 March 2026 11:08:34 +0000 (0:00:00.044) 0:01:02.611 *********
skipping: [instance]
TASK [libvirt_manager : Assert image status] ***********************************
Tuesday 17 March 2026 11:08:34 +0000 (0:00:00.043) 0:01:02.655 *********
skipping: [instance]
TASK [libvirt_manager : Ensure image access rights] ****************************
Tuesday 17 March 2026 11:08:34 +0000 (0:00:00.042) 0:01:02.697 *********
skipping: [instance]
TASK [libvirt_manager : Get ssh key state] *************************************
Tuesday 17 March 2026 11:08:34 +0000 (0:00:00.040) 0:01:02.738 *********
ok: [instance]
TASK [libvirt_manager : Create temporary ssh keypair] **************************
Tuesday 17 March 2026 11:08:34 +0000 (0:00:00.244) 0:01:02.982 *********
changed: [instance]
TASK [libvirt_manager : Slurp public key for later use] ************************
Tuesday 17 March 2026 11:08:35 +0000 (0:00:00.384) 0:01:03.367 *********
ok: [instance]
TASK [libvirt_manager : Slurp private key for later use] ***********************
Tuesday 17 March 2026 11:08:35 +0000 (0:00:00.274) 0:01:03.641 *********
ok: [instance]
TASK [libvirt_manager : Inject cifmw_reproducer_key.pub in hypervisor authorized_keys] ***
Tuesday 17 March 2026 11:08:35 +0000 (0:00:00.194) 0:01:03.836 *********
changed: [instance]
TASK [libvirt_manager : Create fact holding network data for VMs] **************
Tuesday 17 March 2026 11:08:36 +0000 (0:00:00.456) 0:01:04.293 *********
ok: [instance]
TASK [libvirt_manager : List existing networks] ********************************
Tuesday 17 March 2026 11:08:36 +0000 (0:00:00.047) 0:01:04.340 *********
ok: [instance]
TASK [libvirt_manager : Gather pool fact] **************************************
Tuesday 17 March 2026 11:08:36 +0000 (0:00:00.250) 0:01:04.590 *********
ok: [instance]
TASK [libvirt_manager : Create and run VMs] ************************************
Tuesday 17 March 2026 11:08:36 +0000 (0:00:00.422) 0:01:05.013 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/create_vms.yml for instance => (item={'key': 'disk-first-0', 'value': 'disk_first'})
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/create_vms.yml for instance => (item={'key': 'net-first-0', 'value': 'net_first'})
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/create_vms.yml for instance => (item={'key': 'net-only-0', 'value': 'net_only'})
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/create_vms.yml for instance => (item={'key': 'no-boot-order-0', 'value': 'no_boot_order'})
TASK [libvirt_manager : Create VM image for disk-first-0] **********************
Tuesday 17 March 2026 11:08:37 +0000 (0:00:00.217) 0:01:05.231 *********
changed: [instance]
TASK [libvirt_manager : Ensure file ownership and rights for disk-first-0] *****
Tuesday 17 March 2026 11:08:37 +0000 (0:00:00.267) 0:01:05.498 *********
changed: [instance]
TASK [libvirt_manager : Define VMs for type disk-first-0] **********************
Tuesday 17 March 2026 11:08:37 +0000 (0:00:00.248) 0:01:05.747 *********
changed: [instance]
TASK [libvirt_manager : Attach listed networks to the VMs disk-first-0] ********
Tuesday 17 March 2026 11:08:38 +0000 (0:00:01.143) 0:01:06.890 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/net_to_vms.yml for instance
TASK [libvirt_manager : Attach {{ vm_item }} to {{ net_item }}] ****************
Tuesday 17 March 2026 11:08:38 +0000 (0:00:00.070) 0:01:06.961 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/attach_interface.yml for instance => (item=public)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/attach_interface.yml for instance => (item=osp_trunk)
TASK [libvirt_manager : Get virtual network information] ***********************
Tuesday 17 March 2026 11:08:38 +0000 (0:00:00.085) 0:01:07.047 *********
ok: [instance]
TASK [libvirt_manager : Create network to bridge mapping] **********************
Tuesday 17 March 2026 11:08:39 +0000 (0:00:00.251) 0:01:07.298 *********
ok: [instance] => (item=cifmw-osp_trunk)
ok: [instance] => (item=cifmw-public)
TASK [libvirt_manager : Dump domain xml] ***************************************
Tuesday 17 March 2026 11:08:39 +0000 (0:00:00.096) 0:01:07.394 *********
ok: [instance]
TASK [libvirt_manager : Extract networks from XML] *****************************
Tuesday 17 March 2026 11:08:39 +0000 (0:00:00.244) 0:01:07.639 *********
ok: [instance]
TASK [libvirt_manager : Attach interface public on cifmw-disk-first-0] *********
Tuesday 17 March 2026 11:08:39 +0000 (0:00:00.223) 0:01:07.863 *********
changed: [instance]
TASK [libvirt_manager : Get virtual network information] ***********************
Tuesday 17 March 2026 11:08:39 +0000 (0:00:00.294) 0:01:08.157 *********
ok: [instance]
TASK [libvirt_manager : Create network to bridge mapping] **********************
Tuesday 17 March 2026 11:08:40 +0000 (0:00:00.286) 0:01:08.443 *********
ok: [instance] => (item=cifmw-osp_trunk)
ok: [instance] => (item=cifmw-public)
TASK [libvirt_manager : Dump domain xml] ***************************************
Tuesday 17 March 2026 11:08:40 +0000 (0:00:00.066) 0:01:08.509 *********
ok: [instance]
TASK [libvirt_manager : Extract networks from XML] *****************************
Tuesday 17 March 2026 11:08:40 +0000 (0:00:00.246) 0:01:08.756 *********
ok: [instance]
TASK [libvirt_manager : Attach interface osp_trunk on cifmw-disk-first-0] ******
Tuesday 17 March 2026 11:08:40 +0000 (0:00:00.218) 0:01:08.975 *********
changed: [instance]
TASK [libvirt_manager : Attach spines/leafs networks to the VMs disk-first-0] ***
Tuesday 17 March 2026 11:08:41 +0000 (0:00:00.296) 0:01:09.272 *********
skipping: [instance]
TASK [libvirt_manager : Create the requested extra disks for disk-first-0] *****
Tuesday 17 March 2026 11:08:41 +0000 (0:00:00.079) 0:01:09.352 *********
skipping: [instance]
TASK [libvirt_manager : Find volume attachments for VM disk-first-0] ***********
Tuesday 17 March 2026 11:08:41 +0000 (0:00:00.048) 0:01:09.400 *********
skipping: [instance]
TASK [libvirt_manager : Attach volumes for VM disk-first-0] ********************
Tuesday 17 March 2026 11:08:41 +0000 (0:00:00.049) 0:01:09.449 *********
skipping: [instance]
TASK [libvirt_manager : Get VM UUID] *******************************************
Tuesday 17 March 2026 11:08:41 +0000 (0:00:00.047) 0:01:09.496 *********
changed: [instance]
TASK [libvirt_manager : Inject UUID in dataset] ********************************
Tuesday 17 March 2026 11:08:41 +0000 (0:00:00.228) 0:01:09.725 *********
ok: [instance]
TASK [libvirt_manager : Create cloud-init ISO] *********************************
Tuesday 17 March 2026 11:08:41 +0000 (0:00:00.057) 0:01:09.782 *********
skipping: [instance]
TASK [libvirt_manager : Attach cloud-init ISO if exists] ***********************
Tuesday 17 March 2026 11:08:41 +0000 (0:00:00.080) 0:01:09.862 *********
skipping: [instance]
TASK [libvirt_manager : Attach additional devices if specified] ****************
Tuesday 17 March 2026 11:08:41 +0000 (0:00:00.042) 0:01:09.905 *********
skipping: [instance]
TASK [libvirt_manager : Configure boot order for disk-first-0] *****************
Tuesday 17 March 2026 11:08:41 +0000 (0:00:00.064) 0:01:09.969 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/configure_boot_order.yml for instance
TASK [libvirt_manager : Get current domain XML for cifmw-disk-first-0] *********
Tuesday 17 March 2026 11:08:41 +0000 (0:00:00.097) 0:01:10.066 *********
ok: [instance]
TASK [libvirt_manager : Create temporary file for domain XML] ******************
Tuesday 17 March 2026 11:08:42 +0000 (0:00:00.249) 0:01:10.315 *********
changed: [instance]
TASK [libvirt_manager : Write current domain XML to temporary file] ************
Tuesday 17 March 2026 11:08:42 +0000 (0:00:00.316) 0:01:10.631 *********
changed: [instance]
TASK [libvirt_manager : Remove existing boot elements from os section] *********
Tuesday 17 March 2026 11:08:42 +0000 (0:00:00.376) 0:01:11.008 *********
changed: [instance]
TASK [libvirt_manager : Add boot order to disk device] *************************
Tuesday 17 March 2026 11:08:43 +0000 (0:00:00.223) 0:01:11.232 *********
changed: [instance]
TASK [libvirt_manager : Get interface count for boot order] ********************
Tuesday 17 March 2026 11:08:43 +0000 (0:00:00.231) 0:01:11.464 *********
ok: [instance]
TASK [libvirt_manager : Add boot order to network interfaces] ******************
Tuesday 17 March 2026 11:08:43 +0000 (0:00:00.258) 0:01:11.723 *********
changed: [instance]
TASK [libvirt_manager : Read updated domain XML] *******************************
Tuesday 17 March 2026 11:08:43 +0000 (0:00:00.240) 0:01:11.963 *********
ok: [instance]
TASK [libvirt_manager : Redefine domain with updated boot order] ***************
Tuesday 17 March 2026 11:08:43 +0000 (0:00:00.211) 0:01:12.175 *********
changed: [instance]
TASK [libvirt_manager : Clean up temporary domain XML file] ********************
Tuesday 17 March 2026 11:08:44 +0000 (0:00:00.263) 0:01:12.439 *********
changed: [instance]
TASK [libvirt_manager : Create VM image for net-first-0] ***********************
Tuesday 17 March 2026 11:08:44 +0000 (0:00:00.209) 0:01:12.648 *********
changed: [instance]
TASK [libvirt_manager : Ensure file ownership and rights for net-first-0] ******
Tuesday 17 March 2026 11:08:44 +0000 (0:00:00.279) 0:01:12.928 *********
changed: [instance]
TASK [libvirt_manager : Define VMs for type net-first-0] ***********************
Tuesday 17 March 2026 11:08:44 +0000 (0:00:00.241) 0:01:13.170 *********
changed: [instance]
TASK [libvirt_manager : Attach listed networks to the VMs net-first-0] *********
Tuesday 17 March 2026 11:08:45 +0000 (0:00:00.318) 0:01:13.488 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/net_to_vms.yml for instance
TASK [libvirt_manager : Attach {{ vm_item }} to {{ net_item }}] ****************
Tuesday 17 March 2026 11:08:45 +0000 (0:00:00.098) 0:01:13.587 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/attach_interface.yml for instance => (item=public)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/attach_interface.yml for instance => (item=osp_trunk)
TASK [libvirt_manager : Get virtual network information] ***********************
Tuesday 17 March 2026 11:08:45 +0000 (0:00:00.079) 0:01:13.666 *********
ok: [instance]
TASK [libvirt_manager : Create network to bridge mapping] **********************
Tuesday 17 March 2026 11:08:45 +0000 (0:00:00.242) 0:01:13.909 *********
ok: [instance] => (item=cifmw-osp_trunk)
ok: [instance] => (item=cifmw-public)
TASK [libvirt_manager : Dump domain xml] ***************************************
Tuesday 17 March 2026 11:08:45 +0000 (0:00:00.064) 0:01:13.973 *********
ok: [instance]
TASK [libvirt_manager : Extract networks from XML] *****************************
Tuesday 17 March 2026 11:08:46 +0000 (0:00:00.240) 0:01:14.214 *********
ok: [instance]
TASK [libvirt_manager : Attach interface public on cifmw-net-first-0] **********
Tuesday 17 March 2026 11:08:46 +0000 (0:00:00.239) 0:01:14.454 *********
changed: [instance]
TASK [libvirt_manager : Get virtual network information] ***********************
Tuesday 17 March 2026 11:08:46 +0000 (0:00:00.300) 0:01:14.754 *********
ok: [instance]
TASK [libvirt_manager : Create network to bridge mapping] **********************
Tuesday 17 March 2026 11:08:46 +0000 (0:00:00.231) 0:01:14.986 *********
ok: [instance] => (item=cifmw-osp_trunk)
ok: [instance] => (item=cifmw-public)
TASK [libvirt_manager : Dump domain xml] ***************************************
Tuesday 17 March 2026 11:08:46 +0000 (0:00:00.065) 0:01:15.051 *********
ok: [instance]
TASK [libvirt_manager : Extract networks from XML] *****************************
Tuesday 17 March 2026 11:08:47 +0000 (0:00:00.274) 0:01:15.325 *********
ok: [instance]
TASK [libvirt_manager : Attach interface osp_trunk on cifmw-net-first-0] *******
Tuesday 17 March 2026 11:08:47 +0000 (0:00:00.207) 0:01:15.533 *********
changed: [instance]
TASK [libvirt_manager : Attach spines/leafs networks to the VMs net-first-0] ***
Tuesday 17 March 2026 11:08:47 +0000 (0:00:00.287) 0:01:15.820 *********
skipping: [instance]
TASK [libvirt_manager : Create the requested extra disks for net-first-0] ******
Tuesday 17 March 2026 11:08:47 +0000 (0:00:00.040) 0:01:15.860 *********
skipping: [instance]
TASK [libvirt_manager : Find volume attachments for VM net-first-0] ************
Tuesday 17 March 2026 11:08:47 +0000 (0:00:00.047) 0:01:15.908 *********
skipping: [instance]
TASK [libvirt_manager : Attach volumes for VM net-first-0] *********************
Tuesday 17 March 2026 11:08:47 +0000 (0:00:00.046) 0:01:15.954 *********
skipping: [instance]
TASK [libvirt_manager : Get VM UUID] *******************************************
Tuesday 17 March 2026 11:08:47 +0000 (0:00:00.086) 0:01:16.040 *********
changed: [instance]
TASK [libvirt_manager : Inject UUID in dataset] ********************************
Tuesday 17 March 2026 11:08:48 +0000 (0:00:00.227) 0:01:16.268 *********
ok: [instance]
TASK [libvirt_manager : Create cloud-init ISO] *********************************
Tuesday 17 March 2026 11:08:48 +0000 (0:00:00.055) 0:01:16.324 *********
skipping: [instance]
TASK [libvirt_manager : Attach cloud-init ISO if exists] ***********************
Tuesday 17 March 2026 11:08:48 +0000 (0:00:00.042) 0:01:16.367 *********
skipping: [instance]
TASK [libvirt_manager : Attach additional devices if specified] ****************
Tuesday 17 March 2026 11:08:48 +0000 (0:00:00.038) 0:01:16.406 *********
skipping: [instance]
TASK [libvirt_manager : Configure boot order for net-first-0] ******************
Tuesday 17 March 2026 11:08:48 +0000 (0:00:00.094) 0:01:16.500 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/configure_boot_order.yml for instance
TASK [libvirt_manager : Get current domain XML for cifmw-net-first-0] **********
Tuesday 17 March 2026 11:08:48 +0000 (0:00:00.092) 0:01:16.593 *********
ok: [instance]
TASK [libvirt_manager : Create temporary file for domain XML] ******************
Tuesday 17 March 2026 11:08:48 +0000 (0:00:00.232) 0:01:16.825 *********
changed: [instance]
TASK [libvirt_manager : Write current domain XML to temporary file] ************
Tuesday 17 March 2026 11:08:48 +0000 (0:00:00.199) 0:01:17.025 *********
changed: [instance]
TASK [libvirt_manager : Remove existing boot elements from os section] *********
Tuesday 17 March 2026 11:08:49 +0000 (0:00:00.403) 0:01:17.428 *********
changed: [instance]
TASK [libvirt_manager : Add boot order to disk device] *************************
Tuesday 17 March 2026 11:08:49 +0000 (0:00:00.232) 0:01:17.661 *********
changed: [instance]
TASK [libvirt_manager : Get interface count for boot order] ********************
Tuesday 17 March 2026 11:08:49 +0000 (0:00:00.233) 0:01:17.894 *********
ok: [instance]
TASK [libvirt_manager : Add boot order to network interfaces] ******************
Tuesday 17 March 2026 11:08:49 +0000 (0:00:00.238) 0:01:18.133 *********
changed: [instance]
TASK [libvirt_manager : Read updated domain XML] *******************************
Tuesday 17 March 2026 11:08:50 +0000 (0:00:00.244) 0:01:18.377 *********
ok: [instance]
TASK [libvirt_manager : Redefine domain with updated boot order] ***************
Tuesday 17 March 2026 11:08:50 +0000 (0:00:00.244) 0:01:18.621 *********
changed: [instance]
TASK [libvirt_manager : Clean up temporary domain XML file] ********************
Tuesday 17 March 2026 11:08:50 +0000 (0:00:00.260) 0:01:18.882 *********
changed: [instance]
TASK [libvirt_manager : Create VM image for net-only-0] ************************
Tuesday 17 March 2026 11:08:50 +0000 (0:00:00.217) 0:01:19.100 *********
changed: [instance]
TASK [libvirt_manager : Ensure file ownership and rights for net-only-0] *******
Tuesday 17 March 2026 11:08:51 +0000 (0:00:00.261) 0:01:19.361 *********
changed: [instance]
TASK [libvirt_manager : Define VMs for type net-only-0] ************************
Tuesday 17 March 2026 11:08:51 +0000 (0:00:00.267) 0:01:19.629 *********
changed: [instance]
TASK [libvirt_manager : Attach listed networks to the VMs net-only-0] **********
Tuesday 17 March 2026 11:08:51 +0000 (0:00:00.342) 0:01:19.972 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/net_to_vms.yml for instance
TASK [libvirt_manager : Attach {{ vm_item }} to {{ net_item }}] ****************
Tuesday 17 March 2026 11:08:51 +0000 (0:00:00.067) 0:01:20.040 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/attach_interface.yml for instance => (item=public)
TASK [libvirt_manager : Get virtual network information] ***********************
Tuesday 17 March 2026 11:08:51 +0000 (0:00:00.074) 0:01:20.115 *********
ok: [instance]
TASK [libvirt_manager : Create network to bridge mapping] **********************
Tuesday 17 March 2026 11:08:52 +0000 (0:00:00.300) 0:01:20.416 *********
ok: [instance] => (item=cifmw-osp_trunk)
ok: [instance] => (item=cifmw-public)
TASK [libvirt_manager : Dump domain xml] ***************************************
Tuesday 17 March 2026 11:08:52 +0000 (0:00:00.064) 0:01:20.481 *********
ok: [instance]
TASK [libvirt_manager : Extract networks from XML] *****************************
Tuesday 17 March 2026 11:08:52 +0000 (0:00:00.250) 0:01:20.732 *********
ok: [instance]
TASK [libvirt_manager : Attach interface public on cifmw-net-only-0] ***********
Tuesday 17 March 2026 11:08:52 +0000 (0:00:00.213) 0:01:20.945 *********
changed: [instance]
TASK [libvirt_manager : Attach spines/leafs networks to the VMs net-only-0] ****
Tuesday 17 March 2026 11:08:53 +0000 (0:00:00.296) 0:01:21.241 *********
skipping: [instance]
TASK [libvirt_manager : Create the requested extra disks for net-only-0] *******
Tuesday 17 March 2026 11:08:53 +0000 (0:00:00.077) 0:01:21.318 *********
skipping: [instance]
TASK [libvirt_manager : Find volume attachments for VM net-only-0] *************
Tuesday 17 March 2026 11:08:53 +0000 (0:00:00.049) 0:01:21.368 *********
skipping: [instance]
TASK [libvirt_manager : Attach volumes for VM net-only-0] **********************
Tuesday 17 March 2026 11:08:53 +0000 (0:00:00.048) 0:01:21.417 *********
skipping: [instance]
TASK [libvirt_manager : Get VM UUID] *******************************************
Tuesday 17 March 2026 11:08:53 +0000 (0:00:00.045) 0:01:21.463 *********
changed: [instance]
TASK [libvirt_manager : Inject UUID in dataset] ********************************
Tuesday 17 March 2026 11:08:53 +0000 (0:00:00.234) 0:01:21.697 *********
ok: [instance]
TASK [libvirt_manager : Create cloud-init ISO] *********************************
Tuesday 17 March 2026 11:08:53 +0000 (0:00:00.102) 0:01:21.799 *********
skipping: [instance]
TASK [libvirt_manager : Attach cloud-init ISO if exists] ***********************
Tuesday 17 March 2026 11:08:53 +0000 (0:00:00.043) 0:01:21.843 *********
skipping: [instance]
TASK [libvirt_manager : Attach additional devices if specified] ****************
Tuesday 17 March 2026 11:08:53 +0000 (0:00:00.042) 0:01:21.885 *********
skipping: [instance]
TASK [libvirt_manager : Configure boot order for net-only-0] *******************
Tuesday 17 March 2026 11:08:53 +0000 (0:00:00.064) 0:01:21.950 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/configure_boot_order.yml for instance
TASK [libvirt_manager : Get current domain XML for cifmw-net-only-0] ***********
Tuesday 17 March 2026 11:08:53 +0000 (0:00:00.093) 0:01:22.043 *********
ok: [instance]
TASK [libvirt_manager : Create temporary file for domain XML] ******************
Tuesday 17 March 2026 11:08:54 +0000 (0:00:00.281) 0:01:22.325 *********
changed: [instance]
TASK [libvirt_manager : Write current domain XML to temporary file] ************
Tuesday 17 March 2026 11:08:54 +0000 (0:00:00.220) 0:01:22.545 *********
changed: [instance]
TASK [libvirt_manager : Remove existing boot elements from os section] *********
Tuesday 17 March 2026 11:08:54 +0000 (0:00:00.391) 0:01:22.936 *********
changed: [instance]
TASK [libvirt_manager : Add boot order to disk device] *************************
Tuesday 17 March 2026 11:08:54 +0000 (0:00:00.242) 0:01:23.179 *********
skipping: [instance]
TASK [libvirt_manager : Get interface count for boot order] ********************
Tuesday 17 March 2026 11:08:55 +0000 (0:00:00.044) 0:01:23.223 *********
ok: [instance]
TASK [libvirt_manager : Add boot order to network interfaces] ******************
Tuesday 17 March 2026 11:08:55 +0000 (0:00:00.241) 0:01:23.464 *********
changed: [instance]
TASK [libvirt_manager : Read updated domain XML] *******************************
Tuesday 17 March 2026 11:08:55 +0000 (0:00:00.269) 0:01:23.734 *********
ok: [instance]
TASK [libvirt_manager : Redefine domain with updated boot order] ***************
Tuesday 17 March 2026 11:08:55 +0000 (0:00:00.212) 0:01:23.947 *********
changed: [instance]
TASK [libvirt_manager : Clean up temporary domain XML file] ********************
Tuesday 17 March 2026 11:08:56 +0000 (0:00:00.274) 0:01:24.221 *********
changed: [instance]
TASK [libvirt_manager : Create VM image for no-boot-order-0] *******************
Tuesday 17 March 2026 11:08:56 +0000 (0:00:00.269) 0:01:24.490 *********
changed: [instance]
TASK [libvirt_manager : Ensure file ownership and rights for no-boot-order-0] ***
Tuesday 17 March 2026 11:08:56 +0000 (0:00:00.258) 0:01:24.749 *********
changed: [instance]
TASK [libvirt_manager : Define VMs for type no-boot-order-0] *******************
Tuesday 17 March 2026 11:08:56 +0000 (0:00:00.248) 0:01:24.997 *********
changed: [instance]
TASK [libvirt_manager : Attach listed networks to the VMs no-boot-order-0] *****
Tuesday 17 March 2026 11:08:57 +0000 (0:00:00.359) 0:01:25.356 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/net_to_vms.yml for instance
TASK [libvirt_manager : Attach {{ vm_item }} to {{ net_item }}] ****************
Tuesday 17 March 2026 11:08:57 +0000 (0:00:00.112) 0:01:25.469 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/attach_interface.yml for instance => (item=public)
TASK [libvirt_manager : Get virtual network information] ***********************
Tuesday 17 March 2026 11:08:57 +0000 (0:00:00.089) 0:01:25.559 *********
ok: [instance]
TASK [libvirt_manager : Create network to bridge mapping] **********************
Tuesday 17 March 2026 11:08:57 +0000 (0:00:00.261) 0:01:25.820 *********
ok: [instance] => (item=cifmw-osp_trunk)
ok: [instance] => (item=cifmw-public)
TASK [libvirt_manager : Dump domain xml] ***************************************
Tuesday 17 March 2026 11:08:57 +0000 (0:00:00.067) 0:01:25.888 *********
ok: [instance]
TASK [libvirt_manager : Extract networks from XML] *****************************
Tuesday 17 March 2026 11:08:58 +0000 (0:00:00.338) 0:01:26.226 *********
ok: [instance]
TASK [libvirt_manager : Attach interface public on cifmw-no-boot-order-0] ******
Tuesday 17 March 2026 11:08:58 +0000 (0:00:00.225) 0:01:26.452 *********
changed: [instance]
TASK [libvirt_manager : Attach spines/leafs networks to the VMs no-boot-order-0] ***
Tuesday 17 March 2026 11:08:58 +0000 (0:00:00.315) 0:01:26.767 *********
skipping: [instance]
TASK [libvirt_manager : Create the requested extra disks for no-boot-order-0] ***
Tuesday 17 March 2026 11:08:58 +0000 (0:00:00.047) 0:01:26.815 *********
skipping: [instance]
TASK [libvirt_manager : Find volume attachments for VM no-boot-order-0] ********
Tuesday 17 March 2026 11:08:58 +0000 (0:00:00.050) 0:01:26.865 *********
skipping: [instance]
TASK [libvirt_manager : Attach volumes for VM no-boot-order-0] *****************
Tuesday 17 March 2026 11:08:58 +0000 (0:00:00.046) 0:01:26.912 *********
skipping: [instance]
TASK [libvirt_manager : Get VM UUID] *******************************************
Tuesday 17 March 2026 11:08:58 +0000 (0:00:00.093) 0:01:27.006 *********
changed: [instance]
TASK [libvirt_manager : Inject UUID in dataset] ********************************
Tuesday 17 March 2026 11:08:59 +0000 (0:00:00.228) 0:01:27.234 *********
ok: [instance]
TASK [libvirt_manager : Create cloud-init ISO] *********************************
Tuesday 17 March 2026 11:08:59 +0000 (0:00:00.060) 0:01:27.295 *********
skipping: [instance]
TASK [libvirt_manager : Attach cloud-init ISO if exists] ***********************
Tuesday 17 March 2026 11:08:59 +0000 (0:00:00.043) 0:01:27.338 *********
skipping: [instance]
TASK [libvirt_manager : Attach additional devices if specified] ****************
Tuesday 17 March 2026 11:08:59 +0000 (0:00:00.042) 0:01:27.381 *********
skipping: [instance]
TASK [libvirt_manager : Configure boot order for no-boot-order-0] **************
Tuesday 17 March 2026 11:08:59 +0000 (0:00:00.120) 0:01:27.501 *********
skipping: [instance]
TASK [libvirt_manager : Start (power-on) VMs] **********************************
Tuesday 17 March 2026 11:08:59 +0000 (0:00:00.047) 0:01:27.549 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/start_vms.yml for instance
TASK [libvirt_manager : Refresh oooq_pool before starting VMs] *****************
Tuesday 17 March 2026 11:08:59 +0000 (0:00:00.091) 0:01:27.640 *********
skipping: [instance]
TASK [libvirt_manager : Start VMs for type {{ vm_type }}] **********************
Tuesday 17 March 2026 11:08:59 +0000 (0:00:00.051) 0:01:27.692 *********
skipping: [instance] => (item={'key': 'disk-first-0', 'value': 'disk_first'})
skipping: [instance] => (item={'key': 'net-first-0', 'value': 'net_first'})
skipping: [instance] => (item={'key': 'net-only-0', 'value': 'net_only'})
skipping: [instance] => (item={'key': 'no-boot-order-0', 'value': 'no_boot_order'})
skipping: [instance]
TASK [libvirt_manager : Wait for SSH on started VMs] ***************************
Tuesday 17 March 2026 11:09:02 +0000 (0:00:03.079) 0:01:30.771 *********
skipping: [instance] => (item=disk-first-0.utility)
skipping: [instance] => (item=net-first-0.utility)
skipping: [instance] => (item=net-only-0.utility)
skipping: [instance] => (item=no-boot-order-0.utility)
skipping: [instance]
TASK [libvirt_manager : Ensure we get SSH on nodes] ****************************
Tuesday 17 March 2026 11:09:02 +0000 (0:00:00.089) 0:01:30.861 *********
skipping: [instance] => (item={'changed': False, 'skipped': True, 'skip_reason': 'Conditional result was False', 'false_condition': "vm_data.disk_file_name != 'blank'", '_vm': {'key': 'disk-first-0', 'value': 'disk_first'}, 'ansible_loop_var': '_vm'})
skipping: [instance] => (item={'changed': False, 'skipped': True, 'skip_reason': 'Conditional result was False', 'false_condition': "vm_data.disk_file_name != 'blank'", '_vm': {'key': 'net-first-0', 'value': 'net_first'}, 'ansible_loop_var': '_vm'})
skipping: [instance] => (item={'changed': False, 'skipped': True, 'skip_reason': 'Conditional result was False', 'false_condition': "vm_data.disk_file_name != 'blank'", '_vm': {'key': 'net-only-0', 'value': 'net_only'}, 'ansible_loop_var': '_vm'})
skipping: [instance] => (item={'changed': False, 'skipped': True, 'skip_reason': 'Conditional result was False', 'false_condition': "vm_data.disk_file_name != 'blank'", '_vm': {'key': 'no-boot-order-0', 'value': 'no_boot_order'}, 'ansible_loop_var': '_vm'})
skipping: [instance]
TASK [libvirt_manager : Configure managed VMs] *********************************
Tuesday 17 March 2026 11:09:02 +0000 (0:00:00.090) 0:01:30.951 *********
skipping: [instance] => (item={'key': 'disk-first-0', 'value': 'disk_first'})
skipping: [instance] => (item={'key': 'net-first-0', 'value': 'net_first'})
skipping: [instance] => (item={'key': 'net-only-0', 'value': 'net_only'})
skipping: [instance] => (item={'key': 'no-boot-order-0', 'value': 'no_boot_order'})
skipping: [instance]
TASK [Create VBMC entity] ******************************************************
Tuesday 17 March 2026 11:09:02 +0000 (0:00:00.077) 0:01:31.029 *********
skipping: [instance] => (item=disk-first-0)
skipping: [instance] => (item=net-first-0)
skipping: [instance] => (item=net-only-0)
skipping: [instance] => (item=no-boot-order-0)
skipping: [instance]
TASK [libvirt_manager : List running virtual machines.] ************************
Tuesday 17 March 2026 11:09:02 +0000 (0:00:00.068) 0:01:31.098 *********
ok: [instance]
TASK [libvirt_manager : Dump UUIDs] ********************************************
Tuesday 17 March 2026 11:09:03 +0000 (0:00:00.237) 0:01:31.335 *********
changed: [instance]
TASK [Ensure fresh vbmc listing] ***********************************************
Tuesday 17 March 2026 11:09:03 +0000 (0:00:00.351) 0:01:31.687 *********
skipping: [instance]
TASK [libvirt_manager : Update vbmc related fact] ******************************
Tuesday 17 March 2026 11:09:03 +0000 (0:00:00.092) 0:01:31.779 *********
skipping: [instance]
TASK [libvirt_manager : Dump vbmc known hosts] *********************************
Tuesday 17 March 2026 11:09:03 +0000 (0:00:00.052) 0:01:31.831 *********
skipping: [instance]
TASK [libvirt_manager : Copy authorized_keys] **********************************
Tuesday 17 March 2026 11:09:03 +0000 (0:00:00.050) 0:01:31.882 *********
skipping: [instance]
TASK [libvirt_manager : Enable root access on CRC] *****************************
Tuesday 17 March 2026 11:09:03 +0000 (0:00:00.044) 0:01:31.927 *********
skipping: [instance]
TASK [Get disk_first VM XML] ***************************************************
Tuesday 17 March 2026 11:09:03 +0000 (0:00:00.070) 0:01:31.997 *********
ok: [instance]
TASK [Check disk boot order in disk-first VM] **********************************
Tuesday 17 March 2026 11:09:04 +0000 (0:00:00.304) 0:01:32.301 *********
ok: [instance]
TASK [Check interface boot order in disk-first VM] *****************************
Tuesday 17 March 2026 11:09:04 +0000 (0:00:00.205) 0:01:32.507 *********
ok: [instance]
TASK [Assert disk-first VM has correct boot order] *****************************
Tuesday 17 March 2026 11:09:04 +0000 (0:00:00.209) 0:01:32.717 *********
ok: [instance]
TASK [Get net_first VM XML] ****************************************************
Tuesday 17 March 2026 11:09:04 +0000 (0:00:00.046) 0:01:32.764 *********
ok: [instance]
TASK [Check disk boot order in network-first VM] *******************************
Tuesday 17 March 2026 11:09:04 +0000 (0:00:00.244) 0:01:33.009 *********
ok: [instance]
TASK [Check interface boot order in network-first VM] **************************
Tuesday 17 March 2026 11:09:05 +0000 (0:00:00.253) 0:01:33.262 *********
ok: [instance]
TASK [Assert network-first VM has correct boot order] **************************
Tuesday 17 March 2026 11:09:05 +0000 (0:00:00.213) 0:01:33.475 *********
ok: [instance]
TASK [Get net_only VM XML] *****************************************************
Tuesday 17 March 2026 11:09:05 +0000 (0:00:00.047) 0:01:33.522 *********
ok: [instance]
TASK [Check interface boot order in network-only VM] ***************************
Tuesday 17 March 2026 11:09:05 +0000 (0:00:00.237) 0:01:33.760 *********
ok: [instance]
TASK [Check disk boot order in network-only VM (should not exist)] *************
Tuesday 17 March 2026 11:09:05 +0000 (0:00:00.209) 0:01:33.969 *********
ok: [instance]
TASK [Assert network-only VM has correct boot order] ***************************
Tuesday 17 March 2026 11:09:06 +0000 (0:00:00.260) 0:01:34.229 *********
ok: [instance]
TASK [Get no_boot_order VM XML] ************************************************
Tuesday 17 March 2026 11:09:06 +0000 (0:00:00.060) 0:01:34.289 *********
ok: [instance]
TASK [Check for any boot order attributes in no-boot-order VM] *****************
Tuesday 17 March 2026 11:09:06 +0000 (0:00:00.229) 0:01:34.518 *********
ok: [instance]
TASK [Assert no-boot-order VM has no boot order attributes] ********************
Tuesday 17 March 2026 11:09:06 +0000 (0:00:00.204) 0:01:34.723 *********
ok: [instance]
TASK [Output success message] **************************************************
Tuesday 17 March 2026 11:09:06 +0000 (0:00:00.054) 0:01:34.778 *********
ok: [instance] =>
msg: All boot_order validations passed successfully!
PLAY RECAP *********************************************************************
instance : ok=256 changed=103 unreachable=0 failed=0 skipped=103 rescued=0 ignored=1
Tuesday 17 March 2026 11:09:06 +0000 (0:00:00.152) 0:01:34.931 *********
===============================================================================
ci_nmstate : Install required packages on instance --------------------- 10.96s
dnsmasq : Ensure SELinux knows about the new files and directories ------ 3.62s
libvirt_manager : Start VMs for type {{ vm_type }} ---------------------- 3.08s
dnsmasq : Add DHCP entries ---------------------------------------------- 2.83s
dnsmasq : Add/Remove address -------------------------------------------- 2.53s
ci_nmstate : Apply the desidered state on instance ---------------------- 1.95s
libvirt_manager : Create group inventories ------------------------------ 1.66s
libvirt_manager : Restart firewalld ------------------------------------- 1.59s
dnsmasq : Install needed packages --------------------------------------- 1.38s
libvirt_manager : Define VMs for type disk-first-0 ---------------------- 1.14s
Gathering Facts --------------------------------------------------------- 1.01s
libvirt_manager : Ensure networks are created/started ------------------- 0.78s
dnsmasq : Enable and start service -------------------------------------- 0.77s
libvirt_manager : Create needed workload directory ---------------------- 0.69s
libvirt_manager : Test -------------------------------------------------- 0.66s
libvirt_manager : Ensure networks are defined --------------------------- 0.62s
libvirt_manager : Allow QEMU on workload directory ---------------------- 0.60s
libvirt_manager : Ensure networks are active ---------------------------- 0.56s
libvirt_manager : Enable forwarding in the libvirt zone ----------------- 0.55s
libvirt_manager : Enable masquerading for public traffic ---------------- 0.55s
PLAY [Cleanup] *****************************************************************
TASK [Gathering Facts] *********************************************************
Tuesday 17 March 2026 11:09:07 +0000 (0:00:00.037) 0:00:00.038 *********
ok: [instance]
TASK [Ensure we have the destination directory] ********************************
Tuesday 17 March 2026 11:09:08 +0000 (0:00:00.908) 0:00:00.946 *********
changed: [instance]
TASK [Copy generated content to proper location] *******************************
Tuesday 17 March 2026 11:09:08 +0000 (0:00:00.305) 0:00:01.251 *********
changed: [instance] => (item=/opt/basedir/artifacts)
changed: [instance] => (item=/opt/basedir/logs)
ok: [instance] => (item=/opt/basedir/cifmw_config_drive)
changed: [instance] => (item=/etc/cifmw-dnsmasq.conf)
changed: [instance] => (item=/etc/cifmw-dnsmasq.d)
TASK [libvirt_manager : Get installed packages list] ***************************
Tuesday 17 March 2026 11:09:09 +0000 (0:00:01.381) 0:00:02.632 *********
ok: [instance]
TASK [libvirt_manager : Populate service facts] ********************************
Tuesday 17 March 2026 11:09:10 +0000 (0:00:00.791) 0:00:03.424 *********
ok: [instance]
TASK [libvirt_manager : Start virtqemud socket service] ************************
Tuesday 17 March 2026 11:09:12 +0000 (0:00:02.026) 0:00:05.451 *********
ok: [instance] => (item=virtqemud.service)
ok: [instance] => (item=virtqemud.socket)
TASK [libvirt_manager : Start virtnetworkd socket service] *********************
Tuesday 17 March 2026 11:09:13 +0000 (0:00:00.817) 0:00:06.268 *********
changed: [instance] => (item=virtnetworkd.service)
ok: [instance] => (item=virtnetworkd.socket)
TASK [libvirt_manager : Start virtstoraged socket service] *********************
Tuesday 17 March 2026 11:09:14 +0000 (0:00:00.836) 0:00:07.105 *********
changed: [instance] => (item=virtstoraged.service)
ok: [instance] => (item=virtstoraged.socket)
TASK [libvirt_manager : Set _is_deepscrub internal fact] ***********************
Tuesday 17 March 2026 11:09:15 +0000 (0:00:00.938) 0:00:08.043 *********
ok: [instance]
TASK [libvirt_manager : List all of the existing virtual machines] *************
Tuesday 17 March 2026 11:09:15 +0000 (0:00:00.054) 0:00:08.097 *********
ok: [instance]
TASK [libvirt_manager : Get pool configuration] ********************************
Tuesday 17 March 2026 11:09:15 +0000 (0:00:00.445) 0:00:08.543 *********
ok: [instance]
TASK [libvirt_manager : Filter out target environment] *************************
Tuesday 17 March 2026 11:09:16 +0000 (0:00:00.424) 0:00:08.967 *********
ok: [instance]
TASK [libvirt_manager : Expose cleanup list] ***********************************
Tuesday 17 March 2026 11:09:16 +0000 (0:00:00.165) 0:00:09.133 *********
ok: [instance] =>
cleanup_vms:
- cifmw-net-only-0
- cifmw-disk-first-0
- cifmw-net-first-0
- cifmw-no-boot-order-0
TASK [libvirt_manager : Clean ssh known_hosts] *********************************
Tuesday 17 March 2026 11:09:16 +0000 (0:00:00.093) 0:00:09.227 *********
ok: [instance] => (item=cifmw-net-only-0)
ok: [instance] => (item=cifmw-disk-first-0)
ok: [instance] => (item=cifmw-net-first-0)
ok: [instance] => (item=cifmw-no-boot-order-0)
TASK [libvirt_manager : Destroy machine] ***************************************
Tuesday 17 March 2026 11:09:17 +0000 (0:00:00.988) 0:00:10.215 *********
ok: [instance] => (item=cifmw-net-only-0)
ok: [instance] => (item=cifmw-disk-first-0)
ok: [instance] => (item=cifmw-net-first-0)
ok: [instance] => (item=cifmw-no-boot-order-0)
TASK [libvirt_manager : Undefine machine] **************************************
Tuesday 17 March 2026 11:09:18 +0000 (0:00:01.069) 0:00:11.285 *********
ok: [instance] => (item=cifmw-net-only-0)
ok: [instance] => (item=cifmw-disk-first-0)
ok: [instance] => (item=cifmw-net-first-0)
ok: [instance] => (item=cifmw-no-boot-order-0)
TASK [libvirt_manager : (localhost) Clean ssh jumpers] *************************
Tuesday 17 March 2026 11:09:19 +0000 (0:00:01.070) 0:00:12.355 *********
ok: [instance -> localhost] => (item=cifmw-net-only-0)
ok: [instance -> localhost] => (item=cifmw-disk-first-0)
ok: [instance -> localhost] => (item=cifmw-net-first-0)
ok: [instance -> localhost] => (item=cifmw-no-boot-order-0)
TASK [libvirt_manager : (instance) Clean ssh jumpers] **************************
Tuesday 17 March 2026 11:09:20 +0000 (0:00:00.966) 0:00:13.322 *********
ok: [instance] => (item=cifmw-net-only-0)
ok: [instance] => (item=cifmw-disk-first-0)
ok: [instance] => (item=cifmw-net-first-0)
ok: [instance] => (item=cifmw-no-boot-order-0)
TASK [libvirt_manager : Get network list] **************************************
Tuesday 17 March 2026 11:09:21 +0000 (0:00:00.832) 0:00:14.154 *********
ok: [instance]
TASK [libvirt_manager : Filter out target nets] ********************************
Tuesday 17 March 2026 11:09:21 +0000 (0:00:00.365) 0:00:14.520 *********
ok: [instance]
TASK [libvirt_manager : Expose cleanup list] ***********************************
Tuesday 17 March 2026 11:09:21 +0000 (0:00:00.107) 0:00:14.627 *********
ok: [instance] =>
cleanup_nets:
- cifmw-osp_trunk
- cifmw-public
TASK [Remove dnsmasq network bits] *********************************************
Tuesday 17 March 2026 11:09:21 +0000 (0:00:00.076) 0:00:14.704 *********
TASK [dnsmasq : Assert mandatory parameter] ************************************
Tuesday 17 March 2026 11:09:22 +0000 (0:00:00.191) 0:00:14.895 *********
ok: [instance] => changed=false
msg: All assertions passed
TASK [dnsmasq : Assert mandatory parameters for new network] *******************
Tuesday 17 March 2026 11:09:22 +0000 (0:00:00.076) 0:00:14.972 *********
skipping: [instance]
TASK [dnsmasq : Create network] ************************************************
Tuesday 17 March 2026 11:09:22 +0000 (0:00:00.072) 0:00:15.045 *********
skipping: [instance]
TASK [dnsmasq : Remove network] ************************************************
Tuesday 17 March 2026 11:09:22 +0000 (0:00:00.071) 0:00:15.117 *********
ok: [instance]
TASK [dnsmasq : Remove dhcp host files] ****************************************
Tuesday 17 March 2026 11:09:22 +0000 (0:00:00.252) 0:00:15.370 *********
ok: [instance]
TASK [dnsmasq : Assert mandatory parameter] ************************************
Tuesday 17 March 2026 11:09:22 +0000 (0:00:00.299) 0:00:15.669 *********
ok: [instance] => changed=false
msg: All assertions passed
TASK [dnsmasq : Assert mandatory parameters for new network] *******************
Tuesday 17 March 2026 11:09:22 +0000 (0:00:00.077) 0:00:15.746 *********
skipping: [instance]
TASK [dnsmasq : Create network] ************************************************
Tuesday 17 March 2026 11:09:23 +0000 (0:00:00.071) 0:00:15.818 *********
skipping: [instance]
TASK [dnsmasq : Remove network] ************************************************
Tuesday 17 March 2026 11:09:23 +0000 (0:00:00.071) 0:00:15.890 *********
ok: [instance]
TASK [dnsmasq : Remove dhcp host files] ****************************************
Tuesday 17 March 2026 11:09:23 +0000 (0:00:00.249) 0:00:16.140 *********
ok: [instance]
TASK [libvirt_manager : Destroy networks] **************************************
Tuesday 17 March 2026 11:09:23 +0000 (0:00:00.273) 0:00:16.413 *********
ok: [instance] => (item=cifmw-osp_trunk)
ok: [instance] => (item=cifmw-public)
TASK [libvirt_manager : Undefine networks] *************************************
Tuesday 17 March 2026 11:09:24 +0000 (0:00:01.113) 0:00:17.526 *********
ok: [instance] => (item=cifmw-osp_trunk)
ok: [instance] => (item=cifmw-public)
TASK [libvirt_manager : Ensure no trace of networks lays in nmcli] *************
Tuesday 17 March 2026 11:09:25 +0000 (0:00:00.595) 0:00:18.122 *********
ok: [instance] => (item=cifmw-osp_trunk)
ok: [instance] => (item=cifmw-public)
TASK [libvirt_manager : Find dummy interface connection files] *****************
Tuesday 17 March 2026 11:09:26 +0000 (0:00:00.713) 0:00:18.836 *********
ok: [instance]
TASK [libvirt_manager : Remove dummy interface connections] ********************
Tuesday 17 March 2026 11:09:26 +0000 (0:00:00.346) 0:00:19.182 *********
changed: [instance] => (item={'path': '/etc/NetworkManager/system-connections/dummy-yyi5jwm5.nmconnection', 'mode': '0600', 'isdir': False, 'ischr': False, 'isblk': False, 'isreg': True, 'isfifo': False, 'islnk': False, 'issock': False, 'uid': 0, 'gid': 0, 'size': 314, 'inode': 4616825, 'dev': 64513, 'nlink': 1, 'atime': 1773745682.34631, 'mtime': 1773745682.34631, 'ctime': 1773745682.34631, 'gr_name': 'root', 'pw_name': 'root', 'wusr': True, 'rusr': True, 'xusr': False, 'wgrp': False, 'rgrp': False, 'xgrp': False, 'woth': False, 'roth': False, 'xoth': False, 'isuid': False, 'isgid': False})
changed: [instance] => (item={'path': '/etc/NetworkManager/system-connections/dummy-zoorn5o4.nmconnection', 'mode': '0600', 'isdir': False, 'ischr': False, 'isblk': False, 'isreg': True, 'isfifo': False, 'islnk': False, 'issock': False, 'uid': 0, 'gid': 0, 'size': 308, 'inode': 4616826, 'dev': 64513, 'nlink': 1, 'atime': 1773745682.34831, 'mtime': 1773745682.34831, 'ctime': 1773745682.34831, 'gr_name': 'root', 'pw_name': 'root', 'wusr': True, 'rusr': True, 'xusr': False, 'wgrp': False, 'rgrp': False, 'xgrp': False, 'woth': False, 'roth': False, 'xoth': False, 'isuid': False, 'isgid': False})
TASK [libvirt_manager : Clean firewalld libvirt zone] **************************
Tuesday 17 March 2026 11:09:27 +0000 (0:00:00.603) 0:00:19.785 *********
changed: [instance] => (item=cifmw-osp_trunk)
changed: [instance] => (item=cifmw-public)
TASK [libvirt_manager : Ensure firewalld is enabled and started] ***************
Tuesday 17 March 2026 11:09:27 +0000 (0:00:00.921) 0:00:20.706 *********
ok: [instance]
TASK [libvirt_manager : Disable masquerade in firewalld default zone] **********
Tuesday 17 March 2026 11:09:28 +0000 (0:00:00.621) 0:00:21.328 *********
changed: [instance]
TASK [libvirt_manager : Disable forward in firewalld libvirt zone] *************
Tuesday 17 March 2026 11:09:29 +0000 (0:00:00.445) 0:00:21.773 *********
changed: [instance]
TASK [libvirt_manager : Remove cifmw storage pool] *****************************
Tuesday 17 March 2026 11:09:29 +0000 (0:00:00.657) 0:00:22.431 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/storage_pool.yml for instance
TASK [libvirt_manager : Ensure we have a known action] *************************
Tuesday 17 March 2026 11:09:29 +0000 (0:00:00.116) 0:00:22.548 *********
ok: [instance] => changed=false
msg: All assertions passed
TASK [libvirt_manager : Gather the status of cifmw-pool storage pool.] *********
Tuesday 17 March 2026 11:09:29 +0000 (0:00:00.083) 0:00:22.631 *********
changed: [instance]
TASK [libvirt_manager : Create the storage pool] *******************************
Tuesday 17 March 2026 11:09:30 +0000 (0:00:00.286) 0:00:22.917 *********
skipping: [instance]
TASK [libvirt_manager : Ensure the storage pool is started] ********************
Tuesday 17 March 2026 11:09:30 +0000 (0:00:00.087) 0:00:23.005 *********
skipping: [instance] => (item=pool-start)
skipping: [instance] => (item=pool-autostart)
skipping: [instance]
TASK [libvirt_manager : Gather all the volumes in the pool to delete] **********
Tuesday 17 March 2026 11:09:30 +0000 (0:00:00.117) 0:00:23.123 *********
skipping: [instance]
TASK [libvirt_manager : Remove the volumes from pool to delete] ****************
Tuesday 17 March 2026 11:09:30 +0000 (0:00:00.081) 0:00:23.204 *********
skipping: [instance]
TASK [libvirt_manager : Delete storage pool] ***********************************
Tuesday 17 March 2026 11:09:30 +0000 (0:00:00.080) 0:00:23.285 *********
skipping: [instance] => (item=pool-destroy)
skipping: [instance] => (item=pool-undefine)
skipping: [instance]
TASK [libvirt_manager : Refresh pools facts] ***********************************
Tuesday 17 March 2026 11:09:30 +0000 (0:00:00.107) 0:00:23.392 *********
ok: [instance]
TASK [libvirt_manager : Remove overlay images from ocp_volume pools if exists] ***
Tuesday 17 March 2026 11:09:30 +0000 (0:00:00.324) 0:00:23.717 *********
skipping: [instance]
TASK [libvirt_manager : Remove ocp_volumes storage pool] ***********************
Tuesday 17 March 2026 11:09:31 +0000 (0:00:00.050) 0:00:23.767 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/storage_pool.yml for instance
TASK [libvirt_manager : Ensure we have a known action] *************************
Tuesday 17 March 2026 11:09:31 +0000 (0:00:00.118) 0:00:23.886 *********
ok: [instance] => changed=false
msg: All assertions passed
TASK [libvirt_manager : Gather the status of cifmw-pool storage pool.] *********
Tuesday 17 March 2026 11:09:31 +0000 (0:00:00.085) 0:00:23.972 *********
changed: [instance]
TASK [libvirt_manager : Create the storage pool] *******************************
Tuesday 17 March 2026 11:09:31 +0000 (0:00:00.274) 0:00:24.246 *********
skipping: [instance]
TASK [libvirt_manager : Ensure the storage pool is started] ********************
Tuesday 17 March 2026 11:09:31 +0000 (0:00:00.079) 0:00:24.326 *********
skipping: [instance] => (item=pool-start)
skipping: [instance] => (item=pool-autostart)
skipping: [instance]
TASK [libvirt_manager : Gather all the volumes in the pool to delete] **********
Tuesday 17 March 2026 11:09:31 +0000 (0:00:00.106) 0:00:24.433 *********
skipping: [instance]
TASK [libvirt_manager : Remove the volumes from pool to delete] ****************
Tuesday 17 March 2026 11:09:31 +0000 (0:00:00.081) 0:00:24.514 *********
skipping: [instance]
TASK [libvirt_manager : Delete storage pool] ***********************************
Tuesday 17 March 2026 11:09:31 +0000 (0:00:00.146) 0:00:24.661 *********
skipping: [instance] => (item=pool-destroy)
skipping: [instance] => (item=pool-undefine)
skipping: [instance]
TASK [libvirt_manager : Refresh pools facts] ***********************************
Tuesday 17 March 2026 11:09:32 +0000 (0:00:00.110) 0:00:24.772 *********
ok: [instance]
TASK [libvirt_manager : Refresh all pools after actions] ***********************
Tuesday 17 March 2026 11:09:32 +0000 (0:00:00.291) 0:00:25.064 *********
skipping: [instance]
TASK [libvirt_manager : Get temporary key status] ******************************
Tuesday 17 March 2026 11:09:32 +0000 (0:00:00.046) 0:00:25.110 *********
ok: [instance]
TASK [libvirt_manager : Get public key] ****************************************
Tuesday 17 March 2026 11:09:32 +0000 (0:00:00.320) 0:00:25.430 *********
ok: [instance]
TASK [libvirt_manager : Remove public key] *************************************
Tuesday 17 March 2026 11:09:32 +0000 (0:00:00.310) 0:00:25.741 *********
changed: [instance]
TASK [libvirt_manager : Remove keypair] ****************************************
Tuesday 17 March 2026 11:09:33 +0000 (0:00:00.404) 0:00:26.145 *********
changed: [instance] => (item=cifmw_reproducer_key.pub)
changed: [instance] => (item=cifmw_reproducer_key)
TASK [libvirt_manager : List libvirt logs] *************************************
Tuesday 17 March 2026 11:09:33 +0000 (0:00:00.405) 0:00:26.550 *********
ok: [instance]
TASK [libvirt_manager : Remove detected logs] **********************************
Tuesday 17 March 2026 11:09:34 +0000 (0:00:00.202) 0:00:26.752 *********
skipping: [instance]
TASK [libvirt_manager : Remove workload and volumes] ***************************
Tuesday 17 March 2026 11:09:34 +0000 (0:00:00.036) 0:00:26.788 *********
changed: [instance] => (item=workload)
changed: [instance] => (item=volumes)
changed: [instance] => (item=artifacts/debug_network_data.yml)
changed: [instance] => (item=artifacts/debug_pub_net_value.txt)
changed: [instance] => (item=artifacts/debug_cifmw_libvirt_manager_layout.yml)
changed: [instance] => (item=artifacts/interfaces-info.yml)
changed: [instance] => (item=artifacts/libvirt-uuids.yml)
changed: [instance] => (item=artifacts/net-map-def-patch.yml)
TASK [libvirt_manager : Deepscrub data] ****************************************
Tuesday 17 March 2026 11:09:35 +0000 (0:00:01.386) 0:00:28.175 *********
ok: [instance] => (item=images)
ok: [instance] => (item=artifacts/virtual-nodes.yml)
TASK [podman : Ensure podman is installed] *************************************
Tuesday 17 March 2026 11:09:35 +0000 (0:00:00.392) 0:00:28.567 *********
ok: [instance]
TASK [podman : Enable loginctl linger for ansible_user_id] *********************
Tuesday 17 March 2026 11:09:37 +0000 (0:00:01.616) 0:00:30.184 *********
changed: [instance]
TASK [podman : Ensure subordinate UID entry exists for zuul] *******************
Tuesday 17 March 2026 11:09:37 +0000 (0:00:00.283) 0:00:30.468 *********
skipping: [instance]
TASK [podman : Ensure subordinate GID entry exists for zuul] *******************
Tuesday 17 March 2026 11:09:37 +0000 (0:00:00.054) 0:00:30.522 *********
skipping: [instance]
TASK [podman : Run podman system migrate if subuid/subgid files were changed] ***
Tuesday 17 March 2026 11:09:37 +0000 (0:00:00.050) 0:00:30.572 *********
skipping: [instance]
TASK [virtualbmc : Stop and remove vbmc container] *****************************
Tuesday 17 March 2026 11:09:37 +0000 (0:00:00.072) 0:00:30.645 *********
ok: [instance]
TASK [virtualbmc : Remove vbmc container image] ********************************
Tuesday 17 March 2026 11:09:38 +0000 (0:00:00.515) 0:00:31.161 *********
ok: [instance]
TASK [virtualbmc : Check if VBMC key exists] ***********************************
Tuesday 17 March 2026 11:09:38 +0000 (0:00:00.429) 0:00:31.590 *********
ok: [instance]
TASK [virtualbmc : Slurp key] **************************************************
Tuesday 17 March 2026 11:09:39 +0000 (0:00:00.212) 0:00:31.803 *********
skipping: [instance]
TASK [virtualbmc : Revoke VBMC SSH access] *************************************
Tuesday 17 March 2026 11:09:39 +0000 (0:00:00.041) 0:00:31.845 *********
skipping: [instance]
TASK [virtualbmc : Remove vbmc files] ******************************************
Tuesday 17 March 2026 11:09:39 +0000 (0:00:00.050) 0:00:31.895 *********
ok: [instance] => (item=/home/zuul/.ssh/vbmc-key)
ok: [instance] => (item=/home/zuul/.ssh/vbmc-key.pub)
ok: [instance] => (item=/home/zuul/.ssh/virtualbmc.conf)
ok: [instance] => (item=/home/zuul/.ssh/vbmcd.sh)
TASK [Clean remote ssh config] *************************************************
Tuesday 17 March 2026 11:09:39 +0000 (0:00:00.770) 0:00:32.666 *********
TASK [ssh_jumper : Remove Include cifmw_ssh_config.d] **************************
Tuesday 17 March 2026 11:09:40 +0000 (0:00:00.119) 0:00:32.785 *********
ok: [instance]
TASK [ssh_jumper : Remove cifmw_ssh_config.d directory] ************************
Tuesday 17 March 2026 11:09:40 +0000 (0:00:00.315) 0:00:33.101 *********
ok: [instance]
TASK [Clean local ssh config] **************************************************
Tuesday 17 March 2026 11:09:40 +0000 (0:00:00.245) 0:00:33.347 *********
TASK [ssh_jumper : Remove Include cifmw_ssh_config.d] **************************
Tuesday 17 March 2026 11:09:40 +0000 (0:00:00.088) 0:00:33.435 *********
ok: [instance -> localhost]
TASK [ssh_jumper : Remove cifmw_ssh_config.d directory] ************************
Tuesday 17 March 2026 11:09:40 +0000 (0:00:00.213) 0:00:33.649 *********
ok: [instance -> localhost]
TASK [dnsmasq : Cleaning dnsmasq] **********************************************
Tuesday 17 March 2026 11:09:41 +0000 (0:00:00.288) 0:00:33.938 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/configure.yml for instance
TASK [dnsmasq : Install needed packages] ***************************************
Tuesday 17 March 2026 11:09:41 +0000 (0:00:00.074) 0:00:34.012 *********
ok: [instance]
TASK [dnsmasq : Ensure SELinux knows about the new files and directories] ******
Tuesday 17 March 2026 11:09:42 +0000 (0:00:01.284) 0:00:35.297 *********
changed: [instance] => (item={'target': '/etc/cifmw-dnsmasq.conf', 'setype': 'dnsmasq_etc_t'})
changed: [instance] => (item={'target': '/etc/cifmw-dnsmasq.d(/.*)?', 'setype': 'dnsmasq_etc_t'})
changed: [instance] => (item={'target': '/var/run/cifmw-dnsmasq.pid', 'setype': 'dnsmasq_var_run_t'})
TASK [dnsmasq : Manage configuration directory] ********************************
Tuesday 17 March 2026 11:09:45 +0000 (0:00:03.304) 0:00:38.602 *********
changed: [instance]
TASK [dnsmasq : Manage systemd unit file] **************************************
Tuesday 17 March 2026 11:09:46 +0000 (0:00:00.212) 0:00:38.814 *********
skipping: [instance]
TASK [dnsmasq : Manage base configuration file] ********************************
Tuesday 17 March 2026 11:09:46 +0000 (0:00:00.036) 0:00:38.851 *********
skipping: [instance]
TASK [dnsmasq : Render listener configuration] *********************************
Tuesday 17 March 2026 11:09:46 +0000 (0:00:00.036) 0:00:38.887 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/listener.yml for instance
TASK [dnsmasq : Create listener configuration file] ****************************
Tuesday 17 March 2026 11:09:46 +0000 (0:00:00.081) 0:00:38.969 *********
skipping: [instance]
TASK [dnsmasq : Remove listener configuration file] ****************************
Tuesday 17 March 2026 11:09:46 +0000 (0:00:00.038) 0:00:39.007 *********
changed: [instance]
TASK [dnsmasq : Render dns configuration] **************************************
Tuesday 17 March 2026 11:09:46 +0000 (0:00:00.220) 0:00:39.227 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/dns.yml for instance
TASK [dnsmasq : Create dns configuration file] *********************************
Tuesday 17 March 2026 11:09:46 +0000 (0:00:00.062) 0:00:39.290 *********
skipping: [instance]
TASK [dnsmasq : Remove dns configuration file] *********************************
Tuesday 17 March 2026 11:09:46 +0000 (0:00:00.037) 0:00:39.327 *********
changed: [instance]
TASK [dnsmasq : Add localhost addresses from defined dnsmasq listen addresses to loopback interface] ***
Tuesday 17 March 2026 11:09:46 +0000 (0:00:00.210) 0:00:39.537 *********
skipping: [instance]
TASK [dnsmasq : Enable and start service] **************************************
Tuesday 17 March 2026 11:09:46 +0000 (0:00:00.035) 0:00:39.572 *********
skipping: [instance]
TASK [dnsmasq : Stop service] **************************************************
Tuesday 17 March 2026 11:09:46 +0000 (0:00:00.039) 0:00:39.612 *********
changed: [instance]
TASK [dnsmasq : Remove unit file] **********************************************
Tuesday 17 March 2026 11:09:47 +0000 (0:00:00.542) 0:00:40.154 *********
changed: [instance]
TASK [dnsmasq : Remove main configuration files] *******************************
Tuesday 17 March 2026 11:09:47 +0000 (0:00:00.210) 0:00:40.364 *********
changed: [instance] => (item=/etc/cifmw-dnsmasq.conf)
changed: [instance] => (item=/etc/cifmw-dnsmasq.d)
TASK [dnsmasq : Remove lease file] *********************************************
Tuesday 17 March 2026 11:09:48 +0000 (0:00:00.401) 0:00:40.766 *********
changed: [instance]
TASK [radvd : Gather package facts] ********************************************
Tuesday 17 March 2026 11:09:48 +0000 (0:00:00.241) 0:00:41.008 *********
ok: [instance]
TASK [radvd : Stop and disable radvd service] **********************************
Tuesday 17 March 2026 11:09:48 +0000 (0:00:00.626) 0:00:41.634 *********
skipping: [instance]
TASK [radvd : Remove radvd configuration file] *********************************
Tuesday 17 March 2026 11:09:48 +0000 (0:00:00.044) 0:00:41.679 *********
ok: [instance]
TASK [radvd : Remove configuration directory] **********************************
Tuesday 17 March 2026 11:09:49 +0000 (0:00:00.215) 0:00:41.894 *********
ok: [instance]
TASK [radvd : Remove radvd package] ********************************************
Tuesday 17 March 2026 11:09:49 +0000 (0:00:00.213) 0:00:42.108 *********
skipping: [instance]
TASK [Ensure work directory is removed] ****************************************
Tuesday 17 March 2026 11:09:49 +0000 (0:00:00.080) 0:00:42.188 *********
changed: [instance]
RUNNING HANDLER [libvirt_manager : Restart firewalld] **************************
Tuesday 17 March 2026 11:09:49 +0000 (0:00:00.369) 0:00:42.558 *********
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=78 changed=24 unreachable=0 failed=0 skipped=30 rescued=0 ignored=0
Tuesday 17 March 2026 11:09:50 +0000 (0:00:00.655) 0:00:43.214 *********
===============================================================================
dnsmasq : Ensure SELinux knows about the new files and directories ------ 3.30s
libvirt_manager : Populate service facts -------------------------------- 2.03s
podman : Ensure podman is installed ------------------------------------- 1.62s
libvirt_manager : Remove workload and volumes --------------------------- 1.39s
Copy generated content to proper location ------------------------------- 1.38s
dnsmasq : Install needed packages --------------------------------------- 1.28s
libvirt_manager : Destroy networks -------------------------------------- 1.11s
libvirt_manager : Undefine machine -------------------------------------- 1.07s
libvirt_manager : Destroy machine --------------------------------------- 1.07s
libvirt_manager : Clean ssh known_hosts --------------------------------- 0.99s
libvirt_manager : (localhost) Clean ssh jumpers ------------------------- 0.97s
libvirt_manager : Start virtstoraged socket service --------------------- 0.94s
libvirt_manager : Clean firewalld libvirt zone -------------------------- 0.92s
Gathering Facts --------------------------------------------------------- 0.91s
libvirt_manager : Start virtnetworkd socket service --------------------- 0.84s
libvirt_manager : (instance) Clean ssh jumpers -------------------------- 0.83s
libvirt_manager : Start virtqemud socket service ------------------------ 0.82s
libvirt_manager : Get installed packages list --------------------------- 0.79s
virtualbmc : Remove vbmc files ------------------------------------------ 0.77s
libvirt_manager : Ensure no trace of networks lays in nmcli ------------- 0.71s
PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Tuesday 17 March 2026 11:10:08 +0000 (0:00:00.057) 0:00:00.057 *********
ok: [instance]
TASK [Create custom basedir] ***************************************************
Tuesday 17 March 2026 11:10:09 +0000 (0:00:00.824) 0:00:00.881 *********
changed: [instance]
TASK [test_deps : Gather facts if they don't exist] ****************************
Tuesday 17 March 2026 11:10:09 +0000 (0:00:00.419) 0:00:01.300 *********
skipping: [instance]
TASK [test_deps : Gather variables for each operating system] ******************
Tuesday 17 March 2026 11:10:09 +0000 (0:00:00.056) 0:00:01.357 *********
ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml)
TASK [test_deps : Detect mirrors file] *****************************************
Tuesday 17 March 2026 11:10:09 +0000 (0:00:00.103) 0:00:01.460 *********
ok: [instance]
TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Tuesday 17 March 2026 11:10:09 +0000 (0:00:00.308) 0:00:01.769 *********
ok: [instance]
TASK [test_deps : Disable ubi 9 repos] *****************************************
Tuesday 17 March 2026 11:10:10 +0000 (0:00:00.260) 0:00:02.029 *********
ok: [instance] => (item=ubi-9-appstream)
ok: [instance] => (item=ubi-9-baseos)
ok: [instance] => (item=ubi-9-codeready-builder)
TASK [Deploy repo-setup] *******************************************************
Tuesday 17 March 2026 11:10:11 +0000 (0:00:00.792) 0:00:02.822 *********
TASK [repo_setup : Ensure directories are present] *****************************
Tuesday 17 March 2026 11:10:11 +0000 (0:00:00.138) 0:00:02.960 *********
changed: [instance] => (item=tmp)
changed: [instance] => (item=artifacts/repositories)
changed: [instance] => (item=venv/repo_setup)
TASK [repo_setup : Make sure git-core package is installed] ********************
Tuesday 17 March 2026 11:10:11 +0000 (0:00:00.527) 0:00:03.488 *********
ok: [instance]
TASK [repo_setup : Get repo-setup repository] **********************************
Tuesday 17 March 2026 11:10:13 +0000 (0:00:01.396) 0:00:04.884 *********
changed: [instance]
TASK [repo_setup : Initialize python venv and install requirements] ************
Tuesday 17 March 2026 11:10:14 +0000 (0:00:01.130) 0:00:06.015 *********
changed: [instance]
TASK [repo_setup : Install repo-setup package] *********************************
Tuesday 17 March 2026 11:10:20 +0000 (0:00:06.085) 0:00:12.101 *********
changed: [instance]
TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Tuesday 17 March 2026 11:10:20 +0000 (0:00:00.654) 0:00:12.755 *********
skipping: [instance]
TASK [repo_setup : Run repo-setup] *********************************************
Tuesday 17 March 2026 11:10:21 +0000 (0:00:00.050) 0:00:12.806 *********
changed: [instance]
TASK [repo_setup : Get component repo] *****************************************
Tuesday 17 March 2026 11:10:21 +0000 (0:00:00.864) 0:00:13.670 *********
skipping: [instance]
TASK [repo_setup : Rename component repo] **************************************
Tuesday 17 March 2026 11:10:21 +0000 (0:00:00.066) 0:00:13.737 *********
skipping: [instance]
TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Tuesday 17 March 2026 11:10:22 +0000 (0:00:00.065) 0:00:13.802 *********
skipping: [instance]
TASK [repo_setup : Run repo-setup-get-hash] ************************************
Tuesday 17 March 2026 11:10:22 +0000 (0:00:00.066) 0:00:13.868 *********
changed: [instance]
TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Tuesday 17 March 2026 11:10:22 +0000 (0:00:00.562) 0:00:14.431 *********
changed: [instance]
TASK [repo_setup : Dump current-podified hash] *********************************
Tuesday 17 March 2026 11:10:23 +0000 (0:00:00.438) 0:00:14.870 *********
skipping: [instance]
TASK [repo_setup : Slurp current podified hash] ********************************
Tuesday 17 March 2026 11:10:23 +0000 (0:00:00.057) 0:00:14.927 *********
skipping: [instance]
TASK [repo_setup : Update the value of full_hash] ******************************
Tuesday 17 March 2026 11:10:23 +0000 (0:00:00.060) 0:00:14.988 *********
skipping: [instance]
TASK [repo_setup : Export hashes facts for further use] ************************
Tuesday 17 March 2026 11:10:23 +0000 (0:00:00.085) 0:00:15.073 *********
ok: [instance]
TASK [repo_setup : Create download directory] **********************************
Tuesday 17 March 2026 11:10:23 +0000 (0:00:00.073) 0:00:15.147 *********
skipping: [instance]
TASK [repo_setup : Print the URL to request] ***********************************
Tuesday 17 March 2026 11:10:23 +0000 (0:00:00.056) 0:00:15.203 *********
skipping: [instance]
TASK [Download the RPM] ********************************************************
Tuesday 17 March 2026 11:10:23 +0000 (0:00:00.055) 0:00:15.258 *********
skipping: [instance]
TASK [repo_setup : Install RHOS Release tool] **********************************
Tuesday 17 March 2026 11:10:23 +0000 (0:00:00.055) 0:00:15.314 *********
skipping: [instance]
TASK [repo_setup : Get rhos-release tool version] ******************************
Tuesday 17 March 2026 11:10:23 +0000 (0:00:00.096) 0:00:15.410 *********
skipping: [instance]
TASK [repo_setup : Print rhos-release tool version] ****************************
Tuesday 17 March 2026 11:10:23 +0000 (0:00:00.057) 0:00:15.467 *********
skipping: [instance]
TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Tuesday 17 March 2026 11:10:23 +0000 (0:00:00.061) 0:00:15.528 *********
skipping: [instance]
TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Tuesday 17 March 2026 11:10:23 +0000 (0:00:00.057) 0:00:15.586 *********
ok: [instance]
TASK [repo_setup : Use RDO proxy mirrors] **************************************
Tuesday 17 March 2026 11:10:24 +0000 (0:00:00.232) 0:00:15.818 *********
changed: [instance]
TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Tuesday 17 March 2026 11:10:24 +0000 (0:00:00.230) 0:00:16.048 *********
changed: [instance]
TASK [repo_setup : Check for gating.repo file on content provider] *************
Tuesday 17 March 2026 11:10:24 +0000 (0:00:00.254) 0:00:16.303 *********
skipping: [instance]
TASK [repo_setup : Populate gating repo from content provider ip] **************
Tuesday 17 March 2026 11:10:24 +0000 (0:00:00.055) 0:00:16.358 *********
skipping: [instance]
TASK [repo_setup : Check for DLRN repo at the destination] *********************
Tuesday 17 March 2026 11:10:24 +0000 (0:00:00.084) 0:00:16.443 *********
skipping: [instance]
TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Tuesday 17 March 2026 11:10:24 +0000 (0:00:00.053) 0:00:16.497 *********
skipping: [instance]
TASK [repo_setup : Check for DLRN component repo] ******************************
Tuesday 17 March 2026 11:10:24 +0000 (0:00:00.051) 0:00:16.548 *********
skipping: [instance]
TASK [repo_setup : Lower the priority of component repos to allow installation from gating repo] ***
Tuesday 17 March 2026 11:10:24 +0000 (0:00:00.051) 0:00:16.599 *********
skipping: [instance]
TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Tuesday 17 March 2026 11:10:24 +0000 (0:00:00.078) 0:00:16.678 *********
skipping: [instance]
TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Tuesday 17 March 2026 11:10:24 +0000 (0:00:00.047) 0:00:16.725 *********
skipping: [instance]
TASK [repo_setup : Cleanup existing metadata] **********************************
Tuesday 17 March 2026 11:10:25 +0000 (0:00:00.057) 0:00:16.783 *********
skipping: [instance]
TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Tuesday 17 March 2026 11:10:25 +0000 (0:00:00.047) 0:00:16.830 *********
skipping: [instance]
TASK [test_deps : Look for redhat-release rpm] *********************************
Tuesday 17 March 2026 11:10:25 +0000 (0:00:00.107) 0:00:16.937 *********
skipping: [instance]
TASK [test_deps : Remove redhat-release] ***************************************
Tuesday 17 March 2026 11:10:25 +0000 (0:00:00.066) 0:00:17.004 *********
skipping: [instance]
TASK [test_deps : Install centos-stream-release] *******************************
Tuesday 17 March 2026 11:10:25 +0000 (0:00:00.067) 0:00:17.072 *********
skipping: [instance]
TASK [test_deps : Install additional packages] *********************************
Tuesday 17 March 2026 11:10:25 +0000 (0:00:00.065) 0:00:17.138 *********
skipping: [instance]
TASK [test_deps : Install selinux python libs] *********************************
Tuesday 17 March 2026 11:10:25 +0000 (0:00:00.096) 0:00:17.235 *********
ok: [instance]
TASK [test_deps : Install python yaml libs] ************************************
Tuesday 17 March 2026 11:11:13 +0000 (0:00:48.137) 0:01:05.372 *********
ok: [instance]
TASK [test_deps : Install extra packages] **************************************
Tuesday 17 March 2026 11:11:14 +0000 (0:00:01.246) 0:01:06.618 *********
skipping: [instance]
TASK [ci_setup : Gather variables for each operating system] *******************
Tuesday 17 March 2026 11:11:14 +0000 (0:00:00.111) 0:01:06.729 *********
ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_setup/vars/redhat.yml)
TASK [ci_setup : List packages to install] *************************************
Tuesday 17 March 2026 11:11:15 +0000 (0:00:00.104) 0:01:06.834 *********
ok: [instance] =>
cifmw_ci_setup_packages:
- bash-completion
- ca-certificates
- git-core
- make
- tar
- tmux
- python3-pip
TASK [ci_setup : Install needed packages] **************************************
Tuesday 17 March 2026 11:11:15 +0000 (0:00:00.049) 0:01:06.883 *********
ok: [instance]
TASK [ci_setup : Gather version of openshift client] ***************************
Tuesday 17 March 2026 11:11:16 +0000 (0:00:01.272) 0:01:08.156 *********
ok: [instance]
TASK [ci_setup : Ensure openshift client install path is present] **************
Tuesday 17 March 2026 11:11:16 +0000 (0:00:00.268) 0:01:08.424 *********
ok: [instance]
TASK [ci_setup : Install openshift client] *************************************
Tuesday 17 March 2026 11:11:16 +0000 (0:00:00.228) 0:01:08.653 *********
skipping: [instance]
TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
Tuesday 17 March 2026 11:11:16 +0000 (0:00:00.086) 0:01:08.740 *********
skipping: [instance]
TASK [ci_setup : Create completion file] ***************************************
Tuesday 17 March 2026 11:11:17 +0000 (0:00:00.087) 0:01:08.827 *********
ok: [instance]
TASK [ci_setup : Source completion from within .bashrc] ************************
Tuesday 17 March 2026 11:11:17 +0000 (0:00:00.205) 0:01:09.033 *********
changed: [instance]
TASK [ci_setup : Check rhsm status] ********************************************
Tuesday 17 March 2026 11:11:17 +0000 (0:00:00.275) 0:01:09.308 *********
skipping: [instance]
TASK [ci_setup : Gather the repos to be enabled] *******************************
Tuesday 17 March 2026 11:11:17 +0000 (0:00:00.045) 0:01:09.354 *********
skipping: [instance]
TASK [ci_setup : Enabling the required repositories.] **************************
Tuesday 17 March 2026 11:11:17 +0000 (0:00:00.076) 0:01:09.430 *********
skipping: [instance]
TASK [ci_setup : Get current /etc/redhat-release] ******************************
Tuesday 17 March 2026 11:11:17 +0000 (0:00:00.047) 0:01:09.478 *********
skipping: [instance]
TASK [ci_setup : Print current /etc/redhat-release] ****************************
Tuesday 17 March 2026 11:11:17 +0000 (0:00:00.044) 0:01:09.523 *********
skipping: [instance]
TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
Tuesday 17 March 2026 11:11:17 +0000 (0:00:00.043) 0:01:09.567 *********
skipping: [instance]
TASK [ci_setup : Manage directories] *******************************************
Tuesday 17 March 2026 11:11:17 +0000 (0:00:00.078) 0:01:09.646 *********
changed: [instance] => (item=/opt/basedir/artifacts/manifests/openstack/cr)
changed: [instance] => (item=/opt/basedir/logs)
ok: [instance] => (item=/opt/basedir/tmp)
changed: [instance] => (item=/opt/basedir/volumes)
changed: [instance] => (item=/opt/basedir/artifacts/parameters)
TASK [libvirt_manager : Get installed packages list] ***************************
Tuesday 17 March 2026 11:11:18 +0000 (0:00:01.005) 0:01:10.652 *********
ok: [instance]
TASK [libvirt_manager : Populate service facts] ********************************
Tuesday 17 March 2026 11:11:19 +0000 (0:00:00.812) 0:01:11.464 *********
ok: [instance]
TASK [libvirt_manager : Start virtqemud socket service] ************************
Tuesday 17 March 2026 11:11:21 +0000 (0:00:02.032) 0:01:13.497 *********
ok: [instance] => (item=virtqemud.service)
ok: [instance] => (item=virtqemud.socket)
TASK [libvirt_manager : Start virtnetworkd socket service] *********************
Tuesday 17 March 2026 11:11:22 +0000 (0:00:00.862) 0:01:14.359 *********
ok: [instance] => (item=virtnetworkd.service)
ok: [instance] => (item=virtnetworkd.socket)
TASK [libvirt_manager : Start virtstoraged socket service] *********************
Tuesday 17 March 2026 11:11:23 +0000 (0:00:00.665) 0:01:15.025 *********
ok: [instance] => (item=virtstoraged.service)
ok: [instance] => (item=virtstoraged.socket)
TASK [libvirt_manager : Set _is_deepscrub internal fact] ***********************
Tuesday 17 March 2026 11:11:23 +0000 (0:00:00.641) 0:01:15.667 *********
ok: [instance]
TASK [libvirt_manager : List all of the existing virtual machines] *************
Tuesday 17 March 2026 11:11:23 +0000 (0:00:00.050) 0:01:15.718 *********
ok: [instance]
TASK [libvirt_manager : Get pool configuration] ********************************
Tuesday 17 March 2026 11:11:24 +0000 (0:00:00.403) 0:01:16.121 *********
ok: [instance]
TASK [libvirt_manager : Filter out target environment] *************************
Tuesday 17 March 2026 11:11:24 +0000 (0:00:00.362) 0:01:16.483 *********
ok: [instance]
TASK [libvirt_manager : Expose cleanup list] ***********************************
Tuesday 17 March 2026 11:11:24 +0000 (0:00:00.080) 0:01:16.564 *********
ok: [instance] =>
cleanup_vms: []
TASK [libvirt_manager : Clean ssh known_hosts] *********************************
Tuesday 17 March 2026 11:11:24 +0000 (0:00:00.079) 0:01:16.644 *********
skipping: [instance]
TASK [libvirt_manager : Destroy machine] ***************************************
Tuesday 17 March 2026 11:11:24 +0000 (0:00:00.035) 0:01:16.679 *********
skipping: [instance]
TASK [libvirt_manager : Undefine machine] **************************************
Tuesday 17 March 2026 11:11:24 +0000 (0:00:00.032) 0:01:16.712 *********
skipping: [instance]
TASK [libvirt_manager : (localhost) Clean ssh jumpers] *************************
Tuesday 17 March 2026 11:11:24 +0000 (0:00:00.032) 0:01:16.745 *********
skipping: [instance]
TASK [libvirt_manager : (instance) Clean ssh jumpers] **************************
Tuesday 17 March 2026 11:11:24 +0000 (0:00:00.033) 0:01:16.779 *********
skipping: [instance]
TASK [libvirt_manager : Get network list] **************************************
Tuesday 17 March 2026 11:11:25 +0000 (0:00:00.034) 0:01:16.813 *********
fatal: [instance]: FAILED! => changed=false
msg: 'Cannot recv data: Connection reset by peer'
PLAY RECAP *********************************************************************
instance : ok=38 changed=12 unreachable=0 failed=1 skipped=43 rescued=0 ignored=0
Tuesday 17 March 2026 11:11:25 +0000 (0:00:00.360) 0:01:17.174 *********
===============================================================================
test_deps : Install selinux python libs -------------------------------- 48.14s
repo_setup : Initialize python venv and install requirements ------------ 6.09s
libvirt_manager : Populate service facts -------------------------------- 2.03s
repo_setup : Make sure git-core package is installed -------------------- 1.40s
ci_setup : Install needed packages -------------------------------------- 1.27s
test_deps : Install python yaml libs ------------------------------------ 1.25s
repo_setup : Get repo-setup repository ---------------------------------- 1.13s
ci_setup : Manage directories ------------------------------------------- 1.01s
repo_setup : Run repo-setup --------------------------------------------- 0.86s
libvirt_manager : Start virtqemud socket service ------------------------ 0.86s
Gathering Facts --------------------------------------------------------- 0.82s
libvirt_manager : Get installed packages list --------------------------- 0.81s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.79s
libvirt_manager : Start virtnetworkd socket service --------------------- 0.67s
repo_setup : Install repo-setup package --------------------------------- 0.65s
libvirt_manager : Start virtstoraged socket service --------------------- 0.64s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.56s
repo_setup : Ensure directories are present ----------------------------- 0.53s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.44s
Create custom basedir --------------------------------------------------- 0.42s
PLAY [Cleanup] *****************************************************************
TASK [Gathering Facts] *********************************************************
Tuesday 17 March 2026 11:11:25 +0000 (0:00:00.045) 0:00:00.045 *********
ok: [instance]
TASK [Ensure we have the destination directory] ********************************
Tuesday 17 March 2026 11:11:26 +0000 (0:00:00.864) 0:00:00.910 *********
changed: [instance]
TASK [Copy generated content to proper location] *******************************
Tuesday 17 March 2026 11:11:27 +0000 (0:00:00.352) 0:00:01.262 *********
changed: [instance] => (item=/opt/basedir/artifacts)
changed: [instance] => (item=/opt/basedir/logs)
ok: [instance] => (item=/opt/basedir/cifmw_config_drive)
ok: [instance] => (item=/etc/cifmw-dnsmasq.conf)
ok: [instance] => (item=/etc/cifmw-dnsmasq.d)
TASK [libvirt_manager : Get installed packages list] ***************************
Tuesday 17 March 2026 11:11:28 +0000 (0:00:01.350) 0:00:02.612 *********
ok: [instance]
TASK [libvirt_manager : Populate service facts] ********************************
Tuesday 17 March 2026 11:11:29 +0000 (0:00:00.790) 0:00:03.403 *********
ok: [instance]
TASK [libvirt_manager : Start virtqemud socket service] ************************
Tuesday 17 March 2026 11:11:31 +0000 (0:00:01.992) 0:00:05.396 *********
ok: [instance] => (item=virtqemud.service)
ok: [instance] => (item=virtqemud.socket)
TASK [libvirt_manager : Start virtnetworkd socket service] *********************
Tuesday 17 March 2026 11:11:32 +0000 (0:00:00.854) 0:00:06.250 *********
changed: [instance] => (item=virtnetworkd.service)
ok: [instance] => (item=virtnetworkd.socket)
TASK [libvirt_manager : Start virtstoraged socket service] *********************
Tuesday 17 March 2026 11:11:32 +0000 (0:00:00.697) 0:00:06.948 *********
ok: [instance] => (item=virtstoraged.service)
ok: [instance] => (item=virtstoraged.socket)
TASK [libvirt_manager : Set _is_deepscrub internal fact] ***********************
Tuesday 17 March 2026 11:11:33 +0000 (0:00:00.659) 0:00:07.607 *********
ok: [instance]
TASK [libvirt_manager : List all of the existing virtual machines] *************
Tuesday 17 March 2026 11:11:33 +0000 (0:00:00.049) 0:00:07.657 *********
ok: [instance]
TASK [libvirt_manager : Get pool configuration] ********************************
Tuesday 17 March 2026 11:11:33 +0000 (0:00:00.364) 0:00:08.021 *********
ok: [instance]
TASK [libvirt_manager : Filter out target environment] *************************
Tuesday 17 March 2026 11:11:34 +0000 (0:00:00.369) 0:00:08.391 *********
ok: [instance]
TASK [libvirt_manager : Expose cleanup list] ***********************************
Tuesday 17 March 2026 11:11:34 +0000 (0:00:00.080) 0:00:08.471 *********
ok: [instance] =>
cleanup_vms: []
TASK [libvirt_manager : Clean ssh known_hosts] *********************************
Tuesday 17 March 2026 11:11:34 +0000 (0:00:00.075) 0:00:08.546 *********
skipping: [instance]
TASK [libvirt_manager : Destroy machine] ***************************************
Tuesday 17 March 2026 11:11:34 +0000 (0:00:00.032) 0:00:08.579 *********
skipping: [instance]
TASK [libvirt_manager : Undefine machine] **************************************
Tuesday 17 March 2026 11:11:34 +0000 (0:00:00.032) 0:00:08.611 *********
skipping: [instance]
TASK [libvirt_manager : (localhost) Clean ssh jumpers] *************************
Tuesday 17 March 2026 11:11:34 +0000 (0:00:00.032) 0:00:08.643 *********
skipping: [instance]
TASK [libvirt_manager : (instance) Clean ssh jumpers] **************************
Tuesday 17 March 2026 11:11:34 +0000 (0:00:00.034) 0:00:08.678 *********
skipping: [instance]
TASK [libvirt_manager : Get network list] **************************************
Tuesday 17 March 2026 11:11:34 +0000 (0:00:00.031) 0:00:08.709 *********
ok: [instance]
TASK [libvirt_manager : Filter out target nets] ********************************
Tuesday 17 March 2026 11:11:34 +0000 (0:00:00.377) 0:00:09.087 *********
ok: [instance]
TASK [libvirt_manager : Expose cleanup list] ***********************************
Tuesday 17 March 2026 11:11:35 +0000 (0:00:00.151) 0:00:09.238 *********
ok: [instance] =>
cleanup_nets: []
TASK [Remove dnsmasq network bits] *********************************************
Tuesday 17 March 2026 11:11:35 +0000 (0:00:00.078) 0:00:09.316 *********
skipping: [instance]
TASK [libvirt_manager : Destroy networks] **************************************
Tuesday 17 March 2026 11:11:35 +0000 (0:00:00.034) 0:00:09.350 *********
skipping: [instance]
TASK [libvirt_manager : Undefine networks] *************************************
Tuesday 17 March 2026 11:11:35 +0000 (0:00:00.033) 0:00:09.384 *********
skipping: [instance]
TASK [libvirt_manager : Ensure no trace of networks lays in nmcli] *************
Tuesday 17 March 2026 11:11:35 +0000 (0:00:00.031) 0:00:09.416 *********
skipping: [instance]
TASK [libvirt_manager : Find dummy interface connection files] *****************
Tuesday 17 March 2026 11:11:35 +0000 (0:00:00.031) 0:00:09.447 *********
ok: [instance]
TASK [libvirt_manager : Remove dummy interface connections] ********************
Tuesday 17 March 2026 11:11:35 +0000 (0:00:00.333) 0:00:09.781 *********
skipping: [instance]
TASK [libvirt_manager : Clean firewalld libvirt zone] **************************
Tuesday 17 March 2026 11:11:35 +0000 (0:00:00.034) 0:00:09.815 *********
skipping: [instance]
TASK [libvirt_manager : Ensure firewalld is enabled and started] ***************
Tuesday 17 March 2026 11:11:35 +0000 (0:00:00.033) 0:00:09.849 *********
ok: [instance]
TASK [libvirt_manager : Disable masquerade in firewalld default zone] **********
Tuesday 17 March 2026 11:11:36 +0000 (0:00:00.555) 0:00:10.404 *********
ok: [instance]
TASK [libvirt_manager : Disable forward in firewalld libvirt zone] *************
Tuesday 17 March 2026 11:11:36 +0000 (0:00:00.448) 0:00:10.853 *********
changed: [instance]
TASK [libvirt_manager : Remove cifmw storage pool] *****************************
Tuesday 17 March 2026 11:11:37 +0000 (0:00:00.521) 0:00:11.374 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/storage_pool.yml for instance
TASK [libvirt_manager : Ensure we have a known action] *************************
Tuesday 17 March 2026 11:11:37 +0000 (0:00:00.103) 0:00:11.477 *********
ok: [instance] => changed=false
msg: All assertions passed
TASK [libvirt_manager : Gather the status of cifmw-pool storage pool.] *********
Tuesday 17 March 2026 11:11:37 +0000 (0:00:00.074) 0:00:11.552 *********
changed: [instance]
TASK [libvirt_manager : Create the storage pool] *******************************
Tuesday 17 March 2026 11:11:37 +0000 (0:00:00.272) 0:00:11.824 *********
skipping: [instance]
TASK [libvirt_manager : Ensure the storage pool is started] ********************
Tuesday 17 March 2026 11:11:37 +0000 (0:00:00.072) 0:00:11.896 *********
skipping: [instance] => (item=pool-start)
skipping: [instance] => (item=pool-autostart)
skipping: [instance]
TASK [libvirt_manager : Gather all the volumes in the pool to delete] **********
Tuesday 17 March 2026 11:11:37 +0000 (0:00:00.101) 0:00:11.997 *********
skipping: [instance]
TASK [libvirt_manager : Remove the volumes from pool to delete] ****************
Tuesday 17 March 2026 11:11:37 +0000 (0:00:00.077) 0:00:12.075 *********
skipping: [instance]
TASK [libvirt_manager : Delete storage pool] ***********************************
Tuesday 17 March 2026 11:11:38 +0000 (0:00:00.077) 0:00:12.153 *********
skipping: [instance] => (item=pool-destroy)
skipping: [instance] => (item=pool-undefine)
skipping: [instance]
TASK [libvirt_manager : Refresh pools facts] ***********************************
Tuesday 17 March 2026 11:11:38 +0000 (0:00:00.101) 0:00:12.255 *********
ok: [instance]
TASK [libvirt_manager : Remove overlay images from ocp_volume pools if exists] ***
Tuesday 17 March 2026 11:11:38 +0000 (0:00:00.278) 0:00:12.534 *********
skipping: [instance]
TASK [libvirt_manager : Remove ocp_volumes storage pool] ***********************
Tuesday 17 March 2026 11:11:38 +0000 (0:00:00.045) 0:00:12.580 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/storage_pool.yml for instance
TASK [libvirt_manager : Ensure we have a known action] *************************
Tuesday 17 March 2026 11:11:38 +0000 (0:00:00.134) 0:00:12.714 *********
ok: [instance] => changed=false
msg: All assertions passed
TASK [libvirt_manager : Gather the status of cifmw-pool storage pool.] *********
Tuesday 17 March 2026 11:11:38 +0000 (0:00:00.076) 0:00:12.791 *********
changed: [instance]
TASK [libvirt_manager : Create the storage pool] *******************************
Tuesday 17 March 2026 11:11:38 +0000 (0:00:00.264) 0:00:13.056 *********
skipping: [instance]
TASK [libvirt_manager : Ensure the storage pool is started] ********************
Tuesday 17 March 2026 11:11:39 +0000 (0:00:00.077) 0:00:13.134 *********
skipping: [instance] => (item=pool-start)
skipping: [instance] => (item=pool-autostart)
skipping: [instance]
TASK [libvirt_manager : Gather all the volumes in the pool to delete] **********
Tuesday 17 March 2026 11:11:39 +0000 (0:00:00.102) 0:00:13.236 *********
skipping: [instance]
TASK [libvirt_manager : Remove the volumes from pool to delete] ****************
Tuesday 17 March 2026 11:11:39 +0000 (0:00:00.075) 0:00:13.311 *********
skipping: [instance]
TASK [libvirt_manager : Delete storage pool] ***********************************
Tuesday 17 March 2026 11:11:39 +0000 (0:00:00.073) 0:00:13.385 *********
skipping: [instance] => (item=pool-destroy)
skipping: [instance] => (item=pool-undefine)
skipping: [instance]
TASK [libvirt_manager : Refresh pools facts] ***********************************
Tuesday 17 March 2026 11:11:39 +0000 (0:00:00.102) 0:00:13.488 *********
ok: [instance]
TASK [libvirt_manager : Refresh all pools after actions] ***********************
Tuesday 17 March 2026 11:11:39 +0000 (0:00:00.275) 0:00:13.764 *********
skipping: [instance]
TASK [libvirt_manager : Get temporary key status] ******************************
Tuesday 17 March 2026 11:11:39 +0000 (0:00:00.070) 0:00:13.834 *********
ok: [instance]
TASK [libvirt_manager : Get public key] ****************************************
Tuesday 17 March 2026 11:11:40 +0000 (0:00:00.272) 0:00:14.106 *********
skipping: [instance]
TASK [libvirt_manager : Remove public key] *************************************
Tuesday 17 March 2026 11:11:40 +0000 (0:00:00.037) 0:00:14.143 *********
skipping: [instance]
TASK [libvirt_manager : Remove keypair] ****************************************
Tuesday 17 March 2026 11:11:40 +0000 (0:00:00.038) 0:00:14.182 *********
skipping: [instance] => (item=cifmw_reproducer_key.pub)
skipping: [instance] => (item=cifmw_reproducer_key)
skipping: [instance]
TASK [libvirt_manager : List libvirt logs] *************************************
Tuesday 17 March 2026 11:11:40 +0000 (0:00:00.039) 0:00:14.221 *********
ok: [instance]
TASK [libvirt_manager : Remove detected logs] **********************************
Tuesday 17 March 2026 11:11:40 +0000 (0:00:00.205) 0:00:14.427 *********
skipping: [instance]
TASK [libvirt_manager : Remove workload and volumes] ***************************
Tuesday 17 March 2026 11:11:40 +0000 (0:00:00.035) 0:00:14.463 *********
ok: [instance] => (item=workload)
changed: [instance] => (item=volumes)
ok: [instance] => (item=artifacts/debug_network_data.yml)
ok: [instance] => (item=artifacts/debug_pub_net_value.txt)
ok: [instance] => (item=artifacts/debug_cifmw_libvirt_manager_layout.yml)
ok: [instance] => (item=artifacts/interfaces-info.yml)
ok: [instance] => (item=artifacts/libvirt-uuids.yml)
ok: [instance] => (item=artifacts/net-map-def-patch.yml)
TASK [libvirt_manager : Deepscrub data] ****************************************
Tuesday 17 March 2026 11:11:41 +0000 (0:00:01.297) 0:00:15.761 *********
ok: [instance] => (item=images)
ok: [instance] => (item=artifacts/virtual-nodes.yml)
TASK [podman : Ensure podman is installed] *************************************
Tuesday 17 March 2026 11:11:42 +0000 (0:00:00.355) 0:00:16.117 *********
ok: [instance]
TASK [podman : Enable loginctl linger for ansible_user_id] *********************
Tuesday 17 March 2026 11:11:43 +0000 (0:00:01.364) 0:00:17.481 *********
changed: [instance]
TASK [podman : Ensure subordinate UID entry exists for zuul] *******************
Tuesday 17 March 2026 11:11:43 +0000 (0:00:00.245) 0:00:17.726 *********
skipping: [instance]
TASK [podman : Ensure subordinate GID entry exists for zuul] *******************
Tuesday 17 March 2026 11:11:43 +0000 (0:00:00.064) 0:00:17.791 *********
skipping: [instance]
TASK [podman : Run podman system migrate if subuid/subgid files were changed] ***
Tuesday 17 March 2026 11:11:43 +0000 (0:00:00.040) 0:00:17.831 *********
skipping: [instance]
TASK [virtualbmc : Stop and remove vbmc container] *****************************
Tuesday 17 March 2026 11:11:43 +0000 (0:00:00.063) 0:00:17.894 *********
ok: [instance]
TASK [virtualbmc : Remove vbmc container image] ********************************
Tuesday 17 March 2026 11:11:44 +0000 (0:00:00.442) 0:00:18.337 *********
ok: [instance]
TASK [virtualbmc : Check if VBMC key exists] ***********************************
Tuesday 17 March 2026 11:11:44 +0000 (0:00:00.421) 0:00:18.758 *********
ok: [instance]
TASK [virtualbmc : Slurp key] **************************************************
Tuesday 17 March 2026 11:11:44 +0000 (0:00:00.184) 0:00:18.943 *********
skipping: [instance]
TASK [virtualbmc : Revoke VBMC SSH access] *************************************
Tuesday 17 March 2026 11:11:44 +0000 (0:00:00.035) 0:00:18.978 *********
skipping: [instance]
TASK [virtualbmc : Remove vbmc files] ******************************************
Tuesday 17 March 2026 11:11:44 +0000 (0:00:00.057) 0:00:19.035 *********
ok: [instance] => (item=/home/zuul/.ssh/vbmc-key)
ok: [instance] => (item=/home/zuul/.ssh/vbmc-key.pub)
ok: [instance] => (item=/home/zuul/.ssh/virtualbmc.conf)
ok: [instance] => (item=/home/zuul/.ssh/vbmcd.sh)
TASK [Clean remote ssh config] *************************************************
Tuesday 17 March 2026 11:11:45 +0000 (0:00:00.692) 0:00:19.728 *********
TASK [ssh_jumper : Remove Include cifmw_ssh_config.d] **************************
Tuesday 17 March 2026 11:11:45 +0000 (0:00:00.084) 0:00:19.812 *********
ok: [instance]
TASK [ssh_jumper : Remove cifmw_ssh_config.d directory] ************************
Tuesday 17 March 2026 11:11:46 +0000 (0:00:00.316) 0:00:20.129 *********
ok: [instance]
TASK [Clean local ssh config] **************************************************
Tuesday 17 March 2026 11:11:46 +0000 (0:00:00.226) 0:00:20.356 *********
TASK [ssh_jumper : Remove Include cifmw_ssh_config.d] **************************
Tuesday 17 March 2026 11:11:46 +0000 (0:00:00.112) 0:00:20.469 *********
ok: [instance -> localhost]
TASK [ssh_jumper : Remove cifmw_ssh_config.d directory] ************************
Tuesday 17 March 2026 11:11:46 +0000 (0:00:00.192) 0:00:20.661 *********
ok: [instance -> localhost]
TASK [dnsmasq : Cleaning dnsmasq] **********************************************
Tuesday 17 March 2026 11:11:46 +0000 (0:00:00.215) 0:00:20.876 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/configure.yml for instance
TASK [dnsmasq : Install needed packages] ***************************************
Tuesday 17 March 2026 11:11:46 +0000 (0:00:00.068) 0:00:20.945 *********
ok: [instance]
TASK [dnsmasq : Ensure SELinux knows about the new files and directories] ******
Tuesday 17 March 2026 11:11:48 +0000 (0:00:01.198) 0:00:22.143 *********
ok: [instance] => (item={'target': '/etc/cifmw-dnsmasq.conf', 'setype': 'dnsmasq_etc_t'})
ok: [instance] => (item={'target': '/etc/cifmw-dnsmasq.d(/.*)?', 'setype': 'dnsmasq_etc_t'})
ok: [instance] => (item={'target': '/var/run/cifmw-dnsmasq.pid', 'setype': 'dnsmasq_var_run_t'})
TASK [dnsmasq : Manage configuration directory] ********************************
Tuesday 17 March 2026 11:11:49 +0000 (0:00:01.173) 0:00:23.316 *********
ok: [instance]
TASK [dnsmasq : Manage systemd unit file] **************************************
Tuesday 17 March 2026 11:11:49 +0000 (0:00:00.218) 0:00:23.535 *********
skipping: [instance]
TASK [dnsmasq : Manage base configuration file] ********************************
Tuesday 17 March 2026 11:11:49 +0000 (0:00:00.036) 0:00:23.571 *********
skipping: [instance]
TASK [dnsmasq : Render listener configuration] *********************************
Tuesday 17 March 2026 11:11:49 +0000 (0:00:00.035) 0:00:23.607 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/listener.yml for instance
TASK [dnsmasq : Create listener configuration file] ****************************
Tuesday 17 March 2026 11:11:49 +0000 (0:00:00.083) 0:00:23.690 *********
skipping: [instance]
TASK [dnsmasq : Remove listener configuration file] ****************************
Tuesday 17 March 2026 11:11:49 +0000 (0:00:00.035) 0:00:23.726 *********
ok: [instance]
TASK [dnsmasq : Render dns configuration] **************************************
Tuesday 17 March 2026 11:11:49 +0000 (0:00:00.200) 0:00:23.926 *********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/dns.yml for instance
TASK [dnsmasq : Create dns configuration file] *********************************
Tuesday 17 March 2026 11:11:49 +0000 (0:00:00.065) 0:00:23.992 *********
skipping: [instance]
TASK [dnsmasq : Remove dns configuration file] *********************************
Tuesday 17 March 2026 11:11:49 +0000 (0:00:00.037) 0:00:24.029 *********
ok: [instance]
TASK [dnsmasq : Add localhost addresses from defined dnsmasq listen addresses to loopback interface] ***
Tuesday 17 March 2026 11:11:50 +0000 (0:00:00.221) 0:00:24.250 *********
skipping: [instance]
TASK [dnsmasq : Enable and start service] **************************************
Tuesday 17 March 2026 11:11:50 +0000 (0:00:00.032) 0:00:24.283 *********
skipping: [instance]
TASK [dnsmasq : Stop service] **************************************************
Tuesday 17 March 2026 11:11:50 +0000 (0:00:00.033) 0:00:24.317 *********
ok: [instance]
TASK [dnsmasq : Remove unit file] **********************************************
Tuesday 17 March 2026 11:11:50 +0000 (0:00:00.349) 0:00:24.666 *********
ok: [instance]
TASK [dnsmasq : Remove main configuration files] *******************************
Tuesday 17 March 2026 11:11:50 +0000 (0:00:00.215) 0:00:24.882 *********
ok: [instance] => (item=/etc/cifmw-dnsmasq.conf)
ok: [instance] => (item=/etc/cifmw-dnsmasq.d)
TASK [dnsmasq : Remove lease file] *********************************************
Tuesday 17 March 2026 11:11:51 +0000 (0:00:00.393) 0:00:25.275 *********
ok: [instance]
TASK [radvd : Gather package facts] ********************************************
Tuesday 17 March 2026 11:11:51 +0000 (0:00:00.226) 0:00:25.502 *********
ok: [instance]
TASK [radvd : Stop and disable radvd service] **********************************
Tuesday 17 March 2026 11:11:52 +0000 (0:00:00.610) 0:00:26.112 *********
skipping: [instance]
TASK [radvd : Remove radvd configuration file] *********************************
Tuesday 17 March 2026 11:11:52 +0000 (0:00:00.047) 0:00:26.159 *********
ok: [instance]
TASK [radvd : Remove configuration directory] **********************************
Tuesday 17 March 2026 11:11:52 +0000 (0:00:00.207) 0:00:26.367 *********
ok: [instance]
TASK [radvd : Remove radvd package] ********************************************
Tuesday 17 March 2026 11:11:52 +0000 (0:00:00.204) 0:00:26.571 *********
skipping: [instance]
TASK [Ensure work directory is removed] ****************************************
Tuesday 17 March 2026 11:11:52 +0000 (0:00:00.078) 0:00:26.650 *********
changed: [instance]
RUNNING HANDLER [libvirt_manager : Restart firewalld] **************************
Tuesday 17 March 2026 11:11:52 +0000 (0:00:00.371) 0:00:27.022 *********
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=59 changed=10 unreachable=0 failed=0 skipped=40 rescued=0 ignored=0
Tuesday 17 March 2026 11:11:53 +0000 (0:00:00.639) 0:00:27.661 *********
===============================================================================
libvirt_manager : Populate service facts -------------------------------- 1.99s
podman : Ensure podman is installed ------------------------------------- 1.36s
Copy generated content to proper location ------------------------------- 1.35s
libvirt_manager : Remove workload and volumes --------------------------- 1.30s
dnsmasq : Install needed packages --------------------------------------- 1.20s
dnsmasq : Ensure SELinux knows about the new files and directories ------ 1.17s
Gathering Facts --------------------------------------------------------- 0.86s
libvirt_manager : Start virtqemud socket service ------------------------ 0.85s
libvirt_manager : Get installed packages list --------------------------- 0.79s
libvirt_manager : Start virtnetworkd socket service --------------------- 0.70s
virtualbmc : Remove vbmc files ------------------------------------------ 0.69s
libvirt_manager : Start virtstoraged socket service --------------------- 0.66s
libvirt_manager : Restart firewalld ------------------------------------- 0.64s
radvd : Gather package facts -------------------------------------------- 0.61s
libvirt_manager : Ensure firewalld is enabled and started --------------- 0.56s
libvirt_manager : Disable forward in firewalld libvirt zone ------------- 0.52s
libvirt_manager : Disable masquerade in firewalld default zone ---------- 0.45s
virtualbmc : Stop and remove vbmc container ----------------------------- 0.44s
virtualbmc : Remove vbmc container image -------------------------------- 0.42s
dnsmasq : Remove main configuration files ------------------------------- 0.39s