2026-02-23 03:55:27,081 - INFO - Domain Default found not creating 2026-02-23 03:55:27,281 - INFO - Project ctest-TestMd5testsOnControl-38814262 not found, creating it 2026-02-23 03:55:27,890 - INFO - Created Project:ctest-TestMd5testsOnControl-38814262, ID : 7fa835fb-1650-45ca-9fa2-1be2f6aa4905 2026-02-23 03:55:31,324 - DEBUG - Response for create_network : {'network': {'id': 'a02251af-b5f0-43d1-8fa7-b65f10d55563', 'name': 'test_vnv6sr', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'project_id': '7fa835fb165045ca9fa21be2f6aa4905', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-38814262', 'test_vnv6sr'], 'port_security_enabled': True, 'description': ''}} 2026-02-23 03:55:31,593 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b98809d7-e9f4-4cee-a827-1335cbbbcd6f', 'name': '', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'network_id': 'a02251af-b5f0-43d1-8fa7-b65f10d55563', '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': '7fa835fb165045ca9fa21be2f6aa4905'}} 2026-02-23 03:55:31,859 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f381c62f-afbb-4388-af5f-f711801a304c', 'name': '', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'network_id': 'a02251af-b5f0-43d1-8fa7-b65f10d55563', 'ip_version': 4, 'cidr': '54.86.148.128/26', 'allocation_pools': [{'start': '54.86.148.130', 'end': '54.86.148.190'}], 'gateway_ip': '54.86.148.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '54.86.148.130', 'tags': [], 'project_id': '7fa835fb165045ca9fa21be2f6aa4905'}} 2026-02-23 03:55:31,883 - INFO - Created VN test_vnv6sr 2026-02-23 03:55:31,896 - DEBUG - VN test_vnv6sr UUID is a02251af-b5f0-43d1-8fa7-b65f10d55563 2026-02-23 03:55:32,249 - DEBUG - Response for create_network : {'network': {'id': 'a8837fa3-dc3e-46b9-b6d7-9d0e311a2fab', 'name': 'test_vnv6dn', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'project_id': '7fa835fb165045ca9fa21be2f6aa4905', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-38814262', 'test_vnv6dn'], 'port_security_enabled': True, 'description': ''}} 2026-02-23 03:55:32,496 - DEBUG - Response for create_subnet : {'subnet': {'id': '817cf63b-598d-4592-bed4-78f884aa08b5', 'name': '', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'network_id': 'a8837fa3-dc3e-46b9-b6d7-9d0e311a2fab', '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': '7fa835fb165045ca9fa21be2f6aa4905'}} 2026-02-23 03:55:32,730 - DEBUG - Response for create_subnet : {'subnet': {'id': '75d0e680-f116-4b49-a641-5e22fadb3b51', 'name': '', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'network_id': 'a8837fa3-dc3e-46b9-b6d7-9d0e311a2fab', 'ip_version': 4, 'cidr': '52.180.208.64/26', 'allocation_pools': [{'start': '52.180.208.66', 'end': '52.180.208.126'}], 'gateway_ip': '52.180.208.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '52.180.208.66', 'tags': [], 'project_id': '7fa835fb165045ca9fa21be2f6aa4905'}} 2026-02-23 03:55:32,754 - INFO - Created VN test_vnv6dn 2026-02-23 03:55:32,768 - DEBUG - VN test_vnv6dn UUID is a8837fa3-dc3e-46b9-b6d7-9d0e311a2fab 2026-02-23 03:55:32,932 - DEBUG - Services list from nova: [, , , ] 2026-02-23 03:55:34,230 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5383-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5383-2) 2026-02-23 03:55:35,959 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5383-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5383-1) 2026-02-23 03:55:35,959 - INFO - Waiting for VM source_vm to be up.. 2026-02-23 03:55:36,138 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-02-23 03:55:41,229 - DEBUG - VM is in ACTIVE state now 2026-02-23 03:55:41,230 - INFO - VM name : source_vm 2026-02-23 03:55:41,321 - DEBUG - VM source_vm ID is 512c8544-0a61-48ee-a8d5-431249214b5c 2026-02-23 03:55:41,352 - DEBUG - VM source_vm launched on Node an-jenkins-deploy-platform-ansible-os-5383-2 2026-02-23 03:55:41,443 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/512c8544-0a61-48ee-a8d5-431249214b5c 2026-02-23 03:55:41,841 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/512c8544-0a61-48ee-a8d5-431249214b5c 2026-02-23 03:55:41,902 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/4656f525-2b65-40cd-85aa-2bf5ffc66878 2026-02-23 03:55:45,095 - 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 1034ms') 2026-02-23 03:55:45,095 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM source_vm failed! 2026-02-23 03:55:45,109 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-38814262:test_vnv6sr is 2001::101:1 and allocation pool is NOT set 2026-02-23 03:55:45,109 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-38814262:test_vnv6sr is 54.86.148.129 and allocation pool is NOT set 2026-02-23 03:55:47,170 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=3.88 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.627 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.627/2.253/3.879/1.626 ms') 2026-02-23 03:55:47,170 - INFO - Ping to Metadata IP 169.254.0.3 of VM source_vm passed 2026-02-23 03:55:47,242 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-02-23 03:55:47,242 - DEBUG - Waiting to SSH to VM source_vm, IP 54.86.148.131, Port 22 2026-02-23 03:55:47,417 - DEBUG - VM source_vm is ready for SSH connections 2026-02-23 03:55:47,418 - INFO - Waiting for VM dest_vm to be up.. 2026-02-23 03:55:47,502 - DEBUG - VM is in ACTIVE state now 2026-02-23 03:55:47,502 - INFO - VM name : dest_vm 2026-02-23 03:55:47,605 - DEBUG - VM dest_vm ID is 56882499-f862-424a-8433-221450375bfe 2026-02-23 03:55:47,605 - DEBUG - VM dest_vm launched on Node an-jenkins-deploy-platform-ansible-os-5383-1 2026-02-23 03:55:47,706 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/56882499-f862-424a-8433-221450375bfe 2026-02-23 03:55:47,715 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/5a383805-3efd-44b0-84d2-755408be1f22 2026-02-23 03:55:48,878 - 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.07 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.60 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 = 3.604/3.835/4.067/0.231 ms') 2026-02-23 03:55:48,878 - INFO - Ping to Metadata IP 169.254.0.3 of VM dest_vm passed 2026-02-23 03:55:48,944 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-02-23 03:55:48,944 - DEBUG - Waiting to SSH to VM dest_vm, IP 52.180.208.67, Port 22 2026-02-23 03:55:49,012 - DEBUG - Error on ssh to cirros@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-02-23 03:55:49,104 - DEBUG - VM dest_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-02-23 03:55:54,104 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-02-23 03:55:54,105 - DEBUG - Waiting to SSH to VM dest_vm, IP 52.180.208.67, Port 22 2026-02-23 03:55:54,269 - DEBUG - VM dest_vm is ready for SSH connections 2026-02-23 03:55:54,274 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-38814262: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-38814262: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-02-23 03:55:54,591 - INFO - Attaching policy allow_all to vn test_vnv6sr 2026-02-23 03:55:54,962 - INFO - Attaching policy allow_all to vn test_vnv6dn 2026-02-23 03:55:55,238 - INFO - Configure the policy with allow any 2026-02-23 03:55:55,568 - DEBUG - Response for create_network : {'network': {'id': 'e710b888-5535-43ea-9f23-a2f2b748314f', 'name': 'vn1', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'project_id': '7fa835fb165045ca9fa21be2f6aa4905', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-38814262', 'vn1'], 'port_security_enabled': True, 'description': ''}} 2026-02-23 03:55:55,814 - DEBUG - Response for create_subnet : {'subnet': {'id': '81acab54-4083-44c4-b961-68ce0695235b', 'name': '', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'network_id': 'e710b888-5535-43ea-9f23-a2f2b748314f', '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': '7fa835fb165045ca9fa21be2f6aa4905'}} 2026-02-23 03:55:55,839 - INFO - Created VN vn1 2026-02-23 03:55:55,852 - DEBUG - VN vn1 UUID is e710b888-5535-43ea-9f23-a2f2b748314f 2026-02-23 03:55:56,188 - DEBUG - Response for create_network : {'network': {'id': 'bbd2053e-8fae-452e-b3f0-4f61732a7808', 'name': 'vn2', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'project_id': '7fa835fb165045ca9fa21be2f6aa4905', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-38814262', 'vn2'], 'port_security_enabled': True, 'description': ''}} 2026-02-23 03:55:56,457 - DEBUG - Response for create_subnet : {'subnet': {'id': '8dabf92f-b0a4-4590-97cc-b7531bc681e8', 'name': '', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'network_id': 'bbd2053e-8fae-452e-b3f0-4f61732a7808', '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': '7fa835fb165045ca9fa21be2f6aa4905'}} 2026-02-23 03:55:56,481 - INFO - Created VN vn2 2026-02-23 03:55:56,491 - DEBUG - VN vn2 UUID is bbd2053e-8fae-452e-b3f0-4f61732a7808 2026-02-23 03:55:56,569 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-38814262: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-38814262: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-02-23 03:55:56,895 - INFO - Attaching policy sec_grp_policy_ctest-random-04729312 to vn vn1 2026-02-23 03:55:57,251 - INFO - Attaching policy sec_grp_policy_ctest-random-04729312 to vn vn2 2026-02-23 03:55:58,901 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5383-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5383-2) 2026-02-23 03:56:00,435 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5383-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5383-1) 2026-02-23 03:56:00,496 - INFO - ================================================================================ 2026-02-23 03:56:00,496 - INFO - STARTING TEST : test_check_per_peer_on_control 2026-02-23 03:56:00,497 - INFO - TEST DESCRIPTION : Description: Verify per peer md5 and specific protocol on all ports and policy with allow all between VN's 2026-02-23 03:56:01,799 - DEBUG - Skipping xmpp flap check 2026-02-23 03:56:01,799 - INFO - Initial checks done. Running the testcase now 2026-02-23 03:56:01,799 - INFO - 2026-02-23 03:56:01,799 - INFO - config per peer with auth_data None 2026-02-23 03:56:02,350 - INFO - configure MD5 on host a08a793a-dca8-4613-b9b7-3eb89fd45aec 2026-02-23 03:56:02,432 - INFO - config per peer with auth_data None 2026-02-23 03:56:03,013 - INFO - configure MD5 on host c1005ae9-8405-469d-91df-48cedb5cf4d7 2026-02-23 03:56:03,100 - INFO - config per peer with auth_data None 2026-02-23 03:56:03,712 - INFO - configure MD5 on host d06cc4f8-3531-4e35-9cf6-d3304ced66a4 2026-02-23 03:56:03,796 - INFO - check BGP peering is up before setting md5 config 2026-02-23 03:56:03,796 - INFO - Check BGP staus between peers 2026-02-23 03:56:03,808 - INFO - config per peer with auth_data {'key_items': [{'key': 'juniper', 'key_id': 0}], 'key_type': 'md5'} 2026-02-23 03:56:04,364 - INFO - Check BGP staus between peers 2026-02-23 03:56:04,374 - DEBUG - Check the BGP connection on 10.0.0.242 2026-02-23 03:56:04,374 - DEBUG - Check the BGP connection on 10.0.0.242 2026-02-23 03:56:14,375 - INFO - Check BGP staus between peers 2026-02-23 03:56:14,387 - INFO - remove md5 configured on host a08a793a-dca8-4613-b9b7-3eb89fd45aec 2026-02-23 03:56:14,387 - INFO - config per peer with auth_data None 2026-02-23 03:56:14,880 - INFO - configure MD5 on host a08a793a-dca8-4613-b9b7-3eb89fd45aec 2026-02-23 03:56:14,972 - INFO - remove md5 configured on host c1005ae9-8405-469d-91df-48cedb5cf4d7 2026-02-23 03:56:14,973 - INFO - config per peer with auth_data None 2026-02-23 03:56:15,536 - INFO - configure MD5 on host c1005ae9-8405-469d-91df-48cedb5cf4d7 2026-02-23 03:56:15,620 - INFO - remove md5 configured on host d06cc4f8-3531-4e35-9cf6-d3304ced66a4 2026-02-23 03:56:15,620 - INFO - config per peer with auth_data None 2026-02-23 03:56:16,193 - INFO - configure MD5 on host d06cc4f8-3531-4e35-9cf6-d3304ced66a4 2026-02-23 03:56:16,281 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD 2026-02-23 03:56:16,281 - INFO - Deleting VM vn2_vm_0 2026-02-23 03:56:16,281 - ERROR - VM vn2_vm_0 has failed to come up 2026-02-23 03:56:16,281 - ERROR - Nova failed to get host of the VM 2026-02-23 03:56:16,281 - ERROR - VM vn2_vm_0 has failed to come up 2026-02-23 03:56:16,281 - ERROR - Nova failed to get host of the VM 2026-02-23 03:56:16,363 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD 2026-02-23 03:56:16,363 - INFO - Deleting VM vn1_vm_0 2026-02-23 03:56:16,363 - ERROR - VM vn1_vm_0 has failed to come up 2026-02-23 03:56:16,363 - ERROR - Nova failed to get host of the VM 2026-02-23 03:56:16,363 - ERROR - VM vn1_vm_0 has failed to come up 2026-02-23 03:56:16,363 - ERROR - Nova failed to get host of the VM 2026-02-23 03:56:16,452 - INFO - Dettaching policy sec_grp_policy_ctest-random-04729312 from vn vn2 2026-02-23 03:56:16,597 - INFO - Dettaching policy sec_grp_policy_ctest-random-04729312 from vn vn1 2026-02-23 03:56:16,850 - INFO - Deleted policy sec_grp_policy_ctest-random-04729312 2026-02-23 03:56:16,853 - INFO - Deleting VN vn2 2026-02-23 03:56:16,921 - DEBUG - VN bbd2053e-8fae-452e-b3f0-4f61732a7808 still in use: Unable to complete operation on network bbd2053e-8fae-452e-b3f0-4f61732a7808. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-ddd3a201-21fb-47d1-b631-591efeb3a8d0'] 2026-02-23 03:56:16,922 - WARNING - Deleting VN vn2 failed..Will retry 2026-02-23 03:56:19,059 - DEBUG - Response for deleting network () 2026-02-23 03:56:19,059 - INFO - Deleting VN vn1 2026-02-23 03:56:19,265 - DEBUG - Response for deleting network () 2026-02-23 03:56:19,265 - INFO - Dettaching policy allow_all from vn test_vnv6dn 2026-02-23 03:56:19,423 - INFO - Dettaching policy allow_all from vn test_vnv6sr 2026-02-23 03:56:19,679 - INFO - Deleted policy allow_all 2026-02-23 03:56:19,679 - INFO - Deleting VM dest_vm 2026-02-23 03:56:19,782 - INFO - Deleting VM source_vm 2026-02-23 03:56:19,864 - INFO - Deleting VN test_vnv6dn 2026-02-23 03:56:19,915 - DEBUG - VN a8837fa3-dc3e-46b9-b6d7-9d0e311a2fab still in use: Unable to complete operation on network a8837fa3-dc3e-46b9-b6d7-9d0e311a2fab. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-7421c0c4-8ac1-4a4f-88cf-963efeaad6a7'] 2026-02-23 03:56:19,915 - WARNING - Deleting VN test_vnv6dn failed..Will retry 2026-02-23 03:56:22,101 - DEBUG - Response for deleting network () 2026-02-23 03:56:22,101 - INFO - Deleting VN test_vnv6sr 2026-02-23 03:56:22,267 - DEBUG - Response for deleting network () 2026-02-23 03:56:23,527 - DEBUG - Skipping xmpp flap check
2026-02-23 03:56:23,528 - INFO - END TEST : test_check_per_peer_on_control : PASSED[0:00:23]
2026-02-23 03:56:23,528 - INFO - -------------------------------------------------------------------------------- 2026-02-23 03:56:23,774 - DEBUG - Response for create_network : {'network': {'id': '2269d7a5-bd84-4759-b7a7-2633972c7a6f', 'name': 'test_vnv6sr', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'project_id': '7fa835fb165045ca9fa21be2f6aa4905', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-38814262', 'test_vnv6sr'], 'port_security_enabled': True, 'description': ''}} 2026-02-23 03:56:24,027 - DEBUG - Response for create_subnet : {'subnet': {'id': '63e7a01b-400c-4dbc-9788-1ac37160c825', 'name': '', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'network_id': '2269d7a5-bd84-4759-b7a7-2633972c7a6f', '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': '7fa835fb165045ca9fa21be2f6aa4905'}} 2026-02-23 03:56:24,262 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f51defc7-7bf3-468f-a135-1f0363508ac0', 'name': '', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'network_id': '2269d7a5-bd84-4759-b7a7-2633972c7a6f', 'ip_version': 4, 'cidr': '153.80.218.192/26', 'allocation_pools': [{'start': '153.80.218.194', 'end': '153.80.218.254'}], 'gateway_ip': '153.80.218.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '153.80.218.194', 'tags': [], 'project_id': '7fa835fb165045ca9fa21be2f6aa4905'}} 2026-02-23 03:56:24,289 - INFO - Created VN test_vnv6sr 2026-02-23 03:56:24,302 - DEBUG - VN test_vnv6sr UUID is 2269d7a5-bd84-4759-b7a7-2633972c7a6f 2026-02-23 03:56:24,649 - DEBUG - Response for create_network : {'network': {'id': '9d587cf0-3d72-4321-b0c9-24c758d9e403', 'name': 'test_vnv6dn', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'project_id': '7fa835fb165045ca9fa21be2f6aa4905', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-38814262', 'test_vnv6dn'], 'port_security_enabled': True, 'description': ''}} 2026-02-23 03:56:24,874 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e6b61941-3267-4730-a813-cc9fd6080bc5', 'name': '', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'network_id': '9d587cf0-3d72-4321-b0c9-24c758d9e403', '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': '7fa835fb165045ca9fa21be2f6aa4905'}} 2026-02-23 03:56:25,113 - DEBUG - Response for create_subnet : {'subnet': {'id': '498a6958-1935-4245-831a-d22385fbf78e', 'name': '', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'network_id': '9d587cf0-3d72-4321-b0c9-24c758d9e403', 'ip_version': 4, 'cidr': '86.85.12.64/26', 'allocation_pools': [{'start': '86.85.12.66', 'end': '86.85.12.126'}], 'gateway_ip': '86.85.12.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '86.85.12.66', 'tags': [], 'project_id': '7fa835fb165045ca9fa21be2f6aa4905'}} 2026-02-23 03:56:25,140 - INFO - Created VN test_vnv6dn 2026-02-23 03:56:25,154 - DEBUG - VN test_vnv6dn UUID is 9d587cf0-3d72-4321-b0c9-24c758d9e403 2026-02-23 03:56:26,536 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5383-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5383-2) 2026-02-23 03:56:28,022 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5383-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5383-1) 2026-02-23 03:56:28,022 - INFO - Waiting for VM source_vm to be up.. 2026-02-23 03:56:28,110 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-02-23 03:56:33,210 - DEBUG - VM is in ACTIVE state now 2026-02-23 03:56:33,210 - INFO - VM name : source_vm 2026-02-23 03:56:33,296 - DEBUG - VM source_vm ID is e1c308d4-28d5-409e-be79-477ad2756197 2026-02-23 03:56:33,296 - DEBUG - VM source_vm launched on Node an-jenkins-deploy-platform-ansible-os-5383-2 2026-02-23 03:56:33,383 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/e1c308d4-28d5-409e-be79-477ad2756197 2026-02-23 03:56:33,393 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/630ba04f-7024-4d07-98d7-6219bde52522 2026-02-23 03:56:36,577 - 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 1031ms') 2026-02-23 03:56:36,577 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM source_vm failed! 2026-02-23 03:56:36,591 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-38814262:test_vnv6sr is 2001::101:1 and allocation pool is NOT set 2026-02-23 03:56:36,591 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-38814262:test_vnv6sr is 153.80.218.193 and allocation pool is NOT set 2026-02-23 03:56:38,654 - 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.89 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.901 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.901/3.893/6.885/2.992 ms') 2026-02-23 03:56:38,655 - INFO - Ping to Metadata IP 169.254.0.3 of VM source_vm passed 2026-02-23 03:56:38,721 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-02-23 03:56:38,722 - DEBUG - Waiting to SSH to VM source_vm, IP 153.80.218.195, Port 22 2026-02-23 03:56:38,890 - DEBUG - VM source_vm is ready for SSH connections 2026-02-23 03:56:38,890 - INFO - Waiting for VM dest_vm to be up.. 2026-02-23 03:56:38,977 - DEBUG - VM is in ACTIVE state now 2026-02-23 03:56:38,977 - INFO - VM name : dest_vm 2026-02-23 03:56:39,076 - DEBUG - VM dest_vm ID is ac8f3ef9-ea66-439c-b447-7afb12c8b456 2026-02-23 03:56:39,076 - DEBUG - VM dest_vm launched on Node an-jenkins-deploy-platform-ansible-os-5383-1 2026-02-23 03:56:39,170 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/ac8f3ef9-ea66-439c-b447-7afb12c8b456 2026-02-23 03:56:39,179 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/e73538cd-7540-4d1b-9067-eb2dd23a2d1a 2026-02-23 03:56:40,363 - 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=8.23 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.401 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.401/4.317/8.234/3.916 ms') 2026-02-23 03:56:40,363 - INFO - Ping to Metadata IP 169.254.0.3 of VM dest_vm passed 2026-02-23 03:56:40,435 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-02-23 03:56:40,435 - DEBUG - Waiting to SSH to VM dest_vm, IP 86.85.12.67, Port 22 2026-02-23 03:56:40,597 - DEBUG - VM dest_vm is ready for SSH connections 2026-02-23 03:56:40,605 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-38814262: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-38814262: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-02-23 03:56:40,942 - INFO - Attaching policy allow_all to vn test_vnv6sr 2026-02-23 03:56:41,331 - INFO - Attaching policy allow_all to vn test_vnv6dn 2026-02-23 03:56:41,653 - INFO - Configure the policy with allow any 2026-02-23 03:56:41,952 - DEBUG - Response for create_network : {'network': {'id': '2d3b824e-0dd3-404a-ba97-ff1d3a761789', 'name': 'vn1', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'project_id': '7fa835fb165045ca9fa21be2f6aa4905', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-38814262', 'vn1'], 'port_security_enabled': True, 'description': ''}} 2026-02-23 03:56:42,276 - DEBUG - Response for create_subnet : {'subnet': {'id': '2b18ef2b-5df1-40fa-ad42-67372e7d93ca', 'name': '', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'network_id': '2d3b824e-0dd3-404a-ba97-ff1d3a761789', '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': '7fa835fb165045ca9fa21be2f6aa4905'}} 2026-02-23 03:56:42,301 - INFO - Created VN vn1 2026-02-23 03:56:42,312 - DEBUG - VN vn1 UUID is 2d3b824e-0dd3-404a-ba97-ff1d3a761789 2026-02-23 03:56:42,690 - DEBUG - Response for create_network : {'network': {'id': '8e005083-d46d-49a8-b5e1-d7943d06c993', 'name': 'vn2', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'project_id': '7fa835fb165045ca9fa21be2f6aa4905', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-38814262', 'vn2'], 'port_security_enabled': True, 'description': ''}} 2026-02-23 03:56:42,967 - DEBUG - Response for create_subnet : {'subnet': {'id': '2acbb096-eac6-4074-9503-7efe72f3df5f', 'name': '', 'tenant_id': '7fa835fb165045ca9fa21be2f6aa4905', 'network_id': '8e005083-d46d-49a8-b5e1-d7943d06c993', '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': '7fa835fb165045ca9fa21be2f6aa4905'}} 2026-02-23 03:56:42,995 - INFO - Created VN vn2 2026-02-23 03:56:43,010 - DEBUG - VN vn2 UUID is 8e005083-d46d-49a8-b5e1-d7943d06c993 2026-02-23 03:56:43,097 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-38814262: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-38814262: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-02-23 03:56:43,440 - INFO - Attaching policy sec_grp_policy_ctest-random-12800257 to vn vn1 2026-02-23 03:56:43,835 - INFO - Attaching policy sec_grp_policy_ctest-random-12800257 to vn vn2 2026-02-23 03:56:45,721 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5383-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5383-2) 2026-02-23 03:56:47,688 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5383-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5383-1) 2026-02-23 03:56:47,748 - INFO - ================================================================================ 2026-02-23 03:56:47,748 - INFO - STARTING TEST : test_create_md5_on_control 2026-02-23 03:56:47,748 - INFO - TEST DESCRIPTION : Description: Verify md5 with allow specific protocol on all ports and policy with allow all between VN's 2026-02-23 03:56:49,047 - DEBUG - Skipping xmpp flap check 2026-02-23 03:56:49,048 - INFO - Initial checks done. Running the testcase now 2026-02-23 03:56:49,048 - INFO - 2026-02-23 03:56:49,048 - INFO - config md5 on each host with auth_data None 2026-02-23 03:56:49,048 - INFO - config per peer with auth_data None 2026-02-23 03:56:49,572 - INFO - configure MD5 on host a08a793a-dca8-4613-b9b7-3eb89fd45aec 2026-02-23 03:56:49,656 - INFO - config per peer with auth_data None 2026-02-23 03:56:50,282 - INFO - configure MD5 on host c1005ae9-8405-469d-91df-48cedb5cf4d7 2026-02-23 03:56:50,368 - INFO - config per peer with auth_data None 2026-02-23 03:56:50,957 - INFO - configure MD5 on host d06cc4f8-3531-4e35-9cf6-d3304ced66a4 2026-02-23 03:56:51,036 - INFO - check if BGP between peers are up before setting md5 2026-02-23 03:56:51,037 - INFO - Check BGP staus between peers 2026-02-23 03:56:51,063 - INFO - setting MD5 config on host a08a793a-dca8-4613-b9b7-3eb89fd45aec 2026-02-23 03:56:51,065 - INFO - configure MD5 on host a08a793a-dca8-4613-b9b7-3eb89fd45aec 2026-02-23 03:56:51,160 - INFO - setting MD5 config on host c1005ae9-8405-469d-91df-48cedb5cf4d7 2026-02-23 03:56:51,160 - INFO - configure MD5 on host c1005ae9-8405-469d-91df-48cedb5cf4d7 2026-02-23 03:56:51,240 - INFO - setting MD5 config on host d06cc4f8-3531-4e35-9cf6-d3304ced66a4 2026-02-23 03:56:51,240 - INFO - configure MD5 on host d06cc4f8-3531-4e35-9cf6-d3304ced66a4 2026-02-23 03:56:51,329 - INFO - check if BGP peering is up after md5 config 2026-02-23 03:56:51,329 - INFO - Check BGP staus between peers 2026-02-23 03:56:51,345 - DEBUG - Check the BGP connection on 10.0.0.242 2026-02-23 03:56:51,345 - DEBUG - Check the BGP connection on 10.0.0.242 2026-02-23 03:57:01,345 - INFO - Check BGP staus between peers 2026-02-23 03:57:01,367 - INFO - remove md5 configured on host a08a793a-dca8-4613-b9b7-3eb89fd45aec 2026-02-23 03:57:01,367 - INFO - config per peer with auth_data None 2026-02-23 03:57:01,940 - INFO - configure MD5 on host a08a793a-dca8-4613-b9b7-3eb89fd45aec 2026-02-23 03:57:02,032 - INFO - remove md5 configured on host c1005ae9-8405-469d-91df-48cedb5cf4d7 2026-02-23 03:57:02,032 - INFO - config per peer with auth_data None 2026-02-23 03:57:02,584 - INFO - configure MD5 on host c1005ae9-8405-469d-91df-48cedb5cf4d7 2026-02-23 03:57:02,664 - INFO - remove md5 configured on host d06cc4f8-3531-4e35-9cf6-d3304ced66a4 2026-02-23 03:57:02,664 - INFO - config per peer with auth_data None 2026-02-23 03:57:03,244 - INFO - configure MD5 on host d06cc4f8-3531-4e35-9cf6-d3304ced66a4 2026-02-23 03:57:03,333 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD 2026-02-23 03:57:03,333 - INFO - Deleting VM vn2_vm_0 2026-02-23 03:57:03,333 - ERROR - VM vn2_vm_0 has failed to come up 2026-02-23 03:57:03,333 - ERROR - Nova failed to get host of the VM 2026-02-23 03:57:03,333 - ERROR - VM vn2_vm_0 has failed to come up 2026-02-23 03:57:03,333 - ERROR - Nova failed to get host of the VM 2026-02-23 03:57:03,428 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD 2026-02-23 03:57:03,428 - INFO - Deleting VM vn1_vm_0 2026-02-23 03:57:03,429 - ERROR - VM vn1_vm_0 has failed to come up 2026-02-23 03:57:03,429 - ERROR - Nova failed to get host of the VM 2026-02-23 03:57:03,429 - ERROR - VM vn1_vm_0 has failed to come up 2026-02-23 03:57:03,429 - ERROR - Nova failed to get host of the VM 2026-02-23 03:57:03,515 - INFO - Dettaching policy sec_grp_policy_ctest-random-12800257 from vn vn2 2026-02-23 03:57:03,679 - INFO - Dettaching policy sec_grp_policy_ctest-random-12800257 from vn vn1 2026-02-23 03:57:03,918 - INFO - Deleted policy sec_grp_policy_ctest-random-12800257 2026-02-23 03:57:03,919 - INFO - Deleting VN vn2 2026-02-23 03:57:03,980 - DEBUG - VN 8e005083-d46d-49a8-b5e1-d7943d06c993 still in use: Unable to complete operation on network 8e005083-d46d-49a8-b5e1-d7943d06c993. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-8b0134fe-f541-405d-9cfb-c9cf9ce4c29c'] 2026-02-23 03:57:03,980 - WARNING - Deleting VN vn2 failed..Will retry 2026-02-23 03:57:06,127 - DEBUG - Response for deleting network () 2026-02-23 03:57:06,127 - INFO - Deleting VN vn1 2026-02-23 03:57:06,293 - DEBUG - Response for deleting network () 2026-02-23 03:57:06,293 - INFO - Dettaching policy allow_all from vn test_vnv6dn 2026-02-23 03:57:06,499 - INFO - Dettaching policy allow_all from vn test_vnv6sr 2026-02-23 03:57:06,764 - INFO - Deleted policy allow_all 2026-02-23 03:57:06,764 - INFO - Deleting VM dest_vm 2026-02-23 03:57:06,869 - INFO - Deleting VM source_vm 2026-02-23 03:57:06,955 - INFO - Deleting VN test_vnv6dn 2026-02-23 03:57:07,013 - DEBUG - VN 9d587cf0-3d72-4321-b0c9-24c758d9e403 still in use: Unable to complete operation on network 9d587cf0-3d72-4321-b0c9-24c758d9e403. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-2d07bbf3-7436-44b0-8bc3-f7ae0d609d66'] 2026-02-23 03:57:07,013 - WARNING - Deleting VN test_vnv6dn failed..Will retry 2026-02-23 03:57:09,185 - DEBUG - Response for deleting network () 2026-02-23 03:57:09,185 - INFO - Deleting VN test_vnv6sr 2026-02-23 03:57:09,364 - DEBUG - Response for deleting network () 2026-02-23 03:57:10,632 - DEBUG - Skipping xmpp flap check
2026-02-23 03:57:10,632 - INFO - END TEST : test_create_md5_on_control : PASSED[0:00:23]
2026-02-23 03:57:10,632 - INFO - -------------------------------------------------------------------------------- 2026-02-23 03:57:11,495 - INFO - Deleted project: ctest-TestMd5testsOnControl-38814262, ID : 7fa835fb-1650-45ca-9fa2-1be2f6aa4905