is in ACTIVE state now
2026-03-09 03:32:33,284 - INFO - VM name : mltf_vm
2026-03-09 03:32:33,362 - DEBUG - VM mltf_vm ID is be079eb0-bad3-4eae-9502-d558ce6e8b34
2026-03-09 03:32:33,362 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-5454-1
2026-03-09 03:32:33,545 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/be079eb0-bad3-4eae-9502-d558ce6e8b34
2026-03-09 03:32:33,554 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/2fcb0cf0-cb8c-46f0-9382-554a066024f0
2026-03-09 03:32:33,565 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/ecbc532b-d259-418c-85c2-8acf49c8d827
2026-03-09 03:32:34,744 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n64 bytes from 169.254.0.5: icmp_seq=1 ttl=63 time=1.67 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.519 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.519/1.092/1.665/0.573 ms')
2026-03-09 03:32:34,744 - INFO - Ping to Metadata IP 169.254.0.5 of VM mltf_vm passed
2026-03-09 03:32:34,811 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-09 03:32:34,812 - DEBUG - Waiting to SSH to VM mltf_vm, IP 104.107.64.5, Port 22
2026-03-09 03:32:34,976 - DEBUG - VM mltf_vm is ready for SSH connections
2026-03-09 03:32:35,045 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-09 03:32:35,045 - DEBUG - Waiting to SSH to VM mltf_vm, IP 104.107.64.5, Port 22
2026-03-09 03:32:35,213 - DEBUG - VM mltf_vm is ready for SSH connections
2026-03-09 03:32:35,216 - INFO - ================================================================================
2026-03-09 03:32:35,216 - INFO - STARTING TEST : test_verify_session_sampling_teardown
2026-03-09 03:32:35,216 - INFO - TEST DESCRIPTION :
1.query client session samples
2.query server session samples
3.query client session to get number of sessions exported
4.query session record table for teardown bytes/pkts
5.query sample count after teardown on server side
2026-03-09 03:32:36,474 - DEBUG - Skipping xmpp flap check
2026-03-09 03:32:36,474 - INFO - Initial checks done. Running the testcase now
2026-03-09 03:32:36,475 - INFO -
2026-03-09 03:32:36,596 - INFO - Setting flow export rate: 100
2026-03-09 03:32:36,648 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = any, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = any, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None]
2026-03-09 03:32:36,980 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '3a63fa71-bb28-49fd-a90b-69a88d36580e', 'name': 'ctest-vn1-02354139', 'tenant_id': 'fddba49840f442668657724cd328a7e8', 'project_id': 'fddba49840f442668657724cd328a7e8', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['8f3b22a3-4d4b-47ca-bc3c-cc7db5f9a037'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-88828308', 'ctest-vn1-02354139'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-88828308', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '104.107.64.0/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-03-09 03:32:37,181 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '780fd89d-57e1-410b-8ace-8e9b58b27d7b', 'name': 'ctest-vn2-10783488', 'tenant_id': 'fddba49840f442668657724cd328a7e8', 'project_id': 'fddba49840f442668657724cd328a7e8', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['c168d64f-3eaa-4f40-b45a-82f710ea3d32'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-88828308', 'ctest-vn2-10783488'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-88828308', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '26.90.46.0/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-03-09 03:32:37,270 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-03-09 03:32:37,277 - DEBUG - Requesting: http://10.0.0.22:8082/domain/65872af6-2901-4194-bbe6-c1dbc9d32dc7
2026-03-09 03:32:37,318 - DEBUG - Requesting: http://10.0.0.22:8082/project/fddba498-40f4-4266-8657-724cd328a7e8
2026-03-09 03:32:37,415 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/3a63fa71-bb28-49fd-a90b-69a88d36580e
2026-03-09 03:32:37,430 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/3a63fa71-bb28-49fd-a90b-69a88d36580e
2026-03-09 03:32:37,443 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/3fc3f6d6-c7f5-4a19-ad87-8795f81a7afe
2026-03-09 03:32:37,456 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/3fc3f6d6-c7f5-4a19-ad87-8795f81a7afe
2026-03-09 03:32:37,468 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/cc0f2e1a-b3e8-435a-b2be-6d8b24722b4b
2026-03-09 03:32:37,475 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-09 03:32:37,475 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/3a63fa71-bb28-49fd-a90b-69a88d36580e
2026-03-09 03:32:37,487 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/3fc3f6d6-c7f5-4a19-ad87-8795f81a7afe
2026-03-09 03:32:37,504 - INFO - Verified VN network id 12 for VN 3a63fa71-bb28-49fd-a90b-69a88d36580e
2026-03-09 03:32:37,505 - INFO - Verifications in API Server for VN ctest-vn1-02354139 passed
2026-03-09 03:32:37,505 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/3a63fa71-bb28-49fd-a90b-69a88d36580e
2026-03-09 03:32:37,516 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/3fc3f6d6-c7f5-4a19-ad87-8795f81a7afe
2026-03-09 03:32:37,544 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/3fc3f6d6-c7f5-4a19-ad87-8795f81a7afe
2026-03-09 03:32:37,555 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/cc0f2e1a-b3e8-435a-b2be-6d8b24722b4b
2026-03-09 03:32:37,575 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88828308', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4207481843272403453', 'uuid-lslong': '12180945789798209550'}, 'enable': 'true', 'created': '2026-03-09T03:31:13', 'last-modified': '2026-03-09T03:32:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.632704'}
2026-03-09 03:32:37,585 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-09 03:32:37,590 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88828308', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4207481843272403453', 'uuid-lslong': '12180945789798209550'}, 'enable': 'true', 'created': '2026-03-09T03:31:13', 'last-modified': '2026-03-09T03:32:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.651871'}
2026-03-09 03:32:37,609 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-09 03:32:37,616 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88828308', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4207481843272403453', 'uuid-lslong': '12180945789798209550'}, 'enable': 'true', 'created': '2026-03-09T03:31:13', 'last-modified': '2026-03-09T03:32:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.682084'}
2026-03-09 03:32:37,622 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-09 03:32:37,622 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-02354139 passed
2026-03-09 03:32:37,623 - DEBUG - ====Verifying policy data for ctest-vn1-02354139 in API_Server ======
2026-03-09 03:32:37,623 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-03-09 03:32:37,628 - DEBUG - Requesting: http://10.0.0.22:8082/domain/65872af6-2901-4194-bbe6-c1dbc9d32dc7
2026-03-09 03:32:37,641 - DEBUG - Requesting: http://10.0.0.22:8082/project/fddba498-40f4-4266-8657-724cd328a7e8
2026-03-09 03:32:37,760 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/3a63fa71-bb28-49fd-a90b-69a88d36580e
2026-03-09 03:32:37,771 - DEBUG - ==>Verifying data for policy with id: be2dee8d-633b-4055-88f2-2272938464a6, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-88828308', 'policy1']
2026-03-09 03:32:37,771 - INFO - VN ctest-vn1-02354139 Policy verification: verify_vn_policy_in_api_server, status: True
2026-03-09 03:32:37,771 - DEBUG - Verifying the vn in opserver
2026-03-09 03:32:37,771 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139 virtual network link through opserver 10.0.0.22
2026-03-09 03:32:37,771 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-03-09 03:32:37,787 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139?flat'}
2026-03-09 03:32:37,788 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139 virtual network link through opserver 10.0.0.249
2026-03-09 03:32:37,788 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-03-09 03:32:37,800 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139?flat'}
2026-03-09 03:32:37,800 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139 virtual network link through opserver 10.0.0.23
2026-03-09 03:32:37,800 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-03-09 03:32:37,811 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139?flat'}
2026-03-09 03:32:37,811 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139 is found in opserver
2026-03-09 03:32:37,822 - DEBUG - VRF ids for VN ctest-vn1-02354139: {'10.0.0.41': '2'}
2026-03-09 03:32:37,822 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-03-09 03:32:37,827 - DEBUG - Requesting: http://10.0.0.22:8082/domain/65872af6-2901-4194-bbe6-c1dbc9d32dc7
2026-03-09 03:32:37,837 - DEBUG - Requesting: http://10.0.0.22:8082/project/fddba498-40f4-4266-8657-724cd328a7e8
2026-03-09 03:32:37,922 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/780fd89d-57e1-410b-8ace-8e9b58b27d7b
2026-03-09 03:32:37,943 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/780fd89d-57e1-410b-8ace-8e9b58b27d7b
2026-03-09 03:32:37,953 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/8b04236f-72e4-4356-b9a5-1bb2f2100f1e
2026-03-09 03:32:37,963 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/8b04236f-72e4-4356-b9a5-1bb2f2100f1e
2026-03-09 03:32:37,973 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/167bb7ba-bad0-4646-a989-50161ced23c1
2026-03-09 03:32:37,980 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-09 03:32:37,980 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/780fd89d-57e1-410b-8ace-8e9b58b27d7b
2026-03-09 03:32:37,990 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/8b04236f-72e4-4356-b9a5-1bb2f2100f1e
2026-03-09 03:32:38,007 - INFO - Verified VN network id 13 for VN 780fd89d-57e1-410b-8ace-8e9b58b27d7b
2026-03-09 03:32:38,007 - INFO - Verifications in API Server for VN ctest-vn2-10783488 passed
2026-03-09 03:32:38,007 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/780fd89d-57e1-410b-8ace-8e9b58b27d7b
2026-03-09 03:32:38,018 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/8b04236f-72e4-4356-b9a5-1bb2f2100f1e
2026-03-09 03:32:38,026 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/8b04236f-72e4-4356-b9a5-1bb2f2100f1e
2026-03-09 03:32:38,033 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/167bb7ba-bad0-4646-a989-50161ced23c1
2026-03-09 03:32:38,047 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88828308', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8651371579497857291', 'uuid-lslong': '10002088620295617915'}, 'enable': 'true', 'created': '2026-03-09T03:31:48', 'last-modified': '2026-03-09T03:32:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.917026'}
2026-03-09 03:32:38,056 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-09 03:32:38,062 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88828308', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8651371579497857291', 'uuid-lslong': '10002088620295617915'}, 'enable': 'true', 'created': '2026-03-09T03:31:48', 'last-modified': '2026-03-09T03:32:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.933739'}
2026-03-09 03:32:38,068 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-09 03:32:38,073 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88828308', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8651371579497857291', 'uuid-lslong': '10002088620295617915'}, 'enable': 'true', 'created': '2026-03-09T03:31:48', 'last-modified': '2026-03-09T03:32:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.944253'}
2026-03-09 03:32:38,078 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-09 03:32:38,078 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-10783488 passed
2026-03-09 03:32:38,079 - DEBUG - ====Verifying policy data for ctest-vn2-10783488 in API_Server ======
2026-03-09 03:32:38,079 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-03-09 03:32:38,085 - DEBUG - Requesting: http://10.0.0.22:8082/domain/65872af6-2901-4194-bbe6-c1dbc9d32dc7
2026-03-09 03:32:38,095 - DEBUG - Requesting: http://10.0.0.22:8082/project/fddba498-40f4-4266-8657-724cd328a7e8
2026-03-09 03:32:38,186 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/780fd89d-57e1-410b-8ace-8e9b58b27d7b
2026-03-09 03:32:38,199 - DEBUG - ==>Verifying data for policy with id: be2dee8d-633b-4055-88f2-2272938464a6, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-88828308', 'policy1']
2026-03-09 03:32:38,199 - INFO - VN ctest-vn2-10783488 Policy verification: verify_vn_policy_in_api_server, status: True
2026-03-09 03:32:38,199 - DEBUG - Verifying the vn in opserver
2026-03-09 03:32:38,200 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488 virtual network link through opserver 10.0.0.22
2026-03-09 03:32:38,200 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-03-09 03:32:38,213 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488?flat'}
2026-03-09 03:32:38,213 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488 virtual network link through opserver 10.0.0.249
2026-03-09 03:32:38,213 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-03-09 03:32:38,233 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488?flat'}
2026-03-09 03:32:38,233 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488 virtual network link through opserver 10.0.0.23
2026-03-09 03:32:38,233 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-03-09 03:32:38,246 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488?flat'}
2026-03-09 03:32:38,246 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488 is found in opserver
2026-03-09 03:32:38,258 - DEBUG - VRF ids for VN ctest-vn2-10783488: {'10.0.0.41': '3', '10.0.0.27': '2'}
2026-03-09 03:32:38,259 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-03-09 03:32:38,264 - DEBUG - Requesting: http://10.0.0.22:8082/domain/65872af6-2901-4194-bbe6-c1dbc9d32dc7
2026-03-09 03:32:38,274 - DEBUG - Requesting: http://10.0.0.22:8082/project/fddba498-40f4-4266-8657-724cd328a7e8
2026-03-09 03:32:38,365 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/3a63fa71-bb28-49fd-a90b-69a88d36580e
2026-03-09 03:32:38,376 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/3a63fa71-bb28-49fd-a90b-69a88d36580e
2026-03-09 03:32:38,386 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/3fc3f6d6-c7f5-4a19-ad87-8795f81a7afe
2026-03-09 03:32:38,395 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/3fc3f6d6-c7f5-4a19-ad87-8795f81a7afe
2026-03-09 03:32:38,403 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/cc0f2e1a-b3e8-435a-b2be-6d8b24722b4b
2026-03-09 03:32:38,408 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-09 03:32:38,408 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/3a63fa71-bb28-49fd-a90b-69a88d36580e
2026-03-09 03:32:38,417 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/3fc3f6d6-c7f5-4a19-ad87-8795f81a7afe
2026-03-09 03:32:38,432 - INFO - Verified VN network id 12 for VN 3a63fa71-bb28-49fd-a90b-69a88d36580e
2026-03-09 03:32:38,432 - INFO - Verifications in API Server for VN ctest-vn1-02354139 passed
2026-03-09 03:32:38,432 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/3a63fa71-bb28-49fd-a90b-69a88d36580e
2026-03-09 03:32:38,441 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/3fc3f6d6-c7f5-4a19-ad87-8795f81a7afe
2026-03-09 03:32:38,447 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/3fc3f6d6-c7f5-4a19-ad87-8795f81a7afe
2026-03-09 03:32:38,455 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/cc0f2e1a-b3e8-435a-b2be-6d8b24722b4b
2026-03-09 03:32:38,471 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88828308', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4207481843272403453', 'uuid-lslong': '12180945789798209550'}, 'enable': 'true', 'created': '2026-03-09T03:31:13', 'last-modified': '2026-03-09T03:32:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.528224'}
2026-03-09 03:32:38,481 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-09 03:32:38,487 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88828308', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4207481843272403453', 'uuid-lslong': '12180945789798209550'}, 'enable': 'true', 'created': '2026-03-09T03:31:13', 'last-modified': '2026-03-09T03:32:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.548565'}
2026-03-09 03:32:38,494 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-09 03:32:38,500 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88828308', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4207481843272403453', 'uuid-lslong': '12180945789798209550'}, 'enable': 'true', 'created': '2026-03-09T03:31:13', 'last-modified': '2026-03-09T03:32:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.565883'}
2026-03-09 03:32:38,507 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-09 03:32:38,507 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-02354139 passed
2026-03-09 03:32:38,508 - DEBUG - ====Verifying policy data for ctest-vn1-02354139 in API_Server ======
2026-03-09 03:32:38,508 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-03-09 03:32:38,519 - DEBUG - Requesting: http://10.0.0.22:8082/domain/65872af6-2901-4194-bbe6-c1dbc9d32dc7
2026-03-09 03:32:38,529 - DEBUG - Requesting: http://10.0.0.22:8082/project/fddba498-40f4-4266-8657-724cd328a7e8
2026-03-09 03:32:38,622 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/3a63fa71-bb28-49fd-a90b-69a88d36580e
2026-03-09 03:32:38,633 - DEBUG - ==>Verifying data for policy with id: be2dee8d-633b-4055-88f2-2272938464a6, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-88828308', 'policy1']
2026-03-09 03:32:38,633 - INFO - VN ctest-vn1-02354139 Policy verification: verify_vn_policy_in_api_server, status: True
2026-03-09 03:32:38,633 - DEBUG - Verifying the vn in opserver
2026-03-09 03:32:38,633 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139 virtual network link through opserver 10.0.0.22
2026-03-09 03:32:38,633 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-03-09 03:32:38,646 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139?flat'}
2026-03-09 03:32:38,647 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139 virtual network link through opserver 10.0.0.249
2026-03-09 03:32:38,647 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-03-09 03:32:38,659 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139?flat'}
2026-03-09 03:32:38,659 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139 virtual network link through opserver 10.0.0.23
2026-03-09 03:32:38,659 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-03-09 03:32:38,671 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139?flat'}
2026-03-09 03:32:38,671 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139 is found in opserver
2026-03-09 03:32:38,681 - DEBUG - VRF ids for VN ctest-vn1-02354139: {'10.0.0.41': '2'}
2026-03-09 03:32:38,681 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-03-09 03:32:38,687 - DEBUG - Requesting: http://10.0.0.22:8082/domain/65872af6-2901-4194-bbe6-c1dbc9d32dc7
2026-03-09 03:32:38,697 - DEBUG - Requesting: http://10.0.0.22:8082/project/fddba498-40f4-4266-8657-724cd328a7e8
2026-03-09 03:32:38,794 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/780fd89d-57e1-410b-8ace-8e9b58b27d7b
2026-03-09 03:32:38,804 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/780fd89d-57e1-410b-8ace-8e9b58b27d7b
2026-03-09 03:32:38,814 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/8b04236f-72e4-4356-b9a5-1bb2f2100f1e
2026-03-09 03:32:38,821 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/8b04236f-72e4-4356-b9a5-1bb2f2100f1e
2026-03-09 03:32:38,828 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/167bb7ba-bad0-4646-a989-50161ced23c1
2026-03-09 03:32:38,834 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-09 03:32:38,834 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/780fd89d-57e1-410b-8ace-8e9b58b27d7b
2026-03-09 03:32:38,843 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/8b04236f-72e4-4356-b9a5-1bb2f2100f1e
2026-03-09 03:32:38,862 - INFO - Verified VN network id 13 for VN 780fd89d-57e1-410b-8ace-8e9b58b27d7b
2026-03-09 03:32:38,863 - INFO - Verifications in API Server for VN ctest-vn2-10783488 passed
2026-03-09 03:32:38,863 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/780fd89d-57e1-410b-8ace-8e9b58b27d7b
2026-03-09 03:32:38,873 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/8b04236f-72e4-4356-b9a5-1bb2f2100f1e
2026-03-09 03:32:38,883 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/8b04236f-72e4-4356-b9a5-1bb2f2100f1e
2026-03-09 03:32:38,891 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/167bb7ba-bad0-4646-a989-50161ced23c1
2026-03-09 03:32:38,908 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88828308', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8651371579497857291', 'uuid-lslong': '10002088620295617915'}, 'enable': 'true', 'created': '2026-03-09T03:31:48', 'last-modified': '2026-03-09T03:32:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.774695'}
2026-03-09 03:32:38,915 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-09 03:32:38,921 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88828308', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8651371579497857291', 'uuid-lslong': '10002088620295617915'}, 'enable': 'true', 'created': '2026-03-09T03:31:48', 'last-modified': '2026-03-09T03:32:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.792862'}
2026-03-09 03:32:38,930 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-09 03:32:38,936 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88828308', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8651371579497857291', 'uuid-lslong': '10002088620295617915'}, 'enable': 'true', 'created': '2026-03-09T03:31:48', 'last-modified': '2026-03-09T03:32:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.807293'}
2026-03-09 03:32:38,944 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-09 03:32:38,944 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-10783488 passed
2026-03-09 03:32:38,945 - DEBUG - ====Verifying policy data for ctest-vn2-10783488 in API_Server ======
2026-03-09 03:32:38,945 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-03-09 03:32:38,953 - DEBUG - Requesting: http://10.0.0.22:8082/domain/65872af6-2901-4194-bbe6-c1dbc9d32dc7
2026-03-09 03:32:38,966 - DEBUG - Requesting: http://10.0.0.22:8082/project/fddba498-40f4-4266-8657-724cd328a7e8
2026-03-09 03:32:39,076 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/780fd89d-57e1-410b-8ace-8e9b58b27d7b
2026-03-09 03:32:39,086 - DEBUG - ==>Verifying data for policy with id: be2dee8d-633b-4055-88f2-2272938464a6, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-88828308', 'policy1']
2026-03-09 03:32:39,086 - INFO - VN ctest-vn2-10783488 Policy verification: verify_vn_policy_in_api_server, status: True
2026-03-09 03:32:39,086 - DEBUG - Verifying the vn in opserver
2026-03-09 03:32:39,086 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488 virtual network link through opserver 10.0.0.22
2026-03-09 03:32:39,086 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-03-09 03:32:39,100 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488?flat'}
2026-03-09 03:32:39,100 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488 virtual network link through opserver 10.0.0.249
2026-03-09 03:32:39,100 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-03-09 03:32:39,113 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488?flat'}
2026-03-09 03:32:39,113 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488 virtual network link through opserver 10.0.0.23
2026-03-09 03:32:39,113 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-03-09 03:32:39,127 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488?flat'}
2026-03-09 03:32:39,127 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488 is found in opserver
2026-03-09 03:32:39,140 - DEBUG - VRF ids for VN ctest-vn2-10783488: {'10.0.0.41': '3', '10.0.0.27': '2'}
2026-03-09 03:32:39,140 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-03-09 03:32:39,145 - DEBUG - Requesting: http://10.0.0.22:8082/domain/65872af6-2901-4194-bbe6-c1dbc9d32dc7
2026-03-09 03:32:39,156 - DEBUG - Requesting: http://10.0.0.22:8082/project/fddba498-40f4-4266-8657-724cd328a7e8
2026-03-09 03:32:39,243 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/37549dac-7bab-45d3-b7a6-7a80804916f9
2026-03-09 03:32:39,253 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/37549dac-7bab-45d3-b7a6-7a80804916f9
2026-03-09 03:32:39,262 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/ff9f291c-37e9-4d3a-933b-e863911adb89
2026-03-09 03:32:39,269 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/ff9f291c-37e9-4d3a-933b-e863911adb89
2026-03-09 03:32:39,276 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/4af4841e-40f4-4150-9372-99e7ef207cbc
2026-03-09 03:32:39,282 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-09 03:32:39,282 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/37549dac-7bab-45d3-b7a6-7a80804916f9
2026-03-09 03:32:39,292 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/ff9f291c-37e9-4d3a-933b-e863911adb89
2026-03-09 03:32:39,307 - INFO - Verified VN network id 14 for VN 37549dac-7bab-45d3-b7a6-7a80804916f9
2026-03-09 03:32:39,307 - INFO - Verifications in API Server for VN ctest-fip_vn-69474501 passed
2026-03-09 03:32:39,307 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/37549dac-7bab-45d3-b7a6-7a80804916f9
2026-03-09 03:32:39,316 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/ff9f291c-37e9-4d3a-933b-e863911adb89
2026-03-09 03:32:39,324 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/ff9f291c-37e9-4d3a-933b-e863911adb89
2026-03-09 03:32:39,331 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/4af4841e-40f4-4150-9372-99e7ef207cbc
2026-03-09 03:32:39,344 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-fip_vn-69474501', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88828308', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3986984934264489427', 'uuid-lslong': '13233399247401457401'}, 'enable': 'true', 'created': '2026-03-09T03:31:49', 'last-modified': '2026-03-09T03:31:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:49.731082'}
2026-03-09 03:32:39,352 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-09 03:32:39,358 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-fip_vn-69474501', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88828308', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3986984934264489427', 'uuid-lslong': '13233399247401457401'}, 'enable': 'true', 'created': '2026-03-09T03:31:49', 'last-modified': '2026-03-09T03:31:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:49.745183'}
2026-03-09 03:32:39,364 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-09 03:32:39,370 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-fip_vn-69474501', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88828308', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3986984934264489427', 'uuid-lslong': '13233399247401457401'}, 'enable': 'true', 'created': '2026-03-09T03:31:49', 'last-modified': '2026-03-09T03:31:49', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:49.754141'}
2026-03-09 03:32:39,375 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-09 03:32:39,376 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-69474501 passed
2026-03-09 03:32:39,376 - DEBUG - ====Verifying policy data for ctest-fip_vn-69474501 in API_Server ======
2026-03-09 03:32:39,376 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-03-09 03:32:39,381 - DEBUG - Requesting: http://10.0.0.22:8082/domain/65872af6-2901-4194-bbe6-c1dbc9d32dc7
2026-03-09 03:32:39,391 - DEBUG - Requesting: http://10.0.0.22:8082/project/fddba498-40f4-4266-8657-724cd328a7e8
2026-03-09 03:32:39,477 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/37549dac-7bab-45d3-b7a6-7a80804916f9
2026-03-09 03:32:39,486 - DEBUG - =>VN ctest-fip_vn-69474501 has no policy to be verified
2026-03-09 03:32:39,486 - DEBUG - Verifying the vn in opserver
2026-03-09 03:32:39,486 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-fip_vn-69474501 virtual network link through opserver 10.0.0.22
2026-03-09 03:32:39,486 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-03-09 03:32:39,499 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-fip_vn-69474501', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-fip_vn-69474501?flat'}
2026-03-09 03:32:39,499 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-fip_vn-69474501 virtual network link through opserver 10.0.0.249
2026-03-09 03:32:39,499 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-03-09 03:32:39,510 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-fip_vn-69474501', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-fip_vn-69474501?flat'}
2026-03-09 03:32:39,510 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-fip_vn-69474501 virtual network link through opserver 10.0.0.23
2026-03-09 03:32:39,510 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-03-09 03:32:39,522 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-fip_vn-69474501', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-fip_vn-69474501?flat'}
2026-03-09 03:32:39,522 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-fip_vn-69474501 is found in opserver
2026-03-09 03:32:39,538 - DEBUG - VRF ids for VN ctest-fip_vn-69474501: {'10.0.0.27': '3'}
2026-03-09 03:32:39,538 - INFO - start time= 1773027159538475
2026-03-09 03:32:39,538 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 26.90.46.3, host_string: cirros@169.254.0.3, password: gocubsgogateway: ubuntu@10.0.0.41, gateway password: c0ntrail123
2026-03-09 03:32:39,538 - DEBUG - ping -s 56 -c 3 -W 1 26.90.46.3
2026-03-09 03:32:43,405 - DEBUG - PING 26.90.46.3 (26.90.46.3): 56 data bytes
64 bytes from 26.90.46.3: seq=0 ttl=63 time=5.072 ms
64 bytes from 26.90.46.3: seq=1 ttl=63 time=1.123 ms
64 bytes from 26.90.46.3: seq=2 ttl=63 time=1.234 ms
--- 26.90.46.3 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.123/2.476/5.072 ms
2026-03-09 03:32:43,405 - INFO - Ping to IP 26.90.46.3 from VM ctest-vn1_vm1-19910401 passed
2026-03-09 03:32:53,405 - INFO - Verify session samples and teardown pkts
2026-03-09 03:32:53,406 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.22
2026-03-09 03:32:53,408 - DEBUG - Posting: http://10.0.0.22:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1773027159538475, 'end_time': 1773027173408906, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-03-09 03:32:54,431 - DEBUG - [{'T': 1773027161397800}, {'T': 1773027162397846}, {'T': 1773027163397913}]
2026-03-09 03:32:54,432 - DEBUG - Posting: http://10.0.0.22:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1773027159538475, 'end_time': 1773027174432090, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2026-03-09 03:32:55,450 - DEBUG - [{'T': 1773027161545083}, {'T': 1773027162545141}, {'T': 1773027163545247}]
2026-03-09 03:32:55,450 - DEBUG - Posting: http://10.0.0.22:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1773027159538475, 'end_time': 1773027175450378, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-03-09 03:32:56,471 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'sample_count': 3}]
2026-03-09 03:32:56,471 - INFO - wait for the flows to get expire
2026-03-09 03:36:16,472 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5454-1:Compute:contrail-vrouter-agent:0?flat
2026-03-09 03:36:16,510 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5454-1?flat
2026-03-09 03:36:16,544 - DEBUG - Posting: http://10.0.0.22:8081/analytics/query, payload {'table': 'SessionRecordTable', 'start_time': 1773027159538475, 'end_time': 1773027376544398, 'select_fields': ['vn', 'remote_vn', 'forward_teardown_pkts', 'reverse_teardown_pkts'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-03-09 03:36:17,564 - DEBUG - [{'forward_flow_uuid': 'aa4da90c-41b8-492e-b573-53a8514754a0', 'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'reverse_flow_uuid': 'ee1c0bfb-27fc-475f-917b-8de1b9efd2eb', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'forward_teardown_pkts': 3, 'reverse_teardown_pkts': 3}]
2026-03-09 03:36:17,564 - DEBUG - Posting: http://10.0.0.22:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1773027159538475, 'end_time': 1773027377564677, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-03-09 03:36:18,594 - DEBUG - Posting: http://10.0.0.22:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1773027159538475, 'end_time': 1773027378594235, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2026-03-09 03:36:19,615 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488', 'sample_count': 4}]
2026-03-09 03:36:20,106 - INFO - Deleted policy policy1
2026-03-09 03:36:20,220 - INFO - Setting flow export rate: None
2026-03-09 03:36:21,482 - DEBUG - Skipping xmpp flap check
2026-03-09 03:36:21,482 - INFO - END TEST : test_verify_session_sampling_teardown : PASSED[0:03:46]
2026-03-09 03:36:21,482 - INFO - --------------------------------------------------------------------------------
2026-03-09 03:36:21,484 - INFO - Deleting VM mltf_vm
2026-03-09 03:36:21,555 - INFO - Deleting VM ctest-fvn_vm1-05074292
2026-03-09 03:36:21,621 - INFO - Deleting VM ctest-vn2_vm2-66547651
2026-03-09 03:36:21,695 - INFO - Deleting VN ctest-fip_vn-69474501
2026-03-09 03:36:21,736 - DEBUG - VN 37549dac-7bab-45d3-b7a6-7a80804916f9 still in use: Unable to complete operation on network 37549dac-7bab-45d3-b7a6-7a80804916f9. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-43e084e3-8f60-410d-ac84-6d5b86bc434b']
2026-03-09 03:36:21,737 - WARNING - Deleting VN ctest-fip_vn-69474501 failed..Will retry
2026-03-09 03:36:23,949 - DEBUG - Response for deleting network ()
2026-03-09 03:36:23,949 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/ff9f291c-37e9-4d3a-933b-e863911adb89
2026-03-09 03:36:23,983 - DEBUG - Response Code: 404
2026-03-09 03:36:23,983 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-03-09 03:36:23,989 - DEBUG - Requesting: http://10.0.0.22:8082/domain/65872af6-2901-4194-bbe6-c1dbc9d32dc7
2026-03-09 03:36:24,001 - DEBUG - Requesting: http://10.0.0.22:8082/project/fddba498-40f4-4266-8657-724cd328a7e8
2026-03-09 03:36:24,103 - INFO - Validated that VN ctest-fip_vn-69474501 is not found in API Server
2026-03-09 03:36:24,113 - DEBUG - VN ctest-fip_vn-69474501 is not present in Agent 10.0.0.41
2026-03-09 03:36:24,122 - DEBUG - VN ctest-fip_vn-69474501 is not present in Agent 10.0.0.27
2026-03-09 03:36:24,122 - INFO - Validated that VN ctest-fip_vn-69474501 is not in any agent
2026-03-09 03:36:24,127 - DEBUG - VRF 3 is not seen in agent 10.0.0.27
2026-03-09 03:36:24,135 - DEBUG - Vrouter 10.0.0.27 does not have vrf 3 for VN ctest-fip_vn-69474501
2026-03-09 03:36:24,135 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-fip_vn-69474501
2026-03-09 03:36:24,158 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-69474501 info
2026-03-09 03:36:24,159 - INFO - Deleting VN ctest-vn2-10783488
2026-03-09 03:36:24,341 - DEBUG - Response for deleting network ()
2026-03-09 03:36:24,342 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/8b04236f-72e4-4356-b9a5-1bb2f2100f1e
2026-03-09 03:36:24,359 - DEBUG - Response Code: 404
2026-03-09 03:36:24,359 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-03-09 03:36:24,367 - DEBUG - Requesting: http://10.0.0.22:8082/domain/65872af6-2901-4194-bbe6-c1dbc9d32dc7
2026-03-09 03:36:24,420 - DEBUG - Requesting: http://10.0.0.22:8082/project/fddba498-40f4-4266-8657-724cd328a7e8
2026-03-09 03:36:24,501 - INFO - Validated that VN ctest-vn2-10783488 is not found in API Server
2026-03-09 03:36:24,512 - DEBUG - VN ctest-vn2-10783488 is not present in Agent 10.0.0.41
2026-03-09 03:36:24,529 - DEBUG - VN ctest-vn2-10783488 is not present in Agent 10.0.0.27
2026-03-09 03:36:24,529 - INFO - Validated that VN ctest-vn2-10783488 is not in any agent
2026-03-09 03:36:24,536 - DEBUG - VRF 3 is not seen in agent 10.0.0.41
2026-03-09 03:36:24,542 - DEBUG - Vrouter 10.0.0.41 does not have vrf 3 for VN ctest-vn2-10783488
2026-03-09 03:36:24,549 - DEBUG - VRF 2 is not seen in agent 10.0.0.27
2026-03-09 03:36:24,555 - DEBUG - Vrouter 10.0.0.27 does not have vrf 2 for VN ctest-vn2-10783488
2026-03-09 03:36:24,555 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn2-10783488
2026-03-09 03:36:24,578 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-10783488 info
2026-03-09 03:36:24,578 - INFO - Deleting VM ctest-vn1_vm2-60263572
2026-03-09 03:36:24,647 - INFO - Deleting VM ctest-vn1_vm1-19910401
2026-03-09 03:36:24,742 - INFO - Deleting VN ctest-vn1-02354139
2026-03-09 03:36:24,785 - DEBUG - VN 3a63fa71-bb28-49fd-a90b-69a88d36580e still in use: Unable to complete operation on network 3a63fa71-bb28-49fd-a90b-69a88d36580e. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-d57abeea-13e2-46e0-9206-860365814adb']
2026-03-09 03:36:24,786 - WARNING - Deleting VN ctest-vn1-02354139 failed..Will retry
2026-03-09 03:36:26,921 - DEBUG - Response for deleting network ()
2026-03-09 03:36:26,922 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/3fc3f6d6-c7f5-4a19-ad87-8795f81a7afe
2026-03-09 03:36:26,927 - DEBUG - Response Code: 404
2026-03-09 03:36:26,927 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2026-03-09 03:36:26,934 - DEBUG - Requesting: http://10.0.0.22:8082/domain/65872af6-2901-4194-bbe6-c1dbc9d32dc7
2026-03-09 03:36:26,948 - DEBUG - Requesting: http://10.0.0.22:8082/project/fddba498-40f4-4266-8657-724cd328a7e8
2026-03-09 03:36:27,033 - INFO - Validated that VN ctest-vn1-02354139 is not found in API Server
2026-03-09 03:36:27,045 - DEBUG - VN ctest-vn1-02354139 is not present in Agent 10.0.0.41
2026-03-09 03:36:27,054 - DEBUG - VN ctest-vn1-02354139 is not present in Agent 10.0.0.27
2026-03-09 03:36:27,054 - INFO - Validated that VN ctest-vn1-02354139 is not in any agent
2026-03-09 03:36:27,059 - DEBUG - VRF 2 is not seen in agent 10.0.0.41
2026-03-09 03:36:27,065 - DEBUG - Vrouter 10.0.0.41 does not have vrf 2 for VN ctest-vn1-02354139
2026-03-09 03:36:27,065 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-88828308:ctest-vn1-02354139
2026-03-09 03:36:27,085 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-02354139 info
2026-03-09 03:36:27,890 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-88828308, ID : fddba498-40f4-4266-8657-724cd328a7e8