2026-05-20 16:26:09,412 - INFO - Domain Default found not creating 2026-05-20 16:26:09,692 - INFO - Project ctest-AnalyticsTestSanityWithResource-76328617 not found, creating it 2026-05-20 16:26:10,256 - INFO - Created Project:ctest-AnalyticsTestSanityWithResource-76328617, ID : 6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:26:13,122 - DEBUG - Response for create_network : {'network': {'id': '39cba233-dadf-46d4-bf9f-c718cc52741a', 'name': 'ctest-vn1-59722768', 'tenant_id': '6be4856485674728ad65fa36dcd82299', 'project_id': '6be4856485674728ad65fa36dcd82299', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-76328617', 'ctest-vn1-59722768'], 'port_security_enabled': True, 'description': ''}} 2026-05-20 16:26:13,442 - DEBUG - Response for create_subnet : {'subnet': {'id': '10726946-b75e-41b9-b255-e41759e6050f', 'name': '', 'tenant_id': '6be4856485674728ad65fa36dcd82299', 'network_id': '39cba233-dadf-46d4-bf9f-c718cc52741a', 'ip_version': 4, 'cidr': '103.80.129.0/26', 'allocation_pools': [{'start': '103.80.129.2', 'end': '103.80.129.62'}], 'gateway_ip': '103.80.129.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '103.80.129.2', 'tags': [], 'project_id': '6be4856485674728ad65fa36dcd82299'}} 2026-05-20 16:26:13,472 - INFO - Created VN ctest-vn1-59722768 2026-05-20 16:26:13,488 - DEBUG - VN ctest-vn1-59722768 UUID is 39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:26:13,635 - DEBUG - Services list from nova: [, , , ] 2026-05-20 16:26:13,635 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5803-2', 'an-jenkins-deploy-platform-ansible-os-5803-1']} 2026-05-20 16:26:15,272 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5803-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5803-2) 2026-05-20 16:26:17,094 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5803-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5803-2) 2026-05-20 16:26:17,094 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:26:17,474 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:26:17,522 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:26:17,548 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:26:17,671 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:26:17,691 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:26:17,704 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:26:17,715 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:26:17,725 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/fe5921b5-459d-4561-8513-b75552f337fe 2026-05-20 16:26:17,733 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-20 16:26:17,733 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:26:17,749 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:26:17,773 - INFO - Verified VN network id 14 for VN 39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:26:17,774 - INFO - Verifications in API Server for VN ctest-vn1-59722768 passed 2026-05-20 16:26:17,774 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:26:17,835 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:26:17,863 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:26:17,900 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/fe5921b5-459d-4561-8513-b75552f337fe 2026-05-20 16:26:17,923 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4164600624033253076', 'uuid-lslong': '13807973891862328346'}, 'enable': 'true', 'created': '2026-05-20T16:26:13', 'last-modified': '2026-05-20T16:26:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:04.530978'} 2026-05-20 16:26:17,934 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-20 16:26:17,944 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4164600624033253076', 'uuid-lslong': '13807973891862328346'}, 'enable': 'true', 'created': '2026-05-20T16:26:13', 'last-modified': '2026-05-20T16:26:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:04.566729'} 2026-05-20 16:26:17,951 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-20 16:26:17,957 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4164600624033253076', 'uuid-lslong': '13807973891862328346'}, 'enable': 'true', 'created': '2026-05-20T16:26:13', 'last-modified': '2026-05-20T16:26:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:04.581684'} 2026-05-20 16:26:17,964 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-20 16:26:17,964 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-59722768 passed 2026-05-20 16:26:17,965 - DEBUG - ====Verifying policy data for ctest-vn1-59722768 in API_Server ====== 2026-05-20 16:26:17,965 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:26:17,980 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:26:18,008 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:26:18,122 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:26:18,142 - DEBUG - =>VN ctest-vn1-59722768 has no policy to be verified 2026-05-20 16:26:18,142 - DEBUG - Verifying the vn in opserver 2026-05-20 16:26:18,142 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 virtual network link through opserver 10.0.0.57 2026-05-20 16:26:18,143 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks 2026-05-20 16:26:18,582 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks 2026-05-20 16:26:18,674 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768?flat'} 2026-05-20 16:26:18,674 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 virtual network link through opserver 10.0.0.141 2026-05-20 16:26:18,674 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks 2026-05-20 16:26:19,049 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks 2026-05-20 16:26:19,130 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768?flat'} 2026-05-20 16:26:19,130 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 virtual network link through opserver 10.0.0.56 2026-05-20 16:26:19,130 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks 2026-05-20 16:26:19,485 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks 2026-05-20 16:26:19,562 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768?flat'} 2026-05-20 16:26:19,562 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 is found in opserver 2026-05-20 16:26:19,575 - DEBUG - VRF ids for VN ctest-vn1-59722768: {'10.0.0.249': '4'} 2026-05-20 16:26:19,575 - INFO - Waiting for VM ctest-vn1_vm1-12652917 to be up.. 2026-05-20 16:26:19,700 - DEBUG - VM is in ACTIVE state now 2026-05-20 16:26:19,700 - INFO - VM name : ctest-vn1_vm1-12652917 2026-05-20 16:26:19,832 - DEBUG - VM ctest-vn1_vm1-12652917 ID is 31af8fe2-4cbb-4fbd-9951-9450035a428a 2026-05-20 16:26:19,875 - DEBUG - VM ctest-vn1_vm1-12652917 launched on Node an-jenkins-deploy-platform-ansible-os-5803-2 2026-05-20 16:26:20,004 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-machine/31af8fe2-4cbb-4fbd-9951-9450035a428a 2026-05-20 16:26:20,384 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-machine/31af8fe2-4cbb-4fbd-9951-9450035a428a 2026-05-20 16:26:20,428 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-machine-interface/88c7b29c-93e9-49e9-8ecd-fa613e66152e 2026-05-20 16:26:23,602 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1003ms') 2026-05-20 16:26:23,603 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vn1_vm1-12652917 failed! 2026-05-20 16:26:23,619 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 is 103.80.129.1 and allocation pool is NOT set 2026-05-20 16:26:27,698 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms') 2026-05-20 16:26:27,698 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vn1_vm1-12652917 failed! 2026-05-20 16:26:27,714 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 is 103.80.129.1 and allocation pool is NOT set 2026-05-20 16:26:31,792 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms') 2026-05-20 16:26:31,792 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vn1_vm1-12652917 failed! 2026-05-20 16:26:31,810 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 is 103.80.129.1 and allocation pool is NOT set 2026-05-20 16:26:35,895 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms') 2026-05-20 16:26:35,895 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vn1_vm1-12652917 failed! 2026-05-20 16:26:35,910 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 is 103.80.129.1 and allocation pool is NOT set 2026-05-20 16:26:39,992 - 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=2 ttl=63 time=3.58 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1015ms\r\nrtt min/avg/max/mdev = 3.577/3.577/3.577/0.000 ms') 2026-05-20 16:26:39,992 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-vn1_vm1-12652917 passed 2026-05-20 16:26:40,064 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-20 16:26:40,064 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-12652917, IP 103.80.129.3, Port 22 2026-05-20 16:26:40,131 - DEBUG - Error on ssh to cirros@169.254.0.5:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.5/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.5/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.5/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-05-20 16:26:40,241 - DEBUG - VM ctest-vn1_vm1-12652917 is NOT ready for SSH connections, VM status: ACTIVE 2026-05-20 16:26:45,242 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-20 16:26:45,243 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-12652917, IP 103.80.129.3, Port 22 2026-05-20 16:26:45,311 - DEBUG - Error on ssh to cirros@169.254.0.5:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.5/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.5/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.5/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-05-20 16:26:45,421 - DEBUG - VM ctest-vn1_vm1-12652917 is NOT ready for SSH connections, VM status: ACTIVE 2026-05-20 16:26:50,422 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-20 16:26:50,422 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-12652917, IP 103.80.129.3, Port 22 2026-05-20 16:26:50,581 - DEBUG - VM ctest-vn1_vm1-12652917 is ready for SSH connections 2026-05-20 16:26:50,581 - INFO - Waiting for VM ctest-vn1_vm2-03335039 to be up.. 2026-05-20 16:26:50,686 - DEBUG - VM is in ACTIVE state now 2026-05-20 16:26:50,686 - INFO - VM name : ctest-vn1_vm2-03335039 2026-05-20 16:26:50,794 - DEBUG - VM ctest-vn1_vm2-03335039 ID is ac1d2656-0dda-4ae1-804c-0c05139958ac 2026-05-20 16:26:50,794 - DEBUG - VM ctest-vn1_vm2-03335039 launched on Node an-jenkins-deploy-platform-ansible-os-5803-2 2026-05-20 16:26:50,907 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-machine/ac1d2656-0dda-4ae1-804c-0c05139958ac 2026-05-20 16:26:50,921 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-machine-interface/9475cd8d-9421-42c0-baff-2b92745001cf 2026-05-20 16:26:52,112 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n64 bytes from 169.254.0.6: icmp_seq=1 ttl=63 time=4.40 ms\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=0.745 ms\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.745/2.570/4.395/1.825 ms') 2026-05-20 16:26:52,112 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-vn1_vm2-03335039 passed 2026-05-20 16:26:52,183 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-20 16:26:52,183 - DEBUG - Waiting to SSH to VM ctest-vn1_vm2-03335039, IP 103.80.129.4, Port 22 2026-05-20 16:26:52,360 - DEBUG - VM ctest-vn1_vm2-03335039 is ready for SSH connections 2026-05-20 16:26:52,671 - DEBUG - Response for create_network : {'network': {'id': '3c2a3d72-6660-430c-94d1-a524065e3e62', 'name': 'ctest-vn2-50834622', 'tenant_id': '6be4856485674728ad65fa36dcd82299', 'project_id': '6be4856485674728ad65fa36dcd82299', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-76328617', 'ctest-vn2-50834622'], 'port_security_enabled': True, 'description': ''}} 2026-05-20 16:26:52,945 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f32ee487-53d3-401d-976b-fd8fdc8c33da', 'name': '', 'tenant_id': '6be4856485674728ad65fa36dcd82299', 'network_id': '3c2a3d72-6660-430c-94d1-a524065e3e62', 'ip_version': 4, 'cidr': '216.156.71.192/26', 'allocation_pools': [{'start': '216.156.71.194', 'end': '216.156.71.254'}], 'gateway_ip': '216.156.71.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '216.156.71.194', 'tags': [], 'project_id': '6be4856485674728ad65fa36dcd82299'}} 2026-05-20 16:26:52,974 - INFO - Created VN ctest-vn2-50834622 2026-05-20 16:26:52,987 - DEBUG - VN ctest-vn2-50834622 UUID is 3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:26:53,417 - DEBUG - Response for create_network : {'network': {'id': '0eed356d-7b4c-4868-b4a8-9269391dea05', 'name': 'ctest-fip_vn-81973322', 'tenant_id': '6be4856485674728ad65fa36dcd82299', 'project_id': '6be4856485674728ad65fa36dcd82299', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-76328617', 'ctest-fip_vn-81973322'], 'port_security_enabled': True, 'description': ''}} 2026-05-20 16:26:53,740 - DEBUG - Response for create_subnet : {'subnet': {'id': '22e5b61e-9f4b-44aa-99ea-1e2765f75d43', 'name': '', 'tenant_id': '6be4856485674728ad65fa36dcd82299', 'network_id': '0eed356d-7b4c-4868-b4a8-9269391dea05', 'ip_version': 4, 'cidr': '112.35.75.192/26', 'allocation_pools': [{'start': '112.35.75.194', 'end': '112.35.75.254'}], 'gateway_ip': '112.35.75.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '112.35.75.194', 'tags': [], 'project_id': '6be4856485674728ad65fa36dcd82299'}} 2026-05-20 16:26:53,767 - INFO - Created VN ctest-fip_vn-81973322 2026-05-20 16:26:53,782 - DEBUG - VN ctest-fip_vn-81973322 UUID is 0eed356d-7b4c-4868-b4a8-9269391dea05 2026-05-20 16:26:53,862 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5803-2', 'an-jenkins-deploy-platform-ansible-os-5803-1']} 2026-05-20 16:26:55,390 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5803-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5803-1) 2026-05-20 16:26:57,186 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5803-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5803-1) 2026-05-20 16:26:59,684 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5803-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5803-2) 2026-05-20 16:26:59,685 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:26:59,693 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:26:59,719 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:26:59,833 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:26:59,853 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:26:59,866 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:26:59,883 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:26:59,896 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/fe5921b5-459d-4561-8513-b75552f337fe 2026-05-20 16:26:59,906 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-20 16:26:59,906 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:26:59,922 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:26:59,943 - INFO - Verified VN network id 14 for VN 39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:26:59,943 - INFO - Verifications in API Server for VN ctest-vn1-59722768 passed 2026-05-20 16:26:59,944 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:26:59,958 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:26:59,970 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:26:59,980 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/fe5921b5-459d-4561-8513-b75552f337fe 2026-05-20 16:27:00,004 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4164600624033253076', 'uuid-lslong': '13807973891862328346'}, 'enable': 'true', 'created': '2026-05-20T16:26:13', 'last-modified': '2026-05-20T16:26:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:46.610862'} 2026-05-20 16:27:00,021 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-20 16:27:00,028 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4164600624033253076', 'uuid-lslong': '13807973891862328346'}, 'enable': 'true', 'created': '2026-05-20T16:26:13', 'last-modified': '2026-05-20T16:26:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:46.654175'} 2026-05-20 16:27:00,035 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-20 16:27:00,048 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4164600624033253076', 'uuid-lslong': '13807973891862328346'}, 'enable': 'true', 'created': '2026-05-20T16:26:13', 'last-modified': '2026-05-20T16:26:13', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:46.668711'} 2026-05-20 16:27:00,060 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-20 16:27:00,060 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-59722768 passed 2026-05-20 16:27:00,061 - DEBUG - ====Verifying policy data for ctest-vn1-59722768 in API_Server ====== 2026-05-20 16:27:00,061 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:27:00,071 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:27:00,100 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:27:00,279 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:27:00,294 - DEBUG - =>VN ctest-vn1-59722768 has no policy to be verified 2026-05-20 16:27:00,294 - DEBUG - Verifying the vn in opserver 2026-05-20 16:27:00,294 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 virtual network link through opserver 10.0.0.57 2026-05-20 16:27:00,294 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks 2026-05-20 16:27:00,473 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768?flat'} 2026-05-20 16:27:00,473 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 virtual network link through opserver 10.0.0.141 2026-05-20 16:27:00,473 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks 2026-05-20 16:27:00,720 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768?flat'} 2026-05-20 16:27:00,720 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 virtual network link through opserver 10.0.0.56 2026-05-20 16:27:00,720 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks 2026-05-20 16:27:00,957 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768?flat'} 2026-05-20 16:27:00,957 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 is found in opserver 2026-05-20 16:27:00,972 - DEBUG - VRF ids for VN ctest-vn1-59722768: {'10.0.0.249': '4'} 2026-05-20 16:27:00,972 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:27:00,980 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:27:01,008 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:27:01,183 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:01,210 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:01,226 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/54ddf531-17e1-4ac1-abaf-b507e0d07c22 2026-05-20 16:27:01,241 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/54ddf531-17e1-4ac1-abaf-b507e0d07c22 2026-05-20 16:27:01,250 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/8c38e20a-4d29-4cb6-aca1-541e50fcc707 2026-05-20 16:27:01,260 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-20 16:27:01,260 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:01,277 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/54ddf531-17e1-4ac1-abaf-b507e0d07c22 2026-05-20 16:27:01,297 - INFO - Verified VN network id 15 for VN 3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:01,298 - INFO - Verifications in API Server for VN ctest-vn2-50834622 passed 2026-05-20 16:27:01,298 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:01,313 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/54ddf531-17e1-4ac1-abaf-b507e0d07c22 2026-05-20 16:27:01,323 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/54ddf531-17e1-4ac1-abaf-b507e0d07c22 2026-05-20 16:27:01,335 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/8c38e20a-4d29-4cb6-aca1-541e50fcc707 2026-05-20 16:27:01,369 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4335345152850674444', 'uuid-lslong': '10723533761890106978'}, 'enable': 'true', 'created': '2026-05-20T16:26:52', 'last-modified': '2026-05-20T16:26:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:08.482880'} 2026-05-20 16:27:01,386 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-20 16:27:01,394 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4335345152850674444', 'uuid-lslong': '10723533761890106978'}, 'enable': 'true', 'created': '2026-05-20T16:26:52', 'last-modified': '2026-05-20T16:26:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:08.507690'} 2026-05-20 16:27:01,426 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-20 16:27:01,445 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4335345152850674444', 'uuid-lslong': '10723533761890106978'}, 'enable': 'true', 'created': '2026-05-20T16:26:52', 'last-modified': '2026-05-20T16:26:52', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:08.555005'} 2026-05-20 16:27:01,457 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-20 16:27:01,457 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-50834622 passed 2026-05-20 16:27:01,457 - DEBUG - ====Verifying policy data for ctest-vn2-50834622 in API_Server ====== 2026-05-20 16:27:01,457 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:27:01,472 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:27:01,489 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:27:01,603 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:01,627 - DEBUG - =>VN ctest-vn2-50834622 has no policy to be verified 2026-05-20 16:27:01,627 - DEBUG - Verifying the vn in opserver 2026-05-20 16:27:01,628 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622 virtual network link through opserver 10.0.0.57 2026-05-20 16:27:01,628 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks 2026-05-20 16:27:01,661 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622?flat'} 2026-05-20 16:27:01,661 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622 virtual network link through opserver 10.0.0.141 2026-05-20 16:27:01,661 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks 2026-05-20 16:27:01,675 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622?flat'} 2026-05-20 16:27:01,675 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622 virtual network link through opserver 10.0.0.56 2026-05-20 16:27:01,676 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks 2026-05-20 16:27:01,836 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622?flat'} 2026-05-20 16:27:01,836 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622 is found in opserver 2026-05-20 16:27:01,859 - DEBUG - VRF ids for VN ctest-vn2-50834622: {'10.0.0.242': '4'} 2026-05-20 16:27:01,859 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:27:01,871 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:27:01,887 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:27:02,011 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/0eed356d-7b4c-4868-b4a8-9269391dea05 2026-05-20 16:27:02,028 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/0eed356d-7b4c-4868-b4a8-9269391dea05 2026-05-20 16:27:02,046 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/11fdf478-2e14-4661-ab68-eded44733d75 2026-05-20 16:27:02,061 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/11fdf478-2e14-4661-ab68-eded44733d75 2026-05-20 16:27:02,073 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/604ecbe1-e672-4718-9929-1d43edadce8d 2026-05-20 16:27:02,085 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-05-20 16:27:02,085 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/0eed356d-7b4c-4868-b4a8-9269391dea05 2026-05-20 16:27:02,098 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/11fdf478-2e14-4661-ab68-eded44733d75 2026-05-20 16:27:02,119 - INFO - Verified VN network id 16 for VN 0eed356d-7b4c-4868-b4a8-9269391dea05 2026-05-20 16:27:02,119 - INFO - Verifications in API Server for VN ctest-fip_vn-81973322 passed 2026-05-20 16:27:02,120 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/0eed356d-7b4c-4868-b4a8-9269391dea05 2026-05-20 16:27:02,136 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/11fdf478-2e14-4661-ab68-eded44733d75 2026-05-20 16:27:02,146 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/11fdf478-2e14-4661-ab68-eded44733d75 2026-05-20 16:27:02,157 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/604ecbe1-e672-4718-9929-1d43edadce8d 2026-05-20 16:27:02,178 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1075574630347720808', 'uuid-lslong': '13017815703541901829'}, 'enable': 'true', 'created': '2026-05-20T16:26:53', 'last-modified': '2026-05-20T16:26:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:08.546297'} 2026-05-20 16:27:02,194 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-05-20 16:27:02,202 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1075574630347720808', 'uuid-lslong': '13017815703541901829'}, 'enable': 'true', 'created': '2026-05-20T16:26:53', 'last-modified': '2026-05-20T16:26:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:08.573062'} 2026-05-20 16:27:02,211 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-05-20 16:27:02,218 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1075574630347720808', 'uuid-lslong': '13017815703541901829'}, 'enable': 'true', 'created': '2026-05-20T16:26:53', 'last-modified': '2026-05-20T16:26:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:08.590267'} 2026-05-20 16:27:02,228 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-05-20 16:27:02,228 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-81973322 passed 2026-05-20 16:27:02,229 - DEBUG - ====Verifying policy data for ctest-fip_vn-81973322 in API_Server ====== 2026-05-20 16:27:02,229 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:27:02,249 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:27:02,272 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:27:02,397 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/0eed356d-7b4c-4868-b4a8-9269391dea05 2026-05-20 16:27:02,420 - DEBUG - =>VN ctest-fip_vn-81973322 has no policy to be verified 2026-05-20 16:27:02,420 - DEBUG - Verifying the vn in opserver 2026-05-20 16:27:02,420 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322 virtual network link through opserver 10.0.0.57 2026-05-20 16:27:02,420 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks 2026-05-20 16:27:02,511 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322?flat'} 2026-05-20 16:27:02,512 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322 virtual network link through opserver 10.0.0.141 2026-05-20 16:27:02,512 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks 2026-05-20 16:27:02,606 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322?flat'} 2026-05-20 16:27:02,606 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322 virtual network link through opserver 10.0.0.56 2026-05-20 16:27:02,606 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks 2026-05-20 16:27:02,621 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322?flat'} 2026-05-20 16:27:02,621 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322 is found in opserver 2026-05-20 16:27:02,635 - DEBUG - VRF ids for VN ctest-fip_vn-81973322: {'10.0.0.242': '5'} 2026-05-20 16:27:02,635 - INFO - Waiting for VM ctest-fvn_vm1-43023678 to be up.. 2026-05-20 16:27:02,744 - DEBUG - VM is in ACTIVE state now 2026-05-20 16:27:02,744 - INFO - VM name : ctest-fvn_vm1-43023678 2026-05-20 16:27:02,853 - DEBUG - VM ctest-fvn_vm1-43023678 ID is 55cb332f-8191-4ed0-bad7-413a94befb2d 2026-05-20 16:27:02,853 - DEBUG - VM ctest-fvn_vm1-43023678 launched on Node an-jenkins-deploy-platform-ansible-os-5803-1 2026-05-20 16:27:02,968 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-machine/55cb332f-8191-4ed0-bad7-413a94befb2d 2026-05-20 16:27:02,979 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-machine-interface/097058c8-7450-46b1-b233-9527042f4b1a 2026-05-20 16:27:06,171 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1024ms') 2026-05-20 16:27:06,171 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-fvn_vm1-43023678 failed! 2026-05-20 16:27:06,187 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322 is 112.35.75.193 and allocation pool is NOT set 2026-05-20 16:27:10,264 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1013ms') 2026-05-20 16:27:10,265 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-fvn_vm1-43023678 failed! 2026-05-20 16:27:10,283 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322 is 112.35.75.193 and allocation pool is NOT set 2026-05-20 16:27:14,359 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms') 2026-05-20 16:27:14,359 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-fvn_vm1-43023678 failed! 2026-05-20 16:27:14,378 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322 is 112.35.75.193 and allocation pool is NOT set 2026-05-20 16:27:18,455 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms') 2026-05-20 16:27:18,455 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-fvn_vm1-43023678 failed! 2026-05-20 16:27:18,473 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322 is 112.35.75.193 and allocation pool is NOT set 2026-05-20 16:27:22,551 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1021ms') 2026-05-20 16:27:22,551 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-fvn_vm1-43023678 failed! 2026-05-20 16:27:22,566 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322 is 112.35.75.193 and allocation pool is NOT set 2026-05-20 16:27:26,650 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=7.59 ms\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1014ms\r\nrtt min/avg/max/mdev = 7.591/7.591/7.591/0.000 ms') 2026-05-20 16:27:26,650 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-fvn_vm1-43023678 passed 2026-05-20 16:27:26,725 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-20 16:27:26,725 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-43023678, IP 112.35.75.195, Port 22 2026-05-20 16:27:26,800 - DEBUG - Error on ssh to cirros@169.254.0.6:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-05-20 16:27:26,899 - DEBUG - VM ctest-fvn_vm1-43023678 is NOT ready for SSH connections, VM status: ACTIVE 2026-05-20 16:27:31,900 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-20 16:27:31,900 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-43023678, IP 112.35.75.195, Port 22 2026-05-20 16:27:31,969 - DEBUG - Error on ssh to cirros@169.254.0.6:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-05-20 16:27:32,073 - DEBUG - VM ctest-fvn_vm1-43023678 is NOT ready for SSH connections, VM status: ACTIVE 2026-05-20 16:27:37,074 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-20 16:27:37,074 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-43023678, IP 112.35.75.195, Port 22 2026-05-20 16:27:37,252 - DEBUG - VM ctest-fvn_vm1-43023678 is ready for SSH connections 2026-05-20 16:27:37,252 - INFO - Waiting for VM ctest-vn2_vm2-28209418 to be up.. 2026-05-20 16:27:37,366 - DEBUG - VM is in ACTIVE state now 2026-05-20 16:27:37,366 - INFO - VM name : ctest-vn2_vm2-28209418 2026-05-20 16:27:37,487 - DEBUG - VM ctest-vn2_vm2-28209418 ID is 0e6f2d4e-805f-41e3-bfe7-b08b879f80b6 2026-05-20 16:27:37,487 - DEBUG - VM ctest-vn2_vm2-28209418 launched on Node an-jenkins-deploy-platform-ansible-os-5803-1 2026-05-20 16:27:37,594 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-machine/0e6f2d4e-805f-41e3-bfe7-b08b879f80b6 2026-05-20 16:27:37,606 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-machine-interface/cd1cf0d9-0956-4615-b48f-81767ab288e7 2026-05-20 16:27:38,790 - 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=5.91 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=2.43 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 = 2.431/4.168/5.906/1.737 ms') 2026-05-20 16:27:38,790 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-vn2_vm2-28209418 passed 2026-05-20 16:27:38,868 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-20 16:27:38,868 - DEBUG - Waiting to SSH to VM ctest-vn2_vm2-28209418, IP 216.156.71.195, Port 22 2026-05-20 16:27:39,040 - DEBUG - VM ctest-vn2_vm2-28209418 is ready for SSH connections 2026-05-20 16:27:39,040 - INFO - Waiting for VM mltf_vm to be up.. 2026-05-20 16:27:39,168 - DEBUG - VM is in ACTIVE state now 2026-05-20 16:27:39,168 - INFO - VM name : mltf_vm 2026-05-20 16:27:39,292 - DEBUG - VM mltf_vm ID is 50f3064e-6626-4f0c-a1af-6c6525d2c9ea 2026-05-20 16:27:39,292 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-5803-2 2026-05-20 16:27:39,530 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-machine/50f3064e-6626-4f0c-a1af-6c6525d2c9ea 2026-05-20 16:27:39,542 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-machine-interface/2edb9ad0-ce68-4dce-b166-cc7c69c25981 2026-05-20 16:27:39,553 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-machine-interface/9baac449-7e97-43c2-b1f9-45f63639d161 2026-05-20 16:27:40,734 - DEBUG - (True, 'PING 169.254.0.7 (169.254.0.7) 56(84) bytes of data.\r\n64 bytes from 169.254.0.7: icmp_seq=1 ttl=63 time=2.16 ms\r\n64 bytes from 169.254.0.7: icmp_seq=2 ttl=63 time=0.524 ms\r\n\r\n--- 169.254.0.7 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.524/1.341/2.158/0.817 ms') 2026-05-20 16:27:40,734 - INFO - Ping to Metadata IP 169.254.0.7 of VM mltf_vm passed 2026-05-20 16:27:40,816 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-20 16:27:40,816 - DEBUG - Waiting to SSH to VM mltf_vm, IP 103.80.129.5, Port 22 2026-05-20 16:27:40,988 - DEBUG - VM mltf_vm is ready for SSH connections 2026-05-20 16:27:41,063 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-20 16:27:41,063 - DEBUG - Waiting to SSH to VM mltf_vm, IP 103.80.129.5, Port 22 2026-05-20 16:27:41,221 - DEBUG - VM mltf_vm is ready for SSH connections 2026-05-20 16:27:41,223 - INFO - ================================================================================ 2026-05-20 16:27:41,223 - INFO - STARTING TEST : test_verify_session_sampling_teardown 2026-05-20 16:27:41,224 - 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-05-20 16:27:42,521 - DEBUG - Skipping xmpp flap check 2026-05-20 16:27:42,521 - INFO - Initial checks done. Running the testcase now 2026-05-20 16:27:42,521 - INFO - 2026-05-20 16:27:42,650 - INFO - Setting flow export rate: 100 2026-05-20 16:27:42,698 - 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-05-20 16:27:43,086 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '39cba233-dadf-46d4-bf9f-c718cc52741a', 'name': 'ctest-vn1-59722768', 'tenant_id': '6be4856485674728ad65fa36dcd82299', 'project_id': '6be4856485674728ad65fa36dcd82299', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['10726946-b75e-41b9-b255-e41759e6050f'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-76328617', 'ctest-vn1-59722768'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-76328617', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '103.80.129.0/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-05-20 16:27:43,278 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '3c2a3d72-6660-430c-94d1-a524065e3e62', 'name': 'ctest-vn2-50834622', 'tenant_id': '6be4856485674728ad65fa36dcd82299', 'project_id': '6be4856485674728ad65fa36dcd82299', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['f32ee487-53d3-401d-976b-fd8fdc8c33da'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-76328617', 'ctest-vn2-50834622'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-76328617', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '216.156.71.192/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-05-20 16:27:43,374 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:27:43,382 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:27:43,399 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:27:43,622 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:27:43,642 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:27:43,656 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:27:43,734 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:27:43,754 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/fe5921b5-459d-4561-8513-b75552f337fe 2026-05-20 16:27:43,766 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-20 16:27:43,767 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:27:43,785 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:27:43,805 - INFO - Verified VN network id 14 for VN 39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:27:43,805 - INFO - Verifications in API Server for VN ctest-vn1-59722768 passed 2026-05-20 16:27:43,806 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:27:43,825 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:27:43,838 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:27:43,851 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/fe5921b5-459d-4561-8513-b75552f337fe 2026-05-20 16:27:43,867 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4164600624033253076', 'uuid-lslong': '13807973891862328346'}, 'enable': 'true', 'created': '2026-05-20T16:26:13', 'last-modified': '2026-05-20T16:27:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.841956'} 2026-05-20 16:27:43,876 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-20 16:27:43,883 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4164600624033253076', 'uuid-lslong': '13807973891862328346'}, 'enable': 'true', 'created': '2026-05-20T16:26:13', 'last-modified': '2026-05-20T16:27:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.859727'} 2026-05-20 16:27:43,895 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-20 16:27:43,903 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4164600624033253076', 'uuid-lslong': '13807973891862328346'}, 'enable': 'true', 'created': '2026-05-20T16:26:13', 'last-modified': '2026-05-20T16:27:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.881619'} 2026-05-20 16:27:43,910 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-20 16:27:43,911 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-59722768 passed 2026-05-20 16:27:43,911 - DEBUG - ====Verifying policy data for ctest-vn1-59722768 in API_Server ====== 2026-05-20 16:27:43,911 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:27:43,918 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:27:43,932 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:27:44,042 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:27:44,060 - DEBUG - ==>Verifying data for policy with id: 3b96ec97-d07c-465a-b41d-270645759943, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-76328617', 'policy1'] 2026-05-20 16:27:44,060 - INFO - VN ctest-vn1-59722768 Policy verification: verify_vn_policy_in_api_server, status: True 2026-05-20 16:27:44,060 - DEBUG - Verifying the vn in opserver 2026-05-20 16:27:44,060 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 virtual network link through opserver 10.0.0.57 2026-05-20 16:27:44,060 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks 2026-05-20 16:27:44,078 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768?flat'} 2026-05-20 16:27:44,078 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 virtual network link through opserver 10.0.0.141 2026-05-20 16:27:44,078 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks 2026-05-20 16:27:44,092 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768?flat'} 2026-05-20 16:27:44,092 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 virtual network link through opserver 10.0.0.56 2026-05-20 16:27:44,092 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks 2026-05-20 16:27:44,107 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768?flat'} 2026-05-20 16:27:44,107 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 is found in opserver 2026-05-20 16:27:44,121 - DEBUG - VRF ids for VN ctest-vn1-59722768: {'10.0.0.249': '4'} 2026-05-20 16:27:44,121 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:27:44,129 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:27:44,144 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:27:44,251 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:44,266 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:44,278 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/54ddf531-17e1-4ac1-abaf-b507e0d07c22 2026-05-20 16:27:44,290 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/54ddf531-17e1-4ac1-abaf-b507e0d07c22 2026-05-20 16:27:44,300 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/8c38e20a-4d29-4cb6-aca1-541e50fcc707 2026-05-20 16:27:44,308 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-20 16:27:44,309 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:44,320 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/54ddf531-17e1-4ac1-abaf-b507e0d07c22 2026-05-20 16:27:44,338 - INFO - Verified VN network id 15 for VN 3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:44,339 - INFO - Verifications in API Server for VN ctest-vn2-50834622 passed 2026-05-20 16:27:44,339 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:44,352 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/54ddf531-17e1-4ac1-abaf-b507e0d07c22 2026-05-20 16:27:44,365 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/54ddf531-17e1-4ac1-abaf-b507e0d07c22 2026-05-20 16:27:44,376 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/8c38e20a-4d29-4cb6-aca1-541e50fcc707 2026-05-20 16:27:44,391 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4335345152850674444', 'uuid-lslong': '10723533761890106978'}, 'enable': 'true', 'created': '2026-05-20T16:26:52', 'last-modified': '2026-05-20T16:27:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.153436'} 2026-05-20 16:27:44,400 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-20 16:27:44,406 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4335345152850674444', 'uuid-lslong': '10723533761890106978'}, 'enable': 'true', 'created': '2026-05-20T16:26:52', 'last-modified': '2026-05-20T16:27:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.169561'} 2026-05-20 16:27:44,414 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-20 16:27:44,421 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4335345152850674444', 'uuid-lslong': '10723533761890106978'}, 'enable': 'true', 'created': '2026-05-20T16:26:52', 'last-modified': '2026-05-20T16:27:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.165362'} 2026-05-20 16:27:44,430 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-20 16:27:44,430 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-50834622 passed 2026-05-20 16:27:44,430 - DEBUG - ====Verifying policy data for ctest-vn2-50834622 in API_Server ====== 2026-05-20 16:27:44,430 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:27:44,438 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:27:44,453 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:27:44,568 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:44,582 - DEBUG - ==>Verifying data for policy with id: 3b96ec97-d07c-465a-b41d-270645759943, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-76328617', 'policy1'] 2026-05-20 16:27:44,583 - INFO - VN ctest-vn2-50834622 Policy verification: verify_vn_policy_in_api_server, status: True 2026-05-20 16:27:44,583 - DEBUG - Verifying the vn in opserver 2026-05-20 16:27:44,583 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622 virtual network link through opserver 10.0.0.57 2026-05-20 16:27:44,583 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks 2026-05-20 16:27:44,600 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622?flat'} 2026-05-20 16:27:44,600 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622 virtual network link through opserver 10.0.0.141 2026-05-20 16:27:44,601 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks 2026-05-20 16:27:44,614 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622?flat'} 2026-05-20 16:27:44,614 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622 virtual network link through opserver 10.0.0.56 2026-05-20 16:27:44,614 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks 2026-05-20 16:27:44,628 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622?flat'} 2026-05-20 16:27:44,628 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622 is found in opserver 2026-05-20 16:27:44,641 - DEBUG - VRF ids for VN ctest-vn2-50834622: {'10.0.0.242': '4', '10.0.0.249': '5'} 2026-05-20 16:27:44,642 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:27:44,649 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:27:44,664 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:27:44,768 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:27:44,781 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:27:44,794 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:27:44,805 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:27:44,816 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/fe5921b5-459d-4561-8513-b75552f337fe 2026-05-20 16:27:44,824 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-20 16:27:44,824 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:27:44,837 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:27:44,854 - INFO - Verified VN network id 14 for VN 39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:27:44,856 - INFO - Verifications in API Server for VN ctest-vn1-59722768 passed 2026-05-20 16:27:44,856 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:27:44,868 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:27:44,878 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:27:44,889 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/fe5921b5-459d-4561-8513-b75552f337fe 2026-05-20 16:27:44,903 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4164600624033253076', 'uuid-lslong': '13807973891862328346'}, 'enable': 'true', 'created': '2026-05-20T16:26:13', 'last-modified': '2026-05-20T16:27:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.876604'} 2026-05-20 16:27:44,913 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-20 16:27:44,919 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4164600624033253076', 'uuid-lslong': '13807973891862328346'}, 'enable': 'true', 'created': '2026-05-20T16:26:13', 'last-modified': '2026-05-20T16:27:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.896257'} 2026-05-20 16:27:44,926 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-20 16:27:44,933 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4164600624033253076', 'uuid-lslong': '13807973891862328346'}, 'enable': 'true', 'created': '2026-05-20T16:26:13', 'last-modified': '2026-05-20T16:27:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.912822'} 2026-05-20 16:27:44,941 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-20 16:27:44,941 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-59722768 passed 2026-05-20 16:27:44,941 - DEBUG - ====Verifying policy data for ctest-vn1-59722768 in API_Server ====== 2026-05-20 16:27:44,941 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:27:44,949 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:27:44,965 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:27:45,080 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/39cba233-dadf-46d4-bf9f-c718cc52741a 2026-05-20 16:27:45,095 - DEBUG - ==>Verifying data for policy with id: 3b96ec97-d07c-465a-b41d-270645759943, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-76328617', 'policy1'] 2026-05-20 16:27:45,096 - INFO - VN ctest-vn1-59722768 Policy verification: verify_vn_policy_in_api_server, status: True 2026-05-20 16:27:45,096 - DEBUG - Verifying the vn in opserver 2026-05-20 16:27:45,096 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 virtual network link through opserver 10.0.0.57 2026-05-20 16:27:45,096 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks 2026-05-20 16:27:45,114 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768?flat'} 2026-05-20 16:27:45,114 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 virtual network link through opserver 10.0.0.141 2026-05-20 16:27:45,114 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks 2026-05-20 16:27:45,129 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768?flat'} 2026-05-20 16:27:45,129 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 virtual network link through opserver 10.0.0.56 2026-05-20 16:27:45,129 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks 2026-05-20 16:27:45,145 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768?flat'} 2026-05-20 16:27:45,145 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 is found in opserver 2026-05-20 16:27:45,160 - DEBUG - VRF ids for VN ctest-vn1-59722768: {'10.0.0.249': '4'} 2026-05-20 16:27:45,160 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:27:45,168 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:27:45,183 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:27:45,287 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:45,302 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:45,314 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/54ddf531-17e1-4ac1-abaf-b507e0d07c22 2026-05-20 16:27:45,327 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/54ddf531-17e1-4ac1-abaf-b507e0d07c22 2026-05-20 16:27:45,338 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/8c38e20a-4d29-4cb6-aca1-541e50fcc707 2026-05-20 16:27:45,349 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-20 16:27:45,349 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:45,366 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/54ddf531-17e1-4ac1-abaf-b507e0d07c22 2026-05-20 16:27:45,388 - INFO - Verified VN network id 15 for VN 3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:45,388 - INFO - Verifications in API Server for VN ctest-vn2-50834622 passed 2026-05-20 16:27:45,388 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:45,400 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/54ddf531-17e1-4ac1-abaf-b507e0d07c22 2026-05-20 16:27:45,411 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/54ddf531-17e1-4ac1-abaf-b507e0d07c22 2026-05-20 16:27:45,421 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/8c38e20a-4d29-4cb6-aca1-541e50fcc707 2026-05-20 16:27:45,440 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4335345152850674444', 'uuid-lslong': '10723533761890106978'}, 'enable': 'true', 'created': '2026-05-20T16:26:52', 'last-modified': '2026-05-20T16:27:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.200021'} 2026-05-20 16:27:45,449 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-20 16:27:45,458 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4335345152850674444', 'uuid-lslong': '10723533761890106978'}, 'enable': 'true', 'created': '2026-05-20T16:26:52', 'last-modified': '2026-05-20T16:27:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.220902'} 2026-05-20 16:27:45,466 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-20 16:27:45,472 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '4335345152850674444', 'uuid-lslong': '10723533761890106978'}, 'enable': 'true', 'created': '2026-05-20T16:26:52', 'last-modified': '2026-05-20T16:27:43', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.217346'} 2026-05-20 16:27:45,480 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-20 16:27:45,480 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-50834622 passed 2026-05-20 16:27:45,480 - DEBUG - ====Verifying policy data for ctest-vn2-50834622 in API_Server ====== 2026-05-20 16:27:45,480 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:27:45,488 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:27:45,504 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:27:45,603 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/3c2a3d72-6660-430c-94d1-a524065e3e62 2026-05-20 16:27:45,618 - DEBUG - ==>Verifying data for policy with id: 3b96ec97-d07c-465a-b41d-270645759943, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-76328617', 'policy1'] 2026-05-20 16:27:45,618 - INFO - VN ctest-vn2-50834622 Policy verification: verify_vn_policy_in_api_server, status: True 2026-05-20 16:27:45,619 - DEBUG - Verifying the vn in opserver 2026-05-20 16:27:45,619 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622 virtual network link through opserver 10.0.0.57 2026-05-20 16:27:45,619 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks 2026-05-20 16:27:45,635 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622?flat'} 2026-05-20 16:27:45,635 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622 virtual network link through opserver 10.0.0.141 2026-05-20 16:27:45,636 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks 2026-05-20 16:27:45,651 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622?flat'} 2026-05-20 16:27:45,651 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622 virtual network link through opserver 10.0.0.56 2026-05-20 16:27:45,651 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks 2026-05-20 16:27:45,668 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622?flat'} 2026-05-20 16:27:45,668 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622 is found in opserver 2026-05-20 16:27:45,684 - DEBUG - VRF ids for VN ctest-vn2-50834622: {'10.0.0.242': '4', '10.0.0.249': '5'} 2026-05-20 16:27:45,684 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:27:45,693 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:27:45,709 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:27:45,810 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/0eed356d-7b4c-4868-b4a8-9269391dea05 2026-05-20 16:27:45,829 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/0eed356d-7b4c-4868-b4a8-9269391dea05 2026-05-20 16:27:45,842 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/11fdf478-2e14-4661-ab68-eded44733d75 2026-05-20 16:27:45,856 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/11fdf478-2e14-4661-ab68-eded44733d75 2026-05-20 16:27:45,866 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/604ecbe1-e672-4718-9929-1d43edadce8d 2026-05-20 16:27:45,874 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-05-20 16:27:45,874 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/0eed356d-7b4c-4868-b4a8-9269391dea05 2026-05-20 16:27:45,885 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/11fdf478-2e14-4661-ab68-eded44733d75 2026-05-20 16:27:45,903 - INFO - Verified VN network id 16 for VN 0eed356d-7b4c-4868-b4a8-9269391dea05 2026-05-20 16:27:45,903 - INFO - Verifications in API Server for VN ctest-fip_vn-81973322 passed 2026-05-20 16:27:45,903 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/0eed356d-7b4c-4868-b4a8-9269391dea05 2026-05-20 16:27:45,915 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/11fdf478-2e14-4661-ab68-eded44733d75 2026-05-20 16:27:45,924 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/11fdf478-2e14-4661-ab68-eded44733d75 2026-05-20 16:27:45,933 - DEBUG - Requesting: http://10.0.0.57:8082/route-target/604ecbe1-e672-4718-9929-1d43edadce8d 2026-05-20 16:27:45,949 - DEBUG - Control-node 10.0.0.57 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1075574630347720808', 'uuid-lslong': '13017815703541901829'}, 'enable': 'true', 'created': '2026-05-20T16:26:53', 'last-modified': '2026-05-20T16:26:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:52.318257'} 2026-05-20 16:27:45,956 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-05-20 16:27:45,963 - DEBUG - Control-node 10.0.0.141 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1075574630347720808', 'uuid-lslong': '13017815703541901829'}, 'enable': 'true', 'created': '2026-05-20T16:26:53', 'last-modified': '2026-05-20T16:26:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:52.334479'} 2026-05-20 16:27:45,970 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-05-20 16:27:45,976 - DEBUG - Control-node 10.0.0.56 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-76328617', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '1075574630347720808', 'uuid-lslong': '13017815703541901829'}, 'enable': 'true', 'created': '2026-05-20T16:26:53', 'last-modified': '2026-05-20T16:26:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:52.348577'} 2026-05-20 16:27:45,984 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-05-20 16:27:45,984 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-81973322 passed 2026-05-20 16:27:45,985 - DEBUG - ====Verifying policy data for ctest-fip_vn-81973322 in API_Server ====== 2026-05-20 16:27:45,985 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:27:45,992 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:27:46,007 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:27:46,131 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-network/0eed356d-7b4c-4868-b4a8-9269391dea05 2026-05-20 16:27:46,146 - DEBUG - =>VN ctest-fip_vn-81973322 has no policy to be verified 2026-05-20 16:27:46,147 - DEBUG - Verifying the vn in opserver 2026-05-20 16:27:46,147 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322 virtual network link through opserver 10.0.0.57 2026-05-20 16:27:46,147 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/virtual-networks 2026-05-20 16:27:46,162 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322', 'href': 'http://10.0.0.57:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322?flat'} 2026-05-20 16:27:46,163 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322 virtual network link through opserver 10.0.0.141 2026-05-20 16:27:46,163 - DEBUG - Requesting: http://10.0.0.141:8081/analytics/uves/virtual-networks 2026-05-20 16:27:46,177 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322', 'href': 'http://10.0.0.141:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322?flat'} 2026-05-20 16:27:46,177 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322 virtual network link through opserver 10.0.0.56 2026-05-20 16:27:46,177 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/virtual-networks 2026-05-20 16:27:46,194 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322', 'href': 'http://10.0.0.56:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322?flat'} 2026-05-20 16:27:46,194 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322 is found in opserver 2026-05-20 16:27:46,208 - DEBUG - VRF ids for VN ctest-fip_vn-81973322: {'10.0.0.242': '5'} 2026-05-20 16:27:46,208 - INFO - start time= 1779294466208668 2026-05-20 16:27:46,209 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 216.156.71.195, host_string: cirros@169.254.0.5, password: gocubsgogateway: ubuntu@10.0.0.249, gateway password: c0ntrail123 2026-05-20 16:27:46,209 - DEBUG - ping -s 56 -c 3 -W 1 216.156.71.195 2026-05-20 16:27:50,196 - DEBUG - PING 216.156.71.195 (216.156.71.195): 56 data bytes 64 bytes from 216.156.71.195: seq=0 ttl=63 time=4.852 ms 64 bytes from 216.156.71.195: seq=1 ttl=63 time=1.983 ms 64 bytes from 216.156.71.195: seq=2 ttl=63 time=1.494 ms --- 216.156.71.195 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.494/2.776/4.852 ms 2026-05-20 16:27:50,196 - INFO - Ping to IP 216.156.71.195 from VM ctest-vn1_vm1-12652917 passed 2026-05-20 16:28:00,197 - INFO - Verify session samples and teardown pkts 2026-05-20 16:28:00,197 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.57 2026-05-20 16:28:00,203 - DEBUG - Posting: http://10.0.0.57:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1779294466208668, 'end_time': 1779294480203419, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'} 2026-05-20 16:28:01,231 - DEBUG - [{'T': 1779294469093588}, {'T': 1779294470094077}, {'T': 1779294471094215}] 2026-05-20 16:28:01,231 - DEBUG - Posting: http://10.0.0.57:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1779294466208668, 'end_time': 1779294481231212, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'} 2026-05-20 16:28:02,264 - DEBUG - [{'T': 1779294468411429}, {'T': 1779294469411512}, {'T': 1779294470411591}] 2026-05-20 16:28:02,264 - DEBUG - Posting: http://10.0.0.57:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1779294466208668, 'end_time': 1779294482264246, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'} 2026-05-20 16:28:03,290 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', 'sample_count': 3}] 2026-05-20 16:28:03,291 - INFO - wait for the flows to get expire 2026-05-20 16:31:23,292 - DEBUG - Requesting: http://10.0.0.57:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5803-2:Compute:contrail-vrouter-agent:0?flat 2026-05-20 16:31:23,336 - DEBUG - Requesting: http://10.0.0.56:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5803-2?flat 2026-05-20 16:31:24,028 - INFO - Deleted policy policy1 2026-05-20 16:31:24,146 - INFO - Setting flow export rate: None 2026-05-20 16:31:25,445 - ERROR - AssertionError Python 3.9.25: /usr/bin/python3 Wed May 20 16:31:23 2026 A problem occurred in a Python script. Here is the sequence of function calls leading up to the error, in the order they occurred. /contrail-test/tcutils/wrappers.py in wrapper(self=, *args=(), **kwargs={}) 78 log.info('Initial checks done. Running the testcase now') 79 log.info('') 80 result = function(self, *args, **kwargs) 81 if self.inputs.upgrade: 82 pid = os.getpid() result = None function = self = args = () kwargs = {} /contrail-test/serial_scripts/analytics/test_analytics_resource.py in test_verify_session_sampling_teardown(self=) 1281 src_vn = self.res.vn1_fixture.vn_fq_name 1282 dst_vn = self.res.vn2_fixture.vn_fq_name 1283 result = self.verify_session_sampling_teardown(start_time, src_vn, dst_vn) 1284 1285 assert result,'Failed to get expected number of samples' result = True self = self.verify_session_sampling_teardown = > start_time = '1779294466208668' src_vn = 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768' dst_vn = 'default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622' /contrail-test/serial_scripts/analytics/base.py in verify_session_sampling_teardown(self=, start_time='1779294466208668', src_vn='default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768', dst_vn='default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622') 486 flow_record = self.analytics_obj.get_flows_vrouter_uve( 487 vrouter=vm_host) 488 assert not flow_record,'flows not got deleted even after 240 sec' 489 490 res = self.analytics_obj.ops_inspect[ip].post_query( flow_record = 12 AssertionError: flows not got deleted even after 240 sec __cause__ = None __class__ = __context__ = None __delattr__ = __dict__ = {} __dir__ = __doc__ = 'Assertion failed.' __eq__ = __format__ = __ge__ = __getattribute__ = __gt__ = __hash__ = __init__ = __init_subclass__ = __le__ = __lt__ = __ne__ = __new__ = __reduce__ = __reduce_ex__ = __repr__ = __setattr__ = __setstate__ = __sizeof__ = __str__ = __subclasshook__ = __suppress_context__ = False __traceback__ = args = ('flows not got deleted even after 240 sec',) with_traceback = The above is a description of an error in a Python program. Here is the original traceback: Traceback (most recent call last): File "/contrail-test/tcutils/wrappers.py", line 80, in wrapper result = function(self, *args, **kwargs) File "/contrail-test/serial_scripts/analytics/test_analytics_resource.py", line 1283, in test_verify_session_sampling_teardown result = self.verify_session_sampling_teardown(start_time, src_vn, dst_vn) File "/contrail-test/serial_scripts/analytics/base.py", line 488, in verify_session_sampling_teardown assert not flow_record,'flows not got deleted even after 240 sec' AssertionError: flows not got deleted even after 240 sec 2026-05-20 16:31:25,447 - DEBUG - Skipping xmpp flap check 2026-05-20 16:31:25,447 - INFO -

2026-05-20 16:31:25,447 - INFO - END TEST : test_verify_session_sampling_teardown : FAILED[0:03:44]

2026-05-20 16:31:25,447 - INFO - -------------------------------------------------------------------------------- 2026-05-20 16:31:25,450 - INFO - Deleting VM mltf_vm 2026-05-20 16:31:25,547 - INFO - Deleting VM ctest-fvn_vm1-43023678 2026-05-20 16:31:25,634 - INFO - Deleting VM ctest-vn2_vm2-28209418 2026-05-20 16:31:25,729 - INFO - Deleting VN ctest-fip_vn-81973322 2026-05-20 16:31:25,780 - DEBUG - VN 0eed356d-7b4c-4868-b4a8-9269391dea05 still in use: Unable to complete operation on network 0eed356d-7b4c-4868-b4a8-9269391dea05. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-095ffd00-878b-4074-a575-c79ede3b701c'] 2026-05-20 16:31:25,780 - WARNING - Deleting VN ctest-fip_vn-81973322 failed..Will retry 2026-05-20 16:31:27,955 - DEBUG - Response for deleting network () 2026-05-20 16:31:27,956 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/11fdf478-2e14-4661-ab68-eded44733d75 2026-05-20 16:31:28,007 - DEBUG - Response Code: 404 2026-05-20 16:31:28,008 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:31:28,014 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:31:28,029 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:31:28,141 - INFO - Validated that VN ctest-fip_vn-81973322 is not found in API Server 2026-05-20 16:31:28,158 - DEBUG - VN ctest-fip_vn-81973322 is not present in Agent 10.0.0.242 2026-05-20 16:31:28,172 - DEBUG - VN ctest-fip_vn-81973322 is not present in Agent 10.0.0.249 2026-05-20 16:31:28,172 - INFO - Validated that VN ctest-fip_vn-81973322 is not in any agent 2026-05-20 16:31:28,179 - DEBUG - VRF 5 is not seen in agent 10.0.0.242 2026-05-20 16:31:28,186 - DEBUG - Vrouter 10.0.0.242 does not have vrf 5 for VN ctest-fip_vn-81973322 2026-05-20 16:31:28,186 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-fip_vn-81973322 2026-05-20 16:31:28,210 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-81973322 info 2026-05-20 16:31:28,210 - INFO - Deleting VN ctest-vn2-50834622 2026-05-20 16:31:28,385 - DEBUG - Response for deleting network () 2026-05-20 16:31:28,385 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/54ddf531-17e1-4ac1-abaf-b507e0d07c22 2026-05-20 16:31:28,394 - DEBUG - Response Code: 404 2026-05-20 16:31:28,395 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:31:28,406 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:31:28,438 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:31:28,536 - INFO - Validated that VN ctest-vn2-50834622 is not found in API Server 2026-05-20 16:31:28,553 - DEBUG - VN ctest-vn2-50834622 is not present in Agent 10.0.0.242 2026-05-20 16:31:28,568 - DEBUG - VN ctest-vn2-50834622 is not present in Agent 10.0.0.249 2026-05-20 16:31:28,568 - INFO - Validated that VN ctest-vn2-50834622 is not in any agent 2026-05-20 16:31:28,574 - DEBUG - VRF 4 is not seen in agent 10.0.0.242 2026-05-20 16:31:28,580 - DEBUG - Vrouter 10.0.0.242 does not have vrf 4 for VN ctest-vn2-50834622 2026-05-20 16:31:28,587 - DEBUG - VRF 5 is not seen in agent 10.0.0.249 2026-05-20 16:31:28,594 - DEBUG - Vrouter 10.0.0.249 does not have vrf 5 for VN ctest-vn2-50834622 2026-05-20 16:31:28,594 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn2-50834622 2026-05-20 16:31:28,619 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-50834622 info 2026-05-20 16:31:28,619 - INFO - Deleting VM ctest-vn1_vm2-03335039 2026-05-20 16:31:28,708 - INFO - Deleting VM ctest-vn1_vm1-12652917 2026-05-20 16:31:28,820 - INFO - Deleting VN ctest-vn1-59722768 2026-05-20 16:31:28,872 - DEBUG - VN 39cba233-dadf-46d4-bf9f-c718cc52741a still in use: Unable to complete operation on network 39cba233-dadf-46d4-bf9f-c718cc52741a. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-331e8301-1afa-4378-8003-f9f13625c199'] 2026-05-20 16:31:28,872 - WARNING - Deleting VN ctest-vn1-59722768 failed..Will retry 2026-05-20 16:31:31,033 - DEBUG - Response for deleting network () 2026-05-20 16:31:31,033 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/0d84bb4a-fee6-427d-8a36-387152636d0f 2026-05-20 16:31:31,047 - DEBUG - Response Code: 404 2026-05-20 16:31:31,048 - DEBUG - Requesting: http://10.0.0.57:8082/domains 2026-05-20 16:31:31,059 - DEBUG - Requesting: http://10.0.0.57:8082/domain/ffb590f3-7b6e-40e6-89b8-bd634f94ea0b 2026-05-20 16:31:31,075 - DEBUG - Requesting: http://10.0.0.57:8082/project/6be48564-8567-4728-ad65-fa36dcd82299 2026-05-20 16:31:31,192 - INFO - Validated that VN ctest-vn1-59722768 is not found in API Server 2026-05-20 16:31:31,205 - DEBUG - VN ctest-vn1-59722768 is not present in Agent 10.0.0.242 2026-05-20 16:31:31,217 - DEBUG - VN ctest-vn1-59722768 is not present in Agent 10.0.0.249 2026-05-20 16:31:31,217 - INFO - Validated that VN ctest-vn1-59722768 is not in any agent 2026-05-20 16:31:31,226 - DEBUG - VRF 4 is not seen in agent 10.0.0.249 2026-05-20 16:31:31,233 - DEBUG - Vrouter 10.0.0.249 does not have vrf 4 for VN ctest-vn1-59722768 2026-05-20 16:31:31,233 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-76328617:ctest-vn1-59722768 2026-05-20 16:31:31,262 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-59722768 info 2026-05-20 16:31:32,184 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-76328617, ID : 6be48564-8567-4728-ad65-fa36dcd82299