2025-01-27 02:35:56,266 - INFO - Domain Default found not creating
2025-01-27 02:35:56,441 - INFO - Project ctest-TestSvcRegr-22543022 not found, creating it
2025-01-27 02:35:57,073 - INFO - Created Project:ctest-TestSvcRegr-22543022, ID : c9eb16be-a19e-426f-9c00-e7d8636b2b63
2025-01-27 02:35:58,530 - INFO - ================================================================================
2025-01-27 02:35:58,530 - INFO - STARTING TEST : test_svc_in_network_datapath
2025-01-27 02:35:59,844 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.8': '0', '10.20.0.13': '0'}, '10.0.0.43': {'10.20.0.8': '0', '10.20.0.13': '0'}} with
2025-01-27 02:35:59,844 - INFO - Initial checks done. Running the testcase now
2025-01-27 02:35:59,844 - INFO -
2025-01-27 02:36:00,532 - DEBUG - Response for create_network : {'network': {'id': '3e97b07a-b048-4e70-9374-de5a16ee589a', 'name': 'ctest-mgmt_vn-47169289', 'tenant_id': 'c9eb16bea19e426f9c00e7d8636b2b63', 'project_id': 'c9eb16bea19e426f9c00e7d8636b2b63', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-22543022', 'ctest-mgmt_vn-47169289'], 'port_security_enabled': True, 'description': ''}}
2025-01-27 02:36:00,871 - DEBUG - Response for create_subnet : {'subnet': {'id': '37a8dc0b-d16a-4c3d-a35d-45bbcc825b65', 'name': '', 'tenant_id': 'c9eb16bea19e426f9c00e7d8636b2b63', 'network_id': '3e97b07a-b048-4e70-9374-de5a16ee589a', 'ip_version': 4, 'cidr': '192.216.11.128/26', 'allocation_pools': [{'start': '192.216.11.130', 'end': '192.216.11.190'}], 'gateway_ip': '192.216.11.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '192.216.11.130', 'tags': [], 'project_id': 'c9eb16bea19e426f9c00e7d8636b2b63'}}
2025-01-27 02:36:00,898 - INFO - Created VN ctest-mgmt_vn-47169289
2025-01-27 02:36:00,912 - DEBUG - VN ctest-mgmt_vn-47169289 UUID is 3e97b07a-b048-4e70-9374-de5a16ee589a
2025-01-27 02:36:01,005 - DEBUG - Requesting: http://10.0.0.37:8082/domains
2025-01-27 02:36:01,306 - DEBUG - Requesting: http://10.0.0.37:8082/domains
2025-01-27 02:36:01,333 - DEBUG - Requesting: http://10.0.0.37:8082/domain/9f6bcc6d-d9b0-4847-910a-1781c72618e1
2025-01-27 02:36:01,350 - DEBUG - Requesting: http://10.0.0.37:8082/project/c9eb16be-a19e-426f-9c00-e7d8636b2b63
2025-01-27 02:36:01,466 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-network/3e97b07a-b048-4e70-9374-de5a16ee589a
2025-01-27 02:36:01,479 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-network/3e97b07a-b048-4e70-9374-de5a16ee589a
2025-01-27 02:36:01,492 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/29dc47cc-0571-42d3-9660-eb517160a8d2
2025-01-27 02:36:01,505 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/29dc47cc-0571-42d3-9660-eb517160a8d2
2025-01-27 02:36:01,515 - DEBUG - Requesting: http://10.0.0.37:8082/route-target/a30fa7e6-0502-4012-af22-273dc20f688a
2025-01-27 02:36:01,525 - DEBUG - Route Targets: ['target:64512:8000005']
2025-01-27 02:36:01,526 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-network/3e97b07a-b048-4e70-9374-de5a16ee589a
2025-01-27 02:36:01,540 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/29dc47cc-0571-42d3-9660-eb517160a8d2
2025-01-27 02:36:01,561 - INFO - Verified VN network id 7 for VN 3e97b07a-b048-4e70-9374-de5a16ee589a
2025-01-27 02:36:01,561 - INFO - Verifications in API Server for VN ctest-mgmt_vn-47169289 passed
2025-01-27 02:36:01,561 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-network/3e97b07a-b048-4e70-9374-de5a16ee589a
2025-01-27 02:36:01,574 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/29dc47cc-0571-42d3-9660-eb517160a8d2
2025-01-27 02:36:01,583 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/29dc47cc-0571-42d3-9660-eb517160a8d2
2025-01-27 02:36:01,592 - DEBUG - Requesting: http://10.0.0.37:8082/route-target/a30fa7e6-0502-4012-af22-273dc20f688a
2025-01-27 02:36:01,607 - DEBUG - Control-node 10.0.0.37 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22543022', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4510267592824868464', 'uuid-lslong': '10625361899386984602'}, 'enable': 'true', 'created': '2025-01-27T02:36:00', 'last-modified': '2025-01-27T02:36:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.809579'}
2025-01-27 02:36:01,613 - DEBUG - Route Targets: ['target:64512:8000005']
2025-01-27 02:36:01,620 - DEBUG - Control-node 10.0.0.32 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22543022', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4510267592824868464', 'uuid-lslong': '10625361899386984602'}, 'enable': 'true', 'created': '2025-01-27T02:36:00', 'last-modified': '2025-01-27T02:36:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.826356'}
2025-01-27 02:36:01,627 - DEBUG - Route Targets: ['target:64512:8000005']
2025-01-27 02:36:01,634 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22543022', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4510267592824868464', 'uuid-lslong': '10625361899386984602'}, 'enable': 'true', 'created': '2025-01-27T02:36:00', 'last-modified': '2025-01-27T02:36:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.845293'}
2025-01-27 02:36:01,642 - DEBUG - Route Targets: ['target:64512:8000005']
2025-01-27 02:36:01,642 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-47169289 passed
2025-01-27 02:36:01,642 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-47169289 in API_Server ======
2025-01-27 02:36:01,642 - DEBUG - Requesting: http://10.0.0.37:8082/domains
2025-01-27 02:36:01,651 - DEBUG - Requesting: http://10.0.0.37:8082/domain/9f6bcc6d-d9b0-4847-910a-1781c72618e1
2025-01-27 02:36:01,665 - DEBUG - Requesting: http://10.0.0.37:8082/project/c9eb16be-a19e-426f-9c00-e7d8636b2b63
2025-01-27 02:36:01,771 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-network/3e97b07a-b048-4e70-9374-de5a16ee589a
2025-01-27 02:36:01,786 - DEBUG - =>VN ctest-mgmt_vn-47169289 has no policy to be verified
2025-01-27 02:36:01,786 - DEBUG - Verifying the vn in opserver
2025-01-27 02:36:01,786 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289 virtual network link through opserver 10.0.0.37
2025-01-27 02:36:01,786 - DEBUG - Requesting: http://10.0.0.37:8081/analytics/uves/virtual-networks
2025-01-27 02:36:02,081 - DEBUG - Requesting: http://10.0.0.37:8081/analytics/uves/virtual-networks
2025-01-27 02:36:02,140 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289', 'href': 'http://10.0.0.37:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289?flat'}
2025-01-27 02:36:02,141 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289 virtual network link through opserver 10.0.0.32
2025-01-27 02:36:02,141 - DEBUG - Requesting: http://10.0.0.32:8081/analytics/uves/virtual-networks
2025-01-27 02:36:02,440 - DEBUG - Requesting: http://10.0.0.32:8081/analytics/uves/virtual-networks
2025-01-27 02:36:02,509 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289', 'href': 'http://10.0.0.32:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289?flat'}
2025-01-27 02:36:02,509 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289 virtual network link through opserver 10.0.0.22
2025-01-27 02:36:02,510 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-01-27 02:36:02,825 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-01-27 02:36:02,882 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289?flat'}
2025-01-27 02:36:02,882 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289 is found in opserver
2025-01-27 02:36:02,910 - DEBUG - Do not have enough data to verify VN in agent
2025-01-27 02:36:02,923 - DEBUG - VRF ids for VN ctest-mgmt_vn-47169289: {}
2025-01-27 02:36:03,240 - DEBUG - Response for create_network : {'network': {'id': '9b7fac92-eb90-4528-ad1f-d405e9f1b7fa', 'name': 'ctest-left_vn-97803362', 'tenant_id': 'c9eb16bea19e426f9c00e7d8636b2b63', 'project_id': 'c9eb16bea19e426f9c00e7d8636b2b63', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-22543022', 'ctest-left_vn-97803362'], 'port_security_enabled': True, 'description': ''}}
2025-01-27 02:36:03,571 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ee3bcd69-0d84-44ba-a7b6-870a46d0148d', 'name': '', 'tenant_id': 'c9eb16bea19e426f9c00e7d8636b2b63', 'network_id': '9b7fac92-eb90-4528-ad1f-d405e9f1b7fa', 'ip_version': 4, 'cidr': '56.158.24.64/26', 'allocation_pools': [{'start': '56.158.24.66', 'end': '56.158.24.126'}], 'gateway_ip': '56.158.24.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '56.158.24.66', 'tags': [], 'project_id': 'c9eb16bea19e426f9c00e7d8636b2b63'}}
2025-01-27 02:36:03,593 - INFO - Created VN ctest-left_vn-97803362
2025-01-27 02:36:03,605 - DEBUG - VN ctest-left_vn-97803362 UUID is 9b7fac92-eb90-4528-ad1f-d405e9f1b7fa
2025-01-27 02:36:03,679 - DEBUG - Requesting: http://10.0.0.37:8082/domains
2025-01-27 02:36:03,685 - DEBUG - Requesting: http://10.0.0.37:8082/domain/9f6bcc6d-d9b0-4847-910a-1781c72618e1
2025-01-27 02:36:03,699 - DEBUG - Requesting: http://10.0.0.37:8082/project/c9eb16be-a19e-426f-9c00-e7d8636b2b63
2025-01-27 02:36:03,811 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-network/9b7fac92-eb90-4528-ad1f-d405e9f1b7fa
2025-01-27 02:36:03,824 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-network/9b7fac92-eb90-4528-ad1f-d405e9f1b7fa
2025-01-27 02:36:03,835 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/795cd071-ea08-454f-b195-0861479fbafc
2025-01-27 02:36:03,845 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/795cd071-ea08-454f-b195-0861479fbafc
2025-01-27 02:36:03,853 - DEBUG - Requesting: http://10.0.0.37:8082/route-target/66e71df2-109d-42fe-9046-4c931321921a
2025-01-27 02:36:03,861 - DEBUG - Route Targets: ['target:64512:8000006']
2025-01-27 02:36:03,861 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-network/9b7fac92-eb90-4528-ad1f-d405e9f1b7fa
2025-01-27 02:36:03,871 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/795cd071-ea08-454f-b195-0861479fbafc
2025-01-27 02:36:03,891 - INFO - Verified VN network id 8 for VN 9b7fac92-eb90-4528-ad1f-d405e9f1b7fa
2025-01-27 02:36:03,891 - INFO - Verifications in API Server for VN ctest-left_vn-97803362 passed
2025-01-27 02:36:03,891 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-network/9b7fac92-eb90-4528-ad1f-d405e9f1b7fa
2025-01-27 02:36:03,901 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/795cd071-ea08-454f-b195-0861479fbafc
2025-01-27 02:36:03,908 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/795cd071-ea08-454f-b195-0861479fbafc
2025-01-27 02:36:03,916 - DEBUG - Requesting: http://10.0.0.37:8082/route-target/66e71df2-109d-42fe-9046-4c931321921a
2025-01-27 02:36:03,928 - DEBUG - Control-node 10.0.0.37 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22543022', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11204864144938386728', 'uuid-lslong': '12474922614704420858'}, 'enable': 'true', 'created': '2025-01-27T02:36:03', 'last-modified': '2025-01-27T02:36:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.441354'}
2025-01-27 02:36:03,934 - DEBUG - Route Targets: ['target:64512:8000006']
2025-01-27 02:36:03,940 - DEBUG - Control-node 10.0.0.32 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22543022', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11204864144938386728', 'uuid-lslong': '12474922614704420858'}, 'enable': 'true', 'created': '2025-01-27T02:36:03', 'last-modified': '2025-01-27T02:36:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.448007'}
2025-01-27 02:36:03,946 - DEBUG - Route Targets: ['target:64512:8000006']
2025-01-27 02:36:03,953 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22543022', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11204864144938386728', 'uuid-lslong': '12474922614704420858'}, 'enable': 'true', 'created': '2025-01-27T02:36:03', 'last-modified': '2025-01-27T02:36:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.468316'}
2025-01-27 02:36:03,959 - DEBUG - Route Targets: ['target:64512:8000006']
2025-01-27 02:36:03,959 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-97803362 passed
2025-01-27 02:36:03,959 - DEBUG - ====Verifying policy data for ctest-left_vn-97803362 in API_Server ======
2025-01-27 02:36:03,959 - DEBUG - Requesting: http://10.0.0.37:8082/domains
2025-01-27 02:36:03,966 - DEBUG - Requesting: http://10.0.0.37:8082/domain/9f6bcc6d-d9b0-4847-910a-1781c72618e1
2025-01-27 02:36:03,979 - DEBUG - Requesting: http://10.0.0.37:8082/project/c9eb16be-a19e-426f-9c00-e7d8636b2b63
2025-01-27 02:36:04,078 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-network/9b7fac92-eb90-4528-ad1f-d405e9f1b7fa
2025-01-27 02:36:04,090 - DEBUG - =>VN ctest-left_vn-97803362 has no policy to be verified
2025-01-27 02:36:04,090 - DEBUG - Verifying the vn in opserver
2025-01-27 02:36:04,090 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362 virtual network link through opserver 10.0.0.37
2025-01-27 02:36:04,090 - DEBUG - Requesting: http://10.0.0.37:8081/analytics/uves/virtual-networks
2025-01-27 02:36:04,141 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362', 'href': 'http://10.0.0.37:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362?flat'}
2025-01-27 02:36:04,141 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362 virtual network link through opserver 10.0.0.32
2025-01-27 02:36:04,141 - DEBUG - Requesting: http://10.0.0.32:8081/analytics/uves/virtual-networks
2025-01-27 02:36:04,199 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362', 'href': 'http://10.0.0.32:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362?flat'}
2025-01-27 02:36:04,199 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362 virtual network link through opserver 10.0.0.22
2025-01-27 02:36:04,199 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-01-27 02:36:04,252 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362?flat'}
2025-01-27 02:36:04,252 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362 is found in opserver
2025-01-27 02:36:04,284 - DEBUG - Do not have enough data to verify VN in agent
2025-01-27 02:36:04,300 - DEBUG - VRF ids for VN ctest-left_vn-97803362: {}
2025-01-27 02:36:04,633 - DEBUG - Response for create_network : {'network': {'id': 'b2e6f8c6-7576-4e94-ad93-df3942c6abc5', 'name': 'ctest-right_vn-63382439', 'tenant_id': 'c9eb16bea19e426f9c00e7d8636b2b63', 'project_id': 'c9eb16bea19e426f9c00e7d8636b2b63', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-22543022', 'ctest-right_vn-63382439'], 'port_security_enabled': True, 'description': ''}}
2025-01-27 02:36:04,924 - DEBUG - Response for create_subnet : {'subnet': {'id': '2c21f732-d030-407d-a911-0c36b0669114', 'name': '', 'tenant_id': 'c9eb16bea19e426f9c00e7d8636b2b63', 'network_id': 'b2e6f8c6-7576-4e94-ad93-df3942c6abc5', 'ip_version': 4, 'cidr': '146.32.242.128/26', 'allocation_pools': [{'start': '146.32.242.130', 'end': '146.32.242.190'}], 'gateway_ip': '146.32.242.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '146.32.242.130', 'tags': [], 'project_id': 'c9eb16bea19e426f9c00e7d8636b2b63'}}
2025-01-27 02:36:04,947 - INFO - Created VN ctest-right_vn-63382439
2025-01-27 02:36:04,962 - DEBUG - VN ctest-right_vn-63382439 UUID is b2e6f8c6-7576-4e94-ad93-df3942c6abc5
2025-01-27 02:36:05,045 - DEBUG - Requesting: http://10.0.0.37:8082/domains
2025-01-27 02:36:05,052 - DEBUG - Requesting: http://10.0.0.37:8082/domain/9f6bcc6d-d9b0-4847-910a-1781c72618e1
2025-01-27 02:36:05,067 - DEBUG - Requesting: http://10.0.0.37:8082/project/c9eb16be-a19e-426f-9c00-e7d8636b2b63
2025-01-27 02:36:05,160 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-network/b2e6f8c6-7576-4e94-ad93-df3942c6abc5
2025-01-27 02:36:05,190 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-network/b2e6f8c6-7576-4e94-ad93-df3942c6abc5
2025-01-27 02:36:05,203 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/a15e0bbd-536c-4523-86a6-ffaa61fe1905
2025-01-27 02:36:05,216 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/a15e0bbd-536c-4523-86a6-ffaa61fe1905
2025-01-27 02:36:05,224 - DEBUG - Requesting: http://10.0.0.37:8082/route-target/06f023bf-a358-45c0-8409-c196bccdf46a
2025-01-27 02:36:05,232 - DEBUG - Route Targets: ['target:64512:8000007']
2025-01-27 02:36:05,232 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-network/b2e6f8c6-7576-4e94-ad93-df3942c6abc5
2025-01-27 02:36:05,245 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/a15e0bbd-536c-4523-86a6-ffaa61fe1905
2025-01-27 02:36:05,264 - INFO - Verified VN network id 9 for VN b2e6f8c6-7576-4e94-ad93-df3942c6abc5
2025-01-27 02:36:05,265 - INFO - Verifications in API Server for VN ctest-right_vn-63382439 passed
2025-01-27 02:36:05,265 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-network/b2e6f8c6-7576-4e94-ad93-df3942c6abc5
2025-01-27 02:36:05,280 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/a15e0bbd-536c-4523-86a6-ffaa61fe1905
2025-01-27 02:36:05,290 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/a15e0bbd-536c-4523-86a6-ffaa61fe1905
2025-01-27 02:36:05,299 - DEBUG - Requesting: http://10.0.0.37:8082/route-target/06f023bf-a358-45c0-8409-c196bccdf46a
2025-01-27 02:36:05,314 - DEBUG - Control-node 10.0.0.37 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22543022', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12891264514652524180', 'uuid-lslong': '12507586027164445637'}, 'enable': 'true', 'created': '2025-01-27T02:36:04', 'last-modified': '2025-01-27T02:36:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.480086'}
2025-01-27 02:36:05,321 - DEBUG - Route Targets: ['target:64512:8000007']
2025-01-27 02:36:05,327 - DEBUG - Control-node 10.0.0.32 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22543022', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12891264514652524180', 'uuid-lslong': '12507586027164445637'}, 'enable': 'true', 'created': '2025-01-27T02:36:04', 'last-modified': '2025-01-27T02:36:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.492186'}
2025-01-27 02:36:05,334 - DEBUG - Route Targets: ['target:64512:8000007']
2025-01-27 02:36:05,340 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-22543022', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12891264514652524180', 'uuid-lslong': '12507586027164445637'}, 'enable': 'true', 'created': '2025-01-27T02:36:04', 'last-modified': '2025-01-27T02:36:04', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.503547'}
2025-01-27 02:36:05,349 - DEBUG - Route Targets: ['target:64512:8000007']
2025-01-27 02:36:05,349 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-63382439 passed
2025-01-27 02:36:05,350 - DEBUG - ====Verifying policy data for ctest-right_vn-63382439 in API_Server ======
2025-01-27 02:36:05,350 - DEBUG - Requesting: http://10.0.0.37:8082/domains
2025-01-27 02:36:05,357 - DEBUG - Requesting: http://10.0.0.37:8082/domain/9f6bcc6d-d9b0-4847-910a-1781c72618e1
2025-01-27 02:36:05,371 - DEBUG - Requesting: http://10.0.0.37:8082/project/c9eb16be-a19e-426f-9c00-e7d8636b2b63
2025-01-27 02:36:05,477 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-network/b2e6f8c6-7576-4e94-ad93-df3942c6abc5
2025-01-27 02:36:05,489 - DEBUG - =>VN ctest-right_vn-63382439 has no policy to be verified
2025-01-27 02:36:05,489 - DEBUG - Verifying the vn in opserver
2025-01-27 02:36:05,489 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439 virtual network link through opserver 10.0.0.37
2025-01-27 02:36:05,489 - DEBUG - Requesting: http://10.0.0.37:8081/analytics/uves/virtual-networks
2025-01-27 02:36:05,541 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439', 'href': 'http://10.0.0.37:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439?flat'}
2025-01-27 02:36:05,541 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439 virtual network link through opserver 10.0.0.32
2025-01-27 02:36:05,541 - DEBUG - Requesting: http://10.0.0.32:8081/analytics/uves/virtual-networks
2025-01-27 02:36:05,602 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439', 'href': 'http://10.0.0.32:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439?flat'}
2025-01-27 02:36:05,602 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439 virtual network link through opserver 10.0.0.22
2025-01-27 02:36:05,602 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-01-27 02:36:05,659 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439?flat'}
2025-01-27 02:36:05,659 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439 is found in opserver
2025-01-27 02:36:05,712 - DEBUG - Do not have enough data to verify VN in agent
2025-01-27 02:36:05,729 - DEBUG - VRF ids for VN ctest-right_vn-63382439: {}
2025-01-27 02:36:05,794 - DEBUG - Services list from nova: [, , , ]
2025-01-27 02:36:06,827 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-2660-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-2660-2)
2025-01-27 02:36:08,328 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-2660-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-2660-1)
2025-01-27 02:36:08,329 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-98047186']
2025-01-27 02:36:08,641 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-98047186'] created succesfully
2025-01-27 02:36:08,967 - DEBUG - Image by name cirros_in_net not found
2025-01-27 02:36:08,967 - DEBUG - Installing image cirros_in_net
2025-01-27 02:36:08,967 - DEBUG - Image info {'name': 'cirros-in-net.vmdk.gz', 'webserver': '', 'location': '/images/converts/', 'username': 'cirros', 'password': 'gocubsgo', 'type': 'os', 'flavor': 'contrail_flavor_tiny', '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'}
2025-01-27 02:36:08,968 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/converts//cirros-in-net.vmdk.gz
2025-01-27 02:36:08,968 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/converts//cirros-in-net.vmdk.gz
2025-01-27 02:36:08,981 - 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
2025-01-27 02:36:09,298 - DEBUG - Image has been downloaded to /contrail-test/images/cirros-in-net.vmdk.gz
2025-01-27 02:36:09,298 - DEBUG - Unzip image
2025-01-27 02:36:09,298 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/cirros-in-net.vmdk.gz
2025-01-27 02:36:09,556 - DEBUG - Try to create image in user context
2025-01-27 02:36:10,001 - DEBUG - Image has been created in user context
2025-01-27 02:36:10,001 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: rm -f /contrail-test/images/cirros-in-net.vmdk
2025-01-27 02:36:10,015 - DEBUG - Downloaded image has been removed
2025-01-27 02:36:10,036 - DEBUG - Uploaded image status = active
2025-01-27 02:36:11,236 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-2660-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-2660-2)
2025-01-27 02:36:11,237 - INFO - Waiting for VM ctest-pt_svm0-33060016 to be up..
2025-01-27 02:36:11,286 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-01-27 02:36:16,383 - DEBUG - VM is in ACTIVE state now
2025-01-27 02:36:16,383 - INFO - VM name : ctest-pt_svm0-33060016
2025-01-27 02:36:16,474 - DEBUG - VM ctest-pt_svm0-33060016 ID is aba2b351-ca28-4dce-ae67-1a59be07e8c2
2025-01-27 02:36:16,497 - DEBUG - VM ctest-pt_svm0-33060016 launched on Node an-jenkins-deploy-platform-ansible-os-2660-2
2025-01-27 02:36:16,778 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/aba2b351-ca28-4dce-ae67-1a59be07e8c2
2025-01-27 02:36:17,077 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/aba2b351-ca28-4dce-ae67-1a59be07e8c2
2025-01-27 02:36:17,115 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/01cf3ffc-713a-40c7-a6a6-45a09ede2a22
2025-01-27 02:36:17,128 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/4188c517-b199-45a1-b653-267bb0af07a7
2025-01-27 02:36:17,140 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/cfdf4ba4-234d-4b2c-a429-cfcd2f1d75fb
2025-01-27 02:36:20,436 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms')
2025-01-27 02:36:20,437 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-pt_svm0-33060016 failed!
2025-01-27 02:36:20,453 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289 is 192.216.11.129 and allocation pool is NOT set
2025-01-27 02:36:24,535 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1012ms')
2025-01-27 02:36:24,535 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-pt_svm0-33060016 failed!
2025-01-27 02:36:24,553 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289 is 192.216.11.129 and allocation pool is NOT set
2025-01-27 02:36:28,630 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms')
2025-01-27 02:36:28,630 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-pt_svm0-33060016 failed!
2025-01-27 02:36:28,644 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289 is 192.216.11.129 and allocation pool is NOT set
2025-01-27 02:36:32,724 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms')
2025-01-27 02:36:32,724 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-pt_svm0-33060016 failed!
2025-01-27 02:36:32,742 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289 is 192.216.11.129 and allocation pool is NOT set
2025-01-27 02:36:36,828 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms')
2025-01-27 02:36:36,828 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-pt_svm0-33060016 failed!
2025-01-27 02:36:36,845 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289 is 192.216.11.129 and allocation pool is NOT set
2025-01-27 02:36:40,910 - 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=2 ttl=63 time=10.1 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1006ms\r\nrtt min/avg/max/mdev = 10.084/10.084/10.084/0.000 ms')
2025-01-27 02:36:40,910 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-pt_svm0-33060016 passed
2025-01-27 02:36:41,026 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:36:41,026 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-33060016, IP 192.216.11.131, Port 22
2025-01-27 02:36:41,095 - DEBUG - Error on ssh to cirros@169.254.0.4:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.4/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.4/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.4/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-01-27 02:36:41,197 - DEBUG - VM ctest-pt_svm0-33060016 is NOT ready for SSH connections, VM status: ACTIVE
2025-01-27 02:36:46,198 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:36:46,198 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-33060016, IP 192.216.11.131, Port 22
2025-01-27 02:36:46,267 - DEBUG - Error on ssh to cirros@169.254.0.4:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.4/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.4/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.4/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-01-27 02:36:46,360 - DEBUG - VM ctest-pt_svm0-33060016 is NOT ready for SSH connections, VM status: ACTIVE
2025-01-27 02:36:51,361 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:36:51,361 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-33060016, IP 192.216.11.131, Port 22
2025-01-27 02:36:51,431 - DEBUG - Error on ssh to cirros@169.254.0.4:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.4/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.4/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.4/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-01-27 02:36:51,545 - DEBUG - VM ctest-pt_svm0-33060016 is NOT ready for SSH connections, VM status: ACTIVE
2025-01-27 02:36:56,546 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:36:56,546 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-33060016, IP 192.216.11.131, Port 22
2025-01-27 02:36:56,615 - DEBUG - Error on ssh to cirros@169.254.0.4:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.4/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.4/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.4/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-01-27 02:36:56,720 - DEBUG - VM ctest-pt_svm0-33060016 is NOT ready for SSH connections, VM status: ACTIVE
2025-01-27 02:37:01,721 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:37:01,721 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-33060016, IP 192.216.11.131, Port 22
2025-01-27 02:37:01,894 - DEBUG - VM ctest-pt_svm0-33060016 is ready for SSH connections
2025-01-27 02:37:02,008 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:37:02,008 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-33060016, IP 192.216.11.131, Port 22
2025-01-27 02:37:02,175 - DEBUG - VM ctest-pt_svm0-33060016 is ready for SSH connections
2025-01-27 02:37:02,287 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:37:02,287 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-33060016, IP 192.216.11.131, Port 22
2025-01-27 02:37:02,463 - DEBUG - VM ctest-pt_svm0-33060016 is ready for SSH connections
2025-01-27 02:37:02,471 - DEBUG - Creating service instance: ['default-domain', 'ctest-TestSvcRegr-22543022', 'ctest-si-86829426']
2025-01-27 02:37:03,730 - INFO - Waiting for VM ctest-left_vm-35591030 to be up..
2025-01-27 02:37:03,935 - DEBUG - VM is in ACTIVE state now
2025-01-27 02:37:03,935 - INFO - VM name : ctest-left_vm-35591030
2025-01-27 02:37:04,063 - DEBUG - VM ctest-left_vm-35591030 ID is fc1f1b2c-212a-49cc-aae3-f9e496d61790
2025-01-27 02:37:04,063 - DEBUG - VM ctest-left_vm-35591030 launched on Node an-jenkins-deploy-platform-ansible-os-2660-2
2025-01-27 02:37:04,203 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/fc1f1b2c-212a-49cc-aae3-f9e496d61790
2025-01-27 02:37:04,233 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/bdd56038-7947-4135-aaea-2ee173d52bff
2025-01-27 02:37:05,514 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=2.98 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.504 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.504/1.741/2.979/1.237 ms')
2025-01-27 02:37:05,514 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-left_vm-35591030 passed
2025-01-27 02:37:05,627 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:37:05,627 - DEBUG - Waiting to SSH to VM ctest-left_vm-35591030, IP 56.158.24.67, Port 22
2025-01-27 02:37:05,799 - DEBUG - VM ctest-left_vm-35591030 is ready for SSH connections
2025-01-27 02:37:05,799 - INFO - Waiting for VM ctest-right_vm-67796004 to be up..
2025-01-27 02:37:05,895 - DEBUG - VM is in ACTIVE state now
2025-01-27 02:37:05,895 - INFO - VM name : ctest-right_vm-67796004
2025-01-27 02:37:05,996 - DEBUG - VM ctest-right_vm-67796004 ID is 82b26871-c600-41d9-aae8-d46c9691bac1
2025-01-27 02:37:05,996 - DEBUG - VM ctest-right_vm-67796004 launched on Node an-jenkins-deploy-platform-ansible-os-2660-1
2025-01-27 02:37:06,093 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/82b26871-c600-41d9-aae8-d46c9691bac1
2025-01-27 02:37:06,106 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/9f192f9c-5e2b-450d-b3c9-219b4d443373
2025-01-27 02:37:07,320 - 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.49 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.447 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.447/1.969/3.492/1.522 ms')
2025-01-27 02:37:07,320 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-right_vm-67796004 passed
2025-01-27 02:37:07,440 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:37:07,440 - DEBUG - Waiting to SSH to VM ctest-right_vm-67796004, IP 146.32.242.131, Port 22
2025-01-27 02:37:07,616 - DEBUG - VM ctest-right_vm-67796004 is ready for SSH connections
2025-01-27 02:37:07,624 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362, 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-22543022:ctest-right_vn-63382439, 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-22543022:ctest-si-86829426'], 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]
2025-01-27 02:37:07,970 - INFO - Attaching policy ctest-policy-43788011 to vn ctest-left_vn-97803362
2025-01-27 02:37:08,387 - INFO - Attaching policy ctest-policy-43788011 to vn ctest-right_vn-63382439
2025-01-27 02:37:08,722 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-98047186'] created succesfully
2025-01-27 02:37:08,959 - DEBUG - Service instance: ['default-domain', 'ctest-TestSvcRegr-22543022', 'ctest-si-86829426'] created succesfully
2025-01-27 02:37:08,959 - DEBUG - Requesting: http://10.0.0.37:8082/domains
2025-01-27 02:37:08,973 - DEBUG - Requesting: http://10.0.0.37:8082/domain/9f6bcc6d-d9b0-4847-910a-1781c72618e1
2025-01-27 02:37:08,993 - DEBUG - Requesting: http://10.0.0.37:8082/project/c9eb16be-a19e-426f-9c00-e7d8636b2b63
2025-01-27 02:37:09,089 - DEBUG - Requesting: http://10.0.0.37:8082/service-instance/e8e8b34d-1cd3-4254-9319-bacbc4f9d762
2025-01-27 02:37:09,101 - DEBUG - SI 'ctest-si-86829426' has service template ref to ctest-service_template_1-98047186
2025-01-27 02:37:09,101 - DEBUG - Requesting: http://10.0.0.37:8082/domains
2025-01-27 02:37:09,109 - DEBUG - Requesting: http://10.0.0.37:8082/domain/9f6bcc6d-d9b0-4847-910a-1781c72618e1
2025-01-27 02:37:09,134 - DEBUG - Requesting: http://10.0.0.37:8082/project/c9eb16be-a19e-426f-9c00-e7d8636b2b63
2025-01-27 02:37:09,238 - DEBUG - Requesting: http://10.0.0.37:8082/service-instance/e8e8b34d-1cd3-4254-9319-bacbc4f9d762
2025-01-27 02:37:09,259 - DEBUG - Requesting: http://10.0.0.37:8082/port-tuple/88a1db75-779c-4f2e-9439-e2441e31129d
2025-01-27 02:37:09,274 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-machine-interface/01cf3ffc-713a-40c7-a6a6-45a09ede2a22
2025-01-27 02:37:09,303 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-machine-interface/4188c517-b199-45a1-b653-267bb0af07a7
2025-01-27 02:37:09,343 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-machine-interface/cfdf4ba4-234d-4b2c-a429-cfcd2f1d75fb
2025-01-27 02:37:09,648 - DEBUG - VM is in ACTIVE state now
2025-01-27 02:37:10,130 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/aba2b351-ca28-4dce-ae67-1a59be07e8c2
2025-01-27 02:37:10,140 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/01cf3ffc-713a-40c7-a6a6-45a09ede2a22
2025-01-27 02:37:10,153 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/4188c517-b199-45a1-b653-267bb0af07a7
2025-01-27 02:37:10,167 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/cfdf4ba4-234d-4b2c-a429-cfcd2f1d75fb
2025-01-27 02:37:10,179 - DEBUG - Requesting: http://10.0.0.22:8082/instance-ip/9e654699-db88-46ae-bfb7-9a86b35ff5e9
2025-01-27 02:37:10,188 - DEBUG - Requesting: http://10.0.0.22:8082/instance-ip/a602e6bc-c648-407e-8e88-ae2e730f32c3
2025-01-27 02:37:10,198 - DEBUG - Requesting: http://10.0.0.22:8082/instance-ip/c98c1e7c-d0b6-4353-9fce-cd3541ce1480
2025-01-27 02:37:10,206 - DEBUG - Requesting: http://10.0.0.22:8082/instance-ip/0584e560-139f-44bf-8b9e-2ed1c6ff46a0
2025-01-27 02:37:10,216 - DEBUG - Requesting: http://10.0.0.22:8082/instance-ip/77a00eed-d721-403e-be20-ae57849d8a72
2025-01-27 02:37:10,224 - DEBUG - Requesting: http://10.0.0.22:8082/instance-ip/fa48b199-25a3-40aa-b011-2495d9ff3bb6
2025-01-27 02:37:10,232 - DEBUG - Requesting: http://10.0.0.22:8082/instance-ip/1ef2e62c-673b-4e59-a4fa-ba95d288686f
2025-01-27 02:37:10,244 - DEBUG - Requesting: http://10.0.0.22:8082/instance-ip/565b5e7c-9602-44f9-ba5f-0c4a5c0247e0
2025-01-27 02:37:10,257 - DEBUG - Requesting: http://10.0.0.22:8082/instance-ip/61c13019-d8c1-4ce8-b1c5-e16e71b2502a
2025-01-27 02:37:10,724 - DEBUG - VM is in ACTIVE state now
2025-01-27 02:37:10,724 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/aba2b351-ca28-4dce-ae67-1a59be07e8c2
2025-01-27 02:37:10,733 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/01cf3ffc-713a-40c7-a6a6-45a09ede2a22
2025-01-27 02:37:10,743 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/4188c517-b199-45a1-b653-267bb0af07a7
2025-01-27 02:37:10,755 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/cfdf4ba4-234d-4b2c-a429-cfcd2f1d75fb
2025-01-27 02:37:12,270 - 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=1 ttl=63 time=2.87 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.911 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.911/1.892/2.874/0.981 ms')
2025-01-27 02:37:12,270 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-33060016 passed
2025-01-27 02:37:12,316 - DEBUG - VM ctest-pt_svm0-33060016 Tap interface: {'index': '5', 'name': 'tap4188c517-b1', 'uuid': '4188c517-b199-45a1-b653-267bb0af07a7', 'vrf_name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362:ctest-left_vn-97803362', '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': '8', 'vn_name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362', 'vm_uuid': 'aba2b351-ca28-4dce-ae67-1a59be07e8c2', 'vm_name': 'ctest-pt_svm0-33060016', 'ip_addr': '56.158.24.68', 'mac_addr': '02:41:88:c5:17:b1', '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-22543022:4188c517-b199-45a1-b653-267bb0af07a7', 'sg_uuid_list': ['6edc92b8-8330-4140-963b-48423e8bdcb7'], 'static_route_list': None, 'vm_project_uuid': 'c9eb16be-a19e-426f-9c00-e7d8636b2b63', 'admin_state': 'Enabled', 'flow_key_idx': '52', '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': '01cf3ffc-713a-40c7-a6a6-45a09ede2a22', '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': []}
2025-01-27 02:37:12,316 - DEBUG - Agent 10.0.0.43 vrf name: default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362:ctest-left_vn-97803362
2025-01-27 02:37:12,323 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362:ctest-left_vn-97803362', 'ucindex': '2', 'mcindex': '2', 'l2index': '2', 'source': 'Config; ', 'uc6index': '2', 'vn': 'default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362', 'table_label': '-1', 'vxlan_id': '8', 'evpnindex': '2', 'brindex': '2', 'mplsindex': '0', 'RD': '10.20.0.6:2', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]}
2025-01-27 02:37:12,466 - DEBUG - VM ctest-pt_svm0-33060016 : Tap interface tap4188c517-b1 is set to Active
2025-01-27 02:37:12,467 - DEBUG - Tap interface tap4188c517-b1 detail : {'index': '5', 'name': 'tap4188c517-b1', 'uuid': '4188c517-b199-45a1-b653-267bb0af07a7', 'vrf_name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362:ctest-left_vn-97803362', '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': '8', 'vn_name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362', 'vm_uuid': 'aba2b351-ca28-4dce-ae67-1a59be07e8c2', 'vm_name': 'ctest-pt_svm0-33060016', 'ip_addr': '56.158.24.68', 'mac_addr': '02:41:88:c5:17:b1', '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-22543022:4188c517-b199-45a1-b653-267bb0af07a7', 'sg_uuid_list': ['6edc92b8-8330-4140-963b-48423e8bdcb7'], 'static_route_list': None, 'vm_project_uuid': 'c9eb16be-a19e-426f-9c00-e7d8636b2b63', 'admin_state': 'Enabled', 'flow_key_idx': '52', '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': '01cf3ffc-713a-40c7-a6a6-45a09ede2a22', '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': []}
2025-01-27 02:37:12,627 - DEBUG - Starting Layer 2 verification in Agent
2025-01-27 02:37:12,642 - DEBUG - Layer 2 path is seen for VM MAC 02:41:88:c5:17:b1 in agent 10.0.0.43
2025-01-27 02:37:12,642 - DEBUG - Active layer 2 route in agent is present for VMI tap4188c517-b1
2025-01-27 02:37:12,642 - DEBUG - L2 label(43) matches bw route table and interface table
2025-01-27 02:37:12,657 - DEBUG - VN default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362 is found in Agent of node 10.0.0.43
2025-01-27 02:37:12,843 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362 is consistent in agent 10.0.0.43
2025-01-27 02:37:12,844 - DEBUG - Route for VM IP ['56.158.24.68'] is consistent in agent 10.0.0.43
2025-01-27 02:37:12,844 - DEBUG - VN default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362 verification for VM ctest-pt_svm0-33060016 in Agent 10.0.0.43 passed
2025-01-27 02:37:12,999 - DEBUG - Starting all layer 2 verification in agent 10.0.0.43
2025-01-27 02:37:13,015 - DEBUG - Route for VM MAC 02:41:88:c5:17:b1 is consistent in agent 10.0.0.43
2025-01-27 02:37:13,039 - DEBUG - VM ctest-pt_svm0-33060016 Tap interface: {'index': '4', 'name': 'tapcfdf4ba4-23', 'uuid': 'cfdf4ba4-234d-4b2c-a429-cfcd2f1d75fb', 'vrf_name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289:ctest-mgmt_vn-47169289', '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': '34', 'l2_label': '38', 'vxlan_id': '7', 'vn_name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289', 'vm_uuid': 'aba2b351-ca28-4dce-ae67-1a59be07e8c2', 'vm_name': 'ctest-pt_svm0-33060016', 'ip_addr': '192.216.11.131', 'mac_addr': '02:cf:df:4b:a4:23', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.4', 'service_vlan_list': None, 'os_ifindex': '27', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-22543022:cfdf4ba4-234d-4b2c-a429-cfcd2f1d75fb', 'sg_uuid_list': ['6edc92b8-8330-4140-963b-48423e8bdcb7'], 'static_route_list': None, 'vm_project_uuid': 'c9eb16be-a19e-426f-9c00-e7d8636b2b63', 'admin_state': 'Enabled', 'flow_key_idx': '45', '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': []}
2025-01-27 02:37:13,039 - DEBUG - Agent 10.0.0.43 vrf name: default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289:ctest-mgmt_vn-47169289
2025-01-27 02:37:13,047 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289:ctest-mgmt_vn-47169289', 'ucindex': '3', 'mcindex': '3', 'l2index': '3', 'source': 'Config; ', 'uc6index': '3', 'vn': 'default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289', 'table_label': '-1', 'vxlan_id': '7', 'evpnindex': '3', 'brindex': '3', 'mplsindex': '0', 'RD': '10.20.0.6:3', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]}
2025-01-27 02:37:13,171 - DEBUG - VM ctest-pt_svm0-33060016 : Tap interface tapcfdf4ba4-23 is set to Active
2025-01-27 02:37:13,171 - DEBUG - Tap interface tapcfdf4ba4-23 detail : {'index': '4', 'name': 'tapcfdf4ba4-23', 'uuid': 'cfdf4ba4-234d-4b2c-a429-cfcd2f1d75fb', 'vrf_name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289:ctest-mgmt_vn-47169289', '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': '34', 'l2_label': '38', 'vxlan_id': '7', 'vn_name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289', 'vm_uuid': 'aba2b351-ca28-4dce-ae67-1a59be07e8c2', 'vm_name': 'ctest-pt_svm0-33060016', 'ip_addr': '192.216.11.131', 'mac_addr': '02:cf:df:4b:a4:23', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.4', 'service_vlan_list': None, 'os_ifindex': '27', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-22543022:cfdf4ba4-234d-4b2c-a429-cfcd2f1d75fb', 'sg_uuid_list': ['6edc92b8-8330-4140-963b-48423e8bdcb7'], 'static_route_list': None, 'vm_project_uuid': 'c9eb16be-a19e-426f-9c00-e7d8636b2b63', 'admin_state': 'Enabled', 'flow_key_idx': '45', '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': []}
2025-01-27 02:37:13,335 - DEBUG - Starting Layer 2 verification in Agent
2025-01-27 02:37:13,348 - DEBUG - Layer 2 path is seen for VM MAC 02:cf:df:4b:a4:23 in agent 10.0.0.43
2025-01-27 02:37:13,348 - DEBUG - Active layer 2 route in agent is present for VMI tapcfdf4ba4-23
2025-01-27 02:37:13,348 - DEBUG - L2 label(38) matches bw route table and interface table
2025-01-27 02:37:13,364 - DEBUG - VN default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289 is found in Agent of node 10.0.0.43
2025-01-27 02:37:13,541 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289 is consistent in agent 10.0.0.43
2025-01-27 02:37:13,541 - DEBUG - Route for VM IP ['192.216.11.131'] is consistent in agent 10.0.0.43
2025-01-27 02:37:13,541 - DEBUG - VN default-domain:ctest-TestSvcRegr-22543022:ctest-mgmt_vn-47169289 verification for VM ctest-pt_svm0-33060016 in Agent 10.0.0.43 passed
2025-01-27 02:37:13,699 - DEBUG - Starting all layer 2 verification in agent 10.0.0.43
2025-01-27 02:37:13,713 - DEBUG - Route for VM MAC 02:cf:df:4b:a4:23 is consistent in agent 10.0.0.43
2025-01-27 02:37:13,736 - DEBUG - VM ctest-pt_svm0-33060016 Tap interface: {'index': '6', 'name': 'tap01cf3ffc-71', 'uuid': '01cf3ffc-713a-40c7-a6a6-45a09ede2a22', 'vrf_name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439:ctest-right_vn-63382439', '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': '9', 'vn_name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439', 'vm_uuid': 'aba2b351-ca28-4dce-ae67-1a59be07e8c2', 'vm_name': 'ctest-pt_svm0-33060016', 'ip_addr': '146.32.242.132', 'mac_addr': '02:01:cf:3f:fc:71', '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-22543022:01cf3ffc-713a-40c7-a6a6-45a09ede2a22', 'sg_uuid_list': ['6edc92b8-8330-4140-963b-48423e8bdcb7'], 'static_route_list': None, 'vm_project_uuid': 'c9eb16be-a19e-426f-9c00-e7d8636b2b63', 'admin_state': 'Enabled', 'flow_key_idx': '58', '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': '4188c517-b199-45a1-b653-267bb0af07a7', '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': []}
2025-01-27 02:37:13,736 - DEBUG - Agent 10.0.0.43 vrf name: default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439:ctest-right_vn-63382439
2025-01-27 02:37:13,742 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439:ctest-right_vn-63382439', 'ucindex': '4', 'mcindex': '4', 'l2index': '4', 'source': 'Config; ', 'uc6index': '4', 'vn': 'default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439', 'table_label': '-1', 'vxlan_id': '9', 'evpnindex': '4', 'brindex': '4', 'mplsindex': '0', 'RD': '10.20.0.6:4', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]}
2025-01-27 02:37:13,877 - DEBUG - VM ctest-pt_svm0-33060016 : Tap interface tap01cf3ffc-71 is set to Active
2025-01-27 02:37:13,879 - DEBUG - Tap interface tap01cf3ffc-71 detail : {'index': '6', 'name': 'tap01cf3ffc-71', 'uuid': '01cf3ffc-713a-40c7-a6a6-45a09ede2a22', 'vrf_name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439:ctest-right_vn-63382439', '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': '9', 'vn_name': 'default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439', 'vm_uuid': 'aba2b351-ca28-4dce-ae67-1a59be07e8c2', 'vm_name': 'ctest-pt_svm0-33060016', 'ip_addr': '146.32.242.132', 'mac_addr': '02:01:cf:3f:fc:71', '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-22543022:01cf3ffc-713a-40c7-a6a6-45a09ede2a22', 'sg_uuid_list': ['6edc92b8-8330-4140-963b-48423e8bdcb7'], 'static_route_list': None, 'vm_project_uuid': 'c9eb16be-a19e-426f-9c00-e7d8636b2b63', 'admin_state': 'Enabled', 'flow_key_idx': '58', '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': '4188c517-b199-45a1-b653-267bb0af07a7', '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': []}
2025-01-27 02:37:14,039 - DEBUG - Starting Layer 2 verification in Agent
2025-01-27 02:37:14,055 - DEBUG - Layer 2 path is seen for VM MAC 02:01:cf:3f:fc:71 in agent 10.0.0.43
2025-01-27 02:37:14,055 - DEBUG - Active layer 2 route in agent is present for VMI tap01cf3ffc-71
2025-01-27 02:37:14,055 - DEBUG - L2 label(48) matches bw route table and interface table
2025-01-27 02:37:14,062 - DEBUG - VN default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439 is found in Agent of node 10.0.0.50
2025-01-27 02:37:14,240 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439 is consistent in agent 10.0.0.50
2025-01-27 02:37:14,241 - DEBUG - Route for VM IP ['146.32.242.132'] is consistent in agent 10.0.0.50
2025-01-27 02:37:14,241 - DEBUG - VN default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439 verification for VM ctest-pt_svm0-33060016 in Agent 10.0.0.50 passed
2025-01-27 02:37:14,395 - DEBUG - Starting all layer 2 verification in agent 10.0.0.50
2025-01-27 02:37:14,409 - DEBUG - Route for VM MAC 02:01:cf:3f:fc:71 is consistent in agent 10.0.0.50
2025-01-27 02:37:14,417 - DEBUG - VN default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439 is found in Agent of node 10.0.0.43
2025-01-27 02:37:14,605 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439 is consistent in agent 10.0.0.43
2025-01-27 02:37:14,606 - DEBUG - Route for VM IP ['146.32.242.132'] is consistent in agent 10.0.0.43
2025-01-27 02:37:14,606 - DEBUG - VN default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439 verification for VM ctest-pt_svm0-33060016 in Agent 10.0.0.43 passed
2025-01-27 02:37:14,764 - DEBUG - Starting all layer 2 verification in agent 10.0.0.43
2025-01-27 02:37:14,779 - DEBUG - Route for VM MAC 02:01:cf:3f:fc:71 is consistent in agent 10.0.0.43
2025-01-27 02:37:14,779 - INFO - VM ctest-pt_svm0-33060016 verifications in Compute nodes passed
2025-01-27 02:37:14,779 - DEBUG - The SVMs in the SI are : []
2025-01-27 02:37:14,779 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-machine/aba2b351-ca28-4dce-ae67-1a59be07e8c2
2025-01-27 02:37:14,790 - DEBUG - Service VM for SI 'ctest-si-86829426' is launched
2025-01-27 02:37:14,790 - DEBUG - Requesting: http://10.0.0.37:8082/domains
2025-01-27 02:37:14,796 - DEBUG - Requesting: http://10.0.0.37:8082/domain/9f6bcc6d-d9b0-4847-910a-1781c72618e1
2025-01-27 02:37:14,807 - DEBUG - Requesting: http://10.0.0.37:8082/project/c9eb16be-a19e-426f-9c00-e7d8636b2b63
2025-01-27 02:37:14,905 - DEBUG - Requesting: http://10.0.0.37:8082/service-instance/e8e8b34d-1cd3-4254-9319-bacbc4f9d762
2025-01-27 02:37:14,916 - DEBUG - SI ctest-si-86829426 has Port Tuple: ['ctest-port_tuple-10262075']
2025-01-27 02:37:14,935 - INFO - VMI and/or RI refs are present for VN default-domain:ctest-TestSvcRegr-22543022:ctest-left_vn-97803362
2025-01-27 02:37:14,999 - INFO - VMI and/or RI refs are present for VN default-domain:ctest-TestSvcRegr-22543022:ctest-right_vn-63382439
2025-01-27 02:37:15,075 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:37:15,089 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:37:15,090 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:37:15,096 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:37:15,097 - INFO - Route to 146.32.242.131 seen in VRF:5 on an-jenkins-deploy-platform-ansible-os-2660-2, and SI ctest-si-86829426 is seen as the NH
2025-01-27 02:37:15,176 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:37:15,189 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:37:15,189 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:37:15,197 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:37:15,197 - INFO - Route to 56.158.24.67 seen in VRF:6 on an-jenkins-deploy-platform-ansible-os-2660-2, and SI ctest-si-86829426 is seen as the NH
2025-01-27 02:37:15,197 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:37:15,197 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-27 02:37:15,197 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 146.32.242.131, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.43, gateway password: c0ntrail123
2025-01-27 02:37:15,197 - DEBUG - ping -s 56 -c 3 -W 1 146.32.242.131
2025-01-27 02:37:19,193 - DEBUG - PING 146.32.242.131 (146.32.242.131): 56 data bytes
64 bytes from 146.32.242.131: seq=0 ttl=61 time=11.726 ms
64 bytes from 146.32.242.131: seq=1 ttl=61 time=2.449 ms
64 bytes from 146.32.242.131: seq=2 ttl=61 time=2.724 ms
--- 146.32.242.131 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 2.449/5.633/11.726 ms
2025-01-27 02:37:19,193 - INFO - Ping to IP 146.32.242.131 from VM ctest-left_vm-35591030 passed
2025-01-27 02:37:19,193 - INFO - Dettaching policy ctest-policy-43788011 from vn ctest-right_vn-63382439
2025-01-27 02:37:19,438 - INFO - Dettaching policy ctest-policy-43788011 from vn ctest-left_vn-97803362
2025-01-27 02:37:19,741 - INFO - Deleted policy ctest-policy-43788011
2025-01-27 02:37:19,742 - DEBUG - Deleting service instance: ['default-domain', 'ctest-TestSvcRegr-22543022', 'ctest-si-86829426']
2025-01-27 02:37:19,908 - INFO - Deleted SI ['default-domain', 'ctest-TestSvcRegr-22543022', 'ctest-si-86829426']
2025-01-27 02:37:19,908 - DEBUG - Requesting: http://10.0.0.37:8082/domains
2025-01-27 02:37:19,916 - DEBUG - Requesting: http://10.0.0.37:8082/domain/9f6bcc6d-d9b0-4847-910a-1781c72618e1
2025-01-27 02:37:19,930 - DEBUG - Requesting: http://10.0.0.37:8082/project/c9eb16be-a19e-426f-9c00-e7d8636b2b63
2025-01-27 02:37:20,029 - DEBUG - Service instance ctest-si-86829426 removed from api server
2025-01-27 02:37:20,029 - DEBUG - Requesting: http://10.0.0.37:8082/virtual-machine/aba2b351-ca28-4dce-ae67-1a59be07e8c2
2025-01-27 02:37:20,046 - DEBUG - All Service VMs unlinked from SI ctest-si-86829426
2025-01-27 02:37:20,053 - DEBUG - 0 svc intances found in all projects. They are []
2025-01-27 02:37:20,053 - DEBUG - 0 svc intances found in current project. They are []
2025-01-27 02:37:20,102 - DEBUG - 0 svc intances found in all projects. They are []
2025-01-27 02:37:20,102 - DEBUG - 0 svc intances found in current project. They are []
2025-01-27 02:37:20,102 - INFO - Deleting VM ctest-pt_svm0-33060016
2025-01-27 02:37:20,222 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-98047186']
2025-01-27 02:37:20,362 - INFO - Service template: ['default-domain', 'ctest-service_template_1-98047186'] deleted successfully.
2025-01-27 02:37:20,362 - INFO - Deleting VM ctest-right_vm-67796004
2025-01-27 02:37:20,476 - INFO - Deleting VM ctest-left_vm-35591030
2025-01-27 02:37:20,579 - INFO - Deleting VN ctest-right_vn-63382439
2025-01-27 02:37:20,646 - DEBUG - VN b2e6f8c6-7576-4e94-ad93-df3942c6abc5 still in use: Unable to complete operation on network b2e6f8c6-7576-4e94-ad93-df3942c6abc5. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-4d5af4c2-d7e3-4b2e-bb71-bda7601523eb']
2025-01-27 02:37:20,646 - WARNING - Deleting VN ctest-right_vn-63382439 failed..Will retry
2025-01-27 02:37:22,834 - DEBUG - Response for deleting network ()
2025-01-27 02:37:22,834 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/a15e0bbd-536c-4523-86a6-ffaa61fe1905
2025-01-27 02:37:22,846 - DEBUG - Response Code: 404
2025-01-27 02:37:22,846 - DEBUG - Requesting: http://10.0.0.37:8082/domains
2025-01-27 02:37:22,854 - DEBUG - Requesting: http://10.0.0.37:8082/domain/9f6bcc6d-d9b0-4847-910a-1781c72618e1
2025-01-27 02:37:22,881 - DEBUG - Requesting: http://10.0.0.37:8082/project/c9eb16be-a19e-426f-9c00-e7d8636b2b63
2025-01-27 02:37:22,980 - INFO - Validated that VN ctest-right_vn-63382439 is not found in API Server
2025-01-27 02:37:22,995 - DEBUG - VN ctest-right_vn-63382439 is not present in Agent 10.0.0.50
2025-01-27 02:37:23,013 - DEBUG - VN ctest-right_vn-63382439 is not present in Agent 10.0.0.43
2025-01-27 02:37:23,013 - INFO - Validated that VN ctest-right_vn-63382439 is not in any agent
2025-01-27 02:37:23,053 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-63382439 info
2025-01-27 02:37:23,053 - INFO - Deleting VN ctest-left_vn-97803362
2025-01-27 02:37:23,242 - DEBUG - Response for deleting network ()
2025-01-27 02:37:23,242 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/795cd071-ea08-454f-b195-0861479fbafc
2025-01-27 02:37:23,250 - DEBUG - Response Code: 404
2025-01-27 02:37:23,250 - DEBUG - Requesting: http://10.0.0.37:8082/domains
2025-01-27 02:37:23,262 - DEBUG - Requesting: http://10.0.0.37:8082/domain/9f6bcc6d-d9b0-4847-910a-1781c72618e1
2025-01-27 02:37:23,286 - DEBUG - Requesting: http://10.0.0.37:8082/project/c9eb16be-a19e-426f-9c00-e7d8636b2b63
2025-01-27 02:37:23,407 - INFO - Validated that VN ctest-left_vn-97803362 is not found in API Server
2025-01-27 02:37:23,421 - DEBUG - VN ctest-left_vn-97803362 is not present in Agent 10.0.0.50
2025-01-27 02:37:23,433 - DEBUG - VN ctest-left_vn-97803362 is not present in Agent 10.0.0.43
2025-01-27 02:37:23,433 - INFO - Validated that VN ctest-left_vn-97803362 is not in any agent
2025-01-27 02:37:23,474 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-97803362 info
2025-01-27 02:37:23,474 - INFO - Deleting VN ctest-mgmt_vn-47169289
2025-01-27 02:37:23,664 - DEBUG - Response for deleting network ()
2025-01-27 02:37:23,664 - DEBUG - Requesting: http://10.0.0.37:8082/routing-instance/29dc47cc-0571-42d3-9660-eb517160a8d2
2025-01-27 02:37:23,671 - DEBUG - Response Code: 404
2025-01-27 02:37:23,671 - DEBUG - Requesting: http://10.0.0.37:8082/domains
2025-01-27 02:37:23,681 - DEBUG - Requesting: http://10.0.0.37:8082/domain/9f6bcc6d-d9b0-4847-910a-1781c72618e1
2025-01-27 02:37:23,767 - DEBUG - Requesting: http://10.0.0.37:8082/project/c9eb16be-a19e-426f-9c00-e7d8636b2b63
2025-01-27 02:37:23,873 - INFO - Validated that VN ctest-mgmt_vn-47169289 is not found in API Server
2025-01-27 02:37:23,888 - DEBUG - VN ctest-mgmt_vn-47169289 is not present in Agent 10.0.0.50
2025-01-27 02:37:23,908 - DEBUG - VN ctest-mgmt_vn-47169289 is not present in Agent 10.0.0.43
2025-01-27 02:37:23,908 - INFO - Validated that VN ctest-mgmt_vn-47169289 is not in any agent
2025-01-27 02:37:23,949 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-47169289 info
2025-01-27 02:37:25,269 - DEBUG - No XMPP flaps were noticed during the test
2025-01-27 02:37:25,269 - INFO -
2025-01-27 02:37:25,269 - INFO - END TEST : test_svc_in_network_datapath : PASSED[0:01:27]
2025-01-27 02:37:25,269 - INFO - --------------------------------------------------------------------------------
2025-01-27 02:37:26,032 - INFO - Deleted project: ctest-TestSvcRegr-22543022, ID : c9eb16be-a19e-426f-9c00-e7d8636b2b63