is in ACTIVE state now
2025-10-27 03:51:00,018 - INFO - VM name : mltf_vm
2025-10-27 03:51:00,116 - DEBUG - VM mltf_vm ID is d4bd1c0e-89db-4845-8f3a-09a26433177d
2025-10-27 03:51:00,116 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-4489-2
2025-10-27 03:51:00,321 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/d4bd1c0e-89db-4845-8f3a-09a26433177d
2025-10-27 03:51:00,331 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine-interface/0a826cc9-0954-4530-9b65-6ebdf1696463
2025-10-27 03:51:00,341 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine-interface/50e2c5a9-9f26-4c9a-a2e8-90a202d9f032
2025-10-27 03:51:01,520 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n64 bytes from 169.254.0.5: icmp_seq=1 ttl=63 time=1.81 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.533 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.533/1.169/1.805/0.636 ms')
2025-10-27 03:51:01,520 - INFO - Ping to Metadata IP 169.254.0.5 of VM mltf_vm passed
2025-10-27 03:51:01,596 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-27 03:51:01,596 - DEBUG - Waiting to SSH to VM mltf_vm, IP 5.13.206.133, Port 22
2025-10-27 03:51:01,768 - DEBUG - VM mltf_vm is ready for SSH connections
2025-10-27 03:51:01,845 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-27 03:51:01,845 - DEBUG - Waiting to SSH to VM mltf_vm, IP 5.13.206.133, Port 22
2025-10-27 03:51:02,016 - DEBUG - VM mltf_vm is ready for SSH connections
2025-10-27 03:51:02,018 - INFO - ================================================================================
2025-10-27 03:51:02,019 - INFO - STARTING TEST : test_verify_session_sampling_teardown
2025-10-27 03:51:02,019 - INFO - TEST DESCRIPTION :
1.query client session samples
2.query server session samples
3.query client session to get number of sessions exported
4.query session record table for teardown bytes/pkts
5.query sample count after teardown on server side
2025-10-27 03:51:03,296 - DEBUG - Skipping xmpp flap check
2025-10-27 03:51:03,296 - INFO - Initial checks done. Running the testcase now
2025-10-27 03:51:03,296 - INFO -
2025-10-27 03:51:03,421 - INFO - Setting flow export rate: 100
2025-10-27 03:51:03,469 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = any, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = any, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None]
2025-10-27 03:51:03,811 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '392e2efe-ece0-418c-b3bf-d0f44c935e7c', 'name': 'ctest-vn1-32941468', 'tenant_id': '80d709c4ad0941f59ef682cea1516480', 'project_id': '80d709c4ad0941f59ef682cea1516480', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['26bc7e34-2adb-438b-a99e-f63f6b66df16'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-23338239', 'ctest-vn1-32941468'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-23338239', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '5.13.206.128/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-10-27 03:51:04,019 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '0369affc-4296-4bce-9949-6a086193b264', 'name': 'ctest-vn2-73848823', 'tenant_id': '80d709c4ad0941f59ef682cea1516480', 'project_id': '80d709c4ad0941f59ef682cea1516480', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['9dda0a86-6831-40a0-bdac-24e0f7ae638a'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-23338239', 'ctest-vn2-73848823'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-23338239', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '56.27.190.192/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-10-27 03:51:04,112 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:51:04,119 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:51:04,157 - DEBUG - Requesting: http://10.0.0.249:8082/project/80d709c4-ad09-41f5-9ef6-82cea1516480
2025-10-27 03:51:04,265 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/392e2efe-ece0-418c-b3bf-d0f44c935e7c
2025-10-27 03:51:04,276 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/392e2efe-ece0-418c-b3bf-d0f44c935e7c
2025-10-27 03:51:04,286 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/c0d9cf07-eb51-4cef-8864-2b260eaaa501
2025-10-27 03:51:04,295 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/c0d9cf07-eb51-4cef-8864-2b260eaaa501
2025-10-27 03:51:04,305 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/f743b474-2790-42e3-a567-857dde40887f
2025-10-27 03:51:04,332 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-27 03:51:04,332 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/392e2efe-ece0-418c-b3bf-d0f44c935e7c
2025-10-27 03:51:04,355 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/c0d9cf07-eb51-4cef-8864-2b260eaaa501
2025-10-27 03:51:04,374 - INFO - Verified VN network id 15 for VN 392e2efe-ece0-418c-b3bf-d0f44c935e7c
2025-10-27 03:51:04,374 - INFO - Verifications in API Server for VN ctest-vn1-32941468 passed
2025-10-27 03:51:04,374 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/392e2efe-ece0-418c-b3bf-d0f44c935e7c
2025-10-27 03:51:04,391 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/c0d9cf07-eb51-4cef-8864-2b260eaaa501
2025-10-27 03:51:04,400 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/c0d9cf07-eb51-4cef-8864-2b260eaaa501
2025-10-27 03:51:04,411 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/f743b474-2790-42e3-a567-857dde40887f
2025-10-27 03:51:04,427 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-23338239', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4120282381521273228', 'uuid-lslong': '12952300801016159868'}, 'enable': 'true', 'created': '2025-10-27T03:49:33', 'last-modified': '2025-10-27T03:51:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.646173'}
2025-10-27 03:51:04,440 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-27 03:51:04,450 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-23338239', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4120282381521273228', 'uuid-lslong': '12952300801016159868'}, 'enable': 'true', 'created': '2025-10-27T03:49:33', 'last-modified': '2025-10-27T03:51:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.668556'}
2025-10-27 03:51:04,459 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-27 03:51:04,464 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-23338239', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4120282381521273228', 'uuid-lslong': '12952300801016159868'}, 'enable': 'true', 'created': '2025-10-27T03:49:33', 'last-modified': '2025-10-27T03:51:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.677746'}
2025-10-27 03:51:04,476 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-27 03:51:04,476 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-32941468 passed
2025-10-27 03:51:04,477 - DEBUG - ====Verifying policy data for ctest-vn1-32941468 in API_Server ======
2025-10-27 03:51:04,477 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:51:04,485 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:51:04,498 - DEBUG - Requesting: http://10.0.0.249:8082/project/80d709c4-ad09-41f5-9ef6-82cea1516480
2025-10-27 03:51:04,586 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/392e2efe-ece0-418c-b3bf-d0f44c935e7c
2025-10-27 03:51:04,599 - DEBUG - ==>Verifying data for policy with id: 750df9b8-7c80-47d4-ac84-25fb2592ab22, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-23338239', 'policy1']
2025-10-27 03:51:04,599 - INFO - VN ctest-vn1-32941468 Policy verification: verify_vn_policy_in_api_server, status: True
2025-10-27 03:51:04,599 - DEBUG - Verifying the vn in opserver
2025-10-27 03:51:04,599 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468 virtual network link through opserver 10.0.0.249
2025-10-27 03:51:04,599 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-27 03:51:04,612 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468?flat'}
2025-10-27 03:51:04,612 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468 virtual network link through opserver 10.0.0.33
2025-10-27 03:51:04,612 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-27 03:51:04,624 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468?flat'}
2025-10-27 03:51:04,624 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468 virtual network link through opserver 10.0.0.129
2025-10-27 03:51:04,624 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2025-10-27 03:51:04,637 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468?flat'}
2025-10-27 03:51:04,637 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468 is found in opserver
2025-10-27 03:51:04,649 - DEBUG - VRF ids for VN ctest-vn1-32941468: {'10.0.0.131': '2'}
2025-10-27 03:51:04,649 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:51:04,655 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:51:04,666 - DEBUG - Requesting: http://10.0.0.249:8082/project/80d709c4-ad09-41f5-9ef6-82cea1516480
2025-10-27 03:51:04,750 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/0369affc-4296-4bce-9949-6a086193b264
2025-10-27 03:51:04,767 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/0369affc-4296-4bce-9949-6a086193b264
2025-10-27 03:51:04,777 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/f35176c7-8b08-4a28-8fce-27dd6d3c7702
2025-10-27 03:51:04,797 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/f35176c7-8b08-4a28-8fce-27dd6d3c7702
2025-10-27 03:51:04,806 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/93f8a31a-8e76-4b8e-ba4d-08a5bb6da7f7
2025-10-27 03:51:04,814 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-27 03:51:04,814 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/0369affc-4296-4bce-9949-6a086193b264
2025-10-27 03:51:04,828 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/f35176c7-8b08-4a28-8fce-27dd6d3c7702
2025-10-27 03:51:04,850 - INFO - Verified VN network id 16 for VN 0369affc-4296-4bce-9949-6a086193b264
2025-10-27 03:51:04,850 - INFO - Verifications in API Server for VN ctest-vn2-73848823 passed
2025-10-27 03:51:04,850 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/0369affc-4296-4bce-9949-6a086193b264
2025-10-27 03:51:04,863 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/f35176c7-8b08-4a28-8fce-27dd6d3c7702
2025-10-27 03:51:04,871 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/f35176c7-8b08-4a28-8fce-27dd6d3c7702
2025-10-27 03:51:04,879 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/93f8a31a-8e76-4b8e-ba4d-08a5bb6da7f7
2025-10-27 03:51:04,890 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-23338239', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '245921152652168142', 'uuid-lslong': '11045476145332204132'}, 'enable': 'true', 'created': '2025-10-27T03:50:18', 'last-modified': '2025-10-27T03:51:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.917386'}
2025-10-27 03:51:04,898 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-27 03:51:04,903 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'interests': '0-1', 'advertised': '0-1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-23338239', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '245921152652168142', 'uuid-lslong': '11045476145332204132'}, 'enable': 'true', 'created': '2025-10-27T03:50:18', 'last-modified': '2025-10-27T03:51:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.928027'}
2025-10-27 03:51:04,909 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-27 03:51:04,914 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-23338239', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '245921152652168142', 'uuid-lslong': '11045476145332204132'}, 'enable': 'true', 'created': '2025-10-27T03:50:18', 'last-modified': '2025-10-27T03:51:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.944398'}
2025-10-27 03:51:04,920 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-27 03:51:04,920 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-73848823 passed
2025-10-27 03:51:04,921 - DEBUG - ====Verifying policy data for ctest-vn2-73848823 in API_Server ======
2025-10-27 03:51:04,921 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:51:04,927 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:51:04,938 - DEBUG - Requesting: http://10.0.0.249:8082/project/80d709c4-ad09-41f5-9ef6-82cea1516480
2025-10-27 03:51:05,040 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/0369affc-4296-4bce-9949-6a086193b264
2025-10-27 03:51:05,051 - DEBUG - ==>Verifying data for policy with id: 750df9b8-7c80-47d4-ac84-25fb2592ab22, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-23338239', 'policy1']
2025-10-27 03:51:05,051 - INFO - VN ctest-vn2-73848823 Policy verification: verify_vn_policy_in_api_server, status: True
2025-10-27 03:51:05,051 - DEBUG - Verifying the vn in opserver
2025-10-27 03:51:05,051 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823 virtual network link through opserver 10.0.0.249
2025-10-27 03:51:05,051 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-27 03:51:05,066 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823?flat'}
2025-10-27 03:51:05,066 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823 virtual network link through opserver 10.0.0.33
2025-10-27 03:51:05,066 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-27 03:51:05,081 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823?flat'}
2025-10-27 03:51:05,081 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823 virtual network link through opserver 10.0.0.129
2025-10-27 03:51:05,081 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2025-10-27 03:51:05,095 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823?flat'}
2025-10-27 03:51:05,095 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823 is found in opserver
2025-10-27 03:51:05,105 - DEBUG - VRF ids for VN ctest-vn2-73848823: {'10.0.0.130': '2', '10.0.0.131': '3'}
2025-10-27 03:51:05,106 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:51:05,111 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:51:05,123 - DEBUG - Requesting: http://10.0.0.249:8082/project/80d709c4-ad09-41f5-9ef6-82cea1516480
2025-10-27 03:51:05,244 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/392e2efe-ece0-418c-b3bf-d0f44c935e7c
2025-10-27 03:51:05,265 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/392e2efe-ece0-418c-b3bf-d0f44c935e7c
2025-10-27 03:51:05,276 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/c0d9cf07-eb51-4cef-8864-2b260eaaa501
2025-10-27 03:51:05,287 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/c0d9cf07-eb51-4cef-8864-2b260eaaa501
2025-10-27 03:51:05,296 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/f743b474-2790-42e3-a567-857dde40887f
2025-10-27 03:51:05,303 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-27 03:51:05,303 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/392e2efe-ece0-418c-b3bf-d0f44c935e7c
2025-10-27 03:51:05,314 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/c0d9cf07-eb51-4cef-8864-2b260eaaa501
2025-10-27 03:51:05,332 - INFO - Verified VN network id 15 for VN 392e2efe-ece0-418c-b3bf-d0f44c935e7c
2025-10-27 03:51:05,332 - INFO - Verifications in API Server for VN ctest-vn1-32941468 passed
2025-10-27 03:51:05,332 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/392e2efe-ece0-418c-b3bf-d0f44c935e7c
2025-10-27 03:51:05,346 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/c0d9cf07-eb51-4cef-8864-2b260eaaa501
2025-10-27 03:51:05,355 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/c0d9cf07-eb51-4cef-8864-2b260eaaa501
2025-10-27 03:51:05,363 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/f743b474-2790-42e3-a567-857dde40887f
2025-10-27 03:51:05,375 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-23338239', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4120282381521273228', 'uuid-lslong': '12952300801016159868'}, 'enable': 'true', 'created': '2025-10-27T03:49:33', 'last-modified': '2025-10-27T03:51:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.594644'}
2025-10-27 03:51:05,383 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-27 03:51:05,389 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-23338239', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4120282381521273228', 'uuid-lslong': '12952300801016159868'}, 'enable': 'true', 'created': '2025-10-27T03:49:33', 'last-modified': '2025-10-27T03:51:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.610867'}
2025-10-27 03:51:05,395 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-27 03:51:05,401 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-23338239', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4120282381521273228', 'uuid-lslong': '12952300801016159868'}, 'enable': 'true', 'created': '2025-10-27T03:49:33', 'last-modified': '2025-10-27T03:51:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.614329'}
2025-10-27 03:51:05,408 - DEBUG - Route Targets: ['target:64512:8000004']
2025-10-27 03:51:05,408 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-32941468 passed
2025-10-27 03:51:05,408 - DEBUG - ====Verifying policy data for ctest-vn1-32941468 in API_Server ======
2025-10-27 03:51:05,408 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:51:05,414 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:51:05,426 - DEBUG - Requesting: http://10.0.0.249:8082/project/80d709c4-ad09-41f5-9ef6-82cea1516480
2025-10-27 03:51:05,536 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/392e2efe-ece0-418c-b3bf-d0f44c935e7c
2025-10-27 03:51:05,546 - DEBUG - ==>Verifying data for policy with id: 750df9b8-7c80-47d4-ac84-25fb2592ab22, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-23338239', 'policy1']
2025-10-27 03:51:05,546 - INFO - VN ctest-vn1-32941468 Policy verification: verify_vn_policy_in_api_server, status: True
2025-10-27 03:51:05,546 - DEBUG - Verifying the vn in opserver
2025-10-27 03:51:05,546 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468 virtual network link through opserver 10.0.0.249
2025-10-27 03:51:05,547 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-27 03:51:05,561 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468?flat'}
2025-10-27 03:51:05,561 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468 virtual network link through opserver 10.0.0.33
2025-10-27 03:51:05,561 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-27 03:51:05,575 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468?flat'}
2025-10-27 03:51:05,575 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468 virtual network link through opserver 10.0.0.129
2025-10-27 03:51:05,575 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2025-10-27 03:51:05,588 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468?flat'}
2025-10-27 03:51:05,588 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468 is found in opserver
2025-10-27 03:51:05,599 - DEBUG - VRF ids for VN ctest-vn1-32941468: {'10.0.0.131': '2'}
2025-10-27 03:51:05,599 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:51:05,607 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:51:05,618 - DEBUG - Requesting: http://10.0.0.249:8082/project/80d709c4-ad09-41f5-9ef6-82cea1516480
2025-10-27 03:51:05,732 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/0369affc-4296-4bce-9949-6a086193b264
2025-10-27 03:51:05,742 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/0369affc-4296-4bce-9949-6a086193b264
2025-10-27 03:51:05,754 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/f35176c7-8b08-4a28-8fce-27dd6d3c7702
2025-10-27 03:51:05,764 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/f35176c7-8b08-4a28-8fce-27dd6d3c7702
2025-10-27 03:51:05,774 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/93f8a31a-8e76-4b8e-ba4d-08a5bb6da7f7
2025-10-27 03:51:05,783 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-27 03:51:05,783 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/0369affc-4296-4bce-9949-6a086193b264
2025-10-27 03:51:05,796 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/f35176c7-8b08-4a28-8fce-27dd6d3c7702
2025-10-27 03:51:05,814 - INFO - Verified VN network id 16 for VN 0369affc-4296-4bce-9949-6a086193b264
2025-10-27 03:51:05,814 - INFO - Verifications in API Server for VN ctest-vn2-73848823 passed
2025-10-27 03:51:05,814 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/0369affc-4296-4bce-9949-6a086193b264
2025-10-27 03:51:05,826 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/f35176c7-8b08-4a28-8fce-27dd6d3c7702
2025-10-27 03:51:05,835 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/f35176c7-8b08-4a28-8fce-27dd6d3c7702
2025-10-27 03:51:05,845 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/93f8a31a-8e76-4b8e-ba4d-08a5bb6da7f7
2025-10-27 03:51:05,862 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-23338239', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '245921152652168142', 'uuid-lslong': '11045476145332204132'}, 'enable': 'true', 'created': '2025-10-27T03:50:18', 'last-modified': '2025-10-27T03:51:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.888900'}
2025-10-27 03:51:05,870 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-27 03:51:05,876 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'interests': '0-1', 'advertised': '0-1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-23338239', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '245921152652168142', 'uuid-lslong': '11045476145332204132'}, 'enable': 'true', 'created': '2025-10-27T03:50:18', 'last-modified': '2025-10-27T03:51:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.900757'}
2025-10-27 03:51:05,883 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-27 03:51:05,890 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-23338239', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '245921152652168142', 'uuid-lslong': '11045476145332204132'}, 'enable': 'true', 'created': '2025-10-27T03:50:18', 'last-modified': '2025-10-27T03:51:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.919218'}
2025-10-27 03:51:05,898 - DEBUG - Route Targets: ['target:64512:8000005']
2025-10-27 03:51:05,898 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-73848823 passed
2025-10-27 03:51:05,899 - DEBUG - ====Verifying policy data for ctest-vn2-73848823 in API_Server ======
2025-10-27 03:51:05,899 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:51:05,906 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:51:05,918 - DEBUG - Requesting: http://10.0.0.249:8082/project/80d709c4-ad09-41f5-9ef6-82cea1516480
2025-10-27 03:51:06,017 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/0369affc-4296-4bce-9949-6a086193b264
2025-10-27 03:51:06,031 - DEBUG - ==>Verifying data for policy with id: 750df9b8-7c80-47d4-ac84-25fb2592ab22, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-23338239', 'policy1']
2025-10-27 03:51:06,031 - INFO - VN ctest-vn2-73848823 Policy verification: verify_vn_policy_in_api_server, status: True
2025-10-27 03:51:06,031 - DEBUG - Verifying the vn in opserver
2025-10-27 03:51:06,032 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823 virtual network link through opserver 10.0.0.249
2025-10-27 03:51:06,032 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-27 03:51:06,048 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823?flat'}
2025-10-27 03:51:06,048 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823 virtual network link through opserver 10.0.0.33
2025-10-27 03:51:06,048 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-27 03:51:06,062 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823?flat'}
2025-10-27 03:51:06,062 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823 virtual network link through opserver 10.0.0.129
2025-10-27 03:51:06,063 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2025-10-27 03:51:06,076 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823?flat'}
2025-10-27 03:51:06,076 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823 is found in opserver
2025-10-27 03:51:06,088 - DEBUG - VRF ids for VN ctest-vn2-73848823: {'10.0.0.130': '2', '10.0.0.131': '3'}
2025-10-27 03:51:06,088 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:51:06,095 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:51:06,107 - DEBUG - Requesting: http://10.0.0.249:8082/project/80d709c4-ad09-41f5-9ef6-82cea1516480
2025-10-27 03:51:06,202 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/bbb80a84-058c-4477-a1d0-695871624e9c
2025-10-27 03:51:06,214 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/bbb80a84-058c-4477-a1d0-695871624e9c
2025-10-27 03:51:06,223 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b9b555d4-1311-4268-9407-075dc1df14a5
2025-10-27 03:51:06,231 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b9b555d4-1311-4268-9407-075dc1df14a5
2025-10-27 03:51:06,239 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/2efe4010-4926-4d40-bf16-5876dea1a593
2025-10-27 03:51:06,247 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-27 03:51:06,248 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/bbb80a84-058c-4477-a1d0-695871624e9c
2025-10-27 03:51:06,265 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b9b555d4-1311-4268-9407-075dc1df14a5
2025-10-27 03:51:06,282 - INFO - Verified VN network id 17 for VN bbb80a84-058c-4477-a1d0-695871624e9c
2025-10-27 03:51:06,283 - INFO - Verifications in API Server for VN ctest-fip_vn-29814852 passed
2025-10-27 03:51:06,283 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/bbb80a84-058c-4477-a1d0-695871624e9c
2025-10-27 03:51:06,294 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b9b555d4-1311-4268-9407-075dc1df14a5
2025-10-27 03:51:06,301 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b9b555d4-1311-4268-9407-075dc1df14a5
2025-10-27 03:51:06,310 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/2efe4010-4926-4d40-bf16-5876dea1a593
2025-10-27 03:51:06,322 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-fip_vn-29814852', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-23338239', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13526573042952324215', 'uuid-lslong': '11659935263842520732'}, 'enable': 'true', 'created': '2025-10-27T03:50:19', 'last-modified': '2025-10-27T03:50:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:46.772989'}
2025-10-27 03:51:06,334 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-27 03:51:06,340 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-fip_vn-29814852', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-23338239', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13526573042952324215', 'uuid-lslong': '11659935263842520732'}, 'enable': 'true', 'created': '2025-10-27T03:50:19', 'last-modified': '2025-10-27T03:50:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:46.794668'}
2025-10-27 03:51:06,346 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-27 03:51:06,353 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-fip_vn-29814852', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-23338239', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13526573042952324215', 'uuid-lslong': '11659935263842520732'}, 'enable': 'true', 'created': '2025-10-27T03:50:19', 'last-modified': '2025-10-27T03:50:19', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:46.804228'}
2025-10-27 03:51:06,361 - DEBUG - Route Targets: ['target:64512:8000006']
2025-10-27 03:51:06,362 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-29814852 passed
2025-10-27 03:51:06,362 - DEBUG - ====Verifying policy data for ctest-fip_vn-29814852 in API_Server ======
2025-10-27 03:51:06,362 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:51:06,368 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:51:06,379 - DEBUG - Requesting: http://10.0.0.249:8082/project/80d709c4-ad09-41f5-9ef6-82cea1516480
2025-10-27 03:51:06,469 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/bbb80a84-058c-4477-a1d0-695871624e9c
2025-10-27 03:51:06,479 - DEBUG - =>VN ctest-fip_vn-29814852 has no policy to be verified
2025-10-27 03:51:06,479 - DEBUG - Verifying the vn in opserver
2025-10-27 03:51:06,479 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-fip_vn-29814852 virtual network link through opserver 10.0.0.249
2025-10-27 03:51:06,479 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2025-10-27 03:51:06,491 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-fip_vn-29814852', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-fip_vn-29814852?flat'}
2025-10-27 03:51:06,491 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-fip_vn-29814852 virtual network link through opserver 10.0.0.33
2025-10-27 03:51:06,491 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-10-27 03:51:06,503 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-fip_vn-29814852', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-fip_vn-29814852?flat'}
2025-10-27 03:51:06,503 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-fip_vn-29814852 virtual network link through opserver 10.0.0.129
2025-10-27 03:51:06,503 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks
2025-10-27 03:51:06,517 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-fip_vn-29814852', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-fip_vn-29814852?flat'}
2025-10-27 03:51:06,517 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-fip_vn-29814852 is found in opserver
2025-10-27 03:51:06,528 - DEBUG - VRF ids for VN ctest-fip_vn-29814852: {'10.0.0.130': '3'}
2025-10-27 03:51:06,528 - INFO - start time= 1761537066528196
2025-10-27 03:51:06,528 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 56.27.190.195, host_string: cirros@169.254.0.3, password: gocubsgogateway: ubuntu@10.0.0.131, gateway password: c0ntrail123
2025-10-27 03:51:06,528 - DEBUG - ping -s 56 -c 3 -W 1 56.27.190.195
2025-10-27 03:51:10,512 - DEBUG - PING 56.27.190.195 (56.27.190.195): 56 data bytes
64 bytes from 56.27.190.195: seq=0 ttl=63 time=5.470 ms
64 bytes from 56.27.190.195: seq=1 ttl=63 time=1.479 ms
64 bytes from 56.27.190.195: seq=2 ttl=63 time=1.659 ms
--- 56.27.190.195 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.479/2.869/5.470 ms
2025-10-27 03:51:10,512 - INFO - Ping to IP 56.27.190.195 from VM ctest-vn1_vm1-72172866 passed
2025-10-27 03:51:20,513 - INFO - Verify session samples and teardown pkts
2025-10-27 03:51:20,513 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.249
2025-10-27 03:51:20,517 - DEBUG - Posting: http://10.0.0.249:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1761537066528196, 'end_time': 1761537080516996, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-10-27 03:51:21,536 - DEBUG - [{'T': 1761537069450090}, {'T': 1761537070450198}, {'T': 1761537071450304}]
2025-10-27 03:51:21,536 - DEBUG - Posting: http://10.0.0.249:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1761537066528196, 'end_time': 1761537081536678, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-10-27 03:51:22,555 - DEBUG - [{'T': 1761537069156682}, {'T': 1761537070156709}, {'T': 1761537071156744}]
2025-10-27 03:51:22,555 - DEBUG - Posting: http://10.0.0.249:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1761537066528196, 'end_time': 1761537082555867, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-10-27 03:51:23,576 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'sample_count': 3}]
2025-10-27 03:51:23,576 - INFO - wait for the flows to get expire
2025-10-27 03:54:43,577 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4489-2:Compute:contrail-vrouter-agent:0?flat
2025-10-27 03:54:43,618 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4489-2?flat
2025-10-27 03:54:43,690 - DEBUG - Posting: http://10.0.0.249:8081/analytics/query, payload {'table': 'SessionRecordTable', 'start_time': 1761537066528196, 'end_time': 1761537283690513, 'select_fields': ['vn', 'remote_vn', 'forward_teardown_pkts', 'reverse_teardown_pkts'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-10-27 03:54:44,712 - DEBUG - [{'forward_flow_uuid': '807a994b-8eb3-4631-a346-f06dc0998682', 'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'reverse_flow_uuid': '1877cc5c-dd03-4d9c-a6c4-9f0542ff0772', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'forward_teardown_pkts': 3, 'reverse_teardown_pkts': 3}]
2025-10-27 03:54:44,712 - DEBUG - Posting: http://10.0.0.249:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1761537066528196, 'end_time': 1761537284712754, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-10-27 03:54:45,794 - DEBUG - Posting: http://10.0.0.249:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1761537066528196, 'end_time': 1761537285794234, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-10-27 03:54:46,816 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823', 'sample_count': 4}]
2025-10-27 03:54:47,238 - INFO - Deleted policy policy1
2025-10-27 03:54:47,357 - INFO - Setting flow export rate: None
2025-10-27 03:54:48,617 - DEBUG - Skipping xmpp flap check
2025-10-27 03:54:48,617 - INFO - END TEST : test_verify_session_sampling_teardown : PASSED[0:03:46]
2025-10-27 03:54:48,618 - INFO - --------------------------------------------------------------------------------
2025-10-27 03:54:48,621 - INFO - Deleting VM mltf_vm
2025-10-27 03:54:48,726 - INFO - Deleting VM ctest-fvn_vm1-07957047
2025-10-27 03:54:48,814 - INFO - Deleting VM ctest-vn2_vm2-29940815
2025-10-27 03:54:48,889 - INFO - Deleting VN ctest-fip_vn-29814852
2025-10-27 03:54:48,937 - DEBUG - VN bbb80a84-058c-4477-a1d0-695871624e9c still in use: Unable to complete operation on network bbb80a84-058c-4477-a1d0-695871624e9c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-b374961b-87de-4fa6-a023-6de97d3aaf81']
2025-10-27 03:54:48,937 - WARNING - Deleting VN ctest-fip_vn-29814852 failed..Will retry
2025-10-27 03:54:51,127 - DEBUG - Response for deleting network ()
2025-10-27 03:54:51,128 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/b9b555d4-1311-4268-9407-075dc1df14a5
2025-10-27 03:54:51,158 - DEBUG - Response Code: 404
2025-10-27 03:54:51,158 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:54:51,165 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:54:51,178 - DEBUG - Requesting: http://10.0.0.249:8082/project/80d709c4-ad09-41f5-9ef6-82cea1516480
2025-10-27 03:54:51,283 - INFO - Validated that VN ctest-fip_vn-29814852 is not found in API Server
2025-10-27 03:54:51,297 - DEBUG - VN ctest-fip_vn-29814852 is not present in Agent 10.0.0.130
2025-10-27 03:54:51,306 - DEBUG - VN ctest-fip_vn-29814852 is not present in Agent 10.0.0.131
2025-10-27 03:54:51,306 - INFO - Validated that VN ctest-fip_vn-29814852 is not in any agent
2025-10-27 03:54:51,312 - DEBUG - VRF 3 is not seen in agent 10.0.0.130
2025-10-27 03:54:51,319 - DEBUG - Vrouter 10.0.0.130 does not have vrf 3 for VN ctest-fip_vn-29814852
2025-10-27 03:54:51,319 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-fip_vn-29814852
2025-10-27 03:54:51,339 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-29814852 info
2025-10-27 03:54:51,340 - INFO - Deleting VN ctest-vn2-73848823
2025-10-27 03:54:51,495 - DEBUG - Response for deleting network ()
2025-10-27 03:54:51,495 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/f35176c7-8b08-4a28-8fce-27dd6d3c7702
2025-10-27 03:54:51,501 - DEBUG - Response Code: 404
2025-10-27 03:54:51,501 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:54:51,506 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:54:51,558 - DEBUG - Requesting: http://10.0.0.249:8082/project/80d709c4-ad09-41f5-9ef6-82cea1516480
2025-10-27 03:54:51,651 - INFO - Validated that VN ctest-vn2-73848823 is not found in API Server
2025-10-27 03:54:51,666 - DEBUG - VN ctest-vn2-73848823 is not present in Agent 10.0.0.130
2025-10-27 03:54:51,677 - DEBUG - VN ctest-vn2-73848823 is not present in Agent 10.0.0.131
2025-10-27 03:54:51,677 - INFO - Validated that VN ctest-vn2-73848823 is not in any agent
2025-10-27 03:54:51,682 - DEBUG - VRF 2 is not seen in agent 10.0.0.130
2025-10-27 03:54:51,687 - DEBUG - Vrouter 10.0.0.130 does not have vrf 2 for VN ctest-vn2-73848823
2025-10-27 03:54:51,693 - DEBUG - VRF 3 is not seen in agent 10.0.0.131
2025-10-27 03:54:51,700 - DEBUG - Vrouter 10.0.0.131 does not have vrf 3 for VN ctest-vn2-73848823
2025-10-27 03:54:51,700 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn2-73848823
2025-10-27 03:54:51,720 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-73848823 info
2025-10-27 03:54:51,720 - INFO - Deleting VM ctest-vn1_vm2-27918977
2025-10-27 03:54:51,794 - INFO - Deleting VM ctest-vn1_vm1-72172866
2025-10-27 03:54:51,880 - INFO - Deleting VN ctest-vn1-32941468
2025-10-27 03:54:51,919 - DEBUG - VN 392e2efe-ece0-418c-b3bf-d0f44c935e7c still in use: Unable to complete operation on network 392e2efe-ece0-418c-b3bf-d0f44c935e7c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-6b997cdf-c0c8-4c2f-b6d2-16dd5d44ca0b']
2025-10-27 03:54:51,920 - WARNING - Deleting VN ctest-vn1-32941468 failed..Will retry
2025-10-27 03:54:54,085 - DEBUG - Response for deleting network ()
2025-10-27 03:54:54,085 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/c0d9cf07-eb51-4cef-8864-2b260eaaa501
2025-10-27 03:54:54,093 - DEBUG - Response Code: 404
2025-10-27 03:54:54,094 - DEBUG - Requesting: http://10.0.0.249:8082/domains
2025-10-27 03:54:54,107 - DEBUG - Requesting: http://10.0.0.249:8082/domain/8213efff-6224-4943-8f79-85cc33013f73
2025-10-27 03:54:54,122 - DEBUG - Requesting: http://10.0.0.249:8082/project/80d709c4-ad09-41f5-9ef6-82cea1516480
2025-10-27 03:54:54,232 - INFO - Validated that VN ctest-vn1-32941468 is not found in API Server
2025-10-27 03:54:54,245 - DEBUG - VN ctest-vn1-32941468 is not present in Agent 10.0.0.130
2025-10-27 03:54:54,258 - DEBUG - VN ctest-vn1-32941468 is not present in Agent 10.0.0.131
2025-10-27 03:54:54,258 - INFO - Validated that VN ctest-vn1-32941468 is not in any agent
2025-10-27 03:54:54,264 - DEBUG - VRF 2 is not seen in agent 10.0.0.131
2025-10-27 03:54:54,269 - DEBUG - Vrouter 10.0.0.131 does not have vrf 2 for VN ctest-vn1-32941468
2025-10-27 03:54:54,269 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-23338239:ctest-vn1-32941468
2025-10-27 03:54:54,290 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-32941468 info
2025-10-27 03:54:55,043 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-23338239, ID : 80d709c4-ad09-41f5-9ef6-82cea1516480