2026-03-02 03:48:44,836 - INFO - Domain Default found not creating 2026-03-02 03:48:45,041 - INFO - Project ctest-AnalyticsTestSanityWithResource-73587336 not found, creating it 2026-03-02 03:48:45,575 - INFO - Created Project:ctest-AnalyticsTestSanityWithResource-73587336, ID : 347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:48:47,959 - DEBUG - Response for create_network : {'network': {'id': 'ff1b6916-7ac3-41a4-b870-4c45d6feb790', 'name': 'ctest-vn1-79431837', 'tenant_id': '347cae1e2c5b4d828547e7c1679a160e', 'project_id': '347cae1e2c5b4d828547e7c1679a160e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-73587336', 'ctest-vn1-79431837'], 'port_security_enabled': True, 'description': ''}} 2026-03-02 03:48:48,251 - DEBUG - Response for create_subnet : {'subnet': {'id': '6924fa28-62b4-4f0f-ac1d-d38a3be499a7', 'name': '', 'tenant_id': '347cae1e2c5b4d828547e7c1679a160e', 'network_id': 'ff1b6916-7ac3-41a4-b870-4c45d6feb790', 'ip_version': 4, 'cidr': '130.232.223.0/26', 'allocation_pools': [{'start': '130.232.223.2', 'end': '130.232.223.62'}], 'gateway_ip': '130.232.223.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '130.232.223.2', 'tags': [], 'project_id': '347cae1e2c5b4d828547e7c1679a160e'}} 2026-03-02 03:48:48,276 - INFO - Created VN ctest-vn1-79431837 2026-03-02 03:48:48,288 - DEBUG - VN ctest-vn1-79431837 UUID is ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:48:48,392 - DEBUG - Services list from nova: [, , , ] 2026-03-02 03:48:48,392 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5413-1', 'an-jenkins-deploy-platform-ansible-os-5413-2']} 2026-03-02 03:48:49,650 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5413-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5413-1) 2026-03-02 03:48:51,123 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5413-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5413-1) 2026-03-02 03:48:51,124 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:48:51,465 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:48:51,502 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:48:51,525 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:48:51,674 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:48:51,712 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:48:51,728 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:48:51,752 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:48:51,764 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/b8c8d031-7fdd-42b1-86ff-612026a16c7e 2026-03-02 03:48:51,778 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-02 03:48:51,778 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:48:51,801 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:48:51,825 - INFO - Verified VN network id 15 for VN ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:48:51,826 - INFO - Verifications in API Server for VN ctest-vn1-79431837 passed 2026-03-02 03:48:51,826 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:48:51,842 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:48:51,853 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:48:51,863 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/b8c8d031-7fdd-42b1-86ff-612026a16c7e 2026-03-02 03:48:51,878 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18382401849312625060', 'uuid-lslong': '13290206363213805456'}, 'enable': 'true', 'created': '2026-03-02T03:48:47', 'last-modified': '2026-03-02T03:48:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.693230'} 2026-03-02 03:48:51,885 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-02 03:48:51,890 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18382401849312625060', 'uuid-lslong': '13290206363213805456'}, 'enable': 'true', 'created': '2026-03-02T03:48:47', 'last-modified': '2026-03-02T03:48:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.716353'} 2026-03-02 03:48:51,902 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-02 03:48:51,908 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18382401849312625060', 'uuid-lslong': '13290206363213805456'}, 'enable': 'true', 'created': '2026-03-02T03:48:47', 'last-modified': '2026-03-02T03:48:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.735091'} 2026-03-02 03:48:51,915 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-02 03:48:51,915 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-79431837 passed 2026-03-02 03:48:51,915 - DEBUG - ====Verifying policy data for ctest-vn1-79431837 in API_Server ====== 2026-03-02 03:48:51,915 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:48:51,927 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:48:51,940 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:48:52,066 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:48:52,092 - DEBUG - =>VN ctest-vn1-79431837 has no policy to be verified 2026-03-02 03:48:52,092 - DEBUG - Verifying the vn in opserver 2026-03-02 03:48:52,092 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 virtual network link through opserver 10.0.0.242 2026-03-02 03:48:52,092 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2026-03-02 03:48:52,455 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2026-03-02 03:48:52,540 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837?flat'} 2026-03-02 03:48:52,540 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 virtual network link through opserver 10.0.0.27 2026-03-02 03:48:52,540 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-03-02 03:48:52,879 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-03-02 03:48:52,953 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837?flat'} 2026-03-02 03:48:52,953 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 virtual network link through opserver 10.0.0.23 2026-03-02 03:48:52,953 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-03-02 03:48:53,287 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-03-02 03:48:53,361 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837?flat'} 2026-03-02 03:48:53,361 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 is found in opserver 2026-03-02 03:48:53,375 - DEBUG - VRF ids for VN ctest-vn1-79431837: {'10.0.0.41': '2'} 2026-03-02 03:48:53,375 - INFO - Waiting for VM ctest-vn1_vm1-10947738 to be up.. 2026-03-02 03:48:53,472 - DEBUG - VM is in ACTIVE state now 2026-03-02 03:48:53,473 - INFO - VM name : ctest-vn1_vm1-10947738 2026-03-02 03:48:53,592 - DEBUG - VM ctest-vn1_vm1-10947738 ID is c0e6af27-4816-4e93-8e17-33850b171243 2026-03-02 03:48:53,634 - DEBUG - VM ctest-vn1_vm1-10947738 launched on Node an-jenkins-deploy-platform-ansible-os-5413-1 2026-03-02 03:48:53,754 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/c0e6af27-4816-4e93-8e17-33850b171243 2026-03-02 03:48:54,090 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/c0e6af27-4816-4e93-8e17-33850b171243 2026-03-02 03:48:54,130 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/9d3ed7bc-d113-456b-b456-0bc3c7411925 2026-03-02 03:48:57,304 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-03-02 03:48:57,304 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-10947738 failed! 2026-03-02 03:48:57,319 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 is 130.232.223.1 and allocation pool is NOT set 2026-03-02 03:49:01,407 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1027ms') 2026-03-02 03:49:01,407 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-10947738 failed! 2026-03-02 03:49:01,422 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 is 130.232.223.1 and allocation pool is NOT set 2026-03-02 03:49:05,502 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1020ms') 2026-03-02 03:49:05,502 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-10947738 failed! 2026-03-02 03:49:05,520 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 is 130.232.223.1 and allocation pool is NOT set 2026-03-02 03:49:09,593 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms') 2026-03-02 03:49:09,593 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-10947738 failed! 2026-03-02 03:49:09,608 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 is 130.232.223.1 and allocation pool is NOT set 2026-03-02 03:49:11,669 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=4.77 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.500 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.500/2.635/4.770/2.135 ms') 2026-03-02 03:49:11,669 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-10947738 passed 2026-03-02 03:49:11,739 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-02 03:49:11,740 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-10947738, IP 130.232.223.3, Port 22 2026-03-02 03:49:11,794 - DEBUG - Error on ssh to cirros@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-03-02 03:49:11,886 - DEBUG - VM ctest-vn1_vm1-10947738 is NOT ready for SSH connections, VM status: ACTIVE 2026-03-02 03:49:16,887 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-02 03:49:16,887 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-10947738, IP 130.232.223.3, Port 22 2026-03-02 03:49:16,943 - DEBUG - Error on ssh to cirros@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-03-02 03:49:17,039 - DEBUG - VM ctest-vn1_vm1-10947738 is NOT ready for SSH connections, VM status: ACTIVE 2026-03-02 03:49:22,040 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-02 03:49:22,040 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-10947738, IP 130.232.223.3, Port 22 2026-03-02 03:49:22,213 - DEBUG - VM ctest-vn1_vm1-10947738 is ready for SSH connections 2026-03-02 03:49:22,213 - INFO - Waiting for VM ctest-vn1_vm2-28943584 to be up.. 2026-03-02 03:49:22,338 - DEBUG - VM is in ACTIVE state now 2026-03-02 03:49:22,338 - INFO - VM name : ctest-vn1_vm2-28943584 2026-03-02 03:49:22,440 - DEBUG - VM ctest-vn1_vm2-28943584 ID is 0a3b78dd-14e4-45b4-9311-a37f3ad4b18b 2026-03-02 03:49:22,441 - DEBUG - VM ctest-vn1_vm2-28943584 launched on Node an-jenkins-deploy-platform-ansible-os-5413-1 2026-03-02 03:49:22,555 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/0a3b78dd-14e4-45b4-9311-a37f3ad4b18b 2026-03-02 03:49:22,565 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/bc5487cd-d1a0-44b9-86e5-0a0dd916355f 2026-03-02 03:49:23,745 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n64 bytes from 169.254.0.4: icmp_seq=1 ttl=63 time=5.09 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=1.81 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 1.811/3.448/5.086/1.637 ms') 2026-03-02 03:49:23,745 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1_vm2-28943584 passed 2026-03-02 03:49:23,818 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-02 03:49:23,819 - DEBUG - Waiting to SSH to VM ctest-vn1_vm2-28943584, IP 130.232.223.4, Port 22 2026-03-02 03:49:23,981 - DEBUG - VM ctest-vn1_vm2-28943584 is ready for SSH connections 2026-03-02 03:49:24,347 - DEBUG - Response for create_network : {'network': {'id': '4b99745e-a4d0-4a08-ad22-ef330375dcfa', 'name': 'ctest-vn2-80479153', 'tenant_id': '347cae1e2c5b4d828547e7c1679a160e', 'project_id': '347cae1e2c5b4d828547e7c1679a160e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-73587336', 'ctest-vn2-80479153'], 'port_security_enabled': True, 'description': ''}} 2026-03-02 03:49:24,641 - DEBUG - Response for create_subnet : {'subnet': {'id': '22b71236-1e08-460b-9b21-b01a0d31d76e', 'name': '', 'tenant_id': '347cae1e2c5b4d828547e7c1679a160e', 'network_id': '4b99745e-a4d0-4a08-ad22-ef330375dcfa', 'ip_version': 4, 'cidr': '89.249.91.64/26', 'allocation_pools': [{'start': '89.249.91.66', 'end': '89.249.91.126'}], 'gateway_ip': '89.249.91.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '89.249.91.66', 'tags': [], 'project_id': '347cae1e2c5b4d828547e7c1679a160e'}} 2026-03-02 03:49:24,680 - INFO - Created VN ctest-vn2-80479153 2026-03-02 03:49:24,696 - DEBUG - VN ctest-vn2-80479153 UUID is 4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:49:25,079 - DEBUG - Response for create_network : {'network': {'id': '860c5a20-15e0-42e8-b7d7-a7b391349444', 'name': 'ctest-fip_vn-95824667', 'tenant_id': '347cae1e2c5b4d828547e7c1679a160e', 'project_id': '347cae1e2c5b4d828547e7c1679a160e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-73587336', 'ctest-fip_vn-95824667'], 'port_security_enabled': True, 'description': ''}} 2026-03-02 03:49:25,347 - DEBUG - Response for create_subnet : {'subnet': {'id': '0858a66c-daf5-493e-9678-8f9446e0e30d', 'name': '', 'tenant_id': '347cae1e2c5b4d828547e7c1679a160e', 'network_id': '860c5a20-15e0-42e8-b7d7-a7b391349444', 'ip_version': 4, 'cidr': '208.184.94.64/26', 'allocation_pools': [{'start': '208.184.94.66', 'end': '208.184.94.126'}], 'gateway_ip': '208.184.94.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '208.184.94.66', 'tags': [], 'project_id': '347cae1e2c5b4d828547e7c1679a160e'}} 2026-03-02 03:49:25,378 - INFO - Created VN ctest-fip_vn-95824667 2026-03-02 03:49:25,392 - DEBUG - VN ctest-fip_vn-95824667 UUID is 860c5a20-15e0-42e8-b7d7-a7b391349444 2026-03-02 03:49:25,477 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5413-1', 'an-jenkins-deploy-platform-ansible-os-5413-2']} 2026-03-02 03:49:27,023 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5413-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5413-2) 2026-03-02 03:49:28,701 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5413-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5413-2) 2026-03-02 03:49:30,317 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5413-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5413-1) 2026-03-02 03:49:30,318 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:49:30,324 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:49:30,342 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:49:30,450 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:49:30,462 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:49:30,476 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:49:30,486 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:49:30,496 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/b8c8d031-7fdd-42b1-86ff-612026a16c7e 2026-03-02 03:49:30,502 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-02 03:49:30,502 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:49:30,514 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:49:30,532 - INFO - Verified VN network id 15 for VN ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:49:30,533 - INFO - Verifications in API Server for VN ctest-vn1-79431837 passed 2026-03-02 03:49:30,533 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:49:30,547 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:49:30,557 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:49:30,569 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/b8c8d031-7fdd-42b1-86ff-612026a16c7e 2026-03-02 03:49:30,585 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18382401849312625060', 'uuid-lslong': '13290206363213805456'}, 'enable': 'true', 'created': '2026-03-02T03:48:47', 'last-modified': '2026-03-02T03:48:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:42.401470'} 2026-03-02 03:49:30,594 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-02 03:49:30,601 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18382401849312625060', 'uuid-lslong': '13290206363213805456'}, 'enable': 'true', 'created': '2026-03-02T03:48:47', 'last-modified': '2026-03-02T03:48:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:42.426947'} 2026-03-02 03:49:30,608 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-02 03:49:30,614 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18382401849312625060', 'uuid-lslong': '13290206363213805456'}, 'enable': 'true', 'created': '2026-03-02T03:48:47', 'last-modified': '2026-03-02T03:48:48', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:42.441136'} 2026-03-02 03:49:30,620 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-02 03:49:30,620 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-79431837 passed 2026-03-02 03:49:30,620 - DEBUG - ====Verifying policy data for ctest-vn1-79431837 in API_Server ====== 2026-03-02 03:49:30,620 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:49:30,628 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:49:30,650 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:49:30,793 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:49:30,837 - DEBUG - =>VN ctest-vn1-79431837 has no policy to be verified 2026-03-02 03:49:30,837 - DEBUG - Verifying the vn in opserver 2026-03-02 03:49:30,837 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 virtual network link through opserver 10.0.0.242 2026-03-02 03:49:30,837 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2026-03-02 03:49:30,956 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837?flat'} 2026-03-02 03:49:30,956 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 virtual network link through opserver 10.0.0.27 2026-03-02 03:49:30,956 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-03-02 03:49:31,063 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837?flat'} 2026-03-02 03:49:31,063 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 virtual network link through opserver 10.0.0.23 2026-03-02 03:49:31,064 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-03-02 03:49:31,172 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837?flat'} 2026-03-02 03:49:31,172 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 is found in opserver 2026-03-02 03:49:31,186 - DEBUG - VRF ids for VN ctest-vn1-79431837: {'10.0.0.41': '2'} 2026-03-02 03:49:31,186 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:49:31,192 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:49:31,212 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:49:31,315 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:49:31,338 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:49:31,352 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/da7ac701-5881-43e9-9299-9292cfdeaa0b 2026-03-02 03:49:31,363 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/da7ac701-5881-43e9-9299-9292cfdeaa0b 2026-03-02 03:49:31,373 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/a52b1fc4-f126-4b1e-9342-738534fdccee 2026-03-02 03:49:31,400 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-03-02 03:49:31,400 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:49:31,415 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/da7ac701-5881-43e9-9299-9292cfdeaa0b 2026-03-02 03:49:31,450 - INFO - Verified VN network id 16 for VN 4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:49:31,450 - INFO - Verifications in API Server for VN ctest-vn2-80479153 passed 2026-03-02 03:49:31,450 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:49:31,468 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/da7ac701-5881-43e9-9299-9292cfdeaa0b 2026-03-02 03:49:31,479 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/da7ac701-5881-43e9-9299-9292cfdeaa0b 2026-03-02 03:49:31,491 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/a52b1fc4-f126-4b1e-9342-738534fdccee 2026-03-02 03:49:31,509 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5447513174122187272', 'uuid-lslong': '12475796920150121722'}, 'enable': 'true', 'created': '2026-03-02T03:49:24', 'last-modified': '2026-03-02T03:49:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.939863'} 2026-03-02 03:49:31,521 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-03-02 03:49:31,530 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5447513174122187272', 'uuid-lslong': '12475796920150121722'}, 'enable': 'true', 'created': '2026-03-02T03:49:24', 'last-modified': '2026-03-02T03:49:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.973374'} 2026-03-02 03:49:31,540 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-03-02 03:49:31,545 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5447513174122187272', 'uuid-lslong': '12475796920150121722'}, 'enable': 'true', 'created': '2026-03-02T03:49:24', 'last-modified': '2026-03-02T03:49:24', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.987221'} 2026-03-02 03:49:31,551 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-03-02 03:49:31,552 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-80479153 passed 2026-03-02 03:49:31,552 - DEBUG - ====Verifying policy data for ctest-vn2-80479153 in API_Server ====== 2026-03-02 03:49:31,552 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:49:31,559 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:49:31,573 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:49:31,702 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:49:31,723 - DEBUG - =>VN ctest-vn2-80479153 has no policy to be verified 2026-03-02 03:49:31,723 - DEBUG - Verifying the vn in opserver 2026-03-02 03:49:31,723 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153 virtual network link through opserver 10.0.0.242 2026-03-02 03:49:31,723 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2026-03-02 03:49:31,787 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153?flat'} 2026-03-02 03:49:31,787 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153 virtual network link through opserver 10.0.0.27 2026-03-02 03:49:31,787 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-03-02 03:49:31,808 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153?flat'} 2026-03-02 03:49:31,808 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153 virtual network link through opserver 10.0.0.23 2026-03-02 03:49:31,808 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-03-02 03:49:31,822 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153?flat'} 2026-03-02 03:49:31,822 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153 is found in opserver 2026-03-02 03:49:31,834 - DEBUG - VRF ids for VN ctest-vn2-80479153: {'10.0.0.240': '2'} 2026-03-02 03:49:31,834 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:49:31,840 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:49:31,852 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:49:31,968 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/860c5a20-15e0-42e8-b7d7-a7b391349444 2026-03-02 03:49:31,987 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/860c5a20-15e0-42e8-b7d7-a7b391349444 2026-03-02 03:49:31,999 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/f8fe1f40-6faa-411a-874d-b86dd3fa47a0 2026-03-02 03:49:32,010 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/f8fe1f40-6faa-411a-874d-b86dd3fa47a0 2026-03-02 03:49:32,019 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/82e48bc4-e5e8-4bf2-b41c-fa498cf3e3f5 2026-03-02 03:49:32,027 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-03-02 03:49:32,027 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/860c5a20-15e0-42e8-b7d7-a7b391349444 2026-03-02 03:49:32,043 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/f8fe1f40-6faa-411a-874d-b86dd3fa47a0 2026-03-02 03:49:32,062 - INFO - Verified VN network id 17 for VN 860c5a20-15e0-42e8-b7d7-a7b391349444 2026-03-02 03:49:32,062 - INFO - Verifications in API Server for VN ctest-fip_vn-95824667 passed 2026-03-02 03:49:32,062 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/860c5a20-15e0-42e8-b7d7-a7b391349444 2026-03-02 03:49:32,073 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/f8fe1f40-6faa-411a-874d-b86dd3fa47a0 2026-03-02 03:49:32,085 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/f8fe1f40-6faa-411a-874d-b86dd3fa47a0 2026-03-02 03:49:32,092 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/82e48bc4-e5e8-4bf2-b41c-fa498cf3e3f5 2026-03-02 03:49:32,104 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9659194394655343336', 'uuid-lslong': '13247241218610730052'}, 'enable': 'true', 'created': '2026-03-02T03:49:25', 'last-modified': '2026-03-02T03:49:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.837717'} 2026-03-02 03:49:32,110 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-03-02 03:49:32,115 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9659194394655343336', 'uuid-lslong': '13247241218610730052'}, 'enable': 'true', 'created': '2026-03-02T03:49:25', 'last-modified': '2026-03-02T03:49:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.848781'} 2026-03-02 03:49:32,123 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-03-02 03:49:32,128 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9659194394655343336', 'uuid-lslong': '13247241218610730052'}, 'enable': 'true', 'created': '2026-03-02T03:49:25', 'last-modified': '2026-03-02T03:49:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.861454'} 2026-03-02 03:49:32,133 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-03-02 03:49:32,133 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-95824667 passed 2026-03-02 03:49:32,133 - DEBUG - ====Verifying policy data for ctest-fip_vn-95824667 in API_Server ====== 2026-03-02 03:49:32,133 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:49:32,139 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:49:32,149 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:49:32,257 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/860c5a20-15e0-42e8-b7d7-a7b391349444 2026-03-02 03:49:32,267 - DEBUG - =>VN ctest-fip_vn-95824667 has no policy to be verified 2026-03-02 03:49:32,267 - DEBUG - Verifying the vn in opserver 2026-03-02 03:49:32,267 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667 virtual network link through opserver 10.0.0.242 2026-03-02 03:49:32,267 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2026-03-02 03:49:32,278 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667?flat'} 2026-03-02 03:49:32,278 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667 virtual network link through opserver 10.0.0.27 2026-03-02 03:49:32,278 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-03-02 03:49:32,346 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667?flat'} 2026-03-02 03:49:32,346 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667 virtual network link through opserver 10.0.0.23 2026-03-02 03:49:32,346 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-03-02 03:49:32,418 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667?flat'} 2026-03-02 03:49:32,418 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667 is found in opserver 2026-03-02 03:49:32,439 - DEBUG - VRF ids for VN ctest-fip_vn-95824667: {'10.0.0.240': '3'} 2026-03-02 03:49:32,439 - INFO - Waiting for VM ctest-fvn_vm1-87233324 to be up.. 2026-03-02 03:49:32,520 - DEBUG - VM is in ACTIVE state now 2026-03-02 03:49:32,520 - INFO - VM name : ctest-fvn_vm1-87233324 2026-03-02 03:49:32,605 - DEBUG - VM ctest-fvn_vm1-87233324 ID is 6a2b467c-df2b-4f86-a21e-456c3989229b 2026-03-02 03:49:32,605 - DEBUG - VM ctest-fvn_vm1-87233324 launched on Node an-jenkins-deploy-platform-ansible-os-5413-2 2026-03-02 03:49:32,694 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/6a2b467c-df2b-4f86-a21e-456c3989229b 2026-03-02 03:49:32,704 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/94a58bcb-ba0a-4093-8684-a7124ea109b7 2026-03-02 03:49:35,887 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1024ms') 2026-03-02 03:49:35,887 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1-87233324 failed! 2026-03-02 03:49:35,904 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667 is 208.184.94.65 and allocation pool is NOT set 2026-03-02 03:49:39,986 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1022ms') 2026-03-02 03:49:39,986 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1-87233324 failed! 2026-03-02 03:49:40,000 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667 is 208.184.94.65 and allocation pool is NOT set 2026-03-02 03:49:44,079 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms') 2026-03-02 03:49:44,079 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1-87233324 failed! 2026-03-02 03:49:44,093 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667 is 208.184.94.65 and allocation pool is NOT set 2026-03-02 03:49:48,170 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms') 2026-03-02 03:49:48,170 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1-87233324 failed! 2026-03-02 03:49:48,185 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667 is 208.184.94.65 and allocation pool is NOT set 2026-03-02 03:49:52,268 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1022ms') 2026-03-02 03:49:52,269 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1-87233324 failed! 2026-03-02 03:49:52,284 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667 is 208.184.94.65 and allocation pool is NOT set 2026-03-02 03:49:54,352 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n64 bytes from 169.254.0.4: icmp_seq=1 ttl=63 time=6.30 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=1.98 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 1.981/4.138/6.295/2.157 ms') 2026-03-02 03:49:54,353 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1-87233324 passed 2026-03-02 03:49:54,424 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-02 03:49:54,424 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-87233324, IP 208.184.94.67, Port 22 2026-03-02 03:49:54,493 - DEBUG - Error on ssh to cirros@169.254.0.4:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.4/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.4/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.4/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-03-02 03:49:54,593 - DEBUG - VM ctest-fvn_vm1-87233324 is NOT ready for SSH connections, VM status: ACTIVE 2026-03-02 03:49:59,594 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-02 03:49:59,594 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-87233324, IP 208.184.94.67, Port 22 2026-03-02 03:49:59,661 - DEBUG - Error on ssh to cirros@169.254.0.4:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.4/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.4/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.4/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-03-02 03:49:59,745 - DEBUG - VM ctest-fvn_vm1-87233324 is NOT ready for SSH connections, VM status: ACTIVE 2026-03-02 03:50:04,746 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-02 03:50:04,746 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-87233324, IP 208.184.94.67, Port 22 2026-03-02 03:50:04,921 - DEBUG - VM ctest-fvn_vm1-87233324 is ready for SSH connections 2026-03-02 03:50:04,921 - INFO - Waiting for VM ctest-vn2_vm2-06943545 to be up.. 2026-03-02 03:50:05,008 - DEBUG - VM is in ACTIVE state now 2026-03-02 03:50:05,008 - INFO - VM name : ctest-vn2_vm2-06943545 2026-03-02 03:50:05,089 - DEBUG - VM ctest-vn2_vm2-06943545 ID is 7d63a098-fba1-4828-b1d1-bc2522952ff6 2026-03-02 03:50:05,089 - DEBUG - VM ctest-vn2_vm2-06943545 launched on Node an-jenkins-deploy-platform-ansible-os-5413-2 2026-03-02 03:50:05,173 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/7d63a098-fba1-4828-b1d1-bc2522952ff6 2026-03-02 03:50:05,187 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/094d96a0-bf72-4b41-8e57-326f57ab9365 2026-03-02 03:50:06,348 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=2.13 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.431 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.431/1.279/2.128/0.848 ms') 2026-03-02 03:50:06,348 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn2_vm2-06943545 passed 2026-03-02 03:50:06,423 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-02 03:50:06,423 - DEBUG - Waiting to SSH to VM ctest-vn2_vm2-06943545, IP 89.249.91.67, Port 22 2026-03-02 03:50:06,597 - DEBUG - VM ctest-vn2_vm2-06943545 is ready for SSH connections 2026-03-02 03:50:06,597 - INFO - Waiting for VM mltf_vm to be up.. 2026-03-02 03:50:06,694 - DEBUG - VM is in ACTIVE state now 2026-03-02 03:50:06,694 - INFO - VM name : mltf_vm 2026-03-02 03:50:06,789 - DEBUG - VM mltf_vm ID is f33717d2-431d-45be-bc3c-73288c030f76 2026-03-02 03:50:06,789 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-5413-1 2026-03-02 03:50:06,962 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/f33717d2-431d-45be-bc3c-73288c030f76 2026-03-02 03:50:06,972 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/1159dd2f-ba4c-4b39-ae67-7b8cc186a64a 2026-03-02 03:50:06,981 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/fcaf678b-580b-4eed-a3c1-c2e9e65c8324 2026-03-02 03:50:08,151 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n64 bytes from 169.254.0.5: icmp_seq=1 ttl=63 time=2.25 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.379 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.379/1.312/2.245/0.933 ms') 2026-03-02 03:50:08,151 - INFO - Ping to Metadata IP 169.254.0.5 of VM mltf_vm passed 2026-03-02 03:50:08,223 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-02 03:50:08,223 - DEBUG - Waiting to SSH to VM mltf_vm, IP 130.232.223.5, Port 22 2026-03-02 03:50:08,394 - DEBUG - VM mltf_vm is ready for SSH connections 2026-03-02 03:50:08,463 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-02 03:50:08,463 - DEBUG - Waiting to SSH to VM mltf_vm, IP 130.232.223.5, Port 22 2026-03-02 03:50:08,628 - DEBUG - VM mltf_vm is ready for SSH connections 2026-03-02 03:50:08,630 - INFO - ================================================================================ 2026-03-02 03:50:08,631 - INFO - STARTING TEST : test_verify_session_sampling_teardown 2026-03-02 03:50:08,631 - 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-03-02 03:50:09,914 - DEBUG - Skipping xmpp flap check 2026-03-02 03:50:09,915 - INFO - Initial checks done. Running the testcase now 2026-03-02 03:50:09,915 - INFO - 2026-03-02 03:50:10,038 - INFO - Setting flow export rate: 100 2026-03-02 03:50:10,087 - 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-03-02 03:50:10,431 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'ff1b6916-7ac3-41a4-b870-4c45d6feb790', 'name': 'ctest-vn1-79431837', 'tenant_id': '347cae1e2c5b4d828547e7c1679a160e', 'project_id': '347cae1e2c5b4d828547e7c1679a160e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['6924fa28-62b4-4f0f-ac1d-d38a3be499a7'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-73587336', 'ctest-vn1-79431837'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-73587336', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '130.232.223.0/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-03-02 03:50:10,632 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '4b99745e-a4d0-4a08-ad22-ef330375dcfa', 'name': 'ctest-vn2-80479153', 'tenant_id': '347cae1e2c5b4d828547e7c1679a160e', 'project_id': '347cae1e2c5b4d828547e7c1679a160e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['22b71236-1e08-460b-9b21-b01a0d31d76e'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-73587336', 'ctest-vn2-80479153'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-73587336', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '89.249.91.64/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-03-02 03:50:10,722 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:50:10,728 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:50:10,739 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:50:10,861 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:50:10,877 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:50:10,887 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:50:10,956 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:50:10,968 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/b8c8d031-7fdd-42b1-86ff-612026a16c7e 2026-03-02 03:50:10,980 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-02 03:50:10,981 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:50:10,996 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:50:11,036 - INFO - Verified VN network id 15 for VN ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:50:11,036 - INFO - Verifications in API Server for VN ctest-vn1-79431837 passed 2026-03-02 03:50:11,037 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:50:11,064 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:50:11,082 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:50:11,124 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/b8c8d031-7fdd-42b1-86ff-612026a16c7e 2026-03-02 03:50:11,165 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18382401849312625060', 'uuid-lslong': '13290206363213805456'}, 'enable': 'true', 'created': '2026-03-02T03:48:47', 'last-modified': '2026-03-02T03:50:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.770458'} 2026-03-02 03:50:11,177 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-02 03:50:11,186 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18382401849312625060', 'uuid-lslong': '13290206363213805456'}, 'enable': 'true', 'created': '2026-03-02T03:48:47', 'last-modified': '2026-03-02T03:50:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.788781'} 2026-03-02 03:50:11,204 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-02 03:50:11,210 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18382401849312625060', 'uuid-lslong': '13290206363213805456'}, 'enable': 'true', 'created': '2026-03-02T03:48:47', 'last-modified': '2026-03-02T03:50:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.812609'} 2026-03-02 03:50:11,215 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-02 03:50:11,215 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-79431837 passed 2026-03-02 03:50:11,216 - DEBUG - ====Verifying policy data for ctest-vn1-79431837 in API_Server ====== 2026-03-02 03:50:11,216 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:50:11,222 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:50:11,238 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:50:11,347 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:50:11,358 - DEBUG - ==>Verifying data for policy with id: 1b7e7d9e-d3a3-4ec1-a6f0-1cd55bb16ffc, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-73587336', 'policy1'] 2026-03-02 03:50:11,358 - INFO - VN ctest-vn1-79431837 Policy verification: verify_vn_policy_in_api_server, status: True 2026-03-02 03:50:11,358 - DEBUG - Verifying the vn in opserver 2026-03-02 03:50:11,358 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 virtual network link through opserver 10.0.0.242 2026-03-02 03:50:11,359 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2026-03-02 03:50:11,371 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837?flat'} 2026-03-02 03:50:11,371 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 virtual network link through opserver 10.0.0.27 2026-03-02 03:50:11,371 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-03-02 03:50:11,386 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837?flat'} 2026-03-02 03:50:11,387 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 virtual network link through opserver 10.0.0.23 2026-03-02 03:50:11,387 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-03-02 03:50:11,399 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837?flat'} 2026-03-02 03:50:11,399 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 is found in opserver 2026-03-02 03:50:11,418 - DEBUG - VRF ids for VN ctest-vn1-79431837: {'10.0.0.41': '2'} 2026-03-02 03:50:11,418 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:50:11,424 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:50:11,436 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:50:11,537 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:50:11,553 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:50:11,569 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/da7ac701-5881-43e9-9299-9292cfdeaa0b 2026-03-02 03:50:11,580 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/da7ac701-5881-43e9-9299-9292cfdeaa0b 2026-03-02 03:50:11,595 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/a52b1fc4-f126-4b1e-9342-738534fdccee 2026-03-02 03:50:11,608 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-03-02 03:50:11,608 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:50:11,620 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/da7ac701-5881-43e9-9299-9292cfdeaa0b 2026-03-02 03:50:11,637 - INFO - Verified VN network id 16 for VN 4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:50:11,638 - INFO - Verifications in API Server for VN ctest-vn2-80479153 passed 2026-03-02 03:50:11,638 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:50:11,648 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/da7ac701-5881-43e9-9299-9292cfdeaa0b 2026-03-02 03:50:11,658 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/da7ac701-5881-43e9-9299-9292cfdeaa0b 2026-03-02 03:50:11,665 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/a52b1fc4-f126-4b1e-9342-738534fdccee 2026-03-02 03:50:11,679 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'interests': '0-1', 'advertised': '0-1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5447513174122187272', 'uuid-lslong': '12475796920150121722'}, 'enable': 'true', 'created': '2026-03-02T03:49:24', 'last-modified': '2026-03-02T03:50:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.083616'} 2026-03-02 03:50:11,696 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-03-02 03:50:11,706 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5447513174122187272', 'uuid-lslong': '12475796920150121722'}, 'enable': 'true', 'created': '2026-03-02T03:49:24', 'last-modified': '2026-03-02T03:50:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.110394'} 2026-03-02 03:50:11,714 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-03-02 03:50:11,719 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5447513174122187272', 'uuid-lslong': '12475796920150121722'}, 'enable': 'true', 'created': '2026-03-02T03:49:24', 'last-modified': '2026-03-02T03:50:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.123057'} 2026-03-02 03:50:11,725 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-03-02 03:50:11,725 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-80479153 passed 2026-03-02 03:50:11,725 - DEBUG - ====Verifying policy data for ctest-vn2-80479153 in API_Server ====== 2026-03-02 03:50:11,725 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:50:11,732 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:50:11,745 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:50:11,847 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:50:11,857 - DEBUG - ==>Verifying data for policy with id: 1b7e7d9e-d3a3-4ec1-a6f0-1cd55bb16ffc, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-73587336', 'policy1'] 2026-03-02 03:50:11,857 - INFO - VN ctest-vn2-80479153 Policy verification: verify_vn_policy_in_api_server, status: True 2026-03-02 03:50:11,858 - DEBUG - Verifying the vn in opserver 2026-03-02 03:50:11,858 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153 virtual network link through opserver 10.0.0.242 2026-03-02 03:50:11,858 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2026-03-02 03:50:11,870 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153?flat'} 2026-03-02 03:50:11,870 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153 virtual network link through opserver 10.0.0.27 2026-03-02 03:50:11,870 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-03-02 03:50:11,882 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153?flat'} 2026-03-02 03:50:11,883 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153 virtual network link through opserver 10.0.0.23 2026-03-02 03:50:11,883 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-03-02 03:50:11,896 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153?flat'} 2026-03-02 03:50:11,896 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153 is found in opserver 2026-03-02 03:50:11,908 - DEBUG - VRF ids for VN ctest-vn2-80479153: {'10.0.0.41': '3', '10.0.0.240': '2'} 2026-03-02 03:50:11,908 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:50:11,915 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:50:11,933 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:50:12,029 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:50:12,041 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:50:12,054 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:50:12,064 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:50:12,074 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/b8c8d031-7fdd-42b1-86ff-612026a16c7e 2026-03-02 03:50:12,081 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-02 03:50:12,081 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:50:12,092 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:50:12,111 - INFO - Verified VN network id 15 for VN ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:50:12,111 - INFO - Verifications in API Server for VN ctest-vn1-79431837 passed 2026-03-02 03:50:12,111 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:50:12,123 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:50:12,131 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:50:12,141 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/b8c8d031-7fdd-42b1-86ff-612026a16c7e 2026-03-02 03:50:12,153 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18382401849312625060', 'uuid-lslong': '13290206363213805456'}, 'enable': 'true', 'created': '2026-03-02T03:48:47', 'last-modified': '2026-03-02T03:50:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.760954'} 2026-03-02 03:50:12,160 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-02 03:50:12,166 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18382401849312625060', 'uuid-lslong': '13290206363213805456'}, 'enable': 'true', 'created': '2026-03-02T03:48:47', 'last-modified': '2026-03-02T03:50:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.768407'} 2026-03-02 03:50:12,173 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-02 03:50:12,178 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '18382401849312625060', 'uuid-lslong': '13290206363213805456'}, 'enable': 'true', 'created': '2026-03-02T03:48:47', 'last-modified': '2026-03-02T03:50:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.781292'} 2026-03-02 03:50:12,184 - DEBUG - Route Targets: ['target:64512:8000004'] 2026-03-02 03:50:12,184 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-79431837 passed 2026-03-02 03:50:12,184 - DEBUG - ====Verifying policy data for ctest-vn1-79431837 in API_Server ====== 2026-03-02 03:50:12,184 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:50:12,190 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:50:12,200 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:50:12,296 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/ff1b6916-7ac3-41a4-b870-4c45d6feb790 2026-03-02 03:50:12,309 - DEBUG - ==>Verifying data for policy with id: 1b7e7d9e-d3a3-4ec1-a6f0-1cd55bb16ffc, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-73587336', 'policy1'] 2026-03-02 03:50:12,309 - INFO - VN ctest-vn1-79431837 Policy verification: verify_vn_policy_in_api_server, status: True 2026-03-02 03:50:12,309 - DEBUG - Verifying the vn in opserver 2026-03-02 03:50:12,310 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 virtual network link through opserver 10.0.0.242 2026-03-02 03:50:12,310 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2026-03-02 03:50:12,323 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837?flat'} 2026-03-02 03:50:12,324 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 virtual network link through opserver 10.0.0.27 2026-03-02 03:50:12,324 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-03-02 03:50:12,337 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837?flat'} 2026-03-02 03:50:12,337 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 virtual network link through opserver 10.0.0.23 2026-03-02 03:50:12,337 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-03-02 03:50:12,351 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837?flat'} 2026-03-02 03:50:12,351 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 is found in opserver 2026-03-02 03:50:12,362 - DEBUG - VRF ids for VN ctest-vn1-79431837: {'10.0.0.41': '2'} 2026-03-02 03:50:12,362 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:50:12,368 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:50:12,379 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:50:12,499 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:50:12,512 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:50:12,523 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/da7ac701-5881-43e9-9299-9292cfdeaa0b 2026-03-02 03:50:12,533 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/da7ac701-5881-43e9-9299-9292cfdeaa0b 2026-03-02 03:50:12,542 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/a52b1fc4-f126-4b1e-9342-738534fdccee 2026-03-02 03:50:12,551 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-03-02 03:50:12,551 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:50:12,563 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/da7ac701-5881-43e9-9299-9292cfdeaa0b 2026-03-02 03:50:12,584 - INFO - Verified VN network id 16 for VN 4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:50:12,584 - INFO - Verifications in API Server for VN ctest-vn2-80479153 passed 2026-03-02 03:50:12,584 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:50:12,596 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/da7ac701-5881-43e9-9299-9292cfdeaa0b 2026-03-02 03:50:12,603 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/da7ac701-5881-43e9-9299-9292cfdeaa0b 2026-03-02 03:50:12,612 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/a52b1fc4-f126-4b1e-9342-738534fdccee 2026-03-02 03:50:12,624 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'interests': '0-1', 'advertised': '0-1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5447513174122187272', 'uuid-lslong': '12475796920150121722'}, 'enable': 'true', 'created': '2026-03-02T03:49:24', 'last-modified': '2026-03-02T03:50:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.031066'} 2026-03-02 03:50:12,631 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-03-02 03:50:12,636 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5447513174122187272', 'uuid-lslong': '12475796920150121722'}, 'enable': 'true', 'created': '2026-03-02T03:49:24', 'last-modified': '2026-03-02T03:50:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.040894'} 2026-03-02 03:50:12,643 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-03-02 03:50:12,648 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5447513174122187272', 'uuid-lslong': '12475796920150121722'}, 'enable': 'true', 'created': '2026-03-02T03:49:24', 'last-modified': '2026-03-02T03:50:10', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.051699'} 2026-03-02 03:50:12,653 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-03-02 03:50:12,653 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-80479153 passed 2026-03-02 03:50:12,653 - DEBUG - ====Verifying policy data for ctest-vn2-80479153 in API_Server ====== 2026-03-02 03:50:12,653 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:50:12,658 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:50:12,670 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:50:12,772 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/4b99745e-a4d0-4a08-ad22-ef330375dcfa 2026-03-02 03:50:12,782 - DEBUG - ==>Verifying data for policy with id: 1b7e7d9e-d3a3-4ec1-a6f0-1cd55bb16ffc, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-73587336', 'policy1'] 2026-03-02 03:50:12,782 - INFO - VN ctest-vn2-80479153 Policy verification: verify_vn_policy_in_api_server, status: True 2026-03-02 03:50:12,782 - DEBUG - Verifying the vn in opserver 2026-03-02 03:50:12,782 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153 virtual network link through opserver 10.0.0.242 2026-03-02 03:50:12,782 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2026-03-02 03:50:12,794 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153?flat'} 2026-03-02 03:50:12,794 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153 virtual network link through opserver 10.0.0.27 2026-03-02 03:50:12,794 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-03-02 03:50:12,809 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153?flat'} 2026-03-02 03:50:12,809 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153 virtual network link through opserver 10.0.0.23 2026-03-02 03:50:12,809 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-03-02 03:50:12,821 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153?flat'} 2026-03-02 03:50:12,821 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153 is found in opserver 2026-03-02 03:50:12,833 - DEBUG - VRF ids for VN ctest-vn2-80479153: {'10.0.0.41': '3', '10.0.0.240': '2'} 2026-03-02 03:50:12,833 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:50:12,839 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:50:12,851 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:50:12,951 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/860c5a20-15e0-42e8-b7d7-a7b391349444 2026-03-02 03:50:12,964 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/860c5a20-15e0-42e8-b7d7-a7b391349444 2026-03-02 03:50:12,974 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/f8fe1f40-6faa-411a-874d-b86dd3fa47a0 2026-03-02 03:50:12,982 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/f8fe1f40-6faa-411a-874d-b86dd3fa47a0 2026-03-02 03:50:12,990 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/82e48bc4-e5e8-4bf2-b41c-fa498cf3e3f5 2026-03-02 03:50:13,002 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-03-02 03:50:13,002 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/860c5a20-15e0-42e8-b7d7-a7b391349444 2026-03-02 03:50:13,011 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/f8fe1f40-6faa-411a-874d-b86dd3fa47a0 2026-03-02 03:50:13,027 - INFO - Verified VN network id 17 for VN 860c5a20-15e0-42e8-b7d7-a7b391349444 2026-03-02 03:50:13,027 - INFO - Verifications in API Server for VN ctest-fip_vn-95824667 passed 2026-03-02 03:50:13,027 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/860c5a20-15e0-42e8-b7d7-a7b391349444 2026-03-02 03:50:13,038 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/f8fe1f40-6faa-411a-874d-b86dd3fa47a0 2026-03-02 03:50:13,045 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/f8fe1f40-6faa-411a-874d-b86dd3fa47a0 2026-03-02 03:50:13,052 - DEBUG - Requesting: http://10.0.0.242:8082/route-target/82e48bc4-e5e8-4bf2-b41c-fa498cf3e3f5 2026-03-02 03:50:13,064 - DEBUG - Control-node 10.0.0.242 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9659194394655343336', 'uuid-lslong': '13247241218610730052'}, 'enable': 'true', 'created': '2026-03-02T03:49:25', 'last-modified': '2026-03-02T03:49:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:47.797885'} 2026-03-02 03:50:13,070 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-03-02 03:50:13,076 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9659194394655343336', 'uuid-lslong': '13247241218610730052'}, 'enable': 'true', 'created': '2026-03-02T03:49:25', 'last-modified': '2026-03-02T03:49:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:47.809884'} 2026-03-02 03:50:13,082 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-03-02 03:50:13,087 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-73587336', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9659194394655343336', 'uuid-lslong': '13247241218610730052'}, 'enable': 'true', 'created': '2026-03-02T03:49:25', 'last-modified': '2026-03-02T03:49:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:47.821077'} 2026-03-02 03:50:13,093 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-03-02 03:50:13,093 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-95824667 passed 2026-03-02 03:50:13,093 - DEBUG - ====Verifying policy data for ctest-fip_vn-95824667 in API_Server ====== 2026-03-02 03:50:13,093 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:50:13,098 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:50:13,109 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:50:13,207 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-network/860c5a20-15e0-42e8-b7d7-a7b391349444 2026-03-02 03:50:13,218 - DEBUG - =>VN ctest-fip_vn-95824667 has no policy to be verified 2026-03-02 03:50:13,218 - DEBUG - Verifying the vn in opserver 2026-03-02 03:50:13,218 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667 virtual network link through opserver 10.0.0.242 2026-03-02 03:50:13,218 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/virtual-networks 2026-03-02 03:50:13,231 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667', 'href': 'http://10.0.0.242:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667?flat'} 2026-03-02 03:50:13,231 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667 virtual network link through opserver 10.0.0.27 2026-03-02 03:50:13,231 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-03-02 03:50:13,244 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667?flat'} 2026-03-02 03:50:13,244 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667 virtual network link through opserver 10.0.0.23 2026-03-02 03:50:13,244 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-03-02 03:50:13,256 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667?flat'} 2026-03-02 03:50:13,256 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667 is found in opserver 2026-03-02 03:50:13,267 - DEBUG - VRF ids for VN ctest-fip_vn-95824667: {'10.0.0.240': '3'} 2026-03-02 03:50:13,267 - INFO - start time= 1772423413267224 2026-03-02 03:50:13,267 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 89.249.91.67, host_string: cirros@169.254.0.3, password: gocubsgogateway: ubuntu@10.0.0.41, gateway password: c0ntrail123 2026-03-02 03:50:13,267 - DEBUG - ping -s 56 -c 3 -W 1 89.249.91.67 2026-03-02 03:50:17,109 - DEBUG - PING 89.249.91.67 (89.249.91.67): 56 data bytes 64 bytes from 89.249.91.67: seq=0 ttl=63 time=4.267 ms 64 bytes from 89.249.91.67: seq=1 ttl=63 time=1.339 ms 64 bytes from 89.249.91.67: seq=2 ttl=63 time=1.177 ms --- 89.249.91.67 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.177/2.261/4.267 ms 2026-03-02 03:50:17,109 - INFO - Ping to IP 89.249.91.67 from VM ctest-vn1_vm1-10947738 passed 2026-03-02 03:50:27,109 - INFO - Verify session samples and teardown pkts 2026-03-02 03:50:27,109 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.242 2026-03-02 03:50:27,114 - DEBUG - Posting: http://10.0.0.242:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1772423413267224, 'end_time': 1772423427114357, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'} 2026-03-02 03:50:28,137 - DEBUG - [{'T': 1772423415682549}, {'T': 1772423416682619}, {'T': 1772423417682683}] 2026-03-02 03:50:28,137 - DEBUG - Posting: http://10.0.0.242:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1772423413267224, 'end_time': 1772423428137420, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'} 2026-03-02 03:50:29,157 - DEBUG - [{'T': 1772423415092350}, {'T': 1772423416092429}, {'T': 1772423417092520}] 2026-03-02 03:50:29,157 - DEBUG - Posting: http://10.0.0.242:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1772423413267224, 'end_time': 1772423429157910, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'} 2026-03-02 03:50:30,176 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'sample_count': 3}] 2026-03-02 03:50:30,176 - INFO - wait for the flows to get expire 2026-03-02 03:53:50,177 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5413-1:Compute:contrail-vrouter-agent:0?flat 2026-03-02 03:53:50,216 - DEBUG - Requesting: http://10.0.0.242:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5413-1?flat 2026-03-02 03:53:50,249 - DEBUG - Posting: http://10.0.0.242:8081/analytics/query, payload {'table': 'SessionRecordTable', 'start_time': 1772423413267224, 'end_time': 1772423630249701, 'select_fields': ['vn', 'remote_vn', 'forward_teardown_pkts', 'reverse_teardown_pkts'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'} 2026-03-02 03:53:51,269 - DEBUG - [{'forward_flow_uuid': 'f3caa684-6341-4bf6-a690-a165024a35a7', 'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'reverse_flow_uuid': '8f1b4959-c7be-428d-abda-14f65054db99', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'forward_teardown_pkts': 3, 'reverse_teardown_pkts': 3}] 2026-03-02 03:53:51,269 - DEBUG - Posting: http://10.0.0.242:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1772423413267224, 'end_time': 1772423631269600, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'} 2026-03-02 03:53:52,287 - DEBUG - Posting: http://10.0.0.242:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1772423413267224, 'end_time': 1772423632287442, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'} 2026-03-02 03:53:53,306 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153', 'sample_count': 4}] 2026-03-02 03:53:53,795 - INFO - Deleted policy policy1 2026-03-02 03:53:53,910 - INFO - Setting flow export rate: None 2026-03-02 03:53:55,174 - DEBUG - Skipping xmpp flap check
2026-03-02 03:53:55,175 - INFO - END TEST : test_verify_session_sampling_teardown : PASSED[0:03:47]
2026-03-02 03:53:55,175 - INFO - -------------------------------------------------------------------------------- 2026-03-02 03:53:55,176 - INFO - Deleting VM mltf_vm 2026-03-02 03:53:55,252 - INFO - Deleting VM ctest-fvn_vm1-87233324 2026-03-02 03:53:55,319 - INFO - Deleting VM ctest-vn2_vm2-06943545 2026-03-02 03:53:55,386 - INFO - Deleting VN ctest-fip_vn-95824667 2026-03-02 03:53:55,432 - DEBUG - VN 860c5a20-15e0-42e8-b7d7-a7b391349444 still in use: Unable to complete operation on network 860c5a20-15e0-42e8-b7d7-a7b391349444. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-f4b47669-f35c-466f-b47c-aeb4c5124264'] 2026-03-02 03:53:55,432 - WARNING - Deleting VN ctest-fip_vn-95824667 failed..Will retry 2026-03-02 03:53:57,608 - DEBUG - Response for deleting network () 2026-03-02 03:53:57,609 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/f8fe1f40-6faa-411a-874d-b86dd3fa47a0 2026-03-02 03:53:57,671 - DEBUG - Response Code: 404 2026-03-02 03:53:57,671 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:53:57,680 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:53:57,750 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:53:57,854 - INFO - Validated that VN ctest-fip_vn-95824667 is not found in API Server 2026-03-02 03:53:57,868 - DEBUG - VN ctest-fip_vn-95824667 is not present in Agent 10.0.0.41 2026-03-02 03:53:57,878 - DEBUG - VN ctest-fip_vn-95824667 is not present in Agent 10.0.0.240 2026-03-02 03:53:57,878 - INFO - Validated that VN ctest-fip_vn-95824667 is not in any agent 2026-03-02 03:53:57,886 - DEBUG - VRF 3 is not seen in agent 10.0.0.240 2026-03-02 03:53:57,891 - DEBUG - Vrouter 10.0.0.240 does not have vrf 3 for VN ctest-fip_vn-95824667 2026-03-02 03:53:57,891 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-fip_vn-95824667 2026-03-02 03:53:57,911 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-95824667 info 2026-03-02 03:53:57,911 - INFO - Deleting VN ctest-vn2-80479153 2026-03-02 03:53:58,132 - DEBUG - Response for deleting network () 2026-03-02 03:53:58,132 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/da7ac701-5881-43e9-9299-9292cfdeaa0b 2026-03-02 03:53:58,138 - DEBUG - Response Code: 404 2026-03-02 03:53:58,138 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:53:58,144 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:53:58,154 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:53:58,247 - INFO - Validated that VN ctest-vn2-80479153 is not found in API Server 2026-03-02 03:53:58,258 - DEBUG - VN ctest-vn2-80479153 is not present in Agent 10.0.0.41 2026-03-02 03:53:58,268 - DEBUG - VN ctest-vn2-80479153 is not present in Agent 10.0.0.240 2026-03-02 03:53:58,268 - INFO - Validated that VN ctest-vn2-80479153 is not in any agent 2026-03-02 03:53:58,273 - DEBUG - VRF 3 is not seen in agent 10.0.0.41 2026-03-02 03:53:58,278 - DEBUG - Vrouter 10.0.0.41 does not have vrf 3 for VN ctest-vn2-80479153 2026-03-02 03:53:58,283 - DEBUG - VRF 2 is not seen in agent 10.0.0.240 2026-03-02 03:53:58,287 - DEBUG - Vrouter 10.0.0.240 does not have vrf 2 for VN ctest-vn2-80479153 2026-03-02 03:53:58,287 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn2-80479153 2026-03-02 03:53:58,307 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-80479153 info 2026-03-02 03:53:58,307 - INFO - Deleting VM ctest-vn1_vm2-28943584 2026-03-02 03:53:58,385 - INFO - Deleting VM ctest-vn1_vm1-10947738 2026-03-02 03:53:58,449 - INFO - Deleting VN ctest-vn1-79431837 2026-03-02 03:53:58,496 - DEBUG - VN ff1b6916-7ac3-41a4-b870-4c45d6feb790 still in use: Unable to complete operation on network ff1b6916-7ac3-41a4-b870-4c45d6feb790. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-5a64b1a2-5dbf-4908-9998-abde4ba09aa3'] 2026-03-02 03:53:58,496 - WARNING - Deleting VN ctest-vn1-79431837 failed..Will retry 2026-03-02 03:54:00,637 - DEBUG - Response for deleting network () 2026-03-02 03:54:00,637 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/b82c6720-a9b8-41ce-ba0b-66627157d921 2026-03-02 03:54:00,643 - DEBUG - Response Code: 404 2026-03-02 03:54:00,643 - DEBUG - Requesting: http://10.0.0.242:8082/domains 2026-03-02 03:54:00,648 - DEBUG - Requesting: http://10.0.0.242:8082/domain/cc2d0805-fa5b-4698-bfcc-d7811c08231a 2026-03-02 03:54:00,664 - DEBUG - Requesting: http://10.0.0.242:8082/project/347cae1e-2c5b-4d82-8547-e7c1679a160e 2026-03-02 03:54:00,747 - INFO - Validated that VN ctest-vn1-79431837 is not found in API Server 2026-03-02 03:54:00,757 - DEBUG - VN ctest-vn1-79431837 is not present in Agent 10.0.0.41 2026-03-02 03:54:00,769 - DEBUG - VN ctest-vn1-79431837 is not present in Agent 10.0.0.240 2026-03-02 03:54:00,769 - INFO - Validated that VN ctest-vn1-79431837 is not in any agent 2026-03-02 03:54:00,774 - DEBUG - VRF 2 is not seen in agent 10.0.0.41 2026-03-02 03:54:00,779 - DEBUG - Vrouter 10.0.0.41 does not have vrf 2 for VN ctest-vn1-79431837 2026-03-02 03:54:00,779 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-73587336:ctest-vn1-79431837 2026-03-02 03:54:00,797 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-79431837 info 2026-03-02 03:54:01,595 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-73587336, ID : 347cae1e-2c5b-4d82-8547-e7c1679a160e