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

TASK [Gathering Facts] *********************************************************
Thursday 02 October 2025  16:45:11 +0000 (0:00:00.012)       0:00:00.012 ******
ok: [instance]

TASK [test_deps : Gather facts if they don't exist] ****************************
Thursday 02 October 2025  16:45:11 +0000 (0:00:00.845)       0:00:00.857 ******
skipping: [instance]

TASK [test_deps : Gather variables for each operating system] ******************
Thursday 02 October 2025  16:45:11 +0000 (0:00:00.017)       0:00:00.875 ******
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] *****************************************
Thursday 02 October 2025  16:45:11 +0000 (0:00:00.041)       0:00:00.916 ******
ok: [instance]

TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Thursday 02 October 2025  16:45:12 +0000 (0:00:00.280)       0:00:01.196 ******
ok: [instance]

TASK [test_deps : Disable ubi 9 repos] *****************************************
Thursday 02 October 2025  16:45:12 +0000 (0:00:00.309)       0:00:01.505 ******
ok: [instance] => (item=ubi-9-appstream)
ok: [instance] => (item=ubi-9-baseos)
ok: [instance] => (item=ubi-9-codeready-builder)

TASK [Deploy repo-setup] *******************************************************
Thursday 02 October 2025  16:45:13 +0000 (0:00:00.685)       0:00:02.191 ******

TASK [repo_setup : Ensure directories are present] *****************************
Thursday 02 October 2025  16:45:13 +0000 (0:00:00.059)       0:00:02.250 ******
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] ********************
Thursday 02 October 2025  16:45:13 +0000 (0:00:00.545)       0:00:02.795 ******
ok: [instance]

TASK [repo_setup : Get repo-setup repository] **********************************
Thursday 02 October 2025  16:45:14 +0000 (0:00:00.807)       0:00:03.603 ******
changed: [instance]

TASK [repo_setup : Initialize python venv and install requirements] ************
Thursday 02 October 2025  16:45:15 +0000 (0:00:01.191)       0:00:04.794 ******
changed: [instance]

TASK [repo_setup : Install repo-setup package] *********************************
Thursday 02 October 2025  16:45:24 +0000 (0:00:08.978)       0:00:13.773 ******
changed: [instance]

TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Thursday 02 October 2025  16:45:25 +0000 (0:00:00.712)       0:00:14.485 ******
skipping: [instance]

TASK [repo_setup : Run repo-setup] *********************************************
Thursday 02 October 2025  16:45:25 +0000 (0:00:00.021)       0:00:14.506 ******
changed: [instance]

TASK [repo_setup : Get component repo] *****************************************
Thursday 02 October 2025  16:45:26 +0000 (0:00:00.824)       0:00:15.331 ******
skipping: [instance]

TASK [repo_setup : Rename component repo] **************************************
Thursday 02 October 2025  16:45:26 +0000 (0:00:00.035)       0:00:15.367 ******
skipping: [instance]

TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Thursday 02 October 2025  16:45:26 +0000 (0:00:00.034)       0:00:15.401 ******
skipping: [instance]

TASK [repo_setup : Run repo-setup-get-hash] ************************************
Thursday 02 October 2025  16:45:26 +0000 (0:00:00.034)       0:00:15.436 ******
changed: [instance]

TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Thursday 02 October 2025  16:45:27 +0000 (0:00:00.857)       0:00:16.294 ******
changed: [instance]

TASK [repo_setup : Dump current-podified hash] *********************************
Thursday 02 October 2025  16:45:27 +0000 (0:00:00.438)       0:00:16.733 ******
skipping: [instance]

TASK [repo_setup : Slurp current podified hash] ********************************
Thursday 02 October 2025  16:45:27 +0000 (0:00:00.029)       0:00:16.762 ******
skipping: [instance]

TASK [repo_setup : Update the value of full_hash] ******************************
Thursday 02 October 2025  16:45:27 +0000 (0:00:00.028)       0:00:16.790 ******
skipping: [instance]

TASK [repo_setup : Export hashes facts for further use] ************************
Thursday 02 October 2025  16:45:27 +0000 (0:00:00.028)       0:00:16.819 ******
ok: [instance]

TASK [repo_setup : Create download directory] **********************************
Thursday 02 October 2025  16:45:27 +0000 (0:00:00.038)       0:00:16.858 ******
skipping: [instance]

TASK [repo_setup : Print the URL to request] ***********************************
Thursday 02 October 2025  16:45:27 +0000 (0:00:00.028)       0:00:16.886 ******
skipping: [instance]

TASK [Download the RPM] ********************************************************
Thursday 02 October 2025  16:45:27 +0000 (0:00:00.027)       0:00:16.914 ******
skipping: [instance]

TASK [repo_setup : Install RHOS Release tool] **********************************
Thursday 02 October 2025  16:45:27 +0000 (0:00:00.027)       0:00:16.941 ******
skipping: [instance]

TASK [repo_setup : Get rhos-release tool version] ******************************
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.026)       0:00:16.968 ******
skipping: [instance]

TASK [repo_setup : Print rhos-release tool version] ****************************
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.026)       0:00:16.995 ******
skipping: [instance]

TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.028)       0:00:17.023 ******
skipping: [instance]

TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.025)       0:00:17.049 ******
ok: [instance]

TASK [repo_setup : Use RDO proxy mirrors] **************************************
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.190)       0:00:17.240 ******
changed: [instance]

TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.204)       0:00:17.444 ******
changed: [instance]

TASK [repo_setup : Check for gating.repo file on content provider] *************
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.224)       0:00:17.668 ******
skipping: [instance]

TASK [repo_setup : Populate gating repo from content provider ip] **************
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.020)       0:00:17.689 ******
skipping: [instance]

TASK [repo_setup : Check for DLRN repo at the destination] *********************
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.021)       0:00:17.710 ******
skipping: [instance]

TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.020)       0:00:17.731 ******
skipping: [instance]

TASK [repo_setup : Check for DLRN component repo] ******************************
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.021)       0:00:17.752 ******
skipping: [instance]

TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.021)       0:00:17.774 ******
skipping: [instance]

TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.021)       0:00:17.795 ******
skipping: [instance]

TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.017)       0:00:17.812 ******
skipping: [instance]

TASK [repo_setup : Cleanup existing metadata] **********************************
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.028)       0:00:17.841 ******
skipping: [instance]

TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.015)       0:00:17.857 ******
skipping: [instance]

TASK [test_deps : Look for redhat-release rpm] *********************************
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.019)       0:00:17.876 ******
skipping: [instance]

TASK [test_deps : Remove redhat-release] ***************************************
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.029)       0:00:17.905 ******
skipping: [instance]

TASK [test_deps : Install centos-stream-release] *******************************
Thursday 02 October 2025  16:45:28 +0000 (0:00:00.029)       0:00:17.935 ******
skipping: [instance]

TASK [test_deps : Install additional packages] *********************************
Thursday 02 October 2025  16:45:29 +0000 (0:00:00.029)       0:00:17.965 ******
skipping: [instance]

TASK [test_deps : Install selinux python libs] *********************************
Thursday 02 October 2025  16:45:29 +0000 (0:00:00.029)       0:00:17.994 ******
ok: [instance]

TASK [test_deps : Install python yaml libs] ************************************
Thursday 02 October 2025  16:46:30 +0000 (0:01:01.026)       0:01:19.021 ******
ok: [instance]

TASK [test_deps : Install extra packages] **************************************
Thursday 02 October 2025  16:46:31 +0000 (0:00:01.189)       0:01:20.211 ******
skipping: [instance]

TASK [Ensure CRC is started] ***************************************************
Thursday 02 October 2025  16:46:31 +0000 (0:00:00.031)       0:01:20.242 ******
changed: [instance]

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

Thursday 02 October 2025  16:49:13 +0000 (0:02:42.202)       0:04:02.445 ******
===============================================================================
Ensure CRC is started ------------------------------------------------- 162.20s
test_deps : Install selinux python libs -------------------------------- 61.03s
repo_setup : Initialize python venv and install requirements ------------ 8.98s
repo_setup : Get repo-setup repository ---------------------------------- 1.19s
test_deps : Install python yaml libs ------------------------------------ 1.19s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.86s
Gathering Facts --------------------------------------------------------- 0.85s
repo_setup : Run repo-setup --------------------------------------------- 0.82s
repo_setup : Make sure git-core package is installed -------------------- 0.81s
repo_setup : Install repo-setup package --------------------------------- 0.71s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.69s
repo_setup : Ensure directories are present ----------------------------- 0.55s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.44s
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.22s
repo_setup : Use RDO proxy mirrors -------------------------------------- 0.20s
repo_setup : Check for /etc/ci/mirror_info.sh --------------------------- 0.19s
Deploy repo-setup ------------------------------------------------------- 0.06s
test_deps : Gather variables for each operating system ------------------ 0.04s

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

TASK [Gathering Facts] *********************************************************
Thursday 02 October 2025  16:49:14 +0000 (0:00:00.016)       0:00:00.016 ******
ok: [instance]

TASK [openshift_setup : Ensure output directory exists] ************************
Thursday 02 October 2025  16:49:14 +0000 (0:00:00.873)       0:00:00.890 ******
ok: [instance]

TASK [openshift_setup : Fetch namespaces to create] ****************************
Thursday 02 October 2025  16:49:15 +0000 (0:00:00.302)       0:00:01.192 ******
ok: [instance]

TASK [openshift_setup : Create required namespaces] ****************************
Thursday 02 October 2025  16:49:15 +0000 (0:00:00.036)       0:00:01.229 ******
changed: [instance] => (item=openstack)
changed: [instance] => (item=openstack-operators)

TASK [openshift_setup : Get internal OpenShift registry route] *****************
Thursday 02 October 2025  16:49:16 +0000 (0:00:01.383)       0:00:02.613 ******
ok: [instance]

TASK [openshift_setup : Allow anonymous image-pulls in CRC registry for targeted namespaces] ***
Thursday 02 October 2025  16:49:44 +0000 (0:00:27.766)       0:00:30.379 ******
skipping: [instance] => (item=openstack)
skipping: [instance] => (item=openstack-operators)
skipping: [instance]

TASK [openshift_setup : Wait for the image registry to be ready] ***************
Thursday 02 October 2025  16:49:44 +0000 (0:00:00.046)       0:00:30.426 ******
skipping: [instance]

TASK [openshift_setup : Login into OpenShift internal registry] ****************
Thursday 02 October 2025  16:49:44 +0000 (0:00:00.024)       0:00:30.450 ******
skipping: [instance]

TASK [Ensure we have custom CA installed on host] ******************************
Thursday 02 October 2025  16:49:44 +0000 (0:00:00.020)       0:00:30.471 ******

TASK [install_ca : Ensure target directory exists] *****************************
Thursday 02 October 2025  16:49:44 +0000 (0:00:00.037)       0:00:30.508 ******
ok: [instance]

TASK [install_ca : Install internal CA from url] *******************************
Thursday 02 October 2025  16:49:44 +0000 (0:00:00.231)       0:00:30.739 ******
skipping: [instance]

TASK [install_ca : Install custom CA bundle from inline] ***********************
Thursday 02 October 2025  16:49:44 +0000 (0:00:00.032)       0:00:30.772 ******
skipping: [instance]

TASK [install_ca : Install custom CA bundle from file] *************************
Thursday 02 October 2025  16:49:44 +0000 (0:00:00.027)       0:00:30.799 ******
skipping: [instance]

TASK [install_ca : Update ca bundle] *******************************************
Thursday 02 October 2025  16:49:44 +0000 (0:00:00.027)       0:00:30.827 ******
changed: [instance]

TASK [openshift_setup : Update ca bundle] **************************************
Thursday 02 October 2025  16:49:46 +0000 (0:00:01.282)       0:00:32.109 ******
changed: [instance]

TASK [openshift_setup : Slurp CAs file] ****************************************
Thursday 02 October 2025  16:49:47 +0000 (0:00:01.098)       0:00:33.208 ******
ok: [instance]

TASK [openshift_setup : Create config map with registry CAs] *******************
Thursday 02 October 2025  16:49:47 +0000 (0:00:00.283)       0:00:33.492 ******
changed: [instance]

TASK [openshift_setup : Install Red Hat CA for pulling images from internal registry] ***
Thursday 02 October 2025  16:49:48 +0000 (0:00:00.864)       0:00:34.356 ******
changed: [instance]

TASK [openshift_setup : Add insecure registry] *********************************
Thursday 02 October 2025  16:49:49 +0000 (0:00:00.743)       0:00:35.100 ******
skipping: [instance]

TASK [openshift_setup : Create a ICSP with repository digest mirrors] **********
Thursday 02 October 2025  16:49:49 +0000 (0:00:00.021)       0:00:35.122 ******
changed: [instance]

TASK [openshift_setup : Metal3 tweaks] *****************************************
Thursday 02 October 2025  16:49:49 +0000 (0:00:00.710)       0:00:35.832 ******
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] ***********************
Thursday 02 October 2025  16:49:49 +0000 (0:00:00.039)       0:00:35.872 ******
skipping: [instance]

TASK [openshift_setup : Apply the patch to Metal3 Provisioning] ****************
Thursday 02 October 2025  16:49:49 +0000 (0:00:00.043)       0:00:35.915 ******
skipping: [instance]

TASK [openshift_setup : Gather network.operator info] **************************
Thursday 02 October 2025  16:49:49 +0000 (0:00:00.036)       0:00:35.952 ******
ok: [instance]

TASK [openshift_setup : Patch network operator] ********************************
Thursday 02 October 2025  16:49:50 +0000 (0:00:00.702)       0:00:36.655 ******
changed: [instance]

TASK [openshift_setup : Patch samples registry configuration] ******************
Thursday 02 October 2025  16:49:51 +0000 (0:00:00.845)       0:00:37.500 ******
changed: [instance]

TASK [openshift_setup : Delete the pods from openshift-marketplace namespace] ***
Thursday 02 October 2025  16:49:52 +0000 (0:00:00.698)       0:00:38.199 ******
skipping: [instance]

TASK [openshift_setup : Wait for openshift-marketplace pods to be running] *****
Thursday 02 October 2025  16:49:52 +0000 (0:00:00.021)       0:00:38.220 ******
skipping: [instance]

TASK [Check that config map is created] ****************************************
Thursday 02 October 2025  16:49:52 +0000 (0:00:00.029)       0:00:38.250 ******
ok: [instance]

TASK [Assert that configmap was created] ***************************************
Thursday 02 October 2025  16:49:52 +0000 (0:00:00.657)       0:00:38.907 ******
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Check that Image cluster is patched] *************************************
Thursday 02 October 2025  16:49:52 +0000 (0:00:00.020)       0:00:38.928 ******
ok: [instance]

TASK [Assert that cluster was patched] *****************************************
Thursday 02 October 2025  16:49:53 +0000 (0:00:00.646)       0:00:39.574 ******
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Check that registry mirror resource is created] **************************
Thursday 02 October 2025  16:49:53 +0000 (0:00:00.022)       0:00:39.596 ******
ok: [instance]

TASK [Assert that digest mirrors are correct] **********************************
Thursday 02 October 2025  16:49:54 +0000 (0:00:00.617)       0:00:40.214 ******
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

Thursday 02 October 2025  16:49:54 +0000 (0:00:00.037)       0:00:40.251 ******
===============================================================================
openshift_setup : Get internal OpenShift registry route ---------------- 27.77s
openshift_setup : Create required namespaces ---------------------------- 1.38s
install_ca : Update ca bundle ------------------------------------------- 1.28s
openshift_setup : Update ca bundle -------------------------------------- 1.10s
Gathering Facts --------------------------------------------------------- 0.87s
openshift_setup : Create config map with registry CAs ------------------- 0.86s
openshift_setup : Patch network operator -------------------------------- 0.85s
openshift_setup : Install Red Hat CA for pulling images from internal registry --- 0.74s
openshift_setup : Create a ICSP with repository digest mirrors ---------- 0.71s
openshift_setup : Gather network.operator info -------------------------- 0.70s
openshift_setup : Patch samples registry configuration ------------------ 0.70s
Check that config map is created ---------------------------------------- 0.66s
Check that Image cluster is patched ------------------------------------- 0.65s
Check that registry mirror resource is created -------------------------- 0.62s
openshift_setup : Ensure output directory exists ------------------------ 0.30s
openshift_setup : Slurp CAs file ---------------------------------------- 0.28s
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 Metal3 configuration name ----------------------- 0.04s
openshift_setup : Metal3 tweaks ----------------------------------------- 0.04s