2025-10-24 01:48:51,297 - INFO - Domain Default found not creating
2025-10-24 01:48:51,434 - INFO - Project ctest-AnalyticsBasicTestSanity-12112579 not found, creating it
2025-10-24 01:48:51,867 - INFO - Created Project:ctest-AnalyticsBasicTestSanity-12112579, ID : a56d0ede-e1ed-45d9-8b01-8ec4b0bf2339 
2025-10-24 01:48:53,155 - INFO - ================================================================================
2025-10-24 01:48:53,155 - INFO - STARTING TEST    : test_verify_object_logs
2025-10-24 01:48:53,155 - 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-24 01:48:53,284 - DEBUG - Nothing to compare xmpp stats {'10.0.0.254': {'10.20.0.17': '0'}} with
2025-10-24 01:48:53,284 - INFO - Initial checks done. Running the testcase now
2025-10-24 01:48:53,284 - INFO - 
2025-10-24 01:48:54,031 - DEBUG - Response for create_network : {'network': {'id': 'd26d2616-f2c9-43d2-8fd7-4811dbf9eb39', 'name': 'ctest-vn22-85084867', 'tenant_id': 'a56d0edee1ed45d98b018ec4b0bf2339', 'project_id': 'a56d0edee1ed45d98b018ec4b0bf2339', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsBasicTestSanity-12112579', 'ctest-vn22-85084867'], 'port_security_enabled': True, 'description': ''}}
2025-10-24 01:48:54,216 - DEBUG - Response for create_subnet : {'subnet': {'id': '1e42b686-82d0-477d-84d0-66e79d86c2be', 'name': '', 'tenant_id': 'a56d0edee1ed45d98b018ec4b0bf2339', 'network_id': 'd26d2616-f2c9-43d2-8fd7-4811dbf9eb39', 'ip_version': 4, 'cidr': '41.140.87.64/26', 'allocation_pools': [{'start': '41.140.87.66', 'end': '41.140.87.126'}], 'gateway_ip': '41.140.87.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '41.140.87.66', 'tags': [], 'project_id': 'a56d0edee1ed45d98b018ec4b0bf2339'}}
2025-10-24 01:48:54,235 - INFO - Created VN ctest-vn22-85084867
2025-10-24 01:48:54,287 - DEBUG - VN ctest-vn22-85084867 UUID is d26d2616-f2c9-43d2-8fd7-4811dbf9eb39
2025-10-24 01:48:54,392 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-24 01:48:54,681 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-24 01:48:54,707 - DEBUG - Requesting: http://10.0.0.254:8082/domain/4e3805b8-bd72-454f-acd6-c619155d7fc7
2025-10-24 01:48:54,772 - DEBUG - Requesting: http://10.0.0.254:8082/project/a56d0ede-e1ed-45d9-8b01-8ec4b0bf2339
2025-10-24 01:48:54,841 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/d26d2616-f2c9-43d2-8fd7-4811dbf9eb39
2025-10-24 01:48:54,850 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/d26d2616-f2c9-43d2-8fd7-4811dbf9eb39
2025-10-24 01:48:54,859 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/1476d6d8-a85e-42df-8b22-bb1d3bc8c340
2025-10-24 01:48:54,866 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/1476d6d8-a85e-42df-8b22-bb1d3bc8c340
2025-10-24 01:48:54,872 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/27ef597d-56b1-4081-ab5c-9a383023a1eb
2025-10-24 01:48:54,878 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-24 01:48:54,878 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/d26d2616-f2c9-43d2-8fd7-4811dbf9eb39
2025-10-24 01:48:54,886 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/1476d6d8-a85e-42df-8b22-bb1d3bc8c340
2025-10-24 01:48:54,898 - INFO - Verified VN network id 5 for VN d26d2616-f2c9-43d2-8fd7-4811dbf9eb39
2025-10-24 01:48:54,898 - INFO - Verifications in API Server for VN ctest-vn22-85084867 passed
2025-10-24 01:48:54,898 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/d26d2616-f2c9-43d2-8fd7-4811dbf9eb39
2025-10-24 01:48:54,906 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/1476d6d8-a85e-42df-8b22-bb1d3bc8c340
2025-10-24 01:48:54,913 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/1476d6d8-a85e-42df-8b22-bb1d3bc8c340
2025-10-24 01:48:54,919 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/27ef597d-56b1-4081-ab5c-9a383023a1eb
2025-10-24 01:48:54,925 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867
2025-10-24 01:48:54,929 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsBasicTestSanity-12112579', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15162817400430740434', 'uuid-lslong': '10364832308958718777'}, 'enable': 'true', 'created': '2025-10-24T01:48:53', 'last-modified': '2025-10-24T01:48:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.757785'}
2025-10-24 01:48:54,929 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867
2025-10-24 01:48:54,935 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-24 01:48:54,935 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn22-85084867 passed
2025-10-24 01:48:54,935 - DEBUG - ====Verifying policy data for ctest-vn22-85084867 in API_Server ======
2025-10-24 01:48:54,935 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-24 01:48:54,940 - DEBUG - Requesting: http://10.0.0.254:8082/domain/4e3805b8-bd72-454f-acd6-c619155d7fc7
2025-10-24 01:48:54,950 - DEBUG - Requesting: http://10.0.0.254:8082/project/a56d0ede-e1ed-45d9-8b01-8ec4b0bf2339
2025-10-24 01:48:55,018 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/d26d2616-f2c9-43d2-8fd7-4811dbf9eb39
2025-10-24 01:48:55,040 - DEBUG - =>VN ctest-vn22-85084867 has no policy to be verified
2025-10-24 01:48:55,040 - DEBUG - Verifying the vn in opserver
2025-10-24 01:48:55,040 - DEBUG - Verifying the default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867 virtual network link  through opserver 10.0.0.254
2025-10-24 01:48:55,040 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-10-24 01:48:55,328 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-10-24 01:48:55,383 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867?flat'}
2025-10-24 01:48:55,383 - INFO - Validated that VN default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867 is found in opserver
2025-10-24 01:48:55,394 - DEBUG - Do not have enough data to verify VN in agent
2025-10-24 01:48:55,400 - DEBUG - VRF ids for VN ctest-vn22-85084867: {}
2025-10-24 01:48:55,498 - DEBUG - Services list from nova: [, , ]
2025-10-24 01:48:55,587 - DEBUG - Image by name cirros not found
2025-10-24 01:48:55,587 - DEBUG - Installing image cirros
2025-10-24 01:48:55,587 - 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-24 01:48:55,588 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/converts//cirros-0.3.0-x86_64-disk.vmdk.gz
2025-10-24 01:48:55,588 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/converts//cirros-0.3.0-x86_64-disk.vmdk.gz
2025-10-24 01:48:55,600 - 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-24 01:48:55,688 - DEBUG - Image has been downloaded to /contrail-test/images/cirros-0.3.0-x86_64-disk.vmdk.gz
2025-10-24 01:48:55,689 - DEBUG - Unzip image
2025-10-24 01:48:55,689 - 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-24 01:48:55,843 - DEBUG - Try to create image in user context
2025-10-24 01:48:56,028 - DEBUG - Image has been created in user context
2025-10-24 01:48:56,028 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: rm -f /contrail-test/images/cirros-0.3.0-x86_64-disk.vmdk
2025-10-24 01:48:56,040 - DEBUG - Downloaded image has been removed
2025-10-24 01:48:56,058 - DEBUG - Uploaded image status = active
2025-10-24 01:48:58,391 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4472-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4472-1)
2025-10-24 01:48:58,422 - DEBUG - VM  is still in BUILD state, Expected: ACTIVE
2025-10-24 01:49:03,523 - DEBUG - VM  is in ACTIVE state now
2025-10-24 01:49:03,523 - DEBUG - Verifying ObjectVNTable for vn default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867 on analytics node 10.0.0.254
2025-10-24 01:49:03,526 - DEBUG - Posting: http://10.0.0.254:8081/analytics/query, payload {'table': 'ObjectVNTable', 'start_time': 1761270533285013, 'end_time': 1761270543526157, 'select_fields': ['ObjectId', 'Source', 'ObjectLog', 'SystemLog', 'Messagetype', 'ModuleId', 'MessageTS'], 'where': [[{'name': 'ObjectId', 'value': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'op': 1, 'value2': None}]]}
2025-10-24 01:49:04,551 - DEBUG - Query output : [{'MessageTS': 1761270542552461, 'Messagetype': 'VnObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'Addition d26d2616-f2c9-43d2-8fd7-4811dbf9eb39default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-8508486700000000-0000-0000-0000-00000000000041.140.87.642641.140.87.65default-domain:default-project:default-network-ipamtrue41.140.87.66true
truetruetruefalse0controller/src/vnsw/agent/oper/vn.cc1408', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1', 'SystemLog': None}, {'MessageTS': 1761270542557887, 'Messagetype': 'VnObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'Modification d26d2616-f2c9-43d2-8fd7-4811dbf9eb39default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-8508486700000000-0000-0000-0000-000000000000default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-8508486741.140.87.642641.140.87.65default-domain:default-project:default-network-ipamtrue41.140.87.66true
truetruetruefalse5controller/src/vnsw/agent/oper/vn.cc1408', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1', 'SystemLog': None}, {'MessageTS': 1761270533967262, 'Messagetype': 'ContrailConfigTrace', 'ModuleId': 'contrail-api', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867false', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}, {'MessageTS': 1761270533976736, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}, {'MessageTS': 1761270533977144, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}, {'MessageTS': 1761270534006189, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867target:10.20.0.17:6target:64512:7999999
cn-jenkins-deploy-platform-ansible-os-4472-1controller/src/bgp/routing-instance/routing_instance.cc1239', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1', 'SystemLog': None}, {'MessageTS': 1761270534006210, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867Addinetcn-jenkins-deploy-platform-ansible-os-4472-1controller/src/bgp/routing-instance/routing_instance.cc1720', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1', 'SystemLog': None}, {'MessageTS': 1761270534006341, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867Addinet6cn-jenkins-deploy-platform-ansible-os-4472-1controller/src/bgp/routing-instance/routing_instance.cc1720', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1', 'SystemLog': None}, {'MessageTS': 1761270534006411, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867Adderm-vpncn-jenkins-deploy-platform-ansible-os-4472-1controller/src/bgp/routing-instance/routing_instance.cc1720', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1', 'SystemLog': None}, {'MessageTS': 1761270534006505, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867Adde-vpncn-jenkins-deploy-platform-ansible-os-4472-1controller/src/bgp/routing-instance/routing_instance.cc1720', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1', 'SystemLog': None}, {'MessageTS': 1761270534006560, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867Addinet-mvpncn-jenkins-deploy-platform-ansible-os-4472-1controller/src/bgp/routing-instance/routing_instance.cc1720', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1', 'SystemLog': None}, {'MessageTS': 1761270534048610, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-8508486710.20.0.17:6target:64512:8000004
target:64512:8000004
cn-jenkins-deploy-platform-ansible-os-4472-1controller/src/bgp/routing-instance/routing_instance.cc1392', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1', 'SystemLog': None}, {'MessageTS': 1761270534087602, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867
default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}, {'MessageTS': 1761270534088052, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867
default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}, {'MessageTS': 1761270534171968, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867
default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}, {'MessageTS': 1761270534172102, 'Messagetype': 'ContrailConfigTrace', 'ModuleId': 'contrail-api', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867false', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}, {'MessageTS': 1761270534172317, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867
default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}, {'MessageTS': 1761270538136552, 'Messagetype': 'RoutingInstanceStats', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1', 'SystemLog': None}, {'MessageTS': 1761270539360100, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867
default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}, {'MessageTS': 1761270539360320, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867
default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}, {'MessageTS': 1761270539376289, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867
default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}, {'MessageTS': 1761270539376509, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867
default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}, {'MessageTS': 1761270539422072, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867
default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}, {'MessageTS': 1761270539422368, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867
default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}, {'MessageTS': 1761270539884098, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867
default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}, {'MessageTS': 1761270539884304, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867
default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}]
2025-10-24 01:49:04,552 - DEBUG - Verifying ObjectVMTable for vm 89b8e461-1087-471e-b51b-cdc58115410a on analytics node 10.0.0.254
2025-10-24 01:49:04,552 - DEBUG - Posting: http://10.0.0.254:8081/analytics/query, payload {'table': 'ObjectVMTable', 'start_time': 1761270533285013, 'end_time': 1761270544552104, 'select_fields': ['ObjectId', 'Source', 'ObjectLog', 'SystemLog', 'ModuleId', 'Messagetype', 'MessageTS'], 'where': [[{'name': 'ObjectId', 'value': '89b8e461-1087-471e-b51b-cdc58115410a', 'op': 1, 'value2': None}]]}
2025-10-24 01:49:05,574 - DEBUG - Query output : [{'MessageTS': 1761270539278268, 'Messagetype': 'ContrailConfigTrace', 'ModuleId': 'contrail-api', 'ObjectId': '89b8e461-1087-471e-b51b-cdc58115410a', 'ObjectLog': '89b8e461-1087-471e-b51b-cdc58115410afalse', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}, {'MessageTS': 1761270542512898, 'Messagetype': 'VmObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': '89b8e461-1087-471e-b51b-cdc58115410a', 'ObjectLog': 'Addition 89b8e461-1087-471e-b51b-cdc58115410a0controller/src/vnsw/agent/oper/vm.cc141', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1', 'SystemLog': None}, {'MessageTS': 1761270542524656, 'Messagetype': 'VmObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': '89b8e461-1087-471e-b51b-cdc58115410a', 'ObjectLog': 'Modification 89b8e461-1087-471e-b51b-cdc58115410a1controller/src/vnsw/agent/oper/vm.cc141', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1', 'SystemLog': None}]
2025-10-24 01:49:05,574 - DEBUG - Verifying ObjectRoutingInstance for RI default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867 on analytics node 10.0.0.254
2025-10-24 01:49:05,574 - DEBUG - Posting: http://10.0.0.254:8081/analytics/query, payload {'table': 'ObjectRoutingInstance', 'start_time': 1761270533285013, 'end_time': 1761270545574441, 'select_fields': ['ObjectId', 'Source', 'ObjectLog', 'SystemLog', 'ModuleId', 'Messagetype', 'MessageTS'], 'where': [[{'name': 'ObjectId', 'value': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867', 'op': 1, 'value2': None}]]}
2025-10-24 01:49:06,591 - DEBUG - Query output : [{'MessageTS': 1761270542552541, 'Messagetype': 'VrfObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867', 'ObjectLog': 'Addition default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-850848672controller/src/vnsw/agent/oper/vrf.cc414', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1', 'SystemLog': None}]
2025-10-24 01:49:06,591 - DEBUG - Verifying ObjectVMTable for vm 89b8e461-1087-471e-b51b-cdc58115410a on analytics node 10.0.0.254
2025-10-24 01:49:06,591 - DEBUG - Posting: http://10.0.0.254:8081/analytics/query, payload {'table': 'ObjectVMTable', 'start_time': 1761270533285013, 'end_time': 1761270546591475, 'select_fields': ['ObjectId', 'Source', 'ObjectLog', 'SystemLog', 'ModuleId', 'Messagetype', 'MessageTS'], 'where': [[{'name': 'ObjectId', 'value': '89b8e461-1087-471e-b51b-cdc58115410a', 'op': 1, 'value2': None}]]}
2025-10-24 01:49:07,608 - DEBUG - Query output : [{'MessageTS': 1761270539278268, 'Messagetype': 'ContrailConfigTrace', 'ModuleId': 'contrail-api', 'ObjectId': '89b8e461-1087-471e-b51b-cdc58115410a', 'ObjectLog': '89b8e461-1087-471e-b51b-cdc58115410afalse', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1.', 'SystemLog': None}, {'MessageTS': 1761270542512898, 'Messagetype': 'VmObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': '89b8e461-1087-471e-b51b-cdc58115410a', 'ObjectLog': 'Addition 89b8e461-1087-471e-b51b-cdc58115410a0controller/src/vnsw/agent/oper/vm.cc141', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1', 'SystemLog': None}, {'MessageTS': 1761270542524656, 'Messagetype': 'VmObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': '89b8e461-1087-471e-b51b-cdc58115410a', 'ObjectLog': 'Modification 89b8e461-1087-471e-b51b-cdc58115410a1controller/src/vnsw/agent/oper/vm.cc141', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1', 'SystemLog': None}]
2025-10-24 01:49:07,609 - DEBUG - Verifying ObjectRoutingInstance for RI default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867 on analytics node 10.0.0.254
2025-10-24 01:49:07,609 - DEBUG - Posting: http://10.0.0.254:8081/analytics/query, payload {'table': 'ObjectRoutingInstance', 'start_time': 1761270533285013, 'end_time': 1761270547609088, 'select_fields': ['ObjectId', 'Source', 'ObjectLog', 'SystemLog', 'ModuleId', 'Messagetype', 'MessageTS'], 'where': [[{'name': 'ObjectId', 'value': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867', 'op': 1, 'value2': None}]]}
2025-10-24 01:49:08,625 - DEBUG - Query output : [{'MessageTS': 1761270542552541, 'Messagetype': 'VrfObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867', 'ObjectLog': 'Addition default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-850848672controller/src/vnsw/agent/oper/vrf.cc414', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4472-1', 'SystemLog': None}]
2025-10-24 01:49:08,625 - INFO - Validated ObjectVNTable, ObjectRoutingInstance, ObjectVMTable logs
2025-10-24 01:49:08,625 - INFO - Deleting VM ctest-AnalyticsBasicTestSanity-12112579-73425120
2025-10-24 01:49:08,740 - INFO - Deleting VN ctest-vn22-85084867 
2025-10-24 01:49:08,772 - DEBUG - VN d26d2616-f2c9-43d2-8fd7-4811dbf9eb39 still in use: Unable to complete operation on network d26d2616-f2c9-43d2-8fd7-4811dbf9eb39. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-90e75ebd-bbbc-4314-b3b1-91e7234ae303']
2025-10-24 01:49:08,772 - WARNING - Deleting VN ctest-vn22-85084867 failed..Will retry
2025-10-24 01:49:10,888 - DEBUG - Response for deleting network ()
2025-10-24 01:49:10,888 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/1476d6d8-a85e-42df-8b22-bb1d3bc8c340
2025-10-24 01:49:10,893 - DEBUG - Response Code: 404
2025-10-24 01:49:10,893 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-24 01:49:10,899 - DEBUG - Requesting: http://10.0.0.254:8082/domain/4e3805b8-bd72-454f-acd6-c619155d7fc7
2025-10-24 01:49:10,952 - DEBUG - Requesting: http://10.0.0.254:8082/project/a56d0ede-e1ed-45d9-8b01-8ec4b0bf2339
2025-10-24 01:49:11,020 - INFO - Validated that VN ctest-vn22-85084867 is not found in API Server
2025-10-24 01:49:11,031 - DEBUG - VN ctest-vn22-85084867 is not present in Agent 10.0.0.254 
2025-10-24 01:49:11,031 - INFO - Validated that VN ctest-vn22-85084867 is not in any agent
2025-10-24 01:49:11,035 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867:ctest-vn22-85084867
2025-10-24 01:49:11,039 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-AnalyticsBasicTestSanity-12112579:ctest-vn22-85084867
2025-10-24 01:49:11,043 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn22-85084867 info
2025-10-24 01:49:11,170 - DEBUG - No XMPP flaps were noticed during the test
2025-10-24 01:49:11,170 - INFO - END TEST : test_verify_object_logs : PASSED[0:00:18]
2025-10-24 01:49:11,170 - INFO - --------------------------------------------------------------------------------
2025-10-24 01:49:11,829 - INFO - Deleted project: ctest-AnalyticsBasicTestSanity-12112579, ID : a56d0ede-e1ed-45d9-8b01-8ec4b0bf2339 
2025-10-24 01:49:20,465 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-FloatingipBasicTestSanity-14256058:ctest-fvn-07496395
2025-10-24 01:49:20,469 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-FloatingipBasicTestSanity-14256058:ctest-fvn-07496395:ctest-fvn-07496395
2025-10-24 01:49:21,621 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-FloatingipBasicTestSanity-14256058:ctest-vn1-73154253
2025-10-24 01:49:21,626 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-FloatingipBasicTestSanity-14256058:ctest-vn1-73154253:ctest-vn1-73154253
2025-10-24 01:49:24,679 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:ctest-FloatingipBasicTestSanity-14256058:ctest-fvn-07496395:ctest-some-pool-30325174
2025-10-24 01:49:41,519 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRtGroupReq?x=target:64512:8000004
2025-10-24 01:49:44,354 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:ctest-FloatingipBasicTestSanity-14256058:ctest-fvn-07496395:ctest-some-pool-30325174
2025-10-24 01:49:46,738 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-FloatingipBasicTestSanity-14256058:ctest-vn1-73154253:ctest-vn1-73154253
2025-10-24 01:49:46,742 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-FloatingipBasicTestSanity-14256058:ctest-vn1-73154253
2025-10-24 01:49:47,007 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-FloatingipBasicTestSanity-14256058:ctest-fvn-07496395:ctest-fvn-07496395
2025-10-24 01:49:47,011 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-FloatingipBasicTestSanity-14256058:ctest-fvn-07496395
2025-10-24 01:51:36,105 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-48735512:ctest-vn-09695969
2025-10-24 01:51:36,110 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-48735512:ctest-vn-09695969:ctest-vn-09695969
2025-10-24 01:51:36,702 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-48735512:ctest-vn-12272824
2025-10-24 01:51:36,707 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-48735512:ctest-vn-12272824:ctest-vn-12272824
2025-10-24 01:51:37,297 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-48735512:ctest-vn-12272824:ctest-vn-12272824
2025-10-24 01:51:37,301 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-48735512:ctest-vn-12272824
2025-10-24 01:51:37,533 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-48735512:ctest-vn-09695969:ctest-vn-09695969
2025-10-24 01:51:37,536 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-48735512:ctest-vn-09695969
2025-10-24 01:51:42,957 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyNegativeIpv4v6-09204510:ctest-vn4-90569740
2025-10-24 01:51:42,962 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-09204510:ctest-vn4-90569740:ctest-vn4-90569740
2025-10-24 01:51:43,771 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-09204510:ctest-vn4-90569740:ctest-vn4-90569740
2025-10-24 01:51:43,775 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyNegativeIpv4v6-09204510:ctest-vn4-90569740
2025-10-24 01:51:50,226 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicy-80318307:ctest-vn-74166509
2025-10-24 01:51:50,231 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicy-80318307:ctest-vn-74166509:ctest-vn-74166509
2025-10-24 01:51:50,843 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicy-80318307:ctest-vn-77732775
2025-10-24 01:51:50,847 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicy-80318307:ctest-vn-77732775:ctest-vn-77732775
2025-10-24 01:52:15,490 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicy-80318307:ctest-vn-77732775:ctest-vn-77732775
2025-10-24 01:52:15,494 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicy-80318307:ctest-vn-77732775
2025-10-24 01:52:15,732 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicy-80318307:ctest-vn-74166509:ctest-vn-74166509
2025-10-24 01:52:15,738 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicy-80318307:ctest-vn-74166509
2025-10-24 01:52:47,556 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-60488729:ctest-mgmt_vn-46487624
2025-10-24 01:52:47,561 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-60488729:ctest-mgmt_vn-46487624:ctest-mgmt_vn-46487624
2025-10-24 01:52:48,687 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-60488729:ctest-left_vn-96158444
2025-10-24 01:52:48,691 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-60488729:ctest-left_vn-96158444:ctest-left_vn-96158444
2025-10-24 01:52:49,480 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-60488729:ctest-right_vn-36019803
2025-10-24 01:52:49,485 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-60488729:ctest-right_vn-36019803:ctest-right_vn-36019803
2025-10-24 01:53:55,259 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-60488729:ctest-right_vn-36019803:ctest-right_vn-36019803
2025-10-24 01:53:55,263 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-60488729:ctest-right_vn-36019803
2025-10-24 01:53:55,493 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-60488729:ctest-left_vn-96158444:ctest-left_vn-96158444
2025-10-24 01:53:55,497 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-60488729:ctest-left_vn-96158444
2025-10-24 01:53:55,723 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-60488729:ctest-mgmt_vn-46487624:ctest-mgmt_vn-46487624
2025-10-24 01:53:55,727 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-60488729:ctest-mgmt_vn-46487624
2025-10-24 01:53:59,863 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-DNS&search_string=virtual-DNS:default-domain:ctest-vdns1-28179894
2025-10-24 01:54:36,238 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-DNS-record&search_string=virtual-DNS-record:default-domain:ctest-vdns1-28179894:test-rec
2025-10-24 01:54:44,091 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-DNS&search_string=virtual-DNS:default-domain:ctest-vdns1-28179894
2025-10-24 01:55:56,173 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=network-ipam&search_string=network-ipam:default-domain:ctest-TestBasicVMVN-07422042:ctest-ipam-20117227
2025-10-24 01:55:56,369 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicVMVN-07422042:ctest-vn-02233136
2025-10-24 01:55:56,374 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicVMVN-07422042:ctest-vn-02233136:ctest-vn-02233136
2025-10-24 01:56:28,606 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicVMVN-07422042:ctest-vn-02233136:ctest-vn-02233136
2025-10-24 01:56:28,609 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicVMVN-07422042:ctest-vn-02233136
2025-10-24 01:56:28,687 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicVMVN-07422042:ctest-ipam-20117227:ctest-ipam-20117227
2025-10-24 01:56:28,692 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=network-ipam&search_string=network-ipam:default-domain:ctest-TestBasicVMVN-07422042:ctest-ipam-20117227