2026-06-04 19:53:41,819 - INFO - Domain Default found not creating 2026-06-04 19:53:41,980 - INFO - Project ctest-AnalyticsTestSanityWithResource-46681100 not found, creating it 2026-06-04 19:53:42,529 - INFO - Created Project:ctest-AnalyticsTestSanityWithResource-46681100, ID : 9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:53:44,854 - DEBUG - Response for create_network : {'network': {'id': '3a18a2f0-61e0-4f5d-af5e-2777fabf2868', 'name': 'ctest-vn1-56786224', 'tenant_id': '9e9cba66aa0a44f98b338cb00526a2ab', 'project_id': '9e9cba66aa0a44f98b338cb00526a2ab', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-46681100', 'ctest-vn1-56786224'], 'port_security_enabled': True, 'description': ''}} 2026-06-04 19:53:45,213 - DEBUG - Response for create_subnet : {'subnet': {'id': '655ef866-232d-459d-9dea-d10f110ed2b8', 'name': '', 'tenant_id': '9e9cba66aa0a44f98b338cb00526a2ab', 'network_id': '3a18a2f0-61e0-4f5d-af5e-2777fabf2868', 'ip_version': 4, 'cidr': '8.28.133.192/26', 'allocation_pools': [{'start': '8.28.133.194', 'end': '8.28.133.254'}], 'gateway_ip': '8.28.133.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '8.28.133.194', 'tags': [], 'project_id': '9e9cba66aa0a44f98b338cb00526a2ab'}} 2026-06-04 19:53:45,242 - INFO - Created VN ctest-vn1-56786224 2026-06-04 19:53:45,256 - DEBUG - VN ctest-vn1-56786224 UUID is 3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:53:45,349 - DEBUG - Services list from nova: [, , , ] 2026-06-04 19:53:45,349 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5893-2', 'an-jenkins-deploy-platform-ansible-os-5893-1']} 2026-06-04 19:53:46,902 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-2) 2026-06-04 19:53:48,403 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-2) 2026-06-04 19:53:48,403 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:53:48,728 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:53:48,770 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:53:48,789 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:53:48,922 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:53:48,947 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:53:48,963 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:53:48,973 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:53:48,982 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/8a8fae31-a658-432c-9b3b-3baa48ae614c 2026-06-04 19:53:48,990 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-04 19:53:48,990 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:53:49,001 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:53:49,018 - INFO - Verified VN network id 16 for VN 3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:53:49,018 - INFO - Verifications in API Server for VN ctest-vn1-56786224 passed 2026-06-04 19:53:49,018 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:53:49,039 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:53:49,062 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:53:49,074 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/8a8fae31-a658-432c-9b3b-3baa48ae614c 2026-06-04 19:53:49,099 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4186275006958817117', 'uuid-lslong': '12636581000709613672'}, 'enable': 'true', 'created': '2026-06-04T19:53:44', 'last-modified': '2026-06-04T19:53:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.976128'} 2026-06-04 19:53:49,112 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-04 19:53:49,119 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4186275006958817117', 'uuid-lslong': '12636581000709613672'}, 'enable': 'true', 'created': '2026-06-04T19:53:44', 'last-modified': '2026-06-04T19:53:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.980077'} 2026-06-04 19:53:49,125 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-04 19:53:49,132 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4186275006958817117', 'uuid-lslong': '12636581000709613672'}, 'enable': 'true', 'created': '2026-06-04T19:53:44', 'last-modified': '2026-06-04T19:53:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:04.010298'} 2026-06-04 19:53:49,140 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-04 19:53:49,140 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-56786224 passed 2026-06-04 19:53:49,141 - DEBUG - ====Verifying policy data for ctest-vn1-56786224 in API_Server ====== 2026-06-04 19:53:49,141 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:53:49,157 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:53:49,183 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:53:49,282 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:53:49,304 - DEBUG - =>VN ctest-vn1-56786224 has no policy to be verified 2026-06-04 19:53:49,304 - DEBUG - Verifying the vn in opserver 2026-06-04 19:53:49,304 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 virtual network link through opserver 10.0.0.50 2026-06-04 19:53:49,304 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-04 19:53:49,688 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-04 19:53:49,754 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224?flat'} 2026-06-04 19:53:49,754 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 virtual network link through opserver 10.0.0.129 2026-06-04 19:53:49,754 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-06-04 19:53:50,060 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-06-04 19:53:50,135 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224?flat'} 2026-06-04 19:53:50,135 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 virtual network link through opserver 10.0.0.241 2026-06-04 19:53:50,136 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks 2026-06-04 19:53:50,444 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks 2026-06-04 19:53:50,512 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224?flat'} 2026-06-04 19:53:50,512 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 is found in opserver 2026-06-04 19:53:50,523 - DEBUG - VRF ids for VN ctest-vn1-56786224: {'10.0.0.41': '5'} 2026-06-04 19:53:50,524 - INFO - Waiting for VM ctest-vn1_vm1-53577791 to be up.. 2026-06-04 19:53:50,609 - DEBUG - VM is in ACTIVE state now 2026-06-04 19:53:50,609 - INFO - VM name : ctest-vn1_vm1-53577791 2026-06-04 19:53:50,692 - DEBUG - VM ctest-vn1_vm1-53577791 ID is 855b79fa-fa0a-40a9-ab83-1d84229760f2 2026-06-04 19:53:50,721 - DEBUG - VM ctest-vn1_vm1-53577791 launched on Node an-jenkins-deploy-platform-ansible-os-5893-2 2026-06-04 19:53:50,805 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine/855b79fa-fa0a-40a9-ab83-1d84229760f2 2026-06-04 19:53:51,105 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine/855b79fa-fa0a-40a9-ab83-1d84229760f2 2026-06-04 19:53:51,142 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine-interface/4757e1f3-cbb8-4c2a-9c23-0a3c6481e8b1 2026-06-04 19:53:54,328 - 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-04 19:53:54,328 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-vn1_vm1-53577791 failed! 2026-06-04 19:53:54,342 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 is 8.28.133.193 and allocation pool is NOT set 2026-06-04 19:53:58,429 - 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 1018ms') 2026-06-04 19:53:58,429 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-vn1_vm1-53577791 failed! 2026-06-04 19:53:58,443 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 is 8.28.133.193 and allocation pool is NOT set 2026-06-04 19:54:02,526 - 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 1018ms') 2026-06-04 19:54:02,526 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-vn1_vm1-53577791 failed! 2026-06-04 19:54:02,544 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 is 8.28.133.193 and allocation pool is NOT set 2026-06-04 19:54:06,621 - 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 1016ms') 2026-06-04 19:54:06,621 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-vn1_vm1-53577791 failed! 2026-06-04 19:54:06,638 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 is 8.28.133.193 and allocation pool is NOT set 2026-06-04 19:54:08,700 - 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=5.49 ms\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=4.67 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 = 4.669/5.078/5.488/0.409 ms') 2026-06-04 19:54:08,700 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-vn1_vm1-53577791 passed 2026-06-04 19:54:08,770 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-04 19:54:08,770 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-53577791, IP 8.28.133.195, Port 22 2026-06-04 19:54:08,828 - 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-04 19:54:08,924 - DEBUG - VM ctest-vn1_vm1-53577791 is NOT ready for SSH connections, VM status: ACTIVE 2026-06-04 19:54:13,925 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-04 19:54:13,926 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-53577791, IP 8.28.133.195, Port 22 2026-06-04 19:54:14,088 - DEBUG - VM ctest-vn1_vm1-53577791 is ready for SSH connections 2026-06-04 19:54:14,088 - INFO - Waiting for VM ctest-vn1_vm2-38381655 to be up.. 2026-06-04 19:54:14,170 - DEBUG - VM is in ACTIVE state now 2026-06-04 19:54:14,170 - INFO - VM name : ctest-vn1_vm2-38381655 2026-06-04 19:54:14,254 - DEBUG - VM ctest-vn1_vm2-38381655 ID is f2e0548c-c9f0-4858-8df6-8c8c33f86ef5 2026-06-04 19:54:14,254 - DEBUG - VM ctest-vn1_vm2-38381655 launched on Node an-jenkins-deploy-platform-ansible-os-5893-2 2026-06-04 19:54:14,342 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine/f2e0548c-c9f0-4858-8df6-8c8c33f86ef5 2026-06-04 19:54:14,351 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine-interface/b472ac58-2bca-49c5-ad4e-7c18a8b7668b 2026-06-04 19:54:15,505 - 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=3.52 ms\r\n64 bytes from 169.254.0.7: icmp_seq=2 ttl=63 time=3.37 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 = 3.367/3.441/3.516/0.074 ms') 2026-06-04 19:54:15,505 - INFO - Ping to Metadata IP 169.254.0.7 of VM ctest-vn1_vm2-38381655 passed 2026-06-04 19:54:15,574 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-04 19:54:15,574 - DEBUG - Waiting to SSH to VM ctest-vn1_vm2-38381655, IP 8.28.133.196, Port 22 2026-06-04 19:54:15,642 - 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-04 19:54:15,724 - DEBUG - VM ctest-vn1_vm2-38381655 is NOT ready for SSH connections, VM status: ACTIVE 2026-06-04 19:54:20,725 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-04 19:54:20,725 - DEBUG - Waiting to SSH to VM ctest-vn1_vm2-38381655, IP 8.28.133.196, Port 22 2026-06-04 19:54:20,784 - 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-04 19:54:20,865 - DEBUG - VM ctest-vn1_vm2-38381655 is NOT ready for SSH connections, VM status: ACTIVE 2026-06-04 19:54:25,866 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-04 19:54:25,866 - DEBUG - Waiting to SSH to VM ctest-vn1_vm2-38381655, IP 8.28.133.196, Port 22 2026-06-04 19:54:26,020 - DEBUG - VM ctest-vn1_vm2-38381655 is ready for SSH connections 2026-06-04 19:54:26,359 - DEBUG - Response for create_network : {'network': {'id': '9ef4d19a-908a-4b6e-ad53-ceeb33851088', 'name': 'ctest-vn2-56278916', 'tenant_id': '9e9cba66aa0a44f98b338cb00526a2ab', 'project_id': '9e9cba66aa0a44f98b338cb00526a2ab', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-46681100', 'ctest-vn2-56278916'], 'port_security_enabled': True, 'description': ''}} 2026-06-04 19:54:26,547 - DEBUG - Response for create_subnet : {'subnet': {'id': 'af477ac6-aa60-471d-9371-a11bc898a5d2', 'name': '', 'tenant_id': '9e9cba66aa0a44f98b338cb00526a2ab', 'network_id': '9ef4d19a-908a-4b6e-ad53-ceeb33851088', 'ip_version': 4, 'cidr': '13.53.235.64/26', 'allocation_pools': [{'start': '13.53.235.66', 'end': '13.53.235.126'}], 'gateway_ip': '13.53.235.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '13.53.235.66', 'tags': [], 'project_id': '9e9cba66aa0a44f98b338cb00526a2ab'}} 2026-06-04 19:54:26,573 - INFO - Created VN ctest-vn2-56278916 2026-06-04 19:54:26,584 - DEBUG - VN ctest-vn2-56278916 UUID is 9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:54:26,911 - DEBUG - Response for create_network : {'network': {'id': 'b8e28bf5-a7d6-4ae6-9678-c14aec720b5c', 'name': 'ctest-fip_vn-72425039', 'tenant_id': '9e9cba66aa0a44f98b338cb00526a2ab', 'project_id': '9e9cba66aa0a44f98b338cb00526a2ab', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-46681100', 'ctest-fip_vn-72425039'], 'port_security_enabled': True, 'description': ''}} 2026-06-04 19:54:27,135 - DEBUG - Response for create_subnet : {'subnet': {'id': '98916ee5-e132-4b5a-bc91-fb99357cc04f', 'name': '', 'tenant_id': '9e9cba66aa0a44f98b338cb00526a2ab', 'network_id': 'b8e28bf5-a7d6-4ae6-9678-c14aec720b5c', 'ip_version': 4, 'cidr': '7.141.31.192/26', 'allocation_pools': [{'start': '7.141.31.194', 'end': '7.141.31.254'}], 'gateway_ip': '7.141.31.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '7.141.31.194', 'tags': [], 'project_id': '9e9cba66aa0a44f98b338cb00526a2ab'}} 2026-06-04 19:54:27,160 - INFO - Created VN ctest-fip_vn-72425039 2026-06-04 19:54:27,178 - DEBUG - VN ctest-fip_vn-72425039 UUID is b8e28bf5-a7d6-4ae6-9678-c14aec720b5c 2026-06-04 19:54:27,256 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5893-2', 'an-jenkins-deploy-platform-ansible-os-5893-1']} 2026-06-04 19:54:28,678 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-1) 2026-06-04 19:54:30,234 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-1) 2026-06-04 19:54:32,059 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5893-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5893-2) 2026-06-04 19:54:32,059 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:54:32,070 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:54:32,088 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:54:32,203 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:54:32,224 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:54:32,235 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:54:32,247 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:54:32,255 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/8a8fae31-a658-432c-9b3b-3baa48ae614c 2026-06-04 19:54:32,263 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-04 19:54:32,263 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:54:32,276 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:54:32,296 - INFO - Verified VN network id 16 for VN 3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:54:32,296 - INFO - Verifications in API Server for VN ctest-vn1-56786224 passed 2026-06-04 19:54:32,296 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:54:32,306 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:54:32,316 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:54:32,323 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/8a8fae31-a658-432c-9b3b-3baa48ae614c 2026-06-04 19:54:32,340 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4186275006958817117', 'uuid-lslong': '12636581000709613672'}, 'enable': 'true', 'created': '2026-06-04T19:53:44', 'last-modified': '2026-06-04T19:53:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:47.217360'} 2026-06-04 19:54:32,346 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-04 19:54:32,351 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4186275006958817117', 'uuid-lslong': '12636581000709613672'}, 'enable': 'true', 'created': '2026-06-04T19:53:44', 'last-modified': '2026-06-04T19:53:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:47.213069'} 2026-06-04 19:54:32,357 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-04 19:54:32,364 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4186275006958817117', 'uuid-lslong': '12636581000709613672'}, 'enable': 'true', 'created': '2026-06-04T19:53:44', 'last-modified': '2026-06-04T19:53:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:47.242287'} 2026-06-04 19:54:32,369 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-04 19:54:32,369 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-56786224 passed 2026-06-04 19:54:32,370 - DEBUG - ====Verifying policy data for ctest-vn1-56786224 in API_Server ====== 2026-06-04 19:54:32,370 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:54:32,376 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:54:32,389 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:54:32,557 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:54:32,577 - DEBUG - =>VN ctest-vn1-56786224 has no policy to be verified 2026-06-04 19:54:32,577 - DEBUG - Verifying the vn in opserver 2026-06-04 19:54:32,577 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 virtual network link through opserver 10.0.0.50 2026-06-04 19:54:32,577 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-04 19:54:32,677 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224?flat'} 2026-06-04 19:54:32,678 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 virtual network link through opserver 10.0.0.129 2026-06-04 19:54:32,678 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-06-04 19:54:32,811 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224?flat'} 2026-06-04 19:54:32,811 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 virtual network link through opserver 10.0.0.241 2026-06-04 19:54:32,811 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks 2026-06-04 19:54:32,871 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224?flat'} 2026-06-04 19:54:32,871 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 is found in opserver 2026-06-04 19:54:32,898 - DEBUG - VRF ids for VN ctest-vn1-56786224: {'10.0.0.41': '5'} 2026-06-04 19:54:32,898 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:54:32,910 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:54:32,923 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:54:33,055 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:54:33,073 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:54:33,097 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/e23cb8fc-0846-4e76-907c-2ca1eb010979 2026-06-04 19:54:33,107 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/e23cb8fc-0846-4e76-907c-2ca1eb010979 2026-06-04 19:54:33,118 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/aa7e14b5-e841-4447-85f9-8314bb35b91d 2026-06-04 19:54:33,124 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-04 19:54:33,124 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:54:33,133 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/e23cb8fc-0846-4e76-907c-2ca1eb010979 2026-06-04 19:54:33,148 - INFO - Verified VN network id 17 for VN 9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:54:33,149 - INFO - Verifications in API Server for VN ctest-vn2-56278916 passed 2026-06-04 19:54:33,149 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:54:33,159 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/e23cb8fc-0846-4e76-907c-2ca1eb010979 2026-06-04 19:54:33,168 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/e23cb8fc-0846-4e76-907c-2ca1eb010979 2026-06-04 19:54:33,203 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/aa7e14b5-e841-4447-85f9-8314bb35b91d 2026-06-04 19:54:33,229 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11454010214090165102', 'uuid-lslong': '12489553701205512328'}, 'enable': 'true', 'created': '2026-06-04T19:54:26', 'last-modified': '2026-06-04T19:54:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.724302'} 2026-06-04 19:54:33,236 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-04 19:54:33,242 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11454010214090165102', 'uuid-lslong': '12489553701205512328'}, 'enable': 'true', 'created': '2026-06-04T19:54:26', 'last-modified': '2026-06-04T19:54:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.736510'} 2026-06-04 19:54:33,249 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-04 19:54:33,257 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11454010214090165102', 'uuid-lslong': '12489553701205512328'}, 'enable': 'true', 'created': '2026-06-04T19:54:26', 'last-modified': '2026-06-04T19:54:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.755505'} 2026-06-04 19:54:33,263 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-04 19:54:33,263 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-56278916 passed 2026-06-04 19:54:33,263 - DEBUG - ====Verifying policy data for ctest-vn2-56278916 in API_Server ====== 2026-06-04 19:54:33,263 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:54:33,270 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:54:33,287 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:54:33,417 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:54:33,442 - DEBUG - =>VN ctest-vn2-56278916 has no policy to be verified 2026-06-04 19:54:33,442 - DEBUG - Verifying the vn in opserver 2026-06-04 19:54:33,442 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916 virtual network link through opserver 10.0.0.50 2026-06-04 19:54:33,442 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-04 19:54:33,455 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916?flat'} 2026-06-04 19:54:33,455 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916 virtual network link through opserver 10.0.0.129 2026-06-04 19:54:33,455 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-06-04 19:54:33,528 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916?flat'} 2026-06-04 19:54:33,528 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916 virtual network link through opserver 10.0.0.241 2026-06-04 19:54:33,528 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks 2026-06-04 19:54:33,557 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916?flat'} 2026-06-04 19:54:33,557 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916 is found in opserver 2026-06-04 19:54:33,578 - DEBUG - VRF ids for VN ctest-vn2-56278916: {'10.0.0.242': '5'} 2026-06-04 19:54:33,578 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:54:33,585 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:54:33,599 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:54:33,706 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/b8e28bf5-a7d6-4ae6-9678-c14aec720b5c 2026-06-04 19:54:33,721 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/b8e28bf5-a7d6-4ae6-9678-c14aec720b5c 2026-06-04 19:54:33,734 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/39039dba-8c6f-4e66-ba63-80391cd26906 2026-06-04 19:54:33,748 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/39039dba-8c6f-4e66-ba63-80391cd26906 2026-06-04 19:54:33,758 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/d76ae53c-bb89-4088-a57b-ed71e23648c7 2026-06-04 19:54:33,766 - DEBUG - Route Targets: ['target:64512:8000010'] 2026-06-04 19:54:33,767 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/b8e28bf5-a7d6-4ae6-9678-c14aec720b5c 2026-06-04 19:54:33,778 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/39039dba-8c6f-4e66-ba63-80391cd26906 2026-06-04 19:54:33,799 - INFO - Verified VN network id 18 for VN b8e28bf5-a7d6-4ae6-9678-c14aec720b5c 2026-06-04 19:54:33,799 - INFO - Verifications in API Server for VN ctest-fip_vn-72425039 passed 2026-06-04 19:54:33,799 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/b8e28bf5-a7d6-4ae6-9678-c14aec720b5c 2026-06-04 19:54:33,809 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/39039dba-8c6f-4e66-ba63-80391cd26906 2026-06-04 19:54:33,818 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/39039dba-8c6f-4e66-ba63-80391cd26906 2026-06-04 19:54:33,828 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/d76ae53c-bb89-4088-a57b-ed71e23648c7 2026-06-04 19:54:33,844 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13322364534914435814', 'uuid-lslong': '10842628630433106780'}, 'enable': 'true', 'created': '2026-06-04T19:54:26', 'last-modified': '2026-06-04T19:54:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.754883'} 2026-06-04 19:54:33,850 - DEBUG - Route Targets: ['target:64512:8000010'] 2026-06-04 19:54:33,855 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13322364534914435814', 'uuid-lslong': '10842628630433106780'}, 'enable': 'true', 'created': '2026-06-04T19:54:26', 'last-modified': '2026-06-04T19:54:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.767493'} 2026-06-04 19:54:33,862 - DEBUG - Route Targets: ['target:64512:8000010'] 2026-06-04 19:54:33,868 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13322364534914435814', 'uuid-lslong': '10842628630433106780'}, 'enable': 'true', 'created': '2026-06-04T19:54:26', 'last-modified': '2026-06-04T19:54:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.777417'} 2026-06-04 19:54:33,874 - DEBUG - Route Targets: ['target:64512:8000010'] 2026-06-04 19:54:33,874 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-72425039 passed 2026-06-04 19:54:33,875 - DEBUG - ====Verifying policy data for ctest-fip_vn-72425039 in API_Server ====== 2026-06-04 19:54:33,875 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:54:33,882 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:54:33,895 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:54:33,999 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/b8e28bf5-a7d6-4ae6-9678-c14aec720b5c 2026-06-04 19:54:34,010 - DEBUG - =>VN ctest-fip_vn-72425039 has no policy to be verified 2026-06-04 19:54:34,010 - DEBUG - Verifying the vn in opserver 2026-06-04 19:54:34,010 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039 virtual network link through opserver 10.0.0.50 2026-06-04 19:54:34,010 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-04 19:54:34,079 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039?flat'} 2026-06-04 19:54:34,079 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039 virtual network link through opserver 10.0.0.129 2026-06-04 19:54:34,079 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-06-04 19:54:34,092 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039?flat'} 2026-06-04 19:54:34,092 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039 virtual network link through opserver 10.0.0.241 2026-06-04 19:54:34,092 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks 2026-06-04 19:54:34,153 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039?flat'} 2026-06-04 19:54:34,154 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039 is found in opserver 2026-06-04 19:54:34,165 - DEBUG - VRF ids for VN ctest-fip_vn-72425039: {'10.0.0.242': '6'} 2026-06-04 19:54:34,165 - INFO - Waiting for VM ctest-fvn_vm1-84262139 to be up.. 2026-06-04 19:54:34,248 - DEBUG - VM is in ACTIVE state now 2026-06-04 19:54:34,248 - INFO - VM name : ctest-fvn_vm1-84262139 2026-06-04 19:54:34,330 - DEBUG - VM ctest-fvn_vm1-84262139 ID is 08dbb5f7-6e4d-441f-adac-6da32c6bdf5b 2026-06-04 19:54:34,330 - DEBUG - VM ctest-fvn_vm1-84262139 launched on Node an-jenkins-deploy-platform-ansible-os-5893-1 2026-06-04 19:54:34,411 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine/08dbb5f7-6e4d-441f-adac-6da32c6bdf5b 2026-06-04 19:54:34,422 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine-interface/57cbc514-9ab9-44cf-97a4-9b07ff9d752e 2026-06-04 19:54:37,611 - 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 1027ms') 2026-06-04 19:54:37,611 - DEBUG - Ping to Metadata IP 169.254.0.7 of VM ctest-fvn_vm1-84262139 failed! 2026-06-04 19:54:37,628 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039 is 7.141.31.193 and allocation pool is NOT set 2026-06-04 19:54:41,705 - 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-04 19:54:41,705 - DEBUG - Ping to Metadata IP 169.254.0.7 of VM ctest-fvn_vm1-84262139 failed! 2026-06-04 19:54:41,730 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039 is 7.141.31.193 and allocation pool is NOT set 2026-06-04 19:54:45,801 - 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 1010ms') 2026-06-04 19:54:45,802 - DEBUG - Ping to Metadata IP 169.254.0.7 of VM ctest-fvn_vm1-84262139 failed! 2026-06-04 19:54:45,817 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039 is 7.141.31.193 and allocation pool is NOT set 2026-06-04 19:54:49,902 - 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 1019ms') 2026-06-04 19:54:49,903 - DEBUG - Ping to Metadata IP 169.254.0.7 of VM ctest-fvn_vm1-84262139 failed! 2026-06-04 19:54:49,919 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039 is 7.141.31.193 and allocation pool is NOT set 2026-06-04 19:54:53,995 - 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 1014ms') 2026-06-04 19:54:53,995 - DEBUG - Ping to Metadata IP 169.254.0.7 of VM ctest-fvn_vm1-84262139 failed! 2026-06-04 19:54:54,010 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039 is 7.141.31.193 and allocation pool is NOT set 2026-06-04 19:54:56,070 - 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=6.70 ms\r\n64 bytes from 169.254.0.7: icmp_seq=2 ttl=63 time=0.579 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.579/3.640/6.702/3.061 ms') 2026-06-04 19:54:56,070 - INFO - Ping to Metadata IP 169.254.0.7 of VM ctest-fvn_vm1-84262139 passed 2026-06-04 19:54:56,140 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-04 19:54:56,141 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-84262139, IP 7.141.31.195, Port 22 2026-06-04 19:54:56,206 - 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-04 19:54:56,293 - DEBUG - VM ctest-fvn_vm1-84262139 is NOT ready for SSH connections, VM status: ACTIVE 2026-06-04 19:55:01,294 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-04 19:55:01,294 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-84262139, IP 7.141.31.195, Port 22 2026-06-04 19:55:01,362 - 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-04 19:55:01,489 - DEBUG - VM ctest-fvn_vm1-84262139 is NOT ready for SSH connections, VM status: ACTIVE 2026-06-04 19:55:06,489 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-04 19:55:06,489 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-84262139, IP 7.141.31.195, Port 22 2026-06-04 19:55:06,648 - DEBUG - VM ctest-fvn_vm1-84262139 is ready for SSH connections 2026-06-04 19:55:06,648 - INFO - Waiting for VM ctest-vn2_vm2-27965747 to be up.. 2026-06-04 19:55:06,734 - DEBUG - VM is in ACTIVE state now 2026-06-04 19:55:06,734 - INFO - VM name : ctest-vn2_vm2-27965747 2026-06-04 19:55:06,813 - DEBUG - VM ctest-vn2_vm2-27965747 ID is 5a6bdaf1-6c89-4170-9076-9955baa2dae5 2026-06-04 19:55:06,814 - DEBUG - VM ctest-vn2_vm2-27965747 launched on Node an-jenkins-deploy-platform-ansible-os-5893-1 2026-06-04 19:55:06,895 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine/5a6bdaf1-6c89-4170-9076-9955baa2dae5 2026-06-04 19:55:06,906 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine-interface/3164971b-3f1c-44ec-ad64-5dd649eb3f24 2026-06-04 19:55:08,077 - 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=4.31 ms\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=1.94 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 = 1.940/3.124/4.308/1.184 ms') 2026-06-04 19:55:08,077 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-vn2_vm2-27965747 passed 2026-06-04 19:55:08,148 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-04 19:55:08,148 - DEBUG - Waiting to SSH to VM ctest-vn2_vm2-27965747, IP 13.53.235.67, Port 22 2026-06-04 19:55:08,214 - 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-04 19:55:08,292 - DEBUG - VM ctest-vn2_vm2-27965747 is NOT ready for SSH connections, VM status: ACTIVE 2026-06-04 19:55:13,292 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-04 19:55:13,292 - DEBUG - Waiting to SSH to VM ctest-vn2_vm2-27965747, IP 13.53.235.67, Port 22 2026-06-04 19:55:13,458 - DEBUG - VM ctest-vn2_vm2-27965747 is ready for SSH connections 2026-06-04 19:55:13,458 - INFO - Waiting for VM mltf_vm to be up.. 2026-06-04 19:55:13,545 - DEBUG - VM is in ACTIVE state now 2026-06-04 19:55:13,545 - INFO - VM name : mltf_vm 2026-06-04 19:55:13,638 - DEBUG - VM mltf_vm ID is 71ecaa99-3c3f-425e-a73f-184a6704a452 2026-06-04 19:55:13,638 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-5893-2 2026-06-04 19:55:13,830 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine/71ecaa99-3c3f-425e-a73f-184a6704a452 2026-06-04 19:55:13,843 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine-interface/d77dc62f-d525-47ae-b5a1-bfd711e41208 2026-06-04 19:55:13,854 - DEBUG - Requesting: http://10.0.0.241:8082/virtual-machine-interface/f96bc4ba-aad4-4bb1-8389-dba09e302d46 2026-06-04 19:55:15,073 - 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=2.23 ms\r\n64 bytes from 169.254.0.8: icmp_seq=2 ttl=63 time=0.397 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.397/1.313/2.230/0.916 ms') 2026-06-04 19:55:15,073 - INFO - Ping to Metadata IP 169.254.0.8 of VM mltf_vm passed 2026-06-04 19:55:15,144 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-04 19:55:15,144 - DEBUG - Waiting to SSH to VM mltf_vm, IP 8.28.133.197, Port 22 2026-06-04 19:55:15,300 - DEBUG - VM mltf_vm is ready for SSH connections 2026-06-04 19:55:15,377 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-06-04 19:55:15,377 - DEBUG - Waiting to SSH to VM mltf_vm, IP 8.28.133.197, Port 22 2026-06-04 19:55:15,532 - DEBUG - VM mltf_vm is ready for SSH connections 2026-06-04 19:55:15,535 - INFO - ================================================================================ 2026-06-04 19:55:15,535 - INFO - STARTING TEST : test_verify_session_sampling_teardown 2026-06-04 19:55:15,535 - 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-04 19:55:16,818 - DEBUG - Skipping xmpp flap check 2026-06-04 19:55:16,818 - INFO - Initial checks done. Running the testcase now 2026-06-04 19:55:16,818 - INFO - 2026-06-04 19:55:16,942 - INFO - Setting flow export rate: 100 2026-06-04 19:55:16,990 - 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-04 19:55:17,323 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '3a18a2f0-61e0-4f5d-af5e-2777fabf2868', 'name': 'ctest-vn1-56786224', 'tenant_id': '9e9cba66aa0a44f98b338cb00526a2ab', 'project_id': '9e9cba66aa0a44f98b338cb00526a2ab', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['655ef866-232d-459d-9dea-d10f110ed2b8'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-46681100', 'ctest-vn1-56786224'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-46681100', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '8.28.133.192/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-06-04 19:55:17,508 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '9ef4d19a-908a-4b6e-ad53-ceeb33851088', 'name': 'ctest-vn2-56278916', 'tenant_id': '9e9cba66aa0a44f98b338cb00526a2ab', 'project_id': '9e9cba66aa0a44f98b338cb00526a2ab', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['af477ac6-aa60-471d-9371-a11bc898a5d2'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-46681100', 'ctest-vn2-56278916'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-46681100', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '13.53.235.64/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-06-04 19:55:17,597 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:55:17,604 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:55:17,615 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:55:17,708 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:55:17,723 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:55:17,737 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:55:17,749 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:55:17,758 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/8a8fae31-a658-432c-9b3b-3baa48ae614c 2026-06-04 19:55:17,764 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-04 19:55:17,765 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:55:17,788 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:55:17,810 - INFO - Verified VN network id 16 for VN 3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:55:17,810 - INFO - Verifications in API Server for VN ctest-vn1-56786224 passed 2026-06-04 19:55:17,810 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:55:17,820 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:55:17,829 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:55:17,839 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/8a8fae31-a658-432c-9b3b-3baa48ae614c 2026-06-04 19:55:17,889 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4186275006958817117', 'uuid-lslong': '12636581000709613672'}, 'enable': 'true', 'created': '2026-06-04T19:53:44', 'last-modified': '2026-06-04T19:55:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.607205'} 2026-06-04 19:55:17,896 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-04 19:55:17,903 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4186275006958817117', 'uuid-lslong': '12636581000709613672'}, 'enable': 'true', 'created': '2026-06-04T19:53:44', 'last-modified': '2026-06-04T19:55:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.629438'} 2026-06-04 19:55:17,922 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-04 19:55:17,931 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4186275006958817117', 'uuid-lslong': '12636581000709613672'}, 'enable': 'true', 'created': '2026-06-04T19:53:44', 'last-modified': '2026-06-04T19:55:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.659148'} 2026-06-04 19:55:17,941 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-04 19:55:17,941 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-56786224 passed 2026-06-04 19:55:17,941 - DEBUG - ====Verifying policy data for ctest-vn1-56786224 in API_Server ====== 2026-06-04 19:55:17,941 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:55:17,949 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:55:17,971 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:55:18,073 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:55:18,082 - DEBUG - ==>Verifying data for policy with id: 13675ffa-6731-48ea-9b69-ee4f312c33b8, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-46681100', 'policy1'] 2026-06-04 19:55:18,082 - INFO - VN ctest-vn1-56786224 Policy verification: verify_vn_policy_in_api_server, status: True 2026-06-04 19:55:18,082 - DEBUG - Verifying the vn in opserver 2026-06-04 19:55:18,082 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 virtual network link through opserver 10.0.0.50 2026-06-04 19:55:18,082 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-04 19:55:18,094 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224?flat'} 2026-06-04 19:55:18,094 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 virtual network link through opserver 10.0.0.129 2026-06-04 19:55:18,094 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-06-04 19:55:18,108 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224?flat'} 2026-06-04 19:55:18,108 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 virtual network link through opserver 10.0.0.241 2026-06-04 19:55:18,108 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks 2026-06-04 19:55:18,120 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224?flat'} 2026-06-04 19:55:18,120 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 is found in opserver 2026-06-04 19:55:18,132 - DEBUG - VRF ids for VN ctest-vn1-56786224: {'10.0.0.41': '5'} 2026-06-04 19:55:18,132 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:55:18,138 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:55:18,149 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:55:18,248 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:55:18,264 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:55:18,273 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/e23cb8fc-0846-4e76-907c-2ca1eb010979 2026-06-04 19:55:18,283 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/e23cb8fc-0846-4e76-907c-2ca1eb010979 2026-06-04 19:55:18,291 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/aa7e14b5-e841-4447-85f9-8314bb35b91d 2026-06-04 19:55:18,298 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-04 19:55:18,299 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:55:18,309 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/e23cb8fc-0846-4e76-907c-2ca1eb010979 2026-06-04 19:55:18,325 - INFO - Verified VN network id 17 for VN 9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:55:18,325 - INFO - Verifications in API Server for VN ctest-vn2-56278916 passed 2026-06-04 19:55:18,325 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:55:18,335 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/e23cb8fc-0846-4e76-907c-2ca1eb010979 2026-06-04 19:55:18,342 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/e23cb8fc-0846-4e76-907c-2ca1eb010979 2026-06-04 19:55:18,349 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/aa7e14b5-e841-4447-85f9-8314bb35b91d 2026-06-04 19:55:18,359 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11454010214090165102', 'uuid-lslong': '12489553701205512328'}, 'enable': 'true', 'created': '2026-06-04T19:54:26', 'last-modified': '2026-06-04T19:55:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.875993'} 2026-06-04 19:55:18,365 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-04 19:55:18,370 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'interests': '0-1', 'advertised': '0-1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11454010214090165102', 'uuid-lslong': '12489553701205512328'}, 'enable': 'true', 'created': '2026-06-04T19:54:26', 'last-modified': '2026-06-04T19:55:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.893923'} 2026-06-04 19:55:18,376 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-04 19:55:18,382 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11454010214090165102', 'uuid-lslong': '12489553701205512328'}, 'enable': 'true', 'created': '2026-06-04T19:54:26', 'last-modified': '2026-06-04T19:55:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.906343'} 2026-06-04 19:55:18,388 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-04 19:55:18,388 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-56278916 passed 2026-06-04 19:55:18,389 - DEBUG - ====Verifying policy data for ctest-vn2-56278916 in API_Server ====== 2026-06-04 19:55:18,389 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:55:18,395 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:55:18,407 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:55:18,497 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:55:18,515 - DEBUG - ==>Verifying data for policy with id: 13675ffa-6731-48ea-9b69-ee4f312c33b8, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-46681100', 'policy1'] 2026-06-04 19:55:18,516 - INFO - VN ctest-vn2-56278916 Policy verification: verify_vn_policy_in_api_server, status: True 2026-06-04 19:55:18,516 - DEBUG - Verifying the vn in opserver 2026-06-04 19:55:18,516 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916 virtual network link through opserver 10.0.0.50 2026-06-04 19:55:18,516 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-04 19:55:18,529 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916?flat'} 2026-06-04 19:55:18,529 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916 virtual network link through opserver 10.0.0.129 2026-06-04 19:55:18,529 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-06-04 19:55:18,544 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916?flat'} 2026-06-04 19:55:18,544 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916 virtual network link through opserver 10.0.0.241 2026-06-04 19:55:18,544 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks 2026-06-04 19:55:18,557 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916?flat'} 2026-06-04 19:55:18,557 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916 is found in opserver 2026-06-04 19:55:18,567 - DEBUG - VRF ids for VN ctest-vn2-56278916: {'10.0.0.242': '5', '10.0.0.41': '6'} 2026-06-04 19:55:18,567 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:55:18,572 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:55:18,583 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:55:18,677 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:55:18,690 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:55:18,704 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:55:18,717 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:55:18,725 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/8a8fae31-a658-432c-9b3b-3baa48ae614c 2026-06-04 19:55:18,732 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-04 19:55:18,732 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:55:18,742 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:55:18,759 - INFO - Verified VN network id 16 for VN 3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:55:18,759 - INFO - Verifications in API Server for VN ctest-vn1-56786224 passed 2026-06-04 19:55:18,759 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:55:18,773 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:55:18,782 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:55:18,790 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/8a8fae31-a658-432c-9b3b-3baa48ae614c 2026-06-04 19:55:18,806 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4186275006958817117', 'uuid-lslong': '12636581000709613672'}, 'enable': 'true', 'created': '2026-06-04T19:53:44', 'last-modified': '2026-06-04T19:55:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.523931'} 2026-06-04 19:55:18,812 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-04 19:55:18,818 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4186275006958817117', 'uuid-lslong': '12636581000709613672'}, 'enable': 'true', 'created': '2026-06-04T19:53:44', 'last-modified': '2026-06-04T19:55:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.544398'} 2026-06-04 19:55:18,824 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-04 19:55:18,830 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4186275006958817117', 'uuid-lslong': '12636581000709613672'}, 'enable': 'true', 'created': '2026-06-04T19:53:44', 'last-modified': '2026-06-04T19:55:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.559677'} 2026-06-04 19:55:18,836 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-06-04 19:55:18,836 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-56786224 passed 2026-06-04 19:55:18,836 - DEBUG - ====Verifying policy data for ctest-vn1-56786224 in API_Server ====== 2026-06-04 19:55:18,836 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:55:18,842 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:55:18,854 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:55:18,940 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/3a18a2f0-61e0-4f5d-af5e-2777fabf2868 2026-06-04 19:55:18,955 - DEBUG - ==>Verifying data for policy with id: 13675ffa-6731-48ea-9b69-ee4f312c33b8, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-46681100', 'policy1'] 2026-06-04 19:55:18,955 - INFO - VN ctest-vn1-56786224 Policy verification: verify_vn_policy_in_api_server, status: True 2026-06-04 19:55:18,955 - DEBUG - Verifying the vn in opserver 2026-06-04 19:55:18,955 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 virtual network link through opserver 10.0.0.50 2026-06-04 19:55:18,955 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-04 19:55:18,969 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224?flat'} 2026-06-04 19:55:18,969 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 virtual network link through opserver 10.0.0.129 2026-06-04 19:55:18,969 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-06-04 19:55:18,982 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224?flat'} 2026-06-04 19:55:18,982 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 virtual network link through opserver 10.0.0.241 2026-06-04 19:55:18,982 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks 2026-06-04 19:55:18,996 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224?flat'} 2026-06-04 19:55:18,996 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 is found in opserver 2026-06-04 19:55:19,007 - DEBUG - VRF ids for VN ctest-vn1-56786224: {'10.0.0.41': '5'} 2026-06-04 19:55:19,007 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:55:19,015 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:55:19,029 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:55:19,133 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:55:19,144 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:55:19,154 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/e23cb8fc-0846-4e76-907c-2ca1eb010979 2026-06-04 19:55:19,164 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/e23cb8fc-0846-4e76-907c-2ca1eb010979 2026-06-04 19:55:19,173 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/aa7e14b5-e841-4447-85f9-8314bb35b91d 2026-06-04 19:55:19,179 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-04 19:55:19,179 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:55:19,188 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/e23cb8fc-0846-4e76-907c-2ca1eb010979 2026-06-04 19:55:19,204 - INFO - Verified VN network id 17 for VN 9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:55:19,204 - INFO - Verifications in API Server for VN ctest-vn2-56278916 passed 2026-06-04 19:55:19,204 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:55:19,216 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/e23cb8fc-0846-4e76-907c-2ca1eb010979 2026-06-04 19:55:19,225 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/e23cb8fc-0846-4e76-907c-2ca1eb010979 2026-06-04 19:55:19,233 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/aa7e14b5-e841-4447-85f9-8314bb35b91d 2026-06-04 19:55:19,245 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11454010214090165102', 'uuid-lslong': '12489553701205512328'}, 'enable': 'true', 'created': '2026-06-04T19:54:26', 'last-modified': '2026-06-04T19:55:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.761472'} 2026-06-04 19:55:19,251 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-04 19:55:19,257 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'interests': '0-1', 'advertised': '0-1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11454010214090165102', 'uuid-lslong': '12489553701205512328'}, 'enable': 'true', 'created': '2026-06-04T19:54:26', 'last-modified': '2026-06-04T19:55:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.780252'} 2026-06-04 19:55:19,264 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-04 19:55:19,271 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11454010214090165102', 'uuid-lslong': '12489553701205512328'}, 'enable': 'true', 'created': '2026-06-04T19:54:26', 'last-modified': '2026-06-04T19:55:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.794912'} 2026-06-04 19:55:19,278 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-06-04 19:55:19,278 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-56278916 passed 2026-06-04 19:55:19,279 - DEBUG - ====Verifying policy data for ctest-vn2-56278916 in API_Server ====== 2026-06-04 19:55:19,279 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:55:19,285 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:55:19,296 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:55:19,392 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/9ef4d19a-908a-4b6e-ad53-ceeb33851088 2026-06-04 19:55:19,404 - DEBUG - ==>Verifying data for policy with id: 13675ffa-6731-48ea-9b69-ee4f312c33b8, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-46681100', 'policy1'] 2026-06-04 19:55:19,405 - INFO - VN ctest-vn2-56278916 Policy verification: verify_vn_policy_in_api_server, status: True 2026-06-04 19:55:19,405 - DEBUG - Verifying the vn in opserver 2026-06-04 19:55:19,405 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916 virtual network link through opserver 10.0.0.50 2026-06-04 19:55:19,405 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-04 19:55:19,419 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916?flat'} 2026-06-04 19:55:19,419 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916 virtual network link through opserver 10.0.0.129 2026-06-04 19:55:19,419 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-06-04 19:55:19,431 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916?flat'} 2026-06-04 19:55:19,432 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916 virtual network link through opserver 10.0.0.241 2026-06-04 19:55:19,432 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks 2026-06-04 19:55:19,444 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916?flat'} 2026-06-04 19:55:19,444 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916 is found in opserver 2026-06-04 19:55:19,456 - DEBUG - VRF ids for VN ctest-vn2-56278916: {'10.0.0.242': '5', '10.0.0.41': '6'} 2026-06-04 19:55:19,456 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:55:19,462 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:55:19,476 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:55:19,572 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/b8e28bf5-a7d6-4ae6-9678-c14aec720b5c 2026-06-04 19:55:19,584 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/b8e28bf5-a7d6-4ae6-9678-c14aec720b5c 2026-06-04 19:55:19,594 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/39039dba-8c6f-4e66-ba63-80391cd26906 2026-06-04 19:55:19,603 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/39039dba-8c6f-4e66-ba63-80391cd26906 2026-06-04 19:55:19,612 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/d76ae53c-bb89-4088-a57b-ed71e23648c7 2026-06-04 19:55:19,619 - DEBUG - Route Targets: ['target:64512:8000010'] 2026-06-04 19:55:19,619 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/b8e28bf5-a7d6-4ae6-9678-c14aec720b5c 2026-06-04 19:55:19,628 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/39039dba-8c6f-4e66-ba63-80391cd26906 2026-06-04 19:55:19,644 - INFO - Verified VN network id 18 for VN b8e28bf5-a7d6-4ae6-9678-c14aec720b5c 2026-06-04 19:55:19,644 - INFO - Verifications in API Server for VN ctest-fip_vn-72425039 passed 2026-06-04 19:55:19,645 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/b8e28bf5-a7d6-4ae6-9678-c14aec720b5c 2026-06-04 19:55:19,658 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/39039dba-8c6f-4e66-ba63-80391cd26906 2026-06-04 19:55:19,667 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/39039dba-8c6f-4e66-ba63-80391cd26906 2026-06-04 19:55:19,676 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/d76ae53c-bb89-4088-a57b-ed71e23648c7 2026-06-04 19:55:19,688 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13322364534914435814', 'uuid-lslong': '10842628630433106780'}, 'enable': 'true', 'created': '2026-06-04T19:54:26', 'last-modified': '2026-06-04T19:54:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:52.599593'} 2026-06-04 19:55:19,693 - DEBUG - Route Targets: ['target:64512:8000010'] 2026-06-04 19:55:19,699 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13322364534914435814', 'uuid-lslong': '10842628630433106780'}, 'enable': 'true', 'created': '2026-06-04T19:54:26', 'last-modified': '2026-06-04T19:54:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:52.610521'} 2026-06-04 19:55:19,706 - DEBUG - Route Targets: ['target:64512:8000010'] 2026-06-04 19:55:19,711 - DEBUG - Control-node 10.0.0.241 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-46681100', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13322364534914435814', 'uuid-lslong': '10842628630433106780'}, 'enable': 'true', 'created': '2026-06-04T19:54:26', 'last-modified': '2026-06-04T19:54:27', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:52.621211'} 2026-06-04 19:55:19,717 - DEBUG - Route Targets: ['target:64512:8000010'] 2026-06-04 19:55:19,717 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-72425039 passed 2026-06-04 19:55:19,718 - DEBUG - ====Verifying policy data for ctest-fip_vn-72425039 in API_Server ====== 2026-06-04 19:55:19,718 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:55:19,724 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:55:19,735 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:55:19,830 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/b8e28bf5-a7d6-4ae6-9678-c14aec720b5c 2026-06-04 19:55:19,842 - DEBUG - =>VN ctest-fip_vn-72425039 has no policy to be verified 2026-06-04 19:55:19,842 - DEBUG - Verifying the vn in opserver 2026-06-04 19:55:19,842 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039 virtual network link through opserver 10.0.0.50 2026-06-04 19:55:19,842 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-06-04 19:55:19,855 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039?flat'} 2026-06-04 19:55:19,855 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039 virtual network link through opserver 10.0.0.129 2026-06-04 19:55:19,855 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-06-04 19:55:19,868 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039?flat'} 2026-06-04 19:55:19,868 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039 virtual network link through opserver 10.0.0.241 2026-06-04 19:55:19,868 - DEBUG - Requesting: http://10.0.0.241:8081/analytics/uves/virtual-networks 2026-06-04 19:55:19,880 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039', 'href': 'http://10.0.0.241:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039?flat'} 2026-06-04 19:55:19,880 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039 is found in opserver 2026-06-04 19:55:19,892 - DEBUG - VRF ids for VN ctest-fip_vn-72425039: {'10.0.0.242': '6'} 2026-06-04 19:55:19,892 - INFO - start time= 1780602919892129 2026-06-04 19:55:19,892 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 13.53.235.67, host_string: cirros@169.254.0.6, password: gocubsgogateway: ubuntu@10.0.0.41, gateway password: c0ntrail123 2026-06-04 19:55:19,892 - DEBUG - ping -s 56 -c 3 -W 1 13.53.235.67 2026-06-04 19:55:24,193 - DEBUG - PING 13.53.235.67 (13.53.235.67): 56 data bytes 64 bytes from 13.53.235.67: seq=0 ttl=63 time=4.705 ms 64 bytes from 13.53.235.67: seq=1 ttl=63 time=1.547 ms 64 bytes from 13.53.235.67: seq=2 ttl=63 time=1.241 ms --- 13.53.235.67 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.241/2.497/4.705 ms 2026-06-04 19:55:24,193 - INFO - Ping to IP 13.53.235.67 from VM ctest-vn1_vm1-53577791 passed 2026-06-04 19:55:34,194 - INFO - Verify session samples and teardown pkts 2026-06-04 19:55:34,194 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.50 2026-06-04 19:55:34,197 - DEBUG - Posting: http://10.0.0.50:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1780602919892129, 'end_time': 1780602934197711, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'} 2026-06-04 19:55:35,218 - DEBUG - [{'T': 1780602922334132}, {'T': 1780602923334224}, {'T': 1780602924334279}] 2026-06-04 19:55:35,218 - DEBUG - Posting: http://10.0.0.50:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1780602919892129, 'end_time': 1780602935218816, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'} 2026-06-04 19:55:36,238 - DEBUG - [{'T': 1780602922606957}, {'T': 1780602923607073}, {'T': 1780602924607124}] 2026-06-04 19:55:36,238 - DEBUG - Posting: http://10.0.0.50:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1780602919892129, 'end_time': 1780602936238449, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'} 2026-06-04 19:55:37,265 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', 'sample_count': 3}] 2026-06-04 19:55:37,265 - INFO - wait for the flows to get expire 2026-06-04 19:58:57,265 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5893-2:Compute:contrail-vrouter-agent:0?flat 2026-06-04 19:58:57,353 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5893-2?flat 2026-06-04 19:58:57,861 - INFO - Deleted policy policy1 2026-06-04 19:58:57,974 - INFO - Setting flow export rate: None 2026-06-04 19:58:59,269 - ERROR - AssertionError Python 3.9.25: /usr/bin/python3 Thu Jun 4 19:58:57 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 = '1780602919892129' src_vn = 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224' dst_vn = 'default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916' /contrail-test/serial_scripts/analytics/base.py in verify_session_sampling_teardown(self=, start_time='1780602919892129', src_vn='default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224', dst_vn='default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916') 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 = 16 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-04 19:58:59,270 - DEBUG - Skipping xmpp flap check 2026-06-04 19:58:59,270 - INFO -

2026-06-04 19:58:59,270 - INFO - END TEST : test_verify_session_sampling_teardown : FAILED[0:03:44]

2026-06-04 19:58:59,270 - INFO - -------------------------------------------------------------------------------- 2026-06-04 19:58:59,272 - INFO - Deleting VM mltf_vm 2026-06-04 19:58:59,354 - INFO - Deleting VM ctest-fvn_vm1-84262139 2026-06-04 19:58:59,424 - INFO - Deleting VM ctest-vn2_vm2-27965747 2026-06-04 19:58:59,495 - INFO - Deleting VN ctest-fip_vn-72425039 2026-06-04 19:58:59,536 - DEBUG - VN b8e28bf5-a7d6-4ae6-9678-c14aec720b5c still in use: Unable to complete operation on network b8e28bf5-a7d6-4ae6-9678-c14aec720b5c. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-604a828b-8fb9-4692-9a39-277dbf3d3c4d'] 2026-06-04 19:58:59,536 - WARNING - Deleting VN ctest-fip_vn-72425039 failed..Will retry 2026-06-04 19:59:01,682 - DEBUG - Response for deleting network () 2026-06-04 19:59:01,682 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/39039dba-8c6f-4e66-ba63-80391cd26906 2026-06-04 19:59:01,728 - DEBUG - Response Code: 404 2026-06-04 19:59:01,728 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:59:01,734 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:59:01,770 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:59:01,860 - INFO - Validated that VN ctest-fip_vn-72425039 is not found in API Server 2026-06-04 19:59:01,874 - DEBUG - VN ctest-fip_vn-72425039 is not present in Agent 10.0.0.242 2026-06-04 19:59:01,888 - DEBUG - VN ctest-fip_vn-72425039 is not present in Agent 10.0.0.41 2026-06-04 19:59:01,888 - INFO - Validated that VN ctest-fip_vn-72425039 is not in any agent 2026-06-04 19:59:01,896 - DEBUG - VRF 6 is not seen in agent 10.0.0.242 2026-06-04 19:59:01,901 - DEBUG - Vrouter 10.0.0.242 does not have vrf 6 for VN ctest-fip_vn-72425039 2026-06-04 19:59:01,901 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-fip_vn-72425039 2026-06-04 19:59:01,922 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-72425039 info 2026-06-04 19:59:01,923 - INFO - Deleting VN ctest-vn2-56278916 2026-06-04 19:59:02,098 - DEBUG - Response for deleting network () 2026-06-04 19:59:02,098 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/e23cb8fc-0846-4e76-907c-2ca1eb010979 2026-06-04 19:59:02,110 - DEBUG - Response Code: 404 2026-06-04 19:59:02,110 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:59:02,115 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:59:02,135 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:59:02,230 - INFO - Validated that VN ctest-vn2-56278916 is not found in API Server 2026-06-04 19:59:02,241 - DEBUG - VN ctest-vn2-56278916 is not present in Agent 10.0.0.242 2026-06-04 19:59:02,252 - DEBUG - VN ctest-vn2-56278916 is not present in Agent 10.0.0.41 2026-06-04 19:59:02,252 - INFO - Validated that VN ctest-vn2-56278916 is not in any agent 2026-06-04 19:59:02,258 - DEBUG - VRF 5 is not seen in agent 10.0.0.242 2026-06-04 19:59:02,264 - DEBUG - Vrouter 10.0.0.242 does not have vrf 5 for VN ctest-vn2-56278916 2026-06-04 19:59:02,271 - DEBUG - VRF 6 is not seen in agent 10.0.0.41 2026-06-04 19:59:02,276 - DEBUG - Vrouter 10.0.0.41 does not have vrf 6 for VN ctest-vn2-56278916 2026-06-04 19:59:02,276 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn2-56278916 2026-06-04 19:59:02,301 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-56278916 info 2026-06-04 19:59:02,301 - INFO - Deleting VM ctest-vn1_vm2-38381655 2026-06-04 19:59:02,369 - INFO - Deleting VM ctest-vn1_vm1-53577791 2026-06-04 19:59:02,440 - INFO - Deleting VN ctest-vn1-56786224 2026-06-04 19:59:02,490 - DEBUG - VN 3a18a2f0-61e0-4f5d-af5e-2777fabf2868 still in use: Unable to complete operation on network 3a18a2f0-61e0-4f5d-af5e-2777fabf2868. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-e20219bb-cc54-4e7b-b946-122d7dbc8329'] 2026-06-04 19:59:02,490 - WARNING - Deleting VN ctest-vn1-56786224 failed..Will retry 2026-06-04 19:59:04,659 - DEBUG - Response for deleting network () 2026-06-04 19:59:04,659 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/fd067876-b78c-4df0-bf1e-66b20af9bf3a 2026-06-04 19:59:04,666 - DEBUG - Response Code: 404 2026-06-04 19:59:04,666 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2026-06-04 19:59:04,674 - DEBUG - Requesting: http://10.0.0.50:8082/domain/4e02db34-016b-4b63-8018-86160ff1d58c 2026-06-04 19:59:04,691 - DEBUG - Requesting: http://10.0.0.50:8082/project/9e9cba66-aa0a-44f9-8b33-8cb00526a2ab 2026-06-04 19:59:04,785 - INFO - Validated that VN ctest-vn1-56786224 is not found in API Server 2026-06-04 19:59:04,798 - DEBUG - VN ctest-vn1-56786224 is not present in Agent 10.0.0.242 2026-06-04 19:59:04,808 - DEBUG - VN ctest-vn1-56786224 is not present in Agent 10.0.0.41 2026-06-04 19:59:04,808 - INFO - Validated that VN ctest-vn1-56786224 is not in any agent 2026-06-04 19:59:04,814 - DEBUG - VRF 5 is not seen in agent 10.0.0.41 2026-06-04 19:59:04,819 - DEBUG - Vrouter 10.0.0.41 does not have vrf 5 for VN ctest-vn1-56786224 2026-06-04 19:59:04,819 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-46681100:ctest-vn1-56786224 2026-06-04 19:59:04,842 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-56786224 info 2026-06-04 19:59:05,610 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-46681100, ID : 9e9cba66-aa0a-44f9-8b33-8cb00526a2ab