is in ACTIVE state now
2025-08-14 03:32:49,354 - INFO - VM name : mltf_vm
2025-08-14 03:32:49,423 - DEBUG - VM mltf_vm ID is 09afb8e9-70a8-44e6-a1f4-7f667ec45209
2025-08-14 03:32:49,423 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-3851-2
2025-08-14 03:32:49,573 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/09afb8e9-70a8-44e6-a1f4-7f667ec45209
2025-08-14 03:32:49,584 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/29f590ec-f358-4d55-a6a9-8b794c385a44
2025-08-14 03:32:49,594 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/a7c3ea2e-dc20-410e-a42f-9b250cc1c53a
2025-08-14 03:32:50,770 - 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.94 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.438 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.438/1.189/1.940/0.751 ms')
2025-08-14 03:32:50,770 - INFO - Ping to Metadata IP 169.254.0.5 of VM mltf_vm passed
2025-08-14 03:32:50,840 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-14 03:32:50,840 - DEBUG - Waiting to SSH to VM mltf_vm, IP 122.247.189.133, Port 22
2025-08-14 03:32:50,999 - DEBUG - VM mltf_vm is ready for SSH connections
2025-08-14 03:32:51,068 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-14 03:32:51,068 - DEBUG - Waiting to SSH to VM mltf_vm, IP 122.247.189.133, Port 22
2025-08-14 03:32:51,230 - DEBUG - VM mltf_vm is ready for SSH connections
2025-08-14 03:32:51,232 - INFO - ================================================================================
2025-08-14 03:32:51,232 - INFO - STARTING TEST : test_verify_session_sampling_teardown
2025-08-14 03:32:51,232 - 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-08-14 03:32:52,487 - DEBUG - Skipping xmpp flap check
2025-08-14 03:32:52,487 - INFO - Initial checks done. Running the testcase now
2025-08-14 03:32:52,487 - INFO -
2025-08-14 03:32:52,616 - INFO - Setting flow export rate: 100
2025-08-14 03:32:52,668 - 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-08-14 03:32:53,000 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '3a61ff3a-83d3-42d7-9e1f-7e9280d7db23', 'name': 'ctest-vn1-99959722', 'tenant_id': 'c9545d9f029b4c249abbc17b3a0fe3a3', 'project_id': 'c9545d9f029b4c249abbc17b3a0fe3a3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['5b1bff8f-8add-448f-bfcf-611d7edf50b1'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-93539505', 'ctest-vn1-99959722'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-93539505', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '122.247.189.128/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-08-14 03:32:53,191 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'f7fada66-3977-4e7d-a4f3-1cf254664538', 'name': 'ctest-vn2-13654066', 'tenant_id': 'c9545d9f029b4c249abbc17b3a0fe3a3', 'project_id': 'c9545d9f029b4c249abbc17b3a0fe3a3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['0237aa3b-74aa-4417-a027-44b33020f460'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-93539505', 'ctest-vn2-13654066'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-93539505', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '95.72.209.128/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-08-14 03:32:53,270 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-08-14 03:32:53,276 - DEBUG - Requesting: http://10.0.0.38:8082/domain/16362ee5-4ea2-4ad6-8a9c-e34af37c4ada
2025-08-14 03:32:53,290 - DEBUG - Requesting: http://10.0.0.38:8082/project/c9545d9f-029b-4c24-9abb-c17b3a0fe3a3
2025-08-14 03:32:53,384 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/3a61ff3a-83d3-42d7-9e1f-7e9280d7db23
2025-08-14 03:32:53,399 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/3a61ff3a-83d3-42d7-9e1f-7e9280d7db23
2025-08-14 03:32:53,410 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/081ce8cc-be6f-49ed-87cf-34fe7ecbda18
2025-08-14 03:32:53,420 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/081ce8cc-be6f-49ed-87cf-34fe7ecbda18
2025-08-14 03:32:53,453 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/c52661fa-6765-42b2-a77d-1cddcaf7b6aa
2025-08-14 03:32:53,461 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-14 03:32:53,461 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/3a61ff3a-83d3-42d7-9e1f-7e9280d7db23
2025-08-14 03:32:53,476 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/081ce8cc-be6f-49ed-87cf-34fe7ecbda18
2025-08-14 03:32:53,517 - INFO - Verified VN network id 13 for VN 3a61ff3a-83d3-42d7-9e1f-7e9280d7db23
2025-08-14 03:32:53,517 - INFO - Verifications in API Server for VN ctest-vn1-99959722 passed
2025-08-14 03:32:53,517 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/3a61ff3a-83d3-42d7-9e1f-7e9280d7db23
2025-08-14 03:32:53,530 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/081ce8cc-be6f-49ed-87cf-34fe7ecbda18
2025-08-14 03:32:53,563 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/081ce8cc-be6f-49ed-87cf-34fe7ecbda18
2025-08-14 03:32:53,587 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/c52661fa-6765-42b2-a77d-1cddcaf7b6aa
2025-08-14 03:32:53,608 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-93539505', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4206924153725600471', 'uuid-lslong': '11393964749962599203'}, 'enable': 'true', 'created': '2025-08-14T03:31:33', 'last-modified': '2025-08-14T03:32:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.646593'}
2025-08-14 03:32:53,617 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-14 03:32:53,624 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-93539505', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4206924153725600471', 'uuid-lslong': '11393964749962599203'}, 'enable': 'true', 'created': '2025-08-14T03:31:33', 'last-modified': '2025-08-14T03:32:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.657639'}
2025-08-14 03:32:53,631 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-14 03:32:53,637 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-93539505', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4206924153725600471', 'uuid-lslong': '11393964749962599203'}, 'enable': 'true', 'created': '2025-08-14T03:31:33', 'last-modified': '2025-08-14T03:32:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.671565'}
2025-08-14 03:32:53,644 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-14 03:32:53,644 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-99959722 passed
2025-08-14 03:32:53,644 - DEBUG - ====Verifying policy data for ctest-vn1-99959722 in API_Server ======
2025-08-14 03:32:53,644 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-08-14 03:32:53,651 - DEBUG - Requesting: http://10.0.0.38:8082/domain/16362ee5-4ea2-4ad6-8a9c-e34af37c4ada
2025-08-14 03:32:53,663 - DEBUG - Requesting: http://10.0.0.38:8082/project/c9545d9f-029b-4c24-9abb-c17b3a0fe3a3
2025-08-14 03:32:53,754 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/3a61ff3a-83d3-42d7-9e1f-7e9280d7db23
2025-08-14 03:32:53,766 - DEBUG - ==>Verifying data for policy with id: 16e25f40-7fd8-4d99-a5e9-743e9ed66f07, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-93539505', 'policy1']
2025-08-14 03:32:53,766 - INFO - VN ctest-vn1-99959722 Policy verification: verify_vn_policy_in_api_server, status: True
2025-08-14 03:32:53,766 - DEBUG - Verifying the vn in opserver
2025-08-14 03:32:53,766 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722 virtual network link through opserver 10.0.0.38
2025-08-14 03:32:53,766 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-14 03:32:53,778 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722?flat'}
2025-08-14 03:32:53,778 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722 virtual network link through opserver 10.0.0.27
2025-08-14 03:32:53,778 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-08-14 03:32:53,793 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722?flat'}
2025-08-14 03:32:53,793 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722 virtual network link through opserver 10.0.0.23
2025-08-14 03:32:53,793 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-08-14 03:32:53,807 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722?flat'}
2025-08-14 03:32:53,807 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722 is found in opserver
2025-08-14 03:32:53,819 - DEBUG - VRF ids for VN ctest-vn1-99959722: {'10.0.0.130': '2'}
2025-08-14 03:32:53,819 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-08-14 03:32:53,825 - DEBUG - Requesting: http://10.0.0.38:8082/domain/16362ee5-4ea2-4ad6-8a9c-e34af37c4ada
2025-08-14 03:32:53,838 - DEBUG - Requesting: http://10.0.0.38:8082/project/c9545d9f-029b-4c24-9abb-c17b3a0fe3a3
2025-08-14 03:32:53,929 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f7fada66-3977-4e7d-a4f3-1cf254664538
2025-08-14 03:32:53,946 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f7fada66-3977-4e7d-a4f3-1cf254664538
2025-08-14 03:32:53,959 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/2532484b-4595-42f1-9e9e-a6b3389abeba
2025-08-14 03:32:53,971 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/2532484b-4595-42f1-9e9e-a6b3389abeba
2025-08-14 03:32:53,981 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/7c59b2d8-df81-4684-bef3-9959627d2088
2025-08-14 03:32:53,988 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-14 03:32:53,988 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f7fada66-3977-4e7d-a4f3-1cf254664538
2025-08-14 03:32:53,999 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/2532484b-4595-42f1-9e9e-a6b3389abeba
2025-08-14 03:32:54,018 - INFO - Verified VN network id 14 for VN f7fada66-3977-4e7d-a4f3-1cf254664538
2025-08-14 03:32:54,018 - INFO - Verifications in API Server for VN ctest-vn2-13654066 passed
2025-08-14 03:32:54,018 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f7fada66-3977-4e7d-a4f3-1cf254664538
2025-08-14 03:32:54,032 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/2532484b-4595-42f1-9e9e-a6b3389abeba
2025-08-14 03:32:54,041 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/2532484b-4595-42f1-9e9e-a6b3389abeba
2025-08-14 03:32:54,049 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/7c59b2d8-df81-4684-bef3-9959627d2088
2025-08-14 03:32:54,073 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-93539505', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17868834604131503741', 'uuid-lslong': '11885875668684522808'}, 'enable': 'true', 'created': '2025-08-14T03:32:10', 'last-modified': '2025-08-14T03:32:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.915249'}
2025-08-14 03:32:54,082 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-14 03:32:54,089 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-93539505', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17868834604131503741', 'uuid-lslong': '11885875668684522808'}, 'enable': 'true', 'created': '2025-08-14T03:32:10', 'last-modified': '2025-08-14T03:32:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.927575'}
2025-08-14 03:32:54,096 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-14 03:32:54,102 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-93539505', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17868834604131503741', 'uuid-lslong': '11885875668684522808'}, 'enable': 'true', 'created': '2025-08-14T03:32:10', 'last-modified': '2025-08-14T03:32:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.942398'}
2025-08-14 03:32:54,109 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-14 03:32:54,109 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-13654066 passed
2025-08-14 03:32:54,110 - DEBUG - ====Verifying policy data for ctest-vn2-13654066 in API_Server ======
2025-08-14 03:32:54,110 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-08-14 03:32:54,116 - DEBUG - Requesting: http://10.0.0.38:8082/domain/16362ee5-4ea2-4ad6-8a9c-e34af37c4ada
2025-08-14 03:32:54,128 - DEBUG - Requesting: http://10.0.0.38:8082/project/c9545d9f-029b-4c24-9abb-c17b3a0fe3a3
2025-08-14 03:32:54,230 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f7fada66-3977-4e7d-a4f3-1cf254664538
2025-08-14 03:32:54,246 - DEBUG - ==>Verifying data for policy with id: 16e25f40-7fd8-4d99-a5e9-743e9ed66f07, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-93539505', 'policy1']
2025-08-14 03:32:54,246 - INFO - VN ctest-vn2-13654066 Policy verification: verify_vn_policy_in_api_server, status: True
2025-08-14 03:32:54,246 - DEBUG - Verifying the vn in opserver
2025-08-14 03:32:54,246 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066 virtual network link through opserver 10.0.0.38
2025-08-14 03:32:54,247 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-14 03:32:54,264 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066?flat'}
2025-08-14 03:32:54,264 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066 virtual network link through opserver 10.0.0.27
2025-08-14 03:32:54,264 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-08-14 03:32:54,277 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066?flat'}
2025-08-14 03:32:54,277 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066 virtual network link through opserver 10.0.0.23
2025-08-14 03:32:54,277 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-08-14 03:32:54,289 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066?flat'}
2025-08-14 03:32:54,289 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066 is found in opserver
2025-08-14 03:32:54,302 - DEBUG - VRF ids for VN ctest-vn2-13654066: {'10.0.0.65': '2', '10.0.0.130': '3'}
2025-08-14 03:32:54,302 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-08-14 03:32:54,309 - DEBUG - Requesting: http://10.0.0.38:8082/domain/16362ee5-4ea2-4ad6-8a9c-e34af37c4ada
2025-08-14 03:32:54,321 - DEBUG - Requesting: http://10.0.0.38:8082/project/c9545d9f-029b-4c24-9abb-c17b3a0fe3a3
2025-08-14 03:32:54,422 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/3a61ff3a-83d3-42d7-9e1f-7e9280d7db23
2025-08-14 03:32:54,441 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/3a61ff3a-83d3-42d7-9e1f-7e9280d7db23
2025-08-14 03:32:54,456 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/081ce8cc-be6f-49ed-87cf-34fe7ecbda18
2025-08-14 03:32:54,464 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/081ce8cc-be6f-49ed-87cf-34fe7ecbda18
2025-08-14 03:32:54,473 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/c52661fa-6765-42b2-a77d-1cddcaf7b6aa
2025-08-14 03:32:54,480 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-14 03:32:54,480 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/3a61ff3a-83d3-42d7-9e1f-7e9280d7db23
2025-08-14 03:32:54,492 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/081ce8cc-be6f-49ed-87cf-34fe7ecbda18
2025-08-14 03:32:54,512 - INFO - Verified VN network id 13 for VN 3a61ff3a-83d3-42d7-9e1f-7e9280d7db23
2025-08-14 03:32:54,512 - INFO - Verifications in API Server for VN ctest-vn1-99959722 passed
2025-08-14 03:32:54,513 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/3a61ff3a-83d3-42d7-9e1f-7e9280d7db23
2025-08-14 03:32:54,524 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/081ce8cc-be6f-49ed-87cf-34fe7ecbda18
2025-08-14 03:32:54,533 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/081ce8cc-be6f-49ed-87cf-34fe7ecbda18
2025-08-14 03:32:54,541 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/c52661fa-6765-42b2-a77d-1cddcaf7b6aa
2025-08-14 03:32:54,553 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-93539505', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4206924153725600471', 'uuid-lslong': '11393964749962599203'}, 'enable': 'true', 'created': '2025-08-14T03:31:33', 'last-modified': '2025-08-14T03:32:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.592234'}
2025-08-14 03:32:54,562 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-14 03:32:54,568 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-93539505', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4206924153725600471', 'uuid-lslong': '11393964749962599203'}, 'enable': 'true', 'created': '2025-08-14T03:31:33', 'last-modified': '2025-08-14T03:32:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.601605'}
2025-08-14 03:32:54,574 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-14 03:32:54,581 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-93539505', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4206924153725600471', 'uuid-lslong': '11393964749962599203'}, 'enable': 'true', 'created': '2025-08-14T03:31:33', 'last-modified': '2025-08-14T03:32:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.615125'}
2025-08-14 03:32:54,588 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-14 03:32:54,588 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-99959722 passed
2025-08-14 03:32:54,589 - DEBUG - ====Verifying policy data for ctest-vn1-99959722 in API_Server ======
2025-08-14 03:32:54,589 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-08-14 03:32:54,596 - DEBUG - Requesting: http://10.0.0.38:8082/domain/16362ee5-4ea2-4ad6-8a9c-e34af37c4ada
2025-08-14 03:32:54,608 - DEBUG - Requesting: http://10.0.0.38:8082/project/c9545d9f-029b-4c24-9abb-c17b3a0fe3a3
2025-08-14 03:32:54,699 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/3a61ff3a-83d3-42d7-9e1f-7e9280d7db23
2025-08-14 03:32:54,714 - DEBUG - ==>Verifying data for policy with id: 16e25f40-7fd8-4d99-a5e9-743e9ed66f07, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-93539505', 'policy1']
2025-08-14 03:32:54,714 - INFO - VN ctest-vn1-99959722 Policy verification: verify_vn_policy_in_api_server, status: True
2025-08-14 03:32:54,714 - DEBUG - Verifying the vn in opserver
2025-08-14 03:32:54,714 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722 virtual network link through opserver 10.0.0.38
2025-08-14 03:32:54,714 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-14 03:32:54,729 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722?flat'}
2025-08-14 03:32:54,729 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722 virtual network link through opserver 10.0.0.27
2025-08-14 03:32:54,729 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-08-14 03:32:54,743 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722?flat'}
2025-08-14 03:32:54,743 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722 virtual network link through opserver 10.0.0.23
2025-08-14 03:32:54,743 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-08-14 03:32:54,756 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722?flat'}
2025-08-14 03:32:54,756 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722 is found in opserver
2025-08-14 03:32:54,768 - DEBUG - VRF ids for VN ctest-vn1-99959722: {'10.0.0.130': '2'}
2025-08-14 03:32:54,768 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-08-14 03:32:54,773 - DEBUG - Requesting: http://10.0.0.38:8082/domain/16362ee5-4ea2-4ad6-8a9c-e34af37c4ada
2025-08-14 03:32:54,784 - DEBUG - Requesting: http://10.0.0.38:8082/project/c9545d9f-029b-4c24-9abb-c17b3a0fe3a3
2025-08-14 03:32:54,877 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f7fada66-3977-4e7d-a4f3-1cf254664538
2025-08-14 03:32:54,891 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f7fada66-3977-4e7d-a4f3-1cf254664538
2025-08-14 03:32:54,902 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/2532484b-4595-42f1-9e9e-a6b3389abeba
2025-08-14 03:32:54,912 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/2532484b-4595-42f1-9e9e-a6b3389abeba
2025-08-14 03:32:54,920 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/7c59b2d8-df81-4684-bef3-9959627d2088
2025-08-14 03:32:54,927 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-14 03:32:54,927 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f7fada66-3977-4e7d-a4f3-1cf254664538
2025-08-14 03:32:54,940 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/2532484b-4595-42f1-9e9e-a6b3389abeba
2025-08-14 03:32:54,958 - INFO - Verified VN network id 14 for VN f7fada66-3977-4e7d-a4f3-1cf254664538
2025-08-14 03:32:54,958 - INFO - Verifications in API Server for VN ctest-vn2-13654066 passed
2025-08-14 03:32:54,958 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f7fada66-3977-4e7d-a4f3-1cf254664538
2025-08-14 03:32:54,972 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/2532484b-4595-42f1-9e9e-a6b3389abeba
2025-08-14 03:32:54,980 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/2532484b-4595-42f1-9e9e-a6b3389abeba
2025-08-14 03:32:54,989 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/7c59b2d8-df81-4684-bef3-9959627d2088
2025-08-14 03:32:55,008 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-93539505', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17868834604131503741', 'uuid-lslong': '11885875668684522808'}, 'enable': 'true', 'created': '2025-08-14T03:32:10', 'last-modified': '2025-08-14T03:32:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.845796'}
2025-08-14 03:32:55,017 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-14 03:32:55,028 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-93539505', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17868834604131503741', 'uuid-lslong': '11885875668684522808'}, 'enable': 'true', 'created': '2025-08-14T03:32:10', 'last-modified': '2025-08-14T03:32:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.867946'}
2025-08-14 03:32:55,035 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-14 03:32:55,041 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-93539505', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17868834604131503741', 'uuid-lslong': '11885875668684522808'}, 'enable': 'true', 'created': '2025-08-14T03:32:10', 'last-modified': '2025-08-14T03:32:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.880693'}
2025-08-14 03:32:55,048 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-14 03:32:55,048 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-13654066 passed
2025-08-14 03:32:55,048 - DEBUG - ====Verifying policy data for ctest-vn2-13654066 in API_Server ======
2025-08-14 03:32:55,048 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-08-14 03:32:55,054 - DEBUG - Requesting: http://10.0.0.38:8082/domain/16362ee5-4ea2-4ad6-8a9c-e34af37c4ada
2025-08-14 03:32:55,065 - DEBUG - Requesting: http://10.0.0.38:8082/project/c9545d9f-029b-4c24-9abb-c17b3a0fe3a3
2025-08-14 03:32:55,156 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f7fada66-3977-4e7d-a4f3-1cf254664538
2025-08-14 03:32:55,178 - DEBUG - ==>Verifying data for policy with id: 16e25f40-7fd8-4d99-a5e9-743e9ed66f07, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-93539505', 'policy1']
2025-08-14 03:32:55,178 - INFO - VN ctest-vn2-13654066 Policy verification: verify_vn_policy_in_api_server, status: True
2025-08-14 03:32:55,178 - DEBUG - Verifying the vn in opserver
2025-08-14 03:32:55,178 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066 virtual network link through opserver 10.0.0.38
2025-08-14 03:32:55,178 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-14 03:32:55,194 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066?flat'}
2025-08-14 03:32:55,194 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066 virtual network link through opserver 10.0.0.27
2025-08-14 03:32:55,194 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-08-14 03:32:55,208 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066?flat'}
2025-08-14 03:32:55,208 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066 virtual network link through opserver 10.0.0.23
2025-08-14 03:32:55,208 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-08-14 03:32:55,221 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066?flat'}
2025-08-14 03:32:55,221 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066 is found in opserver
2025-08-14 03:32:55,233 - DEBUG - VRF ids for VN ctest-vn2-13654066: {'10.0.0.65': '2', '10.0.0.130': '3'}
2025-08-14 03:32:55,233 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-08-14 03:32:55,240 - DEBUG - Requesting: http://10.0.0.38:8082/domain/16362ee5-4ea2-4ad6-8a9c-e34af37c4ada
2025-08-14 03:32:55,251 - DEBUG - Requesting: http://10.0.0.38:8082/project/c9545d9f-029b-4c24-9abb-c17b3a0fe3a3
2025-08-14 03:32:55,349 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f0d4fa40-2ce3-4522-9f11-d4bf89405c12
2025-08-14 03:32:55,367 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f0d4fa40-2ce3-4522-9f11-d4bf89405c12
2025-08-14 03:32:55,385 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/87899a1c-993a-4066-b52b-fb9b9bdf9213
2025-08-14 03:32:55,395 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/87899a1c-993a-4066-b52b-fb9b9bdf9213
2025-08-14 03:32:55,403 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/360d0cc1-bebe-4d8b-a8d6-8a8caaec911a
2025-08-14 03:32:55,411 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-14 03:32:55,411 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f0d4fa40-2ce3-4522-9f11-d4bf89405c12
2025-08-14 03:32:55,421 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/87899a1c-993a-4066-b52b-fb9b9bdf9213
2025-08-14 03:32:55,439 - INFO - Verified VN network id 15 for VN f0d4fa40-2ce3-4522-9f11-d4bf89405c12
2025-08-14 03:32:55,439 - INFO - Verifications in API Server for VN ctest-fip_vn-08030940 passed
2025-08-14 03:32:55,440 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f0d4fa40-2ce3-4522-9f11-d4bf89405c12
2025-08-14 03:32:55,452 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/87899a1c-993a-4066-b52b-fb9b9bdf9213
2025-08-14 03:32:55,459 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/87899a1c-993a-4066-b52b-fb9b9bdf9213
2025-08-14 03:32:55,466 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/360d0cc1-bebe-4d8b-a8d6-8a8caaec911a
2025-08-14 03:32:55,483 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-fip_vn-08030940', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-93539505', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17353770417703306530', 'uuid-lslong': '11462176445741161490'}, 'enable': 'true', 'created': '2025-08-14T03:32:11', 'last-modified': '2025-08-14T03:32:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:44.003811'}
2025-08-14 03:32:55,494 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-14 03:32:55,501 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-fip_vn-08030940', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-93539505', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17353770417703306530', 'uuid-lslong': '11462176445741161490'}, 'enable': 'true', 'created': '2025-08-14T03:32:11', 'last-modified': '2025-08-14T03:32:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:44.020508'}
2025-08-14 03:32:55,507 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-14 03:32:55,514 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-fip_vn-08030940', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-93539505', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17353770417703306530', 'uuid-lslong': '11462176445741161490'}, 'enable': 'true', 'created': '2025-08-14T03:32:11', 'last-modified': '2025-08-14T03:32:11', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:44.041259'}
2025-08-14 03:32:55,521 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-14 03:32:55,521 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-08030940 passed
2025-08-14 03:32:55,522 - DEBUG - ====Verifying policy data for ctest-fip_vn-08030940 in API_Server ======
2025-08-14 03:32:55,522 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-08-14 03:32:55,528 - DEBUG - Requesting: http://10.0.0.38:8082/domain/16362ee5-4ea2-4ad6-8a9c-e34af37c4ada
2025-08-14 03:32:55,540 - DEBUG - Requesting: http://10.0.0.38:8082/project/c9545d9f-029b-4c24-9abb-c17b3a0fe3a3
2025-08-14 03:32:55,649 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f0d4fa40-2ce3-4522-9f11-d4bf89405c12
2025-08-14 03:32:55,662 - DEBUG - =>VN ctest-fip_vn-08030940 has no policy to be verified
2025-08-14 03:32:55,662 - DEBUG - Verifying the vn in opserver
2025-08-14 03:32:55,662 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-fip_vn-08030940 virtual network link through opserver 10.0.0.38
2025-08-14 03:32:55,662 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-14 03:32:55,675 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-fip_vn-08030940', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-fip_vn-08030940?flat'}
2025-08-14 03:32:55,675 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-fip_vn-08030940 virtual network link through opserver 10.0.0.27
2025-08-14 03:32:55,675 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-08-14 03:32:55,687 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-fip_vn-08030940', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-fip_vn-08030940?flat'}
2025-08-14 03:32:55,687 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-fip_vn-08030940 virtual network link through opserver 10.0.0.23
2025-08-14 03:32:55,687 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-08-14 03:32:55,701 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-fip_vn-08030940', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-fip_vn-08030940?flat'}
2025-08-14 03:32:55,701 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-fip_vn-08030940 is found in opserver
2025-08-14 03:32:55,712 - DEBUG - VRF ids for VN ctest-fip_vn-08030940: {'10.0.0.65': '3'}
2025-08-14 03:32:55,712 - INFO - start time= 1755142375712985
2025-08-14 03:32:55,713 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 95.72.209.131, host_string: cirros@169.254.0.3, password: gocubsgogateway: ubuntu@10.0.0.130, gateway password: c0ntrail123
2025-08-14 03:32:55,713 - DEBUG - ping -s 56 -c 3 -W 1 95.72.209.131
2025-08-14 03:32:59,539 - DEBUG - PING 95.72.209.131 (95.72.209.131): 56 data bytes
64 bytes from 95.72.209.131: seq=0 ttl=63 time=5.898 ms
64 bytes from 95.72.209.131: seq=1 ttl=63 time=1.347 ms
64 bytes from 95.72.209.131: seq=2 ttl=63 time=1.304 ms
--- 95.72.209.131 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.304/2.849/5.898 ms
2025-08-14 03:32:59,539 - INFO - Ping to IP 95.72.209.131 from VM ctest-vn1_vm1-01451575 passed
2025-08-14 03:33:09,540 - INFO - Verify session samples and teardown pkts
2025-08-14 03:33:09,541 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.38
2025-08-14 03:33:09,544 - DEBUG - Posting: http://10.0.0.38:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1755142375712985, 'end_time': 1755142389544699, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-08-14 03:33:10,563 - DEBUG - [{'T': 1755142377871812}, {'T': 1755142378871228}, {'T': 1755142379871251}]
2025-08-14 03:33:10,563 - DEBUG - Posting: http://10.0.0.38:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1755142375712985, 'end_time': 1755142390563624, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-08-14 03:33:11,586 - DEBUG - [{'T': 1755142378493112}, {'T': 1755142379493161}, {'T': 1755142380493217}]
2025-08-14 03:33:11,586 - DEBUG - Posting: http://10.0.0.38:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1755142375712985, 'end_time': 1755142391586896, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-08-14 03:33:12,604 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'sample_count': 3}]
2025-08-14 03:33:12,605 - INFO - wait for the flows to get expire
2025-08-14 03:36:32,605 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3851-2:Compute:contrail-vrouter-agent:0?flat
2025-08-14 03:36:32,648 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3851-2?flat
2025-08-14 03:36:32,684 - DEBUG - Posting: http://10.0.0.38:8081/analytics/query, payload {'table': 'SessionRecordTable', 'start_time': 1755142375712985, 'end_time': 1755142592684393, 'select_fields': ['vn', 'remote_vn', 'forward_teardown_pkts', 'reverse_teardown_pkts'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-08-14 03:36:33,714 - DEBUG - [{'forward_flow_uuid': 'b8536a5e-1426-45ec-a407-96603e867797', 'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'reverse_flow_uuid': 'a8e56fcd-195f-4162-9f9f-32b33e57235e', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'forward_teardown_pkts': 3, 'reverse_teardown_pkts': 3}]
2025-08-14 03:36:33,715 - DEBUG - Posting: http://10.0.0.38:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1755142375712985, 'end_time': 1755142593715140, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-08-14 03:36:34,734 - DEBUG - Posting: http://10.0.0.38:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1755142375712985, 'end_time': 1755142594734065, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-08-14 03:36:35,751 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066', 'sample_count': 4}]
2025-08-14 03:36:36,276 - INFO - Deleted policy policy1
2025-08-14 03:36:36,399 - INFO - Setting flow export rate: None
2025-08-14 03:36:37,662 - DEBUG - Skipping xmpp flap check
2025-08-14 03:36:37,662 - INFO - END TEST : test_verify_session_sampling_teardown : PASSED[0:03:46]
2025-08-14 03:36:37,662 - INFO - --------------------------------------------------------------------------------
2025-08-14 03:36:37,664 - INFO - Deleting VM mltf_vm
2025-08-14 03:36:37,723 - INFO - Deleting VM ctest-fvn_vm1-39355641
2025-08-14 03:36:37,779 - INFO - Deleting VM ctest-vn2_vm2-84566129
2025-08-14 03:36:37,836 - INFO - Deleting VN ctest-fip_vn-08030940
2025-08-14 03:36:37,873 - DEBUG - VN f0d4fa40-2ce3-4522-9f11-d4bf89405c12 still in use: Unable to complete operation on network f0d4fa40-2ce3-4522-9f11-d4bf89405c12. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-f2aeb75f-eec7-4944-9c3c-44116c73be73']
2025-08-14 03:36:37,873 - WARNING - Deleting VN ctest-fip_vn-08030940 failed..Will retry
2025-08-14 03:36:40,055 - DEBUG - Response for deleting network ()
2025-08-14 03:36:40,055 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/87899a1c-993a-4066-b52b-fb9b9bdf9213
2025-08-14 03:36:40,080 - DEBUG - Response Code: 404
2025-08-14 03:36:40,080 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-08-14 03:36:40,087 - DEBUG - Requesting: http://10.0.0.38:8082/domain/16362ee5-4ea2-4ad6-8a9c-e34af37c4ada
2025-08-14 03:36:40,119 - DEBUG - Requesting: http://10.0.0.38:8082/project/c9545d9f-029b-4c24-9abb-c17b3a0fe3a3
2025-08-14 03:36:40,212 - INFO - Validated that VN ctest-fip_vn-08030940 is not found in API Server
2025-08-14 03:36:40,223 - DEBUG - VN ctest-fip_vn-08030940 is not present in Agent 10.0.0.65
2025-08-14 03:36:40,238 - DEBUG - VN ctest-fip_vn-08030940 is not present in Agent 10.0.0.130
2025-08-14 03:36:40,238 - INFO - Validated that VN ctest-fip_vn-08030940 is not in any agent
2025-08-14 03:36:40,245 - DEBUG - VRF 3 is not seen in agent 10.0.0.65
2025-08-14 03:36:40,250 - DEBUG - Vrouter 10.0.0.65 does not have vrf 3 for VN ctest-fip_vn-08030940
2025-08-14 03:36:40,251 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-fip_vn-08030940
2025-08-14 03:36:40,271 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-08030940 info
2025-08-14 03:36:40,272 - INFO - Deleting VN ctest-vn2-13654066
2025-08-14 03:36:40,463 - DEBUG - Response for deleting network ()
2025-08-14 03:36:40,464 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/2532484b-4595-42f1-9e9e-a6b3389abeba
2025-08-14 03:36:40,469 - DEBUG - Response Code: 404
2025-08-14 03:36:40,469 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-08-14 03:36:40,475 - DEBUG - Requesting: http://10.0.0.38:8082/domain/16362ee5-4ea2-4ad6-8a9c-e34af37c4ada
2025-08-14 03:36:40,486 - DEBUG - Requesting: http://10.0.0.38:8082/project/c9545d9f-029b-4c24-9abb-c17b3a0fe3a3
2025-08-14 03:36:40,576 - INFO - Validated that VN ctest-vn2-13654066 is not found in API Server
2025-08-14 03:36:40,588 - DEBUG - VN ctest-vn2-13654066 is not present in Agent 10.0.0.65
2025-08-14 03:36:40,612 - DEBUG - VN ctest-vn2-13654066 is not present in Agent 10.0.0.130
2025-08-14 03:36:40,612 - INFO - Validated that VN ctest-vn2-13654066 is not in any agent
2025-08-14 03:36:40,618 - DEBUG - VRF 2 is not seen in agent 10.0.0.65
2025-08-14 03:36:40,624 - DEBUG - Vrouter 10.0.0.65 does not have vrf 2 for VN ctest-vn2-13654066
2025-08-14 03:36:40,631 - DEBUG - VRF 3 is not seen in agent 10.0.0.130
2025-08-14 03:36:40,637 - DEBUG - Vrouter 10.0.0.130 does not have vrf 3 for VN ctest-vn2-13654066
2025-08-14 03:36:40,637 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn2-13654066
2025-08-14 03:36:40,658 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-13654066 info
2025-08-14 03:36:40,659 - INFO - Deleting VM ctest-vn1_vm2-48283883
2025-08-14 03:36:40,716 - INFO - Deleting VM ctest-vn1_vm1-01451575
2025-08-14 03:36:40,773 - INFO - Deleting VN ctest-vn1-99959722
2025-08-14 03:36:40,818 - DEBUG - VN 3a61ff3a-83d3-42d7-9e1f-7e9280d7db23 still in use: Unable to complete operation on network 3a61ff3a-83d3-42d7-9e1f-7e9280d7db23. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-15324879-5872-4f98-8293-f9999ba1a72d']
2025-08-14 03:36:40,818 - WARNING - Deleting VN ctest-vn1-99959722 failed..Will retry
2025-08-14 03:36:42,962 - DEBUG - Response for deleting network ()
2025-08-14 03:36:42,962 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/081ce8cc-be6f-49ed-87cf-34fe7ecbda18
2025-08-14 03:36:42,968 - DEBUG - Response Code: 404
2025-08-14 03:36:42,969 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-08-14 03:36:42,979 - DEBUG - Requesting: http://10.0.0.38:8082/domain/16362ee5-4ea2-4ad6-8a9c-e34af37c4ada
2025-08-14 03:36:42,995 - DEBUG - Requesting: http://10.0.0.38:8082/project/c9545d9f-029b-4c24-9abb-c17b3a0fe3a3
2025-08-14 03:36:43,085 - INFO - Validated that VN ctest-vn1-99959722 is not found in API Server
2025-08-14 03:36:43,096 - DEBUG - VN ctest-vn1-99959722 is not present in Agent 10.0.0.65
2025-08-14 03:36:43,106 - DEBUG - VN ctest-vn1-99959722 is not present in Agent 10.0.0.130
2025-08-14 03:36:43,106 - INFO - Validated that VN ctest-vn1-99959722 is not in any agent
2025-08-14 03:36:43,111 - DEBUG - VRF 2 is not seen in agent 10.0.0.130
2025-08-14 03:36:43,117 - DEBUG - Vrouter 10.0.0.130 does not have vrf 2 for VN ctest-vn1-99959722
2025-08-14 03:36:43,117 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-93539505:ctest-vn1-99959722
2025-08-14 03:36:43,137 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-99959722 info
2025-08-14 03:36:43,883 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-93539505, ID : c9545d9f-029b-4c24-9abb-c17b3a0fe3a3