2026-04-03 18:46:06,304 - INFO - Domain Default found not creating 2026-04-03 18:46:06,469 - INFO - Project ctest-TestMd5testsOnControl-36964590 not found, creating it 2026-04-03 18:46:06,982 - INFO - Created Project:ctest-TestMd5testsOnControl-36964590, ID : 3ae58269-fff4-44f8-a83a-fada4b3727f2 2026-04-03 18:46:09,188 - DEBUG - Response for create_network : {'network': {'id': 'b54d31bd-122c-40f4-8cb6-e3966793f93c', 'name': 'test_vnv6sr', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'project_id': '3ae58269fff444f8a83afada4b3727f2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-36964590', 'test_vnv6sr'], 'port_security_enabled': True, 'description': ''}} 2026-04-03 18:46:09,536 - DEBUG - Response for create_subnet : {'subnet': {'id': '3e9a1338-f0cd-46f1-aa59-91340f1940da', 'name': '', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'network_id': 'b54d31bd-122c-40f4-8cb6-e3966793f93c', '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': '3ae58269fff444f8a83afada4b3727f2'}} 2026-04-03 18:46:09,793 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f21db599-325b-4dbb-9195-b40572cdda36', 'name': '', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'network_id': 'b54d31bd-122c-40f4-8cb6-e3966793f93c', 'ip_version': 4, 'cidr': '78.38.202.192/26', 'allocation_pools': [{'start': '78.38.202.194', 'end': '78.38.202.254'}], 'gateway_ip': '78.38.202.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '78.38.202.194', 'tags': [], 'project_id': '3ae58269fff444f8a83afada4b3727f2'}} 2026-04-03 18:46:09,816 - INFO - Created VN test_vnv6sr 2026-04-03 18:46:09,830 - DEBUG - VN test_vnv6sr UUID is b54d31bd-122c-40f4-8cb6-e3966793f93c 2026-04-03 18:46:10,200 - DEBUG - Response for create_network : {'network': {'id': 'f15c2ab3-095b-40b2-b724-1022e591c3a4', 'name': 'test_vnv6dn', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'project_id': '3ae58269fff444f8a83afada4b3727f2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-36964590', 'test_vnv6dn'], 'port_security_enabled': True, 'description': ''}} 2026-04-03 18:46:10,423 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ecc4c682-b12e-43b1-93b4-06eacc556e29', 'name': '', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'network_id': 'f15c2ab3-095b-40b2-b724-1022e591c3a4', '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': '3ae58269fff444f8a83afada4b3727f2'}} 2026-04-03 18:46:10,639 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f8857e85-219a-44d3-9a83-317e1c590eaa', 'name': '', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'network_id': 'f15c2ab3-095b-40b2-b724-1022e591c3a4', 'ip_version': 4, 'cidr': '68.188.218.64/26', 'allocation_pools': [{'start': '68.188.218.66', 'end': '68.188.218.126'}], 'gateway_ip': '68.188.218.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '68.188.218.66', 'tags': [], 'project_id': '3ae58269fff444f8a83afada4b3727f2'}} 2026-04-03 18:46:10,664 - INFO - Created VN test_vnv6dn 2026-04-03 18:46:10,678 - DEBUG - VN test_vnv6dn UUID is f15c2ab3-095b-40b2-b724-1022e591c3a4 2026-04-03 18:46:10,962 - DEBUG - Services list from nova: [, , , ] 2026-04-03 18:46:12,129 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5589-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5589-2) 2026-04-03 18:46:13,618 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5589-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5589-1) 2026-04-03 18:46:13,618 - INFO - Waiting for VM source_vm to be up.. 2026-04-03 18:46:13,724 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-04-03 18:46:18,809 - DEBUG - VM is in ACTIVE state now 2026-04-03 18:46:18,809 - INFO - VM name : source_vm 2026-04-03 18:46:18,892 - DEBUG - VM source_vm ID is bde3b6a8-ffce-4cae-b05a-d15670992ae7 2026-04-03 18:46:18,917 - DEBUG - VM source_vm launched on Node an-jenkins-deploy-platform-ansible-os-5589-2 2026-04-03 18:46:18,999 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine/bde3b6a8-ffce-4cae-b05a-d15670992ae7 2026-04-03 18:46:19,300 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine/bde3b6a8-ffce-4cae-b05a-d15670992ae7 2026-04-03 18:46:19,335 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/10e8bcf4-ad49-46ec-abf9-d9cabdd40892 2026-04-03 18:46:22,506 - 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-04-03 18:46:22,506 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM source_vm failed! 2026-04-03 18:46:22,521 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-36964590:test_vnv6sr is 2001::101:1 and allocation pool is NOT set 2026-04-03 18:46:22,521 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-36964590:test_vnv6sr is 78.38.202.193 and allocation pool is NOT set 2026-04-03 18:46:24,580 - 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.14 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.449 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 = 0.449/2.293/4.138/1.844 ms') 2026-04-03 18:46:24,580 - INFO - Ping to Metadata IP 169.254.0.3 of VM source_vm passed 2026-04-03 18:46:24,652 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-03 18:46:24,653 - DEBUG - Waiting to SSH to VM source_vm, IP 78.38.202.195, Port 22 2026-04-03 18:46:24,819 - DEBUG - VM source_vm is ready for SSH connections 2026-04-03 18:46:24,819 - INFO - Waiting for VM dest_vm to be up.. 2026-04-03 18:46:24,907 - DEBUG - VM is in ACTIVE state now 2026-04-03 18:46:24,907 - INFO - VM name : dest_vm 2026-04-03 18:46:25,006 - DEBUG - VM dest_vm ID is ef60fd81-b9d6-4347-9c08-ac6047046453 2026-04-03 18:46:25,006 - DEBUG - VM dest_vm launched on Node an-jenkins-deploy-platform-ansible-os-5589-1 2026-04-03 18:46:25,095 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine/ef60fd81-b9d6-4347-9c08-ac6047046453 2026-04-03 18:46:25,104 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/52a21350-9af1-4430-96b6-93a2cdec8210 2026-04-03 18:46:26,269 - 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=6.86 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.612 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.612/3.734/6.856/3.122 ms') 2026-04-03 18:46:26,269 - INFO - Ping to Metadata IP 169.254.0.5 of VM dest_vm passed 2026-04-03 18:46:26,342 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-03 18:46:26,342 - DEBUG - Waiting to SSH to VM dest_vm, IP 68.188.218.67, Port 22 2026-04-03 18:46:26,409 - DEBUG - Error on ssh to cirros@169.254.0.5:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.5/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.5/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.5/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-04-03 18:46:26,492 - DEBUG - VM dest_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-04-03 18:46:31,493 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-03 18:46:31,494 - DEBUG - Waiting to SSH to VM dest_vm, IP 68.188.218.67, Port 22 2026-04-03 18:46:31,662 - DEBUG - VM dest_vm is ready for SSH connections 2026-04-03 18:46:31,667 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-36964590: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-36964590: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-03 18:46:32,006 - INFO - Attaching policy allow_all to vn test_vnv6sr 2026-04-03 18:46:32,358 - INFO - Attaching policy allow_all to vn test_vnv6dn 2026-04-03 18:46:32,654 - INFO - Configure the policy with allow any 2026-04-03 18:46:32,981 - DEBUG - Response for create_network : {'network': {'id': '72656429-5340-4b80-a5ac-3a9168d89916', 'name': 'vn1', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'project_id': '3ae58269fff444f8a83afada4b3727f2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-36964590', 'vn1'], 'port_security_enabled': True, 'description': ''}} 2026-04-03 18:46:33,209 - DEBUG - Response for create_subnet : {'subnet': {'id': '66ba29f6-0eaa-4fa5-b892-9d8abd0fb255', 'name': '', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'network_id': '72656429-5340-4b80-a5ac-3a9168d89916', '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': '3ae58269fff444f8a83afada4b3727f2'}} 2026-04-03 18:46:33,233 - INFO - Created VN vn1 2026-04-03 18:46:33,247 - DEBUG - VN vn1 UUID is 72656429-5340-4b80-a5ac-3a9168d89916 2026-04-03 18:46:33,621 - DEBUG - Response for create_network : {'network': {'id': 'a4920462-54b0-43fc-98de-9a68a9d7b2a2', 'name': 'vn2', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'project_id': '3ae58269fff444f8a83afada4b3727f2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-36964590', 'vn2'], 'port_security_enabled': True, 'description': ''}} 2026-04-03 18:46:33,857 - DEBUG - Response for create_subnet : {'subnet': {'id': '0c0219a6-e66f-473e-b8c1-a754885e2f97', 'name': '', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'network_id': 'a4920462-54b0-43fc-98de-9a68a9d7b2a2', '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': '3ae58269fff444f8a83afada4b3727f2'}} 2026-04-03 18:46:33,887 - INFO - Created VN vn2 2026-04-03 18:46:33,900 - DEBUG - VN vn2 UUID is a4920462-54b0-43fc-98de-9a68a9d7b2a2 2026-04-03 18:46:33,980 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-36964590: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-36964590: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-03 18:46:34,319 - INFO - Attaching policy sec_grp_policy_ctest-random-48884153 to vn vn1 2026-04-03 18:46:34,687 - INFO - Attaching policy sec_grp_policy_ctest-random-48884153 to vn vn2 2026-04-03 18:46:36,329 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5589-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5589-2) 2026-04-03 18:46:37,962 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5589-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5589-1) 2026-04-03 18:46:38,039 - INFO - ================================================================================ 2026-04-03 18:46:38,040 - INFO - STARTING TEST : test_check_per_peer_on_control 2026-04-03 18:46:38,040 - INFO - TEST DESCRIPTION : Description: Verify per peer md5 and specific protocol on all ports and policy with allow all between VN's 2026-04-03 18:46:39,344 - DEBUG - Skipping xmpp flap check 2026-04-03 18:46:39,344 - INFO - Initial checks done. Running the testcase now 2026-04-03 18:46:39,344 - INFO - 2026-04-03 18:46:39,344 - INFO - config per peer with auth_data None 2026-04-03 18:46:39,939 - INFO - configure MD5 on host 4333136b-4c0f-48fb-9b98-7408191083b4 2026-04-03 18:46:40,027 - INFO - config per peer with auth_data None 2026-04-03 18:46:40,643 - INFO - configure MD5 on host 3346399a-34ba-41bb-9001-d8fb66baea97 2026-04-03 18:46:40,747 - INFO - config per peer with auth_data None 2026-04-03 18:46:41,361 - INFO - configure MD5 on host a7a5d432-3939-462d-8909-8d6124bcfb7c 2026-04-03 18:46:41,455 - INFO - check BGP peering is up before setting md5 config 2026-04-03 18:46:41,455 - INFO - Check BGP staus between peers 2026-04-03 18:46:41,467 - INFO - config per peer with auth_data {'key_items': [{'key': 'juniper', 'key_id': 0}], 'key_type': 'md5'} 2026-04-03 18:46:42,151 - INFO - Check BGP staus between peers 2026-04-03 18:46:42,161 - DEBUG - Check the BGP connection on 10.0.0.22 2026-04-03 18:46:42,161 - DEBUG - Check the BGP connection on 10.0.0.22 2026-04-03 18:46:52,162 - INFO - Check BGP staus between peers 2026-04-03 18:46:52,176 - INFO - remove md5 configured on host 4333136b-4c0f-48fb-9b98-7408191083b4 2026-04-03 18:46:52,176 - INFO - config per peer with auth_data None 2026-04-03 18:46:52,788 - INFO - configure MD5 on host 4333136b-4c0f-48fb-9b98-7408191083b4 2026-04-03 18:46:52,884 - INFO - remove md5 configured on host 3346399a-34ba-41bb-9001-d8fb66baea97 2026-04-03 18:46:52,884 - INFO - config per peer with auth_data None 2026-04-03 18:46:53,491 - INFO - configure MD5 on host 3346399a-34ba-41bb-9001-d8fb66baea97 2026-04-03 18:46:53,583 - INFO - remove md5 configured on host a7a5d432-3939-462d-8909-8d6124bcfb7c 2026-04-03 18:46:53,583 - INFO - config per peer with auth_data None 2026-04-03 18:46:54,159 - INFO - configure MD5 on host a7a5d432-3939-462d-8909-8d6124bcfb7c 2026-04-03 18:46:54,247 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD 2026-04-03 18:46:54,248 - INFO - Deleting VM vn2_vm_0 2026-04-03 18:46:54,248 - ERROR - VM vn2_vm_0 has failed to come up 2026-04-03 18:46:54,248 - ERROR - Nova failed to get host of the VM 2026-04-03 18:46:54,248 - ERROR - VM vn2_vm_0 has failed to come up 2026-04-03 18:46:54,248 - ERROR - Nova failed to get host of the VM 2026-04-03 18:46:54,320 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD 2026-04-03 18:46:54,321 - INFO - Deleting VM vn1_vm_0 2026-04-03 18:46:54,321 - ERROR - VM vn1_vm_0 has failed to come up 2026-04-03 18:46:54,321 - ERROR - Nova failed to get host of the VM 2026-04-03 18:46:54,321 - ERROR - VM vn1_vm_0 has failed to come up 2026-04-03 18:46:54,321 - ERROR - Nova failed to get host of the VM 2026-04-03 18:46:54,387 - INFO - Dettaching policy sec_grp_policy_ctest-random-48884153 from vn vn2 2026-04-03 18:46:54,570 - INFO - Dettaching policy sec_grp_policy_ctest-random-48884153 from vn vn1 2026-04-03 18:46:54,836 - INFO - Deleted policy sec_grp_policy_ctest-random-48884153 2026-04-03 18:46:54,836 - INFO - Deleting VN vn2 2026-04-03 18:46:54,913 - DEBUG - VN a4920462-54b0-43fc-98de-9a68a9d7b2a2 still in use: Unable to complete operation on network a4920462-54b0-43fc-98de-9a68a9d7b2a2. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-cc22c087-150f-4ea3-81c6-22a8f9c64107'] 2026-04-03 18:46:54,913 - WARNING - Deleting VN vn2 failed..Will retry 2026-04-03 18:46:57,087 - DEBUG - Response for deleting network () 2026-04-03 18:46:57,087 - INFO - Deleting VN vn1 2026-04-03 18:46:57,245 - DEBUG - Response for deleting network () 2026-04-03 18:46:57,246 - INFO - Dettaching policy allow_all from vn test_vnv6dn 2026-04-03 18:46:57,428 - INFO - Dettaching policy allow_all from vn test_vnv6sr 2026-04-03 18:46:57,712 - INFO - Deleted policy allow_all 2026-04-03 18:46:57,712 - INFO - Deleting VM dest_vm 2026-04-03 18:46:57,781 - INFO - Deleting VM source_vm 2026-04-03 18:46:57,842 - INFO - Deleting VN test_vnv6dn 2026-04-03 18:46:57,884 - DEBUG - VN f15c2ab3-095b-40b2-b724-1022e591c3a4 still in use: Unable to complete operation on network f15c2ab3-095b-40b2-b724-1022e591c3a4. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-d35f5725-add1-4cb2-8c78-c9e40c3a3f1a'] 2026-04-03 18:46:57,884 - WARNING - Deleting VN test_vnv6dn failed..Will retry 2026-04-03 18:47:00,098 - DEBUG - Response for deleting network () 2026-04-03 18:47:00,098 - INFO - Deleting VN test_vnv6sr 2026-04-03 18:47:00,308 - DEBUG - Response for deleting network () 2026-04-03 18:47:01,570 - DEBUG - Skipping xmpp flap check
2026-04-03 18:47:01,570 - INFO - END TEST : test_check_per_peer_on_control : PASSED[0:00:23]
2026-04-03 18:47:01,570 - INFO - -------------------------------------------------------------------------------- 2026-04-03 18:47:01,873 - DEBUG - Response for create_network : {'network': {'id': '37b7b959-5eca-4c4a-b31a-a5bc6be6a98e', 'name': 'test_vnv6sr', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'project_id': '3ae58269fff444f8a83afada4b3727f2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-36964590', 'test_vnv6sr'], 'port_security_enabled': True, 'description': ''}} 2026-04-03 18:47:02,130 - DEBUG - Response for create_subnet : {'subnet': {'id': '985389e3-30d1-4bd4-90ea-8dd5c9f235cf', 'name': '', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'network_id': '37b7b959-5eca-4c4a-b31a-a5bc6be6a98e', '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': '3ae58269fff444f8a83afada4b3727f2'}} 2026-04-03 18:47:02,335 - DEBUG - Response for create_subnet : {'subnet': {'id': '01f12f14-6e68-4f87-bae8-6497e60faba9', 'name': '', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'network_id': '37b7b959-5eca-4c4a-b31a-a5bc6be6a98e', 'ip_version': 4, 'cidr': '59.73.251.0/26', 'allocation_pools': [{'start': '59.73.251.2', 'end': '59.73.251.62'}], 'gateway_ip': '59.73.251.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '59.73.251.2', 'tags': [], 'project_id': '3ae58269fff444f8a83afada4b3727f2'}} 2026-04-03 18:47:02,357 - INFO - Created VN test_vnv6sr 2026-04-03 18:47:02,370 - DEBUG - VN test_vnv6sr UUID is 37b7b959-5eca-4c4a-b31a-a5bc6be6a98e 2026-04-03 18:47:02,744 - DEBUG - Response for create_network : {'network': {'id': 'be5ecafc-5815-4980-9a18-a96aac88853a', 'name': 'test_vnv6dn', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'project_id': '3ae58269fff444f8a83afada4b3727f2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-36964590', 'test_vnv6dn'], 'port_security_enabled': True, 'description': ''}} 2026-04-03 18:47:02,969 - DEBUG - Response for create_subnet : {'subnet': {'id': '46235286-b99f-4e5c-974d-b3b1ce340376', 'name': '', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'network_id': 'be5ecafc-5815-4980-9a18-a96aac88853a', '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': '3ae58269fff444f8a83afada4b3727f2'}} 2026-04-03 18:47:03,220 - DEBUG - Response for create_subnet : {'subnet': {'id': '2969bb6c-de2e-4df5-a188-3c989d6e5507', 'name': '', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'network_id': 'be5ecafc-5815-4980-9a18-a96aac88853a', 'ip_version': 4, 'cidr': '136.168.181.64/26', 'allocation_pools': [{'start': '136.168.181.66', 'end': '136.168.181.126'}], 'gateway_ip': '136.168.181.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '136.168.181.66', 'tags': [], 'project_id': '3ae58269fff444f8a83afada4b3727f2'}} 2026-04-03 18:47:03,246 - INFO - Created VN test_vnv6dn 2026-04-03 18:47:03,257 - DEBUG - VN test_vnv6dn UUID is be5ecafc-5815-4980-9a18-a96aac88853a 2026-04-03 18:47:04,555 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5589-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5589-2) 2026-04-03 18:47:05,914 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5589-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5589-1) 2026-04-03 18:47:05,914 - INFO - Waiting for VM source_vm to be up.. 2026-04-03 18:47:05,997 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-04-03 18:47:11,077 - DEBUG - VM is in ACTIVE state now 2026-04-03 18:47:11,077 - INFO - VM name : source_vm 2026-04-03 18:47:11,166 - DEBUG - VM source_vm ID is 764d2709-24fe-4c19-90a1-d2c0ed3b2974 2026-04-03 18:47:11,166 - DEBUG - VM source_vm launched on Node an-jenkins-deploy-platform-ansible-os-5589-2 2026-04-03 18:47:11,247 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine/764d2709-24fe-4c19-90a1-d2c0ed3b2974 2026-04-03 18:47:11,257 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/c294ca19-1073-4b15-aa9f-6bdcf41c479d 2026-04-03 18:47:14,437 - 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 1026ms') 2026-04-03 18:47:14,437 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM source_vm failed! 2026-04-03 18:47:14,455 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-36964590:test_vnv6sr is 2001::101:1 and allocation pool is NOT set 2026-04-03 18:47:14,455 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-36964590:test_vnv6sr is 59.73.251.1 and allocation pool is NOT set 2026-04-03 18:47:16,517 - 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=6.23 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.357 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.357/3.291/6.226/2.934 ms') 2026-04-03 18:47:16,517 - INFO - Ping to Metadata IP 169.254.0.3 of VM source_vm passed 2026-04-03 18:47:16,584 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-03 18:47:16,584 - DEBUG - Waiting to SSH to VM source_vm, IP 59.73.251.3, Port 22 2026-04-03 18:47:16,741 - DEBUG - VM source_vm is ready for SSH connections 2026-04-03 18:47:16,741 - INFO - Waiting for VM dest_vm to be up.. 2026-04-03 18:47:16,830 - DEBUG - VM is in ACTIVE state now 2026-04-03 18:47:16,830 - INFO - VM name : dest_vm 2026-04-03 18:47:16,907 - DEBUG - VM dest_vm ID is a87d072a-33a2-44b7-a76a-c9d2db2a2ab2 2026-04-03 18:47:16,907 - DEBUG - VM dest_vm launched on Node an-jenkins-deploy-platform-ansible-os-5589-1 2026-04-03 18:47:16,984 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine/a87d072a-33a2-44b7-a76a-c9d2db2a2ab2 2026-04-03 18:47:16,994 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/7ad300c4-5058-4546-8bde-7df165b520f8 2026-04-03 18:47:18,152 - 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=4.78 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.702 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.702/2.738/4.775/2.036 ms') 2026-04-03 18:47:18,152 - INFO - Ping to Metadata IP 169.254.0.5 of VM dest_vm passed 2026-04-03 18:47:18,228 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-03 18:47:18,228 - DEBUG - Waiting to SSH to VM dest_vm, IP 136.168.181.67, Port 22 2026-04-03 18:47:18,397 - DEBUG - VM dest_vm is ready for SSH connections 2026-04-03 18:47:18,405 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-36964590: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-36964590: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-03 18:47:18,747 - INFO - Attaching policy allow_all to vn test_vnv6sr 2026-04-03 18:47:19,134 - INFO - Attaching policy allow_all to vn test_vnv6dn 2026-04-03 18:47:19,452 - INFO - Configure the policy with allow any 2026-04-03 18:47:19,784 - DEBUG - Response for create_network : {'network': {'id': 'cccbaf99-119f-4896-856a-e6764bcc3f48', 'name': 'vn1', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'project_id': '3ae58269fff444f8a83afada4b3727f2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-36964590', 'vn1'], 'port_security_enabled': True, 'description': ''}} 2026-04-03 18:47:20,006 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c09fa135-9d18-4b03-b46f-7ed197a3ce8b', 'name': '', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'network_id': 'cccbaf99-119f-4896-856a-e6764bcc3f48', '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': '3ae58269fff444f8a83afada4b3727f2'}} 2026-04-03 18:47:20,026 - INFO - Created VN vn1 2026-04-03 18:47:20,037 - DEBUG - VN vn1 UUID is cccbaf99-119f-4896-856a-e6764bcc3f48 2026-04-03 18:47:20,397 - DEBUG - Response for create_network : {'network': {'id': '59c39ae2-ba22-43bf-8535-43c64f3efb90', 'name': 'vn2', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'project_id': '3ae58269fff444f8a83afada4b3727f2', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-36964590', 'vn2'], 'port_security_enabled': True, 'description': ''}} 2026-04-03 18:47:20,628 - DEBUG - Response for create_subnet : {'subnet': {'id': '7c2bef16-27e0-4366-8012-10ef86dee3e2', 'name': '', 'tenant_id': '3ae58269fff444f8a83afada4b3727f2', 'network_id': '59c39ae2-ba22-43bf-8535-43c64f3efb90', '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': '3ae58269fff444f8a83afada4b3727f2'}} 2026-04-03 18:47:20,650 - INFO - Created VN vn2 2026-04-03 18:47:20,664 - DEBUG - VN vn2 UUID is 59c39ae2-ba22-43bf-8535-43c64f3efb90 2026-04-03 18:47:20,775 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-36964590: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-36964590: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-03 18:47:21,107 - INFO - Attaching policy sec_grp_policy_ctest-random-71318587 to vn vn1 2026-04-03 18:47:21,511 - INFO - Attaching policy sec_grp_policy_ctest-random-71318587 to vn vn2 2026-04-03 18:47:23,290 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5589-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5589-2) 2026-04-03 18:47:24,849 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5589-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5589-1) 2026-04-03 18:47:24,911 - INFO - ================================================================================ 2026-04-03 18:47:24,911 - INFO - STARTING TEST : test_create_md5_on_control 2026-04-03 18:47:24,911 - INFO - TEST DESCRIPTION : Description: Verify md5 with allow specific protocol on all ports and policy with allow all between VN's 2026-04-03 18:47:26,229 - DEBUG - Skipping xmpp flap check 2026-04-03 18:47:26,229 - INFO - Initial checks done. Running the testcase now 2026-04-03 18:47:26,230 - INFO - 2026-04-03 18:47:26,230 - INFO - config md5 on each host with auth_data None 2026-04-03 18:47:26,230 - INFO - config per peer with auth_data None 2026-04-03 18:47:26,783 - INFO - configure MD5 on host 4333136b-4c0f-48fb-9b98-7408191083b4 2026-04-03 18:47:26,863 - INFO - config per peer with auth_data None 2026-04-03 18:47:27,439 - INFO - configure MD5 on host 3346399a-34ba-41bb-9001-d8fb66baea97 2026-04-03 18:47:27,523 - INFO - config per peer with auth_data None 2026-04-03 18:47:28,103 - INFO - configure MD5 on host a7a5d432-3939-462d-8909-8d6124bcfb7c 2026-04-03 18:47:28,191 - INFO - check if BGP between peers are up before setting md5 2026-04-03 18:47:28,191 - INFO - Check BGP staus between peers 2026-04-03 18:47:28,201 - INFO - setting MD5 config on host 4333136b-4c0f-48fb-9b98-7408191083b4 2026-04-03 18:47:28,201 - INFO - configure MD5 on host 4333136b-4c0f-48fb-9b98-7408191083b4 2026-04-03 18:47:28,275 - INFO - setting MD5 config on host 3346399a-34ba-41bb-9001-d8fb66baea97 2026-04-03 18:47:28,275 - INFO - configure MD5 on host 3346399a-34ba-41bb-9001-d8fb66baea97 2026-04-03 18:47:28,355 - INFO - setting MD5 config on host a7a5d432-3939-462d-8909-8d6124bcfb7c 2026-04-03 18:47:28,356 - INFO - configure MD5 on host a7a5d432-3939-462d-8909-8d6124bcfb7c 2026-04-03 18:47:28,435 - INFO - check if BGP peering is up after md5 config 2026-04-03 18:47:28,436 - INFO - Check BGP staus between peers 2026-04-03 18:47:28,445 - DEBUG - Check the BGP connection on 10.0.0.22 2026-04-03 18:47:28,445 - DEBUG - Check the BGP connection on 10.0.0.22 2026-04-03 18:47:38,446 - INFO - Check BGP staus between peers 2026-04-03 18:47:38,456 - INFO - remove md5 configured on host 4333136b-4c0f-48fb-9b98-7408191083b4 2026-04-03 18:47:38,456 - INFO - config per peer with auth_data None 2026-04-03 18:47:38,975 - INFO - configure MD5 on host 4333136b-4c0f-48fb-9b98-7408191083b4 2026-04-03 18:47:39,059 - INFO - remove md5 configured on host 3346399a-34ba-41bb-9001-d8fb66baea97 2026-04-03 18:47:39,059 - INFO - config per peer with auth_data None 2026-04-03 18:47:39,659 - INFO - configure MD5 on host 3346399a-34ba-41bb-9001-d8fb66baea97 2026-04-03 18:47:39,747 - INFO - remove md5 configured on host a7a5d432-3939-462d-8909-8d6124bcfb7c 2026-04-03 18:47:39,747 - INFO - config per peer with auth_data None 2026-04-03 18:47:40,416 - INFO - configure MD5 on host a7a5d432-3939-462d-8909-8d6124bcfb7c 2026-04-03 18:47:40,503 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD 2026-04-03 18:47:40,504 - INFO - Deleting VM vn2_vm_0 2026-04-03 18:47:40,504 - ERROR - VM vn2_vm_0 has failed to come up 2026-04-03 18:47:40,504 - ERROR - Nova failed to get host of the VM 2026-04-03 18:47:40,504 - ERROR - VM vn2_vm_0 has failed to come up 2026-04-03 18:47:40,504 - ERROR - Nova failed to get host of the VM 2026-04-03 18:47:40,572 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD 2026-04-03 18:47:40,572 - INFO - Deleting VM vn1_vm_0 2026-04-03 18:47:40,572 - ERROR - VM vn1_vm_0 has failed to come up 2026-04-03 18:47:40,572 - ERROR - Nova failed to get host of the VM 2026-04-03 18:47:40,572 - ERROR - VM vn1_vm_0 has failed to come up 2026-04-03 18:47:40,572 - ERROR - Nova failed to get host of the VM 2026-04-03 18:47:40,638 - INFO - Dettaching policy sec_grp_policy_ctest-random-71318587 from vn vn2 2026-04-03 18:47:40,810 - INFO - Dettaching policy sec_grp_policy_ctest-random-71318587 from vn vn1 2026-04-03 18:47:41,070 - INFO - Deleted policy sec_grp_policy_ctest-random-71318587 2026-04-03 18:47:41,071 - INFO - Deleting VN vn2 2026-04-03 18:47:41,116 - DEBUG - VN 59c39ae2-ba22-43bf-8535-43c64f3efb90 still in use: Unable to complete operation on network 59c39ae2-ba22-43bf-8535-43c64f3efb90. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-7bfc4948-cace-4e3d-8d05-a8ca19c7e426'] 2026-04-03 18:47:41,116 - WARNING - Deleting VN vn2 failed..Will retry 2026-04-03 18:47:43,312 - DEBUG - Response for deleting network () 2026-04-03 18:47:43,312 - INFO - Deleting VN vn1 2026-04-03 18:47:43,482 - DEBUG - Response for deleting network () 2026-04-03 18:47:43,482 - INFO - Dettaching policy allow_all from vn test_vnv6dn 2026-04-03 18:47:43,750 - INFO - Dettaching policy allow_all from vn test_vnv6sr 2026-04-03 18:47:44,041 - INFO - Deleted policy allow_all 2026-04-03 18:47:44,041 - INFO - Deleting VM dest_vm 2026-04-03 18:47:44,140 - INFO - Deleting VM source_vm 2026-04-03 18:47:44,226 - INFO - Deleting VN test_vnv6dn 2026-04-03 18:47:44,274 - DEBUG - VN be5ecafc-5815-4980-9a18-a96aac88853a still in use: Unable to complete operation on network be5ecafc-5815-4980-9a18-a96aac88853a. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-09f7362b-eae5-4f4e-8980-7dd15cd07f8c'] 2026-04-03 18:47:44,275 - WARNING - Deleting VN test_vnv6dn failed..Will retry 2026-04-03 18:47:46,469 - DEBUG - Response for deleting network () 2026-04-03 18:47:46,469 - INFO - Deleting VN test_vnv6sr 2026-04-03 18:47:46,671 - DEBUG - Response for deleting network () 2026-04-03 18:47:47,924 - DEBUG - Skipping xmpp flap check
2026-04-03 18:47:47,925 - INFO - END TEST : test_create_md5_on_control : PASSED[0:00:23]
2026-04-03 18:47:47,925 - INFO - -------------------------------------------------------------------------------- 2026-04-03 18:47:48,707 - INFO - Deleted project: ctest-TestMd5testsOnControl-36964590, ID : 3ae58269-fff4-44f8-a83a-fada4b3727f2