PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Monday 01 December 2025 08:46:40 +0000 (0:00:00.018) 0:00:00.018 *******
ok: [instance]
TASK [Create custom basedir] ***************************************************
Monday 01 December 2025 08:46:41 +0000 (0:00:00.834) 0:00:00.853 *******
changed: [instance]
TASK [test_deps : Gather facts if they don't exist] ****************************
Monday 01 December 2025 08:46:41 +0000 (0:00:00.334) 0:00:01.187 *******
skipping: [instance]
TASK [test_deps : Gather variables for each operating system] ******************
Monday 01 December 2025 08:46:41 +0000 (0:00:00.021) 0:00:01.209 *******
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:46:41 +0000 (0:00:00.042) 0:00:01.251 *******
ok: [instance]
TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Monday 01 December 2025 08:46:42 +0000 (0:00:00.305) 0:00:01.556 *******
ok: [instance]
TASK [test_deps : Disable ubi 9 repos] *****************************************
Monday 01 December 2025 08:46:42 +0000 (0:00:00.213) 0:00:01.770 *******
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:46:43 +0000 (0:00:00.688) 0:00:02.458 *******
TASK [repo_setup : Ensure directories are present] *****************************
Monday 01 December 2025 08:46:43 +0000 (0:00:00.064) 0:00:02.523 *******
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:46:43 +0000 (0:00:00.523) 0:00:03.047 *******
ok: [instance]
TASK [repo_setup : Get repo-setup repository] **********************************
Monday 01 December 2025 08:46:44 +0000 (0:00:00.795) 0:00:03.842 *******
changed: [instance]
TASK [repo_setup : Initialize python venv and install requirements] ************
Monday 01 December 2025 08:46:45 +0000 (0:00:01.107) 0:00:04.949 *******
changed: [instance]
TASK [repo_setup : Install repo-setup package] *********************************
Monday 01 December 2025 08:46:53 +0000 (0:00:07.466) 0:00:12.416 *******
changed: [instance]
TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Monday 01 December 2025 08:46:53 +0000 (0:00:00.719) 0:00:13.136 *******
skipping: [instance]
TASK [repo_setup : Run repo-setup] *********************************************
Monday 01 December 2025 08:46:53 +0000 (0:00:00.023) 0:00:13.159 *******
changed: [instance]
TASK [repo_setup : Get component repo] *****************************************
Monday 01 December 2025 08:46:54 +0000 (0:00:00.790) 0:00:13.949 *******
skipping: [instance]
TASK [repo_setup : Rename component repo] **************************************
Monday 01 December 2025 08:46:54 +0000 (0:00:00.041) 0:00:13.991 *******
skipping: [instance]
TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Monday 01 December 2025 08:46:54 +0000 (0:00:00.041) 0:00:14.033 *******
skipping: [instance]
TASK [repo_setup : Run repo-setup-get-hash] ************************************
Monday 01 December 2025 08:46:54 +0000 (0:00:00.037) 0:00:14.071 *******
changed: [instance]
TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Monday 01 December 2025 08:46:55 +0000 (0:00:00.559) 0:00:14.630 *******
changed: [instance]
TASK [repo_setup : Dump current-podified hash] *********************************
Monday 01 December 2025 08:46:55 +0000 (0:00:00.442) 0:00:15.073 *******
skipping: [instance]
TASK [repo_setup : Slurp current podified hash] ********************************
Monday 01 December 2025 08:46:55 +0000 (0:00:00.049) 0:00:15.123 *******
skipping: [instance]
TASK [repo_setup : Update the value of full_hash] ******************************
Monday 01 December 2025 08:46:55 +0000 (0:00:00.029) 0:00:15.153 *******
skipping: [instance]
TASK [repo_setup : Export hashes facts for further use] ************************
Monday 01 December 2025 08:46:55 +0000 (0:00:00.028) 0:00:15.182 *******
ok: [instance]
TASK [repo_setup : Create download directory] **********************************
Monday 01 December 2025 08:46:55 +0000 (0:00:00.038) 0:00:15.220 *******
skipping: [instance]
TASK [repo_setup : Print the URL to request] ***********************************
Monday 01 December 2025 08:46:55 +0000 (0:00:00.027) 0:00:15.248 *******
skipping: [instance]
TASK [Download the RPM] ********************************************************
Monday 01 December 2025 08:46:55 +0000 (0:00:00.027) 0:00:15.276 *******
skipping: [instance]
TASK [repo_setup : Install RHOS Release tool] **********************************
Monday 01 December 2025 08:46:56 +0000 (0:00:00.027) 0:00:15.303 *******
skipping: [instance]
TASK [repo_setup : Get rhos-release tool version] ******************************
Monday 01 December 2025 08:46:56 +0000 (0:00:00.028) 0:00:15.332 *******
skipping: [instance]
TASK [repo_setup : Print rhos-release tool version] ****************************
Monday 01 December 2025 08:46:56 +0000 (0:00:00.030) 0:00:15.362 *******
skipping: [instance]
TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Monday 01 December 2025 08:46:56 +0000 (0:00:00.031) 0:00:15.393 *******
skipping: [instance]
TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Monday 01 December 2025 08:46:56 +0000 (0:00:00.027) 0:00:15.420 *******
ok: [instance]
TASK [repo_setup : Use RDO proxy mirrors] **************************************
Monday 01 December 2025 08:46:56 +0000 (0:00:00.186) 0:00:15.607 *******
changed: [instance]
TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Monday 01 December 2025 08:46:56 +0000 (0:00:00.212) 0:00:15.819 *******
changed: [instance]
TASK [repo_setup : Check for gating.repo file on content provider] *************
Monday 01 December 2025 08:46:56 +0000 (0:00:00.227) 0:00:16.047 *******
skipping: [instance]
TASK [repo_setup : Populate gating repo from content provider ip] **************
Monday 01 December 2025 08:46:56 +0000 (0:00:00.021) 0:00:16.069 *******
skipping: [instance]
TASK [repo_setup : Check for DLRN repo at the destination] *********************
Monday 01 December 2025 08:46:56 +0000 (0:00:00.021) 0:00:16.090 *******
skipping: [instance]
TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Monday 01 December 2025 08:46:56 +0000 (0:00:00.020) 0:00:16.111 *******
skipping: [instance]
TASK [repo_setup : Check for DLRN component repo] ******************************
Monday 01 December 2025 08:46:56 +0000 (0:00:00.029) 0:00:16.140 *******
skipping: [instance]
TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
Monday 01 December 2025 08:46:56 +0000 (0:00:00.022) 0:00:16.163 *******
skipping: [instance]
TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Monday 01 December 2025 08:46:56 +0000 (0:00:00.024) 0:00:16.187 *******
skipping: [instance]
TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Monday 01 December 2025 08:46:56 +0000 (0:00:00.018) 0:00:16.206 *******
skipping: [instance]
TASK [repo_setup : Cleanup existing metadata] **********************************
Monday 01 December 2025 08:46:56 +0000 (0:00:00.031) 0:00:16.237 *******
skipping: [instance]
TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Monday 01 December 2025 08:46:56 +0000 (0:00:00.018) 0:00:16.256 *******
skipping: [instance]
TASK [test_deps : Look for redhat-release rpm] *********************************
Monday 01 December 2025 08:46:56 +0000 (0:00:00.022) 0:00:16.279 *******
skipping: [instance]
TASK [test_deps : Remove redhat-release] ***************************************
Monday 01 December 2025 08:46:57 +0000 (0:00:00.030) 0:00:16.309 *******
skipping: [instance]
TASK [test_deps : Install centos-stream-release] *******************************
Monday 01 December 2025 08:46:57 +0000 (0:00:00.030) 0:00:16.339 *******
skipping: [instance]
TASK [test_deps : Install additional packages] *********************************
Monday 01 December 2025 08:46:57 +0000 (0:00:00.030) 0:00:16.370 *******
skipping: [instance]
TASK [test_deps : Install selinux python libs] *********************************
Monday 01 December 2025 08:46:57 +0000 (0:00:00.030) 0:00:16.400 *******
ok: [instance]
TASK [test_deps : Install python yaml libs] ************************************
Monday 01 December 2025 08:47:36 +0000 (0:00:39.150) 0:00:55.550 *******
ok: [instance]
TASK [test_deps : Install extra packages] **************************************
Monday 01 December 2025 08:47:37 +0000 (0:00:01.188) 0:00:56.739 *******
skipping: [instance]
TASK [ci_setup : Gather variables for each operating system] *******************
Monday 01 December 2025 08:47:37 +0000 (0:00:00.033) 0:00:56.772 *******
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:47:37 +0000 (0:00:00.043) 0:00:56.816 *******
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:47:37 +0000 (0:00:00.019) 0:00:56.835 *******
changed: [instance]
TASK [ci_setup : Gather version of openshift client] ***************************
Monday 01 December 2025 08:47:44 +0000 (0:00:07.160) 0:01:03.996 *******
ok: [instance]
TASK [ci_setup : Ensure openshift client install path is present] **************
Monday 01 December 2025 08:47:45 +0000 (0:00:00.604) 0:01:04.601 *******
changed: [instance]
TASK [ci_setup : Install openshift client] *************************************
Monday 01 December 2025 08:47:45 +0000 (0:00:00.223) 0:01:04.825 *******
changed: [instance]
TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
Monday 01 December 2025 08:47:51 +0000 (0:00:05.974) 0:01:10.800 *******
ok: [instance]
TASK [ci_setup : Create completion file] ***************************************
Monday 01 December 2025 08:47:51 +0000 (0:00:00.039) 0:01:10.839 *******
changed: [instance]
TASK [ci_setup : Source completion from within .bashrc] ************************
Monday 01 December 2025 08:47:51 +0000 (0:00:00.292) 0:01:11.132 *******
changed: [instance]
TASK [ci_setup : Check rhsm status] ********************************************
Monday 01 December 2025 08:47:52 +0000 (0:00:00.288) 0:01:11.421 *******
skipping: [instance]
TASK [ci_setup : Gather the repos to be enabled] *******************************
Monday 01 December 2025 08:47:52 +0000 (0:00:00.020) 0:01:11.442 *******
skipping: [instance]
TASK [ci_setup : Enabling the required repositories.] **************************
Monday 01 December 2025 08:47:52 +0000 (0:00:00.023) 0:01:11.465 *******
skipping: [instance]
TASK [ci_setup : Get current /etc/redhat-release] ******************************
Monday 01 December 2025 08:47:52 +0000 (0:00:00.023) 0:01:11.488 *******
skipping: [instance]
TASK [ci_setup : Print current /etc/redhat-release] ****************************
Monday 01 December 2025 08:47:52 +0000 (0:00:00.019) 0:01:11.508 *******
skipping: [instance]
TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
Monday 01 December 2025 08:47:52 +0000 (0:00:00.016) 0:01:11.525 *******
skipping: [instance]
TASK [ci_setup : Manage directories] *******************************************
Monday 01 December 2025 08:47:52 +0000 (0:00:00.022) 0:01:11.548 *******
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:47:53 +0000 (0:00:01.028) 0:01:12.576 *******
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=31 changed=17 unreachable=0 failed=0 skipped=36 rescued=0 ignored=0
Monday 01 December 2025 08:47:53 +0000 (0:00:00.349) 0:01:12.925 *******
===============================================================================
test_deps : Install selinux python libs -------------------------------- 39.15s
repo_setup : Initialize python venv and install requirements ------------ 7.47s
ci_setup : Install needed packages -------------------------------------- 7.16s
ci_setup : Install openshift client ------------------------------------- 5.97s
test_deps : Install python yaml libs ------------------------------------ 1.19s
repo_setup : Get repo-setup repository ---------------------------------- 1.11s
ci_setup : Manage directories ------------------------------------------- 1.03s
Gathering Facts --------------------------------------------------------- 0.83s
repo_setup : Make sure git-core package is installed -------------------- 0.80s
repo_setup : Run repo-setup --------------------------------------------- 0.79s
repo_setup : Install repo-setup package --------------------------------- 0.72s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.69s
ci_setup : Gather version of openshift client --------------------------- 0.60s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.56s
repo_setup : Ensure directories are present ----------------------------- 0.52s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.44s
Create secret file ------------------------------------------------------ 0.35s
Create custom basedir --------------------------------------------------- 0.33s
test_deps : Detect mirrors file ----------------------------------------- 0.31s
ci_setup : Create completion file --------------------------------------- 0.29s
PLAY [Converge] ****************************************************************
TASK [Gathering Facts] *********************************************************
Monday 01 December 2025 08:47:54 +0000 (0:00:00.024) 0:00:00.024 *******
ok: [instance]
TASK [Load networking definition from scenario file] ***************************
Monday 01 December 2025 08:47:55 +0000 (0:00:00.861) 0:00:00.885 *******
ok: [instance]
TASK [discover_latest_image : Get latest image] ********************************
Monday 01 December 2025 08:47:55 +0000 (0:00:00.030) 0:00:00.916 *******
changed: [instance]
TASK [discover_latest_image : Export facts accordingly] ************************
Monday 01 December 2025 08:47:57 +0000 (0:00:01.862) 0:00:02.778 *******
ok: [instance]
TASK [reproducer : Load CI job environment] ************************************
Monday 01 December 2025 08:47:57 +0000 (0:00:00.034) 0:00:02.813 *******
skipping: [instance]
TASK [Build final libvirt layout] **********************************************
Monday 01 December 2025 08:47:57 +0000 (0:00:00.072) 0:00:02.885 *******
TASK [libvirt_manager : Chose right parameter for layout definition] ***********
Monday 01 December 2025 08:47:57 +0000 (0:00:00.052) 0:00:02.938 *******
ok: [instance]
TASK [libvirt_manager : Patch the layout if needed] ****************************
Monday 01 December 2025 08:47:57 +0000 (0:00:00.091) 0:00:03.030 *******
skipping: [instance]
TASK [reproducer : Assert no conflicting parameters were passed] ***************
Monday 01 December 2025 08:47:57 +0000 (0:00:00.062) 0:00:03.092 *******
ok: [instance]
TASK [reproducer : Assert that deprecated cifmw_reproducer_internal_ca parameters was not passed] ***
Monday 01 December 2025 08:47:57 +0000 (0:00:00.032) 0:00:03.124 *******
ok: [instance] => changed=false
msg: All assertions passed
TASK [reproducer : Set _use_crc based on actual layout] ************************
Monday 01 December 2025 08:47:57 +0000 (0:00:00.030) 0:00:03.154 *******
ok: [instance]
TASK [reproducer : Ensure directories are present] *****************************
Monday 01 December 2025 08:47:57 +0000 (0:00:00.046) 0:00:03.201 *******
ok: [instance] => (item=artifacts)
ok: [instance] => (item=logs)
TASK [Bootstrap libvirt if needed] *********************************************
Monday 01 December 2025 08:47:57 +0000 (0:00:00.470) 0:00:03.671 *******
TASK [libvirt_manager : Ensure output directory exists] ************************
Monday 01 December 2025 08:47:57 +0000 (0:00:00.079) 0:00:03.751 *******
ok: [instance]
TASK [libvirt_manager : Get vmx/svm extensions from /proc/cpuinfo] *************
Monday 01 December 2025 08:47:58 +0000 (0:00:00.207) 0:00:03.958 *******
changed: [instance]
TASK [libvirt_manager : Check if KVM is enabled] *******************************
Monday 01 December 2025 08:47:58 +0000 (0:00:00.261) 0:00:04.219 *******
ok: [instance]
TASK [libvirt_manager : Fail if KVM not enabled] *******************************
Monday 01 December 2025 08:47:58 +0000 (0:00:00.288) 0:00:04.508 *******
skipping: [instance]
TASK [libvirt_manager : Check if VMX virtualization] ***************************
Monday 01 December 2025 08:47:58 +0000 (0:00:00.029) 0:00:04.538 *******
skipping: [instance]
TASK [libvirt_manager : Check if SVM virtualization] ***************************
Monday 01 December 2025 08:47:58 +0000 (0:00:00.018) 0:00:04.557 *******
ok: [instance]
TASK [libvirt_manager : Enable VMX virtualization] *****************************
Monday 01 December 2025 08:47:58 +0000 (0:00:00.022) 0:00:04.579 *******
skipping: [instance]
TASK [libvirt_manager : Install packages required for using KVM] ***************
Monday 01 December 2025 08:47:58 +0000 (0:00:00.029) 0:00:04.609 *******
changed: [instance]
TASK [libvirt_manager : Create rules.d polkit folder] **************************
Monday 01 December 2025 08:48:10 +0000 (0:00:12.006) 0:00:16.616 *******
changed: [instance]
TASK [libvirt_manager : Enable UNIX socket PolicyKit auth] *********************
Monday 01 December 2025 08:48:11 +0000 (0:00:00.228) 0:00:16.844 *******
changed: [instance]
TASK [libvirt_manager : Restart service polkit service] ************************
Monday 01 December 2025 08:48:11 +0000 (0:00:00.521) 0:00:17.365 *******
changed: [instance]
TASK [libvirt_manager : Remove directory for service override] *****************
Monday 01 December 2025 08:48:12 +0000 (0:00:00.648) 0:00:18.013 *******
ok: [instance]
TASK [libvirt_manager : Reload systemctl and start/enable virtproxyd.service] ***
Monday 01 December 2025 08:48:12 +0000 (0:00:00.205) 0:00:18.219 *******
ok: [instance]
TASK [libvirt_manager : Ensure firewalld service is up] ************************
Monday 01 December 2025 08:48:13 +0000 (0:00:00.679) 0:00:18.898 *******
changed: [instance]
TASK [libvirt_manager : Ensure libvirt modular driver daemons are started.] ****
Monday 01 December 2025 08:48:14 +0000 (0:00:00.951) 0:00:19.850 *******
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:48:14 +0000 (0:00:00.098) 0:00:19.949 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for qemu.] **********
Monday 01 December 2025 08:48:14 +0000 (0:00:00.365) 0:00:20.315 *******
ok: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for qemu.] **************
Monday 01 December 2025 08:48:14 +0000 (0:00:00.355) 0:00:20.670 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for interface.] ****
Monday 01 December 2025 08:48:15 +0000 (0:00:00.382) 0:00:21.053 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for interface.] *****
Monday 01 December 2025 08:48:15 +0000 (0:00:00.377) 0:00:21.430 *******
ok: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for interface.] *********
Monday 01 December 2025 08:48:16 +0000 (0:00:00.350) 0:00:21.781 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for network.] ******
Monday 01 December 2025 08:48:16 +0000 (0:00:00.333) 0:00:22.115 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for network.] *******
Monday 01 December 2025 08:48:16 +0000 (0:00:00.344) 0:00:22.459 *******
ok: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for network.] ***********
Monday 01 December 2025 08:48:17 +0000 (0:00:00.333) 0:00:22.792 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for nodedev.] ******
Monday 01 December 2025 08:48:17 +0000 (0:00:00.339) 0:00:23.132 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for nodedev.] *******
Monday 01 December 2025 08:48:17 +0000 (0:00:00.345) 0:00:23.478 *******
ok: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for nodedev.] ***********
Monday 01 December 2025 08:48:18 +0000 (0:00:00.342) 0:00:23.820 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for nwfilter.] *****
Monday 01 December 2025 08:48:18 +0000 (0:00:00.331) 0:00:24.152 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for nwfilter.] ******
Monday 01 December 2025 08:48:18 +0000 (0:00:00.347) 0:00:24.499 *******
ok: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for nwfilter.] **********
Monday 01 December 2025 08:48:19 +0000 (0:00:00.343) 0:00:24.842 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for secret.] *******
Monday 01 December 2025 08:48:19 +0000 (0:00:00.328) 0:00:25.170 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for secret.] ********
Monday 01 December 2025 08:48:19 +0000 (0:00:00.344) 0:00:25.515 *******
ok: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for secret.] ************
Monday 01 December 2025 08:48:20 +0000 (0:00:00.324) 0:00:25.840 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for storage.] ******
Monday 01 December 2025 08:48:20 +0000 (0:00:00.324) 0:00:26.164 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for storage.] *******
Monday 01 December 2025 08:48:20 +0000 (0:00:00.330) 0:00:26.495 *******
ok: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for storage.] ***********
Monday 01 December 2025 08:48:21 +0000 (0:00:00.337) 0:00:26.832 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-write socket is enabled for proxy.] ********
Monday 01 December 2025 08:48:21 +0000 (0:00:00.345) 0:00:27.178 *******
ok: [instance]
TASK [libvirt_manager : Ensure read-only socket is enabled for proxy.] *********
Monday 01 December 2025 08:48:21 +0000 (0:00:00.336) 0:00:27.514 *******
ok: [instance]
TASK [libvirt_manager : Ensure admin socket is enabled for proxy.] *************
Monday 01 December 2025 08:48:22 +0000 (0:00:00.337) 0:00:27.851 *******
ok: [instance]
TASK [libvirt_manager : Manage service for older releases] *********************
Monday 01 December 2025 08:48:22 +0000 (0:00:00.327) 0:00:28.179 *******
skipping: [instance]
TASK [libvirt_manager : Get libvirt group users] *******************************
Monday 01 December 2025 08:48:22 +0000 (0:00:00.021) 0:00:28.201 *******
ok: [instance]
TASK [libvirt_manager : Add user if not exists in libvirt group] ***************
Monday 01 December 2025 08:48:22 +0000 (0:00:00.289) 0:00:28.490 *******
ok: [instance]
TASK [libvirt_manager : Allow QEMU on home directory for the storage access] ***
Monday 01 December 2025 08:48:23 +0000 (0:00:00.390) 0:00:28.881 *******
changed: [instance]
TASK [libvirt_manager : Inject system connection parameters in bashrc] *********
Monday 01 December 2025 08:48:23 +0000 (0:00:00.321) 0:00:29.202 *******
[WARNING]: Reset is not implemented for this connection
changed: [instance]
TASK [libvirt_manager : Ensure we reload user env] *****************************
Monday 01 December 2025 08:48:23 +0000 (0:00:00.273) 0:00:29.476 *******
TASK [reproducer : Deploy networks in libvirt] *********************************
Monday 01 December 2025 08:48:23 +0000 (0:00:00.014) 0:00:29.491 *******
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:48:23 +0000 (0:00:00.075) 0:00:29.566 *******
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:48:23 +0000 (0:00:00.044) 0:00:29.610 *******
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:48:23 +0000 (0:00:00.048) 0:00:29.659 *******
ok: [instance]
TASK [reproducer : Ensure we don't have extra network defined] *****************
Monday 01 December 2025 08:48:23 +0000 (0:00:00.042) 0:00:29.701 *******
ok: [instance] => changed=false
msg: All assertions passed
TASK [Ensure we get latest OCP config] *****************************************
Monday 01 December 2025 08:48:23 +0000 (0:00:00.041) 0:00:29.743 *******
TASK [devscripts : Gather the configurations to be passed to dev-scripts.] *****
Monday 01 December 2025 08:48:24 +0000 (0:00:00.042) 0:00:29.785 *******
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:48:24 +0000 (0:00:00.072) 0:00:29.857 *******
skipping: [instance]
TASK [devscripts : Ensure output directory exists] *****************************
Monday 01 December 2025 08:48:24 +0000 (0:00:00.019) 0:00:29.877 *******
ok: [instance]
TASK [devscripts : Output built config for easier debugging] *******************
Monday 01 December 2025 08:48:24 +0000 (0:00:00.234) 0:00:30.111 *******
changed: [instance]
TASK [ci_network : Remove the local dns configuration] *************************
Monday 01 December 2025 08:48:24 +0000 (0:00:00.359) 0:00:30.471 *******
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:48:25 +0000 (0:00:00.828) 0:00:31.299 *******
skipping: [instance]
TASK [reproducer : Ensure NetworkManager is configured to use dnsmasq] *********
Monday 01 December 2025 08:48:25 +0000 (0:00:00.031) 0:00:31.331 *******
changed: [instance]
TASK [reproducer : Flush handlers for NetworkManager restart] ******************
Monday 01 December 2025 08:48:25 +0000 (0:00:00.382) 0:00:31.714 *******
RUNNING HANDLER [reproducer : Restart NetworkManager] **************************
Monday 01 December 2025 08:48:25 +0000 (0:00:00.008) 0:00:31.722 *******
changed: [instance]
TASK [Ensure no default networks exists] ***************************************
Monday 01 December 2025 08:48:26 +0000 (0:00:00.491) 0:00:32.213 *******
TASK [libvirt_manager : Deactivate crc] ****************************************
Monday 01 December 2025 08:48:26 +0000 (0:00:00.083) 0:00:32.297 *******
ok: [instance]
TASK [libvirt_manager : Removing crc] ******************************************
Monday 01 December 2025 08:48:27 +0000 (0:00:01.343) 0:00:33.641 *******
ok: [instance]
TASK [libvirt_manager : Deactivate default] ************************************
Monday 01 December 2025 08:48:28 +0000 (0:00:00.248) 0:00:33.889 *******
ok: [instance]
TASK [libvirt_manager : Removing default] **************************************
Monday 01 December 2025 08:48:28 +0000 (0:00:00.545) 0:00:34.434 *******
ok: [instance]
TASK [reproducer : Ensure firewalld is installed] ******************************
Monday 01 December 2025 08:48:28 +0000 (0:00:00.251) 0:00:34.686 *******
ok: [instance]
TASK [reproducer : Ensure firewalld service is enabled and started] ************
Monday 01 December 2025 08:48:30 +0000 (0:00:01.312) 0:00:35.999 *******
ok: [instance]
TASK [reproducer : Ensure br_netfilter module is loaded] ***********************
Monday 01 December 2025 08:48:30 +0000 (0:00:00.342) 0:00:36.342 *******
changed: [instance]
TASK [reproducer : Ensure IP forwarding is enabled] ****************************
Monday 01 December 2025 08:48:30 +0000 (0:00:00.384) 0:00:36.726 *******
changed: [instance]
TASK [reproducer : Ensure the required parameters are loaded] ******************
Monday 01 December 2025 08:48:31 +0000 (0:00:00.347) 0:00:37.074 *******
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:48:32 +0000 (0:00:01.653) 0:00:38.727 *******
ok: [instance]
TASK [reproducer : Set cifmw_ci_nmstate_instance_config if needed] *************
Monday 01 December 2025 08:48:33 +0000 (0:00:00.338) 0:00:39.066 *******
ok: [instance]
TASK [Ensure the required network configurations are applied] ******************
Monday 01 December 2025 08:48:33 +0000 (0:00:00.089) 0:00:39.156 *******
TASK [networking_mapper : Check for Networking Environment Definition file existence] ***
Monday 01 December 2025 08:48:33 +0000 (0:00:00.047) 0:00:39.203 *******
skipping: [instance]
TASK [networking_mapper : Check for Networking Definition file existance] ******
Monday 01 December 2025 08:48:33 +0000 (0:00:00.031) 0:00:39.235 *******
skipping: [instance]
TASK [networking_mapper : Load the Networking Definition from file] ************
Monday 01 December 2025 08:48:33 +0000 (0:00:00.028) 0:00:39.264 *******
skipping: [instance]
TASK [networking_mapper : Set cifmw_networking_env_definition is present] ******
Monday 01 December 2025 08:48:33 +0000 (0:00:00.026) 0:00:39.290 *******
skipping: [instance]
TASK [ci_nmstate : Initialize NMstates for each instance] **********************
Monday 01 December 2025 08:48:33 +0000 (0:00:00.027) 0:00:39.318 *******
ok: [instance]
TASK [ci_nmstate : Build NMstates from the Networking Environment Definition] ***
Monday 01 December 2025 08:48:33 +0000 (0:00:00.048) 0:00:39.366 *******
skipping: [instance]
TASK [ci_nmstate : Get k8s nodes] **********************************************
Monday 01 December 2025 08:48:33 +0000 (0:00:00.036) 0:00:39.402 *******
skipping: [instance]
TASK [ci_nmstate : Set the hosts that will provision nmstate using k8s] ********
Monday 01 December 2025 08:48:33 +0000 (0:00:00.031) 0:00:39.434 *******
ok: [instance]
TASK [ci_nmstate : Provision k8s workers with nmstate] *************************
Monday 01 December 2025 08:48:33 +0000 (0:00:00.058) 0:00:39.492 *******
skipping: [instance]
TASK [ci_nmstate : Provision unmanaged nodes with nmstate] *********************
Monday 01 December 2025 08:48:33 +0000 (0:00:00.028) 0:00:39.521 *******
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:48:33 +0000 (0:00:00.058) 0:00:39.579 *******
ok: [instance -> localhost]
TASK [ci_nmstate : Install required packages on localhost] *********************
Monday 01 December 2025 08:48:34 +0000 (0:00:00.342) 0:00:39.921 *******
changed: [instance -> localhost]
TASK [ci_nmstate : Create the target NMstate dump directory] *******************
Monday 01 December 2025 08:48:42 +0000 (0:00:08.197) 0:00:48.119 *******
changed: [instance]
TASK [ci_nmstate : Save nmstate state for localhost] ***************************
Monday 01 December 2025 08:48:42 +0000 (0:00:00.229) 0:00:48.349 *******
changed: [instance]
TASK [ci_nmstate : Apply the desidered state on localhost] *********************
Monday 01 December 2025 08:48:42 +0000 (0:00:00.410) 0:00:48.759 *******
changed: [instance -> localhost]
TASK [ci_nmstate : Save nmstate debugging data for localhost] ******************
Monday 01 December 2025 08:48:44 +0000 (0:00:01.662) 0:00:50.421 *******
changed: [instance]
TASK [reproducer : Select right domain] ****************************************
Monday 01 December 2025 08:48:45 +0000 (0:00:00.377) 0:00:50.799 *******
ok: [instance]
TASK [Create the virtual networks] *********************************************
Monday 01 December 2025 08:48:45 +0000 (0:00:00.036) 0:00:50.835 *******
TASK [libvirt_manager : Ensure fact is existing, and empty] ********************
Monday 01 December 2025 08:48:45 +0000 (0:00:00.163) 0:00:50.999 *******
ok: [instance]
TASK [libvirt_manager : Check if we get an existing interfaces-info.yml] *******
Monday 01 December 2025 08:48:45 +0000 (0:00:00.026) 0:00:51.026 *******
ok: [instance]
TASK [libvirt_manager : Load file if exists] ***********************************
Monday 01 December 2025 08:48:45 +0000 (0:00:00.201) 0:00:51.227 *******
skipping: [instance]
TASK [libvirt_manager : Update fact with existing content] *********************
Monday 01 December 2025 08:48:45 +0000 (0:00:00.032) 0:00:51.260 *******
skipping: [instance]
TASK [libvirt_manager : Generate VM list] **************************************
Monday 01 December 2025 08:48:45 +0000 (0:00:00.032) 0:00:51.292 *******
ok: [instance]
TASK [libvirt_manager : Generate/update mapping all nodes] *********************
Monday 01 December 2025 08:48:45 +0000 (0:00:00.071) 0:00:51.364 *******
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:48:45 +0000 (0:00:00.136) 0:00:51.500 *******
skipping: [instance]
TASK [libvirt_manager : Dump MAC mapping] **************************************
Monday 01 December 2025 08:48:45 +0000 (0:00:00.041) 0:00:51.542 *******
changed: [instance]
TASK [libvirt_manager : Add libvirt hosts into inventory and dump inventory file] ***
Monday 01 December 2025 08:48:46 +0000 (0:00:00.345) 0:00:51.887 *******
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:48:46 +0000 (0:00:00.082) 0:00:51.969 *******
changed: [instance]
TASK [libvirt_manager : Ensure group section exists] ***************************
Monday 01 December 2025 08:48:46 +0000 (0:00:00.060) 0:00:52.030 *******
changed: [instance]
TASK [libvirt_manager : Append host under proper group] ************************
Monday 01 December 2025 08:48:46 +0000 (0:00:00.356) 0:00:52.387 *******
changed: [instance]
TASK [libvirt_manager : Add host to runtime inventory] *************************
Monday 01 December 2025 08:48:46 +0000 (0:00:00.233) 0:00:52.620 *******
changed: [instance]
TASK [libvirt_manager : Ensure group section exists] ***************************
Monday 01 December 2025 08:48:46 +0000 (0:00:00.060) 0:00:52.681 *******
changed: [instance]
TASK [libvirt_manager : Append host under proper group] ************************
Monday 01 December 2025 08:48:47 +0000 (0:00:00.216) 0:00:52.898 *******
changed: [instance]
TASK [libvirt_manager : Add host to runtime inventory] *************************
Monday 01 December 2025 08:48:47 +0000 (0:00:00.244) 0:00:53.142 *******
changed: [instance]
TASK [libvirt_manager : Ensure group section exists] ***************************
Monday 01 December 2025 08:48:47 +0000 (0:00:00.060) 0:00:53.203 *******
changed: [instance]
TASK [libvirt_manager : Append host under proper group] ************************
Monday 01 December 2025 08:48:47 +0000 (0:00:00.224) 0:00:53.427 *******
changed: [instance]
TASK [libvirt_manager : Convert ini inventory file into yaml] ******************
Monday 01 December 2025 08:48:47 +0000 (0:00:00.226) 0:00:53.654 *******
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 137, 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:48:47 +0000 (0:00:00.039) 0:00:53.693 *******
changed: [instance]
TASK [Get journalctl in a file] ************************************************
Monday 01 December 2025 08:48:48 +0000 (0:00:00.199) 0:00:53.893 *******
changed: [instance]
TASK [Dump journalctl output] **************************************************
Monday 01 December 2025 08:48:48 +0000 (0:00:00.227) 0:00:54.121 *******
changed: [instance]
TASK [Copy all dnsmasq config] *************************************************
Monday 01 December 2025 08:48:48 +0000 (0:00:00.373) 0:00:54.494 *******
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:48:49 +0000 (0:00:00.688) 0:00:55.183 *******
===============================================================================
libvirt_manager : Install packages required for using KVM -------------- 12.01s
ci_nmstate : Install required packages on localhost --------------------- 8.20s
discover_latest_image : Get latest image -------------------------------- 1.86s
ci_nmstate : Apply the desidered state on localhost --------------------- 1.66s
reproducer : Ensure the required parameters are loaded ------------------ 1.65s
libvirt_manager : Deactivate crc ---------------------------------------- 1.34s
reproducer : Ensure firewalld is installed ------------------------------ 1.31s
libvirt_manager : Ensure firewalld service is up ------------------------ 0.95s
Gathering Facts --------------------------------------------------------- 0.86s
ci_network : Remove the local dns configuration ------------------------- 0.83s
Copy all dnsmasq config ------------------------------------------------- 0.69s
libvirt_manager : Reload systemctl and start/enable virtproxyd.service --- 0.68s
libvirt_manager : Restart service polkit service ------------------------ 0.65s
libvirt_manager : Deactivate default ------------------------------------ 0.55s
libvirt_manager : Enable UNIX socket PolicyKit auth --------------------- 0.52s
reproducer : Restart NetworkManager ------------------------------------- 0.49s
reproducer : Ensure directories are present ----------------------------- 0.47s
ci_nmstate : Save nmstate state for localhost --------------------------- 0.41s
libvirt_manager : Add user if not exists in libvirt group --------------- 0.39s
reproducer : Ensure br_netfilter module is loaded ----------------------- 0.38s