2025-12-15 03:54:13,253 - INFO - Domain Default found not creating
2025-12-15 03:54:13,403 - INFO - Project ctest-AnalyticsTestSanityWithResource-14156720 not found, creating it
2025-12-15 03:54:13,958 - INFO - Created Project:ctest-AnalyticsTestSanityWithResource-14156720, ID : 91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:54:16,024 - DEBUG - Response for create_network : {'network': {'id': 'c23cbd8c-298f-467c-9f8b-efcc15881c80', 'name': 'ctest-vn1-15151323', 'tenant_id': '91e75b05a88845969a3b1071d810ad8b', 'project_id': '91e75b05a88845969a3b1071d810ad8b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-14156720', 'ctest-vn1-15151323'], 'port_security_enabled': True, 'description': ''}}
2025-12-15 03:54:16,294 - DEBUG - Response for create_subnet : {'subnet': {'id': '1aa27958-2934-4ada-aee2-8fe4ad5b30b4', 'name': '', 'tenant_id': '91e75b05a88845969a3b1071d810ad8b', 'network_id': 'c23cbd8c-298f-467c-9f8b-efcc15881c80', 'ip_version': 4, 'cidr': '220.222.84.192/26', 'allocation_pools': [{'start': '220.222.84.194', 'end': '220.222.84.254'}], 'gateway_ip': '220.222.84.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '220.222.84.194', 'tags': [], 'project_id': '91e75b05a88845969a3b1071d810ad8b'}}
2025-12-15 03:54:16,315 - INFO - Created VN ctest-vn1-15151323
2025-12-15 03:54:16,330 - DEBUG - VN ctest-vn1-15151323 UUID is c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:54:16,418 - DEBUG - Services list from nova: [, , , ]
2025-12-15 03:54:16,418 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-4894-2', 'an-jenkins-deploy-platform-ansible-os-4894-1']}
2025-12-15 03:54:17,429 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4894-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4894-2)
2025-12-15 03:54:18,686 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4894-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4894-2)
2025-12-15 03:54:18,686 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:54:18,984 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:54:19,018 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:54:19,032 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:54:19,121 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:54:19,134 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:54:19,158 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:54:19,172 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:54:19,196 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/f6e2fa01-7e5c-42c1-8fb9-7656f6f043cf
2025-12-15 03:54:19,205 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-15 03:54:19,206 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:54:19,221 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:54:19,239 - INFO - Verified VN network id 11 for VN c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:54:19,239 - INFO - Verifications in API Server for VN ctest-vn1-15151323 passed
2025-12-15 03:54:19,239 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:54:19,278 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:54:19,288 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:54:19,304 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/f6e2fa01-7e5c-42c1-8fb9-7656f6f043cf
2025-12-15 03:54:19,320 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13996270151650985596', 'uuid-lslong': '11496546133606931584'}, 'enable': 'true', 'created': '2025-12-15T03:54:15', 'last-modified': '2025-12-15T03:54:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.088812'}
2025-12-15 03:54:19,326 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-15 03:54:19,332 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13996270151650985596', 'uuid-lslong': '11496546133606931584'}, 'enable': 'true', 'created': '2025-12-15T03:54:15', 'last-modified': '2025-12-15T03:54:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.102219'}
2025-12-15 03:54:19,342 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-15 03:54:19,350 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13996270151650985596', 'uuid-lslong': '11496546133606931584'}, 'enable': 'true', 'created': '2025-12-15T03:54:15', 'last-modified': '2025-12-15T03:54:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.127152'}
2025-12-15 03:54:19,373 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-15 03:54:19,374 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-15151323 passed
2025-12-15 03:54:19,374 - DEBUG - ====Verifying policy data for ctest-vn1-15151323 in API_Server ======
2025-12-15 03:54:19,374 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:54:19,383 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:54:19,396 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:54:19,501 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:54:19,525 - DEBUG - =>VN ctest-vn1-15151323 has no policy to be verified
2025-12-15 03:54:19,525 - DEBUG - Verifying the vn in opserver
2025-12-15 03:54:19,525 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 virtual network link through opserver 10.0.0.23
2025-12-15 03:54:19,525 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-15 03:54:19,877 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-15 03:54:19,943 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323?flat'}
2025-12-15 03:54:19,943 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 virtual network link through opserver 10.0.0.50
2025-12-15 03:54:19,943 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-15 03:54:20,236 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-15 03:54:20,303 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323?flat'}
2025-12-15 03:54:20,303 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 virtual network link through opserver 10.0.0.65
2025-12-15 03:54:20,303 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-15 03:54:20,615 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-15 03:54:20,675 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323?flat'}
2025-12-15 03:54:20,675 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 is found in opserver
2025-12-15 03:54:20,686 - DEBUG - VRF ids for VN ctest-vn1-15151323: {'10.0.0.27': '2'}
2025-12-15 03:54:20,686 - INFO - Waiting for VM ctest-vn1_vm1-82465718 to be up..
2025-12-15 03:54:20,768 - DEBUG - VM is in ACTIVE state now
2025-12-15 03:54:20,768 - INFO - VM name : ctest-vn1_vm1-82465718
2025-12-15 03:54:20,847 - DEBUG - VM ctest-vn1_vm1-82465718 ID is 7e157b03-0d3c-4876-b5eb-ca91da4d9a7f
2025-12-15 03:54:20,869 - DEBUG - VM ctest-vn1_vm1-82465718 launched on Node an-jenkins-deploy-platform-ansible-os-4894-2
2025-12-15 03:54:20,943 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/7e157b03-0d3c-4876-b5eb-ca91da4d9a7f
2025-12-15 03:54:21,235 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/7e157b03-0d3c-4876-b5eb-ca91da4d9a7f
2025-12-15 03:54:21,273 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/9d865fc8-22d7-4d9e-8ea4-f8ba64ab8338
2025-12-15 03:54:24,470 - 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 1029ms')
2025-12-15 03:54:24,470 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-82465718 failed!
2025-12-15 03:54:24,484 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 is 220.222.84.193 and allocation pool is NOT set
2025-12-15 03:54:28,565 - 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 1016ms')
2025-12-15 03:54:28,565 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-82465718 failed!
2025-12-15 03:54:28,580 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 is 220.222.84.193 and allocation pool is NOT set
2025-12-15 03:54:32,662 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms')
2025-12-15 03:54:32,662 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-82465718 failed!
2025-12-15 03:54:32,677 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 is 220.222.84.193 and allocation pool is NOT set
2025-12-15 03:54:36,761 - 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 1019ms')
2025-12-15 03:54:36,761 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-82465718 failed!
2025-12-15 03:54:36,780 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 is 220.222.84.193 and allocation pool is NOT set
2025-12-15 03:54:38,838 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=4.79 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.264 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.264/2.527/4.791/2.263 ms')
2025-12-15 03:54:38,838 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1_vm1-82465718 passed
2025-12-15 03:54:38,903 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-15 03:54:38,903 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-82465718, IP 220.222.84.195, Port 22
2025-12-15 03:54:38,968 - 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': ''}
2025-12-15 03:54:39,050 - DEBUG - VM ctest-vn1_vm1-82465718 is NOT ready for SSH connections, VM status: ACTIVE
2025-12-15 03:54:44,050 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-15 03:54:44,050 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-82465718, IP 220.222.84.195, Port 22
2025-12-15 03:54:44,107 - 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': ''}
2025-12-15 03:54:44,184 - DEBUG - VM ctest-vn1_vm1-82465718 is NOT ready for SSH connections, VM status: ACTIVE
2025-12-15 03:54:49,185 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-15 03:54:49,185 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-82465718, IP 220.222.84.195, Port 22
2025-12-15 03:54:49,342 - DEBUG - VM ctest-vn1_vm1-82465718 is ready for SSH connections
2025-12-15 03:54:49,343 - INFO - Waiting for VM ctest-vn1_vm2-52187568 to be up..
2025-12-15 03:54:49,456 - DEBUG - VM is in ACTIVE state now
2025-12-15 03:54:49,456 - INFO - VM name : ctest-vn1_vm2-52187568
2025-12-15 03:54:49,534 - DEBUG - VM ctest-vn1_vm2-52187568 ID is bd0f9924-a9e6-4fda-9dd0-01aba5e57daa
2025-12-15 03:54:49,534 - DEBUG - VM ctest-vn1_vm2-52187568 launched on Node an-jenkins-deploy-platform-ansible-os-4894-2
2025-12-15 03:54:49,614 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/bd0f9924-a9e6-4fda-9dd0-01aba5e57daa
2025-12-15 03:54:49,627 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/b42b4e6e-0bb6-4435-834f-0af5dbc6fb5b
2025-12-15 03:54:50,800 - 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=3.59 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=3.41 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 = 3.414/3.499/3.585/0.085 ms')
2025-12-15 03:54:50,800 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1_vm2-52187568 passed
2025-12-15 03:54:50,869 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-15 03:54:50,869 - DEBUG - Waiting to SSH to VM ctest-vn1_vm2-52187568, IP 220.222.84.196, Port 22
2025-12-15 03:54:50,937 - 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': ''}
2025-12-15 03:54:51,019 - DEBUG - VM ctest-vn1_vm2-52187568 is NOT ready for SSH connections, VM status: ACTIVE
2025-12-15 03:54:56,019 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-15 03:54:56,019 - DEBUG - Waiting to SSH to VM ctest-vn1_vm2-52187568, IP 220.222.84.196, Port 22
2025-12-15 03:54:56,189 - DEBUG - VM ctest-vn1_vm2-52187568 is ready for SSH connections
2025-12-15 03:54:56,487 - DEBUG - Response for create_network : {'network': {'id': '9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8', 'name': 'ctest-vn2-04198985', 'tenant_id': '91e75b05a88845969a3b1071d810ad8b', 'project_id': '91e75b05a88845969a3b1071d810ad8b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-14156720', 'ctest-vn2-04198985'], 'port_security_enabled': True, 'description': ''}}
2025-12-15 03:54:56,728 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f49231d7-b738-44d3-b05b-08224aea64cc', 'name': '', 'tenant_id': '91e75b05a88845969a3b1071d810ad8b', 'network_id': '9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8', 'ip_version': 4, 'cidr': '17.208.56.192/26', 'allocation_pools': [{'start': '17.208.56.194', 'end': '17.208.56.254'}], 'gateway_ip': '17.208.56.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '17.208.56.194', 'tags': [], 'project_id': '91e75b05a88845969a3b1071d810ad8b'}}
2025-12-15 03:54:56,751 - INFO - Created VN ctest-vn2-04198985
2025-12-15 03:54:56,767 - DEBUG - VN ctest-vn2-04198985 UUID is 9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:54:57,121 - DEBUG - Response for create_network : {'network': {'id': '88a74803-e5c0-46c8-830a-2b90917a14ee', 'name': 'ctest-fip_vn-00968482', 'tenant_id': '91e75b05a88845969a3b1071d810ad8b', 'project_id': '91e75b05a88845969a3b1071d810ad8b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-14156720', 'ctest-fip_vn-00968482'], 'port_security_enabled': True, 'description': ''}}
2025-12-15 03:54:57,399 - DEBUG - Response for create_subnet : {'subnet': {'id': '8b0360ec-566a-4ec4-bcd1-b44ab826ae96', 'name': '', 'tenant_id': '91e75b05a88845969a3b1071d810ad8b', 'network_id': '88a74803-e5c0-46c8-830a-2b90917a14ee', 'ip_version': 4, 'cidr': '94.206.209.0/26', 'allocation_pools': [{'start': '94.206.209.2', 'end': '94.206.209.62'}], 'gateway_ip': '94.206.209.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '94.206.209.2', 'tags': [], 'project_id': '91e75b05a88845969a3b1071d810ad8b'}}
2025-12-15 03:54:57,427 - INFO - Created VN ctest-fip_vn-00968482
2025-12-15 03:54:57,440 - DEBUG - VN ctest-fip_vn-00968482 UUID is 88a74803-e5c0-46c8-830a-2b90917a14ee
2025-12-15 03:54:57,509 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-4894-2', 'an-jenkins-deploy-platform-ansible-os-4894-1']}
2025-12-15 03:54:58,771 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4894-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4894-1)
2025-12-15 03:55:00,319 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4894-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4894-1)
2025-12-15 03:55:01,935 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4894-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4894-2)
2025-12-15 03:55:01,936 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:55:01,943 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:55:01,958 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:55:02,074 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:02,085 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:02,095 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:55:02,103 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:55:02,113 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/f6e2fa01-7e5c-42c1-8fb9-7656f6f043cf
2025-12-15 03:55:02,119 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-15 03:55:02,119 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:02,129 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:55:02,145 - INFO - Verified VN network id 11 for VN c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:02,145 - INFO - Verifications in API Server for VN ctest-vn1-15151323 passed
2025-12-15 03:55:02,145 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:02,156 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:55:02,171 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:55:02,179 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/f6e2fa01-7e5c-42c1-8fb9-7656f6f043cf
2025-12-15 03:55:02,192 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13996270151650985596', 'uuid-lslong': '11496546133606931584'}, 'enable': 'true', 'created': '2025-12-15T03:54:15', 'last-modified': '2025-12-15T03:54:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:45.959899'}
2025-12-15 03:55:02,196 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-15 03:55:02,203 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13996270151650985596', 'uuid-lslong': '11496546133606931584'}, 'enable': 'true', 'created': '2025-12-15T03:54:15', 'last-modified': '2025-12-15T03:54:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:45.973007'}
2025-12-15 03:55:02,209 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-15 03:55:02,215 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13996270151650985596', 'uuid-lslong': '11496546133606931584'}, 'enable': 'true', 'created': '2025-12-15T03:54:15', 'last-modified': '2025-12-15T03:54:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:45.991231'}
2025-12-15 03:55:02,236 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-15 03:55:02,236 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-15151323 passed
2025-12-15 03:55:02,237 - DEBUG - ====Verifying policy data for ctest-vn1-15151323 in API_Server ======
2025-12-15 03:55:02,237 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:55:02,245 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:55:02,262 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:55:02,389 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:02,409 - DEBUG - =>VN ctest-vn1-15151323 has no policy to be verified
2025-12-15 03:55:02,409 - DEBUG - Verifying the vn in opserver
2025-12-15 03:55:02,409 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 virtual network link through opserver 10.0.0.23
2025-12-15 03:55:02,409 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-15 03:55:02,499 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323?flat'}
2025-12-15 03:55:02,499 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 virtual network link through opserver 10.0.0.50
2025-12-15 03:55:02,499 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-15 03:55:02,603 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323?flat'}
2025-12-15 03:55:02,603 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 virtual network link through opserver 10.0.0.65
2025-12-15 03:55:02,603 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-15 03:55:02,680 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323?flat'}
2025-12-15 03:55:02,680 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 is found in opserver
2025-12-15 03:55:02,693 - DEBUG - VRF ids for VN ctest-vn1-15151323: {'10.0.0.27': '2'}
2025-12-15 03:55:02,693 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:55:02,711 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:55:02,722 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:55:02,863 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:02,894 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:02,905 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7de602ab-86d5-4325-96d4-09e48c38dff8
2025-12-15 03:55:02,926 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7de602ab-86d5-4325-96d4-09e48c38dff8
2025-12-15 03:55:02,944 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/83002847-6c25-4b1f-989f-18b5712f85cc
2025-12-15 03:55:02,954 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-15 03:55:02,954 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:02,968 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7de602ab-86d5-4325-96d4-09e48c38dff8
2025-12-15 03:55:02,992 - INFO - Verified VN network id 12 for VN 9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:02,992 - INFO - Verifications in API Server for VN ctest-vn2-04198985 passed
2025-12-15 03:55:02,992 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:03,004 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7de602ab-86d5-4325-96d4-09e48c38dff8
2025-12-15 03:55:03,013 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7de602ab-86d5-4325-96d4-09e48c38dff8
2025-12-15 03:55:03,021 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/83002847-6c25-4b1f-989f-18b5712f85cc
2025-12-15 03:55:03,038 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11221206461061942499', 'uuid-lslong': '9291300583524921320'}, 'enable': 'true', 'created': '2025-12-15T03:54:56', 'last-modified': '2025-12-15T03:54:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.354568'}
2025-12-15 03:55:03,047 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-15 03:55:03,053 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11221206461061942499', 'uuid-lslong': '9291300583524921320'}, 'enable': 'true', 'created': '2025-12-15T03:54:56', 'last-modified': '2025-12-15T03:54:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.374878'}
2025-12-15 03:55:03,059 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-15 03:55:03,064 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11221206461061942499', 'uuid-lslong': '9291300583524921320'}, 'enable': 'true', 'created': '2025-12-15T03:54:56', 'last-modified': '2025-12-15T03:54:56', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.399997'}
2025-12-15 03:55:03,071 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-15 03:55:03,071 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-04198985 passed
2025-12-15 03:55:03,071 - DEBUG - ====Verifying policy data for ctest-vn2-04198985 in API_Server ======
2025-12-15 03:55:03,071 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:55:03,078 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:55:03,090 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:55:03,199 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:03,213 - DEBUG - =>VN ctest-vn2-04198985 has no policy to be verified
2025-12-15 03:55:03,213 - DEBUG - Verifying the vn in opserver
2025-12-15 03:55:03,213 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985 virtual network link through opserver 10.0.0.23
2025-12-15 03:55:03,213 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-15 03:55:03,229 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985?flat'}
2025-12-15 03:55:03,229 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985 virtual network link through opserver 10.0.0.50
2025-12-15 03:55:03,229 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-15 03:55:03,255 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985?flat'}
2025-12-15 03:55:03,255 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985 virtual network link through opserver 10.0.0.65
2025-12-15 03:55:03,255 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-15 03:55:03,367 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985?flat'}
2025-12-15 03:55:03,367 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985 is found in opserver
2025-12-15 03:55:03,381 - DEBUG - VRF ids for VN ctest-vn2-04198985: {'10.0.0.22': '2'}
2025-12-15 03:55:03,381 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:55:03,394 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:55:03,405 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:55:03,504 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/88a74803-e5c0-46c8-830a-2b90917a14ee
2025-12-15 03:55:03,517 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/88a74803-e5c0-46c8-830a-2b90917a14ee
2025-12-15 03:55:03,526 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/8cc09ce5-d1f3-4f07-847d-4d5cd2b44606
2025-12-15 03:55:03,534 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/8cc09ce5-d1f3-4f07-847d-4d5cd2b44606
2025-12-15 03:55:03,543 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/4fadb0a9-7478-4d4c-8b0c-40c35bc4c1fc
2025-12-15 03:55:03,550 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-15 03:55:03,550 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/88a74803-e5c0-46c8-830a-2b90917a14ee
2025-12-15 03:55:03,565 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/8cc09ce5-d1f3-4f07-847d-4d5cd2b44606
2025-12-15 03:55:03,584 - INFO - Verified VN network id 13 for VN 88a74803-e5c0-46c8-830a-2b90917a14ee
2025-12-15 03:55:03,585 - INFO - Verifications in API Server for VN ctest-fip_vn-00968482 passed
2025-12-15 03:55:03,585 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/88a74803-e5c0-46c8-830a-2b90917a14ee
2025-12-15 03:55:03,596 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/8cc09ce5-d1f3-4f07-847d-4d5cd2b44606
2025-12-15 03:55:03,604 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/8cc09ce5-d1f3-4f07-847d-4d5cd2b44606
2025-12-15 03:55:03,612 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/4fadb0a9-7478-4d4c-8b0c-40c35bc4c1fc
2025-12-15 03:55:03,627 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9846918291845564104', 'uuid-lslong': '9442407468651648238'}, 'enable': 'true', 'created': '2025-12-15T03:54:57', 'last-modified': '2025-12-15T03:54:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.319039'}
2025-12-15 03:55:03,632 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-15 03:55:03,638 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9846918291845564104', 'uuid-lslong': '9442407468651648238'}, 'enable': 'true', 'created': '2025-12-15T03:54:57', 'last-modified': '2025-12-15T03:54:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.320141'}
2025-12-15 03:55:03,646 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-15 03:55:03,651 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9846918291845564104', 'uuid-lslong': '9442407468651648238'}, 'enable': 'true', 'created': '2025-12-15T03:54:57', 'last-modified': '2025-12-15T03:54:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:06.345974'}
2025-12-15 03:55:03,657 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-15 03:55:03,657 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-00968482 passed
2025-12-15 03:55:03,658 - DEBUG - ====Verifying policy data for ctest-fip_vn-00968482 in API_Server ======
2025-12-15 03:55:03,658 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:55:03,664 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:55:03,675 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:55:03,769 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/88a74803-e5c0-46c8-830a-2b90917a14ee
2025-12-15 03:55:03,779 - DEBUG - =>VN ctest-fip_vn-00968482 has no policy to be verified
2025-12-15 03:55:03,779 - DEBUG - Verifying the vn in opserver
2025-12-15 03:55:03,779 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482 virtual network link through opserver 10.0.0.23
2025-12-15 03:55:03,779 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-15 03:55:03,837 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482?flat'}
2025-12-15 03:55:03,837 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482 virtual network link through opserver 10.0.0.50
2025-12-15 03:55:03,837 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-15 03:55:03,901 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482?flat'}
2025-12-15 03:55:03,901 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482 virtual network link through opserver 10.0.0.65
2025-12-15 03:55:03,901 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-15 03:55:03,916 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482?flat'}
2025-12-15 03:55:03,916 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482 is found in opserver
2025-12-15 03:55:03,928 - DEBUG - VRF ids for VN ctest-fip_vn-00968482: {'10.0.0.22': '3'}
2025-12-15 03:55:03,928 - INFO - Waiting for VM ctest-fvn_vm1-38442447 to be up..
2025-12-15 03:55:04,001 - DEBUG - VM is in ACTIVE state now
2025-12-15 03:55:04,002 - INFO - VM name : ctest-fvn_vm1-38442447
2025-12-15 03:55:04,092 - DEBUG - VM ctest-fvn_vm1-38442447 ID is 43efba43-f6e2-44dd-ba44-fe9bdac898d8
2025-12-15 03:55:04,092 - DEBUG - VM ctest-fvn_vm1-38442447 launched on Node an-jenkins-deploy-platform-ansible-os-4894-1
2025-12-15 03:55:04,167 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/43efba43-f6e2-44dd-ba44-fe9bdac898d8
2025-12-15 03:55:04,177 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/411044ab-5767-45e3-a896-a29e676c570b
2025-12-15 03:55:07,355 - 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 1023ms')
2025-12-15 03:55:07,356 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1-38442447 failed!
2025-12-15 03:55:07,370 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482 is 94.206.209.1 and allocation pool is NOT set
2025-12-15 03:55:11,451 - 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 1023ms')
2025-12-15 03:55:11,451 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1-38442447 failed!
2025-12-15 03:55:11,465 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482 is 94.206.209.1 and allocation pool is NOT set
2025-12-15 03:55:15,545 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms')
2025-12-15 03:55:15,545 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1-38442447 failed!
2025-12-15 03:55:15,559 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482 is 94.206.209.1 and allocation pool is NOT set
2025-12-15 03:55:19,649 - 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 1023ms')
2025-12-15 03:55:19,649 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1-38442447 failed!
2025-12-15 03:55:19,663 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482 is 94.206.209.1 and allocation pool is NOT set
2025-12-15 03:55:21,729 - 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.91 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.640 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.640/4.773/8.907/4.133 ms')
2025-12-15 03:55:21,729 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-fvn_vm1-38442447 passed
2025-12-15 03:55:21,796 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-15 03:55:21,796 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-38442447, IP 94.206.209.3, Port 22
2025-12-15 03:55:21,864 - 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': ''}
2025-12-15 03:55:21,938 - DEBUG - VM ctest-fvn_vm1-38442447 is NOT ready for SSH connections, VM status: ACTIVE
2025-12-15 03:55:26,939 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-15 03:55:26,940 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-38442447, IP 94.206.209.3, Port 22
2025-12-15 03:55:27,008 - 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': ''}
2025-12-15 03:55:27,081 - DEBUG - VM ctest-fvn_vm1-38442447 is NOT ready for SSH connections, VM status: ACTIVE
2025-12-15 03:55:32,082 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-15 03:55:32,082 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-38442447, IP 94.206.209.3, Port 22
2025-12-15 03:55:32,255 - DEBUG - VM ctest-fvn_vm1-38442447 is ready for SSH connections
2025-12-15 03:55:32,255 - INFO - Waiting for VM ctest-vn2_vm2-14549400 to be up..
2025-12-15 03:55:32,331 - DEBUG - VM is in ACTIVE state now
2025-12-15 03:55:32,331 - INFO - VM name : ctest-vn2_vm2-14549400
2025-12-15 03:55:32,407 - DEBUG - VM ctest-vn2_vm2-14549400 ID is 7fda84d6-8bd9-4fcc-871c-c544abd76e78
2025-12-15 03:55:32,407 - DEBUG - VM ctest-vn2_vm2-14549400 launched on Node an-jenkins-deploy-platform-ansible-os-4894-1
2025-12-15 03:55:32,480 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/7fda84d6-8bd9-4fcc-871c-c544abd76e78
2025-12-15 03:55:32,490 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/5fff70db-2c3d-4d50-acbf-501bcdabbba3
2025-12-15 03:55:33,667 - 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=3.04 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.25 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1000ms\r\nrtt min/avg/max/mdev = 1.248/2.144/3.041/0.896 ms')
2025-12-15 03:55:33,668 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn2_vm2-14549400 passed
2025-12-15 03:55:33,735 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-15 03:55:33,735 - DEBUG - Waiting to SSH to VM ctest-vn2_vm2-14549400, IP 17.208.56.195, Port 22
2025-12-15 03:55:33,907 - DEBUG - VM ctest-vn2_vm2-14549400 is ready for SSH connections
2025-12-15 03:55:33,907 - INFO - Waiting for VM mltf_vm to be up..
2025-12-15 03:55:33,985 - DEBUG - VM is in ACTIVE state now
2025-12-15 03:55:33,985 - INFO - VM name : mltf_vm
2025-12-15 03:55:34,060 - DEBUG - VM mltf_vm ID is 81e91246-d12a-49f1-816d-7a49b15af17d
2025-12-15 03:55:34,060 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-4894-2
2025-12-15 03:55:34,209 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine/81e91246-d12a-49f1-816d-7a49b15af17d
2025-12-15 03:55:34,220 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/a25653bb-98a7-46a1-9054-6ea0cea421a6
2025-12-15 03:55:34,229 - DEBUG - Requesting: http://10.0.0.65:8082/virtual-machine-interface/a306d917-24ac-4da8-b058-e43c58198296
2025-12-15 03:55:35,402 - 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.63 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.633 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.633/1.629/2.626/0.996 ms')
2025-12-15 03:55:35,402 - INFO - Ping to Metadata IP 169.254.0.5 of VM mltf_vm passed
2025-12-15 03:55:35,476 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-15 03:55:35,476 - DEBUG - Waiting to SSH to VM mltf_vm, IP 220.222.84.197, Port 22
2025-12-15 03:55:35,653 - DEBUG - VM mltf_vm is ready for SSH connections
2025-12-15 03:55:35,730 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-15 03:55:35,730 - DEBUG - Waiting to SSH to VM mltf_vm, IP 220.222.84.197, Port 22
2025-12-15 03:55:35,901 - DEBUG - VM mltf_vm is ready for SSH connections
2025-12-15 03:55:35,903 - INFO - ================================================================================
2025-12-15 03:55:35,903 - INFO - STARTING TEST : test_verify_session_sampling_teardown
2025-12-15 03:55:35,903 - 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
2025-12-15 03:55:37,174 - DEBUG - Skipping xmpp flap check
2025-12-15 03:55:37,175 - INFO - Initial checks done. Running the testcase now
2025-12-15 03:55:37,175 - INFO -
2025-12-15 03:55:37,311 - INFO - Setting flow export rate: 100
2025-12-15 03:55:37,360 - 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]
2025-12-15 03:55:37,710 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'c23cbd8c-298f-467c-9f8b-efcc15881c80', 'name': 'ctest-vn1-15151323', 'tenant_id': '91e75b05a88845969a3b1071d810ad8b', 'project_id': '91e75b05a88845969a3b1071d810ad8b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['1aa27958-2934-4ada-aee2-8fe4ad5b30b4'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-14156720', 'ctest-vn1-15151323'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-14156720', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '220.222.84.192/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-12-15 03:55:37,897 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8', 'name': 'ctest-vn2-04198985', 'tenant_id': '91e75b05a88845969a3b1071d810ad8b', 'project_id': '91e75b05a88845969a3b1071d810ad8b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['f49231d7-b738-44d3-b05b-08224aea64cc'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-14156720', 'ctest-vn2-04198985'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-14156720', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '17.208.56.192/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}}
2025-12-15 03:55:38,010 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:55:38,018 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:55:38,034 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:55:38,162 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:38,210 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:38,220 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:55:38,230 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:55:38,236 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/f6e2fa01-7e5c-42c1-8fb9-7656f6f043cf
2025-12-15 03:55:38,244 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-15 03:55:38,244 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:38,272 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:55:38,290 - INFO - Verified VN network id 11 for VN c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:38,290 - INFO - Verifications in API Server for VN ctest-vn1-15151323 passed
2025-12-15 03:55:38,290 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:38,318 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:55:38,333 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:55:38,348 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/f6e2fa01-7e5c-42c1-8fb9-7656f6f043cf
2025-12-15 03:55:38,374 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13996270151650985596', 'uuid-lslong': '11496546133606931584'}, 'enable': 'true', 'created': '2025-12-15T03:54:15', 'last-modified': '2025-12-15T03:55:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.731522'}
2025-12-15 03:55:38,381 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-15 03:55:38,391 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13996270151650985596', 'uuid-lslong': '11496546133606931584'}, 'enable': 'true', 'created': '2025-12-15T03:54:15', 'last-modified': '2025-12-15T03:55:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.741285'}
2025-12-15 03:55:38,397 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-15 03:55:38,403 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13996270151650985596', 'uuid-lslong': '11496546133606931584'}, 'enable': 'true', 'created': '2025-12-15T03:54:15', 'last-modified': '2025-12-15T03:55:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.753015'}
2025-12-15 03:55:38,410 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-15 03:55:38,410 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-15151323 passed
2025-12-15 03:55:38,410 - DEBUG - ====Verifying policy data for ctest-vn1-15151323 in API_Server ======
2025-12-15 03:55:38,410 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:55:38,415 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:55:38,425 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:55:38,524 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:38,534 - DEBUG - ==>Verifying data for policy with id: 91549870-acf1-4ac7-9858-7c66243b0952, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-14156720', 'policy1']
2025-12-15 03:55:38,534 - INFO - VN ctest-vn1-15151323 Policy verification: verify_vn_policy_in_api_server, status: True
2025-12-15 03:55:38,535 - DEBUG - Verifying the vn in opserver
2025-12-15 03:55:38,535 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 virtual network link through opserver 10.0.0.23
2025-12-15 03:55:38,535 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-15 03:55:38,546 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323?flat'}
2025-12-15 03:55:38,546 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 virtual network link through opserver 10.0.0.50
2025-12-15 03:55:38,546 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-15 03:55:38,559 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323?flat'}
2025-12-15 03:55:38,559 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 virtual network link through opserver 10.0.0.65
2025-12-15 03:55:38,559 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-15 03:55:38,571 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323?flat'}
2025-12-15 03:55:38,572 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 is found in opserver
2025-12-15 03:55:38,582 - DEBUG - VRF ids for VN ctest-vn1-15151323: {'10.0.0.27': '2'}
2025-12-15 03:55:38,582 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:55:38,588 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:55:38,600 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:55:38,690 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:38,705 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:38,715 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7de602ab-86d5-4325-96d4-09e48c38dff8
2025-12-15 03:55:38,724 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7de602ab-86d5-4325-96d4-09e48c38dff8
2025-12-15 03:55:38,733 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/83002847-6c25-4b1f-989f-18b5712f85cc
2025-12-15 03:55:38,738 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-15 03:55:38,739 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:38,748 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7de602ab-86d5-4325-96d4-09e48c38dff8
2025-12-15 03:55:38,764 - INFO - Verified VN network id 12 for VN 9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:38,764 - INFO - Verifications in API Server for VN ctest-vn2-04198985 passed
2025-12-15 03:55:38,764 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:38,776 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7de602ab-86d5-4325-96d4-09e48c38dff8
2025-12-15 03:55:38,784 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7de602ab-86d5-4325-96d4-09e48c38dff8
2025-12-15 03:55:38,793 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/83002847-6c25-4b1f-989f-18b5712f85cc
2025-12-15 03:55:38,803 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11221206461061942499', 'uuid-lslong': '9291300583524921320'}, 'enable': 'true', 'created': '2025-12-15T03:54:56', 'last-modified': '2025-12-15T03:55:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.937621'}
2025-12-15 03:55:38,809 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-15 03:55:38,813 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'interests': '0-1', 'advertised': '0-1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11221206461061942499', 'uuid-lslong': '9291300583524921320'}, 'enable': 'true', 'created': '2025-12-15T03:54:56', 'last-modified': '2025-12-15T03:55:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.946114'}
2025-12-15 03:55:38,819 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-15 03:55:38,825 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11221206461061942499', 'uuid-lslong': '9291300583524921320'}, 'enable': 'true', 'created': '2025-12-15T03:54:56', 'last-modified': '2025-12-15T03:55:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.958252'}
2025-12-15 03:55:38,831 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-15 03:55:38,831 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-04198985 passed
2025-12-15 03:55:38,831 - DEBUG - ====Verifying policy data for ctest-vn2-04198985 in API_Server ======
2025-12-15 03:55:38,832 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:55:38,844 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:55:38,854 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:55:38,952 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:38,961 - DEBUG - ==>Verifying data for policy with id: 91549870-acf1-4ac7-9858-7c66243b0952, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-14156720', 'policy1']
2025-12-15 03:55:38,961 - INFO - VN ctest-vn2-04198985 Policy verification: verify_vn_policy_in_api_server, status: True
2025-12-15 03:55:38,961 - DEBUG - Verifying the vn in opserver
2025-12-15 03:55:38,961 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985 virtual network link through opserver 10.0.0.23
2025-12-15 03:55:38,961 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-15 03:55:38,973 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985?flat'}
2025-12-15 03:55:38,973 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985 virtual network link through opserver 10.0.0.50
2025-12-15 03:55:38,973 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-15 03:55:38,986 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985?flat'}
2025-12-15 03:55:38,986 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985 virtual network link through opserver 10.0.0.65
2025-12-15 03:55:38,986 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-15 03:55:38,998 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985?flat'}
2025-12-15 03:55:38,998 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985 is found in opserver
2025-12-15 03:55:39,010 - DEBUG - VRF ids for VN ctest-vn2-04198985: {'10.0.0.22': '2', '10.0.0.27': '3'}
2025-12-15 03:55:39,010 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:55:39,015 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:55:39,025 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:55:39,117 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:39,129 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:39,141 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:55:39,149 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:55:39,156 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/f6e2fa01-7e5c-42c1-8fb9-7656f6f043cf
2025-12-15 03:55:39,164 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-15 03:55:39,164 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:39,174 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:55:39,189 - INFO - Verified VN network id 11 for VN c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:39,190 - INFO - Verifications in API Server for VN ctest-vn1-15151323 passed
2025-12-15 03:55:39,190 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:39,204 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:55:39,211 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:55:39,219 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/f6e2fa01-7e5c-42c1-8fb9-7656f6f043cf
2025-12-15 03:55:39,232 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13996270151650985596', 'uuid-lslong': '11496546133606931584'}, 'enable': 'true', 'created': '2025-12-15T03:54:15', 'last-modified': '2025-12-15T03:55:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.590947'}
2025-12-15 03:55:39,237 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-15 03:55:39,243 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13996270151650985596', 'uuid-lslong': '11496546133606931584'}, 'enable': 'true', 'created': '2025-12-15T03:54:15', 'last-modified': '2025-12-15T03:55:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.593662'}
2025-12-15 03:55:39,250 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-15 03:55:39,256 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '13996270151650985596', 'uuid-lslong': '11496546133606931584'}, 'enable': 'true', 'created': '2025-12-15T03:54:15', 'last-modified': '2025-12-15T03:55:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.605537'}
2025-12-15 03:55:39,262 - DEBUG - Route Targets: ['target:64512:8000004']
2025-12-15 03:55:39,262 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-15151323 passed
2025-12-15 03:55:39,262 - DEBUG - ====Verifying policy data for ctest-vn1-15151323 in API_Server ======
2025-12-15 03:55:39,262 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:55:39,268 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:55:39,279 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:55:39,381 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/c23cbd8c-298f-467c-9f8b-efcc15881c80
2025-12-15 03:55:39,390 - DEBUG - ==>Verifying data for policy with id: 91549870-acf1-4ac7-9858-7c66243b0952, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-14156720', 'policy1']
2025-12-15 03:55:39,390 - INFO - VN ctest-vn1-15151323 Policy verification: verify_vn_policy_in_api_server, status: True
2025-12-15 03:55:39,390 - DEBUG - Verifying the vn in opserver
2025-12-15 03:55:39,390 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 virtual network link through opserver 10.0.0.23
2025-12-15 03:55:39,390 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-15 03:55:39,402 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323?flat'}
2025-12-15 03:55:39,402 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 virtual network link through opserver 10.0.0.50
2025-12-15 03:55:39,402 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-15 03:55:39,416 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323?flat'}
2025-12-15 03:55:39,416 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 virtual network link through opserver 10.0.0.65
2025-12-15 03:55:39,416 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-15 03:55:39,430 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323?flat'}
2025-12-15 03:55:39,430 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323 is found in opserver
2025-12-15 03:55:39,440 - DEBUG - VRF ids for VN ctest-vn1-15151323: {'10.0.0.27': '2'}
2025-12-15 03:55:39,440 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:55:39,446 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:55:39,456 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:55:39,549 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:39,559 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:39,570 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7de602ab-86d5-4325-96d4-09e48c38dff8
2025-12-15 03:55:39,578 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7de602ab-86d5-4325-96d4-09e48c38dff8
2025-12-15 03:55:39,585 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/83002847-6c25-4b1f-989f-18b5712f85cc
2025-12-15 03:55:39,591 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-15 03:55:39,591 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:39,600 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7de602ab-86d5-4325-96d4-09e48c38dff8
2025-12-15 03:55:39,616 - INFO - Verified VN network id 12 for VN 9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:39,616 - INFO - Verifications in API Server for VN ctest-vn2-04198985 passed
2025-12-15 03:55:39,616 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:39,625 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7de602ab-86d5-4325-96d4-09e48c38dff8
2025-12-15 03:55:39,633 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7de602ab-86d5-4325-96d4-09e48c38dff8
2025-12-15 03:55:39,642 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/83002847-6c25-4b1f-989f-18b5712f85cc
2025-12-15 03:55:39,657 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11221206461061942499', 'uuid-lslong': '9291300583524921320'}, 'enable': 'true', 'created': '2025-12-15T03:54:56', 'last-modified': '2025-12-15T03:55:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.791291'}
2025-12-15 03:55:39,664 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-15 03:55:39,670 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'interests': '0-1', 'advertised': '0-1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11221206461061942499', 'uuid-lslong': '9291300583524921320'}, 'enable': 'true', 'created': '2025-12-15T03:54:56', 'last-modified': '2025-12-15T03:55:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.802214'}
2025-12-15 03:55:39,677 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-15 03:55:39,682 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11221206461061942499', 'uuid-lslong': '9291300583524921320'}, 'enable': 'true', 'created': '2025-12-15T03:54:56', 'last-modified': '2025-12-15T03:55:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.815913'}
2025-12-15 03:55:39,688 - DEBUG - Route Targets: ['target:64512:8000006']
2025-12-15 03:55:39,688 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-04198985 passed
2025-12-15 03:55:39,688 - DEBUG - ====Verifying policy data for ctest-vn2-04198985 in API_Server ======
2025-12-15 03:55:39,688 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:55:39,694 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:55:39,703 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:55:39,793 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/9bb9bbd2-e6ea-4ce3-80f1-54a73e61efe8
2025-12-15 03:55:39,803 - DEBUG - ==>Verifying data for policy with id: 91549870-acf1-4ac7-9858-7c66243b0952, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-14156720', 'policy1']
2025-12-15 03:55:39,803 - INFO - VN ctest-vn2-04198985 Policy verification: verify_vn_policy_in_api_server, status: True
2025-12-15 03:55:39,803 - DEBUG - Verifying the vn in opserver
2025-12-15 03:55:39,804 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985 virtual network link through opserver 10.0.0.23
2025-12-15 03:55:39,804 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-15 03:55:39,817 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985?flat'}
2025-12-15 03:55:39,817 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985 virtual network link through opserver 10.0.0.50
2025-12-15 03:55:39,817 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-15 03:55:39,832 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985?flat'}
2025-12-15 03:55:39,832 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985 virtual network link through opserver 10.0.0.65
2025-12-15 03:55:39,832 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-15 03:55:39,846 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985?flat'}
2025-12-15 03:55:39,846 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985 is found in opserver
2025-12-15 03:55:39,858 - DEBUG - VRF ids for VN ctest-vn2-04198985: {'10.0.0.22': '2', '10.0.0.27': '3'}
2025-12-15 03:55:39,858 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:55:39,863 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:55:39,874 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:55:39,972 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/88a74803-e5c0-46c8-830a-2b90917a14ee
2025-12-15 03:55:39,983 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/88a74803-e5c0-46c8-830a-2b90917a14ee
2025-12-15 03:55:39,992 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/8cc09ce5-d1f3-4f07-847d-4d5cd2b44606
2025-12-15 03:55:40,010 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/8cc09ce5-d1f3-4f07-847d-4d5cd2b44606
2025-12-15 03:55:40,036 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/4fadb0a9-7478-4d4c-8b0c-40c35bc4c1fc
2025-12-15 03:55:40,043 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-15 03:55:40,043 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/88a74803-e5c0-46c8-830a-2b90917a14ee
2025-12-15 03:55:40,053 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/8cc09ce5-d1f3-4f07-847d-4d5cd2b44606
2025-12-15 03:55:40,071 - INFO - Verified VN network id 13 for VN 88a74803-e5c0-46c8-830a-2b90917a14ee
2025-12-15 03:55:40,071 - INFO - Verifications in API Server for VN ctest-fip_vn-00968482 passed
2025-12-15 03:55:40,071 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/88a74803-e5c0-46c8-830a-2b90917a14ee
2025-12-15 03:55:40,080 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/8cc09ce5-d1f3-4f07-847d-4d5cd2b44606
2025-12-15 03:55:40,087 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/8cc09ce5-d1f3-4f07-847d-4d5cd2b44606
2025-12-15 03:55:40,094 - DEBUG - Requesting: http://10.0.0.23:8082/route-target/4fadb0a9-7478-4d4c-8b0c-40c35bc4c1fc
2025-12-15 03:55:40,106 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9846918291845564104', 'uuid-lslong': '9442407468651648238'}, 'enable': 'true', 'created': '2025-12-15T03:54:57', 'last-modified': '2025-12-15T03:54:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:42.798533'}
2025-12-15 03:55:40,111 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-15 03:55:40,117 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9846918291845564104', 'uuid-lslong': '9442407468651648238'}, 'enable': 'true', 'created': '2025-12-15T03:54:57', 'last-modified': '2025-12-15T03:54:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:42.798537'}
2025-12-15 03:55:40,125 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-15 03:55:40,132 - DEBUG - Control-node 10.0.0.65 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-14156720', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '9846918291845564104', 'uuid-lslong': '9442407468651648238'}, 'enable': 'true', 'created': '2025-12-15T03:54:57', 'last-modified': '2025-12-15T03:54:57', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:42.826830'}
2025-12-15 03:55:40,138 - DEBUG - Route Targets: ['target:64512:8000007']
2025-12-15 03:55:40,139 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-00968482 passed
2025-12-15 03:55:40,139 - DEBUG - ====Verifying policy data for ctest-fip_vn-00968482 in API_Server ======
2025-12-15 03:55:40,139 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:55:40,146 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:55:40,164 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:55:40,258 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/88a74803-e5c0-46c8-830a-2b90917a14ee
2025-12-15 03:55:40,268 - DEBUG - =>VN ctest-fip_vn-00968482 has no policy to be verified
2025-12-15 03:55:40,268 - DEBUG - Verifying the vn in opserver
2025-12-15 03:55:40,268 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482 virtual network link through opserver 10.0.0.23
2025-12-15 03:55:40,268 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks
2025-12-15 03:55:40,282 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482?flat'}
2025-12-15 03:55:40,282 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482 virtual network link through opserver 10.0.0.50
2025-12-15 03:55:40,282 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks
2025-12-15 03:55:40,297 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482?flat'}
2025-12-15 03:55:40,297 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482 virtual network link through opserver 10.0.0.65
2025-12-15 03:55:40,297 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/virtual-networks
2025-12-15 03:55:40,311 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482', 'href': 'http://10.0.0.65:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482?flat'}
2025-12-15 03:55:40,311 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482 is found in opserver
2025-12-15 03:55:40,322 - DEBUG - VRF ids for VN ctest-fip_vn-00968482: {'10.0.0.22': '3'}
2025-12-15 03:55:40,323 - INFO - start time= 1765770940322999
2025-12-15 03:55:40,323 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 17.208.56.195, host_string: cirros@169.254.0.3, password: gocubsgogateway: ubuntu@10.0.0.27, gateway password: c0ntrail123
2025-12-15 03:55:40,323 - DEBUG - ping -s 56 -c 3 -W 1 17.208.56.195
2025-12-15 03:55:43,959 - DEBUG - PING 17.208.56.195 (17.208.56.195): 56 data bytes
64 bytes from 17.208.56.195: seq=0 ttl=63 time=4.047 ms
64 bytes from 17.208.56.195: seq=1 ttl=63 time=1.811 ms
64 bytes from 17.208.56.195: seq=2 ttl=63 time=1.633 ms
--- 17.208.56.195 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.633/2.497/4.047 ms
2025-12-15 03:55:43,959 - INFO - Ping to IP 17.208.56.195 from VM ctest-vn1_vm1-82465718 passed
2025-12-15 03:55:53,960 - INFO - Verify session samples and teardown pkts
2025-12-15 03:55:53,960 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.23
2025-12-15 03:55:53,964 - DEBUG - Posting: http://10.0.0.23:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1765770940322999, 'end_time': 1765770953963973, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-12-15 03:55:54,983 - DEBUG - [{'T': 1765770942125534}, {'T': 1765770943125626}, {'T': 1765770944125722}]
2025-12-15 03:55:54,983 - DEBUG - Posting: http://10.0.0.23:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1765770940322999, 'end_time': 1765770954983265, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-12-15 03:55:56,004 - DEBUG - [{'T': 1765770942730564}, {'T': 1765770943730649}, {'T': 1765770944730704}]
2025-12-15 03:55:56,004 - DEBUG - Posting: http://10.0.0.23:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1765770940322999, 'end_time': 1765770956004250, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-12-15 03:55:57,025 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'sample_count': 3}]
2025-12-15 03:55:57,025 - INFO - wait for the flows to get expire
2025-12-15 03:59:17,026 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-4894-2:Compute:contrail-vrouter-agent:0?flat
2025-12-15 03:59:17,057 - DEBUG - Requesting: http://10.0.0.65:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-4894-2?flat
2025-12-15 03:59:17,084 - DEBUG - Posting: http://10.0.0.23:8081/analytics/query, payload {'table': 'SessionRecordTable', 'start_time': 1765770940322999, 'end_time': 1765771157084118, 'select_fields': ['vn', 'remote_vn', 'forward_teardown_pkts', 'reverse_teardown_pkts'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-12-15 03:59:18,107 - DEBUG - [{'forward_flow_uuid': '53c199e8-e96d-48f0-af55-40e8deae43c6', 'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'reverse_flow_uuid': '82321509-9cf0-465a-9150-9c80e95e1096', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'forward_teardown_pkts': 3, 'reverse_teardown_pkts': 3}]
2025-12-15 03:59:18,108 - DEBUG - Posting: http://10.0.0.23:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1765770940322999, 'end_time': 1765771158108096, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'}
2025-12-15 03:59:19,128 - DEBUG - Posting: http://10.0.0.23:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1765770940322999, 'end_time': 1765771159128254, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'}
2025-12-15 03:59:20,150 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985', 'sample_count': 4}]
2025-12-15 03:59:20,673 - INFO - Deleted policy policy1
2025-12-15 03:59:20,787 - INFO - Setting flow export rate: None
2025-12-15 03:59:22,067 - DEBUG - Skipping xmpp flap check
2025-12-15 03:59:22,067 - INFO - END TEST : test_verify_session_sampling_teardown : PASSED[0:03:47]
2025-12-15 03:59:22,067 - INFO - --------------------------------------------------------------------------------
2025-12-15 03:59:22,068 - INFO - Deleting VM mltf_vm
2025-12-15 03:59:22,133 - INFO - Deleting VM ctest-fvn_vm1-38442447
2025-12-15 03:59:22,200 - INFO - Deleting VM ctest-vn2_vm2-14549400
2025-12-15 03:59:22,269 - INFO - Deleting VN ctest-fip_vn-00968482
2025-12-15 03:59:22,308 - DEBUG - VN 88a74803-e5c0-46c8-830a-2b90917a14ee still in use: Unable to complete operation on network 88a74803-e5c0-46c8-830a-2b90917a14ee. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-cf79551b-7e81-4bfb-a952-45d89eb11f76']
2025-12-15 03:59:22,309 - WARNING - Deleting VN ctest-fip_vn-00968482 failed..Will retry
2025-12-15 03:59:24,487 - DEBUG - Response for deleting network ()
2025-12-15 03:59:24,488 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/8cc09ce5-d1f3-4f07-847d-4d5cd2b44606
2025-12-15 03:59:24,542 - DEBUG - Response Code: 404
2025-12-15 03:59:24,542 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:59:24,551 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:59:24,563 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:59:24,650 - INFO - Validated that VN ctest-fip_vn-00968482 is not found in API Server
2025-12-15 03:59:24,661 - DEBUG - VN ctest-fip_vn-00968482 is not present in Agent 10.0.0.22
2025-12-15 03:59:24,670 - DEBUG - VN ctest-fip_vn-00968482 is not present in Agent 10.0.0.27
2025-12-15 03:59:24,670 - INFO - Validated that VN ctest-fip_vn-00968482 is not in any agent
2025-12-15 03:59:24,676 - DEBUG - VRF 3 is not seen in agent 10.0.0.22
2025-12-15 03:59:24,683 - DEBUG - Vrouter 10.0.0.22 does not have vrf 3 for VN ctest-fip_vn-00968482
2025-12-15 03:59:24,683 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-fip_vn-00968482
2025-12-15 03:59:24,704 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-00968482 info
2025-12-15 03:59:24,704 - INFO - Deleting VN ctest-vn2-04198985
2025-12-15 03:59:24,851 - DEBUG - Response for deleting network ()
2025-12-15 03:59:24,851 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/7de602ab-86d5-4325-96d4-09e48c38dff8
2025-12-15 03:59:24,856 - DEBUG - Response Code: 404
2025-12-15 03:59:24,856 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:59:24,862 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:59:24,882 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:59:24,980 - INFO - Validated that VN ctest-vn2-04198985 is not found in API Server
2025-12-15 03:59:24,992 - DEBUG - VN ctest-vn2-04198985 is not present in Agent 10.0.0.22
2025-12-15 03:59:25,002 - DEBUG - VN ctest-vn2-04198985 is not present in Agent 10.0.0.27
2025-12-15 03:59:25,002 - INFO - Validated that VN ctest-vn2-04198985 is not in any agent
2025-12-15 03:59:25,008 - DEBUG - VRF 2 is not seen in agent 10.0.0.22
2025-12-15 03:59:25,015 - DEBUG - Vrouter 10.0.0.22 does not have vrf 2 for VN ctest-vn2-04198985
2025-12-15 03:59:25,023 - DEBUG - VRF 3 is not seen in agent 10.0.0.27
2025-12-15 03:59:25,029 - DEBUG - Vrouter 10.0.0.27 does not have vrf 3 for VN ctest-vn2-04198985
2025-12-15 03:59:25,029 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn2-04198985
2025-12-15 03:59:25,050 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-04198985 info
2025-12-15 03:59:25,050 - INFO - Deleting VM ctest-vn1_vm2-52187568
2025-12-15 03:59:25,128 - INFO - Deleting VM ctest-vn1_vm1-82465718
2025-12-15 03:59:25,195 - INFO - Deleting VN ctest-vn1-15151323
2025-12-15 03:59:25,234 - DEBUG - VN c23cbd8c-298f-467c-9f8b-efcc15881c80 still in use: Unable to complete operation on network c23cbd8c-298f-467c-9f8b-efcc15881c80. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-3a3fc818-b602-41ba-8786-788a2c05b8c3']
2025-12-15 03:59:25,234 - WARNING - Deleting VN ctest-vn1-15151323 failed..Will retry
2025-12-15 03:59:27,427 - DEBUG - Response for deleting network ()
2025-12-15 03:59:27,427 - DEBUG - Requesting: http://10.0.0.23:8082/routing-instance/4d7427aa-e60c-4f94-a422-21dd8e9348ba
2025-12-15 03:59:27,434 - DEBUG - Response Code: 404
2025-12-15 03:59:27,434 - DEBUG - Requesting: http://10.0.0.23:8082/domains
2025-12-15 03:59:27,440 - DEBUG - Requesting: http://10.0.0.23:8082/domain/747a8d7b-37d3-4985-88af-26a6e8bf7d0e
2025-12-15 03:59:27,513 - DEBUG - Requesting: http://10.0.0.23:8082/project/91e75b05-a888-4596-9a3b-1071d810ad8b
2025-12-15 03:59:27,617 - INFO - Validated that VN ctest-vn1-15151323 is not found in API Server
2025-12-15 03:59:27,634 - DEBUG - VN ctest-vn1-15151323 is not present in Agent 10.0.0.22
2025-12-15 03:59:27,644 - DEBUG - VN ctest-vn1-15151323 is not present in Agent 10.0.0.27
2025-12-15 03:59:27,644 - INFO - Validated that VN ctest-vn1-15151323 is not in any agent
2025-12-15 03:59:27,649 - DEBUG - VRF 2 is not seen in agent 10.0.0.27
2025-12-15 03:59:27,654 - DEBUG - Vrouter 10.0.0.27 does not have vrf 2 for VN ctest-vn1-15151323
2025-12-15 03:59:27,654 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-14156720:ctest-vn1-15151323
2025-12-15 03:59:27,673 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-15151323 info
2025-12-15 03:59:28,397 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-14156720, ID : 91e75b05-a888-4596-9a3b-1071d810ad8b