PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025 00:02:54 +0000 (0:00:00.014) 0:00:00.014 *****
ok: [instance]
TASK [Setup libvirt] ***********************************************************
Wednesday 08 October 2025 00:02:55 +0000 (0:00:00.843) 0:00:00.858 *****
skipping: [instance]
TASK [Setup CRC] ***************************************************************
Wednesday 08 October 2025 00:02:55 +0000 (0:00:00.027) 0:00:00.885 *****
skipping: [instance]
TASK [Start RHOL/CRC] **********************************************************
Wednesday 08 October 2025 00:02:55 +0000 (0:00:00.029) 0:00:00.914 *****
changed: [instance]
TASK [Inject our own NetworkManager configuration] *****************************
Wednesday 08 October 2025 00:02:55 +0000 (0:00:00.405) 0:00:01.320 *****
changed: [instance]
TASK [test_deps : Gather facts if they don't exist] ****************************
Wednesday 08 October 2025 00:02:56 +0000 (0:00:00.600) 0:00:01.921 *****
skipping: [instance]
TASK [test_deps : Gather variables for each operating system] ******************
Wednesday 08 October 2025 00:02:56 +0000 (0:00:00.020) 0:00:01.941 *****
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] *****************************************
Wednesday 08 October 2025 00:02:56 +0000 (0:00:00.046) 0:00:01.988 *****
ok: [instance]
TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Wednesday 08 October 2025 00:02:56 +0000 (0:00:00.212) 0:00:02.200 *****
ok: [instance]
TASK [test_deps : Disable ubi 9 repos] *****************************************
Wednesday 08 October 2025 00:02:57 +0000 (0:00:00.348) 0:00:02.549 *****
ok: [instance] => (item=ubi-9-appstream)
ok: [instance] => (item=ubi-9-baseos)
ok: [instance] => (item=ubi-9-codeready-builder)
TASK [Deploy repo-setup] *******************************************************
Wednesday 08 October 2025 00:02:57 +0000 (0:00:00.777) 0:00:03.327 *****
TASK [repo_setup : Ensure directories are present] *****************************
Wednesday 08 October 2025 00:02:57 +0000 (0:00:00.078) 0:00:03.405 *****
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] ********************
Wednesday 08 October 2025 00:02:58 +0000 (0:00:00.672) 0:00:04.077 *****
ok: [instance]
TASK [repo_setup : Get repo-setup repository] **********************************
Wednesday 08 October 2025 00:02:59 +0000 (0:00:00.934) 0:00:05.012 *****
changed: [instance]
TASK [repo_setup : Initialize python venv and install requirements] ************
Wednesday 08 October 2025 00:03:00 +0000 (0:00:01.238) 0:00:06.251 *****
changed: [instance]
TASK [repo_setup : Install repo-setup package] *********************************
Wednesday 08 October 2025 00:03:09 +0000 (0:00:08.725) 0:00:14.977 *****
changed: [instance]
TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Wednesday 08 October 2025 00:03:10 +0000 (0:00:00.768) 0:00:15.745 *****
skipping: [instance]
TASK [repo_setup : Run repo-setup] *********************************************
Wednesday 08 October 2025 00:03:10 +0000 (0:00:00.027) 0:00:15.773 *****
changed: [instance]
TASK [repo_setup : Get component repo] *****************************************
Wednesday 08 October 2025 00:03:11 +0000 (0:00:01.015) 0:00:16.789 *****
skipping: [instance]
TASK [repo_setup : Rename component repo] **************************************
Wednesday 08 October 2025 00:03:11 +0000 (0:00:00.048) 0:00:16.837 *****
skipping: [instance]
TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Wednesday 08 October 2025 00:03:11 +0000 (0:00:00.055) 0:00:16.893 *****
skipping: [instance]
TASK [repo_setup : Run repo-setup-get-hash] ************************************
Wednesday 08 October 2025 00:03:11 +0000 (0:00:00.049) 0:00:16.942 *****
changed: [instance]
TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Wednesday 08 October 2025 00:03:12 +0000 (0:00:00.627) 0:00:17.570 *****
changed: [instance]
TASK [repo_setup : Dump current-podified hash] *********************************
Wednesday 08 October 2025 00:03:12 +0000 (0:00:00.454) 0:00:18.024 *****
skipping: [instance]
TASK [repo_setup : Slurp current podified hash] ********************************
Wednesday 08 October 2025 00:03:12 +0000 (0:00:00.042) 0:00:18.067 *****
skipping: [instance]
TASK [repo_setup : Update the value of full_hash] ******************************
Wednesday 08 October 2025 00:03:12 +0000 (0:00:00.045) 0:00:18.112 *****
skipping: [instance]
TASK [repo_setup : Export hashes facts for further use] ************************
Wednesday 08 October 2025 00:03:12 +0000 (0:00:00.039) 0:00:18.151 *****
ok: [instance]
TASK [repo_setup : Create download directory] **********************************
Wednesday 08 October 2025 00:03:12 +0000 (0:00:00.054) 0:00:18.206 *****
skipping: [instance]
TASK [repo_setup : Print the URL to request] ***********************************
Wednesday 08 October 2025 00:03:12 +0000 (0:00:00.040) 0:00:18.246 *****
skipping: [instance]
TASK [Download the RPM] ********************************************************
Wednesday 08 October 2025 00:03:12 +0000 (0:00:00.040) 0:00:18.287 *****
skipping: [instance]
TASK [repo_setup : Install RHOS Release tool] **********************************
Wednesday 08 October 2025 00:03:12 +0000 (0:00:00.040) 0:00:18.327 *****
skipping: [instance]
TASK [repo_setup : Get rhos-release tool version] ******************************
Wednesday 08 October 2025 00:03:12 +0000 (0:00:00.037) 0:00:18.364 *****
skipping: [instance]
TASK [repo_setup : Print rhos-release tool version] ****************************
Wednesday 08 October 2025 00:03:12 +0000 (0:00:00.038) 0:00:18.403 *****
skipping: [instance]
TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Wednesday 08 October 2025 00:03:12 +0000 (0:00:00.041) 0:00:18.444 *****
skipping: [instance]
TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Wednesday 08 October 2025 00:03:13 +0000 (0:00:00.034) 0:00:18.478 *****
ok: [instance]
TASK [repo_setup : Use RDO proxy mirrors] **************************************
Wednesday 08 October 2025 00:03:13 +0000 (0:00:00.248) 0:00:18.727 *****
changed: [instance]
TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Wednesday 08 October 2025 00:03:13 +0000 (0:00:00.277) 0:00:19.005 *****
changed: [instance]
TASK [repo_setup : Check for gating.repo file on content provider] *************
Wednesday 08 October 2025 00:03:13 +0000 (0:00:00.286) 0:00:19.291 *****
skipping: [instance]
TASK [repo_setup : Populate gating repo from content provider ip] **************
Wednesday 08 October 2025 00:03:13 +0000 (0:00:00.029) 0:00:19.320 *****
skipping: [instance]
TASK [repo_setup : Check for DLRN repo at the destination] *********************
Wednesday 08 October 2025 00:03:13 +0000 (0:00:00.041) 0:00:19.362 *****
skipping: [instance]
TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Wednesday 08 October 2025 00:03:13 +0000 (0:00:00.032) 0:00:19.395 *****
skipping: [instance]
TASK [repo_setup : Check for DLRN component repo] ******************************
Wednesday 08 October 2025 00:03:13 +0000 (0:00:00.038) 0:00:19.434 *****
skipping: [instance]
TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
Wednesday 08 October 2025 00:03:14 +0000 (0:00:00.033) 0:00:19.467 *****
skipping: [instance]
TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Wednesday 08 October 2025 00:03:14 +0000 (0:00:00.035) 0:00:19.502 *****
skipping: [instance]
TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Wednesday 08 October 2025 00:03:14 +0000 (0:00:00.024) 0:00:19.527 *****
skipping: [instance]
TASK [repo_setup : Cleanup existing metadata] **********************************
Wednesday 08 October 2025 00:03:14 +0000 (0:00:00.039) 0:00:19.566 *****
skipping: [instance]
TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Wednesday 08 October 2025 00:03:14 +0000 (0:00:00.025) 0:00:19.592 *****
skipping: [instance]
TASK [test_deps : Look for redhat-release rpm] *********************************
Wednesday 08 October 2025 00:03:14 +0000 (0:00:00.032) 0:00:19.624 *****
skipping: [instance]
TASK [test_deps : Remove redhat-release] ***************************************
Wednesday 08 October 2025 00:03:14 +0000 (0:00:00.036) 0:00:19.661 *****
skipping: [instance]
TASK [test_deps : Install centos-stream-release] *******************************
Wednesday 08 October 2025 00:03:14 +0000 (0:00:00.041) 0:00:19.703 *****
skipping: [instance]
TASK [test_deps : Install additional packages] *********************************
Wednesday 08 October 2025 00:03:14 +0000 (0:00:00.037) 0:00:19.740 *****
skipping: [instance]
TASK [test_deps : Install selinux python libs] *********************************
Wednesday 08 October 2025 00:03:14 +0000 (0:00:00.040) 0:00:19.781 *****
ok: [instance]
TASK [test_deps : Install python yaml libs] ************************************
Wednesday 08 October 2025 00:04:06 +0000 (0:00:52.471) 0:01:12.253 *****
ok: [instance]
TASK [test_deps : Install extra packages] **************************************
Wednesday 08 October 2025 00:04:08 +0000 (0:00:01.350) 0:01:13.603 *****
skipping: [instance]
TASK [ci_setup : Gather variables for each operating system] *******************
Wednesday 08 October 2025 00:04:08 +0000 (0:00:00.046) 0:01:13.650 *****
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] *************************************
Wednesday 08 October 2025 00:04:08 +0000 (0:00:00.050) 0:01:13.700 *****
ok: [instance] =>
cifmw_ci_setup_packages:
- bash-completion
- ca-certificates
- git-core
- make
- tar
- tmux
- python3-pip
TASK [ci_setup : Install needed packages] **************************************
Wednesday 08 October 2025 00:04:08 +0000 (0:00:00.027) 0:01:13.728 *****
changed: [instance]
TASK [ci_setup : Gather version of openshift client] ***************************
Wednesday 08 October 2025 00:04:16 +0000 (0:00:08.447) 0:01:22.176 *****
ok: [instance]
TASK [ci_setup : Ensure openshift client install path is present] **************
Wednesday 08 October 2025 00:04:17 +0000 (0:00:00.658) 0:01:22.835 *****
changed: [instance]
TASK [ci_setup : Install openshift client] *************************************
Wednesday 08 October 2025 00:04:17 +0000 (0:00:00.250) 0:01:23.085 *****
changed: [instance]
TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
Wednesday 08 October 2025 00:04:24 +0000 (0:00:06.415) 0:01:29.500 *****
ok: [instance]
TASK [ci_setup : Create completion file] ***************************************
Wednesday 08 October 2025 00:04:24 +0000 (0:00:00.062) 0:01:29.562 *****
changed: [instance]
TASK [ci_setup : Source completion from within .bashrc] ************************
Wednesday 08 October 2025 00:04:24 +0000 (0:00:00.331) 0:01:29.894 *****
changed: [instance]
TASK [ci_setup : Check rhsm status] ********************************************
Wednesday 08 October 2025 00:04:24 +0000 (0:00:00.389) 0:01:30.284 *****
skipping: [instance]
TASK [ci_setup : Gather the repos to be enabled] *******************************
Wednesday 08 October 2025 00:04:24 +0000 (0:00:00.029) 0:01:30.313 *****
skipping: [instance]
TASK [ci_setup : Enabling the required repositories.] **************************
Wednesday 08 October 2025 00:04:24 +0000 (0:00:00.026) 0:01:30.340 *****
skipping: [instance]
TASK [ci_setup : Get current /etc/redhat-release] ******************************
Wednesday 08 October 2025 00:04:24 +0000 (0:00:00.027) 0:01:30.367 *****
skipping: [instance]
TASK [ci_setup : Print current /etc/redhat-release] ****************************
Wednesday 08 October 2025 00:04:24 +0000 (0:00:00.028) 0:01:30.396 *****
skipping: [instance]
TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
Wednesday 08 October 2025 00:04:24 +0000 (0:00:00.026) 0:01:30.422 *****
skipping: [instance]
TASK [ci_setup : Manage directories] *******************************************
Wednesday 08 October 2025 00:04:24 +0000 (0:00:00.033) 0:01:30.456 *****
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] ***************************************************
Wednesday 08 October 2025 00:04:26 +0000 (0:00:01.265) 0:01:31.722 *****
FAILED - RETRYING: [instance]: Check for CRC startup (120 retries left).
FAILED - RETRYING: [instance]: Check for CRC startup (119 retries left).
FAILED - RETRYING: [instance]: Check for CRC startup (118 retries left).
FAILED - RETRYING: [instance]: Check for CRC startup (117 retries left).
FAILED - RETRYING: [instance]: Check for CRC startup (116 retries left).
FAILED - RETRYING: [instance]: Check for CRC startup (115 retries left).
FAILED - RETRYING: [instance]: Check for CRC startup (114 retries left).
FAILED - RETRYING: [instance]: Check for CRC startup (113 retries left).
FAILED - RETRYING: [instance]: Check for CRC startup (112 retries left).
FAILED - RETRYING: [instance]: Check for CRC startup (111 retries left).
changed: [instance]
RUNNING HANDLER [Restart NetworkManager] ***************************************
Wednesday 08 October 2025 00:12:48 +0000 (0:08:22.638) 0:09:54.360 *****
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=33 changed=19 unreachable=0 failed=0 skipped=38 rescued=0 ignored=0
Wednesday 08 October 2025 00:12:49 +0000 (0:00:00.736) 0:09:55.097 *****
===============================================================================
Check for CRC startup ------------------------------------------------- 502.64s
test_deps : Install selinux python libs -------------------------------- 52.47s
repo_setup : Initialize python venv and install requirements ------------ 8.73s
ci_setup : Install needed packages -------------------------------------- 8.45s
ci_setup : Install openshift client ------------------------------------- 6.42s
test_deps : Install python yaml libs ------------------------------------ 1.35s
ci_setup : Manage directories ------------------------------------------- 1.27s
repo_setup : Get repo-setup repository ---------------------------------- 1.24s
repo_setup : Run repo-setup --------------------------------------------- 1.02s
repo_setup : Make sure git-core package is installed -------------------- 0.93s
Gathering Facts --------------------------------------------------------- 0.84s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.78s
repo_setup : Install repo-setup package --------------------------------- 0.77s
Restart NetworkManager -------------------------------------------------- 0.74s
repo_setup : Ensure directories are present ----------------------------- 0.67s
ci_setup : Gather version of openshift client --------------------------- 0.66s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.63s
Inject our own NetworkManager configuration ----------------------------- 0.60s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.45s
Start RHOL/CRC ---------------------------------------------------------- 0.41s
PLAY [Converge add_crc_creds] **************************************************
TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025 00:12:50 +0000 (0:00:00.034) 0:00:00.034 *****
ok: [instance]
TASK [Verify crc creds playbook] ***********************************************
Wednesday 08 October 2025 00:12:51 +0000 (0:00:00.921) 0:00:00.956 *****
TASK [rhol_crc : Make sure kubeconfig file exists] *****************************
Wednesday 08 October 2025 00:12:51 +0000 (0:00:00.031) 0:00:00.988 *****
ok: [instance]
TASK [rhol_crc : Warn the user that the kubeconfig files doesn't exist] ********
Wednesday 08 October 2025 00:12:51 +0000 (0:00:00.296) 0:00:01.284 *****
skipping: [instance]
TASK [rhol_crc : Add crc creds in the user bashrc file] ************************
Wednesday 08 October 2025 00:12:51 +0000 (0:00:00.035) 0:00:01.320 *****
changed: [instance]
TASK [rhol_crc : Source bashrc and confirm crc login] **************************
Wednesday 08 October 2025 00:12:51 +0000 (0:00:00.277) 0:00:01.597 *****
ok: [instance]
TASK [rhol_crc : Check bashrc results] *****************************************
Wednesday 08 October 2025 00:12:52 +0000 (0:00:00.588) 0:00:02.186 *****
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
Wednesday 08 October 2025 00:12:52 +0000 (0:00:00.047) 0:00:02.233 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 0.92s
rhol_crc : Source bashrc and confirm crc login -------------------------- 0.59s
rhol_crc : Make sure kubeconfig file exists ----------------------------- 0.30s
rhol_crc : Add crc creds in the user bashrc file ------------------------ 0.28s
rhol_crc : Check bashrc results ----------------------------------------- 0.05s
rhol_crc : Warn the user that the kubeconfig files doesn't exist -------- 0.04s
Verify crc creds playbook ----------------------------------------------- 0.03s
PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025 00:12:52 +0000 (0:00:00.014) 0:00:00.014 *****
ok: [instance]
TASK [rhol_crc : Check RHOL/CRC binary exists] *********************************
Wednesday 08 October 2025 00:12:53 +0000 (0:00:00.915) 0:00:00.929 *****
ok: [instance]
TASK [rhol_crc : Delete RHOL/CRC instance and associated configuration] ********
Wednesday 08 October 2025 00:12:54 +0000 (0:00:00.285) 0:00:01.215 *****
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0
Wednesday 08 October 2025 00:12:59 +0000 (0:00:05.147) 0:00:06.362 *****
===============================================================================
rhol_crc : Delete RHOL/CRC instance and associated configuration -------- 5.15s
Gathering Facts --------------------------------------------------------- 0.92s
rhol_crc : Check RHOL/CRC binary exists --------------------------------- 0.29s
PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025 00:13:16 +0000 (0:00:00.018) 0:00:00.018 *****
ok: [instance]
TASK [Setup libvirt] ***********************************************************
Wednesday 08 October 2025 00:13:17 +0000 (0:00:00.866) 0:00:00.885 *****
skipping: [instance]
TASK [Setup CRC] ***************************************************************
Wednesday 08 October 2025 00:13:17 +0000 (0:00:00.024) 0:00:00.910 *****
skipping: [instance]
TASK [Start RHOL/CRC] **********************************************************
Wednesday 08 October 2025 00:13:17 +0000 (0:00:00.030) 0:00:00.940 *****
skipping: [instance]
TASK [Inject our own NetworkManager configuration] *****************************
Wednesday 08 October 2025 00:13:17 +0000 (0:00:00.023) 0:00:00.964 *****
ok: [instance]
TASK [test_deps : Gather facts if they don't exist] ****************************
Wednesday 08 October 2025 00:13:18 +0000 (0:00:00.646) 0:00:01.610 *****
skipping: [instance]
TASK [test_deps : Gather variables for each operating system] ******************
Wednesday 08 October 2025 00:13:18 +0000 (0:00:00.033) 0:00:01.643 *****
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] *****************************************
Wednesday 08 October 2025 00:13:18 +0000 (0:00:00.047) 0:00:01.691 *****
ok: [instance]
TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Wednesday 08 October 2025 00:13:18 +0000 (0:00:00.205) 0:00:01.897 *****
ok: [instance]
TASK [test_deps : Disable ubi 9 repos] *****************************************
Wednesday 08 October 2025 00:13:18 +0000 (0:00:00.222) 0:00:02.119 *****
ok: [instance] => (item=ubi-9-appstream)
ok: [instance] => (item=ubi-9-baseos)
ok: [instance] => (item=ubi-9-codeready-builder)
TASK [Deploy repo-setup] *******************************************************
Wednesday 08 October 2025 00:13:19 +0000 (0:00:00.703) 0:00:02.823 *****
TASK [repo_setup : Ensure directories are present] *****************************
Wednesday 08 October 2025 00:13:19 +0000 (0:00:00.062) 0:00:02.885 *****
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] ********************
Wednesday 08 October 2025 00:13:20 +0000 (0:00:00.557) 0:00:03.443 *****
ok: [instance]
TASK [repo_setup : Get repo-setup repository] **********************************
Wednesday 08 October 2025 00:13:21 +0000 (0:00:01.316) 0:00:04.760 *****
ok: [instance]
TASK [repo_setup : Initialize python venv and install requirements] ************
Wednesday 08 October 2025 00:13:22 +0000 (0:00:00.598) 0:00:05.358 *****
ok: [instance]
TASK [repo_setup : Install repo-setup package] *********************************
Wednesday 08 October 2025 00:13:23 +0000 (0:00:01.240) 0:00:06.599 *****
ok: [instance]
TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Wednesday 08 October 2025 00:13:23 +0000 (0:00:00.292) 0:00:06.892 *****
skipping: [instance]
TASK [repo_setup : Run repo-setup] *********************************************
Wednesday 08 October 2025 00:13:23 +0000 (0:00:00.026) 0:00:06.918 *****
changed: [instance]
TASK [repo_setup : Get component repo] *****************************************
Wednesday 08 October 2025 00:13:24 +0000 (0:00:00.900) 0:00:07.818 *****
skipping: [instance]
TASK [repo_setup : Rename component repo] **************************************
Wednesday 08 October 2025 00:13:24 +0000 (0:00:00.042) 0:00:07.861 *****
skipping: [instance]
TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Wednesday 08 October 2025 00:13:24 +0000 (0:00:00.040) 0:00:07.902 *****
skipping: [instance]
TASK [repo_setup : Run repo-setup-get-hash] ************************************
Wednesday 08 October 2025 00:13:24 +0000 (0:00:00.040) 0:00:07.942 *****
changed: [instance]
TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Wednesday 08 October 2025 00:13:25 +0000 (0:00:00.569) 0:00:08.512 *****
ok: [instance]
TASK [repo_setup : Dump current-podified hash] *********************************
Wednesday 08 October 2025 00:13:25 +0000 (0:00:00.363) 0:00:08.876 *****
skipping: [instance]
TASK [repo_setup : Slurp current podified hash] ********************************
Wednesday 08 October 2025 00:13:25 +0000 (0:00:00.030) 0:00:08.906 *****
skipping: [instance]
TASK [repo_setup : Update the value of full_hash] ******************************
Wednesday 08 October 2025 00:13:25 +0000 (0:00:00.030) 0:00:08.937 *****
skipping: [instance]
TASK [repo_setup : Export hashes facts for further use] ************************
Wednesday 08 October 2025 00:13:25 +0000 (0:00:00.032) 0:00:08.969 *****
ok: [instance]
TASK [repo_setup : Create download directory] **********************************
Wednesday 08 October 2025 00:13:25 +0000 (0:00:00.038) 0:00:09.007 *****
skipping: [instance]
TASK [repo_setup : Print the URL to request] ***********************************
Wednesday 08 October 2025 00:13:25 +0000 (0:00:00.027) 0:00:09.034 *****
skipping: [instance]
TASK [Download the RPM] ********************************************************
Wednesday 08 October 2025 00:13:25 +0000 (0:00:00.029) 0:00:09.064 *****
skipping: [instance]
TASK [repo_setup : Install RHOS Release tool] **********************************
Wednesday 08 October 2025 00:13:25 +0000 (0:00:00.034) 0:00:09.099 *****
skipping: [instance]
TASK [repo_setup : Get rhos-release tool version] ******************************
Wednesday 08 October 2025 00:13:25 +0000 (0:00:00.030) 0:00:09.129 *****
skipping: [instance]
TASK [repo_setup : Print rhos-release tool version] ****************************
Wednesday 08 October 2025 00:13:25 +0000 (0:00:00.036) 0:00:09.166 *****
skipping: [instance]
TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Wednesday 08 October 2025 00:13:25 +0000 (0:00:00.033) 0:00:09.199 *****
skipping: [instance]
TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Wednesday 08 October 2025 00:13:25 +0000 (0:00:00.030) 0:00:09.230 *****
ok: [instance]
TASK [repo_setup : Use RDO proxy mirrors] **************************************
Wednesday 08 October 2025 00:13:26 +0000 (0:00:00.187) 0:00:09.417 *****
changed: [instance]
TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Wednesday 08 October 2025 00:13:26 +0000 (0:00:00.218) 0:00:09.636 *****
changed: [instance]
TASK [repo_setup : Check for gating.repo file on content provider] *************
Wednesday 08 October 2025 00:13:26 +0000 (0:00:00.227) 0:00:09.863 *****
skipping: [instance]
TASK [repo_setup : Populate gating repo from content provider ip] **************
Wednesday 08 October 2025 00:13:26 +0000 (0:00:00.023) 0:00:09.886 *****
skipping: [instance]
TASK [repo_setup : Check for DLRN repo at the destination] *********************
Wednesday 08 October 2025 00:13:26 +0000 (0:00:00.024) 0:00:09.911 *****
skipping: [instance]
TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Wednesday 08 October 2025 00:13:26 +0000 (0:00:00.027) 0:00:09.939 *****
skipping: [instance]
TASK [repo_setup : Check for DLRN component repo] ******************************
Wednesday 08 October 2025 00:13:26 +0000 (0:00:00.028) 0:00:09.968 *****
skipping: [instance]
TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
Wednesday 08 October 2025 00:13:26 +0000 (0:00:00.027) 0:00:09.995 *****
skipping: [instance]
TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Wednesday 08 October 2025 00:13:26 +0000 (0:00:00.027) 0:00:10.023 *****
skipping: [instance]
TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Wednesday 08 October 2025 00:13:26 +0000 (0:00:00.022) 0:00:10.045 *****
skipping: [instance]
TASK [repo_setup : Cleanup existing metadata] **********************************
Wednesday 08 October 2025 00:13:26 +0000 (0:00:00.033) 0:00:10.078 *****
skipping: [instance]
TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Wednesday 08 October 2025 00:13:26 +0000 (0:00:00.020) 0:00:10.099 *****
skipping: [instance]
TASK [test_deps : Look for redhat-release rpm] *********************************
Wednesday 08 October 2025 00:13:26 +0000 (0:00:00.027) 0:00:10.127 *****
skipping: [instance]
TASK [test_deps : Remove redhat-release] ***************************************
Wednesday 08 October 2025 00:13:26 +0000 (0:00:00.032) 0:00:10.160 *****
skipping: [instance]
TASK [test_deps : Install centos-stream-release] *******************************
Wednesday 08 October 2025 00:13:26 +0000 (0:00:00.031) 0:00:10.191 *****
skipping: [instance]
TASK [test_deps : Install additional packages] *********************************
Wednesday 08 October 2025 00:13:26 +0000 (0:00:00.031) 0:00:10.223 *****
skipping: [instance]
TASK [test_deps : Install selinux python libs] *********************************
Wednesday 08 October 2025 00:13:27 +0000 (0:00:00.031) 0:00:10.254 *****
ok: [instance]
TASK [test_deps : Install python yaml libs] ************************************
Wednesday 08 October 2025 00:14:12 +0000 (0:00:45.348) 0:00:55.603 *****
ok: [instance]
TASK [test_deps : Install extra packages] **************************************
Wednesday 08 October 2025 00:14:13 +0000 (0:00:01.193) 0:00:56.797 *****
skipping: [instance]
TASK [ci_setup : Gather variables for each operating system] *******************
Wednesday 08 October 2025 00:14:13 +0000 (0:00:00.042) 0:00:56.839 *****
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] *************************************
Wednesday 08 October 2025 00:14:13 +0000 (0:00:00.050) 0:00:56.889 *****
ok: [instance] =>
cifmw_ci_setup_packages:
- bash-completion
- ca-certificates
- git-core
- make
- tar
- tmux
- python3-pip
TASK [ci_setup : Install needed packages] **************************************
Wednesday 08 October 2025 00:14:13 +0000 (0:00:00.023) 0:00:56.913 *****
ok: [instance]
TASK [ci_setup : Gather version of openshift client] ***************************
Wednesday 08 October 2025 00:14:14 +0000 (0:00:01.322) 0:00:58.236 *****
ok: [instance]
TASK [ci_setup : Ensure openshift client install path is present] **************
Wednesday 08 October 2025 00:14:15 +0000 (0:00:00.291) 0:00:58.527 *****
ok: [instance]
TASK [ci_setup : Install openshift client] *************************************
Wednesday 08 October 2025 00:14:15 +0000 (0:00:00.227) 0:00:58.755 *****
skipping: [instance]
TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
Wednesday 08 October 2025 00:14:15 +0000 (0:00:00.075) 0:00:58.830 *****
skipping: [instance]
TASK [ci_setup : Create completion file] ***************************************
Wednesday 08 October 2025 00:14:15 +0000 (0:00:00.037) 0:00:58.868 *****
ok: [instance]
TASK [ci_setup : Source completion from within .bashrc] ************************
Wednesday 08 October 2025 00:14:15 +0000 (0:00:00.198) 0:00:59.066 *****
changed: [instance]
TASK [ci_setup : Check rhsm status] ********************************************
Wednesday 08 October 2025 00:14:16 +0000 (0:00:00.285) 0:00:59.352 *****
skipping: [instance]
TASK [ci_setup : Gather the repos to be enabled] *******************************
Wednesday 08 October 2025 00:14:16 +0000 (0:00:00.031) 0:00:59.384 *****
skipping: [instance]
TASK [ci_setup : Enabling the required repositories.] **************************
Wednesday 08 October 2025 00:14:16 +0000 (0:00:00.023) 0:00:59.407 *****
skipping: [instance]
TASK [ci_setup : Get current /etc/redhat-release] ******************************
Wednesday 08 October 2025 00:14:16 +0000 (0:00:00.020) 0:00:59.427 *****
skipping: [instance]
TASK [ci_setup : Print current /etc/redhat-release] ****************************
Wednesday 08 October 2025 00:14:16 +0000 (0:00:00.023) 0:00:59.451 *****
skipping: [instance]
TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
Wednesday 08 October 2025 00:14:16 +0000 (0:00:00.021) 0:00:59.473 *****
skipping: [instance]
TASK [ci_setup : Manage directories] *******************************************
Wednesday 08 October 2025 00:14:16 +0000 (0:00:00.030) 0:00:59.504 *****
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] ***************************************************
Wednesday 08 October 2025 00:14:17 +0000 (0:00:01.071) 0:01:00.576 *****
skipping: [instance]
PLAY RECAP *********************************************************************
instance : ok=28 changed=5 unreachable=0 failed=0 skipped=42 rescued=0 ignored=0
Wednesday 08 October 2025 00:14:17 +0000 (0:00:00.041) 0:01:00.617 *****
===============================================================================
test_deps : Install selinux python libs -------------------------------- 45.35s
ci_setup : Install needed packages -------------------------------------- 1.32s
repo_setup : Make sure git-core package is installed -------------------- 1.32s
repo_setup : Initialize python venv and install requirements ------------ 1.24s
test_deps : Install python yaml libs ------------------------------------ 1.19s
ci_setup : Manage directories ------------------------------------------- 1.07s
repo_setup : Run repo-setup --------------------------------------------- 0.90s
Gathering Facts --------------------------------------------------------- 0.87s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.70s
Inject our own NetworkManager configuration ----------------------------- 0.65s
repo_setup : Get repo-setup repository ---------------------------------- 0.60s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.57s
repo_setup : Ensure directories are present ----------------------------- 0.56s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.36s
repo_setup : Install repo-setup package --------------------------------- 0.29s
ci_setup : Gather version of openshift client --------------------------- 0.29s
ci_setup : Source completion from within .bashrc ------------------------ 0.29s
ci_setup : Ensure openshift client install path is present -------------- 0.23s
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.22s
PLAY [Converge binary] *********************************************************
TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025 00:14:17 +0000 (0:00:00.015) 0:00:00.015 *****
ok: [instance]
TASK [rhol_crc : Create bin directory if it does not exist] ********************
Wednesday 08 October 2025 00:14:18 +0000 (0:00:00.887) 0:00:00.903 *****
ok: [instance]
TASK [rhol_crc : Create temporary directory for downloading RHOL/CRC] **********
Wednesday 08 October 2025 00:14:19 +0000 (0:00:00.318) 0:00:01.221 *****
changed: [instance]
TASK [rhol_crc : Download RHOL/CRC with sha256 checksum] ***********************
Wednesday 08 October 2025 00:14:19 +0000 (0:00:00.266) 0:00:01.488 *****
changed: [instance]
TASK [rhol_crc : Unarchive RHOL/CRC binary] ************************************
Wednesday 08 October 2025 00:14:24 +0000 (0:00:04.938) 0:00:06.427 *****
changed: [instance]
TASK [rhol_crc : Delete temporary directory for downloading RHOL/CRC] **********
Wednesday 08 October 2025 00:14:29 +0000 (0:00:04.919) 0:00:11.347 *****
ok: [instance]
TASK [rhol_crc : Get CRC binary version] ***************************************
Wednesday 08 October 2025 00:14:29 +0000 (0:00:00.212) 0:00:11.559 *****
changed: [instance]
TASK [rhol_crc : Extract versions] *********************************************
Wednesday 08 October 2025 00:14:30 +0000 (0:00:00.762) 0:00:12.321 *****
ok: [instance]
TASK [rhol_crc : Output found binary location and versions] ********************
Wednesday 08 October 2025 00:14:30 +0000 (0:00:00.045) 0:00:12.366 *****
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] *********************************************************
Wednesday 08 October 2025 00:14:30 +0000 (0:00:00.055) 0:00:12.422 *****
ok: [instance]
TASK [Ensure facts are set and look correct] ***********************************
Wednesday 08 October 2025 00:14:30 +0000 (0:00:00.653) 0:00:13.075 *****
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
Wednesday 08 October 2025 00:14:30 +0000 (0:00:00.044) 0:00:13.120 *****
===============================================================================
rhol_crc : Download RHOL/CRC with sha256 checksum ----------------------- 4.94s
rhol_crc : Unarchive RHOL/CRC binary ------------------------------------ 4.92s
Gathering Facts --------------------------------------------------------- 0.89s
rhol_crc : Get CRC binary version --------------------------------------- 0.76s
Gathering Facts --------------------------------------------------------- 0.65s
rhol_crc : Create bin directory if it does not exist -------------------- 0.32s
rhol_crc : Create temporary directory for downloading RHOL/CRC ---------- 0.27s
rhol_crc : Delete temporary directory for downloading RHOL/CRC ---------- 0.21s
rhol_crc : Output found binary location and versions -------------------- 0.06s
rhol_crc : Extract versions --------------------------------------------- 0.05s
Ensure facts are set and look correct ----------------------------------- 0.04s
PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025 00:14:31 +0000 (0:00:00.014) 0:00:00.014 *****
ok: [instance]
TASK [Cleanup RHOL/CRC after tests] ********************************************
Wednesday 08 October 2025 00:14:32 +0000 (0:00:00.850) 0:00:00.864 *****
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=2 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0
Wednesday 08 October 2025 00:14:32 +0000 (0:00:00.450) 0:00:01.315 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 0.85s
Cleanup RHOL/CRC after tests -------------------------------------------- 0.45s
PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025 00:14:50 +0000 (0:00:00.017) 0:00:00.017 *****
ok: [instance]
TASK [Setup libvirt] ***********************************************************
Wednesday 08 October 2025 00:14:51 +0000 (0:00:00.790) 0:00:00.807 *****
skipping: [instance]
TASK [Setup CRC] ***************************************************************
Wednesday 08 October 2025 00:14:51 +0000 (0:00:00.024) 0:00:00.831 *****
skipping: [instance]
TASK [Start RHOL/CRC] **********************************************************
Wednesday 08 October 2025 00:14:51 +0000 (0:00:00.024) 0:00:00.856 *****
skipping: [instance]
TASK [Inject our own NetworkManager configuration] *****************************
Wednesday 08 October 2025 00:14:51 +0000 (0:00:00.022) 0:00:00.878 *****
ok: [instance]
TASK [test_deps : Gather facts if they don't exist] ****************************
Wednesday 08 October 2025 00:14:51 +0000 (0:00:00.556) 0:00:01.435 *****
skipping: [instance]
TASK [test_deps : Gather variables for each operating system] ******************
Wednesday 08 October 2025 00:14:51 +0000 (0:00:00.020) 0:00:01.455 *****
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] *****************************************
Wednesday 08 October 2025 00:14:51 +0000 (0:00:00.042) 0:00:01.498 *****
ok: [instance]
TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Wednesday 08 October 2025 00:14:51 +0000 (0:00:00.175) 0:00:01.673 *****
ok: [instance]
TASK [test_deps : Disable ubi 9 repos] *****************************************
Wednesday 08 October 2025 00:14:52 +0000 (0:00:00.202) 0:00:01.875 *****
ok: [instance] => (item=ubi-9-appstream)
ok: [instance] => (item=ubi-9-baseos)
ok: [instance] => (item=ubi-9-codeready-builder)
TASK [Deploy repo-setup] *******************************************************
Wednesday 08 October 2025 00:14:52 +0000 (0:00:00.662) 0:00:02.538 *****
TASK [repo_setup : Ensure directories are present] *****************************
Wednesday 08 October 2025 00:14:52 +0000 (0:00:00.061) 0:00:02.600 *****
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] ********************
Wednesday 08 October 2025 00:14:53 +0000 (0:00:00.535) 0:00:03.136 *****
ok: [instance]
TASK [repo_setup : Get repo-setup repository] **********************************
Wednesday 08 October 2025 00:14:54 +0000 (0:00:01.297) 0:00:04.433 *****
ok: [instance]
TASK [repo_setup : Initialize python venv and install requirements] ************
Wednesday 08 October 2025 00:14:55 +0000 (0:00:00.562) 0:00:04.996 *****
ok: [instance]
TASK [repo_setup : Install repo-setup package] *********************************
Wednesday 08 October 2025 00:14:56 +0000 (0:00:01.200) 0:00:06.197 *****
ok: [instance]
TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Wednesday 08 October 2025 00:14:56 +0000 (0:00:00.283) 0:00:06.480 *****
skipping: [instance]
TASK [repo_setup : Run repo-setup] *********************************************
Wednesday 08 October 2025 00:14:56 +0000 (0:00:00.024) 0:00:06.505 *****
changed: [instance]
TASK [repo_setup : Get component repo] *****************************************
Wednesday 08 October 2025 00:14:57 +0000 (0:00:00.853) 0:00:07.358 *****
skipping: [instance]
TASK [repo_setup : Rename component repo] **************************************
Wednesday 08 October 2025 00:14:57 +0000 (0:00:00.040) 0:00:07.398 *****
skipping: [instance]
TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Wednesday 08 October 2025 00:14:57 +0000 (0:00:00.037) 0:00:07.436 *****
skipping: [instance]
TASK [repo_setup : Run repo-setup-get-hash] ************************************
Wednesday 08 October 2025 00:14:57 +0000 (0:00:00.038) 0:00:07.475 *****
changed: [instance]
TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Wednesday 08 October 2025 00:14:58 +0000 (0:00:00.530) 0:00:08.005 *****
ok: [instance]
TASK [repo_setup : Dump current-podified hash] *********************************
Wednesday 08 October 2025 00:14:58 +0000 (0:00:00.348) 0:00:08.353 *****
skipping: [instance]
TASK [repo_setup : Slurp current podified hash] ********************************
Wednesday 08 October 2025 00:14:58 +0000 (0:00:00.032) 0:00:08.386 *****
skipping: [instance]
TASK [repo_setup : Update the value of full_hash] ******************************
Wednesday 08 October 2025 00:14:58 +0000 (0:00:00.032) 0:00:08.418 *****
skipping: [instance]
TASK [repo_setup : Export hashes facts for further use] ************************
Wednesday 08 October 2025 00:14:58 +0000 (0:00:00.029) 0:00:08.448 *****
ok: [instance]
TASK [repo_setup : Create download directory] **********************************
Wednesday 08 October 2025 00:14:58 +0000 (0:00:00.039) 0:00:08.487 *****
skipping: [instance]
TASK [repo_setup : Print the URL to request] ***********************************
Wednesday 08 October 2025 00:14:58 +0000 (0:00:00.029) 0:00:08.517 *****
skipping: [instance]
TASK [Download the RPM] ********************************************************
Wednesday 08 October 2025 00:14:58 +0000 (0:00:00.031) 0:00:08.548 *****
skipping: [instance]
TASK [repo_setup : Install RHOS Release tool] **********************************
Wednesday 08 October 2025 00:14:58 +0000 (0:00:00.027) 0:00:08.576 *****
skipping: [instance]
TASK [repo_setup : Get rhos-release tool version] ******************************
Wednesday 08 October 2025 00:14:58 +0000 (0:00:00.028) 0:00:08.604 *****
skipping: [instance]
TASK [repo_setup : Print rhos-release tool version] ****************************
Wednesday 08 October 2025 00:14:58 +0000 (0:00:00.026) 0:00:08.631 *****
skipping: [instance]
TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Wednesday 08 October 2025 00:14:58 +0000 (0:00:00.030) 0:00:08.661 *****
skipping: [instance]
TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Wednesday 08 October 2025 00:14:58 +0000 (0:00:00.027) 0:00:08.688 *****
ok: [instance]
TASK [repo_setup : Use RDO proxy mirrors] **************************************
Wednesday 08 October 2025 00:14:59 +0000 (0:00:00.178) 0:00:08.867 *****
changed: [instance]
TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Wednesday 08 October 2025 00:14:59 +0000 (0:00:00.204) 0:00:09.071 *****
changed: [instance]
TASK [repo_setup : Check for gating.repo file on content provider] *************
Wednesday 08 October 2025 00:14:59 +0000 (0:00:00.214) 0:00:09.286 *****
skipping: [instance]
TASK [repo_setup : Populate gating repo from content provider ip] **************
Wednesday 08 October 2025 00:14:59 +0000 (0:00:00.023) 0:00:09.309 *****
skipping: [instance]
TASK [repo_setup : Check for DLRN repo at the destination] *********************
Wednesday 08 October 2025 00:14:59 +0000 (0:00:00.027) 0:00:09.337 *****
skipping: [instance]
TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Wednesday 08 October 2025 00:14:59 +0000 (0:00:00.026) 0:00:09.363 *****
skipping: [instance]
TASK [repo_setup : Check for DLRN component repo] ******************************
Wednesday 08 October 2025 00:14:59 +0000 (0:00:00.024) 0:00:09.387 *****
skipping: [instance]
TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
Wednesday 08 October 2025 00:14:59 +0000 (0:00:00.024) 0:00:09.411 *****
skipping: [instance]
TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Wednesday 08 October 2025 00:14:59 +0000 (0:00:00.025) 0:00:09.437 *****
skipping: [instance]
TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Wednesday 08 October 2025 00:14:59 +0000 (0:00:00.019) 0:00:09.457 *****
skipping: [instance]
TASK [repo_setup : Cleanup existing metadata] **********************************
Wednesday 08 October 2025 00:14:59 +0000 (0:00:00.030) 0:00:09.487 *****
skipping: [instance]
TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Wednesday 08 October 2025 00:14:59 +0000 (0:00:00.020) 0:00:09.508 *****
skipping: [instance]
TASK [test_deps : Look for redhat-release rpm] *********************************
Wednesday 08 October 2025 00:14:59 +0000 (0:00:00.024) 0:00:09.532 *****
skipping: [instance]
TASK [test_deps : Remove redhat-release] ***************************************
Wednesday 08 October 2025 00:14:59 +0000 (0:00:00.030) 0:00:09.562 *****
skipping: [instance]
TASK [test_deps : Install centos-stream-release] *******************************
Wednesday 08 October 2025 00:14:59 +0000 (0:00:00.029) 0:00:09.592 *****
skipping: [instance]
TASK [test_deps : Install additional packages] *********************************
Wednesday 08 October 2025 00:14:59 +0000 (0:00:00.028) 0:00:09.620 *****
skipping: [instance]
TASK [test_deps : Install selinux python libs] *********************************
Wednesday 08 October 2025 00:14:59 +0000 (0:00:00.031) 0:00:09.651 *****
ok: [instance]
TASK [test_deps : Install python yaml libs] ************************************
Wednesday 08 October 2025 00:15:42 +0000 (0:00:42.190) 0:00:51.842 *****
ok: [instance]
TASK [test_deps : Install extra packages] **************************************
Wednesday 08 October 2025 00:15:43 +0000 (0:00:01.206) 0:00:53.049 *****
skipping: [instance]
TASK [ci_setup : Gather variables for each operating system] *******************
Wednesday 08 October 2025 00:15:43 +0000 (0:00:00.035) 0:00:53.084 *****
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] *************************************
Wednesday 08 October 2025 00:15:43 +0000 (0:00:00.049) 0:00:53.134 *****
ok: [instance] =>
cifmw_ci_setup_packages:
- bash-completion
- ca-certificates
- git-core
- make
- tar
- tmux
- python3-pip
TASK [ci_setup : Install needed packages] **************************************
Wednesday 08 October 2025 00:15:43 +0000 (0:00:00.024) 0:00:53.158 *****
ok: [instance]
TASK [ci_setup : Gather version of openshift client] ***************************
Wednesday 08 October 2025 00:15:44 +0000 (0:00:01.205) 0:00:54.363 *****
ok: [instance]
TASK [ci_setup : Ensure openshift client install path is present] **************
Wednesday 08 October 2025 00:15:44 +0000 (0:00:00.282) 0:00:54.646 *****
ok: [instance]
TASK [ci_setup : Install openshift client] *************************************
Wednesday 08 October 2025 00:15:45 +0000 (0:00:00.202) 0:00:54.848 *****
skipping: [instance]
TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
Wednesday 08 October 2025 00:15:45 +0000 (0:00:00.072) 0:00:54.921 *****
skipping: [instance]
TASK [ci_setup : Create completion file] ***************************************
Wednesday 08 October 2025 00:15:45 +0000 (0:00:00.034) 0:00:54.955 *****
ok: [instance]
TASK [ci_setup : Source completion from within .bashrc] ************************
Wednesday 08 October 2025 00:15:45 +0000 (0:00:00.181) 0:00:55.137 *****
ok: [instance]
TASK [ci_setup : Check rhsm status] ********************************************
Wednesday 08 October 2025 00:15:45 +0000 (0:00:00.279) 0:00:55.417 *****
skipping: [instance]
TASK [ci_setup : Gather the repos to be enabled] *******************************
Wednesday 08 October 2025 00:15:45 +0000 (0:00:00.019) 0:00:55.436 *****
skipping: [instance]
TASK [ci_setup : Enabling the required repositories.] **************************
Wednesday 08 October 2025 00:15:45 +0000 (0:00:00.018) 0:00:55.454 *****
skipping: [instance]
TASK [ci_setup : Get current /etc/redhat-release] ******************************
Wednesday 08 October 2025 00:15:45 +0000 (0:00:00.019) 0:00:55.474 *****
skipping: [instance]
TASK [ci_setup : Print current /etc/redhat-release] ****************************
Wednesday 08 October 2025 00:15:45 +0000 (0:00:00.022) 0:00:55.496 *****
skipping: [instance]
TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
Wednesday 08 October 2025 00:15:45 +0000 (0:00:00.017) 0:00:55.513 *****
skipping: [instance]
TASK [ci_setup : Manage directories] *******************************************
Wednesday 08 October 2025 00:15:45 +0000 (0:00:00.022) 0:00:55.536 *****
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] ***************************************************
Wednesday 08 October 2025 00:15:46 +0000 (0:00:00.993) 0:00:56.529 *****
skipping: [instance]
PLAY RECAP *********************************************************************
instance : ok=28 changed=4 unreachable=0 failed=0 skipped=42 rescued=0 ignored=0
Wednesday 08 October 2025 00:15:46 +0000 (0:00:00.039) 0:00:56.569 *****
===============================================================================
test_deps : Install selinux python libs -------------------------------- 42.19s
repo_setup : Make sure git-core package is installed -------------------- 1.30s
test_deps : Install python yaml libs ------------------------------------ 1.21s
ci_setup : Install needed packages -------------------------------------- 1.21s
repo_setup : Initialize python venv and install requirements ------------ 1.20s
ci_setup : Manage directories ------------------------------------------- 0.99s
repo_setup : Run repo-setup --------------------------------------------- 0.85s
Gathering Facts --------------------------------------------------------- 0.79s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.66s
repo_setup : Get repo-setup repository ---------------------------------- 0.56s
Inject our own NetworkManager configuration ----------------------------- 0.56s
repo_setup : Ensure directories are present ----------------------------- 0.54s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.53s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.35s
repo_setup : Install repo-setup package --------------------------------- 0.28s
ci_setup : Gather version of openshift client --------------------------- 0.28s
ci_setup : Source completion from within .bashrc ------------------------ 0.28s
repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist) --- 0.21s
repo_setup : Use RDO proxy mirrors -------------------------------------- 0.20s
ci_setup : Ensure openshift client install path is present -------------- 0.20s
PLAY [Converge default] ********************************************************
TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025 00:15:47 +0000 (0:00:00.028) 0:00:00.028 *****
ok: [instance]
TASK [rhol_crc : Ensure directories exist] *************************************
Wednesday 08 October 2025 00:15:48 +0000 (0:00:00.854) 0:00:00.883 *****
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] ****************************
Wednesday 08 October 2025 00:15:48 +0000 (0:00:00.659) 0:00:01.542 *****
changed: [instance]
TASK [rhol_crc : Check for binary] *********************************************
Wednesday 08 October 2025 00:15:49 +0000 (0:00:00.208) 0:00:01.750 *****
ok: [instance]
TASK [rhol_crc : Get versions if binary is available] **************************
Wednesday 08 October 2025 00:15:49 +0000 (0:00:00.292) 0:00:02.042 *****
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] ***************************************
Wednesday 08 October 2025 00:15:49 +0000 (0:00:00.038) 0:00:02.080 *****
changed: [instance]
TASK [rhol_crc : Extract versions] *********************************************
Wednesday 08 October 2025 00:15:50 +0000 (0:00:00.777) 0:00:02.858 *****
ok: [instance]
TASK [rhol_crc : Output found binary location and versions] ********************
Wednesday 08 October 2025 00:15:50 +0000 (0:00:00.038) 0:00:02.896 *****
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] **************************************
Wednesday 08 October 2025 00:15:50 +0000 (0:00:00.021) 0:00:02.918 *****
ok: [instance]
TASK [rhol_crc : Set CRC status] ***********************************************
Wednesday 08 October 2025 00:15:50 +0000 (0:00:00.330) 0:00:03.249 *****
ok: [instance]
TASK [rhol_crc : Fail if crc domain is already defined] ************************
Wednesday 08 October 2025 00:15:50 +0000 (0:00:00.025) 0:00:03.274 *****
skipping: [instance]
TASK [Ensure pull-secret is in place if we need to configure CRC] **************
Wednesday 08 October 2025 00:15:50 +0000 (0:00:00.026) 0:00:03.301 *****
TASK [manage_secrets : Assert we get needed data] ******************************
Wednesday 08 October 2025 00:15:50 +0000 (0:00:00.039) 0:00:03.340 *****
ok: [instance]
TASK [manage_secrets : Manage secret] ******************************************
Wednesday 08 October 2025 00:15:50 +0000 (0:00:00.020) 0:00:03.361 *****
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] *************************************
Wednesday 08 October 2025 00:15:50 +0000 (0:00:00.024) 0:00:03.385 *****
ok: [instance] =>
_secret_dest: /home/zuul/pull-secret.json
TASK [manage_secrets : Debug _secret_file] *************************************
Wednesday 08 October 2025 00:15:50 +0000 (0:00:00.023) 0:00:03.408 *****
ok: [instance] =>
_secret_file: ''
TASK [manage_secrets : Debug _secret_content] **********************************
Wednesday 08 October 2025 00:15:50 +0000 (0:00:00.019) 0:00:03.427 *****
ok: [instance] =>
_secret_content:
auths:
fake:
auth: Zm9vOmJhcgo=
TASK [manage_secrets : Ensure parameter is an absolute path] *******************
Wednesday 08 October 2025 00:15:50 +0000 (0:00:00.023) 0:00:03.451 *****
skipping: [instance]
TASK [manage_secrets : Check if pull secret src file exists] *******************
Wednesday 08 October 2025 00:15:50 +0000 (0:00:00.016) 0:00:03.468 *****
skipping: [instance]
TASK [manage_secrets : Copy file to location] **********************************
Wednesday 08 October 2025 00:15:50 +0000 (0:00:00.020) 0:00:03.489 *****
skipping: [instance]
TASK [manage_secrets : Create file from content] *******************************
Wednesday 08 October 2025 00:15:50 +0000 (0:00:00.018) 0:00:03.507 *****
changed: [instance]
TASK [rhol_crc : Get wanted RHOL/CRC version binary if needed] *****************
Wednesday 08 October 2025 00:15:51 +0000 (0:00:00.441) 0:00:03.949 *****
skipping: [instance]
TASK [rhol_crc : Setup sudoers file for sudo commands in RHOL/CRC setup] *******
Wednesday 08 October 2025 00:15:51 +0000 (0:00:00.034) 0:00:03.983 *****
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] ****************
Wednesday 08 October 2025 00:15:51 +0000 (0:00:00.035) 0:00:04.018 *****
changed: [instance]
TASK [rhol_crc : Clean RHOL/CRC if wanted] *************************************
Wednesday 08 October 2025 00:15:51 +0000 (0:00:00.306) 0:00:04.324 *****
skipping: [instance]
TASK [rhol_crc : Set RHOL/CRC configuration options] ***************************
Wednesday 08 October 2025 00:15:51 +0000 (0:00:00.038) 0:00:04.362 *****
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] ***************************
Wednesday 08 October 2025 00:15:51 +0000 (0:00:00.045) 0:00:04.408 *****
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] ***********************************************
Wednesday 08 October 2025 00:15:53 +0000 (0:00:01.804) 0:00:06.213 *****
changed: [instance]
TASK [rhol_crc : Start RHOL/CRC] ***********************************************
Wednesday 08 October 2025 00:20:57 +0000 (0:05:03.837) 0:05:10.050 *****
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:22:16.810995'
end: '2025-10-08 00:43:14.385929'
msg: non-zero return code
rc: 1
start: '2025-10-08 00:20:57.574934'
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]"
level=info msg="Kubelet serving certificate has expired, waiting for automatic renewal... [will take up to 5 minutes]"
level=info msg="Waiting for kube-apiserver availability... [takes around 2min]"
level=info msg="Adding user's pull secret to the cluster..."
level=info msg="Updating SSH key to machine config resource..."
level=info msg="Waiting until the user's pull secret is written to the instance disk..."
Failed to update pull secret on the disk: Temporary error: pull secret not updated to disk (x205)
stdout_lines: <omitted>
TASK [rhol_crc : Revoke permissions granted in sudoers file for CRC/RHOL setup] ***
Wednesday 08 October 2025 00:43:14 +0000 (0:22:17.029) 0:27:27.079 *****
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=22 changed=7 unreachable=0 failed=1 skipped=6 rescued=0 ignored=0
Wednesday 08 October 2025 00:43:14 +0000 (0:00:00.195) 0:27:27.275 *****
===============================================================================
rhol_crc : Start RHOL/CRC -------------------------------------------- 1337.03s
rhol_crc : Setup RHOL/CRC --------------------------------------------- 303.84s
rhol_crc : Set RHOL/CRC configuration options --------------------------- 1.80s
Gathering Facts --------------------------------------------------------- 0.85s
rhol_crc : Get CRC binary version --------------------------------------- 0.78s
rhol_crc : Ensure directories exist ------------------------------------- 0.66s
manage_secrets : Create file from content ------------------------------- 0.44s
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.29s
manage_secrets : Ensure directory tree exist ---------------------------- 0.21s
rhol_crc : Revoke permissions granted in sudoers file for CRC/RHOL setup --- 0.20s
rhol_crc : Set RHOL/CRC configuration options --------------------------- 0.05s
Ensure pull-secret is in place if we need to configure CRC -------------- 0.04s
rhol_crc : Extract versions --------------------------------------------- 0.04s
rhol_crc : Clean RHOL/CRC if wanted ------------------------------------- 0.04s
rhol_crc : Get versions if binary is available -------------------------- 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.03s
rhol_crc : Fail if crc domain is already defined ------------------------ 0.03s
PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025 00:43:15 +0000 (0:00:00.014) 0:00:00.014 *****
ok: [instance]
TASK [rhol_crc : Check RHOL/CRC binary exists] *********************************
Wednesday 08 October 2025 00:43:15 +0000 (0:00:00.850) 0:00:00.865 *****
ok: [instance]
TASK [rhol_crc : Delete RHOL/CRC instance and associated configuration] ********
Wednesday 08 October 2025 00:43:16 +0000 (0:00:00.276) 0:00:01.141 *****
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0
Wednesday 08 October 2025 00:43:19 +0000 (0:00:03.515) 0:00:04.657 *****
===============================================================================
rhol_crc : Delete RHOL/CRC instance and associated configuration -------- 3.52s
Gathering Facts --------------------------------------------------------- 0.85s
rhol_crc : Check RHOL/CRC binary exists --------------------------------- 0.28s