2025-10-22 19:08:44,412 - INFO - Domain Default found not creating 2025-10-22 19:08:44,581 - INFO - Project ctest-AnalyticsBasicTestSanity-47623403 not found, creating it 2025-10-22 19:08:45,093 - INFO - Created Project:ctest-AnalyticsBasicTestSanity-47623403, ID : 42039591-f5b6-4a7f-844f-55106f67b773 2025-10-22 19:08:46,523 - INFO - ================================================================================ 2025-10-22 19:08:46,524 - INFO - STARTING TEST : test_verify_object_logs 2025-10-22 19:08:46,524 - INFO - TEST DESCRIPTION : Description: Test to validate object logs 1.Create vn/vm and verify object log tables updated with those vn, vm and routing-instance - fails otherwise Maintainer: sandipd@juniper.net 2025-10-22 19:08:46,655 - DEBUG - Nothing to compare xmpp stats {'10.0.0.249': {'10.20.0.17': '0'}} with 2025-10-22 19:08:46,655 - INFO - Initial checks done. Running the testcase now 2025-10-22 19:08:46,655 - INFO - 2025-10-22 19:08:47,491 - DEBUG - Response for create_network : {'network': {'id': '1c70bcab-35e8-466d-98b7-7433d263a0b5', 'name': 'ctest-vn22-09426189', 'tenant_id': '42039591f5b64a7f844f55106f67b773', 'project_id': '42039591f5b64a7f844f55106f67b773', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsBasicTestSanity-47623403', 'ctest-vn22-09426189'], 'port_security_enabled': True, 'description': ''}} 2025-10-22 19:08:47,658 - DEBUG - Response for create_subnet : {'subnet': {'id': '71ae249b-375b-4751-8911-641ee7046d35', 'name': '', 'tenant_id': '42039591f5b64a7f844f55106f67b773', 'network_id': '1c70bcab-35e8-466d-98b7-7433d263a0b5', 'ip_version': 4, 'cidr': '58.247.52.192/26', 'allocation_pools': [{'start': '58.247.52.194', 'end': '58.247.52.254'}], 'gateway_ip': '58.247.52.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '58.247.52.194', 'tags': [], 'project_id': '42039591f5b64a7f844f55106f67b773'}} 2025-10-22 19:08:47,678 - INFO - Created VN ctest-vn22-09426189 2025-10-22 19:08:47,731 - DEBUG - VN ctest-vn22-09426189 UUID is 1c70bcab-35e8-466d-98b7-7433d263a0b5 2025-10-22 19:08:47,841 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-10-22 19:08:48,137 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-10-22 19:08:48,166 - DEBUG - Requesting: http://10.0.0.249:8082/domain/4fa4561c-cadb-41af-a3b5-05e18d999394 2025-10-22 19:08:48,184 - DEBUG - Requesting: http://10.0.0.249:8082/project/42039591-f5b6-4a7f-844f-55106f67b773 2025-10-22 19:08:48,256 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/1c70bcab-35e8-466d-98b7-7433d263a0b5 2025-10-22 19:08:48,271 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/1c70bcab-35e8-466d-98b7-7433d263a0b5 2025-10-22 19:08:48,282 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b089dce9-161e-42b4-8b98-22ca36d01e42 2025-10-22 19:08:48,291 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b089dce9-161e-42b4-8b98-22ca36d01e42 2025-10-22 19:08:48,297 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/3d533b5e-4889-4296-b444-44fb3aa4f666 2025-10-22 19:08:48,363 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-22 19:08:48,363 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/1c70bcab-35e8-466d-98b7-7433d263a0b5 2025-10-22 19:08:48,372 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b089dce9-161e-42b4-8b98-22ca36d01e42 2025-10-22 19:08:48,387 - INFO - Verified VN network id 5 for VN 1c70bcab-35e8-466d-98b7-7433d263a0b5 2025-10-22 19:08:48,387 - INFO - Verifications in API Server for VN ctest-vn22-09426189 passed 2025-10-22 19:08:48,387 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/1c70bcab-35e8-466d-98b7-7433d263a0b5 2025-10-22 19:08:48,395 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b089dce9-161e-42b4-8b98-22ca36d01e42 2025-10-22 19:08:48,403 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b089dce9-161e-42b4-8b98-22ca36d01e42 2025-10-22 19:08:48,410 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/3d533b5e-4889-4296-b444-44fb3aa4f666 2025-10-22 19:08:48,417 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189 2025-10-22 19:08:48,425 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsBasicTestSanity-47623403', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2049345273983420013', 'uuid-lslong': '11004391980424994997'}, 'enable': 'true', 'created': '2025-10-22T19:08:47', 'last-modified': '2025-10-22T19:08:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.803042'} 2025-10-22 19:08:48,425 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-09426189 2025-10-22 19:08:48,433 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-10-22 19:08:48,433 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn22-09426189 passed 2025-10-22 19:08:48,434 - DEBUG - ====Verifying policy data for ctest-vn22-09426189 in API_Server ====== 2025-10-22 19:08:48,434 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-10-22 19:08:48,440 - DEBUG - Requesting: http://10.0.0.249:8082/domain/4fa4561c-cadb-41af-a3b5-05e18d999394 2025-10-22 19:08:48,451 - DEBUG - Requesting: http://10.0.0.249:8082/project/42039591-f5b6-4a7f-844f-55106f67b773 2025-10-22 19:08:48,530 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/1c70bcab-35e8-466d-98b7-7433d263a0b5 2025-10-22 19:08:48,539 - DEBUG - =>VN ctest-vn22-09426189 has no policy to be verified 2025-10-22 19:08:48,539 - DEBUG - Verifying the vn in opserver 2025-10-22 19:08:48,539 - DEBUG - Verifying the default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189 virtual network link through opserver 10.0.0.249 2025-10-22 19:08:48,540 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2025-10-22 19:08:48,830 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2025-10-22 19:08:48,886 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189?flat'} 2025-10-22 19:08:48,886 - INFO - Validated that VN default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189 is found in opserver 2025-10-22 19:08:48,901 - DEBUG - Do not have enough data to verify VN in agent 2025-10-22 19:08:48,906 - DEBUG - VRF ids for VN ctest-vn22-09426189: {} 2025-10-22 19:08:49,014 - DEBUG - Services list from nova: [, , ] 2025-10-22 19:08:49,147 - DEBUG - Image by name cirros not found 2025-10-22 19:08:49,147 - DEBUG - Installing image cirros 2025-10-22 19:08:49,148 - DEBUG - Image info {'name': 'cirros-0.3.0-x86_64-disk.vmdk.gz', 'webserver': '', 'location': '/images/converts/', 'username': 'cirros', 'password': 'cubswin:)', 'type': 'os', 'flavor': 'contrail_flavor_tiny', 'params': '--container-format bare --disk-format vmdk --property vmware_disktype="sparse" --property vmware_adaptertype="ide" --property hw_scsi_model=virtio-scsi --property hw_disk_bus_model=virtio-scsi --property hw_disk_bus=virtio', 'name_docker': 'phusion-baseimage-enablesshd'} 2025-10-22 19:08:49,148 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/converts//cirros-0.3.0-x86_64-disk.vmdk.gz 2025-10-22 19:08:49,148 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/converts//cirros-0.3.0-x86_64-disk.vmdk.gz 2025-10-22 19:08:49,162 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/converts//cirros-0.3.0-x86_64-disk.vmdk.gz -O /contrail-test/images/cirros-0.3.0-x86_64-disk.vmdk.gz 2025-10-22 19:08:49,241 - DEBUG - Image has been downloaded to /contrail-test/images/cirros-0.3.0-x86_64-disk.vmdk.gz 2025-10-22 19:08:49,241 - DEBUG - Unzip image 2025-10-22 19:08:49,241 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/cirros-0.3.0-x86_64-disk.vmdk.gz 2025-10-22 19:08:49,369 - DEBUG - Try to create image in user context 2025-10-22 19:08:49,578 - DEBUG - Image has been created in user context 2025-10-22 19:08:49,578 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: rm -f /contrail-test/images/cirros-0.3.0-x86_64-disk.vmdk 2025-10-22 19:08:49,593 - DEBUG - Downloaded image has been removed 2025-10-22 19:08:49,613 - DEBUG - Uploaded image status = active 2025-10-22 19:08:52,138 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4436-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4436-1) 2025-10-22 19:08:52,183 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-10-22 19:08:57,287 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-10-22 19:09:02,371 - DEBUG - VM is in ACTIVE state now 2025-10-22 19:09:02,371 - DEBUG - Verifying ObjectVNTable for vn default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189 on analytics node 10.0.0.249 2025-10-22 19:09:02,374 - DEBUG - Posting: http://10.0.0.249:8081/analytics/query, payload {'table': 'ObjectVNTable', 'start_time': 1761160126655687, 'end_time': 1761160142374149, 'select_fields': ['ObjectId', 'Source', 'ObjectLog', 'SystemLog', 'Messagetype', 'ModuleId', 'MessageTS'], 'where': [[{'name': 'ObjectId', 'value': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'op': 1, 'value2': None}]]} 2025-10-22 19:09:03,409 - DEBUG - Query output : [{'MessageTS': 1761160136670529, 'Messagetype': 'VnObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'Addition 1c70bcab-35e8-466d-98b7-7433d263a0b5default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-0942618900000000-0000-0000-0000-00000000000058.247.52.1922658.247.52.193default-domain:default-project:default-network-ipamtrue58.247.52.194truetruetruetruefalse0controller/src/vnsw/agent/oper/vn.cc1408', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1', 'SystemLog': None}, {'MessageTS': 1761160136677223, 'Messagetype': 'VnObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'Modification 1c70bcab-35e8-466d-98b7-7433d263a0b5default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-0942618900000000-0000-0000-0000-000000000000default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-0942618958.247.52.1922658.247.52.193default-domain:default-project:default-network-ipamtrue58.247.52.194truetruetruetruefalse5controller/src/vnsw/agent/oper/vn.cc1408', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1', 'SystemLog': None}, {'MessageTS': 1761160127428359, 'Messagetype': 'ContrailConfigTrace', 'ModuleId': 'contrail-api', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189display_name"ctest-vn22-09426189"fq_name["default-domain", "ctest-AnalyticsBasicTestSanity-47623403", "ctest-vn22-09426189"]id_perms{"permissions": {"owner": "ctest-AnalyticsBasicTestSanity-47623403", "owner_access": 7, "group": "reader", "group_access": 7, "other_access": 7}, "uuid": {"uuid_mslong": 2049345273983420013, "uuid_lslong": 11004391980424994997}, "enable": true, "created": "2025-10-22T19:08:47.420905", "last_modified": "2025-10-22T19:08:47.420905", "description": "", "user_visible": true, "creator": null}is_sharedfalsemtu0network_policy_refs[]parent_type"project"parent_uuid"42039591-f5b6-4a7f-844f-55106f67b773"perms2{"owner": "42039591f5b64a7f844f55106f67b773", "owner_access": 7, "global_access": 0, "share": []}port_security_enabledtruerouter_externalfalseuuid"1c70bcab-35e8-466d-98b7-7433d263a0b5"virtual_network_network_id5false', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}, {'MessageTS': 1761160127431760, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-094261890', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}, {'MessageTS': 1761160127432422, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-094261890', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}, {'MessageTS': 1761160127459362, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-09426189target:10.20.0.17:6target:64512:7999999cn-jenkins-deploy-platform-ansible-os-4436-1controller/src/bgp/routing-instance/routing_instance.cc1239', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1', 'SystemLog': None}, {'MessageTS': 1761160127459384, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-09426189Addinetcn-jenkins-deploy-platform-ansible-os-4436-1controller/src/bgp/routing-instance/routing_instance.cc1720', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1', 'SystemLog': None}, {'MessageTS': 1761160127459476, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-09426189Addinet6cn-jenkins-deploy-platform-ansible-os-4436-1controller/src/bgp/routing-instance/routing_instance.cc1720', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1', 'SystemLog': None}, {'MessageTS': 1761160127459544, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-09426189Adderm-vpncn-jenkins-deploy-platform-ansible-os-4436-1controller/src/bgp/routing-instance/routing_instance.cc1720', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1', 'SystemLog': None}, {'MessageTS': 1761160127459607, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-09426189Adde-vpncn-jenkins-deploy-platform-ansible-os-4436-1controller/src/bgp/routing-instance/routing_instance.cc1720', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1', 'SystemLog': None}, {'MessageTS': 1761160127459676, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-09426189Addinet-mvpncn-jenkins-deploy-platform-ansible-os-4436-1controller/src/bgp/routing-instance/routing_instance.cc1720', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1', 'SystemLog': None}, {'MessageTS': 1761160127516448, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-0942618910.20.0.17:6target:64512:8000004target:64512:8000004cn-jenkins-deploy-platform-ansible-os-4436-1controller/src/bgp/routing-instance/routing_instance.cc1392', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1', 'SystemLog': None}, {'MessageTS': 1761160127559942, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-094261890', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}, {'MessageTS': 1761160127560316, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-094261890', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}, {'MessageTS': 1761160127622335, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-094261890', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}, {'MessageTS': 1761160127622839, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-094261890', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}, {'MessageTS': 1761160127623215, 'Messagetype': 'ContrailConfigTrace', 'ModuleId': 'contrail-api', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189display_name"ctest-vn22-09426189"fq_name["default-domain", "ctest-AnalyticsBasicTestSanity-47623403", "ctest-vn22-09426189"]id_perms{"permissions": {"owner": "ctest-AnalyticsBasicTestSanity-47623403", "owner_access": 7, "group": "reader", "group_access": 7, "other_access": 7}, "uuid": {"uuid_mslong": 2049345273983420013, "uuid_lslong": 11004391980424994997}, "enable": true, "created": "2025-10-22T19:08:47.420905", "last_modified": "2025-10-22T19:08:47.613763", "description": "", "user_visible": true, "creator": null}is_sharedfalsemtu0network_ipam_refs[{"to": ["default-domain", "default-project", "default-network-ipam"], "attr": {"ipam_subnets": [{"subnet": {"ip_prefix": "58.247.52.192", "ip_prefix_len": 26}, "default_gateway": "58.247.52.193", "dns_server_address": "58.247.52.194", "subnet_uuid": "71ae249b-375b-4751-8911-641ee7046d35", "enable_dhcp": true, "dns_nameservers": [], "allocation_pools": [], "addr_from_start": true, "dhcp_option_list": null, "host_routes": null, "subnet_name": "", "alloc_unit": 1, "created": "2025-10-22T19:08:47.599937", "last_modified": "2025-10-22T19:08:47.599937", "subscriber_tag": null, "vlan_tag": null, "dhcp_relay_server": []}], "host_routes": null}, "uuid": "8214b017-3821-4972-901b-61cad1dd912c"}]parent_type"project"parent_uuid"42039591-f5b6-4a7f-844f-55106f67b773"perms2{"owner": "42039591f5b64a7f844f55106f67b773", "owner_access": 7, "global_access": 0, "share": []}port_security_enabledtruerouter_externalfalseuuid"1c70bcab-35e8-466d-98b7-7433d263a0b5"virtual_network_network_id5false', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}, {'MessageTS': 1761160133328118, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-094261890', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}, {'MessageTS': 1761160133328422, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-094261890', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}, {'MessageTS': 1761160133344852, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-094261890', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}, {'MessageTS': 1761160133345146, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-094261890', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}, {'MessageTS': 1761160133400550, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-094261890', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}, {'MessageTS': 1761160133400892, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-094261890', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}, {'MessageTS': 1761160133886499, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-094261890', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}, {'MessageTS': 1761160133886818, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-094261890', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}] 2025-10-22 19:09:03,410 - DEBUG - Verifying ObjectVMTable for vm 39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1 on analytics node 10.0.0.249 2025-10-22 19:09:03,410 - DEBUG - Posting: http://10.0.0.249:8081/analytics/query, payload {'table': 'ObjectVMTable', 'start_time': 1761160126655687, 'end_time': 1761160143410148, 'select_fields': ['ObjectId', 'Source', 'ObjectLog', 'SystemLog', 'ModuleId', 'Messagetype', 'MessageTS'], 'where': [[{'name': 'ObjectId', 'value': '39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1', 'op': 1, 'value2': None}]]} 2025-10-22 19:09:04,437 - DEBUG - Query output : [{'MessageTS': 1761160133245779, 'Messagetype': 'ContrailConfigTrace', 'ModuleId': 'contrail-api', 'ObjectId': '39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1', 'ObjectLog': '39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1display_name"39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1"fq_name["39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1"]id_perms{"permissions": {"owner": "cloud-admin", "owner_access": 7, "group": "cloud-admin-group", "group_access": 7, "other_access": 7}, "uuid": {"uuid_mslong": 4179264168482916066, "uuid_lslong": 11870671555189972209}, "enable": true, "created": "2025-10-22T19:08:53.237353", "last_modified": "2025-10-22T19:08:53.237353", "description": null, "user_visible": true, "creator": null}perms2{"owner": "42039591-f5b6-4a7f-844f-55106f67b773", "owner_access": 7, "global_access": 0, "share": []}server_type"virtual-server"uuid"39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1"false', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}, {'MessageTS': 1761160136632140, 'Messagetype': 'VmObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': '39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1', 'ObjectLog': 'Addition 39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf10controller/src/vnsw/agent/oper/vm.cc141', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1', 'SystemLog': None}, {'MessageTS': 1761160136643861, 'Messagetype': 'VmObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': '39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1', 'ObjectLog': 'Modification 39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf11controller/src/vnsw/agent/oper/vm.cc141', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1', 'SystemLog': None}] 2025-10-22 19:09:04,437 - DEBUG - Verifying ObjectRoutingInstance for RI default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-09426189 on analytics node 10.0.0.249 2025-10-22 19:09:04,437 - DEBUG - Posting: http://10.0.0.249:8081/analytics/query, payload {'table': 'ObjectRoutingInstance', 'start_time': 1761160126655687, 'end_time': 1761160144437322, 'select_fields': ['ObjectId', 'Source', 'ObjectLog', 'SystemLog', 'ModuleId', 'Messagetype', 'MessageTS'], 'where': [[{'name': 'ObjectId', 'value': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-09426189', 'op': 1, 'value2': None}]]} 2025-10-22 19:09:05,456 - DEBUG - Query output : [{'MessageTS': 1761160136670613, 'Messagetype': 'VrfObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-09426189', 'ObjectLog': 'Addition default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-094261892controller/src/vnsw/agent/oper/vrf.cc414', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1', 'SystemLog': None}] 2025-10-22 19:09:05,456 - DEBUG - Verifying ObjectVMTable for vm 39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1 on analytics node 10.0.0.249 2025-10-22 19:09:05,456 - DEBUG - Posting: http://10.0.0.249:8081/analytics/query, payload {'table': 'ObjectVMTable', 'start_time': 1761160126655687, 'end_time': 1761160145456317, 'select_fields': ['ObjectId', 'Source', 'ObjectLog', 'SystemLog', 'ModuleId', 'Messagetype', 'MessageTS'], 'where': [[{'name': 'ObjectId', 'value': '39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1', 'op': 1, 'value2': None}]]} 2025-10-22 19:09:06,478 - DEBUG - Query output : [{'MessageTS': 1761160136632140, 'Messagetype': 'VmObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': '39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1', 'ObjectLog': 'Addition 39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf10controller/src/vnsw/agent/oper/vm.cc141', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1', 'SystemLog': None}, {'MessageTS': 1761160136643861, 'Messagetype': 'VmObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': '39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1', 'ObjectLog': 'Modification 39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf11controller/src/vnsw/agent/oper/vm.cc141', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1', 'SystemLog': None}, {'MessageTS': 1761160133245779, 'Messagetype': 'ContrailConfigTrace', 'ModuleId': 'contrail-api', 'ObjectId': '39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1', 'ObjectLog': '39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1display_name"39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1"fq_name["39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1"]id_perms{"permissions": {"owner": "cloud-admin", "owner_access": 7, "group": "cloud-admin-group", "group_access": 7, "other_access": 7}, "uuid": {"uuid_mslong": 4179264168482916066, "uuid_lslong": 11870671555189972209}, "enable": true, "created": "2025-10-22T19:08:53.237353", "last_modified": "2025-10-22T19:08:53.237353", "description": null, "user_visible": true, "creator": null}perms2{"owner": "42039591-f5b6-4a7f-844f-55106f67b773", "owner_access": 7, "global_access": 0, "share": []}server_type"virtual-server"uuid"39ffba9e-58f1-46e2-a4bd-18e2cc6e9cf1"false', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1.', 'SystemLog': None}] 2025-10-22 19:09:06,478 - DEBUG - Verifying ObjectRoutingInstance for RI default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-09426189 on analytics node 10.0.0.249 2025-10-22 19:09:06,478 - DEBUG - Posting: http://10.0.0.249:8081/analytics/query, payload {'table': 'ObjectRoutingInstance', 'start_time': 1761160126655687, 'end_time': 1761160146478362, 'select_fields': ['ObjectId', 'Source', 'ObjectLog', 'SystemLog', 'ModuleId', 'Messagetype', 'MessageTS'], 'where': [[{'name': 'ObjectId', 'value': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-09426189', 'op': 1, 'value2': None}]]} 2025-10-22 19:09:07,498 - DEBUG - Query output : [{'MessageTS': 1761160136670613, 'Messagetype': 'VrfObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-09426189', 'ObjectLog': 'Addition default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-094261892controller/src/vnsw/agent/oper/vrf.cc414', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4436-1', 'SystemLog': None}] 2025-10-22 19:09:07,499 - INFO - Validated ObjectVNTable, ObjectRoutingInstance, ObjectVMTable logs 2025-10-22 19:09:07,499 - INFO - Deleting VM ctest-AnalyticsBasicTestSanity-47623403-96112597 2025-10-22 19:09:07,643 - INFO - Deleting VN ctest-vn22-09426189 2025-10-22 19:09:07,683 - DEBUG - VN 1c70bcab-35e8-466d-98b7-7433d263a0b5 still in use: Unable to complete operation on network 1c70bcab-35e8-466d-98b7-7433d263a0b5. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-c9b63c94-d749-4bcd-bc85-90f38890e4fd'] 2025-10-22 19:09:07,683 - WARNING - Deleting VN ctest-vn22-09426189 failed..Will retry 2025-10-22 19:09:09,805 - DEBUG - Response for deleting network () 2025-10-22 19:09:09,805 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b089dce9-161e-42b4-8b98-22ca36d01e42 2025-10-22 19:09:09,813 - DEBUG - Response Code: 404 2025-10-22 19:09:09,813 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-10-22 19:09:09,819 - DEBUG - Requesting: http://10.0.0.249:8082/domain/4fa4561c-cadb-41af-a3b5-05e18d999394 2025-10-22 19:09:09,873 - DEBUG - Requesting: http://10.0.0.249:8082/project/42039591-f5b6-4a7f-844f-55106f67b773 2025-10-22 19:09:09,952 - INFO - Validated that VN ctest-vn22-09426189 is not found in API Server 2025-10-22 19:09:09,965 - DEBUG - VN ctest-vn22-09426189 is not present in Agent 10.0.0.249 2025-10-22 19:09:09,965 - INFO - Validated that VN ctest-vn22-09426189 is not in any agent 2025-10-22 19:09:09,971 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189:ctest-vn22-09426189 2025-10-22 19:09:09,976 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-AnalyticsBasicTestSanity-47623403:ctest-vn22-09426189 2025-10-22 19:09:09,982 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn22-09426189 info 2025-10-22 19:09:10,111 - DEBUG - No XMPP flaps were noticed during the test
2025-10-22 19:09:10,111 - INFO - END TEST : test_verify_object_logs : PASSED[0:00:24]
2025-10-22 19:09:10,111 - INFO - -------------------------------------------------------------------------------- 2025-10-22 19:09:10,817 - INFO - Deleted project: ctest-AnalyticsBasicTestSanity-47623403, ID : 42039591-f5b6-4a7f-844f-55106f67b773 2025-10-22 19:09:20,379 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-FloatingipBasicTestSanity-66479375:ctest-fvn-66888569 2025-10-22 19:09:20,384 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-FloatingipBasicTestSanity-66479375:ctest-fvn-66888569:ctest-fvn-66888569 2025-10-22 19:09:21,692 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-FloatingipBasicTestSanity-66479375:ctest-vn1-03924113 2025-10-22 19:09:21,699 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-FloatingipBasicTestSanity-66479375:ctest-vn1-03924113:ctest-vn1-03924113 2025-10-22 19:09:25,109 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:ctest-FloatingipBasicTestSanity-66479375:ctest-fvn-66888569:ctest-some-pool-98993224 2025-10-22 19:09:42,196 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRtGroupReq?x=target:64512:8000004 2025-10-22 19:09:45,422 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:ctest-FloatingipBasicTestSanity-66479375:ctest-fvn-66888569:ctest-some-pool-98993224 2025-10-22 19:09:47,878 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-FloatingipBasicTestSanity-66479375:ctest-vn1-03924113:ctest-vn1-03924113 2025-10-22 19:09:47,883 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-FloatingipBasicTestSanity-66479375:ctest-vn1-03924113 2025-10-22 19:09:48,166 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-FloatingipBasicTestSanity-66479375:ctest-fvn-66888569:ctest-fvn-66888569 2025-10-22 19:09:48,170 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-FloatingipBasicTestSanity-66479375:ctest-fvn-66888569 2025-10-22 19:11:50,352 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-38092032:ctest-vn-74247887 2025-10-22 19:11:50,357 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-38092032:ctest-vn-74247887:ctest-vn-74247887 2025-10-22 19:11:51,015 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-38092032:ctest-vn-36187087 2025-10-22 19:11:51,021 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-38092032:ctest-vn-36187087:ctest-vn-36187087 2025-10-22 19:11:51,732 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-38092032:ctest-vn-36187087:ctest-vn-36187087 2025-10-22 19:11:51,738 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-38092032:ctest-vn-36187087 2025-10-22 19:11:52,021 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-38092032:ctest-vn-74247887:ctest-vn-74247887 2025-10-22 19:11:52,026 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-38092032:ctest-vn-74247887 2025-10-22 19:11:58,010 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyNegativeIpv4v6-12678409:ctest-vn4-37777153 2025-10-22 19:11:58,015 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-12678409:ctest-vn4-37777153:ctest-vn4-37777153 2025-10-22 19:11:58,893 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-12678409:ctest-vn4-37777153:ctest-vn4-37777153 2025-10-22 19:11:58,898 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyNegativeIpv4v6-12678409:ctest-vn4-37777153 2025-10-22 19:12:05,711 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicy-48884225:ctest-vn-81680480 2025-10-22 19:12:05,717 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicy-48884225:ctest-vn-81680480:ctest-vn-81680480 2025-10-22 19:12:06,424 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicy-48884225:ctest-vn-99125641 2025-10-22 19:12:06,433 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicy-48884225:ctest-vn-99125641:ctest-vn-99125641 2025-10-22 19:12:31,896 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicy-48884225:ctest-vn-99125641:ctest-vn-99125641 2025-10-22 19:12:31,901 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicy-48884225:ctest-vn-99125641 2025-10-22 19:12:32,155 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicy-48884225:ctest-vn-81680480:ctest-vn-81680480 2025-10-22 19:12:32,159 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicy-48884225:ctest-vn-81680480 2025-10-22 19:13:04,767 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-63897309:ctest-mgmt_vn-60000330 2025-10-22 19:13:04,772 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-63897309:ctest-mgmt_vn-60000330:ctest-mgmt_vn-60000330 2025-10-22 19:13:05,998 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-63897309:ctest-left_vn-83380681 2025-10-22 19:13:06,003 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-63897309:ctest-left_vn-83380681:ctest-left_vn-83380681 2025-10-22 19:13:06,874 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-63897309:ctest-right_vn-97205594 2025-10-22 19:13:06,880 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-63897309:ctest-right_vn-97205594:ctest-right_vn-97205594 2025-10-22 19:14:08,841 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-63897309:ctest-right_vn-97205594:ctest-right_vn-97205594 2025-10-22 19:14:08,846 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-63897309:ctest-right_vn-97205594 2025-10-22 19:14:09,110 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-63897309:ctest-left_vn-83380681:ctest-left_vn-83380681 2025-10-22 19:14:09,114 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-63897309:ctest-left_vn-83380681 2025-10-22 19:14:09,369 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-63897309:ctest-mgmt_vn-60000330:ctest-mgmt_vn-60000330 2025-10-22 19:14:09,374 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-63897309:ctest-mgmt_vn-60000330 2025-10-22 19:14:13,972 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-DNS&search_string=virtual-DNS:default-domain:ctest-vdns1-86544040 2025-10-22 19:14:56,075 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-DNS-record&search_string=virtual-DNS-record:default-domain:ctest-vdns1-86544040:test-rec 2025-10-22 19:15:04,057 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-DNS&search_string=virtual-DNS:default-domain:ctest-vdns1-86544040 2025-10-22 19:16:13,092 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=network-ipam&search_string=network-ipam:default-domain:ctest-TestBasicVMVN-52653078:ctest-ipam-96808385 2025-10-22 19:16:13,327 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicVMVN-52653078:ctest-vn-56143385 2025-10-22 19:16:13,334 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicVMVN-52653078:ctest-vn-56143385:ctest-vn-56143385 2025-10-22 19:16:46,304 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicVMVN-52653078:ctest-vn-56143385:ctest-vn-56143385 2025-10-22 19:16:46,309 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicVMVN-52653078:ctest-vn-56143385 2025-10-22 19:16:46,395 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicVMVN-52653078:ctest-ipam-96808385:ctest-ipam-96808385 2025-10-22 19:16:46,400 - DEBUG - Requesting: http://10.0.0.249:8083/Snh_IFMapTableShowReq?table_name=network-ipam&search_string=network-ipam:default-domain:ctest-TestBasicVMVN-52653078:ctest-ipam-96808385