is in ACTIVE state now
2025-11-13 03:45:59,368 - INFO - VM name : mltf_vm
2025-11-13 03:45:59,453 - DEBUG - VM mltf_vm ID is 0cc7f4f1-cca4-4a3d-af87-3e24072c2382
2025-11-13 03:45:59,453 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-4712-2
2025-11-13 03:45:59,617 - DEBUG - Requesting: http://10.0.0.61:8082/virtual-machine/0cc7f4f1-cca4-4a3d-af87-3e24072c2382
2025-11-13 03:45:59,629 - DEBUG - Requesting: http://10.0.0.61:8082/virtual-machine-interface/c9dc8aac-b206-4dad-b8ca-dc86bb238213
2025-11-13 03:45:59,640 - DEBUG - Requesting: http://10.0.0.61:8082/virtual-machine-interface/da562b46-4a2d-4839-8485-9af72aad7f2c
2025-11-13 03:46:00,847 - 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.61 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.472 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.472/1.039/1.607/0.567 ms')
2025-11-13 03:46:00,847 - INFO - Ping to Metadata IP 169.254.0.5 of VM mltf_vm passed
2025-11-13 03:46:00,916 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-13 03:46:00,917 - DEBUG - Waiting to SSH to VM mltf_vm, IP 31.134.235.5, Port 22
2025-11-13 03:46:01,090 - DEBUG - VM mltf_vm is ready for SSH connections
2025-11-13 03:46:01,162 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-13 03:46:01,162 - DEBUG - Waiting to SSH to VM mltf_vm, IP 31.134.235.5, Port 22
2025-11-13 03:46:01,323 - DEBUG - VM mltf_vm is ready for SSH connections
2025-11-13 03:46:01,326 - INFO - ================================================================================
2025-11-13 03:46:01,326 - INFO - STARTING TEST : test_verify_session_sampling_teardown
2025-11-13 03:46:01,326 - 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-11-13 03:46:02,579 - DEBUG - Skipping xmpp flap check
2025-11-13 03:46:02,579 - INFO - Initial checks done. Running the testcase now
2025-11-13 03:46:02,579 - INFO -
2025-11-13 03:46:02,695 - INFO - Setting flow export rate: 100
2025-11-13 03:46:02,744 - 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-11-13 03:46:03,097 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '1a6f92d8-584d-4c9d-935c-2c7a84c23f69', 'name': 'ctest-vn1-40349642', 'tenant_id': '310a6cd599fb495aab2eec01122bbdf8', 'project_id': '310a6cd599fb495aab2eec01122bbdf8', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['a64a3983-8115-4086-a3d5-cafd68a06c97'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-41592504', 'ctest-vn1-40349642'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-41592504', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '31.134.235.0/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-11-13 03:46:03,303 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'ac2426e2-65c6-4ca1-942b-4f0bb2e60198', 'name': 'ctest-vn2-60452895', 'tenant_id': '310a6cd599fb495aab2eec01122bbdf8', 'project_id': '310a6cd599fb495aab2eec01122bbdf8', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['7b827b00-832d-4b3b-a4ab-7ad406593bd1'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-41592504', 'ctest-vn2-60452895'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-41592504', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '19.229.168.128/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-11-13 03:46:03,394 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2025-11-13 03:46:03,401 - DEBUG - Requesting: http://10.0.0.141:8082/domain/7e609647-c42c-403c-b0dd-6b1bfaefbd00
2025-11-13 03:46:03,436 - DEBUG - Requesting: http://10.0.0.141:8082/project/310a6cd5-99fb-495a-ab2e-ec01122bbdf8
2025-11-13 03:46:03,542 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/1a6f92d8-584d-4c9d-935c-2c7a84c23f69
2025-11-13 03:46:03,558 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/1a6f92d8-584d-4c9d-935c-2c7a84c23f69
2025-11-13 03:46:03,571 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/6205a927-c743-4511-913f-a5fbbba2f326
2025-11-13 03:46:03,581 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/6205a927-c743-4511-913f-a5fbbba2f326
2025-11-13 03:46:03,589 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/16603073-614a-4701-84e4-5a03af06a40c
2025-11-13 03:46:03,614 - DEBUG - Route Targets: ['target:64512:8000004']
2025-11-13 03:46:03,614 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/1a6f92d8-584d-4c9d-935c-2c7a84c23f69
2025-11-13 03:46:03,637 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/6205a927-c743-4511-913f-a5fbbba2f326
2025-11-13 03:46:03,658 - INFO - Verified VN network id 11 for VN 1a6f92d8-584d-4c9d-935c-2c7a84c23f69
2025-11-13 03:46:03,658 - INFO - Verifications in API Server for VN ctest-vn1-40349642 passed
2025-11-13 03:46:03,658 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/1a6f92d8-584d-4c9d-935c-2c7a84c23f69
2025-11-13 03:46:03,668 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/6205a927-c743-4511-913f-a5fbbba2f326
2025-11-13 03:46:03,698 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/6205a927-c743-4511-913f-a5fbbba2f326
2025-11-13 03:46:03,711 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/16603073-614a-4701-84e4-5a03af06a40c
2025-11-13 03:46:03,726 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-41592504', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1904902625293061277', 'uuid-lslong': '10618410926157741929'}, 'enable': 'true', 'created': '2025-11-13T03:44:36', 'last-modified': '2025-11-13T03:46:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.663106'}
2025-11-13 03:46:03,733 - DEBUG - Route Targets: ['target:64512:8000004']
2025-11-13 03:46:03,747 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-41592504', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1904902625293061277', 'uuid-lslong': '10618410926157741929'}, 'enable': 'true', 'created': '2025-11-13T03:44:36', 'last-modified': '2025-11-13T03:46:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.681069'}
2025-11-13 03:46:03,757 - DEBUG - Route Targets: ['target:64512:8000004']
2025-11-13 03:46:03,765 - DEBUG - Control-node 10.0.0.61 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-41592504', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1904902625293061277', 'uuid-lslong': '10618410926157741929'}, 'enable': 'true', 'created': '2025-11-13T03:44:36', 'last-modified': '2025-11-13T03:46:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.702823'}
2025-11-13 03:46:03,771 - DEBUG - Route Targets: ['target:64512:8000004']
2025-11-13 03:46:03,771 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-40349642 passed
2025-11-13 03:46:03,771 - DEBUG - ====Verifying policy data for ctest-vn1-40349642 in API_Server ======
2025-11-13 03:46:03,771 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2025-11-13 03:46:03,784 - DEBUG - Requesting: http://10.0.0.141:8082/domain/7e609647-c42c-403c-b0dd-6b1bfaefbd00
2025-11-13 03:46:03,807 - DEBUG - Requesting: http://10.0.0.141:8082/project/310a6cd5-99fb-495a-ab2e-ec01122bbdf8
2025-11-13 03:46:03,902 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/1a6f92d8-584d-4c9d-935c-2c7a84c23f69
2025-11-13 03:46:03,912 - DEBUG - ==>Verifying data for policy with id: b7865b5d-923d-4edc-a0c2-ff09e5fcaa4c, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-41592504', 'policy1']
2025-11-13 03:46:03,914 - INFO - VN ctest-vn1-40349642 Policy verification: verify_vn_policy_in_api_server, status: True
2025-11-13 03:46:03,915 - DEBUG - Verifying the vn in opserver
2025-11-13 03:46:03,915 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642 virtual network link through opserver 10.0.0.141
2025-11-13 03:46:03,915 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2025-11-13 03:46:03,930 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642?flat'}
2025-11-13 03:46:03,930 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642 virtual network link through opserver 10.0.0.56
2025-11-13 03:46:03,930 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-11-13 03:46:03,943 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642?flat'}
2025-11-13 03:46:03,943 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642 virtual network link through opserver 10.0.0.61
2025-11-13 03:46:03,943 - DEBUG - Requesting: http://10.0.0.61:8081/analytics/uves/virtual-networks
2025-11-13 03:46:03,955 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'href': 'http://10.0.0.61:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642?flat'}
2025-11-13 03:46:03,955 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642 is found in opserver
2025-11-13 03:46:03,965 - DEBUG - VRF ids for VN ctest-vn1-40349642: {'10.0.0.23': '2'}
2025-11-13 03:46:03,965 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2025-11-13 03:46:03,971 - DEBUG - Requesting: http://10.0.0.141:8082/domain/7e609647-c42c-403c-b0dd-6b1bfaefbd00
2025-11-13 03:46:03,985 - DEBUG - Requesting: http://10.0.0.141:8082/project/310a6cd5-99fb-495a-ab2e-ec01122bbdf8
2025-11-13 03:46:04,091 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/ac2426e2-65c6-4ca1-942b-4f0bb2e60198
2025-11-13 03:46:04,114 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/ac2426e2-65c6-4ca1-942b-4f0bb2e60198
2025-11-13 03:46:04,127 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7b204f02-cbb6-4c03-97d9-69244956c4d0
2025-11-13 03:46:04,139 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7b204f02-cbb6-4c03-97d9-69244956c4d0
2025-11-13 03:46:04,149 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/309208a5-b64b-4e14-92b1-040b5dca60d9
2025-11-13 03:46:04,157 - DEBUG - Route Targets: ['target:64512:8000005']
2025-11-13 03:46:04,157 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/ac2426e2-65c6-4ca1-942b-4f0bb2e60198
2025-11-13 03:46:04,169 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7b204f02-cbb6-4c03-97d9-69244956c4d0
2025-11-13 03:46:04,191 - INFO - Verified VN network id 12 for VN ac2426e2-65c6-4ca1-942b-4f0bb2e60198
2025-11-13 03:46:04,191 - INFO - Verifications in API Server for VN ctest-vn2-60452895 passed
2025-11-13 03:46:04,192 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/ac2426e2-65c6-4ca1-942b-4f0bb2e60198
2025-11-13 03:46:04,203 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7b204f02-cbb6-4c03-97d9-69244956c4d0
2025-11-13 03:46:04,214 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7b204f02-cbb6-4c03-97d9-69244956c4d0
2025-11-13 03:46:04,226 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/309208a5-b64b-4e14-92b1-040b5dca60d9
2025-11-13 03:46:04,241 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-41592504', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12404082027497147553', 'uuid-lslong': '10676714253276545432'}, 'enable': 'true', 'created': '2025-11-13T03:45:11', 'last-modified': '2025-11-13T03:46:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.973279'}
2025-11-13 03:46:04,253 - DEBUG - Route Targets: ['target:64512:8000005']
2025-11-13 03:46:04,261 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-41592504', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12404082027497147553', 'uuid-lslong': '10676714253276545432'}, 'enable': 'true', 'created': '2025-11-13T03:45:11', 'last-modified': '2025-11-13T03:46:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.993160'}
2025-11-13 03:46:04,270 - DEBUG - Route Targets: ['target:64512:8000005']
2025-11-13 03:46:04,276 - DEBUG - Control-node 10.0.0.61 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-41592504', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12404082027497147553', 'uuid-lslong': '10676714253276545432'}, 'enable': 'true', 'created': '2025-11-13T03:45:11', 'last-modified': '2025-11-13T03:46:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.011423'}
2025-11-13 03:46:04,283 - DEBUG - Route Targets: ['target:64512:8000005']
2025-11-13 03:46:04,283 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-60452895 passed
2025-11-13 03:46:04,283 - DEBUG - ====Verifying policy data for ctest-vn2-60452895 in API_Server ======
2025-11-13 03:46:04,283 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2025-11-13 03:46:04,290 - DEBUG - Requesting: http://10.0.0.141:8082/domain/7e609647-c42c-403c-b0dd-6b1bfaefbd00
2025-11-13 03:46:04,301 - DEBUG - Requesting: http://10.0.0.141:8082/project/310a6cd5-99fb-495a-ab2e-ec01122bbdf8
2025-11-13 03:46:04,404 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/ac2426e2-65c6-4ca1-942b-4f0bb2e60198
2025-11-13 03:46:04,418 - DEBUG - ==>Verifying data for policy with id: b7865b5d-923d-4edc-a0c2-ff09e5fcaa4c, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-41592504', 'policy1']
2025-11-13 03:46:04,418 - INFO - VN ctest-vn2-60452895 Policy verification: verify_vn_policy_in_api_server, status: True
2025-11-13 03:46:04,418 - DEBUG - Verifying the vn in opserver
2025-11-13 03:46:04,419 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895 virtual network link through opserver 10.0.0.141
2025-11-13 03:46:04,419 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2025-11-13 03:46:04,430 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895?flat'}
2025-11-13 03:46:04,430 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895 virtual network link through opserver 10.0.0.56
2025-11-13 03:46:04,430 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-11-13 03:46:04,441 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895?flat'}
2025-11-13 03:46:04,441 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895 virtual network link through opserver 10.0.0.61
2025-11-13 03:46:04,441 - DEBUG - Requesting: http://10.0.0.61:8081/analytics/uves/virtual-networks
2025-11-13 03:46:04,454 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'href': 'http://10.0.0.61:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895?flat'}
2025-11-13 03:46:04,454 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895 is found in opserver
2025-11-13 03:46:04,467 - DEBUG - VRF ids for VN ctest-vn2-60452895: {'10.0.0.19': '2', '10.0.0.23': '3'}
2025-11-13 03:46:04,468 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2025-11-13 03:46:04,473 - DEBUG - Requesting: http://10.0.0.141:8082/domain/7e609647-c42c-403c-b0dd-6b1bfaefbd00
2025-11-13 03:46:04,484 - DEBUG - Requesting: http://10.0.0.141:8082/project/310a6cd5-99fb-495a-ab2e-ec01122bbdf8
2025-11-13 03:46:04,586 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/1a6f92d8-584d-4c9d-935c-2c7a84c23f69
2025-11-13 03:46:04,601 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/1a6f92d8-584d-4c9d-935c-2c7a84c23f69
2025-11-13 03:46:04,611 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/6205a927-c743-4511-913f-a5fbbba2f326
2025-11-13 03:46:04,621 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/6205a927-c743-4511-913f-a5fbbba2f326
2025-11-13 03:46:04,629 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/16603073-614a-4701-84e4-5a03af06a40c
2025-11-13 03:46:04,637 - DEBUG - Route Targets: ['target:64512:8000004']
2025-11-13 03:46:04,637 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/1a6f92d8-584d-4c9d-935c-2c7a84c23f69
2025-11-13 03:46:04,648 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/6205a927-c743-4511-913f-a5fbbba2f326
2025-11-13 03:46:04,666 - INFO - Verified VN network id 11 for VN 1a6f92d8-584d-4c9d-935c-2c7a84c23f69
2025-11-13 03:46:04,667 - INFO - Verifications in API Server for VN ctest-vn1-40349642 passed
2025-11-13 03:46:04,668 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/1a6f92d8-584d-4c9d-935c-2c7a84c23f69
2025-11-13 03:46:04,678 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/6205a927-c743-4511-913f-a5fbbba2f326
2025-11-13 03:46:04,686 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/6205a927-c743-4511-913f-a5fbbba2f326
2025-11-13 03:46:04,694 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/16603073-614a-4701-84e4-5a03af06a40c
2025-11-13 03:46:04,708 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-41592504', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1904902625293061277', 'uuid-lslong': '10618410926157741929'}, 'enable': 'true', 'created': '2025-11-13T03:44:36', 'last-modified': '2025-11-13T03:46:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.642848'}
2025-11-13 03:46:04,716 - DEBUG - Route Targets: ['target:64512:8000004']
2025-11-13 03:46:04,722 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-41592504', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1904902625293061277', 'uuid-lslong': '10618410926157741929'}, 'enable': 'true', 'created': '2025-11-13T03:44:36', 'last-modified': '2025-11-13T03:46:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.658570'}
2025-11-13 03:46:04,728 - DEBUG - Route Targets: ['target:64512:8000004']
2025-11-13 03:46:04,733 - DEBUG - Control-node 10.0.0.61 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-41592504', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1904902625293061277', 'uuid-lslong': '10618410926157741929'}, 'enable': 'true', 'created': '2025-11-13T03:44:36', 'last-modified': '2025-11-13T03:46:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.670744'}
2025-11-13 03:46:04,739 - DEBUG - Route Targets: ['target:64512:8000004']
2025-11-13 03:46:04,739 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-40349642 passed
2025-11-13 03:46:04,739 - DEBUG - ====Verifying policy data for ctest-vn1-40349642 in API_Server ======
2025-11-13 03:46:04,739 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2025-11-13 03:46:04,745 - DEBUG - Requesting: http://10.0.0.141:8082/domain/7e609647-c42c-403c-b0dd-6b1bfaefbd00
2025-11-13 03:46:04,756 - DEBUG - Requesting: http://10.0.0.141:8082/project/310a6cd5-99fb-495a-ab2e-ec01122bbdf8
2025-11-13 03:46:04,849 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/1a6f92d8-584d-4c9d-935c-2c7a84c23f69
2025-11-13 03:46:04,862 - DEBUG - ==>Verifying data for policy with id: b7865b5d-923d-4edc-a0c2-ff09e5fcaa4c, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-41592504', 'policy1']
2025-11-13 03:46:04,862 - INFO - VN ctest-vn1-40349642 Policy verification: verify_vn_policy_in_api_server, status: True
2025-11-13 03:46:04,862 - DEBUG - Verifying the vn in opserver
2025-11-13 03:46:04,862 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642 virtual network link through opserver 10.0.0.141
2025-11-13 03:46:04,863 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2025-11-13 03:46:04,879 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642?flat'}
2025-11-13 03:46:04,879 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642 virtual network link through opserver 10.0.0.56
2025-11-13 03:46:04,879 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-11-13 03:46:04,890 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642?flat'}
2025-11-13 03:46:04,890 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642 virtual network link through opserver 10.0.0.61
2025-11-13 03:46:04,890 - DEBUG - Requesting: http://10.0.0.61:8081/analytics/uves/virtual-networks
2025-11-13 03:46:04,903 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'href': 'http://10.0.0.61:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642?flat'}
2025-11-13 03:46:04,904 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642 is found in opserver
2025-11-13 03:46:04,919 - DEBUG - VRF ids for VN ctest-vn1-40349642: {'10.0.0.23': '2'}
2025-11-13 03:46:04,919 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2025-11-13 03:46:04,925 - DEBUG - Requesting: http://10.0.0.141:8082/domain/7e609647-c42c-403c-b0dd-6b1bfaefbd00
2025-11-13 03:46:04,939 - DEBUG - Requesting: http://10.0.0.141:8082/project/310a6cd5-99fb-495a-ab2e-ec01122bbdf8
2025-11-13 03:46:05,039 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/ac2426e2-65c6-4ca1-942b-4f0bb2e60198
2025-11-13 03:46:05,053 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/ac2426e2-65c6-4ca1-942b-4f0bb2e60198
2025-11-13 03:46:05,075 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7b204f02-cbb6-4c03-97d9-69244956c4d0
2025-11-13 03:46:05,083 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7b204f02-cbb6-4c03-97d9-69244956c4d0
2025-11-13 03:46:05,092 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/309208a5-b64b-4e14-92b1-040b5dca60d9
2025-11-13 03:46:05,100 - DEBUG - Route Targets: ['target:64512:8000005']
2025-11-13 03:46:05,100 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/ac2426e2-65c6-4ca1-942b-4f0bb2e60198
2025-11-13 03:46:05,110 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7b204f02-cbb6-4c03-97d9-69244956c4d0
2025-11-13 03:46:05,133 - INFO - Verified VN network id 12 for VN ac2426e2-65c6-4ca1-942b-4f0bb2e60198
2025-11-13 03:46:05,133 - INFO - Verifications in API Server for VN ctest-vn2-60452895 passed
2025-11-13 03:46:05,133 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/ac2426e2-65c6-4ca1-942b-4f0bb2e60198
2025-11-13 03:46:05,144 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7b204f02-cbb6-4c03-97d9-69244956c4d0
2025-11-13 03:46:05,151 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7b204f02-cbb6-4c03-97d9-69244956c4d0
2025-11-13 03:46:05,158 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/309208a5-b64b-4e14-92b1-040b5dca60d9
2025-11-13 03:46:05,169 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-41592504', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12404082027497147553', 'uuid-lslong': '10676714253276545432'}, 'enable': 'true', 'created': '2025-11-13T03:45:11', 'last-modified': '2025-11-13T03:46:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.901487'}
2025-11-13 03:46:05,175 - DEBUG - Route Targets: ['target:64512:8000005']
2025-11-13 03:46:05,182 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-41592504', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12404082027497147553', 'uuid-lslong': '10676714253276545432'}, 'enable': 'true', 'created': '2025-11-13T03:45:11', 'last-modified': '2025-11-13T03:46:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.914902'}
2025-11-13 03:46:05,187 - DEBUG - Route Targets: ['target:64512:8000005']
2025-11-13 03:46:05,193 - DEBUG - Control-node 10.0.0.61 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-41592504', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '12404082027497147553', 'uuid-lslong': '10676714253276545432'}, 'enable': 'true', 'created': '2025-11-13T03:45:11', 'last-modified': '2025-11-13T03:46:03', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.928431'}
2025-11-13 03:46:05,199 - DEBUG - Route Targets: ['target:64512:8000005']
2025-11-13 03:46:05,199 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-60452895 passed
2025-11-13 03:46:05,199 - DEBUG - ====Verifying policy data for ctest-vn2-60452895 in API_Server ======
2025-11-13 03:46:05,199 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2025-11-13 03:46:05,205 - DEBUG - Requesting: http://10.0.0.141:8082/domain/7e609647-c42c-403c-b0dd-6b1bfaefbd00
2025-11-13 03:46:05,216 - DEBUG - Requesting: http://10.0.0.141:8082/project/310a6cd5-99fb-495a-ab2e-ec01122bbdf8
2025-11-13 03:46:05,300 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/ac2426e2-65c6-4ca1-942b-4f0bb2e60198
2025-11-13 03:46:05,313 - DEBUG - ==>Verifying data for policy with id: b7865b5d-923d-4edc-a0c2-ff09e5fcaa4c, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-41592504', 'policy1']
2025-11-13 03:46:05,313 - INFO - VN ctest-vn2-60452895 Policy verification: verify_vn_policy_in_api_server, status: True
2025-11-13 03:46:05,313 - DEBUG - Verifying the vn in opserver
2025-11-13 03:46:05,313 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895 virtual network link through opserver 10.0.0.141
2025-11-13 03:46:05,313 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2025-11-13 03:46:05,325 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895?flat'}
2025-11-13 03:46:05,325 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895 virtual network link through opserver 10.0.0.56
2025-11-13 03:46:05,325 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-11-13 03:46:05,336 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895?flat'}
2025-11-13 03:46:05,336 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895 virtual network link through opserver 10.0.0.61
2025-11-13 03:46:05,337 - DEBUG - Requesting: http://10.0.0.61:8081/analytics/uves/virtual-networks
2025-11-13 03:46:05,347 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'href': 'http://10.0.0.61:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895?flat'}
2025-11-13 03:46:05,347 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895 is found in opserver
2025-11-13 03:46:05,359 - DEBUG - VRF ids for VN ctest-vn2-60452895: {'10.0.0.19': '2', '10.0.0.23': '3'}
2025-11-13 03:46:05,359 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2025-11-13 03:46:05,366 - DEBUG - Requesting: http://10.0.0.141:8082/domain/7e609647-c42c-403c-b0dd-6b1bfaefbd00
2025-11-13 03:46:05,377 - DEBUG - Requesting: http://10.0.0.141:8082/project/310a6cd5-99fb-495a-ab2e-ec01122bbdf8
2025-11-13 03:46:05,530 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/dc8e8bc4-2188-4e47-8439-a61bf0eded40
2025-11-13 03:46:05,543 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/dc8e8bc4-2188-4e47-8439-a61bf0eded40
2025-11-13 03:46:05,558 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7578b01f-b0e5-4578-b5e1-f227d02bac64
2025-11-13 03:46:05,580 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7578b01f-b0e5-4578-b5e1-f227d02bac64
2025-11-13 03:46:05,596 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/d1067a90-6830-413c-aa96-f84b1a806cff
2025-11-13 03:46:05,604 - DEBUG - Route Targets: ['target:64512:8000006']
2025-11-13 03:46:05,604 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/dc8e8bc4-2188-4e47-8439-a61bf0eded40
2025-11-13 03:46:05,614 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7578b01f-b0e5-4578-b5e1-f227d02bac64
2025-11-13 03:46:05,628 - INFO - Verified VN network id 13 for VN dc8e8bc4-2188-4e47-8439-a61bf0eded40
2025-11-13 03:46:05,629 - INFO - Verifications in API Server for VN ctest-fip_vn-40336266 passed
2025-11-13 03:46:05,629 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/dc8e8bc4-2188-4e47-8439-a61bf0eded40
2025-11-13 03:46:05,638 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7578b01f-b0e5-4578-b5e1-f227d02bac64
2025-11-13 03:46:05,645 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7578b01f-b0e5-4578-b5e1-f227d02bac64
2025-11-13 03:46:05,653 - DEBUG - Requesting: http://10.0.0.141:8082/route-target/d1067a90-6830-413c-aa96-f84b1a806cff
2025-11-13 03:46:05,668 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-fip_vn-40336266', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-41592504', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15892793809529491015', 'uuid-lslong': '9527829125615447360'}, 'enable': 'true', 'created': '2025-11-13T03:45:12', 'last-modified': '2025-11-13T03:45:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:52.906737'}
2025-11-13 03:46:05,677 - DEBUG - Route Targets: ['target:64512:8000006']
2025-11-13 03:46:05,684 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-fip_vn-40336266', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-41592504', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15892793809529491015', 'uuid-lslong': '9527829125615447360'}, 'enable': 'true', 'created': '2025-11-13T03:45:12', 'last-modified': '2025-11-13T03:45:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:52.918846'}
2025-11-13 03:46:05,690 - DEBUG - Route Targets: ['target:64512:8000006']
2025-11-13 03:46:05,695 - DEBUG - Control-node 10.0.0.61 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-fip_vn-40336266', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-41592504', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15892793809529491015', 'uuid-lslong': '9527829125615447360'}, 'enable': 'true', 'created': '2025-11-13T03:45:12', 'last-modified': '2025-11-13T03:45:12', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:52.935668'}
2025-11-13 03:46:05,702 - DEBUG - Route Targets: ['target:64512:8000006']
2025-11-13 03:46:05,702 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-40336266 passed
2025-11-13 03:46:05,702 - DEBUG - ====Verifying policy data for ctest-fip_vn-40336266 in API_Server ======
2025-11-13 03:46:05,703 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2025-11-13 03:46:05,709 - DEBUG - Requesting: http://10.0.0.141:8082/domain/7e609647-c42c-403c-b0dd-6b1bfaefbd00
2025-11-13 03:46:05,721 - DEBUG - Requesting: http://10.0.0.141:8082/project/310a6cd5-99fb-495a-ab2e-ec01122bbdf8
2025-11-13 03:46:05,824 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-network/dc8e8bc4-2188-4e47-8439-a61bf0eded40
2025-11-13 03:46:05,836 - DEBUG - =>VN ctest-fip_vn-40336266 has no policy to be verified
2025-11-13 03:46:05,836 - DEBUG - Verifying the vn in opserver
2025-11-13 03:46:05,836 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-fip_vn-40336266 virtual network link through opserver 10.0.0.141
2025-11-13 03:46:05,836 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks
2025-11-13 03:46:05,847 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-fip_vn-40336266', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-fip_vn-40336266?flat'}
2025-11-13 03:46:05,847 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-fip_vn-40336266 virtual network link through opserver 10.0.0.56
2025-11-13 03:46:05,847 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks
2025-11-13 03:46:05,858 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-fip_vn-40336266', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-fip_vn-40336266?flat'}
2025-11-13 03:46:05,858 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-fip_vn-40336266 virtual network link through opserver 10.0.0.61
2025-11-13 03:46:05,858 - DEBUG - Requesting: http://10.0.0.61:8081/analytics/uves/virtual-networks
2025-11-13 03:46:05,870 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-fip_vn-40336266', 'href': 'http://10.0.0.61:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-fip_vn-40336266?flat'}
2025-11-13 03:46:05,870 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-fip_vn-40336266 is found in opserver
2025-11-13 03:46:05,881 - DEBUG - VRF ids for VN ctest-fip_vn-40336266: {'10.0.0.19': '3'}
2025-11-13 03:46:05,882 - INFO - start time= 1763005565882001
2025-11-13 03:46:05,882 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 19.229.168.131, host_string: cirros@169.254.0.3, password: gocubsgogateway: ubuntu@10.0.0.23, gateway password: c0ntrail123
2025-11-13 03:46:05,882 - DEBUG - ping -s 56 -c 3 -W 1 19.229.168.131
2025-11-13 03:46:09,531 - DEBUG - PING 19.229.168.131 (19.229.168.131): 56 data bytes
64 bytes from 19.229.168.131: seq=0 ttl=63 time=5.120 ms
64 bytes from 19.229.168.131: seq=1 ttl=63 time=1.672 ms
64 bytes from 19.229.168.131: seq=2 ttl=63 time=1.523 ms
--- 19.229.168.131 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.523/2.771/5.120 ms
2025-11-13 03:46:09,531 - INFO - Ping to IP 19.229.168.131 from VM ctest-vn1_vm1-37150677 passed
2025-11-13 03:46:19,532 - INFO - Verify session samples and teardown pkts
2025-11-13 03:46:19,532 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.141
2025-11-13 03:46:19,536 - DEBUG - Posting: http://10.0.0.141:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1763005565882001, 'end_time': 1763005579536056, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-11-13 03:46:20,555 - DEBUG - [{'T': 1763005568241211}, {'T': 1763005569241225}, {'T': 1763005570241278}]
2025-11-13 03:46:20,555 - DEBUG - Posting: http://10.0.0.141:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1763005565882001, 'end_time': 1763005580555872, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-11-13 03:46:21,575 - DEBUG - [{'T': 1763005568056791}, {'T': 1763005569056888}, {'T': 1763005570056933}]
2025-11-13 03:46:21,575 - DEBUG - Posting: http://10.0.0.141:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1763005565882001, 'end_time': 1763005581575346, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-11-13 03:46:22,595 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'sample_count': 3}]
2025-11-13 03:46:22,595 - INFO - wait for the flows to get expire
2025-11-13 03:49:42,596 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4712-2:Compute:contrail-vrouter-agent:0?flat
2025-11-13 03:49:42,634 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4712-2?flat
2025-11-13 03:49:42,664 - DEBUG - Posting: http://10.0.0.141:8081/analytics/query, payload {'table': 'SessionRecordTable', 'start_time': 1763005565882001, 'end_time': 1763005782664620, 'select_fields': ['vn', 'remote_vn', 'forward_teardown_pkts', 'reverse_teardown_pkts'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-11-13 03:49:43,724 - DEBUG - [{'forward_flow_uuid': '1d3b8c48-1f1f-4867-a859-7d6f49a8c3da', 'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'reverse_flow_uuid': 'bdd5f288-6997-42f3-887b-dac71b58e136', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'forward_teardown_pkts': 3, 'reverse_teardown_pkts': 3}]
2025-11-13 03:49:43,725 - DEBUG - Posting: http://10.0.0.141:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1763005565882001, 'end_time': 1763005783725172, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-11-13 03:49:44,744 - DEBUG - Posting: http://10.0.0.141:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1763005565882001, 'end_time': 1763005784744688, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-11-13 03:49:45,768 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895', 'sample_count': 4}]
2025-11-13 03:49:46,199 - INFO - Deleted policy policy1
2025-11-13 03:49:46,311 - INFO - Setting flow export rate: None
2025-11-13 03:49:47,599 - DEBUG - Skipping xmpp flap check
2025-11-13 03:49:47,600 - INFO - END TEST : test_verify_session_sampling_teardown : PASSED[0:03:46]
2025-11-13 03:49:47,600 - INFO - --------------------------------------------------------------------------------
2025-11-13 03:49:47,601 - INFO - Deleting VM mltf_vm
2025-11-13 03:49:47,668 - INFO - Deleting VM ctest-fvn_vm1-86537844
2025-11-13 03:49:47,729 - INFO - Deleting VM ctest-vn2_vm2-14970103
2025-11-13 03:49:47,804 - INFO - Deleting VN ctest-fip_vn-40336266
2025-11-13 03:49:47,879 - DEBUG - VN dc8e8bc4-2188-4e47-8439-a61bf0eded40 still in use: Unable to complete operation on network dc8e8bc4-2188-4e47-8439-a61bf0eded40. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-bde55d0f-d3ad-419d-93a7-83d9f7f65f0b']
2025-11-13 03:49:47,879 - WARNING - Deleting VN ctest-fip_vn-40336266 failed..Will retry
2025-11-13 03:49:50,059 - DEBUG - Response for deleting network ()
2025-11-13 03:49:50,059 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7578b01f-b0e5-4578-b5e1-f227d02bac64
2025-11-13 03:49:50,089 - DEBUG - Response Code: 404
2025-11-13 03:49:50,089 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2025-11-13 03:49:50,094 - DEBUG - Requesting: http://10.0.0.141:8082/domain/7e609647-c42c-403c-b0dd-6b1bfaefbd00
2025-11-13 03:49:50,104 - DEBUG - Requesting: http://10.0.0.141:8082/project/310a6cd5-99fb-495a-ab2e-ec01122bbdf8
2025-11-13 03:49:50,198 - INFO - Validated that VN ctest-fip_vn-40336266 is not found in API Server
2025-11-13 03:49:50,209 - DEBUG - VN ctest-fip_vn-40336266 is not present in Agent 10.0.0.19
2025-11-13 03:49:50,218 - DEBUG - VN ctest-fip_vn-40336266 is not present in Agent 10.0.0.23
2025-11-13 03:49:50,218 - INFO - Validated that VN ctest-fip_vn-40336266 is not in any agent
2025-11-13 03:49:50,224 - DEBUG - VRF 3 is not seen in agent 10.0.0.19
2025-11-13 03:49:50,228 - DEBUG - Vrouter 10.0.0.19 does not have vrf 3 for VN ctest-fip_vn-40336266
2025-11-13 03:49:50,228 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-fip_vn-40336266
2025-11-13 03:49:50,247 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-40336266 info
2025-11-13 03:49:50,248 - INFO - Deleting VN ctest-vn2-60452895
2025-11-13 03:49:50,386 - DEBUG - Response for deleting network ()
2025-11-13 03:49:50,387 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/7b204f02-cbb6-4c03-97d9-69244956c4d0
2025-11-13 03:49:50,396 - DEBUG - Response Code: 404
2025-11-13 03:49:50,396 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2025-11-13 03:49:50,405 - DEBUG - Requesting: http://10.0.0.141:8082/domain/7e609647-c42c-403c-b0dd-6b1bfaefbd00
2025-11-13 03:49:50,465 - DEBUG - Requesting: http://10.0.0.141:8082/project/310a6cd5-99fb-495a-ab2e-ec01122bbdf8
2025-11-13 03:49:50,565 - INFO - Validated that VN ctest-vn2-60452895 is not found in API Server
2025-11-13 03:49:50,575 - DEBUG - VN ctest-vn2-60452895 is not present in Agent 10.0.0.19
2025-11-13 03:49:50,584 - DEBUG - VN ctest-vn2-60452895 is not present in Agent 10.0.0.23
2025-11-13 03:49:50,584 - INFO - Validated that VN ctest-vn2-60452895 is not in any agent
2025-11-13 03:49:50,589 - DEBUG - VRF 2 is not seen in agent 10.0.0.19
2025-11-13 03:49:50,594 - DEBUG - Vrouter 10.0.0.19 does not have vrf 2 for VN ctest-vn2-60452895
2025-11-13 03:49:50,599 - DEBUG - VRF 3 is not seen in agent 10.0.0.23
2025-11-13 03:49:50,604 - DEBUG - Vrouter 10.0.0.23 does not have vrf 3 for VN ctest-vn2-60452895
2025-11-13 03:49:50,605 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn2-60452895
2025-11-13 03:49:50,624 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-60452895 info
2025-11-13 03:49:50,624 - INFO - Deleting VM ctest-vn1_vm2-29107273
2025-11-13 03:49:50,690 - INFO - Deleting VM ctest-vn1_vm1-37150677
2025-11-13 03:49:50,753 - INFO - Deleting VN ctest-vn1-40349642
2025-11-13 03:49:50,794 - DEBUG - VN 1a6f92d8-584d-4c9d-935c-2c7a84c23f69 still in use: Unable to complete operation on network 1a6f92d8-584d-4c9d-935c-2c7a84c23f69. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-ff0a5f1f-a2ce-4692-abe9-986682286fc9']
2025-11-13 03:49:50,794 - WARNING - Deleting VN ctest-vn1-40349642 failed..Will retry
2025-11-13 03:49:52,939 - DEBUG - Response for deleting network ()
2025-11-13 03:49:52,939 - DEBUG - Requesting: http://10.0.0.141:8082/routing-instance/6205a927-c743-4511-913f-a5fbbba2f326
2025-11-13 03:49:52,944 - DEBUG - Response Code: 404
2025-11-13 03:49:52,944 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2025-11-13 03:49:52,955 - DEBUG - Requesting: http://10.0.0.141:8082/domain/7e609647-c42c-403c-b0dd-6b1bfaefbd00
2025-11-13 03:49:52,972 - DEBUG - Requesting: http://10.0.0.141:8082/project/310a6cd5-99fb-495a-ab2e-ec01122bbdf8
2025-11-13 03:49:53,081 - INFO - Validated that VN ctest-vn1-40349642 is not found in API Server
2025-11-13 03:49:53,090 - DEBUG - VN ctest-vn1-40349642 is not present in Agent 10.0.0.19
2025-11-13 03:49:53,099 - DEBUG - VN ctest-vn1-40349642 is not present in Agent 10.0.0.23
2025-11-13 03:49:53,099 - INFO - Validated that VN ctest-vn1-40349642 is not in any agent
2025-11-13 03:49:53,103 - DEBUG - VRF 2 is not seen in agent 10.0.0.23
2025-11-13 03:49:53,107 - DEBUG - Vrouter 10.0.0.23 does not have vrf 2 for VN ctest-vn1-40349642
2025-11-13 03:49:53,107 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-41592504:ctest-vn1-40349642
2025-11-13 03:49:53,126 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-40349642 info
2025-11-13 03:49:53,873 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-41592504, ID : 310a6cd5-99fb-495a-ab2e-ec01122bbdf8