is in ACTIVE state now
2026-08-31 04:15:30,774 - INFO - VM name : mltf_vm
2026-08-31 04:15:30,912 - DEBUG - VM mltf_vm ID is d5705175-0deb-45ca-9780-710dcf558ecd
2026-08-31 04:15:30,912 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-6237-1
2026-08-31 04:15:31,178 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/d5705175-0deb-45ca-9780-710dcf558ecd
2026-08-31 04:15:31,193 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/b7989f84-0d37-4613-86b2-2b5e39b3377c
2026-08-31 04:15:31,206 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/daa6cf7d-a2c6-4a52-bef1-d29d8c8fe612
2026-08-31 04:15:32,440 - 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=2.21 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.468 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.468/1.336/2.205/0.868 ms')
2026-08-31 04:15:32,440 - INFO - Ping to Metadata IP 169.254.0.5 of VM mltf_vm passed
2026-08-31 04:15:32,512 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-08-31 04:15:32,512 - DEBUG - Waiting to SSH to VM mltf_vm, IP 133.95.117.133, Port 22
2026-08-31 04:15:32,692 - DEBUG - VM mltf_vm is ready for SSH connections
2026-08-31 04:15:32,768 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-08-31 04:15:32,769 - DEBUG - Waiting to SSH to VM mltf_vm, IP 133.95.117.133, Port 22
2026-08-31 04:15:32,936 - DEBUG - VM mltf_vm is ready for SSH connections
2026-08-31 04:15:32,939 - INFO - ================================================================================
2026-08-31 04:15:32,939 - INFO - STARTING TEST : test_verify_session_sampling_teardown
2026-08-31 04:15:32,940 - INFO - TEST DESCRIPTION :
1.query client session samples
2.query server session samples
3.query client session to get number of sessions exported
4.query session record table for teardown bytes/pkts
5.query sample count after teardown on server side
2026-08-31 04:15:34,256 - DEBUG - Skipping xmpp flap check
2026-08-31 04:15:34,256 - INFO - Initial checks done. Running the testcase now
2026-08-31 04:15:34,256 - INFO -
2026-08-31 04:15:34,390 - INFO - Setting flow export rate: 100
2026-08-31 04:15:34,438 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = any, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = any, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None]
2026-08-31 04:15:34,845 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'ee0c7b39-8ece-4716-aac8-17c12185b761', 'name': 'ctest-vn1-36267730', 'tenant_id': '9d607bb139384e81b422d43764b6afac', 'project_id': '9d607bb139384e81b422d43764b6afac', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': ['4c4761ae-e4f3-4f93-a1c3-161fd4797064'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-87104136', 'ctest-vn1-36267730'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-87104136', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '133.95.117.128/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-08-31 04:15:35,088 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '94d20de3-34aa-49bc-a95f-7f52109decb6', 'name': 'ctest-vn2-19428338', 'tenant_id': '9d607bb139384e81b422d43764b6afac', 'project_id': '9d607bb139384e81b422d43764b6afac', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': ['45a48fda-6720-463e-8675-44a57f547d00'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-87104136', 'ctest-vn2-19428338'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-87104136', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '186.103.17.64/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-08-31 04:15:35,186 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-08-31 04:15:35,195 - DEBUG - Requesting: http://10.0.0.50:8082/domain/e2dd173c-f32f-4272-81b1-e77dae6a5597
2026-08-31 04:15:35,210 - DEBUG - Requesting: http://10.0.0.50:8082/project/9d607bb1-3938-4e81-b422-d43764b6afac
2026-08-31 04:15:35,332 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/ee0c7b39-8ece-4716-aac8-17c12185b761
2026-08-31 04:15:35,352 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/ee0c7b39-8ece-4716-aac8-17c12185b761
2026-08-31 04:15:35,390 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/57bfaa6e-0cf6-4cea-9bf6-613860d20ffd
2026-08-31 04:15:35,432 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/57bfaa6e-0cf6-4cea-9bf6-613860d20ffd
2026-08-31 04:15:35,471 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/cb613428-62c2-474a-b2cf-e7a9356d5740
2026-08-31 04:15:35,482 - DEBUG - Route Targets: ['target:64512:8000005']
2026-08-31 04:15:35,483 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/ee0c7b39-8ece-4716-aac8-17c12185b761
2026-08-31 04:15:35,500 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/57bfaa6e-0cf6-4cea-9bf6-613860d20ffd
2026-08-31 04:15:35,525 - INFO - Verified VN network id 16 for VN ee0c7b39-8ece-4716-aac8-17c12185b761
2026-08-31 04:15:35,525 - INFO - Verifications in API Server for VN ctest-vn1-36267730 passed
2026-08-31 04:15:35,526 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/ee0c7b39-8ece-4716-aac8-17c12185b761
2026-08-31 04:15:35,542 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/57bfaa6e-0cf6-4cea-9bf6-613860d20ffd
2026-08-31 04:15:35,553 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/57bfaa6e-0cf6-4cea-9bf6-613860d20ffd
2026-08-31 04:15:35,563 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/cb613428-62c2-474a-b2cf-e7a9356d5740
2026-08-31 04:15:35,580 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87104136', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17153220567886612246', 'uuid-lslong': '12306112100048418657'}, 'enable': 'true', 'created': '2026-08-31T04:12:50', 'last-modified': '2026-08-31T04:15:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.785914'}
2026-08-31 04:15:35,591 - DEBUG - Route Targets: ['target:64512:8000005']
2026-08-31 04:15:35,598 - DEBUG - Control-node 10.0.0.185 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87104136', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17153220567886612246', 'uuid-lslong': '12306112100048418657'}, 'enable': 'true', 'created': '2026-08-31T04:12:50', 'last-modified': '2026-08-31T04:15:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.806376'}
2026-08-31 04:15:35,606 - DEBUG - Route Targets: ['target:64512:8000005']
2026-08-31 04:15:35,614 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87104136', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17153220567886612246', 'uuid-lslong': '12306112100048418657'}, 'enable': 'true', 'created': '2026-08-31T04:12:50', 'last-modified': '2026-08-31T04:15:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.824516'}
2026-08-31 04:15:35,624 - DEBUG - Route Targets: ['target:64512:8000005']
2026-08-31 04:15:35,624 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-36267730 passed
2026-08-31 04:15:35,624 - DEBUG - ====Verifying policy data for ctest-vn1-36267730 in API_Server ======
2026-08-31 04:15:35,625 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-08-31 04:15:35,633 - DEBUG - Requesting: http://10.0.0.50:8082/domain/e2dd173c-f32f-4272-81b1-e77dae6a5597
2026-08-31 04:15:35,648 - DEBUG - Requesting: http://10.0.0.50:8082/project/9d607bb1-3938-4e81-b422-d43764b6afac
2026-08-31 04:15:35,764 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/ee0c7b39-8ece-4716-aac8-17c12185b761
2026-08-31 04:15:35,779 - DEBUG - ==>Verifying data for policy with id: db8721d3-2b2f-4272-89df-7f2145dc8926, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-87104136', 'policy1']
2026-08-31 04:15:35,779 - INFO - VN ctest-vn1-36267730 Policy verification: verify_vn_policy_in_api_server, status: True
2026-08-31 04:15:35,779 - DEBUG - Verifying the vn in opserver
2026-08-31 04:15:35,779 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730 virtual network link through opserver 10.0.0.50
2026-08-31 04:15:35,779 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-08-31 04:15:35,794 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730?flat'}
2026-08-31 04:15:35,794 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730 virtual network link through opserver 10.0.0.185
2026-08-31 04:15:35,794 - DEBUG - Requesting: http://10.0.0.185:8081/analytics/uves/virtual-networks
2026-08-31 04:15:35,812 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'href': 'http://10.0.0.185:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730?flat'}
2026-08-31 04:15:35,812 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730 virtual network link through opserver 10.0.0.38
2026-08-31 04:15:35,812 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-08-31 04:15:35,830 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730?flat'}
2026-08-31 04:15:35,830 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730 is found in opserver
2026-08-31 04:15:35,844 - DEBUG - VRF ids for VN ctest-vn1-36267730: {'10.0.0.186': '2'}
2026-08-31 04:15:35,844 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-08-31 04:15:35,852 - DEBUG - Requesting: http://10.0.0.50:8082/domain/e2dd173c-f32f-4272-81b1-e77dae6a5597
2026-08-31 04:15:35,868 - DEBUG - Requesting: http://10.0.0.50:8082/project/9d607bb1-3938-4e81-b422-d43764b6afac
2026-08-31 04:15:35,987 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/94d20de3-34aa-49bc-a95f-7f52109decb6
2026-08-31 04:15:36,013 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/94d20de3-34aa-49bc-a95f-7f52109decb6
2026-08-31 04:15:36,035 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/12494057-01e9-48c2-b160-d45e7e5da2d4
2026-08-31 04:15:36,052 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/12494057-01e9-48c2-b160-d45e7e5da2d4
2026-08-31 04:15:36,064 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/0282b605-1c87-4198-aaa7-f26dff79b2a3
2026-08-31 04:15:36,076 - DEBUG - Route Targets: ['target:64512:8000007']
2026-08-31 04:15:36,076 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/94d20de3-34aa-49bc-a95f-7f52109decb6
2026-08-31 04:15:36,091 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/12494057-01e9-48c2-b160-d45e7e5da2d4
2026-08-31 04:15:36,115 - INFO - Verified VN network id 17 for VN 94d20de3-34aa-49bc-a95f-7f52109decb6
2026-08-31 04:15:36,116 - INFO - Verifications in API Server for VN ctest-vn2-19428338 passed
2026-08-31 04:15:36,117 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/94d20de3-34aa-49bc-a95f-7f52109decb6
2026-08-31 04:15:36,145 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/12494057-01e9-48c2-b160-d45e7e5da2d4
2026-08-31 04:15:36,158 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/12494057-01e9-48c2-b160-d45e7e5da2d4
2026-08-31 04:15:36,171 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/0282b605-1c87-4198-aaa7-f26dff79b2a3
2026-08-31 04:15:36,199 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87104136', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10723648932214884796', 'uuid-lslong': '12204613505640164534'}, 'enable': 'true', 'created': '2026-08-31T04:14:12', 'last-modified': '2026-08-31T04:15:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.158967'}
2026-08-31 04:15:36,215 - DEBUG - Route Targets: ['target:64512:8000007']
2026-08-31 04:15:36,222 - DEBUG - Control-node 10.0.0.185 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87104136', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10723648932214884796', 'uuid-lslong': '12204613505640164534'}, 'enable': 'true', 'created': '2026-08-31T04:14:12', 'last-modified': '2026-08-31T04:15:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.177069'}
2026-08-31 04:15:36,232 - DEBUG - Route Targets: ['target:64512:8000007']
2026-08-31 04:15:36,241 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87104136', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10723648932214884796', 'uuid-lslong': '12204613505640164534'}, 'enable': 'true', 'created': '2026-08-31T04:14:12', 'last-modified': '2026-08-31T04:15:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.213068'}
2026-08-31 04:15:36,252 - DEBUG - Route Targets: ['target:64512:8000007']
2026-08-31 04:15:36,253 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-19428338 passed
2026-08-31 04:15:36,253 - DEBUG - ====Verifying policy data for ctest-vn2-19428338 in API_Server ======
2026-08-31 04:15:36,253 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-08-31 04:15:36,264 - DEBUG - Requesting: http://10.0.0.50:8082/domain/e2dd173c-f32f-4272-81b1-e77dae6a5597
2026-08-31 04:15:36,281 - DEBUG - Requesting: http://10.0.0.50:8082/project/9d607bb1-3938-4e81-b422-d43764b6afac
2026-08-31 04:15:36,415 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/94d20de3-34aa-49bc-a95f-7f52109decb6
2026-08-31 04:15:36,439 - DEBUG - ==>Verifying data for policy with id: db8721d3-2b2f-4272-89df-7f2145dc8926, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-87104136', 'policy1']
2026-08-31 04:15:36,439 - INFO - VN ctest-vn2-19428338 Policy verification: verify_vn_policy_in_api_server, status: True
2026-08-31 04:15:36,439 - DEBUG - Verifying the vn in opserver
2026-08-31 04:15:36,439 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338 virtual network link through opserver 10.0.0.50
2026-08-31 04:15:36,439 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-08-31 04:15:36,455 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338?flat'}
2026-08-31 04:15:36,455 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338 virtual network link through opserver 10.0.0.185
2026-08-31 04:15:36,455 - DEBUG - Requesting: http://10.0.0.185:8081/analytics/uves/virtual-networks
2026-08-31 04:15:36,472 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'href': 'http://10.0.0.185:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338?flat'}
2026-08-31 04:15:36,472 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338 virtual network link through opserver 10.0.0.38
2026-08-31 04:15:36,472 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-08-31 04:15:36,495 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338?flat'}
2026-08-31 04:15:36,495 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338 is found in opserver
2026-08-31 04:15:36,518 - DEBUG - VRF ids for VN ctest-vn2-19428338: {'10.0.0.186': '3', '10.0.0.176': '2'}
2026-08-31 04:15:36,518 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-08-31 04:15:36,535 - DEBUG - Requesting: http://10.0.0.50:8082/domain/e2dd173c-f32f-4272-81b1-e77dae6a5597
2026-08-31 04:15:36,552 - DEBUG - Requesting: http://10.0.0.50:8082/project/9d607bb1-3938-4e81-b422-d43764b6afac
2026-08-31 04:15:36,702 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/ee0c7b39-8ece-4716-aac8-17c12185b761
2026-08-31 04:15:36,717 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/ee0c7b39-8ece-4716-aac8-17c12185b761
2026-08-31 04:15:36,733 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/57bfaa6e-0cf6-4cea-9bf6-613860d20ffd
2026-08-31 04:15:36,745 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/57bfaa6e-0cf6-4cea-9bf6-613860d20ffd
2026-08-31 04:15:36,756 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/cb613428-62c2-474a-b2cf-e7a9356d5740
2026-08-31 04:15:36,777 - DEBUG - Route Targets: ['target:64512:8000005']
2026-08-31 04:15:36,777 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/ee0c7b39-8ece-4716-aac8-17c12185b761
2026-08-31 04:15:36,791 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/57bfaa6e-0cf6-4cea-9bf6-613860d20ffd
2026-08-31 04:15:36,812 - INFO - Verified VN network id 16 for VN ee0c7b39-8ece-4716-aac8-17c12185b761
2026-08-31 04:15:36,812 - INFO - Verifications in API Server for VN ctest-vn1-36267730 passed
2026-08-31 04:15:36,812 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/ee0c7b39-8ece-4716-aac8-17c12185b761
2026-08-31 04:15:36,825 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/57bfaa6e-0cf6-4cea-9bf6-613860d20ffd
2026-08-31 04:15:36,836 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/57bfaa6e-0cf6-4cea-9bf6-613860d20ffd
2026-08-31 04:15:36,847 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/cb613428-62c2-474a-b2cf-e7a9356d5740
2026-08-31 04:15:36,864 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87104136', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17153220567886612246', 'uuid-lslong': '12306112100048418657'}, 'enable': 'true', 'created': '2026-08-31T04:12:50', 'last-modified': '2026-08-31T04:15:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.068451'}
2026-08-31 04:15:36,876 - DEBUG - Route Targets: ['target:64512:8000005']
2026-08-31 04:15:36,885 - DEBUG - Control-node 10.0.0.185 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87104136', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17153220567886612246', 'uuid-lslong': '12306112100048418657'}, 'enable': 'true', 'created': '2026-08-31T04:12:50', 'last-modified': '2026-08-31T04:15:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.091726'}
2026-08-31 04:15:36,894 - DEBUG - Route Targets: ['target:64512:8000005']
2026-08-31 04:15:36,901 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87104136', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17153220567886612246', 'uuid-lslong': '12306112100048418657'}, 'enable': 'true', 'created': '2026-08-31T04:12:50', 'last-modified': '2026-08-31T04:15:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.112171'}
2026-08-31 04:15:36,910 - DEBUG - Route Targets: ['target:64512:8000005']
2026-08-31 04:15:36,910 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-36267730 passed
2026-08-31 04:15:36,910 - DEBUG - ====Verifying policy data for ctest-vn1-36267730 in API_Server ======
2026-08-31 04:15:36,911 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-08-31 04:15:36,921 - DEBUG - Requesting: http://10.0.0.50:8082/domain/e2dd173c-f32f-4272-81b1-e77dae6a5597
2026-08-31 04:15:36,945 - DEBUG - Requesting: http://10.0.0.50:8082/project/9d607bb1-3938-4e81-b422-d43764b6afac
2026-08-31 04:15:37,078 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/ee0c7b39-8ece-4716-aac8-17c12185b761
2026-08-31 04:15:37,095 - DEBUG - ==>Verifying data for policy with id: db8721d3-2b2f-4272-89df-7f2145dc8926, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-87104136', 'policy1']
2026-08-31 04:15:37,095 - INFO - VN ctest-vn1-36267730 Policy verification: verify_vn_policy_in_api_server, status: True
2026-08-31 04:15:37,095 - DEBUG - Verifying the vn in opserver
2026-08-31 04:15:37,095 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730 virtual network link through opserver 10.0.0.50
2026-08-31 04:15:37,095 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-08-31 04:15:37,112 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730?flat'}
2026-08-31 04:15:37,112 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730 virtual network link through opserver 10.0.0.185
2026-08-31 04:15:37,112 - DEBUG - Requesting: http://10.0.0.185:8081/analytics/uves/virtual-networks
2026-08-31 04:15:37,131 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'href': 'http://10.0.0.185:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730?flat'}
2026-08-31 04:15:37,131 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730 virtual network link through opserver 10.0.0.38
2026-08-31 04:15:37,131 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-08-31 04:15:37,153 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730?flat'}
2026-08-31 04:15:37,153 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730 is found in opserver
2026-08-31 04:15:37,168 - DEBUG - VRF ids for VN ctest-vn1-36267730: {'10.0.0.186': '2'}
2026-08-31 04:15:37,169 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-08-31 04:15:37,177 - DEBUG - Requesting: http://10.0.0.50:8082/domain/e2dd173c-f32f-4272-81b1-e77dae6a5597
2026-08-31 04:15:37,195 - DEBUG - Requesting: http://10.0.0.50:8082/project/9d607bb1-3938-4e81-b422-d43764b6afac
2026-08-31 04:15:37,326 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/94d20de3-34aa-49bc-a95f-7f52109decb6
2026-08-31 04:15:37,339 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/94d20de3-34aa-49bc-a95f-7f52109decb6
2026-08-31 04:15:37,351 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/12494057-01e9-48c2-b160-d45e7e5da2d4
2026-08-31 04:15:37,364 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/12494057-01e9-48c2-b160-d45e7e5da2d4
2026-08-31 04:15:37,376 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/0282b605-1c87-4198-aaa7-f26dff79b2a3
2026-08-31 04:15:37,387 - DEBUG - Route Targets: ['target:64512:8000007']
2026-08-31 04:15:37,387 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/94d20de3-34aa-49bc-a95f-7f52109decb6
2026-08-31 04:15:37,402 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/12494057-01e9-48c2-b160-d45e7e5da2d4
2026-08-31 04:15:37,423 - INFO - Verified VN network id 17 for VN 94d20de3-34aa-49bc-a95f-7f52109decb6
2026-08-31 04:15:37,424 - INFO - Verifications in API Server for VN ctest-vn2-19428338 passed
2026-08-31 04:15:37,424 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/94d20de3-34aa-49bc-a95f-7f52109decb6
2026-08-31 04:15:37,438 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/12494057-01e9-48c2-b160-d45e7e5da2d4
2026-08-31 04:15:37,448 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/12494057-01e9-48c2-b160-d45e7e5da2d4
2026-08-31 04:15:37,459 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/0282b605-1c87-4198-aaa7-f26dff79b2a3
2026-08-31 04:15:37,476 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87104136', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10723648932214884796', 'uuid-lslong': '12204613505640164534'}, 'enable': 'true', 'created': '2026-08-31T04:14:12', 'last-modified': '2026-08-31T04:15:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.439660'}
2026-08-31 04:15:37,510 - DEBUG - Route Targets: ['target:64512:8000007']
2026-08-31 04:15:37,522 - DEBUG - Control-node 10.0.0.185 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87104136', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10723648932214884796', 'uuid-lslong': '12204613505640164534'}, 'enable': 'true', 'created': '2026-08-31T04:14:12', 'last-modified': '2026-08-31T04:15:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.474423'}
2026-08-31 04:15:37,534 - DEBUG - Route Targets: ['target:64512:8000007']
2026-08-31 04:15:37,543 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87104136', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10723648932214884796', 'uuid-lslong': '12204613505640164534'}, 'enable': 'true', 'created': '2026-08-31T04:14:12', 'last-modified': '2026-08-31T04:15:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.515860'}
2026-08-31 04:15:37,554 - DEBUG - Route Targets: ['target:64512:8000007']
2026-08-31 04:15:37,554 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-19428338 passed
2026-08-31 04:15:37,554 - DEBUG - ====Verifying policy data for ctest-vn2-19428338 in API_Server ======
2026-08-31 04:15:37,554 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-08-31 04:15:37,567 - DEBUG - Requesting: http://10.0.0.50:8082/domain/e2dd173c-f32f-4272-81b1-e77dae6a5597
2026-08-31 04:15:37,583 - DEBUG - Requesting: http://10.0.0.50:8082/project/9d607bb1-3938-4e81-b422-d43764b6afac
2026-08-31 04:15:37,705 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/94d20de3-34aa-49bc-a95f-7f52109decb6
2026-08-31 04:15:37,723 - DEBUG - ==>Verifying data for policy with id: db8721d3-2b2f-4272-89df-7f2145dc8926, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-87104136', 'policy1']
2026-08-31 04:15:37,723 - INFO - VN ctest-vn2-19428338 Policy verification: verify_vn_policy_in_api_server, status: True
2026-08-31 04:15:37,723 - DEBUG - Verifying the vn in opserver
2026-08-31 04:15:37,723 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338 virtual network link through opserver 10.0.0.50
2026-08-31 04:15:37,723 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-08-31 04:15:37,742 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338?flat'}
2026-08-31 04:15:37,742 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338 virtual network link through opserver 10.0.0.185
2026-08-31 04:15:37,742 - DEBUG - Requesting: http://10.0.0.185:8081/analytics/uves/virtual-networks
2026-08-31 04:15:37,759 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'href': 'http://10.0.0.185:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338?flat'}
2026-08-31 04:15:37,759 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338 virtual network link through opserver 10.0.0.38
2026-08-31 04:15:37,759 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-08-31 04:15:37,774 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338?flat'}
2026-08-31 04:15:37,775 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338 is found in opserver
2026-08-31 04:15:37,791 - DEBUG - VRF ids for VN ctest-vn2-19428338: {'10.0.0.186': '3', '10.0.0.176': '2'}
2026-08-31 04:15:37,791 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-08-31 04:15:37,800 - DEBUG - Requesting: http://10.0.0.50:8082/domain/e2dd173c-f32f-4272-81b1-e77dae6a5597
2026-08-31 04:15:37,836 - DEBUG - Requesting: http://10.0.0.50:8082/project/9d607bb1-3938-4e81-b422-d43764b6afac
2026-08-31 04:15:37,959 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9f7f93e5-a84e-42ac-8b65-50aa730c15cb
2026-08-31 04:15:37,980 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9f7f93e5-a84e-42ac-8b65-50aa730c15cb
2026-08-31 04:15:37,993 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6248950f-5208-43b6-842f-4df6fecda345
2026-08-31 04:15:38,006 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6248950f-5208-43b6-842f-4df6fecda345
2026-08-31 04:15:38,018 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/eafae3ac-7e84-4003-9931-35ad56ceee99
2026-08-31 04:15:38,033 - DEBUG - Route Targets: ['target:64512:8000008']
2026-08-31 04:15:38,033 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9f7f93e5-a84e-42ac-8b65-50aa730c15cb
2026-08-31 04:15:38,046 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6248950f-5208-43b6-842f-4df6fecda345
2026-08-31 04:15:38,070 - INFO - Verified VN network id 18 for VN 9f7f93e5-a84e-42ac-8b65-50aa730c15cb
2026-08-31 04:15:38,070 - INFO - Verifications in API Server for VN ctest-fip_vn-18569824 passed
2026-08-31 04:15:38,070 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9f7f93e5-a84e-42ac-8b65-50aa730c15cb
2026-08-31 04:15:38,084 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6248950f-5208-43b6-842f-4df6fecda345
2026-08-31 04:15:38,096 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6248950f-5208-43b6-842f-4df6fecda345
2026-08-31 04:15:38,107 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/eafae3ac-7e84-4003-9931-35ad56ceee99
2026-08-31 04:15:38,128 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-fip_vn-18569824', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87104136', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11493067388653290156', 'uuid-lslong': '10044523236924593611'}, 'enable': 'true', 'created': '2026-08-31T04:14:13', 'last-modified': '2026-08-31T04:14:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:01:24.142521'}
2026-08-31 04:15:38,141 - DEBUG - Route Targets: ['target:64512:8000008']
2026-08-31 04:15:38,150 - DEBUG - Control-node 10.0.0.185 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-fip_vn-18569824', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87104136', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11493067388653290156', 'uuid-lslong': '10044523236924593611'}, 'enable': 'true', 'created': '2026-08-31T04:14:13', 'last-modified': '2026-08-31T04:14:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:01:24.177457'}
2026-08-31 04:15:38,159 - DEBUG - Route Targets: ['target:64512:8000008']
2026-08-31 04:15:38,169 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-fip_vn-18569824', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87104136', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11493067388653290156', 'uuid-lslong': '10044523236924593611'}, 'enable': 'true', 'created': '2026-08-31T04:14:13', 'last-modified': '2026-08-31T04:14:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:01:24.172830'}
2026-08-31 04:15:38,178 - DEBUG - Route Targets: ['target:64512:8000008']
2026-08-31 04:15:38,178 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-18569824 passed
2026-08-31 04:15:38,179 - DEBUG - ====Verifying policy data for ctest-fip_vn-18569824 in API_Server ======
2026-08-31 04:15:38,179 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-08-31 04:15:38,188 - DEBUG - Requesting: http://10.0.0.50:8082/domain/e2dd173c-f32f-4272-81b1-e77dae6a5597
2026-08-31 04:15:38,206 - DEBUG - Requesting: http://10.0.0.50:8082/project/9d607bb1-3938-4e81-b422-d43764b6afac
2026-08-31 04:15:38,328 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9f7f93e5-a84e-42ac-8b65-50aa730c15cb
2026-08-31 04:15:38,344 - DEBUG - =>VN ctest-fip_vn-18569824 has no policy to be verified
2026-08-31 04:15:38,345 - DEBUG - Verifying the vn in opserver
2026-08-31 04:15:38,345 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-fip_vn-18569824 virtual network link through opserver 10.0.0.50
2026-08-31 04:15:38,345 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-08-31 04:15:38,362 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-fip_vn-18569824', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-fip_vn-18569824?flat'}
2026-08-31 04:15:38,362 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-fip_vn-18569824 virtual network link through opserver 10.0.0.185
2026-08-31 04:15:38,362 - DEBUG - Requesting: http://10.0.0.185:8081/analytics/uves/virtual-networks
2026-08-31 04:15:38,378 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-fip_vn-18569824', 'href': 'http://10.0.0.185:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-fip_vn-18569824?flat'}
2026-08-31 04:15:38,378 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-fip_vn-18569824 virtual network link through opserver 10.0.0.38
2026-08-31 04:15:38,378 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-08-31 04:15:38,394 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-fip_vn-18569824', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-fip_vn-18569824?flat'}
2026-08-31 04:15:38,394 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-fip_vn-18569824 is found in opserver
2026-08-31 04:15:38,412 - DEBUG - VRF ids for VN ctest-fip_vn-18569824: {'10.0.0.176': '3'}
2026-08-31 04:15:38,412 - INFO - start time= 1788149738412848
2026-08-31 04:15:38,413 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 186.103.17.67, host_string: cirros@169.254.0.3, password: gocubsgogateway: ubuntu@10.0.0.186, gateway password: c0ntrail123
2026-08-31 04:15:38,413 - DEBUG - ping -s 56 -c 3 -W 1 186.103.17.67
2026-08-31 04:15:42,466 - DEBUG - PING 186.103.17.67 (186.103.17.67): 56 data bytes
64 bytes from 186.103.17.67: seq=0 ttl=63 time=11.483 ms
64 bytes from 186.103.17.67: seq=1 ttl=63 time=2.045 ms
64 bytes from 186.103.17.67: seq=2 ttl=63 time=1.801 ms
--- 186.103.17.67 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.801/5.109/11.483 ms
2026-08-31 04:15:42,466 - INFO - Ping to IP 186.103.17.67 from VM ctest-vn1_vm1-29622328 passed
2026-08-31 04:15:52,467 - INFO - Verify session samples and teardown pkts
2026-08-31 04:15:52,467 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.50
2026-08-31 04:15:52,471 - DEBUG - Posting: http://10.0.0.50:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1788149738412848, 'end_time': 1788149752471464, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-08-31 04:15:53,497 - DEBUG - [{'T': 1788149740501171}, {'T': 1788149741501350}, {'T': 1788149742501410}]
2026-08-31 04:15:53,498 - DEBUG - Posting: http://10.0.0.50:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1788149738412848, 'end_time': 1788149753497946, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2026-08-31 04:15:54,526 - DEBUG - [{'T': 1788149740917108}, {'T': 1788149741917319}, {'T': 1788149742917528}]
2026-08-31 04:15:54,526 - DEBUG - Posting: http://10.0.0.50:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1788149738412848, 'end_time': 1788149754526262, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-08-31 04:15:55,551 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'sample_count': 3}]
2026-08-31 04:15:55,551 - INFO - wait for the flows to get expire
2026-08-31 04:19:15,552 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-6237-1:Compute:contrail-vrouter-agent:0?flat
2026-08-31 04:19:15,588 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-6237-1?flat
2026-08-31 04:19:15,628 - DEBUG - Posting: http://10.0.0.50:8081/analytics/query, payload {'table': 'SessionRecordTable', 'start_time': 1788149738412848, 'end_time': 1788149955628754, 'select_fields': ['vn', 'remote_vn', 'forward_teardown_pkts', 'reverse_teardown_pkts'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-08-31 04:19:16,658 - DEBUG - [{'forward_flow_uuid': 'd84ab1ed-9f66-45ad-a7e0-6ffa11595bbe', 'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'reverse_flow_uuid': '1a6e15bf-a7d0-434b-aa21-e9aa52997b12', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'forward_teardown_pkts': 3, 'reverse_teardown_pkts': 3}]
2026-08-31 04:19:16,658 - DEBUG - Posting: http://10.0.0.50:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1788149738412848, 'end_time': 1788149956658330, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-08-31 04:19:17,753 - DEBUG - Posting: http://10.0.0.50:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1788149738412848, 'end_time': 1788149957753151, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2026-08-31 04:19:18,775 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338', 'sample_count': 4}]
2026-08-31 04:19:19,292 - INFO - Deleted policy policy1
2026-08-31 04:19:19,406 - INFO - Setting flow export rate: None
2026-08-31 04:19:20,787 - DEBUG - Skipping xmpp flap check
2026-08-31 04:19:20,787 - INFO - END TEST : test_verify_session_sampling_teardown : PASSED[0:03:48]
2026-08-31 04:19:20,788 - INFO - --------------------------------------------------------------------------------
2026-08-31 04:19:20,789 - INFO - Deleting VM mltf_vm
2026-08-31 04:19:20,866 - INFO - Deleting VM ctest-fvn_vm1-31928697
2026-08-31 04:19:20,939 - INFO - Deleting VM ctest-vn2_vm2-53018774
2026-08-31 04:19:21,032 - INFO - Deleting VN ctest-fip_vn-18569824
2026-08-31 04:19:21,084 - DEBUG - VN 9f7f93e5-a84e-42ac-8b65-50aa730c15cb still in use: Unable to complete operation on network 9f7f93e5-a84e-42ac-8b65-50aa730c15cb. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-fe7956e4-5b00-4fcf-966c-b78be97b810f']
2026-08-31 04:19:21,085 - WARNING - Deleting VN ctest-fip_vn-18569824 failed..Will retry
2026-08-31 04:19:23,173 - DEBUG - VN 9f7f93e5-a84e-42ac-8b65-50aa730c15cb still in use: Unable to complete operation on network 9f7f93e5-a84e-42ac-8b65-50aa730c15cb. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-0bee8dbb-be74-4922-9f88-3bfb10be9353']
2026-08-31 04:19:23,173 - WARNING - Deleting VN ctest-fip_vn-18569824 failed..Will retry
2026-08-31 04:19:25,409 - DEBUG - Response for deleting network ()
2026-08-31 04:19:25,409 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6248950f-5208-43b6-842f-4df6fecda345
2026-08-31 04:19:25,446 - DEBUG - Response Code: 404
2026-08-31 04:19:25,447 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-08-31 04:19:25,454 - DEBUG - Requesting: http://10.0.0.50:8082/domain/e2dd173c-f32f-4272-81b1-e77dae6a5597
2026-08-31 04:19:25,492 - DEBUG - Requesting: http://10.0.0.50:8082/project/9d607bb1-3938-4e81-b422-d43764b6afac
2026-08-31 04:19:25,597 - INFO - Validated that VN ctest-fip_vn-18569824 is not found in API Server
2026-08-31 04:19:25,611 - DEBUG - VN ctest-fip_vn-18569824 is not present in Agent 10.0.0.186
2026-08-31 04:19:25,623 - DEBUG - VN ctest-fip_vn-18569824 is not present in Agent 10.0.0.176
2026-08-31 04:19:25,623 - INFO - Validated that VN ctest-fip_vn-18569824 is not in any agent
2026-08-31 04:19:25,630 - DEBUG - VRF 3 is not seen in agent 10.0.0.176
2026-08-31 04:19:25,637 - DEBUG - Vrouter 10.0.0.176 does not have vrf 3 for VN ctest-fip_vn-18569824
2026-08-31 04:19:25,637 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-fip_vn-18569824
2026-08-31 04:19:25,668 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-18569824 info
2026-08-31 04:19:25,668 - INFO - Deleting VN ctest-vn2-19428338
2026-08-31 04:19:25,892 - DEBUG - Response for deleting network ()
2026-08-31 04:19:25,893 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/12494057-01e9-48c2-b160-d45e7e5da2d4
2026-08-31 04:19:25,901 - DEBUG - Response Code: 404
2026-08-31 04:19:25,901 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-08-31 04:19:25,910 - DEBUG - Requesting: http://10.0.0.50:8082/domain/e2dd173c-f32f-4272-81b1-e77dae6a5597
2026-08-31 04:19:25,923 - DEBUG - Requesting: http://10.0.0.50:8082/project/9d607bb1-3938-4e81-b422-d43764b6afac
2026-08-31 04:19:26,032 - INFO - Validated that VN ctest-vn2-19428338 is not found in API Server
2026-08-31 04:19:26,046 - DEBUG - VN ctest-vn2-19428338 is not present in Agent 10.0.0.186
2026-08-31 04:19:26,059 - DEBUG - VN ctest-vn2-19428338 is not present in Agent 10.0.0.176
2026-08-31 04:19:26,059 - INFO - Validated that VN ctest-vn2-19428338 is not in any agent
2026-08-31 04:19:26,066 - DEBUG - VRF 3 is not seen in agent 10.0.0.186
2026-08-31 04:19:26,074 - DEBUG - Vrouter 10.0.0.186 does not have vrf 3 for VN ctest-vn2-19428338
2026-08-31 04:19:26,081 - DEBUG - VRF 2 is not seen in agent 10.0.0.176
2026-08-31 04:19:26,089 - DEBUG - Vrouter 10.0.0.176 does not have vrf 2 for VN ctest-vn2-19428338
2026-08-31 04:19:26,089 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn2-19428338
2026-08-31 04:19:26,119 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-19428338 info
2026-08-31 04:19:26,120 - INFO - Deleting VM ctest-vn1_vm2-91398255
2026-08-31 04:19:26,202 - INFO - Deleting VM ctest-vn1_vm1-29622328
2026-08-31 04:19:26,268 - INFO - Deleting VN ctest-vn1-36267730
2026-08-31 04:19:26,316 - DEBUG - VN ee0c7b39-8ece-4716-aac8-17c12185b761 still in use: Unable to complete operation on network ee0c7b39-8ece-4716-aac8-17c12185b761. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-7e0d6f59-576b-4dd2-884f-4a3250a7a36f']
2026-08-31 04:19:26,316 - WARNING - Deleting VN ctest-vn1-36267730 failed..Will retry
2026-08-31 04:19:28,359 - DEBUG - VN ee0c7b39-8ece-4716-aac8-17c12185b761 still in use: Unable to complete operation on network ee0c7b39-8ece-4716-aac8-17c12185b761. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-eba64e8d-3e7e-4ce4-b23e-554c063ca3a1']
2026-08-31 04:19:28,360 - WARNING - Deleting VN ctest-vn1-36267730 failed..Will retry
2026-08-31 04:19:30,567 - DEBUG - Response for deleting network ()
2026-08-31 04:19:30,568 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/57bfaa6e-0cf6-4cea-9bf6-613860d20ffd
2026-08-31 04:19:30,575 - DEBUG - Response Code: 404
2026-08-31 04:19:30,575 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-08-31 04:19:30,613 - DEBUG - Requesting: http://10.0.0.50:8082/domain/e2dd173c-f32f-4272-81b1-e77dae6a5597
2026-08-31 04:19:30,633 - DEBUG - Requesting: http://10.0.0.50:8082/project/9d607bb1-3938-4e81-b422-d43764b6afac
2026-08-31 04:19:30,745 - INFO - Validated that VN ctest-vn1-36267730 is not found in API Server
2026-08-31 04:19:30,757 - DEBUG - VN ctest-vn1-36267730 is not present in Agent 10.0.0.186
2026-08-31 04:19:30,770 - DEBUG - VN ctest-vn1-36267730 is not present in Agent 10.0.0.176
2026-08-31 04:19:30,770 - INFO - Validated that VN ctest-vn1-36267730 is not in any agent
2026-08-31 04:19:30,775 - DEBUG - VRF 2 is not seen in agent 10.0.0.186
2026-08-31 04:19:30,781 - DEBUG - Vrouter 10.0.0.186 does not have vrf 2 for VN ctest-vn1-36267730
2026-08-31 04:19:30,781 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-87104136:ctest-vn1-36267730
2026-08-31 04:19:30,811 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-36267730 info
2026-08-31 04:19:31,780 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-87104136, ID : 9d607bb1-3938-4e81-b422-d43764b6afac