2026-06-18 16:59:22,845 - INFO - Domain Default found not creating 2026-06-18 16:59:23,236 - INFO - Project ctest-AnalyticsTestSanityWithResource-19388606 not found, creating it 2026-06-18 16:59:23,878 - INFO - Created Project:ctest-AnalyticsTestSanityWithResource-19388606, ID : a56a58e3-b177-4f0f-82dc-1d48025f43d7 2026-06-18 16:59:26,069 - DEBUG - Response for create_network : {'network': {'id': '9e39bcc5-3a4c-46a4-a7c7-db5138289ab9', 'name': 'ctest-vn1-91769774', 'tenant_id': 'a56a58e3b1774f0f82dc1d48025f43d7', 'project_id': 'a56a58e3b1774f0f82dc1d48025f43d7', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-19388606', 'ctest-vn1-91769774'], 'port_security_enabled': True, 'description': ''}} 2026-06-18 16:59:26,354 - DEBUG - Response for create_subnet : {'subnet': {'id': '81986d2c-3af7-44c5-b716-07c54f6f6d01', 'name': '', 'tenant_id': 'a56a58e3b1774f0f82dc1d48025f43d7', 'network_id': '9e39bcc5-3a4c-46a4-a7c7-db5138289ab9', 'ip_version': 4, 'cidr': '103.185.157.0/26', 'allocation_pools': [{'start': '103.185.157.2', 'end': '103.185.157.62'}], 'gateway_ip': '103.185.157.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '103.185.157.2', 'tags': [], 'project_id': 'a56a58e3b1774f0f82dc1d48025f43d7'}} 2026-06-18 16:59:26,371 - INFO - Created VN ctest-vn1-91769774 2026-06-18 16:59:26,384 - DEBUG - VN ctest-vn1-91769774 UUID is 9e39bcc5-3a4c-46a4-a7c7-db5138289ab9 2026-06-18 16:59:26,467 - DEBUG - Services list from nova: [, , , ] 2026-06-18 16:59:26,467 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5988-1', 'an-jenkins-deploy-platform-ansible-os-5988-2']} 2026-06-18 16:59:27,656 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5988-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5988-1) 2026-06-18 16:59:28,818 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5988-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5988-1) 2026-06-18 16:59:28,819 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2026-06-18 16:59:29,144 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2026-06-18 16:59:29,172 - DEBUG - Requesting: http://10.0.0.249:8082/domain/9fac9674-3f03-42e2-9600-3ff953e8979b 2026-06-18 16:59:29,190 - DEBUG - Requesting: http://10.0.0.249:8082/project/a56a58e3-b177-4f0f-82dc-1d48025f43d7 2026-06-18 16:59:29,278 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/9e39bcc5-3a4c-46a4-a7c7-db5138289ab9 2026-06-18 16:59:29,298 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/9e39bcc5-3a4c-46a4-a7c7-db5138289ab9 2026-06-18 16:59:29,316 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/5abd2772-ae58-4022-a4b9-1167fbc22434 2026-06-18 16:59:29,327 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/5abd2772-ae58-4022-a4b9-1167fbc22434 2026-06-18 16:59:29,340 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/ba33e988-3f5f-4eb5-b33b-ef34f871fe45 2026-06-18 16:59:29,350 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-06-18 16:59:29,350 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/9e39bcc5-3a4c-46a4-a7c7-db5138289ab9 2026-06-18 16:59:29,362 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/5abd2772-ae58-4022-a4b9-1167fbc22434 2026-06-18 16:59:29,380 - INFO - Verified VN network id 15 for VN 9e39bcc5-3a4c-46a4-a7c7-db5138289ab9 2026-06-18 16:59:29,380 - INFO - Verifications in API Server for VN ctest-vn1-91769774 passed 2026-06-18 16:59:29,380 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/9e39bcc5-3a4c-46a4-a7c7-db5138289ab9 2026-06-18 16:59:29,393 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/5abd2772-ae58-4022-a4b9-1167fbc22434 2026-06-18 16:59:29,402 - DEBUG - Requesting: http://10.0.0.249:8082/routing-instance/5abd2772-ae58-4022-a4b9-1167fbc22434 2026-06-18 16:59:29,411 - DEBUG - Requesting: http://10.0.0.249:8082/route-target/ba33e988-3f5f-4eb5-b33b-ef34f871fe45 2026-06-18 16:59:29,424 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-19388606:ctest-vn1-91769774', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-19388606', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11401351486937777828', 'uuid-lslong': '12089872866580404921'}, 'enable': 'true', 'created': '2026-06-18T16:59:26', 'last-modified': '2026-06-18T16:59:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.120384'} 2026-06-18 16:59:29,430 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-06-18 16:59:29,435 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-19388606:ctest-vn1-91769774', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-19388606', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11401351486937777828', 'uuid-lslong': '12089872866580404921'}, 'enable': 'true', 'created': '2026-06-18T16:59:26', 'last-modified': '2026-06-18T16:59:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.133008'} 2026-06-18 16:59:29,440 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-06-18 16:59:29,445 - DEBUG - Control-node 10.0.0.22 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-19388606:ctest-vn1-91769774', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-19388606', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '11401351486937777828', 'uuid-lslong': '12089872866580404921'}, 'enable': 'true', 'created': '2026-06-18T16:59:26', 'last-modified': '2026-06-18T16:59:26', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.142139'} 2026-06-18 16:59:29,451 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-06-18 16:59:29,451 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-91769774 passed 2026-06-18 16:59:29,451 - DEBUG - ====Verifying policy data for ctest-vn1-91769774 in API_Server ====== 2026-06-18 16:59:29,451 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2026-06-18 16:59:29,457 - DEBUG - Requesting: http://10.0.0.249:8082/domain/9fac9674-3f03-42e2-9600-3ff953e8979b 2026-06-18 16:59:29,469 - DEBUG - Requesting: http://10.0.0.249:8082/project/a56a58e3-b177-4f0f-82dc-1d48025f43d7 2026-06-18 16:59:29,569 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-network/9e39bcc5-3a4c-46a4-a7c7-db5138289ab9 2026-06-18 16:59:29,580 - DEBUG - =>VN ctest-vn1-91769774 has no policy to be verified 2026-06-18 16:59:29,580 - DEBUG - Verifying the vn in opserver 2026-06-18 16:59:29,580 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-19388606:ctest-vn1-91769774 virtual network link through opserver 10.0.0.249 2026-06-18 16:59:29,580 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-06-18 16:59:29,904 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-06-18 16:59:29,953 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-19388606:ctest-vn1-91769774', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-19388606:ctest-vn1-91769774?flat'} 2026-06-18 16:59:29,953 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-19388606:ctest-vn1-91769774 virtual network link through opserver 10.0.0.38 2026-06-18 16:59:29,953 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2026-06-18 16:59:30,277 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2026-06-18 16:59:30,330 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-19388606:ctest-vn1-91769774', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-19388606:ctest-vn1-91769774?flat'} 2026-06-18 16:59:30,330 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-19388606:ctest-vn1-91769774 virtual network link through opserver 10.0.0.22 2026-06-18 16:59:30,330 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks 2026-06-18 16:59:30,657 - DEBUG - Requesting: http://10.0.0.22:8081/analytics/uves/virtual-networks 2026-06-18 16:59:30,714 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-19388606:ctest-vn1-91769774', 'href': 'http://10.0.0.22:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-19388606:ctest-vn1-91769774?flat'} 2026-06-18 16:59:30,714 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-19388606:ctest-vn1-91769774 is found in opserver 2026-06-18 16:59:30,734 - DEBUG - Do not have enough data to verify VN in agent 2026-06-18 16:59:30,742 - DEBUG - VRF ids for VN ctest-vn1-91769774: {} 2026-06-18 16:59:30,742 - INFO - Waiting for VM ctest-vn1_vm1-72845676 to be up.. 2026-06-18 16:59:30,803 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-06-18 16:59:35,878 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-06-18 16:59:40,940 - DEBUG - VM is in ERROR state now 2026-06-18 16:59:40,940 - ERROR - VM in error state. 2026-06-18 16:59:40,940 - ERROR - VM is not in ACTIVE state 2026-06-18 16:59:41,015 - ERROR - Fatal Nova Exception while getting VM detail 2026-06-18 16:59:41,015 - DEBUG - None