2026-04-20 18:46:19,718 - INFO - Domain Default found not creating 2026-04-20 18:46:19,953 - INFO - Project ctest-TestMd5testsOnControl-22841819 not found, creating it 2026-04-20 18:46:20,625 - INFO - Created Project:ctest-TestMd5testsOnControl-22841819, ID : c2b59ce1-8e95-4107-a056-78c40bfbc28c 2026-04-20 18:46:23,414 - DEBUG - Response for create_network : {'network': {'id': '099a3f50-aeac-497d-8d13-57282f746d44', 'name': 'test_vnv6sr', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'project_id': 'c2b59ce18e954107a05678c40bfbc28c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-22841819', 'test_vnv6sr'], 'port_security_enabled': True, 'description': ''}} 2026-04-20 18:46:23,850 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a4dce03a-b78d-4e16-9d72-99be23d1034a', 'name': '', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'network_id': '099a3f50-aeac-497d-8d13-57282f746d44', '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': 'c2b59ce18e954107a05678c40bfbc28c'}} 2026-04-20 18:46:24,155 - DEBUG - Response for create_subnet : {'subnet': {'id': '31b9f598-ae32-464a-aa6e-65901a7fb8e5', 'name': '', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'network_id': '099a3f50-aeac-497d-8d13-57282f746d44', 'ip_version': 4, 'cidr': '191.118.192.128/26', 'allocation_pools': [{'start': '191.118.192.130', 'end': '191.118.192.190'}], 'gateway_ip': '191.118.192.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '191.118.192.130', 'tags': [], 'project_id': 'c2b59ce18e954107a05678c40bfbc28c'}} 2026-04-20 18:46:24,194 - INFO - Created VN test_vnv6sr 2026-04-20 18:46:24,212 - DEBUG - VN test_vnv6sr UUID is 099a3f50-aeac-497d-8d13-57282f746d44 2026-04-20 18:46:24,763 - DEBUG - Response for create_network : {'network': {'id': '4c38368b-1e0b-4c3e-9491-c6773208567b', 'name': 'test_vnv6dn', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'project_id': 'c2b59ce18e954107a05678c40bfbc28c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-22841819', 'test_vnv6dn'], 'port_security_enabled': True, 'description': ''}} 2026-04-20 18:46:25,080 - DEBUG - Response for create_subnet : {'subnet': {'id': '2f371ec0-31a5-4d4d-ba85-bd5e7f62976d', 'name': '', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'network_id': '4c38368b-1e0b-4c3e-9491-c6773208567b', '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': 'c2b59ce18e954107a05678c40bfbc28c'}} 2026-04-20 18:46:25,332 - DEBUG - Response for create_subnet : {'subnet': {'id': '454388ef-b4d9-450b-9e01-61033ace2638', 'name': '', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'network_id': '4c38368b-1e0b-4c3e-9491-c6773208567b', 'ip_version': 4, 'cidr': '76.132.196.0/26', 'allocation_pools': [{'start': '76.132.196.2', 'end': '76.132.196.62'}], 'gateway_ip': '76.132.196.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '76.132.196.2', 'tags': [], 'project_id': 'c2b59ce18e954107a05678c40bfbc28c'}} 2026-04-20 18:46:25,369 - INFO - Created VN test_vnv6dn 2026-04-20 18:46:25,384 - DEBUG - VN test_vnv6dn UUID is 4c38368b-1e0b-4c3e-9491-c6773208567b 2026-04-20 18:46:25,818 - DEBUG - Services list from nova: [, , , ] 2026-04-20 18:46:27,319 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5654-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5654-2) 2026-04-20 18:46:29,210 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5654-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5654-1) 2026-04-20 18:46:29,210 - INFO - Waiting for VM source_vm to be up.. 2026-04-20 18:46:29,348 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-04-20 18:46:34,479 - DEBUG - VM is in ACTIVE state now 2026-04-20 18:46:34,479 - INFO - VM name : source_vm 2026-04-20 18:46:34,605 - DEBUG - VM source_vm ID is 005642cd-e953-441d-b4ad-054e1656f301 2026-04-20 18:46:34,642 - DEBUG - VM source_vm launched on Node an-jenkins-deploy-platform-ansible-os-5654-2 2026-04-20 18:46:34,755 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/005642cd-e953-441d-b4ad-054e1656f301 2026-04-20 18:46:35,073 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/005642cd-e953-441d-b4ad-054e1656f301 2026-04-20 18:46:35,123 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/c8f0ffdd-9afb-4871-a511-4d2f1ffa2d1a 2026-04-20 18:46:38,325 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1021ms') 2026-04-20 18:46:38,325 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM source_vm failed! 2026-04-20 18:46:38,343 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-22841819:test_vnv6sr is 2001::101:1 and allocation pool is NOT set 2026-04-20 18:46:38,343 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-22841819:test_vnv6sr is 191.118.192.129 and allocation pool is NOT set 2026-04-20 18:46:40,412 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n64 bytes from 169.254.0.5: icmp_seq=1 ttl=63 time=7.64 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.541 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.541/4.088/7.635/3.547 ms') 2026-04-20 18:46:40,412 - INFO - Ping to Metadata IP 169.254.0.5 of VM source_vm passed 2026-04-20 18:46:40,492 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-20 18:46:40,492 - DEBUG - Waiting to SSH to VM source_vm, IP 191.118.192.131, Port 22 2026-04-20 18:46:40,668 - DEBUG - VM source_vm is ready for SSH connections 2026-04-20 18:46:40,668 - INFO - Waiting for VM dest_vm to be up.. 2026-04-20 18:46:40,776 - DEBUG - VM is in ACTIVE state now 2026-04-20 18:46:40,776 - INFO - VM name : dest_vm 2026-04-20 18:46:40,895 - DEBUG - VM dest_vm ID is f52e0a15-4e81-48f4-abe0-a9605d973dc2 2026-04-20 18:46:40,895 - DEBUG - VM dest_vm launched on Node an-jenkins-deploy-platform-ansible-os-5654-1 2026-04-20 18:46:41,007 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/f52e0a15-4e81-48f4-abe0-a9605d973dc2 2026-04-20 18:46:41,022 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/896dd4b0-afda-49bc-b2f9-ee3d59e80360 2026-04-20 18:46:42,205 - 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=4.51 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.916 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.916/2.712/4.509/1.796 ms') 2026-04-20 18:46:42,205 - INFO - Ping to Metadata IP 169.254.0.3 of VM dest_vm passed 2026-04-20 18:46:42,283 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-20 18:46:42,283 - DEBUG - Waiting to SSH to VM dest_vm, IP 76.132.196.3, Port 22 2026-04-20 18:46:42,456 - DEBUG - VM dest_vm is ready for SSH connections 2026-04-20 18:46:42,464 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-22841819: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-22841819: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-04-20 18:46:42,856 - INFO - Attaching policy allow_all to vn test_vnv6sr 2026-04-20 18:46:43,273 - INFO - Attaching policy allow_all to vn test_vnv6dn 2026-04-20 18:46:43,574 - INFO - Configure the policy with allow any 2026-04-20 18:46:43,964 - DEBUG - Response for create_network : {'network': {'id': '6d147671-80d5-48db-8148-1cc896d91587', 'name': 'vn1', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'project_id': 'c2b59ce18e954107a05678c40bfbc28c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-22841819', 'vn1'], 'port_security_enabled': True, 'description': ''}} 2026-04-20 18:46:44,239 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a835ff46-af26-4bfe-9a99-556bf7d05fd5', 'name': '', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'network_id': '6d147671-80d5-48db-8148-1cc896d91587', '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': 'c2b59ce18e954107a05678c40bfbc28c'}} 2026-04-20 18:46:44,273 - INFO - Created VN vn1 2026-04-20 18:46:44,289 - DEBUG - VN vn1 UUID is 6d147671-80d5-48db-8148-1cc896d91587 2026-04-20 18:46:44,777 - DEBUG - Response for create_network : {'network': {'id': 'fec4b3ab-8811-4e83-ad6a-b438f92508fd', 'name': 'vn2', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'project_id': 'c2b59ce18e954107a05678c40bfbc28c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-22841819', 'vn2'], 'port_security_enabled': True, 'description': ''}} 2026-04-20 18:46:45,073 - DEBUG - Response for create_subnet : {'subnet': {'id': '4ffe1f9f-a686-4987-93a1-3ad5fa288411', 'name': '', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'network_id': 'fec4b3ab-8811-4e83-ad6a-b438f92508fd', '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': 'c2b59ce18e954107a05678c40bfbc28c'}} 2026-04-20 18:46:45,102 - INFO - Created VN vn2 2026-04-20 18:46:45,120 - DEBUG - VN vn2 UUID is fec4b3ab-8811-4e83-ad6a-b438f92508fd 2026-04-20 18:46:45,231 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-22841819: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-22841819: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-04-20 18:46:45,582 - INFO - Attaching policy sec_grp_policy_ctest-random-73161988 to vn vn1 2026-04-20 18:46:45,989 - INFO - Attaching policy sec_grp_policy_ctest-random-73161988 to vn vn2 2026-04-20 18:46:48,129 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5654-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5654-2) 2026-04-20 18:46:50,142 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5654-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5654-1) 2026-04-20 18:46:50,211 - INFO - ================================================================================ 2026-04-20 18:46:50,211 - INFO - STARTING TEST : test_check_per_peer_on_control 2026-04-20 18:46:50,211 - INFO - TEST DESCRIPTION : Description: Verify per peer md5 and specific protocol on all ports and policy with allow all between VN's 2026-04-20 18:46:51,493 - DEBUG - Skipping xmpp flap check 2026-04-20 18:46:51,493 - INFO - Initial checks done. Running the testcase now 2026-04-20 18:46:51,493 - INFO - 2026-04-20 18:46:51,493 - INFO - config per peer with auth_data None 2026-04-20 18:46:52,130 - INFO - configure MD5 on host 1da8123b-a155-4374-ba56-543f170e422d 2026-04-20 18:46:52,237 - INFO - config per peer with auth_data None 2026-04-20 18:46:52,981 - INFO - configure MD5 on host b0bf02fe-acdd-462e-9e73-97ccb6395eaf 2026-04-20 18:46:53,090 - INFO - config per peer with auth_data None 2026-04-20 18:46:53,822 - INFO - configure MD5 on host 4256b762-56fd-4ff1-821d-7544e31a31f1 2026-04-20 18:46:53,929 - INFO - check BGP peering is up before setting md5 config 2026-04-20 18:46:53,929 - INFO - Check BGP staus between peers 2026-04-20 18:46:53,953 - INFO - config per peer with auth_data {'key_items': [{'key': 'juniper', 'key_id': 0}], 'key_type': 'md5'} 2026-04-20 18:46:54,673 - INFO - Check BGP staus between peers 2026-04-20 18:46:54,686 - DEBUG - Check the BGP connection on 10.0.0.23 2026-04-20 18:46:54,686 - DEBUG - Check the BGP connection on 10.0.0.23 2026-04-20 18:47:04,687 - INFO - Check BGP staus between peers 2026-04-20 18:47:04,699 - INFO - remove md5 configured on host 1da8123b-a155-4374-ba56-543f170e422d 2026-04-20 18:47:04,699 - INFO - config per peer with auth_data None 2026-04-20 18:47:05,401 - INFO - configure MD5 on host 1da8123b-a155-4374-ba56-543f170e422d 2026-04-20 18:47:05,517 - INFO - remove md5 configured on host b0bf02fe-acdd-462e-9e73-97ccb6395eaf 2026-04-20 18:47:05,517 - INFO - config per peer with auth_data None 2026-04-20 18:47:06,185 - INFO - configure MD5 on host b0bf02fe-acdd-462e-9e73-97ccb6395eaf 2026-04-20 18:47:06,297 - INFO - remove md5 configured on host 4256b762-56fd-4ff1-821d-7544e31a31f1 2026-04-20 18:47:06,297 - INFO - config per peer with auth_data None 2026-04-20 18:47:07,037 - INFO - configure MD5 on host 4256b762-56fd-4ff1-821d-7544e31a31f1 2026-04-20 18:47:07,141 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD 2026-04-20 18:47:07,142 - INFO - Deleting VM vn2_vm_0 2026-04-20 18:47:07,142 - ERROR - VM vn2_vm_0 has failed to come up 2026-04-20 18:47:07,142 - ERROR - Nova failed to get host of the VM 2026-04-20 18:47:07,142 - ERROR - VM vn2_vm_0 has failed to come up 2026-04-20 18:47:07,143 - ERROR - Nova failed to get host of the VM 2026-04-20 18:47:07,242 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD 2026-04-20 18:47:07,243 - INFO - Deleting VM vn1_vm_0 2026-04-20 18:47:07,243 - ERROR - VM vn1_vm_0 has failed to come up 2026-04-20 18:47:07,243 - ERROR - Nova failed to get host of the VM 2026-04-20 18:47:07,243 - ERROR - VM vn1_vm_0 has failed to come up 2026-04-20 18:47:07,244 - ERROR - Nova failed to get host of the VM 2026-04-20 18:47:07,382 - INFO - Dettaching policy sec_grp_policy_ctest-random-73161988 from vn vn2 2026-04-20 18:47:07,622 - INFO - Dettaching policy sec_grp_policy_ctest-random-73161988 from vn vn1 2026-04-20 18:47:07,962 - INFO - Deleted policy sec_grp_policy_ctest-random-73161988 2026-04-20 18:47:07,962 - INFO - Deleting VN vn2 2026-04-20 18:47:08,069 - DEBUG - VN fec4b3ab-8811-4e83-ad6a-b438f92508fd still in use: Unable to complete operation on network fec4b3ab-8811-4e83-ad6a-b438f92508fd. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-4217f425-5b6d-409c-84b7-385688d5a114'] 2026-04-20 18:47:08,069 - WARNING - Deleting VN vn2 failed..Will retry 2026-04-20 18:47:10,299 - DEBUG - Response for deleting network () 2026-04-20 18:47:10,300 - INFO - Deleting VN vn1 2026-04-20 18:47:10,538 - DEBUG - Response for deleting network () 2026-04-20 18:47:10,539 - INFO - Dettaching policy allow_all from vn test_vnv6dn 2026-04-20 18:47:10,773 - INFO - Dettaching policy allow_all from vn test_vnv6sr 2026-04-20 18:47:11,091 - INFO - Deleted policy allow_all 2026-04-20 18:47:11,092 - INFO - Deleting VM dest_vm 2026-04-20 18:47:11,195 - INFO - Deleting VM source_vm 2026-04-20 18:47:11,296 - INFO - Deleting VN test_vnv6dn 2026-04-20 18:47:11,376 - DEBUG - VN 4c38368b-1e0b-4c3e-9491-c6773208567b still in use: Unable to complete operation on network 4c38368b-1e0b-4c3e-9491-c6773208567b. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-7e56a54b-8742-4e0a-b4c1-f7289b7b6836'] 2026-04-20 18:47:11,376 - WARNING - Deleting VN test_vnv6dn failed..Will retry 2026-04-20 18:47:13,598 - DEBUG - Response for deleting network () 2026-04-20 18:47:13,598 - INFO - Deleting VN test_vnv6sr 2026-04-20 18:47:13,842 - DEBUG - Response for deleting network () 2026-04-20 18:47:15,126 - DEBUG - Skipping xmpp flap check
2026-04-20 18:47:15,126 - INFO - END TEST : test_check_per_peer_on_control : PASSED[0:00:25]
2026-04-20 18:47:15,126 - INFO - -------------------------------------------------------------------------------- 2026-04-20 18:47:15,487 - DEBUG - Response for create_network : {'network': {'id': '225a37d3-a320-444a-950d-902be07c511b', 'name': 'test_vnv6sr', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'project_id': 'c2b59ce18e954107a05678c40bfbc28c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-22841819', 'test_vnv6sr'], 'port_security_enabled': True, 'description': ''}} 2026-04-20 18:47:15,771 - DEBUG - Response for create_subnet : {'subnet': {'id': '699c21dd-641a-4a82-890a-46e45cbcec8a', 'name': '', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'network_id': '225a37d3-a320-444a-950d-902be07c511b', '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': 'c2b59ce18e954107a05678c40bfbc28c'}} 2026-04-20 18:47:16,115 - DEBUG - Response for create_subnet : {'subnet': {'id': '29f761d8-0412-451c-9bd6-a65f859c2ef1', 'name': '', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'network_id': '225a37d3-a320-444a-950d-902be07c511b', 'ip_version': 4, 'cidr': '82.232.48.128/26', 'allocation_pools': [{'start': '82.232.48.130', 'end': '82.232.48.190'}], 'gateway_ip': '82.232.48.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '82.232.48.130', 'tags': [], 'project_id': 'c2b59ce18e954107a05678c40bfbc28c'}} 2026-04-20 18:47:16,181 - INFO - Created VN test_vnv6sr 2026-04-20 18:47:16,212 - DEBUG - VN test_vnv6sr UUID is 225a37d3-a320-444a-950d-902be07c511b 2026-04-20 18:47:16,792 - DEBUG - Response for create_network : {'network': {'id': '663cdd6d-a9e6-4f8c-8eea-eeb734909b4d', 'name': 'test_vnv6dn', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'project_id': 'c2b59ce18e954107a05678c40bfbc28c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-22841819', 'test_vnv6dn'], 'port_security_enabled': True, 'description': ''}} 2026-04-20 18:47:17,026 - DEBUG - Response for create_subnet : {'subnet': {'id': '4cc07b95-75bc-4c74-8a53-8ff13a125242', 'name': '', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'network_id': '663cdd6d-a9e6-4f8c-8eea-eeb734909b4d', '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': 'c2b59ce18e954107a05678c40bfbc28c'}} 2026-04-20 18:47:17,303 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd4ddbd10-c50e-46aa-a923-ecb3211454d5', 'name': '', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'network_id': '663cdd6d-a9e6-4f8c-8eea-eeb734909b4d', 'ip_version': 4, 'cidr': '87.104.41.64/26', 'allocation_pools': [{'start': '87.104.41.66', 'end': '87.104.41.126'}], 'gateway_ip': '87.104.41.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '87.104.41.66', 'tags': [], 'project_id': 'c2b59ce18e954107a05678c40bfbc28c'}} 2026-04-20 18:47:17,350 - INFO - Created VN test_vnv6dn 2026-04-20 18:47:17,366 - DEBUG - VN test_vnv6dn UUID is 663cdd6d-a9e6-4f8c-8eea-eeb734909b4d 2026-04-20 18:47:18,976 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5654-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5654-2) 2026-04-20 18:47:20,896 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5654-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5654-1) 2026-04-20 18:47:20,896 - INFO - Waiting for VM source_vm to be up.. 2026-04-20 18:47:21,027 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-04-20 18:47:26,241 - DEBUG - VM is in ACTIVE state now 2026-04-20 18:47:26,241 - INFO - VM name : source_vm 2026-04-20 18:47:26,391 - DEBUG - VM source_vm ID is ffb99c8b-4bf6-4726-b6e2-0b8f11aee3b6 2026-04-20 18:47:26,391 - DEBUG - VM source_vm launched on Node an-jenkins-deploy-platform-ansible-os-5654-2 2026-04-20 18:47:26,545 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/ffb99c8b-4bf6-4726-b6e2-0b8f11aee3b6 2026-04-20 18:47:26,562 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/3fdd676b-6ea5-4a92-91bf-c1c9339e368c 2026-04-20 18:47:29,783 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1030ms') 2026-04-20 18:47:29,783 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM source_vm failed! 2026-04-20 18:47:29,797 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-22841819:test_vnv6sr is 2001::101:1 and allocation pool is NOT set 2026-04-20 18:47:29,797 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-22841819:test_vnv6sr is 82.232.48.129 and allocation pool is NOT set 2026-04-20 18:47:31,864 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n64 bytes from 169.254.0.5: icmp_seq=1 ttl=63 time=8.74 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.516 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.516/4.629/8.742/4.113 ms') 2026-04-20 18:47:31,865 - INFO - Ping to Metadata IP 169.254.0.5 of VM source_vm passed 2026-04-20 18:47:31,945 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-20 18:47:31,945 - DEBUG - Waiting to SSH to VM source_vm, IP 82.232.48.131, Port 22 2026-04-20 18:47:32,102 - DEBUG - VM source_vm is ready for SSH connections 2026-04-20 18:47:32,102 - INFO - Waiting for VM dest_vm to be up.. 2026-04-20 18:47:32,213 - DEBUG - VM is in ACTIVE state now 2026-04-20 18:47:32,214 - INFO - VM name : dest_vm 2026-04-20 18:47:32,333 - DEBUG - VM dest_vm ID is e151a191-c14c-40da-af7d-013bd7e3053f 2026-04-20 18:47:32,333 - DEBUG - VM dest_vm launched on Node an-jenkins-deploy-platform-ansible-os-5654-1 2026-04-20 18:47:32,448 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/e151a191-c14c-40da-af7d-013bd7e3053f 2026-04-20 18:47:32,462 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/f24f062c-7580-40b9-9f1b-8fee876ffb90 2026-04-20 18:47:33,647 - 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=4.69 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.847 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.847/2.766/4.685/1.919 ms') 2026-04-20 18:47:33,647 - INFO - Ping to Metadata IP 169.254.0.3 of VM dest_vm passed 2026-04-20 18:47:33,726 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-20 18:47:33,726 - DEBUG - Waiting to SSH to VM dest_vm, IP 87.104.41.67, Port 22 2026-04-20 18:47:33,889 - DEBUG - VM dest_vm is ready for SSH connections 2026-04-20 18:47:33,897 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-22841819: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-22841819: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-04-20 18:47:34,283 - INFO - Attaching policy allow_all to vn test_vnv6sr 2026-04-20 18:47:34,713 - INFO - Attaching policy allow_all to vn test_vnv6dn 2026-04-20 18:47:35,041 - INFO - Configure the policy with allow any 2026-04-20 18:47:35,446 - DEBUG - Response for create_network : {'network': {'id': 'a0a7a3dd-9a01-49de-bf8d-d674db7f2c92', 'name': 'vn1', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'project_id': 'c2b59ce18e954107a05678c40bfbc28c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-22841819', 'vn1'], 'port_security_enabled': True, 'description': ''}} 2026-04-20 18:47:35,740 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a316d4d4-a16b-4ced-9ab9-5103ed4f6dd5', 'name': '', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'network_id': 'a0a7a3dd-9a01-49de-bf8d-d674db7f2c92', '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': 'c2b59ce18e954107a05678c40bfbc28c'}} 2026-04-20 18:47:35,776 - INFO - Created VN vn1 2026-04-20 18:47:35,792 - DEBUG - VN vn1 UUID is a0a7a3dd-9a01-49de-bf8d-d674db7f2c92 2026-04-20 18:47:36,260 - DEBUG - Response for create_network : {'network': {'id': '28d57688-4f44-4caf-94e5-8021e9d894fb', 'name': 'vn2', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'project_id': 'c2b59ce18e954107a05678c40bfbc28c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-22841819', 'vn2'], 'port_security_enabled': True, 'description': ''}} 2026-04-20 18:47:36,572 - DEBUG - Response for create_subnet : {'subnet': {'id': '13608641-3dbd-449c-a5e0-74de42be2ee7', 'name': '', 'tenant_id': 'c2b59ce18e954107a05678c40bfbc28c', 'network_id': '28d57688-4f44-4caf-94e5-8021e9d894fb', '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': 'c2b59ce18e954107a05678c40bfbc28c'}} 2026-04-20 18:47:36,599 - INFO - Created VN vn2 2026-04-20 18:47:36,618 - DEBUG - VN vn2 UUID is 28d57688-4f44-4caf-94e5-8021e9d894fb 2026-04-20 18:47:36,719 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-22841819: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-22841819: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-04-20 18:47:37,090 - INFO - Attaching policy sec_grp_policy_ctest-random-44246279 to vn vn1 2026-04-20 18:47:37,517 - INFO - Attaching policy sec_grp_policy_ctest-random-44246279 to vn vn2 2026-04-20 18:47:39,367 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5654-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5654-2) 2026-04-20 18:47:41,101 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5654-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5654-1) 2026-04-20 18:47:41,169 - INFO - ================================================================================ 2026-04-20 18:47:41,169 - INFO - STARTING TEST : test_create_md5_on_control 2026-04-20 18:47:41,170 - INFO - TEST DESCRIPTION : Description: Verify md5 with allow specific protocol on all ports and policy with allow all between VN's 2026-04-20 18:47:42,497 - DEBUG - Skipping xmpp flap check 2026-04-20 18:47:42,497 - INFO - Initial checks done. Running the testcase now 2026-04-20 18:47:42,497 - INFO - 2026-04-20 18:47:42,497 - INFO - config md5 on each host with auth_data None 2026-04-20 18:47:42,498 - INFO - config per peer with auth_data None 2026-04-20 18:47:43,189 - INFO - configure MD5 on host 1da8123b-a155-4374-ba56-543f170e422d 2026-04-20 18:47:43,289 - INFO - config per peer with auth_data None 2026-04-20 18:47:43,990 - INFO - configure MD5 on host b0bf02fe-acdd-462e-9e73-97ccb6395eaf 2026-04-20 18:47:44,085 - INFO - config per peer with auth_data None 2026-04-20 18:47:44,817 - INFO - configure MD5 on host 4256b762-56fd-4ff1-821d-7544e31a31f1 2026-04-20 18:47:44,917 - INFO - check if BGP between peers are up before setting md5 2026-04-20 18:47:44,917 - INFO - Check BGP staus between peers 2026-04-20 18:47:44,931 - INFO - setting MD5 config on host 1da8123b-a155-4374-ba56-543f170e422d 2026-04-20 18:47:44,932 - INFO - configure MD5 on host 1da8123b-a155-4374-ba56-543f170e422d 2026-04-20 18:47:45,017 - INFO - setting MD5 config on host b0bf02fe-acdd-462e-9e73-97ccb6395eaf 2026-04-20 18:47:45,017 - INFO - configure MD5 on host b0bf02fe-acdd-462e-9e73-97ccb6395eaf 2026-04-20 18:47:45,113 - INFO - setting MD5 config on host 4256b762-56fd-4ff1-821d-7544e31a31f1 2026-04-20 18:47:45,114 - INFO - configure MD5 on host 4256b762-56fd-4ff1-821d-7544e31a31f1 2026-04-20 18:47:45,205 - INFO - check if BGP peering is up after md5 config 2026-04-20 18:47:45,205 - INFO - Check BGP staus between peers 2026-04-20 18:47:45,216 - DEBUG - Check the BGP connection on 10.0.0.23 2026-04-20 18:47:45,216 - DEBUG - Check the BGP connection on 10.0.0.23 2026-04-20 18:47:55,217 - INFO - Check BGP staus between peers 2026-04-20 18:47:55,229 - INFO - remove md5 configured on host 1da8123b-a155-4374-ba56-543f170e422d 2026-04-20 18:47:55,230 - INFO - config per peer with auth_data None 2026-04-20 18:47:55,829 - INFO - configure MD5 on host 1da8123b-a155-4374-ba56-543f170e422d 2026-04-20 18:47:55,942 - INFO - remove md5 configured on host b0bf02fe-acdd-462e-9e73-97ccb6395eaf 2026-04-20 18:47:55,943 - INFO - config per peer with auth_data None 2026-04-20 18:47:56,669 - INFO - configure MD5 on host b0bf02fe-acdd-462e-9e73-97ccb6395eaf 2026-04-20 18:47:56,761 - INFO - remove md5 configured on host 4256b762-56fd-4ff1-821d-7544e31a31f1 2026-04-20 18:47:56,761 - INFO - config per peer with auth_data None 2026-04-20 18:47:57,450 - INFO - configure MD5 on host 4256b762-56fd-4ff1-821d-7544e31a31f1 2026-04-20 18:47:57,549 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD 2026-04-20 18:47:57,549 - INFO - Deleting VM vn2_vm_0 2026-04-20 18:47:57,550 - ERROR - VM vn2_vm_0 has failed to come up 2026-04-20 18:47:57,550 - ERROR - Nova failed to get host of the VM 2026-04-20 18:47:57,550 - ERROR - VM vn2_vm_0 has failed to come up 2026-04-20 18:47:57,550 - ERROR - Nova failed to get host of the VM 2026-04-20 18:47:57,645 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD 2026-04-20 18:47:57,645 - INFO - Deleting VM vn1_vm_0 2026-04-20 18:47:57,646 - ERROR - VM vn1_vm_0 has failed to come up 2026-04-20 18:47:57,646 - ERROR - Nova failed to get host of the VM 2026-04-20 18:47:57,646 - ERROR - VM vn1_vm_0 has failed to come up 2026-04-20 18:47:57,646 - ERROR - Nova failed to get host of the VM 2026-04-20 18:47:57,731 - INFO - Dettaching policy sec_grp_policy_ctest-random-44246279 from vn vn2 2026-04-20 18:47:57,948 - INFO - Dettaching policy sec_grp_policy_ctest-random-44246279 from vn vn1 2026-04-20 18:47:58,298 - INFO - Deleted policy sec_grp_policy_ctest-random-44246279 2026-04-20 18:47:58,298 - INFO - Deleting VN vn2 2026-04-20 18:47:58,377 - DEBUG - VN 28d57688-4f44-4caf-94e5-8021e9d894fb still in use: Unable to complete operation on network 28d57688-4f44-4caf-94e5-8021e9d894fb. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-d3c91f1e-2d6d-46fc-a403-5ac013e8a7e5'] 2026-04-20 18:47:58,377 - WARNING - Deleting VN vn2 failed..Will retry 2026-04-20 18:48:00,576 - DEBUG - Response for deleting network () 2026-04-20 18:48:00,577 - INFO - Deleting VN vn1 2026-04-20 18:48:00,784 - DEBUG - Response for deleting network () 2026-04-20 18:48:00,784 - INFO - Dettaching policy allow_all from vn test_vnv6dn 2026-04-20 18:48:01,059 - INFO - Dettaching policy allow_all from vn test_vnv6sr 2026-04-20 18:48:01,459 - INFO - Deleted policy allow_all 2026-04-20 18:48:01,459 - INFO - Deleting VM dest_vm 2026-04-20 18:48:01,612 - INFO - Deleting VM source_vm 2026-04-20 18:48:01,786 - INFO - Deleting VN test_vnv6dn 2026-04-20 18:48:01,865 - DEBUG - VN 663cdd6d-a9e6-4f8c-8eea-eeb734909b4d still in use: Unable to complete operation on network 663cdd6d-a9e6-4f8c-8eea-eeb734909b4d. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-1208ab52-5891-49d2-a4db-408106b5cb67'] 2026-04-20 18:48:01,866 - WARNING - Deleting VN test_vnv6dn failed..Will retry 2026-04-20 18:48:04,102 - DEBUG - Response for deleting network () 2026-04-20 18:48:04,102 - INFO - Deleting VN test_vnv6sr 2026-04-20 18:48:04,356 - DEBUG - Response for deleting network () 2026-04-20 18:48:05,655 - DEBUG - Skipping xmpp flap check
2026-04-20 18:48:05,655 - INFO - END TEST : test_create_md5_on_control : PASSED[0:00:24]
2026-04-20 18:48:05,655 - INFO - -------------------------------------------------------------------------------- 2026-04-20 18:48:06,507 - INFO - Deleted project: ctest-TestMd5testsOnControl-22841819, ID : c2b59ce1-8e95-4107-a056-78c40bfbc28c