2026-01-29 03:16:23,108 - INFO - Domain Default found not creating
2026-01-29 03:16:23,319 - INFO - Project ctest-TestSvcHC-91679647 not found, creating it
2026-01-29 03:16:23,918 - INFO - Created Project:ctest-TestSvcHC-91679647, ID : 248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:25,459 - INFO - ================================================================================
2026-01-29 03:16:25,459 - INFO - STARTING TEST : test_svc_hc_basic
2026-01-29 03:16:26,758 - DEBUG - Nothing to compare xmpp stats {'10.0.0.49': {'10.20.0.193': '0', '10.20.0.254': '0'}, '10.0.0.128': {'10.20.0.254': '0', '10.20.0.14': '0'}} with
2026-01-29 03:16:26,758 - INFO - Initial checks done. Running the testcase now
2026-01-29 03:16:26,758 - INFO -
2026-01-29 03:16:27,434 - DEBUG - Response for create_network : {'network': {'id': '9d8474f5-2b52-413c-90ca-b4ab125e14b6', 'name': 'ctest-mgmt_vn-97405166', 'tenant_id': '248f44c9178e43c78378822c3eeb9842', 'project_id': '248f44c9178e43c78378822c3eeb9842', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-91679647', 'ctest-mgmt_vn-97405166'], 'port_security_enabled': True, 'description': ''}}
2026-01-29 03:16:27,699 - DEBUG - Response for create_subnet : {'subnet': {'id': '0b360dc7-4918-47cc-a3cc-f16240a6a278', 'name': '', 'tenant_id': '248f44c9178e43c78378822c3eeb9842', 'network_id': '9d8474f5-2b52-413c-90ca-b4ab125e14b6', 'ip_version': 4, 'cidr': '106.240.49.128/26', 'allocation_pools': [{'start': '106.240.49.130', 'end': '106.240.49.190'}], 'gateway_ip': '106.240.49.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '106.240.49.130', 'tags': [], 'project_id': '248f44c9178e43c78378822c3eeb9842'}}
2026-01-29 03:16:27,720 - INFO - Created VN ctest-mgmt_vn-97405166
2026-01-29 03:16:27,734 - DEBUG - VN ctest-mgmt_vn-97405166 UUID is 9d8474f5-2b52-413c-90ca-b4ab125e14b6
2026-01-29 03:16:27,804 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:28,117 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:28,152 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:28,167 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:28,259 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9d8474f5-2b52-413c-90ca-b4ab125e14b6
2026-01-29 03:16:28,274 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9d8474f5-2b52-413c-90ca-b4ab125e14b6
2026-01-29 03:16:28,283 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/69bda31b-6421-4823-a337-5295a5e1fa75
2026-01-29 03:16:28,290 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/69bda31b-6421-4823-a337-5295a5e1fa75
2026-01-29 03:16:28,298 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/a6f2a08d-d5ec-4dab-944a-0b306707fa53
2026-01-29 03:16:28,305 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-29 03:16:28,305 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9d8474f5-2b52-413c-90ca-b4ab125e14b6
2026-01-29 03:16:28,314 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/69bda31b-6421-4823-a337-5295a5e1fa75
2026-01-29 03:16:28,330 - INFO - Verified VN network id 13 for VN 9d8474f5-2b52-413c-90ca-b4ab125e14b6
2026-01-29 03:16:28,330 - INFO - Verifications in API Server for VN ctest-mgmt_vn-97405166 passed
2026-01-29 03:16:28,331 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9d8474f5-2b52-413c-90ca-b4ab125e14b6
2026-01-29 03:16:28,340 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/69bda31b-6421-4823-a337-5295a5e1fa75
2026-01-29 03:16:28,348 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/69bda31b-6421-4823-a337-5295a5e1fa75
2026-01-29 03:16:28,355 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/a6f2a08d-d5ec-4dab-944a-0b306707fa53
2026-01-29 03:16:28,366 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-97405166', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11350325557223113020', 'uuid-lslong': '10433350133597738166'}, 'enable': 'true', 'created': '2026-01-29T03:16:27', 'last-modified': '2026-01-29T03:16:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.730472'}
2026-01-29 03:16:28,372 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-29 03:16:28,377 - DEBUG - Control-node 10.0.0.147 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-97405166', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11350325557223113020', 'uuid-lslong': '10433350133597738166'}, 'enable': 'true', 'created': '2026-01-29T03:16:27', 'last-modified': '2026-01-29T03:16:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.740003'}
2026-01-29 03:16:28,384 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-29 03:16:28,389 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-97405166', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11350325557223113020', 'uuid-lslong': '10433350133597738166'}, 'enable': 'true', 'created': '2026-01-29T03:16:27', 'last-modified': '2026-01-29T03:16:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.756871'}
2026-01-29 03:16:28,394 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-29 03:16:28,394 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-97405166 passed
2026-01-29 03:16:28,395 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-97405166 in API_Server ======
2026-01-29 03:16:28,395 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:28,404 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:28,417 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:28,520 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9d8474f5-2b52-413c-90ca-b4ab125e14b6
2026-01-29 03:16:28,534 - DEBUG - =>VN ctest-mgmt_vn-97405166 has no policy to be verified
2026-01-29 03:16:28,534 - DEBUG - Verifying the vn in opserver
2026-01-29 03:16:28,535 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-97405166 virtual network link through opserver 10.0.0.23
2026-01-29 03:16:28,535 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-01-29 03:16:28,834 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-01-29 03:16:28,894 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-97405166', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-97405166?flat'}
2026-01-29 03:16:28,894 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-97405166 virtual network link through opserver 10.0.0.147
2026-01-29 03:16:28,894 - DEBUG - Requesting: http://10.0.0.147:8081/analytics/uves/virtual-networks
2026-01-29 03:16:29,205 - DEBUG - Requesting: http://10.0.0.147:8081/analytics/uves/virtual-networks
2026-01-29 03:16:29,283 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-97405166', 'href': 'http://10.0.0.147:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-97405166?flat'}
2026-01-29 03:16:29,283 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-97405166 virtual network link through opserver 10.0.0.240
2026-01-29 03:16:29,283 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-01-29 03:16:29,595 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-01-29 03:16:29,707 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-97405166', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-97405166?flat'}
2026-01-29 03:16:29,707 - INFO - Validated that VN default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-97405166 is found in opserver
2026-01-29 03:16:29,736 - DEBUG - Do not have enough data to verify VN in agent
2026-01-29 03:16:29,747 - DEBUG - VRF ids for VN ctest-mgmt_vn-97405166: {}
2026-01-29 03:16:30,038 - DEBUG - Response for create_network : {'network': {'id': '2afcd35c-d1f2-484e-a40b-e3a3883d70d8', 'name': 'ctest-left_vn-20596881', 'tenant_id': '248f44c9178e43c78378822c3eeb9842', 'project_id': '248f44c9178e43c78378822c3eeb9842', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-91679647', 'ctest-left_vn-20596881'], 'port_security_enabled': True, 'description': ''}}
2026-01-29 03:16:30,322 - DEBUG - Response for create_subnet : {'subnet': {'id': '1ff13bbc-d411-44f1-9fd9-ea0318be24c6', 'name': '', 'tenant_id': '248f44c9178e43c78378822c3eeb9842', 'network_id': '2afcd35c-d1f2-484e-a40b-e3a3883d70d8', 'ip_version': 4, 'cidr': '151.220.254.64/26', 'allocation_pools': [{'start': '151.220.254.66', 'end': '151.220.254.126'}], 'gateway_ip': '151.220.254.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '151.220.254.66', 'tags': [], 'project_id': '248f44c9178e43c78378822c3eeb9842'}}
2026-01-29 03:16:30,346 - INFO - Created VN ctest-left_vn-20596881
2026-01-29 03:16:30,358 - DEBUG - VN ctest-left_vn-20596881 UUID is 2afcd35c-d1f2-484e-a40b-e3a3883d70d8
2026-01-29 03:16:30,435 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:30,441 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:30,453 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:30,542 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/2afcd35c-d1f2-484e-a40b-e3a3883d70d8
2026-01-29 03:16:30,554 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/2afcd35c-d1f2-484e-a40b-e3a3883d70d8
2026-01-29 03:16:30,563 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6068684f-27b8-4c3d-a9e9-ab38487915a7
2026-01-29 03:16:30,571 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6068684f-27b8-4c3d-a9e9-ab38487915a7
2026-01-29 03:16:30,582 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/3485c5e1-bf67-4263-a1c9-1ff0c588230a
2026-01-29 03:16:30,590 - DEBUG - Route Targets: ['target:64512:8000005']
2026-01-29 03:16:30,590 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/2afcd35c-d1f2-484e-a40b-e3a3883d70d8
2026-01-29 03:16:30,602 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6068684f-27b8-4c3d-a9e9-ab38487915a7
2026-01-29 03:16:30,628 - INFO - Verified VN network id 14 for VN 2afcd35c-d1f2-484e-a40b-e3a3883d70d8
2026-01-29 03:16:30,628 - INFO - Verifications in API Server for VN ctest-left_vn-20596881 passed
2026-01-29 03:16:30,628 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/2afcd35c-d1f2-484e-a40b-e3a3883d70d8
2026-01-29 03:16:30,639 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6068684f-27b8-4c3d-a9e9-ab38487915a7
2026-01-29 03:16:30,646 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6068684f-27b8-4c3d-a9e9-ab38487915a7
2026-01-29 03:16:30,654 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/3485c5e1-bf67-4263-a1c9-1ff0c588230a
2026-01-29 03:16:30,674 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-20596881', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3097583039336826958', 'uuid-lslong': '11820791938468901080'}, 'enable': 'true', 'created': '2026-01-29T03:16:29', 'last-modified': '2026-01-29T03:16:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.409161'}
2026-01-29 03:16:30,685 - DEBUG - Route Targets: ['target:64512:8000005']
2026-01-29 03:16:30,690 - DEBUG - Control-node 10.0.0.147 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-20596881', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3097583039336826958', 'uuid-lslong': '11820791938468901080'}, 'enable': 'true', 'created': '2026-01-29T03:16:29', 'last-modified': '2026-01-29T03:16:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.433834'}
2026-01-29 03:16:30,695 - DEBUG - Route Targets: ['target:64512:8000005']
2026-01-29 03:16:30,701 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-20596881', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3097583039336826958', 'uuid-lslong': '11820791938468901080'}, 'enable': 'true', 'created': '2026-01-29T03:16:29', 'last-modified': '2026-01-29T03:16:30', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.441495'}
2026-01-29 03:16:30,706 - DEBUG - Route Targets: ['target:64512:8000005']
2026-01-29 03:16:30,706 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-20596881 passed
2026-01-29 03:16:30,707 - DEBUG - ====Verifying policy data for ctest-left_vn-20596881 in API_Server ======
2026-01-29 03:16:30,707 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:30,713 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:30,727 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:30,830 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/2afcd35c-d1f2-484e-a40b-e3a3883d70d8
2026-01-29 03:16:30,838 - DEBUG - =>VN ctest-left_vn-20596881 has no policy to be verified
2026-01-29 03:16:30,838 - DEBUG - Verifying the vn in opserver
2026-01-29 03:16:30,838 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-20596881 virtual network link through opserver 10.0.0.23
2026-01-29 03:16:30,839 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-01-29 03:16:30,900 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-20596881', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-20596881?flat'}
2026-01-29 03:16:30,900 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-20596881 virtual network link through opserver 10.0.0.147
2026-01-29 03:16:30,900 - DEBUG - Requesting: http://10.0.0.147:8081/analytics/uves/virtual-networks
2026-01-29 03:16:30,974 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-20596881', 'href': 'http://10.0.0.147:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-20596881?flat'}
2026-01-29 03:16:30,974 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-20596881 virtual network link through opserver 10.0.0.240
2026-01-29 03:16:30,974 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-01-29 03:16:31,044 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-20596881', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-20596881?flat'}
2026-01-29 03:16:31,044 - INFO - Validated that VN default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-20596881 is found in opserver
2026-01-29 03:16:31,069 - DEBUG - Do not have enough data to verify VN in agent
2026-01-29 03:16:31,080 - DEBUG - VRF ids for VN ctest-left_vn-20596881: {}
2026-01-29 03:16:31,383 - DEBUG - Response for create_network : {'network': {'id': '1ad0b536-e848-43de-a78c-2023130feaad', 'name': 'ctest-right_vn-21277342', 'tenant_id': '248f44c9178e43c78378822c3eeb9842', 'project_id': '248f44c9178e43c78378822c3eeb9842', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-91679647', 'ctest-right_vn-21277342'], 'port_security_enabled': True, 'description': ''}}
2026-01-29 03:16:31,649 - DEBUG - Response for create_subnet : {'subnet': {'id': '3aa17d7f-ac2b-4fb1-83af-c6cd0ed51099', 'name': '', 'tenant_id': '248f44c9178e43c78378822c3eeb9842', 'network_id': '1ad0b536-e848-43de-a78c-2023130feaad', 'ip_version': 4, 'cidr': '68.140.85.128/26', 'allocation_pools': [{'start': '68.140.85.130', 'end': '68.140.85.190'}], 'gateway_ip': '68.140.85.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '68.140.85.130', 'tags': [], 'project_id': '248f44c9178e43c78378822c3eeb9842'}}
2026-01-29 03:16:31,671 - INFO - Created VN ctest-right_vn-21277342
2026-01-29 03:16:31,683 - DEBUG - VN ctest-right_vn-21277342 UUID is 1ad0b536-e848-43de-a78c-2023130feaad
2026-01-29 03:16:31,759 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:31,769 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:31,780 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:31,882 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/1ad0b536-e848-43de-a78c-2023130feaad
2026-01-29 03:16:31,893 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/1ad0b536-e848-43de-a78c-2023130feaad
2026-01-29 03:16:31,905 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/12e72e65-cb68-468c-a7d7-c94c51a9d2c1
2026-01-29 03:16:31,914 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/12e72e65-cb68-468c-a7d7-c94c51a9d2c1
2026-01-29 03:16:31,929 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/7abc234d-6afe-430a-b51d-5ac5aead535e
2026-01-29 03:16:31,938 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-29 03:16:31,938 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/1ad0b536-e848-43de-a78c-2023130feaad
2026-01-29 03:16:31,948 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/12e72e65-cb68-468c-a7d7-c94c51a9d2c1
2026-01-29 03:16:31,965 - INFO - Verified VN network id 15 for VN 1ad0b536-e848-43de-a78c-2023130feaad
2026-01-29 03:16:31,965 - INFO - Verifications in API Server for VN ctest-right_vn-21277342 passed
2026-01-29 03:16:31,965 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/1ad0b536-e848-43de-a78c-2023130feaad
2026-01-29 03:16:31,976 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/12e72e65-cb68-468c-a7d7-c94c51a9d2c1
2026-01-29 03:16:31,983 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/12e72e65-cb68-468c-a7d7-c94c51a9d2c1
2026-01-29 03:16:31,992 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/7abc234d-6afe-430a-b51d-5ac5aead535e
2026-01-29 03:16:32,006 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-21277342', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1932243487571854302', 'uuid-lslong': '12073060036089211565'}, 'enable': 'true', 'created': '2026-01-29T03:16:31', 'last-modified': '2026-01-29T03:16:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.420744'}
2026-01-29 03:16:32,011 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-29 03:16:32,019 - DEBUG - Control-node 10.0.0.147 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-21277342', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1932243487571854302', 'uuid-lslong': '12073060036089211565'}, 'enable': 'true', 'created': '2026-01-29T03:16:31', 'last-modified': '2026-01-29T03:16:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.435383'}
2026-01-29 03:16:32,027 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-29 03:16:32,033 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-21277342', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1932243487571854302', 'uuid-lslong': '12073060036089211565'}, 'enable': 'true', 'created': '2026-01-29T03:16:31', 'last-modified': '2026-01-29T03:16:31', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.451249'}
2026-01-29 03:16:32,041 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-29 03:16:32,041 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-21277342 passed
2026-01-29 03:16:32,041 - DEBUG - ====Verifying policy data for ctest-right_vn-21277342 in API_Server ======
2026-01-29 03:16:32,041 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:32,048 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:32,058 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:32,156 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/1ad0b536-e848-43de-a78c-2023130feaad
2026-01-29 03:16:32,186 - DEBUG - =>VN ctest-right_vn-21277342 has no policy to be verified
2026-01-29 03:16:32,186 - DEBUG - Verifying the vn in opserver
2026-01-29 03:16:32,186 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-21277342 virtual network link through opserver 10.0.0.23
2026-01-29 03:16:32,186 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-01-29 03:16:32,429 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-21277342', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-21277342?flat'}
2026-01-29 03:16:32,429 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-21277342 virtual network link through opserver 10.0.0.147
2026-01-29 03:16:32,430 - DEBUG - Requesting: http://10.0.0.147:8081/analytics/uves/virtual-networks
2026-01-29 03:16:32,441 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-21277342', 'href': 'http://10.0.0.147:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-21277342?flat'}
2026-01-29 03:16:32,442 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-21277342 virtual network link through opserver 10.0.0.240
2026-01-29 03:16:32,442 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-01-29 03:16:32,803 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-21277342', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-21277342?flat'}
2026-01-29 03:16:32,803 - INFO - Validated that VN default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-21277342 is found in opserver
2026-01-29 03:16:32,830 - DEBUG - Do not have enough data to verify VN in agent
2026-01-29 03:16:32,843 - DEBUG - VRF ids for VN ctest-right_vn-21277342: {}
2026-01-29 03:16:32,907 - DEBUG - Services list from nova: [, , , ]
2026-01-29 03:16:34,042 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5115-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5115-1)
2026-01-29 03:16:35,344 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5115-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5115-2)
2026-01-29 03:16:35,344 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-94051499']
2026-01-29 03:16:35,649 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-94051499'] created succesfully
2026-01-29 03:16:36,011 - DEBUG - Image by name tiny_nat_fw not found
2026-01-29 03:16:36,011 - DEBUG - Installing image tiny_nat_fw
2026-01-29 03:16:36,011 - DEBUG - Image info {'name': 'tinycore-in-network-nat.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd', 'vmdk': 'service_chain_images/nat_service/tiny_nat_fw/tinycore-in-network-nat-flat.vmdk', 'shrinked_vmdk': "'no'"}
2026-01-29 03:16:36,011 - DEBUG - Image build path file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-01-29 03:16:36,011 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-01-29 03:16:36,011 - DEBUG - Unzip image
2026-01-29 03:16:36,011 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-in-network-nat.qcow2.gz
2026-01-29 03:16:36,045 - INFO - image /contrail-test/images/tinycore-in-network-nat.qcow2 is not found
2026-01-29 03:16:36,046 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-94051499']
2026-01-29 03:16:36,166 - INFO - Service template: ['default-domain', 'ctest-service_template_1-94051499'] deleted successfully.
2026-01-29 03:16:36,166 - INFO - Skip interface_detach for VM ctest-right_vm-37654998 in state BUILD
2026-01-29 03:16:36,166 - INFO - Deleting VM ctest-right_vm-37654998
2026-01-29 03:16:36,194 - ERROR - VM ctest-right_vm-37654998 has failed to come up
2026-01-29 03:16:36,194 - ERROR - Nova failed to get host of the VM
2026-01-29 03:16:36,194 - ERROR - VM ctest-right_vm-37654998 has failed to come up
2026-01-29 03:16:36,194 - ERROR - Nova failed to get host of the VM
2026-01-29 03:16:36,317 - INFO - Skip interface_detach for VM ctest-left_vm-64845107 in state BUILD
2026-01-29 03:16:36,317 - INFO - Deleting VM ctest-left_vm-64845107
2026-01-29 03:16:36,318 - ERROR - VM ctest-left_vm-64845107 has failed to come up
2026-01-29 03:16:36,318 - ERROR - Nova failed to get host of the VM
2026-01-29 03:16:36,318 - ERROR - VM ctest-left_vm-64845107 has failed to come up
2026-01-29 03:16:36,318 - ERROR - Nova failed to get host of the VM
2026-01-29 03:16:36,399 - INFO - Deleting VN ctest-right_vn-21277342
2026-01-29 03:16:36,442 - DEBUG - VN 1ad0b536-e848-43de-a78c-2023130feaad still in use: Unable to complete operation on network 1ad0b536-e848-43de-a78c-2023130feaad. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-36bd9d7a-0e97-454b-9446-8c956f7fa26e']
2026-01-29 03:16:36,442 - WARNING - Deleting VN ctest-right_vn-21277342 failed..Will retry
2026-01-29 03:16:38,589 - DEBUG - Response for deleting network ()
2026-01-29 03:16:38,589 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/12e72e65-cb68-468c-a7d7-c94c51a9d2c1
2026-01-29 03:16:38,598 - DEBUG - Response Code: 404
2026-01-29 03:16:38,599 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:38,618 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:38,637 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:38,732 - INFO - Validated that VN ctest-right_vn-21277342 is not found in API Server
2026-01-29 03:16:38,745 - DEBUG - VN ctest-right_vn-21277342 is not present in Agent 10.0.0.49
2026-01-29 03:16:38,755 - DEBUG - VN ctest-right_vn-21277342 is not present in Agent 10.0.0.128
2026-01-29 03:16:38,755 - INFO - Validated that VN ctest-right_vn-21277342 is not in any agent
2026-01-29 03:16:38,800 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-21277342 info
2026-01-29 03:16:38,800 - INFO - Deleting VN ctest-left_vn-20596881
2026-01-29 03:16:38,947 - DEBUG - Response for deleting network ()
2026-01-29 03:16:38,947 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6068684f-27b8-4c3d-a9e9-ab38487915a7
2026-01-29 03:16:38,953 - DEBUG - Response Code: 404
2026-01-29 03:16:38,953 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:38,958 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:38,973 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:39,062 - INFO - Validated that VN ctest-left_vn-20596881 is not found in API Server
2026-01-29 03:16:39,073 - DEBUG - VN ctest-left_vn-20596881 is not present in Agent 10.0.0.49
2026-01-29 03:16:39,085 - DEBUG - VN ctest-left_vn-20596881 is not present in Agent 10.0.0.128
2026-01-29 03:16:39,085 - INFO - Validated that VN ctest-left_vn-20596881 is not in any agent
2026-01-29 03:16:39,114 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-20596881 info
2026-01-29 03:16:39,114 - INFO - Deleting VN ctest-mgmt_vn-97405166
2026-01-29 03:16:39,265 - DEBUG - Response for deleting network ()
2026-01-29 03:16:39,265 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/69bda31b-6421-4823-a337-5295a5e1fa75
2026-01-29 03:16:39,276 - DEBUG - Response Code: 404
2026-01-29 03:16:39,276 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:39,287 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:39,343 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:39,432 - INFO - Validated that VN ctest-mgmt_vn-97405166 is not found in API Server
2026-01-29 03:16:39,443 - DEBUG - VN ctest-mgmt_vn-97405166 is not present in Agent 10.0.0.49
2026-01-29 03:16:39,460 - DEBUG - VN ctest-mgmt_vn-97405166 is not present in Agent 10.0.0.128
2026-01-29 03:16:39,460 - INFO - Validated that VN ctest-mgmt_vn-97405166 is not in any agent
2026-01-29 03:16:39,493 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-97405166 info
2026-01-29 03:16:40,772 - DEBUG - No XMPP flaps were noticed during the test
2026-01-29 03:16:40,772 - INFO -
2026-01-29 03:16:40,772 - INFO - END TEST : test_svc_hc_basic : SKIPPED[0:00:15]
2026-01-29 03:16:40,772 - INFO - --------------------------------------------------------------------------------
2026-01-29 03:16:40,775 - INFO - ================================================================================
2026-01-29 03:16:40,776 - INFO - STARTING TEST : test_svc_trans_segment_right_hc_fail_svm
2026-01-29 03:16:42,067 - DEBUG - Nothing to compare xmpp stats {'10.0.0.49': {'10.20.0.193': '0', '10.20.0.254': '0'}, '10.0.0.128': {'10.20.0.254': '0', '10.20.0.14': '0'}} with
2026-01-29 03:16:42,067 - INFO - Initial checks done. Running the testcase now
2026-01-29 03:16:42,067 - INFO -
2026-01-29 03:16:42,331 - DEBUG - Response for create_network : {'network': {'id': '2885b5c7-784d-43c6-859b-a6c260e96eeb', 'name': 'ctest-mgmt_vn-47058693', 'tenant_id': '248f44c9178e43c78378822c3eeb9842', 'project_id': '248f44c9178e43c78378822c3eeb9842', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-91679647', 'ctest-mgmt_vn-47058693'], 'port_security_enabled': True, 'description': ''}}
2026-01-29 03:16:42,551 - DEBUG - Response for create_subnet : {'subnet': {'id': '08fa257f-e71b-43af-8c6e-9efad608436a', 'name': '', 'tenant_id': '248f44c9178e43c78378822c3eeb9842', 'network_id': '2885b5c7-784d-43c6-859b-a6c260e96eeb', 'ip_version': 4, 'cidr': '33.110.57.0/26', 'allocation_pools': [{'start': '33.110.57.2', 'end': '33.110.57.62'}], 'gateway_ip': '33.110.57.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '33.110.57.2', 'tags': [], 'project_id': '248f44c9178e43c78378822c3eeb9842'}}
2026-01-29 03:16:42,572 - INFO - Created VN ctest-mgmt_vn-47058693
2026-01-29 03:16:42,587 - DEBUG - VN ctest-mgmt_vn-47058693 UUID is 2885b5c7-784d-43c6-859b-a6c260e96eeb
2026-01-29 03:16:42,661 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:42,668 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:42,679 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:42,770 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/2885b5c7-784d-43c6-859b-a6c260e96eeb
2026-01-29 03:16:42,782 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/2885b5c7-784d-43c6-859b-a6c260e96eeb
2026-01-29 03:16:42,791 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/612c5154-faac-48c9-812a-ae331296ec25
2026-01-29 03:16:42,798 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/612c5154-faac-48c9-812a-ae331296ec25
2026-01-29 03:16:42,805 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/50296162-b22b-4d87-b54e-377a1453443b
2026-01-29 03:16:42,811 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-29 03:16:42,811 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/2885b5c7-784d-43c6-859b-a6c260e96eeb
2026-01-29 03:16:42,820 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/612c5154-faac-48c9-812a-ae331296ec25
2026-01-29 03:16:42,835 - INFO - Verified VN network id 13 for VN 2885b5c7-784d-43c6-859b-a6c260e96eeb
2026-01-29 03:16:42,835 - INFO - Verifications in API Server for VN ctest-mgmt_vn-47058693 passed
2026-01-29 03:16:42,835 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/2885b5c7-784d-43c6-859b-a6c260e96eeb
2026-01-29 03:16:42,844 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/612c5154-faac-48c9-812a-ae331296ec25
2026-01-29 03:16:42,853 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/612c5154-faac-48c9-812a-ae331296ec25
2026-01-29 03:16:42,860 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/50296162-b22b-4d87-b54e-377a1453443b
2026-01-29 03:16:42,872 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-47058693', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2919939801741083590', 'uuid-lslong': '9627471982214344427'}, 'enable': 'true', 'created': '2026-01-29T03:16:42', 'last-modified': '2026-01-29T03:16:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.365179'}
2026-01-29 03:16:42,877 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-29 03:16:42,882 - DEBUG - Control-node 10.0.0.147 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-47058693', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2919939801741083590', 'uuid-lslong': '9627471982214344427'}, 'enable': 'true', 'created': '2026-01-29T03:16:42', 'last-modified': '2026-01-29T03:16:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.377291'}
2026-01-29 03:16:42,888 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-29 03:16:42,893 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-47058693', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2919939801741083590', 'uuid-lslong': '9627471982214344427'}, 'enable': 'true', 'created': '2026-01-29T03:16:42', 'last-modified': '2026-01-29T03:16:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.390758'}
2026-01-29 03:16:42,899 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-29 03:16:42,899 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-mgmt_vn-47058693 passed
2026-01-29 03:16:42,899 - DEBUG - ====Verifying policy data for ctest-mgmt_vn-47058693 in API_Server ======
2026-01-29 03:16:42,899 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:42,906 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:42,916 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:43,032 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/2885b5c7-784d-43c6-859b-a6c260e96eeb
2026-01-29 03:16:43,041 - DEBUG - =>VN ctest-mgmt_vn-47058693 has no policy to be verified
2026-01-29 03:16:43,041 - DEBUG - Verifying the vn in opserver
2026-01-29 03:16:43,041 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-47058693 virtual network link through opserver 10.0.0.23
2026-01-29 03:16:43,041 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-01-29 03:16:43,053 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-47058693', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-47058693?flat'}
2026-01-29 03:16:43,053 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-47058693 virtual network link through opserver 10.0.0.147
2026-01-29 03:16:43,053 - DEBUG - Requesting: http://10.0.0.147:8081/analytics/uves/virtual-networks
2026-01-29 03:16:43,066 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-47058693', 'href': 'http://10.0.0.147:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-47058693?flat'}
2026-01-29 03:16:43,067 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-47058693 virtual network link through opserver 10.0.0.240
2026-01-29 03:16:43,067 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-01-29 03:16:43,079 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-47058693', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-47058693?flat'}
2026-01-29 03:16:43,079 - INFO - Validated that VN default-domain:ctest-TestSvcHC-91679647:ctest-mgmt_vn-47058693 is found in opserver
2026-01-29 03:16:43,103 - DEBUG - Do not have enough data to verify VN in agent
2026-01-29 03:16:43,116 - DEBUG - VRF ids for VN ctest-mgmt_vn-47058693: {}
2026-01-29 03:16:43,415 - DEBUG - Response for create_network : {'network': {'id': '24094c63-d0ac-48f4-83e8-b284029f6ae0', 'name': 'ctest-left_vn-10838171', 'tenant_id': '248f44c9178e43c78378822c3eeb9842', 'project_id': '248f44c9178e43c78378822c3eeb9842', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-91679647', 'ctest-left_vn-10838171'], 'port_security_enabled': True, 'description': ''}}
2026-01-29 03:16:43,641 - DEBUG - Response for create_subnet : {'subnet': {'id': '31f9f694-629d-430f-82f6-4e63d3d6740a', 'name': '', 'tenant_id': '248f44c9178e43c78378822c3eeb9842', 'network_id': '24094c63-d0ac-48f4-83e8-b284029f6ae0', 'ip_version': 4, 'cidr': '183.44.78.0/26', 'allocation_pools': [{'start': '183.44.78.2', 'end': '183.44.78.62'}], 'gateway_ip': '183.44.78.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '183.44.78.2', 'tags': [], 'project_id': '248f44c9178e43c78378822c3eeb9842'}}
2026-01-29 03:16:43,663 - INFO - Created VN ctest-left_vn-10838171
2026-01-29 03:16:43,675 - DEBUG - VN ctest-left_vn-10838171 UUID is 24094c63-d0ac-48f4-83e8-b284029f6ae0
2026-01-29 03:16:43,751 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:43,757 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:43,769 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:43,860 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/24094c63-d0ac-48f4-83e8-b284029f6ae0
2026-01-29 03:16:43,873 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/24094c63-d0ac-48f4-83e8-b284029f6ae0
2026-01-29 03:16:43,883 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/493b9142-a69f-422e-83b9-5ed8e3c6e19c
2026-01-29 03:16:43,892 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/493b9142-a69f-422e-83b9-5ed8e3c6e19c
2026-01-29 03:16:43,899 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/b724e694-7952-47cd-a8c0-da7bae88af18
2026-01-29 03:16:43,906 - DEBUG - Route Targets: ['target:64512:8000005']
2026-01-29 03:16:43,906 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/24094c63-d0ac-48f4-83e8-b284029f6ae0
2026-01-29 03:16:43,915 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/493b9142-a69f-422e-83b9-5ed8e3c6e19c
2026-01-29 03:16:43,930 - INFO - Verified VN network id 14 for VN 24094c63-d0ac-48f4-83e8-b284029f6ae0
2026-01-29 03:16:43,930 - INFO - Verifications in API Server for VN ctest-left_vn-10838171 passed
2026-01-29 03:16:43,930 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/24094c63-d0ac-48f4-83e8-b284029f6ae0
2026-01-29 03:16:43,939 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/493b9142-a69f-422e-83b9-5ed8e3c6e19c
2026-01-29 03:16:43,946 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/493b9142-a69f-422e-83b9-5ed8e3c6e19c
2026-01-29 03:16:43,956 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/b724e694-7952-47cd-a8c0-da7bae88af18
2026-01-29 03:16:43,967 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-10838171', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2596690651742226676', 'uuid-lslong': '9505043293614861024'}, 'enable': 'true', 'created': '2026-01-29T03:16:43', 'last-modified': '2026-01-29T03:16:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.394300'}
2026-01-29 03:16:43,973 - DEBUG - Route Targets: ['target:64512:8000005']
2026-01-29 03:16:43,980 - DEBUG - Control-node 10.0.0.147 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-10838171', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2596690651742226676', 'uuid-lslong': '9505043293614861024'}, 'enable': 'true', 'created': '2026-01-29T03:16:43', 'last-modified': '2026-01-29T03:16:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.404471'}
2026-01-29 03:16:43,986 - DEBUG - Route Targets: ['target:64512:8000005']
2026-01-29 03:16:43,992 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-10838171', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2596690651742226676', 'uuid-lslong': '9505043293614861024'}, 'enable': 'true', 'created': '2026-01-29T03:16:43', 'last-modified': '2026-01-29T03:16:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.413184'}
2026-01-29 03:16:43,998 - DEBUG - Route Targets: ['target:64512:8000005']
2026-01-29 03:16:43,998 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-left_vn-10838171 passed
2026-01-29 03:16:43,998 - DEBUG - ====Verifying policy data for ctest-left_vn-10838171 in API_Server ======
2026-01-29 03:16:43,998 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:44,005 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:44,016 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:44,109 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/24094c63-d0ac-48f4-83e8-b284029f6ae0
2026-01-29 03:16:44,119 - DEBUG - =>VN ctest-left_vn-10838171 has no policy to be verified
2026-01-29 03:16:44,119 - DEBUG - Verifying the vn in opserver
2026-01-29 03:16:44,119 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-10838171 virtual network link through opserver 10.0.0.23
2026-01-29 03:16:44,119 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-01-29 03:16:44,131 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-10838171', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-10838171?flat'}
2026-01-29 03:16:44,131 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-10838171 virtual network link through opserver 10.0.0.147
2026-01-29 03:16:44,131 - DEBUG - Requesting: http://10.0.0.147:8081/analytics/uves/virtual-networks
2026-01-29 03:16:44,197 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-10838171', 'href': 'http://10.0.0.147:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-10838171?flat'}
2026-01-29 03:16:44,197 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-10838171 virtual network link through opserver 10.0.0.240
2026-01-29 03:16:44,197 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-01-29 03:16:44,210 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-10838171', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-10838171?flat'}
2026-01-29 03:16:44,210 - INFO - Validated that VN default-domain:ctest-TestSvcHC-91679647:ctest-left_vn-10838171 is found in opserver
2026-01-29 03:16:44,232 - DEBUG - Do not have enough data to verify VN in agent
2026-01-29 03:16:44,242 - DEBUG - VRF ids for VN ctest-left_vn-10838171: {}
2026-01-29 03:16:44,516 - DEBUG - Response for create_network : {'network': {'id': 'e341b926-8b56-4ae7-8033-c1313ea53543', 'name': 'ctest-right_vn-68034897', 'tenant_id': '248f44c9178e43c78378822c3eeb9842', 'project_id': '248f44c9178e43c78378822c3eeb9842', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-91679647', 'ctest-right_vn-68034897'], 'port_security_enabled': True, 'description': ''}}
2026-01-29 03:16:44,775 - DEBUG - Response for create_subnet : {'subnet': {'id': '0092a4a3-46d7-4b97-8568-1af9df887a80', 'name': '', 'tenant_id': '248f44c9178e43c78378822c3eeb9842', 'network_id': 'e341b926-8b56-4ae7-8033-c1313ea53543', 'ip_version': 4, 'cidr': '217.224.226.128/26', 'allocation_pools': [{'start': '217.224.226.130', 'end': '217.224.226.190'}], 'gateway_ip': '217.224.226.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '217.224.226.130', 'tags': [], 'project_id': '248f44c9178e43c78378822c3eeb9842'}}
2026-01-29 03:16:44,797 - INFO - Created VN ctest-right_vn-68034897
2026-01-29 03:16:44,809 - DEBUG - VN ctest-right_vn-68034897 UUID is e341b926-8b56-4ae7-8033-c1313ea53543
2026-01-29 03:16:44,885 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:44,891 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:44,905 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:45,004 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/e341b926-8b56-4ae7-8033-c1313ea53543
2026-01-29 03:16:45,016 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/e341b926-8b56-4ae7-8033-c1313ea53543
2026-01-29 03:16:45,025 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/c2a90270-031f-478c-8f12-28747ee21fba
2026-01-29 03:16:45,035 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/c2a90270-031f-478c-8f12-28747ee21fba
2026-01-29 03:16:45,043 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/64bde1f5-5a8a-40ef-8204-47fd83f20789
2026-01-29 03:16:45,051 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-29 03:16:45,051 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/e341b926-8b56-4ae7-8033-c1313ea53543
2026-01-29 03:16:45,061 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/c2a90270-031f-478c-8f12-28747ee21fba
2026-01-29 03:16:45,078 - INFO - Verified VN network id 15 for VN e341b926-8b56-4ae7-8033-c1313ea53543
2026-01-29 03:16:45,079 - INFO - Verifications in API Server for VN ctest-right_vn-68034897 passed
2026-01-29 03:16:45,079 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/e341b926-8b56-4ae7-8033-c1313ea53543
2026-01-29 03:16:45,096 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/c2a90270-031f-478c-8f12-28747ee21fba
2026-01-29 03:16:45,104 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/c2a90270-031f-478c-8f12-28747ee21fba
2026-01-29 03:16:45,111 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/64bde1f5-5a8a-40ef-8204-47fd83f20789
2026-01-29 03:16:45,123 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-68034897', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16375573295293418215', 'uuid-lslong': '9237939677915592003'}, 'enable': 'true', 'created': '2026-01-29T03:16:44', 'last-modified': '2026-01-29T03:16:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.398337'}
2026-01-29 03:16:45,128 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-29 03:16:45,133 - DEBUG - Control-node 10.0.0.147 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-68034897', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16375573295293418215', 'uuid-lslong': '9237939677915592003'}, 'enable': 'true', 'created': '2026-01-29T03:16:44', 'last-modified': '2026-01-29T03:16:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.409028'}
2026-01-29 03:16:45,141 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-29 03:16:45,147 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-68034897', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16375573295293418215', 'uuid-lslong': '9237939677915592003'}, 'enable': 'true', 'created': '2026-01-29T03:16:44', 'last-modified': '2026-01-29T03:16:44', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.430113'}
2026-01-29 03:16:45,153 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-29 03:16:45,153 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-right_vn-68034897 passed
2026-01-29 03:16:45,153 - DEBUG - ====Verifying policy data for ctest-right_vn-68034897 in API_Server ======
2026-01-29 03:16:45,153 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:45,160 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:45,171 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:45,272 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/e341b926-8b56-4ae7-8033-c1313ea53543
2026-01-29 03:16:45,283 - DEBUG - =>VN ctest-right_vn-68034897 has no policy to be verified
2026-01-29 03:16:45,283 - DEBUG - Verifying the vn in opserver
2026-01-29 03:16:45,283 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-68034897 virtual network link through opserver 10.0.0.23
2026-01-29 03:16:45,283 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-01-29 03:16:45,297 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-68034897', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-68034897?flat'}
2026-01-29 03:16:45,297 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-68034897 virtual network link through opserver 10.0.0.147
2026-01-29 03:16:45,297 - DEBUG - Requesting: http://10.0.0.147:8081/analytics/uves/virtual-networks
2026-01-29 03:16:45,311 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-68034897', 'href': 'http://10.0.0.147:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-68034897?flat'}
2026-01-29 03:16:45,312 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-68034897 virtual network link through opserver 10.0.0.240
2026-01-29 03:16:45,312 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-01-29 03:16:45,325 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-68034897', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-68034897?flat'}
2026-01-29 03:16:45,325 - INFO - Validated that VN default-domain:ctest-TestSvcHC-91679647:ctest-right_vn-68034897 is found in opserver
2026-01-29 03:16:45,348 - DEBUG - Do not have enough data to verify VN in agent
2026-01-29 03:16:45,359 - DEBUG - VRF ids for VN ctest-right_vn-68034897: {}
2026-01-29 03:16:45,658 - DEBUG - Response for create_network : {'network': {'id': 'ede2ab17-b326-46cc-a926-fe36c02b6843', 'name': 'ctest-trans_left_vn-41062573', 'tenant_id': '248f44c9178e43c78378822c3eeb9842', 'project_id': '248f44c9178e43c78378822c3eeb9842', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-91679647', 'ctest-trans_left_vn-41062573'], 'port_security_enabled': True, 'description': ''}}
2026-01-29 03:16:45,890 - DEBUG - Response for create_subnet : {'subnet': {'id': '972aefe8-109c-453e-8250-3b85f4db5645', 'name': '', 'tenant_id': '248f44c9178e43c78378822c3eeb9842', 'network_id': 'ede2ab17-b326-46cc-a926-fe36c02b6843', 'ip_version': 4, 'cidr': '78.22.105.128/26', 'allocation_pools': [{'start': '78.22.105.130', 'end': '78.22.105.190'}], 'gateway_ip': '78.22.105.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '78.22.105.130', 'tags': [], 'project_id': '248f44c9178e43c78378822c3eeb9842'}}
2026-01-29 03:16:45,909 - INFO - Created VN ctest-trans_left_vn-41062573
2026-01-29 03:16:45,926 - DEBUG - VN ctest-trans_left_vn-41062573 UUID is ede2ab17-b326-46cc-a926-fe36c02b6843
2026-01-29 03:16:45,995 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:46,002 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:46,012 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:46,112 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/ede2ab17-b326-46cc-a926-fe36c02b6843
2026-01-29 03:16:46,125 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/ede2ab17-b326-46cc-a926-fe36c02b6843
2026-01-29 03:16:46,134 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6c13496d-b238-48d6-9827-8baa4c7cf55e
2026-01-29 03:16:46,141 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6c13496d-b238-48d6-9827-8baa4c7cf55e
2026-01-29 03:16:46,148 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/1f4c3a97-dbda-4c41-a63a-27e2dfc45074
2026-01-29 03:16:46,155 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-29 03:16:46,155 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/ede2ab17-b326-46cc-a926-fe36c02b6843
2026-01-29 03:16:46,164 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6c13496d-b238-48d6-9827-8baa4c7cf55e
2026-01-29 03:16:46,180 - INFO - Verified VN network id 16 for VN ede2ab17-b326-46cc-a926-fe36c02b6843
2026-01-29 03:16:46,180 - INFO - Verifications in API Server for VN ctest-trans_left_vn-41062573 passed
2026-01-29 03:16:46,180 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/ede2ab17-b326-46cc-a926-fe36c02b6843
2026-01-29 03:16:46,191 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6c13496d-b238-48d6-9827-8baa4c7cf55e
2026-01-29 03:16:46,200 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6c13496d-b238-48d6-9827-8baa4c7cf55e
2026-01-29 03:16:46,207 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/1f4c3a97-dbda-4c41-a63a-27e2dfc45074
2026-01-29 03:16:46,222 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-trans_left_vn-41062573', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17141451250003756748', 'uuid-lslong': '12188708952630585411'}, 'enable': 'true', 'created': '2026-01-29T03:16:45', 'last-modified': '2026-01-29T03:16:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.401072'}
2026-01-29 03:16:46,229 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-29 03:16:46,235 - DEBUG - Control-node 10.0.0.147 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-trans_left_vn-41062573', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17141451250003756748', 'uuid-lslong': '12188708952630585411'}, 'enable': 'true', 'created': '2026-01-29T03:16:45', 'last-modified': '2026-01-29T03:16:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.415077'}
2026-01-29 03:16:46,241 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-29 03:16:46,248 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-trans_left_vn-41062573', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17141451250003756748', 'uuid-lslong': '12188708952630585411'}, 'enable': 'true', 'created': '2026-01-29T03:16:45', 'last-modified': '2026-01-29T03:16:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.415037'}
2026-01-29 03:16:46,255 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-29 03:16:46,255 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_left_vn-41062573 passed
2026-01-29 03:16:46,255 - DEBUG - ====Verifying policy data for ctest-trans_left_vn-41062573 in API_Server ======
2026-01-29 03:16:46,255 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:46,265 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:46,279 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:46,408 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/ede2ab17-b326-46cc-a926-fe36c02b6843
2026-01-29 03:16:46,421 - DEBUG - =>VN ctest-trans_left_vn-41062573 has no policy to be verified
2026-01-29 03:16:46,421 - DEBUG - Verifying the vn in opserver
2026-01-29 03:16:46,421 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-trans_left_vn-41062573 virtual network link through opserver 10.0.0.23
2026-01-29 03:16:46,421 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-01-29 03:16:46,434 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-trans_left_vn-41062573', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-trans_left_vn-41062573?flat'}
2026-01-29 03:16:46,434 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-trans_left_vn-41062573 virtual network link through opserver 10.0.0.147
2026-01-29 03:16:46,434 - DEBUG - Requesting: http://10.0.0.147:8081/analytics/uves/virtual-networks
2026-01-29 03:16:46,445 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-trans_left_vn-41062573', 'href': 'http://10.0.0.147:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-trans_left_vn-41062573?flat'}
2026-01-29 03:16:46,445 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-trans_left_vn-41062573 virtual network link through opserver 10.0.0.240
2026-01-29 03:16:46,445 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-01-29 03:16:46,459 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-trans_left_vn-41062573', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-trans_left_vn-41062573?flat'}
2026-01-29 03:16:46,459 - INFO - Validated that VN default-domain:ctest-TestSvcHC-91679647:ctest-trans_left_vn-41062573 is found in opserver
2026-01-29 03:16:46,483 - DEBUG - Do not have enough data to verify VN in agent
2026-01-29 03:16:46,494 - DEBUG - VRF ids for VN ctest-trans_left_vn-41062573: {}
2026-01-29 03:16:46,772 - DEBUG - Response for create_network : {'network': {'id': 'c9344821-e99b-485d-a3fa-1dcae3489169', 'name': 'ctest-trans_right_vn-01369258', 'tenant_id': '248f44c9178e43c78378822c3eeb9842', 'project_id': '248f44c9178e43c78378822c3eeb9842', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestSvcHC-91679647', 'ctest-trans_right_vn-01369258'], 'port_security_enabled': True, 'description': ''}}
2026-01-29 03:16:47,006 - DEBUG - Response for create_subnet : {'subnet': {'id': 'bd5325b9-9e1c-4bc5-b8ab-78908c0cc6b0', 'name': '', 'tenant_id': '248f44c9178e43c78378822c3eeb9842', 'network_id': 'c9344821-e99b-485d-a3fa-1dcae3489169', 'ip_version': 4, 'cidr': '211.187.43.64/26', 'allocation_pools': [{'start': '211.187.43.66', 'end': '211.187.43.126'}], 'gateway_ip': '211.187.43.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '211.187.43.66', 'tags': [], 'project_id': '248f44c9178e43c78378822c3eeb9842'}}
2026-01-29 03:16:47,029 - INFO - Created VN ctest-trans_right_vn-01369258
2026-01-29 03:16:47,044 - DEBUG - VN ctest-trans_right_vn-01369258 UUID is c9344821-e99b-485d-a3fa-1dcae3489169
2026-01-29 03:16:47,124 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:47,134 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:47,149 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:47,263 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c9344821-e99b-485d-a3fa-1dcae3489169
2026-01-29 03:16:47,289 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c9344821-e99b-485d-a3fa-1dcae3489169
2026-01-29 03:16:47,308 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/d66eab14-58fe-477e-909d-b5662395edca
2026-01-29 03:16:47,319 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/d66eab14-58fe-477e-909d-b5662395edca
2026-01-29 03:16:47,329 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/047b6842-c6cd-4806-b863-e3cc79958b89
2026-01-29 03:16:47,337 - DEBUG - Route Targets: ['target:64512:8000008']
2026-01-29 03:16:47,337 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c9344821-e99b-485d-a3fa-1dcae3489169
2026-01-29 03:16:47,349 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/d66eab14-58fe-477e-909d-b5662395edca
2026-01-29 03:16:47,366 - INFO - Verified VN network id 17 for VN c9344821-e99b-485d-a3fa-1dcae3489169
2026-01-29 03:16:47,366 - INFO - Verifications in API Server for VN ctest-trans_right_vn-01369258 passed
2026-01-29 03:16:47,366 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c9344821-e99b-485d-a3fa-1dcae3489169
2026-01-29 03:16:47,377 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/d66eab14-58fe-477e-909d-b5662395edca
2026-01-29 03:16:47,388 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/d66eab14-58fe-477e-909d-b5662395edca
2026-01-29 03:16:47,396 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/047b6842-c6cd-4806-b863-e3cc79958b89
2026-01-29 03:16:47,408 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-trans_right_vn-01369258', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14498292410902857821', 'uuid-lslong': '11815789329593700713'}, 'enable': 'true', 'created': '2026-01-29T03:16:46', 'last-modified': '2026-01-29T03:16:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.452225'}
2026-01-29 03:16:47,416 - DEBUG - Route Targets: ['target:64512:8000008']
2026-01-29 03:16:47,421 - DEBUG - Control-node 10.0.0.147 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-trans_right_vn-01369258', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14498292410902857821', 'uuid-lslong': '11815789329593700713'}, 'enable': 'true', 'created': '2026-01-29T03:16:46', 'last-modified': '2026-01-29T03:16:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.467507'}
2026-01-29 03:16:47,427 - DEBUG - Route Targets: ['target:64512:8000008']
2026-01-29 03:16:47,433 - DEBUG - Control-node 10.0.0.240 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestSvcHC-91679647:ctest-trans_right_vn-01369258', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestSvcHC-91679647', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14498292410902857821', 'uuid-lslong': '11815789329593700713'}, 'enable': 'true', 'created': '2026-01-29T03:16:46', 'last-modified': '2026-01-29T03:16:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.484543'}
2026-01-29 03:16:47,438 - DEBUG - Route Targets: ['target:64512:8000008']
2026-01-29 03:16:47,439 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-trans_right_vn-01369258 passed
2026-01-29 03:16:47,439 - DEBUG - ====Verifying policy data for ctest-trans_right_vn-01369258 in API_Server ======
2026-01-29 03:16:47,439 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:47,446 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:47,460 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:47,565 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c9344821-e99b-485d-a3fa-1dcae3489169
2026-01-29 03:16:47,583 - DEBUG - =>VN ctest-trans_right_vn-01369258 has no policy to be verified
2026-01-29 03:16:47,583 - DEBUG - Verifying the vn in opserver
2026-01-29 03:16:47,583 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-trans_right_vn-01369258 virtual network link through opserver 10.0.0.23
2026-01-29 03:16:47,583 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-01-29 03:16:47,596 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-trans_right_vn-01369258', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-trans_right_vn-01369258?flat'}
2026-01-29 03:16:47,596 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-trans_right_vn-01369258 virtual network link through opserver 10.0.0.147
2026-01-29 03:16:47,596 - DEBUG - Requesting: http://10.0.0.147:8081/analytics/uves/virtual-networks
2026-01-29 03:16:47,608 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-trans_right_vn-01369258', 'href': 'http://10.0.0.147:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-trans_right_vn-01369258?flat'}
2026-01-29 03:16:47,608 - DEBUG - Verifying the default-domain:ctest-TestSvcHC-91679647:ctest-trans_right_vn-01369258 virtual network link through opserver 10.0.0.240
2026-01-29 03:16:47,608 - DEBUG - Requesting: http://10.0.0.240:8081/analytics/uves/virtual-networks
2026-01-29 03:16:47,621 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestSvcHC-91679647:ctest-trans_right_vn-01369258', 'href': 'http://10.0.0.240:8081/analytics/uves/virtual-network/default-domain:ctest-TestSvcHC-91679647:ctest-trans_right_vn-01369258?flat'}
2026-01-29 03:16:47,621 - INFO - Validated that VN default-domain:ctest-TestSvcHC-91679647:ctest-trans_right_vn-01369258 is found in opserver
2026-01-29 03:16:47,644 - DEBUG - Do not have enough data to verify VN in agent
2026-01-29 03:16:47,656 - DEBUG - VRF ids for VN ctest-trans_right_vn-01369258: {}
2026-01-29 03:16:48,739 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5115-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5115-2)
2026-01-29 03:16:50,044 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5115-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5115-1)
2026-01-29 03:16:50,044 - DEBUG - Creating service template: ['default-domain', 'ctest-service_template_1-41902533']
2026-01-29 03:16:50,333 - DEBUG - Service template: ['default-domain', 'ctest-service_template_1-41902533'] created succesfully
2026-01-29 03:16:50,712 - DEBUG - Image by name tiny_trans_fw not found
2026-01-29 03:16:50,712 - DEBUG - Installing image tiny_trans_fw
2026-01-29 03:16:50,712 - DEBUG - Image info {'name': 'tinycore-net-transparent-fw.qcow2.gz', 'webserver': '', 'location': '/images/tinycore/', 'username': 'tc', 'password': 'secret', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hypervisor_type=qemu', 'name_docker': 'phusion-baseimage-enablesshd'}
2026-01-29 03:16:50,713 - DEBUG - Image build path file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-01-29 03:16:50,713 - DEBUG - Download image from local file file:///contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-01-29 03:16:50,713 - DEBUG - Unzip image
2026-01-29 03:16:50,713 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/tinycore-net-transparent-fw.qcow2.gz
2026-01-29 03:16:50,732 - INFO - image /contrail-test/images/tinycore-net-transparent-fw.qcow2 is not found
2026-01-29 03:16:50,733 - DEBUG - Deleting service template: ['default-domain', 'ctest-service_template_1-41902533']
2026-01-29 03:16:50,825 - INFO - Service template: ['default-domain', 'ctest-service_template_1-41902533'] deleted successfully.
2026-01-29 03:16:50,826 - INFO - Skip interface_detach for VM ctest-right_vm-50286498 in state BUILD
2026-01-29 03:16:50,826 - INFO - Deleting VM ctest-right_vm-50286498
2026-01-29 03:16:50,826 - ERROR - VM ctest-right_vm-50286498 has failed to come up
2026-01-29 03:16:50,826 - ERROR - Nova failed to get host of the VM
2026-01-29 03:16:50,826 - ERROR - VM ctest-right_vm-50286498 has failed to come up
2026-01-29 03:16:50,826 - ERROR - Nova failed to get host of the VM
2026-01-29 03:16:50,934 - INFO - Skip interface_detach for VM ctest-left_vm-59972266 in state BUILD
2026-01-29 03:16:50,934 - INFO - Deleting VM ctest-left_vm-59972266
2026-01-29 03:16:50,934 - ERROR - VM ctest-left_vm-59972266 has failed to come up
2026-01-29 03:16:50,934 - ERROR - Nova failed to get host of the VM
2026-01-29 03:16:50,934 - ERROR - VM ctest-left_vm-59972266 has failed to come up
2026-01-29 03:16:50,934 - ERROR - Nova failed to get host of the VM
2026-01-29 03:16:51,029 - INFO - Deleting VN ctest-trans_right_vn-01369258
2026-01-29 03:16:51,199 - DEBUG - Response for deleting network ()
2026-01-29 03:16:51,199 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/d66eab14-58fe-477e-909d-b5662395edca
2026-01-29 03:16:51,206 - DEBUG - Response Code: 404
2026-01-29 03:16:51,207 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:51,214 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:51,229 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:51,341 - INFO - Validated that VN ctest-trans_right_vn-01369258 is not found in API Server
2026-01-29 03:16:51,381 - DEBUG - VN ctest-trans_right_vn-01369258 is not present in Agent 10.0.0.49
2026-01-29 03:16:51,392 - DEBUG - VN ctest-trans_right_vn-01369258 is not present in Agent 10.0.0.128
2026-01-29 03:16:51,392 - INFO - Validated that VN ctest-trans_right_vn-01369258 is not in any agent
2026-01-29 03:16:51,429 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_right_vn-01369258 info
2026-01-29 03:16:51,429 - INFO - Deleting VN ctest-trans_left_vn-41062573
2026-01-29 03:16:51,602 - DEBUG - Response for deleting network ()
2026-01-29 03:16:51,603 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/6c13496d-b238-48d6-9827-8baa4c7cf55e
2026-01-29 03:16:51,610 - DEBUG - Response Code: 404
2026-01-29 03:16:51,611 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:51,626 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:51,637 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:51,727 - INFO - Validated that VN ctest-trans_left_vn-41062573 is not found in API Server
2026-01-29 03:16:51,747 - DEBUG - VN ctest-trans_left_vn-41062573 is not present in Agent 10.0.0.49
2026-01-29 03:16:51,762 - DEBUG - VN ctest-trans_left_vn-41062573 is not present in Agent 10.0.0.128
2026-01-29 03:16:51,762 - INFO - Validated that VN ctest-trans_left_vn-41062573 is not in any agent
2026-01-29 03:16:51,811 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-trans_left_vn-41062573 info
2026-01-29 03:16:51,812 - INFO - Deleting VN ctest-right_vn-68034897
2026-01-29 03:16:51,860 - DEBUG - VN e341b926-8b56-4ae7-8033-c1313ea53543 still in use: Unable to complete operation on network e341b926-8b56-4ae7-8033-c1313ea53543. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-57e8854b-9d25-4c00-b603-1d178fba5481']
2026-01-29 03:16:51,860 - WARNING - Deleting VN ctest-right_vn-68034897 failed..Will retry
2026-01-29 03:16:54,019 - DEBUG - Response for deleting network ()
2026-01-29 03:16:54,019 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/c2a90270-031f-478c-8f12-28747ee21fba
2026-01-29 03:16:54,025 - DEBUG - Response Code: 404
2026-01-29 03:16:54,025 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:54,040 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:54,051 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:54,147 - INFO - Validated that VN ctest-right_vn-68034897 is not found in API Server
2026-01-29 03:16:54,161 - DEBUG - VN ctest-right_vn-68034897 is not present in Agent 10.0.0.49
2026-01-29 03:16:54,172 - DEBUG - VN ctest-right_vn-68034897 is not present in Agent 10.0.0.128
2026-01-29 03:16:54,172 - INFO - Validated that VN ctest-right_vn-68034897 is not in any agent
2026-01-29 03:16:54,222 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-right_vn-68034897 info
2026-01-29 03:16:54,222 - INFO - Deleting VN ctest-left_vn-10838171
2026-01-29 03:16:54,458 - DEBUG - Response for deleting network ()
2026-01-29 03:16:54,458 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/493b9142-a69f-422e-83b9-5ed8e3c6e19c
2026-01-29 03:16:54,471 - DEBUG - Response Code: 404
2026-01-29 03:16:54,472 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:54,479 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:54,538 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:54,647 - INFO - Validated that VN ctest-left_vn-10838171 is not found in API Server
2026-01-29 03:16:54,660 - DEBUG - VN ctest-left_vn-10838171 is not present in Agent 10.0.0.49
2026-01-29 03:16:54,672 - DEBUG - VN ctest-left_vn-10838171 is not present in Agent 10.0.0.128
2026-01-29 03:16:54,672 - INFO - Validated that VN ctest-left_vn-10838171 is not in any agent
2026-01-29 03:16:54,710 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-left_vn-10838171 info
2026-01-29 03:16:54,711 - INFO - Deleting VN ctest-mgmt_vn-47058693
2026-01-29 03:16:54,887 - DEBUG - Response for deleting network ()
2026-01-29 03:16:54,887 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/612c5154-faac-48c9-812a-ae331296ec25
2026-01-29 03:16:54,908 - DEBUG - Response Code: 404
2026-01-29 03:16:54,909 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2026-01-29 03:16:54,917 - DEBUG - Requesting: http://10.0.0.23:8082/domain/65230a56-1cf0-4d34-9498-1ad48da04806
2026-01-29 03:16:54,934 - DEBUG - Requesting: http://10.0.0.23:8082/project/248f44c9-178e-43c7-8378-822c3eeb9842
2026-01-29 03:16:55,035 - INFO - Validated that VN ctest-mgmt_vn-47058693 is not found in API Server
2026-01-29 03:16:55,049 - DEBUG - VN ctest-mgmt_vn-47058693 is not present in Agent 10.0.0.49
2026-01-29 03:16:55,060 - DEBUG - VN ctest-mgmt_vn-47058693 is not present in Agent 10.0.0.128
2026-01-29 03:16:55,060 - INFO - Validated that VN ctest-mgmt_vn-47058693 is not in any agent
2026-01-29 03:16:55,096 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-mgmt_vn-47058693 info
2026-01-29 03:16:56,381 - DEBUG - No XMPP flaps were noticed during the test
2026-01-29 03:16:56,381 - INFO -
2026-01-29 03:16:56,381 - INFO - END TEST : test_svc_trans_segment_right_hc_fail_svm : SKIPPED[0:00:16]
2026-01-29 03:16:56,382 - INFO - --------------------------------------------------------------------------------
2026-01-29 03:16:57,129 - INFO - Deleted project: ctest-TestSvcHC-91679647, ID : 248f44c9-178e-43c7-8378-822c3eeb9842