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

TASK [set basic user fact] *****************************************************
Wednesday 03 December 2025  06:14:28 +0000 (0:00:00.012)       0:00:00.012 ****
ok: [compute-1]

TASK [../../../../molecule/common/test_deps : Validating arguments against arg spec 'main' - The main entry point for the test_deps role.] ***
Wednesday 03 December 2025  06:14:28 +0000 (0:00:00.026)       0:00:00.038 ****
ok: [compute-1]

TASK [../../../../molecule/common/test_deps : Gather facts if they don't exist] ***
Wednesday 03 December 2025  06:14:28 +0000 (0:00:00.014)       0:00:00.052 ****
ok: [compute-1]

TASK [../../../../molecule/common/test_deps : Gather variables for each operating system] ***
Wednesday 03 December 2025  06:14:29 +0000 (0:00:00.477)       0:00:00.530 ****
ok: [compute-1] => (item=/home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/common/test_deps/vars/centos-9.yml)

TASK [../../../../molecule/common/test_deps : Detect mirrors file] *************
Wednesday 03 December 2025  06:14:29 +0000 (0:00:00.036)       0:00:00.566 ****
ok: [compute-1]

TASK [../../../../molecule/common/test_deps : Disable ubi host subscription-manager integration] ***
Wednesday 03 December 2025  06:14:29 +0000 (0:00:00.266)       0:00:00.833 ****
ok: [compute-1]

TASK [../../../../molecule/common/test_deps : Remove ubi 9 repos] **************
Wednesday 03 December 2025  06:14:29 +0000 (0:00:00.286)       0:00:01.120 ****
ok: [compute-1]

TASK [../../../../molecule/common/test_deps : Fetch latest repo version] *******
Wednesday 03 December 2025  06:14:30 +0000 (0:00:00.206)       0:00:01.326 ****
ok: [compute-1]

TASK [../../../../molecule/common/test_deps : Create default repo file] ********
Wednesday 03 December 2025  06:14:30 +0000 (0:00:00.521)       0:00:01.848 ****
changed: [compute-1]

TASK [../../../../molecule/common/test_deps : Install repo-setup pre-requirements] ***
Wednesday 03 December 2025  06:14:30 +0000 (0:00:00.453)       0:00:02.301 ****
ok: [compute-1]

TASK [../../../../molecule/common/test_deps : Get repo-setup repository] *******
Wednesday 03 December 2025  06:14:40 +0000 (0:00:09.303)       0:00:11.605 ****
changed: [compute-1]

TASK [../../../../molecule/common/test_deps : Install repo-setup] **************
Wednesday 03 December 2025  06:14:41 +0000 (0:00:01.010)       0:00:12.616 ****
changed: [compute-1]

TASK [../../../../molecule/common/test_deps : Create repos] ********************
Wednesday 03 December 2025  06:14:44 +0000 (0:00:03.231)       0:00:15.848 ****
changed: [compute-1]

TASK [../../../../molecule/common/test_deps : Look for redhat-release rpm] *****
Wednesday 03 December 2025  06:14:45 +0000 (0:00:00.747)       0:00:16.595 ****
fatal: [compute-1]: FAILED! => changed=true
  cmd: |-
    rpm -qe redhat-release
  delta: '0:00:00.011155'
  end: '2025-12-03 06:14:45.465045'
  msg: non-zero return code
  rc: 1
  start: '2025-12-03 06:14:45.453890'
  stderr: ''
  stderr_lines: <omitted>
  stdout: package redhat-release is not installed
  stdout_lines: <omitted>
...ignoring

TASK [../../../../molecule/common/test_deps : Workaround of redhat-release binary on ubi9] ***
Wednesday 03 December 2025  06:14:45 +0000 (0:00:00.204)       0:00:16.800 ****
skipping: [compute-1]

TASK [../../../../molecule/common/test_deps : Install edpm packages] ***********
Wednesday 03 December 2025  06:14:45 +0000 (0:00:00.027)       0:00:16.827 ****
changed: [compute-1]

TASK [../../../../molecule/common/test_deps : Install selinux python libs] *****
Wednesday 03 December 2025  06:16:04 +0000 (0:01:19.218)       0:01:36.046 ****
ok: [compute-1]

TASK [../../../../molecule/common/test_deps : Install python yaml libs] ********
Wednesday 03 December 2025  06:16:06 +0000 (0:00:01.351)       0:01:37.397 ****
ok: [compute-1]

TASK [../../../../molecule/common/test_deps : Install extra packages] **********
Wednesday 03 December 2025  06:16:07 +0000 (0:00:01.364)       0:01:38.761 ****
ok: [compute-1]

TASK [../../../../molecule/common/test_deps : Check for /etc/ansible/facts.d/bootc.fact] ***
Wednesday 03 December 2025  06:16:08 +0000 (0:00:01.382)       0:01:40.144 ****
ok: [compute-1]

TASK [../../../../molecule/common/test_deps : Create /etc/ansible/facts.d] *****
Wednesday 03 December 2025  06:16:09 +0000 (0:00:00.180)       0:01:40.325 ****
changed: [compute-1]

TASK [../../../../molecule/common/test_deps : Create /etc/ansible/facts.d/bootc.fact] ***
Wednesday 03 December 2025  06:16:09 +0000 (0:00:00.188)       0:01:40.513 ****
changed: [compute-1]

TASK [Install os-net-config] ***************************************************
Wednesday 03 December 2025  06:16:09 +0000 (0:00:00.355)       0:01:40.869 ****
ok: [compute-1]

TASK [Create persistent directories] *******************************************
Wednesday 03 December 2025  06:16:10 +0000 (0:00:01.340)       0:01:42.209 ****
changed: [compute-1] => (item={'path': '/etc/tmpfiles.d/', 'owner': 'root', 'group': 'root', 'mode': '0755'})

TASK [Create firewall directory] ***********************************************
Wednesday 03 December 2025  06:16:11 +0000 (0:00:00.194)       0:01:42.404 ****
changed: [compute-1]

TASK [open port 22 (edpm_nftables will active this later)] *********************
Wednesday 03 December 2025  06:16:11 +0000 (0:00:00.183)       0:01:42.588 ****
changed: [compute-1]

TASK [Force systemd to reread configs] *****************************************
Wednesday 03 December 2025  06:16:11 +0000 (0:00:00.329)       0:01:42.918 ****
ok: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Gather facts if they don't exist] **************
Wednesday 03 December 2025  06:16:12 +0000 (0:00:00.604)       0:01:43.522 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Download needed packages] **********************
Wednesday 03 December 2025  06:16:12 +0000 (0:00:00.014)       0:01:43.537 ****
changed: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Download legacy network service package] *******
Wednesday 03 December 2025  06:16:18 +0000 (0:00:05.811)       0:01:49.349 ****
ok: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Download release version package] **************
Wednesday 03 December 2025  06:16:19 +0000 (0:00:01.124)       0:01:50.474 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Include bootc tasks] ***************************
Wednesday 03 December 2025  06:16:19 +0000 (0:00:00.028)       0:01:50.502 ****
included: /home/zuul/.cache/ansible-compat/8075a4/collections/ansible_collections/osp/edpm/roles/edpm_bootstrap/tasks/bootc.yml for compute-1

TASK [osp.edpm.edpm_bootstrap : Check if /etc/ansible/facts.d/bootc.fact exists] ***
Wednesday 03 December 2025  06:16:19 +0000 (0:00:00.023)       0:01:50.525 ****
ok: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Ensure /etc/ansible/facts.d exists] ************
Wednesday 03 December 2025  06:16:19 +0000 (0:00:00.194)       0:01:50.720 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Ensure /etc/ansible/facts.d/bootc.fact exists] ***
Wednesday 03 December 2025  06:16:19 +0000 (0:00:00.014)       0:01:50.735 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Gather ansible_local facts] ********************
Wednesday 03 December 2025  06:16:19 +0000 (0:00:00.014)       0:01:50.749 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Ensure /var/log/journal exists] ****************
Wednesday 03 December 2025  06:16:19 +0000 (0:00:00.014)       0:01:50.764 ****
changed: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Gather user fact] ******************************
Wednesday 03 December 2025  06:16:19 +0000 (0:00:00.204)       0:01:50.969 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Ensure /var/lib/config-data/ansible-generated exists and fix subdirs owner and mode if it existed] ***
Wednesday 03 December 2025  06:16:19 +0000 (0:00:00.019)       0:01:50.989 ****
changed: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Gather services facts] *************************
Wednesday 03 December 2025  06:16:19 +0000 (0:00:00.213)       0:01:51.202 ****
ok: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Print cloud-init service status] ***************
Wednesday 03 December 2025  06:16:21 +0000 (0:00:01.850)       0:01:53.053 ****
ok: [compute-1] =>
  ansible_facts.services["cloud-init.service"]:
    name: cloud-init.service
    source: systemd
    state: stopped
    status: enabled

TASK [osp.edpm.edpm_bootstrap : Check if cloud-init is disabled via kernel args] ***
Wednesday 03 December 2025  06:16:21 +0000 (0:00:00.050)       0:01:53.103 ****
changed: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Wait for cloud-init to finish, if enabled] *****
Wednesday 03 December 2025  06:16:22 +0000 (0:00:00.265)       0:01:53.369 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Re-read facts] *********************************
Wednesday 03 December 2025  06:16:22 +0000 (0:00:00.029)       0:01:53.398 ****
ok: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Bootstrap command] *****************************
Wednesday 03 December 2025  06:16:22 +0000 (0:00:00.280)       0:01:53.679 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Bootstrap command output] **********************
Wednesday 03 December 2025  06:16:22 +0000 (0:00:00.017)       0:01:53.696 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Create directory for ansible custom facts] *****
Wednesday 03 December 2025  06:16:22 +0000 (0:00:00.017)       0:01:53.713 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Mark bootstrap command as executed on node] ****
Wednesday 03 December 2025  06:16:22 +0000 (0:00:00.017)       0:01:53.730 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Include packages tasks] ************************
Wednesday 03 December 2025  06:16:22 +0000 (0:00:00.017)       0:01:53.748 ****
included: /home/zuul/.cache/ansible-compat/8075a4/collections/ansible_collections/osp/edpm/roles/edpm_bootstrap/tasks/packages.yml for compute-1

TASK [osp.edpm.edpm_bootstrap : Gather facts if they don't exist] **************
Wednesday 03 December 2025  06:16:22 +0000 (0:00:00.036)       0:01:53.784 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Install release version package] ***************
Wednesday 03 December 2025  06:16:22 +0000 (0:00:00.018)       0:01:53.803 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Install required packages to bootstrap EDPM] ***
Wednesday 03 December 2025  06:16:22 +0000 (0:00:00.031)       0:01:53.835 ****
changed: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Ensure packages are actually well installed] ***
Wednesday 03 December 2025  06:17:07 +0000 (0:00:44.611)       0:02:38.446 ****
ok: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Set selinux state] *****************************
Wednesday 03 December 2025  06:17:07 +0000 (0:00:00.808)       0:02:39.255 ****
ok: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Include swap tasks] ****************************
Wednesday 03 December 2025  06:17:08 +0000 (0:00:00.482)       0:02:39.738 ****
included: /home/zuul/.cache/ansible-compat/8075a4/collections/ansible_collections/osp/edpm/roles/edpm_bootstrap/tasks/swap.yml for compute-1

TASK [osp.edpm.edpm_bootstrap : Gather ansible_local facts] ********************
Wednesday 03 December 2025  06:17:08 +0000 (0:00:00.034)       0:02:39.772 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Set swap path] *********************************
Wednesday 03 December 2025  06:17:08 +0000 (0:00:00.021)       0:02:39.793 ****
ok: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Create swapfile if needed] *********************
Wednesday 03 December 2025  06:17:08 +0000 (0:00:00.032)       0:02:39.826 ****
changed: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Set permission on swapfile] ********************
Wednesday 03 December 2025  06:17:09 +0000 (0:00:00.752)       0:02:40.579 ****
ok: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Enable swapfile on fstab] **********************
Wednesday 03 December 2025  06:17:09 +0000 (0:00:00.202)       0:02:40.782 ****
changed: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Check if partition exists by its label] ********
Wednesday 03 December 2025  06:17:09 +0000 (0:00:00.274)       0:02:41.057 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Enable swap partition on fstab] ****************
Wednesday 03 December 2025  06:17:09 +0000 (0:00:00.027)       0:02:41.084 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Gather swap partition by its type] *************
Wednesday 03 December 2025  06:17:09 +0000 (0:00:00.027)       0:02:41.111 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Enable swap partitions in fstab] ***************
Wednesday 03 December 2025  06:17:09 +0000 (0:00:00.027)       0:02:41.138 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Activate swap partitions] **********************
Wednesday 03 December 2025  06:17:09 +0000 (0:00:00.029)       0:02:41.168 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Check if CA cert file exists] ******************
Wednesday 03 December 2025  06:17:09 +0000 (0:00:00.027)       0:02:41.195 ****
ok: [compute-1 -> localhost]

TASK [osp.edpm.edpm_bootstrap : Ensure that the CA destination directory exists] ***
Wednesday 03 December 2025  06:17:10 +0000 (0:00:00.178)       0:02:41.373 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Copy CA certs to the standard location on the compute node] ***
Wednesday 03 December 2025  06:17:10 +0000 (0:00:00.018)       0:02:41.392 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Gather ansible_local facts] ********************
Wednesday 03 December 2025  06:17:10 +0000 (0:00:00.017)       0:02:41.410 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Check FIPS status] *****************************
Wednesday 03 December 2025  06:17:10 +0000 (0:00:00.028)       0:02:41.438 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Warn for changing FIPS status for bootc] *******
Wednesday 03 December 2025  06:17:10 +0000 (0:00:00.028)       0:02:41.467 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Enable FIPS] ***********************************
Wednesday 03 December 2025  06:17:10 +0000 (0:00:00.030)       0:02:41.497 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Disable FIPS] **********************************
Wednesday 03 December 2025  06:17:10 +0000 (0:00:00.028)       0:02:41.525 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Create directory required by edpm-reboot role] ***
Wednesday 03 December 2025  06:17:10 +0000 (0:00:00.028)       0:02:41.553 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Create required file to enforce a reboot] ******
Wednesday 03 December 2025  06:17:10 +0000 (0:00:00.028)       0:02:41.582 ****
skipping: [compute-1]

TASK [Call edpm_reboot role] ***************************************************
Wednesday 03 December 2025  06:17:10 +0000 (0:00:00.028)       0:02:41.610 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Ensure that the proper FIPS status is enabled] ***
Wednesday 03 December 2025  06:17:10 +0000 (0:00:00.028)       0:02:41.639 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Check if the LVM devices file exists] **********
Wednesday 03 December 2025  06:17:10 +0000 (0:00:00.030)       0:02:41.669 ****
ok: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Import any existing LVM devices] ***************
Wednesday 03 December 2025  06:17:10 +0000 (0:00:00.190)       0:02:41.860 ****
changed: [compute-1]

TASK [osp.edpm.edpm_bootstrap : Create an empty LVM devices file] **************
Wednesday 03 December 2025  06:17:10 +0000 (0:00:00.243)       0:02:42.104 ****
changed: [compute-1]

RUNNING HANDLER [osp.edpm.edpm_bootstrap : Setup linux swap area on file if needed] ***
Wednesday 03 December 2025  06:17:11 +0000 (0:00:00.216)       0:02:42.321 ****
changed: [compute-1]

RUNNING HANDLER [osp.edpm.edpm_bootstrap : Activate swap] **********************
Wednesday 03 December 2025  06:17:11 +0000 (0:00:00.451)       0:02:42.772 ****
changed: [compute-1]

PLAY RECAP *********************************************************************
compute-1                  : ok=51   changed=22   unreachable=0    failed=0    skipped=31   rescued=0    ignored=1

Wednesday 03 December 2025  06:17:11 +0000 (0:00:00.202)       0:02:42.974 ****
===============================================================================
../../../../molecule/common/test_deps : Install edpm packages ---------- 79.22s
osp.edpm.edpm_bootstrap : Install required packages to bootstrap EDPM -- 44.61s
../../../../molecule/common/test_deps : Install repo-setup pre-requirements --- 9.30s
osp.edpm.edpm_bootstrap : Download needed packages ---------------------- 5.81s
../../../../molecule/common/test_deps : Install repo-setup -------------- 3.23s
osp.edpm.edpm_bootstrap : Gather services facts ------------------------- 1.85s
../../../../molecule/common/test_deps : Install extra packages ---------- 1.38s
../../../../molecule/common/test_deps : Install python yaml libs -------- 1.36s
../../../../molecule/common/test_deps : Install selinux python libs ----- 1.35s
Install os-net-config --------------------------------------------------- 1.34s
osp.edpm.edpm_bootstrap : Download legacy network service package ------- 1.12s
../../../../molecule/common/test_deps : Get repo-setup repository ------- 1.01s
osp.edpm.edpm_bootstrap : Ensure packages are actually well installed --- 0.81s
osp.edpm.edpm_bootstrap : Create swapfile if needed --------------------- 0.75s
../../../../molecule/common/test_deps : Create repos -------------------- 0.75s
Force systemd to reread configs ----------------------------------------- 0.60s
../../../../molecule/common/test_deps : Fetch latest repo version ------- 0.52s
osp.edpm.edpm_bootstrap : Set selinux state ----------------------------- 0.48s
../../../../molecule/common/test_deps : Gather facts if they don't exist --- 0.48s
../../../../molecule/common/test_deps : Create default repo file -------- 0.45s

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

TASK [set basic user fact] *****************************************************
Wednesday 03 December 2025  06:17:12 +0000 (0:00:00.013)       0:00:00.013 ****
ok: [compute-1]

TASK [Download required role packages] *****************************************
Wednesday 03 December 2025  06:17:12 +0000 (0:00:00.041)       0:00:00.055 ****

TASK [osp.edpm.edpm_frr : Download needed container images] ********************
Wednesday 03 December 2025  06:17:12 +0000 (0:00:00.032)       0:00:00.087 ****
changed: [compute-1] => (item=quay.io/podified-antelope-centos9/openstack-frr:current-podified)

TASK [ansible.builtin.include_role : osp.edpm.edpm_frr] ************************
Wednesday 03 December 2025  06:17:17 +0000 (0:00:05.715)       0:00:05.803 ****

TASK [osp.edpm.edpm_frr : Validating arguments against arg spec 'main' - The main entry point for the edpm_frr role.] ***
Wednesday 03 December 2025  06:17:17 +0000 (0:00:00.062)       0:00:05.865 ****
ok: [compute-1]

TASK [osp.edpm.edpm_frr : Gather user fact] ************************************
Wednesday 03 December 2025  06:17:18 +0000 (0:00:00.037)       0:00:05.902 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_frr : Create persistent directories] ***********************
Wednesday 03 December 2025  06:17:18 +0000 (0:00:00.023)       0:00:05.926 ****
changed: [compute-1] => (item={'path': '/var/lib/openstack/frr', 'setype': 'container_file_t', 'mode': '0750'})
changed: [compute-1] => (item={'path': '/run/frr', 'setype': 'container_file_t', 'mode': '0755'})
changed: [compute-1] => (item={'path': '/var/lib/edpm-config/firewall', 'setype': 'container_file_t', 'mode': '0750'})

TASK [osp.edpm.edpm_frr : Ensure /run/frr is present upon reboot] **************
Wednesday 03 December 2025  06:17:18 +0000 (0:00:00.686)       0:00:06.612 ****
changed: [compute-1]

TASK [osp.edpm.edpm_frr : Gather SELinux fact if needed] ***********************
Wednesday 03 December 2025  06:17:19 +0000 (0:00:00.530)       0:00:07.143 ****
ok: [compute-1]

TASK [osp.edpm.edpm_frr : Create directory /var/lib/openstack/frr] *************
Wednesday 03 December 2025  06:17:19 +0000 (0:00:00.449)       0:00:07.592 ****
changed: [compute-1]

TASK [osp.edpm.edpm_frr : Inject firewall rules for frr BGP and BFD] ***********
Wednesday 03 December 2025  06:17:19 +0000 (0:00:00.213)       0:00:07.806 ****
changed: [compute-1]

TASK [Configure firewall for frr BGP and BFD] **********************************
Wednesday 03 December 2025  06:17:20 +0000 (0:00:00.300)       0:00:08.106 ****

TASK [osp.edpm.edpm_nftables : Create snippets directory] **********************
Wednesday 03 December 2025  06:17:20 +0000 (0:00:00.040)       0:00:08.146 ****
changed: [compute-1]

TASK [osp.edpm.edpm_nftables : Push default ruleset snipet] ********************
Wednesday 03 December 2025  06:17:20 +0000 (0:00:00.199)       0:00:08.345 ****
changed: [compute-1]

TASK [osp.edpm.edpm_nftables : Write user rules snippet] ***********************
Wednesday 03 December 2025  06:17:20 +0000 (0:00:00.362)       0:00:08.708 ****
changed: [compute-1]

TASK [osp.edpm.edpm_nftables : Push empty ruleset] *****************************
Wednesday 03 December 2025  06:17:21 +0000 (0:00:00.363)       0:00:09.072 ****
changed: [compute-1]

TASK [osp.edpm.edpm_nftables : Load empty ruleset] *****************************
Wednesday 03 December 2025  06:17:21 +0000 (0:00:00.357)       0:00:09.429 ****
changed: [compute-1]

TASK [osp.edpm.edpm_nftables : Get current nftables content] *******************
Wednesday 03 December 2025  06:17:21 +0000 (0:00:00.303)       0:00:09.732 ****
changed: [compute-1]

TASK [osp.edpm.edpm_nftables : Load firewall snippets] *************************
Wednesday 03 December 2025  06:17:22 +0000 (0:00:00.204)       0:00:09.937 ****
ok: [compute-1]

TASK [osp.edpm.edpm_nftables : Generate chain jumps] ***************************
Wednesday 03 December 2025  06:17:22 +0000 (0:00:00.276)       0:00:10.213 ****
changed: [compute-1]

TASK [osp.edpm.edpm_nftables : Generate chain jumps] ***************************
Wednesday 03 December 2025  06:17:22 +0000 (0:00:00.401)       0:00:10.615 ****
changed: [compute-1]

TASK [osp.edpm.edpm_nftables : Generate nft flushes] ***************************
Wednesday 03 December 2025  06:17:23 +0000 (0:00:00.374)       0:00:10.990 ****
changed: [compute-1]

TASK [osp.edpm.edpm_nftables : Generate nft edpm chains] ***********************
Wednesday 03 December 2025  06:17:23 +0000 (0:00:00.350)       0:00:11.341 ****
changed: [compute-1]

TASK [osp.edpm.edpm_nftables : Generate nft ruleset in static file] ************
Wednesday 03 December 2025  06:17:23 +0000 (0:00:00.358)       0:00:11.699 ****
changed: [compute-1]

TASK [osp.edpm.edpm_nftables : Create a sentinel file when nft rules are changed] ***
Wednesday 03 December 2025  06:17:24 +0000 (0:00:00.396)       0:00:12.095 ****
changed: [compute-1]

TASK [osp.edpm.edpm_nftables : Validate all of the generated content before loading] ***
Wednesday 03 December 2025  06:17:24 +0000 (0:00:00.207)       0:00:12.303 ****
changed: [compute-1]

TASK [osp.edpm.edpm_nftables : Ensure we load our different nft rulesets on boot] ***
Wednesday 03 December 2025  06:17:24 +0000 (0:00:00.251)       0:00:12.554 ****
changed: [compute-1]

TASK [Apply firewall for frr BGP and BFD] **************************************
Wednesday 03 December 2025  06:17:24 +0000 (0:00:00.289)       0:00:12.844 ****

TASK [osp.edpm.edpm_nftables : Inject our custom chains in nftables] ***********
Wednesday 03 December 2025  06:17:24 +0000 (0:00:00.047)       0:00:12.891 ****
changed: [compute-1]

TASK [osp.edpm.edpm_nftables : Check if rules are changed] *********************
Wednesday 03 December 2025  06:17:25 +0000 (0:00:00.194)       0:00:13.086 ****
ok: [compute-1]

TASK [osp.edpm.edpm_nftables : Reload ruleset] *********************************
Wednesday 03 December 2025  06:17:25 +0000 (0:00:00.192)       0:00:13.278 ****
changed: [compute-1]

TASK [osp.edpm.edpm_nftables : Delete nft_ruleset_changed file] ****************
Wednesday 03 December 2025  06:17:25 +0000 (0:00:00.217)       0:00:13.496 ****
changed: [compute-1]

TASK [osp.edpm.edpm_frr : Identify the real interfaces via os-net-config] ******
Wednesday 03 December 2025  06:17:25 +0000 (0:00:00.205)       0:00:13.701 ****
changed: [compute-1]

TASK [osp.edpm.edpm_frr : Os-net-config from json] *****************************
Wednesday 03 December 2025  06:17:26 +0000 (0:00:00.466)       0:00:14.168 ****
ok: [compute-1]

TASK [osp.edpm.edpm_frr : Assert either edpm_frr_bgp_peers or edpm_frr_bgp_uplinks configured] ***
Wednesday 03 December 2025  06:17:26 +0000 (0:00:00.040)       0:00:14.208 ****
ok: [compute-1] => changed=false
  msg: All assertions passed

TASK [osp.edpm.edpm_frr : Construct FRR uplink interfaces from os-net-config mappings] ***
Wednesday 03 December 2025  06:17:26 +0000 (0:00:00.033)       0:00:14.242 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_frr : Failed to construct FRR uplink interfaces] ***********
Wednesday 03 December 2025  06:17:26 +0000 (0:00:00.029)       0:00:14.272 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_frr : Gather facts if they don't exist] ********************
Wednesday 03 December 2025  06:17:26 +0000 (0:00:00.031)       0:00:14.304 ****
ok: [compute-1]

TASK [osp.edpm.edpm_frr : Configure FRR] ***************************************
Wednesday 03 December 2025  06:17:26 +0000 (0:00:00.290)       0:00:14.594 ****
changed: [compute-1]

TASK [osp.edpm.edpm_frr : Configure FRR daemons] *******************************
Wednesday 03 December 2025  06:17:27 +0000 (0:00:00.408)       0:00:15.002 ****
changed: [compute-1]

TASK [osp.edpm.edpm_container_manage : Create /var/local/libexec dir] **********
Wednesday 03 December 2025  06:17:27 +0000 (0:00:00.374)       0:00:15.377 ****
changed: [compute-1]

TASK [osp.edpm.edpm_container_manage : Deploy edpm-container-shutdown and edpm-start-podman-container] ***
Wednesday 03 December 2025  06:17:27 +0000 (0:00:00.194)       0:00:15.571 ****
changed: [compute-1] => (item=edpm-container-shutdown)
changed: [compute-1] => (item=edpm-start-podman-container)

TASK [osp.edpm.edpm_container_manage : Create systemd preset dir] **************
Wednesday 03 December 2025  06:17:28 +0000 (0:00:00.694)       0:00:16.265 ****
changed: [compute-1]

TASK [osp.edpm.edpm_container_manage : Create /etc/systemd/system/edpm-container-shutdown.service] ***
Wednesday 03 December 2025  06:17:28 +0000 (0:00:00.209)       0:00:16.475 ****
changed: [compute-1]

TASK [osp.edpm.edpm_container_manage : Create /etc/systemd/system-preset/91-edpm-container-shutdown.preset] ***
Wednesday 03 December 2025  06:17:28 +0000 (0:00:00.364)       0:00:16.839 ****
changed: [compute-1]

TASK [osp.edpm.edpm_container_manage : Enable and start edpm-container-shutdown] ***
Wednesday 03 December 2025  06:17:29 +0000 (0:00:00.350)       0:00:17.190 ****
changed: [compute-1]

TASK [osp.edpm.edpm_container_manage : Create /etc/systemd/system/netns-placeholder.service] ***
Wednesday 03 December 2025  06:17:30 +0000 (0:00:00.839)       0:00:18.029 ****
changed: [compute-1]

TASK [osp.edpm.edpm_container_manage : Create /etc/systemd/system-preset/91-netns-placeholder.preset] ***
Wednesday 03 December 2025  06:17:30 +0000 (0:00:00.366)       0:00:18.396 ****
changed: [compute-1]

TASK [osp.edpm.edpm_container_manage : Enable and start netns-placeholder] *****
Wednesday 03 December 2025  06:17:30 +0000 (0:00:00.347)       0:00:18.744 ****
changed: [compute-1]

TASK [Run frr container] *******************************************************
Wednesday 03 December 2025  06:17:31 +0000 (0:00:00.614)       0:00:19.359 ****

TASK [osp.edpm.edpm_container_standalone : Validating arguments against arg spec 'main' - The main entry point for the edpm_container_standalone role.] ***
Wednesday 03 December 2025  06:17:31 +0000 (0:00:00.042)       0:00:19.401 ****
ok: [compute-1]

TASK [osp.edpm.edpm_container_standalone : Ensure /var/lib/edpm-config exists with correct ownership] ***
Wednesday 03 December 2025  06:17:31 +0000 (0:00:00.051)       0:00:19.452 ****
changed: [compute-1]

TASK [osp.edpm.edpm_container_standalone : Ensure directory exists: /var/lib/kolla/config_files] ***
Wednesday 03 December 2025  06:17:31 +0000 (0:00:00.221)       0:00:19.674 ****
changed: [compute-1]

TASK [osp.edpm.edpm_container_standalone : Create kolla config files] **********
Wednesday 03 December 2025  06:17:31 +0000 (0:00:00.195)       0:00:19.869 ****
changed: [compute-1] => (item={'key': 'frr', 'value': {'command': 'bash -c $* -- eval if [ -f /usr/libexec/frr/frrinit.sh ]; then /usr/libexec/frr/frrinit.sh start; else /usr/lib/frr/frr start; fi  && exec /bin/sleep infinity', 'config_files': [{'source': '/var/lib/kolla/config_files/src/etc/frr/*', 'dest': '/etc/frr/', 'merge': True, 'preserve_properties': True}], 'permissions': [{'path': '/run/frr', 'owner': 'frr:frrvty', 'recurse': True}]}})

TASK [osp.edpm.edpm_container_standalone : Create config file /var/lib/edpm-config/container-startup-config/frr] ***
Wednesday 03 December 2025  06:17:32 +0000 (0:00:00.363)       0:00:20.233 ****
changed: [compute-1]

TASK [osp.edpm.edpm_container_standalone : Render container definitions: [frr ]] ***
Wednesday 03 December 2025  06:17:32 +0000 (0:00:00.205)       0:00:20.438 ****
changed: [compute-1] => (item=None)
changed: [compute-1]

TASK [Run containers: [ frr ]] *************************************************
Wednesday 03 December 2025  06:17:32 +0000 (0:00:00.382)       0:00:20.821 ****

TASK [osp.edpm.edpm_container_manage : Validating arguments against arg spec 'main' - The main entry point for the edpm_container_manage role.] ***
Wednesday 03 December 2025  06:17:32 +0000 (0:00:00.040)       0:00:20.861 ****
ok: [compute-1]

TASK [osp.edpm.edpm_container_manage : Find all matching configs configs for in /var/lib/edpm-config/container-startup-config/frr] ***
Wednesday 03 December 2025  06:17:33 +0000 (0:00:00.051)       0:00:20.913 ****
ok: [compute-1]

TASK [osp.edpm.edpm_container_manage : Initialize all_containers_hash for this invocation] ***
Wednesday 03 December 2025  06:17:33 +0000 (0:00:00.293)       0:00:21.206 ****
ok: [compute-1]

TASK [osp.edpm.edpm_container_manage : Filter configs if container list provided] ***
Wednesday 03 December 2025  06:17:33 +0000 (0:00:00.050)       0:00:21.256 ****
ok: [compute-1] => (item=frr)

TASK [osp.edpm.edpm_container_manage : Use all configs if no filter] ***********
Wednesday 03 December 2025  06:17:33 +0000 (0:00:00.067)       0:00:21.324 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_container_manage : Update container configs with new config hashes] ***
Wednesday 03 December 2025  06:17:33 +0000 (0:00:00.047)       0:00:21.371 ****
changed: [compute-1]

TASK [osp.edpm.edpm_container_manage : Delete orphan containers (DEPRECATED)] ***
Wednesday 03 December 2025  06:17:33 +0000 (0:00:00.293)       0:00:21.664 ****
included: /home/zuul/.cache/ansible-compat/8075a4/collections/ansible_collections/osp/edpm/roles/edpm_container_manage/tasks/delete_orphan.yml for compute-1

TASK [osp.edpm.edpm_container_manage : Gather podman infos] ********************
Wednesday 03 December 2025  06:17:33 +0000 (0:00:00.041)       0:00:21.706 ****
ok: [compute-1]

TASK [osp.edpm.edpm_container_manage : Exclude Ceph containers from podman container list] ***
Wednesday 03 December 2025  06:17:34 +0000 (0:00:00.319)       0:00:22.025 ****
ok: [compute-1]

TASK [Delete orphan containers managed by Podman for /var/lib/edpm-config/container-startup-config/frr] ***
Wednesday 03 December 2025  06:17:34 +0000 (0:00:00.039)       0:00:22.065 ****

TASK [osp.edpm.edpm_container_rm : Validating arguments against arg spec 'main' - The main entry point for the edpm_container_rm role.] ***
Wednesday 03 December 2025  06:17:34 +0000 (0:00:00.049)       0:00:22.115 ****
ok: [compute-1]

TASK [osp.edpm.edpm_container_rm : Include edpm container rm task file] ********
Wednesday 03 December 2025  06:17:34 +0000 (0:00:00.040)       0:00:22.155 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_container_manage : Create containers from /var/lib/edpm-config/container-startup-config/frr] ***
Wednesday 03 December 2025  06:17:34 +0000 (0:00:00.038)       0:00:22.193 ****
included: /home/zuul/.cache/ansible-compat/8075a4/collections/ansible_collections/osp/edpm/roles/edpm_container_manage/tasks/create.yml for compute-1

TASK [osp.edpm.edpm_container_manage : Create containers managed by Podman for /var/lib/edpm-config/container-startup-config/frr] ***
Wednesday 03 December 2025  06:17:34 +0000 (0:00:00.045)       0:00:22.239 ****
changed: [compute-1]

TASK [osp.edpm.edpm_container_manage : Check if /etc/sysconfig/podman_drop_in exists] ***
Wednesday 03 December 2025  06:17:34 +0000 (0:00:00.566)       0:00:22.806 ****
ok: [compute-1]

TASK [osp.edpm.edpm_container_manage : Set podman_drop_in fact] ****************
Wednesday 03 December 2025  06:17:35 +0000 (0:00:00.196)       0:00:23.003 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_container_manage : Manage container systemd services and cleanup old systemd healthchecks for /var/lib/edpm-config/container-startup-config/frr] ***
Wednesday 03 December 2025  06:17:35 +0000 (0:00:00.036)       0:00:23.039 ****
changed: [compute-1]

TASK [osp.edpm.edpm_container_standalone : Update service state file] **********
Wednesday 03 December 2025  06:17:36 +0000 (0:00:01.475)       0:00:24.515 ****
included: /home/zuul/.cache/ansible-compat/8075a4/collections/ansible_collections/osp/edpm/roles/edpm_container_standalone/tasks/state_file_update.yml for compute-1

TASK [osp.edpm.edpm_container_standalone : Read current state file] ************
Wednesday 03 December 2025  06:17:36 +0000 (0:00:00.056)       0:00:24.572 ****
ok: [compute-1]

TASK [osp.edpm.edpm_container_standalone : Parse state file data] **************
Wednesday 03 December 2025  06:17:36 +0000 (0:00:00.264)       0:00:24.836 ****
skipping: [compute-1]

TASK [osp.edpm.edpm_container_standalone : Initialize empty state data if file doesn't exist] ***
Wednesday 03 December 2025  06:17:36 +0000 (0:00:00.023)       0:00:24.859 ****
ok: [compute-1]

TASK [osp.edpm.edpm_container_standalone : Update service in state data] *******
Wednesday 03 December 2025  06:17:36 +0000 (0:00:00.025)       0:00:24.884 ****
ok: [compute-1]

TASK [osp.edpm.edpm_container_standalone : Write updated state file] ***********
Wednesday 03 December 2025  06:17:37 +0000 (0:00:00.061)       0:00:24.946 ****
changed: [compute-1]

PLAY RECAP *********************************************************************
compute-1                  : ok=66   changed=43   unreachable=0    failed=0    skipped=7    rescued=0    ignored=0

Wednesday 03 December 2025  06:17:37 +0000 (0:00:00.385)       0:00:25.331 ****
===============================================================================
osp.edpm.edpm_frr : Download needed container images -------------------- 5.72s
osp.edpm.edpm_container_manage : Manage container systemd services and cleanup old systemd healthchecks for /var/lib/edpm-config/container-startup-config/frr --- 1.48s
osp.edpm.edpm_container_manage : Enable and start edpm-container-shutdown --- 0.84s
osp.edpm.edpm_container_manage : Deploy edpm-container-shutdown and edpm-start-podman-container --- 0.69s
osp.edpm.edpm_frr : Create persistent directories ----------------------- 0.69s
osp.edpm.edpm_container_manage : Enable and start netns-placeholder ----- 0.61s
osp.edpm.edpm_container_manage : Create containers managed by Podman for /var/lib/edpm-config/container-startup-config/frr --- 0.57s
osp.edpm.edpm_frr : Ensure /run/frr is present upon reboot -------------- 0.53s
osp.edpm.edpm_frr : Identify the real interfaces via os-net-config ------ 0.47s
osp.edpm.edpm_frr : Gather SELinux fact if needed ----------------------- 0.45s
osp.edpm.edpm_frr : Configure FRR --------------------------------------- 0.41s
osp.edpm.edpm_nftables : Generate chain jumps --------------------------- 0.40s
osp.edpm.edpm_nftables : Generate nft ruleset in static file ------------ 0.40s
osp.edpm.edpm_container_standalone : Write updated state file ----------- 0.39s
osp.edpm.edpm_container_standalone : Render container definitions: [frr ] --- 0.38s
osp.edpm.edpm_nftables : Generate chain jumps --------------------------- 0.37s
osp.edpm.edpm_frr : Configure FRR daemons ------------------------------- 0.37s
osp.edpm.edpm_container_manage : Create /etc/systemd/system/netns-placeholder.service --- 0.37s
osp.edpm.edpm_container_manage : Create /etc/systemd/system/edpm-container-shutdown.service --- 0.36s
osp.edpm.edpm_nftables : Write user rules snippet ----------------------- 0.36s

PLAY [Verify frr] **************************************************************

TASK [ensure expected directories exist] ***************************************
Wednesday 03 December 2025  06:17:37 +0000 (0:00:00.025)       0:00:00.025 ****
included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_dir.yaml for compute-1 => (item=/var/lib/edpm-config/container-startup-config/frr)
included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_dir.yaml for compute-1 => (item=/var/lib/openstack/frr)
included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_dir.yaml for compute-1 => (item=/etc/tmpfiles.d/)
included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_dir.yaml for compute-1 => (item=/var/lib/openstack/frr/etc/frr)

TASK [Check if directory exists /var/lib/edpm-config/container-startup-config/frr] ***
Wednesday 03 December 2025  06:17:37 +0000 (0:00:00.034)       0:00:00.060 ****
ok: [compute-1]

TASK [Assert directory exists /var/lib/edpm-config/container-startup-config/frr] ***
Wednesday 03 December 2025  06:17:38 +0000 (0:00:00.273)       0:00:00.334 ****
ok: [compute-1] => changed=false
  msg: All assertions passed

TASK [Check if directory exists /var/lib/openstack/frr] ************************
Wednesday 03 December 2025  06:17:38 +0000 (0:00:00.022)       0:00:00.356 ****
ok: [compute-1]

TASK [Assert directory exists /var/lib/openstack/frr] **************************
Wednesday 03 December 2025  06:17:38 +0000 (0:00:00.189)       0:00:00.545 ****
ok: [compute-1] => changed=false
  msg: All assertions passed

TASK [Check if directory exists /etc/tmpfiles.d/] ******************************
Wednesday 03 December 2025  06:17:38 +0000 (0:00:00.021)       0:00:00.567 ****
ok: [compute-1]

TASK [Assert directory exists /etc/tmpfiles.d/] ********************************
Wednesday 03 December 2025  06:17:38 +0000 (0:00:00.187)       0:00:00.755 ****
ok: [compute-1] => changed=false
  msg: All assertions passed

TASK [Check if directory exists /var/lib/openstack/frr/etc/frr] ****************
Wednesday 03 December 2025  06:17:38 +0000 (0:00:00.035)       0:00:00.790 ****
ok: [compute-1]

TASK [Assert directory exists /var/lib/openstack/frr/etc/frr] ******************
Wednesday 03 December 2025  06:17:38 +0000 (0:00:00.179)       0:00:00.970 ****
ok: [compute-1] => changed=false
  msg: All assertions passed

TASK [Check if file /etc/tmpfiles.d/run-frr.conf exist] ************************
Wednesday 03 December 2025  06:17:38 +0000 (0:00:00.021)       0:00:00.991 ****
ok: [compute-1]

TASK [Assert file /etc/tmpfiles.d/run-frr.conf exist] **************************
Wednesday 03 December 2025  06:17:39 +0000 (0:00:00.187)       0:00:01.178 ****
ok: [compute-1] => changed=false
  msg: All assertions passed

TASK [Check if file /var/lib/openstack/frr/etc/frr/frr.conf exist] *************
Wednesday 03 December 2025  06:17:39 +0000 (0:00:00.019)       0:00:01.198 ****
ok: [compute-1]

TASK [Assert file /var/lib/openstack/frr/etc/frr/frr.conf exist] ***************
Wednesday 03 December 2025  06:17:39 +0000 (0:00:00.192)       0:00:01.391 ****
ok: [compute-1] => changed=false
  msg: All assertions passed

TASK [Check if file /var/lib/openstack/frr/etc/frr/daemons exist] **************
Wednesday 03 December 2025  06:17:39 +0000 (0:00:00.018)       0:00:01.410 ****
ok: [compute-1]

TASK [Assert file /var/lib/openstack/frr/etc/frr/daemons exist] ****************
Wednesday 03 December 2025  06:17:39 +0000 (0:00:00.189)       0:00:01.599 ****
ok: [compute-1] => changed=false
  msg: All assertions passed

TASK [rule source file exists] *************************************************
Wednesday 03 December 2025  06:17:39 +0000 (0:00:00.018)       0:00:01.618 ****
ok: [compute-1]

TASK [Assert frr BGP and BFD rule source file exists] **************************
Wednesday 03 December 2025  06:17:39 +0000 (0:00:00.189)       0:00:01.807 ****
ok: [compute-1] => changed=false
  msg: All assertions passed

TASK [Check if nftables rule exists in /etc/nftables/edpm-rules.nft] ***********
Wednesday 03 December 2025  06:17:39 +0000 (0:00:00.019)       0:00:01.827 ****
changed: [compute-1] => (item=121 frr bgp port)
changed: [compute-1] => (item=122 frr bfd ports)

TASK [Assert nftables rule exists in /etc/nftables/edpm-rules.nft] *************
Wednesday 03 December 2025  06:17:40 +0000 (0:00:00.457)       0:00:02.284 ****
ok: [compute-1] => (item={'changed': True, 'stdout': '', 'stderr': '', 'rc': 0, 'cmd': 'grep -q "121 frr bgp port" /etc/nftables/edpm-rules.nft', 'start': '2025-12-03 06:17:39.952050', 'end': '2025-12-03 06:17:39.956634', 'delta': '0:00:00.004584', 'msg': '', 'invocation': {'module_args': {'_raw_params': 'grep -q "121 frr bgp port" /etc/nftables/edpm-rules.nft', '_uses_shell': True, 'stdin_add_newline': True, 'strip_empty_ends': True, 'argv': None, 'chdir': None, 'executable': None, 'creates': None, 'removes': None, 'stdin': None}}, 'stdout_lines': [], 'stderr_lines': [], 'failed': False, 'item': '121 frr bgp port', 'ansible_loop_var': 'item'}) => changed=false
  ansible_loop_var: item
  item:
    ansible_loop_var: item
    changed: true
    cmd: grep -q "121 frr bgp port" /etc/nftables/edpm-rules.nft
    delta: '0:00:00.004584'
    end: '2025-12-03 06:17:39.956634'
    failed: false
    invocation:
      module_args:
        _raw_params: grep -q "121 frr bgp port" /etc/nftables/edpm-rules.nft
        _uses_shell: true
        argv: null
        chdir: null
        creates: null
        executable: null
        removes: null
        stdin: null
        stdin_add_newline: true
        strip_empty_ends: true
    item: 121 frr bgp port
    msg: ''
    rc: 0
    start: '2025-12-03 06:17:39.952050'
    stderr: ''
    stderr_lines: []
    stdout: ''
    stdout_lines: []
  msg: All assertions passed
ok: [compute-1] => (item={'changed': True, 'stdout': '', 'stderr': '', 'rc': 0, 'cmd': 'grep -q "122 frr bfd ports" /etc/nftables/edpm-rules.nft', 'start': '2025-12-03 06:17:40.126041', 'end': '2025-12-03 06:17:40.130040', 'delta': '0:00:00.003999', 'msg': '', 'invocation': {'module_args': {'_raw_params': 'grep -q "122 frr bfd ports" /etc/nftables/edpm-rules.nft', '_uses_shell': True, 'stdin_add_newline': True, 'strip_empty_ends': True, 'argv': None, 'chdir': None, 'executable': None, 'creates': None, 'removes': None, 'stdin': None}}, 'stdout_lines': [], 'stderr_lines': [], 'failed': False, 'item': '122 frr bfd ports', 'ansible_loop_var': 'item'}) => changed=false
  ansible_loop_var: item
  item:
    ansible_loop_var: item
    changed: true
    cmd: grep -q "122 frr bfd ports" /etc/nftables/edpm-rules.nft
    delta: '0:00:00.003999'
    end: '2025-12-03 06:17:40.130040'
    failed: false
    invocation:
      module_args:
        _raw_params: grep -q "122 frr bfd ports" /etc/nftables/edpm-rules.nft
        _uses_shell: true
        argv: null
        chdir: null
        creates: null
        executable: null
        removes: null
        stdin: null
        stdin_add_newline: true
        strip_empty_ends: true
    item: 122 frr bfd ports
    msg: ''
    rc: 0
    start: '2025-12-03 06:17:40.126041'
    stderr: ''
    stderr_lines: []
    stdout: ''
    stdout_lines: []
  msg: All assertions passed

TASK [Check rule content] ******************************************************
Wednesday 03 December 2025  06:17:40 +0000 (0:00:00.032)       0:00:02.317 ****
changed: [compute-1] => (item=tcp dport { 179 } ct state new counter accept)
changed: [compute-1] => (item=udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter accept)

TASK [Assert rule content exists] **********************************************
Wednesday 03 December 2025  06:17:40 +0000 (0:00:00.357)       0:00:02.674 ****
ok: [compute-1] => (item={'changed': True, 'stdout': '', 'stderr': '', 'rc': 0, 'cmd': 'grep -q "tcp dport { 179 } ct state new counter accept" /etc/nftables/edpm-rules.nft', 'start': '2025-12-03 06:17:40.346619', 'end': '2025-12-03 06:17:40.350643', 'delta': '0:00:00.004024', 'msg': '', 'invocation': {'module_args': {'_raw_params': 'grep -q "tcp dport { 179 } ct state new counter accept" /etc/nftables/edpm-rules.nft', '_uses_shell': True, 'stdin_add_newline': True, 'strip_empty_ends': True, 'argv': None, 'chdir': None, 'executable': None, 'creates': None, 'removes': None, 'stdin': None}}, 'stdout_lines': [], 'stderr_lines': [], 'failed': False, 'item': 'tcp dport { 179 } ct state new counter accept', 'ansible_loop_var': 'item'}) => changed=false
  ansible_loop_var: item
  item:
    ansible_loop_var: item
    changed: true
    cmd: grep -q "tcp dport { 179 } ct state new counter accept" /etc/nftables/edpm-rules.nft
    delta: '0:00:00.004024'
    end: '2025-12-03 06:17:40.350643'
    failed: false
    invocation:
      module_args:
        _raw_params: grep -q "tcp dport { 179 } ct state new counter accept" /etc/nftables/edpm-rules.nft
        _uses_shell: true
        argv: null
        chdir: null
        creates: null
        executable: null
        removes: null
        stdin: null
        stdin_add_newline: true
        strip_empty_ends: true
    item: tcp dport { 179 } ct state new counter accept
    msg: ''
    rc: 0
    start: '2025-12-03 06:17:40.346619'
    stderr: ''
    stderr_lines: []
    stdout: ''
    stdout_lines: []
  msg: All assertions passed
ok: [compute-1] => (item={'changed': True, 'stdout': '', 'stderr': '', 'rc': 0, 'cmd': 'grep -q "udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter accept" /etc/nftables/edpm-rules.nft', 'start': '2025-12-03 06:17:40.518641', 'end': '2025-12-03 06:17:40.523135', 'delta': '0:00:00.004494', 'msg': '', 'invocation': {'module_args': {'_raw_params': 'grep -q "udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter accept" /etc/nftables/edpm-rules.nft', '_uses_shell': True, 'stdin_add_newline': True, 'strip_empty_ends': True, 'argv': None, 'chdir': None, 'executable': None, 'creates': None, 'removes': None, 'stdin': None}}, 'stdout_lines': [], 'stderr_lines': [], 'failed': False, 'item': 'udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter accept', 'ansible_loop_var': 'item'}) => changed=false
  ansible_loop_var: item
  item:
    ansible_loop_var: item
    changed: true
    cmd: grep -q "udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter accept" /etc/nftables/edpm-rules.nft
    delta: '0:00:00.004494'
    end: '2025-12-03 06:17:40.523135'
    failed: false
    invocation:
      module_args:
        _raw_params: grep -q "udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter accept" /etc/nftables/edpm-rules.nft
        _uses_shell: true
        argv: null
        chdir: null
        creates: null
        executable: null
        removes: null
        stdin: null
        stdin_add_newline: true
        strip_empty_ends: true
    item: udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter accept
    msg: ''
    rc: 0
    start: '2025-12-03 06:17:40.518641'
    stderr: ''
    stderr_lines: []
    stdout: ''
    stdout_lines: []
  msg: All assertions passed

TASK [Check input chain rules are loaded] **************************************
Wednesday 03 December 2025  06:17:40 +0000 (0:00:00.032)       0:00:02.707 ****
changed: [compute-1] => (item=tcp dport 179 ct state new counter)
changed: [compute-1] => (item=udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter)

TASK [Assert rule content exists] **********************************************
Wednesday 03 December 2025  06:17:40 +0000 (0:00:00.388)       0:00:03.095 ****
ok: [compute-1] => (item={'changed': True, 'stdout': '', 'stderr': '', 'rc': 0, 'cmd': 'nft list table inet filter | awk \'/chain EDPM_INPUT {/,/}/\' | grep -q "tcp dport 179 ct state new counter.*accept"', 'start': '2025-12-03 06:17:40.748304', 'end': '2025-12-03 06:17:40.756237', 'delta': '0:00:00.007933', 'msg': '', 'invocation': {'module_args': {'_raw_params': 'nft list table inet filter | awk \'/chain EDPM_INPUT {/,/}/\' | grep -q "tcp dport 179 ct state new counter.*accept"', '_uses_shell': True, 'stdin_add_newline': True, 'strip_empty_ends': True, 'argv': None, 'chdir': None, 'executable': None, 'creates': None, 'removes': None, 'stdin': None}}, 'stdout_lines': [], 'stderr_lines': [], 'failed': False, 'item': 'tcp dport 179 ct state new counter', 'ansible_loop_var': 'item'}) => changed=false
  ansible_loop_var: item
  item:
    ansible_loop_var: item
    changed: true
    cmd: nft list table inet filter | awk '/chain EDPM_INPUT {/,/}/' | grep -q "tcp dport 179 ct state new counter.*accept"
    delta: '0:00:00.007933'
    end: '2025-12-03 06:17:40.756237'
    failed: false
    invocation:
      module_args:
        _raw_params: nft list table inet filter | awk '/chain EDPM_INPUT {/,/}/' | grep -q "tcp dport 179 ct state new counter.*accept"
        _uses_shell: true
        argv: null
        chdir: null
        creates: null
        executable: null
        removes: null
        stdin: null
        stdin_add_newline: true
        strip_empty_ends: true
    item: tcp dport 179 ct state new counter
    msg: ''
    rc: 0
    start: '2025-12-03 06:17:40.748304'
    stderr: ''
    stderr_lines: []
    stdout: ''
    stdout_lines: []
  msg: All assertions passed
ok: [compute-1] => (item={'changed': True, 'stdout': '', 'stderr': '', 'rc': 0, 'cmd': 'nft list table inet filter | awk \'/chain EDPM_INPUT {/,/}/\' | grep -q "udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter.*accept"', 'start': '2025-12-03 06:17:40.919270', 'end': '2025-12-03 06:17:40.926731', 'delta': '0:00:00.007461', 'msg': '', 'invocation': {'module_args': {'_raw_params': 'nft list table inet filter | awk \'/chain EDPM_INPUT {/,/}/\' | grep -q "udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter.*accept"', '_uses_shell': True, 'stdin_add_newline': True, 'strip_empty_ends': True, 'argv': None, 'chdir': None, 'executable': None, 'creates': None, 'removes': None, 'stdin': None}}, 'stdout_lines': [], 'stderr_lines': [], 'failed': False, 'item': 'udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter', 'ansible_loop_var': 'item'}) => changed=false
  ansible_loop_var: item
  item:
    ansible_loop_var: item
    changed: true
    cmd: nft list table inet filter | awk '/chain EDPM_INPUT {/,/}/' | grep -q "udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter.*accept"
    delta: '0:00:00.007461'
    end: '2025-12-03 06:17:40.926731'
    failed: false
    invocation:
      module_args:
        _raw_params: nft list table inet filter | awk '/chain EDPM_INPUT {/,/}/' | grep -q "udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter.*accept"
        _uses_shell: true
        argv: null
        chdir: null
        creates: null
        executable: null
        removes: null
        stdin: null
        stdin_add_newline: true
        strip_empty_ends: true
    item: udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter
    msg: ''
    rc: 0
    start: '2025-12-03 06:17:40.919270'
    stderr: ''
    stderr_lines: []
    stdout: ''
    stdout_lines: []
  msg: All assertions passed

TASK [ensure podman container exists and are running] **************************
Wednesday 03 December 2025  06:17:41 +0000 (0:00:00.029)       0:00:03.125 ****
included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_podman.yaml for compute-1 => (item=frr)

TASK [Check if podman container exists frr] ************************************
Wednesday 03 December 2025  06:17:41 +0000 (0:00:00.039)       0:00:03.164 ****
changed: [compute-1]

TASK [Assert podman container exists frr] **************************************
Wednesday 03 December 2025  06:17:41 +0000 (0:00:00.229)       0:00:03.393 ****
ok: [compute-1] => changed=false
  msg: All assertions passed

TASK [Check if podman container is running frr] ********************************
Wednesday 03 December 2025  06:17:41 +0000 (0:00:00.032)       0:00:03.426 ****
changed: [compute-1]

TASK [Assert podman container is running frr] **********************************
Wednesday 03 December 2025  06:17:41 +0000 (0:00:00.225)       0:00:03.651 ****
ok: [compute-1] => changed=false
  msg: All assertions passed

TASK [ensure systemd services are defined and functional] **********************
Wednesday 03 December 2025  06:17:41 +0000 (0:00:00.030)       0:00:03.681 ****
included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_systemd_unit.yaml for compute-1 => (item={'name': 'edpm_frr.service'})

TASK [Check if systemd file exists edpm_frr.service] ***************************
Wednesday 03 December 2025  06:17:41 +0000 (0:00:00.029)       0:00:03.710 ****
ok: [compute-1]

TASK [Assert systemd unit exists edpm_frr.service] *****************************
Wednesday 03 December 2025  06:17:41 +0000 (0:00:00.216)       0:00:03.927 ****
ok: [compute-1] => changed=false
  msg: All assertions passed

TASK [Check if systemd unit is enabled edpm_frr.service] ***********************
Wednesday 03 December 2025  06:17:41 +0000 (0:00:00.025)       0:00:03.953 ****
ok: [compute-1]

TASK [Assert systemd unit is enabled edpm_frr.service] *************************
Wednesday 03 December 2025  06:17:42 +0000 (0:00:00.189)       0:00:04.142 ****
ok: [compute-1] => changed=false
  msg: All assertions passed

TASK [Check if systemd unit is running edpm_frr.service] ***********************
Wednesday 03 December 2025  06:17:42 +0000 (0:00:00.023)       0:00:04.166 ****
ok: [compute-1]

TASK [Assert systemd unit is running edpm_frr.service] *************************
Wednesday 03 December 2025  06:17:42 +0000 (0:00:00.183)       0:00:04.349 ****
ok: [compute-1] => changed=false
  msg: All assertions passed

PLAY RECAP *********************************************************************
compute-1                  : ok=38   changed=5    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0

Wednesday 03 December 2025  06:17:42 +0000 (0:00:00.044)       0:00:04.394 ****
===============================================================================
Check if nftables rule exists in /etc/nftables/edpm-rules.nft ----------- 0.46s
Check input chain rules are loaded -------------------------------------- 0.39s
Check rule content ------------------------------------------------------ 0.36s
Check if directory exists /var/lib/edpm-config/container-startup-config/frr --- 0.27s
Check if podman container exists frr ------------------------------------ 0.23s
Check if podman container is running frr -------------------------------- 0.23s
Check if systemd file exists edpm_frr.service --------------------------- 0.22s
Check if file /var/lib/openstack/frr/etc/frr/frr.conf exist ------------- 0.19s
Check if directory exists /var/lib/openstack/frr ------------------------ 0.19s
Check if systemd unit is enabled edpm_frr.service ----------------------- 0.19s
rule source file exists ------------------------------------------------- 0.19s
Check if file /var/lib/openstack/frr/etc/frr/daemons exist -------------- 0.19s
Check if directory exists /etc/tmpfiles.d/ ------------------------------ 0.19s
Check if file /etc/tmpfiles.d/run-frr.conf exist ------------------------ 0.19s
Check if systemd unit is running edpm_frr.service ----------------------- 0.18s
Check if directory exists /var/lib/openstack/frr/etc/frr ---------------- 0.18s
Assert systemd unit is running edpm_frr.service ------------------------- 0.04s
ensure podman container exists and are running -------------------------- 0.04s
Assert directory exists /etc/tmpfiles.d/ -------------------------------- 0.04s
ensure expected directories exist --------------------------------------- 0.04s