2026-11-02 04:48:26,852 - INFO - Domain Default found not creating 2026-11-02 04:48:27,035 - INFO - Project ctest-TestMd5testsOnControl-02715667 not found, creating it 2026-11-02 04:48:27,558 - INFO - Created Project:ctest-TestMd5testsOnControl-02715667, ID : f5290f47-da12-4831-9efa-d21b70966512 2026-11-02 04:48:30,031 - DEBUG - Response for create_network : {'network': {'id': '23cf8d2b-d001-45bb-b317-9323c73b8acd', 'name': 'test_vnv6sr', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'project_id': 'f5290f47da1248319efad21b70966512', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-02715667', 'test_vnv6sr'], 'port_security_enabled': True, 'description': ''}} 2026-11-02 04:48:30,332 - DEBUG - Response for create_subnet : {'subnet': {'id': '2977e464-1369-4ee8-8cfc-4680b4e3e3fd', 'name': '', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'network_id': '23cf8d2b-d001-45bb-b317-9323c73b8acd', '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': 'f5290f47da1248319efad21b70966512'}} 2026-11-02 04:48:30,552 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd18b07c4-116a-45ec-8756-3051b0ec6645', 'name': '', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'network_id': '23cf8d2b-d001-45bb-b317-9323c73b8acd', 'ip_version': 4, 'cidr': '69.84.59.128/26', 'allocation_pools': [{'start': '69.84.59.130', 'end': '69.84.59.190'}], 'gateway_ip': '69.84.59.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '69.84.59.130', 'tags': [], 'project_id': 'f5290f47da1248319efad21b70966512'}} 2026-11-02 04:48:30,575 - INFO - Created VN test_vnv6sr 2026-11-02 04:48:30,587 - DEBUG - VN test_vnv6sr UUID is 23cf8d2b-d001-45bb-b317-9323c73b8acd 2026-11-02 04:48:30,971 - DEBUG - Response for create_network : {'network': {'id': '2dc4c94e-475f-44be-8787-30fc225b1702', 'name': 'test_vnv6dn', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'project_id': 'f5290f47da1248319efad21b70966512', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-02715667', 'test_vnv6dn'], 'port_security_enabled': True, 'description': ''}} 2026-11-02 04:48:31,220 - DEBUG - Response for create_subnet : {'subnet': {'id': '5ae401f7-dad2-4c14-b9c4-0b191f51489b', 'name': '', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'network_id': '2dc4c94e-475f-44be-8787-30fc225b1702', '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': 'f5290f47da1248319efad21b70966512'}} 2026-11-02 04:48:31,438 - DEBUG - Response for create_subnet : {'subnet': {'id': '2105084b-d292-47cc-bb5f-7b828936b976', 'name': '', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'network_id': '2dc4c94e-475f-44be-8787-30fc225b1702', 'ip_version': 4, 'cidr': '119.141.0.64/26', 'allocation_pools': [{'start': '119.141.0.66', 'end': '119.141.0.126'}], 'gateway_ip': '119.141.0.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '119.141.0.66', 'tags': [], 'project_id': 'f5290f47da1248319efad21b70966512'}} 2026-11-02 04:48:31,475 - INFO - Created VN test_vnv6dn 2026-11-02 04:48:31,493 - DEBUG - VN test_vnv6dn UUID is 2dc4c94e-475f-44be-8787-30fc225b1702 2026-11-02 04:48:31,676 - DEBUG - Services list from nova: [, , , ] 2026-11-02 04:48:32,848 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6461-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6461-1) 2026-11-02 04:48:33,461 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6461-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6461-2) 2026-11-02 04:48:33,461 - INFO - Waiting for VM source_vm to be up.. 2026-11-02 04:48:33,520 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-11-02 04:48:38,622 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-11-02 04:48:43,748 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-11-02 04:48:48,855 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-11-02 04:48:53,955 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-11-02 04:48:59,052 - DEBUG - VM is in ACTIVE state now 2026-11-02 04:48:59,052 - INFO - VM name : source_vm 2026-11-02 04:48:59,182 - DEBUG - VM source_vm ID is 83122356-7704-4fac-8bd1-69e4bb057d0b 2026-11-02 04:48:59,221 - DEBUG - VM source_vm launched on Node an-jenkins-deploy-platform-ansible-os-6461-1 2026-11-02 04:48:59,320 - DEBUG - Requesting: http://10.0.0.191:8082/virtual-machine/83122356-7704-4fac-8bd1-69e4bb057d0b 2026-11-02 04:48:59,709 - DEBUG - Requesting: http://10.0.0.191:8082/virtual-machine/83122356-7704-4fac-8bd1-69e4bb057d0b 2026-11-02 04:48:59,834 - DEBUG - Requesting: http://10.0.0.191:8082/virtual-machine-interface/5ebb23f5-b688-4232-9415-81a1370f7bc1 2026-11-02 04:49:03,036 - 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 1033ms') 2026-11-02 04:49:03,036 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM source_vm failed! 2026-11-02 04:49:03,052 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-02715667:test_vnv6sr is 2001::101:1 and allocation pool is NOT set 2026-11-02 04:49:03,052 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-02715667:test_vnv6sr is 69.84.59.129 and allocation pool is NOT set 2026-11-02 04:49:05,124 - 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=7.36 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.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 = 1.603/4.479/7.355/2.876 ms') 2026-11-02 04:49:05,124 - INFO - Ping to Metadata IP 169.254.0.3 of VM source_vm passed 2026-11-02 04:49:05,200 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-11-02 04:49:05,200 - DEBUG - Waiting to SSH to VM source_vm, IP 69.84.59.131, Port 22 2026-11-02 04:49:05,269 - 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-11-02 04:49:05,358 - DEBUG - VM source_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-11-02 04:49:10,359 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-11-02 04:49:10,359 - DEBUG - Waiting to SSH to VM source_vm, IP 69.84.59.131, Port 22 2026-11-02 04:49:10,533 - DEBUG - VM source_vm is ready for SSH connections 2026-11-02 04:49:10,533 - INFO - Waiting for VM dest_vm to be up.. 2026-11-02 04:49:10,617 - DEBUG - VM is in ACTIVE state now 2026-11-02 04:49:10,617 - INFO - VM name : dest_vm 2026-11-02 04:49:10,698 - DEBUG - VM dest_vm ID is 4aa12c6a-f924-4319-9cd1-0a9ef4c12799 2026-11-02 04:49:10,698 - DEBUG - VM dest_vm launched on Node an-jenkins-deploy-platform-ansible-os-6461-2 2026-11-02 04:49:10,779 - DEBUG - Requesting: http://10.0.0.191:8082/virtual-machine/4aa12c6a-f924-4319-9cd1-0a9ef4c12799 2026-11-02 04:49:10,791 - DEBUG - Requesting: http://10.0.0.191:8082/virtual-machine-interface/117c12a7-22e2-4190-b8af-61af602267cb 2026-11-02 04:49:11,958 - 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=2.79 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.365 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.365/1.577/2.789/1.212 ms') 2026-11-02 04:49:11,958 - INFO - Ping to Metadata IP 169.254.0.3 of VM dest_vm passed 2026-11-02 04:49:12,031 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-11-02 04:49:12,031 - DEBUG - Waiting to SSH to VM dest_vm, IP 119.141.0.67, Port 22 2026-11-02 04:49:12,201 - DEBUG - VM dest_vm is ready for SSH connections 2026-11-02 04:49:12,209 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-02715667: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-02715667: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-11-02 04:49:12,569 - INFO - Attaching policy allow_all to vn test_vnv6sr 2026-11-02 04:49:12,948 - INFO - Attaching policy allow_all to vn test_vnv6dn 2026-11-02 04:49:13,217 - INFO - Configure the policy with allow any 2026-11-02 04:49:13,551 - DEBUG - Response for create_network : {'network': {'id': 'e1bb4876-497b-4464-bdf4-9f021a6b0f0d', 'name': 'vn1', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'project_id': 'f5290f47da1248319efad21b70966512', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-02715667', 'vn1'], 'port_security_enabled': True, 'description': ''}} 2026-11-02 04:49:13,820 - DEBUG - Response for create_subnet : {'subnet': {'id': '62db88b0-a0fb-4d01-918d-c8e0273e2779', 'name': '', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'network_id': 'e1bb4876-497b-4464-bdf4-9f021a6b0f0d', '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': 'f5290f47da1248319efad21b70966512'}} 2026-11-02 04:49:13,841 - INFO - Created VN vn1 2026-11-02 04:49:13,856 - DEBUG - VN vn1 UUID is e1bb4876-497b-4464-bdf4-9f021a6b0f0d 2026-11-02 04:49:14,255 - DEBUG - Response for create_network : {'network': {'id': '3c350ffb-f9e3-4e3a-ac3e-9892987f47f2', 'name': 'vn2', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'project_id': 'f5290f47da1248319efad21b70966512', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-02715667', 'vn2'], 'port_security_enabled': True, 'description': ''}} 2026-11-02 04:49:14,484 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c77b938d-228b-45c6-8436-be0be56f2b07', 'name': '', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'network_id': '3c350ffb-f9e3-4e3a-ac3e-9892987f47f2', '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': 'f5290f47da1248319efad21b70966512'}} 2026-11-02 04:49:14,506 - INFO - Created VN vn2 2026-11-02 04:49:14,519 - DEBUG - VN vn2 UUID is 3c350ffb-f9e3-4e3a-ac3e-9892987f47f2 2026-11-02 04:49:14,633 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-02715667: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-02715667: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-11-02 04:49:14,965 - INFO - Attaching policy sec_grp_policy_ctest-random-19406751 to vn vn1 2026-11-02 04:49:15,317 - INFO - Attaching policy sec_grp_policy_ctest-random-19406751 to vn vn2 2026-11-02 04:49:16,209 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6461-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6461-1) 2026-11-02 04:49:16,793 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6461-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6461-2) 2026-11-02 04:49:16,860 - INFO - ================================================================================ 2026-11-02 04:49:16,860 - INFO - STARTING TEST : test_check_per_peer_on_control 2026-11-02 04:49:16,860 - INFO - TEST DESCRIPTION : Description: Verify per peer md5 and specific protocol on all ports and policy with allow all between VN's 2026-11-02 04:49:18,157 - DEBUG - Skipping xmpp flap check 2026-11-02 04:49:18,157 - INFO - Initial checks done. Running the testcase now 2026-11-02 04:49:18,157 - INFO - 2026-11-02 04:49:18,157 - INFO - config per peer with auth_data None 2026-11-02 04:49:18,785 - INFO - configure MD5 on host ecb3e092-137c-4914-be20-af0b0ced2df4 2026-11-02 04:49:18,873 - INFO - config per peer with auth_data None 2026-11-02 04:49:19,473 - INFO - configure MD5 on host b711b199-7963-4da0-b76f-e1c20469f1c5 2026-11-02 04:49:19,557 - INFO - config per peer with auth_data None 2026-11-02 04:49:20,113 - INFO - configure MD5 on host ec30c03f-5f86-4972-8058-edddc5fae77b 2026-11-02 04:49:20,193 - INFO - check BGP peering is up before setting md5 config 2026-11-02 04:49:20,193 - INFO - Check BGP staus between peers 2026-11-02 04:49:20,205 - INFO - config per peer with auth_data {'key_items': [{'key': 'juniper', 'key_id': 0}], 'key_type': 'md5'} 2026-11-02 04:49:20,945 - INFO - Check BGP staus between peers 2026-11-02 04:49:20,968 - DEBUG - Check the BGP connection on 10.0.0.50 2026-11-02 04:49:20,968 - DEBUG - Check the BGP connection on 10.0.0.50 2026-11-02 04:49:30,968 - INFO - Check BGP staus between peers 2026-11-02 04:49:30,982 - INFO - remove md5 configured on host ecb3e092-137c-4914-be20-af0b0ced2df4 2026-11-02 04:49:30,982 - INFO - config per peer with auth_data None 2026-11-02 04:49:31,637 - INFO - configure MD5 on host ecb3e092-137c-4914-be20-af0b0ced2df4 2026-11-02 04:49:31,729 - INFO - remove md5 configured on host b711b199-7963-4da0-b76f-e1c20469f1c5 2026-11-02 04:49:31,729 - INFO - config per peer with auth_data None 2026-11-02 04:49:32,305 - INFO - configure MD5 on host b711b199-7963-4da0-b76f-e1c20469f1c5 2026-11-02 04:49:32,389 - INFO - remove md5 configured on host ec30c03f-5f86-4972-8058-edddc5fae77b 2026-11-02 04:49:32,389 - INFO - config per peer with auth_data None 2026-11-02 04:49:33,025 - INFO - configure MD5 on host ec30c03f-5f86-4972-8058-edddc5fae77b 2026-11-02 04:49:33,109 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD 2026-11-02 04:49:33,109 - INFO - Deleting VM vn2_vm_0 2026-11-02 04:49:33,109 - ERROR - VM vn2_vm_0 has failed to come up 2026-11-02 04:49:33,109 - ERROR - Nova failed to get host of the VM 2026-11-02 04:49:33,109 - ERROR - VM vn2_vm_0 has failed to come up 2026-11-02 04:49:33,109 - ERROR - Nova failed to get host of the VM 2026-11-02 04:49:33,199 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD 2026-11-02 04:49:33,199 - INFO - Deleting VM vn1_vm_0 2026-11-02 04:49:33,200 - ERROR - VM vn1_vm_0 has failed to come up 2026-11-02 04:49:33,200 - ERROR - Nova failed to get host of the VM 2026-11-02 04:49:33,200 - ERROR - VM vn1_vm_0 has failed to come up 2026-11-02 04:49:33,200 - ERROR - Nova failed to get host of the VM 2026-11-02 04:49:33,277 - INFO - Dettaching policy sec_grp_policy_ctest-random-19406751 from vn vn2 2026-11-02 04:49:33,461 - INFO - Dettaching policy sec_grp_policy_ctest-random-19406751 from vn vn1 2026-11-02 04:49:33,724 - INFO - Deleted policy sec_grp_policy_ctest-random-19406751 2026-11-02 04:49:33,724 - INFO - Deleting VN vn2 2026-11-02 04:49:33,765 - DEBUG - VN 3c350ffb-f9e3-4e3a-ac3e-9892987f47f2 still in use: Unable to complete operation on network 3c350ffb-f9e3-4e3a-ac3e-9892987f47f2. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-7e378a6d-c249-48ff-a8ec-b3976b203ec0'] 2026-11-02 04:49:33,765 - WARNING - Deleting VN vn2 failed..Will retry 2026-11-02 04:49:35,809 - DEBUG - VN 3c350ffb-f9e3-4e3a-ac3e-9892987f47f2 still in use: Unable to complete operation on network 3c350ffb-f9e3-4e3a-ac3e-9892987f47f2. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-d205a288-7925-40c9-9d77-eec45afd6f0e'] 2026-11-02 04:49:35,809 - WARNING - Deleting VN vn2 failed..Will retry 2026-11-02 04:49:37,853 - DEBUG - VN 3c350ffb-f9e3-4e3a-ac3e-9892987f47f2 still in use: Unable to complete operation on network 3c350ffb-f9e3-4e3a-ac3e-9892987f47f2. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-0fd80fe3-61d1-4639-a0bb-a5717c600eeb'] 2026-11-02 04:49:37,853 - WARNING - Deleting VN vn2 failed..Will retry 2026-11-02 04:49:39,898 - DEBUG - VN 3c350ffb-f9e3-4e3a-ac3e-9892987f47f2 still in use: Unable to complete operation on network 3c350ffb-f9e3-4e3a-ac3e-9892987f47f2. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-ca6069c6-7263-44ca-8ae9-3238ad17495a'] 2026-11-02 04:49:39,898 - WARNING - Deleting VN vn2 failed..Will retry 2026-11-02 04:49:41,948 - DEBUG - VN 3c350ffb-f9e3-4e3a-ac3e-9892987f47f2 still in use: Unable to complete operation on network 3c350ffb-f9e3-4e3a-ac3e-9892987f47f2. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-7fdf3a8f-e139-406f-84e4-b371b245956c'] 2026-11-02 04:49:41,948 - WARNING - Deleting VN vn2 failed..Will retry 2026-11-02 04:49:44,016 - DEBUG - VN 3c350ffb-f9e3-4e3a-ac3e-9892987f47f2 still in use: Unable to complete operation on network 3c350ffb-f9e3-4e3a-ac3e-9892987f47f2. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-b08592ce-133a-4207-81af-f4bffde5aead'] 2026-11-02 04:49:44,016 - WARNING - Deleting VN vn2 failed..Will retry 2026-11-02 04:49:46,182 - DEBUG - Response for deleting network () 2026-11-02 04:49:46,182 - INFO - Deleting VN vn1 2026-11-02 04:49:46,360 - DEBUG - Response for deleting network () 2026-11-02 04:49:46,360 - INFO - Dettaching policy allow_all from vn test_vnv6dn 2026-11-02 04:49:46,560 - INFO - Dettaching policy allow_all from vn test_vnv6sr 2026-11-02 04:49:46,858 - INFO - Deleted policy allow_all 2026-11-02 04:49:46,859 - INFO - Deleting VM dest_vm 2026-11-02 04:49:46,950 - INFO - Deleting VM source_vm 2026-11-02 04:49:47,029 - INFO - Deleting VN test_vnv6dn 2026-11-02 04:49:47,081 - DEBUG - VN 2dc4c94e-475f-44be-8787-30fc225b1702 still in use: Unable to complete operation on network 2dc4c94e-475f-44be-8787-30fc225b1702. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-265b8f7b-5be4-4463-ae0c-29410b547dad'] 2026-11-02 04:49:47,081 - WARNING - Deleting VN test_vnv6dn failed..Will retry 2026-11-02 04:49:49,130 - DEBUG - VN 2dc4c94e-475f-44be-8787-30fc225b1702 still in use: Unable to complete operation on network 2dc4c94e-475f-44be-8787-30fc225b1702. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-ee1daab6-9a71-427d-b8e8-5f107d6f204b'] 2026-11-02 04:49:49,131 - WARNING - Deleting VN test_vnv6dn failed..Will retry 2026-11-02 04:49:51,341 - DEBUG - Response for deleting network () 2026-11-02 04:49:51,341 - INFO - Deleting VN test_vnv6sr 2026-11-02 04:49:51,531 - DEBUG - Response for deleting network () 2026-11-02 04:49:52,831 - DEBUG - Skipping xmpp flap check
2026-11-02 04:49:52,831 - INFO - END TEST : test_check_per_peer_on_control : PASSED[0:00:36]
2026-11-02 04:49:52,831 - INFO - -------------------------------------------------------------------------------- 2026-11-02 04:49:53,161 - DEBUG - Response for create_network : {'network': {'id': '2aac5059-339b-4603-b883-e9af678a5812', 'name': 'test_vnv6sr', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'project_id': 'f5290f47da1248319efad21b70966512', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-02715667', 'test_vnv6sr'], 'port_security_enabled': True, 'description': ''}} 2026-11-02 04:49:53,367 - DEBUG - Response for create_subnet : {'subnet': {'id': '6e7a1078-5bfa-4872-ae7c-bb9a9b25283b', 'name': '', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'network_id': '2aac5059-339b-4603-b883-e9af678a5812', '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': 'f5290f47da1248319efad21b70966512'}} 2026-11-02 04:49:53,595 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ff8a7d7c-cd80-4cce-a60f-c02f0ea5f63c', 'name': '', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'network_id': '2aac5059-339b-4603-b883-e9af678a5812', 'ip_version': 4, 'cidr': '145.124.5.192/26', 'allocation_pools': [{'start': '145.124.5.194', 'end': '145.124.5.254'}], 'gateway_ip': '145.124.5.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '145.124.5.194', 'tags': [], 'project_id': 'f5290f47da1248319efad21b70966512'}} 2026-11-02 04:49:53,618 - INFO - Created VN test_vnv6sr 2026-11-02 04:49:53,634 - DEBUG - VN test_vnv6sr UUID is 2aac5059-339b-4603-b883-e9af678a5812 2026-11-02 04:49:54,026 - DEBUG - Response for create_network : {'network': {'id': 'f5e41771-5c46-450b-b1c0-0e9038c83705', 'name': 'test_vnv6dn', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'project_id': 'f5290f47da1248319efad21b70966512', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-02715667', 'test_vnv6dn'], 'port_security_enabled': True, 'description': ''}} 2026-11-02 04:49:54,257 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b3c151d7-f9c3-415b-9b70-db09ce3b93c9', 'name': '', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'network_id': 'f5e41771-5c46-450b-b1c0-0e9038c83705', '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': 'f5290f47da1248319efad21b70966512'}} 2026-11-02 04:49:54,473 - DEBUG - Response for create_subnet : {'subnet': {'id': 'fbe9e045-da17-4dee-8592-72c1fafeb3d0', 'name': '', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'network_id': 'f5e41771-5c46-450b-b1c0-0e9038c83705', 'ip_version': 4, 'cidr': '36.120.11.0/26', 'allocation_pools': [{'start': '36.120.11.2', 'end': '36.120.11.62'}], 'gateway_ip': '36.120.11.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '36.120.11.2', 'tags': [], 'project_id': 'f5290f47da1248319efad21b70966512'}} 2026-11-02 04:49:54,498 - INFO - Created VN test_vnv6dn 2026-11-02 04:49:54,513 - DEBUG - VN test_vnv6dn UUID is f5e41771-5c46-450b-b1c0-0e9038c83705 2026-11-02 04:49:55,119 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6461-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6461-1) 2026-11-02 04:49:55,574 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6461-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6461-2) 2026-11-02 04:49:55,574 - INFO - Waiting for VM source_vm to be up.. 2026-11-02 04:49:55,623 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-11-02 04:50:00,717 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-11-02 04:50:05,819 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-11-02 04:50:10,908 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-11-02 04:50:15,992 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-11-02 04:50:21,091 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-11-02 04:50:26,174 - DEBUG - VM is in ACTIVE state now 2026-11-02 04:50:26,174 - INFO - VM name : source_vm 2026-11-02 04:50:26,253 - DEBUG - VM source_vm ID is a2927ec0-b6b1-43a1-868b-dc33ab047cab 2026-11-02 04:50:26,253 - DEBUG - VM source_vm launched on Node an-jenkins-deploy-platform-ansible-os-6461-1 2026-11-02 04:50:26,334 - DEBUG - Requesting: http://10.0.0.191:8082/virtual-machine/a2927ec0-b6b1-43a1-868b-dc33ab047cab 2026-11-02 04:50:26,346 - DEBUG - Requesting: http://10.0.0.191:8082/virtual-machine-interface/2ef4be9e-9def-48bd-a2f6-b226b3a10529 2026-11-02 04:50:29,532 - 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=2 ttl=63 time=4.61 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1017ms\r\nrtt min/avg/max/mdev = 4.610/4.610/4.610/0.000 ms') 2026-11-02 04:50:29,533 - INFO - Ping to Metadata IP 169.254.0.3 of VM source_vm passed 2026-11-02 04:50:29,602 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-11-02 04:50:29,602 - DEBUG - Waiting to SSH to VM source_vm, IP 145.124.5.195, Port 22 2026-11-02 04:50:29,668 - 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-11-02 04:50:29,762 - DEBUG - VM source_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-11-02 04:50:34,762 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-11-02 04:50:34,762 - DEBUG - Waiting to SSH to VM source_vm, IP 145.124.5.195, Port 22 2026-11-02 04:50:34,936 - DEBUG - VM source_vm is ready for SSH connections 2026-11-02 04:50:34,936 - INFO - Waiting for VM dest_vm to be up.. 2026-11-02 04:50:35,027 - DEBUG - VM is in ACTIVE state now 2026-11-02 04:50:35,027 - INFO - VM name : dest_vm 2026-11-02 04:50:35,126 - DEBUG - VM dest_vm ID is df6360c2-2b8d-4006-ae9c-4067ea323b0a 2026-11-02 04:50:35,126 - DEBUG - VM dest_vm launched on Node an-jenkins-deploy-platform-ansible-os-6461-2 2026-11-02 04:50:35,227 - DEBUG - Requesting: http://10.0.0.191:8082/virtual-machine/df6360c2-2b8d-4006-ae9c-4067ea323b0a 2026-11-02 04:50:35,237 - DEBUG - Requesting: http://10.0.0.191:8082/virtual-machine-interface/91fa4dc0-49d6-4889-bd23-d92e6d980e10 2026-11-02 04:50:36,415 - 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.53 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.523 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.523/2.525/4.527/2.002 ms') 2026-11-02 04:50:36,415 - INFO - Ping to Metadata IP 169.254.0.3 of VM dest_vm passed 2026-11-02 04:50:36,491 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-11-02 04:50:36,491 - DEBUG - Waiting to SSH to VM dest_vm, IP 36.120.11.3, Port 22 2026-11-02 04:50:36,657 - DEBUG - VM dest_vm is ready for SSH connections 2026-11-02 04:50:36,664 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-02715667: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-02715667: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-11-02 04:50:37,004 - INFO - Attaching policy allow_all to vn test_vnv6sr 2026-11-02 04:50:37,385 - INFO - Attaching policy allow_all to vn test_vnv6dn 2026-11-02 04:50:37,648 - INFO - Configure the policy with allow any 2026-11-02 04:50:37,992 - DEBUG - Response for create_network : {'network': {'id': '04b22839-a0e2-408c-8105-640f22a08ca1', 'name': 'vn1', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'project_id': 'f5290f47da1248319efad21b70966512', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-02715667', 'vn1'], 'port_security_enabled': True, 'description': ''}} 2026-11-02 04:50:38,253 - DEBUG - Response for create_subnet : {'subnet': {'id': '68cdc2be-0ac7-41d2-83fa-862cd93c43ce', 'name': '', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'network_id': '04b22839-a0e2-408c-8105-640f22a08ca1', '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': 'f5290f47da1248319efad21b70966512'}} 2026-11-02 04:50:38,275 - INFO - Created VN vn1 2026-11-02 04:50:38,292 - DEBUG - VN vn1 UUID is 04b22839-a0e2-408c-8105-640f22a08ca1 2026-11-02 04:50:38,693 - DEBUG - Response for create_network : {'network': {'id': 'bc2a45da-8b08-4e5b-b319-d35935550742', 'name': 'vn2', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'project_id': 'f5290f47da1248319efad21b70966512', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-02715667', 'vn2'], 'port_security_enabled': True, 'description': ''}} 2026-11-02 04:50:38,955 - DEBUG - Response for create_subnet : {'subnet': {'id': '2f0f9eb2-0bf4-4d45-998c-71518350364f', 'name': '', 'tenant_id': 'f5290f47da1248319efad21b70966512', 'network_id': 'bc2a45da-8b08-4e5b-b319-d35935550742', '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': 'f5290f47da1248319efad21b70966512'}} 2026-11-02 04:50:38,982 - INFO - Created VN vn2 2026-11-02 04:50:38,995 - DEBUG - VN vn2 UUID is bc2a45da-8b08-4e5b-b319-d35935550742 2026-11-02 04:50:39,086 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-02715667: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-02715667: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-11-02 04:50:39,464 - INFO - Attaching policy sec_grp_policy_ctest-random-33576906 to vn vn1 2026-11-02 04:50:39,824 - INFO - Attaching policy sec_grp_policy_ctest-random-33576906 to vn vn2 2026-11-02 04:50:40,801 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6461-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6461-1) 2026-11-02 04:50:41,479 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6461-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6461-2) 2026-11-02 04:50:41,551 - INFO - ================================================================================ 2026-11-02 04:50:41,551 - INFO - STARTING TEST : test_create_md5_on_control 2026-11-02 04:50:41,551 - INFO - TEST DESCRIPTION : Description: Verify md5 with allow specific protocol on all ports and policy with allow all between VN's 2026-11-02 04:50:42,879 - DEBUG - Skipping xmpp flap check 2026-11-02 04:50:42,879 - INFO - Initial checks done. Running the testcase now 2026-11-02 04:50:42,879 - INFO - 2026-11-02 04:50:42,879 - INFO - config md5 on each host with auth_data None 2026-11-02 04:50:42,879 - INFO - config per peer with auth_data None 2026-11-02 04:50:43,537 - INFO - configure MD5 on host ecb3e092-137c-4914-be20-af0b0ced2df4 2026-11-02 04:50:43,645 - INFO - config per peer with auth_data None 2026-11-02 04:50:44,345 - INFO - configure MD5 on host b711b199-7963-4da0-b76f-e1c20469f1c5 2026-11-02 04:50:44,449 - INFO - config per peer with auth_data None 2026-11-02 04:50:45,057 - INFO - configure MD5 on host ec30c03f-5f86-4972-8058-edddc5fae77b 2026-11-02 04:50:45,197 - INFO - check if BGP between peers are up before setting md5 2026-11-02 04:50:45,197 - INFO - Check BGP staus between peers 2026-11-02 04:50:45,219 - INFO - setting MD5 config on host ecb3e092-137c-4914-be20-af0b0ced2df4 2026-11-02 04:50:45,219 - INFO - configure MD5 on host ecb3e092-137c-4914-be20-af0b0ced2df4 2026-11-02 04:50:45,329 - INFO - setting MD5 config on host b711b199-7963-4da0-b76f-e1c20469f1c5 2026-11-02 04:50:45,329 - INFO - configure MD5 on host b711b199-7963-4da0-b76f-e1c20469f1c5 2026-11-02 04:50:45,457 - INFO - setting MD5 config on host ec30c03f-5f86-4972-8058-edddc5fae77b 2026-11-02 04:50:45,457 - INFO - configure MD5 on host ec30c03f-5f86-4972-8058-edddc5fae77b 2026-11-02 04:50:45,617 - INFO - check if BGP peering is up after md5 config 2026-11-02 04:50:45,617 - INFO - Check BGP staus between peers 2026-11-02 04:50:45,631 - DEBUG - Check the BGP connection on 10.0.0.50 2026-11-02 04:50:45,632 - DEBUG - Check the BGP connection on 10.0.0.50 2026-11-02 04:50:55,633 - INFO - Check BGP staus between peers 2026-11-02 04:50:55,645 - INFO - remove md5 configured on host ecb3e092-137c-4914-be20-af0b0ced2df4 2026-11-02 04:50:55,645 - INFO - config per peer with auth_data None 2026-11-02 04:50:56,185 - INFO - configure MD5 on host ecb3e092-137c-4914-be20-af0b0ced2df4 2026-11-02 04:50:56,265 - INFO - remove md5 configured on host b711b199-7963-4da0-b76f-e1c20469f1c5 2026-11-02 04:50:56,265 - INFO - config per peer with auth_data None 2026-11-02 04:50:56,845 - INFO - configure MD5 on host b711b199-7963-4da0-b76f-e1c20469f1c5 2026-11-02 04:50:56,937 - INFO - remove md5 configured on host ec30c03f-5f86-4972-8058-edddc5fae77b 2026-11-02 04:50:56,937 - INFO - config per peer with auth_data None 2026-11-02 04:50:57,521 - INFO - configure MD5 on host ec30c03f-5f86-4972-8058-edddc5fae77b 2026-11-02 04:50:57,613 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD 2026-11-02 04:50:57,613 - INFO - Deleting VM vn2_vm_0 2026-11-02 04:50:57,613 - ERROR - VM vn2_vm_0 has failed to come up 2026-11-02 04:50:57,613 - ERROR - Nova failed to get host of the VM 2026-11-02 04:50:57,613 - ERROR - VM vn2_vm_0 has failed to come up 2026-11-02 04:50:57,613 - ERROR - Nova failed to get host of the VM 2026-11-02 04:50:57,690 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD 2026-11-02 04:50:57,690 - INFO - Deleting VM vn1_vm_0 2026-11-02 04:50:57,690 - ERROR - VM vn1_vm_0 has failed to come up 2026-11-02 04:50:57,690 - ERROR - Nova failed to get host of the VM 2026-11-02 04:50:57,690 - ERROR - VM vn1_vm_0 has failed to come up 2026-11-02 04:50:57,690 - ERROR - Nova failed to get host of the VM 2026-11-02 04:50:57,765 - INFO - Dettaching policy sec_grp_policy_ctest-random-33576906 from vn vn2 2026-11-02 04:50:57,924 - INFO - Dettaching policy sec_grp_policy_ctest-random-33576906 from vn vn1 2026-11-02 04:50:58,174 - INFO - Deleted policy sec_grp_policy_ctest-random-33576906 2026-11-02 04:50:58,174 - INFO - Deleting VN vn2 2026-11-02 04:50:58,216 - DEBUG - VN bc2a45da-8b08-4e5b-b319-d35935550742 still in use: Unable to complete operation on network bc2a45da-8b08-4e5b-b319-d35935550742. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-3f675cfb-4a89-431d-b6dc-4a5f2be7f0a5'] 2026-11-02 04:50:58,216 - WARNING - Deleting VN vn2 failed..Will retry 2026-11-02 04:51:00,261 - DEBUG - VN bc2a45da-8b08-4e5b-b319-d35935550742 still in use: Unable to complete operation on network bc2a45da-8b08-4e5b-b319-d35935550742. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-45bfafbe-60a6-49a6-873f-5ad2b30a32c8'] 2026-11-02 04:51:00,261 - WARNING - Deleting VN vn2 failed..Will retry 2026-11-02 04:51:02,299 - DEBUG - VN bc2a45da-8b08-4e5b-b319-d35935550742 still in use: Unable to complete operation on network bc2a45da-8b08-4e5b-b319-d35935550742. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-2b7be3a7-f21b-496c-a612-8f47c7230302'] 2026-11-02 04:51:02,300 - WARNING - Deleting VN vn2 failed..Will retry 2026-11-02 04:51:04,341 - DEBUG - VN bc2a45da-8b08-4e5b-b319-d35935550742 still in use: Unable to complete operation on network bc2a45da-8b08-4e5b-b319-d35935550742. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-673273aa-2fd1-4817-8f78-ac35dfa2d08a'] 2026-11-02 04:51:04,341 - WARNING - Deleting VN vn2 failed..Will retry 2026-11-02 04:51:06,380 - DEBUG - VN bc2a45da-8b08-4e5b-b319-d35935550742 still in use: Unable to complete operation on network bc2a45da-8b08-4e5b-b319-d35935550742. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-07042e5b-877c-4ccd-b13b-6260c5bd881c'] 2026-11-02 04:51:06,380 - WARNING - Deleting VN vn2 failed..Will retry 2026-11-02 04:51:08,441 - DEBUG - VN bc2a45da-8b08-4e5b-b319-d35935550742 still in use: Unable to complete operation on network bc2a45da-8b08-4e5b-b319-d35935550742. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-e2c58f15-93a2-4210-b1cc-5ab9ce25e1e2'] 2026-11-02 04:51:08,441 - WARNING - Deleting VN vn2 failed..Will retry 2026-11-02 04:51:10,583 - DEBUG - Response for deleting network () 2026-11-02 04:51:10,583 - INFO - Deleting VN vn1 2026-11-02 04:51:10,754 - DEBUG - Response for deleting network () 2026-11-02 04:51:10,754 - INFO - Dettaching policy allow_all from vn test_vnv6dn 2026-11-02 04:51:10,936 - INFO - Dettaching policy allow_all from vn test_vnv6sr 2026-11-02 04:51:11,230 - INFO - Deleted policy allow_all 2026-11-02 04:51:11,230 - INFO - Deleting VM dest_vm 2026-11-02 04:51:11,322 - INFO - Deleting VM source_vm 2026-11-02 04:51:11,396 - INFO - Deleting VN test_vnv6dn 2026-11-02 04:51:11,442 - DEBUG - VN f5e41771-5c46-450b-b1c0-0e9038c83705 still in use: Unable to complete operation on network f5e41771-5c46-450b-b1c0-0e9038c83705. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-8e6c9355-1a00-44d0-87a8-136a534fa050'] 2026-11-02 04:51:11,442 - WARNING - Deleting VN test_vnv6dn failed..Will retry 2026-11-02 04:51:13,491 - DEBUG - VN f5e41771-5c46-450b-b1c0-0e9038c83705 still in use: Unable to complete operation on network f5e41771-5c46-450b-b1c0-0e9038c83705. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-c0c85ea3-e892-4371-8813-221169163eb5'] 2026-11-02 04:51:13,491 - WARNING - Deleting VN test_vnv6dn failed..Will retry 2026-11-02 04:51:15,709 - DEBUG - Response for deleting network () 2026-11-02 04:51:15,709 - INFO - Deleting VN test_vnv6sr 2026-11-02 04:51:15,888 - DEBUG - Response for deleting network () 2026-11-02 04:51:17,169 - DEBUG - Skipping xmpp flap check
2026-11-02 04:51:17,170 - INFO - END TEST : test_create_md5_on_control : PASSED[0:00:36]
2026-11-02 04:51:17,170 - INFO - -------------------------------------------------------------------------------- 2026-11-02 04:51:17,988 - INFO - Deleted project: ctest-TestMd5testsOnControl-02715667, ID : f5290f47-da12-4831-9efa-d21b70966512