is in ACTIVE state now
2025-11-10 03:32:42,670 - INFO - VM name : mltf_vm
2025-11-10 03:32:42,754 - DEBUG - VM mltf_vm ID is 41391809-9761-4732-bfc6-d4bc43aa5c6a
2025-11-10 03:32:42,754 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-4674-1
2025-11-10 03:32:42,929 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/41391809-9761-4732-bfc6-d4bc43aa5c6a
2025-11-10 03:32:42,942 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/d33eca12-f6f1-481b-bacd-8c34839b29c0
2025-11-10 03:32:42,954 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/f2dca88a-1379-4cc9-8454-29cb041852e5
2025-11-10 03:32:44,142 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n64 bytes from 169.254.0.5: icmp_seq=1 ttl=63 time=2.35 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.464 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.464/1.406/2.348/0.942 ms')
2025-11-10 03:32:44,142 - INFO - Ping to Metadata IP 169.254.0.5 of VM mltf_vm passed
2025-11-10 03:32:44,209 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-10 03:32:44,209 - DEBUG - Waiting to SSH to VM mltf_vm, IP 211.184.165.69, Port 22
2025-11-10 03:32:44,375 - DEBUG - VM mltf_vm is ready for SSH connections
2025-11-10 03:32:44,445 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-10 03:32:44,446 - DEBUG - Waiting to SSH to VM mltf_vm, IP 211.184.165.69, Port 22
2025-11-10 03:32:44,615 - DEBUG - VM mltf_vm is ready for SSH connections
2025-11-10 03:32:44,617 - INFO - ================================================================================
2025-11-10 03:32:44,618 - INFO - STARTING TEST : test_verify_session_sampling_teardown
2025-11-10 03:32:44,618 - 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-11-10 03:32:45,899 - DEBUG - Skipping xmpp flap check
2025-11-10 03:32:45,899 - INFO - Initial checks done. Running the testcase now
2025-11-10 03:32:45,899 - INFO -
2025-11-10 03:32:46,041 - INFO - Setting flow export rate: 100
2025-11-10 03:32:46,089 - 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-11-10 03:32:46,425 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '6897525e-bb28-4674-aa4d-d2b4849cbd0c', 'name': 'ctest-vn1-64374441', 'tenant_id': '3f5a2708a3454e1aae4eb8c4d50b445f', 'project_id': '3f5a2708a3454e1aae4eb8c4d50b445f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['9730eff0-7545-446e-9666-b70e4d8c588a'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-02370580', 'ctest-vn1-64374441'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-02370580', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '211.184.165.64/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-11-10 03:32:46,616 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'e91d3bd8-9c5e-4d54-895b-149b4824926d', 'name': 'ctest-vn2-68724416', 'tenant_id': '3f5a2708a3454e1aae4eb8c4d50b445f', 'project_id': '3f5a2708a3454e1aae4eb8c4d50b445f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['58c1a682-34fc-4035-8542-f35a96026719'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-02370580', 'ctest-vn2-68724416'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-02370580', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '22.26.66.128/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-11-10 03:32:46,708 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2025-11-10 03:32:46,715 - DEBUG - Requesting: http://10.0.0.22:8082/domain/dbdabfa7-f87c-4117-b05b-68cc6fd252ce
2025-11-10 03:32:46,750 - DEBUG - Requesting: http://10.0.0.22:8082/project/3f5a2708-a345-4e1a-ae4e-b8c4d50b445f
2025-11-10 03:32:46,849 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/6897525e-bb28-4674-aa4d-d2b4849cbd0c
2025-11-10 03:32:46,862 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/6897525e-bb28-4674-aa4d-d2b4849cbd0c
2025-11-10 03:32:46,873 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/25c7e322-91bc-44a6-aba7-9e67e9e6ee0a
2025-11-10 03:32:46,886 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/25c7e322-91bc-44a6-aba7-9e67e9e6ee0a
2025-11-10 03:32:46,902 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/37d4ed34-37f8-4bd5-9c20-27f7506501fd
2025-11-10 03:32:46,918 - DEBUG - Route Targets: ['target:64512:8000004']
2025-11-10 03:32:46,918 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/6897525e-bb28-4674-aa4d-d2b4849cbd0c
2025-11-10 03:32:46,933 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/25c7e322-91bc-44a6-aba7-9e67e9e6ee0a
2025-11-10 03:32:46,953 - INFO - Verified VN network id 15 for VN 6897525e-bb28-4674-aa4d-d2b4849cbd0c
2025-11-10 03:32:46,954 - INFO - Verifications in API Server for VN ctest-vn1-64374441 passed
2025-11-10 03:32:46,954 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/6897525e-bb28-4674-aa4d-d2b4849cbd0c
2025-11-10 03:32:47,018 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/25c7e322-91bc-44a6-aba7-9e67e9e6ee0a
2025-11-10 03:32:47,028 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/25c7e322-91bc-44a6-aba7-9e67e9e6ee0a
2025-11-10 03:32:47,038 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/37d4ed34-37f8-4bd5-9c20-27f7506501fd
2025-11-10 03:32:47,060 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-02370580', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7536583068248196724', 'uuid-lslong': '12271696232415280396'}, 'enable': 'true', 'created': '2025-11-10T03:31:21', 'last-modified': '2025-11-10T03:32:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.665414'}
2025-11-10 03:32:47,074 - DEBUG - Route Targets: ['target:64512:8000004']
2025-11-10 03:32:47,083 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-02370580', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7536583068248196724', 'uuid-lslong': '12271696232415280396'}, 'enable': 'true', 'created': '2025-11-10T03:31:21', 'last-modified': '2025-11-10T03:32:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.688804'}
2025-11-10 03:32:47,091 - DEBUG - Route Targets: ['target:64512:8000004']
2025-11-10 03:32:47,118 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-02370580', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7536583068248196724', 'uuid-lslong': '12271696232415280396'}, 'enable': 'true', 'created': '2025-11-10T03:31:21', 'last-modified': '2025-11-10T03:32:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.710052'}
2025-11-10 03:32:47,127 - DEBUG - Route Targets: ['target:64512:8000004']
2025-11-10 03:32:47,127 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-64374441 passed
2025-11-10 03:32:47,127 - DEBUG - ====Verifying policy data for ctest-vn1-64374441 in API_Server ======
2025-11-10 03:32:47,127 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2025-11-10 03:32:47,140 - DEBUG - Requesting: http://10.0.0.22:8082/domain/dbdabfa7-f87c-4117-b05b-68cc6fd252ce
2025-11-10 03:32:47,188 - DEBUG - Requesting: http://10.0.0.22:8082/project/3f5a2708-a345-4e1a-ae4e-b8c4d50b445f
2025-11-10 03:32:47,276 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/6897525e-bb28-4674-aa4d-d2b4849cbd0c
2025-11-10 03:32:47,287 - DEBUG - ==>Verifying data for policy with id: 730cff31-9f0c-4a9b-8e66-51115d9e50b7, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-02370580', 'policy1']
2025-11-10 03:32:47,287 - INFO - VN ctest-vn1-64374441 Policy verification: verify_vn_policy_in_api_server, status: True
2025-11-10 03:32:47,287 - DEBUG - Verifying the vn in opserver
2025-11-10 03:32:47,287 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441 virtual network link through opserver 10.0.0.22
2025-11-10 03:32:47,287 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-11-10 03:32:47,301 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441?flat'}
2025-11-10 03:32:47,301 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441 virtual network link through opserver 10.0.0.50
2025-11-10 03:32:47,301 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-11-10 03:32:47,313 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441?flat'}
2025-11-10 03:32:47,313 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441 virtual network link through opserver 10.0.0.23
2025-11-10 03:32:47,313 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-11-10 03:32:47,328 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441?flat'}
2025-11-10 03:32:47,328 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441 is found in opserver
2025-11-10 03:32:47,338 - DEBUG - VRF ids for VN ctest-vn1-64374441: {'10.0.0.65': '2'}
2025-11-10 03:32:47,339 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2025-11-10 03:32:47,346 - DEBUG - Requesting: http://10.0.0.22:8082/domain/dbdabfa7-f87c-4117-b05b-68cc6fd252ce
2025-11-10 03:32:47,357 - DEBUG - Requesting: http://10.0.0.22:8082/project/3f5a2708-a345-4e1a-ae4e-b8c4d50b445f
2025-11-10 03:32:47,450 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/e91d3bd8-9c5e-4d54-895b-149b4824926d
2025-11-10 03:32:47,466 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/e91d3bd8-9c5e-4d54-895b-149b4824926d
2025-11-10 03:32:47,477 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/40d11918-4765-4545-ab6f-615e524071bb
2025-11-10 03:32:47,487 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/40d11918-4765-4545-ab6f-615e524071bb
2025-11-10 03:32:47,494 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/5606679d-420a-46de-9b48-dbfca038f9f6
2025-11-10 03:32:47,502 - DEBUG - Route Targets: ['target:64512:8000006']
2025-11-10 03:32:47,503 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/e91d3bd8-9c5e-4d54-895b-149b4824926d
2025-11-10 03:32:47,515 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/40d11918-4765-4545-ab6f-615e524071bb
2025-11-10 03:32:47,536 - INFO - Verified VN network id 16 for VN e91d3bd8-9c5e-4d54-895b-149b4824926d
2025-11-10 03:32:47,537 - INFO - Verifications in API Server for VN ctest-vn2-68724416 passed
2025-11-10 03:32:47,537 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/e91d3bd8-9c5e-4d54-895b-149b4824926d
2025-11-10 03:32:47,547 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/40d11918-4765-4545-ab6f-615e524071bb
2025-11-10 03:32:47,557 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/40d11918-4765-4545-ab6f-615e524071bb
2025-11-10 03:32:47,566 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/5606679d-420a-46de-9b48-dbfca038f9f6
2025-11-10 03:32:47,578 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-02370580', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16797647986684218708', 'uuid-lslong': '9897527263239639661'}, 'enable': 'true', 'created': '2025-11-10T03:32:00', 'last-modified': '2025-11-10T03:32:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.997113'}
2025-11-10 03:32:47,584 - DEBUG - Route Targets: ['target:64512:8000006']
2025-11-10 03:32:47,590 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-02370580', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16797647986684218708', 'uuid-lslong': '9897527263239639661'}, 'enable': 'true', 'created': '2025-11-10T03:32:00', 'last-modified': '2025-11-10T03:32:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.007286'}
2025-11-10 03:32:47,597 - DEBUG - Route Targets: ['target:64512:8000006']
2025-11-10 03:32:47,602 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-02370580', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16797647986684218708', 'uuid-lslong': '9897527263239639661'}, 'enable': 'true', 'created': '2025-11-10T03:32:00', 'last-modified': '2025-11-10T03:32:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.019761'}
2025-11-10 03:32:47,608 - DEBUG - Route Targets: ['target:64512:8000006']
2025-11-10 03:32:47,608 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-68724416 passed
2025-11-10 03:32:47,608 - DEBUG - ====Verifying policy data for ctest-vn2-68724416 in API_Server ======
2025-11-10 03:32:47,608 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2025-11-10 03:32:47,614 - DEBUG - Requesting: http://10.0.0.22:8082/domain/dbdabfa7-f87c-4117-b05b-68cc6fd252ce
2025-11-10 03:32:47,626 - DEBUG - Requesting: http://10.0.0.22:8082/project/3f5a2708-a345-4e1a-ae4e-b8c4d50b445f
2025-11-10 03:32:47,728 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/e91d3bd8-9c5e-4d54-895b-149b4824926d
2025-11-10 03:32:47,740 - DEBUG - ==>Verifying data for policy with id: 730cff31-9f0c-4a9b-8e66-51115d9e50b7, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-02370580', 'policy1']
2025-11-10 03:32:47,740 - INFO - VN ctest-vn2-68724416 Policy verification: verify_vn_policy_in_api_server, status: True
2025-11-10 03:32:47,740 - DEBUG - Verifying the vn in opserver
2025-11-10 03:32:47,740 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416 virtual network link through opserver 10.0.0.22
2025-11-10 03:32:47,740 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-11-10 03:32:47,752 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416?flat'}
2025-11-10 03:32:47,752 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416 virtual network link through opserver 10.0.0.50
2025-11-10 03:32:47,752 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-11-10 03:32:47,770 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416?flat'}
2025-11-10 03:32:47,770 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416 virtual network link through opserver 10.0.0.23
2025-11-10 03:32:47,770 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-11-10 03:32:47,783 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416?flat'}
2025-11-10 03:32:47,783 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416 is found in opserver
2025-11-10 03:32:47,793 - DEBUG - VRF ids for VN ctest-vn2-68724416: {'10.0.0.65': '3', '10.0.0.130': '2'}
2025-11-10 03:32:47,793 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2025-11-10 03:32:47,799 - DEBUG - Requesting: http://10.0.0.22:8082/domain/dbdabfa7-f87c-4117-b05b-68cc6fd252ce
2025-11-10 03:32:47,809 - DEBUG - Requesting: http://10.0.0.22:8082/project/3f5a2708-a345-4e1a-ae4e-b8c4d50b445f
2025-11-10 03:32:47,906 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/6897525e-bb28-4674-aa4d-d2b4849cbd0c
2025-11-10 03:32:47,920 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/6897525e-bb28-4674-aa4d-d2b4849cbd0c
2025-11-10 03:32:47,931 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/25c7e322-91bc-44a6-aba7-9e67e9e6ee0a
2025-11-10 03:32:47,942 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/25c7e322-91bc-44a6-aba7-9e67e9e6ee0a
2025-11-10 03:32:47,951 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/37d4ed34-37f8-4bd5-9c20-27f7506501fd
2025-11-10 03:32:47,959 - DEBUG - Route Targets: ['target:64512:8000004']
2025-11-10 03:32:47,959 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/6897525e-bb28-4674-aa4d-d2b4849cbd0c
2025-11-10 03:32:47,970 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/25c7e322-91bc-44a6-aba7-9e67e9e6ee0a
2025-11-10 03:32:47,985 - INFO - Verified VN network id 15 for VN 6897525e-bb28-4674-aa4d-d2b4849cbd0c
2025-11-10 03:32:47,985 - INFO - Verifications in API Server for VN ctest-vn1-64374441 passed
2025-11-10 03:32:47,985 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/6897525e-bb28-4674-aa4d-d2b4849cbd0c
2025-11-10 03:32:47,996 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/25c7e322-91bc-44a6-aba7-9e67e9e6ee0a
2025-11-10 03:32:48,004 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/25c7e322-91bc-44a6-aba7-9e67e9e6ee0a
2025-11-10 03:32:48,012 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/37d4ed34-37f8-4bd5-9c20-27f7506501fd
2025-11-10 03:32:48,028 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-02370580', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7536583068248196724', 'uuid-lslong': '12271696232415280396'}, 'enable': 'true', 'created': '2025-11-10T03:31:21', 'last-modified': '2025-11-10T03:32:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.631725'}
2025-11-10 03:32:48,036 - DEBUG - Route Targets: ['target:64512:8000004']
2025-11-10 03:32:48,041 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-02370580', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7536583068248196724', 'uuid-lslong': '12271696232415280396'}, 'enable': 'true', 'created': '2025-11-10T03:31:21', 'last-modified': '2025-11-10T03:32:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.647775'}
2025-11-10 03:32:48,048 - DEBUG - Route Targets: ['target:64512:8000004']
2025-11-10 03:32:48,055 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-02370580', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7536583068248196724', 'uuid-lslong': '12271696232415280396'}, 'enable': 'true', 'created': '2025-11-10T03:31:21', 'last-modified': '2025-11-10T03:32:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.663416'}
2025-11-10 03:32:48,060 - DEBUG - Route Targets: ['target:64512:8000004']
2025-11-10 03:32:48,060 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-64374441 passed
2025-11-10 03:32:48,060 - DEBUG - ====Verifying policy data for ctest-vn1-64374441 in API_Server ======
2025-11-10 03:32:48,060 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2025-11-10 03:32:48,066 - DEBUG - Requesting: http://10.0.0.22:8082/domain/dbdabfa7-f87c-4117-b05b-68cc6fd252ce
2025-11-10 03:32:48,077 - DEBUG - Requesting: http://10.0.0.22:8082/project/3f5a2708-a345-4e1a-ae4e-b8c4d50b445f
2025-11-10 03:32:48,188 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/6897525e-bb28-4674-aa4d-d2b4849cbd0c
2025-11-10 03:32:48,199 - DEBUG - ==>Verifying data for policy with id: 730cff31-9f0c-4a9b-8e66-51115d9e50b7, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-02370580', 'policy1']
2025-11-10 03:32:48,199 - INFO - VN ctest-vn1-64374441 Policy verification: verify_vn_policy_in_api_server, status: True
2025-11-10 03:32:48,199 - DEBUG - Verifying the vn in opserver
2025-11-10 03:32:48,199 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441 virtual network link through opserver 10.0.0.22
2025-11-10 03:32:48,199 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-11-10 03:32:48,212 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441?flat'}
2025-11-10 03:32:48,212 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441 virtual network link through opserver 10.0.0.50
2025-11-10 03:32:48,212 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-11-10 03:32:48,225 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441?flat'}
2025-11-10 03:32:48,225 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441 virtual network link through opserver 10.0.0.23
2025-11-10 03:32:48,225 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-11-10 03:32:48,238 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441?flat'}
2025-11-10 03:32:48,238 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441 is found in opserver
2025-11-10 03:32:48,249 - DEBUG - VRF ids for VN ctest-vn1-64374441: {'10.0.0.65': '2'}
2025-11-10 03:32:48,249 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2025-11-10 03:32:48,258 - DEBUG - Requesting: http://10.0.0.22:8082/domain/dbdabfa7-f87c-4117-b05b-68cc6fd252ce
2025-11-10 03:32:48,271 - DEBUG - Requesting: http://10.0.0.22:8082/project/3f5a2708-a345-4e1a-ae4e-b8c4d50b445f
2025-11-10 03:32:48,372 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/e91d3bd8-9c5e-4d54-895b-149b4824926d
2025-11-10 03:32:48,390 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/e91d3bd8-9c5e-4d54-895b-149b4824926d
2025-11-10 03:32:48,400 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/40d11918-4765-4545-ab6f-615e524071bb
2025-11-10 03:32:48,409 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/40d11918-4765-4545-ab6f-615e524071bb
2025-11-10 03:32:48,426 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/5606679d-420a-46de-9b48-dbfca038f9f6
2025-11-10 03:32:48,433 - DEBUG - Route Targets: ['target:64512:8000006']
2025-11-10 03:32:48,433 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/e91d3bd8-9c5e-4d54-895b-149b4824926d
2025-11-10 03:32:48,443 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/40d11918-4765-4545-ab6f-615e524071bb
2025-11-10 03:32:48,459 - INFO - Verified VN network id 16 for VN e91d3bd8-9c5e-4d54-895b-149b4824926d
2025-11-10 03:32:48,459 - INFO - Verifications in API Server for VN ctest-vn2-68724416 passed
2025-11-10 03:32:48,459 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/e91d3bd8-9c5e-4d54-895b-149b4824926d
2025-11-10 03:32:48,471 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/40d11918-4765-4545-ab6f-615e524071bb
2025-11-10 03:32:48,479 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/40d11918-4765-4545-ab6f-615e524071bb
2025-11-10 03:32:48,487 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/5606679d-420a-46de-9b48-dbfca038f9f6
2025-11-10 03:32:48,500 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-02370580', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16797647986684218708', 'uuid-lslong': '9897527263239639661'}, 'enable': 'true', 'created': '2025-11-10T03:32:00', 'last-modified': '2025-11-10T03:32:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.919069'}
2025-11-10 03:32:48,506 - DEBUG - Route Targets: ['target:64512:8000006']
2025-11-10 03:32:48,512 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-02370580', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16797647986684218708', 'uuid-lslong': '9897527263239639661'}, 'enable': 'true', 'created': '2025-11-10T03:32:00', 'last-modified': '2025-11-10T03:32:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.929687'}
2025-11-10 03:32:48,519 - DEBUG - Route Targets: ['target:64512:8000006']
2025-11-10 03:32:48,526 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-02370580', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16797647986684218708', 'uuid-lslong': '9897527263239639661'}, 'enable': 'true', 'created': '2025-11-10T03:32:00', 'last-modified': '2025-11-10T03:32:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.943307'}
2025-11-10 03:32:48,534 - DEBUG - Route Targets: ['target:64512:8000006']
2025-11-10 03:32:48,534 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-68724416 passed
2025-11-10 03:32:48,535 - DEBUG - ====Verifying policy data for ctest-vn2-68724416 in API_Server ======
2025-11-10 03:32:48,535 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2025-11-10 03:32:48,543 - DEBUG - Requesting: http://10.0.0.22:8082/domain/dbdabfa7-f87c-4117-b05b-68cc6fd252ce
2025-11-10 03:32:48,555 - DEBUG - Requesting: http://10.0.0.22:8082/project/3f5a2708-a345-4e1a-ae4e-b8c4d50b445f
2025-11-10 03:32:48,648 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/e91d3bd8-9c5e-4d54-895b-149b4824926d
2025-11-10 03:32:48,658 - DEBUG - ==>Verifying data for policy with id: 730cff31-9f0c-4a9b-8e66-51115d9e50b7, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-02370580', 'policy1']
2025-11-10 03:32:48,658 - INFO - VN ctest-vn2-68724416 Policy verification: verify_vn_policy_in_api_server, status: True
2025-11-10 03:32:48,658 - DEBUG - Verifying the vn in opserver
2025-11-10 03:32:48,658 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416 virtual network link through opserver 10.0.0.22
2025-11-10 03:32:48,658 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-11-10 03:32:48,670 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416?flat'}
2025-11-10 03:32:48,670 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416 virtual network link through opserver 10.0.0.50
2025-11-10 03:32:48,670 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-11-10 03:32:48,685 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416?flat'}
2025-11-10 03:32:48,686 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416 virtual network link through opserver 10.0.0.23
2025-11-10 03:32:48,686 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-11-10 03:32:48,698 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416?flat'}
2025-11-10 03:32:48,698 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416 is found in opserver
2025-11-10 03:32:48,709 - DEBUG - VRF ids for VN ctest-vn2-68724416: {'10.0.0.65': '3', '10.0.0.130': '2'}
2025-11-10 03:32:48,710 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2025-11-10 03:32:48,716 - DEBUG - Requesting: http://10.0.0.22:8082/domain/dbdabfa7-f87c-4117-b05b-68cc6fd252ce
2025-11-10 03:32:48,728 - DEBUG - Requesting: http://10.0.0.22:8082/project/3f5a2708-a345-4e1a-ae4e-b8c4d50b445f
2025-11-10 03:32:48,826 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/bcaf9d3a-bdbc-46a5-92c5-6563bc2628bf
2025-11-10 03:32:48,837 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/bcaf9d3a-bdbc-46a5-92c5-6563bc2628bf
2025-11-10 03:32:48,848 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/39c2a2d0-20f2-45dd-bb51-186f5bac9325
2025-11-10 03:32:48,857 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/39c2a2d0-20f2-45dd-bb51-186f5bac9325
2025-11-10 03:32:48,865 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/c2f2a614-599a-45bc-8f97-d99294d32818
2025-11-10 03:32:48,873 - DEBUG - Route Targets: ['target:64512:8000007']
2025-11-10 03:32:48,873 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/bcaf9d3a-bdbc-46a5-92c5-6563bc2628bf
2025-11-10 03:32:48,884 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/39c2a2d0-20f2-45dd-bb51-186f5bac9325
2025-11-10 03:32:48,902 - INFO - Verified VN network id 17 for VN bcaf9d3a-bdbc-46a5-92c5-6563bc2628bf
2025-11-10 03:32:48,902 - INFO - Verifications in API Server for VN ctest-fip_vn-36811114 passed
2025-11-10 03:32:48,902 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/bcaf9d3a-bdbc-46a5-92c5-6563bc2628bf
2025-11-10 03:32:48,912 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/39c2a2d0-20f2-45dd-bb51-186f5bac9325
2025-11-10 03:32:48,921 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/39c2a2d0-20f2-45dd-bb51-186f5bac9325
2025-11-10 03:32:48,929 - DEBUG - Requesting: http://10.0.0.22:8082/route-target/c2f2a614-599a-45bc-8f97-d99294d32818
2025-11-10 03:32:48,942 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-fip_vn-36811114', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-02370580', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13596258675671713445', 'uuid-lslong': '10575970778982262975'}, 'enable': 'true', 'created': '2025-11-10T03:32:01', 'last-modified': '2025-11-10T03:32:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:47.216088'}
2025-11-10 03:32:48,949 - DEBUG - Route Targets: ['target:64512:8000007']
2025-11-10 03:32:48,955 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-fip_vn-36811114', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-02370580', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13596258675671713445', 'uuid-lslong': '10575970778982262975'}, 'enable': 'true', 'created': '2025-11-10T03:32:01', 'last-modified': '2025-11-10T03:32:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:47.233955'}
2025-11-10 03:32:48,962 - DEBUG - Route Targets: ['target:64512:8000007']
2025-11-10 03:32:48,968 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-fip_vn-36811114', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-02370580', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13596258675671713445', 'uuid-lslong': '10575970778982262975'}, 'enable': 'true', 'created': '2025-11-10T03:32:01', 'last-modified': '2025-11-10T03:32:01', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:47.242214'}
2025-11-10 03:32:48,974 - DEBUG - Route Targets: ['target:64512:8000007']
2025-11-10 03:32:48,974 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-36811114 passed
2025-11-10 03:32:48,974 - DEBUG - ====Verifying policy data for ctest-fip_vn-36811114 in API_Server ======
2025-11-10 03:32:48,974 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2025-11-10 03:32:48,982 - DEBUG - Requesting: http://10.0.0.22:8082/domain/dbdabfa7-f87c-4117-b05b-68cc6fd252ce
2025-11-10 03:32:48,995 - DEBUG - Requesting: http://10.0.0.22:8082/project/3f5a2708-a345-4e1a-ae4e-b8c4d50b445f
2025-11-10 03:32:49,100 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-network/bcaf9d3a-bdbc-46a5-92c5-6563bc2628bf
2025-11-10 03:32:49,111 - DEBUG - =>VN ctest-fip_vn-36811114 has no policy to be verified
2025-11-10 03:32:49,111 - DEBUG - Verifying the vn in opserver
2025-11-10 03:32:49,112 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-fip_vn-36811114 virtual network link through opserver 10.0.0.22
2025-11-10 03:32:49,112 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2025-11-10 03:32:49,125 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-fip_vn-36811114', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-fip_vn-36811114?flat'}
2025-11-10 03:32:49,125 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-fip_vn-36811114 virtual network link through opserver 10.0.0.50
2025-11-10 03:32:49,125 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-11-10 03:32:49,139 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-fip_vn-36811114', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-fip_vn-36811114?flat'}
2025-11-10 03:32:49,139 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-fip_vn-36811114 virtual network link through opserver 10.0.0.23
2025-11-10 03:32:49,139 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-11-10 03:32:49,151 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-fip_vn-36811114', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-fip_vn-36811114?flat'}
2025-11-10 03:32:49,151 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-fip_vn-36811114 is found in opserver
2025-11-10 03:32:49,163 - DEBUG - VRF ids for VN ctest-fip_vn-36811114: {'10.0.0.130': '3'}
2025-11-10 03:32:49,163 - INFO - start time= 1762745569163309
2025-11-10 03:32:49,163 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 22.26.66.131, host_string: cirros@169.254.0.3, password: gocubsgogateway: ubuntu@10.0.0.65, gateway password: c0ntrail123
2025-11-10 03:32:49,163 - DEBUG - ping -s 56 -c 3 -W 1 22.26.66.131
2025-11-10 03:32:52,818 - DEBUG - PING 22.26.66.131 (22.26.66.131): 56 data bytes
64 bytes from 22.26.66.131: seq=0 ttl=63 time=5.571 ms
64 bytes from 22.26.66.131: seq=1 ttl=63 time=1.344 ms
64 bytes from 22.26.66.131: seq=2 ttl=63 time=1.505 ms
--- 22.26.66.131 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.344/2.806/5.571 ms
2025-11-10 03:32:52,818 - INFO - Ping to IP 22.26.66.131 from VM ctest-vn1_vm1-15671305 passed
2025-11-10 03:33:02,819 - INFO - Verify session samples and teardown pkts
2025-11-10 03:33:02,819 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.22
2025-11-10 03:33:02,823 - DEBUG - Posting: http://10.0.0.22:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1762745569163309, 'end_time': 1762745582823204, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-11-10 03:33:03,856 - DEBUG - [{'T': 1762745571441901}, {'T': 1762745572442016}, {'T': 1762745573442106}]
2025-11-10 03:33:03,857 - DEBUG - Posting: http://10.0.0.22:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1762745569163309, 'end_time': 1762745583857101, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-11-10 03:33:04,882 - DEBUG - [{'T': 1762745571608791}, {'T': 1762745572608888}, {'T': 1762745573608979}]
2025-11-10 03:33:04,882 - DEBUG - Posting: http://10.0.0.22:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1762745569163309, 'end_time': 1762745584882776, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-11-10 03:33:05,907 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'sample_count': 3}]
2025-11-10 03:33:05,907 - INFO - wait for the flows to get expire
2025-11-10 03:36:25,909 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4674-1:Compute:contrail-vrouter-agent:0?flat
2025-11-10 03:36:25,956 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4674-1?flat
2025-11-10 03:36:25,993 - DEBUG - Posting: http://10.0.0.22:8081/analytics/query, payload {'table': 'SessionRecordTable', 'start_time': 1762745569163309, 'end_time': 1762745785993396, 'select_fields': ['vn', 'remote_vn', 'forward_teardown_pkts', 'reverse_teardown_pkts'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-11-10 03:36:27,016 - DEBUG - [{'forward_flow_uuid': '64e3119c-c554-4051-8fee-721d771c685a', 'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'reverse_flow_uuid': 'fe7a33ff-bec9-42bc-9747-e2add4d76fc0', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'forward_teardown_pkts': 3, 'reverse_teardown_pkts': 3}]
2025-11-10 03:36:27,016 - DEBUG - Posting: http://10.0.0.22:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1762745569163309, 'end_time': 1762745787016274, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-11-10 03:36:28,038 - DEBUG - Posting: http://10.0.0.22:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1762745569163309, 'end_time': 1762745788038707, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-11-10 03:36:29,106 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416', 'sample_count': 4}]
2025-11-10 03:36:29,643 - INFO - Deleted policy policy1
2025-11-10 03:36:29,756 - INFO - Setting flow export rate: None
2025-11-10 03:36:31,048 - DEBUG - Skipping xmpp flap check
2025-11-10 03:36:31,048 - INFO - END TEST : test_verify_session_sampling_teardown : PASSED[0:03:47]
2025-11-10 03:36:31,048 - INFO - --------------------------------------------------------------------------------
2025-11-10 03:36:31,050 - INFO - Deleting VM mltf_vm
2025-11-10 03:36:31,130 - INFO - Deleting VM ctest-fvn_vm1-05973473
2025-11-10 03:36:31,201 - INFO - Deleting VM ctest-vn2_vm2-46041920
2025-11-10 03:36:31,300 - INFO - Deleting VN ctest-fip_vn-36811114
2025-11-10 03:36:31,351 - DEBUG - VN bcaf9d3a-bdbc-46a5-92c5-6563bc2628bf still in use: Unable to complete operation on network bcaf9d3a-bdbc-46a5-92c5-6563bc2628bf. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-561e3469-8c3c-428a-b293-c3ed107ab9ea']
2025-11-10 03:36:31,351 - WARNING - Deleting VN ctest-fip_vn-36811114 failed..Will retry
2025-11-10 03:36:33,557 - DEBUG - Response for deleting network ()
2025-11-10 03:36:33,557 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/39c2a2d0-20f2-45dd-bb51-186f5bac9325
2025-11-10 03:36:33,608 - DEBUG - Response Code: 404
2025-11-10 03:36:33,609 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2025-11-10 03:36:33,616 - DEBUG - Requesting: http://10.0.0.22:8082/domain/dbdabfa7-f87c-4117-b05b-68cc6fd252ce
2025-11-10 03:36:33,635 - DEBUG - Requesting: http://10.0.0.22:8082/project/3f5a2708-a345-4e1a-ae4e-b8c4d50b445f
2025-11-10 03:36:33,736 - INFO - Validated that VN ctest-fip_vn-36811114 is not found in API Server
2025-11-10 03:36:33,747 - DEBUG - VN ctest-fip_vn-36811114 is not present in Agent 10.0.0.65
2025-11-10 03:36:33,758 - DEBUG - VN ctest-fip_vn-36811114 is not present in Agent 10.0.0.130
2025-11-10 03:36:33,758 - INFO - Validated that VN ctest-fip_vn-36811114 is not in any agent
2025-11-10 03:36:33,763 - DEBUG - VRF 3 is not seen in agent 10.0.0.130
2025-11-10 03:36:33,769 - DEBUG - Vrouter 10.0.0.130 does not have vrf 3 for VN ctest-fip_vn-36811114
2025-11-10 03:36:33,769 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-fip_vn-36811114
2025-11-10 03:36:33,790 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-36811114 info
2025-11-10 03:36:33,790 - INFO - Deleting VN ctest-vn2-68724416
2025-11-10 03:36:33,957 - DEBUG - Response for deleting network ()
2025-11-10 03:36:33,958 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/40d11918-4765-4545-ab6f-615e524071bb
2025-11-10 03:36:33,965 - DEBUG - Response Code: 404
2025-11-10 03:36:33,965 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2025-11-10 03:36:33,978 - DEBUG - Requesting: http://10.0.0.22:8082/domain/dbdabfa7-f87c-4117-b05b-68cc6fd252ce
2025-11-10 03:36:34,003 - DEBUG - Requesting: http://10.0.0.22:8082/project/3f5a2708-a345-4e1a-ae4e-b8c4d50b445f
2025-11-10 03:36:34,106 - INFO - Validated that VN ctest-vn2-68724416 is not found in API Server
2025-11-10 03:36:34,120 - DEBUG - VN ctest-vn2-68724416 is not present in Agent 10.0.0.65
2025-11-10 03:36:34,135 - DEBUG - VN ctest-vn2-68724416 is not present in Agent 10.0.0.130
2025-11-10 03:36:34,135 - INFO - Validated that VN ctest-vn2-68724416 is not in any agent
2025-11-10 03:36:34,141 - DEBUG - VRF 3 is not seen in agent 10.0.0.65
2025-11-10 03:36:34,147 - DEBUG - Vrouter 10.0.0.65 does not have vrf 3 for VN ctest-vn2-68724416
2025-11-10 03:36:34,153 - DEBUG - VRF 2 is not seen in agent 10.0.0.130
2025-11-10 03:36:34,158 - DEBUG - Vrouter 10.0.0.130 does not have vrf 2 for VN ctest-vn2-68724416
2025-11-10 03:36:34,158 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn2-68724416
2025-11-10 03:36:34,179 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-68724416 info
2025-11-10 03:36:34,179 - INFO - Deleting VM ctest-vn1_vm2-59961248
2025-11-10 03:36:34,253 - INFO - Deleting VM ctest-vn1_vm1-15671305
2025-11-10 03:36:34,323 - INFO - Deleting VN ctest-vn1-64374441
2025-11-10 03:36:34,373 - DEBUG - VN 6897525e-bb28-4674-aa4d-d2b4849cbd0c still in use: Unable to complete operation on network 6897525e-bb28-4674-aa4d-d2b4849cbd0c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-9c6f9b7a-21a1-4081-bafb-0ec4c4342de9']
2025-11-10 03:36:34,373 - WARNING - Deleting VN ctest-vn1-64374441 failed..Will retry
2025-11-10 03:36:36,556 - DEBUG - Response for deleting network ()
2025-11-10 03:36:36,556 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/25c7e322-91bc-44a6-aba7-9e67e9e6ee0a
2025-11-10 03:36:36,568 - DEBUG - Response Code: 404
2025-11-10 03:36:36,568 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2025-11-10 03:36:36,585 - DEBUG - Requesting: http://10.0.0.22:8082/domain/dbdabfa7-f87c-4117-b05b-68cc6fd252ce
2025-11-10 03:36:36,601 - DEBUG - Requesting: http://10.0.0.22:8082/project/3f5a2708-a345-4e1a-ae4e-b8c4d50b445f
2025-11-10 03:36:36,703 - INFO - Validated that VN ctest-vn1-64374441 is not found in API Server
2025-11-10 03:36:36,715 - DEBUG - VN ctest-vn1-64374441 is not present in Agent 10.0.0.65
2025-11-10 03:36:36,730 - DEBUG - VN ctest-vn1-64374441 is not present in Agent 10.0.0.130
2025-11-10 03:36:36,730 - INFO - Validated that VN ctest-vn1-64374441 is not in any agent
2025-11-10 03:36:36,738 - DEBUG - VRF 2 is not seen in agent 10.0.0.65
2025-11-10 03:36:36,745 - DEBUG - Vrouter 10.0.0.65 does not have vrf 2 for VN ctest-vn1-64374441
2025-11-10 03:36:36,745 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-02370580:ctest-vn1-64374441
2025-11-10 03:36:36,781 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-64374441 info
2025-11-10 03:36:37,579 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-02370580, ID : 3f5a2708-a345-4e1a-ae4e-b8c4d50b445f