2026-06-03 18:53:26,124 - INFO - Domain Default found not creating 2026-06-03 18:53:26,325 - INFO - Project ctest-AnalyticsTestSanityWithResource-45455902 not found, creating it 2026-06-03 18:53:26,946 - INFO - Created Project:ctest-AnalyticsTestSanityWithResource-45455902, ID : 2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:53:29,372 - DEBUG - Response for create_network : {'network': {'id': '110f6368-5675-4791-a5a6-341ddd9e6868', 'name': 'ctest-vn1-53925033', 'tenant_id': '2b6ff4e195c0433f9f9e4bc1ef0f5eb1', 'project_id': '2b6ff4e195c0433f9f9e4bc1ef0f5eb1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-45455902', 'ctest-vn1-53925033'], 'port_security_enabled': True, 'description': ''}} 2026-06-03 18:53:29,638 - DEBUG - Response for create_subnet : {'subnet': {'id': '636d4359-2071-4ce9-ada1-6664001e1cc6', 'name': '', 'tenant_id': '2b6ff4e195c0433f9f9e4bc1ef0f5eb1', 'network_id': '110f6368-5675-4791-a5a6-341ddd9e6868', 'ip_version': 4, 'cidr': '201.129.253.0/26', 'allocation_pools': [{'start': '201.129.253.2', 'end': '201.129.253.62'}], 'gateway_ip': '201.129.253.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '201.129.253.2', 'tags': [], 'project_id': '2b6ff4e195c0433f9f9e4bc1ef0f5eb1'}} 2026-06-03 18:53:29,664 - INFO - Created VN ctest-vn1-53925033 2026-06-03 18:53:29,679 - DEBUG - VN ctest-vn1-53925033 UUID is 110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:53:29,781 - DEBUG - Services list from nova: [, , , ] 2026-06-03 18:53:29,781 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5883-1', 'an-jenkins-deploy-platform-ansible-os-5883-2']} 2026-06-03 18:53:31,238 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5883-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5883-1) 2026-06-03 18:53:32,937 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5883-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5883-1) 2026-06-03 18:53:32,937 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:53:33,263 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:53:33,402 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:53:33,467 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:53:33,584 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:53:33,626 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:53:33,656 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:53:33,678 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:53:33,691 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/439b045a-5f42-4582-bb7f-350ef23032f4 2026-06-03 18:53:33,718 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-03 18:53:33,718 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:53:33,731 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:53:33,753 - INFO - Verified VN network id 17 for VN 110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:53:33,757 - INFO - Verifications in API Server for VN ctest-vn1-53925033 passed 2026-06-03 18:53:33,757 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:53:33,775 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:53:33,785 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:53:33,803 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/439b045a-5f42-4582-bb7f-350ef23032f4 2026-06-03 18:53:33,828 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1229310523073709969', 'uuid-lslong': '11936285165268920424'}, 'enable': 'true', 'created': '2026-06-03T18:53:29', 'last-modified': '2026-06-03T18:53:29', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:04.248991'} 2026-06-03 18:53:33,843 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-03 18:53:33,852 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1229310523073709969', 'uuid-lslong': '11936285165268920424'}, 'enable': 'true', 'created': '2026-06-03T18:53:29', 'last-modified': '2026-06-03T18:53:29', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:04.275768'} 2026-06-03 18:53:33,862 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-03 18:53:33,868 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1229310523073709969', 'uuid-lslong': '11936285165268920424'}, 'enable': 'true', 'created': '2026-06-03T18:53:29', 'last-modified': '2026-06-03T18:53:29', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:04.291705'} 2026-06-03 18:53:33,876 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-03 18:53:33,876 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-53925033 passed 2026-06-03 18:53:33,876 - DEBUG - ====Verifying policy data for ctest-vn1-53925033 in API_Server ====== 2026-06-03 18:53:33,876 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:53:33,889 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:53:33,903 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:53:34,001 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:53:34,014 - DEBUG - =>VN ctest-vn1-53925033 has no policy to be verified 2026-06-03 18:53:34,014 - DEBUG - Verifying the vn in opserver 2026-06-03 18:53:34,014 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 virtual network link through opserver 10.0.0.50 2026-06-03 18:53:34,014 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-03 18:53:34,318 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-03 18:53:34,387 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033?flat'} 2026-06-03 18:53:34,387 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 virtual network link through opserver 10.0.0.33 2026-06-03 18:53:34,387 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks 2026-06-03 18:53:34,699 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks 2026-06-03 18:53:34,772 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033?flat'} 2026-06-03 18:53:34,772 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 virtual network link through opserver 10.0.0.249 2026-06-03 18:53:34,772 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-06-03 18:53:35,077 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-06-03 18:53:35,158 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033?flat'} 2026-06-03 18:53:35,158 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 is found in opserver 2026-06-03 18:53:35,174 - DEBUG - VRF ids for VN ctest-vn1-53925033: {'10.0.0.22': '5'} 2026-06-03 18:53:35,175 - INFO - Waiting for VM ctest-vn1_vm1-29709616 to be up.. 2026-06-03 18:53:35,293 - DEBUG - VM is in ACTIVE state now 2026-06-03 18:53:35,293 - INFO - VM name : ctest-vn1_vm1-29709616 2026-06-03 18:53:35,389 - DEBUG - VM ctest-vn1_vm1-29709616 ID is 8a322534-5b2d-40eb-a81c-230dc9173bf6 2026-06-03 18:53:35,423 - DEBUG - VM ctest-vn1_vm1-29709616 launched on Node an-jenkins-deploy-platform-ansible-os-5883-1 2026-06-03 18:53:35,536 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/8a322534-5b2d-40eb-a81c-230dc9173bf6 2026-06-03 18:53:35,840 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/8a322534-5b2d-40eb-a81c-230dc9173bf6 2026-06-03 18:53:35,886 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/36ff2505-8523-42f2-963d-70a2de0184d2 2026-06-03 18:53:39,081 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1029ms') 2026-06-03 18:53:39,081 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-vn1_vm1-29709616 failed! 2026-06-03 18:53:39,096 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 is 201.129.253.1 and allocation pool is NOT set 2026-06-03 18:53:43,182 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1022ms') 2026-06-03 18:53:43,182 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-vn1_vm1-29709616 failed! 2026-06-03 18:53:43,201 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 is 201.129.253.1 and allocation pool is NOT set 2026-06-03 18:53:47,277 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1007ms') 2026-06-03 18:53:47,277 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-vn1_vm1-29709616 failed! 2026-06-03 18:53:47,293 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 is 201.129.253.1 and allocation pool is NOT set 2026-06-03 18:53:51,377 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms') 2026-06-03 18:53:51,377 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-vn1_vm1-29709616 failed! 2026-06-03 18:53:51,392 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 is 201.129.253.1 and allocation pool is NOT set 2026-06-03 18:53:55,472 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=10.0 ms\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1015ms\r\nrtt min/avg/max/mdev = 10.003/10.003/10.003/0.000 ms') 2026-06-03 18:53:55,472 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-vn1_vm1-29709616 passed 2026-06-03 18:53:55,547 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-03 18:53:55,548 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-29709616, IP 201.129.253.3, Port 22 2026-06-03 18:53:55,616 - DEBUG - Error on ssh to cirros@169.254.0.6:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-06-03 18:53:55,757 - DEBUG - VM ctest-vn1_vm1-29709616 is NOT ready for SSH connections, VM status: ACTIVE 2026-06-03 18:54:00,757 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-03 18:54:00,758 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-29709616, IP 201.129.253.3, Port 22 2026-06-03 18:54:00,823 - DEBUG - Error on ssh to cirros@169.254.0.6:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-06-03 18:54:00,919 - DEBUG - VM ctest-vn1_vm1-29709616 is NOT ready for SSH connections, VM status: ACTIVE 2026-06-03 18:54:05,920 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-03 18:54:05,921 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-29709616, IP 201.129.253.3, Port 22 2026-06-03 18:54:06,103 - DEBUG - VM ctest-vn1_vm1-29709616 is ready for SSH connections 2026-06-03 18:54:06,103 - INFO - Waiting for VM ctest-vn1_vm2-58079454 to be up.. 2026-06-03 18:54:06,217 - DEBUG - VM is in ACTIVE state now 2026-06-03 18:54:06,217 - INFO - VM name : ctest-vn1_vm2-58079454 2026-06-03 18:54:06,311 - DEBUG - VM ctest-vn1_vm2-58079454 ID is 3a609d2b-802c-4a02-a1a4-d94b2380a34d 2026-06-03 18:54:06,311 - DEBUG - VM ctest-vn1_vm2-58079454 launched on Node an-jenkins-deploy-platform-ansible-os-5883-1 2026-06-03 18:54:06,403 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/3a609d2b-802c-4a02-a1a4-d94b2380a34d 2026-06-03 18:54:06,414 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/cfacd696-cb34-4fdb-bb60-363dd63e96f4 2026-06-03 18:54:07,591 - DEBUG - (True, 'PING 169.254.0.7 (169.254.0.7) 56(84) bytes of data.\r\n64 bytes from 169.254.0.7: icmp_seq=1 ttl=63 time=1.93 ms\r\n64 bytes from 169.254.0.7: icmp_seq=2 ttl=63 time=0.413 ms\r\n\r\n--- 169.254.0.7 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.413/1.172/1.931/0.759 ms') 2026-06-03 18:54:07,591 - INFO - Ping to Metadata IP 169.254.0.7 of VM ctest-vn1_vm2-58079454 passed 2026-06-03 18:54:07,671 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-03 18:54:07,671 - DEBUG - Waiting to SSH to VM ctest-vn1_vm2-58079454, IP 201.129.253.4, Port 22 2026-06-03 18:54:07,833 - DEBUG - VM ctest-vn1_vm2-58079454 is ready for SSH connections 2026-06-03 18:54:08,145 - DEBUG - Response for create_network : {'network': {'id': '4b611c2f-aff3-4cc1-966f-cbbab36f4542', 'name': 'ctest-vn2-42987706', 'tenant_id': '2b6ff4e195c0433f9f9e4bc1ef0f5eb1', 'project_id': '2b6ff4e195c0433f9f9e4bc1ef0f5eb1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-45455902', 'ctest-vn2-42987706'], 'port_security_enabled': True, 'description': ''}} 2026-06-03 18:54:08,404 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e8a11a64-d4c2-48d6-9769-2d9a480e8d39', 'name': '', 'tenant_id': '2b6ff4e195c0433f9f9e4bc1ef0f5eb1', 'network_id': '4b611c2f-aff3-4cc1-966f-cbbab36f4542', 'ip_version': 4, 'cidr': '146.173.73.192/26', 'allocation_pools': [{'start': '146.173.73.194', 'end': '146.173.73.254'}], 'gateway_ip': '146.173.73.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '146.173.73.194', 'tags': [], 'project_id': '2b6ff4e195c0433f9f9e4bc1ef0f5eb1'}} 2026-06-03 18:54:08,430 - INFO - Created VN ctest-vn2-42987706 2026-06-03 18:54:08,443 - DEBUG - VN ctest-vn2-42987706 UUID is 4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:54:08,823 - DEBUG - Response for create_network : {'network': {'id': '49c8fcff-edea-452b-948f-bdf074c4e559', 'name': 'ctest-fip_vn-36414688', 'tenant_id': '2b6ff4e195c0433f9f9e4bc1ef0f5eb1', 'project_id': '2b6ff4e195c0433f9f9e4bc1ef0f5eb1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-45455902', 'ctest-fip_vn-36414688'], 'port_security_enabled': True, 'description': ''}} 2026-06-03 18:54:09,053 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c6b73b98-e18c-4bc3-9861-94233a7aa637', 'name': '', 'tenant_id': '2b6ff4e195c0433f9f9e4bc1ef0f5eb1', 'network_id': '49c8fcff-edea-452b-948f-bdf074c4e559', 'ip_version': 4, 'cidr': '174.203.219.192/26', 'allocation_pools': [{'start': '174.203.219.194', 'end': '174.203.219.254'}], 'gateway_ip': '174.203.219.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '174.203.219.194', 'tags': [], 'project_id': '2b6ff4e195c0433f9f9e4bc1ef0f5eb1'}} 2026-06-03 18:54:09,093 - INFO - Created VN ctest-fip_vn-36414688 2026-06-03 18:54:09,105 - DEBUG - VN ctest-fip_vn-36414688 UUID is 49c8fcff-edea-452b-948f-bdf074c4e559 2026-06-03 18:54:09,207 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5883-1', 'an-jenkins-deploy-platform-ansible-os-5883-2']} 2026-06-03 18:54:10,830 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5883-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5883-2) 2026-06-03 18:54:12,596 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5883-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5883-2) 2026-06-03 18:54:14,661 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5883-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5883-1) 2026-06-03 18:54:14,661 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:54:14,669 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:54:14,683 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:54:14,792 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:54:14,813 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:54:14,829 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:54:14,838 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:54:14,848 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/439b045a-5f42-4582-bb7f-350ef23032f4 2026-06-03 18:54:14,870 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-03 18:54:14,870 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:54:14,884 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:54:14,903 - INFO - Verified VN network id 17 for VN 110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:54:14,903 - INFO - Verifications in API Server for VN ctest-vn1-53925033 passed 2026-06-03 18:54:14,903 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:54:14,913 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:54:14,922 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:54:14,931 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/439b045a-5f42-4582-bb7f-350ef23032f4 2026-06-03 18:54:14,945 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1229310523073709969', 'uuid-lslong': '11936285165268920424'}, 'enable': 'true', 'created': '2026-06-03T18:53:29', 'last-modified': '2026-06-03T18:53:29', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:45.368173'} 2026-06-03 18:54:14,951 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-03 18:54:14,958 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1229310523073709969', 'uuid-lslong': '11936285165268920424'}, 'enable': 'true', 'created': '2026-06-03T18:53:29', 'last-modified': '2026-06-03T18:53:29', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:45.381393'} 2026-06-03 18:54:14,964 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-03 18:54:14,971 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1229310523073709969', 'uuid-lslong': '11936285165268920424'}, 'enable': 'true', 'created': '2026-06-03T18:53:29', 'last-modified': '2026-06-03T18:53:29', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:45.394469'} 2026-06-03 18:54:14,982 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-03 18:54:14,983 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-53925033 passed 2026-06-03 18:54:14,983 - DEBUG - ====Verifying policy data for ctest-vn1-53925033 in API_Server ====== 2026-06-03 18:54:14,984 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:54:14,997 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:54:15,014 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:54:15,141 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:54:15,157 - DEBUG - =>VN ctest-vn1-53925033 has no policy to be verified 2026-06-03 18:54:15,157 - DEBUG - Verifying the vn in opserver 2026-06-03 18:54:15,157 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 virtual network link through opserver 10.0.0.50 2026-06-03 18:54:15,157 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-03 18:54:15,310 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033?flat'} 2026-06-03 18:54:15,310 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 virtual network link through opserver 10.0.0.33 2026-06-03 18:54:15,310 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks 2026-06-03 18:54:15,433 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033?flat'} 2026-06-03 18:54:15,433 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 virtual network link through opserver 10.0.0.249 2026-06-03 18:54:15,433 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-06-03 18:54:15,540 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033?flat'} 2026-06-03 18:54:15,540 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 is found in opserver 2026-06-03 18:54:15,552 - DEBUG - VRF ids for VN ctest-vn1-53925033: {'10.0.0.22': '5'} 2026-06-03 18:54:15,552 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:54:15,561 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:54:15,575 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:54:15,766 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:54:15,791 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:54:15,813 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/27366166-d608-4b0d-9103-6e62f6b48b29 2026-06-03 18:54:15,826 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/27366166-d608-4b0d-9103-6e62f6b48b29 2026-06-03 18:54:15,861 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/52313a3e-6484-480a-b82d-92d15227f3d8 2026-06-03 18:54:15,881 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-03 18:54:15,881 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:54:15,902 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/27366166-d608-4b0d-9103-6e62f6b48b29 2026-06-03 18:54:15,930 - INFO - Verified VN network id 18 for VN 4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:54:15,931 - INFO - Verifications in API Server for VN ctest-vn2-42987706 passed 2026-06-03 18:54:15,931 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:54:15,954 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/27366166-d608-4b0d-9103-6e62f6b48b29 2026-06-03 18:54:15,967 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/27366166-d608-4b0d-9103-6e62f6b48b29 2026-06-03 18:54:15,979 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/52313a3e-6484-480a-b82d-92d15227f3d8 2026-06-03 18:54:16,000 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5431653616726527169', 'uuid-lslong': '10840106830838842690'}, 'enable': 'true', 'created': '2026-06-03T18:54:08', 'last-modified': '2026-06-03T18:54:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:07.693801'} 2026-06-03 18:54:16,013 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-03 18:54:16,019 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5431653616726527169', 'uuid-lslong': '10840106830838842690'}, 'enable': 'true', 'created': '2026-06-03T18:54:08', 'last-modified': '2026-06-03T18:54:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:07.708851'} 2026-06-03 18:54:16,030 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-03 18:54:16,037 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5431653616726527169', 'uuid-lslong': '10840106830838842690'}, 'enable': 'true', 'created': '2026-06-03T18:54:08', 'last-modified': '2026-06-03T18:54:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:07.725934'} 2026-06-03 18:54:16,046 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-03 18:54:16,046 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-42987706 passed 2026-06-03 18:54:16,047 - DEBUG - ====Verifying policy data for ctest-vn2-42987706 in API_Server ====== 2026-06-03 18:54:16,047 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:54:16,056 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:54:16,099 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:54:16,214 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:54:16,234 - DEBUG - =>VN ctest-vn2-42987706 has no policy to be verified 2026-06-03 18:54:16,234 - DEBUG - Verifying the vn in opserver 2026-06-03 18:54:16,234 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706 virtual network link through opserver 10.0.0.50 2026-06-03 18:54:16,234 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-03 18:54:16,250 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706?flat'} 2026-06-03 18:54:16,250 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706 virtual network link through opserver 10.0.0.33 2026-06-03 18:54:16,250 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks 2026-06-03 18:54:16,275 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706?flat'} 2026-06-03 18:54:16,276 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706 virtual network link through opserver 10.0.0.249 2026-06-03 18:54:16,276 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-06-03 18:54:16,384 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706?flat'} 2026-06-03 18:54:16,385 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706 is found in opserver 2026-06-03 18:54:16,415 - DEBUG - VRF ids for VN ctest-vn2-42987706: {'10.0.0.19': '5'} 2026-06-03 18:54:16,415 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:54:16,431 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:54:16,449 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:54:16,564 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/49c8fcff-edea-452b-948f-bdf074c4e559 2026-06-03 18:54:16,582 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/49c8fcff-edea-452b-948f-bdf074c4e559 2026-06-03 18:54:16,596 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/b239e00e-0089-4513-aa23-f3f2bcae959c 2026-06-03 18:54:16,608 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/b239e00e-0089-4513-aa23-f3f2bcae959c 2026-06-03 18:54:16,624 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/f65a2e91-2acd-4fae-b13a-1330a69ba959 2026-06-03 18:54:16,637 - DEBUG - Route Targets: ['target:64512:8000010'] 2026-06-03 18:54:16,637 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/49c8fcff-edea-452b-948f-bdf074c4e559 2026-06-03 18:54:16,661 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/b239e00e-0089-4513-aa23-f3f2bcae959c 2026-06-03 18:54:16,684 - INFO - Verified VN network id 19 for VN 49c8fcff-edea-452b-948f-bdf074c4e559 2026-06-03 18:54:16,684 - INFO - Verifications in API Server for VN ctest-fip_vn-36414688 passed 2026-06-03 18:54:16,684 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/49c8fcff-edea-452b-948f-bdf074c4e559 2026-06-03 18:54:16,698 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/b239e00e-0089-4513-aa23-f3f2bcae959c 2026-06-03 18:54:16,713 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/b239e00e-0089-4513-aa23-f3f2bcae959c 2026-06-03 18:54:16,723 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/f65a2e91-2acd-4fae-b13a-1330a69ba959 2026-06-03 18:54:16,734 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5316777536249283883', 'uuid-lslong': '10704983679731819865'}, 'enable': 'true', 'created': '2026-06-03T18:54:08', 'last-modified': '2026-06-03T18:54:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:07.739490'} 2026-06-03 18:54:16,750 - DEBUG - Route Targets: ['target:64512:8000010'] 2026-06-03 18:54:16,757 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5316777536249283883', 'uuid-lslong': '10704983679731819865'}, 'enable': 'true', 'created': '2026-06-03T18:54:08', 'last-modified': '2026-06-03T18:54:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:07.764382'} 2026-06-03 18:54:16,765 - DEBUG - Route Targets: ['target:64512:8000010'] 2026-06-03 18:54:16,771 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5316777536249283883', 'uuid-lslong': '10704983679731819865'}, 'enable': 'true', 'created': '2026-06-03T18:54:08', 'last-modified': '2026-06-03T18:54:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:07.778952'} 2026-06-03 18:54:16,782 - DEBUG - Route Targets: ['target:64512:8000010'] 2026-06-03 18:54:16,782 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-36414688 passed 2026-06-03 18:54:16,782 - DEBUG - ====Verifying policy data for ctest-fip_vn-36414688 in API_Server ====== 2026-06-03 18:54:16,782 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:54:16,790 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:54:16,807 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:54:16,946 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/49c8fcff-edea-452b-948f-bdf074c4e559 2026-06-03 18:54:16,959 - DEBUG - =>VN ctest-fip_vn-36414688 has no policy to be verified 2026-06-03 18:54:16,959 - DEBUG - Verifying the vn in opserver 2026-06-03 18:54:16,959 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688 virtual network link through opserver 10.0.0.50 2026-06-03 18:54:16,959 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-03 18:54:17,072 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688?flat'} 2026-06-03 18:54:17,072 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688 virtual network link through opserver 10.0.0.33 2026-06-03 18:54:17,072 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks 2026-06-03 18:54:17,167 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688?flat'} 2026-06-03 18:54:17,167 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688 virtual network link through opserver 10.0.0.249 2026-06-03 18:54:17,167 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-06-03 18:54:17,183 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688?flat'} 2026-06-03 18:54:17,183 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688 is found in opserver 2026-06-03 18:54:17,195 - DEBUG - VRF ids for VN ctest-fip_vn-36414688: {'10.0.0.19': '6'} 2026-06-03 18:54:17,195 - INFO - Waiting for VM ctest-fvn_vm1-87357366 to be up.. 2026-06-03 18:54:17,339 - DEBUG - VM is in ACTIVE state now 2026-06-03 18:54:17,339 - INFO - VM name : ctest-fvn_vm1-87357366 2026-06-03 18:54:17,448 - DEBUG - VM ctest-fvn_vm1-87357366 ID is 7a6a0cff-979a-4a3d-bd32-9259f9bb067b 2026-06-03 18:54:17,448 - DEBUG - VM ctest-fvn_vm1-87357366 launched on Node an-jenkins-deploy-platform-ansible-os-5883-2 2026-06-03 18:54:17,562 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/7a6a0cff-979a-4a3d-bd32-9259f9bb067b 2026-06-03 18:54:17,589 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/644f4377-1a9c-4543-8662-7e9e3dab8a23 2026-06-03 18:54:20,788 - DEBUG - (True, 'PING 169.254.0.7 (169.254.0.7) 56(84) bytes of data.\r\n\r\n--- 169.254.0.7 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1021ms') 2026-06-03 18:54:20,789 - DEBUG - Ping to Metadata IP 169.254.0.7 of VM ctest-fvn_vm1-87357366 failed! 2026-06-03 18:54:20,805 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688 is 174.203.219.193 and allocation pool is NOT set 2026-06-03 18:54:24,881 - DEBUG - (True, 'PING 169.254.0.7 (169.254.0.7) 56(84) bytes of data.\r\n\r\n--- 169.254.0.7 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1013ms') 2026-06-03 18:54:24,881 - DEBUG - Ping to Metadata IP 169.254.0.7 of VM ctest-fvn_vm1-87357366 failed! 2026-06-03 18:54:24,897 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688 is 174.203.219.193 and allocation pool is NOT set 2026-06-03 18:54:28,979 - DEBUG - (True, 'PING 169.254.0.7 (169.254.0.7) 56(84) bytes of data.\r\n\r\n--- 169.254.0.7 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1020ms') 2026-06-03 18:54:28,979 - DEBUG - Ping to Metadata IP 169.254.0.7 of VM ctest-fvn_vm1-87357366 failed! 2026-06-03 18:54:28,994 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688 is 174.203.219.193 and allocation pool is NOT set 2026-06-03 18:54:33,071 - DEBUG - (True, 'PING 169.254.0.7 (169.254.0.7) 56(84) bytes of data.\r\n\r\n--- 169.254.0.7 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms') 2026-06-03 18:54:33,071 - DEBUG - Ping to Metadata IP 169.254.0.7 of VM ctest-fvn_vm1-87357366 failed! 2026-06-03 18:54:33,089 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688 is 174.203.219.193 and allocation pool is NOT set 2026-06-03 18:54:37,173 - DEBUG - (True, 'PING 169.254.0.7 (169.254.0.7) 56(84) bytes of data.\r\n\r\n--- 169.254.0.7 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1021ms') 2026-06-03 18:54:37,173 - DEBUG - Ping to Metadata IP 169.254.0.7 of VM ctest-fvn_vm1-87357366 failed! 2026-06-03 18:54:37,190 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688 is 174.203.219.193 and allocation pool is NOT set 2026-06-03 18:54:39,254 - DEBUG - (True, 'PING 169.254.0.7 (169.254.0.7) 56(84) bytes of data.\r\n64 bytes from 169.254.0.7: icmp_seq=1 ttl=63 time=8.22 ms\r\n64 bytes from 169.254.0.7: icmp_seq=2 ttl=63 time=2.06 ms\r\n\r\n--- 169.254.0.7 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 2.059/5.138/8.218/3.079 ms') 2026-06-03 18:54:39,254 - INFO - Ping to Metadata IP 169.254.0.7 of VM ctest-fvn_vm1-87357366 passed 2026-06-03 18:54:39,328 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-03 18:54:39,328 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-87357366, IP 174.203.219.195, Port 22 2026-06-03 18:54:39,396 - DEBUG - Error on ssh to cirros@169.254.0.7:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.7/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.7/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.7/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-06-03 18:54:39,511 - DEBUG - VM ctest-fvn_vm1-87357366 is NOT ready for SSH connections, VM status: ACTIVE 2026-06-03 18:54:44,511 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-03 18:54:44,512 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-87357366, IP 174.203.219.195, Port 22 2026-06-03 18:54:44,592 - DEBUG - Error on ssh to cirros@169.254.0.7:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.7/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.7/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.7/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-06-03 18:54:44,713 - DEBUG - VM ctest-fvn_vm1-87357366 is NOT ready for SSH connections, VM status: ACTIVE 2026-06-03 18:54:49,714 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-03 18:54:49,714 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-87357366, IP 174.203.219.195, Port 22 2026-06-03 18:54:49,787 - DEBUG - Error on ssh to cirros@169.254.0.7:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.7/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.7/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.7/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-06-03 18:54:49,908 - DEBUG - VM ctest-fvn_vm1-87357366 is NOT ready for SSH connections, VM status: ACTIVE 2026-06-03 18:54:54,909 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-03 18:54:54,909 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-87357366, IP 174.203.219.195, Port 22 2026-06-03 18:54:55,097 - DEBUG - VM ctest-fvn_vm1-87357366 is ready for SSH connections 2026-06-03 18:54:55,097 - INFO - Waiting for VM ctest-vn2_vm2-77854045 to be up.. 2026-06-03 18:54:55,195 - DEBUG - VM is in ACTIVE state now 2026-06-03 18:54:55,195 - INFO - VM name : ctest-vn2_vm2-77854045 2026-06-03 18:54:55,294 - DEBUG - VM ctest-vn2_vm2-77854045 ID is e8e242a3-42b6-41da-80b8-eeb0ae1be3bf 2026-06-03 18:54:55,294 - DEBUG - VM ctest-vn2_vm2-77854045 launched on Node an-jenkins-deploy-platform-ansible-os-5883-2 2026-06-03 18:54:55,387 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/e8e242a3-42b6-41da-80b8-eeb0ae1be3bf 2026-06-03 18:54:55,399 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/68be84e1-e620-4747-9fe8-a7466605d402 2026-06-03 18:54:56,568 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n64 bytes from 169.254.0.6: icmp_seq=1 ttl=63 time=3.00 ms\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=0.539 ms\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.539/1.767/2.996/1.228 ms') 2026-06-03 18:54:56,568 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-vn2_vm2-77854045 passed 2026-06-03 18:54:56,646 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-03 18:54:56,646 - DEBUG - Waiting to SSH to VM ctest-vn2_vm2-77854045, IP 146.173.73.195, Port 22 2026-06-03 18:54:56,817 - DEBUG - VM ctest-vn2_vm2-77854045 is ready for SSH connections 2026-06-03 18:54:56,817 - INFO - Waiting for VM mltf_vm to be up.. 2026-06-03 18:54:56,939 - DEBUG - VM is in ACTIVE state now 2026-06-03 18:54:56,939 - INFO - VM name : mltf_vm 2026-06-03 18:54:57,054 - DEBUG - VM mltf_vm ID is ea0adb5a-b001-4874-b1cc-2d30dc4bcc29 2026-06-03 18:54:57,054 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-5883-1 2026-06-03 18:54:57,259 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/ea0adb5a-b001-4874-b1cc-2d30dc4bcc29 2026-06-03 18:54:57,273 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/a5675b03-6a81-4418-a55c-864717372d4d 2026-06-03 18:54:57,286 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/a71a4cf9-979f-4377-9d6b-276de5090109 2026-06-03 18:54:58,522 - DEBUG - (True, 'PING 169.254.0.8 (169.254.0.8) 56(84) bytes of data.\r\n64 bytes from 169.254.0.8: icmp_seq=1 ttl=63 time=1.92 ms\r\n64 bytes from 169.254.0.8: icmp_seq=2 ttl=63 time=0.405 ms\r\n\r\n--- 169.254.0.8 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.405/1.160/1.915/0.755 ms') 2026-06-03 18:54:58,522 - INFO - Ping to Metadata IP 169.254.0.8 of VM mltf_vm passed 2026-06-03 18:54:58,594 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-03 18:54:58,594 - DEBUG - Waiting to SSH to VM mltf_vm, IP 201.129.253.5, Port 22 2026-06-03 18:54:58,757 - DEBUG - VM mltf_vm is ready for SSH connections 2026-06-03 18:54:58,831 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-03 18:54:58,832 - DEBUG - Waiting to SSH to VM mltf_vm, IP 201.129.253.5, Port 22 2026-06-03 18:54:58,985 - DEBUG - VM mltf_vm is ready for SSH connections 2026-06-03 18:54:58,987 - INFO - ================================================================================ 2026-06-03 18:54:58,988 - INFO - STARTING TEST : test_verify_session_sampling_teardown 2026-06-03 18:54:58,988 - INFO - TEST DESCRIPTION : 1.query client session samples 2.query server session samples 3.query client session to get number of sessions exported 4.query session record table for teardown bytes/pkts 5.query sample count after teardown on server side 2026-06-03 18:55:00,282 - DEBUG - Skipping xmpp flap check 2026-06-03 18:55:00,283 - INFO - Initial checks done. Running the testcase now 2026-06-03 18:55:00,283 - INFO - 2026-06-03 18:55:00,413 - INFO - Setting flow export rate: 100 2026-06-03 18:55:00,461 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = any, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = any, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None] 2026-06-03 18:55:00,807 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '110f6368-5675-4791-a5a6-341ddd9e6868', 'name': 'ctest-vn1-53925033', 'tenant_id': '2b6ff4e195c0433f9f9e4bc1ef0f5eb1', 'project_id': '2b6ff4e195c0433f9f9e4bc1ef0f5eb1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['636d4359-2071-4ce9-ada1-6664001e1cc6'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-45455902', 'ctest-vn1-53925033'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-45455902', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '201.129.253.0/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-06-03 18:55:01,010 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '4b611c2f-aff3-4cc1-966f-cbbab36f4542', 'name': 'ctest-vn2-42987706', 'tenant_id': '2b6ff4e195c0433f9f9e4bc1ef0f5eb1', 'project_id': '2b6ff4e195c0433f9f9e4bc1ef0f5eb1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['e8a11a64-d4c2-48d6-9769-2d9a480e8d39'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-45455902', 'ctest-vn2-42987706'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-45455902', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '146.173.73.192/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-06-03 18:55:01,105 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:55:01,111 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:55:01,124 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:55:01,220 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:55:01,243 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:55:01,257 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:55:01,270 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:55:01,303 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/439b045a-5f42-4582-bb7f-350ef23032f4 2026-06-03 18:55:01,323 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-03 18:55:01,323 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:55:01,340 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:55:01,366 - INFO - Verified VN network id 17 for VN 110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:55:01,366 - INFO - Verifications in API Server for VN ctest-vn1-53925033 passed 2026-06-03 18:55:01,366 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:55:01,378 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:55:01,403 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:55:01,440 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/439b045a-5f42-4582-bb7f-350ef23032f4 2026-06-03 18:55:01,475 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1229310523073709969', 'uuid-lslong': '11936285165268920424'}, 'enable': 'true', 'created': '2026-06-03T18:53:29', 'last-modified': '2026-06-03T18:55:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.712817'} 2026-06-03 18:55:01,491 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-03 18:55:01,498 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1229310523073709969', 'uuid-lslong': '11936285165268920424'}, 'enable': 'true', 'created': '2026-06-03T18:53:29', 'last-modified': '2026-06-03T18:55:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.736010'} 2026-06-03 18:55:01,506 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-03 18:55:01,513 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1229310523073709969', 'uuid-lslong': '11936285165268920424'}, 'enable': 'true', 'created': '2026-06-03T18:53:29', 'last-modified': '2026-06-03T18:55:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.756667'} 2026-06-03 18:55:01,521 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-03 18:55:01,522 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-53925033 passed 2026-06-03 18:55:01,522 - DEBUG - ====Verifying policy data for ctest-vn1-53925033 in API_Server ====== 2026-06-03 18:55:01,522 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:55:01,538 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:55:01,553 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:55:01,662 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:55:01,675 - DEBUG - ==>Verifying data for policy with id: 962429b5-4836-4819-b232-8b9b8c0910a6, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-45455902', 'policy1'] 2026-06-03 18:55:01,675 - INFO - VN ctest-vn1-53925033 Policy verification: verify_vn_policy_in_api_server, status: True 2026-06-03 18:55:01,675 - DEBUG - Verifying the vn in opserver 2026-06-03 18:55:01,675 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 virtual network link through opserver 10.0.0.50 2026-06-03 18:55:01,675 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-03 18:55:01,690 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033?flat'} 2026-06-03 18:55:01,690 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 virtual network link through opserver 10.0.0.33 2026-06-03 18:55:01,690 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks 2026-06-03 18:55:01,706 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033?flat'} 2026-06-03 18:55:01,706 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 virtual network link through opserver 10.0.0.249 2026-06-03 18:55:01,706 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-06-03 18:55:01,721 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033?flat'} 2026-06-03 18:55:01,721 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 is found in opserver 2026-06-03 18:55:01,734 - DEBUG - VRF ids for VN ctest-vn1-53925033: {'10.0.0.22': '5'} 2026-06-03 18:55:01,734 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:55:01,741 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:55:01,753 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:55:01,878 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:55:01,897 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:55:01,911 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/27366166-d608-4b0d-9103-6e62f6b48b29 2026-06-03 18:55:01,925 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/27366166-d608-4b0d-9103-6e62f6b48b29 2026-06-03 18:55:01,935 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/52313a3e-6484-480a-b82d-92d15227f3d8 2026-06-03 18:55:01,944 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-03 18:55:01,944 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:55:01,957 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/27366166-d608-4b0d-9103-6e62f6b48b29 2026-06-03 18:55:01,978 - INFO - Verified VN network id 18 for VN 4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:55:01,978 - INFO - Verifications in API Server for VN ctest-vn2-42987706 passed 2026-06-03 18:55:01,978 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:55:01,991 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/27366166-d608-4b0d-9103-6e62f6b48b29 2026-06-03 18:55:02,001 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/27366166-d608-4b0d-9103-6e62f6b48b29 2026-06-03 18:55:02,014 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/52313a3e-6484-480a-b82d-92d15227f3d8 2026-06-03 18:55:02,030 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'interests': '0-1', 'advertised': '0-1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5431653616726527169', 'uuid-lslong': '10840106830838842690'}, 'enable': 'true', 'created': '2026-06-03T18:54:08', 'last-modified': '2026-06-03T18:55:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.055771'} 2026-06-03 18:55:02,040 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-03 18:55:02,049 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5431653616726527169', 'uuid-lslong': '10840106830838842690'}, 'enable': 'true', 'created': '2026-06-03T18:54:08', 'last-modified': '2026-06-03T18:55:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.080803'} 2026-06-03 18:55:02,057 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-03 18:55:02,063 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5431653616726527169', 'uuid-lslong': '10840106830838842690'}, 'enable': 'true', 'created': '2026-06-03T18:54:08', 'last-modified': '2026-06-03T18:55:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.089621'} 2026-06-03 18:55:02,071 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-03 18:55:02,071 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-42987706 passed 2026-06-03 18:55:02,072 - DEBUG - ====Verifying policy data for ctest-vn2-42987706 in API_Server ====== 2026-06-03 18:55:02,072 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:55:02,079 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:55:02,091 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:55:02,197 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:55:02,212 - DEBUG - ==>Verifying data for policy with id: 962429b5-4836-4819-b232-8b9b8c0910a6, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-45455902', 'policy1'] 2026-06-03 18:55:02,212 - INFO - VN ctest-vn2-42987706 Policy verification: verify_vn_policy_in_api_server, status: True 2026-06-03 18:55:02,212 - DEBUG - Verifying the vn in opserver 2026-06-03 18:55:02,213 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706 virtual network link through opserver 10.0.0.50 2026-06-03 18:55:02,213 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-03 18:55:02,233 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706?flat'} 2026-06-03 18:55:02,233 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706 virtual network link through opserver 10.0.0.33 2026-06-03 18:55:02,233 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks 2026-06-03 18:55:02,252 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706?flat'} 2026-06-03 18:55:02,252 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706 virtual network link through opserver 10.0.0.249 2026-06-03 18:55:02,252 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-06-03 18:55:02,270 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706?flat'} 2026-06-03 18:55:02,270 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706 is found in opserver 2026-06-03 18:55:02,286 - DEBUG - VRF ids for VN ctest-vn2-42987706: {'10.0.0.22': '6', '10.0.0.19': '5'} 2026-06-03 18:55:02,286 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:55:02,295 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:55:02,311 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:55:02,422 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:55:02,436 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:55:02,453 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:55:02,467 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:55:02,478 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/439b045a-5f42-4582-bb7f-350ef23032f4 2026-06-03 18:55:02,487 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-03 18:55:02,487 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:55:02,501 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:55:02,524 - INFO - Verified VN network id 17 for VN 110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:55:02,524 - INFO - Verifications in API Server for VN ctest-vn1-53925033 passed 2026-06-03 18:55:02,524 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:55:02,539 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:55:02,549 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:55:02,559 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/439b045a-5f42-4582-bb7f-350ef23032f4 2026-06-03 18:55:02,578 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1229310523073709969', 'uuid-lslong': '11936285165268920424'}, 'enable': 'true', 'created': '2026-06-03T18:53:29', 'last-modified': '2026-06-03T18:55:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.818677'} 2026-06-03 18:55:02,587 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-03 18:55:02,596 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1229310523073709969', 'uuid-lslong': '11936285165268920424'}, 'enable': 'true', 'created': '2026-06-03T18:53:29', 'last-modified': '2026-06-03T18:55:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.833184'} 2026-06-03 18:55:02,605 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-03 18:55:02,612 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1229310523073709969', 'uuid-lslong': '11936285165268920424'}, 'enable': 'true', 'created': '2026-06-03T18:53:29', 'last-modified': '2026-06-03T18:55:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.855013'} 2026-06-03 18:55:02,620 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-03 18:55:02,620 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-53925033 passed 2026-06-03 18:55:02,620 - DEBUG - ====Verifying policy data for ctest-vn1-53925033 in API_Server ====== 2026-06-03 18:55:02,620 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:55:02,628 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:55:02,645 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:55:02,756 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/110f6368-5675-4791-a5a6-341ddd9e6868 2026-06-03 18:55:02,769 - DEBUG - ==>Verifying data for policy with id: 962429b5-4836-4819-b232-8b9b8c0910a6, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-45455902', 'policy1'] 2026-06-03 18:55:02,769 - INFO - VN ctest-vn1-53925033 Policy verification: verify_vn_policy_in_api_server, status: True 2026-06-03 18:55:02,769 - DEBUG - Verifying the vn in opserver 2026-06-03 18:55:02,769 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 virtual network link through opserver 10.0.0.50 2026-06-03 18:55:02,770 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-03 18:55:02,785 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033?flat'} 2026-06-03 18:55:02,785 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 virtual network link through opserver 10.0.0.33 2026-06-03 18:55:02,785 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks 2026-06-03 18:55:02,801 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033?flat'} 2026-06-03 18:55:02,801 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 virtual network link through opserver 10.0.0.249 2026-06-03 18:55:02,801 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-06-03 18:55:02,816 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033?flat'} 2026-06-03 18:55:02,816 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 is found in opserver 2026-06-03 18:55:02,830 - DEBUG - VRF ids for VN ctest-vn1-53925033: {'10.0.0.22': '5'} 2026-06-03 18:55:02,830 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:55:02,837 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:55:02,850 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:55:02,953 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:55:02,964 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:55:02,976 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/27366166-d608-4b0d-9103-6e62f6b48b29 2026-06-03 18:55:02,985 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/27366166-d608-4b0d-9103-6e62f6b48b29 2026-06-03 18:55:02,995 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/52313a3e-6484-480a-b82d-92d15227f3d8 2026-06-03 18:55:03,004 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-03 18:55:03,004 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:55:03,015 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/27366166-d608-4b0d-9103-6e62f6b48b29 2026-06-03 18:55:03,032 - INFO - Verified VN network id 18 for VN 4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:55:03,032 - INFO - Verifications in API Server for VN ctest-vn2-42987706 passed 2026-06-03 18:55:03,033 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:55:03,043 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/27366166-d608-4b0d-9103-6e62f6b48b29 2026-06-03 18:55:03,053 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/27366166-d608-4b0d-9103-6e62f6b48b29 2026-06-03 18:55:03,061 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/52313a3e-6484-480a-b82d-92d15227f3d8 2026-06-03 18:55:03,074 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'interests': '0-1', 'advertised': '0-1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5431653616726527169', 'uuid-lslong': '10840106830838842690'}, 'enable': 'true', 'created': '2026-06-03T18:54:08', 'last-modified': '2026-06-03T18:55:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.100445'} 2026-06-03 18:55:03,081 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-03 18:55:03,088 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5431653616726527169', 'uuid-lslong': '10840106830838842690'}, 'enable': 'true', 'created': '2026-06-03T18:54:08', 'last-modified': '2026-06-03T18:55:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.119763'} 2026-06-03 18:55:03,095 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-03 18:55:03,101 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5431653616726527169', 'uuid-lslong': '10840106830838842690'}, 'enable': 'true', 'created': '2026-06-03T18:54:08', 'last-modified': '2026-06-03T18:55:00', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.126964'} 2026-06-03 18:55:03,109 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-03 18:55:03,109 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-42987706 passed 2026-06-03 18:55:03,109 - DEBUG - ====Verifying policy data for ctest-vn2-42987706 in API_Server ====== 2026-06-03 18:55:03,109 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:55:03,116 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:55:03,129 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:55:03,224 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/4b611c2f-aff3-4cc1-966f-cbbab36f4542 2026-06-03 18:55:03,236 - DEBUG - ==>Verifying data for policy with id: 962429b5-4836-4819-b232-8b9b8c0910a6, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-45455902', 'policy1'] 2026-06-03 18:55:03,236 - INFO - VN ctest-vn2-42987706 Policy verification: verify_vn_policy_in_api_server, status: True 2026-06-03 18:55:03,236 - DEBUG - Verifying the vn in opserver 2026-06-03 18:55:03,237 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706 virtual network link through opserver 10.0.0.50 2026-06-03 18:55:03,238 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-03 18:55:03,254 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706?flat'} 2026-06-03 18:55:03,254 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706 virtual network link through opserver 10.0.0.33 2026-06-03 18:55:03,254 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks 2026-06-03 18:55:03,270 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706?flat'} 2026-06-03 18:55:03,270 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706 virtual network link through opserver 10.0.0.249 2026-06-03 18:55:03,270 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-06-03 18:55:03,290 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706?flat'} 2026-06-03 18:55:03,290 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706 is found in opserver 2026-06-03 18:55:03,308 - DEBUG - VRF ids for VN ctest-vn2-42987706: {'10.0.0.22': '6', '10.0.0.19': '5'} 2026-06-03 18:55:03,308 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:55:03,318 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:55:03,336 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:55:03,440 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/49c8fcff-edea-452b-948f-bdf074c4e559 2026-06-03 18:55:03,452 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/49c8fcff-edea-452b-948f-bdf074c4e559 2026-06-03 18:55:03,463 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/b239e00e-0089-4513-aa23-f3f2bcae959c 2026-06-03 18:55:03,473 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/b239e00e-0089-4513-aa23-f3f2bcae959c 2026-06-03 18:55:03,491 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/f65a2e91-2acd-4fae-b13a-1330a69ba959 2026-06-03 18:55:03,503 - DEBUG - Route Targets: ['target:64512:8000010'] 2026-06-03 18:55:03,504 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/49c8fcff-edea-452b-948f-bdf074c4e559 2026-06-03 18:55:03,515 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/b239e00e-0089-4513-aa23-f3f2bcae959c 2026-06-03 18:55:03,536 - INFO - Verified VN network id 19 for VN 49c8fcff-edea-452b-948f-bdf074c4e559 2026-06-03 18:55:03,537 - INFO - Verifications in API Server for VN ctest-fip_vn-36414688 passed 2026-06-03 18:55:03,537 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/49c8fcff-edea-452b-948f-bdf074c4e559 2026-06-03 18:55:03,551 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/b239e00e-0089-4513-aa23-f3f2bcae959c 2026-06-03 18:55:03,562 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/b239e00e-0089-4513-aa23-f3f2bcae959c 2026-06-03 18:55:03,572 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/f65a2e91-2acd-4fae-b13a-1330a69ba959 2026-06-03 18:55:03,589 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5316777536249283883', 'uuid-lslong': '10704983679731819865'}, 'enable': 'true', 'created': '2026-06-03T18:54:08', 'last-modified': '2026-06-03T18:54:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:54.593103'} 2026-06-03 18:55:03,595 - DEBUG - Route Targets: ['target:64512:8000010'] 2026-06-03 18:55:03,602 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5316777536249283883', 'uuid-lslong': '10704983679731819865'}, 'enable': 'true', 'created': '2026-06-03T18:54:08', 'last-modified': '2026-06-03T18:54:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:54.609223'} 2026-06-03 18:55:03,608 - DEBUG - Route Targets: ['target:64512:8000010'] 2026-06-03 18:55:03,614 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-45455902', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5316777536249283883', 'uuid-lslong': '10704983679731819865'}, 'enable': 'true', 'created': '2026-06-03T18:54:08', 'last-modified': '2026-06-03T18:54:08', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:54.622490'} 2026-06-03 18:55:03,621 - DEBUG - Route Targets: ['target:64512:8000010'] 2026-06-03 18:55:03,621 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-36414688 passed 2026-06-03 18:55:03,621 - DEBUG - ====Verifying policy data for ctest-fip_vn-36414688 in API_Server ====== 2026-06-03 18:55:03,621 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:55:03,628 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:55:03,640 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:55:03,758 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/49c8fcff-edea-452b-948f-bdf074c4e559 2026-06-03 18:55:03,772 - DEBUG - =>VN ctest-fip_vn-36414688 has no policy to be verified 2026-06-03 18:55:03,772 - DEBUG - Verifying the vn in opserver 2026-06-03 18:55:03,772 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688 virtual network link through opserver 10.0.0.50 2026-06-03 18:55:03,773 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-03 18:55:03,789 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688?flat'} 2026-06-03 18:55:03,789 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688 virtual network link through opserver 10.0.0.33 2026-06-03 18:55:03,789 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks 2026-06-03 18:55:03,804 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688?flat'} 2026-06-03 18:55:03,804 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688 virtual network link through opserver 10.0.0.249 2026-06-03 18:55:03,804 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-06-03 18:55:03,820 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688?flat'} 2026-06-03 18:55:03,820 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688 is found in opserver 2026-06-03 18:55:03,834 - DEBUG - VRF ids for VN ctest-fip_vn-36414688: {'10.0.0.19': '6'} 2026-06-03 18:55:03,834 - INFO - start time= 1780512903834442 2026-06-03 18:55:03,834 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 146.173.73.195, host_string: cirros@169.254.0.6, password: gocubsgogateway: ubuntu@10.0.0.22, gateway password: c0ntrail123 2026-06-03 18:55:03,834 - DEBUG - ping -s 56 -c 3 -W 1 146.173.73.195 2026-06-03 18:55:07,603 - DEBUG - PING 146.173.73.195 (146.173.73.195): 56 data bytes 64 bytes from 146.173.73.195: seq=0 ttl=63 time=5.401 ms 64 bytes from 146.173.73.195: seq=1 ttl=63 time=1.631 ms 64 bytes from 146.173.73.195: seq=2 ttl=63 time=1.460 ms --- 146.173.73.195 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.460/2.830/5.401 ms 2026-06-03 18:55:07,603 - INFO - Ping to IP 146.173.73.195 from VM ctest-vn1_vm1-29709616 passed 2026-06-03 18:55:17,604 - INFO - Verify session samples and teardown pkts 2026-06-03 18:55:17,604 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.50 2026-06-03 18:55:17,608 - DEBUG - Posting: http://10.0.0.50:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1780512903834442, 'end_time': 1780512917608554, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'} 2026-06-03 18:55:18,631 - DEBUG - [{'T': 1780512905982486}, {'T': 1780512906982575}, {'T': 1780512907982639}] 2026-06-03 18:55:18,631 - DEBUG - Posting: http://10.0.0.50:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1780512903834442, 'end_time': 1780512918631505, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'} 2026-06-03 18:55:19,653 - DEBUG - [{'T': 1780512905601178}, {'T': 1780512906601373}, {'T': 1780512907601434}] 2026-06-03 18:55:19,653 - DEBUG - Posting: http://10.0.0.50:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1780512903834442, 'end_time': 1780512919653756, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'} 2026-06-03 18:55:20,676 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', 'sample_count': 3}] 2026-06-03 18:55:20,677 - INFO - wait for the flows to get expire 2026-06-03 18:58:40,678 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5883-1:Compute:contrail-vrouter-agent:0?flat 2026-06-03 18:58:40,719 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5883-1?flat 2026-06-03 18:58:41,327 - INFO - Deleted policy policy1 2026-06-03 18:58:41,445 - INFO - Setting flow export rate: None 2026-06-03 18:58:42,738 - ERROR - AssertionError Python 3.9.25: /usr/bin/python3 Wed Jun 3 18:58:40 2026 A problem occurred in a Python script. Here is the sequence of function calls leading up to the error, in the order they occurred. /contrail-test/tcutils/wrappers.py in wrapper(self=, *args=(), **kwargs={}) 78 log.info('Initial checks done. Running the testcase now') 79 log.info('') 80 result = function(self, *args, **kwargs) 81 if self.inputs.upgrade: 82 pid = os.getpid() result = None function = self = args = () kwargs = {} /contrail-test/serial_scripts/analytics/test_analytics_resource.py in test_verify_session_sampling_teardown(self=) 1281 src_vn = self.res.vn1_fixture.vn_fq_name 1282 dst_vn = self.res.vn2_fixture.vn_fq_name 1283 result = self.verify_session_sampling_teardown(start_time, src_vn, dst_vn) 1284 1285 assert result,'Failed to get expected number of samples' result = True self = self.verify_session_sampling_teardown = > start_time = '1780512903834442' src_vn = 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033' dst_vn = 'default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706' /contrail-test/serial_scripts/analytics/base.py in verify_session_sampling_teardown(self=, start_time='1780512903834442', src_vn='default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033', dst_vn='default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706') 486 flow_record = self.analytics_obj.get_flows_vrouter_uve( 487 vrouter=vm_host) 488 assert not flow_record,'flows not got deleted even after 240 sec' 489 490 res = self.analytics_obj.ops_inspect[ip].post_query( flow_record = 24 AssertionError: flows not got deleted even after 240 sec __cause__ = None __class__ = __context__ = None __delattr__ = __dict__ = {} __dir__ = __doc__ = 'Assertion failed.' __eq__ = __format__ = __ge__ = __getattribute__ = __gt__ = __hash__ = __init__ = __init_subclass__ = __le__ = __lt__ = __ne__ = __new__ = __reduce__ = __reduce_ex__ = __repr__ = __setattr__ = __setstate__ = __sizeof__ = __str__ = __subclasshook__ = __suppress_context__ = False __traceback__ = args = ('flows not got deleted even after 240 sec',) with_traceback = The above is a description of an error in a Python program. Here is the original traceback: Traceback (most recent call last): File "/contrail-test/tcutils/wrappers.py", line 80, in wrapper result = function(self, *args, **kwargs) File "/contrail-test/serial_scripts/analytics/test_analytics_resource.py", line 1283, in test_verify_session_sampling_teardown result = self.verify_session_sampling_teardown(start_time, src_vn, dst_vn) File "/contrail-test/serial_scripts/analytics/base.py", line 488, in verify_session_sampling_teardown assert not flow_record,'flows not got deleted even after 240 sec' AssertionError: flows not got deleted even after 240 sec 2026-06-03 18:58:42,739 - DEBUG - Skipping xmpp flap check 2026-06-03 18:58:42,739 - INFO -

2026-06-03 18:58:42,739 - INFO - END TEST : test_verify_session_sampling_teardown : FAILED[0:03:44]

2026-06-03 18:58:42,739 - INFO - -------------------------------------------------------------------------------- 2026-06-03 18:58:42,741 - INFO - Deleting VM mltf_vm 2026-06-03 18:58:42,847 - INFO - Deleting VM ctest-fvn_vm1-87357366 2026-06-03 18:58:42,933 - INFO - Deleting VM ctest-vn2_vm2-77854045 2026-06-03 18:58:43,022 - INFO - Deleting VN ctest-fip_vn-36414688 2026-06-03 18:58:43,065 - DEBUG - VN 49c8fcff-edea-452b-948f-bdf074c4e559 still in use: Unable to complete operation on network 49c8fcff-edea-452b-948f-bdf074c4e559. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-06f4ed4f-7566-4d34-a4f2-b78c6c955c66'] 2026-06-03 18:58:43,065 - WARNING - Deleting VN ctest-fip_vn-36414688 failed..Will retry 2026-06-03 18:58:45,359 - DEBUG - Response for deleting network () 2026-06-03 18:58:45,359 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/b239e00e-0089-4513-aa23-f3f2bcae959c 2026-06-03 18:58:45,415 - DEBUG - Response Code: 404 2026-06-03 18:58:45,415 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:58:45,423 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:58:45,436 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:58:45,567 - INFO - Validated that VN ctest-fip_vn-36414688 is not found in API Server 2026-06-03 18:58:45,577 - DEBUG - VN ctest-fip_vn-36414688 is not present in Agent 10.0.0.22 2026-06-03 18:58:45,591 - DEBUG - VN ctest-fip_vn-36414688 is not present in Agent 10.0.0.19 2026-06-03 18:58:45,591 - INFO - Validated that VN ctest-fip_vn-36414688 is not in any agent 2026-06-03 18:58:45,597 - DEBUG - VRF 6 is not seen in agent 10.0.0.19 2026-06-03 18:58:45,602 - DEBUG - Vrouter 10.0.0.19 does not have vrf 6 for VN ctest-fip_vn-36414688 2026-06-03 18:58:45,603 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-fip_vn-36414688 2026-06-03 18:58:45,630 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-36414688 info 2026-06-03 18:58:45,630 - INFO - Deleting VN ctest-vn2-42987706 2026-06-03 18:58:45,900 - DEBUG - Response for deleting network () 2026-06-03 18:58:45,900 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/27366166-d608-4b0d-9103-6e62f6b48b29 2026-06-03 18:58:45,908 - DEBUG - Response Code: 404 2026-06-03 18:58:45,908 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:58:45,916 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:58:45,937 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:58:46,078 - INFO - Validated that VN ctest-vn2-42987706 is not found in API Server 2026-06-03 18:58:46,092 - DEBUG - VN ctest-vn2-42987706 is not present in Agent 10.0.0.22 2026-06-03 18:58:46,107 - DEBUG - VN ctest-vn2-42987706 is not present in Agent 10.0.0.19 2026-06-03 18:58:46,107 - INFO - Validated that VN ctest-vn2-42987706 is not in any agent 2026-06-03 18:58:46,116 - DEBUG - VRF 6 is not seen in agent 10.0.0.22 2026-06-03 18:58:46,123 - DEBUG - Vrouter 10.0.0.22 does not have vrf 6 for VN ctest-vn2-42987706 2026-06-03 18:58:46,130 - DEBUG - VRF 5 is not seen in agent 10.0.0.19 2026-06-03 18:58:46,136 - DEBUG - Vrouter 10.0.0.19 does not have vrf 5 for VN ctest-vn2-42987706 2026-06-03 18:58:46,136 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn2-42987706 2026-06-03 18:58:46,162 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-42987706 info 2026-06-03 18:58:46,162 - INFO - Deleting VM ctest-vn1_vm2-58079454 2026-06-03 18:58:46,258 - INFO - Deleting VM ctest-vn1_vm1-29709616 2026-06-03 18:58:46,355 - INFO - Deleting VN ctest-vn1-53925033 2026-06-03 18:58:46,413 - DEBUG - VN 110f6368-5675-4791-a5a6-341ddd9e6868 still in use: Unable to complete operation on network 110f6368-5675-4791-a5a6-341ddd9e6868. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-f799137a-9f7e-4355-81fe-84cc0c8a61cc'] 2026-06-03 18:58:46,414 - WARNING - Deleting VN ctest-vn1-53925033 failed..Will retry 2026-06-03 18:58:48,676 - DEBUG - Response for deleting network () 2026-06-03 18:58:48,676 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/6bdda923-8063-498f-8ce4-12a89f6b65a6 2026-06-03 18:58:48,684 - DEBUG - Response Code: 404 2026-06-03 18:58:48,684 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-03 18:58:48,692 - DEBUG - Requesting: http://10.0.0.50:8082/domain/cfce58c2-bdea-4e41-80d8-e31e3dad5e9f 2026-06-03 18:58:48,748 - DEBUG - Requesting: http://10.0.0.50:8082/project/2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1 2026-06-03 18:58:48,857 - INFO - Validated that VN ctest-vn1-53925033 is not found in API Server 2026-06-03 18:58:48,869 - DEBUG - VN ctest-vn1-53925033 is not present in Agent 10.0.0.22 2026-06-03 18:58:48,882 - DEBUG - VN ctest-vn1-53925033 is not present in Agent 10.0.0.19 2026-06-03 18:58:48,882 - INFO - Validated that VN ctest-vn1-53925033 is not in any agent 2026-06-03 18:58:48,889 - DEBUG - VRF 5 is not seen in agent 10.0.0.22 2026-06-03 18:58:48,895 - DEBUG - Vrouter 10.0.0.22 does not have vrf 5 for VN ctest-vn1-53925033 2026-06-03 18:58:48,895 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-45455902:ctest-vn1-53925033 2026-06-03 18:58:48,921 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-53925033 info 2026-06-03 18:58:49,890 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-45455902, ID : 2b6ff4e1-95c0-433f-9f9e-4bc1ef0f5eb1