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

TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025  08:51:13 +0000 (0:00:00.017)       0:00:00.017 *****
ok: [instance]

TASK [Add crc hostname with it's IP to /etc/hosts] *****************************
Wednesday 08 October 2025  08:51:15 +0000 (0:00:01.261)       0:00:01.279 *****
changed: [instance]

TASK [Check if new ssh keypair exists] *****************************************
Wednesday 08 October 2025  08:51:15 +0000 (0:00:00.436)       0:00:01.715 *****

TASK [recognize_ssh_keypair : Check if id_ed25519 key exists] ******************
Wednesday 08 October 2025  08:51:15 +0000 (0:00:00.053)       0:00:01.768 *****
ok: [instance]

TASK [recognize_ssh_keypair : Set fact if new keypair exists] ******************
Wednesday 08 October 2025  08:51:16 +0000 (0:00:00.454)       0:00:02.222 *****
ok: [instance]

TASK [recognize_ssh_keypair : Set fact if new keypair does not exists] *********
Wednesday 08 October 2025  08:51:16 +0000 (0:00:00.030)       0:00:02.253 *****
skipping: [instance]

TASK [Add the crc host dynamically] ********************************************
Wednesday 08 October 2025  08:51:16 +0000 (0:00:00.026)       0:00:02.279 *****
changed: [instance]

TASK [Fetch crc network facts] *************************************************
Wednesday 08 October 2025  08:51:16 +0000 (0:00:00.026)       0:00:02.306 *****
ok: [instance -> crc]

TASK [Load shared variables] ***************************************************
Wednesday 08 October 2025  08:51:22 +0000 (0:00:06.394)       0:00:08.700 *****
ok: [instance]

TASK [Call ci_multus role] *****************************************************
Wednesday 08 October 2025  08:51:22 +0000 (0:00:00.039)       0:00:08.739 *****

TASK [ci_multus : Create manifests directory] **********************************
Wednesday 08 October 2025  08:51:22 +0000 (0:00:00.093)       0:00:08.832 *****
changed: [instance]

TASK [networking_mapper : Check for Networking Environment Definition file existence] ***
Wednesday 08 October 2025  08:51:23 +0000 (0:00:00.399)       0:00:09.232 *****
skipping: [instance]

TASK [networking_mapper : Check for Networking Definition file existance] ******
Wednesday 08 October 2025  08:51:23 +0000 (0:00:00.030)       0:00:09.263 *****
skipping: [instance]

TASK [networking_mapper : Load the Networking Definition from file] ************
Wednesday 08 October 2025  08:51:23 +0000 (0:00:00.032)       0:00:09.296 *****
skipping: [instance]

TASK [networking_mapper : Set cifmw_networking_env_definition is present] ******
Wednesday 08 October 2025  08:51:23 +0000 (0:00:00.034)       0:00:09.330 *****
skipping: [instance]

TASK [ci_multus : Gather network layout from OCP host or default networks] *****
Wednesday 08 October 2025  08:51:23 +0000 (0:00:00.045)       0:00:09.376 *****
ok: [instance]

TASK [ci_multus : Merge any available multus net info patches] *****************
Wednesday 08 October 2025  08:51:23 +0000 (0:00:00.061)       0:00:09.438 *****
ok: [instance] => (item={'default': {'interface_name': 'eth0', 'network_name': 'default', 'gw_v4': '192.168.122.1', 'network_v4': '192.168.122.0/24', 'tools': {'multus': {'ipv4_ranges': [{'start': '192.168.122.30', 'end': '192.168.122.70'}], 'multus_type': 'bridge'}}}, 'deny_network': {'gw_v4': '192.168.122.1', 'network_name': 'deny_network', 'network_v4': '192.168.122.0/24', 'tools': {'multus': {'ipv4_ranges': [{'start': '192.168.122.30', 'end': '192.168.122.70'}], 'multus_type': 'bridge'}}}, 'not_allowed_network': {'gw_v4': '192.168.122.1', 'network_name': 'not_allowed_network', 'network_v4': '192.168.122.0/24', 'tools': {'multus': {'ipv4_ranges': [{'start': '192.168.122.30', 'end': '192.168.122.70'}], 'multus_type': 'bridge'}}}, 'no_multus_network': {'gw_v4': '192.168.122.1', 'network_name': 'patchnetwork', 'network_v4': '192.168.122.0/24', 'interface_name': 'eth2'}})
ok: [instance] => (item={'patchnetwork': {'gw_v4': '192.168.122.1', 'network_name': 'patchnetwork', 'network_v4': '192.168.122.0/24', 'interface_name': 'eth2', 'tools': {'multus': {'ipv4_ranges': [{'start': '192.168.122.30', 'end': '192.168.122.70'}], 'multus_type': 'macvlan'}}}})
ok: [instance] => (item={'bridge-to-linux-bridge': {'gw_v4': '192.168.122.1', 'network_name': 'bridge-to-linux-bridge', 'network_v4': '192.168.122.0/24', 'interface_name': 'eth1', 'tools': {'multus': {'ipv4_ranges': [{'start': '192.168.122.30', 'end': '192.168.122.70'}], 'multus_type': 'bridge', 'multus_attach': 'linux-bridge'}}}})

TASK [ci_multus : Remove any networks without Multus networking defined] *******
Wednesday 08 October 2025  08:51:23 +0000 (0:00:00.218)       0:00:09.656 *****
ok: [instance]

TASK [ci_multus : Remove any networks not in cifmw_ci_multus_allow_list if defined] ***
Wednesday 08 October 2025  08:51:23 +0000 (0:00:00.105)       0:00:09.761 *****
ok: [instance]

TASK [ci_multus : Remove any networks in cifmw_ci_multus_deny_list if defined] ***
Wednesday 08 October 2025  08:51:23 +0000 (0:00:00.084)       0:00:09.846 *****
ok: [instance]

TASK [ci_multus : Render NetworkAttachmenktDefinition manifests] ***************
Wednesday 08 October 2025  08:51:23 +0000 (0:00:00.081)       0:00:09.928 *****
changed: [instance]

TASK [ci_multus : Create the multus namespace] *********************************
Wednesday 08 October 2025  08:51:24 +0000 (0:00:00.616)       0:00:10.544 *****
changed: [instance]

TASK [ci_multus : Apply network attachment definition manifests] ***************
Wednesday 08 October 2025  08:51:25 +0000 (0:00:01.105)       0:00:11.650 *****
changed: [instance]

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

Wednesday 08 October 2025  08:51:26 +0000 (0:00:00.941)       0:00:12.591 *****
===============================================================================
Fetch crc network facts ------------------------------------------------- 6.39s
Gathering Facts --------------------------------------------------------- 1.26s
ci_multus : Create the multus namespace --------------------------------- 1.11s
ci_multus : Apply network attachment definition manifests --------------- 0.94s
ci_multus : Render NetworkAttachmenktDefinition manifests --------------- 0.62s
recognize_ssh_keypair : Check if id_ed25519 key exists ------------------ 0.45s
Add crc hostname with it's IP to /etc/hosts ----------------------------- 0.44s
ci_multus : Create manifests directory ---------------------------------- 0.40s
ci_multus : Merge any available multus net info patches ----------------- 0.22s
ci_multus : Remove any networks without Multus networking defined ------- 0.11s
Call ci_multus role ----------------------------------------------------- 0.09s
ci_multus : Remove any networks not in cifmw_ci_multus_allow_list if defined --- 0.08s
ci_multus : Remove any networks in cifmw_ci_multus_deny_list if defined --- 0.08s
ci_multus : Gather network layout from OCP host or default networks ----- 0.06s
Check if new ssh keypair exists ----------------------------------------- 0.05s
networking_mapper : Set cifmw_networking_env_definition is present ------ 0.05s
Load shared variables --------------------------------------------------- 0.04s
networking_mapper : Load the Networking Definition from file ------------ 0.03s
networking_mapper : Check for Networking Definition file existance ------ 0.03s
networking_mapper : Check for Networking Environment Definition file existence --- 0.03s

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

TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025  08:51:27 +0000 (0:00:00.018)       0:00:00.018 *****
ok: [instance]

TASK [Load shared variables] ***************************************************
Wednesday 08 October 2025  08:51:28 +0000 (0:00:01.268)       0:00:01.287 *****
ok: [instance]

TASK [Fetch files stat results] ************************************************
Wednesday 08 October 2025  08:51:28 +0000 (0:00:00.033)       0:00:01.320 *****
ok: [instance]

TASK [Assert that expected file exist] *****************************************
Wednesday 08 October 2025  08:51:28 +0000 (0:00:00.432)       0:00:01.753 *****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Fetch file content] ******************************************************
Wednesday 08 October 2025  08:51:28 +0000 (0:00:00.025)       0:00:01.778 *****
ok: [instance]

TASK [Set _ci_multus_nad variable] *********************************************
Wednesday 08 October 2025  08:51:29 +0000 (0:00:00.375)       0:00:02.153 *****
ok: [instance]

TASK [Assert expected number of Network Attachment Definitions are created] ****
Wednesday 08 October 2025  08:51:29 +0000 (0:00:00.062)       0:00:02.215 *****
ok: [instance]

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

Wednesday 08 October 2025  08:51:29 +0000 (0:00:00.060)       0:00:02.276 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.27s
Fetch files stat results ------------------------------------------------ 0.43s
Fetch file content ------------------------------------------------------ 0.38s
Set _ci_multus_nad variable --------------------------------------------- 0.06s
Assert expected number of Network Attachment Definitions are created ---- 0.06s
Load shared variables --------------------------------------------------- 0.03s
Assert that expected file exist ----------------------------------------- 0.03s

PLAY [Verify CRC] **************************************************************

TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025  08:51:30 +0000 (0:00:00.019)       0:00:00.019 *****
ok: [instance]

TASK [Include default vars] ****************************************************
Wednesday 08 October 2025  08:51:31 +0000 (0:00:01.131)       0:00:01.151 *****
ok: [instance]

TASK [Check if NADs were created] **********************************************
Wednesday 08 October 2025  08:51:31 +0000 (0:00:00.040)       0:00:01.191 *****
ok: [instance]

TASK [Store output spec] *******************************************************
Wednesday 08 October 2025  08:51:32 +0000 (0:00:00.973)       0:00:02.164 *****
ok: [instance]

TASK [Ensure both lists have the same length] **********************************
Wednesday 08 October 2025  08:51:32 +0000 (0:00:00.045)       0:00:02.210 *****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Compare each corresponding element in the lists] *************************
Wednesday 08 October 2025  08:51:32 +0000 (0:00:00.058)       0:00:02.269 *****
ok: [instance] => (item=['{\n  "cniVersion": "0.3.1",\n  "name": "bridge-to-linux-bridge",\n  "type": "bridge",\n  "bridge": "bridge-to-linux-bridge",\n  "ipam": {\n    "type": "whereabouts",\n    "range": "192.168.122.0/24",\n    "range_start": "192.168.122.30",\n    "range_end": "192.168.122.70"\n  }\n}', '{\n  "cniVersion": "0.3.1",\n  "name": "bridge-to-linux-bridge",\n  "type": "bridge",\n  "bridge": "bridge-to-linux-bridge",\n  "ipam": {\n    "type": "whereabouts",\n    "range": "192.168.122.0/24",\n    "range_start": "192.168.122.30",\n    "range_end": "192.168.122.70"\n  }\n}\n']) => changed=false
  ansible_loop_var: item
  item:
  - |-
    {
      "cniVersion": "0.3.1",
      "name": "bridge-to-linux-bridge",
      "type": "bridge",
      "bridge": "bridge-to-linux-bridge",
      "ipam": {
        "type": "whereabouts",
        "range": "192.168.122.0/24",
        "range_start": "192.168.122.30",
        "range_end": "192.168.122.70"
      }
    }
  - |-
    {
      "cniVersion": "0.3.1",
      "name": "bridge-to-linux-bridge",
      "type": "bridge",
      "bridge": "bridge-to-linux-bridge",
      "ipam": {
        "type": "whereabouts",
        "range": "192.168.122.0/24",
        "range_start": "192.168.122.30",
        "range_end": "192.168.122.70"
      }
    }
  msg: All assertions passed
ok: [instance] => (item=['{\n  "cniVersion": "0.3.1",\n  "name": "default",\n  "type": "bridge",\n  "bridge": "eth0",\n  "ipam": {\n    "type": "whereabouts",\n    "range": "192.168.122.0/24",\n    "range_start": "192.168.122.30",\n    "range_end": "192.168.122.70"\n  }\n}\n', '{\n  "cniVersion": "0.3.1",\n  "name": "default",\n  "type": "bridge",\n  "bridge": "eth0",\n  "ipam": {\n    "type": "whereabouts",\n    "range": "192.168.122.0/24",\n    "range_start": "192.168.122.30",\n    "range_end": "192.168.122.70"\n  }\n}\n']) => changed=false
  ansible_loop_var: item
  item:
  - |-
    {
      "cniVersion": "0.3.1",
      "name": "default",
      "type": "bridge",
      "bridge": "eth0",
      "ipam": {
        "type": "whereabouts",
        "range": "192.168.122.0/24",
        "range_start": "192.168.122.30",
        "range_end": "192.168.122.70"
      }
    }
  - |-
    {
      "cniVersion": "0.3.1",
      "name": "default",
      "type": "bridge",
      "bridge": "eth0",
      "ipam": {
        "type": "whereabouts",
        "range": "192.168.122.0/24",
        "range_start": "192.168.122.30",
        "range_end": "192.168.122.70"
      }
    }
  msg: All assertions passed
ok: [instance] => (item=['{\n  "cniVersion": "0.3.1",\n  "name": "patchnetwork",\n  "type": "macvlan",\n  "master": "eth2",\n  "ipam": {\n    "type": "whereabouts",\n    "range": "192.168.122.0/24",\n    "range_start": "192.168.122.30",\n    "range_end": "192.168.122.70"\n  }\n}\n', '{\n  "cniVersion": "0.3.1",\n  "name": "patchnetwork",\n  "type": "macvlan",\n  "master": "eth2",\n  "ipam": {\n    "type": "whereabouts",\n    "range": "192.168.122.0/24",\n    "range_start": "192.168.122.30",\n    "range_end": "192.168.122.70"\n  }\n}']) => changed=false
  ansible_loop_var: item
  item:
  - |-
    {
      "cniVersion": "0.3.1",
      "name": "patchnetwork",
      "type": "macvlan",
      "master": "eth2",
      "ipam": {
        "type": "whereabouts",
        "range": "192.168.122.0/24",
        "range_start": "192.168.122.30",
        "range_end": "192.168.122.70"
      }
    }
  - |-
    {
      "cniVersion": "0.3.1",
      "name": "patchnetwork",
      "type": "macvlan",
      "master": "eth2",
      "ipam": {
        "type": "whereabouts",
        "range": "192.168.122.0/24",
        "range_start": "192.168.122.30",
        "range_end": "192.168.122.70"
      }
    }
  msg: All assertions passed

TASK [Create a test pod to attach a network] ***********************************
Wednesday 08 October 2025  08:51:32 +0000 (0:00:00.071)       0:00:02.341 *****
[WARNING]: unknown field "api_version"
FAILED - RETRYING: [instance]: Create a test pod to attach a network (30 retries left).
FAILED - RETRYING: [instance]: Create a test pod to attach a network (29 retries left).
changed: [instance]

TASK [Assert that test pod has the additional network] *************************
Wednesday 08 October 2025  08:52:35 +0000 (0:01:02.695)       0:01:05.036 *****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Delete test pod] *********************************************************
Wednesday 08 October 2025  08:52:35 +0000 (0:00:00.033)       0:01:05.070 *****
changed: [instance]

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

Wednesday 08 October 2025  08:52:36 +0000 (0:00:00.875)       0:01:05.945 *****
===============================================================================
Create a test pod to attach a network ---------------------------------- 62.70s
Gathering Facts --------------------------------------------------------- 1.13s
Check if NADs were created ---------------------------------------------- 0.97s
Delete test pod --------------------------------------------------------- 0.88s
Compare each corresponding element in the lists ------------------------- 0.07s
Ensure both lists have the same length ---------------------------------- 0.06s
Store output spec ------------------------------------------------------- 0.05s
Include default vars ---------------------------------------------------- 0.04s
Assert that test pod has the additional network ------------------------- 0.03s

PLAY [Clean] *******************************************************************

TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025  08:52:36 +0000 (0:00:00.016)       0:00:00.016 *****
ok: [instance]

TASK [Backup NAD before cleanup so they can be inspected in CI] ****************
Wednesday 08 October 2025  08:52:38 +0000 (0:00:02.204)       0:00:02.221 *****
changed: [instance]

TASK [ci_multus : Cleanup - Fetch NADs in namespace: openstack] ****************
Wednesday 08 October 2025  08:52:39 +0000 (0:00:00.383)       0:00:02.605 *****
ok: [instance]

TASK [ci_multus : Cleanup - Delete NADs] ***************************************
Wednesday 08 October 2025  08:52:40 +0000 (0:00:01.015)       0:00:03.621 *****
changed: [instance] => (item=bridge-to-linux-bridge)
changed: [instance] => (item=default)
changed: [instance] => (item=patchnetwork)

TASK [ci_multus : Cleanup - Remove if artifact directory exists] ***************
Wednesday 08 October 2025  08:52:42 +0000 (0:00:02.647)       0:00:06.268 *****
changed: [instance]

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

Wednesday 08 October 2025  08:52:43 +0000 (0:00:00.392)       0:00:06.660 *****
===============================================================================
ci_multus : Cleanup - Delete NADs --------------------------------------- 2.65s
Gathering Facts --------------------------------------------------------- 2.21s
ci_multus : Cleanup - Fetch NADs in namespace: openstack ---------------- 1.02s
ci_multus : Cleanup - Remove if artifact directory exists --------------- 0.39s
Backup NAD before cleanup so they can be inspected in CI ---------------- 0.38s

PLAY [Verify Clean] ************************************************************

TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025  08:52:44 +0000 (0:00:00.023)       0:00:00.023 *****
ok: [instance]

TASK [Include default vars] ****************************************************
Wednesday 08 October 2025  08:52:45 +0000 (0:00:01.194)       0:00:01.217 *****
ok: [instance]

TASK [Fetch file stat results] *************************************************
Wednesday 08 October 2025  08:52:45 +0000 (0:00:00.033)       0:00:01.251 *****
ok: [instance]

TASK [Assert that created file are removed by cleanup] *************************
Wednesday 08 October 2025  08:52:45 +0000 (0:00:00.422)       0:00:01.673 *****
ok: [instance] => changed=false
  msg: All assertions passed

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

Wednesday 08 October 2025  08:52:45 +0000 (0:00:00.067)       0:00:01.740 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.19s
Fetch file stat results ------------------------------------------------- 0.42s
Assert that created file are removed by cleanup ------------------------- 0.07s
Include default vars ---------------------------------------------------- 0.03s

PLAY [Verify Clean CRC] ********************************************************

TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025  08:52:46 +0000 (0:00:00.018)       0:00:00.018 *****
ok: [instance]

TASK [Include default vars] ****************************************************
Wednesday 08 October 2025  08:52:47 +0000 (0:00:01.213)       0:00:01.232 *****
ok: [instance]

TASK [Check if NADs were deleted] **********************************************
Wednesday 08 October 2025  08:52:47 +0000 (0:00:00.048)       0:00:01.280 *****
ok: [instance]

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

Wednesday 08 October 2025  08:52:48 +0000 (0:00:01.108)       0:00:02.389 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.21s
Check if NADs were deleted ---------------------------------------------- 1.11s
Include default vars ---------------------------------------------------- 0.05s

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

TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025  08:52:49 +0000 (0:00:00.018)       0:00:00.018 *****
ok: [instance]

TASK [Load shared variables] ***************************************************
Wednesday 08 October 2025  08:52:51 +0000 (0:00:02.160)       0:00:02.178 *****
ok: [instance]

TASK [Call ci_multus role] *****************************************************
Wednesday 08 October 2025  08:52:51 +0000 (0:00:00.026)       0:00:02.205 *****

TASK [ci_multus : Create manifests directory] **********************************
Wednesday 08 October 2025  08:52:51 +0000 (0:00:00.047)       0:00:02.252 *****
changed: [instance]

TASK [networking_mapper : Check for Networking Environment Definition file existence] ***
Wednesday 08 October 2025  08:52:52 +0000 (0:00:00.420)       0:00:02.673 *****
skipping: [instance]

TASK [networking_mapper : Check for Networking Definition file existance] ******
Wednesday 08 October 2025  08:52:52 +0000 (0:00:00.037)       0:00:02.711 *****
skipping: [instance]

TASK [networking_mapper : Load the Networking Definition from file] ************
Wednesday 08 October 2025  08:52:52 +0000 (0:00:00.043)       0:00:02.754 *****
skipping: [instance]

TASK [networking_mapper : Set cifmw_networking_env_definition is present] ******
Wednesday 08 October 2025  08:52:52 +0000 (0:00:00.036)       0:00:02.790 *****
skipping: [instance]

TASK [ci_multus : Gather network layout from OCP host or default networks] *****
Wednesday 08 October 2025  08:52:52 +0000 (0:00:00.040)       0:00:02.831 *****
ok: [instance]

TASK [ci_multus : Merge any available multus net info patches] *****************
Wednesday 08 October 2025  08:52:52 +0000 (0:00:00.048)       0:00:02.880 *****
ok: [instance] => (item={'default': {'interface_name': 'eth0', 'network_name': 'default', 'gw_v4': '192.168.122.1', 'network_v4': '192.168.122.0/24', 'tools': {'multus': {'ipv4_ranges': [{'start': '192.168.122.30', 'end': '192.168.122.70'}], 'multus_type': 'bridge'}}}, 'deny_network': {'gw_v4': '192.168.122.1', 'network_name': 'deny_network', 'network_v4': '192.168.122.0/24', 'tools': {'multus': {'ipv4_ranges': [{'start': '192.168.122.30', 'end': '192.168.122.70'}], 'multus_type': 'bridge'}}}, 'not_allowed_network': {'gw_v4': '192.168.122.1', 'network_name': 'not_allowed_network', 'network_v4': '192.168.122.0/24', 'tools': {'multus': {'ipv4_ranges': [{'start': '192.168.122.30', 'end': '192.168.122.70'}], 'multus_type': 'bridge'}}}, 'no_multus_network': {'gw_v4': '192.168.122.1', 'network_name': 'patchnetwork', 'network_v4': '192.168.122.0/24', 'interface_name': 'eth2'}})
ok: [instance] => (item={'patchnetwork': {'gw_v4': '192.168.122.1', 'network_name': 'patchnetwork', 'network_v4': '192.168.122.0/24', 'interface_name': 'eth2', 'tools': {'multus': {'ipv4_ranges': [{'start': '192.168.122.30', 'end': '192.168.122.70'}]}}}})

TASK [ci_multus : Remove any networks without Multus networking defined] *******
Wednesday 08 October 2025  08:52:52 +0000 (0:00:00.184)       0:00:03.064 *****
ok: [instance]

TASK [ci_multus : Remove any networks not in cifmw_ci_multus_allow_list if defined] ***
Wednesday 08 October 2025  08:52:52 +0000 (0:00:00.075)       0:00:03.140 *****
ok: [instance]

TASK [ci_multus : Remove any networks in cifmw_ci_multus_deny_list if defined] ***
Wednesday 08 October 2025  08:52:52 +0000 (0:00:00.088)       0:00:03.229 *****
ok: [instance]

TASK [ci_multus : Render NetworkAttachmenktDefinition manifests] ***************
Wednesday 08 October 2025  08:52:52 +0000 (0:00:00.082)       0:00:03.311 *****
changed: [instance]

TASK [ci_multus : Create the multus namespace] *********************************
Wednesday 08 October 2025  08:52:53 +0000 (0:00:00.758)       0:00:04.070 *****
skipping: [instance]

TASK [ci_multus : Apply network attachment definition manifests] ***************
Wednesday 08 October 2025  08:52:53 +0000 (0:00:00.035)       0:00:04.105 *****
skipping: [instance]

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

Wednesday 08 October 2025  08:52:53 +0000 (0:00:00.055)       0:00:04.161 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 2.16s
ci_multus : Render NetworkAttachmenktDefinition manifests --------------- 0.76s
ci_multus : Create manifests directory ---------------------------------- 0.42s
ci_multus : Merge any available multus net info patches ----------------- 0.18s
ci_multus : Remove any networks not in cifmw_ci_multus_allow_list if defined --- 0.09s
ci_multus : Remove any networks in cifmw_ci_multus_deny_list if defined --- 0.08s
ci_multus : Remove any networks without Multus networking defined ------- 0.08s
ci_multus : Apply network attachment definition manifests --------------- 0.06s
ci_multus : Gather network layout from OCP host or default networks ----- 0.05s
Call ci_multus role ----------------------------------------------------- 0.05s
networking_mapper : Check for Networking Definition file existance ------ 0.04s
networking_mapper : Set cifmw_networking_env_definition is present ------ 0.04s
networking_mapper : Check for Networking Environment Definition file existence --- 0.04s
networking_mapper : Load the Networking Definition from file ------------ 0.04s
ci_multus : Create the multus namespace --------------------------------- 0.04s
Load shared variables --------------------------------------------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025  08:52:54 +0000 (0:00:00.018)       0:00:00.018 *****
ok: [instance]

TASK [Load shared variables] ***************************************************
Wednesday 08 October 2025  08:52:55 +0000 (0:00:01.087)       0:00:01.105 *****
ok: [instance]

TASK [Fetch files stat results] ************************************************
Wednesday 08 October 2025  08:52:55 +0000 (0:00:00.035)       0:00:01.140 *****
ok: [instance]

TASK [Assert that expected file exist] *****************************************
Wednesday 08 October 2025  08:52:55 +0000 (0:00:00.396)       0:00:01.537 *****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Fetch file content] ******************************************************
Wednesday 08 October 2025  08:52:55 +0000 (0:00:00.030)       0:00:01.568 *****
ok: [instance]

TASK [Set _ci_multus_nad variable] *********************************************
Wednesday 08 October 2025  08:52:56 +0000 (0:00:00.396)       0:00:01.964 *****
ok: [instance]

TASK [Assert expected number of Network Attachment Definitions are created] ****
Wednesday 08 October 2025  08:52:56 +0000 (0:00:00.042)       0:00:02.006 *****
ok: [instance]

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

Wednesday 08 October 2025  08:52:56 +0000 (0:00:00.059)       0:00:02.066 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.09s
Fetch files stat results ------------------------------------------------ 0.40s
Fetch file content ------------------------------------------------------ 0.40s
Assert expected number of Network Attachment Definitions are created ---- 0.06s
Set _ci_multus_nad variable --------------------------------------------- 0.04s
Load shared variables --------------------------------------------------- 0.04s
Assert that expected file exist ----------------------------------------- 0.03s

PLAY [Clean] *******************************************************************

TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025  08:52:57 +0000 (0:00:00.021)       0:00:00.021 *****
ok: [instance]

TASK [Backup NAD before cleanup so they can be inspected in CI] ****************
Wednesday 08 October 2025  08:52:58 +0000 (0:00:01.045)       0:00:01.066 *****
changed: [instance]

TASK [ci_multus : Cleanup - Fetch NADs in namespace: openstack] ****************
Wednesday 08 October 2025  08:52:58 +0000 (0:00:00.379)       0:00:01.446 *****
skipping: [instance]

TASK [ci_multus : Cleanup - Delete NADs] ***************************************
Wednesday 08 October 2025  08:52:58 +0000 (0:00:00.027)       0:00:01.473 *****
skipping: [instance]

TASK [ci_multus : Cleanup - Remove if artifact directory exists] ***************
Wednesday 08 October 2025  08:52:58 +0000 (0:00:00.037)       0:00:01.511 *****
changed: [instance]

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

Wednesday 08 October 2025  08:52:58 +0000 (0:00:00.431)       0:00:01.942 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.05s
ci_multus : Cleanup - Remove if artifact directory exists --------------- 0.43s
Backup NAD before cleanup so they can be inspected in CI ---------------- 0.38s
ci_multus : Cleanup - Delete NADs --------------------------------------- 0.04s
ci_multus : Cleanup - Fetch NADs in namespace: openstack ---------------- 0.03s

PLAY [Verify Clean] ************************************************************

TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025  08:52:59 +0000 (0:00:00.019)       0:00:00.019 *****
ok: [instance]

TASK [Include default vars] ****************************************************
Wednesday 08 October 2025  08:53:00 +0000 (0:00:01.039)       0:00:01.059 *****
ok: [instance]

TASK [Fetch file stat results] *************************************************
Wednesday 08 October 2025  08:53:00 +0000 (0:00:00.033)       0:00:01.093 *****
ok: [instance]

TASK [Assert that created file are removed by cleanup] *************************
Wednesday 08 October 2025  08:53:00 +0000 (0:00:00.362)       0:00:01.456 *****
ok: [instance] => changed=false
  msg: All assertions passed

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

Wednesday 08 October 2025  08:53:01 +0000 (0:00:00.059)       0:00:01.516 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.04s
Fetch file stat results ------------------------------------------------- 0.36s
Assert that created file are removed by cleanup ------------------------- 0.06s
Include default vars ---------------------------------------------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025  08:53:01 +0000 (0:00:00.016)       0:00:00.016 *****
ok: [instance]

TASK [Load shared variables] ***************************************************
Wednesday 08 October 2025  08:53:02 +0000 (0:00:01.105)       0:00:01.122 *****
ok: [instance]

TASK [Call ci_multus role] *****************************************************
Wednesday 08 October 2025  08:53:02 +0000 (0:00:00.026)       0:00:01.148 *****

TASK [ci_multus : Create manifests directory] **********************************
Wednesday 08 October 2025  08:53:02 +0000 (0:00:00.048)       0:00:01.197 *****
changed: [instance]

TASK [networking_mapper : Check for Networking Environment Definition file existence] ***
Wednesday 08 October 2025  08:53:03 +0000 (0:00:00.411)       0:00:01.608 *****
skipping: [instance]

TASK [networking_mapper : Check for Networking Definition file existance] ******
Wednesday 08 October 2025  08:53:03 +0000 (0:00:00.030)       0:00:01.638 *****
skipping: [instance]

TASK [networking_mapper : Load the Networking Definition from file] ************
Wednesday 08 October 2025  08:53:03 +0000 (0:00:00.037)       0:00:01.676 *****
skipping: [instance]

TASK [networking_mapper : Set cifmw_networking_env_definition is present] ******
Wednesday 08 October 2025  08:53:03 +0000 (0:00:00.041)       0:00:01.718 *****
skipping: [instance]

TASK [ci_multus : Gather network layout from OCP host or default networks] *****
Wednesday 08 October 2025  08:53:03 +0000 (0:00:00.037)       0:00:01.755 *****
ok: [instance]

TASK [ci_multus : Merge any available multus net info patches] *****************
Wednesday 08 October 2025  08:53:03 +0000 (0:00:00.043)       0:00:01.798 *****
skipping: [instance] => (item={'default': {'interface_name': 'eth1', 'network_name': 'default', 'gw_v6': 'fdc0:8b54:108a:c949:0000:0000:0000:0001', 'network_v6': 'fdc0:8b54:108a:c949::/64', 'tools': {'multus': {'ipv6_ranges': [{'start': 'fdc0:8b54:108a:c949:0000:0000:0000:001e', 'end': 'fdc0:8b54:108a:c949:0000:0000:0000:0027'}]}}}})
skipping: [instance]

TASK [ci_multus : Remove any networks without Multus networking defined] *******
Wednesday 08 October 2025  08:53:03 +0000 (0:00:00.124)       0:00:01.923 *****
ok: [instance]

TASK [ci_multus : Remove any networks not in cifmw_ci_multus_allow_list if defined] ***
Wednesday 08 October 2025  08:53:03 +0000 (0:00:00.082)       0:00:02.006 *****
ok: [instance]

TASK [ci_multus : Remove any networks in cifmw_ci_multus_deny_list if defined] ***
Wednesday 08 October 2025  08:53:03 +0000 (0:00:00.081)       0:00:02.087 *****
ok: [instance]

TASK [ci_multus : Render NetworkAttachmenktDefinition manifests] ***************
Wednesday 08 October 2025  08:53:03 +0000 (0:00:00.083)       0:00:02.171 *****
changed: [instance]

TASK [ci_multus : Create the multus namespace] *********************************
Wednesday 08 October 2025  08:53:04 +0000 (0:00:00.743)       0:00:02.915 *****
skipping: [instance]

TASK [ci_multus : Apply network attachment definition manifests] ***************
Wednesday 08 October 2025  08:53:04 +0000 (0:00:00.024)       0:00:02.939 *****
skipping: [instance]

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

Wednesday 08 October 2025  08:53:04 +0000 (0:00:00.049)       0:00:02.989 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.11s
ci_multus : Render NetworkAttachmenktDefinition manifests --------------- 0.74s
ci_multus : Create manifests directory ---------------------------------- 0.41s
ci_multus : Merge any available multus net info patches ----------------- 0.12s
ci_multus : Remove any networks in cifmw_ci_multus_deny_list if defined --- 0.08s
ci_multus : Remove any networks without Multus networking defined ------- 0.08s
ci_multus : Remove any networks not in cifmw_ci_multus_allow_list if defined --- 0.08s
ci_multus : Apply network attachment definition manifests --------------- 0.05s
Call ci_multus role ----------------------------------------------------- 0.05s
ci_multus : Gather network layout from OCP host or default networks ----- 0.04s
networking_mapper : Load the Networking Definition from file ------------ 0.04s
networking_mapper : Check for Networking Definition file existance ------ 0.04s
networking_mapper : Set cifmw_networking_env_definition is present ------ 0.04s
networking_mapper : Check for Networking Environment Definition file existence --- 0.03s
Load shared variables --------------------------------------------------- 0.03s
ci_multus : Create the multus namespace --------------------------------- 0.02s

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

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

TASK [Load shared variables] ***************************************************
Wednesday 08 October 2025  08:53:06 +0000 (0:00:01.075)       0:00:01.093 *****
ok: [instance]

TASK [Fetch files stat results] ************************************************
Wednesday 08 October 2025  08:53:06 +0000 (0:00:00.030)       0:00:01.123 *****
ok: [instance]

TASK [Assert that expected file exist] *****************************************
Wednesday 08 October 2025  08:53:06 +0000 (0:00:00.394)       0:00:01.518 *****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Fetch file content] ******************************************************
Wednesday 08 October 2025  08:53:06 +0000 (0:00:00.031)       0:00:01.549 *****
ok: [instance]

TASK [Set _ci_multus_nad variable] *********************************************
Wednesday 08 October 2025  08:53:07 +0000 (0:00:00.331)       0:00:01.880 *****
ok: [instance]

TASK [Assert expected number of Network Attachment Definitions are created] ****
Wednesday 08 October 2025  08:53:07 +0000 (0:00:00.045)       0:00:01.926 *****
ok: [instance]

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

Wednesday 08 October 2025  08:53:07 +0000 (0:00:00.059)       0:00:01.986 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.08s
Fetch files stat results ------------------------------------------------ 0.39s
Fetch file content ------------------------------------------------------ 0.33s
Assert expected number of Network Attachment Definitions are created ---- 0.06s
Set _ci_multus_nad variable --------------------------------------------- 0.05s
Assert that expected file exist ----------------------------------------- 0.03s
Load shared variables --------------------------------------------------- 0.03s

PLAY [Clean] *******************************************************************

TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025  08:53:08 +0000 (0:00:00.017)       0:00:00.017 *****
ok: [instance]

TASK [Backup NAD before cleanup so they can be inspected in CI] ****************
Wednesday 08 October 2025  08:53:09 +0000 (0:00:01.175)       0:00:01.193 *****
changed: [instance]

TASK [ci_multus : Cleanup - Fetch NADs in namespace: openstack] ****************
Wednesday 08 October 2025  08:53:09 +0000 (0:00:00.443)       0:00:01.636 *****
skipping: [instance]

TASK [ci_multus : Cleanup - Delete NADs] ***************************************
Wednesday 08 October 2025  08:53:09 +0000 (0:00:00.031)       0:00:01.668 *****
skipping: [instance]

TASK [ci_multus : Cleanup - Remove if artifact directory exists] ***************
Wednesday 08 October 2025  08:53:09 +0000 (0:00:00.034)       0:00:01.702 *****
changed: [instance]

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

Wednesday 08 October 2025  08:53:10 +0000 (0:00:00.489)       0:00:02.192 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.18s
ci_multus : Cleanup - Remove if artifact directory exists --------------- 0.49s
Backup NAD before cleanup so they can be inspected in CI ---------------- 0.44s
ci_multus : Cleanup - Delete NADs --------------------------------------- 0.03s
ci_multus : Cleanup - Fetch NADs in namespace: openstack ---------------- 0.03s

PLAY [Verify Clean] ************************************************************

TASK [Gathering Facts] *********************************************************
Wednesday 08 October 2025  08:53:10 +0000 (0:00:00.016)       0:00:00.016 *****
ok: [instance]

TASK [Include default vars] ****************************************************
Wednesday 08 October 2025  08:53:12 +0000 (0:00:01.155)       0:00:01.172 *****
ok: [instance]

TASK [Fetch file stat results] *************************************************
Wednesday 08 October 2025  08:53:12 +0000 (0:00:00.031)       0:00:01.203 *****
ok: [instance]

TASK [Assert that created file are removed by cleanup] *************************
Wednesday 08 October 2025  08:53:12 +0000 (0:00:00.404)       0:00:01.608 *****
ok: [instance] => changed=false
  msg: All assertions passed

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

Wednesday 08 October 2025  08:53:12 +0000 (0:00:00.044)       0:00:01.652 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.16s
Fetch file stat results ------------------------------------------------- 0.40s
Assert that created file are removed by cleanup ------------------------- 0.04s
Include default vars ---------------------------------------------------- 0.03s