PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:20:43 +0000 (0:00:00.015) 0:00:00.015 ******
ok: [instance]
TASK [Setup libvirt] ***********************************************************
Monday 29 September 2025 19:20:44 +0000 (0:00:00.818) 0:00:00.834 ******
skipping: [instance]
TASK [Setup CRC] ***************************************************************
Monday 29 September 2025 19:20:44 +0000 (0:00:00.021) 0:00:00.856 ******
skipping: [instance]
TASK [Start RHOL/CRC] **********************************************************
Monday 29 September 2025 19:20:44 +0000 (0:00:00.020) 0:00:00.877 ******
changed: [instance]
TASK [Inject our own NetworkManager configuration] *****************************
Monday 29 September 2025 19:20:44 +0000 (0:00:00.417) 0:00:01.294 ******
changed: [instance]
TASK [test_deps : Gather facts if they don't exist] ****************************
Monday 29 September 2025 19:20:45 +0000 (0:00:00.572) 0:00:01.866 ******
skipping: [instance]
TASK [test_deps : Gather variables for each operating system] ******************
Monday 29 September 2025 19:20:45 +0000 (0:00:00.018) 0:00:01.885 ******
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 29 September 2025 19:20:45 +0000 (0:00:00.040) 0:00:01.925 ******
ok: [instance]
TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Monday 29 September 2025 19:20:45 +0000 (0:00:00.209) 0:00:02.135 ******
ok: [instance]
TASK [test_deps : Disable ubi 9 repos] *****************************************
Monday 29 September 2025 19:20:45 +0000 (0:00:00.333) 0:00:02.468 ******
ok: [instance] => (item=ubi-9-appstream)
ok: [instance] => (item=ubi-9-baseos)
ok: [instance] => (item=ubi-9-codeready-builder)
TASK [Deploy repo-setup] *******************************************************
Monday 29 September 2025 19:20:46 +0000 (0:00:00.713) 0:00:03.182 ******
TASK [repo_setup : Ensure directories are present] *****************************
Monday 29 September 2025 19:20:46 +0000 (0:00:00.063) 0:00:03.245 ******
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 29 September 2025 19:20:47 +0000 (0:00:00.594) 0:00:03.840 ******
ok: [instance]
TASK [repo_setup : Get repo-setup repository] **********************************
Monday 29 September 2025 19:20:47 +0000 (0:00:00.889) 0:00:04.730 ******
changed: [instance]
TASK [repo_setup : Initialize python venv and install requirements] ************
Monday 29 September 2025 19:20:49 +0000 (0:00:01.201) 0:00:05.931 ******
changed: [instance]
TASK [repo_setup : Install repo-setup package] *********************************
Monday 29 September 2025 19:20:58 +0000 (0:00:09.500) 0:00:15.432 ******
changed: [instance]
TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Monday 29 September 2025 19:20:59 +0000 (0:00:00.741) 0:00:16.173 ******
skipping: [instance]
TASK [repo_setup : Run repo-setup] *********************************************
Monday 29 September 2025 19:20:59 +0000 (0:00:00.032) 0:00:16.205 ******
changed: [instance]
TASK [repo_setup : Get component repo] *****************************************
Monday 29 September 2025 19:21:00 +0000 (0:00:00.964) 0:00:17.170 ******
skipping: [instance]
TASK [repo_setup : Rename component repo] **************************************
Monday 29 September 2025 19:21:00 +0000 (0:00:00.048) 0:00:17.219 ******
skipping: [instance]
TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Monday 29 September 2025 19:21:00 +0000 (0:00:00.050) 0:00:17.269 ******
skipping: [instance]
TASK [repo_setup : Run repo-setup-get-hash] ************************************
Monday 29 September 2025 19:21:00 +0000 (0:00:00.047) 0:00:17.317 ******
changed: [instance]
TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Monday 29 September 2025 19:21:01 +0000 (0:00:00.650) 0:00:17.968 ******
changed: [instance]
TASK [repo_setup : Dump current-podified hash] *********************************
Monday 29 September 2025 19:21:01 +0000 (0:00:00.405) 0:00:18.373 ******
skipping: [instance]
TASK [repo_setup : Slurp current podified hash] ********************************
Monday 29 September 2025 19:21:01 +0000 (0:00:00.037) 0:00:18.410 ******
skipping: [instance]
TASK [repo_setup : Update the value of full_hash] ******************************
Monday 29 September 2025 19:21:01 +0000 (0:00:00.032) 0:00:18.442 ******
skipping: [instance]
TASK [repo_setup : Export hashes facts for further use] ************************
Monday 29 September 2025 19:21:01 +0000 (0:00:00.031) 0:00:18.474 ******
ok: [instance]
TASK [repo_setup : Create download directory] **********************************
Monday 29 September 2025 19:21:01 +0000 (0:00:00.041) 0:00:18.516 ******
skipping: [instance]
TASK [repo_setup : Print the URL to request] ***********************************
Monday 29 September 2025 19:21:01 +0000 (0:00:00.029) 0:00:18.546 ******
skipping: [instance]
TASK [Download the RPM] ********************************************************
Monday 29 September 2025 19:21:01 +0000 (0:00:00.037) 0:00:18.583 ******
skipping: [instance]
TASK [repo_setup : Install RHOS Release tool] **********************************
Monday 29 September 2025 19:21:01 +0000 (0:00:00.039) 0:00:18.623 ******
skipping: [instance]
TASK [repo_setup : Get rhos-release tool version] ******************************
Monday 29 September 2025 19:21:01 +0000 (0:00:00.030) 0:00:18.653 ******
skipping: [instance]
TASK [repo_setup : Print rhos-release tool version] ****************************
Monday 29 September 2025 19:21:01 +0000 (0:00:00.032) 0:00:18.686 ******
skipping: [instance]
TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Monday 29 September 2025 19:21:01 +0000 (0:00:00.039) 0:00:18.725 ******
skipping: [instance]
TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Monday 29 September 2025 19:21:01 +0000 (0:00:00.030) 0:00:18.756 ******
ok: [instance]
TASK [repo_setup : Use RDO proxy mirrors] **************************************
Monday 29 September 2025 19:21:02 +0000 (0:00:00.217) 0:00:18.974 ******
changed: [instance]
TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Monday 29 September 2025 19:21:02 +0000 (0:00:00.247) 0:00:19.222 ******
changed: [instance]
TASK [repo_setup : Check for gating.repo file on content provider] *************
Monday 29 September 2025 19:21:02 +0000 (0:00:00.256) 0:00:19.478 ******
skipping: [instance]
TASK [repo_setup : Populate gating repo from content provider ip] **************
Monday 29 September 2025 19:21:02 +0000 (0:00:00.024) 0:00:19.503 ******
skipping: [instance]
TASK [repo_setup : Check for DLRN repo at the destination] *********************
Monday 29 September 2025 19:21:02 +0000 (0:00:00.026) 0:00:19.529 ******
skipping: [instance]
TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Monday 29 September 2025 19:21:02 +0000 (0:00:00.028) 0:00:19.557 ******
skipping: [instance]
TASK [repo_setup : Check for DLRN component repo] ******************************
Monday 29 September 2025 19:21:02 +0000 (0:00:00.028) 0:00:19.585 ******
skipping: [instance]
TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
Monday 29 September 2025 19:21:02 +0000 (0:00:00.028) 0:00:19.614 ******
skipping: [instance]
TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Monday 29 September 2025 19:21:02 +0000 (0:00:00.026) 0:00:19.641 ******
skipping: [instance]
TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Monday 29 September 2025 19:21:02 +0000 (0:00:00.021) 0:00:19.662 ******
skipping: [instance]
TASK [repo_setup : Cleanup existing metadata] **********************************
Monday 29 September 2025 19:21:02 +0000 (0:00:00.037) 0:00:19.700 ******
skipping: [instance]
TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Monday 29 September 2025 19:21:02 +0000 (0:00:00.022) 0:00:19.722 ******
skipping: [instance]
TASK [test_deps : Look for redhat-release rpm] *********************************
Monday 29 September 2025 19:21:02 +0000 (0:00:00.026) 0:00:19.749 ******
skipping: [instance]
TASK [test_deps : Remove redhat-release] ***************************************
Monday 29 September 2025 19:21:02 +0000 (0:00:00.035) 0:00:19.784 ******
skipping: [instance]
TASK [test_deps : Install centos-stream-release] *******************************
Monday 29 September 2025 19:21:03 +0000 (0:00:00.034) 0:00:19.818 ******
skipping: [instance]
TASK [test_deps : Install additional packages] *********************************
Monday 29 September 2025 19:21:03 +0000 (0:00:00.033) 0:00:19.852 ******
skipping: [instance]
TASK [test_deps : Install selinux python libs] *********************************
Monday 29 September 2025 19:21:03 +0000 (0:00:00.033) 0:00:19.885 ******
ok: [instance]
TASK [test_deps : Install python yaml libs] ************************************
Monday 29 September 2025 19:21:49 +0000 (0:00:46.875) 0:01:06.761 ******
ok: [instance]
TASK [test_deps : Install extra packages] **************************************
Monday 29 September 2025 19:21:51 +0000 (0:00:01.227) 0:01:07.989 ******
skipping: [instance]
TASK [ci_setup : Gather variables for each operating system] *******************
Monday 29 September 2025 19:21:51 +0000 (0:00:00.034) 0:01:08.023 ******
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 29 September 2025 19:21:51 +0000 (0:00:00.043) 0:01:08.067 ******
ok: [instance] =>
cifmw_ci_setup_packages:
- bash-completion
- ca-certificates
- git-core
- make
- tar
- tmux
- python3-pip
TASK [ci_setup : Install needed packages] **************************************
Monday 29 September 2025 19:21:51 +0000 (0:00:00.019) 0:01:08.086 ******
changed: [instance]
TASK [ci_setup : Gather version of openshift client] ***************************
Monday 29 September 2025 19:21:59 +0000 (0:00:07.990) 0:01:16.077 ******
ok: [instance]
TASK [ci_setup : Ensure openshift client install path is present] **************
Monday 29 September 2025 19:21:59 +0000 (0:00:00.630) 0:01:16.707 ******
changed: [instance]
TASK [ci_setup : Install openshift client] *************************************
Monday 29 September 2025 19:22:00 +0000 (0:00:00.226) 0:01:16.933 ******
changed: [instance]
TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
Monday 29 September 2025 19:22:06 +0000 (0:00:06.104) 0:01:23.038 ******
ok: [instance]
TASK [ci_setup : Create completion file] ***************************************
Monday 29 September 2025 19:22:06 +0000 (0:00:00.047) 0:01:23.085 ******
changed: [instance]
TASK [ci_setup : Source completion from within .bashrc] ************************
Monday 29 September 2025 19:22:06 +0000 (0:00:00.272) 0:01:23.358 ******
changed: [instance]
TASK [ci_setup : Check rhsm status] ********************************************
Monday 29 September 2025 19:22:06 +0000 (0:00:00.281) 0:01:23.639 ******
skipping: [instance]
TASK [ci_setup : Gather the repos to be enabled] *******************************
Monday 29 September 2025 19:22:06 +0000 (0:00:00.018) 0:01:23.658 ******
skipping: [instance]
TASK [ci_setup : Enabling the required repositories.] **************************
Monday 29 September 2025 19:22:06 +0000 (0:00:00.017) 0:01:23.675 ******
skipping: [instance]
TASK [ci_setup : Get current /etc/redhat-release] ******************************
Monday 29 September 2025 19:22:06 +0000 (0:00:00.018) 0:01:23.693 ******
skipping: [instance]
TASK [ci_setup : Print current /etc/redhat-release] ****************************
Monday 29 September 2025 19:22:06 +0000 (0:00:00.016) 0:01:23.710 ******
skipping: [instance]
TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
Monday 29 September 2025 19:22:06 +0000 (0:00:00.017) 0:01:23.727 ******
skipping: [instance]
TASK [ci_setup : Manage directories] *******************************************
Monday 29 September 2025 19:22:06 +0000 (0:00:00.022) 0:01:23.750 ******
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 [Check for CRC startup] ***************************************************
Monday 29 September 2025 19:22:07 +0000 (0:00:01.022) 0:01:24.772 ******
FAILED - RETRYING: [instance]: Check for CRC startup (120 retries left).
FAILED - RETRYING: [instance]: Check for CRC startup (119 retries left).
changed: [instance]
RUNNING HANDLER [Restart NetworkManager] ***************************************
Monday 29 September 2025 19:23:48 +0000 (0:01:40.767) 0:03:05.540 ******
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=33 changed=19 unreachable=0 failed=0 skipped=38 rescued=0 ignored=0
Monday 29 September 2025 19:23:49 +0000 (0:00:00.681) 0:03:06.221 ******
===============================================================================
Check for CRC startup ------------------------------------------------- 100.77s
test_deps : Install selinux python libs -------------------------------- 46.88s
repo_setup : Initialize python venv and install requirements ------------ 9.50s
ci_setup : Install needed packages -------------------------------------- 7.99s
ci_setup : Install openshift client ------------------------------------- 6.10s
test_deps : Install python yaml libs ------------------------------------ 1.23s
repo_setup : Get repo-setup repository ---------------------------------- 1.20s
ci_setup : Manage directories ------------------------------------------- 1.02s
repo_setup : Run repo-setup --------------------------------------------- 0.96s
repo_setup : Make sure git-core package is installed -------------------- 0.89s
Gathering Facts --------------------------------------------------------- 0.82s
repo_setup : Install repo-setup package --------------------------------- 0.74s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.71s
Restart NetworkManager -------------------------------------------------- 0.68s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.65s
ci_setup : Gather version of openshift client --------------------------- 0.63s
repo_setup : Ensure directories are present ----------------------------- 0.59s
Inject our own NetworkManager configuration ----------------------------- 0.57s
Start RHOL/CRC ---------------------------------------------------------- 0.42s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.41s
PLAY [Converge add_crc_creds] **************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:23:49 +0000 (0:00:00.045) 0:00:00.045 ******
ok: [instance]
TASK [Verify crc creds playbook] ***********************************************
Monday 29 September 2025 19:23:50 +0000 (0:00:00.907) 0:00:00.952 ******
TASK [rhol_crc : Make sure kubeconfig file exists] *****************************
Monday 29 September 2025 19:23:50 +0000 (0:00:00.029) 0:00:00.982 ******
ok: [instance]
TASK [rhol_crc : Warn the user that the kubeconfig files doesn't exist] ********
Monday 29 September 2025 19:23:51 +0000 (0:00:00.297) 0:00:01.279 ******
skipping: [instance]
TASK [rhol_crc : Add crc creds in the user bashrc file] ************************
Monday 29 September 2025 19:23:51 +0000 (0:00:00.027) 0:00:01.307 ******
changed: [instance]
TASK [rhol_crc : Source bashrc and confirm crc login] **************************
Monday 29 September 2025 19:23:51 +0000 (0:00:00.285) 0:00:01.593 ******
ok: [instance]
TASK [rhol_crc : Check bashrc results] *****************************************
Monday 29 September 2025 19:23:52 +0000 (0:00:00.577) 0:00:02.170 ******
ok: [instance] =>
bashrc_result.stdout: |-
/usr/local/bin/crc
system:admin
PLAY RECAP *********************************************************************
instance : ok=5 changed=1 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0
Monday 29 September 2025 19:23:52 +0000 (0:00:00.043) 0:00:02.213 ******
===============================================================================
Gathering Facts --------------------------------------------------------- 0.91s
rhol_crc : Source bashrc and confirm crc login -------------------------- 0.58s
rhol_crc : Make sure kubeconfig file exists ----------------------------- 0.30s
rhol_crc : Add crc creds in the user bashrc file ------------------------ 0.29s
rhol_crc : Check bashrc results ----------------------------------------- 0.04s
Verify crc creds playbook ----------------------------------------------- 0.03s
rhol_crc : Warn the user that the kubeconfig files doesn't exist -------- 0.03s
PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:23:52 +0000 (0:00:00.015) 0:00:00.015 ******
ok: [instance]
TASK [rhol_crc : Check RHOL/CRC binary exists] *********************************
Monday 29 September 2025 19:23:53 +0000 (0:00:00.870) 0:00:00.885 ******
ok: [instance]
TASK [rhol_crc : Delete RHOL/CRC instance and associated configuration] ********
Monday 29 September 2025 19:23:53 +0000 (0:00:00.280) 0:00:01.166 ******
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0
Monday 29 September 2025 19:23:57 +0000 (0:00:03.475) 0:00:04.641 ******
===============================================================================
rhol_crc : Delete RHOL/CRC instance and associated configuration -------- 3.48s
Gathering Facts --------------------------------------------------------- 0.87s
rhol_crc : Check RHOL/CRC binary exists --------------------------------- 0.28s
PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:24:14 +0000 (0:00:00.019) 0:00:00.019 ******
ok: [instance]
TASK [Setup libvirt] ***********************************************************
Monday 29 September 2025 19:24:15 +0000 (0:00:00.826) 0:00:00.845 ******
skipping: [instance]
TASK [Setup CRC] ***************************************************************
Monday 29 September 2025 19:24:15 +0000 (0:00:00.022) 0:00:00.867 ******
skipping: [instance]
TASK [Start RHOL/CRC] **********************************************************
Monday 29 September 2025 19:24:15 +0000 (0:00:00.021) 0:00:00.889 ******
skipping: [instance]
TASK [Inject our own NetworkManager configuration] *****************************
Monday 29 September 2025 19:24:15 +0000 (0:00:00.022) 0:00:00.911 ******
ok: [instance]
TASK [test_deps : Gather facts if they don't exist] ****************************
Monday 29 September 2025 19:24:16 +0000 (0:00:00.591) 0:00:01.503 ******
skipping: [instance]
TASK [test_deps : Gather variables for each operating system] ******************
Monday 29 September 2025 19:24:16 +0000 (0:00:00.019) 0:00:01.522 ******
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 29 September 2025 19:24:16 +0000 (0:00:00.043) 0:00:01.566 ******
ok: [instance]
TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Monday 29 September 2025 19:24:16 +0000 (0:00:00.188) 0:00:01.754 ******
ok: [instance]
TASK [test_deps : Disable ubi 9 repos] *****************************************
Monday 29 September 2025 19:24:16 +0000 (0:00:00.211) 0:00:01.966 ******
ok: [instance] => (item=ubi-9-appstream)
ok: [instance] => (item=ubi-9-baseos)
ok: [instance] => (item=ubi-9-codeready-builder)
TASK [Deploy repo-setup] *******************************************************
Monday 29 September 2025 19:24:17 +0000 (0:00:00.700) 0:00:02.667 ******
TASK [repo_setup : Ensure directories are present] *****************************
Monday 29 September 2025 19:24:17 +0000 (0:00:00.063) 0:00:02.730 ******
ok: [instance] => (item=tmp)
ok: [instance] => (item=artifacts/repositories)
ok: [instance] => (item=venv/repo_setup)
TASK [repo_setup : Make sure git-core package is installed] ********************
Monday 29 September 2025 19:24:18 +0000 (0:00:00.575) 0:00:03.306 ******
ok: [instance]
TASK [repo_setup : Get repo-setup repository] **********************************
Monday 29 September 2025 19:24:19 +0000 (0:00:01.381) 0:00:04.687 ******
ok: [instance]
TASK [repo_setup : Initialize python venv and install requirements] ************
Monday 29 September 2025 19:24:20 +0000 (0:00:00.605) 0:00:05.292 ******
ok: [instance]
TASK [repo_setup : Install repo-setup package] *********************************
Monday 29 September 2025 19:24:21 +0000 (0:00:01.316) 0:00:06.609 ******
ok: [instance]
TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Monday 29 September 2025 19:24:21 +0000 (0:00:00.306) 0:00:06.915 ******
skipping: [instance]
TASK [repo_setup : Run repo-setup] *********************************************
Monday 29 September 2025 19:24:21 +0000 (0:00:00.024) 0:00:06.940 ******
changed: [instance]
TASK [repo_setup : Get component repo] *****************************************
Monday 29 September 2025 19:24:22 +0000 (0:00:00.886) 0:00:07.827 ******
skipping: [instance]
TASK [repo_setup : Rename component repo] **************************************
Monday 29 September 2025 19:24:22 +0000 (0:00:00.041) 0:00:07.868 ******
skipping: [instance]
TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Monday 29 September 2025 19:24:22 +0000 (0:00:00.041) 0:00:07.909 ******
skipping: [instance]
TASK [repo_setup : Run repo-setup-get-hash] ************************************
Monday 29 September 2025 19:24:22 +0000 (0:00:00.040) 0:00:07.950 ******
changed: [instance]
TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Monday 29 September 2025 19:24:23 +0000 (0:00:00.563) 0:00:08.513 ******
ok: [instance]
TASK [repo_setup : Dump current-podified hash] *********************************
Monday 29 September 2025 19:24:23 +0000 (0:00:00.360) 0:00:08.873 ******
skipping: [instance]
TASK [repo_setup : Slurp current podified hash] ********************************
Monday 29 September 2025 19:24:23 +0000 (0:00:00.031) 0:00:08.904 ******
skipping: [instance]
TASK [repo_setup : Update the value of full_hash] ******************************
Monday 29 September 2025 19:24:23 +0000 (0:00:00.030) 0:00:08.935 ******
skipping: [instance]
TASK [repo_setup : Export hashes facts for further use] ************************
Monday 29 September 2025 19:24:23 +0000 (0:00:00.055) 0:00:08.990 ******
ok: [instance]
TASK [repo_setup : Create download directory] **********************************
Monday 29 September 2025 19:24:23 +0000 (0:00:00.042) 0:00:09.033 ******
skipping: [instance]
TASK [repo_setup : Print the URL to request] ***********************************
Monday 29 September 2025 19:24:23 +0000 (0:00:00.030) 0:00:09.063 ******
skipping: [instance]
TASK [Download the RPM] ********************************************************
Monday 29 September 2025 19:24:23 +0000 (0:00:00.030) 0:00:09.094 ******
skipping: [instance]
TASK [repo_setup : Install RHOS Release tool] **********************************
Monday 29 September 2025 19:24:23 +0000 (0:00:00.031) 0:00:09.125 ******
skipping: [instance]
TASK [repo_setup : Get rhos-release tool version] ******************************
Monday 29 September 2025 19:24:24 +0000 (0:00:00.031) 0:00:09.156 ******
skipping: [instance]
TASK [repo_setup : Print rhos-release tool version] ****************************
Monday 29 September 2025 19:24:24 +0000 (0:00:00.053) 0:00:09.209 ******
skipping: [instance]
TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Monday 29 September 2025 19:24:24 +0000 (0:00:00.031) 0:00:09.241 ******
skipping: [instance]
TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Monday 29 September 2025 19:24:24 +0000 (0:00:00.028) 0:00:09.269 ******
ok: [instance]
TASK [repo_setup : Use RDO proxy mirrors] **************************************
Monday 29 September 2025 19:24:24 +0000 (0:00:00.187) 0:00:09.456 ******
changed: [instance]
TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Monday 29 September 2025 19:24:24 +0000 (0:00:00.217) 0:00:09.674 ******
changed: [instance]
TASK [repo_setup : Check for gating.repo file on content provider] *************
Monday 29 September 2025 19:24:24 +0000 (0:00:00.232) 0:00:09.906 ******
skipping: [instance]
TASK [repo_setup : Populate gating repo from content provider ip] **************
Monday 29 September 2025 19:24:24 +0000 (0:00:00.022) 0:00:09.929 ******
skipping: [instance]
TASK [repo_setup : Check for DLRN repo at the destination] *********************
Monday 29 September 2025 19:24:24 +0000 (0:00:00.025) 0:00:09.955 ******
skipping: [instance]
TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Monday 29 September 2025 19:24:24 +0000 (0:00:00.025) 0:00:09.981 ******
skipping: [instance]
TASK [repo_setup : Check for DLRN component repo] ******************************
Monday 29 September 2025 19:24:24 +0000 (0:00:00.027) 0:00:10.008 ******
skipping: [instance]
TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
Monday 29 September 2025 19:24:24 +0000 (0:00:00.025) 0:00:10.034 ******
skipping: [instance]
TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Monday 29 September 2025 19:24:24 +0000 (0:00:00.026) 0:00:10.061 ******
skipping: [instance]
TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Monday 29 September 2025 19:24:24 +0000 (0:00:00.021) 0:00:10.083 ******
skipping: [instance]
TASK [repo_setup : Cleanup existing metadata] **********************************
Monday 29 September 2025 19:24:24 +0000 (0:00:00.032) 0:00:10.116 ******
skipping: [instance]
TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Monday 29 September 2025 19:24:24 +0000 (0:00:00.020) 0:00:10.136 ******
skipping: [instance]
TASK [test_deps : Look for redhat-release rpm] *********************************
Monday 29 September 2025 19:24:25 +0000 (0:00:00.027) 0:00:10.164 ******
skipping: [instance]
TASK [test_deps : Remove redhat-release] ***************************************
Monday 29 September 2025 19:24:25 +0000 (0:00:00.031) 0:00:10.195 ******
skipping: [instance]
TASK [test_deps : Install centos-stream-release] *******************************
Monday 29 September 2025 19:24:25 +0000 (0:00:00.032) 0:00:10.228 ******
skipping: [instance]
TASK [test_deps : Install additional packages] *********************************
Monday 29 September 2025 19:24:25 +0000 (0:00:00.033) 0:00:10.262 ******
skipping: [instance]
TASK [test_deps : Install selinux python libs] *********************************
Monday 29 September 2025 19:24:25 +0000 (0:00:00.031) 0:00:10.293 ******
ok: [instance]
TASK [test_deps : Install python yaml libs] ************************************
Monday 29 September 2025 19:25:25 +0000 (0:01:00.640) 0:01:10.934 ******
ok: [instance]
TASK [test_deps : Install extra packages] **************************************
Monday 29 September 2025 19:25:27 +0000 (0:00:01.256) 0:01:12.191 ******
skipping: [instance]
TASK [ci_setup : Gather variables for each operating system] *******************
Monday 29 September 2025 19:25:27 +0000 (0:00:00.034) 0:01:12.225 ******
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 29 September 2025 19:25:27 +0000 (0:00:00.046) 0:01:12.271 ******
ok: [instance] =>
cifmw_ci_setup_packages:
- bash-completion
- ca-certificates
- git-core
- make
- tar
- tmux
- python3-pip
TASK [ci_setup : Install needed packages] **************************************
Monday 29 September 2025 19:25:27 +0000 (0:00:00.020) 0:01:12.292 ******
ok: [instance]
TASK [ci_setup : Gather version of openshift client] ***************************
Monday 29 September 2025 19:25:28 +0000 (0:00:01.269) 0:01:13.561 ******
ok: [instance]
TASK [ci_setup : Ensure openshift client install path is present] **************
Monday 29 September 2025 19:25:28 +0000 (0:00:00.253) 0:01:13.815 ******
ok: [instance]
TASK [ci_setup : Install openshift client] *************************************
Monday 29 September 2025 19:25:28 +0000 (0:00:00.206) 0:01:14.021 ******
skipping: [instance]
TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
Monday 29 September 2025 19:25:28 +0000 (0:00:00.068) 0:01:14.090 ******
skipping: [instance]
TASK [ci_setup : Create completion file] ***************************************
Monday 29 September 2025 19:25:28 +0000 (0:00:00.037) 0:01:14.128 ******
ok: [instance]
TASK [ci_setup : Source completion from within .bashrc] ************************
Monday 29 September 2025 19:25:29 +0000 (0:00:00.185) 0:01:14.313 ******
changed: [instance]
TASK [ci_setup : Check rhsm status] ********************************************
Monday 29 September 2025 19:25:29 +0000 (0:00:00.286) 0:01:14.599 ******
skipping: [instance]
TASK [ci_setup : Gather the repos to be enabled] *******************************
Monday 29 September 2025 19:25:29 +0000 (0:00:00.018) 0:01:14.617 ******
skipping: [instance]
TASK [ci_setup : Enabling the required repositories.] **************************
Monday 29 September 2025 19:25:29 +0000 (0:00:00.018) 0:01:14.636 ******
skipping: [instance]
TASK [ci_setup : Get current /etc/redhat-release] ******************************
Monday 29 September 2025 19:25:29 +0000 (0:00:00.018) 0:01:14.654 ******
skipping: [instance]
TASK [ci_setup : Print current /etc/redhat-release] ****************************
Monday 29 September 2025 19:25:29 +0000 (0:00:00.018) 0:01:14.673 ******
skipping: [instance]
TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
Monday 29 September 2025 19:25:29 +0000 (0:00:00.018) 0:01:14.692 ******
skipping: [instance]
TASK [ci_setup : Manage directories] *******************************************
Monday 29 September 2025 19:25:29 +0000 (0:00:00.025) 0:01:14.717 ******
ok: [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)
ok: [instance] => (item=/home/zuul/ci-framework-data/volumes)
ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/parameters)
TASK [Check for CRC startup] ***************************************************
Monday 29 September 2025 19:25:30 +0000 (0:00:00.989) 0:01:15.707 ******
skipping: [instance]
PLAY RECAP *********************************************************************
instance : ok=28 changed=5 unreachable=0 failed=0 skipped=42 rescued=0 ignored=0
Monday 29 September 2025 19:25:30 +0000 (0:00:00.039) 0:01:15.746 ******
===============================================================================
test_deps : Install selinux python libs -------------------------------- 60.64s
repo_setup : Make sure git-core package is installed -------------------- 1.38s
repo_setup : Initialize python venv and install requirements ------------ 1.32s
ci_setup : Install needed packages -------------------------------------- 1.27s
test_deps : Install python yaml libs ------------------------------------ 1.26s
ci_setup : Manage directories ------------------------------------------- 0.99s
repo_setup : Run repo-setup --------------------------------------------- 0.89s
Gathering Facts --------------------------------------------------------- 0.83s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.70s
repo_setup : Get repo-setup repository ---------------------------------- 0.61s
Inject our own NetworkManager configuration ----------------------------- 0.59s
repo_setup : Ensure directories are present ----------------------------- 0.58s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.56s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.36s
repo_setup : Install repo-setup package --------------------------------- 0.31s
ci_setup : Source completion from within .bashrc ------------------------ 0.29s
ci_setup : Gather version of openshift client --------------------------- 0.25s
repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist) --- 0.23s
repo_setup : Use RDO proxy mirrors -------------------------------------- 0.22s
test_deps : Disable ubi host subscription-manager integration ----------- 0.21s
PLAY [Converge binary] *********************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:25:31 +0000 (0:00:00.015) 0:00:00.015 ******
ok: [instance]
TASK [rhol_crc : Create bin directory if it does not exist] ********************
Monday 29 September 2025 19:25:31 +0000 (0:00:00.832) 0:00:00.847 ******
ok: [instance]
TASK [rhol_crc : Create temporary directory for downloading RHOL/CRC] **********
Monday 29 September 2025 19:25:32 +0000 (0:00:00.309) 0:00:01.157 ******
changed: [instance]
TASK [rhol_crc : Download RHOL/CRC with sha256 checksum] ***********************
Monday 29 September 2025 19:25:32 +0000 (0:00:00.271) 0:00:01.429 ******
changed: [instance]
TASK [rhol_crc : Unarchive RHOL/CRC binary] ************************************
Monday 29 September 2025 19:25:37 +0000 (0:00:05.241) 0:00:06.670 ******
changed: [instance]
TASK [rhol_crc : Delete temporary directory for downloading RHOL/CRC] **********
Monday 29 September 2025 19:25:42 +0000 (0:00:05.100) 0:00:11.770 ******
ok: [instance]
TASK [rhol_crc : Get CRC binary version] ***************************************
Monday 29 September 2025 19:25:43 +0000 (0:00:00.181) 0:00:11.952 ******
changed: [instance]
TASK [rhol_crc : Extract versions] *********************************************
Monday 29 September 2025 19:25:43 +0000 (0:00:00.494) 0:00:12.446 ******
ok: [instance]
TASK [rhol_crc : Output found binary location and versions] ********************
Monday 29 September 2025 19:25:43 +0000 (0:00:00.036) 0:00:12.482 ******
ok: [instance] =>
msg: 'Found crc at /usr/local/bin/crc, with version 2.39.0 (wants: 2.39.0) and serving OpenShift version 4.16.0.'
PLAY [Verify get_version] ******************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:25:43 +0000 (0:00:00.048) 0:00:12.531 ******
ok: [instance]
TASK [Ensure facts are set and look correct] ***********************************
Monday 29 September 2025 19:25:44 +0000 (0:00:00.625) 0:00:13.157 ******
ok: [instance] => changed=false
msg: All assertions passed
PLAY RECAP *********************************************************************
instance : ok=11 changed=4 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0
Monday 29 September 2025 19:25:44 +0000 (0:00:00.042) 0:00:13.199 ******
===============================================================================
rhol_crc : Download RHOL/CRC with sha256 checksum ----------------------- 5.24s
rhol_crc : Unarchive RHOL/CRC binary ------------------------------------ 5.10s
Gathering Facts --------------------------------------------------------- 0.83s
Gathering Facts --------------------------------------------------------- 0.63s
rhol_crc : Get CRC binary version --------------------------------------- 0.49s
rhol_crc : Create bin directory if it does not exist -------------------- 0.31s
rhol_crc : Create temporary directory for downloading RHOL/CRC ---------- 0.27s
rhol_crc : Delete temporary directory for downloading RHOL/CRC ---------- 0.18s
rhol_crc : Output found binary location and versions -------------------- 0.05s
Ensure facts are set and look correct ----------------------------------- 0.04s
rhol_crc : Extract versions --------------------------------------------- 0.04s
PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:25:44 +0000 (0:00:00.015) 0:00:00.015 ******
ok: [instance]
TASK [Cleanup RHOL/CRC after tests] ********************************************
Monday 29 September 2025 19:25:45 +0000 (0:00:00.829) 0:00:00.845 ******
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=2 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0
Monday 29 September 2025 19:25:46 +0000 (0:00:00.437) 0:00:01.283 ******
===============================================================================
Gathering Facts --------------------------------------------------------- 0.83s
Cleanup RHOL/CRC after tests -------------------------------------------- 0.44s
PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:26:05 +0000 (0:00:00.019) 0:00:00.019 ******
ok: [instance]
TASK [Setup libvirt] ***********************************************************
Monday 29 September 2025 19:26:06 +0000 (0:00:00.843) 0:00:00.862 ******
skipping: [instance]
TASK [Setup CRC] ***************************************************************
Monday 29 September 2025 19:26:06 +0000 (0:00:00.022) 0:00:00.885 ******
skipping: [instance]
TASK [Start RHOL/CRC] **********************************************************
Monday 29 September 2025 19:26:06 +0000 (0:00:00.022) 0:00:00.907 ******
skipping: [instance]
TASK [Inject our own NetworkManager configuration] *****************************
Monday 29 September 2025 19:26:06 +0000 (0:00:00.021) 0:00:00.929 ******
ok: [instance]
TASK [test_deps : Gather facts if they don't exist] ****************************
Monday 29 September 2025 19:26:07 +0000 (0:00:00.641) 0:00:01.570 ******
skipping: [instance]
TASK [test_deps : Gather variables for each operating system] ******************
Monday 29 September 2025 19:26:07 +0000 (0:00:00.020) 0:00:01.591 ******
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 29 September 2025 19:26:07 +0000 (0:00:00.045) 0:00:01.637 ******
ok: [instance]
TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Monday 29 September 2025 19:26:07 +0000 (0:00:00.191) 0:00:01.829 ******
ok: [instance]
TASK [test_deps : Disable ubi 9 repos] *****************************************
Monday 29 September 2025 19:26:07 +0000 (0:00:00.233) 0:00:02.062 ******
ok: [instance] => (item=ubi-9-appstream)
ok: [instance] => (item=ubi-9-baseos)
ok: [instance] => (item=ubi-9-codeready-builder)
TASK [Deploy repo-setup] *******************************************************
Monday 29 September 2025 19:26:08 +0000 (0:00:00.692) 0:00:02.755 ******
TASK [repo_setup : Ensure directories are present] *****************************
Monday 29 September 2025 19:26:08 +0000 (0:00:00.064) 0:00:02.820 ******
ok: [instance] => (item=tmp)
ok: [instance] => (item=artifacts/repositories)
ok: [instance] => (item=venv/repo_setup)
TASK [repo_setup : Make sure git-core package is installed] ********************
Monday 29 September 2025 19:26:08 +0000 (0:00:00.572) 0:00:03.392 ******
ok: [instance]
TASK [repo_setup : Get repo-setup repository] **********************************
Monday 29 September 2025 19:26:10 +0000 (0:00:01.364) 0:00:04.757 ******
ok: [instance]
TASK [repo_setup : Initialize python venv and install requirements] ************
Monday 29 September 2025 19:26:10 +0000 (0:00:00.589) 0:00:05.347 ******
ok: [instance]
TASK [repo_setup : Install repo-setup package] *********************************
Monday 29 September 2025 19:26:12 +0000 (0:00:01.313) 0:00:06.660 ******
ok: [instance]
TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Monday 29 September 2025 19:26:12 +0000 (0:00:00.308) 0:00:06.968 ******
skipping: [instance]
TASK [repo_setup : Run repo-setup] *********************************************
Monday 29 September 2025 19:26:12 +0000 (0:00:00.024) 0:00:06.993 ******
changed: [instance]
TASK [repo_setup : Get component repo] *****************************************
Monday 29 September 2025 19:26:13 +0000 (0:00:00.912) 0:00:07.905 ******
skipping: [instance]
TASK [repo_setup : Rename component repo] **************************************
Monday 29 September 2025 19:26:13 +0000 (0:00:00.041) 0:00:07.947 ******
skipping: [instance]
TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Monday 29 September 2025 19:26:13 +0000 (0:00:00.041) 0:00:07.989 ******
skipping: [instance]
TASK [repo_setup : Run repo-setup-get-hash] ************************************
Monday 29 September 2025 19:26:13 +0000 (0:00:00.040) 0:00:08.029 ******
changed: [instance]
TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Monday 29 September 2025 19:26:14 +0000 (0:00:00.589) 0:00:08.619 ******
ok: [instance]
TASK [repo_setup : Dump current-podified hash] *********************************
Monday 29 September 2025 19:26:14 +0000 (0:00:00.372) 0:00:08.991 ******
skipping: [instance]
TASK [repo_setup : Slurp current podified hash] ********************************
Monday 29 September 2025 19:26:14 +0000 (0:00:00.033) 0:00:09.025 ******
skipping: [instance]
TASK [repo_setup : Update the value of full_hash] ******************************
Monday 29 September 2025 19:26:14 +0000 (0:00:00.033) 0:00:09.058 ******
skipping: [instance]
TASK [repo_setup : Export hashes facts for further use] ************************
Monday 29 September 2025 19:26:14 +0000 (0:00:00.032) 0:00:09.091 ******
ok: [instance]
TASK [repo_setup : Create download directory] **********************************
Monday 29 September 2025 19:26:14 +0000 (0:00:00.042) 0:00:09.133 ******
skipping: [instance]
TASK [repo_setup : Print the URL to request] ***********************************
Monday 29 September 2025 19:26:14 +0000 (0:00:00.031) 0:00:09.165 ******
skipping: [instance]
TASK [Download the RPM] ********************************************************
Monday 29 September 2025 19:26:14 +0000 (0:00:00.030) 0:00:09.196 ******
skipping: [instance]
TASK [repo_setup : Install RHOS Release tool] **********************************
Monday 29 September 2025 19:26:14 +0000 (0:00:00.030) 0:00:09.226 ******
skipping: [instance]
TASK [repo_setup : Get rhos-release tool version] ******************************
Monday 29 September 2025 19:26:14 +0000 (0:00:00.032) 0:00:09.259 ******
skipping: [instance]
TASK [repo_setup : Print rhos-release tool version] ****************************
Monday 29 September 2025 19:26:14 +0000 (0:00:00.030) 0:00:09.289 ******
skipping: [instance]
TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Monday 29 September 2025 19:26:14 +0000 (0:00:00.033) 0:00:09.323 ******
skipping: [instance]
TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Monday 29 September 2025 19:26:14 +0000 (0:00:00.030) 0:00:09.353 ******
ok: [instance]
TASK [repo_setup : Use RDO proxy mirrors] **************************************
Monday 29 September 2025 19:26:15 +0000 (0:00:00.203) 0:00:09.557 ******
changed: [instance]
TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Monday 29 September 2025 19:26:15 +0000 (0:00:00.219) 0:00:09.776 ******
changed: [instance]
TASK [repo_setup : Check for gating.repo file on content provider] *************
Monday 29 September 2025 19:26:15 +0000 (0:00:00.234) 0:00:10.010 ******
skipping: [instance]
TASK [repo_setup : Populate gating repo from content provider ip] **************
Monday 29 September 2025 19:26:15 +0000 (0:00:00.023) 0:00:10.033 ******
skipping: [instance]
TASK [repo_setup : Check for DLRN repo at the destination] *********************
Monday 29 September 2025 19:26:15 +0000 (0:00:00.025) 0:00:10.059 ******
skipping: [instance]
TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Monday 29 September 2025 19:26:15 +0000 (0:00:00.026) 0:00:10.085 ******
skipping: [instance]
TASK [repo_setup : Check for DLRN component repo] ******************************
Monday 29 September 2025 19:26:15 +0000 (0:00:00.025) 0:00:10.110 ******
skipping: [instance]
TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
Monday 29 September 2025 19:26:15 +0000 (0:00:00.025) 0:00:10.135 ******
skipping: [instance]
TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Monday 29 September 2025 19:26:15 +0000 (0:00:00.025) 0:00:10.161 ******
skipping: [instance]
TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Monday 29 September 2025 19:26:15 +0000 (0:00:00.020) 0:00:10.181 ******
skipping: [instance]
TASK [repo_setup : Cleanup existing metadata] **********************************
Monday 29 September 2025 19:26:15 +0000 (0:00:00.032) 0:00:10.214 ******
skipping: [instance]
TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Monday 29 September 2025 19:26:15 +0000 (0:00:00.021) 0:00:10.235 ******
skipping: [instance]
TASK [test_deps : Look for redhat-release rpm] *********************************
Monday 29 September 2025 19:26:15 +0000 (0:00:00.025) 0:00:10.261 ******
skipping: [instance]
TASK [test_deps : Remove redhat-release] ***************************************
Monday 29 September 2025 19:26:15 +0000 (0:00:00.031) 0:00:10.292 ******
skipping: [instance]
TASK [test_deps : Install centos-stream-release] *******************************
Monday 29 September 2025 19:26:15 +0000 (0:00:00.031) 0:00:10.324 ******
skipping: [instance]
TASK [test_deps : Install additional packages] *********************************
Monday 29 September 2025 19:26:15 +0000 (0:00:00.030) 0:00:10.355 ******
skipping: [instance]
TASK [test_deps : Install selinux python libs] *********************************
Monday 29 September 2025 19:26:15 +0000 (0:00:00.030) 0:00:10.386 ******
ok: [instance]
TASK [test_deps : Install python yaml libs] ************************************
Monday 29 September 2025 19:26:57 +0000 (0:00:41.181) 0:00:51.568 ******
ok: [instance]
TASK [test_deps : Install extra packages] **************************************
Monday 29 September 2025 19:26:58 +0000 (0:00:01.267) 0:00:52.835 ******
skipping: [instance]
TASK [ci_setup : Gather variables for each operating system] *******************
Monday 29 September 2025 19:26:58 +0000 (0:00:00.037) 0:00:52.873 ******
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 29 September 2025 19:26:58 +0000 (0:00:00.047) 0:00:52.921 ******
ok: [instance] =>
cifmw_ci_setup_packages:
- bash-completion
- ca-certificates
- git-core
- make
- tar
- tmux
- python3-pip
TASK [ci_setup : Install needed packages] **************************************
Monday 29 September 2025 19:26:58 +0000 (0:00:00.022) 0:00:52.943 ******
ok: [instance]
TASK [ci_setup : Gather version of openshift client] ***************************
Monday 29 September 2025 19:26:59 +0000 (0:00:01.242) 0:00:54.185 ******
ok: [instance]
TASK [ci_setup : Ensure openshift client install path is present] **************
Monday 29 September 2025 19:26:59 +0000 (0:00:00.261) 0:00:54.446 ******
ok: [instance]
TASK [ci_setup : Install openshift client] *************************************
Monday 29 September 2025 19:27:00 +0000 (0:00:00.202) 0:00:54.649 ******
skipping: [instance]
TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
Monday 29 September 2025 19:27:00 +0000 (0:00:00.062) 0:00:54.711 ******
skipping: [instance]
TASK [ci_setup : Create completion file] ***************************************
Monday 29 September 2025 19:27:00 +0000 (0:00:00.034) 0:00:54.745 ******
ok: [instance]
TASK [ci_setup : Source completion from within .bashrc] ************************
Monday 29 September 2025 19:27:00 +0000 (0:00:00.184) 0:00:54.930 ******
ok: [instance]
TASK [ci_setup : Check rhsm status] ********************************************
Monday 29 September 2025 19:27:00 +0000 (0:00:00.296) 0:00:55.226 ******
skipping: [instance]
TASK [ci_setup : Gather the repos to be enabled] *******************************
Monday 29 September 2025 19:27:00 +0000 (0:00:00.018) 0:00:55.245 ******
skipping: [instance]
TASK [ci_setup : Enabling the required repositories.] **************************
Monday 29 September 2025 19:27:00 +0000 (0:00:00.018) 0:00:55.264 ******
skipping: [instance]
TASK [ci_setup : Get current /etc/redhat-release] ******************************
Monday 29 September 2025 19:27:00 +0000 (0:00:00.017) 0:00:55.281 ******
skipping: [instance]
TASK [ci_setup : Print current /etc/redhat-release] ****************************
Monday 29 September 2025 19:27:00 +0000 (0:00:00.018) 0:00:55.300 ******
skipping: [instance]
TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
Monday 29 September 2025 19:27:00 +0000 (0:00:00.018) 0:00:55.318 ******
skipping: [instance]
TASK [ci_setup : Manage directories] *******************************************
Monday 29 September 2025 19:27:00 +0000 (0:00:00.026) 0:00:55.344 ******
ok: [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)
ok: [instance] => (item=/home/zuul/ci-framework-data/volumes)
ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/parameters)
TASK [Check for CRC startup] ***************************************************
Monday 29 September 2025 19:27:01 +0000 (0:00:01.002) 0:00:56.347 ******
skipping: [instance]
PLAY RECAP *********************************************************************
instance : ok=28 changed=4 unreachable=0 failed=0 skipped=42 rescued=0 ignored=0
Monday 29 September 2025 19:27:01 +0000 (0:00:00.037) 0:00:56.384 ******
===============================================================================
test_deps : Install selinux python libs -------------------------------- 41.18s
repo_setup : Make sure git-core package is installed -------------------- 1.36s
repo_setup : Initialize python venv and install requirements ------------ 1.31s
test_deps : Install python yaml libs ------------------------------------ 1.27s
ci_setup : Install needed packages -------------------------------------- 1.24s
ci_setup : Manage directories ------------------------------------------- 1.00s
repo_setup : Run repo-setup --------------------------------------------- 0.91s
Gathering Facts --------------------------------------------------------- 0.84s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.69s
Inject our own NetworkManager configuration ----------------------------- 0.64s
repo_setup : Get repo-setup repository ---------------------------------- 0.59s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.59s
repo_setup : Ensure directories are present ----------------------------- 0.57s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.37s
repo_setup : Install repo-setup package --------------------------------- 0.31s
ci_setup : Source completion from within .bashrc ------------------------ 0.30s
ci_setup : Gather version of openshift client --------------------------- 0.26s
repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist) --- 0.23s
test_deps : Disable ubi host subscription-manager integration ----------- 0.23s
repo_setup : Use RDO proxy mirrors -------------------------------------- 0.22s
PLAY [Converge default] ********************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:27:02 +0000 (0:00:00.031) 0:00:00.031 ******
ok: [instance]
TASK [rhol_crc : Ensure directories exist] *************************************
Monday 29 September 2025 19:27:03 +0000 (0:00:00.814) 0:00:00.845 ******
ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts)
ok: [instance] => (item=/home/zuul/ci-framework-data/logs)
ok: [instance] => (item=/usr/local/bin)
TASK [manage_secrets : Ensure directory tree exist] ****************************
Monday 29 September 2025 19:27:03 +0000 (0:00:00.654) 0:00:01.500 ******
changed: [instance]
TASK [rhol_crc : Check for binary] *********************************************
Monday 29 September 2025 19:27:04 +0000 (0:00:00.210) 0:00:01.710 ******
ok: [instance]
TASK [rhol_crc : Get versions if binary is available] **************************
Monday 29 September 2025 19:27:04 +0000 (0:00:00.269) 0:00:01.979 ******
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/rhol_crc/tasks/get_versions.yml for instance
TASK [rhol_crc : Get CRC binary version] ***************************************
Monday 29 September 2025 19:27:04 +0000 (0:00:00.065) 0:00:02.045 ******
changed: [instance]
TASK [rhol_crc : Extract versions] *********************************************
Monday 29 September 2025 19:27:04 +0000 (0:00:00.477) 0:00:02.522 ******
ok: [instance]
TASK [rhol_crc : Output found binary location and versions] ********************
Monday 29 September 2025 19:27:04 +0000 (0:00:00.037) 0:00:02.560 ******
ok: [instance] =>
msg: 'Found crc at /usr/local/bin/crc, with version 2.39.0 (wants: 2.39.0) and serving OpenShift version 4.16.0.'
TASK [rhol_crc : Get CRC VM availability] **************************************
Monday 29 September 2025 19:27:04 +0000 (0:00:00.021) 0:00:02.581 ******
ok: [instance]
TASK [rhol_crc : Set CRC status] ***********************************************
Monday 29 September 2025 19:27:05 +0000 (0:00:00.334) 0:00:02.916 ******
ok: [instance]
TASK [rhol_crc : Fail if crc domain is already defined] ************************
Monday 29 September 2025 19:27:05 +0000 (0:00:00.026) 0:00:02.942 ******
skipping: [instance]
TASK [Ensure pull-secret is in place if we need to configure CRC] **************
Monday 29 September 2025 19:27:05 +0000 (0:00:00.026) 0:00:02.969 ******
TASK [manage_secrets : Assert we get needed data] ******************************
Monday 29 September 2025 19:27:05 +0000 (0:00:00.042) 0:00:03.012 ******
ok: [instance]
TASK [manage_secrets : Manage secret] ******************************************
Monday 29 September 2025 19:27:05 +0000 (0:00:00.023) 0:00:03.035 ******
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/manage_secrets/tasks/_push_secret.yml for instance
TASK [manage_secrets : Debug _secret_dest] *************************************
Monday 29 September 2025 19:27:05 +0000 (0:00:00.026) 0:00:03.062 ******
ok: [instance] =>
_secret_dest: /home/zuul/pull-secret.json
TASK [manage_secrets : Debug _secret_file] *************************************
Monday 29 September 2025 19:27:05 +0000 (0:00:00.023) 0:00:03.086 ******
ok: [instance] =>
_secret_file: ''
TASK [manage_secrets : Debug _secret_content] **********************************
Monday 29 September 2025 19:27:05 +0000 (0:00:00.021) 0:00:03.107 ******
ok: [instance] =>
_secret_content:
auths:
fake:
auth: Zm9vOmJhcgo=
TASK [manage_secrets : Ensure parameter is an absolute path] *******************
Monday 29 September 2025 19:27:05 +0000 (0:00:00.020) 0:00:03.128 ******
skipping: [instance]
TASK [manage_secrets : Check if pull secret src file exists] *******************
Monday 29 September 2025 19:27:05 +0000 (0:00:00.017) 0:00:03.145 ******
skipping: [instance]
TASK [manage_secrets : Copy file to location] **********************************
Monday 29 September 2025 19:27:05 +0000 (0:00:00.017) 0:00:03.162 ******
skipping: [instance]
TASK [manage_secrets : Create file from content] *******************************
Monday 29 September 2025 19:27:05 +0000 (0:00:00.016) 0:00:03.179 ******
changed: [instance]
TASK [rhol_crc : Get wanted RHOL/CRC version binary if needed] *****************
Monday 29 September 2025 19:27:06 +0000 (0:00:00.456) 0:00:03.635 ******
skipping: [instance]
TASK [rhol_crc : Setup sudoers file for sudo commands in RHOL/CRC setup] *******
Monday 29 September 2025 19:27:06 +0000 (0:00:00.034) 0:00:03.670 ******
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/rhol_crc/tasks/sudoers_grant.yml for instance
TASK [rhol_crc : Add passwordless sudo access for CRC commands] ****************
Monday 29 September 2025 19:27:06 +0000 (0:00:00.036) 0:00:03.706 ******
changed: [instance]
TASK [rhol_crc : Clean RHOL/CRC if wanted] *************************************
Monday 29 September 2025 19:27:06 +0000 (0:00:00.313) 0:00:04.020 ******
skipping: [instance]
TASK [rhol_crc : Set RHOL/CRC configuration options] ***************************
Monday 29 September 2025 19:27:06 +0000 (0:00:00.028) 0:00:04.049 ******
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/rhol_crc/tasks/configuration.yml for instance
TASK [rhol_crc : Set RHOL/CRC configuration options] ***************************
Monday 29 September 2025 19:27:06 +0000 (0:00:00.036) 0:00:04.085 ******
changed: [instance] => (item={'key': 'consent-telemetry', 'value': 'no'})
changed: [instance] => (item={'key': 'disk-size', 'value': 32})
changed: [instance] => (item={'key': 'memory', 'value': 10752})
changed: [instance] => (item={'key': 'cpus', 'value': 4})
changed: [instance] => (item={'key': 'preset', 'value': 'openshift'})
changed: [instance] => (item={'key': 'pull-secret-file', 'value': '/home/zuul/pull-secret.json'})
changed: [instance] => (item={'key': 'skip-check-daemon-systemd-unit', 'value': True})
changed: [instance] => (item={'key': 'skip-check-daemon-systemd-sockets', 'value': True})
changed: [instance] => (item={'key': 'kubeadmin-password', 'value': 12345678})
TASK [rhol_crc : Setup RHOL/CRC] ***********************************************
Monday 29 September 2025 19:27:08 +0000 (0:00:01.857) 0:00:05.943 ******
changed: [instance]
TASK [rhol_crc : Start RHOL/CRC] ***********************************************
Monday 29 September 2025 19:31:24 +0000 (0:04:15.996) 0:04:21.939 ******
fatal: [instance]: FAILED! => changed=true
cmd: set -o pipefail; /usr/local/bin/crc start 2>&1 | tee /home/zuul/ci-framework-data/logs/crc-start.log
delta: '0:17:02.185665'
end: '2025-09-29 19:48:26.728209'
msg: non-zero return code
rc: 1
start: '2025-09-29 19:31:24.542544'
stderr: ''
stderr_lines: <omitted>
stdout: |-
level=warning msg="A new version (2.54.0) has been published on https://developers.redhat.com/content-gateway/file/pub/openshift-v4/clients/crc/2.54.0/crc-linux-amd64.tar.xz"
level=info msg="Using bundle path /home/zuul/.crc/cache/crc_libvirt_4.16.0_amd64.crcbundle"
level=info msg="Checking if running as non-root"
level=info msg="Checking if running inside WSL2"
level=info msg="Checking if crc-admin-helper executable is cached"
level=info msg="Checking if running on a supported CPU architecture"
level=info msg="Checking if crc executable symlink exists"
level=info msg="Checking minimum RAM requirements"
level=info msg="Check if Podman binary exists in: /home/zuul/.crc/bin/oc"
level=info msg="Checking if Virtualization is enabled"
level=info msg="Checking if KVM is enabled"
level=info msg="Checking if libvirt is installed"
level=info msg="Checking if user is part of libvirt group"
level=info msg="Checking if active user/process is currently part of the libvirt group"
level=info msg="Checking if libvirt daemon is running"
level=info msg="Checking if a supported libvirt version is installed"
level=info msg="Checking if crc-driver-libvirt is installed"
level=info msg="Checking crc daemon systemd socket units"
level=warning msg="Skipping above check..."
level=info msg="Checking if systemd-networkd is running"
level=info msg="Checking if NetworkManager is installed"
level=info msg="Checking if NetworkManager service is running"
level=info msg="Checking if /etc/NetworkManager/conf.d/crc-nm-dnsmasq.conf exists"
level=info msg="Checking if /etc/NetworkManager/dnsmasq.d/crc.conf exists"
level=info msg="Checking if libvirt 'crc' network is available"
level=info msg="Checking if libvirt 'crc' network is active"
level=info msg="Loading bundle: crc_libvirt_4.16.0_amd64..."
level=info msg="Creating CRC VM for OpenShift 4.16.0..."
level=info msg="Generating new SSH key pair..."
level=info msg="Generating new password for the kubeadmin user"
level=info msg="Starting CRC VM for openshift 4.16.0..."
level=info msg="CRC instance is running with IP 192.168.130.11"
level=info msg="CRC VM is running"
level=info msg="Updating authorized keys..."
level=info msg="Resizing /dev/vda4 filesystem"
level=info msg="Configuring shared directories"
level=info msg="Check internal and public DNS query..."
level=info msg="Check DNS query from host..."
level=info msg="Verifying validity of the kubelet certificates..."
level=info msg="Starting kubelet service"
level=info msg="Kubelet client certificate has expired, renewing it... [will take up to 10 minutes]"
Failed to renew TLS certificates: please check if a newer CRC release is available: Temporary error: No Pending CSR with signerName kubernetes.io/kubelet-serving (x112)
stdout_lines: <omitted>
TASK [rhol_crc : Revoke permissions granted in sudoers file for CRC/RHOL setup] ***
Monday 29 September 2025 19:48:26 +0000 (0:17:02.410) 0:21:24.349 ******
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=22 changed=7 unreachable=0 failed=1 skipped=6 rescued=0 ignored=0
Monday 29 September 2025 19:48:26 +0000 (0:00:00.213) 0:21:24.562 ******
===============================================================================
rhol_crc : Start RHOL/CRC -------------------------------------------- 1022.41s
rhol_crc : Setup RHOL/CRC --------------------------------------------- 256.00s
rhol_crc : Set RHOL/CRC configuration options --------------------------- 1.86s
Gathering Facts --------------------------------------------------------- 0.81s
rhol_crc : Ensure directories exist ------------------------------------- 0.65s
rhol_crc : Get CRC binary version --------------------------------------- 0.48s
manage_secrets : Create file from content ------------------------------- 0.46s
rhol_crc : Get CRC VM availability -------------------------------------- 0.33s
rhol_crc : Add passwordless sudo access for CRC commands ---------------- 0.31s
rhol_crc : Check for binary --------------------------------------------- 0.27s
rhol_crc : Revoke permissions granted in sudoers file for CRC/RHOL setup --- 0.21s
manage_secrets : Ensure directory tree exist ---------------------------- 0.21s
rhol_crc : Get versions if binary is available -------------------------- 0.07s
Ensure pull-secret is in place if we need to configure CRC -------------- 0.04s
rhol_crc : Extract versions --------------------------------------------- 0.04s
rhol_crc : Setup sudoers file for sudo commands in RHOL/CRC setup ------- 0.04s
rhol_crc : Set RHOL/CRC configuration options --------------------------- 0.04s
rhol_crc : Get wanted RHOL/CRC version binary if needed ----------------- 0.03s
rhol_crc : Clean RHOL/CRC if wanted ------------------------------------- 0.03s
rhol_crc : Fail if crc domain is already defined ------------------------ 0.03s
PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:48:27 +0000 (0:00:00.017) 0:00:00.017 ******
ok: [instance]
TASK [rhol_crc : Check RHOL/CRC binary exists] *********************************
Monday 29 September 2025 19:48:28 +0000 (0:00:00.925) 0:00:00.942 ******
ok: [instance]
TASK [rhol_crc : Delete RHOL/CRC instance and associated configuration] ********
Monday 29 September 2025 19:48:28 +0000 (0:00:00.288) 0:00:01.231 ******
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0
Monday 29 September 2025 19:48:31 +0000 (0:00:02.852) 0:00:04.084 ******
===============================================================================
rhol_crc : Delete RHOL/CRC instance and associated configuration -------- 2.85s
Gathering Facts --------------------------------------------------------- 0.93s
rhol_crc : Check RHOL/CRC binary exists --------------------------------- 0.29s