PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:10:24 +0000 (0:00:00.015) 0:00:00.015 ******
ok: [instance]
TASK [Setup libvirt] ***********************************************************
Monday 29 September 2025 19:10:25 +0000 (0:00:00.893) 0:00:00.908 ******
skipping: [instance]
TASK [Setup CRC] ***************************************************************
Monday 29 September 2025 19:10:25 +0000 (0:00:00.025) 0:00:00.933 ******
skipping: [instance]
TASK [Start RHOL/CRC] **********************************************************
Monday 29 September 2025 19:10:25 +0000 (0:00:00.024) 0:00:00.957 ******
changed: [instance]
TASK [Inject our own NetworkManager configuration] *****************************
Monday 29 September 2025 19:10:26 +0000 (0:00:00.455) 0:00:01.413 ******
changed: [instance]
TASK [test_deps : Gather facts if they don't exist] ****************************
Monday 29 September 2025 19:10:26 +0000 (0:00:00.635) 0:00:02.049 ******
skipping: [instance]
TASK [test_deps : Gather variables for each operating system] ******************
Monday 29 September 2025 19:10:26 +0000 (0:00:00.023) 0:00:02.073 ******
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:10:26 +0000 (0:00:00.048) 0:00:02.122 ******
ok: [instance]
TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Monday 29 September 2025 19:10:27 +0000 (0:00:00.208) 0:00:02.330 ******
ok: [instance]
TASK [test_deps : Disable ubi 9 repos] *****************************************
Monday 29 September 2025 19:10:27 +0000 (0:00:00.368) 0:00:02.698 ******
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:10:28 +0000 (0:00:00.794) 0:00:03.493 ******
TASK [repo_setup : Ensure directories are present] *****************************
Monday 29 September 2025 19:10:28 +0000 (0:00:00.089) 0:00:03.582 ******
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:10:29 +0000 (0:00:00.673) 0:00:04.256 ******
ok: [instance]
TASK [repo_setup : Get repo-setup repository] **********************************
Monday 29 September 2025 19:10:30 +0000 (0:00:00.949) 0:00:05.205 ******
changed: [instance]
TASK [repo_setup : Initialize python venv and install requirements] ************
Monday 29 September 2025 19:10:31 +0000 (0:00:01.252) 0:00:06.458 ******
changed: [instance]
TASK [repo_setup : Install repo-setup package] *********************************
Monday 29 September 2025 19:10:40 +0000 (0:00:09.093) 0:00:15.552 ******
changed: [instance]
TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Monday 29 September 2025 19:10:41 +0000 (0:00:00.796) 0:00:16.348 ******
skipping: [instance]
TASK [repo_setup : Run repo-setup] *********************************************
Monday 29 September 2025 19:10:41 +0000 (0:00:00.027) 0:00:16.376 ******
changed: [instance]
TASK [repo_setup : Get component repo] *****************************************
Monday 29 September 2025 19:10:42 +0000 (0:00:01.005) 0:00:17.382 ******
skipping: [instance]
TASK [repo_setup : Rename component repo] **************************************
Monday 29 September 2025 19:10:42 +0000 (0:00:00.041) 0:00:17.424 ******
skipping: [instance]
TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Monday 29 September 2025 19:10:42 +0000 (0:00:00.043) 0:00:17.468 ******
skipping: [instance]
TASK [repo_setup : Run repo-setup-get-hash] ************************************
Monday 29 September 2025 19:10:42 +0000 (0:00:00.038) 0:00:17.506 ******
changed: [instance]
TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Monday 29 September 2025 19:10:42 +0000 (0:00:00.609) 0:00:18.115 ******
changed: [instance]
TASK [repo_setup : Dump current-podified hash] *********************************
Monday 29 September 2025 19:10:43 +0000 (0:00:00.421) 0:00:18.536 ******
skipping: [instance]
TASK [repo_setup : Slurp current podified hash] ********************************
Monday 29 September 2025 19:10:43 +0000 (0:00:00.037) 0:00:18.574 ******
skipping: [instance]
TASK [repo_setup : Update the value of full_hash] ******************************
Monday 29 September 2025 19:10:43 +0000 (0:00:00.038) 0:00:18.613 ******
skipping: [instance]
TASK [repo_setup : Export hashes facts for further use] ************************
Monday 29 September 2025 19:10:43 +0000 (0:00:00.035) 0:00:18.648 ******
ok: [instance]
TASK [repo_setup : Create download directory] **********************************
Monday 29 September 2025 19:10:43 +0000 (0:00:00.053) 0:00:18.702 ******
skipping: [instance]
TASK [repo_setup : Print the URL to request] ***********************************
Monday 29 September 2025 19:10:43 +0000 (0:00:00.032) 0:00:18.734 ******
skipping: [instance]
TASK [Download the RPM] ********************************************************
Monday 29 September 2025 19:10:43 +0000 (0:00:00.031) 0:00:18.766 ******
skipping: [instance]
TASK [repo_setup : Install RHOS Release tool] **********************************
Monday 29 September 2025 19:10:43 +0000 (0:00:00.033) 0:00:18.799 ******
skipping: [instance]
TASK [repo_setup : Get rhos-release tool version] ******************************
Monday 29 September 2025 19:10:43 +0000 (0:00:00.034) 0:00:18.833 ******
skipping: [instance]
TASK [repo_setup : Print rhos-release tool version] ****************************
Monday 29 September 2025 19:10:43 +0000 (0:00:00.031) 0:00:18.865 ******
skipping: [instance]
TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Monday 29 September 2025 19:10:43 +0000 (0:00:00.034) 0:00:18.900 ******
skipping: [instance]
TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Monday 29 September 2025 19:10:43 +0000 (0:00:00.032) 0:00:18.932 ******
ok: [instance]
TASK [repo_setup : Use RDO proxy mirrors] **************************************
Monday 29 September 2025 19:10:43 +0000 (0:00:00.220) 0:00:19.152 ******
changed: [instance]
TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Monday 29 September 2025 19:10:44 +0000 (0:00:00.276) 0:00:19.429 ******
changed: [instance]
TASK [repo_setup : Check for gating.repo file on content provider] *************
Monday 29 September 2025 19:10:44 +0000 (0:00:00.276) 0:00:19.705 ******
skipping: [instance]
TASK [repo_setup : Populate gating repo from content provider ip] **************
Monday 29 September 2025 19:10:44 +0000 (0:00:00.026) 0:00:19.732 ******
skipping: [instance]
TASK [repo_setup : Check for DLRN repo at the destination] *********************
Monday 29 September 2025 19:10:44 +0000 (0:00:00.028) 0:00:19.761 ******
skipping: [instance]
TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Monday 29 September 2025 19:10:44 +0000 (0:00:00.032) 0:00:19.793 ******
skipping: [instance]
TASK [repo_setup : Check for DLRN component repo] ******************************
Monday 29 September 2025 19:10:44 +0000 (0:00:00.030) 0:00:19.823 ******
skipping: [instance]
TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
Monday 29 September 2025 19:10:44 +0000 (0:00:00.031) 0:00:19.855 ******
skipping: [instance]
TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Monday 29 September 2025 19:10:44 +0000 (0:00:00.030) 0:00:19.886 ******
skipping: [instance]
TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Monday 29 September 2025 19:10:44 +0000 (0:00:00.024) 0:00:19.910 ******
skipping: [instance]
TASK [repo_setup : Cleanup existing metadata] **********************************
Monday 29 September 2025 19:10:44 +0000 (0:00:00.037) 0:00:19.947 ******
skipping: [instance]
TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Monday 29 September 2025 19:10:44 +0000 (0:00:00.022) 0:00:19.970 ******
skipping: [instance]
TASK [test_deps : Look for redhat-release rpm] *********************************
Monday 29 September 2025 19:10:44 +0000 (0:00:00.028) 0:00:19.999 ******
skipping: [instance]
TASK [test_deps : Remove redhat-release] ***************************************
Monday 29 September 2025 19:10:44 +0000 (0:00:00.037) 0:00:20.037 ******
skipping: [instance]
TASK [test_deps : Install centos-stream-release] *******************************
Monday 29 September 2025 19:10:44 +0000 (0:00:00.037) 0:00:20.074 ******
skipping: [instance]
TASK [test_deps : Install additional packages] *********************************
Monday 29 September 2025 19:10:44 +0000 (0:00:00.038) 0:00:20.112 ******
skipping: [instance]
TASK [test_deps : Install selinux python libs] *********************************
Monday 29 September 2025 19:10:44 +0000 (0:00:00.038) 0:00:20.151 ******
ok: [instance]
TASK [test_deps : Install python yaml libs] ************************************
Monday 29 September 2025 19:11:35 +0000 (0:00:50.542) 0:01:10.693 ******
ok: [instance]
TASK [test_deps : Install extra packages] **************************************
Monday 29 September 2025 19:11:37 +0000 (0:00:01.527) 0:01:12.221 ******
skipping: [instance]
TASK [ci_setup : Gather variables for each operating system] *******************
Monday 29 September 2025 19:11:37 +0000 (0:00:00.044) 0:01:12.265 ******
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:11:37 +0000 (0:00:00.055) 0:01:12.321 ******
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:11:37 +0000 (0:00:00.026) 0:01:12.348 ******
changed: [instance]
TASK [ci_setup : Gather version of openshift client] ***************************
Monday 29 September 2025 19:11:46 +0000 (0:00:09.578) 0:01:21.926 ******
ok: [instance]
TASK [ci_setup : Ensure openshift client install path is present] **************
Monday 29 September 2025 19:11:47 +0000 (0:00:00.596) 0:01:22.522 ******
changed: [instance]
TASK [ci_setup : Install openshift client] *************************************
Monday 29 September 2025 19:11:47 +0000 (0:00:00.251) 0:01:22.773 ******
changed: [instance]
TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
Monday 29 September 2025 19:11:54 +0000 (0:00:06.534) 0:01:29.308 ******
ok: [instance]
TASK [ci_setup : Create completion file] ***************************************
Monday 29 September 2025 19:11:54 +0000 (0:00:00.055) 0:01:29.363 ******
changed: [instance]
TASK [ci_setup : Source completion from within .bashrc] ************************
Monday 29 September 2025 19:11:54 +0000 (0:00:00.339) 0:01:29.703 ******
changed: [instance]
TASK [ci_setup : Check rhsm status] ********************************************
Monday 29 September 2025 19:11:54 +0000 (0:00:00.351) 0:01:30.055 ******
skipping: [instance]
TASK [ci_setup : Gather the repos to be enabled] *******************************
Monday 29 September 2025 19:11:54 +0000 (0:00:00.023) 0:01:30.078 ******
skipping: [instance]
TASK [ci_setup : Enabling the required repositories.] **************************
Monday 29 September 2025 19:11:54 +0000 (0:00:00.023) 0:01:30.102 ******
skipping: [instance]
TASK [ci_setup : Get current /etc/redhat-release] ******************************
Monday 29 September 2025 19:11:54 +0000 (0:00:00.023) 0:01:30.125 ******
skipping: [instance]
TASK [ci_setup : Print current /etc/redhat-release] ****************************
Monday 29 September 2025 19:11:54 +0000 (0:00:00.023) 0:01:30.149 ******
skipping: [instance]
TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
Monday 29 September 2025 19:11:54 +0000 (0:00:00.023) 0:01:30.172 ******
skipping: [instance]
TASK [ci_setup : Manage directories] *******************************************
Monday 29 September 2025 19:11:55 +0000 (0:00:00.031) 0:01:30.204 ******
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:11:56 +0000 (0:00:01.234) 0:01:31.438 ******
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:13:37 +0000 (0:01:40.816) 0:03:12.254 ******
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=33 changed=19 unreachable=0 failed=0 skipped=38 rescued=0 ignored=0
Monday 29 September 2025 19:13:37 +0000 (0:00:00.757) 0:03:13.012 ******
===============================================================================
Check for CRC startup ------------------------------------------------- 100.82s
test_deps : Install selinux python libs -------------------------------- 50.54s
ci_setup : Install needed packages -------------------------------------- 9.58s
repo_setup : Initialize python venv and install requirements ------------ 9.09s
ci_setup : Install openshift client ------------------------------------- 6.53s
test_deps : Install python yaml libs ------------------------------------ 1.53s
repo_setup : Get repo-setup repository ---------------------------------- 1.25s
ci_setup : Manage directories ------------------------------------------- 1.23s
repo_setup : Run repo-setup --------------------------------------------- 1.01s
repo_setup : Make sure git-core package is installed -------------------- 0.95s
Gathering Facts --------------------------------------------------------- 0.89s
repo_setup : Install repo-setup package --------------------------------- 0.80s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.79s
Restart NetworkManager -------------------------------------------------- 0.76s
repo_setup : Ensure directories are present ----------------------------- 0.67s
Inject our own NetworkManager configuration ----------------------------- 0.64s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.61s
ci_setup : Gather version of openshift client --------------------------- 0.60s
Start RHOL/CRC ---------------------------------------------------------- 0.46s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.42s
PLAY [Converge add_crc_creds] **************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:13:38 +0000 (0:00:00.038) 0:00:00.038 ******
ok: [instance]
TASK [Verify crc creds playbook] ***********************************************
Monday 29 September 2025 19:13:39 +0000 (0:00:00.968) 0:00:01.006 ******
TASK [rhol_crc : Make sure kubeconfig file exists] *****************************
Monday 29 September 2025 19:13:39 +0000 (0:00:00.030) 0:00:01.037 ******
ok: [instance]
TASK [rhol_crc : Warn the user that the kubeconfig files doesn't exist] ********
Monday 29 September 2025 19:13:39 +0000 (0:00:00.323) 0:00:01.361 ******
skipping: [instance]
TASK [rhol_crc : Add crc creds in the user bashrc file] ************************
Monday 29 September 2025 19:13:39 +0000 (0:00:00.031) 0:00:01.393 ******
changed: [instance]
TASK [rhol_crc : Source bashrc and confirm crc login] **************************
Monday 29 September 2025 19:13:40 +0000 (0:00:00.340) 0:00:01.733 ******
ok: [instance]
TASK [rhol_crc : Check bashrc results] *****************************************
Monday 29 September 2025 19:13:40 +0000 (0:00:00.689) 0:00:02.423 ******
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:13:40 +0000 (0:00:00.049) 0:00:02.472 ******
===============================================================================
Gathering Facts --------------------------------------------------------- 0.97s
rhol_crc : Source bashrc and confirm crc login -------------------------- 0.69s
rhol_crc : Add crc creds in the user bashrc file ------------------------ 0.34s
rhol_crc : Make sure kubeconfig file exists ----------------------------- 0.32s
rhol_crc : Check bashrc results ----------------------------------------- 0.05s
rhol_crc : Warn the user that the kubeconfig files doesn't exist -------- 0.03s
Verify crc creds playbook ----------------------------------------------- 0.03s
PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:13:41 +0000 (0:00:00.018) 0:00:00.018 ******
ok: [instance]
TASK [rhol_crc : Check RHOL/CRC binary exists] *********************************
Monday 29 September 2025 19:13:42 +0000 (0:00:00.952) 0:00:00.970 ******
ok: [instance]
TASK [rhol_crc : Delete RHOL/CRC instance and associated configuration] ********
Monday 29 September 2025 19:13:42 +0000 (0:00:00.304) 0:00:01.275 ******
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0
Monday 29 September 2025 19:13:46 +0000 (0:00:03.867) 0:00:05.143 ******
===============================================================================
rhol_crc : Delete RHOL/CRC instance and associated configuration -------- 3.87s
Gathering Facts --------------------------------------------------------- 0.95s
rhol_crc : Check RHOL/CRC binary exists --------------------------------- 0.30s
PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:14:04 +0000 (0:00:00.017) 0:00:00.017 ******
ok: [instance]
TASK [Setup libvirt] ***********************************************************
Monday 29 September 2025 19:14:05 +0000 (0:00:00.854) 0:00:00.872 ******
skipping: [instance]
TASK [Setup CRC] ***************************************************************
Monday 29 September 2025 19:14:05 +0000 (0:00:00.025) 0:00:00.897 ******
skipping: [instance]
TASK [Start RHOL/CRC] **********************************************************
Monday 29 September 2025 19:14:05 +0000 (0:00:00.023) 0:00:00.921 ******
skipping: [instance]
TASK [Inject our own NetworkManager configuration] *****************************
Monday 29 September 2025 19:14:05 +0000 (0:00:00.022) 0:00:00.943 ******
ok: [instance]
TASK [test_deps : Gather facts if they don't exist] ****************************
Monday 29 September 2025 19:14:06 +0000 (0:00:00.609) 0:00:01.552 ******
skipping: [instance]
TASK [test_deps : Gather variables for each operating system] ******************
Monday 29 September 2025 19:14:06 +0000 (0:00:00.020) 0:00:01.572 ******
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:14:06 +0000 (0:00:00.047) 0:00:01.620 ******
ok: [instance]
TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Monday 29 September 2025 19:14:06 +0000 (0:00:00.199) 0:00:01.819 ******
ok: [instance]
TASK [test_deps : Disable ubi 9 repos] *****************************************
Monday 29 September 2025 19:14:06 +0000 (0:00:00.221) 0:00:02.040 ******
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:14:07 +0000 (0:00:00.702) 0:00:02.743 ******
TASK [repo_setup : Ensure directories are present] *****************************
Monday 29 September 2025 19:14:07 +0000 (0:00:00.063) 0:00:02.807 ******
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:14:08 +0000 (0:00:00.604) 0:00:03.411 ******
ok: [instance]
TASK [repo_setup : Get repo-setup repository] **********************************
Monday 29 September 2025 19:14:09 +0000 (0:00:01.436) 0:00:04.847 ******
ok: [instance]
TASK [repo_setup : Initialize python venv and install requirements] ************
Monday 29 September 2025 19:14:10 +0000 (0:00:00.620) 0:00:05.468 ******
ok: [instance]
TASK [repo_setup : Install repo-setup package] *********************************
Monday 29 September 2025 19:14:11 +0000 (0:00:01.338) 0:00:06.807 ******
ok: [instance]
TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Monday 29 September 2025 19:14:12 +0000 (0:00:00.308) 0:00:07.116 ******
skipping: [instance]
TASK [repo_setup : Run repo-setup] *********************************************
Monday 29 September 2025 19:14:12 +0000 (0:00:00.025) 0:00:07.141 ******
changed: [instance]
TASK [repo_setup : Get component repo] *****************************************
Monday 29 September 2025 19:14:13 +0000 (0:00:00.910) 0:00:08.051 ******
skipping: [instance]
TASK [repo_setup : Rename component repo] **************************************
Monday 29 September 2025 19:14:13 +0000 (0:00:00.037) 0:00:08.089 ******
skipping: [instance]
TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Monday 29 September 2025 19:14:13 +0000 (0:00:00.042) 0:00:08.132 ******
skipping: [instance]
TASK [repo_setup : Run repo-setup-get-hash] ************************************
Monday 29 September 2025 19:14:13 +0000 (0:00:00.041) 0:00:08.174 ******
changed: [instance]
TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Monday 29 September 2025 19:14:13 +0000 (0:00:00.578) 0:00:08.753 ******
ok: [instance]
TASK [repo_setup : Dump current-podified hash] *********************************
Monday 29 September 2025 19:14:14 +0000 (0:00:00.385) 0:00:09.139 ******
skipping: [instance]
TASK [repo_setup : Slurp current podified hash] ********************************
Monday 29 September 2025 19:14:14 +0000 (0:00:00.033) 0:00:09.172 ******
skipping: [instance]
TASK [repo_setup : Update the value of full_hash] ******************************
Monday 29 September 2025 19:14:14 +0000 (0:00:00.032) 0:00:09.205 ******
skipping: [instance]
TASK [repo_setup : Export hashes facts for further use] ************************
Monday 29 September 2025 19:14:14 +0000 (0:00:00.033) 0:00:09.238 ******
ok: [instance]
TASK [repo_setup : Create download directory] **********************************
Monday 29 September 2025 19:14:14 +0000 (0:00:00.043) 0:00:09.281 ******
skipping: [instance]
TASK [repo_setup : Print the URL to request] ***********************************
Monday 29 September 2025 19:14:14 +0000 (0:00:00.031) 0:00:09.313 ******
skipping: [instance]
TASK [Download the RPM] ********************************************************
Monday 29 September 2025 19:14:14 +0000 (0:00:00.032) 0:00:09.346 ******
skipping: [instance]
TASK [repo_setup : Install RHOS Release tool] **********************************
Monday 29 September 2025 19:14:14 +0000 (0:00:00.039) 0:00:09.385 ******
skipping: [instance]
TASK [repo_setup : Get rhos-release tool version] ******************************
Monday 29 September 2025 19:14:14 +0000 (0:00:00.030) 0:00:09.416 ******
skipping: [instance]
TASK [repo_setup : Print rhos-release tool version] ****************************
Monday 29 September 2025 19:14:14 +0000 (0:00:00.030) 0:00:09.447 ******
skipping: [instance]
TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Monday 29 September 2025 19:14:14 +0000 (0:00:00.033) 0:00:09.480 ******
skipping: [instance]
TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Monday 29 September 2025 19:14:14 +0000 (0:00:00.029) 0:00:09.510 ******
ok: [instance]
TASK [repo_setup : Use RDO proxy mirrors] **************************************
Monday 29 September 2025 19:14:14 +0000 (0:00:00.197) 0:00:09.708 ******
changed: [instance]
TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Monday 29 September 2025 19:14:14 +0000 (0:00:00.226) 0:00:09.934 ******
changed: [instance]
TASK [repo_setup : Check for gating.repo file on content provider] *************
Monday 29 September 2025 19:14:15 +0000 (0:00:00.242) 0:00:10.176 ******
skipping: [instance]
TASK [repo_setup : Populate gating repo from content provider ip] **************
Monday 29 September 2025 19:14:15 +0000 (0:00:00.024) 0:00:10.201 ******
skipping: [instance]
TASK [repo_setup : Check for DLRN repo at the destination] *********************
Monday 29 September 2025 19:14:15 +0000 (0:00:00.026) 0:00:10.228 ******
skipping: [instance]
TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Monday 29 September 2025 19:14:15 +0000 (0:00:00.027) 0:00:10.255 ******
skipping: [instance]
TASK [repo_setup : Check for DLRN component repo] ******************************
Monday 29 September 2025 19:14:15 +0000 (0:00:00.026) 0:00:10.281 ******
skipping: [instance]
TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
Monday 29 September 2025 19:14:15 +0000 (0:00:00.026) 0:00:10.308 ******
skipping: [instance]
TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Monday 29 September 2025 19:14:15 +0000 (0:00:00.028) 0:00:10.337 ******
skipping: [instance]
TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Monday 29 September 2025 19:14:15 +0000 (0:00:00.021) 0:00:10.358 ******
skipping: [instance]
TASK [repo_setup : Cleanup existing metadata] **********************************
Monday 29 September 2025 19:14:15 +0000 (0:00:00.033) 0:00:10.392 ******
skipping: [instance]
TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Monday 29 September 2025 19:14:15 +0000 (0:00:00.020) 0:00:10.413 ******
skipping: [instance]
TASK [test_deps : Look for redhat-release rpm] *********************************
Monday 29 September 2025 19:14:15 +0000 (0:00:00.028) 0:00:10.441 ******
skipping: [instance]
TASK [test_deps : Remove redhat-release] ***************************************
Monday 29 September 2025 19:14:15 +0000 (0:00:00.035) 0:00:10.476 ******
skipping: [instance]
TASK [test_deps : Install centos-stream-release] *******************************
Monday 29 September 2025 19:14:15 +0000 (0:00:00.038) 0:00:10.514 ******
skipping: [instance]
TASK [test_deps : Install additional packages] *********************************
Monday 29 September 2025 19:14:15 +0000 (0:00:00.034) 0:00:10.549 ******
skipping: [instance]
TASK [test_deps : Install selinux python libs] *********************************
Monday 29 September 2025 19:14:15 +0000 (0:00:00.033) 0:00:10.583 ******
ok: [instance]
TASK [test_deps : Install python yaml libs] ************************************
Monday 29 September 2025 19:15:18 +0000 (0:01:02.508) 0:01:13.091 ******
ok: [instance]
TASK [test_deps : Install extra packages] **************************************
Monday 29 September 2025 19:15:19 +0000 (0:00:01.276) 0:01:14.368 ******
skipping: [instance]
TASK [ci_setup : Gather variables for each operating system] *******************
Monday 29 September 2025 19:15:19 +0000 (0:00:00.036) 0:01:14.404 ******
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:15:19 +0000 (0:00:00.050) 0:01:14.454 ******
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:15:19 +0000 (0:00:00.022) 0:01:14.477 ******
ok: [instance]
TASK [ci_setup : Gather version of openshift client] ***************************
Monday 29 September 2025 19:15:20 +0000 (0:00:01.273) 0:01:15.751 ******
ok: [instance]
TASK [ci_setup : Ensure openshift client install path is present] **************
Monday 29 September 2025 19:15:20 +0000 (0:00:00.278) 0:01:16.030 ******
ok: [instance]
TASK [ci_setup : Install openshift client] *************************************
Monday 29 September 2025 19:15:21 +0000 (0:00:00.209) 0:01:16.239 ******
skipping: [instance]
TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
Monday 29 September 2025 19:15:21 +0000 (0:00:00.069) 0:01:16.309 ******
skipping: [instance]
TASK [ci_setup : Create completion file] ***************************************
Monday 29 September 2025 19:15:21 +0000 (0:00:00.035) 0:01:16.344 ******
ok: [instance]
TASK [ci_setup : Source completion from within .bashrc] ************************
Monday 29 September 2025 19:15:21 +0000 (0:00:00.189) 0:01:16.534 ******
changed: [instance]
TASK [ci_setup : Check rhsm status] ********************************************
Monday 29 September 2025 19:15:21 +0000 (0:00:00.287) 0:01:16.821 ******
skipping: [instance]
TASK [ci_setup : Gather the repos to be enabled] *******************************
Monday 29 September 2025 19:15:21 +0000 (0:00:00.018) 0:01:16.840 ******
skipping: [instance]
TASK [ci_setup : Enabling the required repositories.] **************************
Monday 29 September 2025 19:15:21 +0000 (0:00:00.018) 0:01:16.858 ******
skipping: [instance]
TASK [ci_setup : Get current /etc/redhat-release] ******************************
Monday 29 September 2025 19:15:21 +0000 (0:00:00.019) 0:01:16.877 ******
skipping: [instance]
TASK [ci_setup : Print current /etc/redhat-release] ****************************
Monday 29 September 2025 19:15:21 +0000 (0:00:00.018) 0:01:16.896 ******
skipping: [instance]
TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
Monday 29 September 2025 19:15:21 +0000 (0:00:00.019) 0:01:16.915 ******
skipping: [instance]
TASK [ci_setup : Manage directories] *******************************************
Monday 29 September 2025 19:15:21 +0000 (0:00:00.027) 0:01:16.943 ******
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:15:22 +0000 (0:00:01.032) 0:01:17.975 ******
skipping: [instance]
PLAY RECAP *********************************************************************
instance : ok=28 changed=5 unreachable=0 failed=0 skipped=42 rescued=0 ignored=0
Monday 29 September 2025 19:15:22 +0000 (0:00:00.037) 0:01:18.013 ******
===============================================================================
test_deps : Install selinux python libs -------------------------------- 62.51s
repo_setup : Make sure git-core package is installed -------------------- 1.44s
repo_setup : Initialize python venv and install requirements ------------ 1.34s
test_deps : Install python yaml libs ------------------------------------ 1.28s
ci_setup : Install needed packages -------------------------------------- 1.27s
ci_setup : Manage directories ------------------------------------------- 1.03s
repo_setup : Run repo-setup --------------------------------------------- 0.91s
Gathering Facts --------------------------------------------------------- 0.85s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.70s
repo_setup : Get repo-setup repository ---------------------------------- 0.62s
Inject our own NetworkManager configuration ----------------------------- 0.61s
repo_setup : Ensure directories are present ----------------------------- 0.60s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.58s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.39s
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.28s
repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist) --- 0.24s
repo_setup : Use RDO proxy mirrors -------------------------------------- 0.23s
test_deps : Disable ubi host subscription-manager integration ----------- 0.22s
PLAY [Converge binary] *********************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:15:23 +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:15:24 +0000 (0:00:00.834) 0:00:00.849 ******
ok: [instance]
TASK [rhol_crc : Create temporary directory for downloading RHOL/CRC] **********
Monday 29 September 2025 19:15:24 +0000 (0:00:00.314) 0:00:01.163 ******
changed: [instance]
TASK [rhol_crc : Download RHOL/CRC with sha256 checksum] ***********************
Monday 29 September 2025 19:15:24 +0000 (0:00:00.278) 0:00:01.441 ******
changed: [instance]
TASK [rhol_crc : Unarchive RHOL/CRC binary] ************************************
Monday 29 September 2025 19:15:31 +0000 (0:00:06.287) 0:00:07.728 ******
changed: [instance]
TASK [rhol_crc : Delete temporary directory for downloading RHOL/CRC] **********
Monday 29 September 2025 19:15:36 +0000 (0:00:05.775) 0:00:13.503 ******
ok: [instance]
TASK [rhol_crc : Get CRC binary version] ***************************************
Monday 29 September 2025 19:15:37 +0000 (0:00:00.186) 0:00:13.690 ******
changed: [instance]
TASK [rhol_crc : Extract versions] *********************************************
Monday 29 September 2025 19:15:38 +0000 (0:00:00.886) 0:00:14.577 ******
ok: [instance]
TASK [rhol_crc : Output found binary location and versions] ********************
Monday 29 September 2025 19:15:38 +0000 (0:00:00.038) 0:00:14.615 ******
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:15:38 +0000 (0:00:00.048) 0:00:14.664 ******
ok: [instance]
TASK [Ensure facts are set and look correct] ***********************************
Monday 29 September 2025 19:15:38 +0000 (0:00:00.643) 0:00:15.308 ******
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:15:38 +0000 (0:00:00.057) 0:00:15.366 ******
===============================================================================
rhol_crc : Download RHOL/CRC with sha256 checksum ----------------------- 6.29s
rhol_crc : Unarchive RHOL/CRC binary ------------------------------------ 5.78s
rhol_crc : Get CRC binary version --------------------------------------- 0.89s
Gathering Facts --------------------------------------------------------- 0.83s
Gathering Facts --------------------------------------------------------- 0.64s
rhol_crc : Create bin directory if it does not exist -------------------- 0.31s
rhol_crc : Create temporary directory for downloading RHOL/CRC ---------- 0.28s
rhol_crc : Delete temporary directory for downloading RHOL/CRC ---------- 0.19s
Ensure facts are set and look correct ----------------------------------- 0.06s
rhol_crc : Output found binary location and versions -------------------- 0.05s
rhol_crc : Extract versions --------------------------------------------- 0.04s
PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:15:39 +0000 (0:00:00.015) 0:00:00.015 ******
ok: [instance]
TASK [Cleanup RHOL/CRC after tests] ********************************************
Monday 29 September 2025 19:15:40 +0000 (0:00:00.853) 0:00:00.868 ******
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=2 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0
Monday 29 September 2025 19:15:40 +0000 (0:00:00.447) 0:00:01.315 ******
===============================================================================
Gathering Facts --------------------------------------------------------- 0.85s
Cleanup RHOL/CRC after tests -------------------------------------------- 0.45s
PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:15:58 +0000 (0:00:00.018) 0:00:00.018 ******
ok: [instance]
TASK [Setup libvirt] ***********************************************************
Monday 29 September 2025 19:16:00 +0000 (0:00:01.890) 0:00:01.909 ******
skipping: [instance]
TASK [Setup CRC] ***************************************************************
Monday 29 September 2025 19:16:00 +0000 (0:00:00.025) 0:00:01.934 ******
skipping: [instance]
TASK [Start RHOL/CRC] **********************************************************
Monday 29 September 2025 19:16:00 +0000 (0:00:00.027) 0:00:01.962 ******
skipping: [instance]
TASK [Inject our own NetworkManager configuration] *****************************
Monday 29 September 2025 19:16:00 +0000 (0:00:00.025) 0:00:01.988 ******
ok: [instance]
TASK [test_deps : Gather facts if they don't exist] ****************************
Monday 29 September 2025 19:16:01 +0000 (0:00:00.625) 0:00:02.614 ******
skipping: [instance]
TASK [test_deps : Gather variables for each operating system] ******************
Monday 29 September 2025 19:16:01 +0000 (0:00:00.020) 0:00:02.634 ******
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:16:01 +0000 (0:00:00.044) 0:00:02.678 ******
ok: [instance]
TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Monday 29 September 2025 19:16:01 +0000 (0:00:00.200) 0:00:02.879 ******
ok: [instance]
TASK [test_deps : Disable ubi 9 repos] *****************************************
Monday 29 September 2025 19:16:01 +0000 (0:00:00.218) 0:00:03.097 ******
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:16:02 +0000 (0:00:00.716) 0:00:03.813 ******
TASK [repo_setup : Ensure directories are present] *****************************
Monday 29 September 2025 19:16:02 +0000 (0:00:00.069) 0:00:03.883 ******
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:16:03 +0000 (0:00:00.604) 0:00:04.487 ******
ok: [instance]
TASK [repo_setup : Get repo-setup repository] **********************************
Monday 29 September 2025 19:16:04 +0000 (0:00:01.441) 0:00:05.929 ******
ok: [instance]
TASK [repo_setup : Initialize python venv and install requirements] ************
Monday 29 September 2025 19:16:05 +0000 (0:00:00.629) 0:00:06.558 ******
ok: [instance]
TASK [repo_setup : Install repo-setup package] *********************************
Monday 29 September 2025 19:16:06 +0000 (0:00:01.349) 0:00:07.908 ******
ok: [instance]
TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Monday 29 September 2025 19:16:06 +0000 (0:00:00.307) 0:00:08.215 ******
skipping: [instance]
TASK [repo_setup : Run repo-setup] *********************************************
Monday 29 September 2025 19:16:06 +0000 (0:00:00.025) 0:00:08.241 ******
changed: [instance]
TASK [repo_setup : Get component repo] *****************************************
Monday 29 September 2025 19:16:07 +0000 (0:00:00.940) 0:00:09.182 ******
skipping: [instance]
TASK [repo_setup : Rename component repo] **************************************
Monday 29 September 2025 19:16:07 +0000 (0:00:00.041) 0:00:09.223 ******
skipping: [instance]
TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Monday 29 September 2025 19:16:07 +0000 (0:00:00.043) 0:00:09.267 ******
skipping: [instance]
TASK [repo_setup : Run repo-setup-get-hash] ************************************
Monday 29 September 2025 19:16:08 +0000 (0:00:00.042) 0:00:09.309 ******
changed: [instance]
TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Monday 29 September 2025 19:16:08 +0000 (0:00:00.568) 0:00:09.878 ******
ok: [instance]
TASK [repo_setup : Dump current-podified hash] *********************************
Monday 29 September 2025 19:16:08 +0000 (0:00:00.375) 0:00:10.254 ******
skipping: [instance]
TASK [repo_setup : Slurp current podified hash] ********************************
Monday 29 September 2025 19:16:09 +0000 (0:00:00.031) 0:00:10.285 ******
skipping: [instance]
TASK [repo_setup : Update the value of full_hash] ******************************
Monday 29 September 2025 19:16:09 +0000 (0:00:00.032) 0:00:10.317 ******
skipping: [instance]
TASK [repo_setup : Export hashes facts for further use] ************************
Monday 29 September 2025 19:16:09 +0000 (0:00:00.033) 0:00:10.350 ******
ok: [instance]
TASK [repo_setup : Create download directory] **********************************
Monday 29 September 2025 19:16:09 +0000 (0:00:00.042) 0:00:10.393 ******
skipping: [instance]
TASK [repo_setup : Print the URL to request] ***********************************
Monday 29 September 2025 19:16:09 +0000 (0:00:00.032) 0:00:10.425 ******
skipping: [instance]
TASK [Download the RPM] ********************************************************
Monday 29 September 2025 19:16:09 +0000 (0:00:00.030) 0:00:10.455 ******
skipping: [instance]
TASK [repo_setup : Install RHOS Release tool] **********************************
Monday 29 September 2025 19:16:09 +0000 (0:00:00.032) 0:00:10.488 ******
skipping: [instance]
TASK [repo_setup : Get rhos-release tool version] ******************************
Monday 29 September 2025 19:16:09 +0000 (0:00:00.029) 0:00:10.518 ******
skipping: [instance]
TASK [repo_setup : Print rhos-release tool version] ****************************
Monday 29 September 2025 19:16:09 +0000 (0:00:00.028) 0:00:10.547 ******
skipping: [instance]
TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Monday 29 September 2025 19:16:09 +0000 (0:00:00.030) 0:00:10.578 ******
skipping: [instance]
TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Monday 29 September 2025 19:16:09 +0000 (0:00:00.033) 0:00:10.611 ******
ok: [instance]
TASK [repo_setup : Use RDO proxy mirrors] **************************************
Monday 29 September 2025 19:16:09 +0000 (0:00:00.196) 0:00:10.807 ******
changed: [instance]
TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Monday 29 September 2025 19:16:09 +0000 (0:00:00.228) 0:00:11.035 ******
changed: [instance]
TASK [repo_setup : Check for gating.repo file on content provider] *************
Monday 29 September 2025 19:16:10 +0000 (0:00:00.247) 0:00:11.283 ******
skipping: [instance]
TASK [repo_setup : Populate gating repo from content provider ip] **************
Monday 29 September 2025 19:16:10 +0000 (0:00:00.023) 0:00:11.306 ******
skipping: [instance]
TASK [repo_setup : Check for DLRN repo at the destination] *********************
Monday 29 September 2025 19:16:10 +0000 (0:00:00.023) 0:00:11.330 ******
skipping: [instance]
TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Monday 29 September 2025 19:16:10 +0000 (0:00:00.025) 0:00:11.355 ******
skipping: [instance]
TASK [repo_setup : Check for DLRN component repo] ******************************
Monday 29 September 2025 19:16:10 +0000 (0:00:00.025) 0:00:11.381 ******
skipping: [instance]
TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
Monday 29 September 2025 19:16:10 +0000 (0:00:00.029) 0:00:11.411 ******
skipping: [instance]
TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Monday 29 September 2025 19:16:10 +0000 (0:00:00.027) 0:00:11.438 ******
skipping: [instance]
TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Monday 29 September 2025 19:16:10 +0000 (0:00:00.020) 0:00:11.458 ******
skipping: [instance]
TASK [repo_setup : Cleanup existing metadata] **********************************
Monday 29 September 2025 19:16:10 +0000 (0:00:00.032) 0:00:11.491 ******
skipping: [instance]
TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Monday 29 September 2025 19:16:10 +0000 (0:00:00.020) 0:00:11.511 ******
skipping: [instance]
TASK [test_deps : Look for redhat-release rpm] *********************************
Monday 29 September 2025 19:16:10 +0000 (0:00:00.025) 0:00:11.536 ******
skipping: [instance]
TASK [test_deps : Remove redhat-release] ***************************************
Monday 29 September 2025 19:16:10 +0000 (0:00:00.035) 0:00:11.572 ******
skipping: [instance]
TASK [test_deps : Install centos-stream-release] *******************************
Monday 29 September 2025 19:16:10 +0000 (0:00:00.031) 0:00:11.604 ******
skipping: [instance]
TASK [test_deps : Install additional packages] *********************************
Monday 29 September 2025 19:16:10 +0000 (0:00:00.032) 0:00:11.637 ******
skipping: [instance]
TASK [test_deps : Install selinux python libs] *********************************
Monday 29 September 2025 19:16:10 +0000 (0:00:00.033) 0:00:11.671 ******
ok: [instance]
TASK [test_deps : Install python yaml libs] ************************************
Monday 29 September 2025 19:16:55 +0000 (0:00:45.448) 0:00:57.119 ******
ok: [instance]
TASK [test_deps : Install extra packages] **************************************
Monday 29 September 2025 19:16:57 +0000 (0:00:01.273) 0:00:58.392 ******
skipping: [instance]
TASK [ci_setup : Gather variables for each operating system] *******************
Monday 29 September 2025 19:16:57 +0000 (0:00:00.034) 0:00:58.427 ******
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:16:57 +0000 (0:00:00.047) 0:00:58.474 ******
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:16:57 +0000 (0:00:00.020) 0:00:58.495 ******
ok: [instance]
TASK [ci_setup : Gather version of openshift client] ***************************
Monday 29 September 2025 19:16:58 +0000 (0:00:01.276) 0:00:59.772 ******
ok: [instance]
TASK [ci_setup : Ensure openshift client install path is present] **************
Monday 29 September 2025 19:16:58 +0000 (0:00:00.286) 0:01:00.058 ******
ok: [instance]
TASK [ci_setup : Install openshift client] *************************************
Monday 29 September 2025 19:16:58 +0000 (0:00:00.213) 0:01:00.272 ******
skipping: [instance]
TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
Monday 29 September 2025 19:16:59 +0000 (0:00:00.070) 0:01:00.342 ******
skipping: [instance]
TASK [ci_setup : Create completion file] ***************************************
Monday 29 September 2025 19:16:59 +0000 (0:00:00.039) 0:01:00.381 ******
ok: [instance]
TASK [ci_setup : Source completion from within .bashrc] ************************
Monday 29 September 2025 19:16:59 +0000 (0:00:00.192) 0:01:00.574 ******
ok: [instance]
TASK [ci_setup : Check rhsm status] ********************************************
Monday 29 September 2025 19:16:59 +0000 (0:00:00.289) 0:01:00.863 ******
skipping: [instance]
TASK [ci_setup : Gather the repos to be enabled] *******************************
Monday 29 September 2025 19:16:59 +0000 (0:00:00.019) 0:01:00.883 ******
skipping: [instance]
TASK [ci_setup : Enabling the required repositories.] **************************
Monday 29 September 2025 19:16:59 +0000 (0:00:00.018) 0:01:00.902 ******
skipping: [instance]
TASK [ci_setup : Get current /etc/redhat-release] ******************************
Monday 29 September 2025 19:16:59 +0000 (0:00:00.019) 0:01:00.921 ******
skipping: [instance]
TASK [ci_setup : Print current /etc/redhat-release] ****************************
Monday 29 September 2025 19:16:59 +0000 (0:00:00.019) 0:01:00.940 ******
skipping: [instance]
TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
Monday 29 September 2025 19:16:59 +0000 (0:00:00.018) 0:01:00.959 ******
skipping: [instance]
TASK [ci_setup : Manage directories] *******************************************
Monday 29 September 2025 19:16:59 +0000 (0:00:00.024) 0:01:00.983 ******
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:17:00 +0000 (0:00:01.011) 0:01:01.995 ******
skipping: [instance]
PLAY RECAP *********************************************************************
instance : ok=28 changed=4 unreachable=0 failed=0 skipped=42 rescued=0 ignored=0
Monday 29 September 2025 19:17:00 +0000 (0:00:00.038) 0:01:02.033 ******
===============================================================================
test_deps : Install selinux python libs -------------------------------- 45.45s
Gathering Facts --------------------------------------------------------- 1.89s
repo_setup : Make sure git-core package is installed -------------------- 1.44s
repo_setup : Initialize python venv and install requirements ------------ 1.35s
ci_setup : Install needed packages -------------------------------------- 1.28s
test_deps : Install python yaml libs ------------------------------------ 1.27s
ci_setup : Manage directories ------------------------------------------- 1.01s
repo_setup : Run repo-setup --------------------------------------------- 0.94s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.72s
repo_setup : Get repo-setup repository ---------------------------------- 0.63s
Inject our own NetworkManager configuration ----------------------------- 0.63s
repo_setup : Ensure directories are present ----------------------------- 0.60s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.57s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.38s
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.29s
repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist) --- 0.25s
repo_setup : Use RDO proxy mirrors -------------------------------------- 0.23s
test_deps : Disable ubi host subscription-manager integration ----------- 0.22s
PLAY [Converge default] ********************************************************
TASK [Gathering Facts] *********************************************************
Monday 29 September 2025 19:17:01 +0000 (0:00:00.030) 0:00:00.030 ******
ok: [instance]
TASK [rhol_crc : Ensure directories exist] *************************************
Monday 29 September 2025 19:17:02 +0000 (0:00:00.854) 0:00:00.885 ******
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:17:02 +0000 (0:00:00.687) 0:00:01.573 ******
changed: [instance]
TASK [rhol_crc : Check for binary] *********************************************
Monday 29 September 2025 19:17:03 +0000 (0:00:00.230) 0:00:01.803 ******
ok: [instance]
TASK [rhol_crc : Get versions if binary is available] **************************
Monday 29 September 2025 19:17:03 +0000 (0:00:00.276) 0:00:02.080 ******
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:17:03 +0000 (0:00:00.040) 0:00:02.121 ******
changed: [instance]
TASK [rhol_crc : Extract versions] *********************************************
Monday 29 September 2025 19:17:04 +0000 (0:00:00.755) 0:00:02.876 ******
ok: [instance]
TASK [rhol_crc : Output found binary location and versions] ********************
Monday 29 September 2025 19:17:04 +0000 (0:00:00.041) 0:00:02.917 ******
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:17:04 +0000 (0:00:00.022) 0:00:02.940 ******
ok: [instance]
TASK [rhol_crc : Set CRC status] ***********************************************
Monday 29 September 2025 19:17:04 +0000 (0:00:00.377) 0:00:03.317 ******
ok: [instance]
TASK [rhol_crc : Fail if crc domain is already defined] ************************
Monday 29 September 2025 19:17:04 +0000 (0:00:00.027) 0:00:03.345 ******
skipping: [instance]
TASK [Ensure pull-secret is in place if we need to configure CRC] **************
Monday 29 September 2025 19:17:04 +0000 (0:00:00.028) 0:00:03.373 ******
TASK [manage_secrets : Assert we get needed data] ******************************
Monday 29 September 2025 19:17:04 +0000 (0:00:00.043) 0:00:03.417 ******
ok: [instance]
TASK [manage_secrets : Manage secret] ******************************************
Monday 29 September 2025 19:17:04 +0000 (0:00:00.023) 0:00:03.441 ******
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:17:04 +0000 (0:00:00.027) 0:00:03.468 ******
ok: [instance] =>
_secret_dest: /home/zuul/pull-secret.json
TASK [manage_secrets : Debug _secret_file] *************************************
Monday 29 September 2025 19:17:04 +0000 (0:00:00.025) 0:00:03.494 ******
ok: [instance] =>
_secret_file: ''
TASK [manage_secrets : Debug _secret_content] **********************************
Monday 29 September 2025 19:17:04 +0000 (0:00:00.021) 0:00:03.515 ******
ok: [instance] =>
_secret_content:
auths:
fake:
auth: Zm9vOmJhcgo=
TASK [manage_secrets : Ensure parameter is an absolute path] *******************
Monday 29 September 2025 19:17:04 +0000 (0:00:00.022) 0:00:03.537 ******
skipping: [instance]
TASK [manage_secrets : Check if pull secret src file exists] *******************
Monday 29 September 2025 19:17:04 +0000 (0:00:00.018) 0:00:03.556 ******
skipping: [instance]
TASK [manage_secrets : Copy file to location] **********************************
Monday 29 September 2025 19:17:04 +0000 (0:00:00.019) 0:00:03.576 ******
skipping: [instance]
TASK [manage_secrets : Create file from content] *******************************
Monday 29 September 2025 19:17:04 +0000 (0:00:00.020) 0:00:03.597 ******
changed: [instance]
TASK [rhol_crc : Get wanted RHOL/CRC version binary if needed] *****************
Monday 29 September 2025 19:17:05 +0000 (0:00:00.481) 0:00:04.078 ******
skipping: [instance]
TASK [rhol_crc : Setup sudoers file for sudo commands in RHOL/CRC setup] *******
Monday 29 September 2025 19:17:05 +0000 (0:00:00.035) 0:00:04.114 ******
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:17:05 +0000 (0:00:00.038) 0:00:04.153 ******
changed: [instance]
TASK [rhol_crc : Clean RHOL/CRC if wanted] *************************************
Monday 29 September 2025 19:17:05 +0000 (0:00:00.339) 0:00:04.492 ******
skipping: [instance]
TASK [rhol_crc : Set RHOL/CRC configuration options] ***************************
Monday 29 September 2025 19:17:05 +0000 (0:00:00.032) 0:00:04.525 ******
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:17:05 +0000 (0:00:00.039) 0:00:04.565 ******
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:17:07 +0000 (0:00:01.997) 0:00:06.562 ******
changed: [instance]
TASK [rhol_crc : Start RHOL/CRC] ***********************************************
Monday 29 September 2025 19:22:29 +0000 (0:05:21.616) 0:05:28.179 ******
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:04.128364'
end: '2025-09-29 19:39:33.830186'
msg: non-zero return code
rc: 1
start: '2025-09-29 19:22:29.701822'
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 (x111)
stdout_lines: <omitted>
TASK [rhol_crc : Revoke permissions granted in sudoers file for CRC/RHOL setup] ***
Monday 29 September 2025 19:39:33 +0000 (0:17:04.403) 0:22:32.583 ******
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=22 changed=7 unreachable=0 failed=1 skipped=6 rescued=0 ignored=0
Monday 29 September 2025 19:39:34 +0000 (0:00:00.237) 0:22:32.820 ******
===============================================================================
rhol_crc : Start RHOL/CRC -------------------------------------------- 1024.40s
rhol_crc : Setup RHOL/CRC --------------------------------------------- 321.62s
rhol_crc : Set RHOL/CRC configuration options --------------------------- 2.00s
Gathering Facts --------------------------------------------------------- 0.85s
rhol_crc : Get CRC binary version --------------------------------------- 0.76s
rhol_crc : Ensure directories exist ------------------------------------- 0.69s
manage_secrets : Create file from content ------------------------------- 0.48s
rhol_crc : Get CRC VM availability -------------------------------------- 0.38s
rhol_crc : Add passwordless sudo access for CRC commands ---------------- 0.34s
rhol_crc : Check for binary --------------------------------------------- 0.28s
rhol_crc : Revoke permissions granted in sudoers file for CRC/RHOL setup --- 0.24s
manage_secrets : Ensure directory tree exist ---------------------------- 0.23s
Ensure pull-secret is in place if we need to configure CRC -------------- 0.04s
rhol_crc : Extract versions --------------------------------------------- 0.04s
rhol_crc : Get versions if binary is available -------------------------- 0.04s
rhol_crc : Set RHOL/CRC configuration options --------------------------- 0.04s
rhol_crc : Setup sudoers file for sudo commands in RHOL/CRC setup ------- 0.04s
rhol_crc : Get wanted RHOL/CRC version binary if needed ----------------- 0.04s
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:39:34 +0000 (0:00:00.015) 0:00:00.015 ******
ok: [instance]
TASK [rhol_crc : Check RHOL/CRC binary exists] *********************************
Monday 29 September 2025 19:39:35 +0000 (0:00:00.955) 0:00:00.971 ******
ok: [instance]
TASK [rhol_crc : Delete RHOL/CRC instance and associated configuration] ********
Monday 29 September 2025 19:39:35 +0000 (0:00:00.319) 0:00:01.291 ******
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0
Monday 29 September 2025 19:39:38 +0000 (0:00:02.958) 0:00:04.249 ******
===============================================================================
rhol_crc : Delete RHOL/CRC instance and associated configuration -------- 2.96s
Gathering Facts --------------------------------------------------------- 0.96s
rhol_crc : Check RHOL/CRC binary exists --------------------------------- 0.32s