is in ACTIVE state now
2025-09-04 03:43:36,894 - INFO - VM name : mltf_vm
2025-09-04 03:43:36,974 - DEBUG - VM mltf_vm ID is 9572ce83-36e6-4ae2-94ef-7d4b72db91a8
2025-09-04 03:43:36,974 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-4012-1
2025-09-04 03:43:37,149 - DEBUG - Requesting: http://10.0.0.131:8082/virtual-machine/9572ce83-36e6-4ae2-94ef-7d4b72db91a8
2025-09-04 03:43:37,166 - DEBUG - Requesting: http://10.0.0.131:8082/virtual-machine-interface/050d5125-e6b1-4890-a146-a06106550075
2025-09-04 03:43:37,177 - DEBUG - Requesting: http://10.0.0.131:8082/virtual-machine-interface/13549bc8-3dfb-4167-9b43-6c1d3187c9c7
2025-09-04 03:43:38,346 - 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.68 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=1.26 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 = 1.257/1.468/1.679/0.211 ms')
2025-09-04 03:43:38,346 - INFO - Ping to Metadata IP 169.254.0.5 of VM mltf_vm passed
2025-09-04 03:43:38,417 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-09-04 03:43:38,417 - DEBUG - Waiting to SSH to VM mltf_vm, IP 208.142.147.5, Port 22
2025-09-04 03:43:38,575 - DEBUG - VM mltf_vm is ready for SSH connections
2025-09-04 03:43:38,642 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-09-04 03:43:38,642 - DEBUG - Waiting to SSH to VM mltf_vm, IP 208.142.147.5, Port 22
2025-09-04 03:43:38,810 - DEBUG - VM mltf_vm is ready for SSH connections
2025-09-04 03:43:38,812 - INFO - ================================================================================
2025-09-04 03:43:38,812 - INFO - STARTING TEST : test_verify_session_sampling_teardown
2025-09-04 03:43:38,812 - 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-09-04 03:43:40,120 - DEBUG - Skipping xmpp flap check
2025-09-04 03:43:40,121 - INFO - Initial checks done. Running the testcase now
2025-09-04 03:43:40,121 - INFO -
2025-09-04 03:43:40,248 - INFO - Setting flow export rate: 100
2025-09-04 03:43:40,297 - 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-09-04 03:43:40,630 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '1bc519c0-7e8a-4200-90a7-c7e2ddd7d6b9', 'name': 'ctest-vn1-71694784', 'tenant_id': 'e04a1ca815574f48a8fd8c21fb9efb3d', 'project_id': 'e04a1ca815574f48a8fd8c21fb9efb3d', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['40412f25-7f2c-4721-af1f-d88831ffdef8'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-25962268', 'ctest-vn1-71694784'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-25962268', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '208.142.147.0/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-09-04 03:43:40,838 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '90985eda-41c6-42b9-aa24-7478dbbade9f', 'name': 'ctest-vn2-64627351', 'tenant_id': 'e04a1ca815574f48a8fd8c21fb9efb3d', 'project_id': 'e04a1ca815574f48a8fd8c21fb9efb3d', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['1f9bd0b7-5a89-4a5c-b129-981f7c7a79f0'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-25962268', 'ctest-vn2-64627351'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-25962268', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '120.69.189.128/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-09-04 03:43:40,923 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2025-09-04 03:43:40,933 - DEBUG - Requesting: http://10.0.0.57:8082/domain/e0173f19-70be-4782-8849-f3657660486c
2025-09-04 03:43:40,977 - DEBUG - Requesting: http://10.0.0.57:8082/project/e04a1ca8-1557-4f48-a8fd-8c21fb9efb3d
2025-09-04 03:43:41,082 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1bc519c0-7e8a-4200-90a7-c7e2ddd7d6b9
2025-09-04 03:43:41,103 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1bc519c0-7e8a-4200-90a7-c7e2ddd7d6b9
2025-09-04 03:43:41,114 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/5fc9bd13-308f-4147-b87b-d3d4a22f3eaa
2025-09-04 03:43:41,141 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/5fc9bd13-308f-4147-b87b-d3d4a22f3eaa
2025-09-04 03:43:41,162 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/47322acf-735e-41a1-942a-5cca030ce379
2025-09-04 03:43:41,176 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-04 03:43:41,176 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1bc519c0-7e8a-4200-90a7-c7e2ddd7d6b9
2025-09-04 03:43:41,195 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/5fc9bd13-308f-4147-b87b-d3d4a22f3eaa
2025-09-04 03:43:41,215 - INFO - Verified VN network id 13 for VN 1bc519c0-7e8a-4200-90a7-c7e2ddd7d6b9
2025-09-04 03:43:41,216 - INFO - Verifications in API Server for VN ctest-vn1-71694784 passed
2025-09-04 03:43:41,216 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1bc519c0-7e8a-4200-90a7-c7e2ddd7d6b9
2025-09-04 03:43:41,256 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/5fc9bd13-308f-4147-b87b-d3d4a22f3eaa
2025-09-04 03:43:41,287 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/5fc9bd13-308f-4147-b87b-d3d4a22f3eaa
2025-09-04 03:43:41,316 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/47322acf-735e-41a1-942a-5cca030ce379
2025-09-04 03:43:41,334 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-25962268', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2001033923983458816', 'uuid-lslong': '10423519639770748601'}, 'enable': 'true', 'created': '2025-09-04T03:42:17', 'last-modified': '2025-09-04T03:43:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.732621'}
2025-09-04 03:43:41,344 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-04 03:43:41,354 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-25962268', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2001033923983458816', 'uuid-lslong': '10423519639770748601'}, 'enable': 'true', 'created': '2025-09-04T03:42:17', 'last-modified': '2025-09-04T03:43:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.753067'}
2025-09-04 03:43:41,369 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-04 03:43:41,378 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-25962268', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2001033923983458816', 'uuid-lslong': '10423519639770748601'}, 'enable': 'true', 'created': '2025-09-04T03:42:17', 'last-modified': '2025-09-04T03:43:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.779981'}
2025-09-04 03:43:41,384 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-04 03:43:41,385 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-71694784 passed
2025-09-04 03:43:41,385 - DEBUG - ====Verifying policy data for ctest-vn1-71694784 in API_Server ======
2025-09-04 03:43:41,385 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2025-09-04 03:43:41,391 - DEBUG - Requesting: http://10.0.0.57:8082/domain/e0173f19-70be-4782-8849-f3657660486c
2025-09-04 03:43:41,402 - DEBUG - Requesting: http://10.0.0.57:8082/project/e04a1ca8-1557-4f48-a8fd-8c21fb9efb3d
2025-09-04 03:43:41,495 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1bc519c0-7e8a-4200-90a7-c7e2ddd7d6b9
2025-09-04 03:43:41,507 - DEBUG - ==>Verifying data for policy with id: 98e167f5-7bcc-49da-8bc9-7b2dba1428c6, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-25962268', 'policy1']
2025-09-04 03:43:41,507 - INFO - VN ctest-vn1-71694784 Policy verification: verify_vn_policy_in_api_server, status: True
2025-09-04 03:43:41,507 - DEBUG - Verifying the vn in opserver
2025-09-04 03:43:41,508 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784 virtual network link through opserver 10.0.0.57
2025-09-04 03:43:41,508 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-09-04 03:43:41,520 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784?flat'}
2025-09-04 03:43:41,520 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784 virtual network link through opserver 10.0.0.38
2025-09-04 03:43:41,520 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-09-04 03:43:41,535 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784?flat'}
2025-09-04 03:43:41,535 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784 virtual network link through opserver 10.0.0.131
2025-09-04 03:43:41,535 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2025-09-04 03:43:41,548 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784?flat'}
2025-09-04 03:43:41,548 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784 is found in opserver
2025-09-04 03:43:41,560 - DEBUG - VRF ids for VN ctest-vn1-71694784: {'10.0.0.241': '2'}
2025-09-04 03:43:41,560 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2025-09-04 03:43:41,575 - DEBUG - Requesting: http://10.0.0.57:8082/domain/e0173f19-70be-4782-8849-f3657660486c
2025-09-04 03:43:41,588 - DEBUG - Requesting: http://10.0.0.57:8082/project/e04a1ca8-1557-4f48-a8fd-8c21fb9efb3d
2025-09-04 03:43:41,682 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/90985eda-41c6-42b9-aa24-7478dbbade9f
2025-09-04 03:43:41,698 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/90985eda-41c6-42b9-aa24-7478dbbade9f
2025-09-04 03:43:41,710 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/3640f6ed-606c-4f6e-a3bf-08a57b6f7241
2025-09-04 03:43:41,721 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/3640f6ed-606c-4f6e-a3bf-08a57b6f7241
2025-09-04 03:43:41,731 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/e2a965af-08a7-4fc2-914b-034aadf9910a
2025-09-04 03:43:41,739 - DEBUG - Route Targets: ['target:64512:8000005']
2025-09-04 03:43:41,739 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/90985eda-41c6-42b9-aa24-7478dbbade9f
2025-09-04 03:43:41,749 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/3640f6ed-606c-4f6e-a3bf-08a57b6f7241
2025-09-04 03:43:41,767 - INFO - Verified VN network id 14 for VN 90985eda-41c6-42b9-aa24-7478dbbade9f
2025-09-04 03:43:41,768 - INFO - Verifications in API Server for VN ctest-vn2-64627351 passed
2025-09-04 03:43:41,768 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/90985eda-41c6-42b9-aa24-7478dbbade9f
2025-09-04 03:43:41,782 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/3640f6ed-606c-4f6e-a3bf-08a57b6f7241
2025-09-04 03:43:41,793 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/3640f6ed-606c-4f6e-a3bf-08a57b6f7241
2025-09-04 03:43:41,802 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/e2a965af-08a7-4fc2-914b-034aadf9910a
2025-09-04 03:43:41,816 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-25962268', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10419182029421036217', 'uuid-lslong': '12260052148040687263'}, 'enable': 'true', 'created': '2025-09-04T03:42:55', 'last-modified': '2025-09-04T03:43:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.030591'}
2025-09-04 03:43:41,825 - DEBUG - Route Targets: ['target:64512:8000005']
2025-09-04 03:43:41,831 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-25962268', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10419182029421036217', 'uuid-lslong': '12260052148040687263'}, 'enable': 'true', 'created': '2025-09-04T03:42:55', 'last-modified': '2025-09-04T03:43:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.047661'}
2025-09-04 03:43:41,838 - DEBUG - Route Targets: ['target:64512:8000005']
2025-09-04 03:43:41,843 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-25962268', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10419182029421036217', 'uuid-lslong': '12260052148040687263'}, 'enable': 'true', 'created': '2025-09-04T03:42:55', 'last-modified': '2025-09-04T03:43:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.059545'}
2025-09-04 03:43:41,850 - DEBUG - Route Targets: ['target:64512:8000005']
2025-09-04 03:43:41,850 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-64627351 passed
2025-09-04 03:43:41,850 - DEBUG - ====Verifying policy data for ctest-vn2-64627351 in API_Server ======
2025-09-04 03:43:41,850 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2025-09-04 03:43:41,857 - DEBUG - Requesting: http://10.0.0.57:8082/domain/e0173f19-70be-4782-8849-f3657660486c
2025-09-04 03:43:41,870 - DEBUG - Requesting: http://10.0.0.57:8082/project/e04a1ca8-1557-4f48-a8fd-8c21fb9efb3d
2025-09-04 03:43:41,973 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/90985eda-41c6-42b9-aa24-7478dbbade9f
2025-09-04 03:43:41,985 - DEBUG - ==>Verifying data for policy with id: 98e167f5-7bcc-49da-8bc9-7b2dba1428c6, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-25962268', 'policy1']
2025-09-04 03:43:41,985 - INFO - VN ctest-vn2-64627351 Policy verification: verify_vn_policy_in_api_server, status: True
2025-09-04 03:43:41,985 - DEBUG - Verifying the vn in opserver
2025-09-04 03:43:41,985 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351 virtual network link through opserver 10.0.0.57
2025-09-04 03:43:41,986 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-09-04 03:43:42,000 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351?flat'}
2025-09-04 03:43:42,000 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351 virtual network link through opserver 10.0.0.38
2025-09-04 03:43:42,000 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-09-04 03:43:42,013 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351?flat'}
2025-09-04 03:43:42,013 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351 virtual network link through opserver 10.0.0.131
2025-09-04 03:43:42,013 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2025-09-04 03:43:42,028 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351?flat'}
2025-09-04 03:43:42,028 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351 is found in opserver
2025-09-04 03:43:42,042 - DEBUG - VRF ids for VN ctest-vn2-64627351: {'10.0.0.241': '3', '10.0.0.242': '2'}
2025-09-04 03:43:42,042 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2025-09-04 03:43:42,051 - DEBUG - Requesting: http://10.0.0.57:8082/domain/e0173f19-70be-4782-8849-f3657660486c
2025-09-04 03:43:42,065 - DEBUG - Requesting: http://10.0.0.57:8082/project/e04a1ca8-1557-4f48-a8fd-8c21fb9efb3d
2025-09-04 03:43:42,163 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1bc519c0-7e8a-4200-90a7-c7e2ddd7d6b9
2025-09-04 03:43:42,173 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1bc519c0-7e8a-4200-90a7-c7e2ddd7d6b9
2025-09-04 03:43:42,185 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/5fc9bd13-308f-4147-b87b-d3d4a22f3eaa
2025-09-04 03:43:42,193 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/5fc9bd13-308f-4147-b87b-d3d4a22f3eaa
2025-09-04 03:43:42,203 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/47322acf-735e-41a1-942a-5cca030ce379
2025-09-04 03:43:42,213 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-04 03:43:42,213 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1bc519c0-7e8a-4200-90a7-c7e2ddd7d6b9
2025-09-04 03:43:42,226 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/5fc9bd13-308f-4147-b87b-d3d4a22f3eaa
2025-09-04 03:43:42,245 - INFO - Verified VN network id 13 for VN 1bc519c0-7e8a-4200-90a7-c7e2ddd7d6b9
2025-09-04 03:43:42,246 - INFO - Verifications in API Server for VN ctest-vn1-71694784 passed
2025-09-04 03:43:42,246 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1bc519c0-7e8a-4200-90a7-c7e2ddd7d6b9
2025-09-04 03:43:42,260 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/5fc9bd13-308f-4147-b87b-d3d4a22f3eaa
2025-09-04 03:43:42,270 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/5fc9bd13-308f-4147-b87b-d3d4a22f3eaa
2025-09-04 03:43:42,281 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/47322acf-735e-41a1-942a-5cca030ce379
2025-09-04 03:43:42,301 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-25962268', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2001033923983458816', 'uuid-lslong': '10423519639770748601'}, 'enable': 'true', 'created': '2025-09-04T03:42:17', 'last-modified': '2025-09-04T03:43:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.697218'}
2025-09-04 03:43:42,310 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-04 03:43:42,316 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-25962268', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2001033923983458816', 'uuid-lslong': '10423519639770748601'}, 'enable': 'true', 'created': '2025-09-04T03:42:17', 'last-modified': '2025-09-04T03:43:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.716482'}
2025-09-04 03:43:42,323 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-04 03:43:42,330 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-25962268', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2001033923983458816', 'uuid-lslong': '10423519639770748601'}, 'enable': 'true', 'created': '2025-09-04T03:42:17', 'last-modified': '2025-09-04T03:43:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.734542'}
2025-09-04 03:43:42,337 - DEBUG - Route Targets: ['target:64512:8000004']
2025-09-04 03:43:42,337 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-71694784 passed
2025-09-04 03:43:42,338 - DEBUG - ====Verifying policy data for ctest-vn1-71694784 in API_Server ======
2025-09-04 03:43:42,338 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2025-09-04 03:43:42,345 - DEBUG - Requesting: http://10.0.0.57:8082/domain/e0173f19-70be-4782-8849-f3657660486c
2025-09-04 03:43:42,358 - DEBUG - Requesting: http://10.0.0.57:8082/project/e04a1ca8-1557-4f48-a8fd-8c21fb9efb3d
2025-09-04 03:43:42,460 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/1bc519c0-7e8a-4200-90a7-c7e2ddd7d6b9
2025-09-04 03:43:42,474 - DEBUG - ==>Verifying data for policy with id: 98e167f5-7bcc-49da-8bc9-7b2dba1428c6, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-25962268', 'policy1']
2025-09-04 03:43:42,474 - INFO - VN ctest-vn1-71694784 Policy verification: verify_vn_policy_in_api_server, status: True
2025-09-04 03:43:42,474 - DEBUG - Verifying the vn in opserver
2025-09-04 03:43:42,474 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784 virtual network link through opserver 10.0.0.57
2025-09-04 03:43:42,474 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-09-04 03:43:42,488 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784?flat'}
2025-09-04 03:43:42,488 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784 virtual network link through opserver 10.0.0.38
2025-09-04 03:43:42,488 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-09-04 03:43:42,503 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784?flat'}
2025-09-04 03:43:42,503 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784 virtual network link through opserver 10.0.0.131
2025-09-04 03:43:42,503 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2025-09-04 03:43:42,516 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784?flat'}
2025-09-04 03:43:42,516 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784 is found in opserver
2025-09-04 03:43:42,529 - DEBUG - VRF ids for VN ctest-vn1-71694784: {'10.0.0.241': '2'}
2025-09-04 03:43:42,529 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2025-09-04 03:43:42,536 - DEBUG - Requesting: http://10.0.0.57:8082/domain/e0173f19-70be-4782-8849-f3657660486c
2025-09-04 03:43:42,548 - DEBUG - Requesting: http://10.0.0.57:8082/project/e04a1ca8-1557-4f48-a8fd-8c21fb9efb3d
2025-09-04 03:43:42,637 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/90985eda-41c6-42b9-aa24-7478dbbade9f
2025-09-04 03:43:42,651 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/90985eda-41c6-42b9-aa24-7478dbbade9f
2025-09-04 03:43:42,662 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/3640f6ed-606c-4f6e-a3bf-08a57b6f7241
2025-09-04 03:43:42,677 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/3640f6ed-606c-4f6e-a3bf-08a57b6f7241
2025-09-04 03:43:42,686 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/e2a965af-08a7-4fc2-914b-034aadf9910a
2025-09-04 03:43:42,693 - DEBUG - Route Targets: ['target:64512:8000005']
2025-09-04 03:43:42,693 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/90985eda-41c6-42b9-aa24-7478dbbade9f
2025-09-04 03:43:42,703 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/3640f6ed-606c-4f6e-a3bf-08a57b6f7241
2025-09-04 03:43:42,720 - INFO - Verified VN network id 14 for VN 90985eda-41c6-42b9-aa24-7478dbbade9f
2025-09-04 03:43:42,720 - INFO - Verifications in API Server for VN ctest-vn2-64627351 passed
2025-09-04 03:43:42,720 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/90985eda-41c6-42b9-aa24-7478dbbade9f
2025-09-04 03:43:42,730 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/3640f6ed-606c-4f6e-a3bf-08a57b6f7241
2025-09-04 03:43:42,739 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/3640f6ed-606c-4f6e-a3bf-08a57b6f7241
2025-09-04 03:43:42,747 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/e2a965af-08a7-4fc2-914b-034aadf9910a
2025-09-04 03:43:42,760 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-25962268', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10419182029421036217', 'uuid-lslong': '12260052148040687263'}, 'enable': 'true', 'created': '2025-09-04T03:42:55', 'last-modified': '2025-09-04T03:43:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.974856'}
2025-09-04 03:43:42,768 - DEBUG - Route Targets: ['target:64512:8000005']
2025-09-04 03:43:42,774 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-25962268', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10419182029421036217', 'uuid-lslong': '12260052148040687263'}, 'enable': 'true', 'created': '2025-09-04T03:42:55', 'last-modified': '2025-09-04T03:43:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.990381'}
2025-09-04 03:43:42,782 - DEBUG - Route Targets: ['target:64512:8000005']
2025-09-04 03:43:42,787 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-25962268', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10419182029421036217', 'uuid-lslong': '12260052148040687263'}, 'enable': 'true', 'created': '2025-09-04T03:42:55', 'last-modified': '2025-09-04T03:43:40', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.003699'}
2025-09-04 03:43:42,793 - DEBUG - Route Targets: ['target:64512:8000005']
2025-09-04 03:43:42,793 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-64627351 passed
2025-09-04 03:43:42,793 - DEBUG - ====Verifying policy data for ctest-vn2-64627351 in API_Server ======
2025-09-04 03:43:42,794 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2025-09-04 03:43:42,800 - DEBUG - Requesting: http://10.0.0.57:8082/domain/e0173f19-70be-4782-8849-f3657660486c
2025-09-04 03:43:42,813 - DEBUG - Requesting: http://10.0.0.57:8082/project/e04a1ca8-1557-4f48-a8fd-8c21fb9efb3d
2025-09-04 03:43:42,914 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/90985eda-41c6-42b9-aa24-7478dbbade9f
2025-09-04 03:43:42,927 - DEBUG - ==>Verifying data for policy with id: 98e167f5-7bcc-49da-8bc9-7b2dba1428c6, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-25962268', 'policy1']
2025-09-04 03:43:42,927 - INFO - VN ctest-vn2-64627351 Policy verification: verify_vn_policy_in_api_server, status: True
2025-09-04 03:43:42,927 - DEBUG - Verifying the vn in opserver
2025-09-04 03:43:42,927 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351 virtual network link through opserver 10.0.0.57
2025-09-04 03:43:42,927 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-09-04 03:43:42,940 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351?flat'}
2025-09-04 03:43:42,940 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351 virtual network link through opserver 10.0.0.38
2025-09-04 03:43:42,940 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-09-04 03:43:42,953 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351?flat'}
2025-09-04 03:43:42,953 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351 virtual network link through opserver 10.0.0.131
2025-09-04 03:43:42,953 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2025-09-04 03:43:42,966 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351?flat'}
2025-09-04 03:43:42,966 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351 is found in opserver
2025-09-04 03:43:42,978 - DEBUG - VRF ids for VN ctest-vn2-64627351: {'10.0.0.241': '3', '10.0.0.242': '2'}
2025-09-04 03:43:42,978 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2025-09-04 03:43:42,984 - DEBUG - Requesting: http://10.0.0.57:8082/domain/e0173f19-70be-4782-8849-f3657660486c
2025-09-04 03:43:42,994 - DEBUG - Requesting: http://10.0.0.57:8082/project/e04a1ca8-1557-4f48-a8fd-8c21fb9efb3d
2025-09-04 03:43:43,093 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/7cfe280b-268c-4a13-8898-a9431d0d0489
2025-09-04 03:43:43,106 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/7cfe280b-268c-4a13-8898-a9431d0d0489
2025-09-04 03:43:43,118 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/e1e521fd-82dd-4ab5-a695-55c7fe0be506
2025-09-04 03:43:43,127 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/e1e521fd-82dd-4ab5-a695-55c7fe0be506
2025-09-04 03:43:43,134 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/25ceafa1-cf08-4a34-a7b4-741f6315e919
2025-09-04 03:43:43,141 - DEBUG - Route Targets: ['target:64512:8000006']
2025-09-04 03:43:43,141 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/7cfe280b-268c-4a13-8898-a9431d0d0489
2025-09-04 03:43:43,153 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/e1e521fd-82dd-4ab5-a695-55c7fe0be506
2025-09-04 03:43:43,171 - INFO - Verified VN network id 15 for VN 7cfe280b-268c-4a13-8898-a9431d0d0489
2025-09-04 03:43:43,172 - INFO - Verifications in API Server for VN ctest-fip_vn-46068484 passed
2025-09-04 03:43:43,173 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/7cfe280b-268c-4a13-8898-a9431d0d0489
2025-09-04 03:43:43,187 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/e1e521fd-82dd-4ab5-a695-55c7fe0be506
2025-09-04 03:43:43,198 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/e1e521fd-82dd-4ab5-a695-55c7fe0be506
2025-09-04 03:43:43,207 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/25ceafa1-cf08-4a34-a7b4-741f6315e919
2025-09-04 03:43:43,225 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-fip_vn-46068484', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-25962268', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9006680333144050195', 'uuid-lslong': '9842803091333514377'}, 'enable': 'true', 'created': '2025-09-04T03:42:56', 'last-modified': '2025-09-04T03:42:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:46.870300'}
2025-09-04 03:43:43,238 - DEBUG - Route Targets: ['target:64512:8000006']
2025-09-04 03:43:43,244 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-fip_vn-46068484', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-25962268', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9006680333144050195', 'uuid-lslong': '9842803091333514377'}, 'enable': 'true', 'created': '2025-09-04T03:42:56', 'last-modified': '2025-09-04T03:42:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:46.890437'}
2025-09-04 03:43:43,250 - DEBUG - Route Targets: ['target:64512:8000006']
2025-09-04 03:43:43,255 - DEBUG - Control-node 10.0.0.131 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-fip_vn-46068484', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-25962268', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9006680333144050195', 'uuid-lslong': '9842803091333514377'}, 'enable': 'true', 'created': '2025-09-04T03:42:56', 'last-modified': '2025-09-04T03:42:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:46.903369'}
2025-09-04 03:43:43,262 - DEBUG - Route Targets: ['target:64512:8000006']
2025-09-04 03:43:43,262 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-46068484 passed
2025-09-04 03:43:43,262 - DEBUG - ====Verifying policy data for ctest-fip_vn-46068484 in API_Server ======
2025-09-04 03:43:43,262 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2025-09-04 03:43:43,269 - DEBUG - Requesting: http://10.0.0.57:8082/domain/e0173f19-70be-4782-8849-f3657660486c
2025-09-04 03:43:43,281 - DEBUG - Requesting: http://10.0.0.57:8082/project/e04a1ca8-1557-4f48-a8fd-8c21fb9efb3d
2025-09-04 03:43:43,379 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/7cfe280b-268c-4a13-8898-a9431d0d0489
2025-09-04 03:43:43,390 - DEBUG - =>VN ctest-fip_vn-46068484 has no policy to be verified
2025-09-04 03:43:43,390 - DEBUG - Verifying the vn in opserver
2025-09-04 03:43:43,390 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-fip_vn-46068484 virtual network link through opserver 10.0.0.57
2025-09-04 03:43:43,390 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks
2025-09-04 03:43:43,409 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-fip_vn-46068484', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-fip_vn-46068484?flat'}
2025-09-04 03:43:43,409 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-fip_vn-46068484 virtual network link through opserver 10.0.0.38
2025-09-04 03:43:43,409 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2025-09-04 03:43:43,422 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-fip_vn-46068484', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-fip_vn-46068484?flat'}
2025-09-04 03:43:43,423 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-fip_vn-46068484 virtual network link through opserver 10.0.0.131
2025-09-04 03:43:43,423 - DEBUG - Requesting: http://10.0.0.131:8081/analytics/uves/virtual-networks
2025-09-04 03:43:43,437 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-fip_vn-46068484', 'href': 'http://10.0.0.131:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-fip_vn-46068484?flat'}
2025-09-04 03:43:43,437 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-fip_vn-46068484 is found in opserver
2025-09-04 03:43:43,448 - DEBUG - VRF ids for VN ctest-fip_vn-46068484: {'10.0.0.242': '3'}
2025-09-04 03:43:43,448 - INFO - start time= 1756957423448468
2025-09-04 03:43:43,448 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 120.69.189.131, host_string: cirros@169.254.0.3, password: gocubsgogateway: ubuntu@10.0.0.241, gateway password: c0ntrail123
2025-09-04 03:43:43,448 - DEBUG - ping -s 56 -c 3 -W 1 120.69.189.131
2025-09-04 03:43:47,442 - DEBUG - PING 120.69.189.131 (120.69.189.131): 56 data bytes
64 bytes from 120.69.189.131: seq=0 ttl=63 time=4.931 ms
64 bytes from 120.69.189.131: seq=1 ttl=63 time=1.372 ms
64 bytes from 120.69.189.131: seq=2 ttl=63 time=1.480 ms
--- 120.69.189.131 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.372/2.594/4.931 ms
2025-09-04 03:43:47,442 - INFO - Ping to IP 120.69.189.131 from VM ctest-vn1_vm1-45935490 passed
2025-09-04 03:43:57,442 - INFO - Verify session samples and teardown pkts
2025-09-04 03:43:57,443 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.57
2025-09-04 03:43:57,446 - DEBUG - Posting: http://10.0.0.57:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1756957423448468, 'end_time': 1756957437446617, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-09-04 03:43:58,470 - DEBUG - [{'T': 1756957425766078}, {'T': 1756957426766141}, {'T': 1756957427766236}]
2025-09-04 03:43:58,471 - DEBUG - Posting: http://10.0.0.57:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1756957423448468, 'end_time': 1756957438471044, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-09-04 03:43:59,490 - DEBUG - [{'T': 1756957426074037}, {'T': 1756957427074100}, {'T': 1756957428074189}]
2025-09-04 03:43:59,490 - DEBUG - Posting: http://10.0.0.57:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1756957423448468, 'end_time': 1756957439490890, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-09-04 03:44:00,510 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'sample_count': 3}]
2025-09-04 03:44:00,511 - INFO - wait for the flows to get expire
2025-09-04 03:47:20,511 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4012-1:Compute:contrail-vrouter-agent:0?flat
2025-09-04 03:47:20,546 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4012-1?flat
2025-09-04 03:47:20,578 - DEBUG - Posting: http://10.0.0.57:8081/analytics/query, payload {'table': 'SessionRecordTable', 'start_time': 1756957423448468, 'end_time': 1756957640578297, 'select_fields': ['vn', 'remote_vn', 'forward_teardown_pkts', 'reverse_teardown_pkts'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-09-04 03:47:21,601 - DEBUG - [{'forward_flow_uuid': '1303be0d-0564-4823-9201-19219eedcc39', 'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'reverse_flow_uuid': '05324a2d-dc1f-4aa3-8ccf-588d3c4bba81', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'forward_teardown_pkts': 3, 'reverse_teardown_pkts': 3}]
2025-09-04 03:47:21,601 - DEBUG - Posting: http://10.0.0.57:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1756957423448468, 'end_time': 1756957641601389, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-09-04 03:47:22,667 - DEBUG - Posting: http://10.0.0.57:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1756957423448468, 'end_time': 1756957642666991, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-09-04 03:47:23,687 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351', 'sample_count': 4}]
2025-09-04 03:47:24,175 - INFO - Deleted policy policy1
2025-09-04 03:47:24,284 - INFO - Setting flow export rate: None
2025-09-04 03:47:25,585 - DEBUG - Skipping xmpp flap check
2025-09-04 03:47:25,585 - INFO - END TEST : test_verify_session_sampling_teardown : PASSED[0:03:47]
2025-09-04 03:47:25,585 - INFO - --------------------------------------------------------------------------------
2025-09-04 03:47:25,587 - INFO - Deleting VM mltf_vm
2025-09-04 03:47:25,665 - INFO - Deleting VM ctest-fvn_vm1-79661721
2025-09-04 03:47:25,749 - INFO - Deleting VM ctest-vn2_vm2-08503460
2025-09-04 03:47:25,835 - INFO - Deleting VN ctest-fip_vn-46068484
2025-09-04 03:47:25,884 - DEBUG - VN 7cfe280b-268c-4a13-8898-a9431d0d0489 still in use: Unable to complete operation on network 7cfe280b-268c-4a13-8898-a9431d0d0489. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-cf3a680b-6387-4f97-a565-0fabf31f15c1']
2025-09-04 03:47:25,884 - WARNING - Deleting VN ctest-fip_vn-46068484 failed..Will retry
2025-09-04 03:47:28,066 - DEBUG - Response for deleting network ()
2025-09-04 03:47:28,066 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/e1e521fd-82dd-4ab5-a695-55c7fe0be506
2025-09-04 03:47:28,099 - DEBUG - Response Code: 404
2025-09-04 03:47:28,099 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2025-09-04 03:47:28,105 - DEBUG - Requesting: http://10.0.0.57:8082/domain/e0173f19-70be-4782-8849-f3657660486c
2025-09-04 03:47:28,119 - DEBUG - Requesting: http://10.0.0.57:8082/project/e04a1ca8-1557-4f48-a8fd-8c21fb9efb3d
2025-09-04 03:47:28,213 - INFO - Validated that VN ctest-fip_vn-46068484 is not found in API Server
2025-09-04 03:47:28,226 - DEBUG - VN ctest-fip_vn-46068484 is not present in Agent 10.0.0.241
2025-09-04 03:47:28,235 - DEBUG - VN ctest-fip_vn-46068484 is not present in Agent 10.0.0.242
2025-09-04 03:47:28,236 - INFO - Validated that VN ctest-fip_vn-46068484 is not in any agent
2025-09-04 03:47:28,241 - DEBUG - VRF 3 is not seen in agent 10.0.0.242
2025-09-04 03:47:28,245 - DEBUG - Vrouter 10.0.0.242 does not have vrf 3 for VN ctest-fip_vn-46068484
2025-09-04 03:47:28,245 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-fip_vn-46068484
2025-09-04 03:47:28,268 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-46068484 info
2025-09-04 03:47:28,268 - INFO - Deleting VN ctest-vn2-64627351
2025-09-04 03:47:28,456 - DEBUG - Response for deleting network ()
2025-09-04 03:47:28,456 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/3640f6ed-606c-4f6e-a3bf-08a57b6f7241
2025-09-04 03:47:28,465 - DEBUG - Response Code: 404
2025-09-04 03:47:28,465 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2025-09-04 03:47:28,475 - DEBUG - Requesting: http://10.0.0.57:8082/domain/e0173f19-70be-4782-8849-f3657660486c
2025-09-04 03:47:28,489 - DEBUG - Requesting: http://10.0.0.57:8082/project/e04a1ca8-1557-4f48-a8fd-8c21fb9efb3d
2025-09-04 03:47:28,590 - INFO - Validated that VN ctest-vn2-64627351 is not found in API Server
2025-09-04 03:47:28,605 - DEBUG - VN ctest-vn2-64627351 is not present in Agent 10.0.0.241
2025-09-04 03:47:28,615 - DEBUG - VN ctest-vn2-64627351 is not present in Agent 10.0.0.242
2025-09-04 03:47:28,615 - INFO - Validated that VN ctest-vn2-64627351 is not in any agent
2025-09-04 03:47:28,622 - DEBUG - VRF 3 is not seen in agent 10.0.0.241
2025-09-04 03:47:28,629 - DEBUG - Vrouter 10.0.0.241 does not have vrf 3 for VN ctest-vn2-64627351
2025-09-04 03:47:28,640 - DEBUG - VRF 2 is not seen in agent 10.0.0.242
2025-09-04 03:47:28,645 - DEBUG - Vrouter 10.0.0.242 does not have vrf 2 for VN ctest-vn2-64627351
2025-09-04 03:47:28,645 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn2-64627351
2025-09-04 03:47:28,667 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-64627351 info
2025-09-04 03:47:28,667 - INFO - Deleting VM ctest-vn1_vm2-66810149
2025-09-04 03:47:28,751 - INFO - Deleting VM ctest-vn1_vm1-45935490
2025-09-04 03:47:28,839 - INFO - Deleting VN ctest-vn1-71694784
2025-09-04 03:47:28,883 - DEBUG - VN 1bc519c0-7e8a-4200-90a7-c7e2ddd7d6b9 still in use: Unable to complete operation on network 1bc519c0-7e8a-4200-90a7-c7e2ddd7d6b9. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-ad53e276-b332-4e6c-815d-9a505ad284fb']
2025-09-04 03:47:28,883 - WARNING - Deleting VN ctest-vn1-71694784 failed..Will retry
2025-09-04 03:47:31,064 - DEBUG - Response for deleting network ()
2025-09-04 03:47:31,064 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/5fc9bd13-308f-4147-b87b-d3d4a22f3eaa
2025-09-04 03:47:31,075 - DEBUG - Response Code: 404
2025-09-04 03:47:31,075 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2025-09-04 03:47:31,086 - DEBUG - Requesting: http://10.0.0.57:8082/domain/e0173f19-70be-4782-8849-f3657660486c
2025-09-04 03:47:31,100 - DEBUG - Requesting: http://10.0.0.57:8082/project/e04a1ca8-1557-4f48-a8fd-8c21fb9efb3d
2025-09-04 03:47:31,183 - INFO - Validated that VN ctest-vn1-71694784 is not found in API Server
2025-09-04 03:47:31,195 - DEBUG - VN ctest-vn1-71694784 is not present in Agent 10.0.0.241
2025-09-04 03:47:31,206 - DEBUG - VN ctest-vn1-71694784 is not present in Agent 10.0.0.242
2025-09-04 03:47:31,206 - INFO - Validated that VN ctest-vn1-71694784 is not in any agent
2025-09-04 03:47:31,211 - DEBUG - VRF 2 is not seen in agent 10.0.0.241
2025-09-04 03:47:31,217 - DEBUG - Vrouter 10.0.0.241 does not have vrf 2 for VN ctest-vn1-71694784
2025-09-04 03:47:31,217 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-25962268:ctest-vn1-71694784
2025-09-04 03:47:31,242 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-71694784 info
2025-09-04 03:47:31,992 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-25962268, ID : e04a1ca8-1557-4f48-a8fd-8c21fb9efb3d