2026-06-18 03:25:17,730 - INFO - Domain Default found not creating 2026-06-18 03:25:17,950 - INFO - Project ctest-AnalyticsTestSanityWithResource-59957999 not found, creating it 2026-06-18 03:25:18,423 - INFO - Created Project:ctest-AnalyticsTestSanityWithResource-59957999, ID : 3c4359be-dfc1-4026-8488-0cf18bb17f68 2026-06-18 03:25:20,675 - DEBUG - Response for create_network : {'network': {'id': '0b0b3a16-c0fe-4a1e-a3a8-a3c5a82c947a', 'name': 'ctest-vn1-72163625', 'tenant_id': '3c4359bedfc1402684880cf18bb17f68', 'project_id': '3c4359bedfc1402684880cf18bb17f68', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-59957999', 'ctest-vn1-72163625'], 'port_security_enabled': True, 'description': ''}} 2026-06-18 03:25:20,944 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b0768f89-ab97-4aec-8bf5-ef46678d6de8', 'name': '', 'tenant_id': '3c4359bedfc1402684880cf18bb17f68', 'network_id': '0b0b3a16-c0fe-4a1e-a3a8-a3c5a82c947a', 'ip_version': 4, 'cidr': '131.108.31.0/26', 'allocation_pools': [{'start': '131.108.31.2', 'end': '131.108.31.62'}], 'gateway_ip': '131.108.31.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '131.108.31.2', 'tags': [], 'project_id': '3c4359bedfc1402684880cf18bb17f68'}} 2026-06-18 03:25:20,962 - INFO - Created VN ctest-vn1-72163625 2026-06-18 03:25:20,974 - DEBUG - VN ctest-vn1-72163625 UUID is 0b0b3a16-c0fe-4a1e-a3a8-a3c5a82c947a 2026-06-18 03:25:21,067 - DEBUG - Services list from nova: [, , , ] 2026-06-18 03:25:21,067 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5973-2', 'an-jenkins-deploy-platform-ansible-os-5973-1']} 2026-06-18 03:25:22,418 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5973-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5973-2) 2026-06-18 03:25:23,649 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5973-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5973-2) 2026-06-18 03:25:23,649 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-06-18 03:25:23,977 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-06-18 03:25:24,000 - DEBUG - Requesting: http://10.0.0.27:8082/domain/112b4fa0-b7c4-429e-b96c-45fc5d86f423 2026-06-18 03:25:24,016 - DEBUG - Requesting: http://10.0.0.27:8082/project/3c4359be-dfc1-4026-8488-0cf18bb17f68 2026-06-18 03:25:24,114 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0b0b3a16-c0fe-4a1e-a3a8-a3c5a82c947a 2026-06-18 03:25:24,132 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0b0b3a16-c0fe-4a1e-a3a8-a3c5a82c947a 2026-06-18 03:25:24,146 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/bbe915d5-ae07-45be-a714-8a6abe092f25 2026-06-18 03:25:24,154 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/bbe915d5-ae07-45be-a714-8a6abe092f25 2026-06-18 03:25:24,164 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/ba862dfe-e3fd-4e6b-a931-7169b2de8758 2026-06-18 03:25:24,171 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-06-18 03:25:24,171 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0b0b3a16-c0fe-4a1e-a3a8-a3c5a82c947a 2026-06-18 03:25:24,180 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/bbe915d5-ae07-45be-a714-8a6abe092f25 2026-06-18 03:25:24,195 - INFO - Verified VN network id 14 for VN 0b0b3a16-c0fe-4a1e-a3a8-a3c5a82c947a 2026-06-18 03:25:24,195 - INFO - Verifications in API Server for VN ctest-vn1-72163625 passed 2026-06-18 03:25:24,195 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0b0b3a16-c0fe-4a1e-a3a8-a3c5a82c947a 2026-06-18 03:25:24,205 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/bbe915d5-ae07-45be-a714-8a6abe092f25 2026-06-18 03:25:24,213 - DEBUG - Requesting: http://10.0.0.27:8082/routing-instance/bbe915d5-ae07-45be-a714-8a6abe092f25 2026-06-18 03:25:24,221 - DEBUG - Requesting: http://10.0.0.27:8082/route-target/ba862dfe-e3fd-4e6b-a931-7169b2de8758 2026-06-18 03:25:24,232 - DEBUG - Control-node 10.0.0.27 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59957999:ctest-vn1-72163625', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59957999', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '795793628562606622', 'uuid-lslong': '11792855693595022458'}, 'enable': 'true', 'created': '2026-06-18T03:25:20', 'last-modified': '2026-06-18T03:25:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.343804'} 2026-06-18 03:25:24,238 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-06-18 03:25:24,242 - DEBUG - Control-node 10.0.0.33 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59957999:ctest-vn1-72163625', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59957999', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '795793628562606622', 'uuid-lslong': '11792855693595022458'}, 'enable': 'true', 'created': '2026-06-18T03:25:20', 'last-modified': '2026-06-18T03:25:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.354133'} 2026-06-18 03:25:24,248 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-06-18 03:25:24,253 - DEBUG - Control-node 10.0.0.23 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-59957999:ctest-vn1-72163625', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-59957999', 'owner-access': '7', 'group': 'manager', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '795793628562606622', 'uuid-lslong': '11792855693595022458'}, 'enable': 'true', 'created': '2026-06-18T03:25:20', 'last-modified': '2026-06-18T03:25:20', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.368558'} 2026-06-18 03:25:24,258 - DEBUG - Route Targets: ['target:64512:8000006'] 2026-06-18 03:25:24,258 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-72163625 passed 2026-06-18 03:25:24,258 - DEBUG - ====Verifying policy data for ctest-vn1-72163625 in API_Server ====== 2026-06-18 03:25:24,258 - DEBUG - Requesting: http://10.0.0.27:8082/domains 2026-06-18 03:25:24,264 - DEBUG - Requesting: http://10.0.0.27:8082/domain/112b4fa0-b7c4-429e-b96c-45fc5d86f423 2026-06-18 03:25:24,275 - DEBUG - Requesting: http://10.0.0.27:8082/project/3c4359be-dfc1-4026-8488-0cf18bb17f68 2026-06-18 03:25:24,365 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-network/0b0b3a16-c0fe-4a1e-a3a8-a3c5a82c947a 2026-06-18 03:25:24,377 - DEBUG - =>VN ctest-vn1-72163625 has no policy to be verified 2026-06-18 03:25:24,377 - DEBUG - Verifying the vn in opserver 2026-06-18 03:25:24,377 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59957999:ctest-vn1-72163625 virtual network link through opserver 10.0.0.27 2026-06-18 03:25:24,377 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-06-18 03:25:24,722 - DEBUG - Requesting: http://10.0.0.27:8081/analytics/uves/virtual-networks 2026-06-18 03:25:24,775 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59957999:ctest-vn1-72163625', 'href': 'http://10.0.0.27:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59957999:ctest-vn1-72163625?flat'} 2026-06-18 03:25:24,776 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59957999:ctest-vn1-72163625 virtual network link through opserver 10.0.0.33 2026-06-18 03:25:24,776 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks 2026-06-18 03:25:25,107 - DEBUG - Requesting: http://10.0.0.33:8081/analytics/uves/virtual-networks 2026-06-18 03:25:25,156 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59957999:ctest-vn1-72163625', 'href': 'http://10.0.0.33:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59957999:ctest-vn1-72163625?flat'} 2026-06-18 03:25:25,156 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-59957999:ctest-vn1-72163625 virtual network link through opserver 10.0.0.23 2026-06-18 03:25:25,157 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-06-18 03:25:25,493 - DEBUG - Requesting: http://10.0.0.23:8081/analytics/uves/virtual-networks 2026-06-18 03:25:25,560 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-59957999:ctest-vn1-72163625', 'href': 'http://10.0.0.23:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-59957999:ctest-vn1-72163625?flat'} 2026-06-18 03:25:25,560 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-59957999:ctest-vn1-72163625 is found in opserver 2026-06-18 03:25:25,589 - DEBUG - Do not have enough data to verify VN in agent 2026-06-18 03:25:25,600 - DEBUG - VRF ids for VN ctest-vn1-72163625: {} 2026-06-18 03:25:25,600 - INFO - Waiting for VM ctest-vn1_vm1-06281210 to be up.. 2026-06-18 03:25:25,660 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-06-18 03:25:30,790 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-06-18 03:25:35,853 - DEBUG - VM is in ERROR state now 2026-06-18 03:25:35,853 - ERROR - VM in error state. 2026-06-18 03:25:35,853 - ERROR - VM is not in ACTIVE state 2026-06-18 03:25:35,941 - ERROR - Fatal Nova Exception while getting VM detail 2026-06-18 03:25:35,941 - DEBUG - None