PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Monday 01 December 2025 08:20:48 +0000 (0:00:00.019) 0:00:00.019 *******
ok: [instance]
TASK [Create custom basedir] ***************************************************
Monday 01 December 2025 08:20:49 +0000 (0:00:00.814) 0:00:00.833 *******
changed: [instance]
TASK [test_deps : Gather facts if they don't exist] ****************************
Monday 01 December 2025 08:20:49 +0000 (0:00:00.295) 0:00:01.129 *******
skipping: [instance]
TASK [test_deps : Gather variables for each operating system] ******************
Monday 01 December 2025 08:20:49 +0000 (0:00:00.017) 0:00:01.146 *******
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] *****************************************
Monday 01 December 2025 08:20:49 +0000 (0:00:00.037) 0:00:01.184 *******
ok: [instance]
TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Monday 01 December 2025 08:20:49 +0000 (0:00:00.272) 0:00:01.456 *******
ok: [instance]
TASK [test_deps : Disable ubi 9 repos] *****************************************
Monday 01 December 2025 08:20:50 +0000 (0:00:00.195) 0:00:01.651 *******
ok: [instance] => (item=ubi-9-appstream)
ok: [instance] => (item=ubi-9-baseos)
ok: [instance] => (item=ubi-9-codeready-builder)
TASK [Deploy repo-setup] *******************************************************
Monday 01 December 2025 08:20:50 +0000 (0:00:00.655) 0:00:02.307 *******
TASK [repo_setup : Ensure directories are present] *****************************
Monday 01 December 2025 08:20:50 +0000 (0:00:00.059) 0:00:02.366 *******
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] ********************
Monday 01 December 2025 08:20:51 +0000 (0:00:00.500) 0:00:02.867 *******
ok: [instance]
TASK [repo_setup : Get repo-setup repository] **********************************
Monday 01 December 2025 08:20:52 +0000 (0:00:00.755) 0:00:03.623 *******
changed: [instance]
TASK [repo_setup : Initialize python venv and install requirements] ************
Monday 01 December 2025 08:20:53 +0000 (0:00:01.056) 0:00:04.679 *******
changed: [instance]
TASK [repo_setup : Install repo-setup package] *********************************
Monday 01 December 2025 08:21:00 +0000 (0:00:07.288) 0:00:11.968 *******
changed: [instance]
TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Monday 01 December 2025 08:21:01 +0000 (0:00:00.688) 0:00:12.656 *******
skipping: [instance]
TASK [repo_setup : Run repo-setup] *********************************************
Monday 01 December 2025 08:21:01 +0000 (0:00:00.021) 0:00:12.678 *******
changed: [instance]
TASK [repo_setup : Get component repo] *****************************************
Monday 01 December 2025 08:21:01 +0000 (0:00:00.787) 0:00:13.466 *******
skipping: [instance]
TASK [repo_setup : Rename component repo] **************************************
Monday 01 December 2025 08:21:01 +0000 (0:00:00.036) 0:00:13.502 *******
skipping: [instance]
TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Monday 01 December 2025 08:21:02 +0000 (0:00:00.034) 0:00:13.536 *******
skipping: [instance]
TASK [repo_setup : Run repo-setup-get-hash] ************************************
Monday 01 December 2025 08:21:02 +0000 (0:00:00.035) 0:00:13.571 *******
changed: [instance]
TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Monday 01 December 2025 08:21:02 +0000 (0:00:00.530) 0:00:14.102 *******
changed: [instance]
TASK [repo_setup : Dump current-podified hash] *********************************
Monday 01 December 2025 08:21:03 +0000 (0:00:00.421) 0:00:14.524 *******
skipping: [instance]
TASK [repo_setup : Slurp current podified hash] ********************************
Monday 01 December 2025 08:21:03 +0000 (0:00:00.029) 0:00:14.553 *******
skipping: [instance]
TASK [repo_setup : Update the value of full_hash] ******************************
Monday 01 December 2025 08:21:03 +0000 (0:00:00.028) 0:00:14.582 *******
skipping: [instance]
TASK [repo_setup : Export hashes facts for further use] ************************
Monday 01 December 2025 08:21:03 +0000 (0:00:00.028) 0:00:14.610 *******
ok: [instance]
TASK [repo_setup : Create download directory] **********************************
Monday 01 December 2025 08:21:03 +0000 (0:00:00.036) 0:00:14.646 *******
skipping: [instance]
TASK [repo_setup : Print the URL to request] ***********************************
Monday 01 December 2025 08:21:03 +0000 (0:00:00.025) 0:00:14.672 *******
skipping: [instance]
TASK [Download the RPM] ********************************************************
Monday 01 December 2025 08:21:03 +0000 (0:00:00.025) 0:00:14.697 *******
skipping: [instance]
TASK [repo_setup : Install RHOS Release tool] **********************************
Monday 01 December 2025 08:21:03 +0000 (0:00:00.024) 0:00:14.722 *******
skipping: [instance]
TASK [repo_setup : Get rhos-release tool version] ******************************
Monday 01 December 2025 08:21:03 +0000 (0:00:00.025) 0:00:14.748 *******
skipping: [instance]
TASK [repo_setup : Print rhos-release tool version] ****************************
Monday 01 December 2025 08:21:03 +0000 (0:00:00.025) 0:00:14.773 *******
skipping: [instance]
TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Monday 01 December 2025 08:21:03 +0000 (0:00:00.027) 0:00:14.800 *******
skipping: [instance]
TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Monday 01 December 2025 08:21:03 +0000 (0:00:00.024) 0:00:14.824 *******
ok: [instance]
TASK [repo_setup : Use RDO proxy mirrors] **************************************
Monday 01 December 2025 08:21:03 +0000 (0:00:00.171) 0:00:14.996 *******
changed: [instance]
TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Monday 01 December 2025 08:21:03 +0000 (0:00:00.193) 0:00:15.190 *******
changed: [instance]
TASK [repo_setup : Check for gating.repo file on content provider] *************
Monday 01 December 2025 08:21:03 +0000 (0:00:00.214) 0:00:15.405 *******
skipping: [instance]
TASK [repo_setup : Populate gating repo from content provider ip] **************
Monday 01 December 2025 08:21:03 +0000 (0:00:00.022) 0:00:15.427 *******
skipping: [instance]
TASK [repo_setup : Check for DLRN repo at the destination] *********************
Monday 01 December 2025 08:21:03 +0000 (0:00:00.020) 0:00:15.447 *******
skipping: [instance]
TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Monday 01 December 2025 08:21:03 +0000 (0:00:00.020) 0:00:15.468 *******
skipping: [instance]
TASK [repo_setup : Check for DLRN component repo] ******************************
Monday 01 December 2025 08:21:03 +0000 (0:00:00.020) 0:00:15.488 *******
skipping: [instance]
TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
Monday 01 December 2025 08:21:03 +0000 (0:00:00.023) 0:00:15.512 *******
skipping: [instance]
TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Monday 01 December 2025 08:21:04 +0000 (0:00:00.022) 0:00:15.534 *******
skipping: [instance]
TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Monday 01 December 2025 08:21:04 +0000 (0:00:00.015) 0:00:15.550 *******
skipping: [instance]
TASK [repo_setup : Cleanup existing metadata] **********************************
Monday 01 December 2025 08:21:04 +0000 (0:00:00.026) 0:00:15.577 *******
skipping: [instance]
TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Monday 01 December 2025 08:21:04 +0000 (0:00:00.016) 0:00:15.593 *******
skipping: [instance]
TASK [test_deps : Look for redhat-release rpm] *********************************
Monday 01 December 2025 08:21:04 +0000 (0:00:00.018) 0:00:15.612 *******
skipping: [instance]
TASK [test_deps : Remove redhat-release] ***************************************
Monday 01 December 2025 08:21:04 +0000 (0:00:00.026) 0:00:15.638 *******
skipping: [instance]
TASK [test_deps : Install centos-stream-release] *******************************
Monday 01 December 2025 08:21:04 +0000 (0:00:00.027) 0:00:15.665 *******
skipping: [instance]
TASK [test_deps : Install additional packages] *********************************
Monday 01 December 2025 08:21:04 +0000 (0:00:00.026) 0:00:15.692 *******
skipping: [instance]
TASK [test_deps : Install selinux python libs] *********************************
Monday 01 December 2025 08:21:04 +0000 (0:00:00.025) 0:00:15.718 *******
ok: [instance]
TASK [test_deps : Install python yaml libs] ************************************
Monday 01 December 2025 08:21:46 +0000 (0:00:42.126) 0:00:57.844 *******
ok: [instance]
TASK [test_deps : Install extra packages] **************************************
Monday 01 December 2025 08:21:47 +0000 (0:00:01.119) 0:00:58.963 *******
skipping: [instance]
TASK [ci_setup : Gather variables for each operating system] *******************
Monday 01 December 2025 08:21:47 +0000 (0:00:00.029) 0:00:58.993 *******
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] *************************************
Monday 01 December 2025 08:21:47 +0000 (0:00:00.040) 0:00:59.034 *******
ok: [instance] =>
cifmw_ci_setup_packages:
- bash-completion
- ca-certificates
- git-core
- make
- tar
- tmux
- python3-pip
TASK [ci_setup : Install needed packages] **************************************
Monday 01 December 2025 08:21:47 +0000 (0:00:00.019) 0:00:59.053 *******
changed: [instance]
TASK [ci_setup : Gather version of openshift client] ***************************
Monday 01 December 2025 08:21:55 +0000 (0:00:08.046) 0:01:07.100 *******
ok: [instance]
TASK [ci_setup : Ensure openshift client install path is present] **************
Monday 01 December 2025 08:21:56 +0000 (0:00:00.566) 0:01:07.667 *******
changed: [instance]
TASK [ci_setup : Install openshift client] *************************************
Monday 01 December 2025 08:21:56 +0000 (0:00:00.198) 0:01:07.866 *******
changed: [instance]
TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
Monday 01 December 2025 08:22:02 +0000 (0:00:05.776) 0:01:13.643 *******
ok: [instance]
TASK [ci_setup : Create completion file] ***************************************
Monday 01 December 2025 08:22:02 +0000 (0:00:00.034) 0:01:13.677 *******
changed: [instance]
TASK [ci_setup : Source completion from within .bashrc] ************************
Monday 01 December 2025 08:22:02 +0000 (0:00:00.245) 0:01:13.922 *******
changed: [instance]
TASK [ci_setup : Check rhsm status] ********************************************
Monday 01 December 2025 08:22:02 +0000 (0:00:00.254) 0:01:14.177 *******
skipping: [instance]
TASK [ci_setup : Gather the repos to be enabled] *******************************
Monday 01 December 2025 08:22:02 +0000 (0:00:00.016) 0:01:14.194 *******
skipping: [instance]
TASK [ci_setup : Enabling the required repositories.] **************************
Monday 01 December 2025 08:22:02 +0000 (0:00:00.015) 0:01:14.210 *******
skipping: [instance]
TASK [ci_setup : Get current /etc/redhat-release] ******************************
Monday 01 December 2025 08:22:02 +0000 (0:00:00.016) 0:01:14.227 *******
skipping: [instance]
TASK [ci_setup : Print current /etc/redhat-release] ****************************
Monday 01 December 2025 08:22:02 +0000 (0:00:00.015) 0:01:14.242 *******
skipping: [instance]
TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
Monday 01 December 2025 08:22:02 +0000 (0:00:00.015) 0:01:14.258 *******
skipping: [instance]
TASK [ci_setup : Manage directories] *******************************************
Monday 01 December 2025 08:22:02 +0000 (0:00:00.020) 0:01:14.278 *******
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 [Create secret file] ******************************************************
Monday 01 December 2025 08:22:03 +0000 (0:00:00.933) 0:01:15.211 *******
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=31 changed=17 unreachable=0 failed=0 skipped=36 rescued=0 ignored=0
Monday 01 December 2025 08:22:04 +0000 (0:00:00.309) 0:01:15.521 *******
===============================================================================
test_deps : Install selinux python libs -------------------------------- 42.13s
ci_setup : Install needed packages -------------------------------------- 8.05s
repo_setup : Initialize python venv and install requirements ------------ 7.29s
ci_setup : Install openshift client ------------------------------------- 5.78s
test_deps : Install python yaml libs ------------------------------------ 1.12s
repo_setup : Get repo-setup repository ---------------------------------- 1.06s
ci_setup : Manage directories ------------------------------------------- 0.93s
Gathering Facts --------------------------------------------------------- 0.81s
repo_setup : Run repo-setup --------------------------------------------- 0.79s
repo_setup : Make sure git-core package is installed -------------------- 0.76s
repo_setup : Install repo-setup package --------------------------------- 0.69s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.66s
ci_setup : Gather version of openshift client --------------------------- 0.57s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.53s
repo_setup : Ensure directories are present ----------------------------- 0.50s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.42s
Create secret file ------------------------------------------------------ 0.31s
Create custom basedir --------------------------------------------------- 0.30s
test_deps : Detect mirrors file ----------------------------------------- 0.27s
ci_setup : Source completion from within .bashrc ------------------------ 0.25s
PLAY [Converge] ****************************************************************
TASK [Gathering Facts] *********************************************************
Monday 01 December 2025 08:22:04 +0000 (0:00:00.027) 0:00:00.027 *******
ok: [instance]
TASK [Load networking definition from scenario file] ***************************
Monday 01 December 2025 08:22:05 +0000 (0:00:00.797) 0:00:00.825 *******
ok: [instance]
TASK [discover_latest_image : Get latest image] ********************************
Monday 01 December 2025 08:22:05 +0000 (0:00:00.022) 0:00:00.847 *******
changed: [instance]
TASK [discover_latest_image : Export facts accordingly] ************************
Monday 01 December 2025 08:22:07 +0000 (0:00:01.739) 0:00:02.587 *******
ok: [instance]
TASK [reproducer : Load CI job environment] ************************************
Monday 01 December 2025 08:22:07 +0000 (0:00:00.026) 0:00:02.613 *******
skipping: [instance]
TASK [Build final libvirt layout] **********************************************
Monday 01 December 2025 08:22:07 +0000 (0:00:00.020) 0:00:02.633 *******
TASK [libvirt_manager : Chose right parameter for layout definition] ***********
Monday 01 December 2025 08:22:07 +0000 (0:00:00.046) 0:00:02.680 *******
ok: [instance]
TASK [libvirt_manager : Patch the layout if needed] ****************************
Monday 01 December 2025 08:22:07 +0000 (0:00:00.076) 0:00:02.757 *******
skipping: [instance]
TASK [reproducer : Assert no conflicting parameters were passed] ***************
Monday 01 December 2025 08:22:07 +0000 (0:00:00.055) 0:00:02.812 *******
ok: [instance]
TASK [reproducer : Assert that deprecated cifmw_reproducer_internal_ca parameters was not passed] ***
Monday 01 December 2025 08:22:07 +0000 (0:00:00.024) 0:00:02.837 *******
ok: [instance] => changed=false
msg: All assertions passed
TASK [reproducer : Set _use_crc based on actual layout] ************************
Monday 01 December 2025 08:22:07 +0000 (0:00:00.022) 0:00:02.860 *******
ok: [instance]
TASK [reproducer : Ensure directories are present] *****************************
Monday 01 December 2025 08:22:07 +0000 (0:00:00.039) 0:00:02.899 *******
ok: [instance] => (item=artifacts)
ok: [instance] => (item=logs)
TASK [Bootstrap libvirt if needed] *********************************************
Monday 01 December 2025 08:22:07 +0000 (0:00:00.446) 0:00:03.345 *******
TASK [libvirt_manager : Ensure output directory exists] ************************
Monday 01 December 2025 08:22:08 +0000 (0:00:00.074) 0:00:03.420 *******
ok: [instance]
TASK [libvirt_manager : Get vmx/svm extensions from /proc/cpuinfo] *************
Monday 01 December 2025 08:22:08 +0000 (0:00:00.185) 0:00:03.605 *******
changed: [instance]
TASK [libvirt_manager : Check if KVM is enabled] *******************************
Monday 01 December 2025 08:22:08 +0000 (0:00:00.273) 0:00:03.878 *******
ok: [instance]
TASK [libvirt_manager : Fail if KVM not enabled] *******************************
Monday 01 December 2025 08:22:08 +0000 (0:00:00.278) 0:00:04.157 *******
skipping: [instance]
TASK [libvirt_manager : Check if VMX virtualization] ***************************
Monday 01 December 2025 08:22:08 +0000 (0:00:00.029) 0:00:04.186 *******
skipping: [instance]
TASK [libvirt_manager : Check if SVM virtualization] ***************************
Monday 01 December 2025 08:22:08 +0000 (0:00:00.017) 0:00:04.203 *******
ok: [instance]
TASK [libvirt_manager : Enable VMX virtualization] *****************************
Monday 01 December 2025 08:22:08 +0000 (0:00:00.020) 0:00:04.224 *******
skipping: [instance]
TASK [libvirt_manager : Install packages required for using KVM] ***************
Monday 01 December 2025 08:22:08 +0000 (0:00:00.025) 0:00:04.249 *******
changed: [instance]
TASK [libvirt_manager : Create rules.d polkit folder] **************************
Monday 01 December 2025 08:22:17 +0000 (0:00:08.964) 0:00:13.213 *******
changed: [instance]
TASK [libvirt_manager : Enable UNIX socket PolicyKit auth] *********************
Monday 01 December 2025 08:22:18 +0000 (0:00:00.204) 0:00:13.418 *******
changed: [instance]
TASK [libvirt_manager : Restart service polkit service] ************************
Monday 01 December 2025 08:22:18 +0000 (0:00:00.483) 0:00:13.901 *******
changed: [instance]
TASK [libvirt_manager : Remove directory for service override] *****************
Monday 01 December 2025 08:22:19 +0000 (0:00:00.549) 0:00:14.451 *******
ok: [instance]
TASK [libvirt_manager : Reload systemctl and start/enable virtproxyd.service] ***
Monday 01 December 2025 08:22:19 +0000 (0:00:00.183) 0:00:14.634 *******
ok: [instance]
TASK [libvirt_manager : Ensure firewalld service is up] ************************
Monday 01 December 2025 08:22:19 +0000 (0:00:00.606) 0:00:15.241 *******
changed: [instance]
TASK [libvirt_manager : Ensure libvirt modular driver daemons are started.] ****
Monday 01 December 2025 08:22:20 +0000 (0:00:00.833) 0:00:16.074 *******
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.] *********
Monday 01 December 2025 08:22:20 +0000 (0:00:00.078) 0:00:16.152 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for qemu.] **********
Monday 01 December 2025 08:22:21 +0000 (0:00:00.319) 0:00:16.472 *******
ok: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for qemu.] **************
Monday 01 December 2025 08:22:21 +0000 (0:00:00.300) 0:00:16.773 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for interface.] ****
Monday 01 December 2025 08:22:21 +0000 (0:00:00.293) 0:00:17.066 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for interface.] *****
Monday 01 December 2025 08:22:21 +0000 (0:00:00.304) 0:00:17.371 *******
ok: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for interface.] *********
Monday 01 December 2025 08:22:22 +0000 (0:00:00.309) 0:00:17.680 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for network.] ******
Monday 01 December 2025 08:22:22 +0000 (0:00:00.299) 0:00:17.979 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for network.] *******
Monday 01 December 2025 08:22:22 +0000 (0:00:00.301) 0:00:18.281 *******
ok: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for network.] ***********
Monday 01 December 2025 08:22:23 +0000 (0:00:00.311) 0:00:18.593 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for nodedev.] ******
Monday 01 December 2025 08:22:24 +0000 (0:00:01.308) 0:00:19.901 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for nodedev.] *******
Monday 01 December 2025 08:22:24 +0000 (0:00:00.291) 0:00:20.192 *******
ok: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for nodedev.] ***********
Monday 01 December 2025 08:22:25 +0000 (0:00:00.294) 0:00:20.487 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for nwfilter.] *****
Monday 01 December 2025 08:22:25 +0000 (0:00:00.301) 0:00:20.789 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for nwfilter.] ******
Monday 01 December 2025 08:22:25 +0000 (0:00:00.298) 0:00:21.087 *******
ok: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for nwfilter.] **********
Monday 01 December 2025 08:22:25 +0000 (0:00:00.299) 0:00:21.387 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for secret.] *******
Monday 01 December 2025 08:22:26 +0000 (0:00:00.300) 0:00:21.688 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for secret.] ********
Monday 01 December 2025 08:22:26 +0000 (0:00:00.324) 0:00:22.012 *******
ok: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for secret.] ************
Monday 01 December 2025 08:22:26 +0000 (0:00:00.302) 0:00:22.314 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for storage.] ******
Monday 01 December 2025 08:22:27 +0000 (0:00:00.297) 0:00:22.611 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for storage.] *******
Monday 01 December 2025 08:22:27 +0000 (0:00:00.303) 0:00:22.914 *******
ok: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for storage.] ***********
Monday 01 December 2025 08:22:27 +0000 (0:00:00.296) 0:00:23.211 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for proxy.] ********
Monday 01 December 2025 08:22:28 +0000 (0:00:00.308) 0:00:23.519 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for proxy.] *********
Monday 01 December 2025 08:22:28 +0000 (0:00:00.308) 0:00:23.828 *******
ok: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for proxy.] *************
Monday 01 December 2025 08:22:28 +0000 (0:00:00.311) 0:00:24.139 *******
ok: [instance]
TASK [libvirt_manager : Manage service for older releases] *********************
Monday 01 December 2025 08:22:29 +0000 (0:00:00.297) 0:00:24.437 *******
skipping: [instance]
TASK [libvirt_manager : Get libvirt group users] *******************************
Monday 01 December 2025 08:22:29 +0000 (0:00:00.018) 0:00:24.455 *******
ok: [instance]
TASK [libvirt_manager : Add user if not exists in libvirt group] ***************
Monday 01 December 2025 08:22:29 +0000 (0:00:00.270) 0:00:24.726 *******
ok: [instance]
TASK [libvirt_manager : Allow QEMU on home directory for the storage access] ***
Monday 01 December 2025 08:22:29 +0000 (0:00:00.359) 0:00:25.085 *******
changed: [instance]
TASK [libvirt_manager : Inject system connection parameters in bashrc] *********
Monday 01 December 2025 08:22:29 +0000 (0:00:00.305) 0:00:25.391 *******
[WARNING]: Reset is not implemented for this connection
changed: [instance]
TASK [libvirt_manager : Ensure we reload user env] *****************************
Monday 01 December 2025 08:22:30 +0000 (0:00:00.260) 0:00:25.651 *******
TASK [reproducer : Deploy networks in libvirt] *********************************
Monday 01 December 2025 08:22:30 +0000 (0:00:00.014) 0:00:25.666 *******
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/reproducer/tasks/prepare_networking.yml for instance
TASK [reproducer : Ensure networks are consistent] *****************************
Monday 01 December 2025 08:22:30 +0000 (0:00:00.071) 0:00:25.738 *******
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/reproducer/tasks/network_assertions.yml for instance
TASK [reproducer : Ensure all VM types have defined nets parameter] ************
Monday 01 December 2025 08:22:30 +0000 (0:00:00.053) 0:00:25.791 *******
ok: [instance] => (item=compute)
ok: [instance] => (item=controller)
ok: [instance] => (item=crc)
TASK [reproducer : Ensure all standard attached networks are defined] **********
Monday 01 December 2025 08:22:30 +0000 (0:00:00.047) 0:00:25.838 *******
ok: [instance]
TASK [reproducer : Ensure we don't have extra network defined] *****************
Monday 01 December 2025 08:22:30 +0000 (0:00:00.040) 0:00:25.879 *******
ok: [instance] => changed=false
msg: All assertions passed
TASK [Ensure we get latest OCP config] *****************************************
Monday 01 December 2025 08:22:30 +0000 (0:00:00.037) 0:00:25.916 *******
TASK [devscripts : Gather the configurations to be passed to dev-scripts.] *****
Monday 01 December 2025 08:22:30 +0000 (0:00:00.042) 0:00:25.958 *******
ok: [instance] => (item={'working_dir': '/home/dev-scripts', 'assets_extra_folder': '/home/dev-scripts/assets', 'openshift_release_type': 'ga', 'openshift_version': '4.16.0', 'cluster_name': 'ocp', 'base_domain': 'openstack.lab', 'ntp_servers': 'clock.corp.redhat.com', 'provisioning_network_profile': 'Managed', 'provisioning_network': '172.22.0.0/24', 'cluster_subnet_v4': '192.168.16.0/20', 'cluster_host_prefix_v4': '23', 'service_subnet_v4': '172.30.0.0/16', 'external_subnet_v4': '192.168.111.0/24', 'num_masters': 3, 'num_workers': 0, 'ip_stack': 'v4', 'network_type': 'OVNKubernetes'})
ok: [instance] => (item={})
TASK [devscripts : Replace OCP version if "stable-" alias used] ****************
Monday 01 December 2025 08:22:30 +0000 (0:00:00.066) 0:00:26.025 *******
skipping: [instance]
TASK [devscripts : Ensure output directory exists] *****************************
Monday 01 December 2025 08:22:30 +0000 (0:00:00.015) 0:00:26.040 *******
ok: [instance]
TASK [devscripts : Output built config for easier debugging] *******************
Monday 01 December 2025 08:22:30 +0000 (0:00:00.200) 0:00:26.241 *******
changed: [instance]
TASK [ci_network : Remove the local dns configuration] *************************
Monday 01 December 2025 08:22:31 +0000 (0:00:00.320) 0:00:26.562 *******
ok: [instance] => (item=/etc/NetworkManager/conf.d/00-use-dnsmasq.conf)
ok: [instance] => (item=/etc/NetworkManager/dnsmasq.d/98-cifmw-static-leases.conf)
ok: [instance] => (item=/etc/NetworkManager/dnsmasq.d/99-cifmw-dns-forwarders.conf)
ok: [instance] => (item=/etc/NetworkManager/dnsmasq.d/97-cifmw-local-domain.conf)
TASK [ci_network : Reload the NetworkManager to pick the changes] **************
Monday 01 December 2025 08:22:31 +0000 (0:00:00.701) 0:00:27.264 *******
skipping: [instance]
TASK [reproducer : Ensure NetworkManager is configured to use dnsmasq] *********
Monday 01 December 2025 08:22:31 +0000 (0:00:00.025) 0:00:27.290 *******
changed: [instance]
TASK [reproducer : Flush handlers for NetworkManager restart] ******************
Monday 01 December 2025 08:22:32 +0000 (0:00:00.342) 0:00:27.633 *******
RUNNING HANDLER [reproducer : Restart NetworkManager] **************************
Monday 01 December 2025 08:22:32 +0000 (0:00:00.007) 0:00:27.641 *******
changed: [instance]
TASK [Ensure no default networks exists] ***************************************
Monday 01 December 2025 08:22:32 +0000 (0:00:00.410) 0:00:28.051 *******
TASK [libvirt_manager : Deactivate crc] ****************************************
Monday 01 December 2025 08:22:32 +0000 (0:00:00.074) 0:00:28.126 *******
ok: [instance]
TASK [libvirt_manager : Removing crc] ******************************************
Monday 01 December 2025 08:22:33 +0000 (0:00:01.157) 0:00:29.284 *******
ok: [instance]
TASK [libvirt_manager : Deactivate default] ************************************
Monday 01 December 2025 08:22:34 +0000 (0:00:00.214) 0:00:29.498 *******
ok: [instance]
TASK [libvirt_manager : Removing default] **************************************
Monday 01 December 2025 08:22:34 +0000 (0:00:00.476) 0:00:29.974 *******
ok: [instance]
TASK [reproducer : Ensure firewalld is installed] ******************************
Monday 01 December 2025 08:22:34 +0000 (0:00:00.215) 0:00:30.190 *******
ok: [instance]
TASK [reproducer : Ensure firewalld service is enabled and started] ************
Monday 01 December 2025 08:22:35 +0000 (0:00:01.141) 0:00:31.332 *******
ok: [instance]
TASK [reproducer : Ensure br_netfilter module is loaded] ***********************
Monday 01 December 2025 08:22:36 +0000 (0:00:00.292) 0:00:31.624 *******
changed: [instance]
TASK [reproducer : Ensure IP forwarding is enabled] ****************************
Monday 01 December 2025 08:22:36 +0000 (0:00:00.285) 0:00:31.910 *******
changed: [instance]
TASK [reproducer : Ensure the required parameters are loaded] ******************
Monday 01 December 2025 08:22:36 +0000 (0:00:00.283) 0:00:32.194 *******
changed: [instance] => (item=arptables)
changed: [instance] => (item=iptables)
changed: [instance] => (item=ip6tables)
TASK [reproducer : Ensure firewall service is enabled and started] *************
Monday 01 December 2025 08:22:37 +0000 (0:00:00.529) 0:00:32.724 *******
ok: [instance]
TASK [reproducer : Set cifmw_ci_nmstate_instance_config if needed] *************
Monday 01 December 2025 08:22:37 +0000 (0:00:00.294) 0:00:33.018 *******
ok: [instance]
TASK [Ensure the required network configurations are applied] ******************
Monday 01 December 2025 08:22:37 +0000 (0:00:00.084) 0:00:33.102 *******
TASK [networking_mapper : Check for Networking Environment Definition file existence] ***
Monday 01 December 2025 08:22:37 +0000 (0:00:00.039) 0:00:33.142 *******
skipping: [instance]
TASK [networking_mapper : Check for Networking Definition file existance] ******
Monday 01 December 2025 08:22:37 +0000 (0:00:00.021) 0:00:33.164 *******
skipping: [instance]
TASK [networking_mapper : Load the Networking Definition from file] ************
Monday 01 December 2025 08:22:37 +0000 (0:00:00.021) 0:00:33.186 *******
skipping: [instance]
TASK [networking_mapper : Set cifmw_networking_env_definition is present] ******
Monday 01 December 2025 08:22:37 +0000 (0:00:00.022) 0:00:33.208 *******
skipping: [instance]
TASK [ci_nmstate : Initialize NMstates for each instance] **********************
Monday 01 December 2025 08:22:37 +0000 (0:00:00.026) 0:00:33.234 *******
ok: [instance]
TASK [ci_nmstate : Build NMstates from the Networking Environment Definition] ***
Monday 01 December 2025 08:22:37 +0000 (0:00:00.038) 0:00:33.273 *******
skipping: [instance]
TASK [ci_nmstate : Get k8s nodes] **********************************************
Monday 01 December 2025 08:22:37 +0000 (0:00:00.031) 0:00:33.305 *******
skipping: [instance]
TASK [ci_nmstate : Set the hosts that will provision nmstate using k8s] ********
Monday 01 December 2025 08:22:37 +0000 (0:00:00.020) 0:00:33.326 *******
ok: [instance]
TASK [ci_nmstate : Provision k8s workers with nmstate] *************************
Monday 01 December 2025 08:22:37 +0000 (0:00:00.058) 0:00:33.384 *******
skipping: [instance]
TASK [ci_nmstate : Provision unmanaged nodes with nmstate] *********************
Monday 01 December 2025 08:22:37 +0000 (0:00:00.020) 0:00:33.405 *******
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_nmstate/tasks/nmstate_unmanaged_provision_node.yml for instance => (item=localhost)
TASK [ci_nmstate : Ensure we have needed facts] ********************************
Monday 01 December 2025 08:22:38 +0000 (0:00:00.043) 0:00:33.449 *******
ok: [instance -> localhost]
TASK [ci_nmstate : Install required packages on localhost] *********************
Monday 01 December 2025 08:22:38 +0000 (0:00:00.299) 0:00:33.749 *******
changed: [instance -> localhost]
TASK [ci_nmstate : Create the target NMstate dump directory] *******************
Monday 01 December 2025 08:22:42 +0000 (0:00:04.592) 0:00:38.341 *******
changed: [instance]
TASK [ci_nmstate : Save nmstate state for localhost] ***************************
Monday 01 December 2025 08:22:43 +0000 (0:00:00.191) 0:00:38.533 *******
changed: [instance]
TASK [ci_nmstate : Apply the desidered state on localhost] *********************
Monday 01 December 2025 08:22:43 +0000 (0:00:00.328) 0:00:38.861 *******
changed: [instance -> localhost]
TASK [ci_nmstate : Save nmstate debugging data for localhost] ******************
Monday 01 December 2025 08:22:45 +0000 (0:00:01.581) 0:00:40.442 *******
changed: [instance]
TASK [reproducer : Select right domain] ****************************************
Monday 01 December 2025 08:22:45 +0000 (0:00:00.334) 0:00:40.776 *******
ok: [instance]
TASK [Create the virtual networks] *********************************************
Monday 01 December 2025 08:22:45 +0000 (0:00:00.032) 0:00:40.809 *******
TASK [libvirt_manager : Ensure fact is existing, and empty] ********************
Monday 01 December 2025 08:22:45 +0000 (0:00:00.116) 0:00:40.925 *******
ok: [instance]
TASK [libvirt_manager : Check if we get an existing interfaces-info.yml] *******
Monday 01 December 2025 08:22:45 +0000 (0:00:00.038) 0:00:40.963 *******
ok: [instance]
TASK [libvirt_manager : Load file if exists] ***********************************
Monday 01 December 2025 08:22:45 +0000 (0:00:00.188) 0:00:41.152 *******
skipping: [instance]
TASK [libvirt_manager : Update fact with existing content] *********************
Monday 01 December 2025 08:22:45 +0000 (0:00:00.029) 0:00:41.181 *******
skipping: [instance]
TASK [libvirt_manager : Generate VM list] **************************************
Monday 01 December 2025 08:22:45 +0000 (0:00:00.027) 0:00:41.209 *******
ok: [instance]
TASK [libvirt_manager : Generate/update mapping all nodes] *********************
Monday 01 December 2025 08:22:45 +0000 (0:00:00.055) 0:00:41.264 *******
ok: [instance] => (item={'key': 'compute-0', 'value': 'compute'})
ok: [instance] => (item={'key': 'controller-0', 'value': 'controller'})
ok: [instance] => (item={'key': 'crc-0', 'value': 'crc'})
TASK [libvirt_manager : Append baremetal nodes if needed] **********************
Monday 01 December 2025 08:22:45 +0000 (0:00:00.124) 0:00:41.389 *******
skipping: [instance]
TASK [libvirt_manager : Dump MAC mapping] **************************************
Monday 01 December 2025 08:22:46 +0000 (0:00:00.033) 0:00:41.422 *******
changed: [instance]
TASK [libvirt_manager : Add libvirt hosts into inventory and dump inventory file] ***
Monday 01 December 2025 08:22:46 +0000 (0:00:00.335) 0:00:41.758 *******
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/add_vm_to_inventory.yml for instance => (item=Adding compute-0 to computes)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/add_vm_to_inventory.yml for instance => (item=Adding controller-0 to controllers)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/add_vm_to_inventory.yml for instance => (item=Adding crc-0 to ocps)
TASK [libvirt_manager : Add host to runtime inventory] *************************
Monday 01 December 2025 08:22:46 +0000 (0:00:00.073) 0:00:41.832 *******
changed: [instance]
TASK [libvirt_manager : Ensure group section exists] ***************************
Monday 01 December 2025 08:22:46 +0000 (0:00:00.053) 0:00:41.885 *******
changed: [instance]
TASK [libvirt_manager : Append host under proper group] ************************
Monday 01 December 2025 08:22:46 +0000 (0:00:00.266) 0:00:42.152 *******
changed: [instance]
TASK [libvirt_manager : Add host to runtime inventory] *************************
Monday 01 December 2025 08:22:46 +0000 (0:00:00.201) 0:00:42.353 *******
changed: [instance]
TASK [libvirt_manager : Ensure group section exists] ***************************
Monday 01 December 2025 08:22:47 +0000 (0:00:00.053) 0:00:42.407 *******
changed: [instance]
TASK [libvirt_manager : Append host under proper group] ************************
Monday 01 December 2025 08:22:47 +0000 (0:00:00.192) 0:00:42.599 *******
changed: [instance]
TASK [libvirt_manager : Add host to runtime inventory] *************************
Monday 01 December 2025 08:22:47 +0000 (0:00:00.201) 0:00:42.801 *******
changed: [instance]
TASK [libvirt_manager : Ensure group section exists] ***************************
Monday 01 December 2025 08:22:47 +0000 (0:00:00.052) 0:00:42.854 *******
changed: [instance]
TASK [libvirt_manager : Append host under proper group] ************************
Monday 01 December 2025 08:22:47 +0000 (0:00:00.187) 0:00:43.042 *******
changed: [instance]
TASK [libvirt_manager : Convert ini inventory file into yaml] ******************
Monday 01 December 2025 08:22:47 +0000 (0:00:00.202) 0:00:43.244 *******
fatal: [instance]: FAILED! =>
msg: |-
The conditional check '(_cifmw_libvirt_manager_layout.vms[_vm_type].amount | default(1) | int) > 0' failed. The error was: error while evaluating conditional ((_cifmw_libvirt_manager_layout.vms[_vm_type].amount | default(1) | int) > 0): {{ cifmw_libvirt_manager_all_vms[item.key] | default('none') }}: 'item' is undefined. 'item' is undefined. {{ cifmw_libvirt_manager_all_vms[item.key] | default('none') }}: 'item' is undefined. 'item' is undefined
The error appears to be in '/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/libvirt_manager/tasks/generate_networking_data.yml': line 136, column 7, but may
be elsewhere in the file depending on the exact syntax problem.
The offending line appears to be:
- name: Convert ini inventory file into yaml
^ here
TASK [Create dnsmasq dir] ******************************************************
Monday 01 December 2025 08:22:47 +0000 (0:00:00.032) 0:00:43.277 *******
changed: [instance]
TASK [Get journalctl in a file] ************************************************
Monday 01 December 2025 08:22:48 +0000 (0:00:00.180) 0:00:43.458 *******
changed: [instance]
TASK [Dump journalctl output] **************************************************
Monday 01 December 2025 08:22:48 +0000 (0:00:00.194) 0:00:43.652 *******
changed: [instance]
TASK [Copy all dnsmasq config] *************************************************
Monday 01 December 2025 08:22:48 +0000 (0:00:00.336) 0:00:43.989 *******
failed: [instance] (item=/etc/cifmw-dnsmasq.conf) => changed=false
ansible_loop_var: item
cmd: /usr/bin/rsync --delay-updates -F --compress --archive --out-format='<<CHANGED>>%i %n%L' /etc/cifmw-dnsmasq.conf /home/zuul/ci-framework-data/artifacts/dnsmasq
item: /etc/cifmw-dnsmasq.conf
msg: |-
rsync: [sender] link_stat "/etc/cifmw-dnsmasq.conf" failed: No such file or directory (2)
rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1327) [sender=3.2.5]
rc: 23
failed: [instance] (item=/etc/cifmw-dnsmasq.d/) => changed=false
ansible_loop_var: item
cmd: /usr/bin/rsync --delay-updates -F --compress --archive --out-format='<<CHANGED>>%i %n%L' /etc/cifmw-dnsmasq.d/ /home/zuul/ci-framework-data/artifacts/dnsmasq
item: /etc/cifmw-dnsmasq.d/
msg: |-
rsync: [sender] change_dir "/etc/cifmw-dnsmasq.d" failed: No such file or directory (2)
rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1327) [sender=3.2.5]
rc: 23
PLAY RECAP *********************************************************************
instance : ok=108 changed=33 unreachable=0 failed=2 skipped=18 rescued=0 ignored=0
Monday 01 December 2025 08:22:49 +0000 (0:00:00.638) 0:00:44.627 *******
===============================================================================
libvirt_manager : Install packages required for using KVM --------------- 8.96s
ci_nmstate : Install required packages on localhost --------------------- 4.59s
discover_latest_image : Get latest image -------------------------------- 1.74s
ci_nmstate : Apply the desidered state on localhost --------------------- 1.58s
libvirt_manager : Ensure admin socket is enabled for network. ----------- 1.31s
libvirt_manager : Deactivate crc ---------------------------------------- 1.16s
reproducer : Ensure firewalld is installed ------------------------------ 1.14s
libvirt_manager : Ensure firewalld service is up ------------------------ 0.83s
Gathering Facts --------------------------------------------------------- 0.80s
ci_network : Remove the local dns configuration ------------------------- 0.70s
Copy all dnsmasq config ------------------------------------------------- 0.64s
libvirt_manager : Reload systemctl and start/enable virtproxyd.service --- 0.61s
libvirt_manager : Restart service polkit service ------------------------ 0.55s
reproducer : Ensure the required parameters are loaded ------------------ 0.53s
libvirt_manager : Enable UNIX socket PolicyKit auth --------------------- 0.48s
libvirt_manager : Deactivate default ------------------------------------ 0.48s
reproducer : Ensure directories are present ----------------------------- 0.45s
reproducer : Restart NetworkManager ------------------------------------- 0.41s
libvirt_manager : Add user if not exists in libvirt group --------------- 0.36s
reproducer : Ensure NetworkManager is configured to use dnsmasq --------- 0.34s