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

TASK [Gathering Facts] *********************************************************
Tuesday 30 September 2025  07:54:12 +0000 (0:00:00.011)       0:00:00.011 *****
ok: [instance]

TASK [Add crc hostname with it's IP to /etc/hosts] *****************************
Tuesday 30 September 2025  07:54:13 +0000 (0:00:01.082)       0:00:01.094 *****
changed: [instance]

TASK [Check if new ssh keypair exists] *****************************************
Tuesday 30 September 2025  07:54:13 +0000 (0:00:00.494)       0:00:01.589 *****

TASK [recognize_ssh_keypair : Check if id_ed25519 key exists] ******************
Tuesday 30 September 2025  07:54:13 +0000 (0:00:00.049)       0:00:01.638 *****
ok: [instance]

TASK [recognize_ssh_keypair : Set fact if new keypair exists] ******************
Tuesday 30 September 2025  07:54:14 +0000 (0:00:00.394)       0:00:02.033 *****
ok: [instance]

TASK [recognize_ssh_keypair : Set fact if new keypair does not exists] *********
Tuesday 30 September 2025  07:54:14 +0000 (0:00:00.022)       0:00:02.056 *****
skipping: [instance]

TASK [Add the crc host dynamically] ********************************************
Tuesday 30 September 2025  07:54:14 +0000 (0:00:00.023)       0:00:02.079 *****
changed: [instance]

TASK [Fetch crc network facts] *************************************************
Tuesday 30 September 2025  07:54:14 +0000 (0:00:00.021)       0:00:02.101 *****
ok: [instance -> crc]

TASK [Load shared variables] ***************************************************
Tuesday 30 September 2025  07:54:19 +0000 (0:00:05.061)       0:00:07.163 *****
ok: [instance]

TASK [Call ci_multus role] *****************************************************
Tuesday 30 September 2025  07:54:19 +0000 (0:00:00.025)       0:00:07.188 *****

TASK [ci_multus : Create manifests directory] **********************************
Tuesday 30 September 2025  07:54:19 +0000 (0:00:00.045)       0:00:07.234 *****
changed: [instance]

TASK [networking_mapper : Check for Networking Environment Definition file existence] ***
Tuesday 30 September 2025  07:54:19 +0000 (0:00:00.369)       0:00:07.603 *****
skipping: [instance]

TASK [networking_mapper : Check for Networking Definition file existance] ******
Tuesday 30 September 2025  07:54:19 +0000 (0:00:00.037)       0:00:07.641 *****
skipping: [instance]

TASK [networking_mapper : Load the Networking Definition from file] ************
Tuesday 30 September 2025  07:54:19 +0000 (0:00:00.035)       0:00:07.677 *****
skipping: [instance]

TASK [networking_mapper : Set cifmw_networking_env_definition is present] ******
Tuesday 30 September 2025  07:54:19 +0000 (0:00:00.040)       0:00:07.717 *****
skipping: [instance]

TASK [ci_multus : Gather network layout from OCP host or default networks] *****
Tuesday 30 September 2025  07:54:19 +0000 (0:00:00.057)       0:00:07.775 *****
ok: [instance]

TASK [ci_multus : Merge any available multus net info patches] *****************
Tuesday 30 September 2025  07:54:20 +0000 (0:00:00.057)       0:00:07.832 *****
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', 'interface_name': 'eth2', 'network_name': 'patchnetwork', 'network_v4': '192.168.122.0/24', 'tools': {'multus': {'ipv4_ranges': [{'end': '192.168.122.70', 'start': '192.168.122.30'}], 'multus_type': 'macvlan'}}}})
ok: [instance] => (item={'bridge-to-linux-bridge': {'gw_v4': '192.168.122.1', 'interface_name': 'eth1', 'network_name': 'bridge-to-linux-bridge', 'network_v4': '192.168.122.0/24', 'tools': {'multus': {'ipv4_ranges': [{'end': '192.168.122.70', 'start': '192.168.122.30'}], 'multus_attach': 'linux-bridge', 'multus_type': 'bridge'}}}})

TASK [ci_multus : Remove any networks without Multus networking defined] *******
Tuesday 30 September 2025  07:54:20 +0000 (0:00:00.217)       0:00:08.050 *****
ok: [instance]

TASK [ci_multus : Remove any networks not in cifmw_ci_multus_allow_list if defined] ***
Tuesday 30 September 2025  07:54:20 +0000 (0:00:00.116)       0:00:08.166 *****
ok: [instance]

TASK [ci_multus : Remove any networks in cifmw_ci_multus_deny_list if defined] ***
Tuesday 30 September 2025  07:54:20 +0000 (0:00:00.091)       0:00:08.258 *****
ok: [instance]

TASK [ci_multus : Render NetworkAttachmenktDefinition manifests] ***************
Tuesday 30 September 2025  07:54:20 +0000 (0:00:00.072)       0:00:08.331 *****
changed: [instance]

TASK [ci_multus : Create the multus namespace] *********************************
Tuesday 30 September 2025  07:54:21 +0000 (0:00:00.626)       0:00:08.957 *****
changed: [instance]

TASK [ci_multus : Apply network attachment definition manifests] ***************
Tuesday 30 September 2025  07:54:22 +0000 (0:00:01.044)       0:00:10.002 *****
changed: [instance]

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

Tuesday 30 September 2025  07:54:23 +0000 (0:00:00.844)       0:00:10.847 *****
===============================================================================
Fetch crc network facts ------------------------------------------------- 5.06s
Gathering Facts --------------------------------------------------------- 1.08s
ci_multus : Create the multus namespace --------------------------------- 1.04s
ci_multus : Apply network attachment definition manifests --------------- 0.84s
ci_multus : Render NetworkAttachmenktDefinition manifests --------------- 0.63s
Add crc hostname with it's IP to /etc/hosts ----------------------------- 0.49s
recognize_ssh_keypair : Check if id_ed25519 key exists ------------------ 0.39s
ci_multus : Create manifests directory ---------------------------------- 0.37s
ci_multus : Merge any available multus net info patches ----------------- 0.22s
ci_multus : Remove any networks without Multus networking defined ------- 0.12s
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.07s
networking_mapper : Set cifmw_networking_env_definition is present ------ 0.06s
ci_multus : Gather network layout from OCP host or default networks ----- 0.06s
Check if new ssh keypair exists ----------------------------------------- 0.05s
Call ci_multus role ----------------------------------------------------- 0.05s
networking_mapper : Load the Networking Definition from file ------------ 0.04s
networking_mapper : Check for Networking Environment Definition file existence --- 0.04s
networking_mapper : Check for Networking Definition file existance ------ 0.04s
Load shared variables --------------------------------------------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Tuesday 30 September 2025  07:54:23 +0000 (0:00:00.015)       0:00:00.015 *****
ok: [instance]

TASK [Load shared variables] ***************************************************
Tuesday 30 September 2025  07:54:24 +0000 (0:00:01.214)       0:00:01.229 *****
ok: [instance]

TASK [Fetch files stat results] ************************************************
Tuesday 30 September 2025  07:54:24 +0000 (0:00:00.041)       0:00:01.271 *****
ok: [instance]

TASK [Assert that expected file exist] *****************************************
Tuesday 30 September 2025  07:54:25 +0000 (0:00:00.397)       0:00:01.669 *****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Fetch file content] ******************************************************
Tuesday 30 September 2025  07:54:25 +0000 (0:00:00.026)       0:00:01.695 *****
ok: [instance]

TASK [Set _ci_multus_nad variable] *********************************************
Tuesday 30 September 2025  07:54:25 +0000 (0:00:00.357)       0:00:02.053 *****
ok: [instance]

TASK [Assert expected number of Network Attachment Definitions are created] ****
Tuesday 30 September 2025  07:54:25 +0000 (0:00:00.052)       0:00:02.105 *****
ok: [instance]

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

Tuesday 30 September 2025  07:54:25 +0000 (0:00:00.089)       0:00:02.195 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.21s
Fetch files stat results ------------------------------------------------ 0.40s
Fetch file content ------------------------------------------------------ 0.36s
Assert expected number of Network Attachment Definitions are created ---- 0.09s
Set _ci_multus_nad variable --------------------------------------------- 0.05s
Load shared variables --------------------------------------------------- 0.04s
Assert that expected file exist ----------------------------------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Tuesday 30 September 2025  07:54:26 +0000 (0:00:00.015)       0:00:00.015 *****
ok: [instance]

TASK [Include default vars] ****************************************************
Tuesday 30 September 2025  07:54:27 +0000 (0:00:01.117)       0:00:01.133 *****
ok: [instance]

TASK [Check if NADs were created] **********************************************
Tuesday 30 September 2025  07:54:27 +0000 (0:00:00.033)       0:00:01.166 *****
ok: [instance]

TASK [Store output spec] *******************************************************
Tuesday 30 September 2025  07:54:28 +0000 (0:00:00.935)       0:00:02.101 *****
ok: [instance]

TASK [Ensure both lists have the same length] **********************************
Tuesday 30 September 2025  07:54:28 +0000 (0:00:00.040)       0:00:02.142 *****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Compare each corresponding element in the lists] *************************
Tuesday 30 September 2025  07:54:28 +0000 (0:00:00.043)       0:00:02.186 *****
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] ***********************************
Tuesday 30 September 2025  07:54:28 +0000 (0:00:00.079)       0:00:02.265 *****
[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).
FAILED - RETRYING: [instance]: Create a test pod to attach a network (28 retries left).
FAILED - RETRYING: [instance]: Create a test pod to attach a network (27 retries left).
changed: [instance]

TASK [Assert that test pod has the additional network] *************************
Tuesday 30 September 2025  07:56:02 +0000 (0:01:34.076)       0:01:36.342 *****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Delete test pod] *********************************************************
Tuesday 30 September 2025  07:56:02 +0000 (0:00:00.048)       0:01:36.391 *****
changed: [instance]

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

Tuesday 30 September 2025  07:56:03 +0000 (0:00:00.819)       0:01:37.210 *****
===============================================================================
Create a test pod to attach a network ---------------------------------- 94.08s
Gathering Facts --------------------------------------------------------- 1.12s
Check if NADs were created ---------------------------------------------- 0.94s
Delete test pod --------------------------------------------------------- 0.82s
Compare each corresponding element in the lists ------------------------- 0.08s
Assert that test pod has the additional network ------------------------- 0.05s
Ensure both lists have the same length ---------------------------------- 0.04s
Store output spec ------------------------------------------------------- 0.04s
Include default vars ---------------------------------------------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Tuesday 30 September 2025  07:56:04 +0000 (0:00:00.016)       0:00:00.016 *****
ok: [instance]

TASK [Backup NAD before cleanup so they can be inspected in CI] ****************
Tuesday 30 September 2025  07:56:05 +0000 (0:00:01.087)       0:00:01.103 *****
changed: [instance]

TASK [ci_multus : Cleanup - Fetch NADs in namespace: openstack] ****************
Tuesday 30 September 2025  07:56:05 +0000 (0:00:00.444)       0:00:01.548 *****
ok: [instance]

TASK [ci_multus : Cleanup - Delete NADs] ***************************************
Tuesday 30 September 2025  07:56:06 +0000 (0:00:00.823)       0:00:02.371 *****
changed: [instance] => (item=bridge-to-linux-bridge)
changed: [instance] => (item=default)
changed: [instance] => (item=patchnetwork)

TASK [ci_multus : Cleanup - Remove if artifact directory exists] ***************
Tuesday 30 September 2025  07:56:08 +0000 (0:00:02.296)       0:00:04.668 *****
changed: [instance]

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

Tuesday 30 September 2025  07:56:09 +0000 (0:00:00.410)       0:00:05.079 *****
===============================================================================
ci_multus : Cleanup - Delete NADs --------------------------------------- 2.30s
Gathering Facts --------------------------------------------------------- 1.09s
ci_multus : Cleanup - Fetch NADs in namespace: openstack ---------------- 0.82s
Backup NAD before cleanup so they can be inspected in CI ---------------- 0.44s
ci_multus : Cleanup - Remove if artifact directory exists --------------- 0.41s

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

TASK [Gathering Facts] *********************************************************
Tuesday 30 September 2025  07:56:09 +0000 (0:00:00.016)       0:00:00.016 *****
ok: [instance]

TASK [Include default vars] ****************************************************
Tuesday 30 September 2025  07:56:11 +0000 (0:00:01.124)       0:00:01.141 *****
ok: [instance]

TASK [Fetch file stat results] *************************************************
Tuesday 30 September 2025  07:56:11 +0000 (0:00:00.029)       0:00:01.171 *****
ok: [instance]

TASK [Assert that created file are removed by cleanup] *************************
Tuesday 30 September 2025  07:56:11 +0000 (0:00:00.427)       0:00:01.599 *****
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

Tuesday 30 September 2025  07:56:11 +0000 (0:00:00.061)       0:00:01.660 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.12s
Fetch file stat results ------------------------------------------------- 0.43s
Assert that created file are removed by cleanup ------------------------- 0.06s
Include default vars ---------------------------------------------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Tuesday 30 September 2025  07:56:12 +0000 (0:00:00.015)       0:00:00.015 *****
ok: [instance]

TASK [Include default vars] ****************************************************
Tuesday 30 September 2025  07:56:13 +0000 (0:00:01.127)       0:00:01.143 *****
ok: [instance]

TASK [Check if NADs were deleted] **********************************************
Tuesday 30 September 2025  07:56:13 +0000 (0:00:00.054)       0:00:01.198 *****
ok: [instance]

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

Tuesday 30 September 2025  07:56:14 +0000 (0:00:00.960)       0:00:02.158 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.13s
Check if NADs were deleted ---------------------------------------------- 0.96s
Include default vars ---------------------------------------------------- 0.06s

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

TASK [Gathering Facts] *********************************************************
Tuesday 30 September 2025  07:56:14 +0000 (0:00:00.016)       0:00:00.016 *****
ok: [instance]

TASK [Load shared variables] ***************************************************
Tuesday 30 September 2025  07:56:16 +0000 (0:00:01.095)       0:00:01.111 *****
ok: [instance]

TASK [Call ci_multus role] *****************************************************
Tuesday 30 September 2025  07:56:16 +0000 (0:00:00.036)       0:00:01.147 *****

TASK [ci_multus : Create manifests directory] **********************************
Tuesday 30 September 2025  07:56:16 +0000 (0:00:00.076)       0:00:01.223 *****
changed: [instance]

TASK [networking_mapper : Check for Networking Environment Definition file existence] ***
Tuesday 30 September 2025  07:56:16 +0000 (0:00:00.417)       0:00:01.640 *****
skipping: [instance]

TASK [networking_mapper : Check for Networking Definition file existance] ******
Tuesday 30 September 2025  07:56:16 +0000 (0:00:00.039)       0:00:01.679 *****
skipping: [instance]

TASK [networking_mapper : Load the Networking Definition from file] ************
Tuesday 30 September 2025  07:56:16 +0000 (0:00:00.040)       0:00:01.720 *****
skipping: [instance]

TASK [networking_mapper : Set cifmw_networking_env_definition is present] ******
Tuesday 30 September 2025  07:56:16 +0000 (0:00:00.036)       0:00:01.756 *****
skipping: [instance]

TASK [ci_multus : Gather network layout from OCP host or default networks] *****
Tuesday 30 September 2025  07:56:16 +0000 (0:00:00.056)       0:00:01.813 *****
ok: [instance]

TASK [ci_multus : Merge any available multus net info patches] *****************
Tuesday 30 September 2025  07:56:16 +0000 (0:00:00.067)       0:00:01.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', 'interface_name': 'eth2', 'network_name': 'patchnetwork', 'network_v4': '192.168.122.0/24', 'tools': {'multus': {'ipv4_ranges': [{'end': '192.168.122.70', 'start': '192.168.122.30'}]}}}})

TASK [ci_multus : Remove any networks without Multus networking defined] *******
Tuesday 30 September 2025  07:56:16 +0000 (0:00:00.169)       0:00:02.049 *****
ok: [instance]

TASK [ci_multus : Remove any networks not in cifmw_ci_multus_allow_list if defined] ***
Tuesday 30 September 2025  07:56:17 +0000 (0:00:00.117)       0:00:02.166 *****
ok: [instance]

TASK [ci_multus : Remove any networks in cifmw_ci_multus_deny_list if defined] ***
Tuesday 30 September 2025  07:56:17 +0000 (0:00:00.101)       0:00:02.268 *****
ok: [instance]

TASK [ci_multus : Render NetworkAttachmenktDefinition manifests] ***************
Tuesday 30 September 2025  07:56:17 +0000 (0:00:00.115)       0:00:02.383 *****
changed: [instance]

TASK [ci_multus : Create the multus namespace] *********************************
Tuesday 30 September 2025  07:56:18 +0000 (0:00:00.796)       0:00:03.180 *****
skipping: [instance]

TASK [ci_multus : Apply network attachment definition manifests] ***************
Tuesday 30 September 2025  07:56:18 +0000 (0:00:00.025)       0:00:03.205 *****
skipping: [instance]

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

Tuesday 30 September 2025  07:56:18 +0000 (0:00:00.046)       0:00:03.252 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.10s
ci_multus : Render NetworkAttachmenktDefinition manifests --------------- 0.80s
ci_multus : Create manifests directory ---------------------------------- 0.42s
ci_multus : Merge any available multus net info patches ----------------- 0.17s
ci_multus : Remove any networks without Multus networking defined ------- 0.12s
ci_multus : Remove any networks in cifmw_ci_multus_deny_list if defined --- 0.12s
ci_multus : Remove any networks not in cifmw_ci_multus_allow_list if defined --- 0.10s
Call ci_multus role ----------------------------------------------------- 0.08s
ci_multus : Gather network layout from OCP host or default networks ----- 0.07s
networking_mapper : Set cifmw_networking_env_definition is present ------ 0.06s
ci_multus : Apply network attachment definition manifests --------------- 0.05s
networking_mapper : Check for Networking Definition file existance ------ 0.04s
networking_mapper : Check for Networking Environment Definition file existence --- 0.04s
networking_mapper : Load the Networking Definition from file ------------ 0.04s
Load shared variables --------------------------------------------------- 0.04s
ci_multus : Create the multus namespace --------------------------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Tuesday 30 September 2025  07:56:18 +0000 (0:00:00.018)       0:00:00.018 *****
ok: [instance]

TASK [Load shared variables] ***************************************************
Tuesday 30 September 2025  07:56:20 +0000 (0:00:01.222)       0:00:01.241 *****
ok: [instance]

TASK [Fetch files stat results] ************************************************
Tuesday 30 September 2025  07:56:20 +0000 (0:00:00.033)       0:00:01.274 *****
ok: [instance]

TASK [Assert that expected file exist] *****************************************
Tuesday 30 September 2025  07:56:20 +0000 (0:00:00.389)       0:00:01.663 *****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Fetch file content] ******************************************************
Tuesday 30 September 2025  07:56:20 +0000 (0:00:00.038)       0:00:01.701 *****
ok: [instance]

TASK [Set _ci_multus_nad variable] *********************************************
Tuesday 30 September 2025  07:56:20 +0000 (0:00:00.373)       0:00:02.075 *****
ok: [instance]

TASK [Assert expected number of Network Attachment Definitions are created] ****
Tuesday 30 September 2025  07:56:20 +0000 (0:00:00.039)       0:00:02.115 *****
ok: [instance]

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

Tuesday 30 September 2025  07:56:20 +0000 (0:00:00.052)       0:00:02.167 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.22s
Fetch files stat results ------------------------------------------------ 0.39s
Fetch file content ------------------------------------------------------ 0.37s
Assert expected number of Network Attachment Definitions are created ---- 0.05s
Set _ci_multus_nad variable --------------------------------------------- 0.04s
Assert that expected file exist ----------------------------------------- 0.04s
Load shared variables --------------------------------------------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Tuesday 30 September 2025  07:56:21 +0000 (0:00:00.015)       0:00:00.015 *****
ok: [instance]

TASK [Backup NAD before cleanup so they can be inspected in CI] ****************
Tuesday 30 September 2025  07:56:22 +0000 (0:00:01.164)       0:00:01.179 *****
changed: [instance]

TASK [ci_multus : Cleanup - Fetch NADs in namespace: openstack] ****************
Tuesday 30 September 2025  07:56:23 +0000 (0:00:00.419)       0:00:01.599 *****
skipping: [instance]

TASK [ci_multus : Cleanup - Delete NADs] ***************************************
Tuesday 30 September 2025  07:56:23 +0000 (0:00:00.032)       0:00:01.631 *****
skipping: [instance]

TASK [ci_multus : Cleanup - Remove if artifact directory exists] ***************
Tuesday 30 September 2025  07:56:23 +0000 (0:00:00.062)       0:00:01.694 *****
changed: [instance]

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

Tuesday 30 September 2025  07:56:23 +0000 (0:00:00.451)       0:00:02.146 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.16s
ci_multus : Cleanup - Remove if artifact directory exists --------------- 0.45s
Backup NAD before cleanup so they can be inspected in CI ---------------- 0.42s
ci_multus : Cleanup - Delete NADs --------------------------------------- 0.06s
ci_multus : Cleanup - Fetch NADs in namespace: openstack ---------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Tuesday 30 September 2025  07:56:24 +0000 (0:00:00.015)       0:00:00.015 *****
ok: [instance]

TASK [Include default vars] ****************************************************
Tuesday 30 September 2025  07:56:26 +0000 (0:00:02.169)       0:00:02.185 *****
ok: [instance]

TASK [Fetch file stat results] *************************************************
Tuesday 30 September 2025  07:56:26 +0000 (0:00:00.039)       0:00:02.225 *****
ok: [instance]

TASK [Assert that created file are removed by cleanup] *************************
Tuesday 30 September 2025  07:56:26 +0000 (0:00:00.364)       0:00:02.589 *****
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

Tuesday 30 September 2025  07:56:26 +0000 (0:00:00.055)       0:00:02.645 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 2.17s
Fetch file stat results ------------------------------------------------- 0.36s
Assert that created file are removed by cleanup ------------------------- 0.06s
Include default vars ---------------------------------------------------- 0.04s

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

TASK [Gathering Facts] *********************************************************
Tuesday 30 September 2025  07:56:27 +0000 (0:00:00.015)       0:00:00.015 *****
ok: [instance]

TASK [Load shared variables] ***************************************************
Tuesday 30 September 2025  07:56:28 +0000 (0:00:01.145)       0:00:01.161 *****
ok: [instance]

TASK [Call ci_multus role] *****************************************************
Tuesday 30 September 2025  07:56:28 +0000 (0:00:00.032)       0:00:01.193 *****

TASK [ci_multus : Create manifests directory] **********************************
Tuesday 30 September 2025  07:56:28 +0000 (0:00:00.044)       0:00:01.237 *****
changed: [instance]

TASK [networking_mapper : Check for Networking Environment Definition file existence] ***
Tuesday 30 September 2025  07:56:29 +0000 (0:00:00.421)       0:00:01.659 *****
skipping: [instance]

TASK [networking_mapper : Check for Networking Definition file existance] ******
Tuesday 30 September 2025  07:56:29 +0000 (0:00:00.040)       0:00:01.700 *****
skipping: [instance]

TASK [networking_mapper : Load the Networking Definition from file] ************
Tuesday 30 September 2025  07:56:29 +0000 (0:00:00.031)       0:00:01.732 *****
skipping: [instance]

TASK [networking_mapper : Set cifmw_networking_env_definition is present] ******
Tuesday 30 September 2025  07:56:29 +0000 (0:00:00.051)       0:00:01.783 *****
skipping: [instance]

TASK [ci_multus : Gather network layout from OCP host or default networks] *****
Tuesday 30 September 2025  07:56:29 +0000 (0:00:00.068)       0:00:01.851 *****
ok: [instance]

TASK [ci_multus : Merge any available multus net info patches] *****************
Tuesday 30 September 2025  07:56:29 +0000 (0:00:00.074)       0:00:01.926 *****
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] *******
Tuesday 30 September 2025  07:56:29 +0000 (0:00:00.128)       0:00:02.054 *****
ok: [instance]

TASK [ci_multus : Remove any networks not in cifmw_ci_multus_allow_list if defined] ***
Tuesday 30 September 2025  07:56:29 +0000 (0:00:00.084)       0:00:02.139 *****
ok: [instance]

TASK [ci_multus : Remove any networks in cifmw_ci_multus_deny_list if defined] ***
Tuesday 30 September 2025  07:56:29 +0000 (0:00:00.093)       0:00:02.232 *****
ok: [instance]

TASK [ci_multus : Render NetworkAttachmenktDefinition manifests] ***************
Tuesday 30 September 2025  07:56:29 +0000 (0:00:00.076)       0:00:02.308 *****
changed: [instance]

TASK [ci_multus : Create the multus namespace] *********************************
Tuesday 30 September 2025  07:56:30 +0000 (0:00:00.768)       0:00:03.077 *****
skipping: [instance]

TASK [ci_multus : Apply network attachment definition manifests] ***************
Tuesday 30 September 2025  07:56:30 +0000 (0:00:00.030)       0:00:03.107 *****
skipping: [instance]

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

Tuesday 30 September 2025  07:56:30 +0000 (0:00:00.064)       0:00:03.172 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.15s
ci_multus : Render NetworkAttachmenktDefinition manifests --------------- 0.77s
ci_multus : Create manifests directory ---------------------------------- 0.42s
ci_multus : Merge any available multus net info patches ----------------- 0.13s
ci_multus : Remove any networks not in cifmw_ci_multus_allow_list if defined --- 0.09s
ci_multus : Remove any networks without Multus networking 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.07s
networking_mapper : Set cifmw_networking_env_definition is present ------ 0.07s
ci_multus : Apply network attachment definition manifests --------------- 0.06s
networking_mapper : Load the Networking Definition from file ------------ 0.05s
Call ci_multus role ----------------------------------------------------- 0.04s
networking_mapper : Check for Networking Environment Definition file existence --- 0.04s
Load shared variables --------------------------------------------------- 0.03s
networking_mapper : Check for Networking Definition file existance ------ 0.03s
ci_multus : Create the multus namespace --------------------------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Tuesday 30 September 2025  07:56:31 +0000 (0:00:00.017)       0:00:00.017 *****
ok: [instance]

TASK [Load shared variables] ***************************************************
Tuesday 30 September 2025  07:56:32 +0000 (0:00:01.158)       0:00:01.175 *****
ok: [instance]

TASK [Fetch files stat results] ************************************************
Tuesday 30 September 2025  07:56:32 +0000 (0:00:00.026)       0:00:01.202 *****
ok: [instance]

TASK [Assert that expected file exist] *****************************************
Tuesday 30 September 2025  07:56:32 +0000 (0:00:00.392)       0:00:01.595 *****
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Fetch file content] ******************************************************
Tuesday 30 September 2025  07:56:32 +0000 (0:00:00.040)       0:00:01.635 *****
ok: [instance]

TASK [Set _ci_multus_nad variable] *********************************************
Tuesday 30 September 2025  07:56:33 +0000 (0:00:00.339)       0:00:01.975 *****
ok: [instance]

TASK [Assert expected number of Network Attachment Definitions are created] ****
Tuesday 30 September 2025  07:56:33 +0000 (0:00:00.061)       0:00:02.036 *****
ok: [instance]

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

Tuesday 30 September 2025  07:56:33 +0000 (0:00:00.089)       0:00:02.126 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.16s
Fetch files stat results ------------------------------------------------ 0.39s
Fetch file content ------------------------------------------------------ 0.34s
Assert expected number of Network Attachment Definitions are created ---- 0.09s
Set _ci_multus_nad variable --------------------------------------------- 0.06s
Assert that expected file exist ----------------------------------------- 0.04s
Load shared variables --------------------------------------------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Tuesday 30 September 2025  07:56:34 +0000 (0:00:00.015)       0:00:00.015 *****
ok: [instance]

TASK [Backup NAD before cleanup so they can be inspected in CI] ****************
Tuesday 30 September 2025  07:56:35 +0000 (0:00:01.092)       0:00:01.107 *****
changed: [instance]

TASK [ci_multus : Cleanup - Fetch NADs in namespace: openstack] ****************
Tuesday 30 September 2025  07:56:35 +0000 (0:00:00.408)       0:00:01.515 *****
skipping: [instance]

TASK [ci_multus : Cleanup - Delete NADs] ***************************************
Tuesday 30 September 2025  07:56:35 +0000 (0:00:00.045)       0:00:01.561 *****
skipping: [instance]

TASK [ci_multus : Cleanup - Remove if artifact directory exists] ***************
Tuesday 30 September 2025  07:56:35 +0000 (0:00:00.049)       0:00:01.610 *****
changed: [instance]

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

Tuesday 30 September 2025  07:56:36 +0000 (0:00:00.409)       0:00:02.020 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.09s
ci_multus : Cleanup - Remove if artifact directory exists --------------- 0.41s
Backup NAD before cleanup so they can be inspected in CI ---------------- 0.41s
ci_multus : Cleanup - Delete NADs --------------------------------------- 0.05s
ci_multus : Cleanup - Fetch NADs in namespace: openstack ---------------- 0.05s

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

TASK [Gathering Facts] *********************************************************
Tuesday 30 September 2025  07:56:36 +0000 (0:00:00.015)       0:00:00.015 *****
ok: [instance]

TASK [Include default vars] ****************************************************
Tuesday 30 September 2025  07:56:37 +0000 (0:00:01.100)       0:00:01.115 *****
ok: [instance]

TASK [Fetch file stat results] *************************************************
Tuesday 30 September 2025  07:56:37 +0000 (0:00:00.027)       0:00:01.143 *****
ok: [instance]

TASK [Assert that created file are removed by cleanup] *************************
Tuesday 30 September 2025  07:56:38 +0000 (0:00:00.335)       0:00:01.478 *****
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

Tuesday 30 September 2025  07:56:38 +0000 (0:00:00.050)       0:00:01.529 *****
===============================================================================
Gathering Facts --------------------------------------------------------- 1.10s
Fetch file stat results ------------------------------------------------- 0.34s
Assert that created file are removed by cleanup ------------------------- 0.05s
Include default vars ---------------------------------------------------- 0.03s