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

TASK [Gathering Facts] *********************************************************
Wednesday 26 November 2025  15:48:03 +0000 (0:00:00.012)       0:00:00.012 ****
ok: [instance]

TASK [test_deps : Gather facts if they don't exist] ****************************
Wednesday 26 November 2025  15:48:04 +0000 (0:00:00.799)       0:00:00.812 ****
skipping: [instance]

TASK [test_deps : Gather variables for each operating system] ******************
Wednesday 26 November 2025  15:48:04 +0000 (0:00:00.017)       0:00:00.829 ****
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 26 November 2025  15:48:04 +0000 (0:00:00.039)       0:00:00.869 ****
ok: [instance]

TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Wednesday 26 November 2025  15:48:04 +0000 (0:00:00.262)       0:00:01.132 ****
ok: [instance]

TASK [test_deps : Disable ubi 9 repos] *****************************************
Wednesday 26 November 2025  15:48:04 +0000 (0:00:00.281)       0:00:01.413 ****
ok: [instance] => (item=ubi-9-appstream)
ok: [instance] => (item=ubi-9-baseos)
ok: [instance] => (item=ubi-9-codeready-builder)

TASK [Deploy repo-setup] *******************************************************
Wednesday 26 November 2025  15:48:05 +0000 (0:00:00.640)       0:00:02.053 ****

TASK [repo_setup : Ensure directories are present] *****************************
Wednesday 26 November 2025  15:48:05 +0000 (0:00:00.057)       0:00:02.110 ****
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 26 November 2025  15:48:05 +0000 (0:00:00.509)       0:00:02.619 ****
ok: [instance]

TASK [repo_setup : Get repo-setup repository] **********************************
Wednesday 26 November 2025  15:48:06 +0000 (0:00:00.726)       0:00:03.346 ****
changed: [instance]

TASK [repo_setup : Initialize python venv and install requirements] ************
Wednesday 26 November 2025  15:48:07 +0000 (0:00:01.084)       0:00:04.431 ****
changed: [instance]

TASK [repo_setup : Install repo-setup package] *********************************
Wednesday 26 November 2025  15:48:15 +0000 (0:00:07.468)       0:00:11.899 ****
changed: [instance]

TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Wednesday 26 November 2025  15:48:15 +0000 (0:00:00.654)       0:00:12.554 ****
skipping: [instance]

TASK [repo_setup : Run repo-setup] *********************************************
Wednesday 26 November 2025  15:48:15 +0000 (0:00:00.020)       0:00:12.575 ****
changed: [instance]

TASK [repo_setup : Get component repo] *****************************************
Wednesday 26 November 2025  15:48:16 +0000 (0:00:00.782)       0:00:13.358 ****
skipping: [instance]

TASK [repo_setup : Rename component repo] **************************************
Wednesday 26 November 2025  15:48:16 +0000 (0:00:00.033)       0:00:13.391 ****
skipping: [instance]

TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Wednesday 26 November 2025  15:48:16 +0000 (0:00:00.045)       0:00:13.436 ****
skipping: [instance]

TASK [repo_setup : Run repo-setup-get-hash] ************************************
Wednesday 26 November 2025  15:48:16 +0000 (0:00:00.033)       0:00:13.469 ****
changed: [instance]

TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Wednesday 26 November 2025  15:48:17 +0000 (0:00:00.517)       0:00:13.987 ****
changed: [instance]

TASK [repo_setup : Dump current-podified hash] *********************************
Wednesday 26 November 2025  15:48:17 +0000 (0:00:00.398)       0:00:14.386 ****
skipping: [instance]

TASK [repo_setup : Slurp current podified hash] ********************************
Wednesday 26 November 2025  15:48:17 +0000 (0:00:00.027)       0:00:14.413 ****
skipping: [instance]

TASK [repo_setup : Update the value of full_hash] ******************************
Wednesday 26 November 2025  15:48:17 +0000 (0:00:00.027)       0:00:14.441 ****
skipping: [instance]

TASK [repo_setup : Export hashes facts for further use] ************************
Wednesday 26 November 2025  15:48:17 +0000 (0:00:00.026)       0:00:14.468 ****
ok: [instance]

TASK [repo_setup : Create download directory] **********************************
Wednesday 26 November 2025  15:48:17 +0000 (0:00:00.034)       0:00:14.502 ****
skipping: [instance]

TASK [repo_setup : Print the URL to request] ***********************************
Wednesday 26 November 2025  15:48:17 +0000 (0:00:00.025)       0:00:14.528 ****
skipping: [instance]

TASK [Download the RPM] ********************************************************
Wednesday 26 November 2025  15:48:17 +0000 (0:00:00.024)       0:00:14.552 ****
skipping: [instance]

TASK [repo_setup : Install RHOS Release tool] **********************************
Wednesday 26 November 2025  15:48:17 +0000 (0:00:00.024)       0:00:14.577 ****
skipping: [instance]

TASK [repo_setup : Get rhos-release tool version] ******************************
Wednesday 26 November 2025  15:48:17 +0000 (0:00:00.024)       0:00:14.602 ****
skipping: [instance]

TASK [repo_setup : Print rhos-release tool version] ****************************
Wednesday 26 November 2025  15:48:17 +0000 (0:00:00.024)       0:00:14.627 ****
skipping: [instance]

TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Wednesday 26 November 2025  15:48:17 +0000 (0:00:00.026)       0:00:14.653 ****
skipping: [instance]

TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Wednesday 26 November 2025  15:48:17 +0000 (0:00:00.025)       0:00:14.679 ****
ok: [instance]

TASK [repo_setup : Use RDO proxy mirrors] **************************************
Wednesday 26 November 2025  15:48:18 +0000 (0:00:00.172)       0:00:14.851 ****
changed: [instance]

TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Wednesday 26 November 2025  15:48:18 +0000 (0:00:00.203)       0:00:15.055 ****
changed: [instance]

TASK [repo_setup : Check for gating.repo file on content provider] *************
Wednesday 26 November 2025  15:48:18 +0000 (0:00:00.209)       0:00:15.264 ****
skipping: [instance]

TASK [repo_setup : Populate gating repo from content provider ip] **************
Wednesday 26 November 2025  15:48:18 +0000 (0:00:00.019)       0:00:15.283 ****
skipping: [instance]

TASK [repo_setup : Check for DLRN repo at the destination] *********************
Wednesday 26 November 2025  15:48:18 +0000 (0:00:00.020)       0:00:15.303 ****
skipping: [instance]

TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Wednesday 26 November 2025  15:48:18 +0000 (0:00:00.020)       0:00:15.324 ****
skipping: [instance]

TASK [repo_setup : Check for DLRN component repo] ******************************
Wednesday 26 November 2025  15:48:18 +0000 (0:00:00.019)       0:00:15.343 ****
skipping: [instance]

TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
Wednesday 26 November 2025  15:48:18 +0000 (0:00:00.019)       0:00:15.363 ****
skipping: [instance]

TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Wednesday 26 November 2025  15:48:18 +0000 (0:00:00.018)       0:00:15.381 ****
skipping: [instance]

TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Wednesday 26 November 2025  15:48:18 +0000 (0:00:00.014)       0:00:15.395 ****
skipping: [instance]

TASK [repo_setup : Cleanup existing metadata] **********************************
Wednesday 26 November 2025  15:48:18 +0000 (0:00:00.025)       0:00:15.420 ****
skipping: [instance]

TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Wednesday 26 November 2025  15:48:18 +0000 (0:00:00.013)       0:00:15.434 ****
skipping: [instance]

TASK [test_deps : Look for redhat-release rpm] *********************************
Wednesday 26 November 2025  15:48:18 +0000 (0:00:00.017)       0:00:15.452 ****
skipping: [instance]

TASK [test_deps : Remove redhat-release] ***************************************
Wednesday 26 November 2025  15:48:18 +0000 (0:00:00.025)       0:00:15.478 ****
skipping: [instance]

TASK [test_deps : Install centos-stream-release] *******************************
Wednesday 26 November 2025  15:48:18 +0000 (0:00:00.026)       0:00:15.504 ****
skipping: [instance]

TASK [test_deps : Install additional packages] *********************************
Wednesday 26 November 2025  15:48:18 +0000 (0:00:00.028)       0:00:15.533 ****
skipping: [instance]

TASK [test_deps : Install selinux python libs] *********************************
Wednesday 26 November 2025  15:48:18 +0000 (0:00:00.028)       0:00:15.562 ****
ok: [instance]

TASK [test_deps : Install python yaml libs] ************************************
Wednesday 26 November 2025  15:48:57 +0000 (0:00:38.976)       0:00:54.538 ****
ok: [instance]

TASK [test_deps : Install extra packages] **************************************
Wednesday 26 November 2025  15:48:58 +0000 (0:00:01.136)       0:00:55.674 ****
skipping: [instance]

TASK [Create 1st dummy interface with needed IPs] ******************************
Wednesday 26 November 2025  15:48:59 +0000 (0:00:00.031)       0:00:55.706 ****
changed: [instance]

TASK [Create 2nd dummy interface with needed IPs] ******************************
Wednesday 26 November 2025  15:48:59 +0000 (0:00:00.362)       0:00:56.069 ****
changed: [instance]

TASK [Create 3nd dummy interface with needed IPs] ******************************
Wednesday 26 November 2025  15:48:59 +0000 (0:00:00.254)       0:00:56.324 ****
changed: [instance]

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

Wednesday 26 November 2025  15:48:59 +0000 (0:00:00.266)       0:00:56.590 ****
===============================================================================
test_deps : Install selinux python libs -------------------------------- 38.98s
repo_setup : Initialize python venv and install requirements ------------ 7.47s
test_deps : Install python yaml libs ------------------------------------ 1.14s
repo_setup : Get repo-setup repository ---------------------------------- 1.08s
Gathering Facts --------------------------------------------------------- 0.80s
repo_setup : Run repo-setup --------------------------------------------- 0.78s
repo_setup : Make sure git-core package is installed -------------------- 0.73s
repo_setup : Install repo-setup package --------------------------------- 0.65s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.64s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.52s
repo_setup : Ensure directories are present ----------------------------- 0.51s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.40s
Create 1st dummy interface with needed IPs ------------------------------ 0.36s
test_deps : Disable ubi host subscription-manager integration ----------- 0.28s
Create 3nd dummy interface with needed IPs ------------------------------ 0.27s
test_deps : Detect mirrors file ----------------------------------------- 0.26s
Create 2nd dummy interface with needed IPs ------------------------------ 0.25s
repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist) --- 0.21s
repo_setup : Use RDO proxy mirrors -------------------------------------- 0.20s
repo_setup : Check for /etc/ci/mirror_info.sh --------------------------- 0.17s

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

TASK [Gathering Facts] *********************************************************
Wednesday 26 November 2025  15:49:00 +0000 (0:00:00.016)       0:00:00.016 ****
ok: [instance]

TASK [dnsmasq : Install needed packages] ***************************************
Wednesday 26 November 2025  15:49:01 +0000 (0:00:00.805)       0:00:00.822 ****
changed: [instance]

TASK [dnsmasq : Ensure SELinux knows about the new files and directories] ******
Wednesday 26 November 2025  15:49:04 +0000 (0:00:03.617)       0:00:04.439 ****
changed: [instance] => (item={'target': '/etc/cifmw-dnsmasq.conf', 'setype': 'dnsmasq_etc_t'})
changed: [instance] => (item={'target': '/etc/cifmw-dnsmasq.d(/.*)?', 'setype': 'dnsmasq_etc_t'})
changed: [instance] => (item={'target': '/var/run/cifmw-dnsmasq.pid', 'setype': 'dnsmasq_var_run_t'})

TASK [dnsmasq : Manage configuration directory] ********************************
Wednesday 26 November 2025  15:49:08 +0000 (0:00:03.313)       0:00:07.753 ****
changed: [instance]

TASK [dnsmasq : Manage systemd unit file] **************************************
Wednesday 26 November 2025  15:49:08 +0000 (0:00:00.309)       0:00:08.063 ****
changed: [instance]

TASK [dnsmasq : Manage base configuration file] ********************************
Wednesday 26 November 2025  15:49:08 +0000 (0:00:00.539)       0:00:08.603 ****
changed: [instance]

TASK [dnsmasq : Render listener configuration] *********************************
Wednesday 26 November 2025  15:49:09 +0000 (0:00:00.346)       0:00:08.949 ****
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/listener.yml for instance

TASK [dnsmasq : Create listener configuration file] ****************************
Wednesday 26 November 2025  15:49:09 +0000 (0:00:00.021)       0:00:08.971 ****
changed: [instance]

TASK [dnsmasq : Remove listener configuration file] ****************************
Wednesday 26 November 2025  15:49:09 +0000 (0:00:00.353)       0:00:09.324 ****
skipping: [instance]

TASK [dnsmasq : Render dns configuration] **************************************
Wednesday 26 November 2025  15:49:09 +0000 (0:00:00.015)       0:00:09.340 ****
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/dns.yml for instance

TASK [dnsmasq : Create dns configuration file] *********************************
Wednesday 26 November 2025  15:49:09 +0000 (0:00:00.020)       0:00:09.360 ****
changed: [instance]

TASK [dnsmasq : Remove dns configuration file] *********************************
Wednesday 26 November 2025  15:49:10 +0000 (0:00:00.352)       0:00:09.712 ****
skipping: [instance]

TASK [dnsmasq : Add localhost addresses from defined dnsmasq listen addresses to loopback interface] ***
Wednesday 26 November 2025  15:49:10 +0000 (0:00:00.016)       0:00:09.729 ****
skipping: [instance] => (item=192.168.253.9)
skipping: [instance] => (item=192.168.254.9)
skipping: [instance]

TASK [dnsmasq : Enable and start service] **************************************
Wednesday 26 November 2025  15:49:10 +0000 (0:00:00.022)       0:00:09.752 ****
changed: [instance]

TASK [dnsmasq : Stop service] **************************************************
Wednesday 26 November 2025  15:49:10 +0000 (0:00:00.816)       0:00:10.568 ****
skipping: [instance]

TASK [dnsmasq : Remove unit file] **********************************************
Wednesday 26 November 2025  15:49:10 +0000 (0:00:00.017)       0:00:10.586 ****
skipping: [instance]

TASK [dnsmasq : Remove main configuration files] *******************************
Wednesday 26 November 2025  15:49:10 +0000 (0:00:00.016)       0:00:10.603 ****
skipping: [instance] => (item=/etc/cifmw-dnsmasq.conf)
skipping: [instance] => (item=/etc/cifmw-dnsmasq.d)
skipping: [instance]

TASK [Create network] **********************************************************
Wednesday 26 November 2025  15:49:10 +0000 (0:00:00.026)       0:00:10.629 ****

TASK [dnsmasq : Assert mandatory parameter] ************************************
Wednesday 26 November 2025  15:49:11 +0000 (0:00:00.025)       0:00:10.654 ****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [dnsmasq : Assert mandatory parameters for new network] *******************
Wednesday 26 November 2025  15:49:11 +0000 (0:00:00.023)       0:00:10.678 ****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [dnsmasq : Create network] ************************************************
Wednesday 26 November 2025  15:49:11 +0000 (0:00:00.028)       0:00:10.706 ****
changed: [instance]

TASK [dnsmasq : Remove network] ************************************************
Wednesday 26 November 2025  15:49:11 +0000 (0:00:00.427)       0:00:11.134 ****
skipping: [instance]

TASK [dnsmasq : Remove dhcp host files] ****************************************
Wednesday 26 November 2025  15:49:11 +0000 (0:00:00.016)       0:00:11.151 ****
skipping: [instance]

TASK [Create second network] ***************************************************
Wednesday 26 November 2025  15:49:11 +0000 (0:00:00.019)       0:00:11.171 ****

TASK [dnsmasq : Assert mandatory parameter] ************************************
Wednesday 26 November 2025  15:49:11 +0000 (0:00:00.025)       0:00:11.196 ****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [dnsmasq : Assert mandatory parameters for new network] *******************
Wednesday 26 November 2025  15:49:11 +0000 (0:00:00.023)       0:00:11.219 ****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [dnsmasq : Create network] ************************************************
Wednesday 26 November 2025  15:49:11 +0000 (0:00:00.030)       0:00:11.249 ****
changed: [instance]

TASK [dnsmasq : Remove network] ************************************************
Wednesday 26 November 2025  15:49:12 +0000 (0:00:00.396)       0:00:11.646 ****
skipping: [instance]

TASK [dnsmasq : Remove dhcp host files] ****************************************
Wednesday 26 November 2025  15:49:12 +0000 (0:00:00.015)       0:00:11.662 ****
skipping: [instance]

TASK [Inject enable-ra in startrek] ********************************************
Wednesday 26 November 2025  15:49:12 +0000 (0:00:00.018)       0:00:11.680 ****
ok: [instance]

TASK [Assert no change was done in startrek] ***********************************
Wednesday 26 November 2025  15:49:12 +0000 (0:00:00.280)       0:00:11.961 ****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Create IPv4-only network] ************************************************
Wednesday 26 November 2025  15:49:12 +0000 (0:00:00.020)       0:00:11.981 ****

TASK [dnsmasq : Assert mandatory parameter] ************************************
Wednesday 26 November 2025  15:49:12 +0000 (0:00:00.022)       0:00:12.004 ****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [dnsmasq : Assert mandatory parameters for new network] *******************
Wednesday 26 November 2025  15:49:12 +0000 (0:00:00.022)       0:00:12.027 ****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [dnsmasq : Create network] ************************************************
Wednesday 26 November 2025  15:49:12 +0000 (0:00:00.028)       0:00:12.055 ****
changed: [instance]

TASK [dnsmasq : Remove network] ************************************************
Wednesday 26 November 2025  15:49:12 +0000 (0:00:00.407)       0:00:12.463 ****
skipping: [instance]

TASK [dnsmasq : Remove dhcp host files] ****************************************
Wednesday 26 November 2025  15:49:12 +0000 (0:00:00.014)       0:00:12.478 ****
skipping: [instance]

TASK [Inject enable-ra in oldies] **********************************************
Wednesday 26 November 2025  15:49:12 +0000 (0:00:00.018)       0:00:12.497 ****
changed: [instance]

TASK [Debug] *******************************************************************
Wednesday 26 November 2025  15:49:13 +0000 (0:00:00.184)       0:00:12.682 ****
ok: [instance] =>
  _set_ra:
    backup: ''
    changed: true
    diff:
    - after: ''
      after_header: /etc/cifmw-dnsmasq.d/oldies.conf (content)
      before: ''
      before_header: /etc/cifmw-dnsmasq.d/oldies.conf (content)
    - after_header: /etc/cifmw-dnsmasq.d/oldies.conf (file attributes)
      before_header: /etc/cifmw-dnsmasq.d/oldies.conf (file attributes)
    failed: false
    msg: line added

TASK [Assert oldies was changed] ***********************************************
Wednesday 26 November 2025  15:49:13 +0000 (0:00:00.019)       0:00:12.701 ****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Inject some node in starwars network] ************************************
Wednesday 26 November 2025  15:49:13 +0000 (0:00:00.021)       0:00:12.722 ****

TASK [dnsmasq : Ensure we have the right data and type] ************************
Wednesday 26 November 2025  15:49:13 +0000 (0:00:00.026)       0:00:12.749 ****
ok: [instance]

TASK [dnsmasq : Assert we have needed host data] *******************************
Wednesday 26 November 2025  15:49:13 +0000 (0:00:00.031)       0:00:12.780 ****
ok: [instance] => (item={'network': 'starwars', 'state': 'present', 'mac': '0a:19:02:f8:4c:a7', 'ips': ['2345:0425:2CA1::0567:5673:cafe', '192.168.254.11']})
ok: [instance] => (item={'network': 'starwars', 'state': 'present', 'mac': '0a:19:02:f8:4c:a8', 'ips': ['2345:0425:2CA1::0567:5673:babe', '192.168.254.12'], 'name': 'solo'})
ok: [instance] => (item={'network': 'startrek', 'state': 'present', 'mac': '0a:19:02:f8:4c:a8', 'ips': ['2345:0426:2CA1::0567:5673:babe', '192.168.253.12'], 'name': 'spock'})

TASK [dnsmasq : Ensure networks exists] ****************************************
Wednesday 26 November 2025  15:49:13 +0000 (0:00:00.058)       0:00:12.838 ****
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/_check_net_status.yml for instance => (item=starwars)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/_check_net_status.yml for instance => (item=startrek)

TASK [dnsmasq : Check network file status] *************************************
Wednesday 26 November 2025  15:49:13 +0000 (0:00:00.053)       0:00:12.892 ****
ok: [instance]

TASK [dnsmasq : Assert network exists] *****************************************
Wednesday 26 November 2025  15:49:13 +0000 (0:00:00.166)       0:00:13.059 ****
ok: [instance]

TASK [dnsmasq : Check network file status] *************************************
Wednesday 26 November 2025  15:49:13 +0000 (0:00:00.020)       0:00:13.080 ****
ok: [instance]

TASK [dnsmasq : Assert network exists] *****************************************
Wednesday 26 November 2025  15:49:13 +0000 (0:00:00.165)       0:00:13.246 ****
ok: [instance]

TASK [dnsmasq : Initialize empty dhcp_host_entries] ****************************
Wednesday 26 November 2025  15:49:13 +0000 (0:00:00.019)       0:00:13.265 ****
ok: [instance]

TASK [dnsmasq : Compute entry] *************************************************
Wednesday 26 November 2025  15:49:13 +0000 (0:00:00.015)       0:00:13.280 ****
ok: [instance] => (item={'network': 'starwars', 'state': 'present', 'mac': '0a:19:02:f8:4c:a7', 'ips': ['2345:0425:2CA1::0567:5673:cafe', '192.168.254.11']})
ok: [instance] => (item={'network': 'starwars', 'state': 'present', 'mac': '0a:19:02:f8:4c:a8', 'ips': ['2345:0425:2CA1::0567:5673:babe', '192.168.254.12'], 'name': 'solo'})
ok: [instance] => (item={'network': 'startrek', 'state': 'present', 'mac': '0a:19:02:f8:4c:a8', 'ips': ['2345:0426:2CA1::0567:5673:babe', '192.168.253.12'], 'name': 'spock'})

TASK [dnsmasq : Create add/remove sets] ****************************************
Wednesday 26 November 2025  15:49:13 +0000 (0:00:00.111)       0:00:13.392 ****
ok: [instance]

TASK [dnsmasq : Add DHCP entries] **********************************************
Wednesday 26 November 2025  15:49:13 +0000 (0:00:00.034)       0:00:13.426 ****
changed: [instance] => (item={'file': 'starwars_0a:19:02:f8:4c:a7', 'entry': '0a:19:02:f8:4c:a7,[2345:425:2ca1::567:5673:cafe],192.168.254.11', 'state': 'present'})
changed: [instance] => (item={'file': 'starwars_solo_0a:19:02:f8:4c:a8', 'entry': '0a:19:02:f8:4c:a8,[2345:425:2ca1::567:5673:babe],192.168.254.12,solo', 'state': 'present'})
changed: [instance] => (item={'file': 'startrek_spock_0a:19:02:f8:4c:a8', 'entry': '0a:19:02:f8:4c:a8,[2345:426:2ca1::567:5673:babe],192.168.253.12,spock', 'state': 'present'})

TASK [dnsmasq : Remove DHCP entries] *******************************************
Wednesday 26 November 2025  15:49:14 +0000 (0:00:01.029)       0:00:14.455 ****
skipping: [instance]

TASK [Inject nodes with tags for DHCP options] *********************************
Wednesday 26 November 2025  15:49:14 +0000 (0:00:00.020)       0:00:14.476 ****

TASK [dnsmasq : Ensure we have the right data and type] ************************
Wednesday 26 November 2025  15:49:14 +0000 (0:00:00.031)       0:00:14.507 ****
ok: [instance]

TASK [dnsmasq : Assert we have needed host data] *******************************
Wednesday 26 November 2025  15:49:14 +0000 (0:00:00.033)       0:00:14.540 ****
ok: [instance] => (item={'network': 'starwars', 'state': 'present', 'mac': '0a:19:02:f8:4c:b1', 'ips': ['192.168.254.21', '2345:0425:2CA1::0567:5673:0021'], 'name': 'r2d2', 'tag': 'droid'})
ok: [instance] => (item={'network': 'starwars', 'state': 'present', 'mac': '0a:19:02:f8:4c:b2', 'ips': ['192.168.254.22'], 'name': 'c3po', 'tag': 'droid'})
ok: [instance] => (item={'network': 'startrek', 'state': 'present', 'mac': '0a:19:02:f8:4c:b3', 'ips': ['192.168.253.31'], 'name': 'data', 'tag': 'android'})

TASK [dnsmasq : Ensure networks exists] ****************************************
Wednesday 26 November 2025  15:49:14 +0000 (0:00:00.061)       0:00:14.602 ****
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/_check_net_status.yml for instance => (item=starwars)
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/_check_net_status.yml for instance => (item=startrek)

TASK [dnsmasq : Check network file status] *************************************
Wednesday 26 November 2025  15:49:15 +0000 (0:00:00.040)       0:00:14.642 ****
ok: [instance]

TASK [dnsmasq : Assert network exists] *****************************************
Wednesday 26 November 2025  15:49:15 +0000 (0:00:00.172)       0:00:14.815 ****
ok: [instance]

TASK [dnsmasq : Check network file status] *************************************
Wednesday 26 November 2025  15:49:15 +0000 (0:00:00.020)       0:00:14.835 ****
ok: [instance]

TASK [dnsmasq : Assert network exists] *****************************************
Wednesday 26 November 2025  15:49:15 +0000 (0:00:00.167)       0:00:15.002 ****
ok: [instance]

TASK [dnsmasq : Initialize empty dhcp_host_entries] ****************************
Wednesday 26 November 2025  15:49:15 +0000 (0:00:00.020)       0:00:15.023 ****
ok: [instance]

TASK [dnsmasq : Compute entry] *************************************************
Wednesday 26 November 2025  15:49:15 +0000 (0:00:00.015)       0:00:15.038 ****
ok: [instance] => (item={'network': 'starwars', 'state': 'present', 'mac': '0a:19:02:f8:4c:b1', 'ips': ['192.168.254.21', '2345:0425:2CA1::0567:5673:0021'], 'name': 'r2d2', 'tag': 'droid'})
ok: [instance] => (item={'network': 'starwars', 'state': 'present', 'mac': '0a:19:02:f8:4c:b2', 'ips': ['192.168.254.22'], 'name': 'c3po', 'tag': 'droid'})
ok: [instance] => (item={'network': 'startrek', 'state': 'present', 'mac': '0a:19:02:f8:4c:b3', 'ips': ['192.168.253.31'], 'name': 'data', 'tag': 'android'})

TASK [dnsmasq : Create add/remove sets] ****************************************
Wednesday 26 November 2025  15:49:15 +0000 (0:00:00.108)       0:00:15.147 ****
ok: [instance]

TASK [dnsmasq : Add DHCP entries] **********************************************
Wednesday 26 November 2025  15:49:15 +0000 (0:00:00.033)       0:00:15.181 ****
changed: [instance] => (item={'file': 'starwars_r2d2_0a:19:02:f8:4c:b1', 'entry': 'set:droid,0a:19:02:f8:4c:b1,192.168.254.21,[2345:425:2ca1::567:5673:21],r2d2', 'state': 'present'})
changed: [instance] => (item={'file': 'starwars_c3po_0a:19:02:f8:4c:b2', 'entry': 'set:droid,0a:19:02:f8:4c:b2,192.168.254.22,c3po', 'state': 'present'})
changed: [instance] => (item={'file': 'startrek_data_0a:19:02:f8:4c:b3', 'entry': 'set:android,0a:19:02:f8:4c:b3,192.168.253.31,data', 'state': 'present'})

TASK [dnsmasq : Remove DHCP entries] *******************************************
Wednesday 26 November 2025  15:49:16 +0000 (0:00:01.001)       0:00:16.182 ****
skipping: [instance]

TASK [Read r2d2 DHCP host entry] ***********************************************
Wednesday 26 November 2025  15:49:16 +0000 (0:00:00.020)       0:00:16.203 ****
ok: [instance]

TASK [Read c3po DHCP host entry] ***********************************************
Wednesday 26 November 2025  15:49:16 +0000 (0:00:00.265)       0:00:16.469 ****
ok: [instance]

TASK [Read data DHCP host entry] ***********************************************
Wednesday 26 November 2025  15:49:17 +0000 (0:00:00.175)       0:00:16.644 ****
ok: [instance]

TASK [Decode entries] **********************************************************
Wednesday 26 November 2025  15:49:17 +0000 (0:00:00.184)       0:00:16.829 ****
ok: [instance]

TASK [Assert r2d2 entry has droid tag] *****************************************
Wednesday 26 November 2025  15:49:17 +0000 (0:00:00.031)       0:00:16.861 ****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Assert c3po entry has droid tag] *****************************************
Wednesday 26 November 2025  15:49:17 +0000 (0:00:00.022)       0:00:16.884 ****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Assert data entry has android tag] ***************************************
Wednesday 26 November 2025  15:49:17 +0000 (0:00:00.022)       0:00:16.906 ****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Verify entry without tag has no set: prefix] *****************************
Wednesday 26 November 2025  15:49:17 +0000 (0:00:00.021)       0:00:16.928 ****
ok: [instance]

TASK [Assert solo entry does not have a tag] ***********************************
Wednesday 26 November 2025  15:49:17 +0000 (0:00:00.182)       0:00:17.110 ****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Create DHCP options configuration for tagged hosts] **********************
Wednesday 26 November 2025  15:49:17 +0000 (0:00:00.035)       0:00:17.146 ****
changed: [instance]

TASK [Verify dnsmasq configuration is valid] ***********************************
Wednesday 26 November 2025  15:49:17 +0000 (0:00:00.341)       0:00:17.487 ****
ok: [instance]

TASK [Add a domain specific forwarder] *****************************************
Wednesday 26 November 2025  15:49:18 +0000 (0:00:00.274)       0:00:17.761 ****

TASK [dnsmasq : Assert we have needed forwarder data] **************************
Wednesday 26 November 2025  15:49:18 +0000 (0:00:00.028)       0:00:17.789 ****
ok: [instance]

TASK [dnsmasq : Assert each forwarder element have needed data] ****************
Wednesday 26 November 2025  15:49:18 +0000 (0:00:00.032)       0:00:17.822 ****
ok: [instance] => (item={'state': 'present', 'server': '192.168.254.100', 'domains': ['battlestar.galactica.lan']})

TASK [dnsmasq : Add/Remove forwarder] ******************************************
Wednesday 26 November 2025  15:49:18 +0000 (0:00:00.039)       0:00:17.862 ****
changed: [instance] => (item={'state': 'present', 'server': '192.168.254.100', 'domains': ['battlestar.galactica.lan']})

TASK [Add some host records] ***************************************************
Wednesday 26 November 2025  15:49:18 +0000 (0:00:00.217)       0:00:18.079 ****

TASK [dnsmasq : Assert we have needed host record data] ************************
Wednesday 26 November 2025  15:49:18 +0000 (0:00:00.029)       0:00:18.108 ****
ok: [instance]

TASK [dnsmasq : Assert each address element have needed data] ******************
Wednesday 26 November 2025  15:49:18 +0000 (0:00:00.031)       0:00:18.140 ****
ok: [instance] => (item={'state': 'present', 'ips': ['192.168.253.50', '2345:0425:2CA1::dead'], 'names': ['dead.battlestar.galactica.lan']})
ok: [instance] => (item={'state': 'present', 'ips': ['192.168.253.51', '2345:0425:2CA1::beef'], 'names': ['beef.battlestar.galactica.lan']})

TASK [dnsmasq : Add/Remove address] ********************************************
Wednesday 26 November 2025  15:49:18 +0000 (0:00:00.047)       0:00:18.188 ****
changed: [instance] => (item={'state': 'present', 'ips': ['192.168.253.50', '2345:0425:2CA1::dead'], 'names': ['dead.battlestar.galactica.lan']})
changed: [instance] => (item={'state': 'present', 'ips': ['192.168.253.51', '2345:0425:2CA1::beef'], 'names': ['beef.battlestar.galactica.lan']})

TASK [Add some wildcard addresses] *********************************************
Wednesday 26 November 2025  15:49:18 +0000 (0:00:00.429)       0:00:18.617 ****

TASK [dnsmasq : Assert we have needed address data] ****************************
Wednesday 26 November 2025  15:49:19 +0000 (0:00:00.029)       0:00:18.647 ****
ok: [instance]

TASK [dnsmasq : Assert each address element have needed data] ******************
Wednesday 26 November 2025  15:49:19 +0000 (0:00:00.034)       0:00:18.681 ****
ok: [instance] => (item={'state': 'present', 'ipaddr': '1.2.3.4', 'domains': ['apps.ocp.starwars.lan']})
ok: [instance] => (item={'state': 'present', 'ipaddr': '4.3.2.1', 'domains': ['apps.ocp.startrek.lan']})

TASK [dnsmasq : Add/Remove address] ********************************************
Wednesday 26 November 2025  15:49:19 +0000 (0:00:00.083)       0:00:18.764 ****
changed: [instance] => (item={'state': 'present', 'ipaddr': '1.2.3.4', 'domains': ['apps.ocp.starwars.lan']})
changed: [instance] => (item={'state': 'present', 'ipaddr': '4.3.2.1', 'domains': ['apps.ocp.startrek.lan']})

TASK [Force reload dnsmasq] ****************************************************
Wednesday 26 November 2025  15:49:19 +0000 (0:00:00.393)       0:00:19.158 ****

RUNNING HANDLER [dnsmasq : Restart dnsmasq] ************************************
Wednesday 26 November 2025  15:49:19 +0000 (0:00:00.008)       0:00:19.166 ****
changed: [instance]

RUNNING HANDLER [dnsmasq : Reload dnsmasq] *************************************
Wednesday 26 November 2025  15:49:19 +0000 (0:00:00.315)       0:00:19.482 ****
changed: [instance]

PLAY RECAP *********************************************************************
instance                   : ok=71   changed=20   unreachable=0    failed=0    skipped=14   rescued=0    ignored=0

Wednesday 26 November 2025  15:49:20 +0000 (0:00:00.328)       0:00:19.810 ****
===============================================================================
dnsmasq : Install needed packages --------------------------------------- 3.62s
dnsmasq : Ensure SELinux knows about the new files and directories ------ 3.31s
dnsmasq : Add DHCP entries ---------------------------------------------- 1.03s
dnsmasq : Add DHCP entries ---------------------------------------------- 1.00s
dnsmasq : Enable and start service -------------------------------------- 0.82s
Gathering Facts --------------------------------------------------------- 0.81s
dnsmasq : Manage systemd unit file -------------------------------------- 0.54s
dnsmasq : Add/Remove address -------------------------------------------- 0.43s
dnsmasq : Create network ------------------------------------------------ 0.43s
dnsmasq : Create network ------------------------------------------------ 0.41s
dnsmasq : Create network ------------------------------------------------ 0.40s
dnsmasq : Add/Remove address -------------------------------------------- 0.39s
dnsmasq : Create listener configuration file ---------------------------- 0.35s
dnsmasq : Create dns configuration file --------------------------------- 0.35s
dnsmasq : Manage base configuration file -------------------------------- 0.35s
Create DHCP options configuration for tagged hosts ---------------------- 0.34s
dnsmasq : Reload dnsmasq ------------------------------------------------ 0.33s
dnsmasq : Restart dnsmasq ----------------------------------------------- 0.32s
dnsmasq : Manage configuration directory -------------------------------- 0.31s
Inject enable-ra in startrek -------------------------------------------- 0.28s

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

TASK [Gathering Facts] *********************************************************
Wednesday 26 November 2025  15:49:20 +0000 (0:00:00.012)       0:00:00.012 ****
ok: [instance]

TASK [Copy generated content in ci-framework-data/artifacts] *******************
Wednesday 26 November 2025  15:49:21 +0000 (0:00:00.783)       0:00:00.796 ****
changed: [instance] => (item=/etc/cifmw-dnsmasq.conf)
changed: [instance] => (item=/etc/cifmw-dnsmasq.d/)

TASK [Remove a domain specific forwarder] **************************************
Wednesday 26 November 2025  15:49:21 +0000 (0:00:00.533)       0:00:01.329 ****

TASK [dnsmasq : Assert we have needed forwarder data] **************************
Wednesday 26 November 2025  15:49:21 +0000 (0:00:00.026)       0:00:01.355 ****
ok: [instance]

TASK [dnsmasq : Assert each forwarder element have needed data] ****************
Wednesday 26 November 2025  15:49:22 +0000 (0:00:00.029)       0:00:01.385 ****
ok: [instance] => (item={'state': 'absent', 'server': '192.168.100.100', 'domains': ['battlestar.galactica.lan']})

TASK [dnsmasq : Add/Remove forwarder] ******************************************
Wednesday 26 November 2025  15:49:22 +0000 (0:00:00.035)       0:00:01.420 ****
ok: [instance] => (item={'state': 'absent', 'server': '192.168.100.100', 'domains': ['battlestar.galactica.lan']})

TASK [Remove some host records] ************************************************
Wednesday 26 November 2025  15:49:22 +0000 (0:00:00.282)       0:00:01.703 ****

TASK [dnsmasq : Assert we have needed host record data] ************************
Wednesday 26 November 2025  15:49:22 +0000 (0:00:00.031)       0:00:01.734 ****
ok: [instance]

TASK [dnsmasq : Assert each address element have needed data] ******************
Wednesday 26 November 2025  15:49:22 +0000 (0:00:00.030)       0:00:01.764 ****
ok: [instance] => (item={'state': 'absent', 'ips': ['192.168.253.50', '2345:0425:2CA1::dead'], 'names': ['dead.battlestar.galactica.lan']})
ok: [instance] => (item={'state': 'absent', 'ips': ['192.168.253.51', '2345:0425:2CA1::beef'], 'names': ['beef.battlestar.galactica.lan']})

TASK [dnsmasq : Add/Remove address] ********************************************
Wednesday 26 November 2025  15:49:22 +0000 (0:00:00.044)       0:00:01.809 ****
changed: [instance] => (item={'state': 'absent', 'ips': ['192.168.253.50', '2345:0425:2CA1::dead'], 'names': ['dead.battlestar.galactica.lan']})
changed: [instance] => (item={'state': 'absent', 'ips': ['192.168.253.51', '2345:0425:2CA1::beef'], 'names': ['beef.battlestar.galactica.lan']})

TASK [Remove some wildcard addresses] ******************************************
Wednesday 26 November 2025  15:49:22 +0000 (0:00:00.375)       0:00:02.185 ****

TASK [dnsmasq : Assert we have needed address data] ****************************
Wednesday 26 November 2025  15:49:22 +0000 (0:00:00.029)       0:00:02.214 ****
ok: [instance]

TASK [dnsmasq : Assert each address element have needed data] ******************
Wednesday 26 November 2025  15:49:22 +0000 (0:00:00.031)       0:00:02.246 ****
ok: [instance] => (item={'state': 'absent', 'ipaddr': '1.2.3.4', 'domains': ['apps.ocp.starwars.lan']})
ok: [instance] => (item={'state': 'absent', 'ipaddr': '4.3.2.1', 'domains': ['apps.ocp.startrek.lan']})

TASK [dnsmasq : Add/Remove address] ********************************************
Wednesday 26 November 2025  15:49:22 +0000 (0:00:00.076)       0:00:02.322 ****
changed: [instance] => (item={'state': 'absent', 'ipaddr': '1.2.3.4', 'domains': ['apps.ocp.starwars.lan']})
changed: [instance] => (item={'state': 'absent', 'ipaddr': '4.3.2.1', 'domains': ['apps.ocp.startrek.lan']})

TASK [dnsmasq : Cleaning dnsmasq] **********************************************
Wednesday 26 November 2025  15:49:23 +0000 (0:00:00.378)       0:00:02.701 ****
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/configure.yml for instance

TASK [dnsmasq : Install needed packages] ***************************************
Wednesday 26 November 2025  15:49:23 +0000 (0:00:00.027)       0:00:02.728 ****
ok: [instance]

TASK [dnsmasq : Ensure SELinux knows about the new files and directories] ******
Wednesday 26 November 2025  15:49:24 +0000 (0:00:01.233)       0:00:03.962 ****
changed: [instance] => (item={'target': '/etc/cifmw-dnsmasq.conf', 'setype': 'dnsmasq_etc_t'})
changed: [instance] => (item={'target': '/etc/cifmw-dnsmasq.d(/.*)?', 'setype': 'dnsmasq_etc_t'})
changed: [instance] => (item={'target': '/var/run/cifmw-dnsmasq.pid', 'setype': 'dnsmasq_var_run_t'})

TASK [dnsmasq : Manage configuration directory] ********************************
Wednesday 26 November 2025  15:49:27 +0000 (0:00:03.241)       0:00:07.203 ****
changed: [instance]

TASK [dnsmasq : Manage systemd unit file] **************************************
Wednesday 26 November 2025  15:49:28 +0000 (0:00:00.303)       0:00:07.507 ****
skipping: [instance]

TASK [dnsmasq : Manage base configuration file] ********************************
Wednesday 26 November 2025  15:49:28 +0000 (0:00:00.017)       0:00:07.525 ****
skipping: [instance]

TASK [dnsmasq : Render listener configuration] *********************************
Wednesday 26 November 2025  15:49:28 +0000 (0:00:00.016)       0:00:07.541 ****
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/listener.yml for instance

TASK [dnsmasq : Create listener configuration file] ****************************
Wednesday 26 November 2025  15:49:28 +0000 (0:00:00.023)       0:00:07.565 ****
skipping: [instance]

TASK [dnsmasq : Remove listener configuration file] ****************************
Wednesday 26 November 2025  15:49:28 +0000 (0:00:00.016)       0:00:07.582 ****
changed: [instance]

TASK [dnsmasq : Render dns configuration] **************************************
Wednesday 26 November 2025  15:49:28 +0000 (0:00:00.206)       0:00:07.789 ****
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dnsmasq/tasks/dns.yml for instance

TASK [dnsmasq : Create dns configuration file] *********************************
Wednesday 26 November 2025  15:49:28 +0000 (0:00:00.024)       0:00:07.814 ****
skipping: [instance]

TASK [dnsmasq : Remove dns configuration file] *********************************
Wednesday 26 November 2025  15:49:28 +0000 (0:00:00.017)       0:00:07.832 ****
changed: [instance]

TASK [dnsmasq : Add localhost addresses from defined dnsmasq listen addresses to loopback interface] ***
Wednesday 26 November 2025  15:49:28 +0000 (0:00:00.218)       0:00:08.051 ****
skipping: [instance]

TASK [dnsmasq : Enable and start service] **************************************
Wednesday 26 November 2025  15:49:28 +0000 (0:00:00.016)       0:00:08.067 ****
skipping: [instance]

TASK [dnsmasq : Stop service] **************************************************
Wednesday 26 November 2025  15:49:28 +0000 (0:00:00.017)       0:00:08.084 ****
changed: [instance]

TASK [dnsmasq : Remove unit file] **********************************************
Wednesday 26 November 2025  15:49:29 +0000 (0:00:00.722)       0:00:08.807 ****
changed: [instance]

TASK [dnsmasq : Remove main configuration files] *******************************
Wednesday 26 November 2025  15:49:29 +0000 (0:00:00.199)       0:00:09.006 ****
changed: [instance] => (item=/etc/cifmw-dnsmasq.conf)
changed: [instance] => (item=/etc/cifmw-dnsmasq.d)

TASK [dnsmasq : Remove lease file] *********************************************
Wednesday 26 November 2025  15:49:29 +0000 (0:00:00.359)       0:00:09.365 ****
changed: [instance]

RUNNING HANDLER [dnsmasq : Restart dnsmasq] ************************************
Wednesday 26 November 2025  15:49:30 +0000 (0:00:00.216)       0:00:09.582 ****
ok: [instance]

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

Wednesday 26 November 2025  15:49:30 +0000 (0:00:00.315)       0:00:09.897 ****
===============================================================================
dnsmasq : Ensure SELinux knows about the new files and directories ------ 3.24s
dnsmasq : Install needed packages --------------------------------------- 1.23s
Gathering Facts --------------------------------------------------------- 0.78s
dnsmasq : Stop service -------------------------------------------------- 0.72s
Copy generated content in ci-framework-data/artifacts ------------------- 0.53s
dnsmasq : Add/Remove address -------------------------------------------- 0.38s
dnsmasq : Add/Remove address -------------------------------------------- 0.38s
dnsmasq : Remove main configuration files ------------------------------- 0.36s
dnsmasq : Restart dnsmasq ----------------------------------------------- 0.32s
dnsmasq : Manage configuration directory -------------------------------- 0.30s
dnsmasq : Add/Remove forwarder ------------------------------------------ 0.28s
dnsmasq : Remove dns configuration file --------------------------------- 0.22s
dnsmasq : Remove lease file --------------------------------------------- 0.22s
dnsmasq : Remove listener configuration file ---------------------------- 0.21s
dnsmasq : Remove unit file ---------------------------------------------- 0.20s
dnsmasq : Assert each address element have needed data ------------------ 0.08s
dnsmasq : Assert each address element have needed data ------------------ 0.04s
dnsmasq : Assert each forwarder element have needed data ---------------- 0.04s
dnsmasq : Assert we have needed address data ---------------------------- 0.03s
Remove some host records ------------------------------------------------ 0.03s