2026-05-28 01:30:17,937 - INFO - Domain Default found not creating
2026-05-28 01:30:18,214 - INFO - Project ctest-AnalyticsTestSanityWithResource-66374291 not found, creating it
2026-05-28 01:30:18,894 - INFO - Created Project:ctest-AnalyticsTestSanityWithResource-66374291, ID : e622b493-331e-4770-afce-b24440163875
2026-05-28 01:30:21,714 - DEBUG - Response for create_network : {'network': {'id': 'd6b91dd9-90c2-46c6-a66b-2b6e85d7feb5', 'name': 'ctest-vn1-29750481', 'tenant_id': 'e622b493331e4770afceb24440163875', 'project_id': 'e622b493331e4770afceb24440163875', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-66374291', 'ctest-vn1-29750481'], 'port_security_enabled': True, 'description': ''}}
2026-05-28 01:30:21,985 - DEBUG - Response for create_subnet : {'subnet': {'id': '70711819-0e19-477a-8fdb-7201a876d787', 'name': '', 'tenant_id': 'e622b493331e4770afceb24440163875', 'network_id': 'd6b91dd9-90c2-46c6-a66b-2b6e85d7feb5', 'ip_version': 4, 'cidr': '157.95.23.64/26', 'allocation_pools': [{'start': '157.95.23.66', 'end': '157.95.23.126'}], 'gateway_ip': '157.95.23.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '157.95.23.66', 'tags': [], 'project_id': 'e622b493331e4770afceb24440163875'}}
2026-05-28 01:30:22,019 - INFO - Created VN ctest-vn1-29750481
2026-05-28 01:30:22,035 - DEBUG - VN ctest-vn1-29750481 UUID is d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:30:22,191 - DEBUG - Services list from nova: [, , , ]
2026-05-28 01:30:22,191 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5836-1', 'an-jenkins-deploy-platform-ansible-os-5836-2']}
2026-05-28 01:30:23,564 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5836-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5836-1)
2026-05-28 01:30:25,376 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5836-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5836-1)
2026-05-28 01:30:25,376 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:30:25,760 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:30:25,811 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:30:25,845 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:30:25,982 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:30:26,019 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:30:26,063 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:30:26,094 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:30:26,114 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/26f9a8ea-a0e3-414d-8419-11c755c25ba7
2026-05-28 01:30:26,125 - DEBUG - Route Targets: ['target:64512:8000004']
2026-05-28 01:30:26,125 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:30:26,162 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:30:26,195 - INFO - Verified VN network id 12 for VN d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:30:26,195 - INFO - Verifications in API Server for VN ctest-vn1-29750481 passed
2026-05-28 01:30:26,195 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:30:26,216 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:30:26,242 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:30:26,257 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/26f9a8ea-a0e3-414d-8419-11c755c25ba7
2026-05-28 01:30:26,284 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15472430815081809606', 'uuid-lslong': '11991726186495999669'}, 'enable': 'true', 'created': '2026-05-28T01:30:21', 'last-modified': '2026-05-28T01:30:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:04.377538'}
2026-05-28 01:30:26,297 - DEBUG - Route Targets: ['target:64512:8000004']
2026-05-28 01:30:26,304 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15472430815081809606', 'uuid-lslong': '11991726186495999669'}, 'enable': 'true', 'created': '2026-05-28T01:30:21', 'last-modified': '2026-05-28T01:30:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:04.398033'}
2026-05-28 01:30:26,313 - DEBUG - Route Targets: ['target:64512:8000004']
2026-05-28 01:30:26,321 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15472430815081809606', 'uuid-lslong': '11991726186495999669'}, 'enable': 'true', 'created': '2026-05-28T01:30:21', 'last-modified': '2026-05-28T01:30:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:04.412662'}
2026-05-28 01:30:26,331 - DEBUG - Route Targets: ['target:64512:8000004']
2026-05-28 01:30:26,331 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-29750481 passed
2026-05-28 01:30:26,332 - DEBUG - ====Verifying policy data for ctest-vn1-29750481 in API_Server ======
2026-05-28 01:30:26,332 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:30:26,343 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:30:26,366 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:30:26,535 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:30:26,579 - DEBUG - =>VN ctest-vn1-29750481 has no policy to be verified
2026-05-28 01:30:26,579 - DEBUG - Verifying the vn in opserver
2026-05-28 01:30:26,579 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 virtual network link through opserver 10.0.0.33
2026-05-28 01:30:26,579 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-05-28 01:30:26,989 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-05-28 01:30:27,200 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481?flat'}
2026-05-28 01:30:27,200 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 virtual network link through opserver 10.0.0.249
2026-05-28 01:30:27,200 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-28 01:30:27,585 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-28 01:30:27,686 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481?flat'}
2026-05-28 01:30:27,686 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 virtual network link through opserver 10.0.0.22
2026-05-28 01:30:27,687 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-28 01:30:28,054 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-28 01:30:28,146 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481?flat'}
2026-05-28 01:30:28,146 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 is found in opserver
2026-05-28 01:30:28,163 - DEBUG - VRF ids for VN ctest-vn1-29750481: {'10.0.0.19': '2'}
2026-05-28 01:30:28,163 - INFO - Waiting for VM ctest-vn1_vm1-94685302 to be up..
2026-05-28 01:30:28,285 - DEBUG - VM is in ACTIVE state now
2026-05-28 01:30:28,285 - INFO - VM name : ctest-vn1_vm1-94685302
2026-05-28 01:30:28,413 - DEBUG - VM ctest-vn1_vm1-94685302 ID is f5ee32d1-39d3-469b-a00b-251b7de22f15
2026-05-28 01:30:28,466 - DEBUG - VM ctest-vn1_vm1-94685302 launched on Node an-jenkins-deploy-platform-ansible-os-5836-1
2026-05-28 01:30:28,595 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/f5ee32d1-39d3-469b-a00b-251b7de22f15
2026-05-28 01:30:28,946 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/f5ee32d1-39d3-469b-a00b-251b7de22f15
2026-05-28 01:30:29,008 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/b302a265-c3f8-4367-bb0a-7f3e57aea230
2026-05-28 01:30:32,221 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1025ms')
2026-05-28 01:30:32,221 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-94685302 failed!
2026-05-28 01:30:32,241 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 is 157.95.23.65 and allocation pool is NOT set
2026-05-28 01:30:36,322 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1012ms')
2026-05-28 01:30:36,323 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-94685302 failed!
2026-05-28 01:30:36,342 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 is 157.95.23.65 and allocation pool is NOT set
2026-05-28 01:30:40,425 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1013ms')
2026-05-28 01:30:40,425 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-94685302 failed!
2026-05-28 01:30:40,447 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 is 157.95.23.65 and allocation pool is NOT set
2026-05-28 01:30:44,510 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1001ms')
2026-05-28 01:30:44,510 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-94685302 failed!
2026-05-28 01:30:44,529 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 is 157.95.23.65 and allocation pool is NOT set
2026-05-28 01:30:48,611 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms')
2026-05-28 01:30:48,612 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-94685302 failed!
2026-05-28 01:30:48,641 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 is 157.95.23.65 and allocation pool is NOT set
2026-05-28 01:30:52,733 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=8.96 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1024ms\r\nrtt min/avg/max/mdev = 8.957/8.957/8.957/0.000 ms')
2026-05-28 01:30:52,733 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-94685302 passed
2026-05-28 01:30:52,820 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-28 01:30:52,820 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-94685302, IP 157.95.23.67, Port 22
2026-05-28 01:30:52,890 - DEBUG - Error on ssh to cirros@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-05-28 01:30:53,002 - DEBUG - VM ctest-vn1_vm1-94685302 is NOT ready for SSH connections, VM status: ACTIVE
2026-05-28 01:30:58,003 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-28 01:30:58,003 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-94685302, IP 157.95.23.67, Port 22
2026-05-28 01:30:58,059 - DEBUG - Error on ssh to cirros@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-05-28 01:30:58,160 - DEBUG - VM ctest-vn1_vm1-94685302 is NOT ready for SSH connections, VM status: ACTIVE
2026-05-28 01:31:03,160 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-28 01:31:03,161 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-94685302, IP 157.95.23.67, Port 22
2026-05-28 01:31:03,342 - DEBUG - VM ctest-vn1_vm1-94685302 is ready for SSH connections
2026-05-28 01:31:03,342 - INFO - Waiting for VM ctest-vn1_vm2-05126990 to be up..
2026-05-28 01:31:03,458 - DEBUG - VM is in ACTIVE state now
2026-05-28 01:31:03,459 - INFO - VM name : ctest-vn1_vm2-05126990
2026-05-28 01:31:03,592 - DEBUG - VM ctest-vn1_vm2-05126990 ID is 704ff97b-6d5d-4b8e-8136-59d232c8270f
2026-05-28 01:31:03,592 - DEBUG - VM ctest-vn1_vm2-05126990 launched on Node an-jenkins-deploy-platform-ansible-os-5836-1
2026-05-28 01:31:03,735 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/704ff97b-6d5d-4b8e-8136-59d232c8270f
2026-05-28 01:31:03,749 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/39c524bf-f3b4-4b24-9937-9d5aa5ba69ff
2026-05-28 01:31:04,946 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n64 bytes from 169.254.0.4: icmp_seq=1 ttl=63 time=8.44 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.871 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.871/4.653/8.436/3.782 ms')
2026-05-28 01:31:04,946 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1_vm2-05126990 passed
2026-05-28 01:31:05,026 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-28 01:31:05,027 - DEBUG - Waiting to SSH to VM ctest-vn1_vm2-05126990, IP 157.95.23.68, Port 22
2026-05-28 01:31:05,204 - DEBUG - VM ctest-vn1_vm2-05126990 is ready for SSH connections
2026-05-28 01:31:05,619 - DEBUG - Response for create_network : {'network': {'id': 'ef0e8ab0-9952-4762-8851-3499a41b9f0b', 'name': 'ctest-vn2-46267320', 'tenant_id': 'e622b493331e4770afceb24440163875', 'project_id': 'e622b493331e4770afceb24440163875', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-66374291', 'ctest-vn2-46267320'], 'port_security_enabled': True, 'description': ''}}
2026-05-28 01:31:05,901 - DEBUG - Response for create_subnet : {'subnet': {'id': '360dfc88-4f06-45c1-bbed-c82c7d47a06e', 'name': '', 'tenant_id': 'e622b493331e4770afceb24440163875', 'network_id': 'ef0e8ab0-9952-4762-8851-3499a41b9f0b', 'ip_version': 4, 'cidr': '19.3.189.0/26', 'allocation_pools': [{'start': '19.3.189.2', 'end': '19.3.189.62'}], 'gateway_ip': '19.3.189.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '19.3.189.2', 'tags': [], 'project_id': 'e622b493331e4770afceb24440163875'}}
2026-05-28 01:31:05,931 - INFO - Created VN ctest-vn2-46267320
2026-05-28 01:31:05,946 - DEBUG - VN ctest-vn2-46267320 UUID is ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:06,398 - DEBUG - Response for create_network : {'network': {'id': '07945a04-c480-4921-9156-a41462a44c29', 'name': 'ctest-fip_vn-31958614', 'tenant_id': 'e622b493331e4770afceb24440163875', 'project_id': 'e622b493331e4770afceb24440163875', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-66374291', 'ctest-fip_vn-31958614'], 'port_security_enabled': True, 'description': ''}}
2026-05-28 01:31:06,761 - DEBUG - Response for create_subnet : {'subnet': {'id': '49b54cff-1c63-40f0-b7aa-6e7d7b330159', 'name': '', 'tenant_id': 'e622b493331e4770afceb24440163875', 'network_id': '07945a04-c480-4921-9156-a41462a44c29', 'ip_version': 4, 'cidr': '146.210.147.192/26', 'allocation_pools': [{'start': '146.210.147.194', 'end': '146.210.147.254'}], 'gateway_ip': '146.210.147.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '146.210.147.194', 'tags': [], 'project_id': 'e622b493331e4770afceb24440163875'}}
2026-05-28 01:31:06,796 - INFO - Created VN ctest-fip_vn-31958614
2026-05-28 01:31:06,818 - DEBUG - VN ctest-fip_vn-31958614 UUID is 07945a04-c480-4921-9156-a41462a44c29
2026-05-28 01:31:06,908 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5836-1', 'an-jenkins-deploy-platform-ansible-os-5836-2']}
2026-05-28 01:31:08,513 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5836-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5836-2)
2026-05-28 01:31:10,353 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5836-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5836-2)
2026-05-28 01:31:12,290 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5836-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5836-1)
2026-05-28 01:31:12,291 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:31:12,301 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:31:12,328 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:31:12,461 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:12,483 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:12,499 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:31:12,512 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:31:12,526 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/26f9a8ea-a0e3-414d-8419-11c755c25ba7
2026-05-28 01:31:12,539 - DEBUG - Route Targets: ['target:64512:8000004']
2026-05-28 01:31:12,540 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:12,555 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:31:12,577 - INFO - Verified VN network id 12 for VN d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:12,578 - INFO - Verifications in API Server for VN ctest-vn1-29750481 passed
2026-05-28 01:31:12,578 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:12,598 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:31:12,611 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:31:12,627 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/26f9a8ea-a0e3-414d-8419-11c755c25ba7
2026-05-28 01:31:12,649 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15472430815081809606', 'uuid-lslong': '11991726186495999669'}, 'enable': 'true', 'created': '2026-05-28T01:30:21', 'last-modified': '2026-05-28T01:30:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:50.745023'}
2026-05-28 01:31:12,660 - DEBUG - Route Targets: ['target:64512:8000004']
2026-05-28 01:31:12,668 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15472430815081809606', 'uuid-lslong': '11991726186495999669'}, 'enable': 'true', 'created': '2026-05-28T01:30:21', 'last-modified': '2026-05-28T01:30:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:50.761233'}
2026-05-28 01:31:12,681 - DEBUG - Route Targets: ['target:64512:8000004']
2026-05-28 01:31:12,691 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15472430815081809606', 'uuid-lslong': '11991726186495999669'}, 'enable': 'true', 'created': '2026-05-28T01:30:21', 'last-modified': '2026-05-28T01:30:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:50.781380'}
2026-05-28 01:31:12,705 - DEBUG - Route Targets: ['target:64512:8000004']
2026-05-28 01:31:12,706 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-29750481 passed
2026-05-28 01:31:12,706 - DEBUG - ====Verifying policy data for ctest-vn1-29750481 in API_Server ======
2026-05-28 01:31:12,706 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:31:12,719 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:31:12,738 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:31:12,900 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:12,919 - DEBUG - =>VN ctest-vn1-29750481 has no policy to be verified
2026-05-28 01:31:12,919 - DEBUG - Verifying the vn in opserver
2026-05-28 01:31:12,919 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 virtual network link through opserver 10.0.0.33
2026-05-28 01:31:12,919 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-05-28 01:31:13,079 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481?flat'}
2026-05-28 01:31:13,079 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 virtual network link through opserver 10.0.0.249
2026-05-28 01:31:13,079 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-28 01:31:13,300 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481?flat'}
2026-05-28 01:31:13,300 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 virtual network link through opserver 10.0.0.22
2026-05-28 01:31:13,300 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-28 01:31:13,506 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481?flat'}
2026-05-28 01:31:13,507 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 is found in opserver
2026-05-28 01:31:13,527 - DEBUG - VRF ids for VN ctest-vn1-29750481: {'10.0.0.19': '2'}
2026-05-28 01:31:13,527 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:31:13,539 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:31:13,584 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:31:13,733 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:13,780 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:13,796 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/bb9542d0-2f6b-4ee7-a5d9-4568897b8731
2026-05-28 01:31:13,819 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/bb9542d0-2f6b-4ee7-a5d9-4568897b8731
2026-05-28 01:31:13,834 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/d9310691-60eb-4f3a-a13d-e3b20ffa532f
2026-05-28 01:31:13,852 - DEBUG - Route Targets: ['target:64512:8000006']
2026-05-28 01:31:13,852 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:13,878 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/bb9542d0-2f6b-4ee7-a5d9-4568897b8731
2026-05-28 01:31:13,914 - INFO - Verified VN network id 13 for VN ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:13,914 - INFO - Verifications in API Server for VN ctest-vn2-46267320 passed
2026-05-28 01:31:13,914 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:13,952 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/bb9542d0-2f6b-4ee7-a5d9-4568897b8731
2026-05-28 01:31:13,971 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/bb9542d0-2f6b-4ee7-a5d9-4568897b8731
2026-05-28 01:31:13,986 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/d9310691-60eb-4f3a-a13d-e3b20ffa532f
2026-05-28 01:31:14,016 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17225858115829909346', 'uuid-lslong': '9822690096759676683'}, 'enable': 'true', 'created': '2026-05-28T01:31:05', 'last-modified': '2026-05-28T01:31:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:08.175174'}
2026-05-28 01:31:14,051 - DEBUG - Route Targets: ['target:64512:8000006']
2026-05-28 01:31:14,063 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17225858115829909346', 'uuid-lslong': '9822690096759676683'}, 'enable': 'true', 'created': '2026-05-28T01:31:05', 'last-modified': '2026-05-28T01:31:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:08.233940'}
2026-05-28 01:31:14,077 - DEBUG - Route Targets: ['target:64512:8000006']
2026-05-28 01:31:14,097 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17225858115829909346', 'uuid-lslong': '9822690096759676683'}, 'enable': 'true', 'created': '2026-05-28T01:31:05', 'last-modified': '2026-05-28T01:31:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:08.267579'}
2026-05-28 01:31:14,110 - DEBUG - Route Targets: ['target:64512:8000006']
2026-05-28 01:31:14,110 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-46267320 passed
2026-05-28 01:31:14,110 - DEBUG - ====Verifying policy data for ctest-vn2-46267320 in API_Server ======
2026-05-28 01:31:14,110 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:31:14,129 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:31:14,144 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:31:14,300 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:14,318 - DEBUG - =>VN ctest-vn2-46267320 has no policy to be verified
2026-05-28 01:31:14,318 - DEBUG - Verifying the vn in opserver
2026-05-28 01:31:14,318 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320 virtual network link through opserver 10.0.0.33
2026-05-28 01:31:14,318 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-05-28 01:31:14,469 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320?flat'}
2026-05-28 01:31:14,469 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320 virtual network link through opserver 10.0.0.249
2026-05-28 01:31:14,469 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-28 01:31:14,486 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320?flat'}
2026-05-28 01:31:14,486 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320 virtual network link through opserver 10.0.0.22
2026-05-28 01:31:14,486 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-28 01:31:14,504 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320?flat'}
2026-05-28 01:31:14,505 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320 is found in opserver
2026-05-28 01:31:14,519 - DEBUG - VRF ids for VN ctest-vn2-46267320: {'10.0.0.129': '2'}
2026-05-28 01:31:14,519 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:31:14,531 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:31:14,550 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:31:14,683 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/07945a04-c480-4921-9156-a41462a44c29
2026-05-28 01:31:14,723 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/07945a04-c480-4921-9156-a41462a44c29
2026-05-28 01:31:14,748 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/78aa3138-30b9-462f-872a-56350caece70
2026-05-28 01:31:14,763 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/78aa3138-30b9-462f-872a-56350caece70
2026-05-28 01:31:14,779 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/8a65cd0e-c21a-43d6-abd8-7040c6fb5006
2026-05-28 01:31:14,794 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 01:31:14,794 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/07945a04-c480-4921-9156-a41462a44c29
2026-05-28 01:31:14,814 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/78aa3138-30b9-462f-872a-56350caece70
2026-05-28 01:31:14,845 - INFO - Verified VN network id 14 for VN 07945a04-c480-4921-9156-a41462a44c29
2026-05-28 01:31:14,845 - INFO - Verifications in API Server for VN ctest-fip_vn-31958614 passed
2026-05-28 01:31:14,845 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/07945a04-c480-4921-9156-a41462a44c29
2026-05-28 01:31:14,860 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/78aa3138-30b9-462f-872a-56350caece70
2026-05-28 01:31:14,872 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/78aa3138-30b9-462f-872a-56350caece70
2026-05-28 01:31:14,888 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/8a65cd0e-c21a-43d6-abd8-7040c6fb5006
2026-05-28 01:31:14,915 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '546160431341783329', 'uuid-lslong': '10472738390957902889'}, 'enable': 'true', 'created': '2026-05-28T01:31:06', 'last-modified': '2026-05-28T01:31:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:08.270177'}
2026-05-28 01:31:14,925 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 01:31:14,932 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '546160431341783329', 'uuid-lslong': '10472738390957902889'}, 'enable': 'true', 'created': '2026-05-28T01:31:06', 'last-modified': '2026-05-28T01:31:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:08.297986'}
2026-05-28 01:31:14,940 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 01:31:14,948 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '546160431341783329', 'uuid-lslong': '10472738390957902889'}, 'enable': 'true', 'created': '2026-05-28T01:31:06', 'last-modified': '2026-05-28T01:31:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:08.312075'}
2026-05-28 01:31:14,957 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 01:31:14,959 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-31958614 passed
2026-05-28 01:31:14,959 - DEBUG - ====Verifying policy data for ctest-fip_vn-31958614 in API_Server ======
2026-05-28 01:31:14,960 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:31:14,971 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:31:14,994 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:31:15,148 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/07945a04-c480-4921-9156-a41462a44c29
2026-05-28 01:31:15,166 - DEBUG - =>VN ctest-fip_vn-31958614 has no policy to be verified
2026-05-28 01:31:15,166 - DEBUG - Verifying the vn in opserver
2026-05-28 01:31:15,167 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614 virtual network link through opserver 10.0.0.33
2026-05-28 01:31:15,167 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-05-28 01:31:15,189 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614?flat'}
2026-05-28 01:31:15,189 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614 virtual network link through opserver 10.0.0.249
2026-05-28 01:31:15,189 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-28 01:31:15,284 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614?flat'}
2026-05-28 01:31:15,284 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614 virtual network link through opserver 10.0.0.22
2026-05-28 01:31:15,285 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-28 01:31:15,388 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614?flat'}
2026-05-28 01:31:15,388 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614 is found in opserver
2026-05-28 01:31:15,404 - DEBUG - VRF ids for VN ctest-fip_vn-31958614: {'10.0.0.129': '3'}
2026-05-28 01:31:15,404 - INFO - Waiting for VM ctest-fvn_vm1-63951791 to be up..
2026-05-28 01:31:15,579 - DEBUG - VM is in ACTIVE state now
2026-05-28 01:31:15,579 - INFO - VM name : ctest-fvn_vm1-63951791
2026-05-28 01:31:15,719 - DEBUG - VM ctest-fvn_vm1-63951791 ID is 90ebc204-59a5-456c-91ab-cdec6eb08201
2026-05-28 01:31:15,719 - DEBUG - VM ctest-fvn_vm1-63951791 launched on Node an-jenkins-deploy-platform-ansible-os-5836-2
2026-05-28 01:31:15,839 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/90ebc204-59a5-456c-91ab-cdec6eb08201
2026-05-28 01:31:15,853 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/56584478-5360-4fc1-a27e-bad2921be7bb
2026-05-28 01:31:19,074 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1025ms')
2026-05-28 01:31:19,074 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1-63951791 failed!
2026-05-28 01:31:19,097 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614 is 146.210.147.193 and allocation pool is NOT set
2026-05-28 01:31:23,170 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1006ms')
2026-05-28 01:31:23,170 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1-63951791 failed!
2026-05-28 01:31:23,191 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614 is 146.210.147.193 and allocation pool is NOT set
2026-05-28 01:31:27,265 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms')
2026-05-28 01:31:27,266 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1-63951791 failed!
2026-05-28 01:31:27,287 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614 is 146.210.147.193 and allocation pool is NOT set
2026-05-28 01:31:31,395 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1031ms')
2026-05-28 01:31:31,395 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1-63951791 failed!
2026-05-28 01:31:31,414 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614 is 146.210.147.193 and allocation pool is NOT set
2026-05-28 01:31:35,489 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1009ms')
2026-05-28 01:31:35,489 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1-63951791 failed!
2026-05-28 01:31:35,509 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614 is 146.210.147.193 and allocation pool is NOT set
2026-05-28 01:31:37,580 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n64 bytes from 169.254.0.4: icmp_seq=1 ttl=63 time=5.17 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=2.26 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 2.263/3.716/5.169/1.453 ms')
2026-05-28 01:31:37,581 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1-63951791 passed
2026-05-28 01:31:37,667 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-28 01:31:37,667 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-63951791, IP 146.210.147.195, Port 22
2026-05-28 01:31:37,734 - DEBUG - Error on ssh to cirros@169.254.0.4:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.4/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.4/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.4/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-05-28 01:31:37,849 - DEBUG - VM ctest-fvn_vm1-63951791 is NOT ready for SSH connections, VM status: ACTIVE
2026-05-28 01:31:42,850 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-28 01:31:42,850 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-63951791, IP 146.210.147.195, Port 22
2026-05-28 01:31:42,918 - DEBUG - Error on ssh to cirros@169.254.0.4:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.4/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.4/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.4/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-05-28 01:31:43,030 - DEBUG - VM ctest-fvn_vm1-63951791 is NOT ready for SSH connections, VM status: ACTIVE
2026-05-28 01:31:48,031 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-28 01:31:48,031 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-63951791, IP 146.210.147.195, Port 22
2026-05-28 01:31:48,193 - DEBUG - VM ctest-fvn_vm1-63951791 is ready for SSH connections
2026-05-28 01:31:48,193 - INFO - Waiting for VM ctest-vn2_vm2-44170058 to be up..
2026-05-28 01:31:48,319 - DEBUG - VM is in ACTIVE state now
2026-05-28 01:31:48,319 - INFO - VM name : ctest-vn2_vm2-44170058
2026-05-28 01:31:48,445 - DEBUG - VM ctest-vn2_vm2-44170058 ID is 58cf1132-1e7f-412f-9156-00cf97ffae83
2026-05-28 01:31:48,445 - DEBUG - VM ctest-vn2_vm2-44170058 launched on Node an-jenkins-deploy-platform-ansible-os-5836-2
2026-05-28 01:31:48,551 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/58cf1132-1e7f-412f-9156-00cf97ffae83
2026-05-28 01:31:48,566 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/759a71da-7081-4bb8-9803-d3596e63eeb5
2026-05-28 01:31:49,751 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=2.26 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.410 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.410/1.337/2.264/0.927 ms')
2026-05-28 01:31:49,752 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn2_vm2-44170058 passed
2026-05-28 01:31:49,834 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-28 01:31:49,834 - DEBUG - Waiting to SSH to VM ctest-vn2_vm2-44170058, IP 19.3.189.3, Port 22
2026-05-28 01:31:49,997 - DEBUG - VM ctest-vn2_vm2-44170058 is ready for SSH connections
2026-05-28 01:31:49,997 - INFO - Waiting for VM mltf_vm to be up..
2026-05-28 01:31:50,123 - DEBUG - VM is in ACTIVE state now
2026-05-28 01:31:50,123 - INFO - VM name : mltf_vm
2026-05-28 01:31:50,260 - DEBUG - VM mltf_vm ID is 8f266e5c-b24b-4074-9a21-0dd07616337a
2026-05-28 01:31:50,260 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-5836-1
2026-05-28 01:31:50,507 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/8f266e5c-b24b-4074-9a21-0dd07616337a
2026-05-28 01:31:50,521 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/04314f16-4abd-4bce-adb3-43300c46e93b
2026-05-28 01:31:50,536 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/929d670f-fb45-4f98-bb64-193d39a8b80c
2026-05-28 01:31:51,769 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n64 bytes from 169.254.0.5: icmp_seq=1 ttl=63 time=2.91 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.565 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.565/1.736/2.907/1.171 ms')
2026-05-28 01:31:51,769 - INFO - Ping to Metadata IP 169.254.0.5 of VM mltf_vm passed
2026-05-28 01:31:51,848 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-28 01:31:51,849 - DEBUG - Waiting to SSH to VM mltf_vm, IP 157.95.23.69, Port 22
2026-05-28 01:31:52,023 - DEBUG - VM mltf_vm is ready for SSH connections
2026-05-28 01:31:52,106 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-28 01:31:52,106 - DEBUG - Waiting to SSH to VM mltf_vm, IP 157.95.23.69, Port 22
2026-05-28 01:31:52,279 - DEBUG - VM mltf_vm is ready for SSH connections
2026-05-28 01:31:52,282 - INFO - ================================================================================
2026-05-28 01:31:52,282 - INFO - STARTING TEST : test_verify_session_sampling_teardown
2026-05-28 01:31:52,282 - 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-28 01:31:53,624 - DEBUG - Skipping xmpp flap check
2026-05-28 01:31:53,625 - INFO - Initial checks done. Running the testcase now
2026-05-28 01:31:53,625 - INFO -
2026-05-28 01:31:53,762 - INFO - Setting flow export rate: 100
2026-05-28 01:31:53,811 - 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-28 01:31:54,176 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'd6b91dd9-90c2-46c6-a66b-2b6e85d7feb5', 'name': 'ctest-vn1-29750481', 'tenant_id': 'e622b493331e4770afceb24440163875', 'project_id': 'e622b493331e4770afceb24440163875', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['70711819-0e19-477a-8fdb-7201a876d787'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-66374291', 'ctest-vn1-29750481'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-66374291', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '157.95.23.64/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-05-28 01:31:54,428 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'ef0e8ab0-9952-4762-8851-3499a41b9f0b', 'name': 'ctest-vn2-46267320', 'tenant_id': 'e622b493331e4770afceb24440163875', 'project_id': 'e622b493331e4770afceb24440163875', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['360dfc88-4f06-45c1-bbed-c82c7d47a06e'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-66374291', 'ctest-vn2-46267320'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-66374291', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '19.3.189.0/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2026-05-28 01:31:54,537 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:31:54,546 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:31:54,570 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:31:54,713 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:54,730 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:54,743 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:31:54,782 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:31:54,807 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/26f9a8ea-a0e3-414d-8419-11c755c25ba7
2026-05-28 01:31:54,821 - DEBUG - Route Targets: ['target:64512:8000004']
2026-05-28 01:31:54,821 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:54,839 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:31:54,885 - INFO - Verified VN network id 12 for VN d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:54,885 - INFO - Verifications in API Server for VN ctest-vn1-29750481 passed
2026-05-28 01:31:54,885 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:54,910 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:31:54,927 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:31:54,939 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/26f9a8ea-a0e3-414d-8419-11c755c25ba7
2026-05-28 01:31:54,955 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15472430815081809606', 'uuid-lslong': '11991726186495999669'}, 'enable': 'true', 'created': '2026-05-28T01:30:21', 'last-modified': '2026-05-28T01:31:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.800753'}
2026-05-28 01:31:54,971 - DEBUG - Route Targets: ['target:64512:8000004']
2026-05-28 01:31:54,980 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15472430815081809606', 'uuid-lslong': '11991726186495999669'}, 'enable': 'true', 'created': '2026-05-28T01:30:21', 'last-modified': '2026-05-28T01:31:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.845131'}
2026-05-28 01:31:54,989 - DEBUG - Route Targets: ['target:64512:8000004']
2026-05-28 01:31:54,997 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15472430815081809606', 'uuid-lslong': '11991726186495999669'}, 'enable': 'true', 'created': '2026-05-28T01:30:21', 'last-modified': '2026-05-28T01:31:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.866251'}
2026-05-28 01:31:55,006 - DEBUG - Route Targets: ['target:64512:8000004']
2026-05-28 01:31:55,006 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-29750481 passed
2026-05-28 01:31:55,007 - DEBUG - ====Verifying policy data for ctest-vn1-29750481 in API_Server ======
2026-05-28 01:31:55,007 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:31:55,017 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:31:55,036 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:31:55,169 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:55,186 - DEBUG - ==>Verifying data for policy with id: 498cf8db-ac17-4d2c-82b7-9dccaffd76da, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-66374291', 'policy1']
2026-05-28 01:31:55,186 - INFO - VN ctest-vn1-29750481 Policy verification: verify_vn_policy_in_api_server, status: True
2026-05-28 01:31:55,186 - DEBUG - Verifying the vn in opserver
2026-05-28 01:31:55,187 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 virtual network link through opserver 10.0.0.33
2026-05-28 01:31:55,187 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-05-28 01:31:55,203 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481?flat'}
2026-05-28 01:31:55,203 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 virtual network link through opserver 10.0.0.249
2026-05-28 01:31:55,203 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-28 01:31:55,220 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481?flat'}
2026-05-28 01:31:55,220 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 virtual network link through opserver 10.0.0.22
2026-05-28 01:31:55,220 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-28 01:31:55,238 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481?flat'}
2026-05-28 01:31:55,238 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 is found in opserver
2026-05-28 01:31:55,251 - DEBUG - VRF ids for VN ctest-vn1-29750481: {'10.0.0.19': '2'}
2026-05-28 01:31:55,251 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:31:55,259 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:31:55,275 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:31:55,399 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:55,423 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:55,439 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/bb9542d0-2f6b-4ee7-a5d9-4568897b8731
2026-05-28 01:31:55,456 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/bb9542d0-2f6b-4ee7-a5d9-4568897b8731
2026-05-28 01:31:55,467 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/d9310691-60eb-4f3a-a13d-e3b20ffa532f
2026-05-28 01:31:55,478 - DEBUG - Route Targets: ['target:64512:8000006']
2026-05-28 01:31:55,478 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:55,498 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/bb9542d0-2f6b-4ee7-a5d9-4568897b8731
2026-05-28 01:31:55,525 - INFO - Verified VN network id 13 for VN ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:55,525 - INFO - Verifications in API Server for VN ctest-vn2-46267320 passed
2026-05-28 01:31:55,525 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:55,541 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/bb9542d0-2f6b-4ee7-a5d9-4568897b8731
2026-05-28 01:31:55,553 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/bb9542d0-2f6b-4ee7-a5d9-4568897b8731
2026-05-28 01:31:55,564 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/d9310691-60eb-4f3a-a13d-e3b20ffa532f
2026-05-28 01:31:55,586 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17225858115829909346', 'uuid-lslong': '9822690096759676683'}, 'enable': 'true', 'created': '2026-05-28T01:31:05', 'last-modified': '2026-05-28T01:31:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.194315'}
2026-05-28 01:31:55,597 - DEBUG - Route Targets: ['target:64512:8000006']
2026-05-28 01:31:55,605 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17225858115829909346', 'uuid-lslong': '9822690096759676683'}, 'enable': 'true', 'created': '2026-05-28T01:31:05', 'last-modified': '2026-05-28T01:31:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.231239'}
2026-05-28 01:31:55,617 - DEBUG - Route Targets: ['target:64512:8000006']
2026-05-28 01:31:55,626 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17225858115829909346', 'uuid-lslong': '9822690096759676683'}, 'enable': 'true', 'created': '2026-05-28T01:31:05', 'last-modified': '2026-05-28T01:31:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.253636'}
2026-05-28 01:31:55,636 - DEBUG - Route Targets: ['target:64512:8000006']
2026-05-28 01:31:55,636 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-46267320 passed
2026-05-28 01:31:55,636 - DEBUG - ====Verifying policy data for ctest-vn2-46267320 in API_Server ======
2026-05-28 01:31:55,636 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:31:55,644 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:31:55,660 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:31:55,763 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:55,778 - DEBUG - ==>Verifying data for policy with id: 498cf8db-ac17-4d2c-82b7-9dccaffd76da, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-66374291', 'policy1']
2026-05-28 01:31:55,778 - INFO - VN ctest-vn2-46267320 Policy verification: verify_vn_policy_in_api_server, status: True
2026-05-28 01:31:55,778 - DEBUG - Verifying the vn in opserver
2026-05-28 01:31:55,779 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320 virtual network link through opserver 10.0.0.33
2026-05-28 01:31:55,779 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-05-28 01:31:55,797 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320?flat'}
2026-05-28 01:31:55,797 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320 virtual network link through opserver 10.0.0.249
2026-05-28 01:31:55,797 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-28 01:31:55,815 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320?flat'}
2026-05-28 01:31:55,815 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320 virtual network link through opserver 10.0.0.22
2026-05-28 01:31:55,815 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-28 01:31:55,832 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320?flat'}
2026-05-28 01:31:55,832 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320 is found in opserver
2026-05-28 01:31:55,845 - DEBUG - VRF ids for VN ctest-vn2-46267320: {'10.0.0.19': '3', '10.0.0.129': '2'}
2026-05-28 01:31:55,845 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:31:55,852 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:31:55,866 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:31:55,994 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:56,011 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:56,026 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:31:56,037 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:31:56,050 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/26f9a8ea-a0e3-414d-8419-11c755c25ba7
2026-05-28 01:31:56,060 - DEBUG - Route Targets: ['target:64512:8000004']
2026-05-28 01:31:56,060 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:56,075 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:31:56,099 - INFO - Verified VN network id 12 for VN d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:56,099 - INFO - Verifications in API Server for VN ctest-vn1-29750481 passed
2026-05-28 01:31:56,099 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:56,115 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:31:56,126 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:31:56,136 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/26f9a8ea-a0e3-414d-8419-11c755c25ba7
2026-05-28 01:31:56,152 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15472430815081809606', 'uuid-lslong': '11991726186495999669'}, 'enable': 'true', 'created': '2026-05-28T01:30:21', 'last-modified': '2026-05-28T01:31:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.998321'}
2026-05-28 01:31:56,160 - DEBUG - Route Targets: ['target:64512:8000004']
2026-05-28 01:31:56,168 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15472430815081809606', 'uuid-lslong': '11991726186495999669'}, 'enable': 'true', 'created': '2026-05-28T01:30:21', 'last-modified': '2026-05-28T01:31:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.032313'}
2026-05-28 01:31:56,176 - DEBUG - Route Targets: ['target:64512:8000004']
2026-05-28 01:31:56,185 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15472430815081809606', 'uuid-lslong': '11991726186495999669'}, 'enable': 'true', 'created': '2026-05-28T01:30:21', 'last-modified': '2026-05-28T01:31:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.053989'}
2026-05-28 01:31:56,195 - DEBUG - Route Targets: ['target:64512:8000004']
2026-05-28 01:31:56,195 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-29750481 passed
2026-05-28 01:31:56,195 - DEBUG - ====Verifying policy data for ctest-vn1-29750481 in API_Server ======
2026-05-28 01:31:56,195 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:31:56,205 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:31:56,225 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:31:56,334 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5
2026-05-28 01:31:56,350 - DEBUG - ==>Verifying data for policy with id: 498cf8db-ac17-4d2c-82b7-9dccaffd76da, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-66374291', 'policy1']
2026-05-28 01:31:56,350 - INFO - VN ctest-vn1-29750481 Policy verification: verify_vn_policy_in_api_server, status: True
2026-05-28 01:31:56,350 - DEBUG - Verifying the vn in opserver
2026-05-28 01:31:56,350 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 virtual network link through opserver 10.0.0.33
2026-05-28 01:31:56,351 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-05-28 01:31:56,368 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481?flat'}
2026-05-28 01:31:56,368 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 virtual network link through opserver 10.0.0.249
2026-05-28 01:31:56,368 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-28 01:31:56,384 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481?flat'}
2026-05-28 01:31:56,384 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 virtual network link through opserver 10.0.0.22
2026-05-28 01:31:56,384 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-28 01:31:56,400 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481?flat'}
2026-05-28 01:31:56,401 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481 is found in opserver
2026-05-28 01:31:56,416 - DEBUG - VRF ids for VN ctest-vn1-29750481: {'10.0.0.19': '2'}
2026-05-28 01:31:56,416 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:31:56,426 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:31:56,442 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:31:56,552 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:56,571 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:56,587 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/bb9542d0-2f6b-4ee7-a5d9-4568897b8731
2026-05-28 01:31:56,603 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/bb9542d0-2f6b-4ee7-a5d9-4568897b8731
2026-05-28 01:31:56,617 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/d9310691-60eb-4f3a-a13d-e3b20ffa532f
2026-05-28 01:31:56,628 - DEBUG - Route Targets: ['target:64512:8000006']
2026-05-28 01:31:56,628 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:56,641 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/bb9542d0-2f6b-4ee7-a5d9-4568897b8731
2026-05-28 01:31:56,663 - INFO - Verified VN network id 13 for VN ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:56,663 - INFO - Verifications in API Server for VN ctest-vn2-46267320 passed
2026-05-28 01:31:56,663 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:56,676 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/bb9542d0-2f6b-4ee7-a5d9-4568897b8731
2026-05-28 01:31:56,687 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/bb9542d0-2f6b-4ee7-a5d9-4568897b8731
2026-05-28 01:31:56,699 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/d9310691-60eb-4f3a-a13d-e3b20ffa532f
2026-05-28 01:31:56,716 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17225858115829909346', 'uuid-lslong': '9822690096759676683'}, 'enable': 'true', 'created': '2026-05-28T01:31:05', 'last-modified': '2026-05-28T01:31:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.325413'}
2026-05-28 01:31:56,724 - DEBUG - Route Targets: ['target:64512:8000006']
2026-05-28 01:31:56,730 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17225858115829909346', 'uuid-lslong': '9822690096759676683'}, 'enable': 'true', 'created': '2026-05-28T01:31:05', 'last-modified': '2026-05-28T01:31:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.356642'}
2026-05-28 01:31:56,738 - DEBUG - Route Targets: ['target:64512:8000006']
2026-05-28 01:31:56,745 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17225858115829909346', 'uuid-lslong': '9822690096759676683'}, 'enable': 'true', 'created': '2026-05-28T01:31:05', 'last-modified': '2026-05-28T01:31:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.373458'}
2026-05-28 01:31:56,753 - DEBUG - Route Targets: ['target:64512:8000006']
2026-05-28 01:31:56,753 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-46267320 passed
2026-05-28 01:31:56,753 - DEBUG - ====Verifying policy data for ctest-vn2-46267320 in API_Server ======
2026-05-28 01:31:56,753 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:31:56,762 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:31:56,776 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:31:56,893 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/ef0e8ab0-9952-4762-8851-3499a41b9f0b
2026-05-28 01:31:56,908 - DEBUG - ==>Verifying data for policy with id: 498cf8db-ac17-4d2c-82b7-9dccaffd76da, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-66374291', 'policy1']
2026-05-28 01:31:56,910 - INFO - VN ctest-vn2-46267320 Policy verification: verify_vn_policy_in_api_server, status: True
2026-05-28 01:31:56,910 - DEBUG - Verifying the vn in opserver
2026-05-28 01:31:56,910 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320 virtual network link through opserver 10.0.0.33
2026-05-28 01:31:56,910 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-05-28 01:31:56,927 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320?flat'}
2026-05-28 01:31:56,927 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320 virtual network link through opserver 10.0.0.249
2026-05-28 01:31:56,927 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-28 01:31:56,942 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320?flat'}
2026-05-28 01:31:56,942 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320 virtual network link through opserver 10.0.0.22
2026-05-28 01:31:56,942 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-28 01:31:56,960 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320?flat'}
2026-05-28 01:31:56,960 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320 is found in opserver
2026-05-28 01:31:56,979 - DEBUG - VRF ids for VN ctest-vn2-46267320: {'10.0.0.19': '3', '10.0.0.129': '2'}
2026-05-28 01:31:56,979 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:31:57,000 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:31:57,016 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:31:57,138 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/07945a04-c480-4921-9156-a41462a44c29
2026-05-28 01:31:57,163 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/07945a04-c480-4921-9156-a41462a44c29
2026-05-28 01:31:57,183 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/78aa3138-30b9-462f-872a-56350caece70
2026-05-28 01:31:57,197 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/78aa3138-30b9-462f-872a-56350caece70
2026-05-28 01:31:57,210 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/8a65cd0e-c21a-43d6-abd8-7040c6fb5006
2026-05-28 01:31:57,222 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 01:31:57,222 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/07945a04-c480-4921-9156-a41462a44c29
2026-05-28 01:31:57,236 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/78aa3138-30b9-462f-872a-56350caece70
2026-05-28 01:31:57,259 - INFO - Verified VN network id 14 for VN 07945a04-c480-4921-9156-a41462a44c29
2026-05-28 01:31:57,259 - INFO - Verifications in API Server for VN ctest-fip_vn-31958614 passed
2026-05-28 01:31:57,260 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/07945a04-c480-4921-9156-a41462a44c29
2026-05-28 01:31:57,274 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/78aa3138-30b9-462f-872a-56350caece70
2026-05-28 01:31:57,287 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/78aa3138-30b9-462f-872a-56350caece70
2026-05-28 01:31:57,304 - DEBUG - Requesting: http://10.0.0.33:8082/route-target/8a65cd0e-c21a-43d6-abd8-7040c6fb5006
2026-05-28 01:31:57,324 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '546160431341783329', 'uuid-lslong': '10472738390957902889'}, 'enable': 'true', 'created': '2026-05-28T01:31:06', 'last-modified': '2026-05-28T01:31:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:50.680952'}
2026-05-28 01:31:57,332 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 01:31:57,340 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '546160431341783329', 'uuid-lslong': '10472738390957902889'}, 'enable': 'true', 'created': '2026-05-28T01:31:06', 'last-modified': '2026-05-28T01:31:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:50.705959'}
2026-05-28 01:31:57,349 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 01:31:57,362 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-66374291', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '546160431341783329', 'uuid-lslong': '10472738390957902889'}, 'enable': 'true', 'created': '2026-05-28T01:31:06', 'last-modified': '2026-05-28T01:31:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:50.722403'}
2026-05-28 01:31:57,373 - DEBUG - Route Targets: ['target:64512:8000007']
2026-05-28 01:31:57,373 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-31958614 passed
2026-05-28 01:31:57,374 - DEBUG - ====Verifying policy data for ctest-fip_vn-31958614 in API_Server ======
2026-05-28 01:31:57,374 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:31:57,385 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:31:57,406 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:31:57,537 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-network/07945a04-c480-4921-9156-a41462a44c29
2026-05-28 01:31:57,554 - DEBUG - =>VN ctest-fip_vn-31958614 has no policy to be verified
2026-05-28 01:31:57,554 - DEBUG - Verifying the vn in opserver
2026-05-28 01:31:57,554 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614 virtual network link through opserver 10.0.0.33
2026-05-28 01:31:57,554 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks
2026-05-28 01:31:57,573 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614?flat'}
2026-05-28 01:31:57,573 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614 virtual network link through opserver 10.0.0.249
2026-05-28 01:31:57,573 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks
2026-05-28 01:31:57,592 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614?flat'}
2026-05-28 01:31:57,592 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614 virtual network link through opserver 10.0.0.22
2026-05-28 01:31:57,592 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks
2026-05-28 01:31:57,614 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614?flat'}
2026-05-28 01:31:57,614 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614 is found in opserver
2026-05-28 01:31:57,630 - DEBUG - VRF ids for VN ctest-fip_vn-31958614: {'10.0.0.129': '3'}
2026-05-28 01:31:57,630 - INFO - start time= 1779931917630717
2026-05-28 01:31:57,630 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 19.3.189.3, host_string: cirros@169.254.0.3, password: gocubsgogateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2026-05-28 01:31:57,631 - DEBUG - ping -s 56 -c 3 -W 1 19.3.189.3
2026-05-28 01:32:01,760 - DEBUG - PING 19.3.189.3 (19.3.189.3): 56 data bytes
64 bytes from 19.3.189.3: seq=0 ttl=63 time=4.337 ms
64 bytes from 19.3.189.3: seq=1 ttl=63 time=2.514 ms
64 bytes from 19.3.189.3: seq=2 ttl=63 time=2.212 ms
--- 19.3.189.3 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 2.212/3.021/4.337 ms
2026-05-28 01:32:01,760 - INFO - Ping to IP 19.3.189.3 from VM ctest-vn1_vm1-94685302 passed
2026-05-28 01:32:11,761 - INFO - Verify session samples and teardown pkts
2026-05-28 01:32:11,761 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.33
2026-05-28 01:32:11,765 - DEBUG - Posting: http://10.0.0.33:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1779931917630717, 'end_time': 1779931931765821, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-05-28 01:32:12,791 - DEBUG - [{'T': 1779931920434550}, {'T': 1779931921434684}, {'T': 1779931922434732}]
2026-05-28 01:32:12,792 - DEBUG - Posting: http://10.0.0.33:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1779931917630717, 'end_time': 1779931932792102, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2026-05-28 01:32:13,818 - DEBUG - [{'T': 1779931920596015}, {'T': 1779931921596134}, {'T': 1779931922596257}]
2026-05-28 01:32:13,819 - DEBUG - Posting: http://10.0.0.33:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1779931917630717, 'end_time': 1779931933819070, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-05-28 01:32:14,847 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'sample_count': 3}]
2026-05-28 01:32:14,847 - INFO - wait for the flows to get expire
2026-05-28 01:35:34,848 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5836-1:Compute:contrail-vrouter-agent:0?flat
2026-05-28 01:35:34,999 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5836-1?flat
2026-05-28 01:35:35,116 - DEBUG - Posting: http://10.0.0.33:8081/analytics/query, payload {'table': 'SessionRecordTable', 'start_time': 1779931917630717, 'end_time': 1779932135116481, 'select_fields': ['vn', 'remote_vn', 'forward_teardown_pkts', 'reverse_teardown_pkts'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-05-28 01:35:36,157 - DEBUG - [{'forward_flow_uuid': '07eb166b-319f-4009-ba34-982be9a39f10', 'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'reverse_flow_uuid': '65347c7c-8a1e-4f3b-899a-9d990932a749', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'forward_teardown_pkts': 3, 'reverse_teardown_pkts': 3}]
2026-05-28 01:35:36,158 - DEBUG - Posting: http://10.0.0.33:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1779931917630717, 'end_time': 1779932136158233, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2026-05-28 01:35:37,187 - DEBUG - Posting: http://10.0.0.33:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1779931917630717, 'end_time': 1779932137187112, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2026-05-28 01:35:38,229 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320', 'sample_count': 4}]
2026-05-28 01:35:38,875 - INFO - Deleted policy policy1
2026-05-28 01:35:39,006 - INFO - Setting flow export rate: None
2026-05-28 01:35:40,341 - DEBUG - Skipping xmpp flap check
2026-05-28 01:35:40,341 - INFO - END TEST : test_verify_session_sampling_teardown : PASSED[0:03:48]
2026-05-28 01:35:40,341 - INFO - --------------------------------------------------------------------------------
2026-05-28 01:35:40,342 - INFO - Deleting VM mltf_vm
2026-05-28 01:35:40,461 - INFO - Deleting VM ctest-fvn_vm1-63951791
2026-05-28 01:35:40,557 - INFO - Deleting VM ctest-vn2_vm2-44170058
2026-05-28 01:35:40,661 - INFO - Deleting VN ctest-fip_vn-31958614
2026-05-28 01:35:40,736 - DEBUG - VN 07945a04-c480-4921-9156-a41462a44c29 still in use: Unable to complete operation on network 07945a04-c480-4921-9156-a41462a44c29. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-83934db8-335a-4187-b013-57e95ec6011a']
2026-05-28 01:35:40,736 - WARNING - Deleting VN ctest-fip_vn-31958614 failed..Will retry
2026-05-28 01:35:42,921 - DEBUG - Response for deleting network ()
2026-05-28 01:35:42,921 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/78aa3138-30b9-462f-872a-56350caece70
2026-05-28 01:35:42,983 - DEBUG - Response Code: 404
2026-05-28 01:35:42,984 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:35:42,995 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:35:43,013 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:35:43,118 - INFO - Validated that VN ctest-fip_vn-31958614 is not found in API Server
2026-05-28 01:35:43,134 - DEBUG - VN ctest-fip_vn-31958614 is not present in Agent 10.0.0.19
2026-05-28 01:35:43,146 - DEBUG - VN ctest-fip_vn-31958614 is not present in Agent 10.0.0.129
2026-05-28 01:35:43,146 - INFO - Validated that VN ctest-fip_vn-31958614 is not in any agent
2026-05-28 01:35:43,154 - DEBUG - VRF 3 is not seen in agent 10.0.0.129
2026-05-28 01:35:43,161 - DEBUG - Vrouter 10.0.0.129 does not have vrf 3 for VN ctest-fip_vn-31958614
2026-05-28 01:35:43,161 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-fip_vn-31958614
2026-05-28 01:35:43,189 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-31958614 info
2026-05-28 01:35:43,189 - INFO - Deleting VN ctest-vn2-46267320
2026-05-28 01:35:43,428 - DEBUG - Response for deleting network ()
2026-05-28 01:35:43,428 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/bb9542d0-2f6b-4ee7-a5d9-4568897b8731
2026-05-28 01:35:43,438 - DEBUG - Response Code: 404
2026-05-28 01:35:43,438 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:35:43,451 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:35:43,473 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:35:43,600 - INFO - Validated that VN ctest-vn2-46267320 is not found in API Server
2026-05-28 01:35:43,622 - DEBUG - VN ctest-vn2-46267320 is not present in Agent 10.0.0.19
2026-05-28 01:35:43,639 - DEBUG - VN ctest-vn2-46267320 is not present in Agent 10.0.0.129
2026-05-28 01:35:43,639 - INFO - Validated that VN ctest-vn2-46267320 is not in any agent
2026-05-28 01:35:43,648 - DEBUG - VRF 3 is not seen in agent 10.0.0.19
2026-05-28 01:35:43,654 - DEBUG - Vrouter 10.0.0.19 does not have vrf 3 for VN ctest-vn2-46267320
2026-05-28 01:35:43,660 - DEBUG - VRF 2 is not seen in agent 10.0.0.129
2026-05-28 01:35:43,666 - DEBUG - Vrouter 10.0.0.129 does not have vrf 2 for VN ctest-vn2-46267320
2026-05-28 01:35:43,666 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn2-46267320
2026-05-28 01:35:43,697 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-46267320 info
2026-05-28 01:35:43,697 - INFO - Deleting VM ctest-vn1_vm2-05126990
2026-05-28 01:35:43,811 - INFO - Deleting VM ctest-vn1_vm1-94685302
2026-05-28 01:35:43,917 - INFO - Deleting VN ctest-vn1-29750481
2026-05-28 01:35:43,978 - DEBUG - VN d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5 still in use: Unable to complete operation on network d6b91dd9-90c2-46c6-a66b-2b6e85d7feb5. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-8d9aed47-f311-4ae4-8303-894046dec379']
2026-05-28 01:35:43,978 - WARNING - Deleting VN ctest-vn1-29750481 failed..Will retry
2026-05-28 01:35:46,175 - DEBUG - Response for deleting network ()
2026-05-28 01:35:46,175 - DEBUG - Requesting: http://10.0.0.33:8082/routing-instance/0c4c32bb-5051-45e9-a1dd-8ead43d034e9
2026-05-28 01:35:46,184 - DEBUG - Response Code: 404
2026-05-28 01:35:46,184 - DEBUG - Requesting: http://10.0.0.33:8082/domains
2026-05-28 01:35:46,208 - DEBUG - Requesting: http://10.0.0.33:8082/domain/d674b25c-031a-4c26-a162-50b7aef4cefd
2026-05-28 01:35:46,233 - DEBUG - Requesting: http://10.0.0.33:8082/project/e622b493-331e-4770-afce-b24440163875
2026-05-28 01:35:46,356 - INFO - Validated that VN ctest-vn1-29750481 is not found in API Server
2026-05-28 01:35:46,369 - DEBUG - VN ctest-vn1-29750481 is not present in Agent 10.0.0.19
2026-05-28 01:35:46,383 - DEBUG - VN ctest-vn1-29750481 is not present in Agent 10.0.0.129
2026-05-28 01:35:46,383 - INFO - Validated that VN ctest-vn1-29750481 is not in any agent
2026-05-28 01:35:46,390 - DEBUG - VRF 2 is not seen in agent 10.0.0.19
2026-05-28 01:35:46,396 - DEBUG - Vrouter 10.0.0.19 does not have vrf 2 for VN ctest-vn1-29750481
2026-05-28 01:35:46,396 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-66374291:ctest-vn1-29750481
2026-05-28 01:35:46,423 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-29750481 info
2026-05-28 01:35:47,369 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-66374291, ID : e622b493-331e-4770-afce-b24440163875