2026-06-18 03:37:13,600 - INFO - Domain Default found not creating 2026-06-18 03:37:13,836 - INFO - Project ctest-TestMd5testsOnControl-52711598 not found, creating it 2026-06-18 03:37:14,340 - INFO - Created Project:ctest-TestMd5testsOnControl-52711598, ID : 94fd4012-fb75-4301-abf4-cf5c1d33dc4e 2026-06-18 03:37:16,552 - DEBUG - Response for create_network : {'network': {'id': '3308756d-2a95-468d-aaec-576343b4e933', 'name': 'test_vnv6sr', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'project_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-52711598', 'test_vnv6sr'], 'port_security_enabled': True, 'description': ''}} 2026-06-18 03:37:16,800 - DEBUG - Response for create_subnet : {'subnet': {'id': '33c9a082-aec6-4c49-8b66-85281fb7311c', 'name': '', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'network_id': '3308756d-2a95-468d-aaec-576343b4e933', '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': '94fd4012fb754301abf4cf5c1d33dc4e'}} 2026-06-18 03:37:17,015 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ba4dbe4d-2feb-4389-a170-acc6741f529b', 'name': '', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'network_id': '3308756d-2a95-468d-aaec-576343b4e933', 'ip_version': 4, 'cidr': '88.229.210.128/26', 'allocation_pools': [{'start': '88.229.210.130', 'end': '88.229.210.190'}], 'gateway_ip': '88.229.210.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '88.229.210.130', 'tags': [], 'project_id': '94fd4012fb754301abf4cf5c1d33dc4e'}} 2026-06-18 03:37:17,036 - INFO - Created VN test_vnv6sr 2026-06-18 03:37:17,046 - DEBUG - VN test_vnv6sr UUID is 3308756d-2a95-468d-aaec-576343b4e933 2026-06-18 03:37:17,367 - DEBUG - Response for create_network : {'network': {'id': 'f137b595-3150-4c50-992d-3104d6170647', 'name': 'test_vnv6dn', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'project_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-52711598', 'test_vnv6dn'], 'port_security_enabled': True, 'description': ''}} 2026-06-18 03:37:17,610 - DEBUG - Response for create_subnet : {'subnet': {'id': 'be868405-d9f2-4e2a-b963-ffe71a3507a3', 'name': '', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'network_id': 'f137b595-3150-4c50-992d-3104d6170647', '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': '94fd4012fb754301abf4cf5c1d33dc4e'}} 2026-06-18 03:37:17,764 - DEBUG - Response for create_subnet : {'subnet': {'id': '5975b7b2-0341-4e64-b44d-e5c6d5d58b73', 'name': '', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'network_id': 'f137b595-3150-4c50-992d-3104d6170647', 'ip_version': 4, 'cidr': '215.49.227.0/26', 'allocation_pools': [{'start': '215.49.227.2', 'end': '215.49.227.62'}], 'gateway_ip': '215.49.227.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '215.49.227.2', 'tags': [], 'project_id': '94fd4012fb754301abf4cf5c1d33dc4e'}} 2026-06-18 03:37:17,787 - INFO - Created VN test_vnv6dn 2026-06-18 03:37:17,798 - DEBUG - VN test_vnv6dn UUID is f137b595-3150-4c50-992d-3104d6170647 2026-06-18 03:37:17,989 - DEBUG - Services list from nova: [, , , ] 2026-06-18 03:37:19,152 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5973-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5973-2) 2026-06-18 03:37:20,414 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5973-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5973-1) 2026-06-18 03:37:20,414 - INFO - Waiting for VM source_vm to be up.. 2026-06-18 03:37:20,470 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-06-18 03:37:25,555 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-06-18 03:37:30,640 - DEBUG - VM is in ACTIVE state now 2026-06-18 03:37:30,640 - INFO - VM name : source_vm 2026-06-18 03:37:30,714 - DEBUG - VM source_vm ID is d2a6f26a-4119-4740-a86e-1db017917325 2026-06-18 03:37:30,738 - DEBUG - VM source_vm launched on Node an-jenkins-deploy-platform-ansible-os-5973-2 2026-06-18 03:37:30,810 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/d2a6f26a-4119-4740-a86e-1db017917325 2026-06-18 03:37:31,150 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/d2a6f26a-4119-4740-a86e-1db017917325 2026-06-18 03:37:31,179 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/103307dc-ff5a-4acf-98d5-a520127da7ed 2026-06-18 03:37:34,355 - 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 1006ms') 2026-06-18 03:37:34,355 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM source_vm failed! 2026-06-18 03:37:34,368 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-52711598:test_vnv6sr is 2001::101:1 and allocation pool is NOT set 2026-06-18 03:37:34,368 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-52711598:test_vnv6sr is 88.229.210.129 and allocation pool is NOT set 2026-06-18 03:37:36,435 - 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=10.7 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.44 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 = 1.438/6.060/10.682/4.622 ms') 2026-06-18 03:37:36,435 - INFO - Ping to Metadata IP 169.254.0.3 of VM source_vm passed 2026-06-18 03:37:36,503 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-18 03:37:36,503 - DEBUG - Waiting to SSH to VM source_vm, IP 88.229.210.131, Port 22 2026-06-18 03:37:36,672 - DEBUG - VM source_vm is ready for SSH connections 2026-06-18 03:37:36,672 - INFO - Waiting for VM dest_vm to be up.. 2026-06-18 03:37:36,756 - DEBUG - VM is in ACTIVE state now 2026-06-18 03:37:36,756 - INFO - VM name : dest_vm 2026-06-18 03:37:36,835 - DEBUG - VM dest_vm ID is e75b7dca-3ace-4491-b97f-49cbf9039a80 2026-06-18 03:37:36,835 - DEBUG - VM dest_vm launched on Node an-jenkins-deploy-platform-ansible-os-5973-1 2026-06-18 03:37:36,912 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/e75b7dca-3ace-4491-b97f-49cbf9039a80 2026-06-18 03:37:36,922 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/0d21e3be-695c-4ecb-b933-f4558155ef05 2026-06-18 03:37:38,080 - 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.08 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.570 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.570/2.326/4.082/1.756 ms') 2026-06-18 03:37:38,080 - INFO - Ping to Metadata IP 169.254.0.3 of VM dest_vm passed 2026-06-18 03:37:38,147 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-18 03:37:38,147 - DEBUG - Waiting to SSH to VM dest_vm, IP 215.49.227.3, Port 22 2026-06-18 03:37:38,314 - DEBUG - VM dest_vm is ready for SSH connections 2026-06-18 03:37:38,320 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-52711598: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-52711598:test_vnv6dn, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None] 2026-06-18 03:37:38,650 - INFO - Attaching policy allow_all to vn test_vnv6sr 2026-06-18 03:37:38,995 - INFO - Attaching policy allow_all to vn test_vnv6dn 2026-06-18 03:37:39,257 - INFO - Configure the policy with allow any 2026-06-18 03:37:39,510 - DEBUG - Response for create_network : {'network': {'id': '8ded7132-75c9-4e07-87b1-2bcba5734eb3', 'name': 'vn1', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'project_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-52711598', 'vn1'], 'port_security_enabled': True, 'description': ''}} 2026-06-18 03:37:39,748 - DEBUG - Response for create_subnet : {'subnet': {'id': '4aa8ae64-3623-41ed-9826-323cb15ca362', 'name': '', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'network_id': '8ded7132-75c9-4e07-87b1-2bcba5734eb3', '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': '94fd4012fb754301abf4cf5c1d33dc4e'}} 2026-06-18 03:37:39,767 - INFO - Created VN vn1 2026-06-18 03:37:39,781 - DEBUG - VN vn1 UUID is 8ded7132-75c9-4e07-87b1-2bcba5734eb3 2026-06-18 03:37:40,109 - DEBUG - Response for create_network : {'network': {'id': '1027cb8d-4d3c-4b50-82e5-aba6f5d4b3d2', 'name': 'vn2', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'project_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-52711598', 'vn2'], 'port_security_enabled': True, 'description': ''}} 2026-06-18 03:37:40,317 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f1904f87-e80d-4e76-88e0-7651251c3dda', 'name': '', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'network_id': '1027cb8d-4d3c-4b50-82e5-aba6f5d4b3d2', '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': '94fd4012fb754301abf4cf5c1d33dc4e'}} 2026-06-18 03:37:40,340 - INFO - Created VN vn2 2026-06-18 03:37:40,353 - DEBUG - VN vn2 UUID is 1027cb8d-4d3c-4b50-82e5-aba6f5d4b3d2 2026-06-18 03:37:40,425 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-52711598: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-52711598:vn2, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None] 2026-06-18 03:37:40,740 - INFO - Attaching policy sec_grp_policy_ctest-random-43056201 to vn vn1 2026-06-18 03:37:41,082 - INFO - Attaching policy sec_grp_policy_ctest-random-43056201 to vn vn2 2026-06-18 03:37:42,636 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5973-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5973-2) 2026-06-18 03:37:43,955 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5973-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5973-1) 2026-06-18 03:37:44,016 - INFO - ================================================================================ 2026-06-18 03:37:44,016 - INFO - STARTING TEST : test_check_per_peer_on_control 2026-06-18 03:37:44,016 - INFO - TEST DESCRIPTION : Description: Verify per peer md5 and specific protocol on all ports and policy with allow all between VN's 2026-06-18 03:37:45,296 - DEBUG - Skipping xmpp flap check 2026-06-18 03:37:45,296 - INFO - Initial checks done. Running the testcase now 2026-06-18 03:37:45,296 - INFO - 2026-06-18 03:37:45,296 - INFO - config per peer with auth_data None 2026-06-18 03:37:45,840 - INFO - configure MD5 on host bddd4613-273f-4cda-b60e-011e3c05956b 2026-06-18 03:37:45,932 - INFO - config per peer with auth_data None 2026-06-18 03:37:46,472 - INFO - configure MD5 on host a002ae7e-c4e8-4692-8ce0-d10a82ca07bb 2026-06-18 03:37:46,548 - INFO - config per peer with auth_data None 2026-06-18 03:37:47,148 - INFO - configure MD5 on host 2b8a6c2e-bb5c-41de-919e-02473d877ce8 2026-06-18 03:37:47,232 - INFO - check BGP peering is up before setting md5 config 2026-06-18 03:37:47,232 - INFO - Check BGP staus between peers 2026-06-18 03:37:47,259 - INFO - config per peer with auth_data {'key_items': [{'key': 'juniper', 'key_id': 0}], 'key_type': 'md5'} 2026-06-18 03:37:47,823 - INFO - Check BGP staus between peers 2026-06-18 03:37:47,839 - DEBUG - Check the BGP connection on 10.0.0.27 2026-06-18 03:37:47,839 - DEBUG - Check the BGP connection on 10.0.0.27 2026-06-18 03:37:57,840 - INFO - Check BGP staus between peers 2026-06-18 03:37:57,850 - INFO - remove md5 configured on host bddd4613-273f-4cda-b60e-011e3c05956b 2026-06-18 03:37:57,850 - INFO - config per peer with auth_data None 2026-06-18 03:37:58,369 - INFO - configure MD5 on host bddd4613-273f-4cda-b60e-011e3c05956b 2026-06-18 03:37:58,456 - INFO - remove md5 configured on host a002ae7e-c4e8-4692-8ce0-d10a82ca07bb 2026-06-18 03:37:58,456 - INFO - config per peer with auth_data None 2026-06-18 03:37:58,972 - INFO - configure MD5 on host a002ae7e-c4e8-4692-8ce0-d10a82ca07bb 2026-06-18 03:37:59,048 - INFO - remove md5 configured on host 2b8a6c2e-bb5c-41de-919e-02473d877ce8 2026-06-18 03:37:59,048 - INFO - config per peer with auth_data None 2026-06-18 03:37:59,592 - INFO - configure MD5 on host 2b8a6c2e-bb5c-41de-919e-02473d877ce8 2026-06-18 03:37:59,664 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD 2026-06-18 03:37:59,664 - INFO - Deleting VM vn2_vm_0 2026-06-18 03:37:59,664 - ERROR - VM vn2_vm_0 has failed to come up 2026-06-18 03:37:59,664 - ERROR - Nova failed to get host of the VM 2026-06-18 03:37:59,664 - ERROR - VM vn2_vm_0 has failed to come up 2026-06-18 03:37:59,664 - ERROR - Nova failed to get host of the VM 2026-06-18 03:37:59,772 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD 2026-06-18 03:37:59,772 - INFO - Deleting VM vn1_vm_0 2026-06-18 03:37:59,773 - ERROR - VM vn1_vm_0 has failed to come up 2026-06-18 03:37:59,773 - ERROR - Nova failed to get host of the VM 2026-06-18 03:37:59,773 - ERROR - VM vn1_vm_0 has failed to come up 2026-06-18 03:37:59,773 - ERROR - Nova failed to get host of the VM 2026-06-18 03:37:59,850 - INFO - Dettaching policy sec_grp_policy_ctest-random-43056201 from vn vn2 2026-06-18 03:37:59,991 - INFO - Dettaching policy sec_grp_policy_ctest-random-43056201 from vn vn1 2026-06-18 03:38:00,213 - INFO - Deleted policy sec_grp_policy_ctest-random-43056201 2026-06-18 03:38:00,213 - INFO - Deleting VN vn2 2026-06-18 03:38:00,250 - DEBUG - VN 1027cb8d-4d3c-4b50-82e5-aba6f5d4b3d2 still in use: Unable to complete operation on network 1027cb8d-4d3c-4b50-82e5-aba6f5d4b3d2. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-f7bddf32-1231-4f5f-87db-0501a15ca5e0'] 2026-06-18 03:38:00,250 - WARNING - Deleting VN vn2 failed..Will retry 2026-06-18 03:38:02,365 - DEBUG - Response for deleting network () 2026-06-18 03:38:02,365 - INFO - Deleting VN vn1 2026-06-18 03:38:02,503 - DEBUG - Response for deleting network () 2026-06-18 03:38:02,503 - INFO - Dettaching policy allow_all from vn test_vnv6dn 2026-06-18 03:38:02,667 - INFO - Dettaching policy allow_all from vn test_vnv6sr 2026-06-18 03:38:02,896 - INFO - Deleted policy allow_all 2026-06-18 03:38:02,896 - INFO - Deleting VM dest_vm 2026-06-18 03:38:02,989 - INFO - Deleting VM source_vm 2026-06-18 03:38:03,076 - INFO - Deleting VN test_vnv6dn 2026-06-18 03:38:03,113 - DEBUG - VN f137b595-3150-4c50-992d-3104d6170647 still in use: Unable to complete operation on network f137b595-3150-4c50-992d-3104d6170647. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-2f1a825b-91bd-4abd-b5db-54dce3d2831c'] 2026-06-18 03:38:03,114 - WARNING - Deleting VN test_vnv6dn failed..Will retry 2026-06-18 03:38:05,349 - DEBUG - Response for deleting network () 2026-06-18 03:38:05,349 - INFO - Deleting VN test_vnv6sr 2026-06-18 03:38:05,548 - DEBUG - Response for deleting network () 2026-06-18 03:38:06,802 - DEBUG - Skipping xmpp flap check
2026-06-18 03:38:06,802 - INFO - END TEST : test_check_per_peer_on_control : PASSED[0:00:22]
2026-06-18 03:38:06,802 - INFO - -------------------------------------------------------------------------------- 2026-06-18 03:38:07,039 - DEBUG - Response for create_network : {'network': {'id': '5730e1ae-e58d-454f-9187-980d15e0e496', 'name': 'test_vnv6sr', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'project_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-52711598', 'test_vnv6sr'], 'port_security_enabled': True, 'description': ''}} 2026-06-18 03:38:07,294 - DEBUG - Response for create_subnet : {'subnet': {'id': '444a368a-050e-45c3-b74d-479ee5d42930', 'name': '', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'network_id': '5730e1ae-e58d-454f-9187-980d15e0e496', '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': '94fd4012fb754301abf4cf5c1d33dc4e'}} 2026-06-18 03:38:07,467 - DEBUG - Response for create_subnet : {'subnet': {'id': '14a0fb17-3d25-4156-aebd-8c756c5dd6d2', 'name': '', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'network_id': '5730e1ae-e58d-454f-9187-980d15e0e496', 'ip_version': 4, 'cidr': '201.248.193.128/26', 'allocation_pools': [{'start': '201.248.193.130', 'end': '201.248.193.190'}], 'gateway_ip': '201.248.193.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '201.248.193.130', 'tags': [], 'project_id': '94fd4012fb754301abf4cf5c1d33dc4e'}} 2026-06-18 03:38:07,488 - INFO - Created VN test_vnv6sr 2026-06-18 03:38:07,496 - DEBUG - VN test_vnv6sr UUID is 5730e1ae-e58d-454f-9187-980d15e0e496 2026-06-18 03:38:07,835 - DEBUG - Response for create_network : {'network': {'id': '5669237b-9706-445c-8042-f45fe0207ad0', 'name': 'test_vnv6dn', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'project_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-52711598', 'test_vnv6dn'], 'port_security_enabled': True, 'description': ''}} 2026-06-18 03:38:08,088 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f7ef4ebc-c1ad-404f-9bcd-e3bc957b9fa7', 'name': '', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'network_id': '5669237b-9706-445c-8042-f45fe0207ad0', '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': '94fd4012fb754301abf4cf5c1d33dc4e'}} 2026-06-18 03:38:08,314 - DEBUG - Response for create_subnet : {'subnet': {'id': '8fd8cede-0b5c-488a-9055-47bcc7d07c5e', 'name': '', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'network_id': '5669237b-9706-445c-8042-f45fe0207ad0', 'ip_version': 4, 'cidr': '20.93.172.64/26', 'allocation_pools': [{'start': '20.93.172.66', 'end': '20.93.172.126'}], 'gateway_ip': '20.93.172.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '20.93.172.66', 'tags': [], 'project_id': '94fd4012fb754301abf4cf5c1d33dc4e'}} 2026-06-18 03:38:08,336 - INFO - Created VN test_vnv6dn 2026-06-18 03:38:08,345 - DEBUG - VN test_vnv6dn UUID is 5669237b-9706-445c-8042-f45fe0207ad0 2026-06-18 03:38:08,631 - DEBUG - VM source_vm already present, not creating it 2026-06-18 03:38:09,871 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5973-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5973-2) 2026-06-18 03:38:09,872 - INFO - Waiting for VM source_vm to be up.. 2026-06-18 03:38:09,897 - DEBUG - VM console log not formed yet 2026-06-18 03:38:14,920 - DEBUG - VM console log not formed yet 2026-06-18 03:38:19,950 - DEBUG - VM console log not formed yet 2026-06-18 03:38:24,970 - DEBUG - VM console log not formed yet 2026-06-18 03:38:30,006 - DEBUG - VM console log not formed yet 2026-06-18 03:38:35,030 - DEBUG - VM console log not formed yet 2026-06-18 03:38:40,058 - DEBUG - VM console log not formed yet 2026-06-18 03:38:45,079 - DEBUG - VM console log not formed yet 2026-06-18 03:38:50,106 - DEBUG - VM console log not formed yet 2026-06-18 03:38:55,128 - DEBUG - VM console log not formed yet 2026-06-18 03:39:00,156 - DEBUG - VM console log not formed yet 2026-06-18 03:39:05,176 - DEBUG - VM console log not formed yet 2026-06-18 03:39:10,199 - DEBUG - VM console log not formed yet 2026-06-18 03:39:15,220 - DEBUG - VM console log not formed yet 2026-06-18 03:39:20,244 - DEBUG - VM console log not formed yet 2026-06-18 03:39:25,268 - DEBUG - VM console log not formed yet 2026-06-18 03:39:30,291 - DEBUG - VM console log not formed yet 2026-06-18 03:39:35,314 - DEBUG - VM console log not formed yet 2026-06-18 03:39:40,340 - DEBUG - VM console log not formed yet 2026-06-18 03:39:45,366 - DEBUG - VM console log not formed yet 2026-06-18 03:39:50,390 - DEBUG - VM console log not formed yet 2026-06-18 03:39:55,418 - DEBUG - VM console log not formed yet 2026-06-18 03:40:00,452 - DEBUG - VM console log not formed yet 2026-06-18 03:40:05,475 - DEBUG - VM console log not formed yet 2026-06-18 03:40:10,502 - DEBUG - VM console log not formed yet 2026-06-18 03:40:15,529 - DEBUG - VM console log not formed yet 2026-06-18 03:40:20,558 - DEBUG - VM console log not formed yet 2026-06-18 03:40:25,584 - DEBUG - VM console log not formed yet 2026-06-18 03:40:30,623 - DEBUG - VM console log not formed yet 2026-06-18 03:40:35,653 - DEBUG - VM console log not formed yet 2026-06-18 03:40:40,677 - DEBUG - VM console log not formed yet 2026-06-18 03:40:40,677 - ERROR - VM is not in ACTIVE state 2026-06-18 03:40:40,695 - DEBUG - VM console log not formed yet 2026-06-18 03:40:40,695 - DEBUG - None 2026-06-18 03:40:40,696 - INFO - Waiting for VM dest_vm to be up.. 2026-06-18 03:40:40,822 - DEBUG - VM is in ACTIVE state now 2026-06-18 03:40:40,823 - INFO - VM name : dest_vm 2026-06-18 03:40:40,914 - DEBUG - VM dest_vm ID is f596c754-d60d-4cd1-98e8-ca9878019535 2026-06-18 03:40:40,914 - DEBUG - VM dest_vm launched on Node an-jenkins-deploy-platform-ansible-os-5973-2 2026-06-18 03:40:40,993 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/f596c754-d60d-4cd1-98e8-ca9878019535 2026-06-18 03:40:41,005 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/5f1b1beb-e3f1-47df-ae8f-72cab8380bc4 2026-06-18 03:40:42,163 - 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.58 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.470 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.470/2.526/4.582/2.056 ms') 2026-06-18 03:40:42,164 - INFO - Ping to Metadata IP 169.254.0.3 of VM dest_vm passed 2026-06-18 03:40:42,233 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-18 03:40:42,233 - DEBUG - Waiting to SSH to VM dest_vm, IP 20.93.172.67, Port 22 2026-06-18 03:40:42,389 - DEBUG - VM dest_vm is ready for SSH connections 2026-06-18 03:40:42,396 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-52711598: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-52711598:test_vnv6dn, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None] 2026-06-18 03:40:42,727 - INFO - Attaching policy allow_all to vn test_vnv6sr 2026-06-18 03:40:43,091 - INFO - Attaching policy allow_all to vn test_vnv6dn 2026-06-18 03:40:43,379 - INFO - Configure the policy with allow any 2026-06-18 03:40:43,719 - DEBUG - Response for create_network : {'network': {'id': '8db202ac-ffc9-4ae5-a1f6-9a0e39d06c49', 'name': 'vn1', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'project_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-52711598', 'vn1'], 'port_security_enabled': True, 'description': ''}} 2026-06-18 03:40:44,018 - DEBUG - Response for create_subnet : {'subnet': {'id': '49c3d138-3ca8-492a-b0fb-c8c2413b497b', 'name': '', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'network_id': '8db202ac-ffc9-4ae5-a1f6-9a0e39d06c49', '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': '94fd4012fb754301abf4cf5c1d33dc4e'}} 2026-06-18 03:40:44,041 - INFO - Created VN vn1 2026-06-18 03:40:44,053 - DEBUG - VN vn1 UUID is 8db202ac-ffc9-4ae5-a1f6-9a0e39d06c49 2026-06-18 03:40:44,424 - DEBUG - Response for create_network : {'network': {'id': 'bf32bb9d-af2a-49e2-bf78-e6c352bf7af3', 'name': 'vn2', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'project_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-52711598', 'vn2'], 'port_security_enabled': True, 'description': ''}} 2026-06-18 03:40:44,727 - DEBUG - Response for create_subnet : {'subnet': {'id': '67445247-8360-4600-89a4-bf8bced899d8', 'name': '', 'tenant_id': '94fd4012fb754301abf4cf5c1d33dc4e', 'network_id': 'bf32bb9d-af2a-49e2-bf78-e6c352bf7af3', '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': '94fd4012fb754301abf4cf5c1d33dc4e'}} 2026-06-18 03:40:44,750 - INFO - Created VN vn2 2026-06-18 03:40:44,763 - DEBUG - VN vn2 UUID is bf32bb9d-af2a-49e2-bf78-e6c352bf7af3 2026-06-18 03:40:44,880 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-52711598: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-52711598:vn2, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None] 2026-06-18 03:40:45,211 - INFO - Attaching policy sec_grp_policy_ctest-random-13680282 to vn vn1 2026-06-18 03:40:45,563 - INFO - Attaching policy sec_grp_policy_ctest-random-13680282 to vn vn2 2026-06-18 03:40:47,203 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5973-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5973-1) 2026-06-18 03:40:48,509 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5973-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5973-2) 2026-06-18 03:40:48,572 - INFO - ================================================================================ 2026-06-18 03:40:48,572 - INFO - STARTING TEST : test_create_md5_on_control 2026-06-18 03:40:48,572 - INFO - TEST DESCRIPTION : Description: Verify md5 with allow specific protocol on all ports and policy with allow all between VN's 2026-06-18 03:40:49,841 - DEBUG - Skipping xmpp flap check 2026-06-18 03:40:49,841 - INFO - Initial checks done. Running the testcase now 2026-06-18 03:40:49,841 - INFO - 2026-06-18 03:40:49,841 - INFO - config md5 on each host with auth_data None 2026-06-18 03:40:49,841 - INFO - config per peer with auth_data None 2026-06-18 03:40:50,404 - INFO - configure MD5 on host bddd4613-273f-4cda-b60e-011e3c05956b 2026-06-18 03:40:50,488 - INFO - config per peer with auth_data None 2026-06-18 03:40:51,040 - INFO - configure MD5 on host a002ae7e-c4e8-4692-8ce0-d10a82ca07bb 2026-06-18 03:40:51,136 - INFO - config per peer with auth_data None 2026-06-18 03:40:51,836 - INFO - configure MD5 on host 2b8a6c2e-bb5c-41de-919e-02473d877ce8 2026-06-18 03:40:51,936 - INFO - check if BGP between peers are up before setting md5 2026-06-18 03:40:51,936 - INFO - Check BGP staus between peers 2026-06-18 03:40:51,947 - INFO - setting MD5 config on host bddd4613-273f-4cda-b60e-011e3c05956b 2026-06-18 03:40:51,948 - INFO - configure MD5 on host bddd4613-273f-4cda-b60e-011e3c05956b 2026-06-18 03:40:52,024 - INFO - setting MD5 config on host a002ae7e-c4e8-4692-8ce0-d10a82ca07bb 2026-06-18 03:40:52,024 - INFO - configure MD5 on host a002ae7e-c4e8-4692-8ce0-d10a82ca07bb 2026-06-18 03:40:52,136 - INFO - setting MD5 config on host 2b8a6c2e-bb5c-41de-919e-02473d877ce8 2026-06-18 03:40:52,137 - INFO - configure MD5 on host 2b8a6c2e-bb5c-41de-919e-02473d877ce8 2026-06-18 03:40:52,220 - INFO - check if BGP peering is up after md5 config 2026-06-18 03:40:52,220 - INFO - Check BGP staus between peers 2026-06-18 03:40:52,229 - DEBUG - Check the BGP connection on 10.0.0.27 2026-06-18 03:40:52,229 - DEBUG - Check the BGP connection on 10.0.0.27 2026-06-18 03:41:02,230 - INFO - Check BGP staus between peers 2026-06-18 03:41:02,239 - INFO - remove md5 configured on host bddd4613-273f-4cda-b60e-011e3c05956b 2026-06-18 03:41:02,239 - INFO - config per peer with auth_data None 2026-06-18 03:41:02,828 - INFO - configure MD5 on host bddd4613-273f-4cda-b60e-011e3c05956b 2026-06-18 03:41:02,908 - INFO - remove md5 configured on host a002ae7e-c4e8-4692-8ce0-d10a82ca07bb 2026-06-18 03:41:02,908 - INFO - config per peer with auth_data None 2026-06-18 03:41:03,548 - INFO - configure MD5 on host a002ae7e-c4e8-4692-8ce0-d10a82ca07bb 2026-06-18 03:41:03,640 - INFO - remove md5 configured on host 2b8a6c2e-bb5c-41de-919e-02473d877ce8 2026-06-18 03:41:03,640 - INFO - config per peer with auth_data None 2026-06-18 03:41:04,244 - INFO - configure MD5 on host 2b8a6c2e-bb5c-41de-919e-02473d877ce8 2026-06-18 03:41:04,332 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD 2026-06-18 03:41:04,333 - INFO - Deleting VM vn2_vm_0 2026-06-18 03:41:04,333 - ERROR - VM vn2_vm_0 has failed to come up 2026-06-18 03:41:04,333 - ERROR - Nova failed to get host of the VM 2026-06-18 03:41:04,333 - ERROR - VM vn2_vm_0 has failed to come up 2026-06-18 03:41:04,334 - ERROR - Nova failed to get host of the VM 2026-06-18 03:41:04,437 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD 2026-06-18 03:41:04,437 - INFO - Deleting VM vn1_vm_0 2026-06-18 03:41:04,437 - ERROR - VM vn1_vm_0 has failed to come up 2026-06-18 03:41:04,437 - ERROR - Nova failed to get host of the VM 2026-06-18 03:41:04,437 - ERROR - VM vn1_vm_0 has failed to come up 2026-06-18 03:41:04,437 - ERROR - Nova failed to get host of the VM 2026-06-18 03:41:04,525 - INFO - Dettaching policy sec_grp_policy_ctest-random-13680282 from vn vn2 2026-06-18 03:41:04,742 - INFO - Dettaching policy sec_grp_policy_ctest-random-13680282 from vn vn1 2026-06-18 03:41:05,011 - INFO - Deleted policy sec_grp_policy_ctest-random-13680282 2026-06-18 03:41:05,011 - INFO - Deleting VN vn2 2026-06-18 03:41:05,054 - DEBUG - VN bf32bb9d-af2a-49e2-bf78-e6c352bf7af3 still in use: Unable to complete operation on network bf32bb9d-af2a-49e2-bf78-e6c352bf7af3. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-1ef910d5-23d4-456e-b5da-63b0bc0976cb'] 2026-06-18 03:41:05,055 - WARNING - Deleting VN vn2 failed..Will retry 2026-06-18 03:41:07,197 - DEBUG - Response for deleting network () 2026-06-18 03:41:07,197 - INFO - Deleting VN vn1 2026-06-18 03:41:07,361 - DEBUG - Response for deleting network () 2026-06-18 03:41:07,361 - INFO - Dettaching policy allow_all from vn test_vnv6dn 2026-06-18 03:41:07,540 - INFO - Dettaching policy allow_all from vn test_vnv6sr 2026-06-18 03:41:07,791 - INFO - Deleted policy allow_all 2026-06-18 03:41:07,791 - INFO - Deleting VM dest_vm 2026-06-18 03:41:07,870 - INFO - Skipping the deletion of VM source_vm 2026-06-18 03:41:07,870 - INFO - Deleting VN test_vnv6dn 2026-06-18 03:41:07,921 - DEBUG - VN 5669237b-9706-445c-8042-f45fe0207ad0 still in use: Unable to complete operation on network 5669237b-9706-445c-8042-f45fe0207ad0. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-a3cfe875-32f4-47ea-a778-acc830da28fb'] 2026-06-18 03:41:07,921 - WARNING - Deleting VN test_vnv6dn failed..Will retry 2026-06-18 03:41:09,983 - DEBUG - VN 5669237b-9706-445c-8042-f45fe0207ad0 still in use: Unable to complete operation on network 5669237b-9706-445c-8042-f45fe0207ad0. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-cf9bef2a-6e7d-4d30-b55f-e72df8c29c5b'] 2026-06-18 03:41:09,983 - WARNING - Deleting VN test_vnv6dn failed..Will retry 2026-06-18 03:41:12,149 - DEBUG - Response for deleting network () 2026-06-18 03:41:12,149 - INFO - Deleting VN test_vnv6sr 2026-06-18 03:41:12,311 - DEBUG - Response for deleting network () 2026-06-18 03:41:13,573 - DEBUG - Skipping xmpp flap check
2026-06-18 03:41:13,573 - INFO - END TEST : test_create_md5_on_control : PASSED[0:00:25]
2026-06-18 03:41:13,574 - INFO - -------------------------------------------------------------------------------- 2026-06-18 03:41:14,344 - INFO - Deleted project: ctest-TestMd5testsOnControl-52711598, ID : 94fd4012-fb75-4301-abf4-cf5c1d33dc4e