2026-08-03 02:37:21,841 - INFO - Domain Default found not creating 2026-08-03 02:37:22,029 - INFO - Project ctest-TestSvcRegr-72617740 not found, creating it 2026-08-03 02:37:22,537 - INFO - Created Project:ctest-TestSvcRegr-72617740, ID : d0d44aa2-f779-498c-80df-b66fc84d2326 2026-08-03 02:37:24,165 - INFO - ================================================================================ 2026-08-03 02:37:24,166 - INFO - STARTING TEST : test_svc_in_network_datapath 2026-08-03 02:37:24,426 - DEBUG - Nothing to compare xmpp stats {'10.0.0.33': {'10.20.0.17': '0'}} with 2026-08-03 02:37:24,426 - INFO - Initial checks done. Running the testcase now 2026-08-03 02:37:24,426 - INFO - 2026-08-03 02:37:25,012 - DEBUG - Response for create_network : {'network': {'id': '6492b6de-0c33-491e-92cf-c93dacd006c5', 'name': 'ctest-mgmt_vn-38792969', 'tenant_id': 'd0d44aa2f779498c80dfb66fc84d2326', 'project_id': 'd0d44aa2f779498c80dfb66fc84d2326', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-72617740', 'ctest-mgmt_vn-38792969'], 'port_security_enabled': True, 'description': ''}} 2026-08-03 02:37:25,173 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c26f321e-790b-4423-9d0c-0ca1fa39f4fa', 'name': '', 'tenant_id': 'd0d44aa2f779498c80dfb66fc84d2326', 'network_id': '6492b6de-0c33-491e-92cf-c93dacd006c5', 'ip_version': 4, 'cidr': '18.16.111.0/26', 'allocation_pools': [{'start': '18.16.111.2', 'end': '18.16.111.62'}], 'gateway_ip': '18.16.111.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '18.16.111.2', 'tags': [], 'project_id': 'd0d44aa2f779498c80dfb66fc84d2326'}} 2026-08-03 02:37:25,191 - INFO - Created VN ctest-mgmt_vn-38792969 2026-08-03 02:37:25,243 - DEBUG - VN ctest-mgmt_vn-38792969 UUID is 6492b6de-0c33-491e-92cf-c93dacd006c5 2026-08-03 02:37:25,348 - DEBUG - Requesting: http://10.0.0.33:8082/domains 2026-08-03 02:37:25,680 - DEBUG - Requesting: http://10.0.0.33:8082/domains 2026-08-03 02:37:25,712 - DEBUG - Requesting: http://10.0.0.33:8082/domain/fcfe315e-4663-4767-9fd7-8593d2c673fc 2026-08-03 02:37:25,725 - DEBUG - Requesting: http://10.0.0.33:8082/project/d0d44aa2-f779-498c-80df-b66fc84d2326 2026-08-03 02:37:25,801 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/6492b6de-0c33-491e-92cf-c93dacd006c5 2026-08-03 02:37:25,812 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/6492b6de-0c33-491e-92cf-c93dacd006c5 2026-08-03 02:37:25,821 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/3caa5c58-80d6-4219-a996-627559185e69 2026-08-03 02:37:25,829 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/3caa5c58-80d6-4219-a996-627559185e69 2026-08-03 02:37:25,836 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/e5f66e6e-7e1e-4911-ad73-9dcab27eec3b 2026-08-03 02:37:25,843 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-08-03 02:37:25,843 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/6492b6de-0c33-491e-92cf-c93dacd006c5 2026-08-03 02:37:25,851 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/3caa5c58-80d6-4219-a996-627559185e69 2026-08-03 02:37:25,865 - INFO - Verified VN network id 11 for VN 6492b6de-0c33-491e-92cf-c93dacd006c5 2026-08-03 02:37:25,866 - INFO - Verifications in API Server for VN ctest-mgmt_vn-38792969 passed 2026-08-03 02:37:25,866 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/6492b6de-0c33-491e-92cf-c93dacd006c5 2026-08-03 02:37:25,875 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/3caa5c58-80d6-4219-a996-627559185e69 2026-08-03 02:37:25,881 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/3caa5c58-80d6-4219-a996-627559185e69 2026-08-03 02:37:25,888 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/e5f66e6e-7e1e-4911-ad73-9dcab27eec3b 2026-08-03 02:37:25,902 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72617740:ctest-mgmt_vn-38792969', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72617740', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7247055815196231966', 'uuid-lslong': '10578895316446086853'}, 'enable': 'true', 'created': '2026-08-03T02:37:24', 'last-modified': '2026-08-03T02:37:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.762251'} 2026-08-03 02:37:25,909 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-08-03 02:37:25,909 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-38792969 passed 2026-08-03 02:37:25,909 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-38792969 in API_Server ====== 2026-08-03 02:37:25,909 - DEBUG - Requesting: http://10.0.0.33:8082/domains 2026-08-03 02:37:25,916 - DEBUG - Requesting: http://10.0.0.33:8082/domain/fcfe315e-4663-4767-9fd7-8593d2c673fc 2026-08-03 02:37:25,927 - DEBUG - Requesting: http://10.0.0.33:8082/project/d0d44aa2-f779-498c-80df-b66fc84d2326 2026-08-03 02:37:26,007 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/6492b6de-0c33-491e-92cf-c93dacd006c5 2026-08-03 02:37:26,016 - DEBUG - =>VN ctest-mgmt_vn-38792969 has no policy to be verified 2026-08-03 02:37:26,016 - DEBUG - Verifying the vn in opserver 2026-08-03 02:37:26,016 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72617740:ctest-mgmt_vn-38792969 virtual network link through opserver 10.0.0.33 2026-08-03 02:37:26,016 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks 2026-08-03 02:37:26,354 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks 2026-08-03 02:37:26,412 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72617740:ctest-mgmt_vn-38792969', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72617740:ctest-mgmt_vn-38792969?flat'} 2026-08-03 02:37:26,412 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-72617740:ctest-mgmt_vn-38792969 is found in opserver 2026-08-03 02:37:26,423 - DEBUG - Do not have enough data to verify VN in agent 2026-08-03 02:37:26,430 - DEBUG - VRF ids for VN ctest-mgmt_vn-38792969: {} 2026-08-03 02:37:26,623 - DEBUG - Response for create_network : {'network': {'id': '9a72f3db-e17a-4894-8f45-257ffdce1140', 'name': 'ctest-left_vn-74823485', 'tenant_id': 'd0d44aa2f779498c80dfb66fc84d2326', 'project_id': 'd0d44aa2f779498c80dfb66fc84d2326', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-72617740', 'ctest-left_vn-74823485'], 'port_security_enabled': True, 'description': ''}} 2026-08-03 02:37:26,802 - DEBUG - Response for create_subnet : {'subnet': {'id': '36814b3b-c7b1-483c-bd3e-1727715795d1', 'name': '', 'tenant_id': 'd0d44aa2f779498c80dfb66fc84d2326', 'network_id': '9a72f3db-e17a-4894-8f45-257ffdce1140', 'ip_version': 4, 'cidr': '100.174.36.0/26', 'allocation_pools': [{'start': '100.174.36.2', 'end': '100.174.36.62'}], 'gateway_ip': '100.174.36.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '100.174.36.2', 'tags': [], 'project_id': 'd0d44aa2f779498c80dfb66fc84d2326'}} 2026-08-03 02:37:26,822 - INFO - Created VN ctest-left_vn-74823485 2026-08-03 02:37:26,875 - DEBUG - VN ctest-left_vn-74823485 UUID is 9a72f3db-e17a-4894-8f45-257ffdce1140 2026-08-03 02:37:26,980 - DEBUG - Requesting: http://10.0.0.33:8082/domains 2026-08-03 02:37:26,986 - DEBUG - Requesting: http://10.0.0.33:8082/domain/fcfe315e-4663-4767-9fd7-8593d2c673fc 2026-08-03 02:37:26,997 - DEBUG - Requesting: http://10.0.0.33:8082/project/d0d44aa2-f779-498c-80df-b66fc84d2326 2026-08-03 02:37:27,078 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/9a72f3db-e17a-4894-8f45-257ffdce1140 2026-08-03 02:37:27,092 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/9a72f3db-e17a-4894-8f45-257ffdce1140 2026-08-03 02:37:27,104 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/ccbfa900-f72a-4162-864e-33c7b6eeecbf 2026-08-03 02:37:27,113 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/ccbfa900-f72a-4162-864e-33c7b6eeecbf 2026-08-03 02:37:27,121 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/3646e94e-435b-4d2f-a20a-531a9eafca75 2026-08-03 02:37:27,129 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-08-03 02:37:27,129 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/9a72f3db-e17a-4894-8f45-257ffdce1140 2026-08-03 02:37:27,141 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/ccbfa900-f72a-4162-864e-33c7b6eeecbf 2026-08-03 02:37:27,157 - INFO - Verified VN network id 12 for VN 9a72f3db-e17a-4894-8f45-257ffdce1140 2026-08-03 02:37:27,157 - INFO - Verifications in API Server for VN ctest-left_vn-74823485 passed 2026-08-03 02:37:27,157 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/9a72f3db-e17a-4894-8f45-257ffdce1140 2026-08-03 02:37:27,166 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/ccbfa900-f72a-4162-864e-33c7b6eeecbf 2026-08-03 02:37:27,174 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/ccbfa900-f72a-4162-864e-33c7b6eeecbf 2026-08-03 02:37:27,182 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/3646e94e-435b-4d2f-a20a-531a9eafca75 2026-08-03 02:37:27,195 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72617740:ctest-left_vn-74823485', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72617740', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11129225754892191892', 'uuid-lslong': '10323698952465944896'}, 'enable': 'true', 'created': '2026-08-03T02:37:26', 'last-modified': '2026-08-03T02:37:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.444006'} 2026-08-03 02:37:27,202 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-08-03 02:37:27,202 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-74823485 passed 2026-08-03 02:37:27,203 - DEBUG - ====Verifying policy data for ctest-left_vn-74823485 in API_Server ====== 2026-08-03 02:37:27,203 - DEBUG - Requesting: http://10.0.0.33:8082/domains 2026-08-03 02:37:27,210 - DEBUG - Requesting: http://10.0.0.33:8082/domain/fcfe315e-4663-4767-9fd7-8593d2c673fc 2026-08-03 02:37:27,222 - DEBUG - Requesting: http://10.0.0.33:8082/project/d0d44aa2-f779-498c-80df-b66fc84d2326 2026-08-03 02:37:27,301 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/9a72f3db-e17a-4894-8f45-257ffdce1140 2026-08-03 02:37:27,311 - DEBUG - =>VN ctest-left_vn-74823485 has no policy to be verified 2026-08-03 02:37:27,311 - DEBUG - Verifying the vn in opserver 2026-08-03 02:37:27,311 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72617740:ctest-left_vn-74823485 virtual network link through opserver 10.0.0.33 2026-08-03 02:37:27,311 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks 2026-08-03 02:37:27,321 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72617740:ctest-left_vn-74823485', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72617740:ctest-left_vn-74823485?flat'} 2026-08-03 02:37:27,321 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-72617740:ctest-left_vn-74823485 is found in opserver 2026-08-03 02:37:27,333 - DEBUG - Do not have enough data to verify VN in agent 2026-08-03 02:37:27,339 - DEBUG - VRF ids for VN ctest-left_vn-74823485: {} 2026-08-03 02:37:27,554 - DEBUG - Response for create_network : {'network': {'id': 'a7e37556-fb33-4657-8806-c4449540d072', 'name': 'ctest-right_vn-77503111', 'tenant_id': 'd0d44aa2f779498c80dfb66fc84d2326', 'project_id': 'd0d44aa2f779498c80dfb66fc84d2326', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-72617740', 'ctest-right_vn-77503111'], 'port_security_enabled': True, 'description': ''}} 2026-08-03 02:37:27,725 - DEBUG - Response for create_subnet : {'subnet': {'id': '5bb29a6b-aec6-4a2a-b5b9-ce2e79c29083', 'name': '', 'tenant_id': 'd0d44aa2f779498c80dfb66fc84d2326', 'network_id': 'a7e37556-fb33-4657-8806-c4449540d072', 'ip_version': 4, 'cidr': '218.240.13.0/26', 'allocation_pools': [{'start': '218.240.13.2', 'end': '218.240.13.62'}], 'gateway_ip': '218.240.13.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '218.240.13.2', 'tags': [], 'project_id': 'd0d44aa2f779498c80dfb66fc84d2326'}} 2026-08-03 02:37:27,744 - INFO - Created VN ctest-right_vn-77503111 2026-08-03 02:37:27,799 - DEBUG - VN ctest-right_vn-77503111 UUID is a7e37556-fb33-4657-8806-c4449540d072 2026-08-03 02:37:27,914 - DEBUG - Requesting: http://10.0.0.33:8082/domains 2026-08-03 02:37:27,921 - DEBUG - Requesting: http://10.0.0.33:8082/domain/fcfe315e-4663-4767-9fd7-8593d2c673fc 2026-08-03 02:37:27,933 - DEBUG - Requesting: http://10.0.0.33:8082/project/d0d44aa2-f779-498c-80df-b66fc84d2326 2026-08-03 02:37:28,011 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/a7e37556-fb33-4657-8806-c4449540d072 2026-08-03 02:37:28,025 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/a7e37556-fb33-4657-8806-c4449540d072 2026-08-03 02:37:28,036 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/245d4cb9-bb3b-49af-bed4-20ea66aeea80 2026-08-03 02:37:28,045 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/245d4cb9-bb3b-49af-bed4-20ea66aeea80 2026-08-03 02:37:28,054 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/223bd8e2-6dfc-4411-b98f-4026c03e4e5b 2026-08-03 02:37:28,063 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-08-03 02:37:28,063 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/a7e37556-fb33-4657-8806-c4449540d072 2026-08-03 02:37:28,077 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/245d4cb9-bb3b-49af-bed4-20ea66aeea80 2026-08-03 02:37:28,099 - INFO - Verified VN network id 13 for VN a7e37556-fb33-4657-8806-c4449540d072 2026-08-03 02:37:28,099 - INFO - Verifications in API Server for VN ctest-right_vn-77503111 passed 2026-08-03 02:37:28,099 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/a7e37556-fb33-4657-8806-c4449540d072 2026-08-03 02:37:28,110 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/245d4cb9-bb3b-49af-bed4-20ea66aeea80 2026-08-03 02:37:28,120 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/245d4cb9-bb3b-49af-bed4-20ea66aeea80 2026-08-03 02:37:28,130 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/223bd8e2-6dfc-4411-b98f-4026c03e4e5b 2026-08-03 02:37:28,146 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-72617740:ctest-right_vn-77503111', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-72617740', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12097642040489363031', 'uuid-lslong': '9801737437859336306'}, 'enable': 'true', 'created': '2026-08-03T02:37:27', 'last-modified': '2026-08-03T02:37:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.461655'} 2026-08-03 02:37:28,155 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-08-03 02:37:28,155 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-77503111 passed 2026-08-03 02:37:28,155 - DEBUG - ====Verifying policy data for ctest-right_vn-77503111 in API_Server ====== 2026-08-03 02:37:28,155 - DEBUG - Requesting: http://10.0.0.33:8082/domains 2026-08-03 02:37:28,163 - DEBUG - Requesting: http://10.0.0.33:8082/domain/fcfe315e-4663-4767-9fd7-8593d2c673fc 2026-08-03 02:37:28,177 - DEBUG - Requesting: http://10.0.0.33:8082/project/d0d44aa2-f779-498c-80df-b66fc84d2326 2026-08-03 02:37:28,257 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/a7e37556-fb33-4657-8806-c4449540d072 2026-08-03 02:37:28,267 - DEBUG - =>VN ctest-right_vn-77503111 has no policy to be verified 2026-08-03 02:37:28,267 - DEBUG - Verifying the vn in opserver 2026-08-03 02:37:28,267 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-72617740:ctest-right_vn-77503111 virtual network link through opserver 10.0.0.33 2026-08-03 02:37:28,267 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks 2026-08-03 02:37:28,279 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-72617740:ctest-right_vn-77503111', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-72617740:ctest-right_vn-77503111?flat'} 2026-08-03 02:37:28,279 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-72617740:ctest-right_vn-77503111 is found in opserver 2026-08-03 02:37:28,291 - DEBUG - Do not have enough data to verify VN in agent 2026-08-03 02:37:28,298 - DEBUG - VRF ids for VN ctest-right_vn-77503111: {} 2026-08-03 02:37:28,364 - DEBUG - Services list from nova: [, , ] 2026-08-03 02:37:28,702 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6128-30), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6128-30) 2026-08-03 02:37:29,127 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6128-30), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6128-30) 2026-08-03 02:37:29,127 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-70336267'] 2026-08-03 02:37:29,495 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-70336267'] created succesfully 2026-08-03 02:37:29,756 - DEBUG - Image by name cirros_in_net not found 2026-08-03 02:37:29,757 - DEBUG - Installing image cirros_in_net 2026-08-03 02:37:29,757 - 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-08-03 02:37:29,757 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/converts//cirros-in-net.vmdk.gz 2026-08-03 02:37:29,757 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/converts//cirros-in-net.vmdk.gz 2026-08-03 02:37:29,773 - 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-08-03 02:37:30,011 - DEBUG - Image has been downloaded to /contrail-test/images/cirros-in-net.vmdk.gz 2026-08-03 02:37:30,011 - DEBUG - Unzip image 2026-08-03 02:37:30,011 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/cirros-in-net.vmdk.gz 2026-08-03 02:37:30,163 - DEBUG - Try to create image in user context 2026-08-03 02:37:30,416 - DEBUG - Image has been created in user context 2026-08-03 02:37:30,416 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: rm -f /contrail-test/images/cirros-in-net.vmdk 2026-08-03 02:37:30,435 - DEBUG - Downloaded image has been removed 2026-08-03 02:37:30,452 - DEBUG - Uploaded image status = active 2026-08-03 02:37:30,855 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6128-30), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6128-30) 2026-08-03 02:37:30,856 - INFO - Waiting for VM ctest-pt_svm0-16872613 to be up.. 2026-08-03 02:37:30,900 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-08-03 02:37:35,960 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-08-03 02:37:41,054 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-08-03 02:37:46,162 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-08-03 02:37:51,248 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-08-03 02:37:56,338 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-08-03 02:38:01,436 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-08-03 02:38:06,542 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-08-03 02:38:11,641 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-08-03 02:38:16,737 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-08-03 02:38:21,840 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-08-03 02:38:26,937 - DEBUG - VM is in ACTIVE state now 2026-08-03 02:38:26,937 - INFO - VM name : ctest-pt_svm0-16872613 2026-08-03 02:38:27,019 - DEBUG - VM ctest-pt_svm0-16872613 ID is 2278b2a0-a59c-4f2d-8541-a1ef9a5e26cf 2026-08-03 02:38:27,041 - DEBUG - VM ctest-pt_svm0-16872613 launched on Node cn-jenkins-deploy-platform-ansible-os-6128-30 2026-08-03 02:38:27,308 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/2278b2a0-a59c-4f2d-8541-a1ef9a5e26cf 2026-08-03 02:38:27,317 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/0359bd25-07cb-42e4-87c4-9baec6db6f41 2026-08-03 02:38:27,325 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/324968f1-4b1e-417f-8f7a-df38b2ba2956 2026-08-03 02:38:27,334 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/5b91c573-fa6a-4788-a8ad-5da2c4fc1ca3 2026-08-03 02:38:30,628 - 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 1019ms') 2026-08-03 02:38:30,628 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-16872613 failed! 2026-08-03 02:38:30,683 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-72617740:ctest-mgmt_vn-38792969 is 18.16.111.1 and allocation pool is NOT set 2026-08-03 02:38:34,759 - 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 1013ms') 2026-08-03 02:38:34,759 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-16872613 failed! 2026-08-03 02:38:34,815 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-72617740:ctest-mgmt_vn-38792969 is 18.16.111.1 and allocation pool is NOT set 2026-08-03 02:38:38,888 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms') 2026-08-03 02:38:38,889 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-16872613 failed! 2026-08-03 02:38:38,943 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-72617740:ctest-mgmt_vn-38792969 is 18.16.111.1 and allocation pool is NOT set 2026-08-03 02:38:41,013 - 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=5.57 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=1.13 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 = 1.132/3.351/5.571/2.219 ms') 2026-08-03 02:38:41,013 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-16872613 passed 2026-08-03 02:38:41,171 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:38:41,171 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-16872613, IP 18.16.111.3, Port 22 2026-08-03 02:38:41,241 - 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-08-03 02:38:41,346 - DEBUG - VM ctest-pt_svm0-16872613 is NOT ready for SSH connections, VM status: ACTIVE 2026-08-03 02:38:46,346 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:38:46,347 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-16872613, IP 18.16.111.3, Port 22 2026-08-03 02:38:46,413 - 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-08-03 02:38:46,500 - DEBUG - VM ctest-pt_svm0-16872613 is NOT ready for SSH connections, VM status: ACTIVE 2026-08-03 02:38:51,502 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:38:51,502 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-16872613, IP 18.16.111.3, Port 22 2026-08-03 02:38:51,569 - 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-08-03 02:38:51,655 - DEBUG - VM ctest-pt_svm0-16872613 is NOT ready for SSH connections, VM status: ACTIVE 2026-08-03 02:38:56,656 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:38:56,657 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-16872613, IP 18.16.111.3, Port 22 2026-08-03 02:38:56,837 - DEBUG - VM ctest-pt_svm0-16872613 is ready for SSH connections 2026-08-03 02:38:56,987 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:38:56,987 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-16872613, IP 18.16.111.3, Port 22 2026-08-03 02:38:57,162 - DEBUG - VM ctest-pt_svm0-16872613 is ready for SSH connections 2026-08-03 02:38:57,323 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:38:57,323 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-16872613, IP 18.16.111.3, Port 22 2026-08-03 02:38:57,493 - DEBUG - VM ctest-pt_svm0-16872613 is ready for SSH connections 2026-08-03 02:38:57,499 - DEBUG - Creating service instance: ['default-domain', 'ctest-TestSvcRegr-72617740', 'ctest-si-20862589'] 2026-08-03 02:38:58,438 - INFO - Waiting for VM ctest-left_vm-50728238 to be up.. 2026-08-03 02:38:58,523 - DEBUG - VM is in ACTIVE state now 2026-08-03 02:38:58,523 - INFO - VM name : ctest-left_vm-50728238 2026-08-03 02:38:58,633 - DEBUG - VM ctest-left_vm-50728238 ID is ff8a3f18-7bdd-454b-9455-f52d7280ffb1 2026-08-03 02:38:58,634 - DEBUG - VM ctest-left_vm-50728238 launched on Node cn-jenkins-deploy-platform-ansible-os-6128-30 2026-08-03 02:38:58,987 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/ff8a3f18-7bdd-454b-9455-f52d7280ffb1 2026-08-03 02:38:58,997 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/68a653f2-403d-4834-b639-9e1e26cbb3b0 2026-08-03 02:39:00,253 - 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.72 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.543 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.543/2.130/3.717/1.587 ms') 2026-08-03 02:39:00,253 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-left_vm-50728238 passed 2026-08-03 02:39:00,411 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:39:00,411 - DEBUG - Waiting to SSH to VM ctest-left_vm-50728238, IP 100.174.36.3, Port 22 2026-08-03 02:39:00,577 - DEBUG - VM ctest-left_vm-50728238 is ready for SSH connections 2026-08-03 02:39:00,577 - INFO - Waiting for VM ctest-right_vm-44305206 to be up.. 2026-08-03 02:39:00,661 - DEBUG - VM is in ACTIVE state now 2026-08-03 02:39:00,662 - INFO - VM name : ctest-right_vm-44305206 2026-08-03 02:39:00,754 - DEBUG - VM ctest-right_vm-44305206 ID is 0b80362a-3ec7-46b0-a420-8e45a1bef1b7 2026-08-03 02:39:00,754 - DEBUG - VM ctest-right_vm-44305206 launched on Node cn-jenkins-deploy-platform-ansible-os-6128-30 2026-08-03 02:39:00,845 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/0b80362a-3ec7-46b0-a420-8e45a1bef1b7 2026-08-03 02:39:00,856 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/64a51913-2387-4909-a8f1-f65623dee4d8 2026-08-03 02:39:02,099 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n64 bytes from 169.254.0.4: icmp_seq=1 ttl=63 time=3.84 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.611 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1000ms\r\nrtt min/avg/max/mdev = 0.611/2.223/3.836/1.612 ms') 2026-08-03 02:39:02,100 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-right_vm-44305206 passed 2026-08-03 02:39:02,263 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:39:02,263 - DEBUG - Waiting to SSH to VM ctest-right_vm-44305206, IP 218.240.13.3, Port 22 2026-08-03 02:39:02,441 - DEBUG - VM ctest-right_vm-44305206 is ready for SSH connections 2026-08-03 02:39:02,447 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestSvcRegr-72617740:ctest-left_vn-74823485, 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-72617740:ctest-right_vn-77503111, 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-72617740:ctest-si-20862589'], 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-08-03 02:39:02,895 - INFO - Attaching policy ctest-policy-04402060 to vn ctest-left_vn-74823485 2026-08-03 02:39:03,451 - INFO - Attaching policy ctest-policy-04402060 to vn ctest-right_vn-77503111 2026-08-03 02:39:03,911 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-70336267'] created succesfully 2026-08-03 02:39:04,155 - DEBUG - Service instance: ['default-domain', 'ctest-TestSvcRegr-72617740', 'ctest-si-20862589'] created succesfully 2026-08-03 02:39:04,155 - DEBUG - Requesting: http://10.0.0.33:8082/domains 2026-08-03 02:39:04,162 - DEBUG - Requesting: http://10.0.0.33:8082/domain/fcfe315e-4663-4767-9fd7-8593d2c673fc 2026-08-03 02:39:04,176 - DEBUG - Requesting: http://10.0.0.33:8082/project/d0d44aa2-f779-498c-80df-b66fc84d2326 2026-08-03 02:39:04,266 - DEBUG - Requesting: http://10.0.0.33:8082/service-instance/5f82bca5-67c2-424f-97db-719959d94ea2 2026-08-03 02:39:04,278 - DEBUG - SI 'ctest-si-20862589' has service template ref to ctest-service_template_1-70336267 2026-08-03 02:39:04,278 - DEBUG - Requesting: http://10.0.0.33:8082/domains 2026-08-03 02:39:04,284 - DEBUG - Requesting: http://10.0.0.33:8082/domain/fcfe315e-4663-4767-9fd7-8593d2c673fc 2026-08-03 02:39:04,300 - DEBUG - Requesting: http://10.0.0.33:8082/project/d0d44aa2-f779-498c-80df-b66fc84d2326 2026-08-03 02:39:04,402 - DEBUG - Requesting: http://10.0.0.33:8082/service-instance/5f82bca5-67c2-424f-97db-719959d94ea2 2026-08-03 02:39:04,415 - DEBUG - Requesting: http://10.0.0.33:8082/port-tuple/d3b4ca33-608d-4cf3-a8d0-161e4e2358fe 2026-08-03 02:39:04,424 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/0359bd25-07cb-42e4-87c4-9baec6db6f41 2026-08-03 02:39:04,436 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/324968f1-4b1e-417f-8f7a-df38b2ba2956 2026-08-03 02:39:04,448 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/5b91c573-fa6a-4788-a8ad-5da2c4fc1ca3 2026-08-03 02:39:04,689 - DEBUG - VM is in ACTIVE state now 2026-08-03 02:39:05,131 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/2278b2a0-a59c-4f2d-8541-a1ef9a5e26cf 2026-08-03 02:39:05,139 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/0359bd25-07cb-42e4-87c4-9baec6db6f41 2026-08-03 02:39:05,151 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/324968f1-4b1e-417f-8f7a-df38b2ba2956 2026-08-03 02:39:05,162 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/5b91c573-fa6a-4788-a8ad-5da2c4fc1ca3 2026-08-03 02:39:05,174 - DEBUG - Requesting: http://10.0.0.33:8082/instance-ip/403d3c3b-552c-4bcf-8744-e57a47625302 2026-08-03 02:39:05,185 - DEBUG - Requesting: http://10.0.0.33:8082/instance-ip/8dd10a7c-657d-43da-b757-39e1605cfdee 2026-08-03 02:39:05,196 - DEBUG - Requesting: http://10.0.0.33:8082/instance-ip/b3fc8f1a-c648-48d6-82d4-9dd718be36bd 2026-08-03 02:39:05,207 - DEBUG - Requesting: http://10.0.0.33:8082/instance-ip/9c02230f-ee04-44bc-b213-d63b89ae783f 2026-08-03 02:39:05,216 - DEBUG - Requesting: http://10.0.0.33:8082/instance-ip/aa42ef01-2804-425e-8b38-b8ae3c6e7af3 2026-08-03 02:39:05,226 - DEBUG - Requesting: http://10.0.0.33:8082/instance-ip/b0837215-7e12-441d-9617-6ed9cce2daef 2026-08-03 02:39:05,235 - DEBUG - Requesting: http://10.0.0.33:8082/instance-ip/8c5ce017-8c31-48a4-b4fb-af3a3dde7ecf 2026-08-03 02:39:05,245 - DEBUG - Requesting: http://10.0.0.33:8082/instance-ip/8efbeb6d-b07e-43aa-b248-a5c9cfe80956 2026-08-03 02:39:05,254 - DEBUG - Requesting: http://10.0.0.33:8082/instance-ip/9b9a080f-8a6d-4db5-aeaf-b3ba89301249 2026-08-03 02:39:05,676 - DEBUG - VM is in ACTIVE state now 2026-08-03 02:39:05,677 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/2278b2a0-a59c-4f2d-8541-a1ef9a5e26cf 2026-08-03 02:39:05,686 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/0359bd25-07cb-42e4-87c4-9baec6db6f41 2026-08-03 02:39:05,698 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/324968f1-4b1e-417f-8f7a-df38b2ba2956 2026-08-03 02:39:05,709 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/5b91c573-fa6a-4788-a8ad-5da2c4fc1ca3 2026-08-03 02:39:06,964 - 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=2.00 ms\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=0.654 ms\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.654/1.326/1.998/0.672 ms') 2026-08-03 02:39:06,964 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-pt_svm0-16872613 passed 2026-08-03 02:39:07,002 - DEBUG - VM ctest-pt_svm0-16872613 Tap interface: {'index': '6', 'name': 'tap0359bd25-07', 'uuid': '0359bd25-07cb-42e4-87c4-9baec6db6f41', 'vrf_name': 'default-domain:ctest-TestSvcRegr-72617740:ctest-left_vn-74823485:ctest-left_vn-74823485', '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-72617740:ctest-left_vn-74823485', 'vm_uuid': '2278b2a0-a59c-4f2d-8541-a1ef9a5e26cf', 'vm_name': 'ctest-pt_svm0-16872613', 'ip_addr': '100.174.36.4', 'mac_addr': '02:03:59:bd:25:07', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.6', 'service_vlan_list': None, 'os_ifindex': '47', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-72617740:0359bd25-07cb-42e4-87c4-9baec6db6f41', 'sg_uuid_list': ['21932f5d-a0aa-4f05-8a66-d744c3b1e97d'], 'static_route_list': None, 'vm_project_uuid': 'd0d44aa2-f779-498c-80df-b66fc84d2326', 'admin_state': 'Enabled', 'flow_key_idx': '30', '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': '324968f1-4b1e-417f-8f7a-df38b2ba2956', '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-08-03 02:39:07,002 - DEBUG - Agent 10.0.0.33 vrf name: default-domain:ctest-TestSvcRegr-72617740:ctest-left_vn-74823485:ctest-left_vn-74823485 2026-08-03 02:39:07,007 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-72617740:ctest-left_vn-74823485:ctest-left_vn-74823485', 'ucindex': '2', 'mcindex': '2', 'l2index': '2', 'source': 'Config; ', 'uc6index': '2', 'vn': 'default-domain:ctest-TestSvcRegr-72617740:ctest-left_vn-74823485', 'table_label': '-1', 'vxlan_id': '12', 'evpnindex': '2', 'brindex': '2', 'mplsindex': '0', 'RD': '10.20.0.17:2', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]} 2026-08-03 02:39:07,171 - DEBUG - VM ctest-pt_svm0-16872613 : Tap interface tap0359bd25-07 is set to Active 2026-08-03 02:39:07,171 - DEBUG - Tap interface tap0359bd25-07 detail : {'index': '6', 'name': 'tap0359bd25-07', 'uuid': '0359bd25-07cb-42e4-87c4-9baec6db6f41', 'vrf_name': 'default-domain:ctest-TestSvcRegr-72617740:ctest-left_vn-74823485:ctest-left_vn-74823485', '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-72617740:ctest-left_vn-74823485', 'vm_uuid': '2278b2a0-a59c-4f2d-8541-a1ef9a5e26cf', 'vm_name': 'ctest-pt_svm0-16872613', 'ip_addr': '100.174.36.4', 'mac_addr': '02:03:59:bd:25:07', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.6', 'service_vlan_list': None, 'os_ifindex': '47', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-72617740:0359bd25-07cb-42e4-87c4-9baec6db6f41', 'sg_uuid_list': ['21932f5d-a0aa-4f05-8a66-d744c3b1e97d'], 'static_route_list': None, 'vm_project_uuid': 'd0d44aa2-f779-498c-80df-b66fc84d2326', 'admin_state': 'Enabled', 'flow_key_idx': '30', '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': '324968f1-4b1e-417f-8f7a-df38b2ba2956', '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-08-03 02:39:07,363 - DEBUG - Starting Layer 2 verification in Agent 2026-08-03 02:39:07,374 - DEBUG - Layer 2 path is seen for VM MAC 02:03:59:bd:25:07 in agent 10.0.0.33 2026-08-03 02:39:07,374 - DEBUG - Active layer 2 route in agent is present for VMI tap0359bd25-07 2026-08-03 02:39:07,374 - DEBUG - L2 label(48) matches bw route table and interface table 2026-08-03 02:39:07,380 - DEBUG - VN default-domain:ctest-TestSvcRegr-72617740:ctest-left_vn-74823485 is found in Agent of node 10.0.0.33 2026-08-03 02:39:07,599 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-72617740:ctest-left_vn-74823485 is consistent in agent 10.0.0.33 2026-08-03 02:39:07,599 - DEBUG - Route for VM IP ['100.174.36.4'] is consistent in agent 10.0.0.33 2026-08-03 02:39:07,599 - DEBUG - VN default-domain:ctest-TestSvcRegr-72617740:ctest-left_vn-74823485 verification for VM ctest-pt_svm0-16872613 in Agent 10.0.0.33 passed 2026-08-03 02:39:07,791 - DEBUG - Starting all layer 2 verification in agent 10.0.0.33 2026-08-03 02:39:07,803 - DEBUG - Route for VM MAC 02:03:59:bd:25:07 is consistent in agent 10.0.0.33 2026-08-03 02:39:07,824 - DEBUG - VM ctest-pt_svm0-16872613 Tap interface: {'index': '5', 'name': 'tap5b91c573-fa', 'uuid': '5b91c573-fa6a-4788-a8ad-5da2c4fc1ca3', 'vrf_name': 'default-domain:ctest-TestSvcRegr-72617740:ctest-mgmt_vn-38792969:ctest-mgmt_vn-38792969', '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-72617740:ctest-mgmt_vn-38792969', 'vm_uuid': '2278b2a0-a59c-4f2d-8541-a1ef9a5e26cf', 'vm_name': 'ctest-pt_svm0-16872613', 'ip_addr': '18.16.111.3', 'mac_addr': '02:5b:91:c5:73:fa', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.5', 'service_vlan_list': None, 'os_ifindex': '46', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-72617740:5b91c573-fa6a-4788-a8ad-5da2c4fc1ca3', 'sg_uuid_list': ['21932f5d-a0aa-4f05-8a66-d744c3b1e97d'], 'static_route_list': None, 'vm_project_uuid': 'd0d44aa2-f779-498c-80df-b66fc84d2326', 'admin_state': 'Enabled', 'flow_key_idx': '26', '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-08-03 02:39:07,824 - DEBUG - Agent 10.0.0.33 vrf name: default-domain:ctest-TestSvcRegr-72617740:ctest-mgmt_vn-38792969:ctest-mgmt_vn-38792969 2026-08-03 02:39:07,830 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-72617740:ctest-mgmt_vn-38792969:ctest-mgmt_vn-38792969', 'ucindex': '4', 'mcindex': '4', 'l2index': '4', 'source': 'Config; ', 'uc6index': '4', 'vn': 'default-domain:ctest-TestSvcRegr-72617740:ctest-mgmt_vn-38792969', 'table_label': '-1', 'vxlan_id': '11', 'evpnindex': '4', 'brindex': '4', 'mplsindex': '0', 'RD': '10.20.0.17:4', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]} 2026-08-03 02:39:07,992 - DEBUG - VM ctest-pt_svm0-16872613 : Tap interface tap5b91c573-fa is set to Active 2026-08-03 02:39:07,993 - DEBUG - Tap interface tap5b91c573-fa detail : {'index': '5', 'name': 'tap5b91c573-fa', 'uuid': '5b91c573-fa6a-4788-a8ad-5da2c4fc1ca3', 'vrf_name': 'default-domain:ctest-TestSvcRegr-72617740:ctest-mgmt_vn-38792969:ctest-mgmt_vn-38792969', '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-72617740:ctest-mgmt_vn-38792969', 'vm_uuid': '2278b2a0-a59c-4f2d-8541-a1ef9a5e26cf', 'vm_name': 'ctest-pt_svm0-16872613', 'ip_addr': '18.16.111.3', 'mac_addr': '02:5b:91:c5:73:fa', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.5', 'service_vlan_list': None, 'os_ifindex': '46', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-72617740:5b91c573-fa6a-4788-a8ad-5da2c4fc1ca3', 'sg_uuid_list': ['21932f5d-a0aa-4f05-8a66-d744c3b1e97d'], 'static_route_list': None, 'vm_project_uuid': 'd0d44aa2-f779-498c-80df-b66fc84d2326', 'admin_state': 'Enabled', 'flow_key_idx': '26', '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-08-03 02:39:08,191 - DEBUG - Starting Layer 2 verification in Agent 2026-08-03 02:39:08,205 - DEBUG - Layer 2 path is seen for VM MAC 02:5b:91:c5:73:fa in agent 10.0.0.33 2026-08-03 02:39:08,205 - DEBUG - Active layer 2 route in agent is present for VMI tap5b91c573-fa 2026-08-03 02:39:08,205 - DEBUG - L2 label(43) matches bw route table and interface table 2026-08-03 02:39:08,212 - DEBUG - VN default-domain:ctest-TestSvcRegr-72617740:ctest-mgmt_vn-38792969 is found in Agent of node 10.0.0.33 2026-08-03 02:39:08,425 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-72617740:ctest-mgmt_vn-38792969 is consistent in agent 10.0.0.33 2026-08-03 02:39:08,426 - DEBUG - Route for VM IP ['18.16.111.3'] is consistent in agent 10.0.0.33 2026-08-03 02:39:08,426 - DEBUG - VN default-domain:ctest-TestSvcRegr-72617740:ctest-mgmt_vn-38792969 verification for VM ctest-pt_svm0-16872613 in Agent 10.0.0.33 passed 2026-08-03 02:39:08,619 - DEBUG - Starting all layer 2 verification in agent 10.0.0.33 2026-08-03 02:39:08,630 - DEBUG - Route for VM MAC 02:5b:91:c5:73:fa is consistent in agent 10.0.0.33 2026-08-03 02:39:08,651 - DEBUG - VM ctest-pt_svm0-16872613 Tap interface: {'index': '7', 'name': 'tap324968f1-4b', 'uuid': '324968f1-4b1e-417f-8f7a-df38b2ba2956', 'vrf_name': 'default-domain:ctest-TestSvcRegr-72617740:ctest-right_vn-77503111:ctest-right_vn-77503111', '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-72617740:ctest-right_vn-77503111', 'vm_uuid': '2278b2a0-a59c-4f2d-8541-a1ef9a5e26cf', 'vm_name': 'ctest-pt_svm0-16872613', 'ip_addr': '218.240.13.4', 'mac_addr': '02:32:49:68:f1:4b', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.7', 'service_vlan_list': None, 'os_ifindex': '48', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-72617740:324968f1-4b1e-417f-8f7a-df38b2ba2956', 'sg_uuid_list': ['21932f5d-a0aa-4f05-8a66-d744c3b1e97d'], 'static_route_list': None, 'vm_project_uuid': 'd0d44aa2-f779-498c-80df-b66fc84d2326', 'admin_state': 'Enabled', 'flow_key_idx': '36', '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': '0359bd25-07cb-42e4-87c4-9baec6db6f41', '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-08-03 02:39:08,651 - DEBUG - Agent 10.0.0.33 vrf name: default-domain:ctest-TestSvcRegr-72617740:ctest-right_vn-77503111:ctest-right_vn-77503111 2026-08-03 02:39:08,656 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-72617740:ctest-right_vn-77503111:ctest-right_vn-77503111', 'ucindex': '3', 'mcindex': '3', 'l2index': '3', 'source': 'Config; ', 'uc6index': '3', 'vn': 'default-domain:ctest-TestSvcRegr-72617740:ctest-right_vn-77503111', 'table_label': '-1', 'vxlan_id': '13', 'evpnindex': '3', 'brindex': '3', 'mplsindex': '0', 'RD': '10.20.0.17:3', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]} 2026-08-03 02:39:08,867 - DEBUG - VM ctest-pt_svm0-16872613 : Tap interface tap324968f1-4b is set to Active 2026-08-03 02:39:08,867 - DEBUG - Tap interface tap324968f1-4b detail : {'index': '7', 'name': 'tap324968f1-4b', 'uuid': '324968f1-4b1e-417f-8f7a-df38b2ba2956', 'vrf_name': 'default-domain:ctest-TestSvcRegr-72617740:ctest-right_vn-77503111:ctest-right_vn-77503111', '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-72617740:ctest-right_vn-77503111', 'vm_uuid': '2278b2a0-a59c-4f2d-8541-a1ef9a5e26cf', 'vm_name': 'ctest-pt_svm0-16872613', 'ip_addr': '218.240.13.4', 'mac_addr': '02:32:49:68:f1:4b', 'policy': 'Enable', 'fip_list': [], 'mdata_ip_addr': '169.254.0.7', 'service_vlan_list': None, 'os_ifindex': '48', 'fabric_port': 'NotFabricPort', 'alloc_linklocal_ip': 'LL-Enable', 'analyzer_name': None, 'config_name': 'default-domain:ctest-TestSvcRegr-72617740:324968f1-4b1e-417f-8f7a-df38b2ba2956', 'sg_uuid_list': ['21932f5d-a0aa-4f05-8a66-d744c3b1e97d'], 'static_route_list': None, 'vm_project_uuid': 'd0d44aa2-f779-498c-80df-b66fc84d2326', 'admin_state': 'Enabled', 'flow_key_idx': '36', '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': '0359bd25-07cb-42e4-87c4-9baec6db6f41', '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-08-03 02:39:09,063 - DEBUG - Starting Layer 2 verification in Agent 2026-08-03 02:39:09,074 - DEBUG - Layer 2 path is seen for VM MAC 02:32:49:68:f1:4b in agent 10.0.0.33 2026-08-03 02:39:09,075 - DEBUG - Active layer 2 route in agent is present for VMI tap324968f1-4b 2026-08-03 02:39:09,075 - DEBUG - L2 label(53) matches bw route table and interface table 2026-08-03 02:39:09,084 - DEBUG - VN default-domain:ctest-TestSvcRegr-72617740:ctest-right_vn-77503111 is found in Agent of node 10.0.0.33 2026-08-03 02:39:09,294 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-72617740:ctest-right_vn-77503111 is consistent in agent 10.0.0.33 2026-08-03 02:39:09,295 - DEBUG - Route for VM IP ['218.240.13.4'] is consistent in agent 10.0.0.33 2026-08-03 02:39:09,295 - DEBUG - VN default-domain:ctest-TestSvcRegr-72617740:ctest-right_vn-77503111 verification for VM ctest-pt_svm0-16872613 in Agent 10.0.0.33 passed 2026-08-03 02:39:09,487 - DEBUG - Starting all layer 2 verification in agent 10.0.0.33 2026-08-03 02:39:09,501 - DEBUG - Route for VM MAC 02:32:49:68:f1:4b is consistent in agent 10.0.0.33 2026-08-03 02:39:09,502 - INFO - VM ctest-pt_svm0-16872613 verifications in Compute nodes passed 2026-08-03 02:39:09,502 - DEBUG - The SVMs in the SI are : [] 2026-08-03 02:39:09,502 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/2278b2a0-a59c-4f2d-8541-a1ef9a5e26cf 2026-08-03 02:39:09,511 - DEBUG - Service VM for SI 'ctest-si-20862589' is launched 2026-08-03 02:39:09,511 - DEBUG - Requesting: http://10.0.0.33:8082/domains 2026-08-03 02:39:09,518 - DEBUG - Requesting: http://10.0.0.33:8082/domain/fcfe315e-4663-4767-9fd7-8593d2c673fc 2026-08-03 02:39:09,530 - DEBUG - Requesting: http://10.0.0.33:8082/project/d0d44aa2-f779-498c-80df-b66fc84d2326 2026-08-03 02:39:09,610 - DEBUG - Requesting: http://10.0.0.33:8082/service-instance/5f82bca5-67c2-424f-97db-719959d94ea2 2026-08-03 02:39:09,620 - DEBUG - SI ctest-si-20862589 has Port Tuple: ['ctest-port_tuple-36016943'] 2026-08-03 02:39:09,727 - INFO - VMI and/or RI refs are present for VN default-domain:ctest-TestSvcRegr-72617740:ctest-left_vn-74823485 2026-08-03 02:39:09,875 - INFO - VMI and/or RI refs are present for VN default-domain:ctest-TestSvcRegr-72617740:ctest-right_vn-77503111 2026-08-03 02:39:10,032 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:39:10,042 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:39:10,042 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:39:10,049 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:39:10,049 - INFO - Route to 218.240.13.3 seen in VRF:5 on cn-jenkins-deploy-platform-ansible-os-6128-30, and SI ctest-si-20862589 is seen as the NH 2026-08-03 02:39:10,208 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:39:10,216 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:39:10,217 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:39:10,223 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:39:10,224 - INFO - Route to 100.174.36.3 seen in VRF:6 on cn-jenkins-deploy-platform-ansible-os-6128-30, and SI ctest-si-20862589 is seen as the NH 2026-08-03 02:39:10,224 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:39:10,224 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-08-03 02:39:10,224 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 218.240.13.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.33, gateway password: c0ntrail123 2026-08-03 02:39:10,224 - DEBUG - ping -s 56 -c 3 -W 1 218.240.13.3 2026-08-03 02:39:14,164 - DEBUG - PING 218.240.13.3 (218.240.13.3): 56 data bytes 64 bytes from 218.240.13.3: seq=0 ttl=61 time=8.219 ms 64 bytes from 218.240.13.3: seq=1 ttl=61 time=2.467 ms 64 bytes from 218.240.13.3: seq=2 ttl=61 time=2.057 ms --- 218.240.13.3 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 2.057/4.247/8.219 ms 2026-08-03 02:39:14,165 - INFO - Ping to IP 218.240.13.3 from VM ctest-left_vm-50728238 passed 2026-08-03 02:39:14,165 - INFO - Dettaching policy ctest-policy-04402060 from vn ctest-right_vn-77503111 2026-08-03 02:39:14,383 - INFO - Dettaching policy ctest-policy-04402060 from vn ctest-left_vn-74823485 2026-08-03 02:39:14,669 - INFO - Deleted policy ctest-policy-04402060 2026-08-03 02:39:14,669 - DEBUG - Deleting service instance: ['default-domain', 'ctest-TestSvcRegr-72617740', 'ctest-si-20862589'] 2026-08-03 02:39:14,777 - INFO - Deleted SI ['default-domain', 'ctest-TestSvcRegr-72617740', 'ctest-si-20862589'] 2026-08-03 02:39:14,777 - DEBUG - Requesting: http://10.0.0.33:8082/domains 2026-08-03 02:39:14,783 - DEBUG - Requesting: http://10.0.0.33:8082/domain/fcfe315e-4663-4767-9fd7-8593d2c673fc 2026-08-03 02:39:14,807 - DEBUG - Requesting: http://10.0.0.33:8082/project/d0d44aa2-f779-498c-80df-b66fc84d2326 2026-08-03 02:39:14,893 - DEBUG - Service instance ctest-si-20862589 removed from api server 2026-08-03 02:39:14,893 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/2278b2a0-a59c-4f2d-8541-a1ef9a5e26cf 2026-08-03 02:39:14,903 - DEBUG - All Service VMs unlinked from SI ctest-si-20862589 2026-08-03 02:39:14,909 - DEBUG - 0 svc intances found in all projects. They are [] 2026-08-03 02:39:14,909 - DEBUG - 0 svc intances found in current project. They are [] 2026-08-03 02:39:14,958 - DEBUG - 0 svc intances found in all projects. They are [] 2026-08-03 02:39:14,959 - DEBUG - 0 svc intances found in current project. They are [] 2026-08-03 02:39:14,959 - INFO - Deleting VM ctest-pt_svm0-16872613 2026-08-03 02:39:15,037 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-70336267'] 2026-08-03 02:39:15,119 - INFO - Service template: ['default-domain', 'ctest-service_template_1-70336267'] deleted successfully. 2026-08-03 02:39:15,119 - INFO - Deleting VM ctest-right_vm-44305206 2026-08-03 02:39:15,204 - INFO - Deleting VM ctest-left_vm-50728238 2026-08-03 02:39:15,297 - INFO - Deleting VN ctest-right_vn-77503111 2026-08-03 02:39:15,334 - DEBUG - VN a7e37556-fb33-4657-8806-c4449540d072 still in use: Unable to complete operation on network a7e37556-fb33-4657-8806-c4449540d072. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-1bccf000-4bdc-498e-ba72-04c065e4cdeb'] 2026-08-03 02:39:15,334 - WARNING - Deleting VN ctest-right_vn-77503111 failed..Will retry 2026-08-03 02:39:17,380 - DEBUG - VN a7e37556-fb33-4657-8806-c4449540d072 still in use: Unable to complete operation on network a7e37556-fb33-4657-8806-c4449540d072. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-443f2c4a-35fc-4f55-9e84-b6489a25bba4'] 2026-08-03 02:39:17,381 - WARNING - Deleting VN ctest-right_vn-77503111 failed..Will retry 2026-08-03 02:39:19,580 - DEBUG - Response for deleting network () 2026-08-03 02:39:19,580 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/245d4cb9-bb3b-49af-bed4-20ea66aeea80 2026-08-03 02:39:19,588 - DEBUG - Response Code: 404 2026-08-03 02:39:19,588 - DEBUG - Requesting: http://10.0.0.33:8082/domains 2026-08-03 02:39:19,594 - DEBUG - Requesting: http://10.0.0.33:8082/domain/fcfe315e-4663-4767-9fd7-8593d2c673fc 2026-08-03 02:39:19,650 - DEBUG - Requesting: http://10.0.0.33:8082/project/d0d44aa2-f779-498c-80df-b66fc84d2326 2026-08-03 02:39:19,727 - INFO - Validated that VN ctest-right_vn-77503111 is not found in API Server 2026-08-03 02:39:19,738 - DEBUG - VN ctest-right_vn-77503111 is not present in Agent 10.0.0.33 2026-08-03 02:39:19,738 - INFO - Validated that VN ctest-right_vn-77503111 is not in any agent 2026-08-03 02:39:19,752 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-77503111 info 2026-08-03 02:39:19,752 - INFO - Deleting VN ctest-left_vn-74823485 2026-08-03 02:39:19,858 - DEBUG - Response for deleting network () 2026-08-03 02:39:19,858 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/ccbfa900-f72a-4162-864e-33c7b6eeecbf 2026-08-03 02:39:19,864 - DEBUG - Response Code: 404 2026-08-03 02:39:19,864 - DEBUG - Requesting: http://10.0.0.33:8082/domains 2026-08-03 02:39:19,874 - DEBUG - Requesting: http://10.0.0.33:8082/domain/fcfe315e-4663-4767-9fd7-8593d2c673fc 2026-08-03 02:39:19,928 - DEBUG - Requesting: http://10.0.0.33:8082/project/d0d44aa2-f779-498c-80df-b66fc84d2326 2026-08-03 02:39:19,998 - INFO - Validated that VN ctest-left_vn-74823485 is not found in API Server 2026-08-03 02:39:20,009 - DEBUG - VN ctest-left_vn-74823485 is not present in Agent 10.0.0.33 2026-08-03 02:39:20,009 - INFO - Validated that VN ctest-left_vn-74823485 is not in any agent 2026-08-03 02:39:20,023 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-74823485 info 2026-08-03 02:39:20,023 - INFO - Deleting VN ctest-mgmt_vn-38792969 2026-08-03 02:39:20,176 - DEBUG - Response for deleting network () 2026-08-03 02:39:20,176 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/3caa5c58-80d6-4219-a996-627559185e69 2026-08-03 02:39:20,184 - DEBUG - Response Code: 404 2026-08-03 02:39:20,184 - DEBUG - Requesting: http://10.0.0.33:8082/domains 2026-08-03 02:39:20,191 - DEBUG - Requesting: http://10.0.0.33:8082/domain/fcfe315e-4663-4767-9fd7-8593d2c673fc 2026-08-03 02:39:20,245 - DEBUG - Requesting: http://10.0.0.33:8082/project/d0d44aa2-f779-498c-80df-b66fc84d2326 2026-08-03 02:39:20,327 - INFO - Validated that VN ctest-mgmt_vn-38792969 is not found in API Server 2026-08-03 02:39:20,338 - DEBUG - VN ctest-mgmt_vn-38792969 is not present in Agent 10.0.0.33 2026-08-03 02:39:20,338 - INFO - Validated that VN ctest-mgmt_vn-38792969 is not in any agent 2026-08-03 02:39:20,356 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-38792969 info 2026-08-03 02:39:20,623 - DEBUG - No XMPP flaps were noticed during the test 2026-08-03 02:39:20,623 - INFO -
2026-08-03 02:39:20,623 - INFO - END TEST : test_svc_in_network_datapath : PASSED[0:01:56]
2026-08-03 02:39:20,623 - INFO - -------------------------------------------------------------------------------- 2026-08-03 02:39:21,371 - INFO - Deleted project: ctest-TestSvcRegr-72617740, ID : d0d44aa2-f779-498c-80df-b66fc84d2326