]) created on node: (an-jenkins-deploy-platform-ansible-os-6357-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6357-2)
2026-10-12 04:19:54,374 - INFO - ================================================================================
2026-10-12 04:19:54,374 - INFO - STARTING TEST : test_check_per_peer_on_control
2026-10-12 04:19:54,374 - INFO - TEST DESCRIPTION :
Description: Verify per peer md5 and specific protocol on all ports and policy with allow all between VN's
2026-10-12 04:19:55,634 - DEBUG - Skipping xmpp flap check
2026-10-12 04:19:55,634 - INFO - Initial checks done. Running the testcase now
2026-10-12 04:19:55,634 - INFO -
2026-10-12 04:19:55,634 - INFO - config per peer with auth_data None
2026-10-12 04:19:56,075 - INFO - configure MD5 on host fd7f0341-7039-4d78-a067-f6660270e448
2026-10-12 04:19:56,143 - INFO - config per peer with auth_data None
2026-10-12 04:19:56,775 - INFO - configure MD5 on host 2752e2ac-14cc-45ae-990a-0e16fc0fbd71
2026-10-12 04:19:56,855 - INFO - config per peer with auth_data None
2026-10-12 04:19:57,455 - INFO - configure MD5 on host 83867e3c-d2bd-45e3-86a1-f3c9df575881
2026-10-12 04:19:57,523 - INFO - check BGP peering is up before setting md5 config
2026-10-12 04:19:57,523 - INFO - Check BGP staus between peers
2026-10-12 04:19:57,534 - INFO - config per peer with auth_data {'key_items': [{'key': 'juniper', 'key_id': 0}], 'key_type': 'md5'}
2026-10-12 04:19:58,031 - INFO - Check BGP staus between peers
2026-10-12 04:19:58,052 - DEBUG - Check the BGP connection on 10.0.0.38
2026-10-12 04:19:58,053 - DEBUG - Check the BGP connection on 10.0.0.38
2026-10-12 04:20:08,053 - INFO - Check BGP staus between peers
2026-10-12 04:20:08,065 - INFO - remove md5 configured on host fd7f0341-7039-4d78-a067-f6660270e448
2026-10-12 04:20:08,065 - INFO - config per peer with auth_data None
2026-10-12 04:20:08,523 - INFO - configure MD5 on host fd7f0341-7039-4d78-a067-f6660270e448
2026-10-12 04:20:08,595 - INFO - remove md5 configured on host 2752e2ac-14cc-45ae-990a-0e16fc0fbd71
2026-10-12 04:20:08,595 - INFO - config per peer with auth_data None
2026-10-12 04:20:09,079 - INFO - configure MD5 on host 2752e2ac-14cc-45ae-990a-0e16fc0fbd71
2026-10-12 04:20:09,155 - INFO - remove md5 configured on host 83867e3c-d2bd-45e3-86a1-f3c9df575881
2026-10-12 04:20:09,155 - INFO - config per peer with auth_data None
2026-10-12 04:20:09,667 - INFO - configure MD5 on host 83867e3c-d2bd-45e3-86a1-f3c9df575881
2026-10-12 04:20:09,739 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD
2026-10-12 04:20:09,739 - INFO - Deleting VM vn2_vm_0
2026-10-12 04:20:09,739 - ERROR - VM vn2_vm_0 has failed to come up
2026-10-12 04:20:09,739 - ERROR - Nova failed to get host of the VM
2026-10-12 04:20:09,739 - ERROR - VM vn2_vm_0 has failed to come up
2026-10-12 04:20:09,739 - ERROR - Nova failed to get host of the VM
2026-10-12 04:20:09,805 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD
2026-10-12 04:20:09,805 - INFO - Deleting VM vn1_vm_0
2026-10-12 04:20:09,805 - ERROR - VM vn1_vm_0 has failed to come up
2026-10-12 04:20:09,805 - ERROR - Nova failed to get host of the VM
2026-10-12 04:20:09,805 - ERROR - VM vn1_vm_0 has failed to come up
2026-10-12 04:20:09,805 - ERROR - Nova failed to get host of the VM
2026-10-12 04:20:09,871 - INFO - Dettaching policy sec_grp_policy_ctest-random-61956890 from vn vn2
2026-10-12 04:20:10,012 - INFO - Dettaching policy sec_grp_policy_ctest-random-61956890 from vn vn1
2026-10-12 04:20:10,231 - INFO - Deleted policy sec_grp_policy_ctest-random-61956890
2026-10-12 04:20:10,231 - INFO - Deleting VN vn2
2026-10-12 04:20:10,261 - DEBUG - VN 450a9089-e433-4d5b-8984-86e38e8037f2 still in use: Unable to complete operation on network 450a9089-e433-4d5b-8984-86e38e8037f2. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-e51206e9-e960-4f4d-9fed-71ba6eb5d3f7']
2026-10-12 04:20:10,261 - WARNING - Deleting VN vn2 failed..Will retry
2026-10-12 04:20:12,301 - DEBUG - VN 450a9089-e433-4d5b-8984-86e38e8037f2 still in use: Unable to complete operation on network 450a9089-e433-4d5b-8984-86e38e8037f2. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-2def523d-e632-49de-84ae-149d59b3a7e1']
2026-10-12 04:20:12,301 - WARNING - Deleting VN vn2 failed..Will retry
2026-10-12 04:20:14,334 - DEBUG - VN 450a9089-e433-4d5b-8984-86e38e8037f2 still in use: Unable to complete operation on network 450a9089-e433-4d5b-8984-86e38e8037f2. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-3f6d8aaf-1748-4d07-9ae0-49a68fc9f225']
2026-10-12 04:20:14,334 - WARNING - Deleting VN vn2 failed..Will retry
2026-10-12 04:20:16,366 - DEBUG - VN 450a9089-e433-4d5b-8984-86e38e8037f2 still in use: Unable to complete operation on network 450a9089-e433-4d5b-8984-86e38e8037f2. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-2e9393ed-dde2-4636-bdb3-9da4c088653c']
2026-10-12 04:20:16,366 - WARNING - Deleting VN vn2 failed..Will retry
2026-10-12 04:20:18,399 - DEBUG - VN 450a9089-e433-4d5b-8984-86e38e8037f2 still in use: Unable to complete operation on network 450a9089-e433-4d5b-8984-86e38e8037f2. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-8e5082fc-c75e-4ac3-8fd2-40dd0e989d56']
2026-10-12 04:20:18,399 - WARNING - Deleting VN vn2 failed..Will retry
2026-10-12 04:20:20,518 - DEBUG - Response for deleting network ()
2026-10-12 04:20:20,518 - INFO - Deleting VN vn1
2026-10-12 04:20:20,642 - DEBUG - Response for deleting network ()
2026-10-12 04:20:20,642 - INFO - Dettaching policy allow_all from vn test_vnv6dn
2026-10-12 04:20:20,803 - INFO - Dettaching policy allow_all from vn test_vnv6sr
2026-10-12 04:20:21,009 - INFO - Deleted policy allow_all
2026-10-12 04:20:21,010 - INFO - Deleting VM dest_vm
2026-10-12 04:20:21,070 - INFO - Deleting VM source_vm
2026-10-12 04:20:21,125 - INFO - Deleting VN test_vnv6dn
2026-10-12 04:20:21,160 - DEBUG - VN d526e039-a932-4ec7-9f08-fa221fa0008c still in use: Unable to complete operation on network d526e039-a932-4ec7-9f08-fa221fa0008c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-ac0e8c33-c004-4a1b-9751-99cfcb49d523']
2026-10-12 04:20:21,160 - WARNING - Deleting VN test_vnv6dn failed..Will retry
2026-10-12 04:20:23,217 - DEBUG - VN d526e039-a932-4ec7-9f08-fa221fa0008c still in use: Unable to complete operation on network d526e039-a932-4ec7-9f08-fa221fa0008c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-688a7e22-1fb6-4297-b474-d6b9c8c65bd4']
2026-10-12 04:20:23,217 - WARNING - Deleting VN test_vnv6dn failed..Will retry
2026-10-12 04:20:25,383 - DEBUG - Response for deleting network ()
2026-10-12 04:20:25,383 - INFO - Deleting VN test_vnv6sr
2026-10-12 04:20:25,554 - DEBUG - Response for deleting network ()
2026-10-12 04:20:26,814 - DEBUG - Skipping xmpp flap check
2026-10-12 04:20:26,814 - INFO - END TEST : test_check_per_peer_on_control : PASSED[0:00:32]
2026-10-12 04:20:26,814 - INFO - --------------------------------------------------------------------------------
2026-10-12 04:20:27,156 - DEBUG - Response for create_network : {'network': {'id': 'd832d8c0-4e42-4524-ad25-30cd8d337b73', 'name': 'test_vnv6sr', 'tenant_id': '97c9130f4f8747d1aae0e1363e1d73c4', 'project_id': '97c9130f4f8747d1aae0e1363e1d73c4', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-22700180', 'test_vnv6sr'], 'port_security_enabled': True, 'description': ''}}
2026-10-12 04:20:27,356 - DEBUG - Response for create_subnet : {'subnet': {'id': '65742ae6-b820-4ce1-ad33-acce03786edb', 'name': '', 'tenant_id': '97c9130f4f8747d1aae0e1363e1d73c4', 'network_id': 'd832d8c0-4e42-4524-ad25-30cd8d337b73', 'ip_version': 6, 'cidr': '2001::101:0/120', 'allocation_pools': [{'start': '2001::101:2', 'end': '2001::101:fe'}], 'gateway_ip': '2001::101:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '2001::101:2', 'tags': [], 'project_id': '97c9130f4f8747d1aae0e1363e1d73c4'}}
2026-10-12 04:20:27,570 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c2a43d4c-65ae-4351-9551-73ac1086fdef', 'name': '', 'tenant_id': '97c9130f4f8747d1aae0e1363e1d73c4', 'network_id': 'd832d8c0-4e42-4524-ad25-30cd8d337b73', 'ip_version': 4, 'cidr': '155.180.190.0/26', 'allocation_pools': [{'start': '155.180.190.2', 'end': '155.180.190.62'}], 'gateway_ip': '155.180.190.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '155.180.190.2', 'tags': [], 'project_id': '97c9130f4f8747d1aae0e1363e1d73c4'}}
2026-10-12 04:20:27,597 - INFO - Created VN test_vnv6sr
2026-10-12 04:20:27,607 - DEBUG - VN test_vnv6sr UUID is d832d8c0-4e42-4524-ad25-30cd8d337b73
2026-10-12 04:20:27,966 - DEBUG - Response for create_network : {'network': {'id': '7727e9b4-b4c6-4843-b16b-3718873d2f6a', 'name': 'test_vnv6dn', 'tenant_id': '97c9130f4f8747d1aae0e1363e1d73c4', 'project_id': '97c9130f4f8747d1aae0e1363e1d73c4', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-22700180', 'test_vnv6dn'], 'port_security_enabled': True, 'description': ''}}
2026-10-12 04:20:28,211 - DEBUG - Response for create_subnet : {'subnet': {'id': '962b0959-8e51-4ecb-a459-530a922fd14f', 'name': '', 'tenant_id': '97c9130f4f8747d1aae0e1363e1d73c4', 'network_id': '7727e9b4-b4c6-4843-b16b-3718873d2f6a', 'ip_version': 6, 'cidr': '2001::201:0/120', 'allocation_pools': [{'start': '2001::201:2', 'end': '2001::201:fe'}], 'gateway_ip': '2001::201:1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '2001::201:2', 'tags': [], 'project_id': '97c9130f4f8747d1aae0e1363e1d73c4'}}
2026-10-12 04:20:28,369 - DEBUG - Response for create_subnet : {'subnet': {'id': '3cc8a386-1fbf-4b92-892c-4eebd040cb8c', 'name': '', 'tenant_id': '97c9130f4f8747d1aae0e1363e1d73c4', 'network_id': '7727e9b4-b4c6-4843-b16b-3718873d2f6a', 'ip_version': 4, 'cidr': '92.103.126.0/26', 'allocation_pools': [{'start': '92.103.126.2', 'end': '92.103.126.62'}], 'gateway_ip': '92.103.126.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '92.103.126.2', 'tags': [], 'project_id': '97c9130f4f8747d1aae0e1363e1d73c4'}}
2026-10-12 04:20:28,387 - INFO - Created VN test_vnv6dn
2026-10-12 04:20:28,396 - DEBUG - VN test_vnv6dn UUID is 7727e9b4-b4c6-4843-b16b-3718873d2f6a
2026-10-12 04:20:28,851 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6357-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6357-1)
2026-10-12 04:20:29,339 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6357-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6357-2)
2026-10-12 04:20:29,340 - INFO - Waiting for VM source_vm to be up..
2026-10-12 04:20:29,387 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-12 04:20:34,472 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-12 04:20:39,539 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-12 04:20:44,610 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-12 04:20:49,678 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-12 04:20:54,747 - DEBUG - VM is in ACTIVE state now
2026-10-12 04:20:54,747 - INFO - VM name : source_vm
2026-10-12 04:20:54,813 - DEBUG - VM source_vm ID is 60db13de-84d1-4636-968e-2f3088bb32aa
2026-10-12 04:20:54,813 - DEBUG - VM source_vm launched on Node an-jenkins-deploy-platform-ansible-os-6357-1
2026-10-12 04:20:54,883 - DEBUG - Requesting: http://10.0.0.191:8082/virtual-machine/60db13de-84d1-4636-968e-2f3088bb32aa
2026-10-12 04:20:54,891 - DEBUG - Requesting: http://10.0.0.191:8082/virtual-machine-interface/a9cbf57f-fdff-4f2a-911b-4755a7bb4b49
2026-10-12 04:20:58,046 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1007ms')
2026-10-12 04:20:58,046 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM source_vm failed!
2026-10-12 04:20:58,058 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-22700180:test_vnv6sr is 2001::101:1 and allocation pool is NOT set
2026-10-12 04:20:58,058 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-22700180:test_vnv6sr is 155.180.190.1 and allocation pool is NOT set
2026-10-12 04:21:00,130 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=12.4 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.360 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.360/6.394/12.428/6.034 ms')
2026-10-12 04:21:00,130 - INFO - Ping to Metadata IP 169.254.0.3 of VM source_vm passed
2026-10-12 04:21:00,193 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-10-12 04:21:00,193 - DEBUG - Waiting to SSH to VM source_vm, IP 155.180.190.3, Port 22
2026-10-12 04:21:00,363 - DEBUG - VM source_vm is ready for SSH connections
2026-10-12 04:21:00,363 - INFO - Waiting for VM dest_vm to be up..
2026-10-12 04:21:00,447 - DEBUG - VM is in ACTIVE state now
2026-10-12 04:21:00,447 - INFO - VM name : dest_vm
2026-10-12 04:21:00,517 - DEBUG - VM dest_vm ID is 520c77d7-565d-4fa8-8897-d8a289c77dbf
2026-10-12 04:21:00,517 - DEBUG - VM dest_vm launched on Node an-jenkins-deploy-platform-ansible-os-6357-2
2026-10-12 04:21:00,588 - DEBUG - Requesting: http://10.0.0.191:8082/virtual-machine/520c77d7-565d-4fa8-8897-d8a289c77dbf
2026-10-12 04:21:00,597 - DEBUG - Requesting: http://10.0.0.191:8082/virtual-machine-interface/4f1eabaa-731f-4ea6-a06c-794bc55b1647
2026-10-12 04:21:01,743 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=3.53 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.466 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.466/1.996/3.526/1.530 ms')
2026-10-12 04:21:01,743 - INFO - Ping to Metadata IP 169.254.0.3 of VM dest_vm passed
2026-10-12 04:21:01,805 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-10-12 04:21:01,806 - DEBUG - Waiting to SSH to VM dest_vm, IP 92.103.126.3, Port 22
2026-10-12 04:21:01,976 - DEBUG - VM dest_vm is ready for SSH connections
2026-10-12 04:21:01,981 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-22700180:test_vnv6sr, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-22700180:test_vnv6dn, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None]
2026-10-12 04:21:02,293 - INFO - Attaching policy allow_all to vn test_vnv6sr
2026-10-12 04:21:02,625 - INFO - Attaching policy allow_all to vn test_vnv6dn
2026-10-12 04:21:02,871 - INFO - Configure the policy with allow any
2026-10-12 04:21:03,164 - DEBUG - Response for create_network : {'network': {'id': 'f0124dbf-9806-4c5d-aa28-125322d520be', 'name': 'vn1', 'tenant_id': '97c9130f4f8747d1aae0e1363e1d73c4', 'project_id': '97c9130f4f8747d1aae0e1363e1d73c4', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-22700180', 'vn1'], 'port_security_enabled': True, 'description': ''}}
2026-10-12 04:21:03,417 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd28b1b22-d337-419c-98e8-9ae1b8a0aa04', 'name': '', 'tenant_id': '97c9130f4f8747d1aae0e1363e1d73c4', 'network_id': 'f0124dbf-9806-4c5d-aa28-125322d520be', 'ip_version': 4, 'cidr': '10.1.1.0/24', 'allocation_pools': [{'start': '10.1.1.2', 'end': '10.1.1.254'}], 'gateway_ip': '10.1.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '10.1.1.2', 'tags': [], 'project_id': '97c9130f4f8747d1aae0e1363e1d73c4'}}
2026-10-12 04:21:03,437 - INFO - Created VN vn1
2026-10-12 04:21:03,448 - DEBUG - VN vn1 UUID is f0124dbf-9806-4c5d-aa28-125322d520be
2026-10-12 04:21:03,759 - DEBUG - Response for create_network : {'network': {'id': '4ce460a0-ca3a-4bb6-b4a6-661f9c0bd4db', 'name': 'vn2', 'tenant_id': '97c9130f4f8747d1aae0e1363e1d73c4', 'project_id': '97c9130f4f8747d1aae0e1363e1d73c4', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-22700180', 'vn2'], 'port_security_enabled': True, 'description': ''}}
2026-10-12 04:21:04,002 - DEBUG - Response for create_subnet : {'subnet': {'id': '6efe1af6-582f-47d4-8c0d-343ae23585d7', 'name': '', 'tenant_id': '97c9130f4f8747d1aae0e1363e1d73c4', 'network_id': '4ce460a0-ca3a-4bb6-b4a6-661f9c0bd4db', 'ip_version': 4, 'cidr': '20.1.1.0/24', 'allocation_pools': [{'start': '20.1.1.2', 'end': '20.1.1.254'}], 'gateway_ip': '20.1.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '20.1.1.2', 'tags': [], 'project_id': '97c9130f4f8747d1aae0e1363e1d73c4'}}
2026-10-12 04:21:04,020 - INFO - Created VN vn2
2026-10-12 04:21:04,029 - DEBUG - VN vn2 UUID is 4ce460a0-ca3a-4bb6-b4a6-661f9c0bd4db
2026-10-12 04:21:04,127 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-22700180:vn1, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-22700180:vn2, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None]
2026-10-12 04:21:04,440 - INFO - Attaching policy sec_grp_policy_ctest-random-95351225 to vn vn1
2026-10-12 04:21:04,763 - INFO - Attaching policy sec_grp_policy_ctest-random-95351225 to vn vn2
2026-10-12 04:21:05,520 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6357-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6357-1)
2026-10-12 04:21:05,992 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6357-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6357-2)
2026-10-12 04:21:06,048 - INFO - ================================================================================
2026-10-12 04:21:06,049 - INFO - STARTING TEST : test_create_md5_on_control
2026-10-12 04:21:06,049 - INFO - TEST DESCRIPTION :
Description: Verify md5 with allow specific protocol on all ports and policy with allow all between VN's
2026-10-12 04:21:07,302 - DEBUG - Skipping xmpp flap check
2026-10-12 04:21:07,302 - INFO - Initial checks done. Running the testcase now
2026-10-12 04:21:07,302 - INFO -
2026-10-12 04:21:07,302 - INFO - config md5 on each host with auth_data None
2026-10-12 04:21:07,303 - INFO - config per peer with auth_data None
2026-10-12 04:21:07,755 - INFO - configure MD5 on host fd7f0341-7039-4d78-a067-f6660270e448
2026-10-12 04:21:07,827 - INFO - config per peer with auth_data None
2026-10-12 04:21:08,303 - INFO - configure MD5 on host 2752e2ac-14cc-45ae-990a-0e16fc0fbd71
2026-10-12 04:21:08,375 - INFO - config per peer with auth_data None
2026-10-12 04:21:08,847 - INFO - configure MD5 on host 83867e3c-d2bd-45e3-86a1-f3c9df575881
2026-10-12 04:21:08,923 - INFO - check if BGP between peers are up before setting md5
2026-10-12 04:21:08,923 - INFO - Check BGP staus between peers
2026-10-12 04:21:08,932 - INFO - setting MD5 config on host fd7f0341-7039-4d78-a067-f6660270e448
2026-10-12 04:21:08,932 - INFO - configure MD5 on host fd7f0341-7039-4d78-a067-f6660270e448
2026-10-12 04:21:08,999 - INFO - setting MD5 config on host 2752e2ac-14cc-45ae-990a-0e16fc0fbd71
2026-10-12 04:21:08,999 - INFO - configure MD5 on host 2752e2ac-14cc-45ae-990a-0e16fc0fbd71
2026-10-12 04:21:09,067 - INFO - setting MD5 config on host 83867e3c-d2bd-45e3-86a1-f3c9df575881
2026-10-12 04:21:09,067 - INFO - configure MD5 on host 83867e3c-d2bd-45e3-86a1-f3c9df575881
2026-10-12 04:21:09,143 - INFO - check if BGP peering is up after md5 config
2026-10-12 04:21:09,143 - INFO - Check BGP staus between peers
2026-10-12 04:21:09,152 - DEBUG - Check the BGP connection on 10.0.0.38
2026-10-12 04:21:09,152 - DEBUG - Check the BGP connection on 10.0.0.38
2026-10-12 04:21:19,152 - INFO - Check BGP staus between peers
2026-10-12 04:21:19,164 - INFO - remove md5 configured on host fd7f0341-7039-4d78-a067-f6660270e448
2026-10-12 04:21:19,164 - INFO - config per peer with auth_data None
2026-10-12 04:21:19,615 - INFO - configure MD5 on host fd7f0341-7039-4d78-a067-f6660270e448
2026-10-12 04:21:19,691 - INFO - remove md5 configured on host 2752e2ac-14cc-45ae-990a-0e16fc0fbd71
2026-10-12 04:21:19,691 - INFO - config per peer with auth_data None
2026-10-12 04:21:20,167 - INFO - configure MD5 on host 2752e2ac-14cc-45ae-990a-0e16fc0fbd71
2026-10-12 04:21:20,243 - INFO - remove md5 configured on host 83867e3c-d2bd-45e3-86a1-f3c9df575881
2026-10-12 04:21:20,243 - INFO - config per peer with auth_data None
2026-10-12 04:21:20,719 - INFO - configure MD5 on host 83867e3c-d2bd-45e3-86a1-f3c9df575881
2026-10-12 04:21:20,787 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD
2026-10-12 04:21:20,787 - INFO - Deleting VM vn2_vm_0
2026-10-12 04:21:20,787 - ERROR - VM vn2_vm_0 has failed to come up
2026-10-12 04:21:20,787 - ERROR - Nova failed to get host of the VM
2026-10-12 04:21:20,787 - ERROR - VM vn2_vm_0 has failed to come up
2026-10-12 04:21:20,787 - ERROR - Nova failed to get host of the VM
2026-10-12 04:21:20,850 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD
2026-10-12 04:21:20,850 - INFO - Deleting VM vn1_vm_0
2026-10-12 04:21:20,850 - ERROR - VM vn1_vm_0 has failed to come up
2026-10-12 04:21:20,850 - ERROR - Nova failed to get host of the VM
2026-10-12 04:21:20,850 - ERROR - VM vn1_vm_0 has failed to come up
2026-10-12 04:21:20,851 - ERROR - Nova failed to get host of the VM
2026-10-12 04:21:20,916 - INFO - Dettaching policy sec_grp_policy_ctest-random-95351225 from vn vn2
2026-10-12 04:21:21,093 - INFO - Dettaching policy sec_grp_policy_ctest-random-95351225 from vn vn1
2026-10-12 04:21:21,313 - INFO - Deleted policy sec_grp_policy_ctest-random-95351225
2026-10-12 04:21:21,314 - INFO - Deleting VN vn2
2026-10-12 04:21:21,350 - DEBUG - VN 4ce460a0-ca3a-4bb6-b4a6-661f9c0bd4db still in use: Unable to complete operation on network 4ce460a0-ca3a-4bb6-b4a6-661f9c0bd4db. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-10bd9e84-5def-4e74-8ad6-61cf65ecec5e']
2026-10-12 04:21:21,350 - WARNING - Deleting VN vn2 failed..Will retry
2026-10-12 04:21:23,385 - DEBUG - VN 4ce460a0-ca3a-4bb6-b4a6-661f9c0bd4db still in use: Unable to complete operation on network 4ce460a0-ca3a-4bb6-b4a6-661f9c0bd4db. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-98d2383d-66ff-4f20-97f2-3b74d8054db0']
2026-10-12 04:21:23,386 - WARNING - Deleting VN vn2 failed..Will retry
2026-10-12 04:21:25,428 - DEBUG - VN 4ce460a0-ca3a-4bb6-b4a6-661f9c0bd4db still in use: Unable to complete operation on network 4ce460a0-ca3a-4bb6-b4a6-661f9c0bd4db. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-a01e41f8-3100-48af-b003-c52ef17629b9']
2026-10-12 04:21:25,428 - WARNING - Deleting VN vn2 failed..Will retry
2026-10-12 04:21:27,479 - DEBUG - VN 4ce460a0-ca3a-4bb6-b4a6-661f9c0bd4db still in use: Unable to complete operation on network 4ce460a0-ca3a-4bb6-b4a6-661f9c0bd4db. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-c00b06b7-0ec4-446d-b2a8-f528d89ac85e']
2026-10-12 04:21:27,479 - WARNING - Deleting VN vn2 failed..Will retry
2026-10-12 04:21:29,517 - DEBUG - VN 4ce460a0-ca3a-4bb6-b4a6-661f9c0bd4db still in use: Unable to complete operation on network 4ce460a0-ca3a-4bb6-b4a6-661f9c0bd4db. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-b62eac46-7316-4d38-93d4-3537d87c0bf0']
2026-10-12 04:21:29,517 - WARNING - Deleting VN vn2 failed..Will retry
2026-10-12 04:21:31,556 - DEBUG - VN 4ce460a0-ca3a-4bb6-b4a6-661f9c0bd4db still in use: Unable to complete operation on network 4ce460a0-ca3a-4bb6-b4a6-661f9c0bd4db. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-a50b7974-b5f2-4c77-8868-c65d361b0d84']
2026-10-12 04:21:31,556 - WARNING - Deleting VN vn2 failed..Will retry
2026-10-12 04:21:33,679 - DEBUG - Response for deleting network ()
2026-10-12 04:21:33,679 - INFO - Deleting VN vn1
2026-10-12 04:21:33,821 - DEBUG - Response for deleting network ()
2026-10-12 04:21:33,821 - INFO - Dettaching policy allow_all from vn test_vnv6dn
2026-10-12 04:21:33,988 - INFO - Dettaching policy allow_all from vn test_vnv6sr
2026-10-12 04:21:34,187 - INFO - Deleted policy allow_all
2026-10-12 04:21:34,187 - INFO - Deleting VM dest_vm
2026-10-12 04:21:34,254 - INFO - Deleting VM source_vm
2026-10-12 04:21:34,325 - INFO - Deleting VN test_vnv6dn
2026-10-12 04:21:34,363 - DEBUG - VN 7727e9b4-b4c6-4843-b16b-3718873d2f6a still in use: Unable to complete operation on network 7727e9b4-b4c6-4843-b16b-3718873d2f6a. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-b984e875-1dde-4b95-96be-92baefb7c634']
2026-10-12 04:21:34,363 - WARNING - Deleting VN test_vnv6dn failed..Will retry
2026-10-12 04:21:36,425 - DEBUG - VN 7727e9b4-b4c6-4843-b16b-3718873d2f6a still in use: Unable to complete operation on network 7727e9b4-b4c6-4843-b16b-3718873d2f6a. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-9fe694a3-52a3-48d7-be4a-4f07f33b7071']
2026-10-12 04:21:36,426 - WARNING - Deleting VN test_vnv6dn failed..Will retry
2026-10-12 04:21:38,574 - DEBUG - Response for deleting network ()
2026-10-12 04:21:38,574 - INFO - Deleting VN test_vnv6sr
2026-10-12 04:21:38,701 - DEBUG - Response for deleting network ()
2026-10-12 04:21:39,970 - DEBUG - Skipping xmpp flap check
2026-10-12 04:21:39,970 - INFO - END TEST : test_create_md5_on_control : PASSED[0:00:33]
2026-10-12 04:21:39,970 - INFO - --------------------------------------------------------------------------------
2026-10-12 04:21:40,766 - INFO - Deleted project: ctest-TestMd5testsOnControl-22700180, ID : 97c9130f-4f87-47d1-aae0-e1363e1d73c4