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

TASK [Gathering Facts] *********************************************************
Friday 03 October 2025  13:39:40 +0000 (0:00:00.011)       0:00:00.011 ********
ok: [instance]

TASK [Add crc hostname with it's IP to /etc/hosts] *****************************
Friday 03 October 2025  13:39:41 +0000 (0:00:01.521)       0:00:01.533 ********
changed: [instance]

TASK [Check if new ssh keypair exists] *****************************************
Friday 03 October 2025  13:39:42 +0000 (0:00:00.491)       0:00:02.024 ********

TASK [recognize_ssh_keypair : Check if id_ed25519 key exists] ******************
Friday 03 October 2025  13:39:42 +0000 (0:00:00.032)       0:00:02.056 ********
ok: [instance]

TASK [recognize_ssh_keypair : Set fact if new keypair exists] ******************
Friday 03 October 2025  13:39:42 +0000 (0:00:00.413)       0:00:02.470 ********
ok: [instance]

TASK [recognize_ssh_keypair : Set fact if new keypair does not exists] *********
Friday 03 October 2025  13:39:42 +0000 (0:00:00.035)       0:00:02.505 ********
skipping: [instance]

TASK [Add the crc host dynamically] ********************************************
Friday 03 October 2025  13:39:42 +0000 (0:00:00.033)       0:00:02.538 ********
changed: [instance]

TASK [Fetch crc network facts] *************************************************
Friday 03 October 2025  13:39:42 +0000 (0:00:00.027)       0:00:02.566 ********
ok: [instance -> crc]

TASK [Load shared variables] ***************************************************
Friday 03 October 2025  13:39:47 +0000 (0:00:04.929)       0:00:07.496 ********
ok: [instance]

TASK [Call ci_multus role] *****************************************************
Friday 03 October 2025  13:39:47 +0000 (0:00:00.025)       0:00:07.521 ********

TASK [ci_multus : Create manifests directory] **********************************
Friday 03 October 2025  13:39:47 +0000 (0:00:00.089)       0:00:07.610 ********
changed: [instance]

TASK [networking_mapper : Check for Networking Environment Definition file existence] ***
Friday 03 October 2025  13:39:48 +0000 (0:00:00.385)       0:00:07.996 ********
skipping: [instance]

TASK [networking_mapper : Check for Networking Definition file existance] ******
Friday 03 October 2025  13:39:48 +0000 (0:00:00.026)       0:00:08.023 ********
skipping: [instance]

TASK [networking_mapper : Load the Networking Definition from file] ************
Friday 03 October 2025  13:39:48 +0000 (0:00:00.028)       0:00:08.051 ********
skipping: [instance]

TASK [networking_mapper : Set cifmw_networking_env_definition is present] ******
Friday 03 October 2025  13:39:48 +0000 (0:00:00.025)       0:00:08.077 ********
skipping: [instance]

TASK [ci_multus : Gather network layout from OCP host or default networks] *****
Friday 03 October 2025  13:39:48 +0000 (0:00:00.032)       0:00:08.109 ********
ok: [instance]

TASK [ci_multus : Merge any available multus net info patches] *****************
Friday 03 October 2025  13:39:48 +0000 (0:00:00.046)       0:00:08.156 ********
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] *******
Friday 03 October 2025  13:39:48 +0000 (0:00:00.202)       0:00:08.358 ********
ok: [instance]

TASK [ci_multus : Remove any networks not in cifmw_ci_multus_allow_list if defined] ***
Friday 03 October 2025  13:39:48 +0000 (0:00:00.093)       0:00:08.452 ********
ok: [instance]

TASK [ci_multus : Remove any networks in cifmw_ci_multus_deny_list if defined] ***
Friday 03 October 2025  13:39:48 +0000 (0:00:00.084)       0:00:08.536 ********
ok: [instance]

TASK [ci_multus : Render NetworkAttachmenktDefinition manifests] ***************
Friday 03 October 2025  13:39:48 +0000 (0:00:00.085)       0:00:08.621 ********
changed: [instance]

TASK [ci_multus : Create the multus namespace] *********************************
Friday 03 October 2025  13:39:49 +0000 (0:00:00.674)       0:00:09.296 ********
changed: [instance]

TASK [ci_multus : Apply network attachment definition manifests] ***************
Friday 03 October 2025  13:39:50 +0000 (0:00:01.081)       0:00:10.378 ********
changed: [instance]

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

Friday 03 October 2025  13:39:51 +0000 (0:00:00.889)       0:00:11.267 ********
===============================================================================
Fetch crc network facts ------------------------------------------------- 4.93s
Gathering Facts --------------------------------------------------------- 1.52s
ci_multus : Create the multus namespace --------------------------------- 1.08s
ci_multus : Apply network attachment definition manifests --------------- 0.89s
ci_multus : Render NetworkAttachmenktDefinition manifests --------------- 0.67s
Add crc hostname with it's IP to /etc/hosts ----------------------------- 0.49s
recognize_ssh_keypair : Check if id_ed25519 key exists ------------------ 0.41s
ci_multus : Create manifests directory ---------------------------------- 0.39s
ci_multus : Merge any available multus net info patches ----------------- 0.20s
ci_multus : Remove any networks without Multus networking defined ------- 0.09s
Call ci_multus role ----------------------------------------------------- 0.09s
ci_multus : Remove any networks in cifmw_ci_multus_deny_list if defined --- 0.09s
ci_multus : Remove any networks not in cifmw_ci_multus_allow_list if defined --- 0.08s
ci_multus : Gather network layout from OCP host or default networks ----- 0.05s
recognize_ssh_keypair : Set fact if new keypair exists ------------------ 0.04s
recognize_ssh_keypair : Set fact if new keypair does not exists --------- 0.03s
networking_mapper : Set cifmw_networking_env_definition is present ------ 0.03s
Check if new ssh keypair exists ----------------------------------------- 0.03s
networking_mapper : Check for Networking Definition file existance ------ 0.03s
Add the crc host dynamically -------------------------------------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Friday 03 October 2025  13:39:52 +0000 (0:00:00.017)       0:00:00.017 ********
ok: [instance]

TASK [Load shared variables] ***************************************************
Friday 03 October 2025  13:39:53 +0000 (0:00:01.092)       0:00:01.109 ********
ok: [instance]

TASK [Fetch files stat results] ************************************************
Friday 03 October 2025  13:39:53 +0000 (0:00:00.030)       0:00:01.140 ********
ok: [instance]

TASK [Assert that expected file exist] *****************************************
Friday 03 October 2025  13:39:53 +0000 (0:00:00.396)       0:00:01.536 ********
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Fetch file content] ******************************************************
Friday 03 October 2025  13:39:53 +0000 (0:00:00.028)       0:00:01.565 ********
ok: [instance]

TASK [Set _ci_multus_nad variable] *********************************************
Friday 03 October 2025  13:39:53 +0000 (0:00:00.377)       0:00:01.943 ********
ok: [instance]

TASK [Assert expected number of Network Attachment Definitions are created] ****
Friday 03 October 2025  13:39:53 +0000 (0:00:00.039)       0:00:01.982 ********
ok: [instance]

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

Friday 03 October 2025  13:39:54 +0000 (0:00:00.057)       0:00:02.040 ********
===============================================================================
Gathering Facts --------------------------------------------------------- 1.09s
Fetch files stat results ------------------------------------------------ 0.40s
Fetch file content ------------------------------------------------------ 0.38s
Assert expected number of Network Attachment Definitions are created ---- 0.06s
Set _ci_multus_nad variable --------------------------------------------- 0.04s
Load shared variables --------------------------------------------------- 0.03s
Assert that expected file exist ----------------------------------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Friday 03 October 2025  13:39:54 +0000 (0:00:00.018)       0:00:00.018 ********
ok: [instance]

TASK [Include default vars] ****************************************************
Friday 03 October 2025  13:39:55 +0000 (0:00:01.060)       0:00:01.079 ********
ok: [instance]

TASK [Check if NADs were created] **********************************************
Friday 03 October 2025  13:39:55 +0000 (0:00:00.028)       0:00:01.107 ********
ok: [instance]

TASK [Store output spec] *******************************************************
Friday 03 October 2025  13:39:56 +0000 (0:00:01.024)       0:00:02.131 ********
ok: [instance]

TASK [Ensure both lists have the same length] **********************************
Friday 03 October 2025  13:39:56 +0000 (0:00:00.035)       0:00:02.167 ********
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Compare each corresponding element in the lists] *************************
Friday 03 October 2025  13:39:56 +0000 (0:00:00.038)       0:00:02.206 ********
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] ***********************************
Friday 03 October 2025  13:39:56 +0000 (0:00:00.063)       0:00:02.270 ********
[WARNING]: unknown field "api_version"
changed: [instance]

TASK [Assert that test pod has the additional network] *************************
Friday 03 October 2025  13:40:19 +0000 (0:00:22.120)       0:00:24.390 ********
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Delete test pod] *********************************************************
Friday 03 October 2025  13:40:19 +0000 (0:00:00.035)       0:00:24.425 ********
changed: [instance]

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

Friday 03 October 2025  13:40:19 +0000 (0:00:00.812)       0:00:25.238 ********
===============================================================================
Create a test pod to attach a network ---------------------------------- 22.12s
Gathering Facts --------------------------------------------------------- 1.06s
Check if NADs were created ---------------------------------------------- 1.02s
Delete test pod --------------------------------------------------------- 0.81s
Compare each corresponding element in the lists ------------------------- 0.06s
Ensure both lists have the same length ---------------------------------- 0.04s
Store output spec ------------------------------------------------------- 0.04s
Assert that test pod has the additional network ------------------------- 0.04s
Include default vars ---------------------------------------------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Friday 03 October 2025  13:40:20 +0000 (0:00:00.017)       0:00:00.017 ********
ok: [instance]

TASK [Backup NAD before cleanup so they can be inspected in CI] ****************
Friday 03 October 2025  13:40:21 +0000 (0:00:01.109)       0:00:01.126 ********
changed: [instance]

TASK [ci_multus : Cleanup - Fetch NADs in namespace: openstack] ****************
Friday 03 October 2025  13:40:22 +0000 (0:00:00.407)       0:00:01.534 ********
ok: [instance]

TASK [ci_multus : Cleanup - Delete NADs] ***************************************
Friday 03 October 2025  13:40:23 +0000 (0:00:00.964)       0:00:02.499 ********
changed: [instance] => (item=bridge-to-linux-bridge)
changed: [instance] => (item=default)
changed: [instance] => (item=patchnetwork)

TASK [ci_multus : Cleanup - Remove if artifact directory exists] ***************
Friday 03 October 2025  13:40:25 +0000 (0:00:02.493)       0:00:04.992 ********
changed: [instance]

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

Friday 03 October 2025  13:40:25 +0000 (0:00:00.377)       0:00:05.370 ********
===============================================================================
ci_multus : Cleanup - Delete NADs --------------------------------------- 2.49s
Gathering Facts --------------------------------------------------------- 1.11s
ci_multus : Cleanup - Fetch NADs in namespace: openstack ---------------- 0.96s
Backup NAD before cleanup so they can be inspected in CI ---------------- 0.41s
ci_multus : Cleanup - Remove if artifact directory exists --------------- 0.38s

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

TASK [Gathering Facts] *********************************************************
Friday 03 October 2025  13:40:26 +0000 (0:00:00.016)       0:00:00.016 ********
ok: [instance]

TASK [Include default vars] ****************************************************
Friday 03 October 2025  13:40:27 +0000 (0:00:01.182)       0:00:01.199 ********
ok: [instance]

TASK [Fetch file stat results] *************************************************
Friday 03 October 2025  13:40:27 +0000 (0:00:00.036)       0:00:01.236 ********
ok: [instance]

TASK [Assert that created file are removed by cleanup] *************************
Friday 03 October 2025  13:40:28 +0000 (0:00:00.370)       0:00:01.606 ********
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

Friday 03 October 2025  13:40:28 +0000 (0:00:00.053)       0:00:01.660 ********
===============================================================================
Gathering Facts --------------------------------------------------------- 1.18s
Fetch file stat results ------------------------------------------------- 0.37s
Assert that created file are removed by cleanup ------------------------- 0.05s
Include default vars ---------------------------------------------------- 0.04s

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

TASK [Gathering Facts] *********************************************************
Friday 03 October 2025  13:40:28 +0000 (0:00:00.017)       0:00:00.017 ********
ok: [instance]

TASK [Include default vars] ****************************************************
Friday 03 October 2025  13:40:29 +0000 (0:00:01.067)       0:00:01.084 ********
ok: [instance]

TASK [Check if NADs were deleted] **********************************************
Friday 03 October 2025  13:40:29 +0000 (0:00:00.033)       0:00:01.118 ********
ok: [instance]

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

Friday 03 October 2025  13:40:30 +0000 (0:00:00.989)       0:00:02.107 ********
===============================================================================
Gathering Facts --------------------------------------------------------- 1.07s
Check if NADs were deleted ---------------------------------------------- 0.99s
Include default vars ---------------------------------------------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Friday 03 October 2025  13:40:31 +0000 (0:00:00.018)       0:00:00.018 ********
ok: [instance]

TASK [Load shared variables] ***************************************************
Friday 03 October 2025  13:40:32 +0000 (0:00:01.346)       0:00:01.364 ********
ok: [instance]

TASK [Call ci_multus role] *****************************************************
Friday 03 October 2025  13:40:32 +0000 (0:00:00.025)       0:00:01.389 ********

TASK [ci_multus : Create manifests directory] **********************************
Friday 03 October 2025  13:40:33 +0000 (0:00:00.046)       0:00:01.435 ********
changed: [instance]

TASK [networking_mapper : Check for Networking Environment Definition file existence] ***
Friday 03 October 2025  13:40:33 +0000 (0:00:00.397)       0:00:01.833 ********
skipping: [instance]

TASK [networking_mapper : Check for Networking Definition file existance] ******
Friday 03 October 2025  13:40:33 +0000 (0:00:00.039)       0:00:01.872 ********
skipping: [instance]

TASK [networking_mapper : Load the Networking Definition from file] ************
Friday 03 October 2025  13:40:33 +0000 (0:00:00.028)       0:00:01.901 ********
skipping: [instance]

TASK [networking_mapper : Set cifmw_networking_env_definition is present] ******
Friday 03 October 2025  13:40:33 +0000 (0:00:00.026)       0:00:01.928 ********
skipping: [instance]

TASK [ci_multus : Gather network layout from OCP host or default networks] *****
Friday 03 October 2025  13:40:33 +0000 (0:00:00.034)       0:00:01.962 ********
ok: [instance]

TASK [ci_multus : Merge any available multus net info patches] *****************
Friday 03 October 2025  13:40:33 +0000 (0:00:00.054)       0:00:02.017 ********
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] *******
Friday 03 October 2025  13:40:33 +0000 (0:00:00.162)       0:00:02.180 ********
ok: [instance]

TASK [ci_multus : Remove any networks not in cifmw_ci_multus_allow_list if defined] ***
Friday 03 October 2025  13:40:33 +0000 (0:00:00.085)       0:00:02.265 ********
ok: [instance]

TASK [ci_multus : Remove any networks in cifmw_ci_multus_deny_list if defined] ***
Friday 03 October 2025  13:40:33 +0000 (0:00:00.097)       0:00:02.362 ********
ok: [instance]

TASK [ci_multus : Render NetworkAttachmenktDefinition manifests] ***************
Friday 03 October 2025  13:40:34 +0000 (0:00:00.080)       0:00:02.442 ********
changed: [instance]

TASK [ci_multus : Create the multus namespace] *********************************
Friday 03 October 2025  13:40:34 +0000 (0:00:00.749)       0:00:03.191 ********
skipping: [instance]

TASK [ci_multus : Apply network attachment definition manifests] ***************
Friday 03 October 2025  13:40:34 +0000 (0:00:00.022)       0:00:03.214 ********
skipping: [instance]

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

Friday 03 October 2025  13:40:34 +0000 (0:00:00.045)       0:00:03.259 ********
===============================================================================
Gathering Facts --------------------------------------------------------- 1.35s
ci_multus : Render NetworkAttachmenktDefinition manifests --------------- 0.75s
ci_multus : Create manifests directory ---------------------------------- 0.40s
ci_multus : Merge any available multus net info patches ----------------- 0.16s
ci_multus : Remove any networks not in cifmw_ci_multus_allow_list if defined --- 0.10s
ci_multus : Remove any networks without Multus networking defined ------- 0.09s
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.05s
Call ci_multus role ----------------------------------------------------- 0.05s
ci_multus : Apply network attachment definition manifests --------------- 0.05s
networking_mapper : Check for Networking Environment Definition file existence --- 0.04s
networking_mapper : Set cifmw_networking_env_definition is present ------ 0.03s
networking_mapper : Check for Networking Definition file existance ------ 0.03s
networking_mapper : Load the Networking Definition from file ------------ 0.03s
Load shared variables --------------------------------------------------- 0.03s
ci_multus : Create the multus namespace --------------------------------- 0.02s

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

TASK [Gathering Facts] *********************************************************
Friday 03 October 2025  13:40:35 +0000 (0:00:00.017)       0:00:00.017 ********
ok: [instance]

TASK [Load shared variables] ***************************************************
Friday 03 October 2025  13:40:36 +0000 (0:00:01.069)       0:00:01.086 ********
ok: [instance]

TASK [Fetch files stat results] ************************************************
Friday 03 October 2025  13:40:36 +0000 (0:00:00.024)       0:00:01.111 ********
ok: [instance]

TASK [Assert that expected file exist] *****************************************
Friday 03 October 2025  13:40:37 +0000 (0:00:00.516)       0:00:01.627 ********
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Fetch file content] ******************************************************
Friday 03 October 2025  13:40:37 +0000 (0:00:00.029)       0:00:01.657 ********
ok: [instance]

TASK [Set _ci_multus_nad variable] *********************************************
Friday 03 October 2025  13:40:37 +0000 (0:00:00.342)       0:00:02.000 ********
ok: [instance]

TASK [Assert expected number of Network Attachment Definitions are created] ****
Friday 03 October 2025  13:40:37 +0000 (0:00:00.035)       0:00:02.035 ********
ok: [instance]

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

Friday 03 October 2025  13:40:37 +0000 (0:00:00.063)       0:00:02.099 ********
===============================================================================
Gathering Facts --------------------------------------------------------- 1.07s
Fetch files stat results ------------------------------------------------ 0.52s
Fetch file content ------------------------------------------------------ 0.34s
Assert expected number of Network Attachment Definitions are created ---- 0.06s
Set _ci_multus_nad variable --------------------------------------------- 0.04s
Assert that expected file exist ----------------------------------------- 0.03s
Load shared variables --------------------------------------------------- 0.02s

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

TASK [Gathering Facts] *********************************************************
Friday 03 October 2025  13:40:38 +0000 (0:00:00.015)       0:00:00.015 ********
ok: [instance]

TASK [Backup NAD before cleanup so they can be inspected in CI] ****************
Friday 03 October 2025  13:40:39 +0000 (0:00:01.092)       0:00:01.108 ********
changed: [instance]

TASK [ci_multus : Cleanup - Fetch NADs in namespace: openstack] ****************
Friday 03 October 2025  13:40:39 +0000 (0:00:00.419)       0:00:01.528 ********
skipping: [instance]

TASK [ci_multus : Cleanup - Delete NADs] ***************************************
Friday 03 October 2025  13:40:39 +0000 (0:00:00.026)       0:00:01.554 ********
skipping: [instance]

TASK [ci_multus : Cleanup - Remove if artifact directory exists] ***************
Friday 03 October 2025  13:40:39 +0000 (0:00:00.044)       0:00:01.598 ********
changed: [instance]

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

Friday 03 October 2025  13:40:40 +0000 (0:00:00.374)       0:00:01.972 ********
===============================================================================
Gathering Facts --------------------------------------------------------- 1.09s
Backup NAD before cleanup so they can be inspected in CI ---------------- 0.42s
ci_multus : Cleanup - Remove if artifact directory exists --------------- 0.37s
ci_multus : Cleanup - Delete NADs --------------------------------------- 0.04s
ci_multus : Cleanup - Fetch NADs in namespace: openstack ---------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Friday 03 October 2025  13:40:40 +0000 (0:00:00.021)       0:00:00.021 ********
ok: [instance]

TASK [Include default vars] ****************************************************
Friday 03 October 2025  13:40:41 +0000 (0:00:01.098)       0:00:01.119 ********
ok: [instance]

TASK [Fetch file stat results] *************************************************
Friday 03 October 2025  13:40:41 +0000 (0:00:00.026)       0:00:01.145 ********
ok: [instance]

TASK [Assert that created file are removed by cleanup] *************************
Friday 03 October 2025  13:40:42 +0000 (0:00:00.340)       0:00:01.486 ********
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

Friday 03 October 2025  13:40:42 +0000 (0:00:00.038)       0:00:01.524 ********
===============================================================================
Gathering Facts --------------------------------------------------------- 1.10s
Fetch file stat results ------------------------------------------------- 0.34s
Assert that created file are removed by cleanup ------------------------- 0.04s
Include default vars ---------------------------------------------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Friday 03 October 2025  13:40:42 +0000 (0:00:00.018)       0:00:00.018 ********
ok: [instance]

TASK [Load shared variables] ***************************************************
Friday 03 October 2025  13:40:44 +0000 (0:00:01.334)       0:00:01.352 ********
ok: [instance]

TASK [Call ci_multus role] *****************************************************
Friday 03 October 2025  13:40:44 +0000 (0:00:00.021)       0:00:01.373 ********

TASK [ci_multus : Create manifests directory] **********************************
Friday 03 October 2025  13:40:44 +0000 (0:00:00.048)       0:00:01.422 ********
changed: [instance]

TASK [networking_mapper : Check for Networking Environment Definition file existence] ***
Friday 03 October 2025  13:40:44 +0000 (0:00:00.392)       0:00:01.815 ********
skipping: [instance]

TASK [networking_mapper : Check for Networking Definition file existance] ******
Friday 03 October 2025  13:40:44 +0000 (0:00:00.043)       0:00:01.858 ********
skipping: [instance]

TASK [networking_mapper : Load the Networking Definition from file] ************
Friday 03 October 2025  13:40:44 +0000 (0:00:00.030)       0:00:01.889 ********
skipping: [instance]

TASK [networking_mapper : Set cifmw_networking_env_definition is present] ******
Friday 03 October 2025  13:40:44 +0000 (0:00:00.032)       0:00:01.921 ********
skipping: [instance]

TASK [ci_multus : Gather network layout from OCP host or default networks] *****
Friday 03 October 2025  13:40:44 +0000 (0:00:00.066)       0:00:01.988 ********
ok: [instance]

TASK [ci_multus : Merge any available multus net info patches] *****************
Friday 03 October 2025  13:40:45 +0000 (0:00:00.068)       0:00:02.056 ********
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] *******
Friday 03 October 2025  13:40:45 +0000 (0:00:00.120)       0:00:02.177 ********
ok: [instance]

TASK [ci_multus : Remove any networks not in cifmw_ci_multus_allow_list if defined] ***
Friday 03 October 2025  13:40:45 +0000 (0:00:00.080)       0:00:02.257 ********
ok: [instance]

TASK [ci_multus : Remove any networks in cifmw_ci_multus_deny_list if defined] ***
Friday 03 October 2025  13:40:45 +0000 (0:00:00.100)       0:00:02.357 ********
ok: [instance]

TASK [ci_multus : Render NetworkAttachmenktDefinition manifests] ***************
Friday 03 October 2025  13:40:45 +0000 (0:00:00.095)       0:00:02.453 ********
changed: [instance]

TASK [ci_multus : Create the multus namespace] *********************************
Friday 03 October 2025  13:40:46 +0000 (0:00:00.787)       0:00:03.240 ********
skipping: [instance]

TASK [ci_multus : Apply network attachment definition manifests] ***************
Friday 03 October 2025  13:40:46 +0000 (0:00:00.028)       0:00:03.269 ********
skipping: [instance]

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

Friday 03 October 2025  13:40:46 +0000 (0:00:00.054)       0:00:03.323 ********
===============================================================================
Gathering Facts --------------------------------------------------------- 1.33s
ci_multus : Render NetworkAttachmenktDefinition manifests --------------- 0.79s
ci_multus : Create manifests directory ---------------------------------- 0.39s
ci_multus : Merge any available multus net info patches ----------------- 0.12s
ci_multus : Remove any networks not in cifmw_ci_multus_allow_list if defined --- 0.10s
ci_multus : Remove any networks in cifmw_ci_multus_deny_list if defined --- 0.10s
ci_multus : Remove any networks without Multus networking 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.05s
Call ci_multus role ----------------------------------------------------- 0.05s
networking_mapper : Check for Networking Environment Definition file existence --- 0.04s
networking_mapper : Load the Networking Definition from file ------------ 0.03s
networking_mapper : Check for Networking Definition file existance ------ 0.03s
ci_multus : Create the multus namespace --------------------------------- 0.03s
Load shared variables --------------------------------------------------- 0.02s

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

TASK [Gathering Facts] *********************************************************
Friday 03 October 2025  13:40:46 +0000 (0:00:00.022)       0:00:00.022 ********
ok: [instance]

TASK [Load shared variables] ***************************************************
Friday 03 October 2025  13:40:48 +0000 (0:00:01.136)       0:00:01.159 ********
ok: [instance]

TASK [Fetch files stat results] ************************************************
Friday 03 October 2025  13:40:48 +0000 (0:00:00.042)       0:00:01.202 ********
ok: [instance]

TASK [Assert that expected file exist] *****************************************
Friday 03 October 2025  13:40:48 +0000 (0:00:00.409)       0:00:01.612 ********
ok: [instance] => changed=false
  msg: All assertions passed

TASK [Fetch file content] ******************************************************
Friday 03 October 2025  13:40:48 +0000 (0:00:00.032)       0:00:01.644 ********
ok: [instance]

TASK [Set _ci_multus_nad variable] *********************************************
Friday 03 October 2025  13:40:48 +0000 (0:00:00.401)       0:00:02.046 ********
ok: [instance]

TASK [Assert expected number of Network Attachment Definitions are created] ****
Friday 03 October 2025  13:40:49 +0000 (0:00:00.057)       0:00:02.103 ********
ok: [instance]

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

Friday 03 October 2025  13:40:49 +0000 (0:00:00.068)       0:00:02.172 ********
===============================================================================
Gathering Facts --------------------------------------------------------- 1.14s
Fetch files stat results ------------------------------------------------ 0.41s
Fetch file content ------------------------------------------------------ 0.40s
Assert expected number of Network Attachment Definitions are created ---- 0.07s
Set _ci_multus_nad variable --------------------------------------------- 0.06s
Load shared variables --------------------------------------------------- 0.04s
Assert that expected file exist ----------------------------------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Friday 03 October 2025  13:40:49 +0000 (0:00:00.016)       0:00:00.016 ********
ok: [instance]

TASK [Backup NAD before cleanup so they can be inspected in CI] ****************
Friday 03 October 2025  13:40:50 +0000 (0:00:01.074)       0:00:01.090 ********
changed: [instance]

TASK [ci_multus : Cleanup - Fetch NADs in namespace: openstack] ****************
Friday 03 October 2025  13:40:51 +0000 (0:00:00.456)       0:00:01.546 ********
skipping: [instance]

TASK [ci_multus : Cleanup - Delete NADs] ***************************************
Friday 03 October 2025  13:40:51 +0000 (0:00:00.032)       0:00:01.579 ********
skipping: [instance]

TASK [ci_multus : Cleanup - Remove if artifact directory exists] ***************
Friday 03 October 2025  13:40:51 +0000 (0:00:00.041)       0:00:01.621 ********
changed: [instance]

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

Friday 03 October 2025  13:40:51 +0000 (0:00:00.440)       0:00:02.061 ********
===============================================================================
Gathering Facts --------------------------------------------------------- 1.07s
Backup NAD before cleanup so they can be inspected in CI ---------------- 0.46s
ci_multus : Cleanup - Remove if artifact directory exists --------------- 0.44s
ci_multus : Cleanup - Delete NADs --------------------------------------- 0.04s
ci_multus : Cleanup - Fetch NADs in namespace: openstack ---------------- 0.03s

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

TASK [Gathering Facts] *********************************************************
Friday 03 October 2025  13:40:52 +0000 (0:00:00.019)       0:00:00.019 ********
ok: [instance]

TASK [Include default vars] ****************************************************
Friday 03 October 2025  13:40:53 +0000 (0:00:01.032)       0:00:01.051 ********
ok: [instance]

TASK [Fetch file stat results] *************************************************
Friday 03 October 2025  13:40:53 +0000 (0:00:00.026)       0:00:01.078 ********
ok: [instance]

TASK [Assert that created file are removed by cleanup] *************************
Friday 03 October 2025  13:40:53 +0000 (0:00:00.347)       0:00:01.425 ********
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

Friday 03 October 2025  13:40:53 +0000 (0:00:00.041)       0:00:01.466 ********
===============================================================================
Gathering Facts --------------------------------------------------------- 1.03s
Fetch file stat results ------------------------------------------------- 0.35s
Assert that created file are removed by cleanup ------------------------- 0.04s
Include default vars ---------------------------------------------------- 0.03s