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

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

TASK [Create custom basedir] ***************************************************
Wednesday 08 October 2025  16:16:06 +0000 (0:00:00.826)       0:00:00.839 *****
changed: [instance]

TASK [test_deps : Gather facts if they don't exist] ****************************
Wednesday 08 October 2025  16:16:06 +0000 (0:00:00.310)       0:00:01.150 *****
skipping: [instance]

TASK [test_deps : Gather variables for each operating system] ******************
Wednesday 08 October 2025  16:16:06 +0000 (0:00:00.017)       0:00:01.168 *****
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  16:16:06 +0000 (0:00:00.041)       0:00:01.210 *****
ok: [instance]

TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Wednesday 08 October 2025  16:16:07 +0000 (0:00:00.290)       0:00:01.500 *****
ok: [instance]

TASK [test_deps : Disable ubi 9 repos] *****************************************
Wednesday 08 October 2025  16:16:07 +0000 (0:00:00.207)       0:00:01.708 *****
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  16:16:08 +0000 (0:00:00.710)       0:00:02.418 *****

TASK [repo_setup : Ensure directories are present] *****************************
Wednesday 08 October 2025  16:16:08 +0000 (0:00:00.058)       0:00:02.477 *****
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  16:16:08 +0000 (0:00:00.543)       0:00:03.020 *****
ok: [instance]

TASK [repo_setup : Get repo-setup repository] **********************************
Wednesday 08 October 2025  16:16:09 +0000 (0:00:00.802)       0:00:03.823 *****
changed: [instance]

TASK [repo_setup : Initialize python venv and install requirements] ************
Wednesday 08 October 2025  16:16:10 +0000 (0:00:01.190)       0:00:05.013 *****
changed: [instance]

TASK [repo_setup : Install repo-setup package] *********************************
Wednesday 08 October 2025  16:16:18 +0000 (0:00:07.933)       0:00:12.946 *****
changed: [instance]

TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Wednesday 08 October 2025  16:16:19 +0000 (0:00:00.719)       0:00:13.666 *****
skipping: [instance]

TASK [repo_setup : Run repo-setup] *********************************************
Wednesday 08 October 2025  16:16:19 +0000 (0:00:00.023)       0:00:13.689 *****
changed: [instance]

TASK [repo_setup : Get component repo] *****************************************
Wednesday 08 October 2025  16:16:20 +0000 (0:00:00.820)       0:00:14.509 *****
skipping: [instance]

TASK [repo_setup : Rename component repo] **************************************
Wednesday 08 October 2025  16:16:20 +0000 (0:00:00.034)       0:00:14.544 *****
skipping: [instance]

TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Wednesday 08 October 2025  16:16:20 +0000 (0:00:00.034)       0:00:14.579 *****
skipping: [instance]

TASK [repo_setup : Run repo-setup-get-hash] ************************************
Wednesday 08 October 2025  16:16:20 +0000 (0:00:00.034)       0:00:14.614 *****
changed: [instance]

TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Wednesday 08 October 2025  16:16:20 +0000 (0:00:00.564)       0:00:15.178 *****
changed: [instance]

TASK [repo_setup : Dump current-podified hash] *********************************
Wednesday 08 October 2025  16:16:21 +0000 (0:00:00.439)       0:00:15.618 *****
skipping: [instance]

TASK [repo_setup : Slurp current podified hash] ********************************
Wednesday 08 October 2025  16:16:21 +0000 (0:00:00.029)       0:00:15.647 *****
skipping: [instance]

TASK [repo_setup : Update the value of full_hash] ******************************
Wednesday 08 October 2025  16:16:21 +0000 (0:00:00.030)       0:00:15.677 *****
skipping: [instance]

TASK [repo_setup : Export hashes facts for further use] ************************
Wednesday 08 October 2025  16:16:21 +0000 (0:00:00.029)       0:00:15.707 *****
ok: [instance]

TASK [repo_setup : Create download directory] **********************************
Wednesday 08 October 2025  16:16:21 +0000 (0:00:00.038)       0:00:15.746 *****
skipping: [instance]

TASK [repo_setup : Print the URL to request] ***********************************
Wednesday 08 October 2025  16:16:21 +0000 (0:00:00.027)       0:00:15.773 *****
skipping: [instance]

TASK [Download the RPM] ********************************************************
Wednesday 08 October 2025  16:16:21 +0000 (0:00:00.026)       0:00:15.800 *****
skipping: [instance]

TASK [repo_setup : Install RHOS Release tool] **********************************
Wednesday 08 October 2025  16:16:21 +0000 (0:00:00.026)       0:00:15.827 *****
skipping: [instance]

TASK [repo_setup : Get rhos-release tool version] ******************************
Wednesday 08 October 2025  16:16:21 +0000 (0:00:00.026)       0:00:15.854 *****
skipping: [instance]

TASK [repo_setup : Print rhos-release tool version] ****************************
Wednesday 08 October 2025  16:16:21 +0000 (0:00:00.026)       0:00:15.881 *****
skipping: [instance]

TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Wednesday 08 October 2025  16:16:21 +0000 (0:00:00.029)       0:00:15.910 *****
skipping: [instance]

TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Wednesday 08 October 2025  16:16:21 +0000 (0:00:00.030)       0:00:15.941 *****
ok: [instance]

TASK [repo_setup : Use RDO proxy mirrors] **************************************
Wednesday 08 October 2025  16:16:21 +0000 (0:00:00.190)       0:00:16.132 *****
changed: [instance]

TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Wednesday 08 October 2025  16:16:22 +0000 (0:00:00.211)       0:00:16.343 *****
changed: [instance]

TASK [repo_setup : Check for gating.repo file on content provider] *************
Wednesday 08 October 2025  16:16:22 +0000 (0:00:00.225)       0:00:16.569 *****
skipping: [instance]

TASK [repo_setup : Populate gating repo from content provider ip] **************
Wednesday 08 October 2025  16:16:22 +0000 (0:00:00.021)       0:00:16.591 *****
skipping: [instance]

TASK [repo_setup : Check for DLRN repo at the destination] *********************
Wednesday 08 October 2025  16:16:22 +0000 (0:00:00.021)       0:00:16.612 *****
skipping: [instance]

TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Wednesday 08 October 2025  16:16:22 +0000 (0:00:00.020)       0:00:16.633 *****
skipping: [instance]

TASK [repo_setup : Check for DLRN component repo] ******************************
Wednesday 08 October 2025  16:16:22 +0000 (0:00:00.020)       0:00:16.654 *****
skipping: [instance]

TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
Wednesday 08 October 2025  16:16:22 +0000 (0:00:00.021)       0:00:16.676 *****
skipping: [instance]

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

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

TASK [repo_setup : Cleanup existing metadata] **********************************
Wednesday 08 October 2025  16:16:22 +0000 (0:00:00.028)       0:00:16.744 *****
skipping: [instance]

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

TASK [test_deps : Look for redhat-release rpm] *********************************
Wednesday 08 October 2025  16:16:22 +0000 (0:00:00.020)       0:00:16.781 *****
skipping: [instance]

TASK [test_deps : Remove redhat-release] ***************************************
Wednesday 08 October 2025  16:16:22 +0000 (0:00:00.029)       0:00:16.810 *****
skipping: [instance]

TASK [test_deps : Install centos-stream-release] *******************************
Wednesday 08 October 2025  16:16:22 +0000 (0:00:00.030)       0:00:16.841 *****
skipping: [instance]

TASK [test_deps : Install additional packages] *********************************
Wednesday 08 October 2025  16:16:22 +0000 (0:00:00.030)       0:00:16.871 *****
skipping: [instance]

TASK [test_deps : Install selinux python libs] *********************************
Wednesday 08 October 2025  16:16:22 +0000 (0:00:00.029)       0:00:16.900 *****
ok: [instance]

TASK [test_deps : Install python yaml libs] ************************************
Wednesday 08 October 2025  16:17:09 +0000 (0:00:46.848)       0:01:03.749 *****
ok: [instance]

TASK [test_deps : Install extra packages] **************************************
Wednesday 08 October 2025  16:17:10 +0000 (0:00:01.163)       0:01:04.912 *****
skipping: [instance]

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

Wednesday 08 October 2025  16:17:10 +0000 (0:00:00.044)       0:01:04.956 *****
===============================================================================
test_deps : Install selinux python libs -------------------------------- 46.85s
repo_setup : Initialize python venv and install requirements ------------ 7.93s
repo_setup : Get repo-setup repository ---------------------------------- 1.19s
test_deps : Install python yaml libs ------------------------------------ 1.16s
Gathering Facts --------------------------------------------------------- 0.83s
repo_setup : Run repo-setup --------------------------------------------- 0.82s
repo_setup : Make sure git-core package is installed -------------------- 0.80s
repo_setup : Install repo-setup package --------------------------------- 0.72s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.71s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.56s
repo_setup : Ensure directories are present ----------------------------- 0.54s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.44s
Create custom basedir --------------------------------------------------- 0.31s
test_deps : Detect mirrors file ----------------------------------------- 0.29s
repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist) --- 0.23s
repo_setup : Use RDO proxy mirrors -------------------------------------- 0.21s
test_deps : Disable ubi host subscription-manager integration ----------- 0.21s
repo_setup : Check for /etc/ci/mirror_info.sh --------------------------- 0.19s
Deploy repo-setup ------------------------------------------------------- 0.06s
test_deps : Install extra packages -------------------------------------- 0.04s

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

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

TASK [Crate SSH keypair] *******************************************************
Wednesday 08 October 2025  16:17:12 +0000 (0:00:00.809)       0:00:00.823 *****
changed: [instance]

TASK [Add SSH jumper entries] **************************************************
Wednesday 08 October 2025  16:17:12 +0000 (0:00:00.375)       0:00:01.198 *****

TASK [ssh_jumper : Create ssh-jumper entries] **********************************
Wednesday 08 October 2025  16:17:12 +0000 (0:00:00.025)       0:00:01.223 *****
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ssh_jumper/tasks/manage_ssh_jumper_entry.yml for instance => (item={'ssh_dir': '/opt/basedir/ssh', 'hostname': '192.168.250.10', 'proxy_host': 'proxy.example.com', 'proxy_user': 'cloud-user', 'patterns': ['test', 'test.node']})
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ssh_jumper/tasks/manage_ssh_jumper_entry.yml for instance => (item={'hostname': 'minimal.example.com', 'ssh_dir': '/opt/basedir/ssh'})
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ssh_jumper/tasks/manage_ssh_jumper_entry.yml for instance => (item={'target': 'instance', 'ssh_dir': '/opt/basedir/ssh', 'hostname': '192.168.250.11', 'identity_file': '/opt/basedir/ssh/id_test', 'patterns': ['test', 'test.node']})

TASK [ssh_jumper : Make sure ~/.ssh/cifmw_ssh_config.d directory exists] *******
Wednesday 08 October 2025  16:17:12 +0000 (0:00:00.036)       0:00:01.260 *****
changed: [instance]

TASK [ssh_jumper : Include ~/.ssh/cifmw_ssh_config.d/inventory_hostname/*.conf] ***
Wednesday 08 October 2025  16:17:12 +0000 (0:00:00.308)       0:00:01.569 *****
changed: [instance]

TASK [ssh_jumper : Inject ssh jumpers for 192.168.250.10] **********************
Wednesday 08 October 2025  16:17:13 +0000 (0:00:00.293)       0:00:01.862 *****
changed: [instance]

TASK [ssh_jumper : Make sure ~/.ssh/cifmw_ssh_config.d directory exists] *******
Wednesday 08 October 2025  16:17:13 +0000 (0:00:00.553)       0:00:02.416 *****
ok: [instance]

TASK [ssh_jumper : Include ~/.ssh/cifmw_ssh_config.d/inventory_hostname/*.conf] ***
Wednesday 08 October 2025  16:17:13 +0000 (0:00:00.199)       0:00:02.615 *****
ok: [instance]

TASK [ssh_jumper : Inject ssh jumpers for minimal.example.com] *****************
Wednesday 08 October 2025  16:17:14 +0000 (0:00:00.192)       0:00:02.807 *****
changed: [instance]

TASK [ssh_jumper : Make sure ~/.ssh/cifmw_ssh_config.d directory exists] *******
Wednesday 08 October 2025  16:17:14 +0000 (0:00:00.351)       0:00:03.159 *****
ok: [instance]

TASK [ssh_jumper : Include ~/.ssh/cifmw_ssh_config.d/inventory_hostname/*.conf] ***
Wednesday 08 October 2025  16:17:14 +0000 (0:00:00.200)       0:00:03.359 *****
ok: [instance]

TASK [ssh_jumper : Inject ssh jumpers for 192.168.250.11] **********************
Wednesday 08 October 2025  16:17:14 +0000 (0:00:00.196)       0:00:03.556 *****
changed: [instance]

TASK [Slurp ssh/config] ********************************************************
Wednesday 08 October 2025  16:17:15 +0000 (0:00:00.364)       0:00:03.920 *****
ok: [instance]

TASK [Slurp ssh/cifmw_ssh_config.d/minimal.example.com.conf] *******************
Wednesday 08 October 2025  16:17:15 +0000 (0:00:00.270)       0:00:04.190 *****
ok: [instance]

TASK [Slurp ssh/cifmw_ssh_config.d/192.168.250.10.conf] ************************
Wednesday 08 October 2025  16:17:15 +0000 (0:00:00.167)       0:00:04.358 *****
ok: [instance]

TASK [Slurp ssh/cifmw_ssh_config.d/192.168.250.11.conf] ************************
Wednesday 08 October 2025  16:17:15 +0000 (0:00:00.170)       0:00:04.529 *****
ok: [instance]

TASK [Assert Include in ssh_config] ********************************************
Wednesday 08 October 2025  16:17:15 +0000 (0:00:00.178)       0:00:04.707 *****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Assert SSH host - minimal config] ****************************************
Wednesday 08 October 2025  16:17:15 +0000 (0:00:00.029)       0:00:04.737 *****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Assert cifmw-192.168.250.10.conf] ****************************************
Wednesday 08 October 2025  16:17:15 +0000 (0:00:00.030)       0:00:04.768 *****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Assert cifmw-192.168.250.11.conf] ****************************************
Wednesday 08 October 2025  16:17:16 +0000 (0:00:00.030)       0:00:04.798 *****
ok: [instance] => changed=false
  msg: All assertions passed

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

Wednesday 08 October 2025  16:17:16 +0000 (0:00:00.043)       0:00:04.842 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 0.81s
ssh_jumper : Inject ssh jumpers for 192.168.250.10 ---------------------- 0.55s
Crate SSH keypair ------------------------------------------------------- 0.38s
ssh_jumper : Inject ssh jumpers for 192.168.250.11 ---------------------- 0.36s
ssh_jumper : Inject ssh jumpers for minimal.example.com ----------------- 0.35s
ssh_jumper : Make sure ~/.ssh/cifmw_ssh_config.d directory exists ------- 0.31s
ssh_jumper : Include ~/.ssh/cifmw_ssh_config.d/inventory_hostname/*.conf --- 0.29s
Slurp ssh/config -------------------------------------------------------- 0.27s
ssh_jumper : Make sure ~/.ssh/cifmw_ssh_config.d directory exists ------- 0.20s
ssh_jumper : Make sure ~/.ssh/cifmw_ssh_config.d directory exists ------- 0.20s
ssh_jumper : Include ~/.ssh/cifmw_ssh_config.d/inventory_hostname/*.conf --- 0.20s
ssh_jumper : Include ~/.ssh/cifmw_ssh_config.d/inventory_hostname/*.conf --- 0.19s
Slurp ssh/cifmw_ssh_config.d/192.168.250.11.conf ------------------------ 0.18s
Slurp ssh/cifmw_ssh_config.d/192.168.250.10.conf ------------------------ 0.17s
Slurp ssh/cifmw_ssh_config.d/minimal.example.com.conf ------------------- 0.17s
Assert cifmw-192.168.250.11.conf ---------------------------------------- 0.04s
ssh_jumper : Create ssh-jumper entries ---------------------------------- 0.04s
Assert SSH host - minimal config ---------------------------------------- 0.03s
Assert cifmw-192.168.250.10.conf ---------------------------------------- 0.03s
Assert Include in ssh_config -------------------------------------------- 0.03s

PLAY [Cleanup] *****************************************************************

TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025  16:17:16 +0000 (0:00:00.036)       0:00:00.036 *****
ok: [instance]

TASK [Cleanup SSH jumper hosts] ************************************************
Wednesday 08 October 2025  16:17:17 +0000 (0:00:00.786)       0:00:00.822 *****

TASK [ssh_jumper : Remove Include cifmw_ssh_config.d] **************************
Wednesday 08 October 2025  16:17:17 +0000 (0:00:00.024)       0:00:00.847 *****
changed: [instance]

TASK [ssh_jumper : Remove cifmw_ssh_config.d directory] ************************
Wednesday 08 October 2025  16:17:17 +0000 (0:00:00.296)       0:00:01.144 *****
changed: [instance]

PLAY RECAP *********************************************************************
instance                   : ok=3    changed=2    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0

Wednesday 08 October 2025  16:17:17 +0000 (0:00:00.308)       0:00:01.452 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 0.79s
ssh_jumper : Remove cifmw_ssh_config.d directory ------------------------ 0.31s
ssh_jumper : Remove Include cifmw_ssh_config.d -------------------------- 0.30s
Cleanup SSH jumper hosts ------------------------------------------------ 0.02s