2026-06-18 17:10:23,689 - INFO - Domain Default found not creating
2026-06-18 17:10:23,823 - INFO - Project ctest-TestMd5testsOnControl-10643293 not found, creating it
2026-06-18 17:10:24,342 - INFO - Created Project:ctest-TestMd5testsOnControl-10643293, ID : 4ce1a13a-1474-4045-bb48-f6bad661e860
2026-06-18 17:10:26,480 - DEBUG - Response for create_network : {'network': {'id': 'f66b1ff2-5d3d-46bd-91c9-1069fe9c9d81', 'name': 'test_vnv6sr', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'project_id': '4ce1a13a14744045bb48f6bad661e860', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-10643293', 'test_vnv6sr'], 'port_security_enabled': True, 'description': ''}}
2026-06-18 17:10:26,780 - DEBUG - Response for create_subnet : {'subnet': {'id': '53dd1baa-665b-497e-8cd4-6970c4ed1394', 'name': '', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'network_id': 'f66b1ff2-5d3d-46bd-91c9-1069fe9c9d81', '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': '4ce1a13a14744045bb48f6bad661e860'}}
2026-06-18 17:10:26,997 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e42d9aae-4cc6-4e81-8328-4f89a65aa2b2', 'name': '', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'network_id': 'f66b1ff2-5d3d-46bd-91c9-1069fe9c9d81', 'ip_version': 4, 'cidr': '36.233.126.64/26', 'allocation_pools': [{'start': '36.233.126.66', 'end': '36.233.126.126'}], 'gateway_ip': '36.233.126.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '36.233.126.66', 'tags': [], 'project_id': '4ce1a13a14744045bb48f6bad661e860'}}
2026-06-18 17:10:27,017 - INFO - Created VN test_vnv6sr
2026-06-18 17:10:27,027 - DEBUG - VN test_vnv6sr UUID is f66b1ff2-5d3d-46bd-91c9-1069fe9c9d81
2026-06-18 17:10:27,373 - DEBUG - Response for create_network : {'network': {'id': '5fba00b8-753f-4e2b-9734-50abe0abf93b', 'name': 'test_vnv6dn', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'project_id': '4ce1a13a14744045bb48f6bad661e860', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-10643293', 'test_vnv6dn'], 'port_security_enabled': True, 'description': ''}}
2026-06-18 17:10:27,638 - DEBUG - Response for create_subnet : {'subnet': {'id': '5b967b8f-6d96-4954-be70-5bc37cca7c23', 'name': '', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'network_id': '5fba00b8-753f-4e2b-9734-50abe0abf93b', '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': '4ce1a13a14744045bb48f6bad661e860'}}
2026-06-18 17:10:27,811 - DEBUG - Response for create_subnet : {'subnet': {'id': '42f396d8-ac33-4b6f-8956-00168c8571c2', 'name': '', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'network_id': '5fba00b8-753f-4e2b-9734-50abe0abf93b', 'ip_version': 4, 'cidr': '211.54.25.192/26', 'allocation_pools': [{'start': '211.54.25.194', 'end': '211.54.25.254'}], 'gateway_ip': '211.54.25.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '211.54.25.194', 'tags': [], 'project_id': '4ce1a13a14744045bb48f6bad661e860'}}
2026-06-18 17:10:27,831 - INFO - Created VN test_vnv6dn
2026-06-18 17:10:27,844 - DEBUG - VN test_vnv6dn UUID is 5fba00b8-753f-4e2b-9734-50abe0abf93b
2026-06-18 17:10:28,029 - DEBUG - Services list from nova: [, , , ]
2026-06-18 17:10:29,189 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5988-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5988-1)
2026-06-18 17:10:30,339 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5988-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5988-2)
2026-06-18 17:10:30,339 - INFO - Waiting for VM source_vm to be up..
2026-06-18 17:10:30,388 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-18 17:10:35,470 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-18 17:10:40,543 - DEBUG - VM is in ACTIVE state now
2026-06-18 17:10:40,543 - INFO - VM name : source_vm
2026-06-18 17:10:40,610 - DEBUG - VM source_vm ID is 4b3dd91d-222a-4e7b-b3bf-a678410480dd
2026-06-18 17:10:40,632 - DEBUG - VM source_vm launched on Node an-jenkins-deploy-platform-ansible-os-5988-1
2026-06-18 17:10:40,705 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/4b3dd91d-222a-4e7b-b3bf-a678410480dd
2026-06-18 17:10:41,038 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/4b3dd91d-222a-4e7b-b3bf-a678410480dd
2026-06-18 17:10:41,087 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/8629f9b2-fe81-4466-8789-a8e282060f38
2026-06-18 17:10:44,273 - 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 1002ms')
2026-06-18 17:10:44,273 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM source_vm failed!
2026-06-18 17:10:44,287 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-10643293:test_vnv6sr is 2001::101:1 and allocation pool is NOT set
2026-06-18 17:10:44,287 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-10643293:test_vnv6sr is 36.233.126.65 and allocation pool is NOT set
2026-06-18 17:10:46,354 - 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.82 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.323 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.323/2.069/3.815/1.746 ms')
2026-06-18 17:10:46,354 - INFO - Ping to Metadata IP 169.254.0.3 of VM source_vm passed
2026-06-18 17:10:46,422 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-18 17:10:46,422 - DEBUG - Waiting to SSH to VM source_vm, IP 36.233.126.67, Port 22
2026-06-18 17:10:46,587 - DEBUG - VM source_vm is ready for SSH connections
2026-06-18 17:10:46,587 - INFO - Waiting for VM dest_vm to be up..
2026-06-18 17:10:46,660 - DEBUG - VM is in ACTIVE state now
2026-06-18 17:10:46,661 - INFO - VM name : dest_vm
2026-06-18 17:10:46,734 - DEBUG - VM dest_vm ID is 2f4c4312-3754-481a-9326-ee5a999a93ee
2026-06-18 17:10:46,734 - DEBUG - VM dest_vm launched on Node an-jenkins-deploy-platform-ansible-os-5988-2
2026-06-18 17:10:46,803 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/2f4c4312-3754-481a-9326-ee5a999a93ee
2026-06-18 17:10:46,813 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/71faf171-9789-450b-a31e-f6e171994414
2026-06-18 17:10:47,960 - 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.30 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.358 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.358/1.826/3.295/1.468 ms')
2026-06-18 17:10:47,960 - INFO - Ping to Metadata IP 169.254.0.3 of VM dest_vm passed
2026-06-18 17:10:48,026 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-18 17:10:48,026 - DEBUG - Waiting to SSH to VM dest_vm, IP 211.54.25.195, Port 22
2026-06-18 17:10:48,196 - DEBUG - VM dest_vm is ready for SSH connections
2026-06-18 17:10:48,202 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-10643293: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-10643293: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-06-18 17:10:48,552 - INFO - Attaching policy allow_all to vn test_vnv6sr
2026-06-18 17:10:48,896 - INFO - Attaching policy allow_all to vn test_vnv6dn
2026-06-18 17:10:49,153 - INFO - Configure the policy with allow any
2026-06-18 17:10:49,462 - DEBUG - Response for create_network : {'network': {'id': '4f8e9591-d17a-4591-a063-35f3f0d08b23', 'name': 'vn1', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'project_id': '4ce1a13a14744045bb48f6bad661e860', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-10643293', 'vn1'], 'port_security_enabled': True, 'description': ''}}
2026-06-18 17:10:49,674 - DEBUG - Response for create_subnet : {'subnet': {'id': '546e50e0-8fc9-48ac-b744-6ad925863430', 'name': '', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'network_id': '4f8e9591-d17a-4591-a063-35f3f0d08b23', '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': '4ce1a13a14744045bb48f6bad661e860'}}
2026-06-18 17:10:49,698 - INFO - Created VN vn1
2026-06-18 17:10:49,733 - DEBUG - VN vn1 UUID is 4f8e9591-d17a-4591-a063-35f3f0d08b23
2026-06-18 17:10:50,124 - DEBUG - Response for create_network : {'network': {'id': 'f22a6ef6-f603-4bec-bf42-0386fca18eaf', 'name': 'vn2', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'project_id': '4ce1a13a14744045bb48f6bad661e860', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-10643293', 'vn2'], 'port_security_enabled': True, 'description': ''}}
2026-06-18 17:10:50,311 - DEBUG - Response for create_subnet : {'subnet': {'id': '3126f515-4629-48e3-af6f-0301b4fd4ba8', 'name': '', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'network_id': 'f22a6ef6-f603-4bec-bf42-0386fca18eaf', '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': '4ce1a13a14744045bb48f6bad661e860'}}
2026-06-18 17:10:50,328 - INFO - Created VN vn2
2026-06-18 17:10:50,380 - DEBUG - VN vn2 UUID is f22a6ef6-f603-4bec-bf42-0386fca18eaf
2026-06-18 17:10:50,490 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-10643293: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-10643293: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-06-18 17:10:50,808 - INFO - Attaching policy sec_grp_policy_ctest-random-50282485 to vn vn1
2026-06-18 17:10:51,168 - INFO - Attaching policy sec_grp_policy_ctest-random-50282485 to vn vn2
2026-06-18 17:10:52,654 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5988-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5988-1)
2026-06-18 17:10:54,341 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5988-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5988-2)
2026-06-18 17:10:54,414 - INFO - ================================================================================
2026-06-18 17:10:54,414 - INFO - STARTING TEST : test_check_per_peer_on_control
2026-06-18 17:10:54,414 - INFO - TEST DESCRIPTION :
Description: Verify per peer md5 and specific protocol on all ports and policy with allow all between VN's
2026-06-18 17:10:55,662 - DEBUG - Skipping xmpp flap check
2026-06-18 17:10:55,662 - INFO - Initial checks done. Running the testcase now
2026-06-18 17:10:55,662 - INFO -
2026-06-18 17:10:55,662 - INFO - config per peer with auth_data None
2026-06-18 17:10:56,174 - INFO - configure MD5 on host cc1f258c-a947-4526-9c20-d29ffe6897ad
2026-06-18 17:10:56,262 - INFO - config per peer with auth_data None
2026-06-18 17:10:56,794 - INFO - configure MD5 on host 0bbda49c-85cb-47be-8284-884f4eb6b692
2026-06-18 17:10:56,874 - INFO - config per peer with auth_data None
2026-06-18 17:10:57,530 - INFO - configure MD5 on host d7481530-c73f-4427-bb07-50b5c40c2fbc
2026-06-18 17:10:57,614 - INFO - check BGP peering is up before setting md5 config
2026-06-18 17:10:57,614 - INFO - Check BGP staus between peers
2026-06-18 17:10:57,623 - INFO - config per peer with auth_data {'key_items': [{'key': 'juniper', 'key_id': 0}], 'key_type': 'md5'}
2026-06-18 17:10:58,202 - INFO - Check BGP staus between peers
2026-06-18 17:10:58,212 - DEBUG - Check the BGP connection on 10.0.0.249
2026-06-18 17:10:58,212 - DEBUG - Check the BGP connection on 10.0.0.249
2026-06-18 17:11:08,212 - INFO - Check BGP staus between peers
2026-06-18 17:11:08,221 - INFO - remove md5 configured on host cc1f258c-a947-4526-9c20-d29ffe6897ad
2026-06-18 17:11:08,221 - INFO - config per peer with auth_data None
2026-06-18 17:11:08,766 - INFO - configure MD5 on host cc1f258c-a947-4526-9c20-d29ffe6897ad
2026-06-18 17:11:08,862 - INFO - remove md5 configured on host 0bbda49c-85cb-47be-8284-884f4eb6b692
2026-06-18 17:11:08,862 - INFO - config per peer with auth_data None
2026-06-18 17:11:09,474 - INFO - configure MD5 on host 0bbda49c-85cb-47be-8284-884f4eb6b692
2026-06-18 17:11:09,554 - INFO - remove md5 configured on host d7481530-c73f-4427-bb07-50b5c40c2fbc
2026-06-18 17:11:09,554 - INFO - config per peer with auth_data None
2026-06-18 17:11:10,130 - INFO - configure MD5 on host d7481530-c73f-4427-bb07-50b5c40c2fbc
2026-06-18 17:11:10,218 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD
2026-06-18 17:11:10,218 - INFO - Deleting VM vn2_vm_0
2026-06-18 17:11:10,218 - ERROR - VM vn2_vm_0 has failed to come up
2026-06-18 17:11:10,218 - ERROR - Nova failed to get host of the VM
2026-06-18 17:11:10,219 - ERROR - VM vn2_vm_0 has failed to come up
2026-06-18 17:11:10,219 - ERROR - Nova failed to get host of the VM
2026-06-18 17:11:10,309 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD
2026-06-18 17:11:10,309 - INFO - Deleting VM vn1_vm_0
2026-06-18 17:11:10,309 - ERROR - VM vn1_vm_0 has failed to come up
2026-06-18 17:11:10,309 - ERROR - Nova failed to get host of the VM
2026-06-18 17:11:10,309 - ERROR - VM vn1_vm_0 has failed to come up
2026-06-18 17:11:10,309 - ERROR - Nova failed to get host of the VM
2026-06-18 17:11:10,385 - INFO - Dettaching policy sec_grp_policy_ctest-random-50282485 from vn vn2
2026-06-18 17:11:10,528 - INFO - Dettaching policy sec_grp_policy_ctest-random-50282485 from vn vn1
2026-06-18 17:11:10,768 - INFO - Deleted policy sec_grp_policy_ctest-random-50282485
2026-06-18 17:11:10,768 - INFO - Deleting VN vn2
2026-06-18 17:11:10,871 - DEBUG - VN f22a6ef6-f603-4bec-bf42-0386fca18eaf still in use: Unable to complete operation on network f22a6ef6-f603-4bec-bf42-0386fca18eaf. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-0d47171f-fea2-4737-98d5-3df671585c04']
2026-06-18 17:11:10,871 - WARNING - Deleting VN vn2 failed..Will retry
2026-06-18 17:11:12,995 - DEBUG - Response for deleting network ()
2026-06-18 17:11:12,995 - INFO - Deleting VN vn1
2026-06-18 17:11:13,123 - DEBUG - Response for deleting network ()
2026-06-18 17:11:13,123 - INFO - Dettaching policy allow_all from vn test_vnv6dn
2026-06-18 17:11:13,325 - INFO - Dettaching policy allow_all from vn test_vnv6sr
2026-06-18 17:11:13,566 - INFO - Deleted policy allow_all
2026-06-18 17:11:13,566 - INFO - Deleting VM dest_vm
2026-06-18 17:11:13,635 - INFO - Deleting VM source_vm
2026-06-18 17:11:13,700 - INFO - Deleting VN test_vnv6dn
2026-06-18 17:11:13,739 - DEBUG - VN 5fba00b8-753f-4e2b-9734-50abe0abf93b still in use: Unable to complete operation on network 5fba00b8-753f-4e2b-9734-50abe0abf93b. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-f8c64ef8-85bf-4e41-a5e2-c8bda9c8e09f']
2026-06-18 17:11:13,739 - WARNING - Deleting VN test_vnv6dn failed..Will retry
2026-06-18 17:11:15,802 - DEBUG - VN 5fba00b8-753f-4e2b-9734-50abe0abf93b still in use: Unable to complete operation on network 5fba00b8-753f-4e2b-9734-50abe0abf93b. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-465a2a0c-2b0a-44e0-9f18-f747a78147f9']
2026-06-18 17:11:15,802 - WARNING - Deleting VN test_vnv6dn failed..Will retry
2026-06-18 17:11:17,968 - DEBUG - Response for deleting network ()
2026-06-18 17:11:17,968 - INFO - Deleting VN test_vnv6sr
2026-06-18 17:11:18,129 - DEBUG - Response for deleting network ()
2026-06-18 17:11:19,378 - DEBUG - Skipping xmpp flap check
2026-06-18 17:11:19,378 - INFO - END TEST : test_check_per_peer_on_control : PASSED[0:00:25]
2026-06-18 17:11:19,378 - INFO - --------------------------------------------------------------------------------
2026-06-18 17:11:19,636 - DEBUG - Response for create_network : {'network': {'id': 'db0348e3-d12c-45ed-8884-f48bf35eb774', 'name': 'test_vnv6sr', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'project_id': '4ce1a13a14744045bb48f6bad661e860', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-10643293', 'test_vnv6sr'], 'port_security_enabled': True, 'description': ''}}
2026-06-18 17:11:19,835 - DEBUG - Response for create_subnet : {'subnet': {'id': '6bfbcda3-da4d-4c68-8405-2a59ce1fd2fc', 'name': '', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'network_id': 'db0348e3-d12c-45ed-8884-f48bf35eb774', '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': '4ce1a13a14744045bb48f6bad661e860'}}
2026-06-18 17:11:20,076 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ba04d5cc-8531-440d-98b0-a6a76c7489a4', 'name': '', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'network_id': 'db0348e3-d12c-45ed-8884-f48bf35eb774', 'ip_version': 4, 'cidr': '151.72.82.192/26', 'allocation_pools': [{'start': '151.72.82.194', 'end': '151.72.82.254'}], 'gateway_ip': '151.72.82.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '151.72.82.194', 'tags': [], 'project_id': '4ce1a13a14744045bb48f6bad661e860'}}
2026-06-18 17:11:20,099 - INFO - Created VN test_vnv6sr
2026-06-18 17:11:20,113 - DEBUG - VN test_vnv6sr UUID is db0348e3-d12c-45ed-8884-f48bf35eb774
2026-06-18 17:11:20,434 - DEBUG - Response for create_network : {'network': {'id': '629ed6c8-e90a-49a5-9bbe-64f9bf9ebc2c', 'name': 'test_vnv6dn', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'project_id': '4ce1a13a14744045bb48f6bad661e860', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-10643293', 'test_vnv6dn'], 'port_security_enabled': True, 'description': ''}}
2026-06-18 17:11:20,632 - DEBUG - Response for create_subnet : {'subnet': {'id': '6ce69c92-6495-41be-8bfc-6eee166a8f0d', 'name': '', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'network_id': '629ed6c8-e90a-49a5-9bbe-64f9bf9ebc2c', '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': '4ce1a13a14744045bb48f6bad661e860'}}
2026-06-18 17:11:20,882 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f8ae673c-8650-4a18-af9f-4b3b714587ac', 'name': '', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'network_id': '629ed6c8-e90a-49a5-9bbe-64f9bf9ebc2c', 'ip_version': 4, 'cidr': '196.222.135.64/26', 'allocation_pools': [{'start': '196.222.135.66', 'end': '196.222.135.126'}], 'gateway_ip': '196.222.135.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '196.222.135.66', 'tags': [], 'project_id': '4ce1a13a14744045bb48f6bad661e860'}}
2026-06-18 17:11:20,902 - INFO - Created VN test_vnv6dn
2026-06-18 17:11:20,914 - DEBUG - VN test_vnv6dn UUID is 629ed6c8-e90a-49a5-9bbe-64f9bf9ebc2c
2026-06-18 17:11:22,186 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5988-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5988-1)
2026-06-18 17:11:23,301 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5988-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5988-2)
2026-06-18 17:11:23,301 - INFO - Waiting for VM source_vm to be up..
2026-06-18 17:11:23,346 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-18 17:11:28,422 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-18 17:11:33,504 - DEBUG - VM is in ACTIVE state now
2026-06-18 17:11:33,504 - INFO - VM name : source_vm
2026-06-18 17:11:33,585 - DEBUG - VM source_vm ID is 3a0e49a0-8605-4004-a0d3-b4a9fa3cd91b
2026-06-18 17:11:33,585 - DEBUG - VM source_vm launched on Node an-jenkins-deploy-platform-ansible-os-5988-1
2026-06-18 17:11:33,660 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/3a0e49a0-8605-4004-a0d3-b4a9fa3cd91b
2026-06-18 17:11:33,676 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/88288ecd-a9a0-4d68-adae-43671be915b3
2026-06-18 17:11:36,850 - 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 1015ms')
2026-06-18 17:11:36,850 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM source_vm failed!
2026-06-18 17:11:36,865 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-10643293:test_vnv6sr is 2001::101:1 and allocation pool is NOT set
2026-06-18 17:11:36,865 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-10643293:test_vnv6sr is 151.72.82.193 and allocation pool is NOT set
2026-06-18 17:11:38,926 - 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.79 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.438 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.438/2.111/3.785/1.673 ms')
2026-06-18 17:11:38,926 - INFO - Ping to Metadata IP 169.254.0.3 of VM source_vm passed
2026-06-18 17:11:38,995 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-18 17:11:38,995 - DEBUG - Waiting to SSH to VM source_vm, IP 151.72.82.195, Port 22
2026-06-18 17:11:39,151 - DEBUG - VM source_vm is ready for SSH connections
2026-06-18 17:11:39,151 - INFO - Waiting for VM dest_vm to be up..
2026-06-18 17:11:39,266 - DEBUG - VM is in ACTIVE state now
2026-06-18 17:11:39,266 - INFO - VM name : dest_vm
2026-06-18 17:11:39,362 - DEBUG - VM dest_vm ID is b717194c-c8f6-4a84-a11e-b2e548c3a013
2026-06-18 17:11:39,362 - DEBUG - VM dest_vm launched on Node an-jenkins-deploy-platform-ansible-os-5988-2
2026-06-18 17:11:39,455 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/b717194c-c8f6-4a84-a11e-b2e548c3a013
2026-06-18 17:11:39,466 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/7be71761-e02d-48f6-9d3c-aadc54cf6dfb
2026-06-18 17:11:40,621 - 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=2.97 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.356 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.356/1.663/2.971/1.307 ms')
2026-06-18 17:11:40,621 - INFO - Ping to Metadata IP 169.254.0.3 of VM dest_vm passed
2026-06-18 17:11:40,691 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-18 17:11:40,691 - DEBUG - Waiting to SSH to VM dest_vm, IP 196.222.135.67, Port 22
2026-06-18 17:11:40,842 - DEBUG - VM dest_vm is ready for SSH connections
2026-06-18 17:11:40,848 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-10643293: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-10643293: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-06-18 17:11:41,181 - INFO - Attaching policy allow_all to vn test_vnv6sr
2026-06-18 17:11:41,529 - INFO - Attaching policy allow_all to vn test_vnv6dn
2026-06-18 17:11:41,783 - INFO - Configure the policy with allow any
2026-06-18 17:11:42,094 - DEBUG - Response for create_network : {'network': {'id': '12421244-1649-440e-bcff-011038318225', 'name': 'vn1', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'project_id': '4ce1a13a14744045bb48f6bad661e860', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-10643293', 'vn1'], 'port_security_enabled': True, 'description': ''}}
2026-06-18 17:11:42,311 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ea3843b6-e574-4d38-96ff-7c3aa812225c', 'name': '', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'network_id': '12421244-1649-440e-bcff-011038318225', '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': '4ce1a13a14744045bb48f6bad661e860'}}
2026-06-18 17:11:42,332 - INFO - Created VN vn1
2026-06-18 17:11:42,347 - DEBUG - VN vn1 UUID is 12421244-1649-440e-bcff-011038318225
2026-06-18 17:11:42,659 - DEBUG - Response for create_network : {'network': {'id': '4a593008-9f62-4e58-8dde-f06958628822', 'name': 'vn2', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'project_id': '4ce1a13a14744045bb48f6bad661e860', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-10643293', 'vn2'], 'port_security_enabled': True, 'description': ''}}
2026-06-18 17:11:42,868 - DEBUG - Response for create_subnet : {'subnet': {'id': '66dbf21e-460c-4c9c-ba4c-e675519cc4bd', 'name': '', 'tenant_id': '4ce1a13a14744045bb48f6bad661e860', 'network_id': '4a593008-9f62-4e58-8dde-f06958628822', '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': '4ce1a13a14744045bb48f6bad661e860'}}
2026-06-18 17:11:42,891 - INFO - Created VN vn2
2026-06-18 17:11:42,904 - DEBUG - VN vn2 UUID is 4a593008-9f62-4e58-8dde-f06958628822
2026-06-18 17:11:42,981 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-10643293: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-10643293: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-06-18 17:11:43,313 - INFO - Attaching policy sec_grp_policy_ctest-random-44428781 to vn vn1
2026-06-18 17:11:43,685 - INFO - Attaching policy sec_grp_policy_ctest-random-44428781 to vn vn2
2026-06-18 17:11:45,206 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5988-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5988-1)
2026-06-18 17:11:46,525 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5988-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5988-2)
2026-06-18 17:11:46,585 - INFO - ================================================================================
2026-06-18 17:11:46,586 - INFO - STARTING TEST : test_create_md5_on_control
2026-06-18 17:11:46,586 - INFO - TEST DESCRIPTION :
Description: Verify md5 with allow specific protocol on all ports and policy with allow all between VN's
2026-06-18 17:11:47,838 - DEBUG - Skipping xmpp flap check
2026-06-18 17:11:47,838 - INFO - Initial checks done. Running the testcase now
2026-06-18 17:11:47,838 - INFO -
2026-06-18 17:11:47,838 - INFO - config md5 on each host with auth_data None
2026-06-18 17:11:47,838 - INFO - config per peer with auth_data None
2026-06-18 17:11:48,386 - INFO - configure MD5 on host cc1f258c-a947-4526-9c20-d29ffe6897ad
2026-06-18 17:11:48,470 - INFO - config per peer with auth_data None
2026-06-18 17:11:49,046 - INFO - configure MD5 on host 0bbda49c-85cb-47be-8284-884f4eb6b692
2026-06-18 17:11:49,138 - INFO - config per peer with auth_data None
2026-06-18 17:11:49,917 - INFO - configure MD5 on host d7481530-c73f-4427-bb07-50b5c40c2fbc
2026-06-18 17:11:50,053 - INFO - check if BGP between peers are up before setting md5
2026-06-18 17:11:50,053 - INFO - Check BGP staus between peers
2026-06-18 17:11:50,062 - INFO - setting MD5 config on host cc1f258c-a947-4526-9c20-d29ffe6897ad
2026-06-18 17:11:50,062 - INFO - configure MD5 on host cc1f258c-a947-4526-9c20-d29ffe6897ad
2026-06-18 17:11:50,146 - INFO - setting MD5 config on host 0bbda49c-85cb-47be-8284-884f4eb6b692
2026-06-18 17:11:50,146 - INFO - configure MD5 on host 0bbda49c-85cb-47be-8284-884f4eb6b692
2026-06-18 17:11:50,218 - INFO - setting MD5 config on host d7481530-c73f-4427-bb07-50b5c40c2fbc
2026-06-18 17:11:50,218 - INFO - configure MD5 on host d7481530-c73f-4427-bb07-50b5c40c2fbc
2026-06-18 17:11:50,294 - INFO - check if BGP peering is up after md5 config
2026-06-18 17:11:50,294 - INFO - Check BGP staus between peers
2026-06-18 17:11:50,303 - DEBUG - Check the BGP connection on 10.0.0.249
2026-06-18 17:11:50,303 - DEBUG - Check the BGP connection on 10.0.0.249
2026-06-18 17:12:00,304 - INFO - Check BGP staus between peers
2026-06-18 17:12:00,313 - INFO - remove md5 configured on host cc1f258c-a947-4526-9c20-d29ffe6897ad
2026-06-18 17:12:00,314 - INFO - config per peer with auth_data None
2026-06-18 17:12:00,871 - INFO - configure MD5 on host cc1f258c-a947-4526-9c20-d29ffe6897ad
2026-06-18 17:12:00,958 - INFO - remove md5 configured on host 0bbda49c-85cb-47be-8284-884f4eb6b692
2026-06-18 17:12:00,958 - INFO - config per peer with auth_data None
2026-06-18 17:12:01,562 - INFO - configure MD5 on host 0bbda49c-85cb-47be-8284-884f4eb6b692
2026-06-18 17:12:01,642 - INFO - remove md5 configured on host d7481530-c73f-4427-bb07-50b5c40c2fbc
2026-06-18 17:12:01,642 - INFO - config per peer with auth_data None
2026-06-18 17:12:02,334 - INFO - configure MD5 on host d7481530-c73f-4427-bb07-50b5c40c2fbc
2026-06-18 17:12:02,426 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD
2026-06-18 17:12:02,426 - INFO - Deleting VM vn2_vm_0
2026-06-18 17:12:02,426 - ERROR - VM vn2_vm_0 has failed to come up
2026-06-18 17:12:02,426 - ERROR - Nova failed to get host of the VM
2026-06-18 17:12:02,427 - ERROR - VM vn2_vm_0 has failed to come up
2026-06-18 17:12:02,427 - ERROR - Nova failed to get host of the VM
2026-06-18 17:12:02,535 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD
2026-06-18 17:12:02,536 - INFO - Deleting VM vn1_vm_0
2026-06-18 17:12:02,536 - ERROR - VM vn1_vm_0 has failed to come up
2026-06-18 17:12:02,536 - ERROR - Nova failed to get host of the VM
2026-06-18 17:12:02,536 - ERROR - VM vn1_vm_0 has failed to come up
2026-06-18 17:12:02,536 - ERROR - Nova failed to get host of the VM
2026-06-18 17:12:02,611 - INFO - Dettaching policy sec_grp_policy_ctest-random-44428781 from vn vn2
2026-06-18 17:12:02,773 - INFO - Dettaching policy sec_grp_policy_ctest-random-44428781 from vn vn1
2026-06-18 17:12:03,002 - INFO - Deleted policy sec_grp_policy_ctest-random-44428781
2026-06-18 17:12:03,002 - INFO - Deleting VN vn2
2026-06-18 17:12:03,044 - DEBUG - VN 4a593008-9f62-4e58-8dde-f06958628822 still in use: Unable to complete operation on network 4a593008-9f62-4e58-8dde-f06958628822. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-929d17b1-7fb6-4705-a894-353a2fb8dca5']
2026-06-18 17:12:03,044 - WARNING - Deleting VN vn2 failed..Will retry
2026-06-18 17:12:05,216 - DEBUG - Response for deleting network ()
2026-06-18 17:12:05,217 - INFO - Deleting VN vn1
2026-06-18 17:12:05,402 - DEBUG - Response for deleting network ()
2026-06-18 17:12:05,402 - INFO - Dettaching policy allow_all from vn test_vnv6dn
2026-06-18 17:12:05,581 - INFO - Dettaching policy allow_all from vn test_vnv6sr
2026-06-18 17:12:05,848 - INFO - Deleted policy allow_all
2026-06-18 17:12:05,848 - INFO - Deleting VM dest_vm
2026-06-18 17:12:05,921 - INFO - Deleting VM source_vm
2026-06-18 17:12:06,008 - INFO - Deleting VN test_vnv6dn
2026-06-18 17:12:06,047 - DEBUG - VN 629ed6c8-e90a-49a5-9bbe-64f9bf9ebc2c still in use: Unable to complete operation on network 629ed6c8-e90a-49a5-9bbe-64f9bf9ebc2c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-ae499d3e-de7a-4d26-a2e0-c8cc95dbc678']
2026-06-18 17:12:06,047 - WARNING - Deleting VN test_vnv6dn failed..Will retry
2026-06-18 17:12:08,344 - DEBUG - Response for deleting network ()
2026-06-18 17:12:08,344 - INFO - Deleting VN test_vnv6sr
2026-06-18 17:12:08,529 - DEBUG - Response for deleting network ()
2026-06-18 17:12:09,801 - DEBUG - Skipping xmpp flap check
2026-06-18 17:12:09,801 - INFO - END TEST : test_create_md5_on_control : PASSED[0:00:23]
2026-06-18 17:12:09,801 - INFO - --------------------------------------------------------------------------------
2026-06-18 17:12:10,566 - INFO - Deleted project: ctest-TestMd5testsOnControl-10643293, ID : 4ce1a13a-1474-4045-bb48-f6bad661e860