2026-07-06 17:00:40,222 - INFO - Domain Default found not creating
2026-07-06 17:00:40,362 - INFO - Project ctest-TestMd5testsOnControl-45845655 not found, creating it
2026-07-06 17:00:40,845 - INFO - Created Project:ctest-TestMd5testsOnControl-45845655, ID : 96b4d95f-1392-4103-b1dd-398280967fbe
2026-07-06 17:00:43,021 - DEBUG - Response for create_network : {'network': {'id': 'c27baa64-c0da-4717-a801-f767b1b2b54d', 'name': 'test_vnv6sr', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'project_id': '96b4d95f13924103b1dd398280967fbe', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-45845655', 'test_vnv6sr'], 'port_security_enabled': True, 'description': ''}}
2026-07-06 17:00:43,237 - DEBUG - Response for create_subnet : {'subnet': {'id': '128ce6d6-d7f0-47bf-aa25-8dfd3adb001e', 'name': '', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'network_id': 'c27baa64-c0da-4717-a801-f767b1b2b54d', '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': '96b4d95f13924103b1dd398280967fbe'}}
2026-07-06 17:00:43,494 - DEBUG - Response for create_subnet : {'subnet': {'id': '7e5cf310-1baf-4ce2-a66f-57882b184742', 'name': '', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'network_id': 'c27baa64-c0da-4717-a801-f767b1b2b54d', 'ip_version': 4, 'cidr': '69.138.219.64/26', 'allocation_pools': [{'start': '69.138.219.66', 'end': '69.138.219.126'}], 'gateway_ip': '69.138.219.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '69.138.219.66', 'tags': [], 'project_id': '96b4d95f13924103b1dd398280967fbe'}}
2026-07-06 17:00:43,515 - INFO - Created VN test_vnv6sr
2026-07-06 17:00:43,527 - DEBUG - VN test_vnv6sr UUID is c27baa64-c0da-4717-a801-f767b1b2b54d
2026-07-06 17:00:43,886 - DEBUG - Response for create_network : {'network': {'id': '543dd04a-aef2-4f9c-b963-18d4fdd9263f', 'name': 'test_vnv6dn', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'project_id': '96b4d95f13924103b1dd398280967fbe', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-45845655', 'test_vnv6dn'], 'port_security_enabled': True, 'description': ''}}
2026-07-06 17:00:44,144 - DEBUG - Response for create_subnet : {'subnet': {'id': '6d644c55-d321-48ac-9405-2e9928104fde', 'name': '', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'network_id': '543dd04a-aef2-4f9c-b963-18d4fdd9263f', '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': '96b4d95f13924103b1dd398280967fbe'}}
2026-07-06 17:00:44,343 - DEBUG - Response for create_subnet : {'subnet': {'id': '317b99c0-2909-433a-8131-46c46a06cbe7', 'name': '', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'network_id': '543dd04a-aef2-4f9c-b963-18d4fdd9263f', 'ip_version': 4, 'cidr': '150.135.231.64/26', 'allocation_pools': [{'start': '150.135.231.66', 'end': '150.135.231.126'}], 'gateway_ip': '150.135.231.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '150.135.231.66', 'tags': [], 'project_id': '96b4d95f13924103b1dd398280967fbe'}}
2026-07-06 17:00:44,364 - INFO - Created VN test_vnv6dn
2026-07-06 17:00:44,377 - DEBUG - VN test_vnv6dn UUID is 543dd04a-aef2-4f9c-b963-18d4fdd9263f
2026-07-06 17:00:44,526 - DEBUG - Services list from nova: [, , , ]
2026-07-06 17:00:45,041 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6083-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6083-1)
2026-07-06 17:00:45,506 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6083-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6083-2)
2026-07-06 17:00:45,507 - INFO - Waiting for VM source_vm to be up..
2026-07-06 17:00:45,561 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-07-06 17:00:50,668 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-07-06 17:00:55,747 - DEBUG - VM is in ACTIVE state now
2026-07-06 17:00:55,747 - INFO - VM name : source_vm
2026-07-06 17:00:55,823 - DEBUG - VM source_vm ID is e4dc72a0-aeb4-4fee-9cee-07c16b363b13
2026-07-06 17:00:55,846 - DEBUG - VM source_vm launched on Node an-jenkins-deploy-platform-ansible-os-6083-1
2026-07-06 17:00:55,921 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/e4dc72a0-aeb4-4fee-9cee-07c16b363b13
2026-07-06 17:00:56,262 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/e4dc72a0-aeb4-4fee-9cee-07c16b363b13
2026-07-06 17:00:56,294 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/f15ea8ca-8ab3-4504-beef-e3d69276e6ef
2026-07-06 17:00:59,481 - 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 1019ms')
2026-07-06 17:00:59,481 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM source_vm failed!
2026-07-06 17:00:59,498 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-45845655:test_vnv6sr is 2001::101:1 and allocation pool is NOT set
2026-07-06 17:00:59,498 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-45845655:test_vnv6sr is 69.138.219.65 and allocation pool is NOT set
2026-07-06 17:01:03,578 - 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=15.5 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1013ms\r\nrtt min/avg/max/mdev = 15.471/15.471/15.471/0.000 ms')
2026-07-06 17:01:03,578 - INFO - Ping to Metadata IP 169.254.0.3 of VM source_vm passed
2026-07-06 17:01:03,648 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-07-06 17:01:03,648 - DEBUG - Waiting to SSH to VM source_vm, IP 69.138.219.67, Port 22
2026-07-06 17:01:03,822 - DEBUG - VM source_vm is ready for SSH connections
2026-07-06 17:01:03,822 - INFO - Waiting for VM dest_vm to be up..
2026-07-06 17:01:03,912 - DEBUG - VM is in ACTIVE state now
2026-07-06 17:01:03,913 - INFO - VM name : dest_vm
2026-07-06 17:01:03,987 - DEBUG - VM dest_vm ID is ca608fee-2373-4c3e-a614-599c553733fd
2026-07-06 17:01:03,987 - DEBUG - VM dest_vm launched on Node an-jenkins-deploy-platform-ansible-os-6083-2
2026-07-06 17:01:04,061 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/ca608fee-2373-4c3e-a614-599c553733fd
2026-07-06 17:01:04,072 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/10a20f1b-546c-4756-92a2-2601fa12f78f
2026-07-06 17:01:05,242 - 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.87 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.565 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.565/2.219/3.874/1.654 ms')
2026-07-06 17:01:05,242 - INFO - Ping to Metadata IP 169.254.0.3 of VM dest_vm passed
2026-07-06 17:01:05,317 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-07-06 17:01:05,317 - DEBUG - Waiting to SSH to VM dest_vm, IP 150.135.231.67, Port 22
2026-07-06 17:01:05,495 - DEBUG - VM dest_vm is ready for SSH connections
2026-07-06 17:01:05,501 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-45845655: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-45845655: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-07-06 17:01:05,839 - INFO - Attaching policy allow_all to vn test_vnv6sr
2026-07-06 17:01:06,222 - INFO - Attaching policy allow_all to vn test_vnv6dn
2026-07-06 17:01:06,534 - INFO - Configure the policy with allow any
2026-07-06 17:01:06,894 - DEBUG - Response for create_network : {'network': {'id': '9a3edc9e-edd4-4fc2-83df-6296121a19f5', 'name': 'vn1', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'project_id': '96b4d95f13924103b1dd398280967fbe', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-45845655', 'vn1'], 'port_security_enabled': True, 'description': ''}}
2026-07-06 17:01:07,171 - DEBUG - Response for create_subnet : {'subnet': {'id': '2079e663-4d3b-401c-87b0-2cfd802ff252', 'name': '', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'network_id': '9a3edc9e-edd4-4fc2-83df-6296121a19f5', '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': '96b4d95f13924103b1dd398280967fbe'}}
2026-07-06 17:01:07,192 - INFO - Created VN vn1
2026-07-06 17:01:07,210 - DEBUG - VN vn1 UUID is 9a3edc9e-edd4-4fc2-83df-6296121a19f5
2026-07-06 17:01:07,574 - DEBUG - Response for create_network : {'network': {'id': 'e854ef7f-cf9c-4820-9ca1-1e8c498838d2', 'name': 'vn2', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'project_id': '96b4d95f13924103b1dd398280967fbe', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-45845655', 'vn2'], 'port_security_enabled': True, 'description': ''}}
2026-07-06 17:01:07,789 - DEBUG - Response for create_subnet : {'subnet': {'id': '5e64dfbe-7fff-45bb-97ae-cceee776fe57', 'name': '', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'network_id': 'e854ef7f-cf9c-4820-9ca1-1e8c498838d2', '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': '96b4d95f13924103b1dd398280967fbe'}}
2026-07-06 17:01:07,826 - INFO - Created VN vn2
2026-07-06 17:01:07,838 - DEBUG - VN vn2 UUID is e854ef7f-cf9c-4820-9ca1-1e8c498838d2
2026-07-06 17:01:07,959 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-45845655: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-45845655: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-07-06 17:01:08,319 - INFO - Attaching policy sec_grp_policy_ctest-random-21030593 to vn vn1
2026-07-06 17:01:08,738 - INFO - Attaching policy sec_grp_policy_ctest-random-21030593 to vn vn2
2026-07-06 17:01:09,667 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6083-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6083-1)
2026-07-06 17:01:10,291 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6083-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6083-2)
2026-07-06 17:01:10,354 - INFO - ================================================================================
2026-07-06 17:01:10,355 - INFO - STARTING TEST : test_check_per_peer_on_control
2026-07-06 17:01:10,355 - INFO - TEST DESCRIPTION :
Description: Verify per peer md5 and specific protocol on all ports and policy with allow all between VN's
2026-07-06 17:01:11,651 - DEBUG - Skipping xmpp flap check
2026-07-06 17:01:11,651 - INFO - Initial checks done. Running the testcase now
2026-07-06 17:01:11,652 - INFO -
2026-07-06 17:01:11,652 - INFO - config per peer with auth_data None
2026-07-06 17:01:12,267 - INFO - configure MD5 on host 84bd8685-fbed-4a69-8b50-8aae91c52bc4
2026-07-06 17:01:12,351 - INFO - config per peer with auth_data None
2026-07-06 17:01:12,971 - INFO - configure MD5 on host 719fdbf6-56ec-4624-8677-d5e133f8c343
2026-07-06 17:01:13,060 - INFO - config per peer with auth_data None
2026-07-06 17:01:13,695 - INFO - configure MD5 on host 648a442f-2599-4471-8cd4-dda963671121
2026-07-06 17:01:13,775 - INFO - check BGP peering is up before setting md5 config
2026-07-06 17:01:13,775 - INFO - Check BGP staus between peers
2026-07-06 17:01:13,786 - INFO - config per peer with auth_data {'key_items': [{'key': 'juniper', 'key_id': 0}], 'key_type': 'md5'}
2026-07-06 17:01:14,463 - INFO - Check BGP staus between peers
2026-07-06 17:01:14,474 - DEBUG - Check the BGP connection on 10.0.0.50
2026-07-06 17:01:14,474 - DEBUG - Check the BGP connection on 10.0.0.50
2026-07-06 17:01:24,474 - INFO - Check BGP staus between peers
2026-07-06 17:01:24,484 - INFO - remove md5 configured on host 84bd8685-fbed-4a69-8b50-8aae91c52bc4
2026-07-06 17:01:24,484 - INFO - config per peer with auth_data None
2026-07-06 17:01:25,075 - INFO - configure MD5 on host 84bd8685-fbed-4a69-8b50-8aae91c52bc4
2026-07-06 17:01:25,171 - INFO - remove md5 configured on host 719fdbf6-56ec-4624-8677-d5e133f8c343
2026-07-06 17:01:25,171 - INFO - config per peer with auth_data None
2026-07-06 17:01:25,759 - INFO - configure MD5 on host 719fdbf6-56ec-4624-8677-d5e133f8c343
2026-07-06 17:01:25,861 - INFO - remove md5 configured on host 648a442f-2599-4471-8cd4-dda963671121
2026-07-06 17:01:25,862 - INFO - config per peer with auth_data None
2026-07-06 17:01:26,443 - INFO - configure MD5 on host 648a442f-2599-4471-8cd4-dda963671121
2026-07-06 17:01:26,519 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD
2026-07-06 17:01:26,519 - INFO - Deleting VM vn2_vm_0
2026-07-06 17:01:26,519 - ERROR - VM vn2_vm_0 has failed to come up
2026-07-06 17:01:26,519 - ERROR - Nova failed to get host of the VM
2026-07-06 17:01:26,520 - ERROR - VM vn2_vm_0 has failed to come up
2026-07-06 17:01:26,520 - ERROR - Nova failed to get host of the VM
2026-07-06 17:01:26,616 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD
2026-07-06 17:01:26,617 - INFO - Deleting VM vn1_vm_0
2026-07-06 17:01:26,617 - ERROR - VM vn1_vm_0 has failed to come up
2026-07-06 17:01:26,617 - ERROR - Nova failed to get host of the VM
2026-07-06 17:01:26,617 - ERROR - VM vn1_vm_0 has failed to come up
2026-07-06 17:01:26,617 - ERROR - Nova failed to get host of the VM
2026-07-06 17:01:26,699 - INFO - Dettaching policy sec_grp_policy_ctest-random-21030593 from vn vn2
2026-07-06 17:01:26,846 - INFO - Dettaching policy sec_grp_policy_ctest-random-21030593 from vn vn1
2026-07-06 17:01:27,102 - INFO - Deleted policy sec_grp_policy_ctest-random-21030593
2026-07-06 17:01:27,103 - INFO - Deleting VN vn2
2026-07-06 17:01:27,151 - DEBUG - VN e854ef7f-cf9c-4820-9ca1-1e8c498838d2 still in use: Unable to complete operation on network e854ef7f-cf9c-4820-9ca1-1e8c498838d2. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-a6ac04d4-415d-4a24-a745-3320996edc18']
2026-07-06 17:01:27,152 - WARNING - Deleting VN vn2 failed..Will retry
2026-07-06 17:01:29,334 - DEBUG - Response for deleting network ()
2026-07-06 17:01:29,334 - INFO - Deleting VN vn1
2026-07-06 17:01:29,477 - DEBUG - Response for deleting network ()
2026-07-06 17:01:29,477 - INFO - Dettaching policy allow_all from vn test_vnv6dn
2026-07-06 17:01:29,698 - INFO - Dettaching policy allow_all from vn test_vnv6sr
2026-07-06 17:01:29,932 - INFO - Deleted policy allow_all
2026-07-06 17:01:29,933 - INFO - Deleting VM dest_vm
2026-07-06 17:01:29,999 - INFO - Deleting VM source_vm
2026-07-06 17:01:30,073 - INFO - Deleting VN test_vnv6dn
2026-07-06 17:01:30,111 - DEBUG - VN 543dd04a-aef2-4f9c-b963-18d4fdd9263f still in use: Unable to complete operation on network 543dd04a-aef2-4f9c-b963-18d4fdd9263f. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-fccef257-f7e9-434a-a55e-048383c4e0dd']
2026-07-06 17:01:30,111 - WARNING - Deleting VN test_vnv6dn failed..Will retry
2026-07-06 17:01:32,200 - DEBUG - VN 543dd04a-aef2-4f9c-b963-18d4fdd9263f still in use: Unable to complete operation on network 543dd04a-aef2-4f9c-b963-18d4fdd9263f. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-53680868-c619-443e-8fff-ba816046b766']
2026-07-06 17:01:32,200 - WARNING - Deleting VN test_vnv6dn failed..Will retry
2026-07-06 17:01:34,404 - DEBUG - Response for deleting network ()
2026-07-06 17:01:34,404 - INFO - Deleting VN test_vnv6sr
2026-07-06 17:01:34,604 - DEBUG - Response for deleting network ()
2026-07-06 17:01:35,872 - DEBUG - Skipping xmpp flap check
2026-07-06 17:01:35,872 - INFO - END TEST : test_check_per_peer_on_control : PASSED[0:00:25]
2026-07-06 17:01:35,872 - INFO - --------------------------------------------------------------------------------
2026-07-06 17:01:36,142 - DEBUG - Response for create_network : {'network': {'id': '6fe50eb2-57d2-4655-8a6f-e3a9dcf649b6', 'name': 'test_vnv6sr', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'project_id': '96b4d95f13924103b1dd398280967fbe', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-45845655', 'test_vnv6sr'], 'port_security_enabled': True, 'description': ''}}
2026-07-06 17:01:36,363 - DEBUG - Response for create_subnet : {'subnet': {'id': '31a635b7-a0f9-4ce9-9806-f52f48340d13', 'name': '', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'network_id': '6fe50eb2-57d2-4655-8a6f-e3a9dcf649b6', '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': '96b4d95f13924103b1dd398280967fbe'}}
2026-07-06 17:01:36,556 - DEBUG - Response for create_subnet : {'subnet': {'id': '405f8313-9a4e-4111-b0e7-e1e1ac1496a2', 'name': '', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'network_id': '6fe50eb2-57d2-4655-8a6f-e3a9dcf649b6', 'ip_version': 4, 'cidr': '150.186.88.64/26', 'allocation_pools': [{'start': '150.186.88.66', 'end': '150.186.88.126'}], 'gateway_ip': '150.186.88.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '150.186.88.66', 'tags': [], 'project_id': '96b4d95f13924103b1dd398280967fbe'}}
2026-07-06 17:01:36,591 - INFO - Created VN test_vnv6sr
2026-07-06 17:01:36,605 - DEBUG - VN test_vnv6sr UUID is 6fe50eb2-57d2-4655-8a6f-e3a9dcf649b6
2026-07-06 17:01:36,976 - DEBUG - Response for create_network : {'network': {'id': '4ef96c40-21b5-4b5c-b72a-2e5bf6b8f4da', 'name': 'test_vnv6dn', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'project_id': '96b4d95f13924103b1dd398280967fbe', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-45845655', 'test_vnv6dn'], 'port_security_enabled': True, 'description': ''}}
2026-07-06 17:01:37,232 - DEBUG - Response for create_subnet : {'subnet': {'id': '1890c2c1-7084-4728-acf5-dec753e84f06', 'name': '', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'network_id': '4ef96c40-21b5-4b5c-b72a-2e5bf6b8f4da', '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': '96b4d95f13924103b1dd398280967fbe'}}
2026-07-06 17:01:37,461 - DEBUG - Response for create_subnet : {'subnet': {'id': '79e32866-dada-4faf-806b-bf08836513a2', 'name': '', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'network_id': '4ef96c40-21b5-4b5c-b72a-2e5bf6b8f4da', 'ip_version': 4, 'cidr': '149.70.102.64/26', 'allocation_pools': [{'start': '149.70.102.66', 'end': '149.70.102.126'}], 'gateway_ip': '149.70.102.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '149.70.102.66', 'tags': [], 'project_id': '96b4d95f13924103b1dd398280967fbe'}}
2026-07-06 17:01:37,485 - INFO - Created VN test_vnv6dn
2026-07-06 17:01:37,496 - DEBUG - VN test_vnv6dn UUID is 4ef96c40-21b5-4b5c-b72a-2e5bf6b8f4da
2026-07-06 17:01:38,003 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6083-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6083-1)
2026-07-06 17:01:38,487 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6083-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6083-2)
2026-07-06 17:01:38,487 - INFO - Waiting for VM source_vm to be up..
2026-07-06 17:01:38,525 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-07-06 17:01:43,604 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-07-06 17:01:48,703 - DEBUG - VM is in ACTIVE state now
2026-07-06 17:01:48,703 - INFO - VM name : source_vm
2026-07-06 17:01:48,810 - DEBUG - VM source_vm ID is fcc95d89-7f3d-41c8-b4a7-5708cd25459f
2026-07-06 17:01:48,810 - DEBUG - VM source_vm launched on Node an-jenkins-deploy-platform-ansible-os-6083-1
2026-07-06 17:01:48,920 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/fcc95d89-7f3d-41c8-b4a7-5708cd25459f
2026-07-06 17:01:48,932 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/951ac4d9-c01b-476e-bf14-8c3554330fcf
2026-07-06 17:01:52,114 - 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 1013ms')
2026-07-06 17:01:52,114 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM source_vm failed!
2026-07-06 17:01:52,129 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-45845655:test_vnv6sr is 2001::101:1 and allocation pool is NOT set
2026-07-06 17:01:52,129 - DEBUG - Gateway for vn default-domain:ctest-TestMd5testsOnControl-45845655:test_vnv6sr is 150.186.88.65 and allocation pool is NOT set
2026-07-06 17:01:56,212 - 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=13.2 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1019ms\r\nrtt min/avg/max/mdev = 13.220/13.220/13.220/0.000 ms')
2026-07-06 17:01:56,212 - INFO - Ping to Metadata IP 169.254.0.3 of VM source_vm passed
2026-07-06 17:01:56,288 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-07-06 17:01:56,288 - DEBUG - Waiting to SSH to VM source_vm, IP 150.186.88.67, Port 22
2026-07-06 17:01:56,458 - DEBUG - VM source_vm is ready for SSH connections
2026-07-06 17:01:56,459 - INFO - Waiting for VM dest_vm to be up..
2026-07-06 17:01:56,537 - DEBUG - VM is in ACTIVE state now
2026-07-06 17:01:56,537 - INFO - VM name : dest_vm
2026-07-06 17:01:56,619 - DEBUG - VM dest_vm ID is 86afdbf5-554c-4b34-ac2f-a30906447b47
2026-07-06 17:01:56,621 - DEBUG - VM dest_vm launched on Node an-jenkins-deploy-platform-ansible-os-6083-2
2026-07-06 17:01:56,709 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/86afdbf5-554c-4b34-ac2f-a30906447b47
2026-07-06 17:01:56,720 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/e3f66d94-6069-40fb-82bb-0a875d16b22c
2026-07-06 17:01:57,885 - 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.31 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.404 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.404/1.854/3.305/1.450 ms')
2026-07-06 17:01:57,886 - INFO - Ping to Metadata IP 169.254.0.3 of VM dest_vm passed
2026-07-06 17:01:57,960 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-07-06 17:01:57,960 - DEBUG - Waiting to SSH to VM dest_vm, IP 149.70.102.67, Port 22
2026-07-06 17:01:58,120 - DEBUG - VM dest_vm is ready for SSH connections
2026-07-06 17:01:58,126 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-45845655: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-45845655: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-07-06 17:01:58,458 - INFO - Attaching policy allow_all to vn test_vnv6sr
2026-07-06 17:01:58,826 - INFO - Attaching policy allow_all to vn test_vnv6dn
2026-07-06 17:01:59,083 - INFO - Configure the policy with allow any
2026-07-06 17:01:59,439 - DEBUG - Response for create_network : {'network': {'id': 'f95eba2f-ff8e-40f0-a75c-cd95715226ba', 'name': 'vn1', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'project_id': '96b4d95f13924103b1dd398280967fbe', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-45845655', 'vn1'], 'port_security_enabled': True, 'description': ''}}
2026-07-06 17:01:59,650 - DEBUG - Response for create_subnet : {'subnet': {'id': '77f684b1-3441-4f09-930a-d46956b7dff1', 'name': '', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'network_id': 'f95eba2f-ff8e-40f0-a75c-cd95715226ba', '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': '96b4d95f13924103b1dd398280967fbe'}}
2026-07-06 17:01:59,669 - INFO - Created VN vn1
2026-07-06 17:01:59,680 - DEBUG - VN vn1 UUID is f95eba2f-ff8e-40f0-a75c-cd95715226ba
2026-07-06 17:02:00,055 - DEBUG - Response for create_network : {'network': {'id': 'ebe0cae6-75be-49f8-8f7f-c14471969268', 'name': 'vn2', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'project_id': '96b4d95f13924103b1dd398280967fbe', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestMd5testsOnControl-45845655', 'vn2'], 'port_security_enabled': True, 'description': ''}}
2026-07-06 17:02:00,355 - DEBUG - Response for create_subnet : {'subnet': {'id': '34d3a250-b6dd-4e7e-bfd2-d9f33f5852ff', 'name': '', 'tenant_id': '96b4d95f13924103b1dd398280967fbe', 'network_id': 'ebe0cae6-75be-49f8-8f7f-c14471969268', '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': '96b4d95f13924103b1dd398280967fbe'}}
2026-07-06 17:02:00,375 - INFO - Created VN vn2
2026-07-06 17:02:00,387 - DEBUG - VN vn2 UUID is ebe0cae6-75be-49f8-8f7f-c14471969268
2026-07-06 17:02:00,503 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestMd5testsOnControl-45845655: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-45845655: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-07-06 17:02:00,838 - INFO - Attaching policy sec_grp_policy_ctest-random-41374844 to vn vn1
2026-07-06 17:02:01,196 - INFO - Attaching policy sec_grp_policy_ctest-random-41374844 to vn vn2
2026-07-06 17:02:02,163 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6083-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6083-1)
2026-07-06 17:02:02,735 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-6083-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-6083-2)
2026-07-06 17:02:02,798 - INFO - ================================================================================
2026-07-06 17:02:02,799 - INFO - STARTING TEST : test_create_md5_on_control
2026-07-06 17:02:02,799 - INFO - TEST DESCRIPTION :
Description: Verify md5 with allow specific protocol on all ports and policy with allow all between VN's
2026-07-06 17:02:04,068 - DEBUG - Skipping xmpp flap check
2026-07-06 17:02:04,068 - INFO - Initial checks done. Running the testcase now
2026-07-06 17:02:04,068 - INFO -
2026-07-06 17:02:04,068 - INFO - config md5 on each host with auth_data None
2026-07-06 17:02:04,068 - INFO - config per peer with auth_data None
2026-07-06 17:02:04,627 - INFO - configure MD5 on host 84bd8685-fbed-4a69-8b50-8aae91c52bc4
2026-07-06 17:02:04,727 - INFO - config per peer with auth_data None
2026-07-06 17:02:05,307 - INFO - configure MD5 on host 719fdbf6-56ec-4624-8677-d5e133f8c343
2026-07-06 17:02:05,399 - INFO - config per peer with auth_data None
2026-07-06 17:02:05,995 - INFO - configure MD5 on host 648a442f-2599-4471-8cd4-dda963671121
2026-07-06 17:02:06,075 - INFO - check if BGP between peers are up before setting md5
2026-07-06 17:02:06,075 - INFO - Check BGP staus between peers
2026-07-06 17:02:06,084 - INFO - setting MD5 config on host 84bd8685-fbed-4a69-8b50-8aae91c52bc4
2026-07-06 17:02:06,084 - INFO - configure MD5 on host 84bd8685-fbed-4a69-8b50-8aae91c52bc4
2026-07-06 17:02:06,163 - INFO - setting MD5 config on host 719fdbf6-56ec-4624-8677-d5e133f8c343
2026-07-06 17:02:06,163 - INFO - configure MD5 on host 719fdbf6-56ec-4624-8677-d5e133f8c343
2026-07-06 17:02:06,247 - INFO - setting MD5 config on host 648a442f-2599-4471-8cd4-dda963671121
2026-07-06 17:02:06,248 - INFO - configure MD5 on host 648a442f-2599-4471-8cd4-dda963671121
2026-07-06 17:02:06,327 - INFO - check if BGP peering is up after md5 config
2026-07-06 17:02:06,327 - INFO - Check BGP staus between peers
2026-07-06 17:02:06,337 - DEBUG - Check the BGP connection on 10.0.0.50
2026-07-06 17:02:06,337 - DEBUG - Check the BGP connection on 10.0.0.50
2026-07-06 17:02:16,338 - INFO - Check BGP staus between peers
2026-07-06 17:02:16,349 - INFO - remove md5 configured on host 84bd8685-fbed-4a69-8b50-8aae91c52bc4
2026-07-06 17:02:16,349 - INFO - config per peer with auth_data None
2026-07-06 17:02:17,011 - INFO - configure MD5 on host 84bd8685-fbed-4a69-8b50-8aae91c52bc4
2026-07-06 17:02:17,112 - INFO - remove md5 configured on host 719fdbf6-56ec-4624-8677-d5e133f8c343
2026-07-06 17:02:17,112 - INFO - config per peer with auth_data None
2026-07-06 17:02:17,723 - INFO - configure MD5 on host 719fdbf6-56ec-4624-8677-d5e133f8c343
2026-07-06 17:02:17,815 - INFO - remove md5 configured on host 648a442f-2599-4471-8cd4-dda963671121
2026-07-06 17:02:17,815 - INFO - config per peer with auth_data None
2026-07-06 17:02:18,451 - INFO - configure MD5 on host 648a442f-2599-4471-8cd4-dda963671121
2026-07-06 17:02:18,535 - INFO - Skip interface_detach for VM vn2_vm_0 in state BUILD
2026-07-06 17:02:18,535 - INFO - Deleting VM vn2_vm_0
2026-07-06 17:02:18,535 - ERROR - VM vn2_vm_0 has failed to come up
2026-07-06 17:02:18,535 - ERROR - Nova failed to get host of the VM
2026-07-06 17:02:18,535 - ERROR - VM vn2_vm_0 has failed to come up
2026-07-06 17:02:18,535 - ERROR - Nova failed to get host of the VM
2026-07-06 17:02:18,604 - INFO - Skip interface_detach for VM vn1_vm_0 in state BUILD
2026-07-06 17:02:18,604 - INFO - Deleting VM vn1_vm_0
2026-07-06 17:02:18,604 - ERROR - VM vn1_vm_0 has failed to come up
2026-07-06 17:02:18,604 - ERROR - Nova failed to get host of the VM
2026-07-06 17:02:18,604 - ERROR - VM vn1_vm_0 has failed to come up
2026-07-06 17:02:18,604 - ERROR - Nova failed to get host of the VM
2026-07-06 17:02:18,667 - INFO - Dettaching policy sec_grp_policy_ctest-random-41374844 from vn vn2
2026-07-06 17:02:18,829 - INFO - Dettaching policy sec_grp_policy_ctest-random-41374844 from vn vn1
2026-07-06 17:02:19,063 - INFO - Deleted policy sec_grp_policy_ctest-random-41374844
2026-07-06 17:02:19,064 - INFO - Deleting VN vn2
2026-07-06 17:02:19,104 - DEBUG - VN ebe0cae6-75be-49f8-8f7f-c14471969268 still in use: Unable to complete operation on network ebe0cae6-75be-49f8-8f7f-c14471969268. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-5212c724-5af3-4505-9cc6-1cdd86d22107']
2026-07-06 17:02:19,105 - WARNING - Deleting VN vn2 failed..Will retry
2026-07-06 17:02:21,257 - DEBUG - Response for deleting network ()
2026-07-06 17:02:21,257 - INFO - Deleting VN vn1
2026-07-06 17:02:21,433 - DEBUG - Response for deleting network ()
2026-07-06 17:02:21,433 - INFO - Dettaching policy allow_all from vn test_vnv6dn
2026-07-06 17:02:21,597 - INFO - Dettaching policy allow_all from vn test_vnv6sr
2026-07-06 17:02:21,870 - INFO - Deleted policy allow_all
2026-07-06 17:02:21,870 - INFO - Deleting VM dest_vm
2026-07-06 17:02:21,938 - INFO - Deleting VM source_vm
2026-07-06 17:02:22,007 - INFO - Deleting VN test_vnv6dn
2026-07-06 17:02:22,047 - DEBUG - VN 4ef96c40-21b5-4b5c-b72a-2e5bf6b8f4da still in use: Unable to complete operation on network 4ef96c40-21b5-4b5c-b72a-2e5bf6b8f4da. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-82c44e2a-0a7c-494f-9a99-440f05ede2d2']
2026-07-06 17:02:22,048 - WARNING - Deleting VN test_vnv6dn failed..Will retry
2026-07-06 17:02:24,133 - DEBUG - VN 4ef96c40-21b5-4b5c-b72a-2e5bf6b8f4da still in use: Unable to complete operation on network 4ef96c40-21b5-4b5c-b72a-2e5bf6b8f4da. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-a5ffd012-bb7a-4dcc-a4fb-8bf7618dedf6']
2026-07-06 17:02:24,133 - WARNING - Deleting VN test_vnv6dn failed..Will retry
2026-07-06 17:02:26,323 - DEBUG - Response for deleting network ()
2026-07-06 17:02:26,323 - INFO - Deleting VN test_vnv6sr
2026-07-06 17:02:26,490 - DEBUG - Response for deleting network ()
2026-07-06 17:02:27,768 - DEBUG - Skipping xmpp flap check
2026-07-06 17:02:27,768 - INFO - END TEST : test_create_md5_on_control : PASSED[0:00:25]
2026-07-06 17:02:27,769 - INFO - --------------------------------------------------------------------------------
2026-07-06 17:02:28,510 - INFO - Deleted project: ctest-TestMd5testsOnControl-45845655, ID : 96b4d95f-1392-4103-b1dd-398280967fbe