is in ACTIVE state now
2025-12-04 04:06:18,029 - INFO - VM name : mltf_vm
2025-12-04 04:06:18,118 - DEBUG - VM mltf_vm ID is 45236408-f430-4d4f-b9d0-a1ba56058da2
2025-12-04 04:06:18,118 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-4840-1
2025-12-04 04:06:18,298 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/45236408-f430-4d4f-b9d0-a1ba56058da2
2025-12-04 04:06:18,308 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/43f57038-0c28-4b9e-8198-70a1fc323928
2025-12-04 04:06:18,321 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/4cc1294d-4cb5-4983-855b-63e25bb00ec0
2025-12-04 04:06:19,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=2.05 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.384 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.384/1.217/2.051/0.833 ms')
2025-12-04 04:06:19,520 - INFO - Ping to Metadata IP 169.254.0.5 of VM mltf_vm passed
2025-12-04 04:06:19,594 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-04 04:06:19,595 - DEBUG - Waiting to SSH to VM mltf_vm, IP 219.250.219.133, Port 22
2025-12-04 04:06:19,767 - DEBUG - VM mltf_vm is ready for SSH connections
2025-12-04 04:06:19,838 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-04 04:06:19,838 - DEBUG - Waiting to SSH to VM mltf_vm, IP 219.250.219.133, Port 22
2025-12-04 04:06:20,006 - DEBUG - VM mltf_vm is ready for SSH connections
2025-12-04 04:06:20,009 - INFO - ================================================================================
2025-12-04 04:06:20,009 - INFO - STARTING TEST : test_verify_session_sampling_teardown
2025-12-04 04:06:20,009 - 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-12-04 04:06:21,291 - DEBUG - Skipping xmpp flap check
2025-12-04 04:06:21,291 - INFO - Initial checks done. Running the testcase now
2025-12-04 04:06:21,291 - INFO -
2025-12-04 04:06:21,425 - INFO - Setting flow export rate: 100
2025-12-04 04:06:21,473 - 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-12-04 04:06:21,821 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '56701fc2-a074-4cdf-91af-27e5e5fc2236', 'name': 'ctest-vn1-41664404', 'tenant_id': 'ca612f3c3ee44c2588b3b42fcf1e2ba7', 'project_id': 'ca612f3c3ee44c2588b3b42fcf1e2ba7', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['44d1e3f1-89d7-406a-a996-18580554b2e5'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-88475386', 'ctest-vn1-41664404'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-88475386', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '219.250.219.128/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-12-04 04:06:22,035 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '6a67874d-a84c-485f-a221-419c5e2fe275', 'name': 'ctest-vn2-42905528', 'tenant_id': 'ca612f3c3ee44c2588b3b42fcf1e2ba7', 'project_id': 'ca612f3c3ee44c2588b3b42fcf1e2ba7', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['69f5fbb5-18cb-4186-bc66-f5a0404eed7a'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-88475386', 'ctest-vn2-42905528'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-88475386', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '101.16.245.64/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-12-04 04:06:22,137 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-04 04:06:22,143 - DEBUG - Requesting: http://10.0.0.27:8082/domain/77f3106b-db9e-49b5-893e-09cac574b890
2025-12-04 04:06:22,156 - DEBUG - Requesting: http://10.0.0.27:8082/project/ca612f3c-3ee4-4c25-88b3-b42fcf1e2ba7
2025-12-04 04:06:22,287 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/56701fc2-a074-4cdf-91af-27e5e5fc2236
2025-12-04 04:06:22,317 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/56701fc2-a074-4cdf-91af-27e5e5fc2236
2025-12-04 04:06:22,333 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1f800b68-594c-4a9c-a9d8-39f547241692
2025-12-04 04:06:22,345 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1f800b68-594c-4a9c-a9d8-39f547241692
2025-12-04 04:06:22,356 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/ccce61a6-0e6f-48c2-85be-658cbb06271e
2025-12-04 04:06:22,366 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-04 04:06:22,366 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/56701fc2-a074-4cdf-91af-27e5e5fc2236
2025-12-04 04:06:22,380 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1f800b68-594c-4a9c-a9d8-39f547241692
2025-12-04 04:06:22,426 - INFO - Verified VN network id 13 for VN 56701fc2-a074-4cdf-91af-27e5e5fc2236
2025-12-04 04:06:22,426 - INFO - Verifications in API Server for VN ctest-vn1-41664404 passed
2025-12-04 04:06:22,426 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/56701fc2-a074-4cdf-91af-27e5e5fc2236
2025-12-04 04:06:22,438 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1f800b68-594c-4a9c-a9d8-39f547241692
2025-12-04 04:06:22,460 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1f800b68-594c-4a9c-a9d8-39f547241692
2025-12-04 04:06:22,469 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/ccce61a6-0e6f-48c2-85be-658cbb06271e
2025-12-04 04:06:22,487 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88475386', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6228513205429488863', 'uuid-lslong': '10497653124783415862'}, 'enable': 'true', 'created': '2025-12-04T04:04:52', 'last-modified': '2025-12-04T04:06:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.703149'}
2025-12-04 04:06:22,506 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-04 04:06:22,522 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88475386', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6228513205429488863', 'uuid-lslong': '10497653124783415862'}, 'enable': 'true', 'created': '2025-12-04T04:04:52', 'last-modified': '2025-12-04T04:06:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.730960'}
2025-12-04 04:06:22,533 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-04 04:06:22,545 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88475386', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6228513205429488863', 'uuid-lslong': '10497653124783415862'}, 'enable': 'true', 'created': '2025-12-04T04:04:52', 'last-modified': '2025-12-04T04:06:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.756341'}
2025-12-04 04:06:22,561 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-04 04:06:22,561 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-41664404 passed
2025-12-04 04:06:22,562 - DEBUG - ====Verifying policy data for ctest-vn1-41664404 in API_Server ======
2025-12-04 04:06:22,562 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-04 04:06:22,571 - DEBUG - Requesting: http://10.0.0.27:8082/domain/77f3106b-db9e-49b5-893e-09cac574b890
2025-12-04 04:06:22,588 - DEBUG - Requesting: http://10.0.0.27:8082/project/ca612f3c-3ee4-4c25-88b3-b42fcf1e2ba7
2025-12-04 04:06:22,690 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/56701fc2-a074-4cdf-91af-27e5e5fc2236
2025-12-04 04:06:22,704 - DEBUG - ==>Verifying data for policy with id: de39ffea-4adb-4f53-9bfa-83ce6e4c61cd, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-88475386', 'policy1']
2025-12-04 04:06:22,704 - INFO - VN ctest-vn1-41664404 Policy verification: verify_vn_policy_in_api_server, status: True
2025-12-04 04:06:22,704 - DEBUG - Verifying the vn in opserver
2025-12-04 04:06:22,704 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404 virtual network link through opserver 10.0.0.27
2025-12-04 04:06:22,704 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-04 04:06:22,718 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404?flat'}
2025-12-04 04:06:22,718 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404 virtual network link through opserver 10.0.0.33
2025-12-04 04:06:22,718 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-04 04:06:22,733 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404?flat'}
2025-12-04 04:06:22,733 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404 virtual network link through opserver 10.0.0.23
2025-12-04 04:06:22,733 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-04 04:06:22,747 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404?flat'}
2025-12-04 04:06:22,747 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404 is found in opserver
2025-12-04 04:06:22,760 - DEBUG - VRF ids for VN ctest-vn1-41664404: {'10.0.0.22': '2'}
2025-12-04 04:06:22,760 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-04 04:06:22,767 - DEBUG - Requesting: http://10.0.0.27:8082/domain/77f3106b-db9e-49b5-893e-09cac574b890
2025-12-04 04:06:22,782 - DEBUG - Requesting: http://10.0.0.27:8082/project/ca612f3c-3ee4-4c25-88b3-b42fcf1e2ba7
2025-12-04 04:06:22,885 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6a67874d-a84c-485f-a221-419c5e2fe275
2025-12-04 04:06:22,902 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6a67874d-a84c-485f-a221-419c5e2fe275
2025-12-04 04:06:22,914 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4413e6fe-ac3f-44b0-bb9f-695d7cf7e472
2025-12-04 04:06:22,927 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4413e6fe-ac3f-44b0-bb9f-695d7cf7e472
2025-12-04 04:06:22,938 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/54ec7986-3630-4e09-aa03-dcd88cddd5d0
2025-12-04 04:06:22,946 - DEBUG - Route Targets: ['target:64512:8000005']
2025-12-04 04:06:22,946 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6a67874d-a84c-485f-a221-419c5e2fe275
2025-12-04 04:06:22,958 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4413e6fe-ac3f-44b0-bb9f-695d7cf7e472
2025-12-04 04:06:22,976 - INFO - Verified VN network id 14 for VN 6a67874d-a84c-485f-a221-419c5e2fe275
2025-12-04 04:06:22,977 - INFO - Verifications in API Server for VN ctest-vn2-42905528 passed
2025-12-04 04:06:22,977 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6a67874d-a84c-485f-a221-419c5e2fe275
2025-12-04 04:06:22,990 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4413e6fe-ac3f-44b0-bb9f-695d7cf7e472
2025-12-04 04:06:23,000 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4413e6fe-ac3f-44b0-bb9f-695d7cf7e472
2025-12-04 04:06:23,012 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/54ec7986-3630-4e09-aa03-dcd88cddd5d0
2025-12-04 04:06:23,032 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88475386', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7667245658227361887', 'uuid-lslong': '11682691048226677365'}, 'enable': 'true', 'created': '2025-12-04T04:05:34', 'last-modified': '2025-12-04T04:06:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.042307'}
2025-12-04 04:06:23,040 - DEBUG - Route Targets: ['target:64512:8000005']
2025-12-04 04:06:23,047 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88475386', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7667245658227361887', 'uuid-lslong': '11682691048226677365'}, 'enable': 'true', 'created': '2025-12-04T04:05:34', 'last-modified': '2025-12-04T04:06:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.040196'}
2025-12-04 04:06:23,055 - DEBUG - Route Targets: ['target:64512:8000005']
2025-12-04 04:06:23,062 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88475386', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7667245658227361887', 'uuid-lslong': '11682691048226677365'}, 'enable': 'true', 'created': '2025-12-04T04:05:34', 'last-modified': '2025-12-04T04:06:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.067445'}
2025-12-04 04:06:23,070 - DEBUG - Route Targets: ['target:64512:8000005']
2025-12-04 04:06:23,071 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-42905528 passed
2025-12-04 04:06:23,071 - DEBUG - ====Verifying policy data for ctest-vn2-42905528 in API_Server ======
2025-12-04 04:06:23,071 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-04 04:06:23,078 - DEBUG - Requesting: http://10.0.0.27:8082/domain/77f3106b-db9e-49b5-893e-09cac574b890
2025-12-04 04:06:23,090 - DEBUG - Requesting: http://10.0.0.27:8082/project/ca612f3c-3ee4-4c25-88b3-b42fcf1e2ba7
2025-12-04 04:06:23,193 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6a67874d-a84c-485f-a221-419c5e2fe275
2025-12-04 04:06:23,206 - DEBUG - ==>Verifying data for policy with id: de39ffea-4adb-4f53-9bfa-83ce6e4c61cd, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-88475386', 'policy1']
2025-12-04 04:06:23,206 - INFO - VN ctest-vn2-42905528 Policy verification: verify_vn_policy_in_api_server, status: True
2025-12-04 04:06:23,206 - DEBUG - Verifying the vn in opserver
2025-12-04 04:06:23,206 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528 virtual network link through opserver 10.0.0.27
2025-12-04 04:06:23,206 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-04 04:06:23,219 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528?flat'}
2025-12-04 04:06:23,219 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528 virtual network link through opserver 10.0.0.33
2025-12-04 04:06:23,219 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-04 04:06:23,233 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528?flat'}
2025-12-04 04:06:23,234 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528 virtual network link through opserver 10.0.0.23
2025-12-04 04:06:23,234 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-04 04:06:23,247 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528?flat'}
2025-12-04 04:06:23,247 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528 is found in opserver
2025-12-04 04:06:23,272 - DEBUG - VRF ids for VN ctest-vn2-42905528: {'10.0.0.22': '3', '10.0.0.130': '2'}
2025-12-04 04:06:23,272 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-04 04:06:23,279 - DEBUG - Requesting: http://10.0.0.27:8082/domain/77f3106b-db9e-49b5-893e-09cac574b890
2025-12-04 04:06:23,294 - DEBUG - Requesting: http://10.0.0.27:8082/project/ca612f3c-3ee4-4c25-88b3-b42fcf1e2ba7
2025-12-04 04:06:23,407 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/56701fc2-a074-4cdf-91af-27e5e5fc2236
2025-12-04 04:06:23,420 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/56701fc2-a074-4cdf-91af-27e5e5fc2236
2025-12-04 04:06:23,434 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1f800b68-594c-4a9c-a9d8-39f547241692
2025-12-04 04:06:23,447 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1f800b68-594c-4a9c-a9d8-39f547241692
2025-12-04 04:06:23,460 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/ccce61a6-0e6f-48c2-85be-658cbb06271e
2025-12-04 04:06:23,469 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-04 04:06:23,469 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/56701fc2-a074-4cdf-91af-27e5e5fc2236
2025-12-04 04:06:23,485 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1f800b68-594c-4a9c-a9d8-39f547241692
2025-12-04 04:06:23,509 - INFO - Verified VN network id 13 for VN 56701fc2-a074-4cdf-91af-27e5e5fc2236
2025-12-04 04:06:23,509 - INFO - Verifications in API Server for VN ctest-vn1-41664404 passed
2025-12-04 04:06:23,510 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/56701fc2-a074-4cdf-91af-27e5e5fc2236
2025-12-04 04:06:23,546 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1f800b68-594c-4a9c-a9d8-39f547241692
2025-12-04 04:06:23,562 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1f800b68-594c-4a9c-a9d8-39f547241692
2025-12-04 04:06:23,573 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/ccce61a6-0e6f-48c2-85be-658cbb06271e
2025-12-04 04:06:23,593 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88475386', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6228513205429488863', 'uuid-lslong': '10497653124783415862'}, 'enable': 'true', 'created': '2025-12-04T04:04:52', 'last-modified': '2025-12-04T04:06:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.806602'}
2025-12-04 04:06:23,616 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-04 04:06:23,624 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88475386', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6228513205429488863', 'uuid-lslong': '10497653124783415862'}, 'enable': 'true', 'created': '2025-12-04T04:04:52', 'last-modified': '2025-12-04T04:06:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.834134'}
2025-12-04 04:06:23,635 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-04 04:06:23,655 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88475386', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6228513205429488863', 'uuid-lslong': '10497653124783415862'}, 'enable': 'true', 'created': '2025-12-04T04:04:52', 'last-modified': '2025-12-04T04:06:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.865396'}
2025-12-04 04:06:23,665 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-04 04:06:23,665 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-41664404 passed
2025-12-04 04:06:23,665 - DEBUG - ====Verifying policy data for ctest-vn1-41664404 in API_Server ======
2025-12-04 04:06:23,665 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-04 04:06:23,675 - DEBUG - Requesting: http://10.0.0.27:8082/domain/77f3106b-db9e-49b5-893e-09cac574b890
2025-12-04 04:06:23,695 - DEBUG - Requesting: http://10.0.0.27:8082/project/ca612f3c-3ee4-4c25-88b3-b42fcf1e2ba7
2025-12-04 04:06:23,796 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/56701fc2-a074-4cdf-91af-27e5e5fc2236
2025-12-04 04:06:23,812 - DEBUG - ==>Verifying data for policy with id: de39ffea-4adb-4f53-9bfa-83ce6e4c61cd, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-88475386', 'policy1']
2025-12-04 04:06:23,812 - INFO - VN ctest-vn1-41664404 Policy verification: verify_vn_policy_in_api_server, status: True
2025-12-04 04:06:23,812 - DEBUG - Verifying the vn in opserver
2025-12-04 04:06:23,812 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404 virtual network link through opserver 10.0.0.27
2025-12-04 04:06:23,812 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-04 04:06:23,826 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404?flat'}
2025-12-04 04:06:23,826 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404 virtual network link through opserver 10.0.0.33
2025-12-04 04:06:23,826 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-04 04:06:23,840 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404?flat'}
2025-12-04 04:06:23,840 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404 virtual network link through opserver 10.0.0.23
2025-12-04 04:06:23,840 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-04 04:06:23,854 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404?flat'}
2025-12-04 04:06:23,854 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404 is found in opserver
2025-12-04 04:06:23,866 - DEBUG - VRF ids for VN ctest-vn1-41664404: {'10.0.0.22': '2'}
2025-12-04 04:06:23,866 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-04 04:06:23,873 - DEBUG - Requesting: http://10.0.0.27:8082/domain/77f3106b-db9e-49b5-893e-09cac574b890
2025-12-04 04:06:23,887 - DEBUG - Requesting: http://10.0.0.27:8082/project/ca612f3c-3ee4-4c25-88b3-b42fcf1e2ba7
2025-12-04 04:06:23,989 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6a67874d-a84c-485f-a221-419c5e2fe275
2025-12-04 04:06:24,001 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6a67874d-a84c-485f-a221-419c5e2fe275
2025-12-04 04:06:24,015 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4413e6fe-ac3f-44b0-bb9f-695d7cf7e472
2025-12-04 04:06:24,024 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4413e6fe-ac3f-44b0-bb9f-695d7cf7e472
2025-12-04 04:06:24,033 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/54ec7986-3630-4e09-aa03-dcd88cddd5d0
2025-12-04 04:06:24,046 - DEBUG - Route Targets: ['target:64512:8000005']
2025-12-04 04:06:24,046 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6a67874d-a84c-485f-a221-419c5e2fe275
2025-12-04 04:06:24,058 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4413e6fe-ac3f-44b0-bb9f-695d7cf7e472
2025-12-04 04:06:24,079 - INFO - Verified VN network id 14 for VN 6a67874d-a84c-485f-a221-419c5e2fe275
2025-12-04 04:06:24,079 - INFO - Verifications in API Server for VN ctest-vn2-42905528 passed
2025-12-04 04:06:24,079 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6a67874d-a84c-485f-a221-419c5e2fe275
2025-12-04 04:06:24,093 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4413e6fe-ac3f-44b0-bb9f-695d7cf7e472
2025-12-04 04:06:24,102 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4413e6fe-ac3f-44b0-bb9f-695d7cf7e472
2025-12-04 04:06:24,114 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/54ec7986-3630-4e09-aa03-dcd88cddd5d0
2025-12-04 04:06:24,137 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88475386', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7667245658227361887', 'uuid-lslong': '11682691048226677365'}, 'enable': 'true', 'created': '2025-12-04T04:05:34', 'last-modified': '2025-12-04T04:06:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.145026'}
2025-12-04 04:06:24,146 - DEBUG - Route Targets: ['target:64512:8000005']
2025-12-04 04:06:24,154 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88475386', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7667245658227361887', 'uuid-lslong': '11682691048226677365'}, 'enable': 'true', 'created': '2025-12-04T04:05:34', 'last-modified': '2025-12-04T04:06:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.147601'}
2025-12-04 04:06:24,161 - DEBUG - Route Targets: ['target:64512:8000005']
2025-12-04 04:06:24,168 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88475386', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7667245658227361887', 'uuid-lslong': '11682691048226677365'}, 'enable': 'true', 'created': '2025-12-04T04:05:34', 'last-modified': '2025-12-04T04:06:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.173622'}
2025-12-04 04:06:24,175 - DEBUG - Route Targets: ['target:64512:8000005']
2025-12-04 04:06:24,175 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-42905528 passed
2025-12-04 04:06:24,175 - DEBUG - ====Verifying policy data for ctest-vn2-42905528 in API_Server ======
2025-12-04 04:06:24,176 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-04 04:06:24,182 - DEBUG - Requesting: http://10.0.0.27:8082/domain/77f3106b-db9e-49b5-893e-09cac574b890
2025-12-04 04:06:24,194 - DEBUG - Requesting: http://10.0.0.27:8082/project/ca612f3c-3ee4-4c25-88b3-b42fcf1e2ba7
2025-12-04 04:06:24,290 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/6a67874d-a84c-485f-a221-419c5e2fe275
2025-12-04 04:06:24,304 - DEBUG - ==>Verifying data for policy with id: de39ffea-4adb-4f53-9bfa-83ce6e4c61cd, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-88475386', 'policy1']
2025-12-04 04:06:24,304 - INFO - VN ctest-vn2-42905528 Policy verification: verify_vn_policy_in_api_server, status: True
2025-12-04 04:06:24,304 - DEBUG - Verifying the vn in opserver
2025-12-04 04:06:24,304 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528 virtual network link through opserver 10.0.0.27
2025-12-04 04:06:24,305 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-04 04:06:24,320 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528?flat'}
2025-12-04 04:06:24,320 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528 virtual network link through opserver 10.0.0.33
2025-12-04 04:06:24,320 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-04 04:06:24,335 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528?flat'}
2025-12-04 04:06:24,335 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528 virtual network link through opserver 10.0.0.23
2025-12-04 04:06:24,335 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-04 04:06:24,351 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528?flat'}
2025-12-04 04:06:24,351 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528 is found in opserver
2025-12-04 04:06:24,365 - DEBUG - VRF ids for VN ctest-vn2-42905528: {'10.0.0.22': '3', '10.0.0.130': '2'}
2025-12-04 04:06:24,365 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-04 04:06:24,373 - DEBUG - Requesting: http://10.0.0.27:8082/domain/77f3106b-db9e-49b5-893e-09cac574b890
2025-12-04 04:06:24,386 - DEBUG - Requesting: http://10.0.0.27:8082/project/ca612f3c-3ee4-4c25-88b3-b42fcf1e2ba7
2025-12-04 04:06:24,492 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7d2ea16c-3229-4003-b8bc-87663507138b
2025-12-04 04:06:24,512 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7d2ea16c-3229-4003-b8bc-87663507138b
2025-12-04 04:06:24,527 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4d894b9a-140f-4562-b6d1-09b4a5e6d14a
2025-12-04 04:06:24,536 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4d894b9a-140f-4562-b6d1-09b4a5e6d14a
2025-12-04 04:06:24,546 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/073c44b1-8bf3-4868-be4c-6ea022265cdb
2025-12-04 04:06:24,558 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-04 04:06:24,558 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7d2ea16c-3229-4003-b8bc-87663507138b
2025-12-04 04:06:24,570 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4d894b9a-140f-4562-b6d1-09b4a5e6d14a
2025-12-04 04:06:24,593 - INFO - Verified VN network id 15 for VN 7d2ea16c-3229-4003-b8bc-87663507138b
2025-12-04 04:06:24,594 - INFO - Verifications in API Server for VN ctest-fip_vn-91178289 passed
2025-12-04 04:06:24,594 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7d2ea16c-3229-4003-b8bc-87663507138b
2025-12-04 04:06:24,606 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4d894b9a-140f-4562-b6d1-09b4a5e6d14a
2025-12-04 04:06:24,615 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4d894b9a-140f-4562-b6d1-09b4a5e6d14a
2025-12-04 04:06:24,624 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/073c44b1-8bf3-4868-be4c-6ea022265cdb
2025-12-04 04:06:24,640 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-fip_vn-91178289', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88475386', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9020324589739786243', 'uuid-lslong': '13311663471646413707'}, 'enable': 'true', 'created': '2025-12-04T04:05:35', 'last-modified': '2025-12-04T04:05:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:48.661977'}
2025-12-04 04:06:24,647 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-04 04:06:24,653 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-fip_vn-91178289', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88475386', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9020324589739786243', 'uuid-lslong': '13311663471646413707'}, 'enable': 'true', 'created': '2025-12-04T04:05:35', 'last-modified': '2025-12-04T04:05:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:48.677597'}
2025-12-04 04:06:24,660 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-04 04:06:24,666 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-fip_vn-91178289', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-88475386', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9020324589739786243', 'uuid-lslong': '13311663471646413707'}, 'enable': 'true', 'created': '2025-12-04T04:05:35', 'last-modified': '2025-12-04T04:05:35', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:48.687637'}
2025-12-04 04:06:24,673 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-04 04:06:24,673 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-91178289 passed
2025-12-04 04:06:24,674 - DEBUG - ====Verifying policy data for ctest-fip_vn-91178289 in API_Server ======
2025-12-04 04:06:24,674 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-04 04:06:24,681 - DEBUG - Requesting: http://10.0.0.27:8082/domain/77f3106b-db9e-49b5-893e-09cac574b890
2025-12-04 04:06:24,692 - DEBUG - Requesting: http://10.0.0.27:8082/project/ca612f3c-3ee4-4c25-88b3-b42fcf1e2ba7
2025-12-04 04:06:24,797 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/7d2ea16c-3229-4003-b8bc-87663507138b
2025-12-04 04:06:24,812 - DEBUG - =>VN ctest-fip_vn-91178289 has no policy to be verified
2025-12-04 04:06:24,812 - DEBUG - Verifying the vn in opserver
2025-12-04 04:06:24,813 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-fip_vn-91178289 virtual network link through opserver 10.0.0.27
2025-12-04 04:06:24,813 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks
2025-12-04 04:06:24,827 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-fip_vn-91178289', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-fip_vn-91178289?flat'}
2025-12-04 04:06:24,827 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-fip_vn-91178289 virtual network link through opserver 10.0.0.33
2025-12-04 04:06:24,827 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2025-12-04 04:06:24,841 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-fip_vn-91178289', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-fip_vn-91178289?flat'}
2025-12-04 04:06:24,841 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-fip_vn-91178289 virtual network link through opserver 10.0.0.23
2025-12-04 04:06:24,841 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-04 04:06:24,855 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-fip_vn-91178289', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-fip_vn-91178289?flat'}
2025-12-04 04:06:24,855 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-fip_vn-91178289 is found in opserver
2025-12-04 04:06:24,868 - DEBUG - VRF ids for VN ctest-fip_vn-91178289: {'10.0.0.130': '3'}
2025-12-04 04:06:24,868 - INFO - start time= 1764821184868501
2025-12-04 04:06:24,868 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 101.16.245.67, host_string: cirros@169.254.0.3, password: gocubsgogateway: ubuntu@10.0.0.22, gateway password: c0ntrail123
2025-12-04 04:06:24,868 - DEBUG - ping -s 56 -c 3 -W 1 101.16.245.67
2025-12-04 04:06:28,846 - DEBUG - PING 101.16.245.67 (101.16.245.67): 56 data bytes
64 bytes from 101.16.245.67: seq=0 ttl=63 time=3.704 ms
64 bytes from 101.16.245.67: seq=1 ttl=63 time=1.567 ms
64 bytes from 101.16.245.67: seq=2 ttl=63 time=1.347 ms
--- 101.16.245.67 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.347/2.206/3.704 ms
2025-12-04 04:06:28,846 - INFO - Ping to IP 101.16.245.67 from VM ctest-vn1_vm1-49575530 passed
2025-12-04 04:06:38,847 - INFO - Verify session samples and teardown pkts
2025-12-04 04:06:38,847 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.27
2025-12-04 04:06:38,851 - DEBUG - Posting: http://10.0.0.27:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1764821184868501, 'end_time': 1764821198851351, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-12-04 04:06:39,876 - DEBUG - [{'T': 1764821187054873}, {'T': 1764821188054966}, {'T': 1764821189055026}]
2025-12-04 04:06:39,876 - DEBUG - Posting: http://10.0.0.27:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1764821184868501, 'end_time': 1764821199876445, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-12-04 04:06:40,898 - DEBUG - [{'T': 1764821187771088}, {'T': 1764821188771105}, {'T': 1764821189771238}]
2025-12-04 04:06:40,898 - DEBUG - Posting: http://10.0.0.27:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1764821184868501, 'end_time': 1764821200898551, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-12-04 04:06:41,922 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'sample_count': 3}]
2025-12-04 04:06:41,922 - INFO - wait for the flows to get expire
2025-12-04 04:10:01,923 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4840-1:Compute:contrail-vrouter-agent:0?flat
2025-12-04 04:10:02,038 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4840-1?flat
2025-12-04 04:10:02,080 - DEBUG - Posting: http://10.0.0.27:8081/analytics/query, payload {'table': 'SessionRecordTable', 'start_time': 1764821184868501, 'end_time': 1764821402080693, 'select_fields': ['vn', 'remote_vn', 'forward_teardown_pkts', 'reverse_teardown_pkts'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-12-04 04:10:03,107 - DEBUG - [{'forward_flow_uuid': '5607617c-5791-4b8b-b44a-cef9d760a8ae', 'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'reverse_flow_uuid': '8642ca89-b29c-45f8-a9aa-78836e9573e6', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'forward_teardown_pkts': 3, 'reverse_teardown_pkts': 3}]
2025-12-04 04:10:03,107 - DEBUG - Posting: http://10.0.0.27:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1764821184868501, 'end_time': 1764821403107177, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-12-04 04:10:04,130 - DEBUG - Posting: http://10.0.0.27:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1764821184868501, 'end_time': 1764821404130072, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-12-04 04:10:05,151 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528', 'sample_count': 4}]
2025-12-04 04:10:05,765 - INFO - Deleted policy policy1
2025-12-04 04:10:05,881 - INFO - Setting flow export rate: None
2025-12-04 04:10:07,187 - DEBUG - Skipping xmpp flap check
2025-12-04 04:10:07,187 - INFO - END TEST : test_verify_session_sampling_teardown : PASSED[0:03:47]
2025-12-04 04:10:07,187 - INFO - --------------------------------------------------------------------------------
2025-12-04 04:10:07,189 - INFO - Deleting VM mltf_vm
2025-12-04 04:10:07,273 - INFO - Deleting VM ctest-fvn_vm1-37302344
2025-12-04 04:10:07,363 - INFO - Deleting VM ctest-vn2_vm2-28009062
2025-12-04 04:10:07,452 - INFO - Deleting VN ctest-fip_vn-91178289
2025-12-04 04:10:07,497 - DEBUG - VN 7d2ea16c-3229-4003-b8bc-87663507138b still in use: Unable to complete operation on network 7d2ea16c-3229-4003-b8bc-87663507138b. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-49ce5f89-3ca8-4d87-b8ac-8d849e4ec35f']
2025-12-04 04:10:07,497 - WARNING - Deleting VN ctest-fip_vn-91178289 failed..Will retry
2025-12-04 04:10:09,703 - DEBUG - Response for deleting network ()
2025-12-04 04:10:09,703 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4d894b9a-140f-4562-b6d1-09b4a5e6d14a
2025-12-04 04:10:09,764 - DEBUG - Response Code: 404
2025-12-04 04:10:09,764 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-04 04:10:09,770 - DEBUG - Requesting: http://10.0.0.27:8082/domain/77f3106b-db9e-49b5-893e-09cac574b890
2025-12-04 04:10:09,811 - DEBUG - Requesting: http://10.0.0.27:8082/project/ca612f3c-3ee4-4c25-88b3-b42fcf1e2ba7
2025-12-04 04:10:09,929 - INFO - Validated that VN ctest-fip_vn-91178289 is not found in API Server
2025-12-04 04:10:09,941 - DEBUG - VN ctest-fip_vn-91178289 is not present in Agent 10.0.0.22
2025-12-04 04:10:09,952 - DEBUG - VN ctest-fip_vn-91178289 is not present in Agent 10.0.0.130
2025-12-04 04:10:09,952 - INFO - Validated that VN ctest-fip_vn-91178289 is not in any agent
2025-12-04 04:10:09,958 - DEBUG - VRF 3 is not seen in agent 10.0.0.130
2025-12-04 04:10:09,963 - DEBUG - Vrouter 10.0.0.130 does not have vrf 3 for VN ctest-fip_vn-91178289
2025-12-04 04:10:09,963 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-fip_vn-91178289
2025-12-04 04:10:09,997 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-91178289 info
2025-12-04 04:10:09,997 - INFO - Deleting VN ctest-vn2-42905528
2025-12-04 04:10:10,242 - DEBUG - Response for deleting network ()
2025-12-04 04:10:10,242 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/4413e6fe-ac3f-44b0-bb9f-695d7cf7e472
2025-12-04 04:10:10,255 - DEBUG - Response Code: 404
2025-12-04 04:10:10,255 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-04 04:10:10,263 - DEBUG - Requesting: http://10.0.0.27:8082/domain/77f3106b-db9e-49b5-893e-09cac574b890
2025-12-04 04:10:10,280 - DEBUG - Requesting: http://10.0.0.27:8082/project/ca612f3c-3ee4-4c25-88b3-b42fcf1e2ba7
2025-12-04 04:10:10,389 - INFO - Validated that VN ctest-vn2-42905528 is not found in API Server
2025-12-04 04:10:10,408 - DEBUG - VN ctest-vn2-42905528 is not present in Agent 10.0.0.22
2025-12-04 04:10:10,421 - DEBUG - VN ctest-vn2-42905528 is not present in Agent 10.0.0.130
2025-12-04 04:10:10,421 - INFO - Validated that VN ctest-vn2-42905528 is not in any agent
2025-12-04 04:10:10,431 - DEBUG - VRF 3 is not seen in agent 10.0.0.22
2025-12-04 04:10:10,438 - DEBUG - Vrouter 10.0.0.22 does not have vrf 3 for VN ctest-vn2-42905528
2025-12-04 04:10:10,445 - DEBUG - VRF 2 is not seen in agent 10.0.0.130
2025-12-04 04:10:10,456 - DEBUG - Vrouter 10.0.0.130 does not have vrf 2 for VN ctest-vn2-42905528
2025-12-04 04:10:10,456 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn2-42905528
2025-12-04 04:10:10,483 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-42905528 info
2025-12-04 04:10:10,485 - INFO - Deleting VM ctest-vn1_vm2-68986933
2025-12-04 04:10:10,577 - INFO - Deleting VM ctest-vn1_vm1-49575530
2025-12-04 04:10:10,691 - INFO - Deleting VN ctest-vn1-41664404
2025-12-04 04:10:10,748 - DEBUG - VN 56701fc2-a074-4cdf-91af-27e5e5fc2236 still in use: Unable to complete operation on network 56701fc2-a074-4cdf-91af-27e5e5fc2236. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-cb0a79f3-87d5-43e7-826f-67fdb0bb4b71']
2025-12-04 04:10:10,748 - WARNING - Deleting VN ctest-vn1-41664404 failed..Will retry
2025-12-04 04:10:12,922 - DEBUG - Response for deleting network ()
2025-12-04 04:10:12,922 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/1f800b68-594c-4a9c-a9d8-39f547241692
2025-12-04 04:10:12,930 - DEBUG - Response Code: 404
2025-12-04 04:10:12,930 - DEBUG - Requesting: http://10.0.0.27:8082/domains
2025-12-04 04:10:12,947 - DEBUG - Requesting: http://10.0.0.27:8082/domain/77f3106b-db9e-49b5-893e-09cac574b890
2025-12-04 04:10:12,971 - DEBUG - Requesting: http://10.0.0.27:8082/project/ca612f3c-3ee4-4c25-88b3-b42fcf1e2ba7
2025-12-04 04:10:13,086 - INFO - Validated that VN ctest-vn1-41664404 is not found in API Server
2025-12-04 04:10:13,111 - DEBUG - VN ctest-vn1-41664404 is not present in Agent 10.0.0.22
2025-12-04 04:10:13,131 - DEBUG - VN ctest-vn1-41664404 is not present in Agent 10.0.0.130
2025-12-04 04:10:13,131 - INFO - Validated that VN ctest-vn1-41664404 is not in any agent
2025-12-04 04:10:13,138 - DEBUG - VRF 2 is not seen in agent 10.0.0.22
2025-12-04 04:10:13,144 - DEBUG - Vrouter 10.0.0.22 does not have vrf 2 for VN ctest-vn1-41664404
2025-12-04 04:10:13,144 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-88475386:ctest-vn1-41664404
2025-12-04 04:10:13,171 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-41664404 info
2025-12-04 04:10:14,055 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-88475386, ID : ca612f3c-3ee4-4c25-88b3-b42fcf1e2ba7