2026-06-04 20:12:51,261 - INFO - Domain Default found not creating
2026-06-04 20:12:51,451 - INFO - Project ctest-TestMd5testsOnControl-56328416 not found, creating it
2026-06-04 20:12:51,955 - INFO - Created Project:ctest-TestMd5testsOnControl-56328416, ID : 5fd79c07-7cba-4741-954c-fe9d006d0816
2026-06-04 20:12:54,171 - DEBUG - Response for create_network : {'network': {'id': '24478ae3-d85b-4d12-b34a-97bd687b94c8', 'name': 'test_vnv6sr', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'project_id': '5fd79c077cba4741954cfe9d006d0816', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-56328416', 'test_vnv6sr'], 'port_security_enabled': True, 'description': ''}}
2026-06-04 20:12:54,440 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f2258ebc-0650-411c-bf59-ff7ba443667c', 'name': '', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'network_id': '24478ae3-d85b-4d12-b34a-97bd687b94c8', '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': '5fd79c077cba4741954cfe9d006d0816'}}
2026-06-04 20:12:54,676 - DEBUG - Response for create_subnet : {'subnet': {'id': 'bbad5249-1927-4bb9-a503-f522cd7fd0e3', 'name': '', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'network_id': '24478ae3-d85b-4d12-b34a-97bd687b94c8', 'ip_version': 4, 'cidr': '201.191.41.0/26', 'allocation_pools': [{'start': '201.191.41.2', 'end': '201.191.41.62'}], 'gateway_ip': '201.191.41.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '201.191.41.2', 'tags': [], 'project_id': '5fd79c077cba4741954cfe9d006d0816'}}
2026-06-04 20:12:54,712 - INFO - Created VN test_vnv6sr
2026-06-04 20:12:54,726 - DEBUG - VN test_vnv6sr UUID is 24478ae3-d85b-4d12-b34a-97bd687b94c8
2026-06-04 20:12:55,119 - DEBUG - Response for create_network : {'network': {'id': 'd8bab2a8-ae39-437b-b505-ebdd107b8f13', 'name': 'test_vnv6dn', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'project_id': '5fd79c077cba4741954cfe9d006d0816', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-56328416', 'test_vnv6dn'], 'port_security_enabled': True, 'description': ''}}
2026-06-04 20:12:55,357 - DEBUG - Response for create_subnet : {'subnet': {'id': '88595977-d37d-4e8e-8b15-c4998d10fe6a', 'name': '', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'network_id': 'd8bab2a8-ae39-437b-b505-ebdd107b8f13', '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': '5fd79c077cba4741954cfe9d006d0816'}}
2026-06-04 20:12:55,577 - DEBUG - Response for create_subnet : {'subnet': {'id': '94e869f2-1967-4606-ace1-d16ad4e3028d', 'name': '', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'network_id': 'd8bab2a8-ae39-437b-b505-ebdd107b8f13', 'ip_version': 4, 'cidr': '64.237.16.128/26', 'allocation_pools': [{'start': '64.237.16.130', 'end': '64.237.16.190'}], 'gateway_ip': '64.237.16.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '64.237.16.130', 'tags': [], 'project_id': '5fd79c077cba4741954cfe9d006d0816'}}
2026-06-04 20:12:55,602 - INFO - Created VN test_vnv6dn
2026-06-04 20:12:55,615 - DEBUG - VN test_vnv6dn UUID is d8bab2a8-ae39-437b-b505-ebdd107b8f13
2026-06-04 20:12:55,951 - DEBUG - Services list from nova: [, , , ]
2026-06-04 20:12:57,203 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-2)
2026-06-04 20:12:58,816 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-1)
2026-06-04 20:12:58,816 - INFO - Waiting for VM source_vm to be up..
2026-06-04 20:12:58,916 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-04 20:13:04,001 - DEBUG - VM is in ACTIVE state now
2026-06-04 20:13:04,001 - INFO - VM name : source_vm
2026-06-04 20:13:04,082 - DEBUG - VM source_vm ID is 1d703922-e96c-4e71-90a7-e8ef54ba7d05
2026-06-04 20:13:04,122 - DEBUG - VM source_vm launched on Node an-jenkins-deploy-platform-ansible-os-5893-2
2026-06-04 20:13:04,217 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine/1d703922-e96c-4e71-90a7-e8ef54ba7d05
2026-06-04 20:13:04,526 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine/1d703922-e96c-4e71-90a7-e8ef54ba7d05
2026-06-04 20:13:04,562 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine-interface/00718a17-b6db-45b0-93e5-a5dc2267b4cf
2026-06-04 20:13:07,742 - 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 1020ms')
2026-06-04 20:13:07,742 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM source_vm failed!
2026-06-04 20:13:07,756 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-56328416:test_vnv6sr is 2001::101:1 and allocation pool is NOT set
2026-06-04 20:13:07,757 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-56328416:test_vnv6sr is 201.191.41.1 and allocation pool is NOT set
2026-06-04 20:13:09,823 - 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.45 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.335 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.335/2.393/4.452/2.058 ms')
2026-06-04 20:13:09,823 - INFO - Ping to Metadata IP 169.254.0.3 of VM source_vm passed
2026-06-04 20:13:09,891 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:13:09,891 - DEBUG - Waiting to SSH to VM source_vm, IP 201.191.41.3, Port 22
2026-06-04 20:13:10,047 - DEBUG - VM source_vm is ready for SSH connections
2026-06-04 20:13:10,048 - INFO - Waiting for VM dest_vm to be up..
2026-06-04 20:13:10,158 - DEBUG - VM is in ACTIVE state now
2026-06-04 20:13:10,158 - INFO - VM name : dest_vm
2026-06-04 20:13:10,251 - DEBUG - VM dest_vm ID is eef29f07-a068-4305-8fea-f9ce06d5a9e7
2026-06-04 20:13:10,251 - DEBUG - VM dest_vm launched on Node an-jenkins-deploy-platform-ansible-os-5893-1
2026-06-04 20:13:10,343 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine/eef29f07-a068-4305-8fea-f9ce06d5a9e7
2026-06-04 20:13:10,355 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine-interface/81b60017-80c3-4b5d-a769-f8d28c5383a5
2026-06-04 20:13:11,526 - 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=5.87 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.450 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.450/3.160/5.870/2.710 ms')
2026-06-04 20:13:11,526 - INFO - Ping to Metadata IP 169.254.0.5 of VM dest_vm passed
2026-06-04 20:13:11,598 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:13:11,598 - DEBUG - Waiting to SSH to VM dest_vm, IP 64.237.16.131, Port 22
2026-06-04 20:13:11,770 - DEBUG - VM dest_vm is ready for SSH connections
2026-06-04 20:13:11,776 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-56328416: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-56328416: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-04 20:13:12,101 - INFO - Attaching policy allow_all to vn test_vnv6sr
2026-06-04 20:13:12,468 - INFO - Attaching policy allow_all to vn test_vnv6dn
2026-06-04 20:13:12,733 - INFO - Configure the policy with allow any
2026-06-04 20:13:13,035 - DEBUG - Response for create_network : {'network': {'id': '4293a0b2-1561-49fa-a0c8-fea72630e8b9', 'name': 'vn1', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'project_id': '5fd79c077cba4741954cfe9d006d0816', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-56328416', 'vn1'], 'port_security_enabled': True, 'description': ''}}
2026-06-04 20:13:13,239 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd28c42af-fb2c-400f-b111-0b302659de28', 'name': '', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'network_id': '4293a0b2-1561-49fa-a0c8-fea72630e8b9', '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': '5fd79c077cba4741954cfe9d006d0816'}}
2026-06-04 20:13:13,262 - INFO - Created VN vn1
2026-06-04 20:13:13,272 - DEBUG - VN vn1 UUID is 4293a0b2-1561-49fa-a0c8-fea72630e8b9
2026-06-04 20:13:13,615 - DEBUG - Response for create_network : {'network': {'id': 'fa0aebe7-1d88-4b4d-b152-8f2a0317cd17', 'name': 'vn2', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'project_id': '5fd79c077cba4741954cfe9d006d0816', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-56328416', 'vn2'], 'port_security_enabled': True, 'description': ''}}
2026-06-04 20:13:13,895 - DEBUG - Response for create_subnet : {'subnet': {'id': '90609d43-18a2-490a-82c5-b3df38bf5caa', 'name': '', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'network_id': 'fa0aebe7-1d88-4b4d-b152-8f2a0317cd17', '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': '5fd79c077cba4741954cfe9d006d0816'}}
2026-06-04 20:13:13,922 - INFO - Created VN vn2
2026-06-04 20:13:13,935 - DEBUG - VN vn2 UUID is fa0aebe7-1d88-4b4d-b152-8f2a0317cd17
2026-06-04 20:13:14,014 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-56328416: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-56328416: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-04 20:13:14,341 - INFO - Attaching policy sec_grp_policy_ctest-random-83944013 to vn vn1
2026-06-04 20:13:14,701 - INFO - Attaching policy sec_grp_policy_ctest-random-83944013 to vn vn2
2026-06-04 20:13:16,429 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-2)
2026-06-04 20:13:18,032 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-1)
2026-06-04 20:13:18,093 - INFO - ================================================================================
2026-06-04 20:13:18,094 - INFO - STARTING TEST : test_check_per_peer_on_control
2026-06-04 20:13:18,094 - INFO - TEST DESCRIPTION :
Description: Verify per peer md5 and specific protocol on all ports and policy with allow all between VN's
2026-06-04 20:13:19,356 - DEBUG - Skipping xmpp flap check
2026-06-04 20:13:19,357 - INFO - Initial checks done. Running the testcase now
2026-06-04 20:13:19,357 - INFO -
2026-06-04 20:13:19,357 - INFO - config per peer with auth_data None
2026-06-04 20:13:19,930 - INFO - configure MD5 on host d7c5d44b-1fdd-4f44-bba0-1385ab46a32a
2026-06-04 20:13:20,010 - INFO - config per peer with auth_data None
2026-06-04 20:13:20,594 - INFO - configure MD5 on host 2c207bf0-9b02-4820-83c4-a08612df989e
2026-06-04 20:13:20,686 - INFO - config per peer with auth_data None
2026-06-04 20:13:21,250 - INFO - configure MD5 on host d5ac6658-bfe4-4230-840f-51e82a8e2f53
2026-06-04 20:13:21,350 - INFO - check BGP peering is up before setting md5 config
2026-06-04 20:13:21,350 - INFO - Check BGP staus between peers
2026-06-04 20:13:21,363 - INFO - config per peer with auth_data {'key_items': [{'key': 'juniper', 'key_id': 0}], 'key_type': 'md5'}
2026-06-04 20:13:21,963 - INFO - Check BGP staus between peers
2026-06-04 20:13:21,975 - DEBUG - Check the BGP connection on 10.0.0.50
2026-06-04 20:13:21,975 - DEBUG - Check the BGP connection on 10.0.0.50
2026-06-04 20:13:31,976 - INFO - Check BGP staus between peers
2026-06-04 20:13:31,988 - INFO - remove md5 configured on host d7c5d44b-1fdd-4f44-bba0-1385ab46a32a
2026-06-04 20:13:31,988 - INFO - config per peer with auth_data None
2026-06-04 20:13:32,515 - INFO - configure MD5 on host d7c5d44b-1fdd-4f44-bba0-1385ab46a32a
2026-06-04 20:13:32,606 - INFO - remove md5 configured on host 2c207bf0-9b02-4820-83c4-a08612df989e
2026-06-04 20:13:32,606 - INFO - config per peer with auth_data None
2026-06-04 20:13:33,183 - INFO - configure MD5 on host 2c207bf0-9b02-4820-83c4-a08612df989e
2026-06-04 20:13:33,262 - INFO - remove md5 configured on host d5ac6658-bfe4-4230-840f-51e82a8e2f53
2026-06-04 20:13:33,262 - INFO - config per peer with auth_data None
2026-06-04 20:13:33,866 - INFO - configure MD5 on host d5ac6658-bfe4-4230-840f-51e82a8e2f53
2026-06-04 20:13:33,954 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD
2026-06-04 20:13:33,955 - INFO - Deleting VM vn2_vm_0
2026-06-04 20:13:33,955 - ERROR - VM vn2_vm_0 has failed to come up
2026-06-04 20:13:33,955 - ERROR - Nova failed to get host of the VM
2026-06-04 20:13:33,955 - ERROR - VM vn2_vm_0 has failed to come up
2026-06-04 20:13:33,955 - ERROR - Nova failed to get host of the VM
2026-06-04 20:13:34,028 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD
2026-06-04 20:13:34,029 - INFO - Deleting VM vn1_vm_0
2026-06-04 20:13:34,029 - ERROR - VM vn1_vm_0 has failed to come up
2026-06-04 20:13:34,029 - ERROR - Nova failed to get host of the VM
2026-06-04 20:13:34,029 - ERROR - VM vn1_vm_0 has failed to come up
2026-06-04 20:13:34,029 - ERROR - Nova failed to get host of the VM
2026-06-04 20:13:34,096 - INFO - Dettaching policy sec_grp_policy_ctest-random-83944013 from vn vn2
2026-06-04 20:13:34,263 - INFO - Dettaching policy sec_grp_policy_ctest-random-83944013 from vn vn1
2026-06-04 20:13:34,520 - INFO - Deleted policy sec_grp_policy_ctest-random-83944013
2026-06-04 20:13:34,520 - INFO - Deleting VN vn2
2026-06-04 20:13:34,596 - DEBUG - VN fa0aebe7-1d88-4b4d-b152-8f2a0317cd17 still in use: Unable to complete operation on network fa0aebe7-1d88-4b4d-b152-8f2a0317cd17. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-182846ba-ede6-4b71-b31d-c36475cf78cf']
2026-06-04 20:13:34,596 - WARNING - Deleting VN vn2 failed..Will retry
2026-06-04 20:13:36,742 - DEBUG - Response for deleting network ()
2026-06-04 20:13:36,742 - INFO - Deleting VN vn1
2026-06-04 20:13:36,901 - DEBUG - Response for deleting network ()
2026-06-04 20:13:36,901 - INFO - Dettaching policy allow_all from vn test_vnv6dn
2026-06-04 20:13:37,089 - INFO - Dettaching policy allow_all from vn test_vnv6sr
2026-06-04 20:13:37,351 - INFO - Deleted policy allow_all
2026-06-04 20:13:37,351 - INFO - Deleting VM dest_vm
2026-06-04 20:13:37,435 - INFO - Deleting VM source_vm
2026-06-04 20:13:37,516 - INFO - Deleting VN test_vnv6dn
2026-06-04 20:13:37,572 - DEBUG - VN d8bab2a8-ae39-437b-b505-ebdd107b8f13 still in use: Unable to complete operation on network d8bab2a8-ae39-437b-b505-ebdd107b8f13. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-bb2bf1a2-64fd-4233-b9b4-9b179269617e']
2026-06-04 20:13:37,573 - WARNING - Deleting VN test_vnv6dn failed..Will retry
2026-06-04 20:13:39,746 - DEBUG - Response for deleting network ()
2026-06-04 20:13:39,746 - INFO - Deleting VN test_vnv6sr
2026-06-04 20:13:39,929 - DEBUG - Response for deleting network ()
2026-06-04 20:13:41,188 - DEBUG - Skipping xmpp flap check
2026-06-04 20:13:41,188 - INFO - END TEST : test_check_per_peer_on_control : PASSED[0:00:23]
2026-06-04 20:13:41,188 - INFO - --------------------------------------------------------------------------------
2026-06-04 20:13:41,523 - DEBUG - Response for create_network : {'network': {'id': 'f7865850-136e-4073-9806-bd8f30679376', 'name': 'test_vnv6sr', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'project_id': '5fd79c077cba4741954cfe9d006d0816', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-56328416', 'test_vnv6sr'], 'port_security_enabled': True, 'description': ''}}
2026-06-04 20:13:41,801 - DEBUG - Response for create_subnet : {'subnet': {'id': '8870a6fe-d783-43e5-a0c3-b066aaa196ed', 'name': '', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'network_id': 'f7865850-136e-4073-9806-bd8f30679376', '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': '5fd79c077cba4741954cfe9d006d0816'}}
2026-06-04 20:13:42,055 - DEBUG - Response for create_subnet : {'subnet': {'id': '5c9219ad-3496-46db-9515-11ed8d53370a', 'name': '', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'network_id': 'f7865850-136e-4073-9806-bd8f30679376', 'ip_version': 4, 'cidr': '35.50.53.128/26', 'allocation_pools': [{'start': '35.50.53.130', 'end': '35.50.53.190'}], 'gateway_ip': '35.50.53.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '35.50.53.130', 'tags': [], 'project_id': '5fd79c077cba4741954cfe9d006d0816'}}
2026-06-04 20:13:42,077 - INFO - Created VN test_vnv6sr
2026-06-04 20:13:42,088 - DEBUG - VN test_vnv6sr UUID is f7865850-136e-4073-9806-bd8f30679376
2026-06-04 20:13:42,451 - DEBUG - Response for create_network : {'network': {'id': 'e55c3019-9a92-41a4-9eb9-729069b4ac44', 'name': 'test_vnv6dn', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'project_id': '5fd79c077cba4741954cfe9d006d0816', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-56328416', 'test_vnv6dn'], 'port_security_enabled': True, 'description': ''}}
2026-06-04 20:13:42,713 - DEBUG - Response for create_subnet : {'subnet': {'id': 'fc2f05ea-c56c-41c2-8f3d-3f602c5b09ce', 'name': '', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'network_id': 'e55c3019-9a92-41a4-9eb9-729069b4ac44', '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': '5fd79c077cba4741954cfe9d006d0816'}}
2026-06-04 20:13:42,961 - DEBUG - Response for create_subnet : {'subnet': {'id': 'cc6ece7e-d2b1-4840-b31e-bd32a5324494', 'name': '', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'network_id': 'e55c3019-9a92-41a4-9eb9-729069b4ac44', 'ip_version': 4, 'cidr': '162.39.41.128/26', 'allocation_pools': [{'start': '162.39.41.130', 'end': '162.39.41.190'}], 'gateway_ip': '162.39.41.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '162.39.41.130', 'tags': [], 'project_id': '5fd79c077cba4741954cfe9d006d0816'}}
2026-06-04 20:13:42,986 - INFO - Created VN test_vnv6dn
2026-06-04 20:13:42,997 - DEBUG - VN test_vnv6dn UUID is e55c3019-9a92-41a4-9eb9-729069b4ac44
2026-06-04 20:13:44,527 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-2)
2026-06-04 20:13:46,333 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-1)
2026-06-04 20:13:46,333 - INFO - Waiting for VM source_vm to be up..
2026-06-04 20:13:46,473 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-04 20:13:51,560 - DEBUG - VM is in ACTIVE state now
2026-06-04 20:13:51,560 - INFO - VM name : source_vm
2026-06-04 20:13:51,657 - DEBUG - VM source_vm ID is 4c73b305-1a27-4275-9cef-5cae00342180
2026-06-04 20:13:51,657 - DEBUG - VM source_vm launched on Node an-jenkins-deploy-platform-ansible-os-5893-2
2026-06-04 20:13:51,736 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine/4c73b305-1a27-4275-9cef-5cae00342180
2026-06-04 20:13:51,747 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine-interface/0dc8bca6-417b-4683-8d86-4dfabf5267ab
2026-06-04 20:13:54,904 - 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 1009ms')
2026-06-04 20:13:54,904 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM source_vm failed!
2026-06-04 20:13:54,920 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-56328416:test_vnv6sr is 2001::101:1 and allocation pool is NOT set
2026-06-04 20:13:54,920 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-56328416:test_vnv6sr is 35.50.53.129 and allocation pool is NOT set
2026-06-04 20:13:56,979 - 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=14.1 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.08 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1000ms\r\nrtt min/avg/max/mdev = 2.076/8.111/14.146/6.035 ms')
2026-06-04 20:13:56,979 - INFO - Ping to Metadata IP 169.254.0.3 of VM source_vm passed
2026-06-04 20:13:57,051 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:13:57,051 - DEBUG - Waiting to SSH to VM source_vm, IP 35.50.53.131, Port 22
2026-06-04 20:13:57,208 - DEBUG - VM source_vm is ready for SSH connections
2026-06-04 20:13:57,208 - INFO - Waiting for VM dest_vm to be up..
2026-06-04 20:13:57,289 - DEBUG - VM is in ACTIVE state now
2026-06-04 20:13:57,289 - INFO - VM name : dest_vm
2026-06-04 20:13:57,369 - DEBUG - VM dest_vm ID is a9899de1-0b33-47b4-9ae3-a5a66e8fcfc2
2026-06-04 20:13:57,369 - DEBUG - VM dest_vm launched on Node an-jenkins-deploy-platform-ansible-os-5893-1
2026-06-04 20:13:57,449 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine/a9899de1-0b33-47b4-9ae3-a5a66e8fcfc2
2026-06-04 20:13:57,459 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine-interface/8013925e-41a2-4a89-a73f-2d2ae71a6d38
2026-06-04 20:13:58,623 - 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=3.70 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=1.15 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 = 1.145/2.420/3.695/1.275 ms')
2026-06-04 20:13:58,623 - INFO - Ping to Metadata IP 169.254.0.5 of VM dest_vm passed
2026-06-04 20:13:58,692 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 20:13:58,692 - DEBUG - Waiting to SSH to VM dest_vm, IP 162.39.41.131, Port 22
2026-06-04 20:13:58,853 - DEBUG - VM dest_vm is ready for SSH connections
2026-06-04 20:13:58,859 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-56328416: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-56328416: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-04 20:13:59,189 - INFO - Attaching policy allow_all to vn test_vnv6sr
2026-06-04 20:13:59,538 - INFO - Attaching policy allow_all to vn test_vnv6dn
2026-06-04 20:13:59,824 - INFO - Configure the policy with allow any
2026-06-04 20:14:00,131 - DEBUG - Response for create_network : {'network': {'id': 'edd691f4-3398-4d75-bd1b-2bc3eca17e7f', 'name': 'vn1', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'project_id': '5fd79c077cba4741954cfe9d006d0816', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-56328416', 'vn1'], 'port_security_enabled': True, 'description': ''}}
2026-06-04 20:14:00,363 - DEBUG - Response for create_subnet : {'subnet': {'id': '1f09f568-0ef5-460e-bcf2-54466937b6d7', 'name': '', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'network_id': 'edd691f4-3398-4d75-bd1b-2bc3eca17e7f', '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': '5fd79c077cba4741954cfe9d006d0816'}}
2026-06-04 20:14:00,387 - INFO - Created VN vn1
2026-06-04 20:14:00,398 - DEBUG - VN vn1 UUID is edd691f4-3398-4d75-bd1b-2bc3eca17e7f
2026-06-04 20:14:00,735 - DEBUG - Response for create_network : {'network': {'id': 'fe38b60e-079f-44b7-ae55-087b710d3965', 'name': 'vn2', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'project_id': '5fd79c077cba4741954cfe9d006d0816', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-56328416', 'vn2'], 'port_security_enabled': True, 'description': ''}}
2026-06-04 20:14:00,972 - DEBUG - Response for create_subnet : {'subnet': {'id': '975387a8-95b0-494a-9151-1145560835b7', 'name': '', 'tenant_id': '5fd79c077cba4741954cfe9d006d0816', 'network_id': 'fe38b60e-079f-44b7-ae55-087b710d3965', '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': '5fd79c077cba4741954cfe9d006d0816'}}
2026-06-04 20:14:00,992 - INFO - Created VN vn2
2026-06-04 20:14:01,005 - DEBUG - VN vn2 UUID is fe38b60e-079f-44b7-ae55-087b710d3965
2026-06-04 20:14:01,118 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-56328416: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-56328416: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-04 20:14:01,454 - INFO - Attaching policy sec_grp_policy_ctest-random-65505600 to vn vn1
2026-06-04 20:14:01,832 - INFO - Attaching policy sec_grp_policy_ctest-random-65505600 to vn vn2
2026-06-04 20:14:03,581 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-2)
2026-06-04 20:14:05,153 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-1)
2026-06-04 20:14:05,214 - INFO - ================================================================================
2026-06-04 20:14:05,214 - INFO - STARTING TEST : test_create_md5_on_control
2026-06-04 20:14:05,214 - INFO - TEST DESCRIPTION :
Description: Verify md5 with allow specific protocol on all ports and policy with allow all between VN's
2026-06-04 20:14:06,504 - DEBUG - Skipping xmpp flap check
2026-06-04 20:14:06,504 - INFO - Initial checks done. Running the testcase now
2026-06-04 20:14:06,504 - INFO -
2026-06-04 20:14:06,504 - INFO - config md5 on each host with auth_data None
2026-06-04 20:14:06,504 - INFO - config per peer with auth_data None
2026-06-04 20:14:07,050 - INFO - configure MD5 on host d7c5d44b-1fdd-4f44-bba0-1385ab46a32a
2026-06-04 20:14:07,126 - INFO - config per peer with auth_data None
2026-06-04 20:14:07,670 - INFO - configure MD5 on host 2c207bf0-9b02-4820-83c4-a08612df989e
2026-06-04 20:14:07,750 - INFO - config per peer with auth_data None
2026-06-04 20:14:08,302 - INFO - configure MD5 on host d5ac6658-bfe4-4230-840f-51e82a8e2f53
2026-06-04 20:14:08,386 - INFO - check if BGP between peers are up before setting md5
2026-06-04 20:14:08,387 - INFO - Check BGP staus between peers
2026-06-04 20:14:08,406 - INFO - setting MD5 config on host d7c5d44b-1fdd-4f44-bba0-1385ab46a32a
2026-06-04 20:14:08,407 - INFO - configure MD5 on host d7c5d44b-1fdd-4f44-bba0-1385ab46a32a
2026-06-04 20:14:08,490 - INFO - setting MD5 config on host 2c207bf0-9b02-4820-83c4-a08612df989e
2026-06-04 20:14:08,490 - INFO - configure MD5 on host 2c207bf0-9b02-4820-83c4-a08612df989e
2026-06-04 20:14:08,570 - INFO - setting MD5 config on host d5ac6658-bfe4-4230-840f-51e82a8e2f53
2026-06-04 20:14:08,570 - INFO - configure MD5 on host d5ac6658-bfe4-4230-840f-51e82a8e2f53
2026-06-04 20:14:08,650 - INFO - check if BGP peering is up after md5 config
2026-06-04 20:14:08,650 - INFO - Check BGP staus between peers
2026-06-04 20:14:08,660 - DEBUG - Check the BGP connection on 10.0.0.50
2026-06-04 20:14:08,660 - DEBUG - Check the BGP connection on 10.0.0.50
2026-06-04 20:14:18,660 - INFO - Check BGP staus between peers
2026-06-04 20:14:18,671 - INFO - remove md5 configured on host d7c5d44b-1fdd-4f44-bba0-1385ab46a32a
2026-06-04 20:14:18,671 - INFO - config per peer with auth_data None
2026-06-04 20:14:19,202 - INFO - configure MD5 on host d7c5d44b-1fdd-4f44-bba0-1385ab46a32a
2026-06-04 20:14:19,294 - INFO - remove md5 configured on host 2c207bf0-9b02-4820-83c4-a08612df989e
2026-06-04 20:14:19,294 - INFO - config per peer with auth_data None
2026-06-04 20:14:19,858 - INFO - configure MD5 on host 2c207bf0-9b02-4820-83c4-a08612df989e
2026-06-04 20:14:19,950 - INFO - remove md5 configured on host d5ac6658-bfe4-4230-840f-51e82a8e2f53
2026-06-04 20:14:19,950 - INFO - config per peer with auth_data None
2026-06-04 20:14:20,534 - INFO - configure MD5 on host d5ac6658-bfe4-4230-840f-51e82a8e2f53
2026-06-04 20:14:20,622 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD
2026-06-04 20:14:20,622 - INFO - Deleting VM vn2_vm_0
2026-06-04 20:14:20,622 - ERROR - VM vn2_vm_0 has failed to come up
2026-06-04 20:14:20,622 - ERROR - Nova failed to get host of the VM
2026-06-04 20:14:20,622 - ERROR - VM vn2_vm_0 has failed to come up
2026-06-04 20:14:20,622 - ERROR - Nova failed to get host of the VM
2026-06-04 20:14:20,687 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD
2026-06-04 20:14:20,688 - INFO - Deleting VM vn1_vm_0
2026-06-04 20:14:20,688 - ERROR - VM vn1_vm_0 has failed to come up
2026-06-04 20:14:20,688 - ERROR - Nova failed to get host of the VM
2026-06-04 20:14:20,688 - ERROR - VM vn1_vm_0 has failed to come up
2026-06-04 20:14:20,688 - ERROR - Nova failed to get host of the VM
2026-06-04 20:14:20,752 - INFO - Dettaching policy sec_grp_policy_ctest-random-65505600 from vn vn2
2026-06-04 20:14:20,918 - INFO - Dettaching policy sec_grp_policy_ctest-random-65505600 from vn vn1
2026-06-04 20:14:21,158 - INFO - Deleted policy sec_grp_policy_ctest-random-65505600
2026-06-04 20:14:21,159 - INFO - Deleting VN vn2
2026-06-04 20:14:21,213 - DEBUG - VN fe38b60e-079f-44b7-ae55-087b710d3965 still in use: Unable to complete operation on network fe38b60e-079f-44b7-ae55-087b710d3965. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-9ef2cc7e-8a4f-47ce-91bf-3fcdfb973369']
2026-06-04 20:14:21,213 - WARNING - Deleting VN vn2 failed..Will retry
2026-06-04 20:14:23,405 - DEBUG - Response for deleting network ()
2026-06-04 20:14:23,405 - INFO - Deleting VN vn1
2026-06-04 20:14:23,551 - DEBUG - Response for deleting network ()
2026-06-04 20:14:23,551 - INFO - Dettaching policy allow_all from vn test_vnv6dn
2026-06-04 20:14:23,711 - INFO - Dettaching policy allow_all from vn test_vnv6sr
2026-06-04 20:14:24,083 - INFO - Deleted policy allow_all
2026-06-04 20:14:24,084 - INFO - Deleting VM dest_vm
2026-06-04 20:14:24,153 - INFO - Deleting VM source_vm
2026-06-04 20:14:24,224 - INFO - Deleting VN test_vnv6dn
2026-06-04 20:14:24,271 - DEBUG - VN e55c3019-9a92-41a4-9eb9-729069b4ac44 still in use: Unable to complete operation on network e55c3019-9a92-41a4-9eb9-729069b4ac44. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-c78e10ba-d313-4bee-9a54-877481b7c5ab']
2026-06-04 20:14:24,271 - WARNING - Deleting VN test_vnv6dn failed..Will retry
2026-06-04 20:14:26,424 - DEBUG - Response for deleting network ()
2026-06-04 20:14:26,424 - INFO - Deleting VN test_vnv6sr
2026-06-04 20:14:26,602 - DEBUG - Response for deleting network ()
2026-06-04 20:14:27,868 - DEBUG - Skipping xmpp flap check
2026-06-04 20:14:27,868 - INFO - END TEST : test_create_md5_on_control : PASSED[0:00:22]
2026-06-04 20:14:27,868 - INFO - --------------------------------------------------------------------------------
2026-06-04 20:14:28,560 - INFO - Deleted project: ctest-TestMd5testsOnControl-56328416, ID : 5fd79c07-7cba-4741-954c-fe9d006d0816