2025-07-23 17:53:01,597 - INFO - Domain Default found not creating 2025-07-23 17:53:01,737 - INFO - Project ctest-TestIpVlanLearning-19992096 not found, creating it 2025-07-23 17:53:02,309 - INFO - Created Project:ctest-TestIpVlanLearning-19992096, ID : 93e58107-283c-48f6-bb51-17d5bbf51519 2025-07-23 17:53:03,761 - DEBUG - Services list from nova: [, , , ] 2025-07-23 17:53:03,761 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-3704-2', 'an-jenkins-deploy-platform-ansible-os-3704-1']} 2025-07-23 17:53:03,763 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-3704-2', 'an-jenkins-deploy-platform-ansible-os-3704-1']} 2025-07-23 17:53:04,505 - DEBUG - Response for create_network : {'network': {'id': '7de78f68-a00e-439e-9ef2-1971bf928235', 'name': 'ctest-vn1-47649822', 'tenant_id': '93e58107283c48f6bb5117d5bbf51519', 'project_id': '93e58107283c48f6bb5117d5bbf51519', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIpVlanLearning-19992096', 'ctest-vn1-47649822'], 'port_security_enabled': True, 'description': ''}} 2025-07-23 17:53:04,802 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b00a854c-108f-4b56-8612-91b962516aa8', 'name': '', 'tenant_id': '93e58107283c48f6bb5117d5bbf51519', 'network_id': '7de78f68-a00e-439e-9ef2-1971bf928235', 'ip_version': 4, 'cidr': '165.62.194.0/24', 'allocation_pools': [{'start': '165.62.194.2', 'end': '165.62.194.254'}], 'gateway_ip': '165.62.194.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '165.62.194.2', 'tags': [], 'project_id': '93e58107283c48f6bb5117d5bbf51519'}} 2025-07-23 17:53:04,826 - INFO - Created VN ctest-vn1-47649822 2025-07-23 17:53:04,839 - DEBUG - VN ctest-vn1-47649822 UUID is 7de78f68-a00e-439e-9ef2-1971bf928235 2025-07-23 17:53:05,211 - DEBUG - Response for create_network : {'network': {'id': '2a1e7444-9a46-4844-bb36-af9877bd69ec', 'name': 'ctest-vn2-63491770', 'tenant_id': '93e58107283c48f6bb5117d5bbf51519', 'project_id': '93e58107283c48f6bb5117d5bbf51519', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIpVlanLearning-19992096', 'ctest-vn2-63491770'], 'port_security_enabled': True, 'description': ''}} 2025-07-23 17:53:05,466 - DEBUG - Response for create_subnet : {'subnet': {'id': '068eee62-db24-485e-88e1-27d2c590b25e', 'name': '', 'tenant_id': '93e58107283c48f6bb5117d5bbf51519', 'network_id': '2a1e7444-9a46-4844-bb36-af9877bd69ec', 'ip_version': 4, 'cidr': '59.27.152.0/24', 'allocation_pools': [{'start': '59.27.152.2', 'end': '59.27.152.254'}], 'gateway_ip': '59.27.152.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '59.27.152.2', 'tags': [], 'project_id': '93e58107283c48f6bb5117d5bbf51519'}} 2025-07-23 17:53:05,489 - INFO - Created VN ctest-vn2-63491770 2025-07-23 17:53:05,502 - DEBUG - VN ctest-vn2-63491770 UUID is 2a1e7444-9a46-4844-bb36-af9877bd69ec 2025-07-23 17:53:05,567 - DEBUG - Updating mac_ip_learning flag on VN default-domain:ctest-TestIpVlanLearning-19992096:ctest-vn1-47649822 to True 2025-07-23 17:53:05,671 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/7de78f68-a00e-439e-9ef2-1971bf928235 2025-07-23 17:53:05,968 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/7de78f68-a00e-439e-9ef2-1971bf928235 2025-07-23 17:53:06,013 - DEBUG - Updating mac_ip_learning flag on VN default-domain:ctest-TestIpVlanLearning-19992096:ctest-vn2-63491770 to True 2025-07-23 17:53:06,123 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/2a1e7444-9a46-4844-bb36-af9877bd69ec 2025-07-23 17:53:06,304 - DEBUG - Image by name crpd-ipvlan not found 2025-07-23 17:53:06,304 - DEBUG - Installing image crpd-ipvlan 2025-07-23 17:53:06,304 - 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-23 17:53:06,304 - DEBUG - Image build path http://nexus.opensdn.io/repository///images/crpd//docker-crpd-ipvlan2.qcow2 2025-07-23 17:53:06,304 - DEBUG - Download image from web http://nexus.opensdn.io/repository///images/crpd//docker-crpd-ipvlan2.qcow2 2025-07-23 17:53:06,321 - 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-23 17:53:06,360 - DEBUG - Image has been downloaded to /contrail-test/images/docker-crpd-ipvlan2.qcow2 2025-07-23 17:53:06,361 - DEBUG - Try to create image in user context 2025-07-23 17:53:06,453 - DEBUG - Image has been created in user context 2025-07-23 17:53:06,453 - DEBUG - Image download (local=True) (proxy=None): Execute cmd: rm -f /contrail-test/images/docker-crpd-ipvlan2.qcow2 2025-07-23 17:53:06,470 - DEBUG - Downloaded image has been removed 2025-07-23 17:53:06,483 - DEBUG - Uploaded image status = active 2025-07-23 17:53:07,895 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3704-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3704-1) 2025-07-23 17:53:09,051 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3704-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3704-1) 2025-07-23 17:53:10,173 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3704-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3704-2) 2025-07-23 17:53:11,387 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3704-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3704-2) 2025-07-23 17:53:11,387 - INFO - Waiting for VM ctest-crpd-vm1-50182260 to be up.. 2025-07-23 17:53:11,452 - DEBUG - VM is in ERROR state now 2025-07-23 17:53:11,452 - ERROR - VM in error state. 2025-07-23 17:53:11,452 - ERROR - VM is not in ACTIVE state 2025-07-23 17:53:11,541 - ERROR - Fatal Nova Exception while getting VM detail 2025-07-23 17:53:11,541 - DEBUG - None 2025-07-23 17:53:11,542 - INFO - Skip interface_detach for VM ctest-crpd-vm4-96663381 in state BUILD 2025-07-23 17:53:11,542 - INFO - Deleting VM ctest-crpd-vm4-96663381 2025-07-23 17:53:11,564 - ERROR - VM ctest-crpd-vm4-96663381 has failed to come up 2025-07-23 17:53:11,564 - ERROR - Nova failed to get host of the VM 2025-07-23 17:53:11,564 - ERROR - VM ctest-crpd-vm4-96663381 has failed to come up 2025-07-23 17:53:11,564 - ERROR - Nova failed to get host of the VM 2025-07-23 17:53:11,752 - INFO - Skip interface_detach for VM ctest-crpd-vm3-41350393 in state BUILD 2025-07-23 17:53:11,752 - INFO - Deleting VM ctest-crpd-vm3-41350393 2025-07-23 17:53:11,752 - ERROR - VM ctest-crpd-vm3-41350393 has failed to come up 2025-07-23 17:53:11,752 - ERROR - Nova failed to get host of the VM 2025-07-23 17:53:11,753 - ERROR - VM ctest-crpd-vm3-41350393 has failed to come up 2025-07-23 17:53:11,753 - ERROR - Nova failed to get host of the VM 2025-07-23 17:53:11,920 - INFO - Skip interface_detach for VM ctest-crpd-vm2-52031100 in state ERROR 2025-07-23 17:53:11,920 - INFO - Deleting VM ctest-crpd-vm2-52031100 2025-07-23 17:53:11,920 - ERROR - VM ctest-crpd-vm2-52031100 has failed to come up 2025-07-23 17:53:11,920 - ERROR - Fault seen in nova show is: {'code': 500, 'created': '2025-07-23T17:53:08Z', '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-23 17:53:11,926 - INFO - Skip interface_detach for VM ctest-crpd-vm1-50182260 in state ERROR 2025-07-23 17:53:11,926 - INFO - Deleting VM ctest-crpd-vm1-50182260 2025-07-23 17:53:11,926 - ERROR - VM ctest-crpd-vm1-50182260 has failed to come up 2025-07-23 17:53:11,926 - ERROR - Fault seen in nova show is: {'code': 500, 'created': '2025-07-23T17:53:08Z', '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-23 17:53:11,926 - INFO - Deleting VN ctest-vn2-63491770 2025-07-23 17:53:12,097 - DEBUG - Response for deleting network () 2025-07-23 17:53:12,097 - INFO - Deleting VN ctest-vn1-47649822 2025-07-23 17:53:12,253 - DEBUG - Response for deleting network () 2025-07-23 17:53:12,277 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-3704-2', 'an-jenkins-deploy-platform-ansible-os-3704-1']} 2025-07-23 17:53:12,541 - DEBUG - Response for create_network : {'network': {'id': '04f39e9d-9c4b-4d20-9113-411e6df5cb03', 'name': 'ctest-vn1-40806529', 'tenant_id': '93e58107283c48f6bb5117d5bbf51519', 'project_id': '93e58107283c48f6bb5117d5bbf51519', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIpVlanLearning-19992096', 'ctest-vn1-40806529'], 'port_security_enabled': True, 'description': ''}} 2025-07-23 17:53:12,741 - DEBUG - Response for create_subnet : {'subnet': {'id': '77c4f153-0da7-4857-9080-0f7ab45f3d7a', 'name': '', 'tenant_id': '93e58107283c48f6bb5117d5bbf51519', 'network_id': '04f39e9d-9c4b-4d20-9113-411e6df5cb03', 'ip_version': 4, 'cidr': '172.71.178.0/24', 'allocation_pools': [{'start': '172.71.178.2', 'end': '172.71.178.254'}], 'gateway_ip': '172.71.178.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '172.71.178.2', 'tags': [], 'project_id': '93e58107283c48f6bb5117d5bbf51519'}} 2025-07-23 17:53:12,761 - INFO - Created VN ctest-vn1-40806529 2025-07-23 17:53:12,771 - DEBUG - VN ctest-vn1-40806529 UUID is 04f39e9d-9c4b-4d20-9113-411e6df5cb03 2025-07-23 17:53:13,140 - DEBUG - Response for create_network : {'network': {'id': 'b67e2177-1993-4790-a4b8-b35ed5229aff', 'name': 'ctest-vn2-47538786', 'tenant_id': '93e58107283c48f6bb5117d5bbf51519', 'project_id': '93e58107283c48f6bb5117d5bbf51519', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestIpVlanLearning-19992096', 'ctest-vn2-47538786'], 'port_security_enabled': True, 'description': ''}} 2025-07-23 17:53:13,445 - DEBUG - Response for create_subnet : {'subnet': {'id': '61517e68-2ae1-4848-b3c4-f2ed23b7a11b', 'name': '', 'tenant_id': '93e58107283c48f6bb5117d5bbf51519', 'network_id': 'b67e2177-1993-4790-a4b8-b35ed5229aff', 'ip_version': 4, 'cidr': '49.178.255.0/24', 'allocation_pools': [{'start': '49.178.255.2', 'end': '49.178.255.254'}], 'gateway_ip': '49.178.255.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '49.178.255.2', 'tags': [], 'project_id': '93e58107283c48f6bb5117d5bbf51519'}} 2025-07-23 17:53:13,466 - INFO - Created VN ctest-vn2-47538786 2025-07-23 17:53:13,481 - DEBUG - VN ctest-vn2-47538786 UUID is b67e2177-1993-4790-a4b8-b35ed5229aff 2025-07-23 17:53:13,560 - DEBUG - Updating mac_ip_learning flag on VN default-domain:ctest-TestIpVlanLearning-19992096:ctest-vn1-40806529 to True 2025-07-23 17:53:13,667 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/04f39e9d-9c4b-4d20-9113-411e6df5cb03 2025-07-23 17:53:13,680 - DEBUG - Updating mac_ip_learning flag on VN default-domain:ctest-TestIpVlanLearning-19992096:ctest-vn2-47538786 to True 2025-07-23 17:53:13,791 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-network/b67e2177-1993-4790-a4b8-b35ed5229aff 2025-07-23 17:53:14,907 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3704-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3704-1) 2025-07-23 17:53:15,989 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3704-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3704-1) 2025-07-23 17:53:17,126 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3704-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3704-2) 2025-07-23 17:53:18,083 - INFO - Skip interface_detach for VM ctest-crpd-vm3-94024221 in state BUILD 2025-07-23 17:53:18,083 - INFO - Deleting VM ctest-crpd-vm3-94024221 2025-07-23 17:53:18,083 - ERROR - VM ctest-crpd-vm3-94024221 has failed to come up 2025-07-23 17:53:18,083 - ERROR - Nova failed to get host of the VM 2025-07-23 17:53:18,084 - ERROR - VM ctest-crpd-vm3-94024221 has failed to come up 2025-07-23 17:53:18,084 - ERROR - Nova failed to get host of the VM 2025-07-23 17:53:18,244 - INFO - Skip interface_detach for VM ctest-crpd-vm2-85266419 in state BUILD 2025-07-23 17:53:18,244 - INFO - Deleting VM ctest-crpd-vm2-85266419 2025-07-23 17:53:18,245 - ERROR - VM ctest-crpd-vm2-85266419 has failed to come up 2025-07-23 17:53:18,245 - ERROR - Nova failed to get host of the VM 2025-07-23 17:53:18,245 - ERROR - VM ctest-crpd-vm2-85266419 has failed to come up 2025-07-23 17:53:18,245 - ERROR - Nova failed to get host of the VM 2025-07-23 17:53:18,412 - INFO - Skip interface_detach for VM ctest-crpd-vm1-59527015 in state BUILD 2025-07-23 17:53:18,413 - INFO - Deleting VM ctest-crpd-vm1-59527015 2025-07-23 17:53:18,413 - ERROR - VM ctest-crpd-vm1-59527015 has failed to come up 2025-07-23 17:53:18,413 - ERROR - Nova failed to get host of the VM 2025-07-23 17:53:18,413 - ERROR - VM ctest-crpd-vm1-59527015 has failed to come up 2025-07-23 17:53:18,413 - ERROR - Nova failed to get host of the VM 2025-07-23 17:53:18,563 - INFO - Deleting VN ctest-vn2-47538786 2025-07-23 17:53:18,720 - DEBUG - Response for deleting network () 2025-07-23 17:53:18,720 - INFO - Deleting VN ctest-vn1-40806529 2025-07-23 17:53:18,883 - DEBUG - Response for deleting network () 2025-07-23 17:53:19,795 - INFO - Deleted project: ctest-TestIpVlanLearning-19992096, ID : 93e58107-283c-48f6-bb51-17d5bbf51519