PLAY [Prepare] *****************************************************************

TASK [Gathering Facts] *********************************************************
Monday 13 October 2025  09:37:02 +0000 (0:00:00.028)       0:00:00.028 ********
ok: [instance]

TASK [test_deps : Gather facts if they don't exist] ****************************
Monday 13 October 2025  09:37:03 +0000 (0:00:00.888)       0:00:00.917 ********
skipping: [instance]

TASK [test_deps : Gather variables for each operating system] ******************
Monday 13 October 2025  09:37:03 +0000 (0:00:00.025)       0:00:00.942 ********
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 13 October 2025  09:37:03 +0000 (0:00:00.048)       0:00:00.990 ********
ok: [instance]

TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Monday 13 October 2025  09:37:03 +0000 (0:00:00.331)       0:00:01.322 ********
ok: [instance]

TASK [test_deps : Disable ubi 9 repos] *****************************************
Monday 13 October 2025  09:37:03 +0000 (0:00:00.347)       0:00:01.669 ********
ok: [instance] => (item=ubi-9-appstream)
ok: [instance] => (item=ubi-9-baseos)
ok: [instance] => (item=ubi-9-codeready-builder)

TASK [Deploy repo-setup] *******************************************************
Monday 13 October 2025  09:37:04 +0000 (0:00:00.750)       0:00:02.420 ********

TASK [repo_setup : Ensure directories are present] *****************************
Monday 13 October 2025  09:37:04 +0000 (0:00:00.060)       0:00:02.481 ********
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 13 October 2025  09:37:05 +0000 (0:00:00.571)       0:00:03.052 ********
ok: [instance]

TASK [repo_setup : Get repo-setup repository] **********************************
Monday 13 October 2025  09:37:06 +0000 (0:00:00.813)       0:00:03.866 ********
changed: [instance]

TASK [repo_setup : Initialize python venv and install requirements] ************
Monday 13 October 2025  09:37:07 +0000 (0:00:01.164)       0:00:05.031 ********
changed: [instance]

TASK [repo_setup : Install repo-setup package] *********************************
Monday 13 October 2025  09:37:15 +0000 (0:00:07.882)       0:00:12.913 ********
changed: [instance]

TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Monday 13 October 2025  09:37:15 +0000 (0:00:00.711)       0:00:13.625 ********
skipping: [instance]

TASK [repo_setup : Run repo-setup] *********************************************
Monday 13 October 2025  09:37:15 +0000 (0:00:00.022)       0:00:13.647 ********
changed: [instance]

TASK [repo_setup : Get component repo] *****************************************
Monday 13 October 2025  09:37:16 +0000 (0:00:00.850)       0:00:14.498 ********
skipping: [instance]

TASK [repo_setup : Rename component repo] **************************************
Monday 13 October 2025  09:37:16 +0000 (0:00:00.037)       0:00:14.535 ********
skipping: [instance]

TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Monday 13 October 2025  09:37:16 +0000 (0:00:00.038)       0:00:14.574 ********
skipping: [instance]

TASK [repo_setup : Run repo-setup-get-hash] ************************************
Monday 13 October 2025  09:37:16 +0000 (0:00:00.038)       0:00:14.612 ********
changed: [instance]

TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Monday 13 October 2025  09:37:17 +0000 (0:00:00.553)       0:00:15.166 ********
changed: [instance]

TASK [repo_setup : Dump current-podified hash] *********************************
Monday 13 October 2025  09:37:17 +0000 (0:00:00.431)       0:00:15.597 ********
skipping: [instance]

TASK [repo_setup : Slurp current podified hash] ********************************
Monday 13 October 2025  09:37:17 +0000 (0:00:00.029)       0:00:15.626 ********
skipping: [instance]

TASK [repo_setup : Update the value of full_hash] ******************************
Monday 13 October 2025  09:37:17 +0000 (0:00:00.029)       0:00:15.656 ********
skipping: [instance]

TASK [repo_setup : Export hashes facts for further use] ************************
Monday 13 October 2025  09:37:17 +0000 (0:00:00.028)       0:00:15.684 ********
ok: [instance]

TASK [repo_setup : Create download directory] **********************************
Monday 13 October 2025  09:37:17 +0000 (0:00:00.037)       0:00:15.722 ********
skipping: [instance]

TASK [repo_setup : Print the URL to request] ***********************************
Monday 13 October 2025  09:37:18 +0000 (0:00:00.027)       0:00:15.750 ********
skipping: [instance]

TASK [Download the RPM] ********************************************************
Monday 13 October 2025  09:37:18 +0000 (0:00:00.028)       0:00:15.778 ********
skipping: [instance]

TASK [repo_setup : Install RHOS Release tool] **********************************
Monday 13 October 2025  09:37:18 +0000 (0:00:00.028)       0:00:15.806 ********
skipping: [instance]

TASK [repo_setup : Get rhos-release tool version] ******************************
Monday 13 October 2025  09:37:18 +0000 (0:00:00.028)       0:00:15.835 ********
skipping: [instance]

TASK [repo_setup : Print rhos-release tool version] ****************************
Monday 13 October 2025  09:37:18 +0000 (0:00:00.027)       0:00:15.862 ********
skipping: [instance]

TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Monday 13 October 2025  09:37:18 +0000 (0:00:00.030)       0:00:15.893 ********
skipping: [instance]

TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Monday 13 October 2025  09:37:18 +0000 (0:00:00.026)       0:00:15.920 ********
ok: [instance]

TASK [repo_setup : Use RDO proxy mirrors] **************************************
Monday 13 October 2025  09:37:18 +0000 (0:00:00.190)       0:00:16.110 ********
changed: [instance]

TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Monday 13 October 2025  09:37:18 +0000 (0:00:00.216)       0:00:16.327 ********
changed: [instance]

TASK [repo_setup : Check for gating.repo file on content provider] *************
Monday 13 October 2025  09:37:18 +0000 (0:00:00.230)       0:00:16.557 ********
skipping: [instance]

TASK [repo_setup : Populate gating repo from content provider ip] **************
Monday 13 October 2025  09:37:18 +0000 (0:00:00.021)       0:00:16.579 ********
skipping: [instance]

TASK [repo_setup : Check for DLRN repo at the destination] *********************
Monday 13 October 2025  09:37:18 +0000 (0:00:00.023)       0:00:16.602 ********
skipping: [instance]

TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Monday 13 October 2025  09:37:18 +0000 (0:00:00.025)       0:00:16.628 ********
skipping: [instance]

TASK [repo_setup : Check for DLRN component repo] ******************************
Monday 13 October 2025  09:37:18 +0000 (0:00:00.023)       0:00:16.652 ********
skipping: [instance]

TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
Monday 13 October 2025  09:37:18 +0000 (0:00:00.024)       0:00:16.676 ********
skipping: [instance]

TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Monday 13 October 2025  09:37:18 +0000 (0:00:00.023)       0:00:16.700 ********
skipping: [instance]

TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Monday 13 October 2025  09:37:18 +0000 (0:00:00.020)       0:00:16.720 ********
skipping: [instance]

TASK [repo_setup : Cleanup existing metadata] **********************************
Monday 13 October 2025  09:37:19 +0000 (0:00:00.030)       0:00:16.751 ********
skipping: [instance]

TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Monday 13 October 2025  09:37:19 +0000 (0:00:00.019)       0:00:16.770 ********
skipping: [instance]

TASK [test_deps : Look for redhat-release rpm] *********************************
Monday 13 October 2025  09:37:19 +0000 (0:00:00.022)       0:00:16.793 ********
skipping: [instance]

TASK [test_deps : Remove redhat-release] ***************************************
Monday 13 October 2025  09:37:19 +0000 (0:00:00.029)       0:00:16.822 ********
skipping: [instance]

TASK [test_deps : Install centos-stream-release] *******************************
Monday 13 October 2025  09:37:19 +0000 (0:00:00.030)       0:00:16.853 ********
skipping: [instance]

TASK [test_deps : Install additional packages] *********************************
Monday 13 October 2025  09:37:19 +0000 (0:00:00.032)       0:00:16.886 ********
skipping: [instance]

TASK [test_deps : Install selinux python libs] *********************************
Monday 13 October 2025  09:37:19 +0000 (0:00:00.030)       0:00:16.916 ********
ok: [instance]

TASK [test_deps : Install python yaml libs] ************************************
Monday 13 October 2025  09:38:01 +0000 (0:00:42.131)       0:00:59.048 ********
ok: [instance]

TASK [test_deps : Install extra packages] **************************************
Monday 13 October 2025  09:38:02 +0000 (0:00:01.274)       0:01:00.322 ********
skipping: [instance]

TASK [ci_setup : Gather variables for each operating system] *******************
Monday 13 October 2025  09:38:02 +0000 (0:00:00.032)       0:01:00.355 ********
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 13 October 2025  09:38:02 +0000 (0:00:00.043)       0:01:00.399 ********
ok: [instance] =>
  cifmw_ci_setup_packages:
  - bash-completion
  - ca-certificates
  - git-core
  - make
  - tar
  - tmux
  - python3-pip

TASK [ci_setup : Install needed packages] **************************************
Monday 13 October 2025  09:38:02 +0000 (0:00:00.021)       0:01:00.420 ********
changed: [instance]

TASK [ci_setup : Gather version of openshift client] ***************************
Monday 13 October 2025  09:38:08 +0000 (0:00:05.762)       0:01:06.182 ********
ok: [instance]

TASK [ci_setup : Ensure openshift client install path is present] **************
Monday 13 October 2025  09:38:09 +0000 (0:00:00.574)       0:01:06.756 ********
changed: [instance]

TASK [ci_setup : Install openshift client] *************************************
Monday 13 October 2025  09:38:09 +0000 (0:00:00.213)       0:01:06.970 ********
changed: [instance]

TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
Monday 13 October 2025  09:38:15 +0000 (0:00:05.925)       0:01:12.896 ********
skipping: [instance]

TASK [ci_setup : Create completion file] ***************************************
Monday 13 October 2025  09:38:15 +0000 (0:00:00.035)       0:01:12.931 ********
changed: [instance]

TASK [ci_setup : Source completion from within .bashrc] ************************
Monday 13 October 2025  09:38:15 +0000 (0:00:00.260)       0:01:13.192 ********
changed: [instance]

TASK [ci_setup : Check rhsm status] ********************************************
Monday 13 October 2025  09:38:15 +0000 (0:00:00.264)       0:01:13.456 ********
skipping: [instance]

TASK [ci_setup : Gather the repos to be enabled] *******************************
Monday 13 October 2025  09:38:15 +0000 (0:00:00.018)       0:01:13.475 ********
skipping: [instance]

TASK [ci_setup : Enabling the required repositories.] **************************
Monday 13 October 2025  09:38:15 +0000 (0:00:00.016)       0:01:13.491 ********
skipping: [instance]

TASK [ci_setup : Get current /etc/redhat-release] ******************************
Monday 13 October 2025  09:38:15 +0000 (0:00:00.016)       0:01:13.508 ********
skipping: [instance]

TASK [ci_setup : Print current /etc/redhat-release] ****************************
Monday 13 October 2025  09:38:15 +0000 (0:00:00.015)       0:01:13.523 ********
skipping: [instance]

TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
Monday 13 October 2025  09:38:15 +0000 (0:00:00.014)       0:01:13.538 ********
skipping: [instance]

TASK [ci_setup : Manage directories] *******************************************
Monday 13 October 2025  09:38:15 +0000 (0:00:00.020)       0:01:13.559 ********
changed: [instance] => (item=/home/zuul/ci-framework-data/artifacts/manifests/openstack/cr)
ok: [instance] => (item=/home/zuul/ci-framework-data/logs)
ok: [instance] => (item=/home/zuul/ci-framework-data/tmp)
changed: [instance] => (item=/home/zuul/ci-framework-data/volumes)
ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/parameters)

TASK [libvirt_manager : Ensure output directory exists] ************************
Monday 13 October 2025  09:38:16 +0000 (0:00:01.046)       0:01:14.606 ********
ok: [instance]

TASK [libvirt_manager : Get vmx/svm extensions from /proc/cpuinfo] *************
Monday 13 October 2025  09:38:17 +0000 (0:00:00.215)       0:01:14.821 ********
changed: [instance]

TASK [libvirt_manager : Check if KVM is enabled] *******************************
Monday 13 October 2025  09:38:17 +0000 (0:00:00.190)       0:01:15.012 ********
ok: [instance]

TASK [libvirt_manager : Fail if KVM not enabled] *******************************
Monday 13 October 2025  09:38:17 +0000 (0:00:00.187)       0:01:15.199 ********
skipping: [instance]

TASK [libvirt_manager : Check if VMX virtualization] ***************************
Monday 13 October 2025  09:38:17 +0000 (0:00:00.027)       0:01:15.227 ********
skipping: [instance]

TASK [libvirt_manager : Check if SVM virtualization] ***************************
Monday 13 October 2025  09:38:17 +0000 (0:00:00.016)       0:01:15.243 ********
ok: [instance]

TASK [libvirt_manager : Enable VMX virtualization] *****************************
Monday 13 October 2025  09:38:17 +0000 (0:00:00.018)       0:01:15.261 ********
skipping: [instance]

TASK [libvirt_manager : Install packages required for using KVM] ***************
Monday 13 October 2025  09:38:17 +0000 (0:00:00.025)       0:01:15.287 ********
changed: [instance]

TASK [libvirt_manager : Create rules.d polkit folder] **************************
Monday 13 October 2025  09:38:25 +0000 (0:00:08.438)       0:01:23.725 ********
changed: [instance]

TASK [libvirt_manager : Enable UNIX socket PolicyKit auth] *********************
Monday 13 October 2025  09:38:26 +0000 (0:00:00.204)       0:01:23.930 ********
changed: [instance]

TASK [libvirt_manager : Restart service polkit service] ************************
Monday 13 October 2025  09:38:26 +0000 (0:00:00.380)       0:01:24.310 ********
changed: [instance]

TASK [libvirt_manager : Remove directory for service override] *****************
Monday 13 October 2025  09:38:27 +0000 (0:00:00.577)       0:01:24.888 ********
ok: [instance]

TASK [libvirt_manager : Reload systemctl and start/enable virtproxyd.service] ***
Monday 13 October 2025  09:38:27 +0000 (0:00:00.189)       0:01:25.078 ********
ok: [instance]

TASK [libvirt_manager : Ensure firewalld service is up] ************************
Monday 13 October 2025  09:38:27 +0000 (0:00:00.649)       0:01:25.727 ********
changed: [instance]

TASK [libvirt_manager : Ensure libvirt modular driver daemons are started.] ****
Monday 13 October 2025  09:38:28 +0000 (0:00:00.915)       0:01:26.643 ********
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 13 October 2025  09:38:28 +0000 (0:00:00.078)       0:01:26.721 ********
ok: [instance]

TASK [libvirt_manager : Ensure read-only socket is enabled for qemu.] **********
Monday 13 October 2025  09:38:29 +0000 (0:00:00.328)       0:01:27.050 ********
ok: [instance]

TASK [libvirt_manager : Ensure admin socket is enabled for qemu.] **************
Monday 13 October 2025  09:38:29 +0000 (0:00:00.333)       0:01:27.384 ********
ok: [instance]

TASK [libvirt_manager : Ensure read-write socket is enabled for interface.] ****
Monday 13 October 2025  09:38:29 +0000 (0:00:00.325)       0:01:27.710 ********
ok: [instance]

TASK [libvirt_manager : Ensure read-only socket is enabled for interface.] *****
Monday 13 October 2025  09:38:30 +0000 (0:00:00.322)       0:01:28.032 ********
ok: [instance]

TASK [libvirt_manager : Ensure admin socket is enabled for interface.] *********
Monday 13 October 2025  09:38:30 +0000 (0:00:00.321)       0:01:28.353 ********
ok: [instance]

TASK [libvirt_manager : Ensure read-write socket is enabled for network.] ******
Monday 13 October 2025  09:38:30 +0000 (0:00:00.320)       0:01:28.674 ********
ok: [instance]

TASK [libvirt_manager : Ensure read-only socket is enabled for network.] *******
Monday 13 October 2025  09:38:32 +0000 (0:00:01.326)       0:01:30.001 ********
ok: [instance]

TASK [libvirt_manager : Ensure admin socket is enabled for network.] ***********
Monday 13 October 2025  09:38:32 +0000 (0:00:00.325)       0:01:30.327 ********
ok: [instance]

TASK [libvirt_manager : Ensure read-write socket is enabled for nodedev.] ******
Monday 13 October 2025  09:38:32 +0000 (0:00:00.331)       0:01:30.658 ********
ok: [instance]

TASK [libvirt_manager : Ensure read-only socket is enabled for nodedev.] *******
Monday 13 October 2025  09:38:34 +0000 (0:00:01.341)       0:01:32.000 ********
ok: [instance]

TASK [libvirt_manager : Ensure admin socket is enabled for nodedev.] ***********
Monday 13 October 2025  09:38:34 +0000 (0:00:00.339)       0:01:32.339 ********
ok: [instance]

TASK [libvirt_manager : Ensure read-write socket is enabled for nwfilter.] *****
Monday 13 October 2025  09:38:34 +0000 (0:00:00.341)       0:01:32.681 ********
ok: [instance]

TASK [libvirt_manager : Ensure read-only socket is enabled for nwfilter.] ******
Monday 13 October 2025  09:38:35 +0000 (0:00:00.333)       0:01:33.014 ********
ok: [instance]

TASK [libvirt_manager : Ensure admin socket is enabled for nwfilter.] **********
Monday 13 October 2025  09:38:36 +0000 (0:00:01.338)       0:01:34.353 ********
ok: [instance]

TASK [libvirt_manager : Ensure read-write socket is enabled for secret.] *******
Monday 13 October 2025  09:38:36 +0000 (0:00:00.321)       0:01:34.675 ********
ok: [instance]

TASK [libvirt_manager : Ensure read-only socket is enabled for secret.] ********
Monday 13 October 2025  09:38:37 +0000 (0:00:00.325)       0:01:35.001 ********
ok: [instance]

TASK [libvirt_manager : Ensure admin socket is enabled for secret.] ************
Monday 13 October 2025  09:38:37 +0000 (0:00:00.322)       0:01:35.324 ********
ok: [instance]

TASK [libvirt_manager : Ensure read-write socket is enabled for storage.] ******
Monday 13 October 2025  09:38:37 +0000 (0:00:00.327)       0:01:35.652 ********
ok: [instance]

TASK [libvirt_manager : Ensure read-only socket is enabled for storage.] *******
Monday 13 October 2025  09:38:38 +0000 (0:00:00.319)       0:01:35.972 ********
ok: [instance]

TASK [libvirt_manager : Ensure admin socket is enabled for storage.] ***********
Monday 13 October 2025  09:38:38 +0000 (0:00:00.326)       0:01:36.298 ********
ok: [instance]

TASK [libvirt_manager : Ensure read-write socket is enabled for proxy.] ********
Monday 13 October 2025  09:38:38 +0000 (0:00:00.329)       0:01:36.627 ********
ok: [instance]

TASK [libvirt_manager : Ensure read-only socket is enabled for proxy.] *********
Monday 13 October 2025  09:38:39 +0000 (0:00:00.340)       0:01:36.967 ********
ok: [instance]

TASK [libvirt_manager : Ensure admin socket is enabled for proxy.] *************
Monday 13 October 2025  09:38:39 +0000 (0:00:00.328)       0:01:37.296 ********
ok: [instance]

TASK [libvirt_manager : Manage service for older releases] *********************
Monday 13 October 2025  09:38:39 +0000 (0:00:00.328)       0:01:37.625 ********
skipping: [instance]

TASK [libvirt_manager : Get libvirt group users] *******************************
Monday 13 October 2025  09:38:39 +0000 (0:00:00.019)       0:01:37.644 ********
ok: [instance]

TASK [libvirt_manager : Add user if not exists in libvirt group] ***************
Monday 13 October 2025  09:38:40 +0000 (0:00:00.282)       0:01:37.926 ********
ok: [instance]

TASK [libvirt_manager : Allow QEMU on home directory for the storage access] ***
Monday 13 October 2025  09:38:40 +0000 (0:00:00.377)       0:01:38.303 ********
changed: [instance]

TASK [libvirt_manager : Inject system connection parameters in bashrc] *********
Monday 13 October 2025  09:38:40 +0000 (0:00:00.309)       0:01:38.613 ********
[WARNING]: Reset is not implemented for this connection
changed: [instance]

TASK [libvirt_manager : Ensure we reload user env] *****************************
Monday 13 October 2025  09:38:41 +0000 (0:00:00.180)       0:01:38.794 ********

PLAY RECAP *********************************************************************
instance                   : ok=75   changed=23   unreachable=0    failed=0    skipped=41   rescued=0    ignored=0

Monday 13 October 2025  09:38:41 +0000 (0:00:00.026)       0:01:38.820 ********
===============================================================================
test_deps : Install selinux python libs -------------------------------- 42.13s
libvirt_manager : Install packages required for using KVM --------------- 8.44s
repo_setup : Initialize python venv and install requirements ------------ 7.88s
ci_setup : Install openshift client ------------------------------------- 5.93s
ci_setup : Install needed packages -------------------------------------- 5.76s
libvirt_manager : Ensure read-write socket is enabled for nodedev. ------ 1.34s
libvirt_manager : Ensure read-only socket is enabled for nwfilter. ------ 1.34s
libvirt_manager : Ensure read-write socket is enabled for network. ------ 1.33s
test_deps : Install python yaml libs ------------------------------------ 1.27s
repo_setup : Get repo-setup repository ---------------------------------- 1.16s
ci_setup : Manage directories ------------------------------------------- 1.05s
libvirt_manager : Ensure firewalld service is up ------------------------ 0.92s
Gathering Facts --------------------------------------------------------- 0.89s
repo_setup : Run repo-setup --------------------------------------------- 0.85s
repo_setup : Make sure git-core package is installed -------------------- 0.81s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.75s
repo_setup : Install repo-setup package --------------------------------- 0.71s
libvirt_manager : Reload systemctl and start/enable virtproxyd.service --- 0.65s
libvirt_manager : Restart service polkit service ------------------------ 0.58s
ci_setup : Gather version of openshift client --------------------------- 0.57s

PLAY [Converge] ****************************************************************

TASK [Gathering Facts] *********************************************************
Monday 13 October 2025  09:38:41 +0000 (0:00:00.014)       0:00:00.014 ********
ok: [instance]

TASK [Including the openshift provisioner node role.] **************************
Monday 13 October 2025  09:38:42 +0000 (0:00:00.804)       0:00:00.818 ********

TASK [openshift_provisioner_node : Create the artifacts directory] *************
Monday 13 October 2025  09:38:42 +0000 (0:00:00.040)       0:00:00.859 ********
ok: [instance -> localhost]

TASK [openshift_provisioner_node : Adding user kni] ****************************
Monday 13 October 2025  09:38:42 +0000 (0:00:00.306)       0:00:01.165 ********
changed: [instance]

TASK [openshift_provisioner_node : Generate SSH keys] **************************
Monday 13 October 2025  09:38:43 +0000 (0:00:00.402)       0:00:01.568 ********
changed: [instance -> localhost]

TASK [openshift_provisioner_node : Enable passwordless access] *****************
Monday 13 October 2025  09:38:43 +0000 (0:00:00.371)       0:00:01.939 ********
changed: [instance]

TASK [openshift_provisioner_node : Install required packages need to execute openshift installer] ***
Monday 13 October 2025  09:38:43 +0000 (0:00:00.387)       0:00:02.326 ********
changed: [instance]

TASK [openshift_provisioner_node : Create the external network connection] *****
Monday 13 October 2025  09:39:24 +0000 (0:00:40.867)       0:00:43.194 ********
changed: [instance]

TASK [openshift_provisioner_node : Verify external network interface is defined] ***
Monday 13 October 2025  09:39:25 +0000 (0:00:00.432)       0:00:43.626 ********
skipping: [instance]

TASK [openshift_provisioner_node : Add iface to the external network connection] ***
Monday 13 October 2025  09:39:25 +0000 (0:00:00.033)       0:00:43.660 ********
skipping: [instance]

TASK [openshift_provisioner_node : Create the provisioning network connection] ***
Monday 13 October 2025  09:39:25 +0000 (0:00:00.027)       0:00:43.688 ********
skipping: [instance]

TASK [openshift_provisioner_node : Add iface to the provisioning network connection] ***
Monday 13 October 2025  09:39:25 +0000 (0:00:00.032)       0:00:43.720 ********
skipping: [instance]

TASK [openshift_provisioner_node : Check required virtualization networks] *****
Monday 13 October 2025  09:39:25 +0000 (0:00:00.032)       0:00:43.753 ********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/openshift_provisioner_node/tasks/add_virtual_network.yml for instance => (item=baremetal)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/openshift_provisioner_node/tasks/add_virtual_network.yml for instance => (item=provisioning)

TASK [openshift_provisioner_node : Define virtual network baremetal] ***********
Monday 13 October 2025  09:39:25 +0000 (0:00:00.039)       0:00:43.792 ********
changed: [instance]

TASK [openshift_provisioner_node : Start the network - baremetal] **************
Monday 13 October 2025  09:39:26 +0000 (0:00:00.897)       0:00:44.690 ********
changed: [instance]

TASK [openshift_provisioner_node : Enable network autostart for baremetal] *****
Monday 13 October 2025  09:39:26 +0000 (0:00:00.238)       0:00:44.929 ********
changed: [instance]

TASK [openshift_provisioner_node : Define virtual network provisioning] ********
Monday 13 October 2025  09:39:26 +0000 (0:00:00.227)       0:00:45.156 ********
changed: [instance]

TASK [openshift_provisioner_node : Start the network - provisioning] ***********
Monday 13 October 2025  09:39:26 +0000 (0:00:00.236)       0:00:45.393 ********
changed: [instance]

TASK [openshift_provisioner_node : Enable network autostart for provisioning] ***
Monday 13 October 2025  09:39:27 +0000 (0:00:00.227)       0:00:45.620 ********
changed: [instance]

TASK [openshift_provisioner_node : Cache the MAC addresses] ********************
Monday 13 October 2025  09:39:27 +0000 (0:00:00.226)       0:00:45.847 ********
ok: [instance]

TASK [openshift_provisioner_node : Read host SSH fingerprint] ******************
Monday 13 October 2025  09:39:27 +0000 (0:00:00.051)       0:00:45.899 ********
ok: [instance]

TASK [openshift_provisioner_node : Set the role output parameters] *************
Monday 13 October 2025  09:39:27 +0000 (0:00:00.272)       0:00:46.171 ********
ok: [instance]

TASK [openshift_provisioner_node : Cache provisioning bridge name] *************
Monday 13 October 2025  09:39:27 +0000 (0:00:00.033)       0:00:46.205 ********
skipping: [instance]

TASK [Verify user is created] **************************************************
Monday 13 October 2025  09:39:27 +0000 (0:00:00.035)       0:00:46.240 ********
ok: [instance]

TASK [Verify external network bridge exists] ***********************************
Monday 13 October 2025  09:39:28 +0000 (0:00:00.299)       0:00:46.540 ********
Follow script's output here: /home/zuul/ci-framework-data/logs/ci_script_000_verify_external_network.log
changed: [instance]

TASK [Perform cleanup] *********************************************************
Monday 13 October 2025  09:39:28 +0000 (0:00:00.109)       0:00:46.650 ********

TASK [openshift_provisioner_node : Cleaning up the virtual networks] ***********
Monday 13 October 2025  09:39:28 +0000 (0:00:00.037)       0:00:46.687 ********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/openshift_provisioner_node/tasks/cleanup_virtual_network.yml for instance => (item=baremetal)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/openshift_provisioner_node/tasks/cleanup_virtual_network.yml for instance => (item=provisioning)

TASK [openshift_provisioner_node : Stopping virtual network baremetal] *********
Monday 13 October 2025  09:39:28 +0000 (0:00:00.029)       0:00:46.717 ********
ok: [instance]

TASK [openshift_provisioner_node : Remove virtual network baremetal] ***********
Monday 13 October 2025  09:39:28 +0000 (0:00:00.234)       0:00:46.952 ********
ok: [instance]

TASK [openshift_provisioner_node : Stopping virtual network provisioning] ******
Monday 13 October 2025  09:39:28 +0000 (0:00:00.227)       0:00:47.179 ********
ok: [instance]

TASK [openshift_provisioner_node : Remove virtual network provisioning] ********
Monday 13 October 2025  09:39:28 +0000 (0:00:00.235)       0:00:47.415 ********
ok: [instance]

TASK [openshift_provisioner_node : Remove provisioning network] ****************
Monday 13 October 2025  09:39:29 +0000 (0:00:00.231)       0:00:47.646 ********
ok: [instance]

TASK [openshift_provisioner_node : Remove the user] ****************************
Monday 13 October 2025  09:39:29 +0000 (0:00:00.257)       0:00:47.904 ********
changed: [instance]

PLAY RECAP *********************************************************************
instance                   : ok=28   changed=13   unreachable=0    failed=0    skipped=5    rescued=0    ignored=0

Monday 13 October 2025  09:39:29 +0000 (0:00:00.390)       0:00:48.294 ********
===============================================================================
openshift_provisioner_node : Install required packages need to execute openshift installer -- 40.87s
openshift_provisioner_node : Define virtual network baremetal ----------- 0.90s
Gathering Facts --------------------------------------------------------- 0.80s
openshift_provisioner_node : Create the external network connection ----- 0.43s
openshift_provisioner_node : Adding user kni ---------------------------- 0.40s
openshift_provisioner_node : Remove the user ---------------------------- 0.39s
openshift_provisioner_node : Enable passwordless access ----------------- 0.39s
openshift_provisioner_node : Generate SSH keys -------------------------- 0.37s
openshift_provisioner_node : Create the artifacts directory ------------- 0.31s
Verify user is created -------------------------------------------------- 0.30s
openshift_provisioner_node : Read host SSH fingerprint ------------------ 0.27s
openshift_provisioner_node : Remove provisioning network ---------------- 0.26s
openshift_provisioner_node : Start the network - baremetal -------------- 0.24s
openshift_provisioner_node : Define virtual network provisioning -------- 0.24s
openshift_provisioner_node : Stopping virtual network provisioning ------ 0.24s
openshift_provisioner_node : Stopping virtual network baremetal --------- 0.23s
openshift_provisioner_node : Remove virtual network provisioning -------- 0.23s
openshift_provisioner_node : Enable network autostart for baremetal ----- 0.23s
openshift_provisioner_node : Start the network - provisioning ----------- 0.23s
openshift_provisioner_node : Remove virtual network baremetal ----------- 0.23s