is in ACTIVE state now
2026-01-19 03:42:12,441 - INFO - VM name : mltf_vm
2026-01-19 03:42:12,532 - DEBUG - VM mltf_vm ID is 2076daa6-cb6a-4d36-b64a-605aebcf7b13
2026-01-19 03:42:12,532 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-5040-1
2026-01-19 03:42:12,701 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/2076daa6-cb6a-4d36-b64a-605aebcf7b13
2026-01-19 03:42:12,712 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/58d773ac-c3cc-414d-85d1-396725755e52
2026-01-19 03:42:12,723 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/8615c0d9-9040-4c3f-8e76-a0e8c39c3e35
2026-01-19 03:42:13,908 - 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.10 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.437 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1000ms\r\nrtt min/avg/max/mdev = 0.437/1.769/3.101/1.332 ms')
2026-01-19 03:42:13,909 - INFO - Ping to Metadata IP 169.254.0.5 of VM mltf_vm passed
2026-01-19 03:42:13,984 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-19 03:42:13,984 - DEBUG - Waiting to SSH to VM mltf_vm, IP 179.226.209.197, Port 22
2026-01-19 03:42:14,143 - DEBUG - VM mltf_vm is ready for SSH connections
2026-01-19 03:42:14,214 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-19 03:42:14,214 - DEBUG - Waiting to SSH to VM mltf_vm, IP 179.226.209.197, Port 22
2026-01-19 03:42:14,384 - DEBUG - VM mltf_vm is ready for SSH connections
2026-01-19 03:42:14,387 - INFO - ================================================================================
2026-01-19 03:42:14,387 - INFO - STARTING TEST : test_verify_session_sampling_teardown
2026-01-19 03:42:14,387 - INFO - TEST DESCRIPTION :
1.query client session samples
2.query server session samples
3.query client session to get number of sessions exported
4.query session record table for teardown bytes/pkts
5.query sample count after teardown on server side
2026-01-19 03:42:15,656 - DEBUG - Skipping xmpp flap check
2026-01-19 03:42:15,656 - INFO - Initial checks done. Running the testcase now
2026-01-19 03:42:15,656 - INFO -
2026-01-19 03:42:15,783 - INFO - Setting flow export rate: 100
2026-01-19 03:42:15,831 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = any, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = any, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None]
2026-01-19 03:42:16,197 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'b961562b-6235-4bd8-a543-be58397c86f1', 'name': 'ctest-vn1-62678230', 'tenant_id': '075b0fb7f3e14a6ebc313fd0a7f3f278', 'project_id': '075b0fb7f3e14a6ebc313fd0a7f3f278', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['3b83cf3b-2809-46d8-a8ae-0429ebbfcbfc'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-84413787', 'ctest-vn1-62678230'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-84413787', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '179.226.209.192/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-01-19 03:42:16,378 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '6be4a1be-e270-4db1-af67-e59c8f0a108b', 'name': 'ctest-vn2-96285596', 'tenant_id': '075b0fb7f3e14a6ebc313fd0a7f3f278', 'project_id': '075b0fb7f3e14a6ebc313fd0a7f3f278', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['b90bac88-0658-4fc1-96d0-6da952998aca'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-84413787', 'ctest-vn2-96285596'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-84413787', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '223.86.150.64/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-01-19 03:42:16,470 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-01-19 03:42:16,477 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7
2026-01-19 03:42:16,514 - DEBUG - Requesting: http://10.0.0.27:8082/project/075b0fb7-f3e1-4a6e-bc31-3fd0a7f3f278
2026-01-19 03:42:16,617 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b961562b-6235-4bd8-a543-be58397c86f1
2026-01-19 03:42:16,635 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b961562b-6235-4bd8-a543-be58397c86f1
2026-01-19 03:42:16,645 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7e240d6f-164e-41f5-80a1-5cf20ae88b88
2026-01-19 03:42:16,659 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7e240d6f-164e-41f5-80a1-5cf20ae88b88
2026-01-19 03:42:16,669 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/15489d5f-31e3-400e-8f9e-1e1088f17273
2026-01-19 03:42:16,677 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-19 03:42:16,677 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b961562b-6235-4bd8-a543-be58397c86f1
2026-01-19 03:42:16,694 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7e240d6f-164e-41f5-80a1-5cf20ae88b88
2026-01-19 03:42:16,712 - INFO - Verified VN network id 16 for VN b961562b-6235-4bd8-a543-be58397c86f1
2026-01-19 03:42:16,712 - INFO - Verifications in API Server for VN ctest-vn1-62678230 passed
2026-01-19 03:42:16,712 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b961562b-6235-4bd8-a543-be58397c86f1
2026-01-19 03:42:16,723 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7e240d6f-164e-41f5-80a1-5cf20ae88b88
2026-01-19 03:42:16,737 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7e240d6f-164e-41f5-80a1-5cf20ae88b88
2026-01-19 03:42:16,755 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/15489d5f-31e3-400e-8f9e-1e1088f17273
2026-01-19 03:42:16,768 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-84413787', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13358052714088844248', 'uuid-lslong': '11908571125828585201'}, 'enable': 'true', 'created': '2026-01-19T03:40:54', 'last-modified': '2026-01-19T03:42:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.607062'}
2026-01-19 03:42:16,774 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-19 03:42:16,780 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-84413787', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13358052714088844248', 'uuid-lslong': '11908571125828585201'}, 'enable': 'true', 'created': '2026-01-19T03:40:54', 'last-modified': '2026-01-19T03:42:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.620412'}
2026-01-19 03:42:16,787 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-19 03:42:16,793 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-84413787', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13358052714088844248', 'uuid-lslong': '11908571125828585201'}, 'enable': 'true', 'created': '2026-01-19T03:40:54', 'last-modified': '2026-01-19T03:42:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.630920'}
2026-01-19 03:42:16,809 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-19 03:42:16,809 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-62678230 passed
2026-01-19 03:42:16,809 - DEBUG - ====Verifying policy data for ctest-vn1-62678230 in API_Server ======
2026-01-19 03:42:16,809 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-01-19 03:42:16,823 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7
2026-01-19 03:42:16,839 - DEBUG - Requesting: http://10.0.0.27:8082/project/075b0fb7-f3e1-4a6e-bc31-3fd0a7f3f278
2026-01-19 03:42:16,988 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b961562b-6235-4bd8-a543-be58397c86f1
2026-01-19 03:42:16,998 - DEBUG - ==>Verifying data for policy with id: 3e363b85-7c47-4e26-bd67-33aad09892e4, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-84413787', 'policy1']
2026-01-19 03:42:16,998 - INFO - VN ctest-vn1-62678230 Policy verification: verify_vn_policy_in_api_server, status: True
2026-01-19 03:42:16,999 - DEBUG - Verifying the vn in opserver
2026-01-19 03:42:16,999 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230 virtual network link through opserver 10.0.0.27
2026-01-19 03:42:16,999 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-01-19 03:42:17,014 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230?flat'}
2026-01-19 03:42:17,014 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230 virtual network link through opserver 10.0.0.50
2026-01-19 03:42:17,014 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-01-19 03:42:17,026 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230?flat'}
2026-01-19 03:42:17,026 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230 virtual network link through opserver 10.0.0.23
2026-01-19 03:42:17,026 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-01-19 03:42:17,038 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230?flat'}
2026-01-19 03:42:17,038 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230 is found in opserver
2026-01-19 03:42:17,049 - DEBUG - VRF ids for VN ctest-vn1-62678230: {'10.0.0.249': '2'}
2026-01-19 03:42:17,049 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-01-19 03:42:17,054 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7
2026-01-19 03:42:17,065 - DEBUG - Requesting: http://10.0.0.27:8082/project/075b0fb7-f3e1-4a6e-bc31-3fd0a7f3f278
2026-01-19 03:42:17,158 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6be4a1be-e270-4db1-af67-e59c8f0a108b
2026-01-19 03:42:17,178 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6be4a1be-e270-4db1-af67-e59c8f0a108b
2026-01-19 03:42:17,189 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2fa2f774-f8f0-4fe7-ad46-a6c9d52bca2f
2026-01-19 03:42:17,198 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2fa2f774-f8f0-4fe7-ad46-a6c9d52bca2f
2026-01-19 03:42:17,205 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/11546521-4226-423c-b10a-42f011c7621c
2026-01-19 03:42:17,211 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-19 03:42:17,211 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6be4a1be-e270-4db1-af67-e59c8f0a108b
2026-01-19 03:42:17,219 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2fa2f774-f8f0-4fe7-ad46-a6c9d52bca2f
2026-01-19 03:42:17,234 - INFO - Verified VN network id 17 for VN 6be4a1be-e270-4db1-af67-e59c8f0a108b
2026-01-19 03:42:17,235 - INFO - Verifications in API Server for VN ctest-vn2-96285596 passed
2026-01-19 03:42:17,235 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6be4a1be-e270-4db1-af67-e59c8f0a108b
2026-01-19 03:42:17,246 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2fa2f774-f8f0-4fe7-ad46-a6c9d52bca2f
2026-01-19 03:42:17,256 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2fa2f774-f8f0-4fe7-ad46-a6c9d52bca2f
2026-01-19 03:42:17,263 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/11546521-4226-423c-b10a-42f011c7621c
2026-01-19 03:42:17,280 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-84413787', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7774516697963187633', 'uuid-lslong': '12639323339816046731'}, 'enable': 'true', 'created': '2026-01-19T03:41:34', 'last-modified': '2026-01-19T03:42:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.924855'}
2026-01-19 03:42:17,285 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-19 03:42:17,291 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-84413787', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7774516697963187633', 'uuid-lslong': '12639323339816046731'}, 'enable': 'true', 'created': '2026-01-19T03:41:34', 'last-modified': '2026-01-19T03:42:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.944669'}
2026-01-19 03:42:17,297 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-19 03:42:17,303 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-84413787', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7774516697963187633', 'uuid-lslong': '12639323339816046731'}, 'enable': 'true', 'created': '2026-01-19T03:41:34', 'last-modified': '2026-01-19T03:42:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.957482'}
2026-01-19 03:42:17,309 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-19 03:42:17,309 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-96285596 passed
2026-01-19 03:42:17,310 - DEBUG - ====Verifying policy data for ctest-vn2-96285596 in API_Server ======
2026-01-19 03:42:17,310 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-01-19 03:42:17,315 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7
2026-01-19 03:42:17,325 - DEBUG - Requesting: http://10.0.0.27:8082/project/075b0fb7-f3e1-4a6e-bc31-3fd0a7f3f278
2026-01-19 03:42:17,426 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6be4a1be-e270-4db1-af67-e59c8f0a108b
2026-01-19 03:42:17,437 - DEBUG - ==>Verifying data for policy with id: 3e363b85-7c47-4e26-bd67-33aad09892e4, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-84413787', 'policy1']
2026-01-19 03:42:17,438 - INFO - VN ctest-vn2-96285596 Policy verification: verify_vn_policy_in_api_server, status: True
2026-01-19 03:42:17,438 - DEBUG - Verifying the vn in opserver
2026-01-19 03:42:17,438 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596 virtual network link through opserver 10.0.0.27
2026-01-19 03:42:17,438 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-01-19 03:42:17,450 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596?flat'}
2026-01-19 03:42:17,450 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596 virtual network link through opserver 10.0.0.50
2026-01-19 03:42:17,451 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-01-19 03:42:17,463 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596?flat'}
2026-01-19 03:42:17,463 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596 virtual network link through opserver 10.0.0.23
2026-01-19 03:42:17,463 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-01-19 03:42:17,477 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596?flat'}
2026-01-19 03:42:17,477 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596 is found in opserver
2026-01-19 03:42:17,487 - DEBUG - VRF ids for VN ctest-vn2-96285596: {'10.0.0.249': '3', '10.0.0.65': '2'}
2026-01-19 03:42:17,488 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-01-19 03:42:17,493 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7
2026-01-19 03:42:17,505 - DEBUG - Requesting: http://10.0.0.27:8082/project/075b0fb7-f3e1-4a6e-bc31-3fd0a7f3f278
2026-01-19 03:42:17,608 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b961562b-6235-4bd8-a543-be58397c86f1
2026-01-19 03:42:17,620 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b961562b-6235-4bd8-a543-be58397c86f1
2026-01-19 03:42:17,632 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7e240d6f-164e-41f5-80a1-5cf20ae88b88
2026-01-19 03:42:17,643 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7e240d6f-164e-41f5-80a1-5cf20ae88b88
2026-01-19 03:42:17,652 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/15489d5f-31e3-400e-8f9e-1e1088f17273
2026-01-19 03:42:17,664 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-19 03:42:17,664 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b961562b-6235-4bd8-a543-be58397c86f1
2026-01-19 03:42:17,678 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7e240d6f-164e-41f5-80a1-5cf20ae88b88
2026-01-19 03:42:17,702 - INFO - Verified VN network id 16 for VN b961562b-6235-4bd8-a543-be58397c86f1
2026-01-19 03:42:17,702 - INFO - Verifications in API Server for VN ctest-vn1-62678230 passed
2026-01-19 03:42:17,702 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b961562b-6235-4bd8-a543-be58397c86f1
2026-01-19 03:42:17,713 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7e240d6f-164e-41f5-80a1-5cf20ae88b88
2026-01-19 03:42:17,721 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7e240d6f-164e-41f5-80a1-5cf20ae88b88
2026-01-19 03:42:17,732 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/15489d5f-31e3-400e-8f9e-1e1088f17273
2026-01-19 03:42:17,748 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-84413787', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13358052714088844248', 'uuid-lslong': '11908571125828585201'}, 'enable': 'true', 'created': '2026-01-19T03:40:54', 'last-modified': '2026-01-19T03:42:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.586154'}
2026-01-19 03:42:17,755 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-19 03:42:17,761 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-84413787', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13358052714088844248', 'uuid-lslong': '11908571125828585201'}, 'enable': 'true', 'created': '2026-01-19T03:40:54', 'last-modified': '2026-01-19T03:42:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.601342'}
2026-01-19 03:42:17,768 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-19 03:42:17,774 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-84413787', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13358052714088844248', 'uuid-lslong': '11908571125828585201'}, 'enable': 'true', 'created': '2026-01-19T03:40:54', 'last-modified': '2026-01-19T03:42:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.612394'}
2026-01-19 03:42:17,781 - DEBUG - Route Targets: ['target:64512:8000004']
2026-01-19 03:42:17,781 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-62678230 passed
2026-01-19 03:42:17,782 - DEBUG - ====Verifying policy data for ctest-vn1-62678230 in API_Server ======
2026-01-19 03:42:17,782 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-01-19 03:42:17,788 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7
2026-01-19 03:42:17,799 - DEBUG - Requesting: http://10.0.0.27:8082/project/075b0fb7-f3e1-4a6e-bc31-3fd0a7f3f278
2026-01-19 03:42:17,899 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/b961562b-6235-4bd8-a543-be58397c86f1
2026-01-19 03:42:17,910 - DEBUG - ==>Verifying data for policy with id: 3e363b85-7c47-4e26-bd67-33aad09892e4, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-84413787', 'policy1']
2026-01-19 03:42:17,910 - INFO - VN ctest-vn1-62678230 Policy verification: verify_vn_policy_in_api_server, status: True
2026-01-19 03:42:17,910 - DEBUG - Verifying the vn in opserver
2026-01-19 03:42:17,910 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230 virtual network link through opserver 10.0.0.27
2026-01-19 03:42:17,910 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-01-19 03:42:17,923 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230?flat'}
2026-01-19 03:42:17,923 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230 virtual network link through opserver 10.0.0.50
2026-01-19 03:42:17,923 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-01-19 03:42:17,937 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230?flat'}
2026-01-19 03:42:17,937 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230 virtual network link through opserver 10.0.0.23
2026-01-19 03:42:17,937 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-01-19 03:42:17,952 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230?flat'}
2026-01-19 03:42:17,952 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230 is found in opserver
2026-01-19 03:42:17,962 - DEBUG - VRF ids for VN ctest-vn1-62678230: {'10.0.0.249': '2'}
2026-01-19 03:42:17,962 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-01-19 03:42:17,969 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7
2026-01-19 03:42:17,985 - DEBUG - Requesting: http://10.0.0.27:8082/project/075b0fb7-f3e1-4a6e-bc31-3fd0a7f3f278
2026-01-19 03:42:18,101 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6be4a1be-e270-4db1-af67-e59c8f0a108b
2026-01-19 03:42:18,112 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6be4a1be-e270-4db1-af67-e59c8f0a108b
2026-01-19 03:42:18,122 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2fa2f774-f8f0-4fe7-ad46-a6c9d52bca2f
2026-01-19 03:42:18,134 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2fa2f774-f8f0-4fe7-ad46-a6c9d52bca2f
2026-01-19 03:42:18,143 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/11546521-4226-423c-b10a-42f011c7621c
2026-01-19 03:42:18,153 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-19 03:42:18,153 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6be4a1be-e270-4db1-af67-e59c8f0a108b
2026-01-19 03:42:18,165 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2fa2f774-f8f0-4fe7-ad46-a6c9d52bca2f
2026-01-19 03:42:18,185 - INFO - Verified VN network id 17 for VN 6be4a1be-e270-4db1-af67-e59c8f0a108b
2026-01-19 03:42:18,185 - INFO - Verifications in API Server for VN ctest-vn2-96285596 passed
2026-01-19 03:42:18,185 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6be4a1be-e270-4db1-af67-e59c8f0a108b
2026-01-19 03:42:18,197 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2fa2f774-f8f0-4fe7-ad46-a6c9d52bca2f
2026-01-19 03:42:18,207 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2fa2f774-f8f0-4fe7-ad46-a6c9d52bca2f
2026-01-19 03:42:18,219 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/11546521-4226-423c-b10a-42f011c7621c
2026-01-19 03:42:18,236 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-84413787', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7774516697963187633', 'uuid-lslong': '12639323339816046731'}, 'enable': 'true', 'created': '2026-01-19T03:41:34', 'last-modified': '2026-01-19T03:42:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.882736'}
2026-01-19 03:42:18,247 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-19 03:42:18,256 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-84413787', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7774516697963187633', 'uuid-lslong': '12639323339816046731'}, 'enable': 'true', 'created': '2026-01-19T03:41:34', 'last-modified': '2026-01-19T03:42:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.909231'}
2026-01-19 03:42:18,264 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-19 03:42:18,272 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-84413787', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7774516697963187633', 'uuid-lslong': '12639323339816046731'}, 'enable': 'true', 'created': '2026-01-19T03:41:34', 'last-modified': '2026-01-19T03:42:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.926413'}
2026-01-19 03:42:18,279 - DEBUG - Route Targets: ['target:64512:8000006']
2026-01-19 03:42:18,279 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-96285596 passed
2026-01-19 03:42:18,279 - DEBUG - ====Verifying policy data for ctest-vn2-96285596 in API_Server ======
2026-01-19 03:42:18,279 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-01-19 03:42:18,287 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7
2026-01-19 03:42:18,303 - DEBUG - Requesting: http://10.0.0.27:8082/project/075b0fb7-f3e1-4a6e-bc31-3fd0a7f3f278
2026-01-19 03:42:18,412 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6be4a1be-e270-4db1-af67-e59c8f0a108b
2026-01-19 03:42:18,424 - DEBUG - ==>Verifying data for policy with id: 3e363b85-7c47-4e26-bd67-33aad09892e4, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-84413787', 'policy1']
2026-01-19 03:42:18,424 - INFO - VN ctest-vn2-96285596 Policy verification: verify_vn_policy_in_api_server, status: True
2026-01-19 03:42:18,424 - DEBUG - Verifying the vn in opserver
2026-01-19 03:42:18,424 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596 virtual network link through opserver 10.0.0.27
2026-01-19 03:42:18,424 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-01-19 03:42:18,437 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596?flat'}
2026-01-19 03:42:18,437 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596 virtual network link through opserver 10.0.0.50
2026-01-19 03:42:18,437 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-01-19 03:42:18,450 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596?flat'}
2026-01-19 03:42:18,450 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596 virtual network link through opserver 10.0.0.23
2026-01-19 03:42:18,450 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-01-19 03:42:18,464 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596?flat'}
2026-01-19 03:42:18,464 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596 is found in opserver
2026-01-19 03:42:18,479 - DEBUG - VRF ids for VN ctest-vn2-96285596: {'10.0.0.249': '3', '10.0.0.65': '2'}
2026-01-19 03:42:18,479 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-01-19 03:42:18,487 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7
2026-01-19 03:42:18,506 - DEBUG - Requesting: http://10.0.0.27:8082/project/075b0fb7-f3e1-4a6e-bc31-3fd0a7f3f278
2026-01-19 03:42:18,598 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6d04f7e2-1c7d-4a5b-8489-3a994f7d6299
2026-01-19 03:42:18,621 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6d04f7e2-1c7d-4a5b-8489-3a994f7d6299
2026-01-19 03:42:18,631 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/dc95fc5e-f1a0-4043-997a-bf62c9b68253
2026-01-19 03:42:18,640 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/dc95fc5e-f1a0-4043-997a-bf62c9b68253
2026-01-19 03:42:18,649 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/f53b29fb-db8d-4048-a5a5-3af83e61a5c6
2026-01-19 03:42:18,656 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-19 03:42:18,656 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6d04f7e2-1c7d-4a5b-8489-3a994f7d6299
2026-01-19 03:42:18,665 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/dc95fc5e-f1a0-4043-997a-bf62c9b68253
2026-01-19 03:42:18,682 - INFO - Verified VN network id 18 for VN 6d04f7e2-1c7d-4a5b-8489-3a994f7d6299
2026-01-19 03:42:18,682 - INFO - Verifications in API Server for VN ctest-fip_vn-02843539 passed
2026-01-19 03:42:18,682 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6d04f7e2-1c7d-4a5b-8489-3a994f7d6299
2026-01-19 03:42:18,701 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/dc95fc5e-f1a0-4043-997a-bf62c9b68253
2026-01-19 03:42:18,710 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/dc95fc5e-f1a0-4043-997a-bf62c9b68253
2026-01-19 03:42:18,720 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/f53b29fb-db8d-4048-a5a5-3af83e61a5c6
2026-01-19 03:42:18,737 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-fip_vn-02843539', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-84413787', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7855676200553630299', 'uuid-lslong': '9550228914953872025'}, 'enable': 'true', 'created': '2026-01-19T03:41:35', 'last-modified': '2026-01-19T03:41:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:43.211091'}
2026-01-19 03:42:18,743 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-19 03:42:18,749 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-fip_vn-02843539', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-84413787', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7855676200553630299', 'uuid-lslong': '9550228914953872025'}, 'enable': 'true', 'created': '2026-01-19T03:41:35', 'last-modified': '2026-01-19T03:41:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:43.224387'}
2026-01-19 03:42:18,757 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-19 03:42:18,762 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-fip_vn-02843539', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-84413787', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7855676200553630299', 'uuid-lslong': '9550228914953872025'}, 'enable': 'true', 'created': '2026-01-19T03:41:35', 'last-modified': '2026-01-19T03:41:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:43.237311'}
2026-01-19 03:42:18,768 - DEBUG - Route Targets: ['target:64512:8000007']
2026-01-19 03:42:18,768 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-02843539 passed
2026-01-19 03:42:18,768 - DEBUG - ====Verifying policy data for ctest-fip_vn-02843539 in API_Server ======
2026-01-19 03:42:18,768 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-01-19 03:42:18,774 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7
2026-01-19 03:42:18,787 - DEBUG - Requesting: http://10.0.0.27:8082/project/075b0fb7-f3e1-4a6e-bc31-3fd0a7f3f278
2026-01-19 03:42:18,879 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6d04f7e2-1c7d-4a5b-8489-3a994f7d6299
2026-01-19 03:42:18,892 - DEBUG - =>VN ctest-fip_vn-02843539 has no policy to be verified
2026-01-19 03:42:18,892 - DEBUG - Verifying the vn in opserver
2026-01-19 03:42:18,892 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-fip_vn-02843539 virtual network link through opserver 10.0.0.27
2026-01-19 03:42:18,893 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-01-19 03:42:18,909 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-fip_vn-02843539', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-fip_vn-02843539?flat'}
2026-01-19 03:42:18,909 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-fip_vn-02843539 virtual network link through opserver 10.0.0.50
2026-01-19 03:42:18,909 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2026-01-19 03:42:18,922 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-fip_vn-02843539', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-fip_vn-02843539?flat'}
2026-01-19 03:42:18,922 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-fip_vn-02843539 virtual network link through opserver 10.0.0.23
2026-01-19 03:42:18,922 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2026-01-19 03:42:18,938 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-fip_vn-02843539', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-fip_vn-02843539?flat'}
2026-01-19 03:42:18,938 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-fip_vn-02843539 is found in opserver
2026-01-19 03:42:18,957 - DEBUG - VRF ids for VN ctest-fip_vn-02843539: {'10.0.0.65': '3'}
2026-01-19 03:42:18,957 - INFO - start time= 1768794138957705
2026-01-19 03:42:18,958 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 223.86.150.67, host_string: cirros@169.254.0.3, password: gocubsgogateway: ubuntu@10.0.0.249, gateway password: c0ntrail123
2026-01-19 03:42:18,958 - DEBUG - ping -s 56 -c 3 -W 1 223.86.150.67
2026-01-19 03:42:22,877 - DEBUG - PING 223.86.150.67 (223.86.150.67): 56 data bytes
64 bytes from 223.86.150.67: seq=0 ttl=63 time=5.556 ms
64 bytes from 223.86.150.67: seq=1 ttl=63 time=1.321 ms
64 bytes from 223.86.150.67: seq=2 ttl=63 time=1.494 ms
--- 223.86.150.67 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.321/2.790/5.556 ms
2026-01-19 03:42:22,877 - INFO - Ping to IP 223.86.150.67 from VM ctest-vn1_vm1-93686515 passed
2026-01-19 03:42:32,877 - INFO - Verify session samples and teardown pkts
2026-01-19 03:42:32,877 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.27
2026-01-19 03:42:32,881 - DEBUG - Posting: http://10.0.0.27:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1768794138957705, 'end_time': 1768794152881491, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-01-19 03:42:33,903 - DEBUG - [{'T': 1768794141568362}, {'T': 1768794142568446}, {'T': 1768794143568502}]
2026-01-19 03:42:33,903 - DEBUG - Posting: http://10.0.0.27:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1768794138957705, 'end_time': 1768794153903744, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2026-01-19 03:42:34,934 - DEBUG - [{'T': 1768794140964294}, {'T': 1768794141964365}, {'T': 1768794142964480}]
2026-01-19 03:42:34,934 - DEBUG - Posting: http://10.0.0.27:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1768794138957705, 'end_time': 1768794154934786, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-01-19 03:42:35,955 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'sample_count': 3}]
2026-01-19 03:42:35,955 - INFO - wait for the flows to get expire
2026-01-19 03:45:55,956 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5040-1:Compute:contrail-vrouter-agent:0?flat
2026-01-19 03:45:55,998 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5040-1?flat
2026-01-19 03:45:56,028 - DEBUG - Posting: http://10.0.0.27:8081/analytics/query, payload {'table': 'SessionRecordTable', 'start_time': 1768794138957705, 'end_time': 1768794356028265, 'select_fields': ['vn', 'remote_vn', 'forward_teardown_pkts', 'reverse_teardown_pkts'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-01-19 03:45:57,051 - DEBUG - [{'forward_flow_uuid': 'e9c7cd5a-3152-4d75-b5ae-b09fc65e78d9', 'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'reverse_flow_uuid': 'f81ae90e-f75a-44e0-8fc5-d6ca24633c07', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'forward_teardown_pkts': 3, 'reverse_teardown_pkts': 3}]
2026-01-19 03:45:57,051 - DEBUG - Posting: http://10.0.0.27:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1768794138957705, 'end_time': 1768794357051255, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-01-19 03:45:58,072 - DEBUG - Posting: http://10.0.0.27:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1768794138957705, 'end_time': 1768794358072410, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2026-01-19 03:45:59,146 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596', 'sample_count': 4}]
2026-01-19 03:45:59,676 - INFO - Deleted policy policy1
2026-01-19 03:45:59,812 - INFO - Setting flow export rate: None
2026-01-19 03:46:01,104 - DEBUG - Skipping xmpp flap check
2026-01-19 03:46:01,104 - INFO - END TEST : test_verify_session_sampling_teardown : PASSED[0:03:47]
2026-01-19 03:46:01,104 - INFO - --------------------------------------------------------------------------------
2026-01-19 03:46:01,106 - INFO - Deleting VM mltf_vm
2026-01-19 03:46:01,213 - INFO - Deleting VM ctest-fvn_vm1-84889855
2026-01-19 03:46:01,317 - INFO - Deleting VM ctest-vn2_vm2-59459417
2026-01-19 03:46:01,405 - INFO - Deleting VN ctest-fip_vn-02843539
2026-01-19 03:46:01,452 - DEBUG - VN 6d04f7e2-1c7d-4a5b-8489-3a994f7d6299 still in use: Unable to complete operation on network 6d04f7e2-1c7d-4a5b-8489-3a994f7d6299. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-31c7340a-69c4-41e4-bd4c-4e44012ef53e']
2026-01-19 03:46:01,452 - WARNING - Deleting VN ctest-fip_vn-02843539 failed..Will retry
2026-01-19 03:46:03,616 - DEBUG - Response for deleting network ()
2026-01-19 03:46:03,616 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/dc95fc5e-f1a0-4043-997a-bf62c9b68253
2026-01-19 03:46:03,659 - DEBUG - Response Code: 404
2026-01-19 03:46:03,660 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-01-19 03:46:03,666 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7
2026-01-19 03:46:03,678 - DEBUG - Requesting: http://10.0.0.27:8082/project/075b0fb7-f3e1-4a6e-bc31-3fd0a7f3f278
2026-01-19 03:46:03,771 - INFO - Validated that VN ctest-fip_vn-02843539 is not found in API Server
2026-01-19 03:46:03,781 - DEBUG - VN ctest-fip_vn-02843539 is not present in Agent 10.0.0.249
2026-01-19 03:46:03,791 - DEBUG - VN ctest-fip_vn-02843539 is not present in Agent 10.0.0.65
2026-01-19 03:46:03,791 - INFO - Validated that VN ctest-fip_vn-02843539 is not in any agent
2026-01-19 03:46:03,795 - DEBUG - VRF 3 is not seen in agent 10.0.0.65
2026-01-19 03:46:03,800 - DEBUG - Vrouter 10.0.0.65 does not have vrf 3 for VN ctest-fip_vn-02843539
2026-01-19 03:46:03,800 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-fip_vn-02843539
2026-01-19 03:46:03,822 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-02843539 info
2026-01-19 03:46:03,823 - INFO - Deleting VN ctest-vn2-96285596
2026-01-19 03:46:04,000 - DEBUG - Response for deleting network ()
2026-01-19 03:46:04,000 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/2fa2f774-f8f0-4fe7-ad46-a6c9d52bca2f
2026-01-19 03:46:04,007 - DEBUG - Response Code: 404
2026-01-19 03:46:04,007 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-01-19 03:46:04,012 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7
2026-01-19 03:46:04,023 - DEBUG - Requesting: http://10.0.0.27:8082/project/075b0fb7-f3e1-4a6e-bc31-3fd0a7f3f278
2026-01-19 03:46:04,108 - INFO - Validated that VN ctest-vn2-96285596 is not found in API Server
2026-01-19 03:46:04,119 - DEBUG - VN ctest-vn2-96285596 is not present in Agent 10.0.0.249
2026-01-19 03:46:04,128 - DEBUG - VN ctest-vn2-96285596 is not present in Agent 10.0.0.65
2026-01-19 03:46:04,128 - INFO - Validated that VN ctest-vn2-96285596 is not in any agent
2026-01-19 03:46:04,134 - DEBUG - VRF 3 is not seen in agent 10.0.0.249
2026-01-19 03:46:04,140 - DEBUG - Vrouter 10.0.0.249 does not have vrf 3 for VN ctest-vn2-96285596
2026-01-19 03:46:04,145 - DEBUG - VRF 2 is not seen in agent 10.0.0.65
2026-01-19 03:46:04,149 - DEBUG - Vrouter 10.0.0.65 does not have vrf 2 for VN ctest-vn2-96285596
2026-01-19 03:46:04,149 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn2-96285596
2026-01-19 03:46:04,173 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-96285596 info
2026-01-19 03:46:04,173 - INFO - Deleting VM ctest-vn1_vm2-05681982
2026-01-19 03:46:04,247 - INFO - Deleting VM ctest-vn1_vm1-93686515
2026-01-19 03:46:04,318 - INFO - Deleting VN ctest-vn1-62678230
2026-01-19 03:46:04,361 - DEBUG - VN b961562b-6235-4bd8-a543-be58397c86f1 still in use: Unable to complete operation on network b961562b-6235-4bd8-a543-be58397c86f1. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-9bd9751c-448e-4ffb-986f-1b688d29161f']
2026-01-19 03:46:04,361 - WARNING - Deleting VN ctest-vn1-62678230 failed..Will retry
2026-01-19 03:46:06,558 - DEBUG - Response for deleting network ()
2026-01-19 03:46:06,558 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/7e240d6f-164e-41f5-80a1-5cf20ae88b88
2026-01-19 03:46:06,565 - DEBUG - Response Code: 404
2026-01-19 03:46:06,565 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2026-01-19 03:46:06,571 - DEBUG - Requesting: http://10.0.0.27:8082/domain/bc123c74-c45e-4d7a-a955-76f59d7a4cc7
2026-01-19 03:46:06,582 - DEBUG - Requesting: http://10.0.0.27:8082/project/075b0fb7-f3e1-4a6e-bc31-3fd0a7f3f278
2026-01-19 03:46:06,685 - INFO - Validated that VN ctest-vn1-62678230 is not found in API Server
2026-01-19 03:46:06,698 - DEBUG - VN ctest-vn1-62678230 is not present in Agent 10.0.0.249
2026-01-19 03:46:06,708 - DEBUG - VN ctest-vn1-62678230 is not present in Agent 10.0.0.65
2026-01-19 03:46:06,708 - INFO - Validated that VN ctest-vn1-62678230 is not in any agent
2026-01-19 03:46:06,713 - DEBUG - VRF 2 is not seen in agent 10.0.0.249
2026-01-19 03:46:06,720 - DEBUG - Vrouter 10.0.0.249 does not have vrf 2 for VN ctest-vn1-62678230
2026-01-19 03:46:06,720 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-84413787:ctest-vn1-62678230
2026-01-19 03:46:06,741 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-62678230 info
2026-01-19 03:46:07,536 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-84413787, ID : 075b0fb7-f3e1-4a6e-bc31-3fd0a7f3f278