2025-07-24 05:37:12,399 - INFO - Domain Default found not creating 2025-07-24 05:37:12,581 - INFO - Project ctest-TestIpVlanLearning-21623978 not found, creating it 2025-07-24 05:37:13,237 - INFO - Created Project:ctest-TestIpVlanLearning-21623978, ID : 65e39e0e-7ecd-49ba-9a1b-559913cfded9 2025-07-24 05:37:15,335 - DEBUG - Services list from nova: [, , , ] 2025-07-24 05:37:15,335 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-3712-1', 'an-jenkins-deploy-platform-ansible-os-3712-2']} 2025-07-24 05:37:15,337 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-3712-1', 'an-jenkins-deploy-platform-ansible-os-3712-2']} 2025-07-24 05:37:16,405 - DEBUG - Response for create_network : {'network': {'id': 'b73bd8f4-adaa-4f39-b822-e5fb3917b58d', 'name': 'ctest-vn1-64148720', 'tenant_id': '65e39e0e7ecd49ba9a1b559913cfded9', 'project_id': '65e39e0e7ecd49ba9a1b559913cfded9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIpVlanLearning-21623978', 'ctest-vn1-64148720'], 'port_security_enabled': True, 'description': ''}} 2025-07-24 05:37:16,795 - DEBUG - Response for create_subnet : {'subnet': {'id': '556437e9-48eb-4ebc-bb4d-5c5411c26250', 'name': '', 'tenant_id': '65e39e0e7ecd49ba9a1b559913cfded9', 'network_id': 'b73bd8f4-adaa-4f39-b822-e5fb3917b58d', 'ip_version': 4, 'cidr': '206.231.101.0/24', 'allocation_pools': [{'start': '206.231.101.2', 'end': '206.231.101.254'}], 'gateway_ip': '206.231.101.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '206.231.101.2', 'tags': [], 'project_id': '65e39e0e7ecd49ba9a1b559913cfded9'}} 2025-07-24 05:37:16,824 - INFO - Created VN ctest-vn1-64148720 2025-07-24 05:37:16,841 - DEBUG - VN ctest-vn1-64148720 UUID is b73bd8f4-adaa-4f39-b822-e5fb3917b58d 2025-07-24 05:37:17,265 - DEBUG - Response for create_network : {'network': {'id': '9ba8daca-bc03-476f-a66e-3034f53c01b9', 'name': 'ctest-vn2-00394104', 'tenant_id': '65e39e0e7ecd49ba9a1b559913cfded9', 'project_id': '65e39e0e7ecd49ba9a1b559913cfded9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIpVlanLearning-21623978', 'ctest-vn2-00394104'], 'port_security_enabled': True, 'description': ''}} 2025-07-24 05:37:17,581 - DEBUG - Response for create_subnet : {'subnet': {'id': '2caa6577-e2ce-487c-903d-05f3c7856119', 'name': '', 'tenant_id': '65e39e0e7ecd49ba9a1b559913cfded9', 'network_id': '9ba8daca-bc03-476f-a66e-3034f53c01b9', 'ip_version': 4, 'cidr': '20.31.132.0/24', 'allocation_pools': [{'start': '20.31.132.2', 'end': '20.31.132.254'}], 'gateway_ip': '20.31.132.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '20.31.132.2', 'tags': [], 'project_id': '65e39e0e7ecd49ba9a1b559913cfded9'}} 2025-07-24 05:37:17,607 - INFO - Created VN ctest-vn2-00394104 2025-07-24 05:37:17,630 - DEBUG - VN ctest-vn2-00394104 UUID is 9ba8daca-bc03-476f-a66e-3034f53c01b9 2025-07-24 05:37:17,727 - DEBUG - Updating mac_ip_learning flag on VN default-domain:ctest-TestIpVlanLearning-21623978:ctest-vn1-64148720 to True 2025-07-24 05:37:17,852 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/b73bd8f4-adaa-4f39-b822-e5fb3917b58d 2025-07-24 05:37:18,163 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/b73bd8f4-adaa-4f39-b822-e5fb3917b58d 2025-07-24 05:37:18,208 - DEBUG - Updating mac_ip_learning flag on VN default-domain:ctest-TestIpVlanLearning-21623978:ctest-vn2-00394104 to True 2025-07-24 05:37:18,336 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/9ba8daca-bc03-476f-a66e-3034f53c01b9 2025-07-24 05:37:18,563 - DEBUG - Image by name crpd-ipvlan not found 2025-07-24 05:37:18,563 - DEBUG - Installing image crpd-ipvlan 2025-07-24 05:37:18,563 - DEBUG - Image info {'name': 'docker-crpd-ipvlan2.qcow2', 'webserver': '', 'location': '/images/crpd/', 'username': 'centos', 'password': 'centos', 'type': 'os', 'flavor': 'contrail_crpd', 'params': '--container-format bare --disk-format qcow2 --property vmware_disktype="sparse" --property vmware_adaptertype="ide"', 'name_docker': 'phusion-baseimage-enablesshd'} 2025-07-24 05:37:18,563 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/crpd//docker-crpd-ipvlan2.qcow2 2025-07-24 05:37:18,564 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/crpd//docker-crpd-ipvlan2.qcow2 2025-07-24 05:37:18,578 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: wget -nv http://nexus.opensdn.io/repository///images/crpd//docker-crpd-ipvlan2.qcow2 -O /contrail-test/images/docker-crpd-ipvlan2.qcow2 2025-07-24 05:37:18,715 - DEBUG - Image has been downloaded to /contrail-test/images/docker-crpd-ipvlan2.qcow2 2025-07-24 05:37:18,716 - DEBUG - Try to create image in user context 2025-07-24 05:37:18,834 - DEBUG - Image has been created in user context 2025-07-24 05:37:18,835 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: rm -f /contrail-test/images/docker-crpd-ipvlan2.qcow2 2025-07-24 05:37:18,865 - DEBUG - Downloaded image has been removed 2025-07-24 05:37:18,883 - DEBUG - Uploaded image status = active 2025-07-24 05:37:20,268 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3712-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3712-1) 2025-07-24 05:37:21,769 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3712-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3712-1) 2025-07-24 05:37:23,071 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3712-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3712-2) 2025-07-24 05:37:24,362 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3712-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3712-2) 2025-07-24 05:37:24,362 - INFO - Waiting for VM ctest-crpd-vm1-41735875 to be up.. 2025-07-24 05:37:24,441 - DEBUG - VM is in ERROR state now 2025-07-24 05:37:24,441 - ERROR - VM in error state. 2025-07-24 05:37:24,441 - ERROR - VM is not in ACTIVE state 2025-07-24 05:37:24,575 - ERROR - Fatal Nova Exception while getting VM detail 2025-07-24 05:37:24,575 - DEBUG - None 2025-07-24 05:37:24,576 - INFO - Skip interface_detach for VM ctest-crpd-vm4-93907321 in state BUILD 2025-07-24 05:37:24,576 - INFO - Deleting VM ctest-crpd-vm4-93907321 2025-07-24 05:37:24,605 - ERROR - VM ctest-crpd-vm4-93907321 has failed to come up 2025-07-24 05:37:24,605 - ERROR - Nova failed to get host of the VM 2025-07-24 05:37:24,605 - ERROR - VM ctest-crpd-vm4-93907321 has failed to come up 2025-07-24 05:37:24,605 - ERROR - Nova failed to get host of the VM 2025-07-24 05:37:24,842 - INFO - Skip interface_detach for VM ctest-crpd-vm3-61109714 in state BUILD 2025-07-24 05:37:24,842 - INFO - Deleting VM ctest-crpd-vm3-61109714 2025-07-24 05:37:24,842 - ERROR - VM ctest-crpd-vm3-61109714 has failed to come up 2025-07-24 05:37:24,842 - ERROR - Nova failed to get host of the VM 2025-07-24 05:37:24,842 - ERROR - VM ctest-crpd-vm3-61109714 has failed to come up 2025-07-24 05:37:24,842 - ERROR - Nova failed to get host of the VM 2025-07-24 05:37:25,036 - INFO - Skip interface_detach for VM ctest-crpd-vm2-66772402 in state BUILD 2025-07-24 05:37:25,036 - INFO - Deleting VM ctest-crpd-vm2-66772402 2025-07-24 05:37:25,036 - ERROR - VM ctest-crpd-vm2-66772402 has failed to come up 2025-07-24 05:37:25,037 - ERROR - Nova failed to get host of the VM 2025-07-24 05:37:25,037 - ERROR - VM ctest-crpd-vm2-66772402 has failed to come up 2025-07-24 05:37:25,037 - ERROR - Nova failed to get host of the VM 2025-07-24 05:37:25,215 - INFO - Skip interface_detach for VM ctest-crpd-vm1-41735875 in state ERROR 2025-07-24 05:37:25,215 - INFO - Deleting VM ctest-crpd-vm1-41735875 2025-07-24 05:37:25,215 - ERROR - VM ctest-crpd-vm1-41735875 has failed to come up 2025-07-24 05:37:25,216 - ERROR - Fault seen in nova show is: {'code': 500, 'created': '2025-07-24T05:37:20Z', 'message': 'No valid host was found. ', 'details': 'Traceback (most recent call last):\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/conductor/manager.py", line 1581, in schedule_and_build_instances\n instance_uuids, return_alternates=True)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/conductor/manager.py", line 942, in _schedule_instances\n return_alternates=return_alternates)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/scheduler/client/query.py", line 42, in select_destinations\n instance_uuids, return_objects, return_alternates)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/scheduler/rpcapi.py", line 160, in select_destinations\n return cctxt.call(ctxt, \'select_destinations\', **msg_args)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/rpc/client.py", line 192, in call\n retry=self.retry, transport_options=self.transport_options)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/transport.py", line 128, in _send\n transport_options=transport_options)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/_drivers/amqpdriver.py", line 691, in send\n transport_options=transport_options)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/_drivers/amqpdriver.py", line 681, in _send\n raise result\nnova.exception_Remote.NoValidHost_Remote: No valid host was found. \nTraceback (most recent call last):\n\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/rpc/server.py", line 241, in inner\n return func(*args, **kwargs)\n\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/scheduler/manager.py", line 209, in select_destinations\n raise exception.NoValidHost(reason="")\n\nnova.exception.NoValidHost: No valid host was found. \n\n'} 2025-07-24 05:37:25,216 - INFO - Deleting VN ctest-vn2-00394104 2025-07-24 05:37:25,416 - DEBUG - Response for deleting network () 2025-07-24 05:37:25,417 - INFO - Deleting VN ctest-vn1-64148720 2025-07-24 05:37:25,654 - DEBUG - Response for deleting network () 2025-07-24 05:37:25,663 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-3712-1', 'an-jenkins-deploy-platform-ansible-os-3712-2']} 2025-07-24 05:37:26,011 - DEBUG - Response for create_network : {'network': {'id': 'fabec3a4-4977-4264-afed-40843b57610a', 'name': 'ctest-vn1-44275224', 'tenant_id': '65e39e0e7ecd49ba9a1b559913cfded9', 'project_id': '65e39e0e7ecd49ba9a1b559913cfded9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIpVlanLearning-21623978', 'ctest-vn1-44275224'], 'port_security_enabled': True, 'description': ''}} 2025-07-24 05:37:26,267 - DEBUG - Response for create_subnet : {'subnet': {'id': 'dc102883-e66e-4ee1-934c-2df8eff7dba3', 'name': '', 'tenant_id': '65e39e0e7ecd49ba9a1b559913cfded9', 'network_id': 'fabec3a4-4977-4264-afed-40843b57610a', 'ip_version': 4, 'cidr': '86.18.245.0/24', 'allocation_pools': [{'start': '86.18.245.2', 'end': '86.18.245.254'}], 'gateway_ip': '86.18.245.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '86.18.245.2', 'tags': [], 'project_id': '65e39e0e7ecd49ba9a1b559913cfded9'}} 2025-07-24 05:37:26,300 - INFO - Created VN ctest-vn1-44275224 2025-07-24 05:37:26,317 - DEBUG - VN ctest-vn1-44275224 UUID is fabec3a4-4977-4264-afed-40843b57610a 2025-07-24 05:37:26,796 - DEBUG - Response for create_network : {'network': {'id': '20679d26-5a72-455e-9ae7-8d728a3e16e2', 'name': 'ctest-vn2-35985536', 'tenant_id': '65e39e0e7ecd49ba9a1b559913cfded9', 'project_id': '65e39e0e7ecd49ba9a1b559913cfded9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIpVlanLearning-21623978', 'ctest-vn2-35985536'], 'port_security_enabled': True, 'description': ''}} 2025-07-24 05:37:27,095 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd1b215e1-ff9d-43f3-b607-3bde34e1b553', 'name': '', 'tenant_id': '65e39e0e7ecd49ba9a1b559913cfded9', 'network_id': '20679d26-5a72-455e-9ae7-8d728a3e16e2', 'ip_version': 4, 'cidr': '84.175.124.0/24', 'allocation_pools': [{'start': '84.175.124.2', 'end': '84.175.124.254'}], 'gateway_ip': '84.175.124.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '84.175.124.2', 'tags': [], 'project_id': '65e39e0e7ecd49ba9a1b559913cfded9'}} 2025-07-24 05:37:27,122 - INFO - Created VN ctest-vn2-35985536 2025-07-24 05:37:27,146 - DEBUG - VN ctest-vn2-35985536 UUID is 20679d26-5a72-455e-9ae7-8d728a3e16e2 2025-07-24 05:37:27,250 - DEBUG - Updating mac_ip_learning flag on VN default-domain:ctest-TestIpVlanLearning-21623978:ctest-vn1-44275224 to True 2025-07-24 05:37:27,404 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/fabec3a4-4977-4264-afed-40843b57610a 2025-07-24 05:37:27,422 - DEBUG - Updating mac_ip_learning flag on VN default-domain:ctest-TestIpVlanLearning-21623978:ctest-vn2-35985536 to True 2025-07-24 05:37:27,564 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-network/20679d26-5a72-455e-9ae7-8d728a3e16e2 2025-07-24 05:37:28,920 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3712-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3712-1) 2025-07-24 05:37:30,180 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3712-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3712-1) 2025-07-24 05:37:31,509 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3712-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3712-2) 2025-07-24 05:37:32,890 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3712-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3712-2) 2025-07-24 05:37:32,891 - INFO - Waiting for VM ctest-crpd-vm1-29038297 to be up.. 2025-07-24 05:37:32,966 - DEBUG - VM is in ERROR state now 2025-07-24 05:37:32,966 - ERROR - VM in error state. 2025-07-24 05:37:32,966 - ERROR - VM is not in ACTIVE state 2025-07-24 05:37:33,063 - ERROR - Fatal Nova Exception while getting VM detail 2025-07-24 05:37:33,063 - DEBUG - None 2025-07-24 05:37:33,064 - INFO - Skip interface_detach for VM ctest-crpd-vm4-37142650 in state BUILD 2025-07-24 05:37:33,064 - INFO - Deleting VM ctest-crpd-vm4-37142650 2025-07-24 05:37:33,064 - ERROR - VM ctest-crpd-vm4-37142650 has failed to come up 2025-07-24 05:37:33,064 - ERROR - Nova failed to get host of the VM 2025-07-24 05:37:33,064 - ERROR - VM ctest-crpd-vm4-37142650 has failed to come up 2025-07-24 05:37:33,064 - ERROR - Nova failed to get host of the VM 2025-07-24 05:37:33,248 - INFO - Skip interface_detach for VM ctest-crpd-vm3-93729446 in state BUILD 2025-07-24 05:37:33,248 - INFO - Deleting VM ctest-crpd-vm3-93729446 2025-07-24 05:37:33,248 - ERROR - VM ctest-crpd-vm3-93729446 has failed to come up 2025-07-24 05:37:33,248 - ERROR - Nova failed to get host of the VM 2025-07-24 05:37:33,249 - ERROR - VM ctest-crpd-vm3-93729446 has failed to come up 2025-07-24 05:37:33,249 - ERROR - Nova failed to get host of the VM 2025-07-24 05:37:33,450 - INFO - Skip interface_detach for VM ctest-crpd-vm2-63329532 in state BUILD 2025-07-24 05:37:33,450 - INFO - Deleting VM ctest-crpd-vm2-63329532 2025-07-24 05:37:33,451 - ERROR - VM ctest-crpd-vm2-63329532 has failed to come up 2025-07-24 05:37:33,451 - ERROR - Nova failed to get host of the VM 2025-07-24 05:37:33,451 - ERROR - VM ctest-crpd-vm2-63329532 has failed to come up 2025-07-24 05:37:33,451 - ERROR - Nova failed to get host of the VM 2025-07-24 05:37:33,637 - INFO - Skip interface_detach for VM ctest-crpd-vm1-29038297 in state ERROR 2025-07-24 05:37:33,638 - INFO - Deleting VM ctest-crpd-vm1-29038297 2025-07-24 05:37:33,638 - ERROR - VM ctest-crpd-vm1-29038297 has failed to come up 2025-07-24 05:37:33,638 - ERROR - Fault seen in nova show is: {'code': 500, 'created': '2025-07-24T05:37:28Z', 'message': 'No valid host was found. ', 'details': 'Traceback (most recent call last):\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/conductor/manager.py", line 1581, in schedule_and_build_instances\n instance_uuids, return_alternates=True)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/conductor/manager.py", line 942, in _schedule_instances\n return_alternates=return_alternates)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/scheduler/client/query.py", line 42, in select_destinations\n instance_uuids, return_objects, return_alternates)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/scheduler/rpcapi.py", line 160, in select_destinations\n return cctxt.call(ctxt, \'select_destinations\', **msg_args)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/rpc/client.py", line 192, in call\n retry=self.retry, transport_options=self.transport_options)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/transport.py", line 128, in _send\n transport_options=transport_options)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/_drivers/amqpdriver.py", line 691, in send\n transport_options=transport_options)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/_drivers/amqpdriver.py", line 681, in _send\n raise result\nnova.exception_Remote.NoValidHost_Remote: No valid host was found. \nTraceback (most recent call last):\n\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/rpc/server.py", line 241, in inner\n return func(*args, **kwargs)\n\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/scheduler/manager.py", line 209, in select_destinations\n raise exception.NoValidHost(reason="")\n\nnova.exception.NoValidHost: No valid host was found. \n\n'} 2025-07-24 05:37:33,638 - INFO - Deleting VN ctest-vn2-35985536 2025-07-24 05:37:33,824 - DEBUG - Response for deleting network () 2025-07-24 05:37:33,824 - INFO - Deleting VN ctest-vn1-44275224 2025-07-24 05:37:34,035 - DEBUG - Response for deleting network () 2025-07-24 05:37:34,918 - INFO - Deleted project: ctest-TestIpVlanLearning-21623978, ID : 65e39e0e-7ecd-49ba-9a1b-559913cfded9