is in ACTIVE state now
2025-10-14 13:03:03,010 - INFO - VM name : mltf_vm
2025-10-14 13:03:03,109 - DEBUG - VM mltf_vm ID is b39b021a-cb4a-402e-91ff-9e29203f47fe
2025-10-14 13:03:03,109 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-4312-30
2025-10-14 13:03:03,348 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/b39b021a-cb4a-402e-91ff-9e29203f47fe
2025-10-14 13:03:03,362 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/214d140b-ead3-4569-b18e-1db4043678b6
2025-10-14 13:03:03,377 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/b6fb3fd3-c291-4958-8584-c64e6f2cb960
2025-10-14 13:03:04,566 - 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.92 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.440 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.440/1.178/1.916/0.738 ms')
2025-10-14 13:03:04,566 - INFO - Ping to Metadata IP 169.254.0.5 of VM mltf_vm passed
2025-10-14 13:03:04,640 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-14 13:03:04,640 - DEBUG - Waiting to SSH to VM mltf_vm, IP 182.229.242.197, Port 22
2025-10-14 13:03:04,797 - DEBUG - VM mltf_vm is ready for SSH connections
2025-10-14 13:03:04,872 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-14 13:03:04,872 - DEBUG - Waiting to SSH to VM mltf_vm, IP 182.229.242.197, Port 22
2025-10-14 13:03:05,034 - DEBUG - VM mltf_vm is ready for SSH connections
2025-10-14 13:03:05,036 - INFO - ================================================================================
2025-10-14 13:03:05,036 - INFO - STARTING TEST : test_verify_session_sampling_teardown
2025-10-14 13:03:05,036 - 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-10-14 13:03:06,361 - DEBUG - Skipping xmpp flap check
2025-10-14 13:03:06,361 - INFO - Initial checks done. Running the testcase now
2025-10-14 13:03:06,361 - INFO -
2025-10-14 13:03:06,498 - INFO - Setting flow export rate: 100
2025-10-14 13:03:06,551 - 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-10-14 13:03:06,926 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '1e8bf660-4a15-4e19-bd14-3d27da55eead', 'name': 'ctest-vn1-72384264', 'tenant_id': '8fbcad56f1ea4eb688632810e937eb2a', 'project_id': '8fbcad56f1ea4eb688632810e937eb2a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['6c2d29c6-3271-4828-b432-2395fb801ef6'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-03059036', 'ctest-vn1-72384264'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-03059036', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '182.229.242.192/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-10-14 13:03:07,128 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '8babb4f0-4a3f-4e5c-86ec-676d01176f5c', 'name': 'ctest-vn2-87980045', 'tenant_id': '8fbcad56f1ea4eb688632810e937eb2a', 'project_id': '8fbcad56f1ea4eb688632810e937eb2a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['5b6f99ed-9784-45ef-90ad-85e52cd5a14a'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-03059036', 'ctest-vn2-87980045'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-03059036', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '190.92.47.128/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-10-14 13:03:07,227 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-14 13:03:07,234 - DEBUG - Requesting: http://10.0.0.254:8082/domain/972a6834-584f-4bae-af8e-4c4518226241
2025-10-14 13:03:07,274 - DEBUG - Requesting: http://10.0.0.254:8082/project/8fbcad56-f1ea-4eb6-8863-2810e937eb2a
2025-10-14 13:03:07,379 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/1e8bf660-4a15-4e19-bd14-3d27da55eead
2025-10-14 13:03:07,390 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/1e8bf660-4a15-4e19-bd14-3d27da55eead
2025-10-14 13:03:07,400 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/d415235a-94eb-4536-926f-a3501b8d550d
2025-10-14 13:03:07,410 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/d415235a-94eb-4536-926f-a3501b8d550d
2025-10-14 13:03:07,421 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/deb9ae98-edfb-4746-bdf8-df16fa64c240
2025-10-14 13:03:07,435 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-14 13:03:07,435 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/1e8bf660-4a15-4e19-bd14-3d27da55eead
2025-10-14 13:03:07,472 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/d415235a-94eb-4536-926f-a3501b8d550d
2025-10-14 13:03:07,510 - INFO - Verified VN network id 14 for VN 1e8bf660-4a15-4e19-bd14-3d27da55eead
2025-10-14 13:03:07,510 - INFO - Verifications in API Server for VN ctest-vn1-72384264 passed
2025-10-14 13:03:07,511 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/1e8bf660-4a15-4e19-bd14-3d27da55eead
2025-10-14 13:03:07,527 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/d415235a-94eb-4536-926f-a3501b8d550d
2025-10-14 13:03:07,538 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/d415235a-94eb-4536-926f-a3501b8d550d
2025-10-14 13:03:07,559 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/deb9ae98-edfb-4746-bdf8-df16fa64c240
2025-10-14 13:03:07,583 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-03059036', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2201123736320822809', 'uuid-lslong': '13624582014078676653'}, 'enable': 'true', 'created': '2025-10-14T13:01:33', 'last-modified': '2025-10-14T13:03:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.702016'}
2025-10-14 13:03:07,591 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-14 13:03:07,599 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-03059036', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2201123736320822809', 'uuid-lslong': '13624582014078676653'}, 'enable': 'true', 'created': '2025-10-14T13:01:33', 'last-modified': '2025-10-14T13:03:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.707404'}
2025-10-14 13:03:07,609 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-14 13:03:07,616 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-03059036', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2201123736320822809', 'uuid-lslong': '13624582014078676653'}, 'enable': 'true', 'created': '2025-10-14T13:01:33', 'last-modified': '2025-10-14T13:03:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.733923'}
2025-10-14 13:03:07,644 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-14 13:03:07,645 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-72384264 passed
2025-10-14 13:03:07,646 - DEBUG - ====Verifying policy data for ctest-vn1-72384264 in API_Server ======
2025-10-14 13:03:07,647 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-14 13:03:07,662 - DEBUG - Requesting: http://10.0.0.254:8082/domain/972a6834-584f-4bae-af8e-4c4518226241
2025-10-14 13:03:07,691 - DEBUG - Requesting: http://10.0.0.254:8082/project/8fbcad56-f1ea-4eb6-8863-2810e937eb2a
2025-10-14 13:03:07,802 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/1e8bf660-4a15-4e19-bd14-3d27da55eead
2025-10-14 13:03:07,813 - DEBUG - ==>Verifying data for policy with id: e5fe079e-12ed-4527-8992-0bf70d1df54f, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-03059036', 'policy1']
2025-10-14 13:03:07,813 - INFO - VN ctest-vn1-72384264 Policy verification: verify_vn_policy_in_api_server, status: True
2025-10-14 13:03:07,813 - DEBUG - Verifying the vn in opserver
2025-10-14 13:03:07,813 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264 virtual network link through opserver 10.0.0.254
2025-10-14 13:03:07,813 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-10-14 13:03:07,828 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264?flat'}
2025-10-14 13:03:07,828 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264 virtual network link through opserver 10.0.0.50
2025-10-14 13:03:07,828 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-10-14 13:03:07,844 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264?flat'}
2025-10-14 13:03:07,844 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264 virtual network link through opserver 10.0.0.33
2025-10-14 13:03:07,844 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-14 13:03:07,862 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264?flat'}
2025-10-14 13:03:07,862 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264 is found in opserver
2025-10-14 13:03:07,873 - DEBUG - VRF ids for VN ctest-vn1-72384264: {'10.0.0.22': '2'}
2025-10-14 13:03:07,873 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-14 13:03:07,880 - DEBUG - Requesting: http://10.0.0.254:8082/domain/972a6834-584f-4bae-af8e-4c4518226241
2025-10-14 13:03:07,892 - DEBUG - Requesting: http://10.0.0.254:8082/project/8fbcad56-f1ea-4eb6-8863-2810e937eb2a
2025-10-14 13:03:07,990 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/8babb4f0-4a3f-4e5c-86ec-676d01176f5c
2025-10-14 13:03:08,002 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/8babb4f0-4a3f-4e5c-86ec-676d01176f5c
2025-10-14 13:03:08,013 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/a2f2040e-bd68-4dac-af45-d81b89845db0
2025-10-14 13:03:08,022 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/a2f2040e-bd68-4dac-af45-d81b89845db0
2025-10-14 13:03:08,029 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/07e18a1a-e924-44d0-9185-9a2c48d1a0eb
2025-10-14 13:03:08,037 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-14 13:03:08,037 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/8babb4f0-4a3f-4e5c-86ec-676d01176f5c
2025-10-14 13:03:08,046 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/a2f2040e-bd68-4dac-af45-d81b89845db0
2025-10-14 13:03:08,067 - INFO - Verified VN network id 15 for VN 8babb4f0-4a3f-4e5c-86ec-676d01176f5c
2025-10-14 13:03:08,067 - INFO - Verifications in API Server for VN ctest-vn2-87980045 passed
2025-10-14 13:03:08,067 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/8babb4f0-4a3f-4e5c-86ec-676d01176f5c
2025-10-14 13:03:08,078 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/a2f2040e-bd68-4dac-af45-d81b89845db0
2025-10-14 13:03:08,085 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/a2f2040e-bd68-4dac-af45-d81b89845db0
2025-10-14 13:03:08,093 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/07e18a1a-e924-44d0-9185-9a2c48d1a0eb
2025-10-14 13:03:08,105 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-03059036', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10064336736420318812', 'uuid-lslong': '9722259413453467484'}, 'enable': 'true', 'created': '2025-10-14T13:02:20', 'last-modified': '2025-10-14T13:03:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.012249'}
2025-10-14 13:03:08,114 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-14 13:03:08,121 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-03059036', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10064336736420318812', 'uuid-lslong': '9722259413453467484'}, 'enable': 'true', 'created': '2025-10-14T13:02:20', 'last-modified': '2025-10-14T13:03:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.027784'}
2025-10-14 13:03:08,127 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-14 13:03:08,132 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-03059036', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10064336736420318812', 'uuid-lslong': '9722259413453467484'}, 'enable': 'true', 'created': '2025-10-14T13:02:20', 'last-modified': '2025-10-14T13:03:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.042915'}
2025-10-14 13:03:08,139 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-14 13:03:08,139 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-87980045 passed
2025-10-14 13:03:08,139 - DEBUG - ====Verifying policy data for ctest-vn2-87980045 in API_Server ======
2025-10-14 13:03:08,139 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-14 13:03:08,145 - DEBUG - Requesting: http://10.0.0.254:8082/domain/972a6834-584f-4bae-af8e-4c4518226241
2025-10-14 13:03:08,156 - DEBUG - Requesting: http://10.0.0.254:8082/project/8fbcad56-f1ea-4eb6-8863-2810e937eb2a
2025-10-14 13:03:08,257 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/8babb4f0-4a3f-4e5c-86ec-676d01176f5c
2025-10-14 13:03:08,270 - DEBUG - ==>Verifying data for policy with id: e5fe079e-12ed-4527-8992-0bf70d1df54f, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-03059036', 'policy1']
2025-10-14 13:03:08,270 - INFO - VN ctest-vn2-87980045 Policy verification: verify_vn_policy_in_api_server, status: True
2025-10-14 13:03:08,270 - DEBUG - Verifying the vn in opserver
2025-10-14 13:03:08,270 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045 virtual network link through opserver 10.0.0.254
2025-10-14 13:03:08,270 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-10-14 13:03:08,285 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045?flat'}
2025-10-14 13:03:08,285 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045 virtual network link through opserver 10.0.0.50
2025-10-14 13:03:08,285 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-10-14 13:03:08,298 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045?flat'}
2025-10-14 13:03:08,298 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045 virtual network link through opserver 10.0.0.33
2025-10-14 13:03:08,298 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-14 13:03:08,313 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045?flat'}
2025-10-14 13:03:08,313 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045 is found in opserver
2025-10-14 13:03:08,327 - DEBUG - VRF ids for VN ctest-vn2-87980045: {'10.0.0.65': '2', '10.0.0.22': '3'}
2025-10-14 13:03:08,327 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-14 13:03:08,334 - DEBUG - Requesting: http://10.0.0.254:8082/domain/972a6834-584f-4bae-af8e-4c4518226241
2025-10-14 13:03:08,347 - DEBUG - Requesting: http://10.0.0.254:8082/project/8fbcad56-f1ea-4eb6-8863-2810e937eb2a
2025-10-14 13:03:08,451 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/1e8bf660-4a15-4e19-bd14-3d27da55eead
2025-10-14 13:03:08,463 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/1e8bf660-4a15-4e19-bd14-3d27da55eead
2025-10-14 13:03:08,476 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/d415235a-94eb-4536-926f-a3501b8d550d
2025-10-14 13:03:08,489 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/d415235a-94eb-4536-926f-a3501b8d550d
2025-10-14 13:03:08,500 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/deb9ae98-edfb-4746-bdf8-df16fa64c240
2025-10-14 13:03:08,510 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-14 13:03:08,510 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/1e8bf660-4a15-4e19-bd14-3d27da55eead
2025-10-14 13:03:08,531 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/d415235a-94eb-4536-926f-a3501b8d550d
2025-10-14 13:03:08,555 - INFO - Verified VN network id 14 for VN 1e8bf660-4a15-4e19-bd14-3d27da55eead
2025-10-14 13:03:08,555 - INFO - Verifications in API Server for VN ctest-vn1-72384264 passed
2025-10-14 13:03:08,555 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/1e8bf660-4a15-4e19-bd14-3d27da55eead
2025-10-14 13:03:08,570 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/d415235a-94eb-4536-926f-a3501b8d550d
2025-10-14 13:03:08,586 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/d415235a-94eb-4536-926f-a3501b8d550d
2025-10-14 13:03:08,595 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/deb9ae98-edfb-4746-bdf8-df16fa64c240
2025-10-14 13:03:08,608 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-03059036', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2201123736320822809', 'uuid-lslong': '13624582014078676653'}, 'enable': 'true', 'created': '2025-10-14T13:01:33', 'last-modified': '2025-10-14T13:03:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.727785'}
2025-10-14 13:03:08,614 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-14 13:03:08,619 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-03059036', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2201123736320822809', 'uuid-lslong': '13624582014078676653'}, 'enable': 'true', 'created': '2025-10-14T13:01:33', 'last-modified': '2025-10-14T13:03:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.729536'}
2025-10-14 13:03:08,629 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-14 13:03:08,637 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-03059036', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2201123736320822809', 'uuid-lslong': '13624582014078676653'}, 'enable': 'true', 'created': '2025-10-14T13:01:33', 'last-modified': '2025-10-14T13:03:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.754341'}
2025-10-14 13:03:08,645 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-14 13:03:08,645 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-72384264 passed
2025-10-14 13:03:08,645 - DEBUG - ====Verifying policy data for ctest-vn1-72384264 in API_Server ======
2025-10-14 13:03:08,645 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-14 13:03:08,651 - DEBUG - Requesting: http://10.0.0.254:8082/domain/972a6834-584f-4bae-af8e-4c4518226241
2025-10-14 13:03:08,661 - DEBUG - Requesting: http://10.0.0.254:8082/project/8fbcad56-f1ea-4eb6-8863-2810e937eb2a
2025-10-14 13:03:08,767 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/1e8bf660-4a15-4e19-bd14-3d27da55eead
2025-10-14 13:03:08,779 - DEBUG - ==>Verifying data for policy with id: e5fe079e-12ed-4527-8992-0bf70d1df54f, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-03059036', 'policy1']
2025-10-14 13:03:08,779 - INFO - VN ctest-vn1-72384264 Policy verification: verify_vn_policy_in_api_server, status: True
2025-10-14 13:03:08,779 - DEBUG - Verifying the vn in opserver
2025-10-14 13:03:08,779 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264 virtual network link through opserver 10.0.0.254
2025-10-14 13:03:08,779 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-10-14 13:03:08,793 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264?flat'}
2025-10-14 13:03:08,793 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264 virtual network link through opserver 10.0.0.50
2025-10-14 13:03:08,794 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-10-14 13:03:08,809 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264?flat'}
2025-10-14 13:03:08,809 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264 virtual network link through opserver 10.0.0.33
2025-10-14 13:03:08,809 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-14 13:03:08,824 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264?flat'}
2025-10-14 13:03:08,824 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264 is found in opserver
2025-10-14 13:03:08,837 - DEBUG - VRF ids for VN ctest-vn1-72384264: {'10.0.0.22': '2'}
2025-10-14 13:03:08,838 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-14 13:03:08,855 - DEBUG - Requesting: http://10.0.0.254:8082/domain/972a6834-584f-4bae-af8e-4c4518226241
2025-10-14 13:03:08,866 - DEBUG - Requesting: http://10.0.0.254:8082/project/8fbcad56-f1ea-4eb6-8863-2810e937eb2a
2025-10-14 13:03:08,971 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/8babb4f0-4a3f-4e5c-86ec-676d01176f5c
2025-10-14 13:03:08,986 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/8babb4f0-4a3f-4e5c-86ec-676d01176f5c
2025-10-14 13:03:08,998 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/a2f2040e-bd68-4dac-af45-d81b89845db0
2025-10-14 13:03:09,007 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/a2f2040e-bd68-4dac-af45-d81b89845db0
2025-10-14 13:03:09,016 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/07e18a1a-e924-44d0-9185-9a2c48d1a0eb
2025-10-14 13:03:09,025 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-14 13:03:09,025 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/8babb4f0-4a3f-4e5c-86ec-676d01176f5c
2025-10-14 13:03:09,036 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/a2f2040e-bd68-4dac-af45-d81b89845db0
2025-10-14 13:03:09,055 - INFO - Verified VN network id 15 for VN 8babb4f0-4a3f-4e5c-86ec-676d01176f5c
2025-10-14 13:03:09,056 - INFO - Verifications in API Server for VN ctest-vn2-87980045 passed
2025-10-14 13:03:09,056 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/8babb4f0-4a3f-4e5c-86ec-676d01176f5c
2025-10-14 13:03:09,069 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/a2f2040e-bd68-4dac-af45-d81b89845db0
2025-10-14 13:03:09,090 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/a2f2040e-bd68-4dac-af45-d81b89845db0
2025-10-14 13:03:09,099 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/07e18a1a-e924-44d0-9185-9a2c48d1a0eb
2025-10-14 13:03:09,114 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-03059036', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10064336736420318812', 'uuid-lslong': '9722259413453467484'}, 'enable': 'true', 'created': '2025-10-14T13:02:20', 'last-modified': '2025-10-14T13:03:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.021421'}
2025-10-14 13:03:09,122 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-14 13:03:09,130 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-03059036', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10064336736420318812', 'uuid-lslong': '9722259413453467484'}, 'enable': 'true', 'created': '2025-10-14T13:02:20', 'last-modified': '2025-10-14T13:03:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.035904'}
2025-10-14 13:03:09,139 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-14 13:03:09,145 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-03059036', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10064336736420318812', 'uuid-lslong': '9722259413453467484'}, 'enable': 'true', 'created': '2025-10-14T13:02:20', 'last-modified': '2025-10-14T13:03:07', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.055006'}
2025-10-14 13:03:09,152 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-14 13:03:09,152 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-87980045 passed
2025-10-14 13:03:09,152 - DEBUG - ====Verifying policy data for ctest-vn2-87980045 in API_Server ======
2025-10-14 13:03:09,152 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-14 13:03:09,160 - DEBUG - Requesting: http://10.0.0.254:8082/domain/972a6834-584f-4bae-af8e-4c4518226241
2025-10-14 13:03:09,173 - DEBUG - Requesting: http://10.0.0.254:8082/project/8fbcad56-f1ea-4eb6-8863-2810e937eb2a
2025-10-14 13:03:09,273 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/8babb4f0-4a3f-4e5c-86ec-676d01176f5c
2025-10-14 13:03:09,285 - DEBUG - ==>Verifying data for policy with id: e5fe079e-12ed-4527-8992-0bf70d1df54f, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-03059036', 'policy1']
2025-10-14 13:03:09,285 - INFO - VN ctest-vn2-87980045 Policy verification: verify_vn_policy_in_api_server, status: True
2025-10-14 13:03:09,285 - DEBUG - Verifying the vn in opserver
2025-10-14 13:03:09,285 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045 virtual network link through opserver 10.0.0.254
2025-10-14 13:03:09,285 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-10-14 13:03:09,316 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045?flat'}
2025-10-14 13:03:09,316 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045 virtual network link through opserver 10.0.0.50
2025-10-14 13:03:09,316 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-10-14 13:03:09,333 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045?flat'}
2025-10-14 13:03:09,333 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045 virtual network link through opserver 10.0.0.33
2025-10-14 13:03:09,333 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-14 13:03:09,349 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045?flat'}
2025-10-14 13:03:09,349 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045 is found in opserver
2025-10-14 13:03:09,360 - DEBUG - VRF ids for VN ctest-vn2-87980045: {'10.0.0.65': '2', '10.0.0.22': '3'}
2025-10-14 13:03:09,361 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-14 13:03:09,368 - DEBUG - Requesting: http://10.0.0.254:8082/domain/972a6834-584f-4bae-af8e-4c4518226241
2025-10-14 13:03:09,381 - DEBUG - Requesting: http://10.0.0.254:8082/project/8fbcad56-f1ea-4eb6-8863-2810e937eb2a
2025-10-14 13:03:09,482 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/5b678cb2-6dbe-410f-b8ef-a10a66c129cf
2025-10-14 13:03:09,493 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/5b678cb2-6dbe-410f-b8ef-a10a66c129cf
2025-10-14 13:03:09,502 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/9f99c03d-e13d-49e4-be1b-321f0d5af3b7
2025-10-14 13:03:09,510 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/9f99c03d-e13d-49e4-be1b-321f0d5af3b7
2025-10-14 13:03:09,518 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/098121dd-e4ae-488b-8892-758cc56316cf
2025-10-14 13:03:09,525 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-14 13:03:09,525 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/5b678cb2-6dbe-410f-b8ef-a10a66c129cf
2025-10-14 13:03:09,535 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/9f99c03d-e13d-49e4-be1b-321f0d5af3b7
2025-10-14 13:03:09,551 - INFO - Verified VN network id 16 for VN 5b678cb2-6dbe-410f-b8ef-a10a66c129cf
2025-10-14 13:03:09,552 - INFO - Verifications in API Server for VN ctest-fip_vn-88090658 passed
2025-10-14 13:03:09,552 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/5b678cb2-6dbe-410f-b8ef-a10a66c129cf
2025-10-14 13:03:09,564 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/9f99c03d-e13d-49e4-be1b-321f0d5af3b7
2025-10-14 13:03:09,572 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/9f99c03d-e13d-49e4-be1b-321f0d5af3b7
2025-10-14 13:03:09,580 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/098121dd-e4ae-488b-8892-758cc56316cf
2025-10-14 13:03:09,591 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-fip_vn-88090658', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-03059036', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6586387678025892111', 'uuid-lslong': '13326046888458267087'}, 'enable': 'true', 'created': '2025-10-14T13:02:21', 'last-modified': '2025-10-14T13:02:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:48.008333'}
2025-10-14 13:03:09,597 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-14 13:03:09,605 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-fip_vn-88090658', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-03059036', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6586387678025892111', 'uuid-lslong': '13326046888458267087'}, 'enable': 'true', 'created': '2025-10-14T13:02:21', 'last-modified': '2025-10-14T13:02:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:48.017035'}
2025-10-14 13:03:09,618 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-14 13:03:09,632 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-fip_vn-88090658', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-03059036', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6586387678025892111', 'uuid-lslong': '13326046888458267087'}, 'enable': 'true', 'created': '2025-10-14T13:02:21', 'last-modified': '2025-10-14T13:02:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:48.054756'}
2025-10-14 13:03:09,639 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-14 13:03:09,639 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-88090658 passed
2025-10-14 13:03:09,639 - DEBUG - ====Verifying policy data for ctest-fip_vn-88090658 in API_Server ======
2025-10-14 13:03:09,639 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-14 13:03:09,646 - DEBUG - Requesting: http://10.0.0.254:8082/domain/972a6834-584f-4bae-af8e-4c4518226241
2025-10-14 13:03:09,661 - DEBUG - Requesting: http://10.0.0.254:8082/project/8fbcad56-f1ea-4eb6-8863-2810e937eb2a
2025-10-14 13:03:09,759 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/5b678cb2-6dbe-410f-b8ef-a10a66c129cf
2025-10-14 13:03:09,771 - DEBUG - =>VN ctest-fip_vn-88090658 has no policy to be verified
2025-10-14 13:03:09,771 - DEBUG - Verifying the vn in opserver
2025-10-14 13:03:09,771 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-fip_vn-88090658 virtual network link through opserver 10.0.0.254
2025-10-14 13:03:09,771 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-10-14 13:03:09,789 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-fip_vn-88090658', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-fip_vn-88090658?flat'}
2025-10-14 13:03:09,789 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-fip_vn-88090658 virtual network link through opserver 10.0.0.50
2025-10-14 13:03:09,789 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-10-14 13:03:09,803 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-fip_vn-88090658', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-fip_vn-88090658?flat'}
2025-10-14 13:03:09,804 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-fip_vn-88090658 virtual network link through opserver 10.0.0.33
2025-10-14 13:03:09,804 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-14 13:03:09,819 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-fip_vn-88090658', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-fip_vn-88090658?flat'}
2025-10-14 13:03:09,819 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-fip_vn-88090658 is found in opserver
2025-10-14 13:03:09,830 - DEBUG - VRF ids for VN ctest-fip_vn-88090658: {'10.0.0.65': '3'}
2025-10-14 13:03:09,830 - INFO - start time= 1760446989830809
2025-10-14 13:03:09,831 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 190.92.47.131, host_string: cirros@169.254.0.3, password: gocubsgogateway: ubuntu@10.0.0.22, gateway password: c0ntrail123
2025-10-14 13:03:09,831 - DEBUG - ping -s 56 -c 3 -W 1 190.92.47.131
2025-10-14 13:03:13,509 - DEBUG - PING 190.92.47.131 (190.92.47.131): 56 data bytes
64 bytes from 190.92.47.131: seq=0 ttl=63 time=3.686 ms
64 bytes from 190.92.47.131: seq=1 ttl=63 time=1.896 ms
64 bytes from 190.92.47.131: seq=2 ttl=63 time=2.047 ms
--- 190.92.47.131 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.896/2.543/3.686 ms
2025-10-14 13:03:13,509 - INFO - Ping to IP 190.92.47.131 from VM ctest-vn1_vm1-36807368 passed
2025-10-14 13:03:23,510 - INFO - Verify session samples and teardown pkts
2025-10-14 13:03:23,510 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.254
2025-10-14 13:03:23,515 - DEBUG - Posting: http://10.0.0.254:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1760446989830809, 'end_time': 1760447003515559, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-10-14 13:03:24,539 - DEBUG - [{'T': 1760446991945777}, {'T': 1760446992945843}, {'T': 1760446993945943}]
2025-10-14 13:03:24,539 - DEBUG - Posting: http://10.0.0.254:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1760446989830809, 'end_time': 1760447004539868, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-10-14 13:03:25,561 - DEBUG - [{'T': 1760446991736539}, {'T': 1760446992736531}, {'T': 1760446993736698}]
2025-10-14 13:03:25,561 - DEBUG - Posting: http://10.0.0.254:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1760446989830809, 'end_time': 1760447005561526, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-10-14 13:03:26,581 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'sample_count': 3}]
2025-10-14 13:03:26,581 - INFO - wait for the flows to get expire
2025-10-14 13:06:46,581 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4312-30:Compute:contrail-vrouter-agent:0?flat
2025-10-14 13:06:46,675 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4312-30?flat
2025-10-14 13:06:46,711 - DEBUG - Posting: http://10.0.0.254:8081/analytics/query, payload {'table': 'SessionRecordTable', 'start_time': 1760446989830809, 'end_time': 1760447206710966, 'select_fields': ['vn', 'remote_vn', 'forward_teardown_pkts', 'reverse_teardown_pkts'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-10-14 13:06:47,736 - DEBUG - [{'forward_flow_uuid': '70f3d6ee-e75c-4e3f-a095-81487c6db6d4', 'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'reverse_flow_uuid': '61d15289-0f7c-48d0-aaed-12004ce969c2', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'forward_teardown_pkts': 3, 'reverse_teardown_pkts': 3}]
2025-10-14 13:06:47,736 - DEBUG - Posting: http://10.0.0.254:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1760446989830809, 'end_time': 1760447207736606, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-10-14 13:06:48,763 - DEBUG - Posting: http://10.0.0.254:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1760446989830809, 'end_time': 1760447208762912, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-10-14 13:06:49,782 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045', 'sample_count': 4}]
2025-10-14 13:06:50,280 - INFO - Deleted policy policy1
2025-10-14 13:06:50,398 - INFO - Setting flow export rate: None
2025-10-14 13:06:51,721 - DEBUG - Skipping xmpp flap check
2025-10-14 13:06:51,721 - INFO - END TEST : test_verify_session_sampling_teardown : PASSED[0:03:46]
2025-10-14 13:06:51,721 - INFO - --------------------------------------------------------------------------------
2025-10-14 13:06:51,722 - INFO - Deleting VM mltf_vm
2025-10-14 13:06:51,799 - INFO - Deleting VM ctest-fvn_vm1-72288685
2025-10-14 13:06:51,870 - INFO - Deleting VM ctest-vn2_vm2-98631697
2025-10-14 13:06:51,938 - INFO - Deleting VN ctest-fip_vn-88090658
2025-10-14 13:06:51,984 - DEBUG - VN 5b678cb2-6dbe-410f-b8ef-a10a66c129cf still in use: Unable to complete operation on network 5b678cb2-6dbe-410f-b8ef-a10a66c129cf. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-10fbf8a6-3d65-4240-8fdc-c3eb07b5631a']
2025-10-14 13:06:51,985 - WARNING - Deleting VN ctest-fip_vn-88090658 failed..Will retry
2025-10-14 13:06:54,166 - DEBUG - Response for deleting network ()
2025-10-14 13:06:54,166 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/9f99c03d-e13d-49e4-be1b-321f0d5af3b7
2025-10-14 13:06:54,209 - DEBUG - Response Code: 404
2025-10-14 13:06:54,209 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-14 13:06:54,217 - DEBUG - Requesting: http://10.0.0.254:8082/domain/972a6834-584f-4bae-af8e-4c4518226241
2025-10-14 13:06:54,232 - DEBUG - Requesting: http://10.0.0.254:8082/project/8fbcad56-f1ea-4eb6-8863-2810e937eb2a
2025-10-14 13:06:54,326 - INFO - Validated that VN ctest-fip_vn-88090658 is not found in API Server
2025-10-14 13:06:54,338 - DEBUG - VN ctest-fip_vn-88090658 is not present in Agent 10.0.0.65
2025-10-14 13:06:54,347 - DEBUG - VN ctest-fip_vn-88090658 is not present in Agent 10.0.0.22
2025-10-14 13:06:54,347 - INFO - Validated that VN ctest-fip_vn-88090658 is not in any agent
2025-10-14 13:06:54,353 - DEBUG - VRF 3 is not seen in agent 10.0.0.65
2025-10-14 13:06:54,359 - DEBUG - Vrouter 10.0.0.65 does not have vrf 3 for VN ctest-fip_vn-88090658
2025-10-14 13:06:54,359 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-fip_vn-88090658
2025-10-14 13:06:54,380 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-88090658 info
2025-10-14 13:06:54,380 - INFO - Deleting VN ctest-vn2-87980045
2025-10-14 13:06:54,612 - DEBUG - Response for deleting network ()
2025-10-14 13:06:54,612 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/a2f2040e-bd68-4dac-af45-d81b89845db0
2025-10-14 13:06:54,619 - DEBUG - Response Code: 404
2025-10-14 13:06:54,619 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-14 13:06:54,625 - DEBUG - Requesting: http://10.0.0.254:8082/domain/972a6834-584f-4bae-af8e-4c4518226241
2025-10-14 13:06:54,636 - DEBUG - Requesting: http://10.0.0.254:8082/project/8fbcad56-f1ea-4eb6-8863-2810e937eb2a
2025-10-14 13:06:54,727 - INFO - Validated that VN ctest-vn2-87980045 is not found in API Server
2025-10-14 13:06:54,742 - DEBUG - VN ctest-vn2-87980045 is not present in Agent 10.0.0.65
2025-10-14 13:06:54,751 - DEBUG - VN ctest-vn2-87980045 is not present in Agent 10.0.0.22
2025-10-14 13:06:54,751 - INFO - Validated that VN ctest-vn2-87980045 is not in any agent
2025-10-14 13:06:54,757 - DEBUG - VRF 2 is not seen in agent 10.0.0.65
2025-10-14 13:06:54,762 - DEBUG - Vrouter 10.0.0.65 does not have vrf 2 for VN ctest-vn2-87980045
2025-10-14 13:06:54,767 - DEBUG - VRF 3 is not seen in agent 10.0.0.22
2025-10-14 13:06:54,772 - DEBUG - Vrouter 10.0.0.22 does not have vrf 3 for VN ctest-vn2-87980045
2025-10-14 13:06:54,772 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn2-87980045
2025-10-14 13:06:54,794 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-87980045 info
2025-10-14 13:06:54,794 - INFO - Deleting VM ctest-vn1_vm2-17143254
2025-10-14 13:06:54,860 - INFO - Deleting VM ctest-vn1_vm1-36807368
2025-10-14 13:06:54,928 - INFO - Deleting VN ctest-vn1-72384264
2025-10-14 13:06:54,975 - DEBUG - VN 1e8bf660-4a15-4e19-bd14-3d27da55eead still in use: Unable to complete operation on network 1e8bf660-4a15-4e19-bd14-3d27da55eead. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-d92d77ef-cc37-488c-80b7-a3b433596777']
2025-10-14 13:06:54,975 - WARNING - Deleting VN ctest-vn1-72384264 failed..Will retry
2025-10-14 13:06:57,140 - DEBUG - Response for deleting network ()
2025-10-14 13:06:57,140 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/d415235a-94eb-4536-926f-a3501b8d550d
2025-10-14 13:06:57,148 - DEBUG - Response Code: 404
2025-10-14 13:06:57,148 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-14 13:06:57,154 - DEBUG - Requesting: http://10.0.0.254:8082/domain/972a6834-584f-4bae-af8e-4c4518226241
2025-10-14 13:06:57,208 - DEBUG - Requesting: http://10.0.0.254:8082/project/8fbcad56-f1ea-4eb6-8863-2810e937eb2a
2025-10-14 13:06:57,302 - INFO - Validated that VN ctest-vn1-72384264 is not found in API Server
2025-10-14 13:06:57,315 - DEBUG - VN ctest-vn1-72384264 is not present in Agent 10.0.0.65
2025-10-14 13:06:57,327 - DEBUG - VN ctest-vn1-72384264 is not present in Agent 10.0.0.22
2025-10-14 13:06:57,327 - INFO - Validated that VN ctest-vn1-72384264 is not in any agent
2025-10-14 13:06:57,334 - DEBUG - VRF 2 is not seen in agent 10.0.0.22
2025-10-14 13:06:57,340 - DEBUG - Vrouter 10.0.0.22 does not have vrf 2 for VN ctest-vn1-72384264
2025-10-14 13:06:57,340 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-03059036:ctest-vn1-72384264
2025-10-14 13:06:57,364 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-72384264 info
2025-10-14 13:06:58,176 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-03059036, ID : 8fbcad56-f1ea-4eb6-8863-2810e937eb2a