is in ACTIVE state now
2025-09-22 03:39:21,972 - INFO - VM name : mltf_vm
2025-09-22 03:39:22,050 - DEBUG - VM mltf_vm ID is 6c73a806-fced-4719-9af5-188b582652ad
2025-09-22 03:39:22,050 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-4159-2
2025-09-22 03:39:22,201 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/6c73a806-fced-4719-9af5-188b582652ad
2025-09-22 03:39:22,214 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/5e3723e0-0451-43f2-bcb0-f799f1014e8f
2025-09-22 03:39:22,223 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/f180650e-7aa5-4a20-ae28-061bc6b15fee
2025-09-22 03:39:23,391 - 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.96 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.403 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.403/1.182/1.962/0.779 ms')
2025-09-22 03:39:23,391 - INFO - Ping to Metadata IP 169.254.0.5 of VM mltf_vm passed
2025-09-22 03:39:23,461 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-09-22 03:39:23,461 - DEBUG - Waiting to SSH to VM mltf_vm, IP 117.40.29.5, Port 22
2025-09-22 03:39:23,621 - DEBUG - VM mltf_vm is ready for SSH connections
2025-09-22 03:39:23,690 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-09-22 03:39:23,690 - DEBUG - Waiting to SSH to VM mltf_vm, IP 117.40.29.5, Port 22
2025-09-22 03:39:23,857 - DEBUG - VM mltf_vm is ready for SSH connections
2025-09-22 03:39:23,859 - INFO - ================================================================================
2025-09-22 03:39:23,859 - INFO - STARTING TEST : test_verify_session_sampling_teardown
2025-09-22 03:39:23,859 - 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
2025-09-22 03:39:25,138 - DEBUG - Skipping xmpp flap check
2025-09-22 03:39:25,138 - INFO - Initial checks done. Running the testcase now
2025-09-22 03:39:25,138 - INFO -
2025-09-22 03:39:25,264 - INFO - Setting flow export rate: 100
2025-09-22 03:39:25,312 - 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]
2025-09-22 03:39:25,662 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '8bca0d1b-34f6-4e12-9c1e-a7be1c789502', 'name': 'ctest-vn1-53202659', 'tenant_id': '4ba4e14d27754e328dff6eb1789bce1e', 'project_id': '4ba4e14d27754e328dff6eb1789bce1e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['f033c0aa-8a73-42ce-b3ba-5c5cb0b4434a'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-69437745', 'ctest-vn1-53202659'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-69437745', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '117.40.29.0/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-09-22 03:39:25,853 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'cb4138e2-1085-480a-b5e8-3badc2678f44', 'name': 'ctest-vn2-26233083', 'tenant_id': '4ba4e14d27754e328dff6eb1789bce1e', 'project_id': '4ba4e14d27754e328dff6eb1789bce1e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['e0ebe7ad-9921-442e-92a8-b6756d261c88'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-69437745', 'ctest-vn2-26233083'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-69437745', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '103.133.101.128/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-09-22 03:39:25,943 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-09-22 03:39:25,948 - DEBUG - Requesting: http://10.0.0.56:8082/domain/ccce3d88-d117-4380-892c-193ef8fcc90d
2025-09-22 03:39:25,979 - DEBUG - Requesting: http://10.0.0.56:8082/project/4ba4e14d-2775-4e32-8dff-6eb1789bce1e
2025-09-22 03:39:26,080 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/8bca0d1b-34f6-4e12-9c1e-a7be1c789502
2025-09-22 03:39:26,097 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/8bca0d1b-34f6-4e12-9c1e-a7be1c789502
2025-09-22 03:39:26,107 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/7d878a16-22bd-426f-85ab-65a54264e93a
2025-09-22 03:39:26,116 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/7d878a16-22bd-426f-85ab-65a54264e93a
2025-09-22 03:39:26,124 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/30051801-495c-447c-89e6-d3a7ed756def
2025-09-22 03:39:26,131 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-22 03:39:26,132 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/8bca0d1b-34f6-4e12-9c1e-a7be1c789502
2025-09-22 03:39:26,180 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/7d878a16-22bd-426f-85ab-65a54264e93a
2025-09-22 03:39:26,199 - INFO - Verified VN network id 12 for VN 8bca0d1b-34f6-4e12-9c1e-a7be1c789502
2025-09-22 03:39:26,200 - INFO - Verifications in API Server for VN ctest-vn1-53202659 passed
2025-09-22 03:39:26,200 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/8bca0d1b-34f6-4e12-9c1e-a7be1c789502
2025-09-22 03:39:26,214 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/7d878a16-22bd-426f-85ab-65a54264e93a
2025-09-22 03:39:26,225 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/7d878a16-22bd-426f-85ab-65a54264e93a
2025-09-22 03:39:26,233 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/30051801-495c-447c-89e6-d3a7ed756def
2025-09-22 03:39:26,261 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-69437745', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10072877927071370770', 'uuid-lslong': '11249613354181367042'}, 'enable': 'true', 'created': '2025-09-22T03:37:56', 'last-modified': '2025-09-22T03:39:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.626680'}
2025-09-22 03:39:26,273 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-22 03:39:26,279 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-69437745', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10072877927071370770', 'uuid-lslong': '11249613354181367042'}, 'enable': 'true', 'created': '2025-09-22T03:37:56', 'last-modified': '2025-09-22T03:39:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.651926'}
2025-09-22 03:39:26,286 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-22 03:39:26,312 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-69437745', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10072877927071370770', 'uuid-lslong': '11249613354181367042'}, 'enable': 'true', 'created': '2025-09-22T03:37:56', 'last-modified': '2025-09-22T03:39:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.670686'}
2025-09-22 03:39:26,325 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-22 03:39:26,325 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-53202659 passed
2025-09-22 03:39:26,326 - DEBUG - ====Verifying policy data for ctest-vn1-53202659 in API_Server ======
2025-09-22 03:39:26,326 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-09-22 03:39:26,338 - DEBUG - Requesting: http://10.0.0.56:8082/domain/ccce3d88-d117-4380-892c-193ef8fcc90d
2025-09-22 03:39:26,354 - DEBUG - Requesting: http://10.0.0.56:8082/project/4ba4e14d-2775-4e32-8dff-6eb1789bce1e
2025-09-22 03:39:26,443 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/8bca0d1b-34f6-4e12-9c1e-a7be1c789502
2025-09-22 03:39:26,453 - DEBUG - ==>Verifying data for policy with id: 1666a49a-5a5a-4313-a91d-da7eb4e39163, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-69437745', 'policy1']
2025-09-22 03:39:26,453 - INFO - VN ctest-vn1-53202659 Policy verification: verify_vn_policy_in_api_server, status: True
2025-09-22 03:39:26,453 - DEBUG - Verifying the vn in opserver
2025-09-22 03:39:26,453 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659 virtual network link through opserver 10.0.0.56
2025-09-22 03:39:26,453 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-09-22 03:39:26,465 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659?flat'}
2025-09-22 03:39:26,465 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659 virtual network link through opserver 10.0.0.38
2025-09-22 03:39:26,465 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-09-22 03:39:26,478 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659?flat'}
2025-09-22 03:39:26,478 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659 virtual network link through opserver 10.0.0.27
2025-09-22 03:39:26,478 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-09-22 03:39:26,491 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659?flat'}
2025-09-22 03:39:26,491 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659 is found in opserver
2025-09-22 03:39:26,501 - DEBUG - VRF ids for VN ctest-vn1-53202659: {'10.0.0.23': '2'}
2025-09-22 03:39:26,501 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-09-22 03:39:26,507 - DEBUG - Requesting: http://10.0.0.56:8082/domain/ccce3d88-d117-4380-892c-193ef8fcc90d
2025-09-22 03:39:26,520 - DEBUG - Requesting: http://10.0.0.56:8082/project/4ba4e14d-2775-4e32-8dff-6eb1789bce1e
2025-09-22 03:39:26,609 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/cb4138e2-1085-480a-b5e8-3badc2678f44
2025-09-22 03:39:26,621 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/cb4138e2-1085-480a-b5e8-3badc2678f44
2025-09-22 03:39:26,631 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/bab298b6-2329-42e1-976b-50245e0a9145
2025-09-22 03:39:26,640 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/bab298b6-2329-42e1-976b-50245e0a9145
2025-09-22 03:39:26,647 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/d99a190d-4c85-4e1e-952d-d690a14ba87f
2025-09-22 03:39:26,653 - DEBUG - Route Targets: ['target:64512:8000005']
2025-09-22 03:39:26,653 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/cb4138e2-1085-480a-b5e8-3badc2678f44
2025-09-22 03:39:26,661 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/bab298b6-2329-42e1-976b-50245e0a9145
2025-09-22 03:39:26,676 - INFO - Verified VN network id 13 for VN cb4138e2-1085-480a-b5e8-3badc2678f44
2025-09-22 03:39:26,676 - INFO - Verifications in API Server for VN ctest-vn2-26233083 passed
2025-09-22 03:39:26,676 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/cb4138e2-1085-480a-b5e8-3badc2678f44
2025-09-22 03:39:26,685 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/bab298b6-2329-42e1-976b-50245e0a9145
2025-09-22 03:39:26,691 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/bab298b6-2329-42e1-976b-50245e0a9145
2025-09-22 03:39:26,698 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/d99a190d-4c85-4e1e-952d-d690a14ba87f
2025-09-22 03:39:26,708 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-69437745', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14646050006776498186', 'uuid-lslong': '13107792332938776388'}, 'enable': 'true', 'created': '2025-09-22T03:38:33', 'last-modified': '2025-09-22T03:39:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.895018'}
2025-09-22 03:39:26,714 - DEBUG - Route Targets: ['target:64512:8000005']
2025-09-22 03:39:26,718 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-69437745', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14646050006776498186', 'uuid-lslong': '13107792332938776388'}, 'enable': 'true', 'created': '2025-09-22T03:38:33', 'last-modified': '2025-09-22T03:39:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.906998'}
2025-09-22 03:39:26,725 - DEBUG - Route Targets: ['target:64512:8000005']
2025-09-22 03:39:26,729 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-69437745', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14646050006776498186', 'uuid-lslong': '13107792332938776388'}, 'enable': 'true', 'created': '2025-09-22T03:38:33', 'last-modified': '2025-09-22T03:39:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.910286'}
2025-09-22 03:39:26,735 - DEBUG - Route Targets: ['target:64512:8000005']
2025-09-22 03:39:26,735 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-26233083 passed
2025-09-22 03:39:26,735 - DEBUG - ====Verifying policy data for ctest-vn2-26233083 in API_Server ======
2025-09-22 03:39:26,735 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-09-22 03:39:26,740 - DEBUG - Requesting: http://10.0.0.56:8082/domain/ccce3d88-d117-4380-892c-193ef8fcc90d
2025-09-22 03:39:26,750 - DEBUG - Requesting: http://10.0.0.56:8082/project/4ba4e14d-2775-4e32-8dff-6eb1789bce1e
2025-09-22 03:39:26,847 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/cb4138e2-1085-480a-b5e8-3badc2678f44
2025-09-22 03:39:26,860 - DEBUG - ==>Verifying data for policy with id: 1666a49a-5a5a-4313-a91d-da7eb4e39163, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-69437745', 'policy1']
2025-09-22 03:39:26,860 - INFO - VN ctest-vn2-26233083 Policy verification: verify_vn_policy_in_api_server, status: True
2025-09-22 03:39:26,860 - DEBUG - Verifying the vn in opserver
2025-09-22 03:39:26,861 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083 virtual network link through opserver 10.0.0.56
2025-09-22 03:39:26,861 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-09-22 03:39:26,872 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083?flat'}
2025-09-22 03:39:26,872 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083 virtual network link through opserver 10.0.0.38
2025-09-22 03:39:26,872 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-09-22 03:39:26,886 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083?flat'}
2025-09-22 03:39:26,886 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083 virtual network link through opserver 10.0.0.27
2025-09-22 03:39:26,886 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-09-22 03:39:26,897 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083?flat'}
2025-09-22 03:39:26,897 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083 is found in opserver
2025-09-22 03:39:26,907 - DEBUG - VRF ids for VN ctest-vn2-26233083: {'10.0.0.33': '2', '10.0.0.23': '3'}
2025-09-22 03:39:26,908 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-09-22 03:39:26,913 - DEBUG - Requesting: http://10.0.0.56:8082/domain/ccce3d88-d117-4380-892c-193ef8fcc90d
2025-09-22 03:39:26,924 - DEBUG - Requesting: http://10.0.0.56:8082/project/4ba4e14d-2775-4e32-8dff-6eb1789bce1e
2025-09-22 03:39:27,029 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/8bca0d1b-34f6-4e12-9c1e-a7be1c789502
2025-09-22 03:39:27,039 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/8bca0d1b-34f6-4e12-9c1e-a7be1c789502
2025-09-22 03:39:27,049 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/7d878a16-22bd-426f-85ab-65a54264e93a
2025-09-22 03:39:27,059 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/7d878a16-22bd-426f-85ab-65a54264e93a
2025-09-22 03:39:27,069 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/30051801-495c-447c-89e6-d3a7ed756def
2025-09-22 03:39:27,075 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-22 03:39:27,075 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/8bca0d1b-34f6-4e12-9c1e-a7be1c789502
2025-09-22 03:39:27,085 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/7d878a16-22bd-426f-85ab-65a54264e93a
2025-09-22 03:39:27,101 - INFO - Verified VN network id 12 for VN 8bca0d1b-34f6-4e12-9c1e-a7be1c789502
2025-09-22 03:39:27,101 - INFO - Verifications in API Server for VN ctest-vn1-53202659 passed
2025-09-22 03:39:27,101 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/8bca0d1b-34f6-4e12-9c1e-a7be1c789502
2025-09-22 03:39:27,110 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/7d878a16-22bd-426f-85ab-65a54264e93a
2025-09-22 03:39:27,118 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/7d878a16-22bd-426f-85ab-65a54264e93a
2025-09-22 03:39:27,124 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/30051801-495c-447c-89e6-d3a7ed756def
2025-09-22 03:39:27,134 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-69437745', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10072877927071370770', 'uuid-lslong': '11249613354181367042'}, 'enable': 'true', 'created': '2025-09-22T03:37:56', 'last-modified': '2025-09-22T03:39:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.500006'}
2025-09-22 03:39:27,139 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-22 03:39:27,145 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-69437745', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10072877927071370770', 'uuid-lslong': '11249613354181367042'}, 'enable': 'true', 'created': '2025-09-22T03:37:56', 'last-modified': '2025-09-22T03:39:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.517445'}
2025-09-22 03:39:27,152 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-22 03:39:27,158 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-69437745', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10072877927071370770', 'uuid-lslong': '11249613354181367042'}, 'enable': 'true', 'created': '2025-09-22T03:37:56', 'last-modified': '2025-09-22T03:39:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.530848'}
2025-09-22 03:39:27,164 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-22 03:39:27,164 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-53202659 passed
2025-09-22 03:39:27,164 - DEBUG - ====Verifying policy data for ctest-vn1-53202659 in API_Server ======
2025-09-22 03:39:27,164 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-09-22 03:39:27,170 - DEBUG - Requesting: http://10.0.0.56:8082/domain/ccce3d88-d117-4380-892c-193ef8fcc90d
2025-09-22 03:39:27,180 - DEBUG - Requesting: http://10.0.0.56:8082/project/4ba4e14d-2775-4e32-8dff-6eb1789bce1e
2025-09-22 03:39:27,276 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/8bca0d1b-34f6-4e12-9c1e-a7be1c789502
2025-09-22 03:39:27,289 - DEBUG - ==>Verifying data for policy with id: 1666a49a-5a5a-4313-a91d-da7eb4e39163, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-69437745', 'policy1']
2025-09-22 03:39:27,289 - INFO - VN ctest-vn1-53202659 Policy verification: verify_vn_policy_in_api_server, status: True
2025-09-22 03:39:27,289 - DEBUG - Verifying the vn in opserver
2025-09-22 03:39:27,289 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659 virtual network link through opserver 10.0.0.56
2025-09-22 03:39:27,289 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-09-22 03:39:27,304 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659?flat'}
2025-09-22 03:39:27,304 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659 virtual network link through opserver 10.0.0.38
2025-09-22 03:39:27,304 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-09-22 03:39:27,318 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659?flat'}
2025-09-22 03:39:27,318 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659 virtual network link through opserver 10.0.0.27
2025-09-22 03:39:27,318 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-09-22 03:39:27,331 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659?flat'}
2025-09-22 03:39:27,331 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659 is found in opserver
2025-09-22 03:39:27,341 - DEBUG - VRF ids for VN ctest-vn1-53202659: {'10.0.0.23': '2'}
2025-09-22 03:39:27,342 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-09-22 03:39:27,350 - DEBUG - Requesting: http://10.0.0.56:8082/domain/ccce3d88-d117-4380-892c-193ef8fcc90d
2025-09-22 03:39:27,360 - DEBUG - Requesting: http://10.0.0.56:8082/project/4ba4e14d-2775-4e32-8dff-6eb1789bce1e
2025-09-22 03:39:27,455 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/cb4138e2-1085-480a-b5e8-3badc2678f44
2025-09-22 03:39:27,464 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/cb4138e2-1085-480a-b5e8-3badc2678f44
2025-09-22 03:39:27,472 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/bab298b6-2329-42e1-976b-50245e0a9145
2025-09-22 03:39:27,479 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/bab298b6-2329-42e1-976b-50245e0a9145
2025-09-22 03:39:27,485 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/d99a190d-4c85-4e1e-952d-d690a14ba87f
2025-09-22 03:39:27,490 - DEBUG - Route Targets: ['target:64512:8000005']
2025-09-22 03:39:27,490 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/cb4138e2-1085-480a-b5e8-3badc2678f44
2025-09-22 03:39:27,498 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/bab298b6-2329-42e1-976b-50245e0a9145
2025-09-22 03:39:27,512 - INFO - Verified VN network id 13 for VN cb4138e2-1085-480a-b5e8-3badc2678f44
2025-09-22 03:39:27,512 - INFO - Verifications in API Server for VN ctest-vn2-26233083 passed
2025-09-22 03:39:27,512 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/cb4138e2-1085-480a-b5e8-3badc2678f44
2025-09-22 03:39:27,520 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/bab298b6-2329-42e1-976b-50245e0a9145
2025-09-22 03:39:27,526 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/bab298b6-2329-42e1-976b-50245e0a9145
2025-09-22 03:39:27,533 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/d99a190d-4c85-4e1e-952d-d690a14ba87f
2025-09-22 03:39:27,543 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-69437745', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14646050006776498186', 'uuid-lslong': '13107792332938776388'}, 'enable': 'true', 'created': '2025-09-22T03:38:33', 'last-modified': '2025-09-22T03:39:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.729960'}
2025-09-22 03:39:27,548 - DEBUG - Route Targets: ['target:64512:8000005']
2025-09-22 03:39:27,554 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-69437745', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14646050006776498186', 'uuid-lslong': '13107792332938776388'}, 'enable': 'true', 'created': '2025-09-22T03:38:33', 'last-modified': '2025-09-22T03:39:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.741930'}
2025-09-22 03:39:27,560 - DEBUG - Route Targets: ['target:64512:8000005']
2025-09-22 03:39:27,565 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-69437745', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14646050006776498186', 'uuid-lslong': '13107792332938776388'}, 'enable': 'true', 'created': '2025-09-22T03:38:33', 'last-modified': '2025-09-22T03:39:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.745704'}
2025-09-22 03:39:27,571 - DEBUG - Route Targets: ['target:64512:8000005']
2025-09-22 03:39:27,571 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-26233083 passed
2025-09-22 03:39:27,571 - DEBUG - ====Verifying policy data for ctest-vn2-26233083 in API_Server ======
2025-09-22 03:39:27,571 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-09-22 03:39:27,577 - DEBUG - Requesting: http://10.0.0.56:8082/domain/ccce3d88-d117-4380-892c-193ef8fcc90d
2025-09-22 03:39:27,586 - DEBUG - Requesting: http://10.0.0.56:8082/project/4ba4e14d-2775-4e32-8dff-6eb1789bce1e
2025-09-22 03:39:27,672 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/cb4138e2-1085-480a-b5e8-3badc2678f44
2025-09-22 03:39:27,682 - DEBUG - ==>Verifying data for policy with id: 1666a49a-5a5a-4313-a91d-da7eb4e39163, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-69437745', 'policy1']
2025-09-22 03:39:27,682 - INFO - VN ctest-vn2-26233083 Policy verification: verify_vn_policy_in_api_server, status: True
2025-09-22 03:39:27,682 - DEBUG - Verifying the vn in opserver
2025-09-22 03:39:27,682 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083 virtual network link through opserver 10.0.0.56
2025-09-22 03:39:27,682 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-09-22 03:39:27,693 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083?flat'}
2025-09-22 03:39:27,693 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083 virtual network link through opserver 10.0.0.38
2025-09-22 03:39:27,693 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-09-22 03:39:27,707 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083?flat'}
2025-09-22 03:39:27,707 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083 virtual network link through opserver 10.0.0.27
2025-09-22 03:39:27,707 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-09-22 03:39:27,719 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083?flat'}
2025-09-22 03:39:27,719 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083 is found in opserver
2025-09-22 03:39:27,729 - DEBUG - VRF ids for VN ctest-vn2-26233083: {'10.0.0.33': '2', '10.0.0.23': '3'}
2025-09-22 03:39:27,729 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-09-22 03:39:27,735 - DEBUG - Requesting: http://10.0.0.56:8082/domain/ccce3d88-d117-4380-892c-193ef8fcc90d
2025-09-22 03:39:27,744 - DEBUG - Requesting: http://10.0.0.56:8082/project/4ba4e14d-2775-4e32-8dff-6eb1789bce1e
2025-09-22 03:39:27,835 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/38ea379b-5a68-4efe-b818-3039944ba2c6
2025-09-22 03:39:27,844 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/38ea379b-5a68-4efe-b818-3039944ba2c6
2025-09-22 03:39:27,852 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/3cb2c314-bf00-4fc8-b172-d2be6f0cf6f9
2025-09-22 03:39:27,858 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/3cb2c314-bf00-4fc8-b172-d2be6f0cf6f9
2025-09-22 03:39:27,864 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/55e08a41-9f16-4fe9-a24d-a9debf41986e
2025-09-22 03:39:27,870 - DEBUG - Route Targets: ['target:64512:8000006']
2025-09-22 03:39:27,870 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/38ea379b-5a68-4efe-b818-3039944ba2c6
2025-09-22 03:39:27,878 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/3cb2c314-bf00-4fc8-b172-d2be6f0cf6f9
2025-09-22 03:39:27,893 - INFO - Verified VN network id 14 for VN 38ea379b-5a68-4efe-b818-3039944ba2c6
2025-09-22 03:39:27,893 - INFO - Verifications in API Server for VN ctest-fip_vn-13600869 passed
2025-09-22 03:39:27,893 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/38ea379b-5a68-4efe-b818-3039944ba2c6
2025-09-22 03:39:27,902 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/3cb2c314-bf00-4fc8-b172-d2be6f0cf6f9
2025-09-22 03:39:27,908 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/3cb2c314-bf00-4fc8-b172-d2be6f0cf6f9
2025-09-22 03:39:27,915 - DEBUG - Requesting: http://10.0.0.56:8082/route-target/55e08a41-9f16-4fe9-a24d-a9debf41986e
2025-09-22 03:39:27,926 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-fip_vn-13600869', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-69437745', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4101151551050501886', 'uuid-lslong': '13265405726279049926'}, 'enable': 'true', 'created': '2025-09-22T03:38:33', 'last-modified': '2025-09-22T03:38:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:53.935786'}
2025-09-22 03:39:27,932 - DEBUG - Route Targets: ['target:64512:8000006']
2025-09-22 03:39:27,939 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-fip_vn-13600869', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-69437745', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4101151551050501886', 'uuid-lslong': '13265405726279049926'}, 'enable': 'true', 'created': '2025-09-22T03:38:33', 'last-modified': '2025-09-22T03:38:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:53.952186'}
2025-09-22 03:39:27,948 - DEBUG - Route Targets: ['target:64512:8000006']
2025-09-22 03:39:27,954 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-fip_vn-13600869', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-69437745', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4101151551050501886', 'uuid-lslong': '13265405726279049926'}, 'enable': 'true', 'created': '2025-09-22T03:38:33', 'last-modified': '2025-09-22T03:38:33', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:53.955555'}
2025-09-22 03:39:27,961 - DEBUG - Route Targets: ['target:64512:8000006']
2025-09-22 03:39:27,961 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-13600869 passed
2025-09-22 03:39:27,961 - DEBUG - ====Verifying policy data for ctest-fip_vn-13600869 in API_Server ======
2025-09-22 03:39:27,961 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-09-22 03:39:27,967 - DEBUG - Requesting: http://10.0.0.56:8082/domain/ccce3d88-d117-4380-892c-193ef8fcc90d
2025-09-22 03:39:27,976 - DEBUG - Requesting: http://10.0.0.56:8082/project/4ba4e14d-2775-4e32-8dff-6eb1789bce1e
2025-09-22 03:39:28,072 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-network/38ea379b-5a68-4efe-b818-3039944ba2c6
2025-09-22 03:39:28,082 - DEBUG - =>VN ctest-fip_vn-13600869 has no policy to be verified
2025-09-22 03:39:28,082 - DEBUG - Verifying the vn in opserver
2025-09-22 03:39:28,082 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-fip_vn-13600869 virtual network link through opserver 10.0.0.56
2025-09-22 03:39:28,082 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-09-22 03:39:28,092 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-fip_vn-13600869', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-fip_vn-13600869?flat'}
2025-09-22 03:39:28,092 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-fip_vn-13600869 virtual network link through opserver 10.0.0.38
2025-09-22 03:39:28,092 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-09-22 03:39:28,104 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-fip_vn-13600869', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-fip_vn-13600869?flat'}
2025-09-22 03:39:28,104 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-fip_vn-13600869 virtual network link through opserver 10.0.0.27
2025-09-22 03:39:28,104 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-09-22 03:39:28,115 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-fip_vn-13600869', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-fip_vn-13600869?flat'}
2025-09-22 03:39:28,115 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-fip_vn-13600869 is found in opserver
2025-09-22 03:39:28,124 - DEBUG - VRF ids for VN ctest-fip_vn-13600869: {'10.0.0.33': '3'}
2025-09-22 03:39:28,124 - INFO - start time= 1758512368124116
2025-09-22 03:39:28,124 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 103.133.101.131, host_string: cirros@169.254.0.3, password: gocubsgogateway: ubuntu@10.0.0.23, gateway password: c0ntrail123
2025-09-22 03:39:28,124 - DEBUG - ping -s 56 -c 3 -W 1 103.133.101.131
2025-09-22 03:39:31,687 - DEBUG - PING 103.133.101.131 (103.133.101.131): 56 data bytes
64 bytes from 103.133.101.131: seq=0 ttl=63 time=4.166 ms
64 bytes from 103.133.101.131: seq=1 ttl=63 time=1.380 ms
64 bytes from 103.133.101.131: seq=2 ttl=63 time=1.344 ms
--- 103.133.101.131 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.344/2.296/4.166 ms
2025-09-22 03:39:31,687 - INFO - Ping to IP 103.133.101.131 from VM ctest-vn1_vm1-44433323 passed
2025-09-22 03:39:41,688 - INFO - Verify session samples and teardown pkts
2025-09-22 03:39:41,688 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.56
2025-09-22 03:39:41,691 - DEBUG - Posting: http://10.0.0.56:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1758512368124116, 'end_time': 1758512381691426, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-09-22 03:39:42,712 - DEBUG - [{'T': 1758512370378508}, {'T': 1758512371378549}, {'T': 1758512372378649}]
2025-09-22 03:39:42,712 - DEBUG - Posting: http://10.0.0.56:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1758512368124116, 'end_time': 1758512382712282, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-09-22 03:39:43,732 - DEBUG - [{'T': 1758512370314542}, {'T': 1758512371314617}, {'T': 1758512372314716}]
2025-09-22 03:39:43,732 - DEBUG - Posting: http://10.0.0.56:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1758512368124116, 'end_time': 1758512383732232, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-09-22 03:39:44,752 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'sample_count': 3}]
2025-09-22 03:39:44,752 - INFO - wait for the flows to get expire
2025-09-22 03:43:04,753 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4159-2:Compute:contrail-vrouter-agent:0?flat
2025-09-22 03:43:04,830 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4159-2?flat
2025-09-22 03:43:04,861 - DEBUG - Posting: http://10.0.0.56:8081/analytics/query, payload {'table': 'SessionRecordTable', 'start_time': 1758512368124116, 'end_time': 1758512584861258, 'select_fields': ['vn', 'remote_vn', 'forward_teardown_pkts', 'reverse_teardown_pkts'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-09-22 03:43:05,891 - DEBUG - [{'forward_flow_uuid': 'bc12a03a-758c-4906-93e5-93884a75dafe', 'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'reverse_flow_uuid': '4c6146e6-b052-4a2f-8d35-9c0cb163cae1', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'forward_teardown_pkts': 3, 'reverse_teardown_pkts': 3}]
2025-09-22 03:43:05,891 - DEBUG - Posting: http://10.0.0.56:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1758512368124116, 'end_time': 1758512585891732, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-09-22 03:43:06,911 - DEBUG - Posting: http://10.0.0.56:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1758512368124116, 'end_time': 1758512586911169, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-09-22 03:43:07,933 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083', 'sample_count': 4}]
2025-09-22 03:43:08,434 - INFO - Deleted policy policy1
2025-09-22 03:43:08,552 - INFO - Setting flow export rate: None
2025-09-22 03:43:09,843 - DEBUG - Skipping xmpp flap check
2025-09-22 03:43:09,843 - INFO - END TEST : test_verify_session_sampling_teardown : PASSED[0:03:46]
2025-09-22 03:43:09,843 - INFO - --------------------------------------------------------------------------------
2025-09-22 03:43:09,845 - INFO - Deleting VM mltf_vm
2025-09-22 03:43:09,911 - INFO - Deleting VM ctest-fvn_vm1-76680717
2025-09-22 03:43:09,974 - INFO - Deleting VM ctest-vn2_vm2-19031929
2025-09-22 03:43:10,046 - INFO - Deleting VN ctest-fip_vn-13600869
2025-09-22 03:43:10,092 - DEBUG - VN 38ea379b-5a68-4efe-b818-3039944ba2c6 still in use: Unable to complete operation on network 38ea379b-5a68-4efe-b818-3039944ba2c6. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-064c1218-532a-4884-9568-1b8867f5498d']
2025-09-22 03:43:10,092 - WARNING - Deleting VN ctest-fip_vn-13600869 failed..Will retry
2025-09-22 03:43:12,287 - DEBUG - Response for deleting network ()
2025-09-22 03:43:12,287 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/3cb2c314-bf00-4fc8-b172-d2be6f0cf6f9
2025-09-22 03:43:12,331 - DEBUG - Response Code: 404
2025-09-22 03:43:12,332 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-09-22 03:43:12,337 - DEBUG - Requesting: http://10.0.0.56:8082/domain/ccce3d88-d117-4380-892c-193ef8fcc90d
2025-09-22 03:43:12,348 - DEBUG - Requesting: http://10.0.0.56:8082/project/4ba4e14d-2775-4e32-8dff-6eb1789bce1e
2025-09-22 03:43:12,447 - INFO - Validated that VN ctest-fip_vn-13600869 is not found in API Server
2025-09-22 03:43:12,458 - DEBUG - VN ctest-fip_vn-13600869 is not present in Agent 10.0.0.33
2025-09-22 03:43:12,468 - DEBUG - VN ctest-fip_vn-13600869 is not present in Agent 10.0.0.23
2025-09-22 03:43:12,468 - INFO - Validated that VN ctest-fip_vn-13600869 is not in any agent
2025-09-22 03:43:12,473 - DEBUG - VRF 3 is not seen in agent 10.0.0.33
2025-09-22 03:43:12,479 - DEBUG - Vrouter 10.0.0.33 does not have vrf 3 for VN ctest-fip_vn-13600869
2025-09-22 03:43:12,479 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-fip_vn-13600869
2025-09-22 03:43:12,502 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-13600869 info
2025-09-22 03:43:12,502 - INFO - Deleting VN ctest-vn2-26233083
2025-09-22 03:43:12,675 - DEBUG - Response for deleting network ()
2025-09-22 03:43:12,675 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/bab298b6-2329-42e1-976b-50245e0a9145
2025-09-22 03:43:12,681 - DEBUG - Response Code: 404
2025-09-22 03:43:12,682 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-09-22 03:43:12,688 - DEBUG - Requesting: http://10.0.0.56:8082/domain/ccce3d88-d117-4380-892c-193ef8fcc90d
2025-09-22 03:43:12,705 - DEBUG - Requesting: http://10.0.0.56:8082/project/4ba4e14d-2775-4e32-8dff-6eb1789bce1e
2025-09-22 03:43:12,800 - INFO - Validated that VN ctest-vn2-26233083 is not found in API Server
2025-09-22 03:43:12,813 - DEBUG - VN ctest-vn2-26233083 is not present in Agent 10.0.0.33
2025-09-22 03:43:12,822 - DEBUG - VN ctest-vn2-26233083 is not present in Agent 10.0.0.23
2025-09-22 03:43:12,822 - INFO - Validated that VN ctest-vn2-26233083 is not in any agent
2025-09-22 03:43:12,828 - DEBUG - VRF 2 is not seen in agent 10.0.0.33
2025-09-22 03:43:12,832 - DEBUG - Vrouter 10.0.0.33 does not have vrf 2 for VN ctest-vn2-26233083
2025-09-22 03:43:12,837 - DEBUG - VRF 3 is not seen in agent 10.0.0.23
2025-09-22 03:43:12,841 - DEBUG - Vrouter 10.0.0.23 does not have vrf 3 for VN ctest-vn2-26233083
2025-09-22 03:43:12,841 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn2-26233083
2025-09-22 03:43:12,863 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-26233083 info
2025-09-22 03:43:12,864 - INFO - Deleting VM ctest-vn1_vm2-03092563
2025-09-22 03:43:12,925 - INFO - Deleting VM ctest-vn1_vm1-44433323
2025-09-22 03:43:12,980 - INFO - Deleting VN ctest-vn1-53202659
2025-09-22 03:43:13,028 - DEBUG - VN 8bca0d1b-34f6-4e12-9c1e-a7be1c789502 still in use: Unable to complete operation on network 8bca0d1b-34f6-4e12-9c1e-a7be1c789502. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-53920618-2661-4d85-b720-6de82277f966']
2025-09-22 03:43:13,028 - WARNING - Deleting VN ctest-vn1-53202659 failed..Will retry
2025-09-22 03:43:15,206 - DEBUG - Response for deleting network ()
2025-09-22 03:43:15,206 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/7d878a16-22bd-426f-85ab-65a54264e93a
2025-09-22 03:43:15,217 - DEBUG - Response Code: 404
2025-09-22 03:43:15,218 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-09-22 03:43:15,234 - DEBUG - Requesting: http://10.0.0.56:8082/domain/ccce3d88-d117-4380-892c-193ef8fcc90d
2025-09-22 03:43:15,285 - DEBUG - Requesting: http://10.0.0.56:8082/project/4ba4e14d-2775-4e32-8dff-6eb1789bce1e
2025-09-22 03:43:15,376 - INFO - Validated that VN ctest-vn1-53202659 is not found in API Server
2025-09-22 03:43:15,386 - DEBUG - VN ctest-vn1-53202659 is not present in Agent 10.0.0.33
2025-09-22 03:43:15,396 - DEBUG - VN ctest-vn1-53202659 is not present in Agent 10.0.0.23
2025-09-22 03:43:15,396 - INFO - Validated that VN ctest-vn1-53202659 is not in any agent
2025-09-22 03:43:15,400 - DEBUG - VRF 2 is not seen in agent 10.0.0.23
2025-09-22 03:43:15,404 - DEBUG - Vrouter 10.0.0.23 does not have vrf 2 for VN ctest-vn1-53202659
2025-09-22 03:43:15,404 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-69437745:ctest-vn1-53202659
2025-09-22 03:43:15,422 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-53202659 info
2025-09-22 03:43:16,128 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-69437745, ID : 4ba4e14d-2775-4e32-8dff-6eb1789bce1e