is in ACTIVE state now
2026-03-19 04:02:25,847 - INFO - VM name : mltf_vm
2026-03-19 04:02:25,948 - DEBUG - VM mltf_vm ID is ae5f996d-723b-4d82-855c-5cfc95984bb5
2026-03-19 04:02:25,948 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-5493-2
2026-03-19 04:02:26,186 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/ae5f996d-723b-4d82-855c-5cfc95984bb5
2026-03-19 04:02:26,197 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/47c2e3d5-d435-4870-961f-903dba319d23
2026-03-19 04:02:26,208 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/c49404d1-adbd-4a14-bee5-fd49c63b1851
2026-03-19 04:02:28,747 - 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=5.56 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=2.70 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 = 2.704/4.133/5.562/1.429 ms')
2026-03-19 04:02:28,748 - INFO - Ping to Metadata IP 169.254.0.5 of VM mltf_vm passed
2026-03-19 04:02:28,815 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-19 04:02:28,815 - DEBUG - Waiting to SSH to VM mltf_vm, IP 204.62.11.197, Port 22
2026-03-19 04:02:28,882 - DEBUG - Error on ssh to cirros@169.254.0.5:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.5/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.5/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.5/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-03-19 04:02:28,978 - DEBUG - VM mltf_vm is NOT ready for SSH connections, VM status: ACTIVE
2026-03-19 04:02:33,979 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-19 04:02:33,979 - DEBUG - Waiting to SSH to VM mltf_vm, IP 204.62.11.197, Port 22
2026-03-19 04:02:34,154 - DEBUG - VM mltf_vm is ready for SSH connections
2026-03-19 04:02:34,227 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-19 04:02:34,227 - DEBUG - Waiting to SSH to VM mltf_vm, IP 204.62.11.197, Port 22
2026-03-19 04:02:34,394 - DEBUG - VM mltf_vm is ready for SSH connections
2026-03-19 04:02:34,396 - INFO - ================================================================================
2026-03-19 04:02:34,396 - INFO - STARTING TEST : test_verify_session_sampling_teardown
2026-03-19 04:02:34,396 - 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-03-19 04:02:35,683 - DEBUG - Skipping xmpp flap check
2026-03-19 04:02:35,683 - INFO - Initial checks done. Running the testcase now
2026-03-19 04:02:35,683 - INFO -
2026-03-19 04:02:35,806 - INFO - Setting flow export rate: 100
2026-03-19 04:02:35,859 - 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-03-19 04:02:36,197 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '2ffc085f-191f-4919-a0bd-af9398622928', 'name': 'ctest-vn1-77315273', 'tenant_id': '397e684e8b054622834efb9d458dd0bb', 'project_id': '397e684e8b054622834efb9d458dd0bb', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['1d778634-92a5-4b35-810c-82fc23b046a6'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-59278712', 'ctest-vn1-77315273'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-59278712', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '204.62.11.192/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-03-19 04:02:36,413 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'aab1ca6d-69f0-4ba1-a578-a6695e980255', 'name': 'ctest-vn2-86370994', 'tenant_id': '397e684e8b054622834efb9d458dd0bb', 'project_id': '397e684e8b054622834efb9d458dd0bb', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['e10b4aad-4b69-4768-89f5-309466cd2345'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-59278712', 'ctest-vn2-86370994'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-59278712', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '102.254.202.128/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-03-19 04:02:36,506 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 04:02:36,533 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 04:02:36,577 - DEBUG - Requesting: http://10.0.0.41:8082/project/397e684e-8b05-4622-834e-fb9d458dd0bb
2026-03-19 04:02:36,695 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/2ffc085f-191f-4919-a0bd-af9398622928
2026-03-19 04:02:36,721 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/2ffc085f-191f-4919-a0bd-af9398622928
2026-03-19 04:02:36,735 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/103096d3-5a7f-4279-98f0-4e7c0e38b929
2026-03-19 04:02:36,749 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/103096d3-5a7f-4279-98f0-4e7c0e38b929
2026-03-19 04:02:36,758 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/2c3a3eb1-98cd-46a9-be48-5114321a96e5
2026-03-19 04:02:36,766 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 04:02:36,766 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/2ffc085f-191f-4919-a0bd-af9398622928
2026-03-19 04:02:36,779 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/103096d3-5a7f-4279-98f0-4e7c0e38b929
2026-03-19 04:02:36,803 - INFO - Verified VN network id 14 for VN 2ffc085f-191f-4919-a0bd-af9398622928
2026-03-19 04:02:36,803 - INFO - Verifications in API Server for VN ctest-vn1-77315273 passed
2026-03-19 04:02:36,804 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/2ffc085f-191f-4919-a0bd-af9398622928
2026-03-19 04:02:36,823 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/103096d3-5a7f-4279-98f0-4e7c0e38b929
2026-03-19 04:02:36,837 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/103096d3-5a7f-4279-98f0-4e7c0e38b929
2026-03-19 04:02:36,859 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/2c3a3eb1-98cd-46a9-be48-5114321a96e5
2026-03-19 04:02:36,883 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59278712', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3457647818450094361', 'uuid-lslong': '11582606865118406952'}, 'enable': 'true', 'created': '2026-03-19T04:00:40', 'last-modified': '2026-03-19T04:02:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.722438'}
2026-03-19 04:02:36,893 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 04:02:36,899 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59278712', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3457647818450094361', 'uuid-lslong': '11582606865118406952'}, 'enable': 'true', 'created': '2026-03-19T04:00:40', 'last-modified': '2026-03-19T04:02:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.741914'}
2026-03-19 04:02:36,907 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 04:02:36,913 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59278712', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3457647818450094361', 'uuid-lslong': '11582606865118406952'}, 'enable': 'true', 'created': '2026-03-19T04:00:40', 'last-modified': '2026-03-19T04:02:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.753151'}
2026-03-19 04:02:36,920 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 04:02:36,921 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-77315273 passed
2026-03-19 04:02:36,921 - DEBUG - ====Verifying policy data for ctest-vn1-77315273 in API_Server ======
2026-03-19 04:02:36,921 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 04:02:36,928 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 04:02:36,948 - DEBUG - Requesting: http://10.0.0.41:8082/project/397e684e-8b05-4622-834e-fb9d458dd0bb
2026-03-19 04:02:37,049 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/2ffc085f-191f-4919-a0bd-af9398622928
2026-03-19 04:02:37,060 - DEBUG - ==>Verifying data for policy with id: 876161ef-74ec-4155-8dae-80bc1deb2661, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-59278712', 'policy1']
2026-03-19 04:02:37,060 - INFO - VN ctest-vn1-77315273 Policy verification: verify_vn_policy_in_api_server, status: True
2026-03-19 04:02:37,060 - DEBUG - Verifying the vn in opserver
2026-03-19 04:02:37,060 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273 virtual network link through opserver 10.0.0.41
2026-03-19 04:02:37,060 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-03-19 04:02:37,074 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273?flat'}
2026-03-19 04:02:37,074 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273 virtual network link through opserver 10.0.0.242
2026-03-19 04:02:37,074 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-03-19 04:02:37,088 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273?flat'}
2026-03-19 04:02:37,088 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273 virtual network link through opserver 10.0.0.27
2026-03-19 04:02:37,088 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-19 04:02:37,101 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273?flat'}
2026-03-19 04:02:37,101 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273 is found in opserver
2026-03-19 04:02:37,113 - DEBUG - VRF ids for VN ctest-vn1-77315273: {'10.0.0.240': '2'}
2026-03-19 04:02:37,113 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 04:02:37,120 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 04:02:37,133 - DEBUG - Requesting: http://10.0.0.41:8082/project/397e684e-8b05-4622-834e-fb9d458dd0bb
2026-03-19 04:02:37,235 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/aab1ca6d-69f0-4ba1-a578-a6695e980255
2026-03-19 04:02:37,254 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/aab1ca6d-69f0-4ba1-a578-a6695e980255
2026-03-19 04:02:37,267 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/8fba0982-4336-4bc4-802a-0c4bd5d044be
2026-03-19 04:02:37,279 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/8fba0982-4336-4bc4-802a-0c4bd5d044be
2026-03-19 04:02:37,292 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/75a1388f-c7d6-458d-bc2e-407af8bf9eeb
2026-03-19 04:02:37,303 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 04:02:37,303 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/aab1ca6d-69f0-4ba1-a578-a6695e980255
2026-03-19 04:02:37,317 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/8fba0982-4336-4bc4-802a-0c4bd5d044be
2026-03-19 04:02:37,340 - INFO - Verified VN network id 15 for VN aab1ca6d-69f0-4ba1-a578-a6695e980255
2026-03-19 04:02:37,340 - INFO - Verifications in API Server for VN ctest-vn2-86370994 passed
2026-03-19 04:02:37,341 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/aab1ca6d-69f0-4ba1-a578-a6695e980255
2026-03-19 04:02:37,355 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/8fba0982-4336-4bc4-802a-0c4bd5d044be
2026-03-19 04:02:37,367 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/8fba0982-4336-4bc4-802a-0c4bd5d044be
2026-03-19 04:02:37,378 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/75a1388f-c7d6-458d-bc2e-407af8bf9eeb
2026-03-19 04:02:37,399 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59278712', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12299834628603136929', 'uuid-lslong': '11923462984952185429'}, 'enable': 'true', 'created': '2026-03-19T04:01:41', 'last-modified': '2026-03-19T04:02:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.011740'}
2026-03-19 04:02:37,407 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 04:02:37,416 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59278712', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12299834628603136929', 'uuid-lslong': '11923462984952185429'}, 'enable': 'true', 'created': '2026-03-19T04:01:41', 'last-modified': '2026-03-19T04:02:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.039465'}
2026-03-19 04:02:37,425 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 04:02:37,432 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'interests': '0-1', 'advertised': '0-1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59278712', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12299834628603136929', 'uuid-lslong': '11923462984952185429'}, 'enable': 'true', 'created': '2026-03-19T04:01:41', 'last-modified': '2026-03-19T04:02:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.058378'}
2026-03-19 04:02:37,439 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 04:02:37,439 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-86370994 passed
2026-03-19 04:02:37,439 - DEBUG - ====Verifying policy data for ctest-vn2-86370994 in API_Server ======
2026-03-19 04:02:37,440 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 04:02:37,447 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 04:02:37,461 - DEBUG - Requesting: http://10.0.0.41:8082/project/397e684e-8b05-4622-834e-fb9d458dd0bb
2026-03-19 04:02:37,554 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/aab1ca6d-69f0-4ba1-a578-a6695e980255
2026-03-19 04:02:37,573 - DEBUG - ==>Verifying data for policy with id: 876161ef-74ec-4155-8dae-80bc1deb2661, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-59278712', 'policy1']
2026-03-19 04:02:37,573 - INFO - VN ctest-vn2-86370994 Policy verification: verify_vn_policy_in_api_server, status: True
2026-03-19 04:02:37,573 - DEBUG - Verifying the vn in opserver
2026-03-19 04:02:37,573 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994 virtual network link through opserver 10.0.0.41
2026-03-19 04:02:37,573 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-03-19 04:02:37,586 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994?flat'}
2026-03-19 04:02:37,586 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994 virtual network link through opserver 10.0.0.242
2026-03-19 04:02:37,586 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-03-19 04:02:37,600 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994?flat'}
2026-03-19 04:02:37,600 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994 virtual network link through opserver 10.0.0.27
2026-03-19 04:02:37,600 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-19 04:02:37,620 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994?flat'}
2026-03-19 04:02:37,620 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994 is found in opserver
2026-03-19 04:02:37,632 - DEBUG - VRF ids for VN ctest-vn2-86370994: {'10.0.0.23': '2', '10.0.0.240': '3'}
2026-03-19 04:02:37,633 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 04:02:37,640 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 04:02:37,657 - DEBUG - Requesting: http://10.0.0.41:8082/project/397e684e-8b05-4622-834e-fb9d458dd0bb
2026-03-19 04:02:37,767 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/2ffc085f-191f-4919-a0bd-af9398622928
2026-03-19 04:02:37,780 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/2ffc085f-191f-4919-a0bd-af9398622928
2026-03-19 04:02:37,794 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/103096d3-5a7f-4279-98f0-4e7c0e38b929
2026-03-19 04:02:37,811 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/103096d3-5a7f-4279-98f0-4e7c0e38b929
2026-03-19 04:02:37,824 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/2c3a3eb1-98cd-46a9-be48-5114321a96e5
2026-03-19 04:02:37,836 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 04:02:37,836 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/2ffc085f-191f-4919-a0bd-af9398622928
2026-03-19 04:02:37,855 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/103096d3-5a7f-4279-98f0-4e7c0e38b929
2026-03-19 04:02:37,880 - INFO - Verified VN network id 14 for VN 2ffc085f-191f-4919-a0bd-af9398622928
2026-03-19 04:02:37,880 - INFO - Verifications in API Server for VN ctest-vn1-77315273 passed
2026-03-19 04:02:37,880 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/2ffc085f-191f-4919-a0bd-af9398622928
2026-03-19 04:02:37,908 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/103096d3-5a7f-4279-98f0-4e7c0e38b929
2026-03-19 04:02:37,919 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/103096d3-5a7f-4279-98f0-4e7c0e38b929
2026-03-19 04:02:37,929 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/2c3a3eb1-98cd-46a9-be48-5114321a96e5
2026-03-19 04:02:37,944 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59278712', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3457647818450094361', 'uuid-lslong': '11582606865118406952'}, 'enable': 'true', 'created': '2026-03-19T04:00:40', 'last-modified': '2026-03-19T04:02:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.783067'}
2026-03-19 04:02:37,958 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 04:02:37,964 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59278712', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3457647818450094361', 'uuid-lslong': '11582606865118406952'}, 'enable': 'true', 'created': '2026-03-19T04:00:40', 'last-modified': '2026-03-19T04:02:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.806763'}
2026-03-19 04:02:37,973 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 04:02:37,979 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59278712', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3457647818450094361', 'uuid-lslong': '11582606865118406952'}, 'enable': 'true', 'created': '2026-03-19T04:00:40', 'last-modified': '2026-03-19T04:02:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.818893'}
2026-03-19 04:02:37,986 - DEBUG - Route Targets: ['target:64512:8000004']
2026-03-19 04:02:37,987 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-77315273 passed
2026-03-19 04:02:37,987 - DEBUG - ====Verifying policy data for ctest-vn1-77315273 in API_Server ======
2026-03-19 04:02:37,987 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 04:02:37,996 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 04:02:38,011 - DEBUG - Requesting: http://10.0.0.41:8082/project/397e684e-8b05-4622-834e-fb9d458dd0bb
2026-03-19 04:02:38,127 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/2ffc085f-191f-4919-a0bd-af9398622928
2026-03-19 04:02:38,149 - DEBUG - ==>Verifying data for policy with id: 876161ef-74ec-4155-8dae-80bc1deb2661, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-59278712', 'policy1']
2026-03-19 04:02:38,149 - INFO - VN ctest-vn1-77315273 Policy verification: verify_vn_policy_in_api_server, status: True
2026-03-19 04:02:38,149 - DEBUG - Verifying the vn in opserver
2026-03-19 04:02:38,149 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273 virtual network link through opserver 10.0.0.41
2026-03-19 04:02:38,149 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-03-19 04:02:38,164 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273?flat'}
2026-03-19 04:02:38,164 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273 virtual network link through opserver 10.0.0.242
2026-03-19 04:02:38,164 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-03-19 04:02:38,180 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273?flat'}
2026-03-19 04:02:38,180 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273 virtual network link through opserver 10.0.0.27
2026-03-19 04:02:38,180 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-19 04:02:38,194 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273?flat'}
2026-03-19 04:02:38,194 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273 is found in opserver
2026-03-19 04:02:38,207 - DEBUG - VRF ids for VN ctest-vn1-77315273: {'10.0.0.240': '2'}
2026-03-19 04:02:38,208 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 04:02:38,216 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 04:02:38,231 - DEBUG - Requesting: http://10.0.0.41:8082/project/397e684e-8b05-4622-834e-fb9d458dd0bb
2026-03-19 04:02:38,352 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/aab1ca6d-69f0-4ba1-a578-a6695e980255
2026-03-19 04:02:38,364 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/aab1ca6d-69f0-4ba1-a578-a6695e980255
2026-03-19 04:02:38,375 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/8fba0982-4336-4bc4-802a-0c4bd5d044be
2026-03-19 04:02:38,385 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/8fba0982-4336-4bc4-802a-0c4bd5d044be
2026-03-19 04:02:38,395 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/75a1388f-c7d6-458d-bc2e-407af8bf9eeb
2026-03-19 04:02:38,407 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 04:02:38,407 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/aab1ca6d-69f0-4ba1-a578-a6695e980255
2026-03-19 04:02:38,421 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/8fba0982-4336-4bc4-802a-0c4bd5d044be
2026-03-19 04:02:38,441 - INFO - Verified VN network id 15 for VN aab1ca6d-69f0-4ba1-a578-a6695e980255
2026-03-19 04:02:38,441 - INFO - Verifications in API Server for VN ctest-vn2-86370994 passed
2026-03-19 04:02:38,441 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/aab1ca6d-69f0-4ba1-a578-a6695e980255
2026-03-19 04:02:38,454 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/8fba0982-4336-4bc4-802a-0c4bd5d044be
2026-03-19 04:02:38,466 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/8fba0982-4336-4bc4-802a-0c4bd5d044be
2026-03-19 04:02:38,478 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/75a1388f-c7d6-458d-bc2e-407af8bf9eeb
2026-03-19 04:02:38,498 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59278712', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12299834628603136929', 'uuid-lslong': '11923462984952185429'}, 'enable': 'true', 'created': '2026-03-19T04:01:41', 'last-modified': '2026-03-19T04:02:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.107832'}
2026-03-19 04:02:38,508 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 04:02:38,514 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59278712', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12299834628603136929', 'uuid-lslong': '11923462984952185429'}, 'enable': 'true', 'created': '2026-03-19T04:01:41', 'last-modified': '2026-03-19T04:02:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.139152'}
2026-03-19 04:02:38,520 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 04:02:38,526 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'interests': '0-1', 'advertised': '0-1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59278712', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12299834628603136929', 'uuid-lslong': '11923462984952185429'}, 'enable': 'true', 'created': '2026-03-19T04:01:41', 'last-modified': '2026-03-19T04:02:36', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.152534'}
2026-03-19 04:02:38,533 - DEBUG - Route Targets: ['target:64512:8000005']
2026-03-19 04:02:38,534 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-86370994 passed
2026-03-19 04:02:38,534 - DEBUG - ====Verifying policy data for ctest-vn2-86370994 in API_Server ======
2026-03-19 04:02:38,534 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 04:02:38,542 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 04:02:38,556 - DEBUG - Requesting: http://10.0.0.41:8082/project/397e684e-8b05-4622-834e-fb9d458dd0bb
2026-03-19 04:02:38,662 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/aab1ca6d-69f0-4ba1-a578-a6695e980255
2026-03-19 04:02:38,678 - DEBUG - ==>Verifying data for policy with id: 876161ef-74ec-4155-8dae-80bc1deb2661, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-59278712', 'policy1']
2026-03-19 04:02:38,678 - INFO - VN ctest-vn2-86370994 Policy verification: verify_vn_policy_in_api_server, status: True
2026-03-19 04:02:38,678 - DEBUG - Verifying the vn in opserver
2026-03-19 04:02:38,678 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994 virtual network link through opserver 10.0.0.41
2026-03-19 04:02:38,678 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-03-19 04:02:38,694 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994?flat'}
2026-03-19 04:02:38,694 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994 virtual network link through opserver 10.0.0.242
2026-03-19 04:02:38,694 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-03-19 04:02:38,713 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994?flat'}
2026-03-19 04:02:38,713 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994 virtual network link through opserver 10.0.0.27
2026-03-19 04:02:38,713 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-19 04:02:38,727 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994?flat'}
2026-03-19 04:02:38,727 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994 is found in opserver
2026-03-19 04:02:38,743 - DEBUG - VRF ids for VN ctest-vn2-86370994: {'10.0.0.23': '2', '10.0.0.240': '3'}
2026-03-19 04:02:38,743 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 04:02:38,750 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 04:02:38,763 - DEBUG - Requesting: http://10.0.0.41:8082/project/397e684e-8b05-4622-834e-fb9d458dd0bb
2026-03-19 04:02:38,857 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/c760800d-f477-4713-87ea-1645cc171d1b
2026-03-19 04:02:38,873 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/c760800d-f477-4713-87ea-1645cc171d1b
2026-03-19 04:02:38,887 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1d0f8fd8-9b47-435d-8b02-42fe3e10abee
2026-03-19 04:02:38,899 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1d0f8fd8-9b47-435d-8b02-42fe3e10abee
2026-03-19 04:02:38,912 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/8a4a8846-9fb3-4d1e-bce8-066f6e26bf1f
2026-03-19 04:02:38,921 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-19 04:02:38,921 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/c760800d-f477-4713-87ea-1645cc171d1b
2026-03-19 04:02:38,932 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1d0f8fd8-9b47-435d-8b02-42fe3e10abee
2026-03-19 04:02:38,950 - INFO - Verified VN network id 16 for VN c760800d-f477-4713-87ea-1645cc171d1b
2026-03-19 04:02:38,950 - INFO - Verifications in API Server for VN ctest-fip_vn-85328215 passed
2026-03-19 04:02:38,950 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/c760800d-f477-4713-87ea-1645cc171d1b
2026-03-19 04:02:38,963 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1d0f8fd8-9b47-435d-8b02-42fe3e10abee
2026-03-19 04:02:38,974 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1d0f8fd8-9b47-435d-8b02-42fe3e10abee
2026-03-19 04:02:38,986 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/8a4a8846-9fb3-4d1e-bce8-066f6e26bf1f
2026-03-19 04:02:39,002 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-fip_vn-85328215', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59278712', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14366623608736270099', 'uuid-lslong': '9793664828703186203'}, 'enable': 'true', 'created': '2026-03-19T04:01:41', 'last-modified': '2026-03-19T04:01:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:56.956196'}
2026-03-19 04:02:39,010 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-19 04:02:39,017 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-fip_vn-85328215', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59278712', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14366623608736270099', 'uuid-lslong': '9793664828703186203'}, 'enable': 'true', 'created': '2026-03-19T04:01:41', 'last-modified': '2026-03-19T04:01:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:56.975367'}
2026-03-19 04:02:39,028 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-19 04:02:39,034 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-fip_vn-85328215', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59278712', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '14366623608736270099', 'uuid-lslong': '9793664828703186203'}, 'enable': 'true', 'created': '2026-03-19T04:01:41', 'last-modified': '2026-03-19T04:01:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:56.992872'}
2026-03-19 04:02:39,040 - DEBUG - Route Targets: ['target:64512:8000006']
2026-03-19 04:02:39,041 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-85328215 passed
2026-03-19 04:02:39,041 - DEBUG - ====Verifying policy data for ctest-fip_vn-85328215 in API_Server ======
2026-03-19 04:02:39,041 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 04:02:39,050 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 04:02:39,064 - DEBUG - Requesting: http://10.0.0.41:8082/project/397e684e-8b05-4622-834e-fb9d458dd0bb
2026-03-19 04:02:39,156 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/c760800d-f477-4713-87ea-1645cc171d1b
2026-03-19 04:02:39,166 - DEBUG - =>VN ctest-fip_vn-85328215 has no policy to be verified
2026-03-19 04:02:39,166 - DEBUG - Verifying the vn in opserver
2026-03-19 04:02:39,166 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-fip_vn-85328215 virtual network link through opserver 10.0.0.41
2026-03-19 04:02:39,166 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2026-03-19 04:02:39,179 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-fip_vn-85328215', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-fip_vn-85328215?flat'}
2026-03-19 04:02:39,179 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-fip_vn-85328215 virtual network link through opserver 10.0.0.242
2026-03-19 04:02:39,179 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks
2026-03-19 04:02:39,195 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-fip_vn-85328215', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-fip_vn-85328215?flat'}
2026-03-19 04:02:39,195 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-fip_vn-85328215 virtual network link through opserver 10.0.0.27
2026-03-19 04:02:39,195 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2026-03-19 04:02:39,208 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-fip_vn-85328215', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-fip_vn-85328215?flat'}
2026-03-19 04:02:39,208 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-fip_vn-85328215 is found in opserver
2026-03-19 04:02:39,222 - DEBUG - VRF ids for VN ctest-fip_vn-85328215: {'10.0.0.23': '3'}
2026-03-19 04:02:39,222 - INFO - start time= 1773892959222782
2026-03-19 04:02:39,222 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 102.254.202.131, host_string: cirros@169.254.0.3, password: gocubsgogateway: ubuntu@10.0.0.240, gateway password: c0ntrail123
2026-03-19 04:02:39,223 - DEBUG - ping -s 56 -c 3 -W 1 102.254.202.131
2026-03-19 04:02:43,237 - DEBUG - PING 102.254.202.131 (102.254.202.131): 56 data bytes
64 bytes from 102.254.202.131: seq=0 ttl=63 time=5.074 ms
64 bytes from 102.254.202.131: seq=1 ttl=63 time=1.340 ms
64 bytes from 102.254.202.131: seq=2 ttl=63 time=1.590 ms
--- 102.254.202.131 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.340/2.668/5.074 ms
2026-03-19 04:02:43,237 - INFO - Ping to IP 102.254.202.131 from VM ctest-vn1_vm1-16318725 passed
2026-03-19 04:02:53,238 - INFO - Verify session samples and teardown pkts
2026-03-19 04:02:53,238 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.41
2026-03-19 04:02:53,242 - DEBUG - Posting: http://10.0.0.41:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1773892959222782, 'end_time': 1773892973242010, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-03-19 04:02:54,268 - DEBUG - [{'T': 1773892961562087}, {'T': 1773892962561919}, {'T': 1773892963561961}]
2026-03-19 04:02:54,268 - DEBUG - Posting: http://10.0.0.41:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1773892959222782, 'end_time': 1773892974268471, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2026-03-19 04:02:55,293 - DEBUG - [{'T': 1773892961271104}, {'T': 1773892962271194}, {'T': 1773892963271302}]
2026-03-19 04:02:55,293 - DEBUG - Posting: http://10.0.0.41:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1773892959222782, 'end_time': 1773892975293691, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-03-19 04:02:56,321 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'sample_count': 3}]
2026-03-19 04:02:56,321 - INFO - wait for the flows to get expire
2026-03-19 04:06:16,322 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5493-2:Compute:contrail-vrouter-agent:0?flat
2026-03-19 04:06:16,363 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5493-2?flat
2026-03-19 04:06:16,396 - DEBUG - Posting: http://10.0.0.41:8081/analytics/query, payload {'table': 'SessionRecordTable', 'start_time': 1773892959222782, 'end_time': 1773893176396786, 'select_fields': ['vn', 'remote_vn', 'forward_teardown_pkts', 'reverse_teardown_pkts'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-03-19 04:06:17,418 - DEBUG - [{'forward_flow_uuid': 'f42eb274-4b15-462f-930b-fbd6e16876ea', 'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'reverse_flow_uuid': '268cab38-c836-4dc2-bb88-e4bcc636939d', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'forward_teardown_pkts': 3, 'reverse_teardown_pkts': 3}]
2026-03-19 04:06:17,418 - DEBUG - Posting: http://10.0.0.41:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1773892959222782, 'end_time': 1773893177418185, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-03-19 04:06:18,505 - DEBUG - Posting: http://10.0.0.41:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1773892959222782, 'end_time': 1773893178505641, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2026-03-19 04:06:19,531 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994', 'sample_count': 4}]
2026-03-19 04:06:20,116 - INFO - Deleted policy policy1
2026-03-19 04:06:20,226 - INFO - Setting flow export rate: None
2026-03-19 04:06:21,512 - DEBUG - Skipping xmpp flap check
2026-03-19 04:06:21,512 - INFO - END TEST : test_verify_session_sampling_teardown : PASSED[0:03:47]
2026-03-19 04:06:21,512 - INFO - --------------------------------------------------------------------------------
2026-03-19 04:06:21,514 - INFO - Deleting VM mltf_vm
2026-03-19 04:06:21,613 - INFO - Deleting VM ctest-fvn_vm1-83513750
2026-03-19 04:06:21,698 - INFO - Deleting VM ctest-vn2_vm2-57498700
2026-03-19 04:06:21,779 - INFO - Deleting VN ctest-fip_vn-85328215
2026-03-19 04:06:21,819 - DEBUG - VN c760800d-f477-4713-87ea-1645cc171d1b still in use: Unable to complete operation on network c760800d-f477-4713-87ea-1645cc171d1b. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-cc215b12-fd8c-4890-acf5-c8d78c70344f']
2026-03-19 04:06:21,819 - WARNING - Deleting VN ctest-fip_vn-85328215 failed..Will retry
2026-03-19 04:06:23,979 - DEBUG - Response for deleting network ()
2026-03-19 04:06:23,979 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/1d0f8fd8-9b47-435d-8b02-42fe3e10abee
2026-03-19 04:06:24,025 - DEBUG - Response Code: 404
2026-03-19 04:06:24,025 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 04:06:24,031 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 04:06:24,045 - DEBUG - Requesting: http://10.0.0.41:8082/project/397e684e-8b05-4622-834e-fb9d458dd0bb
2026-03-19 04:06:24,148 - INFO - Validated that VN ctest-fip_vn-85328215 is not found in API Server
2026-03-19 04:06:24,159 - DEBUG - VN ctest-fip_vn-85328215 is not present in Agent 10.0.0.23
2026-03-19 04:06:24,176 - DEBUG - VN ctest-fip_vn-85328215 is not present in Agent 10.0.0.240
2026-03-19 04:06:24,176 - INFO - Validated that VN ctest-fip_vn-85328215 is not in any agent
2026-03-19 04:06:24,182 - DEBUG - VRF 3 is not seen in agent 10.0.0.23
2026-03-19 04:06:24,187 - DEBUG - Vrouter 10.0.0.23 does not have vrf 3 for VN ctest-fip_vn-85328215
2026-03-19 04:06:24,187 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-fip_vn-85328215
2026-03-19 04:06:24,207 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-85328215 info
2026-03-19 04:06:24,207 - INFO - Deleting VN ctest-vn2-86370994
2026-03-19 04:06:24,369 - DEBUG - Response for deleting network ()
2026-03-19 04:06:24,369 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/8fba0982-4336-4bc4-802a-0c4bd5d044be
2026-03-19 04:06:24,378 - DEBUG - Response Code: 404
2026-03-19 04:06:24,379 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 04:06:24,385 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 04:06:24,396 - DEBUG - Requesting: http://10.0.0.41:8082/project/397e684e-8b05-4622-834e-fb9d458dd0bb
2026-03-19 04:06:24,517 - INFO - Validated that VN ctest-vn2-86370994 is not found in API Server
2026-03-19 04:06:24,529 - DEBUG - VN ctest-vn2-86370994 is not present in Agent 10.0.0.23
2026-03-19 04:06:24,539 - DEBUG - VN ctest-vn2-86370994 is not present in Agent 10.0.0.240
2026-03-19 04:06:24,539 - INFO - Validated that VN ctest-vn2-86370994 is not in any agent
2026-03-19 04:06:24,545 - DEBUG - VRF 2 is not seen in agent 10.0.0.23
2026-03-19 04:06:24,550 - DEBUG - Vrouter 10.0.0.23 does not have vrf 2 for VN ctest-vn2-86370994
2026-03-19 04:06:24,557 - DEBUG - VRF 3 is not seen in agent 10.0.0.240
2026-03-19 04:06:24,564 - DEBUG - Vrouter 10.0.0.240 does not have vrf 3 for VN ctest-vn2-86370994
2026-03-19 04:06:24,564 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn2-86370994
2026-03-19 04:06:24,584 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-86370994 info
2026-03-19 04:06:24,585 - INFO - Deleting VM ctest-vn1_vm2-74118669
2026-03-19 04:06:24,682 - INFO - Deleting VM ctest-vn1_vm1-16318725
2026-03-19 04:06:24,768 - INFO - Deleting VN ctest-vn1-77315273
2026-03-19 04:06:24,818 - DEBUG - VN 2ffc085f-191f-4919-a0bd-af9398622928 still in use: Unable to complete operation on network 2ffc085f-191f-4919-a0bd-af9398622928. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-158ccdad-4439-4489-b34d-92a8d89ad4ab']
2026-03-19 04:06:24,818 - WARNING - Deleting VN ctest-vn1-77315273 failed..Will retry
2026-03-19 04:06:27,014 - DEBUG - Response for deleting network ()
2026-03-19 04:06:27,015 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/103096d3-5a7f-4279-98f0-4e7c0e38b929
2026-03-19 04:06:27,025 - DEBUG - Response Code: 404
2026-03-19 04:06:27,025 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2026-03-19 04:06:27,032 - DEBUG - Requesting: http://10.0.0.41:8082/domain/cb4acbf6-9e94-415a-a3f1-1be95317ba76
2026-03-19 04:06:27,051 - DEBUG - Requesting: http://10.0.0.41:8082/project/397e684e-8b05-4622-834e-fb9d458dd0bb
2026-03-19 04:06:27,157 - INFO - Validated that VN ctest-vn1-77315273 is not found in API Server
2026-03-19 04:06:27,174 - DEBUG - VN ctest-vn1-77315273 is not present in Agent 10.0.0.23
2026-03-19 04:06:27,184 - DEBUG - VN ctest-vn1-77315273 is not present in Agent 10.0.0.240
2026-03-19 04:06:27,184 - INFO - Validated that VN ctest-vn1-77315273 is not in any agent
2026-03-19 04:06:27,190 - DEBUG - VRF 2 is not seen in agent 10.0.0.240
2026-03-19 04:06:27,196 - DEBUG - Vrouter 10.0.0.240 does not have vrf 2 for VN ctest-vn1-77315273
2026-03-19 04:06:27,196 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-59278712:ctest-vn1-77315273
2026-03-19 04:06:27,217 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-77315273 info
2026-03-19 04:06:28,073 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-59278712, ID : 397e684e-8b05-4622-834e-fb9d458dd0bb