is in ACTIVE state now
2025-08-28 03:35:57,194 - INFO - VM name : mltf_vm
2025-08-28 03:35:57,269 - DEBUG - VM mltf_vm ID is 3f0b8613-3e66-4b6b-9ef9-94d6c85ec0ac
2025-08-28 03:35:57,269 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-3956-1
2025-08-28 03:35:57,431 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine/3f0b8613-3e66-4b6b-9ef9-94d6c85ec0ac
2025-08-28 03:35:57,441 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine-interface/752384b6-d291-4083-a975-0ce5a1deb066
2025-08-28 03:35:57,453 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine-interface/c03f226c-3ac9-4504-8ce6-e6dc6e78a3a5
2025-08-28 03:35:58,614 - 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.60 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.397 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.397/0.998/1.599/0.601 ms')
2025-08-28 03:35:58,614 - INFO - Ping to Metadata IP 169.254.0.5 of VM mltf_vm passed
2025-08-28 03:35:58,682 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-28 03:35:58,682 - DEBUG - Waiting to SSH to VM mltf_vm, IP 99.45.202.197, Port 22
2025-08-28 03:35:58,838 - DEBUG - VM mltf_vm is ready for SSH connections
2025-08-28 03:35:58,905 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-28 03:35:58,906 - DEBUG - Waiting to SSH to VM mltf_vm, IP 99.45.202.197, Port 22
2025-08-28 03:35:59,072 - DEBUG - VM mltf_vm is ready for SSH connections
2025-08-28 03:35:59,074 - INFO - ================================================================================
2025-08-28 03:35:59,074 - INFO - STARTING TEST : test_verify_session_sampling_teardown
2025-08-28 03:35:59,074 - 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-28 03:36:00,350 - DEBUG - Skipping xmpp flap check
2025-08-28 03:36:00,350 - INFO - Initial checks done. Running the testcase now
2025-08-28 03:36:00,350 - INFO -
2025-08-28 03:36:00,477 - INFO - Setting flow export rate: 100
2025-08-28 03:36:00,525 - 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-28 03:36:00,876 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '6f61ced0-159f-4a29-8762-27fd4ac1f880', 'name': 'ctest-vn1-49973789', 'tenant_id': 'a3f27b7650d34bc7921ad9a8b7f6e8d0', 'project_id': 'a3f27b7650d34bc7921ad9a8b7f6e8d0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['254d1443-4c7e-4eb5-bac3-94503eee4045'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-87368848', 'ctest-vn1-49973789'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-87368848', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '99.45.202.192/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-08-28 03:36:01,065 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'b5af1997-cbb6-4eef-99e2-16ef0fa59b5b', 'name': 'ctest-vn2-39675318', 'tenant_id': 'a3f27b7650d34bc7921ad9a8b7f6e8d0', 'project_id': 'a3f27b7650d34bc7921ad9a8b7f6e8d0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['fe060d75-767c-49a7-9ea9-bd5883738987'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-87368848', 'ctest-vn2-39675318'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-87368848', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '201.197.132.192/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-08-28 03:36:01,163 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-28 03:36:01,169 - DEBUG - Requesting: http://10.0.0.19:8082/domain/692c5a68-a199-4232-a07c-1cd4918de9d4
2025-08-28 03:36:01,182 - DEBUG - Requesting: http://10.0.0.19:8082/project/a3f27b76-50d3-4bc7-921a-d9a8b7f6e8d0
2025-08-28 03:36:01,336 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/6f61ced0-159f-4a29-8762-27fd4ac1f880
2025-08-28 03:36:01,392 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/6f61ced0-159f-4a29-8762-27fd4ac1f880
2025-08-28 03:36:01,410 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7ccbdc25-96df-44ba-9196-015a7ef30bfe
2025-08-28 03:36:01,423 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7ccbdc25-96df-44ba-9196-015a7ef30bfe
2025-08-28 03:36:01,521 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/c1fc1dae-fc41-45ea-9ec1-43486755b388
2025-08-28 03:36:01,538 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-28 03:36:01,538 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/6f61ced0-159f-4a29-8762-27fd4ac1f880
2025-08-28 03:36:01,557 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7ccbdc25-96df-44ba-9196-015a7ef30bfe
2025-08-28 03:36:01,577 - INFO - Verified VN network id 12 for VN 6f61ced0-159f-4a29-8762-27fd4ac1f880
2025-08-28 03:36:01,577 - INFO - Verifications in API Server for VN ctest-vn1-49973789 passed
2025-08-28 03:36:01,578 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/6f61ced0-159f-4a29-8762-27fd4ac1f880
2025-08-28 03:36:01,592 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7ccbdc25-96df-44ba-9196-015a7ef30bfe
2025-08-28 03:36:01,604 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7ccbdc25-96df-44ba-9196-015a7ef30bfe
2025-08-28 03:36:01,614 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/c1fc1dae-fc41-45ea-9ec1-43486755b388
2025-08-28 03:36:01,630 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87368848', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8025923404062214697', 'uuid-lslong': '9755403711672350848'}, 'enable': 'true', 'created': '2025-08-28T03:34:42', 'last-modified': '2025-08-28T03:36:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.799902'}
2025-08-28 03:36:01,638 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-28 03:36:01,644 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87368848', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8025923404062214697', 'uuid-lslong': '9755403711672350848'}, 'enable': 'true', 'created': '2025-08-28T03:34:42', 'last-modified': '2025-08-28T03:36:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.809600'}
2025-08-28 03:36:01,650 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-28 03:36:01,656 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87368848', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8025923404062214697', 'uuid-lslong': '9755403711672350848'}, 'enable': 'true', 'created': '2025-08-28T03:34:42', 'last-modified': '2025-08-28T03:36:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.821032'}
2025-08-28 03:36:01,664 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-28 03:36:01,664 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-49973789 passed
2025-08-28 03:36:01,665 - DEBUG - ====Verifying policy data for ctest-vn1-49973789 in API_Server ======
2025-08-28 03:36:01,665 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-28 03:36:01,671 - DEBUG - Requesting: http://10.0.0.19:8082/domain/692c5a68-a199-4232-a07c-1cd4918de9d4
2025-08-28 03:36:01,681 - DEBUG - Requesting: http://10.0.0.19:8082/project/a3f27b76-50d3-4bc7-921a-d9a8b7f6e8d0
2025-08-28 03:36:01,779 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/6f61ced0-159f-4a29-8762-27fd4ac1f880
2025-08-28 03:36:01,795 - DEBUG - ==>Verifying data for policy with id: 948a0871-8d46-433f-a889-7eb20c2ce5c6, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-87368848', 'policy1']
2025-08-28 03:36:01,795 - INFO - VN ctest-vn1-49973789 Policy verification: verify_vn_policy_in_api_server, status: True
2025-08-28 03:36:01,795 - DEBUG - Verifying the vn in opserver
2025-08-28 03:36:01,795 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789 virtual network link through opserver 10.0.0.19
2025-08-28 03:36:01,795 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-28 03:36:01,807 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789?flat'}
2025-08-28 03:36:01,807 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789 virtual network link through opserver 10.0.0.38
2025-08-28 03:36:01,807 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-28 03:36:01,820 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789?flat'}
2025-08-28 03:36:01,820 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789 virtual network link through opserver 10.0.0.41
2025-08-28 03:36:01,820 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-08-28 03:36:01,832 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789?flat'}
2025-08-28 03:36:01,832 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789 is found in opserver
2025-08-28 03:36:01,843 - DEBUG - VRF ids for VN ctest-vn1-49973789: {'10.0.0.65': '2'}
2025-08-28 03:36:01,843 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-28 03:36:01,850 - DEBUG - Requesting: http://10.0.0.19:8082/domain/692c5a68-a199-4232-a07c-1cd4918de9d4
2025-08-28 03:36:01,860 - DEBUG - Requesting: http://10.0.0.19:8082/project/a3f27b76-50d3-4bc7-921a-d9a8b7f6e8d0
2025-08-28 03:36:01,959 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/b5af1997-cbb6-4eef-99e2-16ef0fa59b5b
2025-08-28 03:36:01,978 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/b5af1997-cbb6-4eef-99e2-16ef0fa59b5b
2025-08-28 03:36:01,988 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/a3327707-e833-4950-bd61-a8f277874b03
2025-08-28 03:36:01,998 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/a3327707-e833-4950-bd61-a8f277874b03
2025-08-28 03:36:02,006 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/8c21e984-5717-4987-b8f1-d4bccd93001a
2025-08-28 03:36:02,013 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-28 03:36:02,013 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/b5af1997-cbb6-4eef-99e2-16ef0fa59b5b
2025-08-28 03:36:02,023 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/a3327707-e833-4950-bd61-a8f277874b03
2025-08-28 03:36:02,040 - INFO - Verified VN network id 13 for VN b5af1997-cbb6-4eef-99e2-16ef0fa59b5b
2025-08-28 03:36:02,040 - INFO - Verifications in API Server for VN ctest-vn2-39675318 passed
2025-08-28 03:36:02,041 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/b5af1997-cbb6-4eef-99e2-16ef0fa59b5b
2025-08-28 03:36:02,050 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/a3327707-e833-4950-bd61-a8f277874b03
2025-08-28 03:36:02,058 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/a3327707-e833-4950-bd61-a8f277874b03
2025-08-28 03:36:02,065 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/8c21e984-5717-4987-b8f1-d4bccd93001a
2025-08-28 03:36:02,076 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87368848', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13091710781537799919', 'uuid-lslong': '11088450448555088731'}, 'enable': 'true', 'created': '2025-08-28T03:35:17', 'last-modified': '2025-08-28T03:36:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.055804'}
2025-08-28 03:36:02,082 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-28 03:36:02,088 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87368848', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13091710781537799919', 'uuid-lslong': '11088450448555088731'}, 'enable': 'true', 'created': '2025-08-28T03:35:17', 'last-modified': '2025-08-28T03:36:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.067659'}
2025-08-28 03:36:02,096 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-28 03:36:02,101 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87368848', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13091710781537799919', 'uuid-lslong': '11088450448555088731'}, 'enable': 'true', 'created': '2025-08-28T03:35:17', 'last-modified': '2025-08-28T03:36:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.078615'}
2025-08-28 03:36:02,106 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-28 03:36:02,106 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-39675318 passed
2025-08-28 03:36:02,106 - DEBUG - ====Verifying policy data for ctest-vn2-39675318 in API_Server ======
2025-08-28 03:36:02,106 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-28 03:36:02,112 - DEBUG - Requesting: http://10.0.0.19:8082/domain/692c5a68-a199-4232-a07c-1cd4918de9d4
2025-08-28 03:36:02,122 - DEBUG - Requesting: http://10.0.0.19:8082/project/a3f27b76-50d3-4bc7-921a-d9a8b7f6e8d0
2025-08-28 03:36:02,218 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/b5af1997-cbb6-4eef-99e2-16ef0fa59b5b
2025-08-28 03:36:02,236 - DEBUG - ==>Verifying data for policy with id: 948a0871-8d46-433f-a889-7eb20c2ce5c6, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-87368848', 'policy1']
2025-08-28 03:36:02,236 - INFO - VN ctest-vn2-39675318 Policy verification: verify_vn_policy_in_api_server, status: True
2025-08-28 03:36:02,236 - DEBUG - Verifying the vn in opserver
2025-08-28 03:36:02,236 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318 virtual network link through opserver 10.0.0.19
2025-08-28 03:36:02,236 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-28 03:36:02,249 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318?flat'}
2025-08-28 03:36:02,249 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318 virtual network link through opserver 10.0.0.38
2025-08-28 03:36:02,249 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-28 03:36:02,261 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318?flat'}
2025-08-28 03:36:02,261 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318 virtual network link through opserver 10.0.0.41
2025-08-28 03:36:02,261 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-08-28 03:36:02,274 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318?flat'}
2025-08-28 03:36:02,274 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318 is found in opserver
2025-08-28 03:36:02,286 - DEBUG - VRF ids for VN ctest-vn2-39675318: {'10.0.0.65': '3', '10.0.0.27': '2'}
2025-08-28 03:36:02,286 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-28 03:36:02,292 - DEBUG - Requesting: http://10.0.0.19:8082/domain/692c5a68-a199-4232-a07c-1cd4918de9d4
2025-08-28 03:36:02,303 - DEBUG - Requesting: http://10.0.0.19:8082/project/a3f27b76-50d3-4bc7-921a-d9a8b7f6e8d0
2025-08-28 03:36:02,387 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/6f61ced0-159f-4a29-8762-27fd4ac1f880
2025-08-28 03:36:02,402 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/6f61ced0-159f-4a29-8762-27fd4ac1f880
2025-08-28 03:36:02,411 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7ccbdc25-96df-44ba-9196-015a7ef30bfe
2025-08-28 03:36:02,421 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7ccbdc25-96df-44ba-9196-015a7ef30bfe
2025-08-28 03:36:02,428 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/c1fc1dae-fc41-45ea-9ec1-43486755b388
2025-08-28 03:36:02,435 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-28 03:36:02,435 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/6f61ced0-159f-4a29-8762-27fd4ac1f880
2025-08-28 03:36:02,446 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7ccbdc25-96df-44ba-9196-015a7ef30bfe
2025-08-28 03:36:02,462 - INFO - Verified VN network id 12 for VN 6f61ced0-159f-4a29-8762-27fd4ac1f880
2025-08-28 03:36:02,462 - INFO - Verifications in API Server for VN ctest-vn1-49973789 passed
2025-08-28 03:36:02,462 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/6f61ced0-159f-4a29-8762-27fd4ac1f880
2025-08-28 03:36:02,473 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7ccbdc25-96df-44ba-9196-015a7ef30bfe
2025-08-28 03:36:02,481 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7ccbdc25-96df-44ba-9196-015a7ef30bfe
2025-08-28 03:36:02,490 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/c1fc1dae-fc41-45ea-9ec1-43486755b388
2025-08-28 03:36:02,503 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87368848', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8025923404062214697', 'uuid-lslong': '9755403711672350848'}, 'enable': 'true', 'created': '2025-08-28T03:34:42', 'last-modified': '2025-08-28T03:36:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.673242'}
2025-08-28 03:36:02,510 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-28 03:36:02,517 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87368848', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8025923404062214697', 'uuid-lslong': '9755403711672350848'}, 'enable': 'true', 'created': '2025-08-28T03:34:42', 'last-modified': '2025-08-28T03:36:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.681386'}
2025-08-28 03:36:02,524 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-28 03:36:02,529 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87368848', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '8025923404062214697', 'uuid-lslong': '9755403711672350848'}, 'enable': 'true', 'created': '2025-08-28T03:34:42', 'last-modified': '2025-08-28T03:36:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.693128'}
2025-08-28 03:36:02,536 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-28 03:36:02,536 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-49973789 passed
2025-08-28 03:36:02,536 - DEBUG - ====Verifying policy data for ctest-vn1-49973789 in API_Server ======
2025-08-28 03:36:02,536 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-28 03:36:02,542 - DEBUG - Requesting: http://10.0.0.19:8082/domain/692c5a68-a199-4232-a07c-1cd4918de9d4
2025-08-28 03:36:02,552 - DEBUG - Requesting: http://10.0.0.19:8082/project/a3f27b76-50d3-4bc7-921a-d9a8b7f6e8d0
2025-08-28 03:36:02,646 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/6f61ced0-159f-4a29-8762-27fd4ac1f880
2025-08-28 03:36:02,657 - DEBUG - ==>Verifying data for policy with id: 948a0871-8d46-433f-a889-7eb20c2ce5c6, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-87368848', 'policy1']
2025-08-28 03:36:02,657 - INFO - VN ctest-vn1-49973789 Policy verification: verify_vn_policy_in_api_server, status: True
2025-08-28 03:36:02,657 - DEBUG - Verifying the vn in opserver
2025-08-28 03:36:02,657 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789 virtual network link through opserver 10.0.0.19
2025-08-28 03:36:02,657 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-28 03:36:02,669 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789?flat'}
2025-08-28 03:36:02,669 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789 virtual network link through opserver 10.0.0.38
2025-08-28 03:36:02,669 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-28 03:36:02,682 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789?flat'}
2025-08-28 03:36:02,682 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789 virtual network link through opserver 10.0.0.41
2025-08-28 03:36:02,682 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-08-28 03:36:02,695 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789?flat'}
2025-08-28 03:36:02,695 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789 is found in opserver
2025-08-28 03:36:02,705 - DEBUG - VRF ids for VN ctest-vn1-49973789: {'10.0.0.65': '2'}
2025-08-28 03:36:02,705 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-28 03:36:02,711 - DEBUG - Requesting: http://10.0.0.19:8082/domain/692c5a68-a199-4232-a07c-1cd4918de9d4
2025-08-28 03:36:02,720 - DEBUG - Requesting: http://10.0.0.19:8082/project/a3f27b76-50d3-4bc7-921a-d9a8b7f6e8d0
2025-08-28 03:36:02,811 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/b5af1997-cbb6-4eef-99e2-16ef0fa59b5b
2025-08-28 03:36:02,821 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/b5af1997-cbb6-4eef-99e2-16ef0fa59b5b
2025-08-28 03:36:02,830 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/a3327707-e833-4950-bd61-a8f277874b03
2025-08-28 03:36:02,838 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/a3327707-e833-4950-bd61-a8f277874b03
2025-08-28 03:36:02,845 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/8c21e984-5717-4987-b8f1-d4bccd93001a
2025-08-28 03:36:02,851 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-28 03:36:02,851 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/b5af1997-cbb6-4eef-99e2-16ef0fa59b5b
2025-08-28 03:36:02,859 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/a3327707-e833-4950-bd61-a8f277874b03
2025-08-28 03:36:02,875 - INFO - Verified VN network id 13 for VN b5af1997-cbb6-4eef-99e2-16ef0fa59b5b
2025-08-28 03:36:02,876 - INFO - Verifications in API Server for VN ctest-vn2-39675318 passed
2025-08-28 03:36:02,876 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/b5af1997-cbb6-4eef-99e2-16ef0fa59b5b
2025-08-28 03:36:02,884 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/a3327707-e833-4950-bd61-a8f277874b03
2025-08-28 03:36:02,891 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/a3327707-e833-4950-bd61-a8f277874b03
2025-08-28 03:36:02,898 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/8c21e984-5717-4987-b8f1-d4bccd93001a
2025-08-28 03:36:02,910 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87368848', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13091710781537799919', 'uuid-lslong': '11088450448555088731'}, 'enable': 'true', 'created': '2025-08-28T03:35:17', 'last-modified': '2025-08-28T03:36:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.890087'}
2025-08-28 03:36:02,915 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-28 03:36:02,920 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87368848', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13091710781537799919', 'uuid-lslong': '11088450448555088731'}, 'enable': 'true', 'created': '2025-08-28T03:35:17', 'last-modified': '2025-08-28T03:36:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.901001'}
2025-08-28 03:36:02,929 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-28 03:36:02,934 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87368848', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13091710781537799919', 'uuid-lslong': '11088450448555088731'}, 'enable': 'true', 'created': '2025-08-28T03:35:17', 'last-modified': '2025-08-28T03:36:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.911596'}
2025-08-28 03:36:02,939 - DEBUG - Route Targets: ['target:64512:8000006']
2025-08-28 03:36:02,939 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-39675318 passed
2025-08-28 03:36:02,939 - DEBUG - ====Verifying policy data for ctest-vn2-39675318 in API_Server ======
2025-08-28 03:36:02,939 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-28 03:36:02,945 - DEBUG - Requesting: http://10.0.0.19:8082/domain/692c5a68-a199-4232-a07c-1cd4918de9d4
2025-08-28 03:36:02,954 - DEBUG - Requesting: http://10.0.0.19:8082/project/a3f27b76-50d3-4bc7-921a-d9a8b7f6e8d0
2025-08-28 03:36:03,040 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/b5af1997-cbb6-4eef-99e2-16ef0fa59b5b
2025-08-28 03:36:03,049 - DEBUG - ==>Verifying data for policy with id: 948a0871-8d46-433f-a889-7eb20c2ce5c6, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-87368848', 'policy1']
2025-08-28 03:36:03,049 - INFO - VN ctest-vn2-39675318 Policy verification: verify_vn_policy_in_api_server, status: True
2025-08-28 03:36:03,049 - DEBUG - Verifying the vn in opserver
2025-08-28 03:36:03,050 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318 virtual network link through opserver 10.0.0.19
2025-08-28 03:36:03,050 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-28 03:36:03,062 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318?flat'}
2025-08-28 03:36:03,062 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318 virtual network link through opserver 10.0.0.38
2025-08-28 03:36:03,062 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-28 03:36:03,076 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318?flat'}
2025-08-28 03:36:03,076 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318 virtual network link through opserver 10.0.0.41
2025-08-28 03:36:03,077 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-08-28 03:36:03,088 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318?flat'}
2025-08-28 03:36:03,088 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318 is found in opserver
2025-08-28 03:36:03,098 - DEBUG - VRF ids for VN ctest-vn2-39675318: {'10.0.0.65': '3', '10.0.0.27': '2'}
2025-08-28 03:36:03,099 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-28 03:36:03,104 - DEBUG - Requesting: http://10.0.0.19:8082/domain/692c5a68-a199-4232-a07c-1cd4918de9d4
2025-08-28 03:36:03,115 - DEBUG - Requesting: http://10.0.0.19:8082/project/a3f27b76-50d3-4bc7-921a-d9a8b7f6e8d0
2025-08-28 03:36:03,217 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/09226e3e-2872-4590-8a30-c91636a7d3e1
2025-08-28 03:36:03,229 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/09226e3e-2872-4590-8a30-c91636a7d3e1
2025-08-28 03:36:03,238 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/a5f386f5-0390-4a88-bc05-de7bc141f315
2025-08-28 03:36:03,246 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/a5f386f5-0390-4a88-bc05-de7bc141f315
2025-08-28 03:36:03,253 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/1c1223e9-4386-428a-8ab3-4a2d2847795c
2025-08-28 03:36:03,261 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-28 03:36:03,261 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/09226e3e-2872-4590-8a30-c91636a7d3e1
2025-08-28 03:36:03,271 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/a5f386f5-0390-4a88-bc05-de7bc141f315
2025-08-28 03:36:03,287 - INFO - Verified VN network id 14 for VN 09226e3e-2872-4590-8a30-c91636a7d3e1
2025-08-28 03:36:03,287 - INFO - Verifications in API Server for VN ctest-fip_vn-87931686 passed
2025-08-28 03:36:03,287 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/09226e3e-2872-4590-8a30-c91636a7d3e1
2025-08-28 03:36:03,301 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/a5f386f5-0390-4a88-bc05-de7bc141f315
2025-08-28 03:36:03,310 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/a5f386f5-0390-4a88-bc05-de7bc141f315
2025-08-28 03:36:03,319 - DEBUG - Requesting: http://10.0.0.19:8082/route-target/1c1223e9-4386-428a-8ab3-4a2d2847795c
2025-08-28 03:36:03,331 - DEBUG - Control-node 10.0.0.19 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-fip_vn-87931686', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87368848', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '658209708795118992', 'uuid-lslong': '9957679873359598561'}, 'enable': 'true', 'created': '2025-08-28T03:35:18', 'last-modified': '2025-08-28T03:35:18', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:44.720428'}
2025-08-28 03:36:03,336 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-28 03:36:03,343 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-fip_vn-87931686', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87368848', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '658209708795118992', 'uuid-lslong': '9957679873359598561'}, 'enable': 'true', 'created': '2025-08-28T03:35:18', 'last-modified': '2025-08-28T03:35:18', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:44.725591'}
2025-08-28 03:36:03,349 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-28 03:36:03,356 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-fip_vn-87931686', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-87368848', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '658209708795118992', 'uuid-lslong': '9957679873359598561'}, 'enable': 'true', 'created': '2025-08-28T03:35:18', 'last-modified': '2025-08-28T03:35:18', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:44.745685'}
2025-08-28 03:36:03,361 - DEBUG - Route Targets: ['target:64512:8000007']
2025-08-28 03:36:03,361 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-87931686 passed
2025-08-28 03:36:03,361 - DEBUG - ====Verifying policy data for ctest-fip_vn-87931686 in API_Server ======
2025-08-28 03:36:03,361 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-28 03:36:03,366 - DEBUG - Requesting: http://10.0.0.19:8082/domain/692c5a68-a199-4232-a07c-1cd4918de9d4
2025-08-28 03:36:03,377 - DEBUG - Requesting: http://10.0.0.19:8082/project/a3f27b76-50d3-4bc7-921a-d9a8b7f6e8d0
2025-08-28 03:36:03,466 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/09226e3e-2872-4590-8a30-c91636a7d3e1
2025-08-28 03:36:03,477 - DEBUG - =>VN ctest-fip_vn-87931686 has no policy to be verified
2025-08-28 03:36:03,477 - DEBUG - Verifying the vn in opserver
2025-08-28 03:36:03,477 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-fip_vn-87931686 virtual network link through opserver 10.0.0.19
2025-08-28 03:36:03,477 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/virtual-networks
2025-08-28 03:36:03,488 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-fip_vn-87931686', 'href': 'http://10.0.0.19:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-fip_vn-87931686?flat'}
2025-08-28 03:36:03,488 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-fip_vn-87931686 virtual network link through opserver 10.0.0.38
2025-08-28 03:36:03,488 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-08-28 03:36:03,502 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-fip_vn-87931686', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-fip_vn-87931686?flat'}
2025-08-28 03:36:03,502 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-fip_vn-87931686 virtual network link through opserver 10.0.0.41
2025-08-28 03:36:03,502 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-08-28 03:36:03,515 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-fip_vn-87931686', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-fip_vn-87931686?flat'}
2025-08-28 03:36:03,515 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-fip_vn-87931686 is found in opserver
2025-08-28 03:36:03,527 - DEBUG - VRF ids for VN ctest-fip_vn-87931686: {'10.0.0.27': '3'}
2025-08-28 03:36:03,527 - INFO - start time= 1756352163527542
2025-08-28 03:36:03,527 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 201.197.132.195, host_string: cirros@169.254.0.3, password: gocubsgogateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-08-28 03:36:03,528 - DEBUG - ping -s 56 -c 3 -W 1 201.197.132.195
2025-08-28 03:36:07,114 - DEBUG - PING 201.197.132.195 (201.197.132.195): 56 data bytes
64 bytes from 201.197.132.195: seq=0 ttl=63 time=3.118 ms
64 bytes from 201.197.132.195: seq=1 ttl=63 time=1.339 ms
64 bytes from 201.197.132.195: seq=2 ttl=63 time=1.196 ms
--- 201.197.132.195 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.196/1.884/3.118 ms
2025-08-28 03:36:07,114 - INFO - Ping to IP 201.197.132.195 from VM ctest-vn1_vm1-09669007 passed
2025-08-28 03:36:17,114 - INFO - Verify session samples and teardown pkts
2025-08-28 03:36:17,114 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.19
2025-08-28 03:36:17,118 - DEBUG - Posting: http://10.0.0.19:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1756352163527542, 'end_time': 1756352177118075, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-08-28 03:36:18,138 - DEBUG - [{'T': 1756352165779211}, {'T': 1756352166779281}, {'T': 1756352167779379}]
2025-08-28 03:36:18,138 - DEBUG - Posting: http://10.0.0.19:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1756352163527542, 'end_time': 1756352178138781, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-08-28 03:36:19,159 - DEBUG - [{'T': 1756352165950674}, {'T': 1756352166950787}, {'T': 1756352167950872}]
2025-08-28 03:36:19,159 - DEBUG - Posting: http://10.0.0.19:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1756352163527542, 'end_time': 1756352179159620, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-08-28 03:36:20,183 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'sample_count': 3}]
2025-08-28 03:36:20,183 - INFO - wait for the flows to get expire
2025-08-28 03:39:40,184 - DEBUG - Requesting: http://10.0.0.19:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-3956-1:Compute:contrail-vrouter-agent:0?flat
2025-08-28 03:39:40,219 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-3956-1?flat
2025-08-28 03:39:40,249 - DEBUG - Posting: http://10.0.0.19:8081/analytics/query, payload {'table': 'SessionRecordTable', 'start_time': 1756352163527542, 'end_time': 1756352380249577, 'select_fields': ['vn', 'remote_vn', 'forward_teardown_pkts', 'reverse_teardown_pkts'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-08-28 03:39:41,277 - DEBUG - [{'forward_flow_uuid': 'ba7e74eb-a96e-4cf7-b6ed-91f70d8a0c2e', 'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'reverse_flow_uuid': '4f798b2e-ca2a-4d28-bca1-6fcb52aeb10e', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'forward_teardown_pkts': 3, 'reverse_teardown_pkts': 3}]
2025-08-28 03:39:41,278 - DEBUG - Posting: http://10.0.0.19:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1756352163527542, 'end_time': 1756352381278047, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-08-28 03:39:42,295 - DEBUG - Posting: http://10.0.0.19:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1756352163527542, 'end_time': 1756352382295113, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-08-28 03:39:43,315 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318', 'sample_count': 4}]
2025-08-28 03:39:43,815 - INFO - Deleted policy policy1
2025-08-28 03:39:43,921 - INFO - Setting flow export rate: None
2025-08-28 03:39:45,205 - DEBUG - Skipping xmpp flap check
2025-08-28 03:39:45,205 - INFO - END TEST : test_verify_session_sampling_teardown : PASSED[0:03:46]
2025-08-28 03:39:45,205 - INFO - --------------------------------------------------------------------------------
2025-08-28 03:39:45,207 - INFO - Deleting VM mltf_vm
2025-08-28 03:39:45,273 - INFO - Deleting VM ctest-fvn_vm1-78149499
2025-08-28 03:39:45,333 - INFO - Deleting VM ctest-vn2_vm2-21174956
2025-08-28 03:39:45,401 - INFO - Deleting VN ctest-fip_vn-87931686
2025-08-28 03:39:45,447 - DEBUG - VN 09226e3e-2872-4590-8a30-c91636a7d3e1 still in use: Unable to complete operation on network 09226e3e-2872-4590-8a30-c91636a7d3e1. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-aabc9c95-a351-4c84-b8c9-73698ddfb11d']
2025-08-28 03:39:45,447 - WARNING - Deleting VN ctest-fip_vn-87931686 failed..Will retry
2025-08-28 03:39:47,637 - DEBUG - Response for deleting network ()
2025-08-28 03:39:47,637 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/a5f386f5-0390-4a88-bc05-de7bc141f315
2025-08-28 03:39:47,664 - DEBUG - Response Code: 404
2025-08-28 03:39:47,664 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-28 03:39:47,670 - DEBUG - Requesting: http://10.0.0.19:8082/domain/692c5a68-a199-4232-a07c-1cd4918de9d4
2025-08-28 03:39:47,705 - DEBUG - Requesting: http://10.0.0.19:8082/project/a3f27b76-50d3-4bc7-921a-d9a8b7f6e8d0
2025-08-28 03:39:47,805 - INFO - Validated that VN ctest-fip_vn-87931686 is not found in API Server
2025-08-28 03:39:47,826 - DEBUG - VN ctest-fip_vn-87931686 is not present in Agent 10.0.0.65
2025-08-28 03:39:47,836 - DEBUG - VN ctest-fip_vn-87931686 is not present in Agent 10.0.0.27
2025-08-28 03:39:47,836 - INFO - Validated that VN ctest-fip_vn-87931686 is not in any agent
2025-08-28 03:39:47,840 - DEBUG - VRF 3 is not seen in agent 10.0.0.27
2025-08-28 03:39:47,844 - DEBUG - Vrouter 10.0.0.27 does not have vrf 3 for VN ctest-fip_vn-87931686
2025-08-28 03:39:47,844 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-fip_vn-87931686
2025-08-28 03:39:47,862 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-87931686 info
2025-08-28 03:39:47,863 - INFO - Deleting VN ctest-vn2-39675318
2025-08-28 03:39:48,013 - DEBUG - Response for deleting network ()
2025-08-28 03:39:48,013 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/a3327707-e833-4950-bd61-a8f277874b03
2025-08-28 03:39:48,019 - DEBUG - Response Code: 404
2025-08-28 03:39:48,019 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-28 03:39:48,024 - DEBUG - Requesting: http://10.0.0.19:8082/domain/692c5a68-a199-4232-a07c-1cd4918de9d4
2025-08-28 03:39:48,091 - DEBUG - Requesting: http://10.0.0.19:8082/project/a3f27b76-50d3-4bc7-921a-d9a8b7f6e8d0
2025-08-28 03:39:48,179 - INFO - Validated that VN ctest-vn2-39675318 is not found in API Server
2025-08-28 03:39:48,190 - DEBUG - VN ctest-vn2-39675318 is not present in Agent 10.0.0.65
2025-08-28 03:39:48,199 - DEBUG - VN ctest-vn2-39675318 is not present in Agent 10.0.0.27
2025-08-28 03:39:48,199 - INFO - Validated that VN ctest-vn2-39675318 is not in any agent
2025-08-28 03:39:48,204 - DEBUG - VRF 3 is not seen in agent 10.0.0.65
2025-08-28 03:39:48,209 - DEBUG - Vrouter 10.0.0.65 does not have vrf 3 for VN ctest-vn2-39675318
2025-08-28 03:39:48,213 - DEBUG - VRF 2 is not seen in agent 10.0.0.27
2025-08-28 03:39:48,218 - DEBUG - Vrouter 10.0.0.27 does not have vrf 2 for VN ctest-vn2-39675318
2025-08-28 03:39:48,218 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn2-39675318
2025-08-28 03:39:48,236 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-39675318 info
2025-08-28 03:39:48,237 - INFO - Deleting VM ctest-vn1_vm2-88842818
2025-08-28 03:39:48,305 - INFO - Deleting VM ctest-vn1_vm1-09669007
2025-08-28 03:39:48,376 - INFO - Deleting VN ctest-vn1-49973789
2025-08-28 03:39:48,421 - DEBUG - VN 6f61ced0-159f-4a29-8762-27fd4ac1f880 still in use: Unable to complete operation on network 6f61ced0-159f-4a29-8762-27fd4ac1f880. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-8ac98499-233b-424d-9129-e890dc247c4a']
2025-08-28 03:39:48,421 - WARNING - Deleting VN ctest-vn1-49973789 failed..Will retry
2025-08-28 03:39:50,593 - DEBUG - Response for deleting network ()
2025-08-28 03:39:50,593 - DEBUG - Requesting: http://10.0.0.19:8082/routing-instance/7ccbdc25-96df-44ba-9196-015a7ef30bfe
2025-08-28 03:39:50,599 - DEBUG - Response Code: 404
2025-08-28 03:39:50,599 - DEBUG - Requesting: http://10.0.0.19:8082/domains
2025-08-28 03:39:50,605 - DEBUG - Requesting: http://10.0.0.19:8082/domain/692c5a68-a199-4232-a07c-1cd4918de9d4
2025-08-28 03:39:50,625 - DEBUG - Requesting: http://10.0.0.19:8082/project/a3f27b76-50d3-4bc7-921a-d9a8b7f6e8d0
2025-08-28 03:39:50,730 - INFO - Validated that VN ctest-vn1-49973789 is not found in API Server
2025-08-28 03:39:50,742 - DEBUG - VN ctest-vn1-49973789 is not present in Agent 10.0.0.65
2025-08-28 03:39:50,750 - DEBUG - VN ctest-vn1-49973789 is not present in Agent 10.0.0.27
2025-08-28 03:39:50,750 - INFO - Validated that VN ctest-vn1-49973789 is not in any agent
2025-08-28 03:39:50,755 - DEBUG - VRF 2 is not seen in agent 10.0.0.65
2025-08-28 03:39:50,760 - DEBUG - Vrouter 10.0.0.65 does not have vrf 2 for VN ctest-vn1-49973789
2025-08-28 03:39:50,760 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-87368848:ctest-vn1-49973789
2025-08-28 03:39:50,782 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-49973789 info
2025-08-28 03:39:51,528 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-87368848, ID : a3f27b76-50d3-4bc7-921a-d9a8b7f6e8d0