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

TASK [Gathering Facts] *********************************************************
Thursday 26 February 2026  21:14:35 +0000 (0:00:00.019)       0:00:00.019 *****
ok: [instance]

TASK [Create custom basedir] ***************************************************
Thursday 26 February 2026  21:14:36 +0000 (0:00:00.826)       0:00:00.845 *****
changed: [instance]

TASK [test_deps : Gather facts if they don't exist] ****************************
Thursday 26 February 2026  21:14:36 +0000 (0:00:00.307)       0:00:01.153 *****
skipping: [instance]

TASK [test_deps : Gather variables for each operating system] ******************
Thursday 26 February 2026  21:14:36 +0000 (0:00:00.017)       0:00:01.171 *****
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 26 February 2026  21:14:37 +0000 (0:00:00.041)       0:00:01.213 *****
ok: [instance]

TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Thursday 26 February 2026  21:14:37 +0000 (0:00:00.281)       0:00:01.494 *****
ok: [instance]

TASK [test_deps : Disable ubi 9 repos] *****************************************
Thursday 26 February 2026  21:14:37 +0000 (0:00:00.214)       0:00:01.709 *****
ok: [instance] => (item=ubi-9-appstream)
ok: [instance] => (item=ubi-9-baseos)
ok: [instance] => (item=ubi-9-codeready-builder)

TASK [Deploy repo-setup] *******************************************************
Thursday 26 February 2026  21:14:38 +0000 (0:00:00.684)       0:00:02.393 *****

TASK [repo_setup : Ensure directories are present] *****************************
Thursday 26 February 2026  21:14:38 +0000 (0:00:00.057)       0:00:02.451 *****
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 26 February 2026  21:14:38 +0000 (0:00:00.513)       0:00:02.965 *****
ok: [instance]

TASK [repo_setup : Get repo-setup repository] **********************************
Thursday 26 February 2026  21:14:39 +0000 (0:00:00.816)       0:00:03.781 *****
changed: [instance]

TASK [repo_setup : Initialize python venv and install requirements] ************
Thursday 26 February 2026  21:14:40 +0000 (0:00:01.086)       0:00:04.868 *****
changed: [instance]

TASK [repo_setup : Install repo-setup package] *********************************
Thursday 26 February 2026  21:14:48 +0000 (0:00:07.423)       0:00:12.292 *****
changed: [instance]

TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Thursday 26 February 2026  21:14:48 +0000 (0:00:00.676)       0:00:12.968 *****
skipping: [instance]

TASK [repo_setup : Run repo-setup] *********************************************
Thursday 26 February 2026  21:14:48 +0000 (0:00:00.022)       0:00:12.990 *****
changed: [instance]

TASK [repo_setup : Get component repo] *****************************************
Thursday 26 February 2026  21:14:49 +0000 (0:00:00.802)       0:00:13.793 *****
skipping: [instance]

TASK [repo_setup : Rename component repo] **************************************
Thursday 26 February 2026  21:14:49 +0000 (0:00:00.036)       0:00:13.830 *****
skipping: [instance]

TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Thursday 26 February 2026  21:14:49 +0000 (0:00:00.036)       0:00:13.866 *****
skipping: [instance]

TASK [repo_setup : Run repo-setup-get-hash] ************************************
Thursday 26 February 2026  21:14:49 +0000 (0:00:00.035)       0:00:13.901 *****
changed: [instance]

TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Thursday 26 February 2026  21:14:50 +0000 (0:00:00.530)       0:00:14.432 *****
changed: [instance]

TASK [repo_setup : Dump current-podified hash] *********************************
Thursday 26 February 2026  21:14:50 +0000 (0:00:00.428)       0:00:14.860 *****
skipping: [instance]

TASK [repo_setup : Slurp current podified hash] ********************************
Thursday 26 February 2026  21:14:50 +0000 (0:00:00.030)       0:00:14.891 *****
skipping: [instance]

TASK [repo_setup : Update the value of full_hash] ******************************
Thursday 26 February 2026  21:14:50 +0000 (0:00:00.029)       0:00:14.920 *****
skipping: [instance]

TASK [repo_setup : Export hashes facts for further use] ************************
Thursday 26 February 2026  21:14:50 +0000 (0:00:00.028)       0:00:14.949 *****
ok: [instance]

TASK [repo_setup : Create download directory] **********************************
Thursday 26 February 2026  21:14:50 +0000 (0:00:00.040)       0:00:14.989 *****
skipping: [instance]

TASK [repo_setup : Print the URL to request] ***********************************
Thursday 26 February 2026  21:14:50 +0000 (0:00:00.029)       0:00:15.019 *****
skipping: [instance]

TASK [Download the RPM] ********************************************************
Thursday 26 February 2026  21:14:50 +0000 (0:00:00.028)       0:00:15.047 *****
skipping: [instance]

TASK [repo_setup : Install RHOS Release tool] **********************************
Thursday 26 February 2026  21:14:50 +0000 (0:00:00.028)       0:00:15.076 *****
skipping: [instance]

TASK [repo_setup : Get rhos-release tool version] ******************************
Thursday 26 February 2026  21:14:50 +0000 (0:00:00.027)       0:00:15.104 *****
skipping: [instance]

TASK [repo_setup : Print rhos-release tool version] ****************************
Thursday 26 February 2026  21:14:50 +0000 (0:00:00.027)       0:00:15.131 *****
skipping: [instance]

TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Thursday 26 February 2026  21:14:50 +0000 (0:00:00.029)       0:00:15.160 *****
skipping: [instance]

TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Thursday 26 February 2026  21:14:50 +0000 (0:00:00.026)       0:00:15.187 *****
ok: [instance]

TASK [repo_setup : Use RDO proxy mirrors] **************************************
Thursday 26 February 2026  21:14:51 +0000 (0:00:00.186)       0:00:15.373 *****
changed: [instance]

TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Thursday 26 February 2026  21:14:51 +0000 (0:00:00.203)       0:00:15.577 *****
changed: [instance]

TASK [repo_setup : Check for gating.repo file on content provider] *************
Thursday 26 February 2026  21:14:51 +0000 (0:00:00.225)       0:00:15.802 *****
skipping: [instance]

TASK [repo_setup : Populate gating repo from content provider ip] **************
Thursday 26 February 2026  21:14:51 +0000 (0:00:00.022)       0:00:15.825 *****
skipping: [instance]

TASK [repo_setup : Check for DLRN repo at the destination] *********************
Thursday 26 February 2026  21:14:51 +0000 (0:00:00.021)       0:00:15.847 *****
skipping: [instance]

TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Thursday 26 February 2026  21:14:51 +0000 (0:00:00.022)       0:00:15.869 *****
skipping: [instance]

TASK [repo_setup : Check for DLRN component repo] ******************************
Thursday 26 February 2026  21:14:51 +0000 (0:00:00.023)       0:00:15.892 *****
skipping: [instance]

TASK [repo_setup : Lower the priority of component repos to allow installation from gating repo] ***
Thursday 26 February 2026  21:14:51 +0000 (0:00:00.024)       0:00:15.916 *****
skipping: [instance]

TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Thursday 26 February 2026  21:14:51 +0000 (0:00:00.023)       0:00:15.940 *****
skipping: [instance]

TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Thursday 26 February 2026  21:14:51 +0000 (0:00:00.017)       0:00:15.957 *****
skipping: [instance]

TASK [repo_setup : Cleanup existing metadata] **********************************
Thursday 26 February 2026  21:14:51 +0000 (0:00:00.028)       0:00:15.985 *****
skipping: [instance]

TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Thursday 26 February 2026  21:14:51 +0000 (0:00:00.017)       0:00:16.003 *****
skipping: [instance]

TASK [test_deps : Look for redhat-release rpm] *********************************
Thursday 26 February 2026  21:14:51 +0000 (0:00:00.020)       0:00:16.023 *****
skipping: [instance]

TASK [test_deps : Remove redhat-release] ***************************************
Thursday 26 February 2026  21:14:51 +0000 (0:00:00.028)       0:00:16.051 *****
skipping: [instance]

TASK [test_deps : Install centos-stream-release] *******************************
Thursday 26 February 2026  21:14:51 +0000 (0:00:00.028)       0:00:16.080 *****
skipping: [instance]

TASK [test_deps : Install additional packages] *********************************
Thursday 26 February 2026  21:14:51 +0000 (0:00:00.028)       0:00:16.109 *****
skipping: [instance]

TASK [test_deps : Install selinux python libs] *********************************
Thursday 26 February 2026  21:14:51 +0000 (0:00:00.030)       0:00:16.139 *****
ok: [instance]

TASK [test_deps : Install python yaml libs] ************************************
Thursday 26 February 2026  21:15:36 +0000 (0:00:44.925)       0:01:01.065 *****
ok: [instance]

TASK [test_deps : Install extra packages] **************************************
Thursday 26 February 2026  21:15:38 +0000 (0:00:01.174)       0:01:02.239 *****
skipping: [instance]

TASK [ci_setup : Gather variables for each operating system] *******************
Thursday 26 February 2026  21:15:38 +0000 (0:00:00.031)       0:01:02.271 *****
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] *************************************
Thursday 26 February 2026  21:15:38 +0000 (0:00:00.042)       0:01:02.314 *****
ok: [instance] =>
  cifmw_ci_setup_packages:
  - bash-completion
  - ca-certificates
  - git-core
  - make
  - tar
  - tmux
  - python3-pip

TASK [ci_setup : Install needed packages] **************************************
Thursday 26 February 2026  21:15:38 +0000 (0:00:00.019)       0:01:02.333 *****
changed: [instance]

TASK [ci_setup : Gather version of openshift client] ***************************
Thursday 26 February 2026  21:15:41 +0000 (0:00:03.726)       0:01:06.059 *****
ok: [instance]

TASK [ci_setup : Ensure openshift client install path is present] **************
Thursday 26 February 2026  21:15:42 +0000 (0:00:00.569)       0:01:06.629 *****
changed: [instance]

TASK [ci_setup : Install openshift client] *************************************
Thursday 26 February 2026  21:15:42 +0000 (0:00:00.195)       0:01:06.824 *****
changed: [instance]

TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
Thursday 26 February 2026  21:15:48 +0000 (0:00:05.989)       0:01:12.814 *****
ok: [instance]

TASK [ci_setup : Create completion file] ***************************************
Thursday 26 February 2026  21:15:48 +0000 (0:00:00.035)       0:01:12.850 *****
changed: [instance]

TASK [ci_setup : Source completion from within .bashrc] ************************
Thursday 26 February 2026  21:15:48 +0000 (0:00:00.251)       0:01:13.102 *****
changed: [instance]

TASK [ci_setup : Check rhsm status] ********************************************
Thursday 26 February 2026  21:15:49 +0000 (0:00:00.267)       0:01:13.369 *****
skipping: [instance]

TASK [ci_setup : Gather the repos to be enabled] *******************************
Thursday 26 February 2026  21:15:49 +0000 (0:00:00.017)       0:01:13.387 *****
skipping: [instance]

TASK [ci_setup : Enabling the required repositories.] **************************
Thursday 26 February 2026  21:15:49 +0000 (0:00:00.017)       0:01:13.404 *****
skipping: [instance]

TASK [ci_setup : Get current /etc/redhat-release] ******************************
Thursday 26 February 2026  21:15:49 +0000 (0:00:00.044)       0:01:13.449 *****
skipping: [instance]

TASK [ci_setup : Print current /etc/redhat-release] ****************************
Thursday 26 February 2026  21:15:49 +0000 (0:00:00.017)       0:01:13.466 *****
skipping: [instance]

TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
Thursday 26 February 2026  21:15:49 +0000 (0:00:00.016)       0:01:13.482 *****
skipping: [instance]

TASK [ci_setup : Manage directories] *******************************************
Thursday 26 February 2026  21:15:49 +0000 (0:00:00.039)       0:01:13.522 *****
changed: [instance] => (item=/opt/basedir/artifacts/manifests/openstack/cr)
changed: [instance] => (item=/opt/basedir/logs)
ok: [instance] => (item=/opt/basedir/tmp)
changed: [instance] => (item=/opt/basedir/volumes)
changed: [instance] => (item=/opt/basedir/artifacts/parameters)

TASK [Create secret file] ******************************************************
Thursday 26 February 2026  21:15:50 +0000 (0:00:00.930)       0:01:14.452 *****
changed: [instance]

PLAY RECAP *********************************************************************
instance                   : ok=31   changed=17   unreachable=0    failed=0    skipped=36   rescued=0    ignored=0

Thursday 26 February 2026  21:15:50 +0000 (0:00:00.323)       0:01:14.775 *****
===============================================================================
test_deps : Install selinux python libs -------------------------------- 44.93s
repo_setup : Initialize python venv and install requirements ------------ 7.42s
ci_setup : Install openshift client ------------------------------------- 5.99s
ci_setup : Install needed packages -------------------------------------- 3.73s
test_deps : Install python yaml libs ------------------------------------ 1.17s
repo_setup : Get repo-setup repository ---------------------------------- 1.09s
ci_setup : Manage directories ------------------------------------------- 0.93s
Gathering Facts --------------------------------------------------------- 0.83s
repo_setup : Make sure git-core package is installed -------------------- 0.82s
repo_setup : Run repo-setup --------------------------------------------- 0.80s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.68s
repo_setup : Install repo-setup package --------------------------------- 0.68s
ci_setup : Gather version of openshift client --------------------------- 0.57s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.53s
repo_setup : Ensure directories are present ----------------------------- 0.51s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.43s
Create secret file ------------------------------------------------------ 0.32s
Create custom basedir --------------------------------------------------- 0.31s
test_deps : Detect mirrors file ----------------------------------------- 0.28s
ci_setup : Source completion from within .bashrc ------------------------ 0.27s

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

TASK [Gathering Facts] *********************************************************
Thursday 26 February 2026  21:15:51 +0000 (0:00:00.025)       0:00:00.025 *****
ok: [instance]

TASK [Load networking definition from scenario file] ***************************
Thursday 26 February 2026  21:15:51 +0000 (0:00:00.802)       0:00:00.828 *****
ok: [instance]

TASK [discover_latest_image : Discover several images if requested] ************
Thursday 26 February 2026  21:15:52 +0000 (0:00:00.020)       0:00:00.848 *****
skipping: [instance]

TASK [discover_latest_image : Discover the image] ******************************
Thursday 26 February 2026  21:15:52 +0000 (0:00:00.026)       0:00:00.875 *****
changed: [instance]

TASK [discover_latest_image : Export facts accordingly] ************************
Thursday 26 February 2026  21:15:53 +0000 (0:00:01.540)       0:00:02.415 *****
ok: [instance]

TASK [discover_latest_image : Also export this via the latest images dict] *****
Thursday 26 February 2026  21:15:53 +0000 (0:00:00.034)       0:00:02.450 *****
ok: [instance]

TASK [discover_latest_image : A debug task] ************************************
Thursday 26 February 2026  21:15:53 +0000 (0:00:00.033)       0:00:02.483 *****
ok: [instance] =>
  cifmw_discover_latest_image_images_dict:
    default:
      hash: 732aef83ec83d501dd4ceba8f08d29ffba016300c4710e056c77d4908412b10c
      hash_algorithm: sha256
      image_name: CentOS-Stream-GenericCloud-x86_64-9-latest.x86_64.qcow2
      image_url: https://cloud.centos.org/centos/9-stream/x86_64/images//CentOS-Stream-GenericCloud-x86_64-9-latest.x86_64.qcow2

TASK [discover_latest_image : another debug task] ******************************
Thursday 26 February 2026  21:15:53 +0000 (0:00:00.018)       0:00:02.502 *****
ok: [instance] =>
  cifmw_discovered_image_url: https://cloud.centos.org/centos/9-stream/x86_64/images//CentOS-Stream-GenericCloud-x86_64-9-latest.x86_64.qcow2

TASK [reproducer : Fail for now] ***********************************************
Thursday 26 February 2026  21:15:53 +0000 (0:00:00.023)       0:00:02.525 *****
fatal: [instance]: FAILED! => changed=false
  msg: Failed on purpose!

TASK [Create dnsmasq dir] ******************************************************
Thursday 26 February 2026  21:15:53 +0000 (0:00:00.016)       0:00:02.542 *****
changed: [instance]

TASK [Get journalctl in a file] ************************************************
Thursday 26 February 2026  21:15:53 +0000 (0:00:00.280)       0:00:02.822 *****
changed: [instance]

TASK [Dump journalctl output] **************************************************
Thursday 26 February 2026  21:15:54 +0000 (0:00:00.292)       0:00:03.115 *****
changed: [instance]

TASK [Copy all dnsmasq config] *************************************************
Thursday 26 February 2026  21:15:54 +0000 (0:00:00.535)       0:00:03.651 *****
failed: [instance] (item=/etc/cifmw-dnsmasq.conf) => changed=false
  ansible_loop_var: item
  cmd: /usr/bin/rsync --delay-updates -F --compress --archive --out-format='<<CHANGED>>%i %n%L' /etc/cifmw-dnsmasq.conf /home/zuul/ci-framework-data/artifacts/dnsmasq
  item: /etc/cifmw-dnsmasq.conf
  msg: |-
    rsync: [sender] link_stat "/etc/cifmw-dnsmasq.conf" failed: No such file or directory (2)
    rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1327) [sender=3.2.5]
  rc: 23
failed: [instance] (item=/etc/cifmw-dnsmasq.d/) => changed=false
  ansible_loop_var: item
  cmd: /usr/bin/rsync --delay-updates -F --compress --archive --out-format='<<CHANGED>>%i %n%L' /etc/cifmw-dnsmasq.d/ /home/zuul/ci-framework-data/artifacts/dnsmasq
  item: /etc/cifmw-dnsmasq.d/
  msg: |-
    rsync: [sender] change_dir "/etc/cifmw-dnsmasq.d" failed: No such file or directory (2)
    rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1327) [sender=3.2.5]
  rc: 23

PLAY RECAP *********************************************************************
instance                   : ok=10   changed=4    unreachable=0    failed=2    skipped=1    rescued=0    ignored=0

Thursday 26 February 2026  21:15:55 +0000 (0:00:00.646)       0:00:04.297 *****
===============================================================================
discover_latest_image : Discover the image ------------------------------ 1.54s
Gathering Facts --------------------------------------------------------- 0.80s
Copy all dnsmasq config ------------------------------------------------- 0.65s
Dump journalctl output -------------------------------------------------- 0.54s
Get journalctl in a file ------------------------------------------------ 0.29s
Create dnsmasq dir ------------------------------------------------------ 0.28s
discover_latest_image : Export facts accordingly ------------------------ 0.03s
discover_latest_image : Also export this via the latest images dict ----- 0.03s
discover_latest_image : Discover several images if requested ------------ 0.03s
discover_latest_image : another debug task ------------------------------ 0.02s
Load networking definition from scenario file --------------------------- 0.02s
discover_latest_image : A debug task ------------------------------------ 0.02s
reproducer : Fail for now ----------------------------------------------- 0.02s