2025-12-10 17:06:43,089 - INFO - Domain Default found not creating 2025-12-10 17:06:43,229 - INFO - Project ctest-TestSvcRegr-48409792 not found, creating it 2025-12-10 17:06:43,655 - INFO - Created Project:ctest-TestSvcRegr-48409792, ID : 1f518ebd-7a1e-4821-b257-80116955cda7 2025-12-10 17:06:45,024 - INFO - ================================================================================ 2025-12-10 17:06:45,024 - INFO - STARTING TEST : test_svc_in_network_datapath 2025-12-10 17:06:45,286 - DEBUG - Nothing to compare xmpp stats {'10.0.0.141': {'10.20.0.193': '0'}} with 2025-12-10 17:06:45,286 - INFO - Initial checks done. Running the testcase now 2025-12-10 17:06:45,287 - INFO - 2025-12-10 17:06:45,821 - DEBUG - Response for create_network : {'network': {'id': 'a8c113a2-a9ba-4182-989f-e41eaf662eaf', 'name': 'ctest-mgmt_vn-80685149', 'tenant_id': '1f518ebd7a1e4821b25780116955cda7', 'project_id': '1f518ebd7a1e4821b25780116955cda7', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-48409792', 'ctest-mgmt_vn-80685149'], 'port_security_enabled': True, 'description': ''}} 2025-12-10 17:06:46,032 - DEBUG - Response for create_subnet : {'subnet': {'id': '640bd9ba-8159-41de-b04e-3e729033adae', 'name': '', 'tenant_id': '1f518ebd7a1e4821b25780116955cda7', 'network_id': 'a8c113a2-a9ba-4182-989f-e41eaf662eaf', 'ip_version': 4, 'cidr': '126.57.115.0/26', 'allocation_pools': [{'start': '126.57.115.2', 'end': '126.57.115.62'}], 'gateway_ip': '126.57.115.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '126.57.115.2', 'tags': [], 'project_id': '1f518ebd7a1e4821b25780116955cda7'}} 2025-12-10 17:06:46,061 - INFO - Created VN ctest-mgmt_vn-80685149 2025-12-10 17:06:46,113 - DEBUG - VN ctest-mgmt_vn-80685149 UUID is a8c113a2-a9ba-4182-989f-e41eaf662eaf 2025-12-10 17:06:46,213 - DEBUG - Requesting: http://10.0.0.141:8082/domains 2025-12-10 17:06:46,504 - DEBUG - Requesting: http://10.0.0.141:8082/domains 2025-12-10 17:06:46,536 - DEBUG - Requesting: http://10.0.0.141:8082/domain/012a191c-4dbe-4738-824a-1fb29bb5bf4c 2025-12-10 17:06:46,546 - DEBUG - Requesting: http://10.0.0.141:8082/project/1f518ebd-7a1e-4821-b257-80116955cda7 2025-12-10 17:06:46,612 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/a8c113a2-a9ba-4182-989f-e41eaf662eaf 2025-12-10 17:06:46,623 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/a8c113a2-a9ba-4182-989f-e41eaf662eaf 2025-12-10 17:06:46,630 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/073aa4f0-59d5-4e1f-abb9-572ee89f0a44 2025-12-10 17:06:46,636 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/073aa4f0-59d5-4e1f-abb9-572ee89f0a44 2025-12-10 17:06:46,640 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/1355b36d-c118-4e67-9fac-3d351b171b37 2025-12-10 17:06:46,645 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-12-10 17:06:46,645 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/a8c113a2-a9ba-4182-989f-e41eaf662eaf 2025-12-10 17:06:46,652 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/073aa4f0-59d5-4e1f-abb9-572ee89f0a44 2025-12-10 17:06:46,663 - INFO - Verified VN network id 12 for VN a8c113a2-a9ba-4182-989f-e41eaf662eaf 2025-12-10 17:06:46,664 - INFO - Verifications in API Server for VN ctest-mgmt_vn-80685149 passed 2025-12-10 17:06:46,664 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/a8c113a2-a9ba-4182-989f-e41eaf662eaf 2025-12-10 17:06:46,671 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/073aa4f0-59d5-4e1f-abb9-572ee89f0a44 2025-12-10 17:06:46,677 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/073aa4f0-59d5-4e1f-abb9-572ee89f0a44 2025-12-10 17:06:46,682 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/1355b36d-c118-4e67-9fac-3d351b171b37 2025-12-10 17:06:46,692 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-48409792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12160022058230235522', 'uuid-lslong': '10997759635504901807'}, 'enable': 'true', 'created': '2025-12-10T17:06:45', 'last-modified': '2025-12-10T17:06:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.690109'} 2025-12-10 17:06:46,697 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-12-10 17:06:46,697 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-80685149 passed 2025-12-10 17:06:46,697 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-80685149 in API_Server ====== 2025-12-10 17:06:46,697 - DEBUG - Requesting: http://10.0.0.141:8082/domains 2025-12-10 17:06:46,703 - DEBUG - Requesting: http://10.0.0.141:8082/domain/012a191c-4dbe-4738-824a-1fb29bb5bf4c 2025-12-10 17:06:46,712 - DEBUG - Requesting: http://10.0.0.141:8082/project/1f518ebd-7a1e-4821-b257-80116955cda7 2025-12-10 17:06:46,778 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/a8c113a2-a9ba-4182-989f-e41eaf662eaf 2025-12-10 17:06:46,785 - DEBUG - =>VN ctest-mgmt_vn-80685149 has no policy to be verified 2025-12-10 17:06:46,785 - DEBUG - Verifying the vn in opserver 2025-12-10 17:06:46,785 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149 virtual network link through opserver 10.0.0.141 2025-12-10 17:06:46,786 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks 2025-12-10 17:06:47,072 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks 2025-12-10 17:06:47,123 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149?flat'} 2025-12-10 17:06:47,123 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149 is found in opserver 2025-12-10 17:06:47,139 - DEBUG - Do not have enough data to verify VN in agent 2025-12-10 17:06:47,149 - DEBUG - VRF ids for VN ctest-mgmt_vn-80685149: {} 2025-12-10 17:06:47,315 - DEBUG - Response for create_network : {'network': {'id': 'a0820e26-6dba-476b-957c-c8bf86ccf72e', 'name': 'ctest-left_vn-55296171', 'tenant_id': '1f518ebd7a1e4821b25780116955cda7', 'project_id': '1f518ebd7a1e4821b25780116955cda7', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-48409792', 'ctest-left_vn-55296171'], 'port_security_enabled': True, 'description': ''}} 2025-12-10 17:06:47,472 - DEBUG - Response for create_subnet : {'subnet': {'id': '9b029cd1-634c-46b2-9d85-e66caba0a254', 'name': '', 'tenant_id': '1f518ebd7a1e4821b25780116955cda7', 'network_id': 'a0820e26-6dba-476b-957c-c8bf86ccf72e', 'ip_version': 4, 'cidr': '20.129.62.128/26', 'allocation_pools': [{'start': '20.129.62.130', 'end': '20.129.62.190'}], 'gateway_ip': '20.129.62.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '20.129.62.130', 'tags': [], 'project_id': '1f518ebd7a1e4821b25780116955cda7'}} 2025-12-10 17:06:47,490 - INFO - Created VN ctest-left_vn-55296171 2025-12-10 17:06:47,541 - DEBUG - VN ctest-left_vn-55296171 UUID is a0820e26-6dba-476b-957c-c8bf86ccf72e 2025-12-10 17:06:47,647 - DEBUG - Requesting: http://10.0.0.141:8082/domains 2025-12-10 17:06:47,658 - DEBUG - Requesting: http://10.0.0.141:8082/domain/012a191c-4dbe-4738-824a-1fb29bb5bf4c 2025-12-10 17:06:47,668 - DEBUG - Requesting: http://10.0.0.141:8082/project/1f518ebd-7a1e-4821-b257-80116955cda7 2025-12-10 17:06:47,739 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/a0820e26-6dba-476b-957c-c8bf86ccf72e 2025-12-10 17:06:47,748 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/a0820e26-6dba-476b-957c-c8bf86ccf72e 2025-12-10 17:06:47,756 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7236ec36-2929-4160-8f47-e5ea25722134 2025-12-10 17:06:47,762 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7236ec36-2929-4160-8f47-e5ea25722134 2025-12-10 17:06:47,768 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/0b7df5c5-38d6-44f2-9535-51dc0788269e 2025-12-10 17:06:47,773 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-12-10 17:06:47,773 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/a0820e26-6dba-476b-957c-c8bf86ccf72e 2025-12-10 17:06:47,779 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7236ec36-2929-4160-8f47-e5ea25722134 2025-12-10 17:06:47,791 - INFO - Verified VN network id 13 for VN a0820e26-6dba-476b-957c-c8bf86ccf72e 2025-12-10 17:06:47,791 - INFO - Verifications in API Server for VN ctest-left_vn-55296171 passed 2025-12-10 17:06:47,791 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/a0820e26-6dba-476b-957c-c8bf86ccf72e 2025-12-10 17:06:47,798 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7236ec36-2929-4160-8f47-e5ea25722134 2025-12-10 17:06:47,804 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7236ec36-2929-4160-8f47-e5ea25722134 2025-12-10 17:06:47,809 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/0b7df5c5-38d6-44f2-9535-51dc0788269e 2025-12-10 17:06:47,818 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-48409792:ctest-left_vn-55296171', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-48409792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11565822351253325675', 'uuid-lslong': '10771705133689272110'}, 'enable': 'true', 'created': '2025-12-10T17:06:47', 'last-modified': '2025-12-10T17:06:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.372777'} 2025-12-10 17:06:47,824 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-12-10 17:06:47,824 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-55296171 passed 2025-12-10 17:06:47,824 - DEBUG - ====Verifying policy data for ctest-left_vn-55296171 in API_Server ====== 2025-12-10 17:06:47,824 - DEBUG - Requesting: http://10.0.0.141:8082/domains 2025-12-10 17:06:47,829 - DEBUG - Requesting: http://10.0.0.141:8082/domain/012a191c-4dbe-4738-824a-1fb29bb5bf4c 2025-12-10 17:06:47,837 - DEBUG - Requesting: http://10.0.0.141:8082/project/1f518ebd-7a1e-4821-b257-80116955cda7 2025-12-10 17:06:47,905 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/a0820e26-6dba-476b-957c-c8bf86ccf72e 2025-12-10 17:06:47,912 - DEBUG - =>VN ctest-left_vn-55296171 has no policy to be verified 2025-12-10 17:06:47,912 - DEBUG - Verifying the vn in opserver 2025-12-10 17:06:47,912 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-48409792:ctest-left_vn-55296171 virtual network link through opserver 10.0.0.141 2025-12-10 17:06:47,912 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks 2025-12-10 17:06:47,919 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-left_vn-55296171', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-48409792:ctest-left_vn-55296171?flat'} 2025-12-10 17:06:47,919 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-48409792:ctest-left_vn-55296171 is found in opserver 2025-12-10 17:06:47,926 - DEBUG - Do not have enough data to verify VN in agent 2025-12-10 17:06:47,930 - DEBUG - VRF ids for VN ctest-left_vn-55296171: {} 2025-12-10 17:06:48,078 - DEBUG - Response for create_network : {'network': {'id': '5b716446-1a42-4a0f-8622-2ee25cfb6ffc', 'name': 'ctest-right_vn-15119370', 'tenant_id': '1f518ebd7a1e4821b25780116955cda7', 'project_id': '1f518ebd7a1e4821b25780116955cda7', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-48409792', 'ctest-right_vn-15119370'], 'port_security_enabled': True, 'description': ''}} 2025-12-10 17:06:48,257 - DEBUG - Response for create_subnet : {'subnet': {'id': '6b88b45c-b6bd-40cd-b3b5-ac42e7a176f5', 'name': '', 'tenant_id': '1f518ebd7a1e4821b25780116955cda7', 'network_id': '5b716446-1a42-4a0f-8622-2ee25cfb6ffc', 'ip_version': 4, 'cidr': '184.184.104.128/26', 'allocation_pools': [{'start': '184.184.104.130', 'end': '184.184.104.190'}], 'gateway_ip': '184.184.104.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '184.184.104.130', 'tags': [], 'project_id': '1f518ebd7a1e4821b25780116955cda7'}} 2025-12-10 17:06:48,271 - INFO - Created VN ctest-right_vn-15119370 2025-12-10 17:06:48,321 - DEBUG - VN ctest-right_vn-15119370 UUID is 5b716446-1a42-4a0f-8622-2ee25cfb6ffc 2025-12-10 17:06:48,411 - DEBUG - Requesting: http://10.0.0.141:8082/domains 2025-12-10 17:06:48,415 - DEBUG - Requesting: http://10.0.0.141:8082/domain/012a191c-4dbe-4738-824a-1fb29bb5bf4c 2025-12-10 17:06:48,423 - DEBUG - Requesting: http://10.0.0.141:8082/project/1f518ebd-7a1e-4821-b257-80116955cda7 2025-12-10 17:06:48,486 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/5b716446-1a42-4a0f-8622-2ee25cfb6ffc 2025-12-10 17:06:48,495 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/5b716446-1a42-4a0f-8622-2ee25cfb6ffc 2025-12-10 17:06:48,502 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/d4f57e95-e7b5-4407-98aa-44cdfe1331f0 2025-12-10 17:06:48,507 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/d4f57e95-e7b5-4407-98aa-44cdfe1331f0 2025-12-10 17:06:48,512 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/a79cd99a-9654-42f2-86c2-c94838a125c3 2025-12-10 17:06:48,517 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-12-10 17:06:48,517 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/5b716446-1a42-4a0f-8622-2ee25cfb6ffc 2025-12-10 17:06:48,524 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/d4f57e95-e7b5-4407-98aa-44cdfe1331f0 2025-12-10 17:06:48,536 - INFO - Verified VN network id 14 for VN 5b716446-1a42-4a0f-8622-2ee25cfb6ffc 2025-12-10 17:06:48,536 - INFO - Verifications in API Server for VN ctest-right_vn-15119370 passed 2025-12-10 17:06:48,536 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/5b716446-1a42-4a0f-8622-2ee25cfb6ffc 2025-12-10 17:06:48,543 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/d4f57e95-e7b5-4407-98aa-44cdfe1331f0 2025-12-10 17:06:48,548 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/d4f57e95-e7b5-4407-98aa-44cdfe1331f0 2025-12-10 17:06:48,553 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/a79cd99a-9654-42f2-86c2-c94838a125c3 2025-12-10 17:06:48,561 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-48409792:ctest-right_vn-15119370', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-48409792', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6589157982070786575', 'uuid-lslong': '9665339300047974396'}, 'enable': 'true', 'created': '2025-12-10T17:06:48', 'last-modified': '2025-12-10T17:06:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.327573'} 2025-12-10 17:06:48,566 - DEBUG - Route Targets: ['target:64512:8000006'] 2025-12-10 17:06:48,566 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-15119370 passed 2025-12-10 17:06:48,566 - DEBUG - ====Verifying policy data for ctest-right_vn-15119370 in API_Server ====== 2025-12-10 17:06:48,566 - DEBUG - Requesting: http://10.0.0.141:8082/domains 2025-12-10 17:06:48,570 - DEBUG - Requesting: http://10.0.0.141:8082/domain/012a191c-4dbe-4738-824a-1fb29bb5bf4c 2025-12-10 17:06:48,578 - DEBUG - Requesting: http://10.0.0.141:8082/project/1f518ebd-7a1e-4821-b257-80116955cda7 2025-12-10 17:06:48,645 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/5b716446-1a42-4a0f-8622-2ee25cfb6ffc 2025-12-10 17:06:48,653 - DEBUG - =>VN ctest-right_vn-15119370 has no policy to be verified 2025-12-10 17:06:48,653 - DEBUG - Verifying the vn in opserver 2025-12-10 17:06:48,653 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-48409792:ctest-right_vn-15119370 virtual network link through opserver 10.0.0.141 2025-12-10 17:06:48,653 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks 2025-12-10 17:06:48,661 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-right_vn-15119370', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-48409792:ctest-right_vn-15119370?flat'} 2025-12-10 17:06:48,661 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-48409792:ctest-right_vn-15119370 is found in opserver 2025-12-10 17:06:48,669 - DEBUG - Do not have enough data to verify VN in agent 2025-12-10 17:06:48,672 - DEBUG - VRF ids for VN ctest-right_vn-15119370: {} 2025-12-10 17:06:48,720 - DEBUG - Services list from nova: [, , ] 2025-12-10 17:06:49,793 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4878-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4878-1) 2025-12-10 17:06:50,897 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4878-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4878-1) 2025-12-10 17:06:50,897 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-59012667'] 2025-12-10 17:06:51,277 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-59012667'] created succesfully 2025-12-10 17:06:51,575 - DEBUG - Image by name cirros_in_net not found 2025-12-10 17:06:51,575 - DEBUG - Installing image cirros_in_net 2025-12-10 17:06:51,576 - DEBUG - Image info {'name': 'cirros-in-net.vmdk.gz', 'webserver': '', 'location': '/images/converts/', 'username': 'cirros', 'password': 'gocubsgo', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hw_scsi_model=virtio-scsi --property hw_disk_bus_model=virtio-scsi --property hw_disk_bus=virtio', 'name_docker': 'phusion-baseimage-enablesshd'} 2025-12-10 17:06:51,576 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/converts//cirros-in-net.vmdk.gz 2025-12-10 17:06:51,576 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/converts//cirros-in-net.vmdk.gz 2025-12-10 17:06:51,594 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/converts//cirros-in-net.vmdk.gz -O /contrail-test/images/cirros-in-net.vmdk.gz 2025-12-10 17:06:51,721 - DEBUG - Image has been downloaded to /contrail-test/images/cirros-in-net.vmdk.gz 2025-12-10 17:06:51,721 - DEBUG - Unzip image 2025-12-10 17:06:51,721 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/cirros-in-net.vmdk.gz 2025-12-10 17:06:51,872 - DEBUG - Try to create image in user context 2025-12-10 17:06:52,092 - DEBUG - Image has been created in user context 2025-12-10 17:06:52,092 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: rm -f /contrail-test/images/cirros-in-net.vmdk 2025-12-10 17:06:52,107 - DEBUG - Downloaded image has been removed 2025-12-10 17:06:52,124 - DEBUG - Uploaded image status = active 2025-12-10 17:06:53,211 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4878-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4878-1) 2025-12-10 17:06:53,211 - INFO - Waiting for VM ctest-pt_svm0-00798692 to be up.. 2025-12-10 17:06:53,248 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-12-10 17:06:58,314 - DEBUG - VM is in ACTIVE state now 2025-12-10 17:06:58,314 - INFO - VM name : ctest-pt_svm0-00798692 2025-12-10 17:06:58,384 - DEBUG - VM ctest-pt_svm0-00798692 ID is dac00747-c648-4503-b9b5-ba2b3dee5aa8 2025-12-10 17:06:58,401 - DEBUG - VM ctest-pt_svm0-00798692 launched on Node cn-jenkins-deploy-platform-ansible-os-4878-1 2025-12-10 17:06:58,651 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine/dac00747-c648-4503-b9b5-ba2b3dee5aa8 2025-12-10 17:06:58,662 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/8d6f8751-3d44-4970-8cc2-a0d8d3984069 2025-12-10 17:06:58,677 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/d55cd660-2a63-4dcd-a324-1b7fad9c93e6 2025-12-10 17:06:58,691 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/e7317fe2-2869-4bf0-9f12-682a55ff1bff 2025-12-10 17:07:01,980 - 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 1015ms') 2025-12-10 17:07:01,980 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-00798692 failed! 2025-12-10 17:07:02,033 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149 is 126.57.115.1 and allocation pool is NOT set 2025-12-10 17:07:06,102 - 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 1015ms') 2025-12-10 17:07:06,102 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-00798692 failed! 2025-12-10 17:07:06,153 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149 is 126.57.115.1 and allocation pool is NOT set 2025-12-10 17:07:10,232 - 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 1024ms') 2025-12-10 17:07:10,232 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-00798692 failed! 2025-12-10 17:07:10,285 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149 is 126.57.115.1 and allocation pool is NOT set 2025-12-10 17:07:14,367 - 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') 2025-12-10 17:07:14,367 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-00798692 failed! 2025-12-10 17:07:14,425 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149 is 126.57.115.1 and allocation pool is NOT set 2025-12-10 17:07:16,489 - 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=3.34 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.720 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.720/2.029/3.338/1.309 ms') 2025-12-10 17:07:16,490 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-00798692 passed 2025-12-10 17:07:16,641 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:16,641 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-00798692, IP 126.57.115.3, Port 22 2025-12-10 17:07:16,706 - 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': ''} 2025-12-10 17:07:16,781 - DEBUG - VM ctest-pt_svm0-00798692 is NOT ready for SSH connections, VM status: ACTIVE 2025-12-10 17:07:21,782 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:21,782 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-00798692, IP 126.57.115.3, Port 22 2025-12-10 17:07:21,837 - 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': ''} 2025-12-10 17:07:21,905 - DEBUG - VM ctest-pt_svm0-00798692 is NOT ready for SSH connections, VM status: ACTIVE 2025-12-10 17:07:26,906 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:26,906 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-00798692, IP 126.57.115.3, Port 22 2025-12-10 17:07:26,960 - 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': ''} 2025-12-10 17:07:27,037 - DEBUG - VM ctest-pt_svm0-00798692 is NOT ready for SSH connections, VM status: ACTIVE 2025-12-10 17:07:32,037 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:32,038 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-00798692, IP 126.57.115.3, Port 22 2025-12-10 17:07:32,189 - DEBUG - VM ctest-pt_svm0-00798692 is ready for SSH connections 2025-12-10 17:07:32,341 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:32,341 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-00798692, IP 126.57.115.3, Port 22 2025-12-10 17:07:32,493 - DEBUG - VM ctest-pt_svm0-00798692 is ready for SSH connections 2025-12-10 17:07:32,641 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:32,641 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-00798692, IP 126.57.115.3, Port 22 2025-12-10 17:07:32,796 - DEBUG - VM ctest-pt_svm0-00798692 is ready for SSH connections 2025-12-10 17:07:32,801 - DEBUG - Creating service instance: ['default-domain', 'ctest-TestSvcRegr-48409792', 'ctest-si-56604119'] 2025-12-10 17:07:33,641 - INFO - Waiting for VM ctest-left_vm-58674545 to be up.. 2025-12-10 17:07:33,705 - DEBUG - VM is in ACTIVE state now 2025-12-10 17:07:33,705 - INFO - VM name : ctest-left_vm-58674545 2025-12-10 17:07:33,777 - DEBUG - VM ctest-left_vm-58674545 ID is ae6fa152-3849-4674-be98-c207309532cd 2025-12-10 17:07:33,777 - DEBUG - VM ctest-left_vm-58674545 launched on Node cn-jenkins-deploy-platform-ansible-os-4878-1 2025-12-10 17:07:33,851 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine/ae6fa152-3849-4674-be98-c207309532cd 2025-12-10 17:07:33,858 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/a5928aa6-be3a-45b9-b8e2-1f5762666d4b 2025-12-10 17:07:35,096 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=2.52 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.340 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.340/1.427/2.515/1.087 ms') 2025-12-10 17:07:35,096 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-left_vm-58674545 passed 2025-12-10 17:07:35,245 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:35,245 - DEBUG - Waiting to SSH to VM ctest-left_vm-58674545, IP 20.129.62.131, Port 22 2025-12-10 17:07:35,397 - DEBUG - VM ctest-left_vm-58674545 is ready for SSH connections 2025-12-10 17:07:35,397 - INFO - Waiting for VM ctest-right_vm-17728824 to be up.. 2025-12-10 17:07:35,461 - DEBUG - VM is in ACTIVE state now 2025-12-10 17:07:35,461 - INFO - VM name : ctest-right_vm-17728824 2025-12-10 17:07:35,523 - DEBUG - VM ctest-right_vm-17728824 ID is bd6897df-c8ed-4200-9ece-b906ce093b6d 2025-12-10 17:07:35,523 - DEBUG - VM ctest-right_vm-17728824 launched on Node cn-jenkins-deploy-platform-ansible-os-4878-1 2025-12-10 17:07:35,586 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine/bd6897df-c8ed-4200-9ece-b906ce093b6d 2025-12-10 17:07:35,592 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/85ef4e99-e54c-40a4-babd-a5f98b75c594 2025-12-10 17:07:36,819 - 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.79 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.357 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.357/1.572/2.787/1.215 ms') 2025-12-10 17:07:36,819 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-right_vm-17728824 passed 2025-12-10 17:07:36,965 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:36,965 - DEBUG - Waiting to SSH to VM ctest-right_vm-17728824, IP 184.184.104.131, Port 22 2025-12-10 17:07:37,117 - DEBUG - VM ctest-right_vm-17728824 is ready for SSH connections 2025-12-10 17:07:37,122 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestSvcRegr-48409792:ctest-left_vn-55296171, 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-48409792:ctest-right_vn-15119370, 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-48409792:ctest-si-56604119'], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None] 2025-12-10 17:07:37,549 - INFO - Attaching policy ctest-policy-60871936 to vn ctest-left_vn-55296171 2025-12-10 17:07:38,077 - INFO - Attaching policy ctest-policy-60871936 to vn ctest-right_vn-15119370 2025-12-10 17:07:38,509 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-59012667'] created succesfully 2025-12-10 17:07:38,717 - DEBUG - Service instance: ['default-domain', 'ctest-TestSvcRegr-48409792', 'ctest-si-56604119'] created succesfully 2025-12-10 17:07:38,717 - DEBUG - Requesting: http://10.0.0.141:8082/domains 2025-12-10 17:07:38,723 - DEBUG - Requesting: http://10.0.0.141:8082/domain/012a191c-4dbe-4738-824a-1fb29bb5bf4c 2025-12-10 17:07:38,733 - DEBUG - Requesting: http://10.0.0.141:8082/project/1f518ebd-7a1e-4821-b257-80116955cda7 2025-12-10 17:07:38,803 - DEBUG - Requesting: http://10.0.0.141:8082/service-instance/6615e077-2204-42f8-b2dd-ae675afb8a9e 2025-12-10 17:07:38,815 - DEBUG - SI 'ctest-si-56604119' has service template ref to ctest-service_template_1-59012667 2025-12-10 17:07:38,815 - DEBUG - Requesting: http://10.0.0.141:8082/domains 2025-12-10 17:07:38,822 - DEBUG - Requesting: http://10.0.0.141:8082/domain/012a191c-4dbe-4738-824a-1fb29bb5bf4c 2025-12-10 17:07:38,833 - DEBUG - Requesting: http://10.0.0.141:8082/project/1f518ebd-7a1e-4821-b257-80116955cda7 2025-12-10 17:07:38,901 - DEBUG - Requesting: http://10.0.0.141:8082/service-instance/6615e077-2204-42f8-b2dd-ae675afb8a9e 2025-12-10 17:07:38,907 - DEBUG - Requesting: http://10.0.0.141:8082/port-tuple/a05a00ac-dcb7-4d4b-80b6-11ef8491d9ba 2025-12-10 17:07:38,913 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/8d6f8751-3d44-4970-8cc2-a0d8d3984069 2025-12-10 17:07:38,923 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/d55cd660-2a63-4dcd-a324-1b7fad9c93e6 2025-12-10 17:07:38,936 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/e7317fe2-2869-4bf0-9f12-682a55ff1bff 2025-12-10 17:07:39,116 - DEBUG - VM is in ACTIVE state now 2025-12-10 17:07:39,465 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine/dac00747-c648-4503-b9b5-ba2b3dee5aa8 2025-12-10 17:07:39,471 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/8d6f8751-3d44-4970-8cc2-a0d8d3984069 2025-12-10 17:07:39,479 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/d55cd660-2a63-4dcd-a324-1b7fad9c93e6 2025-12-10 17:07:39,488 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/e7317fe2-2869-4bf0-9f12-682a55ff1bff 2025-12-10 17:07:39,498 - DEBUG - Requesting: http://10.0.0.141:8082/instance-ip/2e249574-2653-415e-a32f-8f5a51fca203 2025-12-10 17:07:39,505 - DEBUG - Requesting: http://10.0.0.141:8082/instance-ip/cbabc7ba-5949-4608-9f6c-71eef12b2e73 2025-12-10 17:07:39,513 - DEBUG - Requesting: http://10.0.0.141:8082/instance-ip/d53b5eee-240c-4db6-b7ab-138069ecff1d 2025-12-10 17:07:39,520 - DEBUG - Requesting: http://10.0.0.141:8082/instance-ip/0a8bed1b-6875-4768-b09c-b3a775089039 2025-12-10 17:07:39,528 - DEBUG - Requesting: http://10.0.0.141:8082/instance-ip/2d6fed27-a1de-4e22-8a84-d6031d4d0e90 2025-12-10 17:07:39,535 - DEBUG - Requesting: http://10.0.0.141:8082/instance-ip/b9c2fcdc-17e8-4e83-8008-d45f6188fda3 2025-12-10 17:07:39,542 - DEBUG - Requesting: http://10.0.0.141:8082/instance-ip/2cb96f07-baa9-4332-82dd-bbc1165f2ee4 2025-12-10 17:07:39,548 - DEBUG - Requesting: http://10.0.0.141:8082/instance-ip/496298f7-5101-4939-9c8c-d6719be0b016 2025-12-10 17:07:39,554 - DEBUG - Requesting: http://10.0.0.141:8082/instance-ip/868ed937-03f8-469d-91d2-446c0cd405e9 2025-12-10 17:07:39,874 - DEBUG - VM is in ACTIVE state now 2025-12-10 17:07:39,874 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine/dac00747-c648-4503-b9b5-ba2b3dee5aa8 2025-12-10 17:07:39,880 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/8d6f8751-3d44-4970-8cc2-a0d8d3984069 2025-12-10 17:07:39,887 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/d55cd660-2a63-4dcd-a324-1b7fad9c93e6 2025-12-10 17:07:39,894 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/e7317fe2-2869-4bf0-9f12-682a55ff1bff 2025-12-10 17:07:41,129 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n64 bytes from 169.254.0.6: icmp_seq=1 ttl=63 time=1.23 ms\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=0.585 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.585/0.908/1.231/0.323 ms') 2025-12-10 17:07:41,130 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-pt_svm0-00798692 passed 2025-12-10 17:07:41,167 - DEBUG - VM ctest-pt_svm0-00798692 Tap interface: {'index': '6', 'name': 'tape7317fe2-28', 'uuid': 'e7317fe2-2869-4bf0-9f12-682a55ff1bff', 'vrf_name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-left_vn-55296171:ctest-left_vn-55296171', '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': '13', 'vn_name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-left_vn-55296171', 'vm_uuid': 'dac00747-c648-4503-b9b5-ba2b3dee5aa8', 'vm_name': 'ctest-pt_svm0-00798692', 'ip_addr': '20.129.62.132', 'mac_addr': '02:e7:31:7f:e2:28', '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-48409792:e7317fe2-2869-4bf0-9f12-682a55ff1bff', 'sg_uuid_list': ['1132682f-f12f-400e-b515-7634e3c29d16'], 'static_route_list': None, 'vm_project_uuid': '1f518ebd-7a1e-4821-b257-80116955cda7', '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': '8d6f8751-3d44-4970-8cc2-a0d8d3984069', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []} 2025-12-10 17:07:41,167 - DEBUG - Agent 10.0.0.141 vrf name: default-domain:ctest-TestSvcRegr-48409792:ctest-left_vn-55296171:ctest-left_vn-55296171 2025-12-10 17:07:41,171 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-left_vn-55296171:ctest-left_vn-55296171', 'ucindex': '2', 'mcindex': '2', 'l2index': '2', 'source': 'Config; ', 'uc6index': '2', 'vn': 'default-domain:ctest-TestSvcRegr-48409792:ctest-left_vn-55296171', 'table_label': '-1', 'vxlan_id': '13', 'evpnindex': '2', 'brindex': '2', 'mplsindex': '0', 'RD': '10.20.0.193:2', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]} 2025-12-10 17:07:41,328 - DEBUG - VM ctest-pt_svm0-00798692 : Tap interface tape7317fe2-28 is set to Active 2025-12-10 17:07:41,328 - DEBUG - Tap interface tape7317fe2-28 detail : {'index': '6', 'name': 'tape7317fe2-28', 'uuid': 'e7317fe2-2869-4bf0-9f12-682a55ff1bff', 'vrf_name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-left_vn-55296171:ctest-left_vn-55296171', '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': '13', 'vn_name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-left_vn-55296171', 'vm_uuid': 'dac00747-c648-4503-b9b5-ba2b3dee5aa8', 'vm_name': 'ctest-pt_svm0-00798692', 'ip_addr': '20.129.62.132', 'mac_addr': '02:e7:31:7f:e2:28', '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-48409792:e7317fe2-2869-4bf0-9f12-682a55ff1bff', 'sg_uuid_list': ['1132682f-f12f-400e-b515-7634e3c29d16'], 'static_route_list': None, 'vm_project_uuid': '1f518ebd-7a1e-4821-b257-80116955cda7', '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': '8d6f8751-3d44-4970-8cc2-a0d8d3984069', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []} 2025-12-10 17:07:41,521 - DEBUG - Starting Layer 2 verification in Agent 2025-12-10 17:07:41,531 - DEBUG - Layer 2 path is seen for VM MAC 02:e7:31:7f:e2:28 in agent 10.0.0.141 2025-12-10 17:07:41,531 - DEBUG - Active layer 2 route in agent is present for VMI tape7317fe2-28 2025-12-10 17:07:41,531 - DEBUG - L2 label(48) matches bw route table and interface table 2025-12-10 17:07:41,535 - DEBUG - VN default-domain:ctest-TestSvcRegr-48409792:ctest-left_vn-55296171 is found in Agent of node 10.0.0.141 2025-12-10 17:07:41,739 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-48409792:ctest-left_vn-55296171 is consistent in agent 10.0.0.141 2025-12-10 17:07:41,740 - DEBUG - Route for VM IP ['20.129.62.132'] is consistent in agent 10.0.0.141 2025-12-10 17:07:41,740 - DEBUG - VN default-domain:ctest-TestSvcRegr-48409792:ctest-left_vn-55296171 verification for VM ctest-pt_svm0-00798692 in Agent 10.0.0.141 passed 2025-12-10 17:07:41,929 - DEBUG - Starting all layer 2 verification in agent 10.0.0.141 2025-12-10 17:07:41,938 - DEBUG - Route for VM MAC 02:e7:31:7f:e2:28 is consistent in agent 10.0.0.141 2025-12-10 17:07:41,953 - DEBUG - VM ctest-pt_svm0-00798692 Tap interface: {'index': '5', 'name': 'tapd55cd660-2a', 'uuid': 'd55cd660-2a63-4dcd-a324-1b7fad9c93e6', 'vrf_name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149:ctest-mgmt_vn-80685149', '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': '12', 'vn_name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149', 'vm_uuid': 'dac00747-c648-4503-b9b5-ba2b3dee5aa8', 'vm_name': 'ctest-pt_svm0-00798692', 'ip_addr': '126.57.115.3', 'mac_addr': '02:d5:5c:d6:60:2a', '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-48409792:d55cd660-2a63-4dcd-a324-1b7fad9c93e6', 'sg_uuid_list': ['1132682f-f12f-400e-b515-7634e3c29d16'], 'static_route_list': None, 'vm_project_uuid': '1f518ebd-7a1e-4821-b257-80116955cda7', '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': []} 2025-12-10 17:07:41,953 - DEBUG - Agent 10.0.0.141 vrf name: default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149:ctest-mgmt_vn-80685149 2025-12-10 17:07:41,957 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149:ctest-mgmt_vn-80685149', 'ucindex': '4', 'mcindex': '4', 'l2index': '4', 'source': 'Config; ', 'uc6index': '4', 'vn': 'default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149', 'table_label': '-1', 'vxlan_id': '12', 'evpnindex': '4', 'brindex': '4', 'mplsindex': '0', 'RD': '10.20.0.193:4', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]} 2025-12-10 17:07:42,153 - DEBUG - VM ctest-pt_svm0-00798692 : Tap interface tapd55cd660-2a is set to Active 2025-12-10 17:07:42,153 - DEBUG - Tap interface tapd55cd660-2a detail : {'index': '5', 'name': 'tapd55cd660-2a', 'uuid': 'd55cd660-2a63-4dcd-a324-1b7fad9c93e6', 'vrf_name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149:ctest-mgmt_vn-80685149', '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': '12', 'vn_name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149', 'vm_uuid': 'dac00747-c648-4503-b9b5-ba2b3dee5aa8', 'vm_name': 'ctest-pt_svm0-00798692', 'ip_addr': '126.57.115.3', 'mac_addr': '02:d5:5c:d6:60:2a', '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-48409792:d55cd660-2a63-4dcd-a324-1b7fad9c93e6', 'sg_uuid_list': ['1132682f-f12f-400e-b515-7634e3c29d16'], 'static_route_list': None, 'vm_project_uuid': '1f518ebd-7a1e-4821-b257-80116955cda7', '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': []} 2025-12-10 17:07:42,345 - DEBUG - Starting Layer 2 verification in Agent 2025-12-10 17:07:42,354 - DEBUG - Layer 2 path is seen for VM MAC 02:d5:5c:d6:60:2a in agent 10.0.0.141 2025-12-10 17:07:42,354 - DEBUG - Active layer 2 route in agent is present for VMI tapd55cd660-2a 2025-12-10 17:07:42,354 - DEBUG - L2 label(43) matches bw route table and interface table 2025-12-10 17:07:42,358 - DEBUG - VN default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149 is found in Agent of node 10.0.0.141 2025-12-10 17:07:42,573 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149 is consistent in agent 10.0.0.141 2025-12-10 17:07:42,573 - DEBUG - Route for VM IP ['126.57.115.3'] is consistent in agent 10.0.0.141 2025-12-10 17:07:42,573 - DEBUG - VN default-domain:ctest-TestSvcRegr-48409792:ctest-mgmt_vn-80685149 verification for VM ctest-pt_svm0-00798692 in Agent 10.0.0.141 passed 2025-12-10 17:07:42,765 - DEBUG - Starting all layer 2 verification in agent 10.0.0.141 2025-12-10 17:07:42,773 - DEBUG - Route for VM MAC 02:d5:5c:d6:60:2a is consistent in agent 10.0.0.141 2025-12-10 17:07:42,788 - DEBUG - VM ctest-pt_svm0-00798692 Tap interface: {'index': '7', 'name': 'tap8d6f8751-3d', 'uuid': '8d6f8751-3d44-4970-8cc2-a0d8d3984069', 'vrf_name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-right_vn-15119370:ctest-right_vn-15119370', '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': '14', 'vn_name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-right_vn-15119370', 'vm_uuid': 'dac00747-c648-4503-b9b5-ba2b3dee5aa8', 'vm_name': 'ctest-pt_svm0-00798692', 'ip_addr': '184.184.104.132', 'mac_addr': '02:8d:6f:87:51:3d', '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-48409792:8d6f8751-3d44-4970-8cc2-a0d8d3984069', 'sg_uuid_list': ['1132682f-f12f-400e-b515-7634e3c29d16'], 'static_route_list': None, 'vm_project_uuid': '1f518ebd-7a1e-4821-b257-80116955cda7', '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': 'e7317fe2-2869-4bf0-9f12-682a55ff1bff', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []} 2025-12-10 17:07:42,788 - DEBUG - Agent 10.0.0.141 vrf name: default-domain:ctest-TestSvcRegr-48409792:ctest-right_vn-15119370:ctest-right_vn-15119370 2025-12-10 17:07:42,792 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-right_vn-15119370:ctest-right_vn-15119370', 'ucindex': '3', 'mcindex': '3', 'l2index': '3', 'source': 'Config; ', 'uc6index': '3', 'vn': 'default-domain:ctest-TestSvcRegr-48409792:ctest-right_vn-15119370', 'table_label': '-1', 'vxlan_id': '14', 'evpnindex': '3', 'brindex': '3', 'mplsindex': '0', 'RD': '10.20.0.193:3', 'mac_aging_time': '0', 'layer2_control_word': 'false', 'forwarding_vrf': None, 'hbf_rintf': '-1', 'hbf_lintf': '-1'}]} 2025-12-10 17:07:42,991 - DEBUG - VM ctest-pt_svm0-00798692 : Tap interface tap8d6f8751-3d is set to Active 2025-12-10 17:07:42,991 - DEBUG - Tap interface tap8d6f8751-3d detail : {'index': '7', 'name': 'tap8d6f8751-3d', 'uuid': '8d6f8751-3d44-4970-8cc2-a0d8d3984069', 'vrf_name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-right_vn-15119370:ctest-right_vn-15119370', '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': '14', 'vn_name': 'default-domain:ctest-TestSvcRegr-48409792:ctest-right_vn-15119370', 'vm_uuid': 'dac00747-c648-4503-b9b5-ba2b3dee5aa8', 'vm_name': 'ctest-pt_svm0-00798692', 'ip_addr': '184.184.104.132', 'mac_addr': '02:8d:6f:87:51:3d', '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-48409792:8d6f8751-3d44-4970-8cc2-a0d8d3984069', 'sg_uuid_list': ['1132682f-f12f-400e-b515-7634e3c29d16'], 'static_route_list': None, 'vm_project_uuid': '1f518ebd-7a1e-4821-b257-80116955cda7', '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': 'e7317fe2-2869-4bf0-9f12-682a55ff1bff', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []} 2025-12-10 17:07:43,185 - DEBUG - Starting Layer 2 verification in Agent 2025-12-10 17:07:43,194 - DEBUG - Layer 2 path is seen for VM MAC 02:8d:6f:87:51:3d in agent 10.0.0.141 2025-12-10 17:07:43,194 - DEBUG - Active layer 2 route in agent is present for VMI tap8d6f8751-3d 2025-12-10 17:07:43,194 - DEBUG - L2 label(53) matches bw route table and interface table 2025-12-10 17:07:43,199 - DEBUG - VN default-domain:ctest-TestSvcRegr-48409792:ctest-right_vn-15119370 is found in Agent of node 10.0.0.141 2025-12-10 17:07:43,408 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-48409792:ctest-right_vn-15119370 is consistent in agent 10.0.0.141 2025-12-10 17:07:43,408 - DEBUG - Route for VM IP ['184.184.104.132'] is consistent in agent 10.0.0.141 2025-12-10 17:07:43,408 - DEBUG - VN default-domain:ctest-TestSvcRegr-48409792:ctest-right_vn-15119370 verification for VM ctest-pt_svm0-00798692 in Agent 10.0.0.141 passed 2025-12-10 17:07:43,605 - DEBUG - Starting all layer 2 verification in agent 10.0.0.141 2025-12-10 17:07:43,614 - DEBUG - Route for VM MAC 02:8d:6f:87:51:3d is consistent in agent 10.0.0.141 2025-12-10 17:07:43,615 - INFO - VM ctest-pt_svm0-00798692 verifications in Compute nodes passed 2025-12-10 17:07:43,615 - DEBUG - The SVMs in the SI are : [] 2025-12-10 17:07:43,615 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine/dac00747-c648-4503-b9b5-ba2b3dee5aa8 2025-12-10 17:07:43,622 - DEBUG - Service VM for SI 'ctest-si-56604119' is launched 2025-12-10 17:07:43,622 - DEBUG - Requesting: http://10.0.0.141:8082/domains 2025-12-10 17:07:43,627 - DEBUG - Requesting: http://10.0.0.141:8082/domain/012a191c-4dbe-4738-824a-1fb29bb5bf4c 2025-12-10 17:07:43,636 - DEBUG - Requesting: http://10.0.0.141:8082/project/1f518ebd-7a1e-4821-b257-80116955cda7 2025-12-10 17:07:43,704 - DEBUG - Requesting: http://10.0.0.141:8082/service-instance/6615e077-2204-42f8-b2dd-ae675afb8a9e 2025-12-10 17:07:43,713 - DEBUG - SI ctest-si-56604119 has Port Tuple: ['ctest-port_tuple-94828221'] 2025-12-10 17:07:43,813 - INFO - VMI and/or RI refs are present for VN default-domain:ctest-TestSvcRegr-48409792:ctest-left_vn-55296171 2025-12-10 17:07:43,957 - INFO - VMI and/or RI refs are present for VN default-domain:ctest-TestSvcRegr-48409792:ctest-right_vn-15119370 2025-12-10 17:07:44,106 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:44,113 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:44,113 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:44,117 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:44,117 - INFO - Route to 184.184.104.131 seen in VRF:5 on cn-jenkins-deploy-platform-ansible-os-4878-1, and SI ctest-si-56604119 is seen as the NH 2025-12-10 17:07:44,266 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:44,272 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:44,272 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:44,277 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:44,277 - INFO - Route to 20.129.62.131 seen in VRF:6 on cn-jenkins-deploy-platform-ansible-os-4878-1, and SI ctest-si-56604119 is seen as the NH 2025-12-10 17:07:44,277 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:44,277 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-10 17:07:44,277 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 184.184.104.131, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.141, gateway password: c0ntrail123 2025-12-10 17:07:44,278 - DEBUG - ping -s 56 -c 3 -W 1 184.184.104.131 2025-12-10 17:07:48,244 - DEBUG - PING 184.184.104.131 (184.184.104.131): 56 data bytes 64 bytes from 184.184.104.131: seq=0 ttl=61 time=6.226 ms 64 bytes from 184.184.104.131: seq=1 ttl=61 time=1.572 ms 64 bytes from 184.184.104.131: seq=2 ttl=61 time=1.378 ms --- 184.184.104.131 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.378/3.058/6.226 ms 2025-12-10 17:07:48,244 - INFO - Ping to IP 184.184.104.131 from VM ctest-left_vm-58674545 passed 2025-12-10 17:07:48,244 - INFO - Dettaching policy ctest-policy-60871936 from vn ctest-right_vn-15119370 2025-12-10 17:07:48,445 - INFO - Dettaching policy ctest-policy-60871936 from vn ctest-left_vn-55296171 2025-12-10 17:07:48,708 - INFO - Deleted policy ctest-policy-60871936 2025-12-10 17:07:48,708 - DEBUG - Deleting service instance: ['default-domain', 'ctest-TestSvcRegr-48409792', 'ctest-si-56604119'] 2025-12-10 17:07:48,790 - INFO - Deleted SI ['default-domain', 'ctest-TestSvcRegr-48409792', 'ctest-si-56604119'] 2025-12-10 17:07:48,790 - DEBUG - Requesting: http://10.0.0.141:8082/domains 2025-12-10 17:07:48,795 - DEBUG - Requesting: http://10.0.0.141:8082/domain/012a191c-4dbe-4738-824a-1fb29bb5bf4c 2025-12-10 17:07:48,807 - DEBUG - Requesting: http://10.0.0.141:8082/project/1f518ebd-7a1e-4821-b257-80116955cda7 2025-12-10 17:07:48,880 - DEBUG - Service instance ctest-si-56604119 removed from api server 2025-12-10 17:07:48,880 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine/dac00747-c648-4503-b9b5-ba2b3dee5aa8 2025-12-10 17:07:48,886 - DEBUG - All Service VMs unlinked from SI ctest-si-56604119 2025-12-10 17:07:48,890 - DEBUG - 0 svc intances found in all projects. They are [] 2025-12-10 17:07:48,890 - DEBUG - 0 svc intances found in current project. They are [] 2025-12-10 17:07:48,937 - DEBUG - 0 svc intances found in all projects. They are [] 2025-12-10 17:07:48,937 - DEBUG - 0 svc intances found in current project. They are [] 2025-12-10 17:07:48,937 - INFO - Deleting VM ctest-pt_svm0-00798692 2025-12-10 17:07:49,012 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-59012667'] 2025-12-10 17:07:49,085 - INFO - Service template: ['default-domain', 'ctest-service_template_1-59012667'] deleted successfully. 2025-12-10 17:07:49,085 - INFO - Deleting VM ctest-right_vm-17728824 2025-12-10 17:07:49,177 - INFO - Deleting VM ctest-left_vm-58674545 2025-12-10 17:07:49,259 - INFO - Deleting VN ctest-right_vn-15119370 2025-12-10 17:07:49,290 - DEBUG - VN 5b716446-1a42-4a0f-8622-2ee25cfb6ffc still in use: Unable to complete operation on network 5b716446-1a42-4a0f-8622-2ee25cfb6ffc. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-3a384c25-b89b-4ea0-a088-9d458000ba21'] 2025-12-10 17:07:49,290 - WARNING - Deleting VN ctest-right_vn-15119370 failed..Will retry 2025-12-10 17:07:51,371 - DEBUG - Response for deleting network () 2025-12-10 17:07:51,371 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/d4f57e95-e7b5-4407-98aa-44cdfe1331f0 2025-12-10 17:07:51,377 - DEBUG - Response Code: 404 2025-12-10 17:07:51,377 - DEBUG - Requesting: http://10.0.0.141:8082/domains 2025-12-10 17:07:51,389 - DEBUG - Requesting: http://10.0.0.141:8082/domain/012a191c-4dbe-4738-824a-1fb29bb5bf4c 2025-12-10 17:07:51,444 - DEBUG - Requesting: http://10.0.0.141:8082/project/1f518ebd-7a1e-4821-b257-80116955cda7 2025-12-10 17:07:51,513 - INFO - Validated that VN ctest-right_vn-15119370 is not found in API Server 2025-12-10 17:07:51,521 - DEBUG - VN ctest-right_vn-15119370 is not present in Agent 10.0.0.141 2025-12-10 17:07:51,521 - INFO - Validated that VN ctest-right_vn-15119370 is not in any agent 2025-12-10 17:07:51,531 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-15119370 info 2025-12-10 17:07:51,531 - INFO - Deleting VN ctest-left_vn-55296171 2025-12-10 17:07:51,614 - DEBUG - Response for deleting network () 2025-12-10 17:07:51,614 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7236ec36-2929-4160-8f47-e5ea25722134 2025-12-10 17:07:51,619 - DEBUG - Response Code: 404 2025-12-10 17:07:51,619 - DEBUG - Requesting: http://10.0.0.141:8082/domains 2025-12-10 17:07:51,623 - DEBUG - Requesting: http://10.0.0.141:8082/domain/012a191c-4dbe-4738-824a-1fb29bb5bf4c 2025-12-10 17:07:51,678 - DEBUG - Requesting: http://10.0.0.141:8082/project/1f518ebd-7a1e-4821-b257-80116955cda7 2025-12-10 17:07:51,747 - INFO - Validated that VN ctest-left_vn-55296171 is not found in API Server 2025-12-10 17:07:51,758 - DEBUG - VN ctest-left_vn-55296171 is not present in Agent 10.0.0.141 2025-12-10 17:07:51,758 - INFO - Validated that VN ctest-left_vn-55296171 is not in any agent 2025-12-10 17:07:51,774 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-55296171 info 2025-12-10 17:07:51,774 - INFO - Deleting VN ctest-mgmt_vn-80685149 2025-12-10 17:07:51,862 - DEBUG - Response for deleting network () 2025-12-10 17:07:51,862 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/073aa4f0-59d5-4e1f-abb9-572ee89f0a44 2025-12-10 17:07:51,867 - DEBUG - Response Code: 404 2025-12-10 17:07:51,867 - DEBUG - Requesting: http://10.0.0.141:8082/domains 2025-12-10 17:07:51,871 - DEBUG - Requesting: http://10.0.0.141:8082/domain/012a191c-4dbe-4738-824a-1fb29bb5bf4c 2025-12-10 17:07:51,921 - DEBUG - Requesting: http://10.0.0.141:8082/project/1f518ebd-7a1e-4821-b257-80116955cda7 2025-12-10 17:07:51,986 - INFO - Validated that VN ctest-mgmt_vn-80685149 is not found in API Server 2025-12-10 17:07:51,996 - DEBUG - VN ctest-mgmt_vn-80685149 is not present in Agent 10.0.0.141 2025-12-10 17:07:51,997 - INFO - Validated that VN ctest-mgmt_vn-80685149 is not in any agent 2025-12-10 17:07:52,010 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-80685149 info 2025-12-10 17:07:52,261 - DEBUG - No XMPP flaps were noticed during the test 2025-12-10 17:07:52,261 - INFO -
2025-12-10 17:07:52,261 - INFO - END TEST : test_svc_in_network_datapath : PASSED[0:01:07]
2025-12-10 17:07:52,261 - INFO - -------------------------------------------------------------------------------- 2025-12-10 17:07:52,942 - INFO - Deleted project: ctest-TestSvcRegr-48409792, ID : 1f518ebd-7a1e-4821-b257-80116955cda7