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

TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025  11:53:40 +0000 (0:00:00.013)       0:00:00.013 *****
ok: [instance]

TASK [test_deps : Gather facts if they don't exist] ****************************
Wednesday 08 October 2025  11:53:41 +0000 (0:00:00.849)       0:00:00.862 *****
skipping: [instance]

TASK [test_deps : Gather variables for each operating system] ******************
Wednesday 08 October 2025  11:53:41 +0000 (0:00:00.019)       0:00:00.881 *****
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  11:53:41 +0000 (0:00:00.042)       0:00:00.923 *****
ok: [instance]

TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Wednesday 08 October 2025  11:53:41 +0000 (0:00:00.283)       0:00:01.207 *****
ok: [instance]

TASK [test_deps : Disable ubi 9 repos] *****************************************
Wednesday 08 October 2025  11:53:41 +0000 (0:00:00.312)       0:00:01.520 *****
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  11:53:42 +0000 (0:00:00.675)       0:00:02.195 *****

TASK [repo_setup : Ensure directories are present] *****************************
Wednesday 08 October 2025  11:53:42 +0000 (0:00:00.059)       0:00:02.255 *****
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  11:53:43 +0000 (0:00:00.543)       0:00:02.799 *****
ok: [instance]

TASK [repo_setup : Get repo-setup repository] **********************************
Wednesday 08 October 2025  11:53:43 +0000 (0:00:00.807)       0:00:03.606 *****
changed: [instance]

TASK [repo_setup : Initialize python venv and install requirements] ************
Wednesday 08 October 2025  11:53:45 +0000 (0:00:01.166)       0:00:04.773 *****
changed: [instance]

TASK [repo_setup : Install repo-setup package] *********************************
Wednesday 08 October 2025  11:53:53 +0000 (0:00:07.990)       0:00:12.763 *****
changed: [instance]

TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Wednesday 08 October 2025  11:53:53 +0000 (0:00:00.741)       0:00:13.505 *****
skipping: [instance]

TASK [repo_setup : Run repo-setup] *********************************************
Wednesday 08 October 2025  11:53:53 +0000 (0:00:00.022)       0:00:13.527 *****
changed: [instance]

TASK [repo_setup : Get component repo] *****************************************
Wednesday 08 October 2025  11:53:54 +0000 (0:00:00.844)       0:00:14.372 *****
skipping: [instance]

TASK [repo_setup : Rename component repo] **************************************
Wednesday 08 October 2025  11:53:54 +0000 (0:00:00.038)       0:00:14.411 *****
skipping: [instance]

TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Wednesday 08 October 2025  11:53:54 +0000 (0:00:00.036)       0:00:14.447 *****
skipping: [instance]

TASK [repo_setup : Run repo-setup-get-hash] ************************************
Wednesday 08 October 2025  11:53:54 +0000 (0:00:00.035)       0:00:14.483 *****
changed: [instance]

TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Wednesday 08 October 2025  11:53:55 +0000 (0:00:00.583)       0:00:15.066 *****
changed: [instance]

TASK [repo_setup : Dump current-podified hash] *********************************
Wednesday 08 October 2025  11:53:55 +0000 (0:00:00.482)       0:00:15.549 *****
skipping: [instance]

TASK [repo_setup : Slurp current podified hash] ********************************
Wednesday 08 October 2025  11:53:55 +0000 (0:00:00.029)       0:00:15.579 *****
skipping: [instance]

TASK [repo_setup : Update the value of full_hash] ******************************
Wednesday 08 October 2025  11:53:55 +0000 (0:00:00.029)       0:00:15.608 *****
skipping: [instance]

TASK [repo_setup : Export hashes facts for further use] ************************
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.029)       0:00:15.638 *****
ok: [instance]

TASK [repo_setup : Create download directory] **********************************
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.038)       0:00:15.676 *****
skipping: [instance]

TASK [repo_setup : Print the URL to request] ***********************************
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.027)       0:00:15.704 *****
skipping: [instance]

TASK [Download the RPM] ********************************************************
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.028)       0:00:15.732 *****
skipping: [instance]

TASK [repo_setup : Install RHOS Release tool] **********************************
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.027)       0:00:15.759 *****
skipping: [instance]

TASK [repo_setup : Get rhos-release tool version] ******************************
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.026)       0:00:15.786 *****
skipping: [instance]

TASK [repo_setup : Print rhos-release tool version] ****************************
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.026)       0:00:15.812 *****
skipping: [instance]

TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.028)       0:00:15.840 *****
skipping: [instance]

TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.025)       0:00:15.866 *****
ok: [instance]

TASK [repo_setup : Use RDO proxy mirrors] **************************************
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.183)       0:00:16.050 *****
changed: [instance]

TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.212)       0:00:16.262 *****
changed: [instance]

TASK [repo_setup : Check for gating.repo file on content provider] *************
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.227)       0:00:16.489 *****
skipping: [instance]

TASK [repo_setup : Populate gating repo from content provider ip] **************
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.021)       0:00:16.511 *****
skipping: [instance]

TASK [repo_setup : Check for DLRN repo at the destination] *********************
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.022)       0:00:16.533 *****
skipping: [instance]

TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.022)       0:00:16.555 *****
skipping: [instance]

TASK [repo_setup : Check for DLRN component repo] ******************************
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.022)       0:00:16.578 *****
skipping: [instance]

TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.022)       0:00:16.600 *****
skipping: [instance]

TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Wednesday 08 October 2025  11:53:56 +0000 (0:00:00.022)       0:00:16.622 *****
skipping: [instance]

TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Wednesday 08 October 2025  11:53:57 +0000 (0:00:00.016)       0:00:16.639 *****
skipping: [instance]

TASK [repo_setup : Cleanup existing metadata] **********************************
Wednesday 08 October 2025  11:53:57 +0000 (0:00:00.028)       0:00:16.668 *****
skipping: [instance]

TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Wednesday 08 October 2025  11:53:57 +0000 (0:00:00.016)       0:00:16.684 *****
skipping: [instance]

TASK [test_deps : Look for redhat-release rpm] *********************************
Wednesday 08 October 2025  11:53:57 +0000 (0:00:00.020)       0:00:16.705 *****
skipping: [instance]

TASK [test_deps : Remove redhat-release] ***************************************
Wednesday 08 October 2025  11:53:57 +0000 (0:00:00.029)       0:00:16.735 *****
skipping: [instance]

TASK [test_deps : Install centos-stream-release] *******************************
Wednesday 08 October 2025  11:53:57 +0000 (0:00:00.029)       0:00:16.764 *****
skipping: [instance]

TASK [test_deps : Install additional packages] *********************************
Wednesday 08 October 2025  11:53:57 +0000 (0:00:00.029)       0:00:16.794 *****
skipping: [instance]

TASK [test_deps : Install selinux python libs] *********************************
Wednesday 08 October 2025  11:53:57 +0000 (0:00:00.031)       0:00:16.826 *****
ok: [instance]

TASK [test_deps : Install python yaml libs] ************************************
Wednesday 08 October 2025  11:54:45 +0000 (0:00:48.677)       0:01:05.503 *****
ok: [instance]

TASK [test_deps : Install extra packages] **************************************
Wednesday 08 October 2025  11:54:47 +0000 (0:00:01.221)       0:01:06.724 *****
skipping: [instance]

TASK [Ensure CRC is started] ***************************************************
Wednesday 08 October 2025  11:54:47 +0000 (0:00:00.037)       0:01:06.761 *****
changed: [instance]

PLAY RECAP *********************************************************************
instance                   : ok=20   changed=10   unreachable=0    failed=0    skipped=30   rescued=0    ignored=0

Wednesday 08 October 2025  11:57:34 +0000 (0:02:46.898)       0:03:53.660 *****
===============================================================================
Ensure CRC is started ------------------------------------------------- 166.90s
test_deps : Install selinux python libs -------------------------------- 48.68s
repo_setup : Initialize python venv and install requirements ------------ 7.99s
test_deps : Install python yaml libs ------------------------------------ 1.22s
repo_setup : Get repo-setup repository ---------------------------------- 1.17s
Gathering Facts --------------------------------------------------------- 0.85s
repo_setup : Run repo-setup --------------------------------------------- 0.84s
repo_setup : Make sure git-core package is installed -------------------- 0.81s
repo_setup : Install repo-setup package --------------------------------- 0.74s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.68s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.58s
repo_setup : Ensure directories are present ----------------------------- 0.54s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.48s
test_deps : Disable ubi host subscription-manager integration ----------- 0.31s
test_deps : Detect mirrors file ----------------------------------------- 0.28s
repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist) --- 0.23s
repo_setup : Use RDO proxy mirrors -------------------------------------- 0.21s
repo_setup : Check for /etc/ci/mirror_info.sh --------------------------- 0.18s
Deploy repo-setup ------------------------------------------------------- 0.06s
test_deps : Gather variables for each operating system ------------------ 0.04s

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

TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025  11:57:34 +0000 (0:00:00.017)       0:00:00.017 *****
ok: [instance]

TASK [openshift_setup : Ensure output directory exists] ************************
Wednesday 08 October 2025  11:57:35 +0000 (0:00:00.875)       0:00:00.893 *****
ok: [instance]

TASK [openshift_setup : Fetch namespaces to create] ****************************
Wednesday 08 October 2025  11:57:35 +0000 (0:00:00.310)       0:00:01.204 *****
ok: [instance]

TASK [openshift_setup : Create required namespaces] ****************************
Wednesday 08 October 2025  11:57:35 +0000 (0:00:00.039)       0:00:01.244 *****
changed: [instance] => (item=openstack)
changed: [instance] => (item=openstack-operators)

TASK [openshift_setup : Get internal OpenShift registry route] *****************
Wednesday 08 October 2025  11:57:37 +0000 (0:00:01.449)       0:00:02.693 *****
ok: [instance]

TASK [openshift_setup : Allow anonymous image-pulls in CRC registry for targeted namespaces] ***
Wednesday 08 October 2025  11:57:49 +0000 (0:00:11.978)       0:00:14.671 *****
skipping: [instance] => (item=openstack)
skipping: [instance] => (item=openstack-operators)
skipping: [instance]

TASK [openshift_setup : Wait for the image registry to be ready] ***************
Wednesday 08 October 2025  11:57:49 +0000 (0:00:00.048)       0:00:14.720 *****
skipping: [instance]

TASK [openshift_setup : Login into OpenShift internal registry] ****************
Wednesday 08 October 2025  11:57:49 +0000 (0:00:00.028)       0:00:14.748 *****
skipping: [instance]

TASK [Ensure we have custom CA installed on host] ******************************
Wednesday 08 October 2025  11:57:49 +0000 (0:00:00.023)       0:00:14.772 *****

TASK [install_ca : Ensure target directory exists] *****************************
Wednesday 08 October 2025  11:57:49 +0000 (0:00:00.036)       0:00:14.808 *****
ok: [instance]

TASK [install_ca : Install internal CA from url] *******************************
Wednesday 08 October 2025  11:57:49 +0000 (0:00:00.228)       0:00:15.036 *****
skipping: [instance]

TASK [install_ca : Install custom CA bundle from inline] ***********************
Wednesday 08 October 2025  11:57:49 +0000 (0:00:00.028)       0:00:15.065 *****
skipping: [instance]

TASK [install_ca : Install custom CA bundle from file] *************************
Wednesday 08 October 2025  11:57:49 +0000 (0:00:00.027)       0:00:15.093 *****
skipping: [instance]

TASK [install_ca : Update ca bundle] *******************************************
Wednesday 08 October 2025  11:57:49 +0000 (0:00:00.029)       0:00:15.122 *****
changed: [instance]

TASK [openshift_setup : Update ca bundle] **************************************
Wednesday 08 October 2025  11:57:50 +0000 (0:00:01.271)       0:00:16.394 *****
changed: [instance]

TASK [openshift_setup : Slurp CAs file] ****************************************
Wednesday 08 October 2025  11:57:52 +0000 (0:00:01.109)       0:00:17.504 *****
ok: [instance]

TASK [openshift_setup : Create config map with registry CAs] *******************
Wednesday 08 October 2025  11:57:52 +0000 (0:00:00.300)       0:00:17.804 *****
changed: [instance]

TASK [openshift_setup : Install Red Hat CA for pulling images from internal registry] ***
Wednesday 08 October 2025  11:57:53 +0000 (0:00:00.717)       0:00:18.522 *****
changed: [instance]

TASK [openshift_setup : Add insecure registry] *********************************
Wednesday 08 October 2025  11:57:53 +0000 (0:00:00.678)       0:00:19.201 *****
skipping: [instance]

TASK [openshift_setup : Create a ICSP with repository digest mirrors] **********
Wednesday 08 October 2025  11:57:53 +0000 (0:00:00.025)       0:00:19.226 *****
changed: [instance]

TASK [openshift_setup : Metal3 tweaks] *****************************************
Wednesday 08 October 2025  11:57:54 +0000 (0:00:00.743)       0:00:19.969 *****
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/openshift_setup/tasks/metal3_config.yml for instance

TASK [openshift_setup : Fetch Metal3 configuration name] ***********************
Wednesday 08 October 2025  11:57:54 +0000 (0:00:00.030)       0:00:20.000 *****
skipping: [instance]

TASK [openshift_setup : Apply the patch to Metal3 Provisioning] ****************
Wednesday 08 October 2025  11:57:54 +0000 (0:00:00.031)       0:00:20.031 *****
skipping: [instance]

TASK [openshift_setup : Gather network.operator info] **************************
Wednesday 08 October 2025  11:57:54 +0000 (0:00:00.030)       0:00:20.062 *****
ok: [instance]

TASK [openshift_setup : Patch network operator] ********************************
Wednesday 08 October 2025  11:57:55 +0000 (0:00:00.712)       0:00:20.774 *****
changed: [instance]

TASK [openshift_setup : Patch samples registry configuration] ******************
Wednesday 08 October 2025  11:57:56 +0000 (0:00:00.926)       0:00:21.701 *****
changed: [instance]

TASK [openshift_setup : Delete the pods from openshift-marketplace namespace] ***
Wednesday 08 October 2025  11:57:56 +0000 (0:00:00.715)       0:00:22.417 *****
skipping: [instance]

TASK [openshift_setup : Wait for openshift-marketplace pods to be running] *****
Wednesday 08 October 2025  11:57:56 +0000 (0:00:00.021)       0:00:22.439 *****
skipping: [instance]

TASK [Check that config map is created] ****************************************
Wednesday 08 October 2025  11:57:56 +0000 (0:00:00.026)       0:00:22.466 *****
ok: [instance]

TASK [Assert that configmap was created] ***************************************
Wednesday 08 October 2025  11:57:57 +0000 (0:00:00.720)       0:00:23.186 *****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Check that Image cluster is patched] *************************************
Wednesday 08 October 2025  11:57:57 +0000 (0:00:00.028)       0:00:23.215 *****
ok: [instance]

TASK [Assert that cluster was patched] *****************************************
Wednesday 08 October 2025  11:57:58 +0000 (0:00:00.783)       0:00:23.999 *****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Check that registry mirror resource is created] **************************
Wednesday 08 October 2025  11:57:58 +0000 (0:00:00.033)       0:00:24.033 *****
ok: [instance]

TASK [Assert that digest mirrors are correct] **********************************
Wednesday 08 October 2025  11:57:59 +0000 (0:00:00.763)       0:00:24.796 *****
ok: [instance] => changed=false
  msg: All assertions passed

PLAY RECAP *********************************************************************
instance                   : ok=22   changed=8    unreachable=0    failed=0    skipped=11   rescued=0    ignored=0

Wednesday 08 October 2025  11:57:59 +0000 (0:00:00.038)       0:00:24.835 *****
===============================================================================
openshift_setup : Get internal OpenShift registry route ---------------- 11.98s
openshift_setup : Create required namespaces ---------------------------- 1.45s
install_ca : Update ca bundle ------------------------------------------- 1.27s
openshift_setup : Update ca bundle -------------------------------------- 1.11s
openshift_setup : Patch network operator -------------------------------- 0.93s
Gathering Facts --------------------------------------------------------- 0.88s
Check that Image cluster is patched ------------------------------------- 0.78s
Check that registry mirror resource is created -------------------------- 0.76s
openshift_setup : Create a ICSP with repository digest mirrors ---------- 0.74s
Check that config map is created ---------------------------------------- 0.72s
openshift_setup : Create config map with registry CAs ------------------- 0.72s
openshift_setup : Patch samples registry configuration ------------------ 0.72s
openshift_setup : Gather network.operator info -------------------------- 0.71s
openshift_setup : Install Red Hat CA for pulling images from internal registry --- 0.68s
openshift_setup : Ensure output directory exists ------------------------ 0.31s
openshift_setup : Slurp CAs file ---------------------------------------- 0.30s
install_ca : Ensure target directory exists ----------------------------- 0.23s
openshift_setup : Allow anonymous image-pulls in CRC registry for targeted namespaces --- 0.05s
openshift_setup : Fetch namespaces to create ---------------------------- 0.04s
Assert that digest mirrors are correct ---------------------------------- 0.04s