2026-02-11 13:12:29,589 - INFO - Domain Default found not creating
2026-02-11 13:12:29,741 - INFO - Project ctest-TestSvcRegr-05892892 not found, creating it
2026-02-11 13:12:30,194 - INFO - Created Project:ctest-TestSvcRegr-05892892, ID : ffd4bd27-04e2-4241-afc1-1bf6cf399fe5
2026-02-11 13:12:31,680 - INFO - ================================================================================
2026-02-11 13:12:31,681 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-02-11 13:12:31,951 - DEBUG - Nothing to compare xmpp stats {'10.0.0.249': {'10.20.0.14': '0'}} with
2026-02-11 13:12:31,951 - INFO - Initial checks done. Running the testcase now
2026-02-11 13:12:31,951 - INFO -
2026-02-11 13:12:32,495 - DEBUG - Response for create_network : {'network': {'id': 'c82d7357-287d-4bd2-ad66-0885a8be09f7', 'name': 'ctest-mgmt_vn-82792426', 'tenant_id': 'ffd4bd2704e24241afc11bf6cf399fe5', 'project_id': 'ffd4bd2704e24241afc11bf6cf399fe5', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-05892892', 'ctest-mgmt_vn-82792426'], 'port_security_enabled': True, 'description': ''}}
2026-02-11 13:12:32,678 - DEBUG - Response for create_subnet : {'subnet': {'id': '6a60bebe-8560-4ac4-95ef-323d8f80bc35', 'name': '', 'tenant_id': 'ffd4bd2704e24241afc11bf6cf399fe5', 'network_id': 'c82d7357-287d-4bd2-ad66-0885a8be09f7', 'ip_version': 4, 'cidr': '3.238.123.0/26', 'allocation_pools': [{'start': '3.238.123.2', 'end': '3.238.123.62'}], 'gateway_ip': '3.238.123.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '3.238.123.2', 'tags': [], 'project_id': 'ffd4bd2704e24241afc11bf6cf399fe5'}}
2026-02-11 13:12:32,704 - INFO - Created VN ctest-mgmt_vn-82792426
2026-02-11 13:12:32,759 - DEBUG - VN ctest-mgmt_vn-82792426 UUID is c82d7357-287d-4bd2-ad66-0885a8be09f7
2026-02-11 13:12:32,863 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2026-02-11 13:12:33,159 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2026-02-11 13:12:33,191 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3f35fa34-8928-44db-8bf6-346c4525ac92
2026-02-11 13:12:33,206 - DEBUG - Requesting: http://10.0.0.249:8082/project/ffd4bd27-04e2-4241-afc1-1bf6cf399fe5
2026-02-11 13:12:33,281 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/c82d7357-287d-4bd2-ad66-0885a8be09f7
2026-02-11 13:12:33,292 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/c82d7357-287d-4bd2-ad66-0885a8be09f7
2026-02-11 13:12:33,301 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b586e9e1-209f-4352-aa96-a195dd6f6648
2026-02-11 13:12:33,307 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b586e9e1-209f-4352-aa96-a195dd6f6648
2026-02-11 13:12:33,313 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/4a8aba9a-ad41-4b47-801a-7c1f0af9095b
2026-02-11 13:12:33,319 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-11 13:12:33,319 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/c82d7357-287d-4bd2-ad66-0885a8be09f7
2026-02-11 13:12:33,327 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b586e9e1-209f-4352-aa96-a195dd6f6648
2026-02-11 13:12:33,339 - INFO - Verified VN network id 11 for VN c82d7357-287d-4bd2-ad66-0885a8be09f7
2026-02-11 13:12:33,339 - INFO - Verifications in API Server for VN ctest-mgmt_vn-82792426 passed
2026-02-11 13:12:33,339 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/c82d7357-287d-4bd2-ad66-0885a8be09f7
2026-02-11 13:12:33,347 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b586e9e1-209f-4352-aa96-a195dd6f6648
2026-02-11 13:12:33,353 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b586e9e1-209f-4352-aa96-a195dd6f6648
2026-02-11 13:12:33,358 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/4a8aba9a-ad41-4b47-801a-7c1f0af9095b
2026-02-11 13:12:33,368 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-05892892', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14424311999716215762', 'uuid-lslong': '12494683586340719095'}, 'enable': 'true', 'created': '2026-02-11T13:12:32', 'last-modified': '2026-02-11T13:12:32', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.733941'}
2026-02-11 13:12:33,375 - DEBUG - Route Targets: ['target:64512:8000004']
2026-02-11 13:12:33,375 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-82792426 passed
2026-02-11 13:12:33,375 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-82792426 in API_Server ======
2026-02-11 13:12:33,375 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2026-02-11 13:12:33,380 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3f35fa34-8928-44db-8bf6-346c4525ac92
2026-02-11 13:12:33,390 - DEBUG - Requesting: http://10.0.0.249:8082/project/ffd4bd27-04e2-4241-afc1-1bf6cf399fe5
2026-02-11 13:12:33,461 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/c82d7357-287d-4bd2-ad66-0885a8be09f7
2026-02-11 13:12:33,469 - DEBUG - =>VN ctest-mgmt_vn-82792426 has no policy to be verified
2026-02-11 13:12:33,469 - DEBUG - Verifying the vn in opserver
2026-02-11 13:12:33,469 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426 virtual network link through opserver 10.0.0.249
2026-02-11 13:12:33,470 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-02-11 13:12:33,770 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-02-11 13:12:33,828 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426?flat'}
2026-02-11 13:12:33,828 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426 is found in opserver
2026-02-11 13:12:33,837 - DEBUG - Do not have enough data to verify VN in agent
2026-02-11 13:12:33,841 - DEBUG - VRF ids for VN ctest-mgmt_vn-82792426: {}
2026-02-11 13:12:34,011 - DEBUG - Response for create_network : {'network': {'id': '90860ec4-a768-4618-8cca-a96a04cfd26a', 'name': 'ctest-left_vn-44614594', 'tenant_id': 'ffd4bd2704e24241afc11bf6cf399fe5', 'project_id': 'ffd4bd2704e24241afc11bf6cf399fe5', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-05892892', 'ctest-left_vn-44614594'], 'port_security_enabled': True, 'description': ''}}
2026-02-11 13:12:34,186 - DEBUG - Response for create_subnet : {'subnet': {'id': 'dbe9fc92-a6ce-4318-9ee6-bdea4adfa8ca', 'name': '', 'tenant_id': 'ffd4bd2704e24241afc11bf6cf399fe5', 'network_id': '90860ec4-a768-4618-8cca-a96a04cfd26a', 'ip_version': 4, 'cidr': '158.5.96.128/26', 'allocation_pools': [{'start': '158.5.96.130', 'end': '158.5.96.190'}], 'gateway_ip': '158.5.96.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '158.5.96.130', 'tags': [], 'project_id': 'ffd4bd2704e24241afc11bf6cf399fe5'}}
2026-02-11 13:12:34,204 - INFO - Created VN ctest-left_vn-44614594
2026-02-11 13:12:34,255 - DEBUG - VN ctest-left_vn-44614594 UUID is 90860ec4-a768-4618-8cca-a96a04cfd26a
2026-02-11 13:12:34,362 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2026-02-11 13:12:34,367 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3f35fa34-8928-44db-8bf6-346c4525ac92
2026-02-11 13:12:34,377 - DEBUG - Requesting: http://10.0.0.249:8082/project/ffd4bd27-04e2-4241-afc1-1bf6cf399fe5
2026-02-11 13:12:34,443 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/90860ec4-a768-4618-8cca-a96a04cfd26a
2026-02-11 13:12:34,452 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/90860ec4-a768-4618-8cca-a96a04cfd26a
2026-02-11 13:12:34,463 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/75d2648f-f9ef-4609-bbb9-00457aba1a5a
2026-02-11 13:12:34,470 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/75d2648f-f9ef-4609-bbb9-00457aba1a5a
2026-02-11 13:12:34,476 - DEBUG - Route Targets: []
2026-02-11 13:12:34,477 - DEBUG - RT names not yet present for VN ctest-left_vn-44614594
2026-02-11 13:12:39,478 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2026-02-11 13:12:39,485 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3f35fa34-8928-44db-8bf6-346c4525ac92
2026-02-11 13:12:39,497 - DEBUG - Requesting: http://10.0.0.249:8082/project/ffd4bd27-04e2-4241-afc1-1bf6cf399fe5
2026-02-11 13:12:39,574 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/90860ec4-a768-4618-8cca-a96a04cfd26a
2026-02-11 13:12:39,585 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/90860ec4-a768-4618-8cca-a96a04cfd26a
2026-02-11 13:12:39,595 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/75d2648f-f9ef-4609-bbb9-00457aba1a5a
2026-02-11 13:12:39,603 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/75d2648f-f9ef-4609-bbb9-00457aba1a5a
2026-02-11 13:12:39,610 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/7704b951-78b2-40d8-9457-963b2948a764
2026-02-11 13:12:39,617 - DEBUG - Route Targets: ['target:64512:8000005']
2026-02-11 13:12:39,617 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/90860ec4-a768-4618-8cca-a96a04cfd26a
2026-02-11 13:12:39,626 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/75d2648f-f9ef-4609-bbb9-00457aba1a5a
2026-02-11 13:12:39,647 - INFO - Verified VN network id 12 for VN 90860ec4-a768-4618-8cca-a96a04cfd26a
2026-02-11 13:12:39,647 - INFO - Verifications in API Server for VN ctest-left_vn-44614594 passed
2026-02-11 13:12:39,648 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/90860ec4-a768-4618-8cca-a96a04cfd26a
2026-02-11 13:12:39,662 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/75d2648f-f9ef-4609-bbb9-00457aba1a5a
2026-02-11 13:12:39,670 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/75d2648f-f9ef-4609-bbb9-00457aba1a5a
2026-02-11 13:12:39,679 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/7704b951-78b2-40d8-9457-963b2948a764
2026-02-11 13:12:39,691 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-05892892:ctest-left_vn-44614594', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-05892892', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10414027426125858328', 'uuid-lslong': '10145107383417819754'}, 'enable': 'true', 'created': '2026-02-11T13:12:33', 'last-modified': '2026-02-11T13:12:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:05.538079'}
2026-02-11 13:12:39,696 - DEBUG - Route Targets: ['target:64512:8000005']
2026-02-11 13:12:39,696 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-44614594 passed
2026-02-11 13:12:39,697 - DEBUG - ====Verifying policy data for ctest-left_vn-44614594 in API_Server ======
2026-02-11 13:12:39,697 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2026-02-11 13:12:39,702 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3f35fa34-8928-44db-8bf6-346c4525ac92
2026-02-11 13:12:39,711 - DEBUG - Requesting: http://10.0.0.249:8082/project/ffd4bd27-04e2-4241-afc1-1bf6cf399fe5
2026-02-11 13:12:39,779 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/90860ec4-a768-4618-8cca-a96a04cfd26a
2026-02-11 13:12:39,788 - DEBUG - =>VN ctest-left_vn-44614594 has no policy to be verified
2026-02-11 13:12:39,788 - DEBUG - Verifying the vn in opserver
2026-02-11 13:12:39,788 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-05892892:ctest-left_vn-44614594 virtual network link through opserver 10.0.0.249
2026-02-11 13:12:39,788 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-02-11 13:12:39,799 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-left_vn-44614594', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-05892892:ctest-left_vn-44614594?flat'}
2026-02-11 13:12:39,799 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-05892892:ctest-left_vn-44614594 is found in opserver
2026-02-11 13:12:39,809 - DEBUG - Do not have enough data to verify VN in agent
2026-02-11 13:12:39,813 - DEBUG - VRF ids for VN ctest-left_vn-44614594: {}
2026-02-11 13:12:39,976 - DEBUG - Response for create_network : {'network': {'id': '067b37e2-9ab0-47d0-8e32-c5fb91efbe35', 'name': 'ctest-right_vn-06355912', 'tenant_id': 'ffd4bd2704e24241afc11bf6cf399fe5', 'project_id': 'ffd4bd2704e24241afc11bf6cf399fe5', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-05892892', 'ctest-right_vn-06355912'], 'port_security_enabled': True, 'description': ''}}
2026-02-11 13:12:40,148 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e77ff4a4-bd46-479f-90ae-54c3d822eabe', 'name': '', 'tenant_id': 'ffd4bd2704e24241afc11bf6cf399fe5', 'network_id': '067b37e2-9ab0-47d0-8e32-c5fb91efbe35', 'ip_version': 4, 'cidr': '75.24.212.0/26', 'allocation_pools': [{'start': '75.24.212.2', 'end': '75.24.212.62'}], 'gateway_ip': '75.24.212.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '75.24.212.2', 'tags': [], 'project_id': 'ffd4bd2704e24241afc11bf6cf399fe5'}}
2026-02-11 13:12:40,165 - INFO - Created VN ctest-right_vn-06355912
2026-02-11 13:12:40,219 - DEBUG - VN ctest-right_vn-06355912 UUID is 067b37e2-9ab0-47d0-8e32-c5fb91efbe35
2026-02-11 13:12:40,338 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2026-02-11 13:12:40,344 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3f35fa34-8928-44db-8bf6-346c4525ac92
2026-02-11 13:12:40,355 - DEBUG - Requesting: http://10.0.0.249:8082/project/ffd4bd27-04e2-4241-afc1-1bf6cf399fe5
2026-02-11 13:12:40,423 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/067b37e2-9ab0-47d0-8e32-c5fb91efbe35
2026-02-11 13:12:40,433 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/067b37e2-9ab0-47d0-8e32-c5fb91efbe35
2026-02-11 13:12:40,441 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/79e84c6d-a85a-4630-9eee-38ec61bd1ec2
2026-02-11 13:12:40,448 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/79e84c6d-a85a-4630-9eee-38ec61bd1ec2
2026-02-11 13:12:40,456 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/4c805295-0491-4cb3-8fc6-7e59359e7bb3
2026-02-11 13:12:40,463 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-11 13:12:40,463 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/067b37e2-9ab0-47d0-8e32-c5fb91efbe35
2026-02-11 13:12:40,472 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/79e84c6d-a85a-4630-9eee-38ec61bd1ec2
2026-02-11 13:12:40,489 - INFO - Verified VN network id 13 for VN 067b37e2-9ab0-47d0-8e32-c5fb91efbe35
2026-02-11 13:12:40,490 - INFO - Verifications in API Server for VN ctest-right_vn-06355912 passed
2026-02-11 13:12:40,490 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/067b37e2-9ab0-47d0-8e32-c5fb91efbe35
2026-02-11 13:12:40,498 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/79e84c6d-a85a-4630-9eee-38ec61bd1ec2
2026-02-11 13:12:40,505 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/79e84c6d-a85a-4630-9eee-38ec61bd1ec2
2026-02-11 13:12:40,513 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/4c805295-0491-4cb3-8fc6-7e59359e7bb3
2026-02-11 13:12:40,525 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-05892892:ctest-right_vn-06355912', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-05892892', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '467028432760358864', 'uuid-lslong': '10246469786497170997'}, 'enable': 'true', 'created': '2026-02-11T13:12:39', 'last-modified': '2026-02-11T13:12:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.413939'}
2026-02-11 13:12:40,530 - DEBUG - Route Targets: ['target:64512:8000006']
2026-02-11 13:12:40,530 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-06355912 passed
2026-02-11 13:12:40,530 - DEBUG - ====Verifying policy data for ctest-right_vn-06355912 in API_Server ======
2026-02-11 13:12:40,530 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2026-02-11 13:12:40,535 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3f35fa34-8928-44db-8bf6-346c4525ac92
2026-02-11 13:12:40,546 - DEBUG - Requesting: http://10.0.0.249:8082/project/ffd4bd27-04e2-4241-afc1-1bf6cf399fe5
2026-02-11 13:12:40,622 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/067b37e2-9ab0-47d0-8e32-c5fb91efbe35
2026-02-11 13:12:40,631 - DEBUG - =>VN ctest-right_vn-06355912 has no policy to be verified
2026-02-11 13:12:40,631 - DEBUG - Verifying the vn in opserver
2026-02-11 13:12:40,631 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-05892892:ctest-right_vn-06355912 virtual network link through opserver 10.0.0.249
2026-02-11 13:12:40,631 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-02-11 13:12:40,640 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-right_vn-06355912', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-05892892:ctest-right_vn-06355912?flat'}
2026-02-11 13:12:40,640 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-05892892:ctest-right_vn-06355912 is found in opserver
2026-02-11 13:12:40,649 - DEBUG - Do not have enough data to verify VN in agent
2026-02-11 13:12:40,654 - DEBUG - VRF ids for VN ctest-right_vn-06355912: {}
2026-02-11 13:12:40,726 - DEBUG - Services list from nova: [, , ]
2026-02-11 13:12:41,752 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5291-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5291-1)
2026-02-11 13:12:42,934 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5291-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5291-1)
2026-02-11 13:12:42,934 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-02328200']
2026-02-11 13:12:43,303 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-02328200'] created succesfully
2026-02-11 13:12:43,649 - DEBUG - Image by name cirros_in_net not found
2026-02-11 13:12:43,649 - DEBUG - Installing image cirros_in_net
2026-02-11 13:12:43,650 - 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'}
2026-02-11 13:12:43,650 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/converts//cirros-in-net.vmdk.gz
2026-02-11 13:12:43,650 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/converts//cirros-in-net.vmdk.gz
2026-02-11 13:12:43,667 - 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
2026-02-11 13:12:43,790 - DEBUG - Image has been downloaded to /contrail-test/images/cirros-in-net.vmdk.gz
2026-02-11 13:12:43,790 - DEBUG - Unzip image
2026-02-11 13:12:43,790 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/cirros-in-net.vmdk.gz
2026-02-11 13:12:43,936 - DEBUG - Try to create image in user context
2026-02-11 13:12:44,184 - DEBUG - Image has been created in user context
2026-02-11 13:12:44,184 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: rm -f /contrail-test/images/cirros-in-net.vmdk
2026-02-11 13:12:44,203 - DEBUG - Downloaded image has been removed
2026-02-11 13:12:44,221 - DEBUG - Uploaded image status = active
2026-02-11 13:12:45,292 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5291-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5291-1)
2026-02-11 13:12:45,292 - INFO - Waiting for VM ctest-pt_svm0-93278574 to be up..
2026-02-11 13:12:45,328 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-02-11 13:12:50,409 - DEBUG - VM is in ACTIVE state now
2026-02-11 13:12:50,409 - INFO - VM name : ctest-pt_svm0-93278574
2026-02-11 13:12:50,498 - DEBUG - VM ctest-pt_svm0-93278574 ID is 7a302da3-624c-433b-9644-595388683689
2026-02-11 13:12:50,524 - DEBUG - VM ctest-pt_svm0-93278574 launched on Node cn-jenkins-deploy-platform-ansible-os-5291-1
2026-02-11 13:12:50,765 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/7a302da3-624c-433b-9644-595388683689
2026-02-11 13:12:50,773 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/1ec4aa4f-159a-4c69-9c4f-dbc34611f649
2026-02-11 13:12:50,781 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/a33dc1ee-d974-407a-81ed-a5fd812a2057
2026-02-11 13:12:50,789 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/dac8ccd9-3cef-47e3-8c70-4956a7d00e69
2026-02-11 13:12:54,080 - 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 1027ms')
2026-02-11 13:12:54,080 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-93278574 failed!
2026-02-11 13:12:54,135 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426 is 3.238.123.1 and allocation pool is NOT set
2026-02-11 13:12:58,205 - 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 1011ms')
2026-02-11 13:12:58,205 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-93278574 failed!
2026-02-11 13:12:58,259 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426 is 3.238.123.1 and allocation pool is NOT set
2026-02-11 13:13:02,335 - 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 1020ms')
2026-02-11 13:13:02,335 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-93278574 failed!
2026-02-11 13:13:02,391 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426 is 3.238.123.1 and allocation pool is NOT set
2026-02-11 13:13:06,456 - 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=11.6 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1010ms\r\nrtt min/avg/max/mdev = 11.583/11.583/11.583/0.000 ms')
2026-02-11 13:13:06,456 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-93278574 passed
2026-02-11 13:13:06,615 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:06,615 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-93278574, IP 3.238.123.3, Port 22
2026-02-11 13:13:06,680 - 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': ''}
2026-02-11 13:13:06,765 - DEBUG - VM ctest-pt_svm0-93278574 is NOT ready for SSH connections, VM status: ACTIVE
2026-02-11 13:13:11,765 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:11,766 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-93278574, IP 3.238.123.3, Port 22
2026-02-11 13:13:11,822 - 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': ''}
2026-02-11 13:13:11,901 - DEBUG - VM ctest-pt_svm0-93278574 is NOT ready for SSH connections, VM status: ACTIVE
2026-02-11 13:13:16,902 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:16,902 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-93278574, IP 3.238.123.3, Port 22
2026-02-11 13:13:16,958 - 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': ''}
2026-02-11 13:13:17,041 - DEBUG - VM ctest-pt_svm0-93278574 is NOT ready for SSH connections, VM status: ACTIVE
2026-02-11 13:13:22,042 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:22,042 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-93278574, IP 3.238.123.3, Port 22
2026-02-11 13:13:22,098 - 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': ''}
2026-02-11 13:13:22,181 - DEBUG - VM ctest-pt_svm0-93278574 is NOT ready for SSH connections, VM status: ACTIVE
2026-02-11 13:13:27,182 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:27,182 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-93278574, IP 3.238.123.3, Port 22
2026-02-11 13:13:27,339 - DEBUG - VM ctest-pt_svm0-93278574 is ready for SSH connections
2026-02-11 13:13:27,487 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:27,487 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-93278574, IP 3.238.123.3, Port 22
2026-02-11 13:13:27,643 - DEBUG - VM ctest-pt_svm0-93278574 is ready for SSH connections
2026-02-11 13:13:27,799 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:27,799 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-93278574, IP 3.238.123.3, Port 22
2026-02-11 13:13:27,950 - DEBUG - VM ctest-pt_svm0-93278574 is ready for SSH connections
2026-02-11 13:13:27,956 - DEBUG - Creating service instance: ['default-domain', 'ctest-TestSvcRegr-05892892', 'ctest-si-59767008']
2026-02-11 13:13:28,843 - INFO - Waiting for VM ctest-left_vm-44821757 to be up..
2026-02-11 13:13:28,916 - DEBUG - VM is in ACTIVE state now
2026-02-11 13:13:28,916 - INFO - VM name : ctest-left_vm-44821757
2026-02-11 13:13:28,987 - DEBUG - VM ctest-left_vm-44821757 ID is 9438b24b-5218-4d3f-9cca-8a29fb5ea9e8
2026-02-11 13:13:28,987 - DEBUG - VM ctest-left_vm-44821757 launched on Node cn-jenkins-deploy-platform-ansible-os-5291-1
2026-02-11 13:13:29,053 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/9438b24b-5218-4d3f-9cca-8a29fb5ea9e8
2026-02-11 13:13:29,062 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/b7f4da9c-e549-472d-9e7a-71ef9dc2f230
2026-02-11 13:13:30,289 - 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.22 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.335 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.335/1.779/3.224/1.444 ms')
2026-02-11 13:13:30,290 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-left_vm-44821757 passed
2026-02-11 13:13:30,439 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:30,439 - DEBUG - Waiting to SSH to VM ctest-left_vm-44821757, IP 158.5.96.131, Port 22
2026-02-11 13:13:30,595 - DEBUG - VM ctest-left_vm-44821757 is ready for SSH connections
2026-02-11 13:13:30,595 - INFO - Waiting for VM ctest-right_vm-54083287 to be up..
2026-02-11 13:13:30,664 - DEBUG - VM is in ACTIVE state now
2026-02-11 13:13:30,664 - INFO - VM name : ctest-right_vm-54083287
2026-02-11 13:13:30,730 - DEBUG - VM ctest-right_vm-54083287 ID is d4920b19-55bc-475c-8502-366015e156f6
2026-02-11 13:13:30,730 - DEBUG - VM ctest-right_vm-54083287 launched on Node cn-jenkins-deploy-platform-ansible-os-5291-1
2026-02-11 13:13:30,798 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/d4920b19-55bc-475c-8502-366015e156f6
2026-02-11 13:13:30,805 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/0fafb909-2b94-4818-bec8-a10a8c762b3e
2026-02-11 13:13:32,033 - 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=2.90 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.450 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.450/1.675/2.901/1.225 ms')
2026-02-11 13:13:32,033 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-right_vm-54083287 passed
2026-02-11 13:13:32,187 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:32,187 - DEBUG - Waiting to SSH to VM ctest-right_vm-54083287, IP 75.24.212.3, Port 22
2026-02-11 13:13:32,346 - DEBUG - VM ctest-right_vm-54083287 is ready for SSH connections
2026-02-11 13:13:32,352 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestSvcRegr-05892892:ctest-left_vn-44614594, 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-05892892:ctest-right_vn-06355912, 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-05892892:ctest-si-59767008'], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None]
2026-02-11 13:13:32,767 - INFO - Attaching policy ctest-policy-98997921 to vn ctest-left_vn-44614594
2026-02-11 13:13:33,304 - INFO - Attaching policy ctest-policy-98997921 to vn ctest-right_vn-06355912
2026-02-11 13:13:33,735 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-02328200'] created succesfully
2026-02-11 13:13:33,943 - DEBUG - Service instance: ['default-domain', 'ctest-TestSvcRegr-05892892', 'ctest-si-59767008'] created succesfully
2026-02-11 13:13:33,943 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2026-02-11 13:13:33,949 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3f35fa34-8928-44db-8bf6-346c4525ac92
2026-02-11 13:13:33,960 - DEBUG - Requesting: http://10.0.0.249:8082/project/ffd4bd27-04e2-4241-afc1-1bf6cf399fe5
2026-02-11 13:13:34,037 - DEBUG - Requesting: http://10.0.0.249:8082/service-instance/601c8d00-fbe1-4744-909f-135f500f7660
2026-02-11 13:13:34,048 - DEBUG - SI 'ctest-si-59767008' has service template ref to ctest-service_template_1-02328200
2026-02-11 13:13:34,048 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2026-02-11 13:13:34,056 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3f35fa34-8928-44db-8bf6-346c4525ac92
2026-02-11 13:13:34,067 - DEBUG - Requesting: http://10.0.0.249:8082/project/ffd4bd27-04e2-4241-afc1-1bf6cf399fe5
2026-02-11 13:13:34,144 - DEBUG - Requesting: http://10.0.0.249:8082/service-instance/601c8d00-fbe1-4744-909f-135f500f7660
2026-02-11 13:13:34,151 - DEBUG - Requesting: http://10.0.0.249:8082/port-tuple/c4419d4b-12ff-4262-a84a-56aa5ab9c9e4
2026-02-11 13:13:34,160 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/1ec4aa4f-159a-4c69-9c4f-dbc34611f649
2026-02-11 13:13:34,172 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/a33dc1ee-d974-407a-81ed-a5fd812a2057
2026-02-11 13:13:34,192 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/dac8ccd9-3cef-47e3-8c70-4956a7d00e69
2026-02-11 13:13:34,459 - DEBUG - VM is in ACTIVE state now
2026-02-11 13:13:34,859 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/7a302da3-624c-433b-9644-595388683689
2026-02-11 13:13:34,866 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/1ec4aa4f-159a-4c69-9c4f-dbc34611f649
2026-02-11 13:13:34,875 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/a33dc1ee-d974-407a-81ed-a5fd812a2057
2026-02-11 13:13:34,884 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/dac8ccd9-3cef-47e3-8c70-4956a7d00e69
2026-02-11 13:13:34,892 - DEBUG - Requesting: http://10.0.0.249:8082/instance-ip/2085bad3-275a-4fd0-a17c-8924af428976
2026-02-11 13:13:34,900 - DEBUG - Requesting: http://10.0.0.249:8082/instance-ip/60ad79db-82bd-4681-8df4-bccf478190ed
2026-02-11 13:13:34,906 - DEBUG - Requesting: http://10.0.0.249:8082/instance-ip/91ffd7b6-0f45-4d72-9167-dfa02e88992a
2026-02-11 13:13:34,912 - DEBUG - Requesting: http://10.0.0.249:8082/instance-ip/5525b2ed-df82-4608-9c38-2842011d53f6
2026-02-11 13:13:34,918 - DEBUG - Requesting: http://10.0.0.249:8082/instance-ip/9d6f9e5a-192a-4c07-837b-62013ddd1ed2
2026-02-11 13:13:34,925 - DEBUG - Requesting: http://10.0.0.249:8082/instance-ip/a8831a80-ac5a-4cd8-ab52-4ac4be755851
2026-02-11 13:13:34,931 - DEBUG - Requesting: http://10.0.0.249:8082/instance-ip/1825786e-4764-4a91-83a8-34079dc2bcf1
2026-02-11 13:13:34,937 - DEBUG - Requesting: http://10.0.0.249:8082/instance-ip/4bf44ad4-0729-4f54-a8bb-39f921da2596
2026-02-11 13:13:34,944 - DEBUG - Requesting: http://10.0.0.249:8082/instance-ip/4e0aed14-006c-4aa4-ba66-00a14450ebb6
2026-02-11 13:13:35,298 - DEBUG - VM is in ACTIVE state now
2026-02-11 13:13:35,298 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/7a302da3-624c-433b-9644-595388683689
2026-02-11 13:13:35,307 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/1ec4aa4f-159a-4c69-9c4f-dbc34611f649
2026-02-11 13:13:35,318 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/a33dc1ee-d974-407a-81ed-a5fd812a2057
2026-02-11 13:13:35,329 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/dac8ccd9-3cef-47e3-8c70-4956a7d00e69
2026-02-11 13:13:36,586 - 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=0.824 ms\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=0.498 ms\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1022ms\r\nrtt min/avg/max/mdev = 0.498/0.661/0.824/0.163 ms')
2026-02-11 13:13:36,586 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-pt_svm0-93278574 passed
2026-02-11 13:13:36,620 - DEBUG - VM ctest-pt_svm0-93278574 Tap interface: {'index': '6', 'name': 'tap1ec4aa4f-15', 'uuid': '1ec4aa4f-159a-4c69-9c4f-dbc34611f649', 'vrf_name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-left_vn-44614594:ctest-left_vn-44614594', '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': '12', 'vn_name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-left_vn-44614594', 'vm_uuid': '7a302da3-624c-433b-9644-595388683689', 'vm_name': 'ctest-pt_svm0-93278574', 'ip_addr': '158.5.96.132', 'mac_addr': '02:1e:c4:aa:4f:15', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.6', 'service_vlan_list': None, 'os_ifindex': '41', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-05892892:1ec4aa4f-159a-4c69-9c4f-dbc34611f649', 'sg_uuid_list': ['864b9dbb-bdd4-400e-a548-a8eeb41d3e44'], 'static_route_list': None, 'vm_project_uuid': 'ffd4bd27-04e2-4241-afc1-1bf6cf399fe5', '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': 'a33dc1ee-d974-407a-81ed-a5fd812a2057', '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': []}
2026-02-11 13:13:36,620 - DEBUG - Agent 10.0.0.249 vrf name: default-domain:ctest-TestSvcRegr-05892892:ctest-left_vn-44614594:ctest-left_vn-44614594
2026-02-11 13:13:36,625 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-left_vn-44614594:ctest-left_vn-44614594', 'ucindex': '2', 'mcindex': '2', 'l2index': '2', 'source': 'Config; ', 'uc6index': '2', 'vn': 'default-domain:ctest-TestSvcRegr-05892892:ctest-left_vn-44614594', 'table_label': '-1', 'vxlan_id': '12', 'evpnindex': '2', 'brindex': '2', 'mplsindex': '0', 'RD': '10.20.0.14:2', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]}
2026-02-11 13:13:36,786 - DEBUG - VM ctest-pt_svm0-93278574 : Tap interface tap1ec4aa4f-15 is set to Active
2026-02-11 13:13:36,786 - DEBUG - Tap interface tap1ec4aa4f-15 detail : {'index': '6', 'name': 'tap1ec4aa4f-15', 'uuid': '1ec4aa4f-159a-4c69-9c4f-dbc34611f649', 'vrf_name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-left_vn-44614594:ctest-left_vn-44614594', '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': '12', 'vn_name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-left_vn-44614594', 'vm_uuid': '7a302da3-624c-433b-9644-595388683689', 'vm_name': 'ctest-pt_svm0-93278574', 'ip_addr': '158.5.96.132', 'mac_addr': '02:1e:c4:aa:4f:15', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.6', 'service_vlan_list': None, 'os_ifindex': '41', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-05892892:1ec4aa4f-159a-4c69-9c4f-dbc34611f649', 'sg_uuid_list': ['864b9dbb-bdd4-400e-a548-a8eeb41d3e44'], 'static_route_list': None, 'vm_project_uuid': 'ffd4bd27-04e2-4241-afc1-1bf6cf399fe5', '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': 'a33dc1ee-d974-407a-81ed-a5fd812a2057', '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': []}
2026-02-11 13:13:36,979 - DEBUG - Starting Layer 2 verification in Agent
2026-02-11 13:13:36,989 - DEBUG - Layer 2 path is seen for VM MAC 02:1e:c4:aa:4f:15 in agent 10.0.0.249
2026-02-11 13:13:36,989 - DEBUG - Active layer 2 route in agent is present for VMI tap1ec4aa4f-15
2026-02-11 13:13:36,989 - DEBUG - L2 label(48) matches bw route table and interface table
2026-02-11 13:13:36,994 - DEBUG - VN default-domain:ctest-TestSvcRegr-05892892:ctest-left_vn-44614594 is found in Agent of node 10.0.0.249
2026-02-11 13:13:37,198 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-05892892:ctest-left_vn-44614594 is consistent in agent 10.0.0.249
2026-02-11 13:13:37,198 - DEBUG - Route for VM IP ['158.5.96.132'] is consistent in agent 10.0.0.249
2026-02-11 13:13:37,199 - DEBUG - VN default-domain:ctest-TestSvcRegr-05892892:ctest-left_vn-44614594 verification for VM ctest-pt_svm0-93278574 in Agent 10.0.0.249 passed
2026-02-11 13:13:37,391 - DEBUG - Starting all layer 2 verification in agent 10.0.0.249
2026-02-11 13:13:37,401 - DEBUG - Route for VM MAC 02:1e:c4:aa:4f:15 is consistent in agent 10.0.0.249
2026-02-11 13:13:37,418 - DEBUG - VM ctest-pt_svm0-93278574 Tap interface: {'index': '5', 'name': 'tapdac8ccd9-3c', 'uuid': 'dac8ccd9-3cef-47e3-8c70-4956a7d00e69', 'vrf_name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426:ctest-mgmt_vn-82792426', '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': '11', 'vn_name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426', 'vm_uuid': '7a302da3-624c-433b-9644-595388683689', 'vm_name': 'ctest-pt_svm0-93278574', 'ip_addr': '3.238.123.3', 'mac_addr': '02:da:c8:cc:d9:3c', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.5', 'service_vlan_list': None, 'os_ifindex': '40', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-05892892:dac8ccd9-3cef-47e3-8c70-4956a7d00e69', 'sg_uuid_list': ['864b9dbb-bdd4-400e-a548-a8eeb41d3e44'], 'static_route_list': None, 'vm_project_uuid': 'ffd4bd27-04e2-4241-afc1-1bf6cf399fe5', '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': []}
2026-02-11 13:13:37,419 - DEBUG - Agent 10.0.0.249 vrf name: default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426:ctest-mgmt_vn-82792426
2026-02-11 13:13:37,423 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426:ctest-mgmt_vn-82792426', 'ucindex': '4', 'mcindex': '4', 'l2index': '4', 'source': 'Config; ', 'uc6index': '4', 'vn': 'default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426', 'table_label': '-1', 'vxlan_id': '11', 'evpnindex': '4', 'brindex': '4', 'mplsindex': '0', 'RD': '10.20.0.14:4', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]}
2026-02-11 13:13:37,623 - DEBUG - VM ctest-pt_svm0-93278574 : Tap interface tapdac8ccd9-3c is set to Active
2026-02-11 13:13:37,624 - DEBUG - Tap interface tapdac8ccd9-3c detail : {'index': '5', 'name': 'tapdac8ccd9-3c', 'uuid': 'dac8ccd9-3cef-47e3-8c70-4956a7d00e69', 'vrf_name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426:ctest-mgmt_vn-82792426', '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': '11', 'vn_name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426', 'vm_uuid': '7a302da3-624c-433b-9644-595388683689', 'vm_name': 'ctest-pt_svm0-93278574', 'ip_addr': '3.238.123.3', 'mac_addr': '02:da:c8:cc:d9:3c', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.5', 'service_vlan_list': None, 'os_ifindex': '40', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-05892892:dac8ccd9-3cef-47e3-8c70-4956a7d00e69', 'sg_uuid_list': ['864b9dbb-bdd4-400e-a548-a8eeb41d3e44'], 'static_route_list': None, 'vm_project_uuid': 'ffd4bd27-04e2-4241-afc1-1bf6cf399fe5', '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': []}
2026-02-11 13:13:37,815 - DEBUG - Starting Layer 2 verification in Agent
2026-02-11 13:13:37,824 - DEBUG - Layer 2 path is seen for VM MAC 02:da:c8:cc:d9:3c in agent 10.0.0.249
2026-02-11 13:13:37,825 - DEBUG - Active layer 2 route in agent is present for VMI tapdac8ccd9-3c
2026-02-11 13:13:37,825 - DEBUG - L2 label(43) matches bw route table and interface table
2026-02-11 13:13:37,829 - DEBUG - VN default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426 is found in Agent of node 10.0.0.249
2026-02-11 13:13:38,032 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426 is consistent in agent 10.0.0.249
2026-02-11 13:13:38,032 - DEBUG - Route for VM IP ['3.238.123.3'] is consistent in agent 10.0.0.249
2026-02-11 13:13:38,032 - DEBUG - VN default-domain:ctest-TestSvcRegr-05892892:ctest-mgmt_vn-82792426 verification for VM ctest-pt_svm0-93278574 in Agent 10.0.0.249 passed
2026-02-11 13:13:38,231 - DEBUG - Starting all layer 2 verification in agent 10.0.0.249
2026-02-11 13:13:38,243 - DEBUG - Route for VM MAC 02:da:c8:cc:d9:3c is consistent in agent 10.0.0.249
2026-02-11 13:13:38,262 - DEBUG - VM ctest-pt_svm0-93278574 Tap interface: {'index': '7', 'name': 'tapa33dc1ee-d9', 'uuid': 'a33dc1ee-d974-407a-81ed-a5fd812a2057', 'vrf_name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-right_vn-06355912:ctest-right_vn-06355912', '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': '13', 'vn_name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-right_vn-06355912', 'vm_uuid': '7a302da3-624c-433b-9644-595388683689', 'vm_name': 'ctest-pt_svm0-93278574', 'ip_addr': '75.24.212.4', 'mac_addr': '02:a3:3d:c1:ee:d9', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.7', 'service_vlan_list': None, 'os_ifindex': '42', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-05892892:a33dc1ee-d974-407a-81ed-a5fd812a2057', 'sg_uuid_list': ['864b9dbb-bdd4-400e-a548-a8eeb41d3e44'], 'static_route_list': None, 'vm_project_uuid': 'ffd4bd27-04e2-4241-afc1-1bf6cf399fe5', 'admin_state': 'Enabled', 'flow_key_idx': '28', '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': '1ec4aa4f-159a-4c69-9c4f-dbc34611f649', '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': []}
2026-02-11 13:13:38,262 - DEBUG - Agent 10.0.0.249 vrf name: default-domain:ctest-TestSvcRegr-05892892:ctest-right_vn-06355912:ctest-right_vn-06355912
2026-02-11 13:13:38,267 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-right_vn-06355912:ctest-right_vn-06355912', 'ucindex': '3', 'mcindex': '3', 'l2index': '3', 'source': 'Config; ', 'uc6index': '3', 'vn': 'default-domain:ctest-TestSvcRegr-05892892:ctest-right_vn-06355912', 'table_label': '-1', 'vxlan_id': '13', 'evpnindex': '3', 'brindex': '3', 'mplsindex': '0', 'RD': '10.20.0.14:3', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]}
2026-02-11 13:13:38,465 - DEBUG - VM ctest-pt_svm0-93278574 : Tap interface tapa33dc1ee-d9 is set to Active
2026-02-11 13:13:38,465 - DEBUG - Tap interface tapa33dc1ee-d9 detail : {'index': '7', 'name': 'tapa33dc1ee-d9', 'uuid': 'a33dc1ee-d974-407a-81ed-a5fd812a2057', 'vrf_name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-right_vn-06355912:ctest-right_vn-06355912', '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': '13', 'vn_name': 'default-domain:ctest-TestSvcRegr-05892892:ctest-right_vn-06355912', 'vm_uuid': '7a302da3-624c-433b-9644-595388683689', 'vm_name': 'ctest-pt_svm0-93278574', 'ip_addr': '75.24.212.4', 'mac_addr': '02:a3:3d:c1:ee:d9', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.7', 'service_vlan_list': None, 'os_ifindex': '42', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-05892892:a33dc1ee-d974-407a-81ed-a5fd812a2057', 'sg_uuid_list': ['864b9dbb-bdd4-400e-a548-a8eeb41d3e44'], 'static_route_list': None, 'vm_project_uuid': 'ffd4bd27-04e2-4241-afc1-1bf6cf399fe5', 'admin_state': 'Enabled', 'flow_key_idx': '28', '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': '1ec4aa4f-159a-4c69-9c4f-dbc34611f649', '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': []}
2026-02-11 13:13:38,659 - DEBUG - Starting Layer 2 verification in Agent
2026-02-11 13:13:38,669 - DEBUG - Layer 2 path is seen for VM MAC 02:a3:3d:c1:ee:d9 in agent 10.0.0.249
2026-02-11 13:13:38,669 - DEBUG - Active layer 2 route in agent is present for VMI tapa33dc1ee-d9
2026-02-11 13:13:38,669 - DEBUG - L2 label(53) matches bw route table and interface table
2026-02-11 13:13:38,674 - DEBUG - VN default-domain:ctest-TestSvcRegr-05892892:ctest-right_vn-06355912 is found in Agent of node 10.0.0.249
2026-02-11 13:13:38,879 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-05892892:ctest-right_vn-06355912 is consistent in agent 10.0.0.249
2026-02-11 13:13:38,879 - DEBUG - Route for VM IP ['75.24.212.4'] is consistent in agent 10.0.0.249
2026-02-11 13:13:38,879 - DEBUG - VN default-domain:ctest-TestSvcRegr-05892892:ctest-right_vn-06355912 verification for VM ctest-pt_svm0-93278574 in Agent 10.0.0.249 passed
2026-02-11 13:13:39,079 - DEBUG - Starting all layer 2 verification in agent 10.0.0.249
2026-02-11 13:13:39,090 - DEBUG - Route for VM MAC 02:a3:3d:c1:ee:d9 is consistent in agent 10.0.0.249
2026-02-11 13:13:39,090 - INFO - VM ctest-pt_svm0-93278574 verifications in Compute nodes passed
2026-02-11 13:13:39,090 - DEBUG - The SVMs in the SI are : []
2026-02-11 13:13:39,090 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/7a302da3-624c-433b-9644-595388683689
2026-02-11 13:13:39,097 - DEBUG - Service VM for SI 'ctest-si-59767008' is launched
2026-02-11 13:13:39,097 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2026-02-11 13:13:39,101 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3f35fa34-8928-44db-8bf6-346c4525ac92
2026-02-11 13:13:39,111 - DEBUG - Requesting: http://10.0.0.249:8082/project/ffd4bd27-04e2-4241-afc1-1bf6cf399fe5
2026-02-11 13:13:39,182 - DEBUG - Requesting: http://10.0.0.249:8082/service-instance/601c8d00-fbe1-4744-909f-135f500f7660
2026-02-11 13:13:39,190 - DEBUG - SI ctest-si-59767008 has Port Tuple: ['ctest-port_tuple-45686103']
2026-02-11 13:13:39,287 - INFO - VMI and/or RI refs are present for VN default-domain:ctest-TestSvcRegr-05892892:ctest-left_vn-44614594
2026-02-11 13:13:39,431 - INFO - VMI and/or RI refs are present for VN default-domain:ctest-TestSvcRegr-05892892:ctest-right_vn-06355912
2026-02-11 13:13:39,587 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:39,596 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:39,596 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:39,601 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:39,602 - INFO - Route to 75.24.212.3 seen in VRF:5 on cn-jenkins-deploy-platform-ansible-os-5291-1, and SI ctest-si-59767008 is seen as the NH
2026-02-11 13:13:39,748 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:39,755 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:39,755 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:39,759 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:39,760 - INFO - Route to 158.5.96.131 seen in VRF:6 on cn-jenkins-deploy-platform-ansible-os-5291-1, and SI ctest-si-59767008 is seen as the NH
2026-02-11 13:13:39,760 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:39,760 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-11 13:13:39,760 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 75.24.212.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.249, gateway password: c0ntrail123
2026-02-11 13:13:39,760 - DEBUG - ping -s 56 -c 3 -W 1 75.24.212.3
2026-02-11 13:13:43,741 - DEBUG - PING 75.24.212.3 (75.24.212.3): 56 data bytes
64 bytes from 75.24.212.3: seq=0 ttl=61 time=5.808 ms
64 bytes from 75.24.212.3: seq=1 ttl=61 time=1.565 ms
64 bytes from 75.24.212.3: seq=2 ttl=61 time=1.396 ms
--- 75.24.212.3 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.396/2.923/5.808 ms
2026-02-11 13:13:43,742 - INFO - Ping to IP 75.24.212.3 from VM ctest-left_vm-44821757 passed
2026-02-11 13:13:43,742 - INFO - Dettaching policy ctest-policy-98997921 from vn ctest-right_vn-06355912
2026-02-11 13:13:43,947 - INFO - Dettaching policy ctest-policy-98997921 from vn ctest-left_vn-44614594
2026-02-11 13:13:44,219 - INFO - Deleted policy ctest-policy-98997921
2026-02-11 13:13:44,219 - DEBUG - Deleting service instance: ['default-domain', 'ctest-TestSvcRegr-05892892', 'ctest-si-59767008']
2026-02-11 13:13:44,308 - INFO - Deleted SI ['default-domain', 'ctest-TestSvcRegr-05892892', 'ctest-si-59767008']
2026-02-11 13:13:44,308 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2026-02-11 13:13:44,314 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3f35fa34-8928-44db-8bf6-346c4525ac92
2026-02-11 13:13:44,323 - DEBUG - Requesting: http://10.0.0.249:8082/project/ffd4bd27-04e2-4241-afc1-1bf6cf399fe5
2026-02-11 13:13:44,393 - DEBUG - Service instance ctest-si-59767008 removed from api server
2026-02-11 13:13:44,393 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/7a302da3-624c-433b-9644-595388683689
2026-02-11 13:13:44,400 - DEBUG - All Service VMs unlinked from SI ctest-si-59767008
2026-02-11 13:13:44,404 - DEBUG - 0 svc intances found in all projects. They are []
2026-02-11 13:13:44,404 - DEBUG - 0 svc intances found in current project. They are []
2026-02-11 13:13:44,451 - DEBUG - 0 svc intances found in all projects. They are []
2026-02-11 13:13:44,451 - DEBUG - 0 svc intances found in current project. They are []
2026-02-11 13:13:44,451 - INFO - Deleting VM ctest-pt_svm0-93278574
2026-02-11 13:13:44,525 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-02328200']
2026-02-11 13:13:44,599 - INFO - Service template: ['default-domain', 'ctest-service_template_1-02328200'] deleted successfully.
2026-02-11 13:13:44,599 - INFO - Deleting VM ctest-right_vm-54083287
2026-02-11 13:13:44,696 - INFO - Deleting VM ctest-left_vm-44821757
2026-02-11 13:13:44,795 - INFO - Deleting VN ctest-right_vn-06355912
2026-02-11 13:13:44,836 - DEBUG - VN 067b37e2-9ab0-47d0-8e32-c5fb91efbe35 still in use: Unable to complete operation on network 067b37e2-9ab0-47d0-8e32-c5fb91efbe35. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-0991d416-dc10-4230-9ce4-1e87424b9909']
2026-02-11 13:13:44,836 - WARNING - Deleting VN ctest-right_vn-06355912 failed..Will retry
2026-02-11 13:13:46,928 - DEBUG - Response for deleting network ()
2026-02-11 13:13:46,929 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/79e84c6d-a85a-4630-9eee-38ec61bd1ec2
2026-02-11 13:13:46,934 - DEBUG - Response Code: 404
2026-02-11 13:13:46,934 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2026-02-11 13:13:46,939 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3f35fa34-8928-44db-8bf6-346c4525ac92
2026-02-11 13:13:46,993 - DEBUG - Requesting: http://10.0.0.249:8082/project/ffd4bd27-04e2-4241-afc1-1bf6cf399fe5
2026-02-11 13:13:47,061 - INFO - Validated that VN ctest-right_vn-06355912 is not found in API Server
2026-02-11 13:13:47,072 - DEBUG - VN ctest-right_vn-06355912 is not present in Agent 10.0.0.249
2026-02-11 13:13:47,072 - INFO - Validated that VN ctest-right_vn-06355912 is not in any agent
2026-02-11 13:13:47,088 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-06355912 info
2026-02-11 13:13:47,088 - INFO - Deleting VN ctest-left_vn-44614594
2026-02-11 13:13:47,177 - DEBUG - Response for deleting network ()
2026-02-11 13:13:47,177 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/75d2648f-f9ef-4609-bbb9-00457aba1a5a
2026-02-11 13:13:47,187 - DEBUG - Response Code: 404
2026-02-11 13:13:47,187 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2026-02-11 13:13:47,191 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3f35fa34-8928-44db-8bf6-346c4525ac92
2026-02-11 13:13:47,243 - DEBUG - Requesting: http://10.0.0.249:8082/project/ffd4bd27-04e2-4241-afc1-1bf6cf399fe5
2026-02-11 13:13:47,311 - INFO - Validated that VN ctest-left_vn-44614594 is not found in API Server
2026-02-11 13:13:47,321 - DEBUG - VN ctest-left_vn-44614594 is not present in Agent 10.0.0.249
2026-02-11 13:13:47,321 - INFO - Validated that VN ctest-left_vn-44614594 is not in any agent
2026-02-11 13:13:47,334 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-44614594 info
2026-02-11 13:13:47,334 - INFO - Deleting VN ctest-mgmt_vn-82792426
2026-02-11 13:13:47,434 - DEBUG - Response for deleting network ()
2026-02-11 13:13:47,434 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b586e9e1-209f-4352-aa96-a195dd6f6648
2026-02-11 13:13:47,444 - DEBUG - Response Code: 404
2026-02-11 13:13:47,444 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2026-02-11 13:13:47,449 - DEBUG - Requesting: http://10.0.0.249:8082/domain/3f35fa34-8928-44db-8bf6-346c4525ac92
2026-02-11 13:13:47,500 - DEBUG - Requesting: http://10.0.0.249:8082/project/ffd4bd27-04e2-4241-afc1-1bf6cf399fe5
2026-02-11 13:13:47,571 - INFO - Validated that VN ctest-mgmt_vn-82792426 is not found in API Server
2026-02-11 13:13:47,582 - DEBUG - VN ctest-mgmt_vn-82792426 is not present in Agent 10.0.0.249
2026-02-11 13:13:47,582 - INFO - Validated that VN ctest-mgmt_vn-82792426 is not in any agent
2026-02-11 13:13:47,595 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-82792426 info
2026-02-11 13:13:47,847 - DEBUG - No XMPP flaps were noticed during the test
2026-02-11 13:13:47,847 - INFO -
2026-02-11 13:13:47,847 - INFO - END TEST : test_svc_in_network_datapath : PASSED[0:01:16]
2026-02-11 13:13:47,847 - INFO - --------------------------------------------------------------------------------
2026-02-11 13:13:48,530 - INFO - Deleted project: ctest-TestSvcRegr-05892892, ID : ffd4bd27-04e2-4241-afc1-1bf6cf399fe5