is in ACTIVE state now
2025-10-31 16:23:49,209 - INFO - VM name : mltf_vm
2025-10-31 16:23:49,287 - DEBUG - VM mltf_vm ID is e0b0ee7d-9c62-4cab-a1d8-fbc63eceab86
2025-10-31 16:23:49,287 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-4577-1
2025-10-31 16:23:49,451 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/e0b0ee7d-9c62-4cab-a1d8-fbc63eceab86
2025-10-31 16:23:49,461 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/b44eb00d-a5f1-4921-b6e7-2a7a9b18264d
2025-10-31 16:23:49,471 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/ff1bb869-4773-426f-8d18-1e35424ebf98
2025-10-31 16:23:50,649 - 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=3.30 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=1.54 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 = 1.540/2.419/3.299/0.879 ms')
2025-10-31 16:23:50,649 - INFO - Ping to Metadata IP 169.254.0.5 of VM mltf_vm passed
2025-10-31 16:23:50,724 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-31 16:23:50,724 - DEBUG - Waiting to SSH to VM mltf_vm, IP 71.144.121.5, Port 22
2025-10-31 16:23:50,885 - DEBUG - VM mltf_vm is ready for SSH connections
2025-10-31 16:23:50,956 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-31 16:23:50,956 - DEBUG - Waiting to SSH to VM mltf_vm, IP 71.144.121.5, Port 22
2025-10-31 16:23:51,122 - DEBUG - VM mltf_vm is ready for SSH connections
2025-10-31 16:23:51,124 - INFO - ================================================================================
2025-10-31 16:23:51,124 - INFO - STARTING TEST : test_verify_session_sampling_teardown
2025-10-31 16:23:51,125 - INFO - TEST DESCRIPTION :
1.query client session samples
2.query server session samples
3.query client session to get number of sessions exported
4.query session record table for teardown bytes/pkts
5.query sample count after teardown on server side
2025-10-31 16:23:52,405 - DEBUG - Skipping xmpp flap check
2025-10-31 16:23:52,405 - INFO - Initial checks done. Running the testcase now
2025-10-31 16:23:52,405 - INFO -
2025-10-31 16:23:52,530 - INFO - Setting flow export rate: 100
2025-10-31 16:23:52,579 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = any, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = any, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None]
2025-10-31 16:23:52,926 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'aee05370-742e-4429-a4dd-c72e24bd4909', 'name': 'ctest-vn1-74232823', 'tenant_id': '335b6c6e81dc404fbf10e9c59e981cbf', 'project_id': '335b6c6e81dc404fbf10e9c59e981cbf', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['1540845f-b421-4372-b522-468f28b0d65f'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-72421903', 'ctest-vn1-74232823'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-72421903', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '71.144.121.0/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-10-31 16:23:53,115 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'cedd5539-6c3c-4911-9066-b8f139412c37', 'name': 'ctest-vn2-87870431', 'tenant_id': '335b6c6e81dc404fbf10e9c59e981cbf', 'project_id': '335b6c6e81dc404fbf10e9c59e981cbf', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['79633f18-c514-4fc7-9191-d5b9b6b1c280'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-72421903', 'ctest-vn2-87870431'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-72421903', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '100.54.159.192/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-10-31 16:23:53,210 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-10-31 16:23:53,222 - DEBUG - Requesting: http://10.0.0.38:8082/domain/84461aec-f8f2-4c85-873b-ef5843450b69
2025-10-31 16:23:53,260 - DEBUG - Requesting: http://10.0.0.38:8082/project/335b6c6e-81dc-404f-bf10-e9c59e981cbf
2025-10-31 16:23:53,383 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/aee05370-742e-4429-a4dd-c72e24bd4909
2025-10-31 16:23:53,399 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/aee05370-742e-4429-a4dd-c72e24bd4909
2025-10-31 16:23:53,410 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/5e06862b-6cd6-4383-8859-cdff4f401582
2025-10-31 16:23:53,419 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/5e06862b-6cd6-4383-8859-cdff4f401582
2025-10-31 16:23:53,427 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/98b30a88-cfbb-4837-b799-fe88258f7d11
2025-10-31 16:23:53,434 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-31 16:23:53,434 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/aee05370-742e-4429-a4dd-c72e24bd4909
2025-10-31 16:23:53,448 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/5e06862b-6cd6-4383-8859-cdff4f401582
2025-10-31 16:23:53,469 - INFO - Verified VN network id 15 for VN aee05370-742e-4429-a4dd-c72e24bd4909
2025-10-31 16:23:53,469 - INFO - Verifications in API Server for VN ctest-vn1-74232823 passed
2025-10-31 16:23:53,469 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/aee05370-742e-4429-a4dd-c72e24bd4909
2025-10-31 16:23:53,513 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/5e06862b-6cd6-4383-8859-cdff4f401582
2025-10-31 16:23:53,525 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/5e06862b-6cd6-4383-8859-cdff4f401582
2025-10-31 16:23:53,535 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/98b30a88-cfbb-4837-b799-fe88258f7d11
2025-10-31 16:23:53,546 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-72421903', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12601163499833279529', 'uuid-lslong': '11879870393072044297'}, 'enable': 'true', 'created': '2025-10-31T16:22:27', 'last-modified': '2025-10-31T16:23:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.656351'}
2025-10-31 16:23:53,559 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-31 16:23:53,566 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-72421903', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12601163499833279529', 'uuid-lslong': '11879870393072044297'}, 'enable': 'true', 'created': '2025-10-31T16:22:27', 'last-modified': '2025-10-31T16:23:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.682297'}
2025-10-31 16:23:53,575 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-31 16:23:53,584 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-72421903', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12601163499833279529', 'uuid-lslong': '11879870393072044297'}, 'enable': 'true', 'created': '2025-10-31T16:22:27', 'last-modified': '2025-10-31T16:23:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.699177'}
2025-10-31 16:23:53,591 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-31 16:23:53,591 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-74232823 passed
2025-10-31 16:23:53,591 - DEBUG - ====Verifying policy data for ctest-vn1-74232823 in API_Server ======
2025-10-31 16:23:53,591 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-10-31 16:23:53,600 - DEBUG - Requesting: http://10.0.0.38:8082/domain/84461aec-f8f2-4c85-873b-ef5843450b69
2025-10-31 16:23:53,617 - DEBUG - Requesting: http://10.0.0.38:8082/project/335b6c6e-81dc-404f-bf10-e9c59e981cbf
2025-10-31 16:23:53,762 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/aee05370-742e-4429-a4dd-c72e24bd4909
2025-10-31 16:23:53,777 - DEBUG - ==>Verifying data for policy with id: 8c3e9dc5-2e65-4349-a5c7-66d978c8685a, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-72421903', 'policy1']
2025-10-31 16:23:53,778 - INFO - VN ctest-vn1-74232823 Policy verification: verify_vn_policy_in_api_server, status: True
2025-10-31 16:23:53,778 - DEBUG - Verifying the vn in opserver
2025-10-31 16:23:53,778 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823 virtual network link through opserver 10.0.0.38
2025-10-31 16:23:53,778 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-10-31 16:23:53,793 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823?flat'}
2025-10-31 16:23:53,793 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823 virtual network link through opserver 10.0.0.249
2025-10-31 16:23:53,793 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-31 16:23:53,810 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823?flat'}
2025-10-31 16:23:53,811 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823 virtual network link through opserver 10.0.0.65
2025-10-31 16:23:53,811 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-10-31 16:23:53,825 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823?flat'}
2025-10-31 16:23:53,825 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823 is found in opserver
2025-10-31 16:23:53,836 - DEBUG - VRF ids for VN ctest-vn1-74232823: {'10.0.0.19': '2'}
2025-10-31 16:23:53,836 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-10-31 16:23:53,842 - DEBUG - Requesting: http://10.0.0.38:8082/domain/84461aec-f8f2-4c85-873b-ef5843450b69
2025-10-31 16:23:53,852 - DEBUG - Requesting: http://10.0.0.38:8082/project/335b6c6e-81dc-404f-bf10-e9c59e981cbf
2025-10-31 16:23:53,944 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cedd5539-6c3c-4911-9066-b8f139412c37
2025-10-31 16:23:53,956 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cedd5539-6c3c-4911-9066-b8f139412c37
2025-10-31 16:23:53,967 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/432bc1a6-059a-4499-8e7c-08be2a431f07
2025-10-31 16:23:53,976 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/432bc1a6-059a-4499-8e7c-08be2a431f07
2025-10-31 16:23:53,984 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/43030668-6e8d-4850-a603-34f69e8472f3
2025-10-31 16:23:53,991 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-31 16:23:53,992 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cedd5539-6c3c-4911-9066-b8f139412c37
2025-10-31 16:23:54,002 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/432bc1a6-059a-4499-8e7c-08be2a431f07
2025-10-31 16:23:54,031 - INFO - Verified VN network id 16 for VN cedd5539-6c3c-4911-9066-b8f139412c37
2025-10-31 16:23:54,031 - INFO - Verifications in API Server for VN ctest-vn2-87870431 passed
2025-10-31 16:23:54,031 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cedd5539-6c3c-4911-9066-b8f139412c37
2025-10-31 16:23:54,042 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/432bc1a6-059a-4499-8e7c-08be2a431f07
2025-10-31 16:23:54,049 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/432bc1a6-059a-4499-8e7c-08be2a431f07
2025-10-31 16:23:54,058 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/43030668-6e8d-4850-a603-34f69e8472f3
2025-10-31 16:23:54,074 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-72421903', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14906164046783596817', 'uuid-lslong': '10405207335273311287'}, 'enable': 'true', 'created': '2025-10-31T16:23:08', 'last-modified': '2025-10-31T16:23:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.994121'}
2025-10-31 16:23:54,084 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-31 16:23:54,090 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-72421903', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14906164046783596817', 'uuid-lslong': '10405207335273311287'}, 'enable': 'true', 'created': '2025-10-31T16:23:08', 'last-modified': '2025-10-31T16:23:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.011849'}
2025-10-31 16:23:54,098 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-31 16:23:54,106 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-72421903', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14906164046783596817', 'uuid-lslong': '10405207335273311287'}, 'enable': 'true', 'created': '2025-10-31T16:23:08', 'last-modified': '2025-10-31T16:23:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.021949'}
2025-10-31 16:23:54,114 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-31 16:23:54,114 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-87870431 passed
2025-10-31 16:23:54,114 - DEBUG - ====Verifying policy data for ctest-vn2-87870431 in API_Server ======
2025-10-31 16:23:54,114 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-10-31 16:23:54,122 - DEBUG - Requesting: http://10.0.0.38:8082/domain/84461aec-f8f2-4c85-873b-ef5843450b69
2025-10-31 16:23:54,135 - DEBUG - Requesting: http://10.0.0.38:8082/project/335b6c6e-81dc-404f-bf10-e9c59e981cbf
2025-10-31 16:23:54,238 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cedd5539-6c3c-4911-9066-b8f139412c37
2025-10-31 16:23:54,250 - DEBUG - ==>Verifying data for policy with id: 8c3e9dc5-2e65-4349-a5c7-66d978c8685a, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-72421903', 'policy1']
2025-10-31 16:23:54,250 - INFO - VN ctest-vn2-87870431 Policy verification: verify_vn_policy_in_api_server, status: True
2025-10-31 16:23:54,250 - DEBUG - Verifying the vn in opserver
2025-10-31 16:23:54,250 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431 virtual network link through opserver 10.0.0.38
2025-10-31 16:23:54,250 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-10-31 16:23:54,262 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431?flat'}
2025-10-31 16:23:54,262 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431 virtual network link through opserver 10.0.0.249
2025-10-31 16:23:54,262 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-31 16:23:54,277 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431?flat'}
2025-10-31 16:23:54,277 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431 virtual network link through opserver 10.0.0.65
2025-10-31 16:23:54,277 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-10-31 16:23:54,290 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431?flat'}
2025-10-31 16:23:54,290 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431 is found in opserver
2025-10-31 16:23:54,302 - DEBUG - VRF ids for VN ctest-vn2-87870431: {'10.0.0.19': '3', '10.0.0.22': '2'}
2025-10-31 16:23:54,303 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-10-31 16:23:54,309 - DEBUG - Requesting: http://10.0.0.38:8082/domain/84461aec-f8f2-4c85-873b-ef5843450b69
2025-10-31 16:23:54,319 - DEBUG - Requesting: http://10.0.0.38:8082/project/335b6c6e-81dc-404f-bf10-e9c59e981cbf
2025-10-31 16:23:54,414 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/aee05370-742e-4429-a4dd-c72e24bd4909
2025-10-31 16:23:54,424 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/aee05370-742e-4429-a4dd-c72e24bd4909
2025-10-31 16:23:54,433 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/5e06862b-6cd6-4383-8859-cdff4f401582
2025-10-31 16:23:54,444 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/5e06862b-6cd6-4383-8859-cdff4f401582
2025-10-31 16:23:54,452 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/98b30a88-cfbb-4837-b799-fe88258f7d11
2025-10-31 16:23:54,459 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-31 16:23:54,459 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/aee05370-742e-4429-a4dd-c72e24bd4909
2025-10-31 16:23:54,468 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/5e06862b-6cd6-4383-8859-cdff4f401582
2025-10-31 16:23:54,484 - INFO - Verified VN network id 15 for VN aee05370-742e-4429-a4dd-c72e24bd4909
2025-10-31 16:23:54,484 - INFO - Verifications in API Server for VN ctest-vn1-74232823 passed
2025-10-31 16:23:54,484 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/aee05370-742e-4429-a4dd-c72e24bd4909
2025-10-31 16:23:54,495 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/5e06862b-6cd6-4383-8859-cdff4f401582
2025-10-31 16:23:54,503 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/5e06862b-6cd6-4383-8859-cdff4f401582
2025-10-31 16:23:54,512 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/98b30a88-cfbb-4837-b799-fe88258f7d11
2025-10-31 16:23:54,529 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-72421903', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12601163499833279529', 'uuid-lslong': '11879870393072044297'}, 'enable': 'true', 'created': '2025-10-31T16:22:27', 'last-modified': '2025-10-31T16:23:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.636164'}
2025-10-31 16:23:54,536 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-31 16:23:54,542 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-72421903', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12601163499833279529', 'uuid-lslong': '11879870393072044297'}, 'enable': 'true', 'created': '2025-10-31T16:22:27', 'last-modified': '2025-10-31T16:23:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.660218'}
2025-10-31 16:23:54,550 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-31 16:23:54,560 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-72421903', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12601163499833279529', 'uuid-lslong': '11879870393072044297'}, 'enable': 'true', 'created': '2025-10-31T16:22:27', 'last-modified': '2025-10-31T16:23:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.675045'}
2025-10-31 16:23:54,569 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-31 16:23:54,569 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-74232823 passed
2025-10-31 16:23:54,569 - DEBUG - ====Verifying policy data for ctest-vn1-74232823 in API_Server ======
2025-10-31 16:23:54,569 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-10-31 16:23:54,576 - DEBUG - Requesting: http://10.0.0.38:8082/domain/84461aec-f8f2-4c85-873b-ef5843450b69
2025-10-31 16:23:54,587 - DEBUG - Requesting: http://10.0.0.38:8082/project/335b6c6e-81dc-404f-bf10-e9c59e981cbf
2025-10-31 16:23:54,696 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/aee05370-742e-4429-a4dd-c72e24bd4909
2025-10-31 16:23:54,711 - DEBUG - ==>Verifying data for policy with id: 8c3e9dc5-2e65-4349-a5c7-66d978c8685a, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-72421903', 'policy1']
2025-10-31 16:23:54,711 - INFO - VN ctest-vn1-74232823 Policy verification: verify_vn_policy_in_api_server, status: True
2025-10-31 16:23:54,711 - DEBUG - Verifying the vn in opserver
2025-10-31 16:23:54,711 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823 virtual network link through opserver 10.0.0.38
2025-10-31 16:23:54,711 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-10-31 16:23:54,725 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823?flat'}
2025-10-31 16:23:54,725 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823 virtual network link through opserver 10.0.0.249
2025-10-31 16:23:54,725 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-31 16:23:54,739 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823?flat'}
2025-10-31 16:23:54,739 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823 virtual network link through opserver 10.0.0.65
2025-10-31 16:23:54,739 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-10-31 16:23:54,756 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823?flat'}
2025-10-31 16:23:54,756 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823 is found in opserver
2025-10-31 16:23:54,770 - DEBUG - VRF ids for VN ctest-vn1-74232823: {'10.0.0.19': '2'}
2025-10-31 16:23:54,770 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-10-31 16:23:54,777 - DEBUG - Requesting: http://10.0.0.38:8082/domain/84461aec-f8f2-4c85-873b-ef5843450b69
2025-10-31 16:23:54,787 - DEBUG - Requesting: http://10.0.0.38:8082/project/335b6c6e-81dc-404f-bf10-e9c59e981cbf
2025-10-31 16:23:54,890 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cedd5539-6c3c-4911-9066-b8f139412c37
2025-10-31 16:23:54,903 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cedd5539-6c3c-4911-9066-b8f139412c37
2025-10-31 16:23:54,914 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/432bc1a6-059a-4499-8e7c-08be2a431f07
2025-10-31 16:23:54,922 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/432bc1a6-059a-4499-8e7c-08be2a431f07
2025-10-31 16:23:54,930 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/43030668-6e8d-4850-a603-34f69e8472f3
2025-10-31 16:23:54,938 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-31 16:23:54,939 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cedd5539-6c3c-4911-9066-b8f139412c37
2025-10-31 16:23:54,950 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/432bc1a6-059a-4499-8e7c-08be2a431f07
2025-10-31 16:23:54,976 - INFO - Verified VN network id 16 for VN cedd5539-6c3c-4911-9066-b8f139412c37
2025-10-31 16:23:54,976 - INFO - Verifications in API Server for VN ctest-vn2-87870431 passed
2025-10-31 16:23:54,976 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cedd5539-6c3c-4911-9066-b8f139412c37
2025-10-31 16:23:54,986 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/432bc1a6-059a-4499-8e7c-08be2a431f07
2025-10-31 16:23:54,996 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/432bc1a6-059a-4499-8e7c-08be2a431f07
2025-10-31 16:23:55,004 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/43030668-6e8d-4850-a603-34f69e8472f3
2025-10-31 16:23:55,019 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-72421903', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14906164046783596817', 'uuid-lslong': '10405207335273311287'}, 'enable': 'true', 'created': '2025-10-31T16:23:08', 'last-modified': '2025-10-31T16:23:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.938286'}
2025-10-31 16:23:55,027 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-31 16:23:55,034 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-72421903', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14906164046783596817', 'uuid-lslong': '10405207335273311287'}, 'enable': 'true', 'created': '2025-10-31T16:23:08', 'last-modified': '2025-10-31T16:23:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.955546'}
2025-10-31 16:23:55,041 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-31 16:23:55,051 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-72421903', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14906164046783596817', 'uuid-lslong': '10405207335273311287'}, 'enable': 'true', 'created': '2025-10-31T16:23:08', 'last-modified': '2025-10-31T16:23:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.964476'}
2025-10-31 16:23:55,058 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-31 16:23:55,058 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-87870431 passed
2025-10-31 16:23:55,058 - DEBUG - ====Verifying policy data for ctest-vn2-87870431 in API_Server ======
2025-10-31 16:23:55,058 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-10-31 16:23:55,067 - DEBUG - Requesting: http://10.0.0.38:8082/domain/84461aec-f8f2-4c85-873b-ef5843450b69
2025-10-31 16:23:55,078 - DEBUG - Requesting: http://10.0.0.38:8082/project/335b6c6e-81dc-404f-bf10-e9c59e981cbf
2025-10-31 16:23:55,183 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/cedd5539-6c3c-4911-9066-b8f139412c37
2025-10-31 16:23:55,194 - DEBUG - ==>Verifying data for policy with id: 8c3e9dc5-2e65-4349-a5c7-66d978c8685a, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-72421903', 'policy1']
2025-10-31 16:23:55,194 - INFO - VN ctest-vn2-87870431 Policy verification: verify_vn_policy_in_api_server, status: True
2025-10-31 16:23:55,194 - DEBUG - Verifying the vn in opserver
2025-10-31 16:23:55,194 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431 virtual network link through opserver 10.0.0.38
2025-10-31 16:23:55,194 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-10-31 16:23:55,209 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431?flat'}
2025-10-31 16:23:55,209 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431 virtual network link through opserver 10.0.0.249
2025-10-31 16:23:55,209 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-31 16:23:55,223 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431?flat'}
2025-10-31 16:23:55,223 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431 virtual network link through opserver 10.0.0.65
2025-10-31 16:23:55,223 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-10-31 16:23:55,237 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431?flat'}
2025-10-31 16:23:55,237 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431 is found in opserver
2025-10-31 16:23:55,249 - DEBUG - VRF ids for VN ctest-vn2-87870431: {'10.0.0.19': '3', '10.0.0.22': '2'}
2025-10-31 16:23:55,249 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-10-31 16:23:55,254 - DEBUG - Requesting: http://10.0.0.38:8082/domain/84461aec-f8f2-4c85-873b-ef5843450b69
2025-10-31 16:23:55,267 - DEBUG - Requesting: http://10.0.0.38:8082/project/335b6c6e-81dc-404f-bf10-e9c59e981cbf
2025-10-31 16:23:55,373 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/6eb5cfbb-45b5-4ad2-af09-48fc22197801
2025-10-31 16:23:55,383 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/6eb5cfbb-45b5-4ad2-af09-48fc22197801
2025-10-31 16:23:55,393 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f934eeaa-09e9-4ef4-a0b6-32fbe2cc4322
2025-10-31 16:23:55,401 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f934eeaa-09e9-4ef4-a0b6-32fbe2cc4322
2025-10-31 16:23:55,408 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/75259e6c-fb45-4c70-b406-520ff20ec193
2025-10-31 16:23:55,415 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-31 16:23:55,415 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/6eb5cfbb-45b5-4ad2-af09-48fc22197801
2025-10-31 16:23:55,425 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f934eeaa-09e9-4ef4-a0b6-32fbe2cc4322
2025-10-31 16:23:55,440 - INFO - Verified VN network id 17 for VN 6eb5cfbb-45b5-4ad2-af09-48fc22197801
2025-10-31 16:23:55,440 - INFO - Verifications in API Server for VN ctest-fip_vn-38254149 passed
2025-10-31 16:23:55,440 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/6eb5cfbb-45b5-4ad2-af09-48fc22197801
2025-10-31 16:23:55,449 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f934eeaa-09e9-4ef4-a0b6-32fbe2cc4322
2025-10-31 16:23:55,455 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f934eeaa-09e9-4ef4-a0b6-32fbe2cc4322
2025-10-31 16:23:55,462 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/75259e6c-fb45-4c70-b406-520ff20ec193
2025-10-31 16:23:55,475 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-fip_vn-38254149', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-72421903', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7977510718192044754', 'uuid-lslong': '12612692479168837633'}, 'enable': 'true', 'created': '2025-10-31T16:23:09', 'last-modified': '2025-10-31T16:23:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:45.681122'}
2025-10-31 16:23:55,486 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-31 16:23:55,493 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-fip_vn-38254149', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-72421903', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7977510718192044754', 'uuid-lslong': '12612692479168837633'}, 'enable': 'true', 'created': '2025-10-31T16:23:09', 'last-modified': '2025-10-31T16:23:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:45.698481'}
2025-10-31 16:23:55,499 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-31 16:23:55,503 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-fip_vn-38254149', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-72421903', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7977510718192044754', 'uuid-lslong': '12612692479168837633'}, 'enable': 'true', 'created': '2025-10-31T16:23:09', 'last-modified': '2025-10-31T16:23:09', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:45.710225'}
2025-10-31 16:23:55,509 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-31 16:23:55,509 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-38254149 passed
2025-10-31 16:23:55,509 - DEBUG - ====Verifying policy data for ctest-fip_vn-38254149 in API_Server ======
2025-10-31 16:23:55,509 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-10-31 16:23:55,515 - DEBUG - Requesting: http://10.0.0.38:8082/domain/84461aec-f8f2-4c85-873b-ef5843450b69
2025-10-31 16:23:55,525 - DEBUG - Requesting: http://10.0.0.38:8082/project/335b6c6e-81dc-404f-bf10-e9c59e981cbf
2025-10-31 16:23:55,620 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/6eb5cfbb-45b5-4ad2-af09-48fc22197801
2025-10-31 16:23:55,630 - DEBUG - =>VN ctest-fip_vn-38254149 has no policy to be verified
2025-10-31 16:23:55,630 - DEBUG - Verifying the vn in opserver
2025-10-31 16:23:55,630 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-fip_vn-38254149 virtual network link through opserver 10.0.0.38
2025-10-31 16:23:55,630 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-10-31 16:23:55,643 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-fip_vn-38254149', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-fip_vn-38254149?flat'}
2025-10-31 16:23:55,643 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-fip_vn-38254149 virtual network link through opserver 10.0.0.249
2025-10-31 16:23:55,643 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-31 16:23:55,658 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-fip_vn-38254149', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-fip_vn-38254149?flat'}
2025-10-31 16:23:55,658 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-fip_vn-38254149 virtual network link through opserver 10.0.0.65
2025-10-31 16:23:55,658 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-10-31 16:23:55,672 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-fip_vn-38254149', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-fip_vn-38254149?flat'}
2025-10-31 16:23:55,672 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-fip_vn-38254149 is found in opserver
2025-10-31 16:23:55,683 - DEBUG - VRF ids for VN ctest-fip_vn-38254149: {'10.0.0.22': '3'}
2025-10-31 16:23:55,683 - INFO - start time= 1761927835683947
2025-10-31 16:23:55,684 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 100.54.159.195, host_string: cirros@169.254.0.3, password: gocubsgogateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2025-10-31 16:23:55,684 - DEBUG - ping -s 56 -c 3 -W 1 100.54.159.195
2025-10-31 16:23:59,293 - DEBUG - PING 100.54.159.195 (100.54.159.195): 56 data bytes
64 bytes from 100.54.159.195: seq=0 ttl=63 time=4.120 ms
64 bytes from 100.54.159.195: seq=1 ttl=63 time=1.630 ms
64 bytes from 100.54.159.195: seq=2 ttl=63 time=1.659 ms
--- 100.54.159.195 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.630/2.469/4.120 ms
2025-10-31 16:23:59,293 - INFO - Ping to IP 100.54.159.195 from VM ctest-vn1_vm1-16680591 passed
2025-10-31 16:24:09,295 - INFO - Verify session samples and teardown pkts
2025-10-31 16:24:09,295 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.38
2025-10-31 16:24:09,299 - DEBUG - Posting: http://10.0.0.38:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1761927835683947, 'end_time': 1761927849299057, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-10-31 16:24:10,320 - DEBUG - [{'T': 1761927838122006}, {'T': 1761927839122054}, {'T': 1761927840122175}]
2025-10-31 16:24:10,320 - DEBUG - Posting: http://10.0.0.38:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1761927835683947, 'end_time': 1761927850320719, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-10-31 16:24:11,343 - DEBUG - [{'T': 1761927837878337}, {'T': 1761927838878445}, {'T': 1761927839878592}]
2025-10-31 16:24:11,343 - DEBUG - Posting: http://10.0.0.38:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1761927835683947, 'end_time': 1761927851343804, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-10-31 16:24:12,368 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'sample_count': 3}]
2025-10-31 16:24:12,368 - INFO - wait for the flows to get expire
2025-10-31 16:27:32,368 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4577-1:Compute:contrail-vrouter-agent:0?flat
2025-10-31 16:27:32,449 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4577-1?flat
2025-10-31 16:27:32,529 - DEBUG - Posting: http://10.0.0.38:8081/analytics/query, payload {'table': 'SessionRecordTable', 'start_time': 1761927835683947, 'end_time': 1761928052529214, 'select_fields': ['vn', 'remote_vn', 'forward_teardown_pkts', 'reverse_teardown_pkts'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-10-31 16:27:33,551 - DEBUG - [{'forward_flow_uuid': '49d5030a-d07a-4aab-9907-3da746756702', 'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'reverse_flow_uuid': '54fcfd3a-92e5-4ee0-8442-9e697e80564b', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'forward_teardown_pkts': 3, 'reverse_teardown_pkts': 3}]
2025-10-31 16:27:33,552 - DEBUG - Posting: http://10.0.0.38:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1761927835683947, 'end_time': 1761928053552040, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-10-31 16:27:34,574 - DEBUG - Posting: http://10.0.0.38:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1761927835683947, 'end_time': 1761928054574296, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-10-31 16:27:35,597 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431', 'sample_count': 4}]
2025-10-31 16:27:36,032 - INFO - Deleted policy policy1
2025-10-31 16:27:36,146 - INFO - Setting flow export rate: None
2025-10-31 16:27:37,445 - DEBUG - Skipping xmpp flap check
2025-10-31 16:27:37,445 - INFO - END TEST : test_verify_session_sampling_teardown : PASSED[0:03:46]
2025-10-31 16:27:37,446 - INFO - --------------------------------------------------------------------------------
2025-10-31 16:27:37,447 - INFO - Deleting VM mltf_vm
2025-10-31 16:27:37,519 - INFO - Deleting VM ctest-fvn_vm1-98202872
2025-10-31 16:27:37,584 - INFO - Deleting VM ctest-vn2_vm2-32956887
2025-10-31 16:27:37,653 - INFO - Deleting VN ctest-fip_vn-38254149
2025-10-31 16:27:37,695 - DEBUG - VN 6eb5cfbb-45b5-4ad2-af09-48fc22197801 still in use: Unable to complete operation on network 6eb5cfbb-45b5-4ad2-af09-48fc22197801. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-edb9f8bd-084d-4b88-8abc-d4caf85f6f7e']
2025-10-31 16:27:37,695 - WARNING - Deleting VN ctest-fip_vn-38254149 failed..Will retry
2025-10-31 16:27:39,920 - DEBUG - Response for deleting network ()
2025-10-31 16:27:39,920 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/f934eeaa-09e9-4ef4-a0b6-32fbe2cc4322
2025-10-31 16:27:39,971 - DEBUG - Response Code: 404
2025-10-31 16:27:39,972 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-10-31 16:27:39,978 - DEBUG - Requesting: http://10.0.0.38:8082/domain/84461aec-f8f2-4c85-873b-ef5843450b69
2025-10-31 16:27:39,994 - DEBUG - Requesting: http://10.0.0.38:8082/project/335b6c6e-81dc-404f-bf10-e9c59e981cbf
2025-10-31 16:27:40,104 - INFO - Validated that VN ctest-fip_vn-38254149 is not found in API Server
2025-10-31 16:27:40,122 - DEBUG - VN ctest-fip_vn-38254149 is not present in Agent 10.0.0.19
2025-10-31 16:27:40,134 - DEBUG - VN ctest-fip_vn-38254149 is not present in Agent 10.0.0.22
2025-10-31 16:27:40,134 - INFO - Validated that VN ctest-fip_vn-38254149 is not in any agent
2025-10-31 16:27:40,139 - DEBUG - VRF 3 is not seen in agent 10.0.0.22
2025-10-31 16:27:40,147 - DEBUG - Vrouter 10.0.0.22 does not have vrf 3 for VN ctest-fip_vn-38254149
2025-10-31 16:27:40,147 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-fip_vn-38254149
2025-10-31 16:27:40,167 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-38254149 info
2025-10-31 16:27:40,167 - INFO - Deleting VN ctest-vn2-87870431
2025-10-31 16:27:40,363 - DEBUG - Response for deleting network ()
2025-10-31 16:27:40,363 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/432bc1a6-059a-4499-8e7c-08be2a431f07
2025-10-31 16:27:40,369 - DEBUG - Response Code: 404
2025-10-31 16:27:40,369 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-10-31 16:27:40,402 - DEBUG - Requesting: http://10.0.0.38:8082/domain/84461aec-f8f2-4c85-873b-ef5843450b69
2025-10-31 16:27:40,420 - DEBUG - Requesting: http://10.0.0.38:8082/project/335b6c6e-81dc-404f-bf10-e9c59e981cbf
2025-10-31 16:27:40,519 - INFO - Validated that VN ctest-vn2-87870431 is not found in API Server
2025-10-31 16:27:40,531 - DEBUG - VN ctest-vn2-87870431 is not present in Agent 10.0.0.19
2025-10-31 16:27:40,544 - DEBUG - VN ctest-vn2-87870431 is not present in Agent 10.0.0.22
2025-10-31 16:27:40,544 - INFO - Validated that VN ctest-vn2-87870431 is not in any agent
2025-10-31 16:27:40,550 - DEBUG - VRF 3 is not seen in agent 10.0.0.19
2025-10-31 16:27:40,555 - DEBUG - Vrouter 10.0.0.19 does not have vrf 3 for VN ctest-vn2-87870431
2025-10-31 16:27:40,562 - DEBUG - VRF 2 is not seen in agent 10.0.0.22
2025-10-31 16:27:40,567 - DEBUG - Vrouter 10.0.0.22 does not have vrf 2 for VN ctest-vn2-87870431
2025-10-31 16:27:40,567 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn2-87870431
2025-10-31 16:27:40,595 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-87870431 info
2025-10-31 16:27:40,595 - INFO - Deleting VM ctest-vn1_vm2-48904724
2025-10-31 16:27:40,675 - INFO - Deleting VM ctest-vn1_vm1-16680591
2025-10-31 16:27:40,744 - INFO - Deleting VN ctest-vn1-74232823
2025-10-31 16:27:40,792 - DEBUG - VN aee05370-742e-4429-a4dd-c72e24bd4909 still in use: Unable to complete operation on network aee05370-742e-4429-a4dd-c72e24bd4909. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-4bbd2e9a-da12-46e3-a604-c63c2abe35d1']
2025-10-31 16:27:40,792 - WARNING - Deleting VN ctest-vn1-74232823 failed..Will retry
2025-10-31 16:27:42,984 - DEBUG - Response for deleting network ()
2025-10-31 16:27:42,984 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/5e06862b-6cd6-4383-8859-cdff4f401582
2025-10-31 16:27:42,992 - DEBUG - Response Code: 404
2025-10-31 16:27:42,992 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2025-10-31 16:27:42,999 - DEBUG - Requesting: http://10.0.0.38:8082/domain/84461aec-f8f2-4c85-873b-ef5843450b69
2025-10-31 16:27:43,013 - DEBUG - Requesting: http://10.0.0.38:8082/project/335b6c6e-81dc-404f-bf10-e9c59e981cbf
2025-10-31 16:27:43,096 - INFO - Validated that VN ctest-vn1-74232823 is not found in API Server
2025-10-31 16:27:43,109 - DEBUG - VN ctest-vn1-74232823 is not present in Agent 10.0.0.19
2025-10-31 16:27:43,123 - DEBUG - VN ctest-vn1-74232823 is not present in Agent 10.0.0.22
2025-10-31 16:27:43,123 - INFO - Validated that VN ctest-vn1-74232823 is not in any agent
2025-10-31 16:27:43,129 - DEBUG - VRF 2 is not seen in agent 10.0.0.19
2025-10-31 16:27:43,134 - DEBUG - Vrouter 10.0.0.19 does not have vrf 2 for VN ctest-vn1-74232823
2025-10-31 16:27:43,134 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-72421903:ctest-vn1-74232823
2025-10-31 16:27:43,153 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-74232823 info
2025-10-31 16:27:43,854 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-72421903, ID : 335b6c6e-81dc-404f-bf10-e9c59e981cbf