2024-12-23 11:39:45,609 - INFO - Domain Default found not creating 2024-12-23 11:39:45,748 - INFO - Project ctest-TestSvcRegr-61086061 not found, creating it 2024-12-23 11:39:46,239 - INFO - Created Project:ctest-TestSvcRegr-61086061, ID : c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000 2024-12-23 11:39:47,905 - INFO - ================================================================================ 2024-12-23 11:39:47,905 - INFO - STARTING TEST : test_svc_in_network_datapath 2024-12-23 11:39:48,168 - DEBUG - Nothing to compare xmpp stats {'10.0.0.44': {'10.20.0.5': '0'}} with 2024-12-23 11:39:48,168 - INFO - Initial checks done. Running the testcase now 2024-12-23 11:39:48,168 - INFO - 2024-12-23 11:39:48,841 - DEBUG - Response for create_network : {'network': {'id': '4578928d-7f70-4095-9dfa-ef4313f719ad', 'name': 'ctest-mgmt_vn-47040334', 'tenant_id': 'c6f794055ec14c9da6a23ddcc28f6000', 'project_id': 'c6f794055ec14c9da6a23ddcc28f6000', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-61086061', 'ctest-mgmt_vn-47040334'], 'port_security_enabled': True, 'description': ''}} 2024-12-23 11:39:49,086 - DEBUG - Response for create_subnet : {'subnet': {'id': '4a6a878a-f529-4306-981a-7af04abff28b', 'name': '', 'tenant_id': 'c6f794055ec14c9da6a23ddcc28f6000', 'network_id': '4578928d-7f70-4095-9dfa-ef4313f719ad', 'ip_version': 4, 'cidr': '113.174.193.128/26', 'allocation_pools': [{'start': '113.174.193.130', 'end': '113.174.193.190'}], 'gateway_ip': '113.174.193.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '113.174.193.130', 'tags': [], 'project_id': 'c6f794055ec14c9da6a23ddcc28f6000'}} 2024-12-23 11:39:49,106 - INFO - Created VN ctest-mgmt_vn-47040334 2024-12-23 11:39:49,160 - DEBUG - VN ctest-mgmt_vn-47040334 UUID is 4578928d-7f70-4095-9dfa-ef4313f719ad 2024-12-23 11:39:49,283 - DEBUG - Requesting: http://10.0.0.44:8082/domains 2024-12-23 11:39:49,633 - DEBUG - Requesting: http://10.0.0.44:8082/domains 2024-12-23 11:39:49,667 - DEBUG - Requesting: http://10.0.0.44:8082/domain/720148ca-78e2-4f54-905c-229612518405 2024-12-23 11:39:49,681 - DEBUG - Requesting: http://10.0.0.44:8082/project/c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000 2024-12-23 11:39:49,755 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-network/4578928d-7f70-4095-9dfa-ef4313f719ad 2024-12-23 11:39:49,767 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-network/4578928d-7f70-4095-9dfa-ef4313f719ad 2024-12-23 11:39:49,779 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/581b1c4d-a726-49e1-8391-cf5f68f709c3 2024-12-23 11:39:49,788 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/581b1c4d-a726-49e1-8391-cf5f68f709c3 2024-12-23 11:39:49,797 - DEBUG - Requesting: http://10.0.0.44:8082/route-target/baff45b0-2f32-4f3a-9efc-c185ac9f3c0c 2024-12-23 11:39:49,807 - DEBUG - Route Targets: ['target:64512:8000005'] 2024-12-23 11:39:49,807 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-network/4578928d-7f70-4095-9dfa-ef4313f719ad 2024-12-23 11:39:49,819 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/581b1c4d-a726-49e1-8391-cf5f68f709c3 2024-12-23 11:39:49,834 - INFO - Verified VN network id 9 for VN 4578928d-7f70-4095-9dfa-ef4313f719ad 2024-12-23 11:39:49,834 - INFO - Verifications in API Server for VN ctest-mgmt_vn-47040334 passed 2024-12-23 11:39:49,834 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-network/4578928d-7f70-4095-9dfa-ef4313f719ad 2024-12-23 11:39:49,844 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/581b1c4d-a726-49e1-8391-cf5f68f709c3 2024-12-23 11:39:49,852 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/581b1c4d-a726-49e1-8391-cf5f68f709c3 2024-12-23 11:39:49,861 - DEBUG - Requesting: http://10.0.0.44:8082/route-target/baff45b0-2f32-4f3a-9efc-c185ac9f3c0c 2024-12-23 11:39:49,876 - DEBUG - Control-node 10.0.0.44 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61086061', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5005912122248413333', 'uuid-lslong': '11383674079509158317'}, 'enable': 'true', 'created': '2024-12-23T11:39:48', 'last-modified': '2024-12-23T11:39:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.820681'} 2024-12-23 11:39:49,884 - DEBUG - Route Targets: ['target:64512:8000005'] 2024-12-23 11:39:49,884 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-47040334 passed 2024-12-23 11:39:49,884 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-47040334 in API_Server ====== 2024-12-23 11:39:49,884 - DEBUG - Requesting: http://10.0.0.44:8082/domains 2024-12-23 11:39:49,890 - DEBUG - Requesting: http://10.0.0.44:8082/domain/720148ca-78e2-4f54-905c-229612518405 2024-12-23 11:39:49,903 - DEBUG - Requesting: http://10.0.0.44:8082/project/c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000 2024-12-23 11:39:49,987 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-network/4578928d-7f70-4095-9dfa-ef4313f719ad 2024-12-23 11:39:49,998 - DEBUG - =>VN ctest-mgmt_vn-47040334 has no policy to be verified 2024-12-23 11:39:49,998 - DEBUG - Verifying the vn in opserver 2024-12-23 11:39:49,998 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334 virtual network link through opserver 10.0.0.44 2024-12-23 11:39:49,998 - DEBUG - Requesting: http://10.0.0.44:8081/analytics/uves/virtual-networks 2024-12-23 11:39:50,335 - DEBUG - Requesting: http://10.0.0.44:8081/analytics/uves/virtual-networks 2024-12-23 11:39:50,400 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334', 'href': 'http://10.0.0.44:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334?flat'} 2024-12-23 11:39:50,401 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334 is found in opserver 2024-12-23 11:39:50,416 - DEBUG - Do not have enough data to verify VN in agent 2024-12-23 11:39:50,422 - DEBUG - VRF ids for VN ctest-mgmt_vn-47040334: {} 2024-12-23 11:39:50,675 - DEBUG - Response for create_network : {'network': {'id': '79fa126e-9ec6-4bd5-8035-bb28b5640190', 'name': 'ctest-left_vn-40334188', 'tenant_id': 'c6f794055ec14c9da6a23ddcc28f6000', 'project_id': 'c6f794055ec14c9da6a23ddcc28f6000', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-61086061', 'ctest-left_vn-40334188'], 'port_security_enabled': True, 'description': ''}} 2024-12-23 11:39:50,899 - DEBUG - Response for create_subnet : {'subnet': {'id': '030dc0e3-f9c5-46cc-aba2-010992963b9e', 'name': '', 'tenant_id': 'c6f794055ec14c9da6a23ddcc28f6000', 'network_id': '79fa126e-9ec6-4bd5-8035-bb28b5640190', 'ip_version': 4, 'cidr': '44.117.165.128/26', 'allocation_pools': [{'start': '44.117.165.130', 'end': '44.117.165.190'}], 'gateway_ip': '44.117.165.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '44.117.165.130', 'tags': [], 'project_id': 'c6f794055ec14c9da6a23ddcc28f6000'}} 2024-12-23 11:39:50,919 - INFO - Created VN ctest-left_vn-40334188 2024-12-23 11:39:50,972 - DEBUG - VN ctest-left_vn-40334188 UUID is 79fa126e-9ec6-4bd5-8035-bb28b5640190 2024-12-23 11:39:51,087 - DEBUG - Requesting: http://10.0.0.44:8082/domains 2024-12-23 11:39:51,095 - DEBUG - Requesting: http://10.0.0.44:8082/domain/720148ca-78e2-4f54-905c-229612518405 2024-12-23 11:39:51,112 - DEBUG - Requesting: http://10.0.0.44:8082/project/c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000 2024-12-23 11:39:51,190 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-network/79fa126e-9ec6-4bd5-8035-bb28b5640190 2024-12-23 11:39:51,203 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-network/79fa126e-9ec6-4bd5-8035-bb28b5640190 2024-12-23 11:39:51,213 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/0de753a5-865a-4a29-ac91-e4aedbc607f9 2024-12-23 11:39:51,221 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/0de753a5-865a-4a29-ac91-e4aedbc607f9 2024-12-23 11:39:51,228 - DEBUG - Requesting: http://10.0.0.44:8082/route-target/0ddc24cc-16c4-4141-aa17-50586f66dc25 2024-12-23 11:39:51,235 - DEBUG - Route Targets: ['target:64512:8000006'] 2024-12-23 11:39:51,235 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-network/79fa126e-9ec6-4bd5-8035-bb28b5640190 2024-12-23 11:39:51,245 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/0de753a5-865a-4a29-ac91-e4aedbc607f9 2024-12-23 11:39:51,260 - INFO - Verified VN network id 10 for VN 79fa126e-9ec6-4bd5-8035-bb28b5640190 2024-12-23 11:39:51,260 - INFO - Verifications in API Server for VN ctest-left_vn-40334188 passed 2024-12-23 11:39:51,260 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-network/79fa126e-9ec6-4bd5-8035-bb28b5640190 2024-12-23 11:39:51,270 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/0de753a5-865a-4a29-ac91-e4aedbc607f9 2024-12-23 11:39:51,277 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/0de753a5-865a-4a29-ac91-e4aedbc607f9 2024-12-23 11:39:51,284 - DEBUG - Requesting: http://10.0.0.44:8082/route-target/0ddc24cc-16c4-4141-aa17-50586f66dc25 2024-12-23 11:39:51,296 - DEBUG - Control-node 10.0.0.44 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61086061:ctest-left_vn-40334188', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61086061', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8789357889086442453', 'uuid-lslong': '9238495994136756624'}, 'enable': 'true', 'created': '2024-12-23T11:39:50', 'last-modified': '2024-12-23T11:39:50', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.442951'} 2024-12-23 11:39:51,305 - DEBUG - Route Targets: ['target:64512:8000006'] 2024-12-23 11:39:51,305 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-40334188 passed 2024-12-23 11:39:51,306 - DEBUG - ====Verifying policy data for ctest-left_vn-40334188 in API_Server ====== 2024-12-23 11:39:51,306 - DEBUG - Requesting: http://10.0.0.44:8082/domains 2024-12-23 11:39:51,311 - DEBUG - Requesting: http://10.0.0.44:8082/domain/720148ca-78e2-4f54-905c-229612518405 2024-12-23 11:39:51,324 - DEBUG - Requesting: http://10.0.0.44:8082/project/c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000 2024-12-23 11:39:51,404 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-network/79fa126e-9ec6-4bd5-8035-bb28b5640190 2024-12-23 11:39:51,416 - DEBUG - =>VN ctest-left_vn-40334188 has no policy to be verified 2024-12-23 11:39:51,416 - DEBUG - Verifying the vn in opserver 2024-12-23 11:39:51,416 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61086061:ctest-left_vn-40334188 virtual network link through opserver 10.0.0.44 2024-12-23 11:39:51,416 - DEBUG - Requesting: http://10.0.0.44:8081/analytics/uves/virtual-networks 2024-12-23 11:39:51,430 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-left_vn-40334188', 'href': 'http://10.0.0.44:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61086061:ctest-left_vn-40334188?flat'} 2024-12-23 11:39:51,430 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-61086061:ctest-left_vn-40334188 is found in opserver 2024-12-23 11:39:51,442 - DEBUG - Do not have enough data to verify VN in agent 2024-12-23 11:39:51,447 - DEBUG - VRF ids for VN ctest-left_vn-40334188: {} 2024-12-23 11:39:51,664 - DEBUG - Response for create_network : {'network': {'id': '370a454c-9e03-4a55-8cd4-48e058f3b943', 'name': 'ctest-right_vn-27151952', 'tenant_id': 'c6f794055ec14c9da6a23ddcc28f6000', 'project_id': 'c6f794055ec14c9da6a23ddcc28f6000', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-61086061', 'ctest-right_vn-27151952'], 'port_security_enabled': True, 'description': ''}} 2024-12-23 11:39:51,888 - DEBUG - Response for create_subnet : {'subnet': {'id': '616c37e1-8849-4da6-a013-0f3631c9e7c1', 'name': '', 'tenant_id': 'c6f794055ec14c9da6a23ddcc28f6000', 'network_id': '370a454c-9e03-4a55-8cd4-48e058f3b943', 'ip_version': 4, 'cidr': '56.155.113.0/26', 'allocation_pools': [{'start': '56.155.113.2', 'end': '56.155.113.62'}], 'gateway_ip': '56.155.113.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '56.155.113.2', 'tags': [], 'project_id': 'c6f794055ec14c9da6a23ddcc28f6000'}} 2024-12-23 11:39:51,911 - INFO - Created VN ctest-right_vn-27151952 2024-12-23 11:39:51,968 - DEBUG - VN ctest-right_vn-27151952 UUID is 370a454c-9e03-4a55-8cd4-48e058f3b943 2024-12-23 11:39:52,096 - DEBUG - Requesting: http://10.0.0.44:8082/domains 2024-12-23 11:39:52,104 - DEBUG - Requesting: http://10.0.0.44:8082/domain/720148ca-78e2-4f54-905c-229612518405 2024-12-23 11:39:52,122 - DEBUG - Requesting: http://10.0.0.44:8082/project/c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000 2024-12-23 11:39:52,204 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-network/370a454c-9e03-4a55-8cd4-48e058f3b943 2024-12-23 11:39:52,217 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-network/370a454c-9e03-4a55-8cd4-48e058f3b943 2024-12-23 11:39:52,228 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/dd9ea6e0-5188-41da-ac01-1d87ac7aeaef 2024-12-23 11:39:52,236 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/dd9ea6e0-5188-41da-ac01-1d87ac7aeaef 2024-12-23 11:39:52,244 - DEBUG - Requesting: http://10.0.0.44:8082/route-target/16aecceb-a9a3-4ff5-95af-3d53844d5f1e 2024-12-23 11:39:52,252 - DEBUG - Route Targets: ['target:64512:8000007'] 2024-12-23 11:39:52,252 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-network/370a454c-9e03-4a55-8cd4-48e058f3b943 2024-12-23 11:39:52,263 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/dd9ea6e0-5188-41da-ac01-1d87ac7aeaef 2024-12-23 11:39:52,278 - INFO - Verified VN network id 11 for VN 370a454c-9e03-4a55-8cd4-48e058f3b943 2024-12-23 11:39:52,278 - INFO - Verifications in API Server for VN ctest-right_vn-27151952 passed 2024-12-23 11:39:52,278 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-network/370a454c-9e03-4a55-8cd4-48e058f3b943 2024-12-23 11:39:52,289 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/dd9ea6e0-5188-41da-ac01-1d87ac7aeaef 2024-12-23 11:39:52,296 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/dd9ea6e0-5188-41da-ac01-1d87ac7aeaef 2024-12-23 11:39:52,304 - DEBUG - Requesting: http://10.0.0.44:8082/route-target/16aecceb-a9a3-4ff5-95af-3d53844d5f1e 2024-12-23 11:39:52,317 - DEBUG - Control-node 10.0.0.44 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-61086061:ctest-right_vn-27151952', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-61086061', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3966058617223989845', 'uuid-lslong': '10147815988774811971'}, 'enable': 'true', 'created': '2024-12-23T11:39:51', 'last-modified': '2024-12-23T11:39:51', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.473294'} 2024-12-23 11:39:52,325 - DEBUG - Route Targets: ['target:64512:8000007'] 2024-12-23 11:39:52,326 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-27151952 passed 2024-12-23 11:39:52,326 - DEBUG - ====Verifying policy data for ctest-right_vn-27151952 in API_Server ====== 2024-12-23 11:39:52,326 - DEBUG - Requesting: http://10.0.0.44:8082/domains 2024-12-23 11:39:52,332 - DEBUG - Requesting: http://10.0.0.44:8082/domain/720148ca-78e2-4f54-905c-229612518405 2024-12-23 11:39:52,346 - DEBUG - Requesting: http://10.0.0.44:8082/project/c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000 2024-12-23 11:39:52,425 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-network/370a454c-9e03-4a55-8cd4-48e058f3b943 2024-12-23 11:39:52,435 - DEBUG - =>VN ctest-right_vn-27151952 has no policy to be verified 2024-12-23 11:39:52,436 - DEBUG - Verifying the vn in opserver 2024-12-23 11:39:52,436 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-61086061:ctest-right_vn-27151952 virtual network link through opserver 10.0.0.44 2024-12-23 11:39:52,436 - DEBUG - Requesting: http://10.0.0.44:8081/analytics/uves/virtual-networks 2024-12-23 11:39:52,448 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-right_vn-27151952', 'href': 'http://10.0.0.44:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-61086061:ctest-right_vn-27151952?flat'} 2024-12-23 11:39:52,448 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-61086061:ctest-right_vn-27151952 is found in opserver 2024-12-23 11:39:52,460 - DEBUG - Do not have enough data to verify VN in agent 2024-12-23 11:39:52,465 - DEBUG - VRF ids for VN ctest-right_vn-27151952: {} 2024-12-23 11:39:52,527 - DEBUG - Services list from nova: [, , ] 2024-12-23 11:39:53,686 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-2490-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-2490-1) 2024-12-23 11:39:55,000 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-2490-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-2490-1) 2024-12-23 11:39:55,001 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-05983995'] 2024-12-23 11:39:55,420 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-05983995'] created succesfully 2024-12-23 11:39:55,802 - DEBUG - Image by name cirros_in_net not found 2024-12-23 11:39:55,802 - DEBUG - Installing image cirros_in_net 2024-12-23 11:39:55,802 - DEBUG - Image info {'name': 'cirros-in-net.vmdk.gz', 'webserver': '', 'location': '/images/converts/', 'username': 'cirros', 'password': 'gocubsgo', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'vcpath': '/images/vcenter/', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hw_scsi_model=virtio-scsi --property hw_disk_bus_model=virtio-scsi --property hw_disk_bus=virtio', 'name_docker': 'phusion-baseimage-enablesshd'} 2024-12-23 11:39:55,803 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/converts//cirros-in-net.vmdk.gz 2024-12-23 11:39:55,803 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/converts//cirros-in-net.vmdk.gz 2024-12-23 11:39:55,831 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/converts//cirros-in-net.vmdk.gz -O /contrail-test/images/cirros-in-net.vmdk.gz 2024-12-23 11:39:56,027 - DEBUG - Image has been downloaded to /contrail-test/images/cirros-in-net.vmdk.gz 2024-12-23 11:39:56,027 - DEBUG - Unzip image 2024-12-23 11:39:56,027 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/cirros-in-net.vmdk.gz 2024-12-23 11:39:56,202 - DEBUG - Try to create image in user context 2024-12-23 11:39:56,466 - DEBUG - Image has been created in user context 2024-12-23 11:39:56,467 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: rm -f /contrail-test/images/cirros-in-net.vmdk 2024-12-23 11:39:56,483 - DEBUG - Downloaded image has been removed 2024-12-23 11:39:56,498 - DEBUG - Uploaded image status = active 2024-12-23 11:39:57,882 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-2490-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-2490-1) 2024-12-23 11:39:57,883 - INFO - Waiting for VM ctest-pt_svm0-42021457 to be up.. 2024-12-23 11:39:57,947 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2024-12-23 11:40:03,045 - DEBUG - VM is in ACTIVE state now 2024-12-23 11:40:03,045 - INFO - VM name : ctest-pt_svm0-42021457 2024-12-23 11:40:03,136 - DEBUG - VM ctest-pt_svm0-42021457 ID is 423e71db-f90d-4f64-b67d-96c00ca2d1ba 2024-12-23 11:40:03,159 - DEBUG - VM ctest-pt_svm0-42021457 launched on Node cn-jenkins-deploy-platform-ansible-os-2490-1 2024-12-23 11:40:03,467 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine/423e71db-f90d-4f64-b67d-96c00ca2d1ba 2024-12-23 11:40:03,479 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine-interface/0ebab95e-b9d4-46cb-a229-4141ed8815cf 2024-12-23 11:40:03,493 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine-interface/2a4512d3-d75c-4baf-9806-38d263aadba8 2024-12-23 11:40:03,505 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine-interface/e7be322b-a5ad-4a7f-aeb0-ba16f9025ed2 2024-12-23 11:40:06,808 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1005ms') 2024-12-23 11:40:06,808 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-42021457 failed! 2024-12-23 11:40:06,864 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334 is 113.174.193.129 and allocation pool is NOT set 2024-12-23 11:40:10,935 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms') 2024-12-23 11:40:10,935 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-42021457 failed! 2024-12-23 11:40:10,992 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334 is 113.174.193.129 and allocation pool is NOT set 2024-12-23 11:40:15,059 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1006ms') 2024-12-23 11:40:15,059 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-42021457 failed! 2024-12-23 11:40:15,116 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334 is 113.174.193.129 and allocation pool is NOT set 2024-12-23 11:40:19,186 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2024-12-23 11:40:19,186 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-42021457 failed! 2024-12-23 11:40:19,245 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334 is 113.174.193.129 and allocation pool is NOT set 2024-12-23 11:40:23,321 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=7.18 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1014ms\r\nrtt min/avg/max/mdev = 7.184/7.184/7.184/0.000 ms') 2024-12-23 11:40:23,321 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-42021457 passed 2024-12-23 11:40:23,481 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:23,481 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-42021457, IP 113.174.193.131, Port 22 2024-12-23 11:40:23,546 - DEBUG - Error on ssh to cirros@169.254.0.5:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.5/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.5/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.5/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2024-12-23 11:40:23,648 - DEBUG - VM ctest-pt_svm0-42021457 is NOT ready for SSH connections, VM status: ACTIVE 2024-12-23 11:40:28,649 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:28,650 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-42021457, IP 113.174.193.131, Port 22 2024-12-23 11:40:28,719 - DEBUG - Error on ssh to cirros@169.254.0.5:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.5/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.5/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.5/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2024-12-23 11:40:28,815 - DEBUG - VM ctest-pt_svm0-42021457 is NOT ready for SSH connections, VM status: ACTIVE 2024-12-23 11:40:33,815 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:33,815 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-42021457, IP 113.174.193.131, Port 22 2024-12-23 11:40:33,883 - DEBUG - Error on ssh to cirros@169.254.0.5:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.5/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.5/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.5/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2024-12-23 11:40:33,991 - DEBUG - VM ctest-pt_svm0-42021457 is NOT ready for SSH connections, VM status: ACTIVE 2024-12-23 11:40:38,992 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:38,993 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-42021457, IP 113.174.193.131, Port 22 2024-12-23 11:40:39,059 - DEBUG - Error on ssh to cirros@169.254.0.5:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.5/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.5/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.5/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2024-12-23 11:40:39,156 - DEBUG - VM ctest-pt_svm0-42021457 is NOT ready for SSH connections, VM status: ACTIVE 2024-12-23 11:40:44,157 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:44,157 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-42021457, IP 113.174.193.131, Port 22 2024-12-23 11:40:44,331 - DEBUG - VM ctest-pt_svm0-42021457 is ready for SSH connections 2024-12-23 11:40:44,489 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:44,489 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-42021457, IP 113.174.193.131, Port 22 2024-12-23 11:40:44,648 - DEBUG - VM ctest-pt_svm0-42021457 is ready for SSH connections 2024-12-23 11:40:44,808 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:44,809 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-42021457, IP 113.174.193.131, Port 22 2024-12-23 11:40:44,979 - DEBUG - VM ctest-pt_svm0-42021457 is ready for SSH connections 2024-12-23 11:40:44,989 - DEBUG - Creating service instance: ['default-domain', 'ctest-TestSvcRegr-61086061', 'ctest-si-30102312'] 2024-12-23 11:40:45,932 - INFO - Waiting for VM ctest-left_vm-19959000 to be up.. 2024-12-23 11:40:46,029 - DEBUG - VM is in ACTIVE state now 2024-12-23 11:40:46,030 - INFO - VM name : ctest-left_vm-19959000 2024-12-23 11:40:46,128 - DEBUG - VM ctest-left_vm-19959000 ID is 948e3877-f064-49bf-8e5a-6cffa4d913f8 2024-12-23 11:40:46,128 - DEBUG - VM ctest-left_vm-19959000 launched on Node cn-jenkins-deploy-platform-ansible-os-2490-1 2024-12-23 11:40:46,219 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine/948e3877-f064-49bf-8e5a-6cffa4d913f8 2024-12-23 11:40:46,231 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine-interface/3cb99aef-2656-4474-9cfe-d7bdd174fb74 2024-12-23 11:40:47,496 - 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.94 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.437 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.437/2.187/3.937/1.750 ms') 2024-12-23 11:40:47,496 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-left_vm-19959000 passed 2024-12-23 11:40:47,653 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:47,653 - DEBUG - Waiting to SSH to VM ctest-left_vm-19959000, IP 44.117.165.131, Port 22 2024-12-23 11:40:47,808 - DEBUG - VM ctest-left_vm-19959000 is ready for SSH connections 2024-12-23 11:40:47,808 - INFO - Waiting for VM ctest-right_vm-64348310 to be up.. 2024-12-23 11:40:47,896 - DEBUG - VM is in ACTIVE state now 2024-12-23 11:40:47,896 - INFO - VM name : ctest-right_vm-64348310 2024-12-23 11:40:47,988 - DEBUG - VM ctest-right_vm-64348310 ID is d8fc5699-2aae-43d7-9fc0-04e5c813d38e 2024-12-23 11:40:47,988 - DEBUG - VM ctest-right_vm-64348310 launched on Node cn-jenkins-deploy-platform-ansible-os-2490-1 2024-12-23 11:40:48,083 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine/d8fc5699-2aae-43d7-9fc0-04e5c813d38e 2024-12-23 11:40:48,097 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine-interface/1af619ae-6733-404c-8f7a-264250acb4df 2024-12-23 11:40:49,360 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n64 bytes from 169.254.0.4: icmp_seq=1 ttl=63 time=3.90 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.508 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.508/2.203/3.898/1.695 ms') 2024-12-23 11:40:49,360 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-right_vm-64348310 passed 2024-12-23 11:40:49,517 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:49,517 - DEBUG - Waiting to SSH to VM ctest-right_vm-64348310, IP 56.155.113.3, Port 22 2024-12-23 11:40:49,676 - DEBUG - VM ctest-right_vm-64348310 is ready for SSH connections 2024-12-23 11:40:49,683 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestSvcRegr-61086061:ctest-left_vn-40334188, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = 0, end_port = 65535], application = [], dst_addresses = [subnet = None, virtual_network = default-domain:ctest-TestSvcRegr-61086061:ctest-right_vn-27151952, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = 0, end_port = 65535], action_list = simple_action = pass, gateway_name = None, apply_service = ['default-domain:ctest-TestSvcRegr-61086061:ctest-si-30102312'], 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] 2024-12-23 11:40:50,124 - INFO - Attaching policy ctest-policy-76284015 to vn ctest-left_vn-40334188 2024-12-23 11:40:50,708 - INFO - Attaching policy ctest-policy-76284015 to vn ctest-right_vn-27151952 2024-12-23 11:40:51,193 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-05983995'] created succesfully 2024-12-23 11:40:51,437 - DEBUG - Service instance: ['default-domain', 'ctest-TestSvcRegr-61086061', 'ctest-si-30102312'] created succesfully 2024-12-23 11:40:51,437 - DEBUG - Requesting: http://10.0.0.44:8082/domains 2024-12-23 11:40:51,451 - DEBUG - Requesting: http://10.0.0.44:8082/domain/720148ca-78e2-4f54-905c-229612518405 2024-12-23 11:40:51,468 - DEBUG - Requesting: http://10.0.0.44:8082/project/c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000 2024-12-23 11:40:51,551 - DEBUG - Requesting: http://10.0.0.44:8082/service-instance/8a592385-f58b-4e99-b0c9-f81306c00e9b 2024-12-23 11:40:51,565 - DEBUG - SI 'ctest-si-30102312' has service template ref to ctest-service_template_1-05983995 2024-12-23 11:40:51,565 - DEBUG - Requesting: http://10.0.0.44:8082/domains 2024-12-23 11:40:51,574 - DEBUG - Requesting: http://10.0.0.44:8082/domain/720148ca-78e2-4f54-905c-229612518405 2024-12-23 11:40:51,588 - DEBUG - Requesting: http://10.0.0.44:8082/project/c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000 2024-12-23 11:40:51,663 - DEBUG - Requesting: http://10.0.0.44:8082/service-instance/8a592385-f58b-4e99-b0c9-f81306c00e9b 2024-12-23 11:40:51,678 - DEBUG - Requesting: http://10.0.0.44:8082/port-tuple/b11dd370-65b5-4a51-85c3-afd8b69ac3fe 2024-12-23 11:40:51,690 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine-interface/0ebab95e-b9d4-46cb-a229-4141ed8815cf 2024-12-23 11:40:51,707 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine-interface/2a4512d3-d75c-4baf-9806-38d263aadba8 2024-12-23 11:40:51,725 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine-interface/e7be322b-a5ad-4a7f-aeb0-ba16f9025ed2 2024-12-23 11:40:51,996 - DEBUG - VM is in ACTIVE state now 2024-12-23 11:40:52,464 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine/423e71db-f90d-4f64-b67d-96c00ca2d1ba 2024-12-23 11:40:52,474 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine-interface/0ebab95e-b9d4-46cb-a229-4141ed8815cf 2024-12-23 11:40:52,489 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine-interface/2a4512d3-d75c-4baf-9806-38d263aadba8 2024-12-23 11:40:52,502 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine-interface/e7be322b-a5ad-4a7f-aeb0-ba16f9025ed2 2024-12-23 11:40:52,515 - DEBUG - Requesting: http://10.0.0.44:8082/instance-ip/ab1bb320-2f57-4814-8d80-824157e0287e 2024-12-23 11:40:52,524 - DEBUG - Requesting: http://10.0.0.44:8082/instance-ip/cdbc8469-b21b-4772-9995-4805590f1a4b 2024-12-23 11:40:52,535 - DEBUG - Requesting: http://10.0.0.44:8082/instance-ip/eecb0089-85a9-4960-b215-9cf845268596 2024-12-23 11:40:52,546 - DEBUG - Requesting: http://10.0.0.44:8082/instance-ip/3d50c22b-8835-49f5-8281-0277e3ca469a 2024-12-23 11:40:52,554 - DEBUG - Requesting: http://10.0.0.44:8082/instance-ip/6c34e393-2380-4807-9240-c36f1a7cb163 2024-12-23 11:40:52,562 - DEBUG - Requesting: http://10.0.0.44:8082/instance-ip/c6d9c827-f4c3-49ad-b2d1-1367cf916748 2024-12-23 11:40:52,573 - DEBUG - Requesting: http://10.0.0.44:8082/instance-ip/1f996028-b8f1-44f8-8ddc-8900c66191e2 2024-12-23 11:40:52,582 - DEBUG - Requesting: http://10.0.0.44:8082/instance-ip/896ad78b-0d7c-45ab-9c5f-7fdd099594de 2024-12-23 11:40:52,594 - DEBUG - Requesting: http://10.0.0.44:8082/instance-ip/db2ed46d-b131-49f5-a353-088511bc0826 2024-12-23 11:40:53,041 - DEBUG - VM is in ACTIVE state now 2024-12-23 11:40:53,041 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine/423e71db-f90d-4f64-b67d-96c00ca2d1ba 2024-12-23 11:40:53,052 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine-interface/0ebab95e-b9d4-46cb-a229-4141ed8815cf 2024-12-23 11:40:53,064 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine-interface/2a4512d3-d75c-4baf-9806-38d263aadba8 2024-12-23 11:40:53,076 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine-interface/e7be322b-a5ad-4a7f-aeb0-ba16f9025ed2 2024-12-23 11:40:54,334 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n64 bytes from 169.254.0.6: icmp_seq=1 ttl=63 time=1.63 ms\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=0.678 ms\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.678/1.155/1.632/0.477 ms') 2024-12-23 11:40:54,335 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-pt_svm0-42021457 passed 2024-12-23 11:40:54,377 - DEBUG - VM ctest-pt_svm0-42021457 Tap interface: {'index': '6', 'name': 'tap0ebab95e-b9', 'uuid': '0ebab95e-b9d4-46cb-a229-4141ed8815cf', 'vrf_name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-left_vn-40334188:ctest-left_vn-40334188', 'active': 'Active', 'ipv4_active': 'Active', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Enable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Enable', 'type': 'vport', 'label': '44', 'l2_label': '48', 'vxlan_id': '10', 'vn_name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-left_vn-40334188', 'vm_uuid': '423e71db-f90d-4f64-b67d-96c00ca2d1ba', 'vm_name': 'ctest-pt_svm0-42021457', 'ip_addr': '44.117.165.132', 'mac_addr': '02:0e:ba:b9:5e:b9', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.6', 'service_vlan_list': None, 'os_ifindex': '29', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-61086061:0ebab95e-b9d4-46cb-a229-4141ed8815cf', 'sg_uuid_list': ['d33a0fe4-a39d-4c73-b46d-d33005f2d725'], 'static_route_list': None, 'vm_project_uuid': 'c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000', 'admin_state': 'Enabled', 'flow_key_idx': '42', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '2a4512d3-d75c-4baf-9806-38d263aadba8', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []} 2024-12-23 11:40:54,377 - DEBUG - Agent 10.0.0.44 vrf name: default-domain:ctest-TestSvcRegr-61086061:ctest-left_vn-40334188:ctest-left_vn-40334188 2024-12-23 11:40:54,383 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-left_vn-40334188:ctest-left_vn-40334188', 'ucindex': '2', 'mcindex': '2', 'l2index': '2', 'source': 'Config; ', 'uc6index': '2', 'vn': 'default-domain:ctest-TestSvcRegr-61086061:ctest-left_vn-40334188', 'table_label': '-1', 'vxlan_id': '10', 'evpnindex': '2', 'brindex': '2', 'mplsindex': '0', 'RD': '10.20.0.5:2', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]} 2024-12-23 11:40:54,559 - DEBUG - VM ctest-pt_svm0-42021457 : Tap interface tap0ebab95e-b9 is set to Active 2024-12-23 11:40:54,559 - DEBUG - Tap interface tap0ebab95e-b9 detail : {'index': '6', 'name': 'tap0ebab95e-b9', 'uuid': '0ebab95e-b9d4-46cb-a229-4141ed8815cf', 'vrf_name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-left_vn-40334188:ctest-left_vn-40334188', 'active': 'Active', 'ipv4_active': 'Active', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Enable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Enable', 'type': 'vport', 'label': '44', 'l2_label': '48', 'vxlan_id': '10', 'vn_name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-left_vn-40334188', 'vm_uuid': '423e71db-f90d-4f64-b67d-96c00ca2d1ba', 'vm_name': 'ctest-pt_svm0-42021457', 'ip_addr': '44.117.165.132', 'mac_addr': '02:0e:ba:b9:5e:b9', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.6', 'service_vlan_list': None, 'os_ifindex': '29', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-61086061:0ebab95e-b9d4-46cb-a229-4141ed8815cf', 'sg_uuid_list': ['d33a0fe4-a39d-4c73-b46d-d33005f2d725'], 'static_route_list': None, 'vm_project_uuid': 'c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000', 'admin_state': 'Enabled', 'flow_key_idx': '42', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '2a4512d3-d75c-4baf-9806-38d263aadba8', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []} 2024-12-23 11:40:54,757 - DEBUG - Starting Layer 2 verification in Agent 2024-12-23 11:40:54,776 - DEBUG - Layer 2 path is seen for VM MAC 02:0e:ba:b9:5e:b9 in agent 10.0.0.44 2024-12-23 11:40:54,776 - DEBUG - Active layer 2 route in agent is present for VMI tap0ebab95e-b9 2024-12-23 11:40:54,777 - DEBUG - L2 label(48) matches bw route table and interface table 2024-12-23 11:40:54,784 - DEBUG - VN default-domain:ctest-TestSvcRegr-61086061:ctest-left_vn-40334188 is found in Agent of node 10.0.0.44 2024-12-23 11:40:55,008 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-61086061:ctest-left_vn-40334188 is consistent in agent 10.0.0.44 2024-12-23 11:40:55,008 - DEBUG - Route for VM IP ['44.117.165.132'] is consistent in agent 10.0.0.44 2024-12-23 11:40:55,008 - DEBUG - VN default-domain:ctest-TestSvcRegr-61086061:ctest-left_vn-40334188 verification for VM ctest-pt_svm0-42021457 in Agent 10.0.0.44 passed 2024-12-23 11:40:55,208 - DEBUG - Starting all layer 2 verification in agent 10.0.0.44 2024-12-23 11:40:55,223 - DEBUG - Route for VM MAC 02:0e:ba:b9:5e:b9 is consistent in agent 10.0.0.44 2024-12-23 11:40:55,249 - DEBUG - VM ctest-pt_svm0-42021457 Tap interface: {'index': '5', 'name': 'tape7be322b-a5', 'uuid': 'e7be322b-a5ad-4a7f-aeb0-ba16f9025ed2', 'vrf_name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334:ctest-mgmt_vn-47040334', 'active': 'Active', 'ipv4_active': 'Active', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Enable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Enable', 'type': 'vport', 'label': '39', 'l2_label': '43', 'vxlan_id': '9', 'vn_name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334', 'vm_uuid': '423e71db-f90d-4f64-b67d-96c00ca2d1ba', 'vm_name': 'ctest-pt_svm0-42021457', 'ip_addr': '113.174.193.131', 'mac_addr': '02:e7:be:32:2b:a5', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.5', 'service_vlan_list': None, 'os_ifindex': '28', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-61086061:e7be322b-a5ad-4a7f-aeb0-ba16f9025ed2', 'sg_uuid_list': ['d33a0fe4-a39d-4c73-b46d-d33005f2d725'], 'static_route_list': None, 'vm_project_uuid': 'c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000', 'admin_state': 'Enabled', 'flow_key_idx': '43', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []} 2024-12-23 11:40:55,249 - DEBUG - Agent 10.0.0.44 vrf name: default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334:ctest-mgmt_vn-47040334 2024-12-23 11:40:55,257 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334:ctest-mgmt_vn-47040334', 'ucindex': '4', 'mcindex': '4', 'l2index': '4', 'source': 'Config; ', 'uc6index': '4', 'vn': 'default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334', 'table_label': '-1', 'vxlan_id': '9', 'evpnindex': '4', 'brindex': '4', 'mplsindex': '0', 'RD': '10.20.0.5:4', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]} 2024-12-23 11:40:55,435 - DEBUG - VM ctest-pt_svm0-42021457 : Tap interface tape7be322b-a5 is set to Active 2024-12-23 11:40:55,436 - DEBUG - Tap interface tape7be322b-a5 detail : {'index': '5', 'name': 'tape7be322b-a5', 'uuid': 'e7be322b-a5ad-4a7f-aeb0-ba16f9025ed2', 'vrf_name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334:ctest-mgmt_vn-47040334', 'active': 'Active', 'ipv4_active': 'Active', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Enable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Enable', 'type': 'vport', 'label': '39', 'l2_label': '43', 'vxlan_id': '9', 'vn_name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334', 'vm_uuid': '423e71db-f90d-4f64-b67d-96c00ca2d1ba', 'vm_name': 'ctest-pt_svm0-42021457', 'ip_addr': '113.174.193.131', 'mac_addr': '02:e7:be:32:2b:a5', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.5', 'service_vlan_list': None, 'os_ifindex': '28', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-61086061:e7be322b-a5ad-4a7f-aeb0-ba16f9025ed2', 'sg_uuid_list': ['d33a0fe4-a39d-4c73-b46d-d33005f2d725'], 'static_route_list': None, 'vm_project_uuid': 'c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000', 'admin_state': 'Enabled', 'flow_key_idx': '43', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []} 2024-12-23 11:40:55,641 - DEBUG - Starting Layer 2 verification in Agent 2024-12-23 11:40:55,657 - DEBUG - Layer 2 path is seen for VM MAC 02:e7:be:32:2b:a5 in agent 10.0.0.44 2024-12-23 11:40:55,658 - DEBUG - Active layer 2 route in agent is present for VMI tape7be322b-a5 2024-12-23 11:40:55,658 - DEBUG - L2 label(43) matches bw route table and interface table 2024-12-23 11:40:55,667 - DEBUG - VN default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334 is found in Agent of node 10.0.0.44 2024-12-23 11:40:55,899 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334 is consistent in agent 10.0.0.44 2024-12-23 11:40:55,899 - DEBUG - Route for VM IP ['113.174.193.131'] is consistent in agent 10.0.0.44 2024-12-23 11:40:55,899 - DEBUG - VN default-domain:ctest-TestSvcRegr-61086061:ctest-mgmt_vn-47040334 verification for VM ctest-pt_svm0-42021457 in Agent 10.0.0.44 passed 2024-12-23 11:40:56,097 - DEBUG - Starting all layer 2 verification in agent 10.0.0.44 2024-12-23 11:40:56,111 - DEBUG - Route for VM MAC 02:e7:be:32:2b:a5 is consistent in agent 10.0.0.44 2024-12-23 11:40:56,146 - DEBUG - VM ctest-pt_svm0-42021457 Tap interface: {'index': '7', 'name': 'tap2a4512d3-d7', 'uuid': '2a4512d3-d75c-4baf-9806-38d263aadba8', 'vrf_name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-right_vn-27151952:ctest-right_vn-27151952', 'active': 'Active', 'ipv4_active': 'Active', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Enable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Enable', 'type': 'vport', 'label': '49', 'l2_label': '53', 'vxlan_id': '11', 'vn_name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-right_vn-27151952', 'vm_uuid': '423e71db-f90d-4f64-b67d-96c00ca2d1ba', 'vm_name': 'ctest-pt_svm0-42021457', 'ip_addr': '56.155.113.4', 'mac_addr': '02:2a:45:12:d3:d7', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.7', 'service_vlan_list': None, 'os_ifindex': '30', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-61086061:2a4512d3-d75c-4baf-9806-38d263aadba8', 'sg_uuid_list': ['d33a0fe4-a39d-4c73-b46d-d33005f2d725'], 'static_route_list': None, 'vm_project_uuid': 'c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000', 'admin_state': 'Enabled', 'flow_key_idx': '56', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '0ebab95e-b9d4-46cb-a229-4141ed8815cf', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []} 2024-12-23 11:40:56,146 - DEBUG - Agent 10.0.0.44 vrf name: default-domain:ctest-TestSvcRegr-61086061:ctest-right_vn-27151952:ctest-right_vn-27151952 2024-12-23 11:40:56,156 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-right_vn-27151952:ctest-right_vn-27151952', 'ucindex': '3', 'mcindex': '3', 'l2index': '3', 'source': 'Config; ', 'uc6index': '3', 'vn': 'default-domain:ctest-TestSvcRegr-61086061:ctest-right_vn-27151952', 'table_label': '-1', 'vxlan_id': '11', 'evpnindex': '3', 'brindex': '3', 'mplsindex': '0', 'RD': '10.20.0.5:3', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]} 2024-12-23 11:40:56,347 - DEBUG - VM ctest-pt_svm0-42021457 : Tap interface tap2a4512d3-d7 is set to Active 2024-12-23 11:40:56,347 - DEBUG - Tap interface tap2a4512d3-d7 detail : {'index': '7', 'name': 'tap2a4512d3-d7', 'uuid': '2a4512d3-d75c-4baf-9806-38d263aadba8', 'vrf_name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-right_vn-27151952:ctest-right_vn-27151952', 'active': 'Active', 'ipv4_active': 'Active', 'l2_active': 'L2 Active', 'ip6_active': 'Ipv6 Inactive < no-ipv6-addr >', 'health_check_active': 'Active', 'dhcp_service': 'Enable', 'dhcp_service_v6': 'Disable', 'dns_service': 'Enable', 'type': 'vport', 'label': '49', 'l2_label': '53', 'vxlan_id': '11', 'vn_name': 'default-domain:ctest-TestSvcRegr-61086061:ctest-right_vn-27151952', 'vm_uuid': '423e71db-f90d-4f64-b67d-96c00ca2d1ba', 'vm_name': 'ctest-pt_svm0-42021457', 'ip_addr': '56.155.113.4', 'mac_addr': '02:2a:45:12:d3:d7', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.7', 'service_vlan_list': None, 'os_ifindex': '30', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-61086061:2a4512d3-d75c-4baf-9806-38d263aadba8', 'sg_uuid_list': ['d33a0fe4-a39d-4c73-b46d-d33005f2d725'], 'static_route_list': None, 'vm_project_uuid': 'c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000', 'admin_state': 'Enabled', 'flow_key_idx': '56', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '0ebab95e-b9d4-46cb-a229-4141ed8815cf', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []} 2024-12-23 11:40:56,544 - DEBUG - Starting Layer 2 verification in Agent 2024-12-23 11:40:56,560 - DEBUG - Layer 2 path is seen for VM MAC 02:2a:45:12:d3:d7 in agent 10.0.0.44 2024-12-23 11:40:56,560 - DEBUG - Active layer 2 route in agent is present for VMI tap2a4512d3-d7 2024-12-23 11:40:56,560 - DEBUG - L2 label(53) matches bw route table and interface table 2024-12-23 11:40:56,570 - DEBUG - VN default-domain:ctest-TestSvcRegr-61086061:ctest-right_vn-27151952 is found in Agent of node 10.0.0.44 2024-12-23 11:40:56,798 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-61086061:ctest-right_vn-27151952 is consistent in agent 10.0.0.44 2024-12-23 11:40:56,798 - DEBUG - Route for VM IP ['56.155.113.4'] is consistent in agent 10.0.0.44 2024-12-23 11:40:56,798 - DEBUG - VN default-domain:ctest-TestSvcRegr-61086061:ctest-right_vn-27151952 verification for VM ctest-pt_svm0-42021457 in Agent 10.0.0.44 passed 2024-12-23 11:40:56,997 - DEBUG - Starting all layer 2 verification in agent 10.0.0.44 2024-12-23 11:40:57,011 - DEBUG - Route for VM MAC 02:2a:45:12:d3:d7 is consistent in agent 10.0.0.44 2024-12-23 11:40:57,012 - INFO - VM ctest-pt_svm0-42021457 verifications in Compute nodes passed 2024-12-23 11:40:57,012 - DEBUG - The SVMs in the SI are : [] 2024-12-23 11:40:57,012 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine/423e71db-f90d-4f64-b67d-96c00ca2d1ba 2024-12-23 11:40:57,022 - DEBUG - Service VM for SI 'ctest-si-30102312' is launched 2024-12-23 11:40:57,022 - DEBUG - Requesting: http://10.0.0.44:8082/domains 2024-12-23 11:40:57,029 - DEBUG - Requesting: http://10.0.0.44:8082/domain/720148ca-78e2-4f54-905c-229612518405 2024-12-23 11:40:57,046 - DEBUG - Requesting: http://10.0.0.44:8082/project/c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000 2024-12-23 11:40:57,140 - DEBUG - Requesting: http://10.0.0.44:8082/service-instance/8a592385-f58b-4e99-b0c9-f81306c00e9b 2024-12-23 11:40:57,154 - DEBUG - SI ctest-si-30102312 has Port Tuple: ['ctest-port_tuple-70936203'] 2024-12-23 11:40:57,269 - INFO - VMI and/or RI refs are present for VN default-domain:ctest-TestSvcRegr-61086061:ctest-left_vn-40334188 2024-12-23 11:40:57,421 - INFO - VMI and/or RI refs are present for VN default-domain:ctest-TestSvcRegr-61086061:ctest-right_vn-27151952 2024-12-23 11:40:57,593 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:57,604 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:57,604 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:57,613 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:57,613 - INFO - Route to 56.155.113.3 seen in VRF:5 on cn-jenkins-deploy-platform-ansible-os-2490-1, and SI ctest-si-30102312 is seen as the NH 2024-12-23 11:40:57,774 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:57,786 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:57,786 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:57,797 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:57,797 - INFO - Route to 44.117.165.131 seen in VRF:6 on cn-jenkins-deploy-platform-ansible-os-2490-1, and SI ctest-si-30102312 is seen as the NH 2024-12-23 11:40:57,797 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:57,797 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2024-12-23 11:40:57,797 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 56.155.113.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.44, gateway password: c0ntrail123 2024-12-23 11:40:57,797 - DEBUG - ping -s 56 -c 3 -W 1 56.155.113.3 2024-12-23 11:41:01,896 - DEBUG - PING 56.155.113.3 (56.155.113.3): 56 data bytes 64 bytes from 56.155.113.3: seq=0 ttl=61 time=6.803 ms 64 bytes from 56.155.113.3: seq=1 ttl=61 time=1.715 ms 64 bytes from 56.155.113.3: seq=2 ttl=61 time=2.166 ms --- 56.155.113.3 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.715/3.561/6.803 ms 2024-12-23 11:41:01,896 - INFO - Ping to IP 56.155.113.3 from VM ctest-left_vm-19959000 passed 2024-12-23 11:41:01,896 - INFO - Dettaching policy ctest-policy-76284015 from vn ctest-right_vn-27151952 2024-12-23 11:41:02,116 - INFO - Dettaching policy ctest-policy-76284015 from vn ctest-left_vn-40334188 2024-12-23 11:41:02,410 - INFO - Deleted policy ctest-policy-76284015 2024-12-23 11:41:02,410 - DEBUG - Deleting service instance: ['default-domain', 'ctest-TestSvcRegr-61086061', 'ctest-si-30102312'] 2024-12-23 11:41:02,517 - INFO - Deleted SI ['default-domain', 'ctest-TestSvcRegr-61086061', 'ctest-si-30102312'] 2024-12-23 11:41:02,517 - DEBUG - Requesting: http://10.0.0.44:8082/domains 2024-12-23 11:41:02,524 - DEBUG - Requesting: http://10.0.0.44:8082/domain/720148ca-78e2-4f54-905c-229612518405 2024-12-23 11:41:02,543 - DEBUG - Requesting: http://10.0.0.44:8082/project/c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000 2024-12-23 11:41:02,617 - DEBUG - Service instance ctest-si-30102312 removed from api server 2024-12-23 11:41:02,617 - DEBUG - Requesting: http://10.0.0.44:8082/virtual-machine/423e71db-f90d-4f64-b67d-96c00ca2d1ba 2024-12-23 11:41:02,629 - DEBUG - All Service VMs unlinked from SI ctest-si-30102312 2024-12-23 11:41:02,634 - DEBUG - 0 svc intances found in all projects. They are [] 2024-12-23 11:41:02,634 - DEBUG - 0 svc intances found in current project. They are [] 2024-12-23 11:41:02,680 - DEBUG - 0 svc intances found in all projects. They are [] 2024-12-23 11:41:02,680 - DEBUG - 0 svc intances found in current project. They are [] 2024-12-23 11:41:02,680 - INFO - Deleting VM ctest-pt_svm0-42021457 2024-12-23 11:41:02,762 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-05983995'] 2024-12-23 11:41:02,860 - INFO - Service template: ['default-domain', 'ctest-service_template_1-05983995'] deleted successfully. 2024-12-23 11:41:02,860 - INFO - Deleting VM ctest-right_vm-64348310 2024-12-23 11:41:02,941 - INFO - Deleting VM ctest-left_vm-19959000 2024-12-23 11:41:03,028 - INFO - Deleting VN ctest-right_vn-27151952 2024-12-23 11:41:03,071 - DEBUG - VN 370a454c-9e03-4a55-8cd4-48e058f3b943 still in use: Unable to complete operation on network 370a454c-9e03-4a55-8cd4-48e058f3b943. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-07e86d30-faad-4458-97ff-b639a5981b14'] 2024-12-23 11:41:03,071 - WARNING - Deleting VN ctest-right_vn-27151952 failed..Will retry 2024-12-23 11:41:05,186 - DEBUG - Response for deleting network () 2024-12-23 11:41:05,186 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/dd9ea6e0-5188-41da-ac01-1d87ac7aeaef 2024-12-23 11:41:05,192 - DEBUG - Response Code: 404 2024-12-23 11:41:05,192 - DEBUG - Requesting: http://10.0.0.44:8082/domains 2024-12-23 11:41:05,198 - DEBUG - Requesting: http://10.0.0.44:8082/domain/720148ca-78e2-4f54-905c-229612518405 2024-12-23 11:41:05,256 - DEBUG - Requesting: http://10.0.0.44:8082/project/c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000 2024-12-23 11:41:05,329 - INFO - Validated that VN ctest-right_vn-27151952 is not found in API Server 2024-12-23 11:41:05,341 - DEBUG - VN ctest-right_vn-27151952 is not present in Agent 10.0.0.44 2024-12-23 11:41:05,341 - INFO - Validated that VN ctest-right_vn-27151952 is not in any agent 2024-12-23 11:41:05,359 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-27151952 info 2024-12-23 11:41:05,359 - INFO - Deleting VN ctest-left_vn-40334188 2024-12-23 11:41:05,491 - DEBUG - Response for deleting network () 2024-12-23 11:41:05,491 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/0de753a5-865a-4a29-ac91-e4aedbc607f9 2024-12-23 11:41:05,498 - DEBUG - Response Code: 404 2024-12-23 11:41:05,498 - DEBUG - Requesting: http://10.0.0.44:8082/domains 2024-12-23 11:41:05,504 - DEBUG - Requesting: http://10.0.0.44:8082/domain/720148ca-78e2-4f54-905c-229612518405 2024-12-23 11:41:05,559 - DEBUG - Requesting: http://10.0.0.44:8082/project/c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000 2024-12-23 11:41:05,639 - INFO - Validated that VN ctest-left_vn-40334188 is not found in API Server 2024-12-23 11:41:05,653 - DEBUG - VN ctest-left_vn-40334188 is not present in Agent 10.0.0.44 2024-12-23 11:41:05,653 - INFO - Validated that VN ctest-left_vn-40334188 is not in any agent 2024-12-23 11:41:05,674 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-40334188 info 2024-12-23 11:41:05,674 - INFO - Deleting VN ctest-mgmt_vn-47040334 2024-12-23 11:41:05,805 - DEBUG - Response for deleting network () 2024-12-23 11:41:05,805 - DEBUG - Requesting: http://10.0.0.44:8082/routing-instance/581b1c4d-a726-49e1-8391-cf5f68f709c3 2024-12-23 11:41:05,811 - DEBUG - Response Code: 404 2024-12-23 11:41:05,812 - DEBUG - Requesting: http://10.0.0.44:8082/domains 2024-12-23 11:41:05,818 - DEBUG - Requesting: http://10.0.0.44:8082/domain/720148ca-78e2-4f54-905c-229612518405 2024-12-23 11:41:05,874 - DEBUG - Requesting: http://10.0.0.44:8082/project/c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000 2024-12-23 11:41:05,947 - INFO - Validated that VN ctest-mgmt_vn-47040334 is not found in API Server 2024-12-23 11:41:05,959 - DEBUG - VN ctest-mgmt_vn-47040334 is not present in Agent 10.0.0.44 2024-12-23 11:41:05,959 - INFO - Validated that VN ctest-mgmt_vn-47040334 is not in any agent 2024-12-23 11:41:05,978 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-47040334 info 2024-12-23 11:41:06,236 - DEBUG - No XMPP flaps were noticed during the test 2024-12-23 11:41:06,236 - INFO -
2024-12-23 11:41:06,236 - INFO - END TEST : test_svc_in_network_datapath : PASSED[0:01:19]
2024-12-23 11:41:06,236 - INFO - -------------------------------------------------------------------------------- 2024-12-23 11:41:06,997 - INFO - Deleted project: ctest-TestSvcRegr-61086061, ID : c6f79405-5ec1-4c9d-a6a2-3ddcc28f6000