2026-04-22 13:38:17,061 - INFO - Domain Default found not creating
2026-04-22 13:38:17,221 - INFO - Project ctest-TestSvcRegr-95960813 not found, creating it
2026-04-22 13:38:17,677 - INFO - Created Project:ctest-TestSvcRegr-95960813, ID : db3d3b58-a623-4de6-8078-b617b055d267
2026-04-22 13:38:19,446 - INFO - ================================================================================
2026-04-22 13:38:19,446 - INFO - STARTING TEST : test_svc_in_network_datapath
2026-04-22 13:38:19,714 - DEBUG - Nothing to compare xmpp stats {'10.0.0.27': {'10.20.0.17': '0'}} with
2026-04-22 13:38:19,714 - INFO - Initial checks done. Running the testcase now
2026-04-22 13:38:19,714 - INFO -
2026-04-22 13:38:20,308 - DEBUG - Response for create_network : {'network': {'id': 'f26065c5-7fc6-4252-8309-f2a8f1bfb647', 'name': 'ctest-mgmt_vn-21733823', 'tenant_id': 'db3d3b58a6234de68078b617b055d267', 'project_id': 'db3d3b58a6234de68078b617b055d267', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-95960813', 'ctest-mgmt_vn-21733823'], 'port_security_enabled': True, 'description': ''}}
2026-04-22 13:38:20,485 - DEBUG - Response for create_subnet : {'subnet': {'id': '01369477-bb1a-4988-8843-570eda1dcb9a', 'name': '', 'tenant_id': 'db3d3b58a6234de68078b617b055d267', 'network_id': 'f26065c5-7fc6-4252-8309-f2a8f1bfb647', 'ip_version': 4, 'cidr': '219.91.33.128/26', 'allocation_pools': [{'start': '219.91.33.130', 'end': '219.91.33.190'}], 'gateway_ip': '219.91.33.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '219.91.33.130', 'tags': [], 'project_id': 'db3d3b58a6234de68078b617b055d267'}}
2026-04-22 13:38:20,506 - INFO - Created VN ctest-mgmt_vn-21733823
2026-04-22 13:38:20,560 - DEBUG - VN ctest-mgmt_vn-21733823 UUID is f26065c5-7fc6-4252-8309-f2a8f1bfb647
2026-04-22 13:38:20,665 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-04-22 13:38:20,956 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-04-22 13:38:20,983 - DEBUG - Requesting: http://10.0.0.27:8082/domain/3d4477e5-6f25-4379-ad0e-f85d3877549d
2026-04-22 13:38:20,993 - DEBUG - Requesting: http://10.0.0.27:8082/project/db3d3b58-a623-4de6-8078-b617b055d267
2026-04-22 13:38:21,062 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/f26065c5-7fc6-4252-8309-f2a8f1bfb647
2026-04-22 13:38:21,072 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/f26065c5-7fc6-4252-8309-f2a8f1bfb647
2026-04-22 13:38:21,081 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3afe94af-3fcb-49ec-baf3-d2629f10e49d
2026-04-22 13:38:21,087 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3afe94af-3fcb-49ec-baf3-d2629f10e49d
2026-04-22 13:38:21,093 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/ccb5343f-a5c9-4797-8c2f-8f25ccbb7510
2026-04-22 13:38:21,099 - DEBUG - Route Targets: ['target:64512:8000004']
2026-04-22 13:38:21,099 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/f26065c5-7fc6-4252-8309-f2a8f1bfb647
2026-04-22 13:38:21,108 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3afe94af-3fcb-49ec-baf3-d2629f10e49d
2026-04-22 13:38:21,119 - INFO - Verified VN network id 11 for VN f26065c5-7fc6-4252-8309-f2a8f1bfb647
2026-04-22 13:38:21,119 - INFO - Verifications in API Server for VN ctest-mgmt_vn-21733823 passed
2026-04-22 13:38:21,120 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/f26065c5-7fc6-4252-8309-f2a8f1bfb647
2026-04-22 13:38:21,127 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3afe94af-3fcb-49ec-baf3-d2629f10e49d
2026-04-22 13:38:21,132 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3afe94af-3fcb-49ec-baf3-d2629f10e49d
2026-04-22 13:38:21,137 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/ccb5343f-a5c9-4797-8c2f-8f25ccbb7510
2026-04-22 13:38:21,146 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95960813:ctest-mgmt_vn-21733823', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95960813', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17465071253869445714', 'uuid-lslong': '9442344901183256135'}, 'enable': 'true', 'created': '2026-04-22T13:38:20', 'last-modified': '2026-04-22T13:38:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.696527'}
2026-04-22 13:38:21,152 - DEBUG - Route Targets: ['target:64512:8000004']
2026-04-22 13:38:21,152 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-21733823 passed
2026-04-22 13:38:21,152 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-21733823 in API_Server ======
2026-04-22 13:38:21,152 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-04-22 13:38:21,157 - DEBUG - Requesting: http://10.0.0.27:8082/domain/3d4477e5-6f25-4379-ad0e-f85d3877549d
2026-04-22 13:38:21,166 - DEBUG - Requesting: http://10.0.0.27:8082/project/db3d3b58-a623-4de6-8078-b617b055d267
2026-04-22 13:38:21,234 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/f26065c5-7fc6-4252-8309-f2a8f1bfb647
2026-04-22 13:38:21,241 - DEBUG - =>VN ctest-mgmt_vn-21733823 has no policy to be verified
2026-04-22 13:38:21,241 - DEBUG - Verifying the vn in opserver
2026-04-22 13:38:21,241 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95960813:ctest-mgmt_vn-21733823 virtual network link through opserver 10.0.0.27
2026-04-22 13:38:21,241 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-04-22 13:38:21,535 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-04-22 13:38:21,589 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95960813:ctest-mgmt_vn-21733823', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95960813:ctest-mgmt_vn-21733823?flat'}
2026-04-22 13:38:21,589 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-95960813:ctest-mgmt_vn-21733823 is found in opserver
2026-04-22 13:38:21,598 - DEBUG - Do not have enough data to verify VN in agent
2026-04-22 13:38:21,602 - DEBUG - VRF ids for VN ctest-mgmt_vn-21733823: {}
2026-04-22 13:38:21,761 - DEBUG - Response for create_network : {'network': {'id': '99426896-2d34-420b-9d26-b12375bc808c', 'name': 'ctest-left_vn-87436873', 'tenant_id': 'db3d3b58a6234de68078b617b055d267', 'project_id': 'db3d3b58a6234de68078b617b055d267', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-95960813', 'ctest-left_vn-87436873'], 'port_security_enabled': True, 'description': ''}}
2026-04-22 13:38:21,909 - DEBUG - Response for create_subnet : {'subnet': {'id': '0b3bb0e1-de72-49dd-bb14-af493916ec2b', 'name': '', 'tenant_id': 'db3d3b58a6234de68078b617b055d267', 'network_id': '99426896-2d34-420b-9d26-b12375bc808c', 'ip_version': 4, 'cidr': '191.174.98.0/26', 'allocation_pools': [{'start': '191.174.98.2', 'end': '191.174.98.62'}], 'gateway_ip': '191.174.98.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '191.174.98.2', 'tags': [], 'project_id': 'db3d3b58a6234de68078b617b055d267'}}
2026-04-22 13:38:21,925 - INFO - Created VN ctest-left_vn-87436873
2026-04-22 13:38:21,976 - DEBUG - VN ctest-left_vn-87436873 UUID is 99426896-2d34-420b-9d26-b12375bc808c
2026-04-22 13:38:22,081 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-04-22 13:38:22,086 - DEBUG - Requesting: http://10.0.0.27:8082/domain/3d4477e5-6f25-4379-ad0e-f85d3877549d
2026-04-22 13:38:22,096 - DEBUG - Requesting: http://10.0.0.27:8082/project/db3d3b58-a623-4de6-8078-b617b055d267
2026-04-22 13:38:22,164 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/99426896-2d34-420b-9d26-b12375bc808c
2026-04-22 13:38:22,173 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/99426896-2d34-420b-9d26-b12375bc808c
2026-04-22 13:38:22,180 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/b9c28812-3e4e-4261-a168-86cf487ef1aa
2026-04-22 13:38:22,187 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/b9c28812-3e4e-4261-a168-86cf487ef1aa
2026-04-22 13:38:22,194 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/0d7c2813-26e1-4662-8f71-11464f7ff570
2026-04-22 13:38:22,199 - DEBUG - Route Targets: ['target:64512:8000005']
2026-04-22 13:38:22,199 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/99426896-2d34-420b-9d26-b12375bc808c
2026-04-22 13:38:22,206 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/b9c28812-3e4e-4261-a168-86cf487ef1aa
2026-04-22 13:38:22,218 - INFO - Verified VN network id 12 for VN 99426896-2d34-420b-9d26-b12375bc808c
2026-04-22 13:38:22,219 - INFO - Verifications in API Server for VN ctest-left_vn-87436873 passed
2026-04-22 13:38:22,219 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/99426896-2d34-420b-9d26-b12375bc808c
2026-04-22 13:38:22,226 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/b9c28812-3e4e-4261-a168-86cf487ef1aa
2026-04-22 13:38:22,231 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/b9c28812-3e4e-4261-a168-86cf487ef1aa
2026-04-22 13:38:22,237 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/0d7c2813-26e1-4662-8f71-11464f7ff570
2026-04-22 13:38:22,246 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95960813:ctest-left_vn-87436873', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95960813', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11043504230478660107', 'uuid-lslong': '11323933078926950540'}, 'enable': 'true', 'created': '2026-04-22T13:38:21', 'last-modified': '2026-04-22T13:38:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.364797'}
2026-04-22 13:38:22,251 - DEBUG - Route Targets: ['target:64512:8000005']
2026-04-22 13:38:22,251 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-87436873 passed
2026-04-22 13:38:22,251 - DEBUG - ====Verifying policy data for ctest-left_vn-87436873 in API_Server ======
2026-04-22 13:38:22,251 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-04-22 13:38:22,256 - DEBUG - Requesting: http://10.0.0.27:8082/domain/3d4477e5-6f25-4379-ad0e-f85d3877549d
2026-04-22 13:38:22,267 - DEBUG - Requesting: http://10.0.0.27:8082/project/db3d3b58-a623-4de6-8078-b617b055d267
2026-04-22 13:38:22,336 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/99426896-2d34-420b-9d26-b12375bc808c
2026-04-22 13:38:22,345 - DEBUG - =>VN ctest-left_vn-87436873 has no policy to be verified
2026-04-22 13:38:22,345 - DEBUG - Verifying the vn in opserver
2026-04-22 13:38:22,345 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95960813:ctest-left_vn-87436873 virtual network link through opserver 10.0.0.27
2026-04-22 13:38:22,345 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-04-22 13:38:22,354 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95960813:ctest-left_vn-87436873', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95960813:ctest-left_vn-87436873?flat'}
2026-04-22 13:38:22,354 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-95960813:ctest-left_vn-87436873 is found in opserver
2026-04-22 13:38:22,363 - DEBUG - Do not have enough data to verify VN in agent
2026-04-22 13:38:22,366 - DEBUG - VRF ids for VN ctest-left_vn-87436873: {}
2026-04-22 13:38:22,528 - DEBUG - Response for create_network : {'network': {'id': 'bc13df5e-45fd-4842-b33e-00171e1aef9b', 'name': 'ctest-right_vn-60235500', 'tenant_id': 'db3d3b58a6234de68078b617b055d267', 'project_id': 'db3d3b58a6234de68078b617b055d267', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcRegr-95960813', 'ctest-right_vn-60235500'], 'port_security_enabled': True, 'description': ''}}
2026-04-22 13:38:22,718 - DEBUG - Response for create_subnet : {'subnet': {'id': 'faa22766-1998-460b-b72e-c2bda8c9867e', 'name': '', 'tenant_id': 'db3d3b58a6234de68078b617b055d267', 'network_id': 'bc13df5e-45fd-4842-b33e-00171e1aef9b', 'ip_version': 4, 'cidr': '143.110.239.128/26', 'allocation_pools': [{'start': '143.110.239.130', 'end': '143.110.239.190'}], 'gateway_ip': '143.110.239.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '143.110.239.130', 'tags': [], 'project_id': 'db3d3b58a6234de68078b617b055d267'}}
2026-04-22 13:38:22,734 - INFO - Created VN ctest-right_vn-60235500
2026-04-22 13:38:22,784 - DEBUG - VN ctest-right_vn-60235500 UUID is bc13df5e-45fd-4842-b33e-00171e1aef9b
2026-04-22 13:38:22,890 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-04-22 13:38:22,894 - DEBUG - Requesting: http://10.0.0.27:8082/domain/3d4477e5-6f25-4379-ad0e-f85d3877549d
2026-04-22 13:38:22,904 - DEBUG - Requesting: http://10.0.0.27:8082/project/db3d3b58-a623-4de6-8078-b617b055d267
2026-04-22 13:38:22,971 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/bc13df5e-45fd-4842-b33e-00171e1aef9b
2026-04-22 13:38:22,980 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/bc13df5e-45fd-4842-b33e-00171e1aef9b
2026-04-22 13:38:22,988 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/bf53d24b-f238-435c-9663-a24021816fbc
2026-04-22 13:38:22,994 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/bf53d24b-f238-435c-9663-a24021816fbc
2026-04-22 13:38:23,000 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/55a1f206-770f-4666-950b-942e244c53ac
2026-04-22 13:38:23,005 - DEBUG - Route Targets: ['target:64512:8000006']
2026-04-22 13:38:23,005 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/bc13df5e-45fd-4842-b33e-00171e1aef9b
2026-04-22 13:38:23,013 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/bf53d24b-f238-435c-9663-a24021816fbc
2026-04-22 13:38:23,027 - INFO - Verified VN network id 13 for VN bc13df5e-45fd-4842-b33e-00171e1aef9b
2026-04-22 13:38:23,027 - INFO - Verifications in API Server for VN ctest-right_vn-60235500 passed
2026-04-22 13:38:23,027 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/bc13df5e-45fd-4842-b33e-00171e1aef9b
2026-04-22 13:38:23,035 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/bf53d24b-f238-435c-9663-a24021816fbc
2026-04-22 13:38:23,041 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/bf53d24b-f238-435c-9663-a24021816fbc
2026-04-22 13:38:23,046 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/55a1f206-770f-4666-950b-942e244c53ac
2026-04-22 13:38:23,056 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcRegr-95960813:ctest-right_vn-60235500', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcRegr-95960813', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13552421299682101314', 'uuid-lslong': '12915760880634490779'}, 'enable': 'true', 'created': '2026-04-22T13:38:22', 'last-modified': '2026-04-22T13:38:22', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.361906'}
2026-04-22 13:38:23,061 - DEBUG - Route Targets: ['target:64512:8000006']
2026-04-22 13:38:23,062 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-60235500 passed
2026-04-22 13:38:23,062 - DEBUG - ====Verifying policy data for ctest-right_vn-60235500 in API_Server ======
2026-04-22 13:38:23,062 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-04-22 13:38:23,066 - DEBUG - Requesting: http://10.0.0.27:8082/domain/3d4477e5-6f25-4379-ad0e-f85d3877549d
2026-04-22 13:38:23,076 - DEBUG - Requesting: http://10.0.0.27:8082/project/db3d3b58-a623-4de6-8078-b617b055d267
2026-04-22 13:38:23,143 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/bc13df5e-45fd-4842-b33e-00171e1aef9b
2026-04-22 13:38:23,151 - DEBUG - =>VN ctest-right_vn-60235500 has no policy to be verified
2026-04-22 13:38:23,151 - DEBUG - Verifying the vn in opserver
2026-04-22 13:38:23,151 - DEBUG - Verifying the default-domain:ctest-TestSvcRegr-95960813:ctest-right_vn-60235500 virtual network link through opserver 10.0.0.27
2026-04-22 13:38:23,151 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-04-22 13:38:23,160 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcRegr-95960813:ctest-right_vn-60235500', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcRegr-95960813:ctest-right_vn-60235500?flat'}
2026-04-22 13:38:23,160 - INFO - Validated that VN default-domain:ctest-TestSvcRegr-95960813:ctest-right_vn-60235500 is found in opserver
2026-04-22 13:38:23,168 - DEBUG - Do not have enough data to verify VN in agent
2026-04-22 13:38:23,172 - DEBUG - VRF ids for VN ctest-right_vn-60235500: {}
2026-04-22 13:38:23,223 - DEBUG - Services list from nova: [, , ]
2026-04-22 13:38:24,217 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5666-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5666-1)
2026-04-22 13:38:25,338 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5666-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5666-1)
2026-04-22 13:38:25,339 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-21353308']
2026-04-22 13:38:25,700 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-21353308'] created succesfully
2026-04-22 13:38:26,060 - DEBUG - Image by name cirros_in_net not found
2026-04-22 13:38:26,061 - DEBUG - Installing image cirros_in_net
2026-04-22 13:38:26,061 - 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-04-22 13:38:26,061 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/converts//cirros-in-net.vmdk.gz
2026-04-22 13:38:26,061 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/converts//cirros-in-net.vmdk.gz
2026-04-22 13:38:26,080 - 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-04-22 13:38:26,200 - DEBUG - Image has been downloaded to /contrail-test/images/cirros-in-net.vmdk.gz
2026-04-22 13:38:26,201 - DEBUG - Unzip image
2026-04-22 13:38:26,201 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/cirros-in-net.vmdk.gz
2026-04-22 13:38:26,344 - DEBUG - Try to create image in user context
2026-04-22 13:38:26,563 - DEBUG - Image has been created in user context
2026-04-22 13:38:26,563 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: rm -f /contrail-test/images/cirros-in-net.vmdk
2026-04-22 13:38:26,578 - DEBUG - Downloaded image has been removed
2026-04-22 13:38:26,591 - DEBUG - Uploaded image status = active
2026-04-22 13:38:27,703 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5666-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5666-1)
2026-04-22 13:38:27,703 - INFO - Waiting for VM ctest-pt_svm0-82800744 to be up..
2026-04-22 13:38:27,743 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-04-22 13:38:32,828 - DEBUG - VM is in ACTIVE state now
2026-04-22 13:38:32,828 - INFO - VM name : ctest-pt_svm0-82800744
2026-04-22 13:38:32,909 - DEBUG - VM ctest-pt_svm0-82800744 ID is 720f803a-7838-483d-8af3-10bc44e6c8eb
2026-04-22 13:38:32,927 - DEBUG - VM ctest-pt_svm0-82800744 launched on Node cn-jenkins-deploy-platform-ansible-os-5666-1
2026-04-22 13:38:33,161 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/720f803a-7838-483d-8af3-10bc44e6c8eb
2026-04-22 13:38:33,171 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/37d22dee-c535-411a-9686-43e97a6b46a3
2026-04-22 13:38:33,181 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/413b51a7-5a1e-4afb-b7ac-877586e6c7ce
2026-04-22 13:38:33,191 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/b45f16ca-e03a-4fe7-8b49-38bf76d6fb9f
2026-04-22 13:38:36,468 - 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 1002ms')
2026-04-22 13:38:36,468 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-82800744 failed!
2026-04-22 13:38:36,520 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-95960813:ctest-mgmt_vn-21733823 is 219.91.33.129 and allocation pool is NOT set
2026-04-22 13:38:40,590 - 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')
2026-04-22 13:38:40,590 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-82800744 failed!
2026-04-22 13:38:40,644 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-95960813:ctest-mgmt_vn-21733823 is 219.91.33.129 and allocation pool is NOT set
2026-04-22 13:38:44,725 - 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 1023ms')
2026-04-22 13:38:44,725 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-82800744 failed!
2026-04-22 13:38:44,776 - DEBUG - Gateway for vn default-domain:ctest-TestSvcRegr-95960813:ctest-mgmt_vn-21733823 is 219.91.33.129 and allocation pool is NOT set
2026-04-22 13:38:48,854 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=9.36 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1016ms\r\nrtt min/avg/max/mdev = 9.355/9.355/9.355/0.000 ms')
2026-04-22 13:38:48,854 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-pt_svm0-82800744 passed
2026-04-22 13:38:49,000 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:38:49,000 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-82800744, IP 219.91.33.131, Port 22
2026-04-22 13:38:49,065 - 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-04-22 13:38:49,147 - DEBUG - VM ctest-pt_svm0-82800744 is NOT ready for SSH connections, VM status: ACTIVE
2026-04-22 13:38:54,147 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:38:54,148 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-82800744, IP 219.91.33.131, Port 22
2026-04-22 13:38:54,203 - 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-04-22 13:38:54,278 - DEBUG - VM ctest-pt_svm0-82800744 is NOT ready for SSH connections, VM status: ACTIVE
2026-04-22 13:38:59,279 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:38:59,279 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-82800744, IP 219.91.33.131, Port 22
2026-04-22 13:38:59,346 - 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-04-22 13:38:59,426 - DEBUG - VM ctest-pt_svm0-82800744 is NOT ready for SSH connections, VM status: ACTIVE
2026-04-22 13:39:04,426 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:39:04,426 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-82800744, IP 219.91.33.131, Port 22
2026-04-22 13:39:04,484 - 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-04-22 13:39:04,564 - DEBUG - VM ctest-pt_svm0-82800744 is NOT ready for SSH connections, VM status: ACTIVE
2026-04-22 13:39:09,565 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:39:09,565 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-82800744, IP 219.91.33.131, Port 22
2026-04-22 13:39:09,724 - DEBUG - VM ctest-pt_svm0-82800744 is ready for SSH connections
2026-04-22 13:39:09,872 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:39:09,872 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-82800744, IP 219.91.33.131, Port 22
2026-04-22 13:39:10,032 - DEBUG - VM ctest-pt_svm0-82800744 is ready for SSH connections
2026-04-22 13:39:10,184 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:39:10,184 - DEBUG - Waiting to SSH to VM ctest-pt_svm0-82800744, IP 219.91.33.131, Port 22
2026-04-22 13:39:10,336 - DEBUG - VM ctest-pt_svm0-82800744 is ready for SSH connections
2026-04-22 13:39:10,341 - DEBUG - Creating service instance: ['default-domain', 'ctest-TestSvcRegr-95960813', 'ctest-si-85446061']
2026-04-22 13:39:11,200 - INFO - Waiting for VM ctest-left_vm-01404687 to be up..
2026-04-22 13:39:11,271 - DEBUG - VM is in ACTIVE state now
2026-04-22 13:39:11,271 - INFO - VM name : ctest-left_vm-01404687
2026-04-22 13:39:11,354 - DEBUG - VM ctest-left_vm-01404687 ID is ffffc4bc-e05b-4556-a474-90082176fde5
2026-04-22 13:39:11,354 - DEBUG - VM ctest-left_vm-01404687 launched on Node cn-jenkins-deploy-platform-ansible-os-5666-1
2026-04-22 13:39:11,447 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/ffffc4bc-e05b-4556-a474-90082176fde5
2026-04-22 13:39:11,455 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/1cd154ac-f5fc-434a-bcac-00e0a42fbafa
2026-04-22 13:39:12,703 - 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.04 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.367 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.367/1.705/3.043/1.338 ms')
2026-04-22 13:39:12,703 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-left_vm-01404687 passed
2026-04-22 13:39:12,860 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:39:12,860 - DEBUG - Waiting to SSH to VM ctest-left_vm-01404687, IP 191.174.98.3, Port 22
2026-04-22 13:39:13,022 - DEBUG - VM ctest-left_vm-01404687 is ready for SSH connections
2026-04-22 13:39:13,022 - INFO - Waiting for VM ctest-right_vm-61629194 to be up..
2026-04-22 13:39:13,090 - DEBUG - VM is in ACTIVE state now
2026-04-22 13:39:13,090 - INFO - VM name : ctest-right_vm-61629194
2026-04-22 13:39:13,165 - DEBUG - VM ctest-right_vm-61629194 ID is 4090129e-2d64-4e75-9e64-4df094b6bc17
2026-04-22 13:39:13,165 - DEBUG - VM ctest-right_vm-61629194 launched on Node cn-jenkins-deploy-platform-ansible-os-5666-1
2026-04-22 13:39:13,232 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/4090129e-2d64-4e75-9e64-4df094b6bc17
2026-04-22 13:39:13,239 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/79bd3327-4ac7-4246-8231-aa7ab9b0ff96
2026-04-22 13:39:14,465 - 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.70 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.362 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.362/1.529/2.697/1.167 ms')
2026-04-22 13:39:14,465 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-right_vm-61629194 passed
2026-04-22 13:39:14,612 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:39:14,612 - DEBUG - Waiting to SSH to VM ctest-right_vm-61629194, IP 143.110.239.131, Port 22
2026-04-22 13:39:14,772 - DEBUG - VM ctest-right_vm-61629194 is ready for SSH connections
2026-04-22 13:39:14,777 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = any, src_addresses = [subnet = None, virtual_network = default-domain:ctest-TestSvcRegr-95960813:ctest-left_vn-87436873, 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-95960813:ctest-right_vn-60235500, 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-95960813:ctest-si-85446061'], 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-04-22 13:39:15,204 - INFO - Attaching policy ctest-policy-39881074 to vn ctest-left_vn-87436873
2026-04-22 13:39:15,728 - INFO - Attaching policy ctest-policy-39881074 to vn ctest-right_vn-60235500
2026-04-22 13:39:16,160 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-21353308'] created succesfully
2026-04-22 13:39:16,372 - DEBUG - Service instance: ['default-domain', 'ctest-TestSvcRegr-95960813', 'ctest-si-85446061'] created succesfully
2026-04-22 13:39:16,372 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-04-22 13:39:16,378 - DEBUG - Requesting: http://10.0.0.27:8082/domain/3d4477e5-6f25-4379-ad0e-f85d3877549d
2026-04-22 13:39:16,388 - DEBUG - Requesting: http://10.0.0.27:8082/project/db3d3b58-a623-4de6-8078-b617b055d267
2026-04-22 13:39:16,464 - DEBUG - Requesting: http://10.0.0.27:8082/service-instance/0a604fb7-0b76-45c9-99b3-29873820ed57
2026-04-22 13:39:16,472 - DEBUG - SI 'ctest-si-85446061' has service template ref to ctest-service_template_1-21353308
2026-04-22 13:39:16,472 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-04-22 13:39:16,479 - DEBUG - Requesting: http://10.0.0.27:8082/domain/3d4477e5-6f25-4379-ad0e-f85d3877549d
2026-04-22 13:39:16,489 - DEBUG - Requesting: http://10.0.0.27:8082/project/db3d3b58-a623-4de6-8078-b617b055d267
2026-04-22 13:39:16,554 - DEBUG - Requesting: http://10.0.0.27:8082/service-instance/0a604fb7-0b76-45c9-99b3-29873820ed57
2026-04-22 13:39:16,560 - DEBUG - Requesting: http://10.0.0.27:8082/port-tuple/efcef067-59cd-4318-9a7f-88871ca64d9c
2026-04-22 13:39:16,566 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/37d22dee-c535-411a-9686-43e97a6b46a3
2026-04-22 13:39:16,575 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/413b51a7-5a1e-4afb-b7ac-877586e6c7ce
2026-04-22 13:39:16,583 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/b45f16ca-e03a-4fe7-8b49-38bf76d6fb9f
2026-04-22 13:39:16,766 - DEBUG - VM is in ACTIVE state now
2026-04-22 13:39:17,132 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/720f803a-7838-483d-8af3-10bc44e6c8eb
2026-04-22 13:39:17,139 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/37d22dee-c535-411a-9686-43e97a6b46a3
2026-04-22 13:39:17,149 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/413b51a7-5a1e-4afb-b7ac-877586e6c7ce
2026-04-22 13:39:17,158 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/b45f16ca-e03a-4fe7-8b49-38bf76d6fb9f
2026-04-22 13:39:17,167 - DEBUG - Requesting: http://10.0.0.27:8082/instance-ip/04d20da3-76ba-4b8d-a525-6331d550a38f
2026-04-22 13:39:17,175 - DEBUG - Requesting: http://10.0.0.27:8082/instance-ip/7e6cff39-6d7e-4fc0-8007-20f37079bb9f
2026-04-22 13:39:17,182 - DEBUG - Requesting: http://10.0.0.27:8082/instance-ip/9b3d1295-75f4-4119-a30c-958190492127
2026-04-22 13:39:17,188 - DEBUG - Requesting: http://10.0.0.27:8082/instance-ip/12e6ff38-cdf0-4a7d-b186-f4ba729d7daa
2026-04-22 13:39:17,194 - DEBUG - Requesting: http://10.0.0.27:8082/instance-ip/5caa5187-8cac-4f4a-a242-15e168af5bca
2026-04-22 13:39:17,200 - DEBUG - Requesting: http://10.0.0.27:8082/instance-ip/c2a1554b-3884-499f-b6d0-c6265fc7d6fd
2026-04-22 13:39:17,206 - DEBUG - Requesting: http://10.0.0.27:8082/instance-ip/065a92c9-5481-4aac-8e3a-e40871918f3d
2026-04-22 13:39:17,212 - DEBUG - Requesting: http://10.0.0.27:8082/instance-ip/6c80444d-98b5-4673-888a-d379154858b3
2026-04-22 13:39:17,219 - DEBUG - Requesting: http://10.0.0.27:8082/instance-ip/ee536884-f2fb-421c-bbcc-d2a80f0d01a7
2026-04-22 13:39:17,600 - DEBUG - VM is in ACTIVE state now
2026-04-22 13:39:17,600 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/720f803a-7838-483d-8af3-10bc44e6c8eb
2026-04-22 13:39:17,608 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/37d22dee-c535-411a-9686-43e97a6b46a3
2026-04-22 13:39:17,617 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/413b51a7-5a1e-4afb-b7ac-877586e6c7ce
2026-04-22 13:39:17,625 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/b45f16ca-e03a-4fe7-8b49-38bf76d6fb9f
2026-04-22 13:39:18,882 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n64 bytes from 169.254.0.6: icmp_seq=1 ttl=63 time=0.857 ms\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=0.477 ms\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1020ms\r\nrtt min/avg/max/mdev = 0.477/0.667/0.857/0.190 ms')
2026-04-22 13:39:18,883 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-pt_svm0-82800744 passed
2026-04-22 13:39:18,915 - DEBUG - VM ctest-pt_svm0-82800744 Tap interface: {'index': '6', 'name': 'tap37d22dee-c5', 'uuid': '37d22dee-c535-411a-9686-43e97a6b46a3', 'vrf_name': 'default-domain:ctest-TestSvcRegr-95960813:ctest-left_vn-87436873:ctest-left_vn-87436873', '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-95960813:ctest-left_vn-87436873', 'vm_uuid': '720f803a-7838-483d-8af3-10bc44e6c8eb', 'vm_name': 'ctest-pt_svm0-82800744', 'ip_addr': '191.174.98.4', 'mac_addr': '02:37:d2:2d:ee:c5', '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-95960813:37d22dee-c535-411a-9686-43e97a6b46a3', 'sg_uuid_list': ['7dd46a36-556a-407f-84e0-cb850f36afb1'], 'static_route_list': None, 'vm_project_uuid': 'db3d3b58-a623-4de6-8078-b617b055d267', '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': 'b45f16ca-e03a-4fe7-8b49-38bf76d6fb9f', '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-04-22 13:39:18,916 - DEBUG - Agent 10.0.0.27 vrf name: default-domain:ctest-TestSvcRegr-95960813:ctest-left_vn-87436873:ctest-left_vn-87436873
2026-04-22 13:39:18,919 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-95960813:ctest-left_vn-87436873:ctest-left_vn-87436873', 'ucindex': '2', 'mcindex': '2', 'l2index': '2', 'source': 'Config; ', 'uc6index': '2', 'vn': 'default-domain:ctest-TestSvcRegr-95960813:ctest-left_vn-87436873', '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-04-22 13:39:19,087 - DEBUG - VM ctest-pt_svm0-82800744 : Tap interface tap37d22dee-c5 is set to Active
2026-04-22 13:39:19,087 - DEBUG - Tap interface tap37d22dee-c5 detail : {'index': '6', 'name': 'tap37d22dee-c5', 'uuid': '37d22dee-c535-411a-9686-43e97a6b46a3', 'vrf_name': 'default-domain:ctest-TestSvcRegr-95960813:ctest-left_vn-87436873:ctest-left_vn-87436873', '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-95960813:ctest-left_vn-87436873', 'vm_uuid': '720f803a-7838-483d-8af3-10bc44e6c8eb', 'vm_name': 'ctest-pt_svm0-82800744', 'ip_addr': '191.174.98.4', 'mac_addr': '02:37:d2:2d:ee:c5', '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-95960813:37d22dee-c535-411a-9686-43e97a6b46a3', 'sg_uuid_list': ['7dd46a36-556a-407f-84e0-cb850f36afb1'], 'static_route_list': None, 'vm_project_uuid': 'db3d3b58-a623-4de6-8078-b617b055d267', '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': 'b45f16ca-e03a-4fe7-8b49-38bf76d6fb9f', '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-04-22 13:39:19,288 - DEBUG - Starting Layer 2 verification in Agent
2026-04-22 13:39:19,298 - DEBUG - Layer 2 path is seen for VM MAC 02:37:d2:2d:ee:c5 in agent 10.0.0.27
2026-04-22 13:39:19,298 - DEBUG - Active layer 2 route in agent is present for VMI tap37d22dee-c5
2026-04-22 13:39:19,299 - DEBUG - L2 label(48) matches bw route table and interface table
2026-04-22 13:39:19,303 - DEBUG - VN default-domain:ctest-TestSvcRegr-95960813:ctest-left_vn-87436873 is found in Agent of node 10.0.0.27
2026-04-22 13:39:19,520 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-95960813:ctest-left_vn-87436873 is consistent in agent 10.0.0.27
2026-04-22 13:39:19,521 - DEBUG - Route for VM IP ['191.174.98.4'] is consistent in agent 10.0.0.27
2026-04-22 13:39:19,521 - DEBUG - VN default-domain:ctest-TestSvcRegr-95960813:ctest-left_vn-87436873 verification for VM ctest-pt_svm0-82800744 in Agent 10.0.0.27 passed
2026-04-22 13:39:19,716 - DEBUG - Starting all layer 2 verification in agent 10.0.0.27
2026-04-22 13:39:19,733 - DEBUG - Route for VM MAC 02:37:d2:2d:ee:c5 is consistent in agent 10.0.0.27
2026-04-22 13:39:19,753 - DEBUG - VM ctest-pt_svm0-82800744 Tap interface: {'index': '5', 'name': 'tap413b51a7-5a', 'uuid': '413b51a7-5a1e-4afb-b7ac-877586e6c7ce', 'vrf_name': 'default-domain:ctest-TestSvcRegr-95960813:ctest-mgmt_vn-21733823:ctest-mgmt_vn-21733823', '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-95960813:ctest-mgmt_vn-21733823', 'vm_uuid': '720f803a-7838-483d-8af3-10bc44e6c8eb', 'vm_name': 'ctest-pt_svm0-82800744', 'ip_addr': '219.91.33.131', 'mac_addr': '02:41:3b:51:a7:5a', '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-95960813:413b51a7-5a1e-4afb-b7ac-877586e6c7ce', 'sg_uuid_list': ['7dd46a36-556a-407f-84e0-cb850f36afb1'], 'static_route_list': None, 'vm_project_uuid': 'db3d3b58-a623-4de6-8078-b617b055d267', 'admin_state': 'Enabled', 'flow_key_idx': '43', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2026-04-22 13:39:19,754 - DEBUG - Agent 10.0.0.27 vrf name: default-domain:ctest-TestSvcRegr-95960813:ctest-mgmt_vn-21733823:ctest-mgmt_vn-21733823
2026-04-22 13:39:19,759 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-95960813:ctest-mgmt_vn-21733823:ctest-mgmt_vn-21733823', 'ucindex': '4', 'mcindex': '4', 'l2index': '4', 'source': 'Config; ', 'uc6index': '4', 'vn': 'default-domain:ctest-TestSvcRegr-95960813:ctest-mgmt_vn-21733823', '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-04-22 13:39:19,923 - DEBUG - VM ctest-pt_svm0-82800744 : Tap interface tap413b51a7-5a is set to Active
2026-04-22 13:39:19,923 - DEBUG - Tap interface tap413b51a7-5a detail : {'index': '5', 'name': 'tap413b51a7-5a', 'uuid': '413b51a7-5a1e-4afb-b7ac-877586e6c7ce', 'vrf_name': 'default-domain:ctest-TestSvcRegr-95960813:ctest-mgmt_vn-21733823:ctest-mgmt_vn-21733823', '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-95960813:ctest-mgmt_vn-21733823', 'vm_uuid': '720f803a-7838-483d-8af3-10bc44e6c8eb', 'vm_name': 'ctest-pt_svm0-82800744', 'ip_addr': '219.91.33.131', 'mac_addr': '02:41:3b:51:a7:5a', '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-95960813:413b51a7-5a1e-4afb-b7ac-877586e6c7ce', 'sg_uuid_list': ['7dd46a36-556a-407f-84e0-cb850f36afb1'], 'static_route_list': None, 'vm_project_uuid': 'db3d3b58-a623-4de6-8078-b617b055d267', 'admin_state': 'Enabled', 'flow_key_idx': '43', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '00000000-0000-0000-0000-000000000000', 'cfg_igmp_enable': 'false', 'igmp_enabled': 'false', 'max_flows': '0', 'policy_set_fwaas_list': None, 'bond_interface_list': None, 'mac_ip_learning_enable': 'false', 'mac_ip_list': []}
2026-04-22 13:39:20,120 - DEBUG - Starting Layer 2 verification in Agent
2026-04-22 13:39:20,130 - DEBUG - Layer 2 path is seen for VM MAC 02:41:3b:51:a7:5a in agent 10.0.0.27
2026-04-22 13:39:20,131 - DEBUG - Active layer 2 route in agent is present for VMI tap413b51a7-5a
2026-04-22 13:39:20,131 - DEBUG - L2 label(43) matches bw route table and interface table
2026-04-22 13:39:20,136 - DEBUG - VN default-domain:ctest-TestSvcRegr-95960813:ctest-mgmt_vn-21733823 is found in Agent of node 10.0.0.27
2026-04-22 13:39:20,353 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-95960813:ctest-mgmt_vn-21733823 is consistent in agent 10.0.0.27
2026-04-22 13:39:20,353 - DEBUG - Route for VM IP ['219.91.33.131'] is consistent in agent 10.0.0.27
2026-04-22 13:39:20,354 - DEBUG - VN default-domain:ctest-TestSvcRegr-95960813:ctest-mgmt_vn-21733823 verification for VM ctest-pt_svm0-82800744 in Agent 10.0.0.27 passed
2026-04-22 13:39:20,548 - DEBUG - Starting all layer 2 verification in agent 10.0.0.27
2026-04-22 13:39:20,559 - DEBUG - Route for VM MAC 02:41:3b:51:a7:5a is consistent in agent 10.0.0.27
2026-04-22 13:39:20,578 - DEBUG - VM ctest-pt_svm0-82800744 Tap interface: {'index': '7', 'name': 'tapb45f16ca-e0', 'uuid': 'b45f16ca-e03a-4fe7-8b49-38bf76d6fb9f', 'vrf_name': 'default-domain:ctest-TestSvcRegr-95960813:ctest-right_vn-60235500:ctest-right_vn-60235500', '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-95960813:ctest-right_vn-60235500', 'vm_uuid': '720f803a-7838-483d-8af3-10bc44e6c8eb', 'vm_name': 'ctest-pt_svm0-82800744', 'ip_addr': '143.110.239.132', 'mac_addr': '02:b4:5f:16:ca:e0', '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-95960813:b45f16ca-e03a-4fe7-8b49-38bf76d6fb9f', 'sg_uuid_list': ['7dd46a36-556a-407f-84e0-cb850f36afb1'], 'static_route_list': None, 'vm_project_uuid': 'db3d3b58-a623-4de6-8078-b617b055d267', 'admin_state': 'Enabled', 'flow_key_idx': '56', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '37d22dee-c535-411a-9686-43e97a6b46a3', '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-04-22 13:39:20,578 - DEBUG - Agent 10.0.0.27 vrf name: default-domain:ctest-TestSvcRegr-95960813:ctest-right_vn-60235500:ctest-right_vn-60235500
2026-04-22 13:39:20,583 - DEBUG - Agent VRF Object : {'vrf_list': [{'name': 'default-domain:ctest-TestSvcRegr-95960813:ctest-right_vn-60235500:ctest-right_vn-60235500', 'ucindex': '3', 'mcindex': '3', 'l2index': '3', 'source': 'Config; ', 'uc6index': '3', 'vn': 'default-domain:ctest-TestSvcRegr-95960813:ctest-right_vn-60235500', '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-04-22 13:39:20,793 - DEBUG - VM ctest-pt_svm0-82800744 : Tap interface tapb45f16ca-e0 is set to Active
2026-04-22 13:39:20,793 - DEBUG - Tap interface tapb45f16ca-e0 detail : {'index': '7', 'name': 'tapb45f16ca-e0', 'uuid': 'b45f16ca-e03a-4fe7-8b49-38bf76d6fb9f', 'vrf_name': 'default-domain:ctest-TestSvcRegr-95960813:ctest-right_vn-60235500:ctest-right_vn-60235500', '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-95960813:ctest-right_vn-60235500', 'vm_uuid': '720f803a-7838-483d-8af3-10bc44e6c8eb', 'vm_name': 'ctest-pt_svm0-82800744', 'ip_addr': '143.110.239.132', 'mac_addr': '02:b4:5f:16:ca:e0', '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-95960813:b45f16ca-e03a-4fe7-8b49-38bf76d6fb9f', 'sg_uuid_list': ['7dd46a36-556a-407f-84e0-cb850f36afb1'], 'static_route_list': None, 'vm_project_uuid': 'db3d3b58-a623-4de6-8078-b617b055d267', 'admin_state': 'Enabled', 'flow_key_idx': '56', 'allowed_address_pair_list': None, 'ip6_addr': '::', 'local_preference': '0', 'tx_vlan_id': '-1', 'rx_vlan_id': '-1', 'parent_interface': None, 'subnet': '--NA--', 'sub_type': 'Tap', 'vrf_assign_acl_uuid': '--NA--', 'vmi_type': 'Virtual Machine', 'transport': 'Ethernet', 'logical_interface_uuid': '00000000-0000-0000-0000-000000000000', 'flood_unknown_unicast': 'false', 'physical_device': None, 'physical_interface': None, 'fixed_ip4_list': None, 'fixed_ip6_list': None, 'fat_flow_list': None, 'metadata_ip_active': 'Active', 'service_health_check_ip': '0.0.0.0', 'alias_ip_list': None, 'drop_new_flows': 'false', 'bridge_domain_list': [], 'vmi_tag_list': None, 'policy_set_acl_list': None, 'slo_list': None, 'vhostuser_mode': '0', 'si_other_end_vmi': '37d22dee-c535-411a-9686-43e97a6b46a3', '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-04-22 13:39:20,992 - DEBUG - Starting Layer 2 verification in Agent
2026-04-22 13:39:21,002 - DEBUG - Layer 2 path is seen for VM MAC 02:b4:5f:16:ca:e0 in agent 10.0.0.27
2026-04-22 13:39:21,003 - DEBUG - Active layer 2 route in agent is present for VMI tapb45f16ca-e0
2026-04-22 13:39:21,003 - DEBUG - L2 label(53) matches bw route table and interface table
2026-04-22 13:39:21,008 - DEBUG - VN default-domain:ctest-TestSvcRegr-95960813:ctest-right_vn-60235500 is found in Agent of node 10.0.0.27
2026-04-22 13:39:21,215 - DEBUG - VRF IDs of VN default-domain:ctest-TestSvcRegr-95960813:ctest-right_vn-60235500 is consistent in agent 10.0.0.27
2026-04-22 13:39:21,215 - DEBUG - Route for VM IP ['143.110.239.132'] is consistent in agent 10.0.0.27
2026-04-22 13:39:21,215 - DEBUG - VN default-domain:ctest-TestSvcRegr-95960813:ctest-right_vn-60235500 verification for VM ctest-pt_svm0-82800744 in Agent 10.0.0.27 passed
2026-04-22 13:39:21,404 - DEBUG - Starting all layer 2 verification in agent 10.0.0.27
2026-04-22 13:39:21,414 - DEBUG - Route for VM MAC 02:b4:5f:16:ca:e0 is consistent in agent 10.0.0.27
2026-04-22 13:39:21,414 - INFO - VM ctest-pt_svm0-82800744 verifications in Compute nodes passed
2026-04-22 13:39:21,414 - DEBUG - The SVMs in the SI are : []
2026-04-22 13:39:21,414 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/720f803a-7838-483d-8af3-10bc44e6c8eb
2026-04-22 13:39:21,421 - DEBUG - Service VM for SI 'ctest-si-85446061' is launched
2026-04-22 13:39:21,421 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-04-22 13:39:21,426 - DEBUG - Requesting: http://10.0.0.27:8082/domain/3d4477e5-6f25-4379-ad0e-f85d3877549d
2026-04-22 13:39:21,458 - DEBUG - Requesting: http://10.0.0.27:8082/project/db3d3b58-a623-4de6-8078-b617b055d267
2026-04-22 13:39:21,528 - DEBUG - Requesting: http://10.0.0.27:8082/service-instance/0a604fb7-0b76-45c9-99b3-29873820ed57
2026-04-22 13:39:21,536 - DEBUG - SI ctest-si-85446061 has Port Tuple: ['ctest-port_tuple-34106812']
2026-04-22 13:39:21,636 - INFO - VMI and/or RI refs are present for VN default-domain:ctest-TestSvcRegr-95960813:ctest-left_vn-87436873
2026-04-22 13:39:21,780 - INFO - VMI and/or RI refs are present for VN default-domain:ctest-TestSvcRegr-95960813:ctest-right_vn-60235500
2026-04-22 13:39:21,933 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:39:21,940 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:39:21,940 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:39:21,945 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:39:21,945 - INFO - Route to 143.110.239.131 seen in VRF:5 on cn-jenkins-deploy-platform-ansible-os-5666-1, and SI ctest-si-85446061 is seen as the NH
2026-04-22 13:39:22,097 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:39:22,104 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:39:22,104 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:39:22,109 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:39:22,109 - INFO - Route to 191.174.98.3 seen in VRF:6 on cn-jenkins-deploy-platform-ansible-os-5666-1, and SI ctest-si-85446061 is seen as the NH
2026-04-22 13:39:22,109 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:39:22,109 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-22 13:39:22,109 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 143.110.239.131, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.27, gateway password: c0ntrail123
2026-04-22 13:39:22,109 - DEBUG - ping -s 56 -c 3 -W 1 143.110.239.131
2026-04-22 13:39:26,063 - DEBUG - PING 143.110.239.131 (143.110.239.131): 56 data bytes
64 bytes from 143.110.239.131: seq=0 ttl=61 time=5.550 ms
64 bytes from 143.110.239.131: seq=1 ttl=61 time=1.472 ms
64 bytes from 143.110.239.131: seq=2 ttl=61 time=1.447 ms
--- 143.110.239.131 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.447/2.823/5.550 ms
2026-04-22 13:39:26,063 - INFO - Ping to IP 143.110.239.131 from VM ctest-left_vm-01404687 passed
2026-04-22 13:39:26,063 - INFO - Dettaching policy ctest-policy-39881074 from vn ctest-right_vn-60235500
2026-04-22 13:39:26,260 - INFO - Dettaching policy ctest-policy-39881074 from vn ctest-left_vn-87436873
2026-04-22 13:39:26,531 - INFO - Deleted policy ctest-policy-39881074
2026-04-22 13:39:26,531 - DEBUG - Deleting service instance: ['default-domain', 'ctest-TestSvcRegr-95960813', 'ctest-si-85446061']
2026-04-22 13:39:26,628 - INFO - Deleted SI ['default-domain', 'ctest-TestSvcRegr-95960813', 'ctest-si-85446061']
2026-04-22 13:39:26,628 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-04-22 13:39:26,637 - DEBUG - Requesting: http://10.0.0.27:8082/domain/3d4477e5-6f25-4379-ad0e-f85d3877549d
2026-04-22 13:39:26,666 - DEBUG - Requesting: http://10.0.0.27:8082/project/db3d3b58-a623-4de6-8078-b617b055d267
2026-04-22 13:39:26,758 - DEBUG - Service instance ctest-si-85446061 removed from api server
2026-04-22 13:39:26,758 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/720f803a-7838-483d-8af3-10bc44e6c8eb
2026-04-22 13:39:26,773 - DEBUG - All Service VMs unlinked from SI ctest-si-85446061
2026-04-22 13:39:26,777 - DEBUG - 0 svc intances found in all projects. They are []
2026-04-22 13:39:26,777 - DEBUG - 0 svc intances found in current project. They are []
2026-04-22 13:39:26,824 - DEBUG - 0 svc intances found in all projects. They are []
2026-04-22 13:39:26,824 - DEBUG - 0 svc intances found in current project. They are []
2026-04-22 13:39:26,824 - INFO - Deleting VM ctest-pt_svm0-82800744
2026-04-22 13:39:26,904 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-21353308']
2026-04-22 13:39:26,984 - INFO - Service template: ['default-domain', 'ctest-service_template_1-21353308'] deleted successfully.
2026-04-22 13:39:26,984 - INFO - Deleting VM ctest-right_vm-61629194
2026-04-22 13:39:27,066 - INFO - Deleting VM ctest-left_vm-01404687
2026-04-22 13:39:27,145 - INFO - Deleting VN ctest-right_vn-60235500
2026-04-22 13:39:27,187 - DEBUG - VN bc13df5e-45fd-4842-b33e-00171e1aef9b still in use: Unable to complete operation on network bc13df5e-45fd-4842-b33e-00171e1aef9b. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-233009c2-c6f2-48ef-9d12-5a53fbf73207']
2026-04-22 13:39:27,187 - WARNING - Deleting VN ctest-right_vn-60235500 failed..Will retry
2026-04-22 13:39:29,281 - DEBUG - Response for deleting network ()
2026-04-22 13:39:29,281 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/bf53d24b-f238-435c-9663-a24021816fbc
2026-04-22 13:39:29,289 - DEBUG - Response Code: 404
2026-04-22 13:39:29,289 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-04-22 13:39:29,294 - DEBUG - Requesting: http://10.0.0.27:8082/domain/3d4477e5-6f25-4379-ad0e-f85d3877549d
2026-04-22 13:39:29,350 - DEBUG - Requesting: http://10.0.0.27:8082/project/db3d3b58-a623-4de6-8078-b617b055d267
2026-04-22 13:39:29,423 - INFO - Validated that VN ctest-right_vn-60235500 is not found in API Server
2026-04-22 13:39:29,439 - DEBUG - VN ctest-right_vn-60235500 is not present in Agent 10.0.0.27
2026-04-22 13:39:29,439 - INFO - Validated that VN ctest-right_vn-60235500 is not in any agent
2026-04-22 13:39:29,453 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-60235500 info
2026-04-22 13:39:29,454 - INFO - Deleting VN ctest-left_vn-87436873
2026-04-22 13:39:29,568 - DEBUG - Response for deleting network ()
2026-04-22 13:39:29,568 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/b9c28812-3e4e-4261-a168-86cf487ef1aa
2026-04-22 13:39:29,576 - DEBUG - Response Code: 404
2026-04-22 13:39:29,576 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-04-22 13:39:29,581 - DEBUG - Requesting: http://10.0.0.27:8082/domain/3d4477e5-6f25-4379-ad0e-f85d3877549d
2026-04-22 13:39:29,633 - DEBUG - Requesting: http://10.0.0.27:8082/project/db3d3b58-a623-4de6-8078-b617b055d267
2026-04-22 13:39:29,702 - INFO - Validated that VN ctest-left_vn-87436873 is not found in API Server
2026-04-22 13:39:29,711 - DEBUG - VN ctest-left_vn-87436873 is not present in Agent 10.0.0.27
2026-04-22 13:39:29,711 - INFO - Validated that VN ctest-left_vn-87436873 is not in any agent
2026-04-22 13:39:29,724 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-87436873 info
2026-04-22 13:39:29,724 - INFO - Deleting VN ctest-mgmt_vn-21733823
2026-04-22 13:39:29,810 - DEBUG - Response for deleting network ()
2026-04-22 13:39:29,810 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/3afe94af-3fcb-49ec-baf3-d2629f10e49d
2026-04-22 13:39:29,814 - DEBUG - Response Code: 404
2026-04-22 13:39:29,814 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-04-22 13:39:29,818 - DEBUG - Requesting: http://10.0.0.27:8082/domain/3d4477e5-6f25-4379-ad0e-f85d3877549d
2026-04-22 13:39:29,868 - DEBUG - Requesting: http://10.0.0.27:8082/project/db3d3b58-a623-4de6-8078-b617b055d267
2026-04-22 13:39:29,938 - INFO - Validated that VN ctest-mgmt_vn-21733823 is not found in API Server
2026-04-22 13:39:29,947 - DEBUG - VN ctest-mgmt_vn-21733823 is not present in Agent 10.0.0.27
2026-04-22 13:39:29,947 - INFO - Validated that VN ctest-mgmt_vn-21733823 is not in any agent
2026-04-22 13:39:29,958 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-21733823 info
2026-04-22 13:39:30,213 - DEBUG - No XMPP flaps were noticed during the test
2026-04-22 13:39:30,213 - INFO -
2026-04-22 13:39:30,213 - INFO - END TEST : test_svc_in_network_datapath : PASSED[0:01:11]
2026-04-22 13:39:30,213 - INFO - --------------------------------------------------------------------------------
2026-04-22 13:39:30,890 - INFO - Deleted project: ctest-TestSvcRegr-95960813, ID : db3d3b58-a623-4de6-8078-b617b055d267