2025-09-18 19:29:52,303 - INFO - Domain Default found not creating
2025-09-18 19:29:52,432 - INFO - Project ctest-AnalyticsBasicTestSanity-37812159 not found, creating it
2025-09-18 19:29:52,885 - INFO - Created Project:ctest-AnalyticsBasicTestSanity-37812159, ID : 6a63283a-9d9c-410c-8c48-c89a8eab7fad
2025-09-18 19:29:54,181 - INFO - ================================================================================
2025-09-18 19:29:54,181 - INFO - STARTING TEST : test_verify_object_logs
2025-09-18 19:29:54,181 - 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-09-18 19:29:54,302 - DEBUG - Nothing to compare xmpp stats {'10.0.0.254': {'10.20.0.254': '0'}} with
2025-09-18 19:29:54,302 - INFO - Initial checks done. Running the testcase now
2025-09-18 19:29:54,302 - INFO -
2025-09-18 19:29:55,039 - DEBUG - Response for create_network : {'network': {'id': '49ad8518-1311-4006-8cfd-32af76021596', 'name': 'ctest-vn22-19397761', 'tenant_id': '6a63283a9d9c410c8c48c89a8eab7fad', 'project_id': '6a63283a9d9c410c8c48c89a8eab7fad', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsBasicTestSanity-37812159', 'ctest-vn22-19397761'], 'port_security_enabled': True, 'description': ''}}
2025-09-18 19:29:55,184 - DEBUG - Response for create_subnet : {'subnet': {'id': '36a7a27e-2eca-4692-b5c2-956e82972c15', 'name': '', 'tenant_id': '6a63283a9d9c410c8c48c89a8eab7fad', 'network_id': '49ad8518-1311-4006-8cfd-32af76021596', 'ip_version': 4, 'cidr': '40.245.40.0/26', 'allocation_pools': [{'start': '40.245.40.2', 'end': '40.245.40.62'}], 'gateway_ip': '40.245.40.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '40.245.40.2', 'tags': [], 'project_id': '6a63283a9d9c410c8c48c89a8eab7fad'}}
2025-09-18 19:29:55,199 - INFO - Created VN ctest-vn22-19397761
2025-09-18 19:29:55,248 - DEBUG - VN ctest-vn22-19397761 UUID is 49ad8518-1311-4006-8cfd-32af76021596
2025-09-18 19:29:55,342 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-09-18 19:29:55,629 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-09-18 19:29:55,653 - DEBUG - Requesting: http://10.0.0.254:8082/domain/b2e4eef2-234a-403e-874f-6574d1def19b
2025-09-18 19:29:55,670 - DEBUG - Requesting: http://10.0.0.254:8082/project/6a63283a-9d9c-410c-8c48-c89a8eab7fad
2025-09-18 19:29:55,742 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/49ad8518-1311-4006-8cfd-32af76021596
2025-09-18 19:29:55,754 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/49ad8518-1311-4006-8cfd-32af76021596
2025-09-18 19:29:55,764 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/6b3e0369-6329-4118-b3b9-637454197db9
2025-09-18 19:29:55,771 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/6b3e0369-6329-4118-b3b9-637454197db9
2025-09-18 19:29:55,776 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/dc22223d-422c-479e-9647-fd8cfaaaf9af
2025-09-18 19:29:55,781 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-18 19:29:55,782 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/49ad8518-1311-4006-8cfd-32af76021596
2025-09-18 19:29:55,790 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/6b3e0369-6329-4118-b3b9-637454197db9
2025-09-18 19:29:55,801 - INFO - Verified VN network id 5 for VN 49ad8518-1311-4006-8cfd-32af76021596
2025-09-18 19:29:55,801 - INFO - Verifications in API Server for VN ctest-vn22-19397761 passed
2025-09-18 19:29:55,801 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/49ad8518-1311-4006-8cfd-32af76021596
2025-09-18 19:29:55,808 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/6b3e0369-6329-4118-b3b9-637454197db9
2025-09-18 19:29:55,813 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/6b3e0369-6329-4118-b3b9-637454197db9
2025-09-18 19:29:55,819 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/dc22223d-422c-479e-9647-fd8cfaaaf9af
2025-09-18 19:29:55,823 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761
2025-09-18 19:29:55,828 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsBasicTestSanity-37812159', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5309045874185289734', 'uuid-lslong': '10159332063598220694'}, 'enable': 'true', 'created': '2025-09-18T19:29:54', 'last-modified': '2025-09-18T19:29:55', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.672920'}
2025-09-18 19:29:55,828 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761
2025-09-18 19:29:55,833 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-18 19:29:55,833 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn22-19397761 passed
2025-09-18 19:29:55,834 - DEBUG - ====Verifying policy data for ctest-vn22-19397761 in API_Server ======
2025-09-18 19:29:55,834 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-09-18 19:29:55,838 - DEBUG - Requesting: http://10.0.0.254:8082/domain/b2e4eef2-234a-403e-874f-6574d1def19b
2025-09-18 19:29:55,847 - DEBUG - Requesting: http://10.0.0.254:8082/project/6a63283a-9d9c-410c-8c48-c89a8eab7fad
2025-09-18 19:29:55,916 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/49ad8518-1311-4006-8cfd-32af76021596
2025-09-18 19:29:55,924 - DEBUG - =>VN ctest-vn22-19397761 has no policy to be verified
2025-09-18 19:29:55,924 - DEBUG - Verifying the vn in opserver
2025-09-18 19:29:55,924 - DEBUG - Verifying the default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761 virtual network link through opserver 10.0.0.254
2025-09-18 19:29:55,924 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-09-18 19:29:56,210 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-09-18 19:29:56,257 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761?flat'}
2025-09-18 19:29:56,257 - INFO - Validated that VN default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761 is found in opserver
2025-09-18 19:29:56,268 - DEBUG - Do not have enough data to verify VN in agent
2025-09-18 19:29:56,273 - DEBUG - VRF ids for VN ctest-vn22-19397761: {}
2025-09-18 19:29:56,361 - DEBUG - Services list from nova: [, , ]
2025-09-18 19:29:56,444 - DEBUG - Image by name cirros not found
2025-09-18 19:29:56,444 - DEBUG - Installing image cirros
2025-09-18 19:29:56,444 - 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-09-18 19:29:56,445 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/converts//cirros-0.3.0-x86_64-disk.vmdk.gz
2025-09-18 19:29:56,445 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/converts//cirros-0.3.0-x86_64-disk.vmdk.gz
2025-09-18 19:29:56,457 - 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-09-18 19:29:56,527 - DEBUG - Image has been downloaded to /contrail-test/images/cirros-0.3.0-x86_64-disk.vmdk.gz
2025-09-18 19:29:56,528 - DEBUG - Unzip image
2025-09-18 19:29:56,528 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: gunzip -f /contrail-test/images/cirros-0.3.0-x86_64-disk.vmdk.gz
2025-09-18 19:29:56,645 - DEBUG - Try to create image in user context
2025-09-18 19:29:56,818 - DEBUG - Image has been created in user context
2025-09-18 19:29:56,818 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: rm -f /contrail-test/images/cirros-0.3.0-x86_64-disk.vmdk
2025-09-18 19:29:56,830 - DEBUG - Downloaded image has been removed
2025-09-18 19:29:56,846 - DEBUG - Uploaded image status = active
2025-09-18 19:29:59,181 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4141-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4141-1)
2025-09-18 19:29:59,216 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-09-18 19:30:04,325 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-09-18 19:30:09,390 - DEBUG - VM is in ACTIVE state now
2025-09-18 19:30:09,390 - DEBUG - Verifying ObjectVNTable for vn default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761 on analytics node 10.0.0.254
2025-09-18 19:30:09,393 - DEBUG - Posting: http://10.0.0.254:8081/analytics/query, payload {'table': 'ObjectVNTable', 'start_time': 1758223794302923, 'end_time': 1758223809393787, 'select_fields': ['ObjectId', 'Source', 'ObjectLog', 'SystemLog', 'Messagetype', 'ModuleId', 'MessageTS'], 'where': [[{'name': 'ObjectId', 'value': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'op': 1, 'value2': None}]]}
2025-09-18 19:30:10,424 - DEBUG - Query output : [{'MessageTS': 1758223803648917, 'Messagetype': 'VnObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'Addition 49ad8518-1311-4006-8cfd-32af76021596default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-1939776100000000-0000-0000-0000-00000000000040.245.40.02640.245.40.1default-domain:default-project:default-network-ipamtrue40.245.40.2true
truetruetruefalse0controller/src/vnsw/agent/oper/vn.cc1408', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1', 'SystemLog': None}, {'MessageTS': 1758223803655307, 'Messagetype': 'VnObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'Modification 49ad8518-1311-4006-8cfd-32af76021596default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-1939776100000000-0000-0000-0000-000000000000default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-1939776140.245.40.02640.245.40.1default-domain:default-project:default-network-ipamtrue40.245.40.2true
truetruetruefalse5controller/src/vnsw/agent/oper/vn.cc1408', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1', 'SystemLog': None}, {'MessageTS': 1758223794984038, 'Messagetype': 'ContrailConfigTrace', 'ModuleId': 'contrail-api', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761false', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}, {'MessageTS': 1758223794993764, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}, {'MessageTS': 1758223794994207, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}, {'MessageTS': 1758223795008447, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761target:10.20.0.254:6target:64512:7999999
cn-jenkins-deploy-platform-ansible-os-4141-1controller/src/bgp/routing-instance/routing_instance.cc1239', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1', 'SystemLog': None}, {'MessageTS': 1758223795008469, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761Addinetcn-jenkins-deploy-platform-ansible-os-4141-1controller/src/bgp/routing-instance/routing_instance.cc1720', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1', 'SystemLog': None}, {'MessageTS': 1758223795008744, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761Addinet6cn-jenkins-deploy-platform-ansible-os-4141-1controller/src/bgp/routing-instance/routing_instance.cc1720', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1', 'SystemLog': None}, {'MessageTS': 1758223795008829, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761Adderm-vpncn-jenkins-deploy-platform-ansible-os-4141-1controller/src/bgp/routing-instance/routing_instance.cc1720', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1', 'SystemLog': None}, {'MessageTS': 1758223795008954, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761Adde-vpncn-jenkins-deploy-platform-ansible-os-4141-1controller/src/bgp/routing-instance/routing_instance.cc1720', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1', 'SystemLog': None}, {'MessageTS': 1758223795009021, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761Addinet-mvpncn-jenkins-deploy-platform-ansible-os-4141-1controller/src/bgp/routing-instance/routing_instance.cc1720', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1', 'SystemLog': None}, {'MessageTS': 1758223795047560, 'Messagetype': 'RoutingInstanceCollector', 'ModuleId': 'contrail-control', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-1939776110.20.0.254:6target:64512:8000004
target:64512:8000004
cn-jenkins-deploy-platform-ansible-os-4141-1controller/src/bgp/routing-instance/routing_instance.cc1392', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1', 'SystemLog': None}, {'MessageTS': 1758223795088924, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761
default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}, {'MessageTS': 1758223795089262, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761
default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}, {'MessageTS': 1758223795152740, 'Messagetype': 'ContrailConfigTrace', 'ModuleId': 'contrail-api', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761false', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}, {'MessageTS': 1758223795157272, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761
default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}, {'MessageTS': 1758223795157574, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761
default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}, {'MessageTS': 1758223800117399, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761
default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}, {'MessageTS': 1758223800117615, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761
default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}, {'MessageTS': 1758223800133895, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761
default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}, {'MessageTS': 1758223800134101, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761
default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}, {'MessageTS': 1758223800181617, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761
default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}, {'MessageTS': 1758223800181823, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761
default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}, {'MessageTS': 1758223800620127, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761
default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}, {'MessageTS': 1758223800620374, 'Messagetype': 'UveVirtualNetworkConfigTrace', 'ModuleId': 'contrail-schema', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761', 'ObjectLog': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761
default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761
0', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}]
2025-09-18 19:30:10,424 - DEBUG - Verifying ObjectVMTable for vm d1e64d85-7bbd-4f82-bef6-8345c6d1c06e on analytics node 10.0.0.254
2025-09-18 19:30:10,424 - DEBUG - Posting: http://10.0.0.254:8081/analytics/query, payload {'table': 'ObjectVMTable', 'start_time': 1758223794302923, 'end_time': 1758223810424587, 'select_fields': ['ObjectId', 'Source', 'ObjectLog', 'SystemLog', 'ModuleId', 'Messagetype', 'MessageTS'], 'where': [[{'name': 'ObjectId', 'value': 'd1e64d85-7bbd-4f82-bef6-8345c6d1c06e', 'op': 1, 'value2': None}]]}
2025-09-18 19:30:11,440 - DEBUG - Query output : [{'MessageTS': 1758223800038165, 'Messagetype': 'ContrailConfigTrace', 'ModuleId': 'contrail-api', 'ObjectId': 'd1e64d85-7bbd-4f82-bef6-8345c6d1c06e', 'ObjectLog': 'd1e64d85-7bbd-4f82-bef6-8345c6d1c06efalse', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}, {'MessageTS': 1758223803610415, 'Messagetype': 'VmObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': 'd1e64d85-7bbd-4f82-bef6-8345c6d1c06e', 'ObjectLog': 'Addition d1e64d85-7bbd-4f82-bef6-8345c6d1c06e0controller/src/vnsw/agent/oper/vm.cc141', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1', 'SystemLog': None}, {'MessageTS': 1758223803621035, 'Messagetype': 'VmObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': 'd1e64d85-7bbd-4f82-bef6-8345c6d1c06e', 'ObjectLog': 'Modification d1e64d85-7bbd-4f82-bef6-8345c6d1c06e1controller/src/vnsw/agent/oper/vm.cc141', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1', 'SystemLog': None}]
2025-09-18 19:30:11,440 - DEBUG - Verifying ObjectRoutingInstance for RI default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761 on analytics node 10.0.0.254
2025-09-18 19:30:11,440 - DEBUG - Posting: http://10.0.0.254:8081/analytics/query, payload {'table': 'ObjectRoutingInstance', 'start_time': 1758223794302923, 'end_time': 1758223811440902, 'select_fields': ['ObjectId', 'Source', 'ObjectLog', 'SystemLog', 'ModuleId', 'Messagetype', 'MessageTS'], 'where': [[{'name': 'ObjectId', 'value': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761', 'op': 1, 'value2': None}]]}
2025-09-18 19:30:12,456 - DEBUG - Query output : [{'MessageTS': 1758223803648987, 'Messagetype': 'VrfObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761', 'ObjectLog': 'Addition default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-193977612controller/src/vnsw/agent/oper/vrf.cc414', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1', 'SystemLog': None}]
2025-09-18 19:30:12,456 - DEBUG - Verifying ObjectVMTable for vm d1e64d85-7bbd-4f82-bef6-8345c6d1c06e on analytics node 10.0.0.254
2025-09-18 19:30:12,456 - DEBUG - Posting: http://10.0.0.254:8081/analytics/query, payload {'table': 'ObjectVMTable', 'start_time': 1758223794302923, 'end_time': 1758223812456945, 'select_fields': ['ObjectId', 'Source', 'ObjectLog', 'SystemLog', 'ModuleId', 'Messagetype', 'MessageTS'], 'where': [[{'name': 'ObjectId', 'value': 'd1e64d85-7bbd-4f82-bef6-8345c6d1c06e', 'op': 1, 'value2': None}]]}
2025-09-18 19:30:13,477 - DEBUG - Query output : [{'MessageTS': 1758223811424871, 'Messagetype': 'UveVirtualMachineAgentTrace', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': 'd1e64d85-7bbd-4f82-bef6-8345c6d1c06e', 'ObjectLog': 'd1e64d85-7bbd-4f82-bef6-8345c6d1c06edefault-domain:ctest-AnalyticsBasicTestSanity-37812159:bcf83aa9-9801-4b2f-a466-eba523d691a7
cn-jenkins-deploy-platform-ansible-os-4141-1d1e64d85-7bbd-4f82-bef6-8345c6d1c06ectest-AnalyticsBasicTestSanity-37812159-64388569', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1', 'SystemLog': None}, {'MessageTS': 1758223800038165, 'Messagetype': 'ContrailConfigTrace', 'ModuleId': 'contrail-api', 'ObjectId': 'd1e64d85-7bbd-4f82-bef6-8345c6d1c06e', 'ObjectLog': 'd1e64d85-7bbd-4f82-bef6-8345c6d1c06efalse', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1.', 'SystemLog': None}, {'MessageTS': 1758223803610415, 'Messagetype': 'VmObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': 'd1e64d85-7bbd-4f82-bef6-8345c6d1c06e', 'ObjectLog': 'Addition d1e64d85-7bbd-4f82-bef6-8345c6d1c06e0controller/src/vnsw/agent/oper/vm.cc141', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1', 'SystemLog': None}, {'MessageTS': 1758223803621035, 'Messagetype': 'VmObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': 'd1e64d85-7bbd-4f82-bef6-8345c6d1c06e', 'ObjectLog': 'Modification d1e64d85-7bbd-4f82-bef6-8345c6d1c06e1controller/src/vnsw/agent/oper/vm.cc141', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1', 'SystemLog': None}]
2025-09-18 19:30:13,477 - DEBUG - Verifying ObjectRoutingInstance for RI default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761 on analytics node 10.0.0.254
2025-09-18 19:30:13,478 - DEBUG - Posting: http://10.0.0.254:8081/analytics/query, payload {'table': 'ObjectRoutingInstance', 'start_time': 1758223794302923, 'end_time': 1758223813478079, 'select_fields': ['ObjectId', 'Source', 'ObjectLog', 'SystemLog', 'ModuleId', 'Messagetype', 'MessageTS'], 'where': [[{'name': 'ObjectId', 'value': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761', 'op': 1, 'value2': None}]]}
2025-09-18 19:30:14,496 - DEBUG - Query output : [{'MessageTS': 1758223803648987, 'Messagetype': 'VrfObjectLog', 'ModuleId': 'contrail-vrouter-agent', 'ObjectId': 'default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761', 'ObjectLog': 'Addition default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-193977612controller/src/vnsw/agent/oper/vrf.cc414', 'Source': 'cn-jenkins-deploy-platform-ansible-os-4141-1', 'SystemLog': None}]
2025-09-18 19:30:14,496 - INFO - Validated ObjectVNTable, ObjectRoutingInstance, ObjectVMTable logs
2025-09-18 19:30:14,496 - INFO - Deleting VM ctest-AnalyticsBasicTestSanity-37812159-64388569
2025-09-18 19:30:14,617 - INFO - Deleting VN ctest-vn22-19397761
2025-09-18 19:30:14,654 - DEBUG - VN 49ad8518-1311-4006-8cfd-32af76021596 still in use: Unable to complete operation on network 49ad8518-1311-4006-8cfd-32af76021596. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-6929118e-3448-4f69-8598-f852ba0cb2c8']
2025-09-18 19:30:14,654 - WARNING - Deleting VN ctest-vn22-19397761 failed..Will retry
2025-09-18 19:30:16,798 - DEBUG - Response for deleting network ()
2025-09-18 19:30:16,798 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/6b3e0369-6329-4118-b3b9-637454197db9
2025-09-18 19:30:16,803 - DEBUG - Response Code: 404
2025-09-18 19:30:16,803 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-09-18 19:30:16,808 - DEBUG - Requesting: http://10.0.0.254:8082/domain/b2e4eef2-234a-403e-874f-6574d1def19b
2025-09-18 19:30:16,862 - DEBUG - Requesting: http://10.0.0.254:8082/project/6a63283a-9d9c-410c-8c48-c89a8eab7fad
2025-09-18 19:30:16,934 - INFO - Validated that VN ctest-vn22-19397761 is not found in API Server
2025-09-18 19:30:16,943 - DEBUG - VN ctest-vn22-19397761 is not present in Agent 10.0.0.254
2025-09-18 19:30:16,943 - INFO - Validated that VN ctest-vn22-19397761 is not in any agent
2025-09-18 19:30:16,947 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761:ctest-vn22-19397761
2025-09-18 19:30:16,951 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-AnalyticsBasicTestSanity-37812159:ctest-vn22-19397761
2025-09-18 19:30:16,955 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn22-19397761 info
2025-09-18 19:30:17,078 - DEBUG - No XMPP flaps were noticed during the test
2025-09-18 19:30:17,078 - INFO - END TEST : test_verify_object_logs : PASSED[0:00:23]
2025-09-18 19:30:17,078 - INFO - --------------------------------------------------------------------------------
2025-09-18 19:30:17,761 - INFO - Deleted project: ctest-AnalyticsBasicTestSanity-37812159, ID : 6a63283a-9d9c-410c-8c48-c89a8eab7fad
2025-09-18 19:30:26,636 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-FloatingipBasicTestSanity-38669710:ctest-fvn-95038974
2025-09-18 19:30:26,640 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-FloatingipBasicTestSanity-38669710:ctest-fvn-95038974:ctest-fvn-95038974
2025-09-18 19:30:27,782 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-FloatingipBasicTestSanity-38669710:ctest-vn1-22812217
2025-09-18 19:30:27,786 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-FloatingipBasicTestSanity-38669710:ctest-vn1-22812217:ctest-vn1-22812217
2025-09-18 19:30:30,688 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:ctest-FloatingipBasicTestSanity-38669710:ctest-fvn-95038974:ctest-some-pool-98027475
2025-09-18 19:30:42,448 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRtGroupReq?x=target:64512:8000004
2025-09-18 19:30:45,303 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=floating-ip-pool&search_string=floating-ip-pool:default-domain:ctest-FloatingipBasicTestSanity-38669710:ctest-fvn-95038974:ctest-some-pool-98027475
2025-09-18 19:30:47,713 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-FloatingipBasicTestSanity-38669710:ctest-vn1-22812217:ctest-vn1-22812217
2025-09-18 19:30:47,717 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-FloatingipBasicTestSanity-38669710:ctest-vn1-22812217
2025-09-18 19:30:47,951 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-FloatingipBasicTestSanity-38669710:ctest-fvn-95038974:ctest-fvn-95038974
2025-09-18 19:30:47,954 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-FloatingipBasicTestSanity-38669710:ctest-fvn-95038974
2025-09-18 19:32:36,988 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-03925208:ctest-vn-62878981
2025-09-18 19:32:36,993 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-03925208:ctest-vn-62878981:ctest-vn-62878981
2025-09-18 19:32:37,593 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-03925208:ctest-vn-00000950
2025-09-18 19:32:37,597 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-03925208:ctest-vn-00000950:ctest-vn-00000950
2025-09-18 19:32:38,210 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-03925208:ctest-vn-00000950:ctest-vn-00000950
2025-09-18 19:32:38,214 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-03925208:ctest-vn-00000950
2025-09-18 19:32:38,456 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyIpv4v6-03925208:ctest-vn-62878981:ctest-vn-62878981
2025-09-18 19:32:38,460 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyIpv4v6-03925208:ctest-vn-62878981
2025-09-18 19:32:44,012 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyNegativeIpv4v6-58095873:ctest-vn4-98426638
2025-09-18 19:32:44,017 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-58095873:ctest-vn4-98426638:ctest-vn4-98426638
2025-09-18 19:32:44,885 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicyNegativeIpv4v6-58095873:ctest-vn4-98426638:ctest-vn4-98426638
2025-09-18 19:32:44,889 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicyNegativeIpv4v6-58095873:ctest-vn4-98426638
2025-09-18 19:32:51,175 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicy-21392151:ctest-vn-65545697
2025-09-18 19:32:51,179 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicy-21392151:ctest-vn-65545697:ctest-vn-65545697
2025-09-18 19:32:51,769 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicy-21392151:ctest-vn-16284030
2025-09-18 19:32:51,774 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicy-21392151:ctest-vn-16284030:ctest-vn-16284030
2025-09-18 19:33:16,381 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicy-21392151:ctest-vn-16284030:ctest-vn-16284030
2025-09-18 19:33:16,385 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicy-21392151:ctest-vn-16284030
2025-09-18 19:33:16,615 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicPolicy-21392151:ctest-vn-65545697:ctest-vn-65545697
2025-09-18 19:33:16,619 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicPolicy-21392151:ctest-vn-65545697
2025-09-18 19:33:48,116 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-55608170:ctest-mgmt_vn-47654804
2025-09-18 19:33:48,121 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-55608170:ctest-mgmt_vn-47654804:ctest-mgmt_vn-47654804
2025-09-18 19:33:49,180 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-55608170:ctest-left_vn-87128195
2025-09-18 19:33:49,185 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-55608170:ctest-left_vn-87128195:ctest-left_vn-87128195
2025-09-18 19:33:49,933 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-55608170:ctest-right_vn-73641484
2025-09-18 19:33:49,938 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-55608170:ctest-right_vn-73641484:ctest-right_vn-73641484
2025-09-18 19:35:00,649 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-55608170:ctest-right_vn-73641484:ctest-right_vn-73641484
2025-09-18 19:35:00,653 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-55608170:ctest-right_vn-73641484
2025-09-18 19:35:00,884 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-55608170:ctest-left_vn-87128195:ctest-left_vn-87128195
2025-09-18 19:35:00,889 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-55608170:ctest-left_vn-87128195
2025-09-18 19:35:01,130 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestSvcRegr-55608170:ctest-mgmt_vn-47654804:ctest-mgmt_vn-47654804
2025-09-18 19:35:01,135 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestSvcRegr-55608170:ctest-mgmt_vn-47654804
2025-09-18 19:35:05,329 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-DNS&search_string=virtual-DNS:default-domain:ctest-vdns1-75925684
2025-09-18 19:35:46,760 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-DNS-record&search_string=virtual-DNS-record:default-domain:ctest-vdns1-75925684:test-rec
2025-09-18 19:35:54,560 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-DNS&search_string=virtual-DNS:default-domain:ctest-vdns1-75925684
2025-09-18 19:37:07,033 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=network-ipam&search_string=network-ipam:default-domain:ctest-TestBasicVMVN-15906541:ctest-ipam-01761300
2025-09-18 19:37:07,263 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicVMVN-15906541:ctest-vn-71906007
2025-09-18 19:37:07,268 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicVMVN-15906541:ctest-vn-71906007:ctest-vn-71906007
2025-09-18 19:37:39,711 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicVMVN-15906541:ctest-vn-71906007:ctest-vn-71906007
2025-09-18 19:37:39,714 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=virtual-network&search_string=virtual-network:default-domain:ctest-TestBasicVMVN-15906541:ctest-vn-71906007
2025-09-18 19:37:39,792 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_ShowRoutingInstanceReq?name=default-domain:ctest-TestBasicVMVN-15906541:ctest-ipam-01761300:ctest-ipam-01761300
2025-09-18 19:37:39,797 - DEBUG - Requesting: http://10.0.0.254:8083/Snh_IFMapTableShowReq?table_name=network-ipam&search_string=network-ipam:default-domain:ctest-TestBasicVMVN-15906541:ctest-ipam-01761300