yahoo-eng-team team mailing list archive

Thread
Date
[Bug 1729780] [NEW] migrate/live-migrate instance, no vailid host selected.

To: yahoo-eng-team@xxxxxxxxxxxxxxxxxxx
From: Charlotte Han <han.rong3@xxxxxxxxxx>
Date: Fri, 03 Nov 2017 06:24:58 -0000
Reply-to: Bug 1729780 <1729780@xxxxxxxxxxxxxxxxxx>
Sender: bounces@xxxxxxxxxxxxx
Public bug reported:

Description
===========
Openstack cloud has enough resource, create instances will be successful, but migrate or live migrate instance will be failed.

Steps to reproduce
==================
* I did create 5 instances at a time.
    openstack server create hanrong_numa --image 235166b9-f63c-4bc2-ba73-51a0e47e3b39 --flavor 1111 --nic net-id=ba8d7500-2d2a-425f-83b3-ffa45a5ad28a --max 5

* then I did migrate one instance.
  nova migrate 62ad226f-8848-455a-9e24-3b83443fc051
ERROR (BadRequest): No valid host was found. No valid host found for cold migrate (HTTP 400) (Request-ID: req-6ae8da3f-424a-42a8-abc0-296ad831af22)


Expected result
===============
nova-scheduler can select one compute host for this instance to migrate.

Actual result
=============
nova-scheduler raise no valid host exception.

Environment
===========
1. Exact version of OpenStack you are running. See the following
  Pike version


Logs & Configs
==============
[root@ctrl3 ~]# cat /var/log/nova/nova-scheduler.log  | grep req-6ae8da3f-424a-42a8-abc0-296ad831af22
2017-11-03 14:15:56.554 131332 DEBUG nova.scheduler.manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Starting to schedule for instances: [u'62ad226f-8848-455a-9e24-3b83443fc051'] select_destinations /usr/lib/python2.7/site-packages/nova/scheduler/manager.py:113
2017-11-03 14:15:56.825 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Getting compute nodes and services for cell 0d81237d-c567-46de-8838-edeb5b126738(cell1) _get_computes_for_cells /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:608
2017-11-03 14:15:56.826 131332 DEBUG oslo_concurrency.lockutils [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Lock "0d81237d-c567-46de-8838-edeb5b126738" acquired by "nova.context.get_or_set_cached_cell_and_set_connections" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:270
2017-11-03 14:15:56.826 131332 DEBUG oslo_concurrency.lockutils [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Lock "0d81237d-c567-46de-8838-edeb5b126738" released by "nova.context.get_or_set_cached_cell_and_set_connections" :: held 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:282
2017-11-03 14:15:56.843 131332 DEBUG oslo_concurrency.lockutils [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Lock "(u'ctrl3', u'ctrl3')" acquired by "nova.scheduler.host_manager._locked_update" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:270
2017-11-03 14:15:56.844 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Update host state from compute node: ComputeNode(cpu_allocation_ratio=1.0,cpu_info='{"vendor": "Intel", "model": "Haswell-noTSX", "arch": "x86_64", "features": ["pge", "avx", "clflush", "sep", "syscall", "vme", "dtes64", "invpcid", "tsc", "fsgsbase", "xsave", "vmx", "erms", "xtpr", "cmov", "smep", "ssse3", "est", "pat", "monitor", "smx", "pbe", "lm", "msr", "nx", "fxsr", "tm", "sse4.1", "pae", "sse4.2", "pclmuldq", "acpi", "fma", "tsc-deadline", "mmx", "osxsave", "cx8", "mce", "de", "tm2", "ht", "dca", "lahf_lm", "abm", "popcnt", "mca", "pdpe1gb", "apic", "sse", "f16c", "pse", "ds", "invtsc", "pni", "rdtscp", "avx2", "aes", "sse2", "ss", "ds_cpl", "bmi1", "bmi2", "pcid", "fpu", "cx16", "pse36", "mtrr", "movbe", "pdcm", "rdrand", "x2apic"], "topology": {"cores": 12, "cells": 2, "threads": 2, "sockets": 1}}',created_at=2017-10-25T02:48:00Z,current_workload=0,deleted=False,deleted_at=None,disk_allocation_ratio=1.0,disk_available_least=55,free_disk_gb=59,free_ram_mb=110201,host='ctrl3',host_ip=193.168.1.13,hypervisor_hostname='ctrl3',hypervisor_type='QEMU',hypervisor_version=2005000,id=1,local_gb=59,local_gb_used=0,mapped=1,memory_mb=128377,memory_mb_used=18176,metrics='[{"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.user.percent", "value": 0.02, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.kernel.time", "value": 282133380000000, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.kernel.percent", "value": 0.0, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.idle.time", "value": 64710013250000000, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.idle.percent", "value": 0.96, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.iowait.time", "value": 18656250000000, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.percent", "value": 0.03, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.user.time", "value": 806826950000000, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.frequency", "value": 2294, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.iowait.percent", "value": 0.0, "source": "libvirt.LibvirtDriver"}]',numa_topology='{"nova_object.version": "1.2", "nova_object.changes": ["cells"], "nova_object.name": "NUMATopology", "nova_object.data": {"cells": [{"nova_object.version": "1.2", "nova_object.changes": ["cpu_usage", "memory_usage", "cpuset", "pinned_cpus", "siblings", "memory", "mempages", "id"], "nova_object.name": "NUMACell", "nova_object.data": {"cpu_usage": 6, "memory_usage": 768, "cpuset": [0, 2, 4, 6, 8, 10, 12, 14, 16, 18, 20, 22, 24, 26, 28, 30, 32, 34, 36, 38, 40, 42, 44, 46], "pinned_cpus": [0, 16, 2, 28, 44, 18], "siblings": [[28, 4], [2, 26], [44, 20], [0, 24], [18, 42], [16, 40], [46, 22], [38, 14], [36, 12], [8, 32], [30, 6], [10, 34]], "memory": 65440, "mempages": [{"nova_object.version": "1.1", "nova_object.changes": ["total", "used", "reserved", "size_kb"], "nova_object.name": "NUMAPagesTopology", "nova_object.data": {"used": 0, "total": 16752732, "reserved": 0, "size_kb": 4}, "nova_object.namespace": "nova"}, {"nova_object.version": "1.1", "nova_object.changes": ["total", "used", "reserved", "size_kb"], "nova_object.name": "NUMAPagesTopology", "nova_object.data": {"used": 0, "total": 0, "reserved": 0, "size_kb": 1048576}, "nova_object.namespace": "nova"}], "id": 0}, "nova_object.namespace": "nova"}, {"nova_object.version": "1.2", "nova_object.changes": ["cpu_usage", "memory_usage", "cpuset", "pinned_cpus", "siblings", "memory", "mempages", "id"], "nova_object.name": "NUMACell", "nova_object.data": {"cpu_usage": 0, "memory_usage": 0, "cpuset": [1, 3, 5, 7, 9, 11, 13, 15, 17, 19, 21, 23, 25, 27, 29, 31, 33, 35, 37, 39, 41, 43, 45, 47], "pinned_cpus": [], "siblings": [[21, 45], [31, 7], [39, 15], [35, 11], [17, 41], [27, 3], [13, 37], [9, 33], [47, 23], [43, 19], [5, 29], [1, 25]], "memory": 65536, "mempages": [{"nova_object.version": "1.1", "nova_object.changes": ["total", "used", "reserved", "size_kb"], "nova_object.name": "NUMAPagesTopology", "nova_object.data": {"used": 0, "total": 16777216, "reserved": 0, "size_kb": 4}, "nova_object.namespace": "nova"}, {"nova_object.version": "1.1", "nova_object.changes": ["total", "used", "reserved", "size_kb"], "nova_object.name": "NUMAPagesTopology", "nova_object.data": {"used": 0, "total": 0, "reserved": 0, "size_kb": 1048576}, "nova_object.namespace": "nova"}], "id": 1}, "nova_object.namespace": "nova"}]}, "nova_object.namespace": "nova"}',pci_device_pools=PciDevicePoolList,ram_allocation_ratio=1.0,running_vms=6,service_id=None,stats={io_workload='0',num_instances='6',num_os_type_None='6',num_proj_0c1f9446e0bd4b70bce91cb5a69673f7='6',num_task_None='6',num_vm_active='6'},supported_hv_specs=[HVSpec,HVSpec,HVSpec,HVSpec],updated_at=2017-11-03T06:15:22Z,uuid=ae5d2eae-9f7d-4b23-87fd-2503f9a0fc65,vcpus=48,vcpus_used=6) _locked_update /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:172
2017-11-03 14:15:56.847 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Update host state with aggregates: [] _locked_update /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:175
2017-11-03 14:15:56.847 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Update host state with service dict: {'binary': u'nova-compute', 'uuid': '967fe0cc-098d-4d81-be30-94fa95f535f9', 'deleted': False, 'created_at': datetime.datetime(2017, 10, 25, 2, 48, tzinfo=<iso8601.Utc>), 'updated_at': datetime.datetime(2017, 11, 3, 6, 15, 51, tzinfo=<iso8601.Utc>), 'report_count': 78903, 'topic': u'compute', 'host': u'ctrl3', 'version': 22, 'disabled': False, 'forced_down': False, 'last_seen_up': datetime.datetime(2017, 11, 3, 6, 15, 51, tzinfo=<iso8601.Utc>), 'deleted_at': None, 'disabled_reason': None, 'id': 37} _locked_update /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:178
2017-11-03 14:15:56.848 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Update host state with instances: {'6bdcaa14-e26c-46ee-a43e-82ea503d2ac1': Instance(access_ip_v4=None,access_ip_v6=None,architecture=None,auto_disk_config=False,availability_zone='nova',cell_name=None,cleaned=False,config_drive='',created_at=2017-11-03T05:35:21Z,default_ephemeral_device=None,default_swap_device=None,deleted=False,deleted_at=None,device_metadata=<?>,disable_terminate=False,display_description='hanrong_numa',display_name='hanrong_numa-2',ec2_ids=<?>,ephemeral_gb=0,ephemeral_key_uuid=None,fault=<?>,flavor=<?>,host='ctrl3',hostname='hanrong-numa-2',id=6,image_ref='235166b9-f63c-4bc2-ba73-51a0e47e3b39',info_cache=<?>,instance_type_id=2,kernel_id='',key_data=None,key_name=None,keypairs=<?>,launch_index=1,launched_at=2017-11-03T05:35:33Z,launched_on='ctrl3',locked=False,locked_by=None,memory_mb=128,metadata=<?>,migration_context=<?>,new_flavor=<?>,node='ctrl3',numa_topology=<?>,old_flavor=<?>,os_type=None,pci_devices=<?>,pci_requests=<?>,power_state=1,progress=0,project_id='0c1f9446e0bd4b70bce91cb5a69673f7',ramdisk_id='',reservation_id='r-0u7ay8lb',root_device_name='/dev/vda',root_gb=0,security_groups=<?>,services=<?>,shutdown_terminate=False,system_metadata=<?>,tags=<?>,task_state=None,terminated_at=None,updated_at=2017-11-03T05:35:33Z,user_data=None,user_id='6c493f80a87f4a17be8681f580f2fa48',uuid=6bdcaa14-e26c-46ee-a43e-82ea503d2ac1,vcpu_model=<?>,vcpus=1,vm_mode=None,vm_state='active'), 'e8ab79d5-2832-44d3-ab38-d0463aa3cc4e': Instance(access_ip_v4=None,access_ip_v6=None,architecture=None,auto_disk_config=False,availability_zone='nova',cell_name=None,cleaned=False,config_drive='',created_at=2017-11-03T05:35:21Z,default_ephemeral_device=None,default_swap_device=None,deleted=False,deleted_at=None,device_metadata=<?>,disable_terminate=False,display_description='hanrong_numa',display_name='hanrong_numa-4',ec2_ids=<?>,ephemeral_gb=0,ephemeral_key_uuid=None,fault=<?>,flavor=<?>,host='ctrl3',hostname='hanrong-numa-4',id=10,image_ref='235166b9-f63c-4bc2-ba73-51a0e47e3b39',info_cache=<?>,instance_type_id=2,kernel_id='',key_data=None,key_name=None,keypairs=<?>,launch_index=3,launched_at=2017-11-03T05:35:31Z,launched_on='ctrl3',locked=False,locked_by=None,memory_mb=128,metadata=<?>,migration_context=<?>,new_flavor=<?>,node='ctrl3',numa_topology=<?>,old_flavor=<?>,os_type=None,pci_devices=<?>,pci_requests=<?>,power_state=1,progress=0,project_id='0c1f9446e0bd4b70bce91cb5a69673f7',ramdisk_id='',reservation_id='r-0u7ay8lb',root_device_name='/dev/vda',root_gb=0,security_groups=<?>,services=<?>,shutdown_terminate=False,system_metadata=<?>,tags=<?>,task_state=None,terminated_at=None,updated_at=2017-11-03T05:35:31Z,user_data=None,user_id='6c493f80a87f4a17be8681f580f2fa48',uuid=e8ab79d5-2832-44d3-ab38-d0463aa3cc4e,vcpu_model=<?>,vcpus=1,vm_mode=None,vm_state='active'), '62ad226f-8848-455a-9e24-3b83443fc051': Instance(access_ip_v4=None,access_ip_v6=None,architecture=None,auto_disk_config=False,availability_zone='nova',cell_name=None,cleaned=True,config_drive='',created_at=2017-11-03T05:35:21Z,default_ephemeral_device=None,default_swap_device=None,deleted=False,deleted_at=None,device_metadata=<?>,disable_terminate=False,display_description='hanrong_numa',display_name='hanrong_numa-1',ec2_ids=<?>,ephemeral_gb=0,ephemeral_key_uuid=None,fault=<?>,flavor=<?>,host='ctrl3',hostname='hanrong-numa-1',id=4,image_ref='235166b9-f63c-4bc2-ba73-51a0e47e3b39',info_cache=<?>,instance_type_id=2,kernel_id='',key_data=None,key_name=None,keypairs=<?>,launch_index=0,launched_at=2017-11-03T05:35:43Z,launched_on='ctrl3',locked=False,locked_by=None,memory_mb=128,metadata=<?>,migration_context=<?>,new_flavor=<?>,node='ctrl3',numa_topology=<?>,old_flavor=<?>,os_type=None,pci_devices=<?>,pci_requests=<?>,power_state=1,progress=0,project_id='0c1f9446e0bd4b70bce91cb5a69673f7',ramdisk_id='',reservation_id='r-0u7ay8lb',root_device_name='/dev/vda',root_gb=0,security_groups=<?>,services=<?>,shutdown_terminate=False,system_metadata=<?>,tags=<?>,task_state=None,terminated_at=None,updated_at=2017-11-03T05:54:22Z,user_data=None,user_id='6c493f80a87f4a17be8681f580f2fa48',uuid=62ad226f-8848-455a-9e24-3b83443fc051,vcpu_model=<?>,vcpus=1,vm_mode=None,vm_state='active'), '0416af9a-e552-4d66-b816-8b66433312cd': Instance(access_ip_v4=None,access_ip_v6=None,architecture=None,auto_disk_config=False,availability_zone='nova',cell_name=None,cleaned=True,config_drive='',created_at=2017-11-03T05:35:21Z,default_ephemeral_device=None,default_swap_device=None,deleted=False,deleted_at=None,device_metadata=<?>,disable_terminate=False,display_description='hanrong_numa',display_name='hanrong_numa-3',ec2_ids=<?>,ephemeral_gb=0,ephemeral_key_uuid=None,fault=<?>,flavor=<?>,host='ctrl3',hostname='hanrong-numa-3',id=8,image_ref='235166b9-f63c-4bc2-ba73-51a0e47e3b39',info_cache=<?>,instance_type_id=2,kernel_id='',key_data=None,key_name=None,keypairs=<?>,launch_index=2,launched_at=2017-11-03T05:35:43Z,launched_on='ctrl3',locked=False,locked_by=None,memory_mb=128,metadata=<?>,migration_context=<?>,new_flavor=<?>,node='ctrl3',numa_topology=<?>,old_flavor=<?>,os_type=None,pci_devices=<?>,pci_requests=<?>,power_state=1,progress=0,project_id='0c1f9446e0bd4b70bce91cb5a69673f7',ramdisk_id='',reservation_id='r-0u7ay8lb',root_device_name='/dev/vda',root_gb=0,security_groups=<?>,services=<?>,shutdown_terminate=False,system_metadata=<?>,tags=<?>,task_state=None,terminated_at=None,updated_at=2017-11-03T05:35:43Z,user_data=None,user_id='6c493f80a87f4a17be8681f580f2fa48',uuid=0416af9a-e552-4d66-b816-8b66433312cd,vcpu_model=<?>,vcpus=1,vm_mode=None,vm_state='active'), 'a18ca5aa-177d-4f94-8239-1c6486dbc963': Instance(access_ip_v4=None,access_ip_v6=None,architecture=None,auto_disk_config=False,availability_zone='nova',cell_name=None,cleaned=True,config_drive='',created_at=2017-10-30T09:36:32Z,default_ephemeral_device=None,default_swap_device=None,deleted=False,deleted_at=None,device_metadata=<?>,disable_terminate=False,display_description='hanrong_numa',display_name='hanrong_numa',ec2_ids=<?>,ephemeral_gb=0,ephemeral_key_uuid=None,fault=<?>,flavor=<?>,host='ctrl3',hostname='hanrong-numa',id=2,image_ref='235166b9-f63c-4bc2-ba73-51a0e47e3b39',info_cache=<?>,instance_type_id=2,kernel_id='',key_data=None,key_name=None,keypairs=<?>,launch_index=0,launched_at=2017-10-30T09:36:55Z,launched_on='ctrl3',locked=False,locked_by=None,memory_mb=128,metadata=<?>,migration_context=<?>,new_flavor=<?>,node='ctrl3',numa_topology=<?>,old_flavor=<?>,os_type=None,pci_devices=<?>,pci_requests=<?>,power_state=1,progress=0,project_id='0c1f9446e0bd4b70bce91cb5a69673f7',ramdisk_id='',reservation_id='r-qn2iqs43',root_device_name='/dev/vda',root_gb=0,security_groups=<?>,services=<?>,shutdown_terminate=False,system_metadata=<?>,tags=<?>,task_state=None,terminated_at=None,updated_at=2017-10-30T09:36:55Z,user_data=None,user_id='6c493f80a87f4a17be8681f580f2fa48',uuid=a18ca5aa-177d-4f94-8239-1c6486dbc963,vcpu_model=<?>,vcpus=1,vm_mode=None,vm_state='active'), '034bfaeb-b1a5-4b00-8ce9-1afdc2352501': Instance(access_ip_v4=None,access_ip_v6=None,architecture=None,auto_disk_config=False,availability_zone='nova',cell_name=None,cleaned=True,config_drive='',created_at=2017-11-03T05:35:21Z,default_ephemeral_device=None,default_swap_device=None,deleted=False,deleted_at=None,device_metadata=<?>,disable_terminate=False,display_description='hanrong_numa',display_name='hanrong_numa-5',ec2_ids=<?>,ephemeral_gb=0,ephemeral_key_uuid=None,fault=<?>,flavor=<?>,host='ctrl3',hostname='hanrong-numa-5',id=12,image_ref='235166b9-f63c-4bc2-ba73-51a0e47e3b39',info_cache=<?>,instance_type_id=2,kernel_id='',key_data=None,key_name=None,keypairs=<?>,launch_index=4,launched_at=2017-11-03T05:35:41Z,launched_on='ctrl3',locked=False,locked_by=None,memory_mb=128,metadata=<?>,migration_context=<?>,new_flavor=<?>,node='ctrl3',numa_topology=<?>,old_flavor=<?>,os_type=None,pci_devices=<?>,pci_requests=<?>,power_state=1,progress=0,project_id='0c1f9446e0bd4b70bce91cb5a69673f7',ramdisk_id='',reservation_id='r-0u7ay8lb',root_device_name='/dev/vda',root_gb=0,security_groups=<?>,services=<?>,shutdown_terminate=False,system_metadata=<?>,tags=<?>,task_state=None,terminated_at=None,updated_at=2017-11-03T05:35:41Z,user_data=None,user_id='6c493f80a87f4a17be8681f580f2fa48',uuid=034bfaeb-b1a5-4b00-8ce9-1afdc2352501,vcpu_model=<?>,vcpus=1,vm_mode=None,vm_state='active')} _locked_update /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:181
2017-11-03 14:15:56.856 131332 DEBUG oslo_concurrency.lockutils [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Lock "(u'ctrl3', u'ctrl3')" released by "nova.scheduler.host_manager._locked_update" :: held 0.013s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:282
2017-11-03 14:15:56.857 131332 DEBUG oslo_concurrency.lockutils [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Lock "(u'computer1', u'computer1')" acquired by "nova.scheduler.host_manager._locked_update" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:270
2017-11-03 14:15:56.857 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Update host state from compute node: ComputeNode(cpu_allocation_ratio=1.0,cpu_info='{"vendor": "Intel", "model": "Haswell-noTSX", "arch": "x86_64", "features": ["pge", "avx", "clflush", "sep", "syscall", "vme", "dtes64", "invpcid", "tsc", "fsgsbase", "xsave", "vmx", "erms", "xtpr", "cmov", "smep", "ssse3", "est", "pat", "monitor", "smx", "pbe", "lm", "msr", "nx", "fxsr", "tm", "sse4.1", "pae", "sse4.2", "pclmuldq", "acpi", "fma", "tsc-deadline", "mmx", "osxsave", "cx8", "mce", "de", "tm2", "ht", "dca", "lahf_lm", "abm", "popcnt", "mca", "pdpe1gb", "apic", "sse", "f16c", "pse", "ds", "invtsc", "pni", "rdtscp", "avx2", "aes", "sse2", "ss", "ds_cpl", "bmi1", "bmi2", "pcid", "fpu", "cx16", "pse36", "mtrr", "movbe", "pdcm", "rdrand", "x2apic"], "topology": {"cores": 12, "cells": 2, "threads": 2, "sockets": 1}}',created_at=2017-10-25T02:48:01Z,current_workload=0,deleted=False,deleted_at=None,disk_allocation_ratio=1.0,disk_available_least=85,free_disk_gb=98,free_ram_mb=127865,host='computer1',host_ip=193.168.1.11,hypervisor_hostname='computer1',hypervisor_type='QEMU',hypervisor_version=2005000,id=3,local_gb=98,local_gb_used=0,mapped=1,memory_mb=128377,memory_mb_used=512,metrics='[{"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.user.percent", "value": 0.01, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.kernel.time", "value": 205504520000000, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.kernel.percent", "value": 0.0, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.idle.time", "value": 40833182420000000, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.idle.percent", "value": 0.98, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.iowait.time", "value": 18643690000000, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.percent", "value": 0.01, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.user.time", "value": 362072300000000, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.frequency", "value": 2294, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.iowait.percent", "value": 0.0, "source": "libvirt.LibvirtDriver"}]',numa_topology='{"nova_object.version": "1.2", "nova_object.changes": ["cells"], "nova_object.name": "NUMATopology", "nova_object.data": {"cells": [{"nova_object.version": "1.2", "nova_object.changes": ["cpu_usage", "memory_usage", "cpuset", "mempages", "pinned_cpus", "memory", "siblings", "id"], "nova_object.name": "NUMACell", "nova_object.data": {"cpu_usage": 0, "memory_usage": 0, "cpuset": [0, 2, 4, 6, 8, 10, 12, 14, 16, 18, 20, 22, 24, 26, 28, 30, 32, 34, 36, 38, 40, 42, 44, 46], "pinned_cpus": [], "siblings": [[28, 4], [2, 26], [44, 20], [0, 24], [18, 42], [16, 40], [46, 22], [38, 14], [36, 12], [8, 32], [30, 6], [10, 34]], "memory": 65440, "mempages": [{"nova_object.version": "1.1", "nova_object.changes": ["total", "used", "reserved", "size_kb"], "nova_object.name": "NUMAPagesTopology", "nova_object.data": {"used": 0, "total": 16752732, "reserved": 0, "size_kb": 4}, "nova_object.namespace": "nova"}, {"nova_object.version": "1.1", "nova_object.changes": ["total", "used", "reserved", "size_kb"], "nova_object.name": "NUMAPagesTopology", "nova_object.data": {"used": 0, "total": 0, "reserved": 0, "size_kb": 1048576}, "nova_object.namespace": "nova"}], "id": 0}, "nova_object.namespace": "nova"}, {"nova_object.version": "1.2", "nova_object.changes": ["cpu_usage", "memory_usage", "cpuset", "mempages", "pinned_cpus", "memory", "siblings", "id"], "nova_object.name": "NUMACell", "nova_object.data": {"cpu_usage": 0, "memory_usage": 0, "cpuset": [1, 3, 5, 7, 9, 11, 13, 15, 17, 19, 21, 23, 25, 27, 29, 31, 33, 35, 37, 39, 41, 43, 45, 47], "pinned_cpus": [], "siblings": [[21, 45], [31, 7], [39, 15], [35, 11], [17, 41], [27, 3], [13, 37], [9, 33], [47, 23], [43, 19], [5, 29], [1, 25]], "memory": 65536, "mempages": [{"nova_object.version": "1.1", "nova_object.changes": ["total", "used", "reserved", "size_kb"], "nova_object.name": "NUMAPagesTopology", "nova_object.data": {"used": 0, "total": 16777216, "reserved": 0, "size_kb": 4}, "nova_object.namespace": "nova"}, {"nova_object.version": "1.1", "nova_object.changes": ["total", "used", "reserved", "size_kb"], "nova_object.name": "NUMAPagesTopology", "nova_object.data": {"used": 0, "total": 0, "reserved": 0, "size_kb": 1048576}, "nova_object.namespace": "nova"}], "id": 1}, "nova_object.namespace": "nova"}]}, "nova_object.namespace": "nova"}',pci_device_pools=PciDevicePoolList,ram_allocation_ratio=1.0,running_vms=0,service_id=None,stats={},supported_hv_specs=[HVSpec,HVSpec,HVSpec,HVSpec],updated_at=2017-11-03T06:15:49Z,uuid=54cec566-8130-4ca5-b3e9-bbacdc52dd50,vcpus=48,vcpus_used=0) _locked_update /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:172
2017-11-03 14:15:56.860 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Update host state with aggregates: [] _locked_update /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:175
2017-11-03 14:15:56.860 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Update host state with service dict: {'binary': u'nova-compute', 'uuid': '9955ccab-5bc6-4153-b73b-9df65bf10df4', 'deleted': False, 'created_at': datetime.datetime(2017, 10, 25, 2, 48, tzinfo=<iso8601.Utc>), 'updated_at': datetime.datetime(2017, 11, 3, 6, 15, 52, tzinfo=<iso8601.Utc>), 'report_count': 78841, 'topic': u'compute', 'host': u'computer1', 'version': 22, 'disabled': False, 'forced_down': False, 'last_seen_up': datetime.datetime(2017, 11, 3, 6, 15, 52, tzinfo=<iso8601.Utc>), 'deleted_at': None, 'disabled_reason': None, 'id': 39} _locked_update /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:178
2017-11-03 14:15:56.861 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Update host state with instances: {} _locked_update /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:181
2017-11-03 14:15:56.861 131332 DEBUG oslo_concurrency.lockutils [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Lock "(u'computer1', u'computer1')" released by "nova.scheduler.host_manager._locked_update" :: held 0.004s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:282
2017-11-03 14:15:56.861 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Starting with 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:70
2017-11-03 14:15:56.866 131332 DEBUG nova.scheduler.filters.retry_filter [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Re-scheduling is disabled host_passes /usr/lib/python2.7/site-packages/nova/scheduler/filters/retry_filter.py:34
2017-11-03 14:15:56.866 131332 DEBUG nova.scheduler.filters.retry_filter [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Re-scheduling is disabled host_passes /usr/lib/python2.7/site-packages/nova/scheduler/filters/retry_filter.py:34
2017-11-03 14:15:56.866 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter RetryFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
2017-11-03 14:15:56.867 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter AvailabilityZoneFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
2017-11-03 14:15:56.867 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter ComputeFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
2017-11-03 14:15:56.868 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter ComputeCapabilitiesFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
2017-11-03 14:15:56.868 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter ImagePropertiesFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
2017-11-03 14:15:56.869 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter PciPassthroughFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
2017-11-03 14:15:56.875 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Attempting to fit instance cell InstanceNUMACell(cpu_pinning_raw=None,cpu_policy='dedicated',cpu_thread_policy=None,cpu_topology=<?>,cpuset=set([0]),cpuset_reserved=None,id=0,memory=128,pagesize=None) on host_cell NUMACell(cpu_usage=6,cpuset=set([0,2,4,6,8,10,12,14,16,18,20,22,24,26,28,30,32,34,36,38,40,42,44,46]),id=0,memory=65440,memory_usage=768,mempages=[NUMAPagesTopology,NUMAPagesTopology],pinned_cpus=set([0,16,2,28,44,18]),siblings=[set([4,28]),set([2,26]),set([20,44]),set([0,24]),set([18,42]),set([16,40]),set([22,46]),set([14,38]),set([12,36]),set([8,32]),set([6,30]),set([10,34])]) _numa_fit_instance_cell /usr/lib/python2.7/site-packages/nova/virt/hardware.py:981
2017-11-03 14:15:56.876 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Pinning has been requested _numa_fit_instance_cell /usr/lib/python2.7/site-packages/nova/virt/hardware.py:1001
2017-11-03 14:15:56.877 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Using thread siblings for packing _numa_fit_instance_cell_with_pinning /usr/lib/python2.7/site-packages/nova/virt/hardware.py:937
2017-11-03 14:15:56.877 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Packing an instance onto a set of siblings:     available_siblings: [CoercedSet([4]), CoercedSet([26]), CoercedSet([20]), CoercedSet([24]), CoercedSet([42]), CoercedSet([40]), CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])]    instance_cell: InstanceNUMACell(cpu_pinning_raw=None,cpu_policy='dedicated',cpu_thread_policy=None,cpu_topology=<?>,cpuset=set([0]),cpuset_reserved=None,id=0,memory=128,pagesize=None)    host_cell_id: 0    threads_per_core: 2 _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:696
2017-11-03 14:15:56.878 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Built sibling_sets: defaultdict(<type 'list'>, {1: [CoercedSet([4]), CoercedSet([26]), CoercedSet([20]), CoercedSet([24]), CoercedSet([42]), CoercedSet([40]), CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])], 2: [CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])]}) _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:705
2017-11-03 14:15:56.878 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] User did not specify a thread policy. Using default for 1 cores _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:836
2017-11-03 14:15:56.879 131332 INFO nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Computed NUMA topology CPU pinning: usable pCPUs: [[46, 22], [38, 14], [36, 12], [8, 32], [30, 6], [10, 34]], vCPUs mapping: [(0, 46)]
2017-11-03 14:15:56.879 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Selected cores for pinning: [(0, 46)], in cell 0 _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:891
2017-11-03 14:15:56.886 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Attempting to fit instance cell InstanceNUMACell(cpu_pinning_raw=None,cpu_policy='dedicated',cpu_thread_policy=None,cpu_topology=<?>,cpuset=set([0]),cpuset_reserved=None,id=0,memory=128,pagesize=None) on host_cell NUMACell(cpu_usage=0,cpuset=set([0,2,4,6,8,10,12,14,16,18,20,22,24,26,28,30,32,34,36,38,40,42,44,46]),id=0,memory=65440,memory_usage=0,mempages=[NUMAPagesTopology,NUMAPagesTopology],pinned_cpus=set([]),siblings=[set([4,28]),set([2,26]),set([20,44]),set([0,24]),set([18,42]),set([16,40]),set([22,46]),set([14,38]),set([12,36]),set([8,32]),set([6,30]),set([10,34])]) _numa_fit_instance_cell /usr/lib/python2.7/site-packages/nova/virt/hardware.py:981
2017-11-03 14:15:56.887 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Pinning has been requested _numa_fit_instance_cell /usr/lib/python2.7/site-packages/nova/virt/hardware.py:1001
2017-11-03 14:15:56.887 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Using thread siblings for packing _numa_fit_instance_cell_with_pinning /usr/lib/python2.7/site-packages/nova/virt/hardware.py:937
2017-11-03 14:15:56.888 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Packing an instance onto a set of siblings:     available_siblings: [CoercedSet([28, 4]), CoercedSet([2, 26]), CoercedSet([44, 20]), CoercedSet([0, 24]), CoercedSet([18, 42]), CoercedSet([16, 40]), CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])]    instance_cell: InstanceNUMACell(cpu_pinning_raw=None,cpu_policy='dedicated',cpu_thread_policy=None,cpu_topology=<?>,cpuset=set([0]),cpuset_reserved=None,id=0,memory=128,pagesize=None)    host_cell_id: 0    threads_per_core: 2 _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:696
2017-11-03 14:15:56.889 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Built sibling_sets: defaultdict(<type 'list'>, {1: [CoercedSet([28, 4]), CoercedSet([2, 26]), CoercedSet([44, 20]), CoercedSet([0, 24]), CoercedSet([18, 42]), CoercedSet([16, 40]), CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])], 2: [CoercedSet([28, 4]), CoercedSet([2, 26]), CoercedSet([44, 20]), CoercedSet([0, 24]), CoercedSet([18, 42]), CoercedSet([16, 40]), CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])]}) _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:705
2017-11-03 14:15:56.889 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] User did not specify a thread policy. Using default for 1 cores _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:836
2017-11-03 14:15:56.890 131332 INFO nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Computed NUMA topology CPU pinning: usable pCPUs: [[28, 4], [2, 26], [44, 20], [0, 24], [18, 42], [16, 40], [46, 22], [38, 14], [36, 12], [8, 32], [30, 6], [10, 34]], vCPUs mapping: [(0, 28)]
2017-11-03 14:15:56.890 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Selected cores for pinning: [(0, 28)], in cell 0 _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:891
2017-11-03 14:15:56.891 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter NUMATopologyFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
2017-11-03 14:15:56.891 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter AggregateCoreFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
2017-11-03 14:15:56.891 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter AggregateDiskFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
2017-11-03 14:15:56.892 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter AggregateRamFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
2017-11-03 14:15:56.892 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter ServerGroupAntiAffinityFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
2017-11-03 14:15:56.893 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter ServerGroupAffinityFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
2017-11-03 14:15:56.893 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter AggregateMultiTenancyIsolation returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
2017-11-03 14:15:56.894 131332 DEBUG nova.scheduler.filter_scheduler [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filtered [(ctrl3, ctrl3) ram: 110201MB disk: 56320MB io_ops: 0 instances: 6, (computer1, computer1) ram: 127865MB disk: 87040MB io_ops: 0 instances: 0] _get_sorted_hosts /usr/lib/python2.7/site-packages/nova/scheduler/filter_scheduler.py:298
2017-11-03 14:15:56.895 131332 DEBUG nova.scheduler.filter_scheduler [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Weighed [(computer1, computer1) ram: 127865MB disk: 87040MB io_ops: 0 instances: 0, (ctrl3, ctrl3) ram: 110201MB disk: 56320MB io_ops: 0 instances: 6] _get_sorted_hosts /usr/lib/python2.7/site-packages/nova/scheduler/filter_scheduler.py:308
2017-11-03 14:15:56.895 131332 DEBUG nova.scheduler.filter_scheduler [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Attempting to claim resources in the placement API for instance 62ad226f-8848-455a-9e24-3b83443fc051 _claim_resources /usr/lib/python2.7/site-packages/nova/scheduler/filter_scheduler.py:270
2017-11-03 14:15:57.144 131332 DEBUG nova.scheduler.client.report [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Doubling-up allocation request for move operation. _move_operation_alloc_request /usr/lib/python2.7/site-packages/nova/scheduler/client/report.py:162
2017-11-03 14:15:57.145 131332 DEBUG nova.scheduler.client.report [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] New allocation request containing both source and destination hosts in move operation: {'allocations': [{'resource_provider': {'uuid': u'54cec566-8130-4ca5-b3e9-bbacdc52dd50'}, 'resources': {u'VCPU': 6, u'MEMORY_MB': 768}}, {'resource_provider': {'uuid': u'ae5d2eae-9f7d-4b23-87fd-2503f9a0fc65'}, 'resources': {u'VCPU': 1, u'MEMORY_MB': 128}}]} _move_operation_alloc_request /usr/lib/python2.7/site-packages/nova/scheduler/client/report.py:202
2017-11-03 14:15:57.317 131332 DEBUG nova.scheduler.filter_scheduler [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Selected host: (computer1, computer1) ram: 127865MB disk: 87040MB io_ops: 0 instances: 0 _schedule /usr/lib/python2.7/site-packages/nova/scheduler/filter_scheduler.py:227
2017-11-03 14:15:57.318 131332 DEBUG oslo_concurrency.lockutils [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Lock "(u'computer1', u'computer1')" acquired by "nova.scheduler.host_manager._locked" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:270
2017-11-03 14:15:57.320 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Attempting to fit instance cell InstanceNUMACell(cpu_pinning_raw=None,cpu_policy='dedicated',cpu_thread_policy=None,cpu_topology=<?>,cpuset=set([0]),cpuset_reserved=None,id=0,memory=128,pagesize=None) on host_cell NUMACell(cpu_usage=0,cpuset=set([0,2,4,6,8,10,12,14,16,18,20,22,24,26,28,30,32,34,36,38,40,42,44,46]),id=0,memory=65440,memory_usage=0,mempages=[NUMAPagesTopology,NUMAPagesTopology],pinned_cpus=set([]),siblings=[set([4,28]),set([2,26]),set([20,44]),set([0,24]),set([18,42]),set([16,40]),set([22,46]),set([14,38]),set([12,36]),set([8,32]),set([6,30]),set([10,34])]) _numa_fit_instance_cell /usr/lib/python2.7/site-packages/nova/virt/hardware.py:981
2017-11-03 14:15:57.321 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Pinning has been requested _numa_fit_instance_cell /usr/lib/python2.7/site-packages/nova/virt/hardware.py:1001
2017-11-03 14:15:57.321 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Using thread siblings for packing _numa_fit_instance_cell_with_pinning /usr/lib/python2.7/site-packages/nova/virt/hardware.py:937
2017-11-03 14:15:57.322 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Packing an instance onto a set of siblings:     available_siblings: [CoercedSet([28, 4]), CoercedSet([2, 26]), CoercedSet([44, 20]), CoercedSet([0, 24]), CoercedSet([18, 42]), CoercedSet([16, 40]), CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])]    instance_cell: InstanceNUMACell(cpu_pinning_raw=None,cpu_policy='dedicated',cpu_thread_policy=None,cpu_topology=<?>,cpuset=set([0]),cpuset_reserved=None,id=0,memory=128,pagesize=None)    host_cell_id: 0    threads_per_core: 2 _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:696
2017-11-03 14:15:57.323 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Built sibling_sets: defaultdict(<type 'list'>, {1: [CoercedSet([28, 4]), CoercedSet([2, 26]), CoercedSet([44, 20]), CoercedSet([0, 24]), CoercedSet([18, 42]), CoercedSet([16, 40]), CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])], 2: [CoercedSet([28, 4]), CoercedSet([2, 26]), CoercedSet([44, 20]), CoercedSet([0, 24]), CoercedSet([18, 42]), CoercedSet([16, 40]), CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])]}) _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:705
2017-11-03 14:15:57.323 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] User did not specify a thread policy. Using default for 1 cores _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:836
2017-11-03 14:15:57.324 131332 INFO nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Computed NUMA topology CPU pinning: usable pCPUs: [[28, 4], [2, 26], [44, 20], [0, 24], [18, 42], [16, 40], [46, 22], [38, 14], [36, 12], [8, 32], [30, 6], [10, 34]], vCPUs mapping: [(0, 28)]
2017-11-03 14:15:57.324 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Selected cores for pinning: [(0, 28)], in cell 0 _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:891
2017-11-03 14:15:57.328 131332 DEBUG oslo_concurrency.lockutils [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Lock "(u'computer1', u'computer1')" released by "nova.scheduler.host_manager._locked" :: held 0.010s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:282
2017-11-03 14:15:57.328 131332 DEBUG nova.scheduler.filter_scheduler [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] There are 1 hosts available but 5 instances requested to build. select_destinations /usr/lib/python2.7/site-packages/nova/scheduler/filter_scheduler.py:101

** Affects: nova
     Importance: Medium
         Status: New


** Tags: nova-scheduler

** Changed in: nova
   Importance: Undecided => Medium

** Tags added: nova-scheduler

-- 
You received this bug notification because you are a member of Yahoo!
Engineering Team, which is subscribed to OpenStack Compute (nova).
https://bugs.launchpad.net/bugs/1729780

Title:
  migrate/live-migrate instance, no vailid host selected.

Status in OpenStack Compute (nova):
  New

Bug description:
  Description
  ===========
  Openstack cloud has enough resource, create instances will be successful, but migrate or live migrate instance will be failed.

  Steps to reproduce
  ==================
  * I did create 5 instances at a time.
      openstack server create hanrong_numa --image 235166b9-f63c-4bc2-ba73-51a0e47e3b39 --flavor 1111 --nic net-id=ba8d7500-2d2a-425f-83b3-ffa45a5ad28a --max 5

  * then I did migrate one instance.
    nova migrate 62ad226f-8848-455a-9e24-3b83443fc051
  ERROR (BadRequest): No valid host was found. No valid host found for cold migrate (HTTP 400) (Request-ID: req-6ae8da3f-424a-42a8-abc0-296ad831af22)

  
  Expected result
  ===============
  nova-scheduler can select one compute host for this instance to migrate.

  Actual result
  =============
  nova-scheduler raise no valid host exception.

  Environment
  ===========
  1. Exact version of OpenStack you are running. See the following
    Pike version

  
  Logs & Configs
  ==============
  [root@ctrl3 ~]# cat /var/log/nova/nova-scheduler.log  | grep req-6ae8da3f-424a-42a8-abc0-296ad831af22
  2017-11-03 14:15:56.554 131332 DEBUG nova.scheduler.manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Starting to schedule for instances: [u'62ad226f-8848-455a-9e24-3b83443fc051'] select_destinations /usr/lib/python2.7/site-packages/nova/scheduler/manager.py:113
  2017-11-03 14:15:56.825 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Getting compute nodes and services for cell 0d81237d-c567-46de-8838-edeb5b126738(cell1) _get_computes_for_cells /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:608
  2017-11-03 14:15:56.826 131332 DEBUG oslo_concurrency.lockutils [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Lock "0d81237d-c567-46de-8838-edeb5b126738" acquired by "nova.context.get_or_set_cached_cell_and_set_connections" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:270
  2017-11-03 14:15:56.826 131332 DEBUG oslo_concurrency.lockutils [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Lock "0d81237d-c567-46de-8838-edeb5b126738" released by "nova.context.get_or_set_cached_cell_and_set_connections" :: held 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:282
  2017-11-03 14:15:56.843 131332 DEBUG oslo_concurrency.lockutils [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Lock "(u'ctrl3', u'ctrl3')" acquired by "nova.scheduler.host_manager._locked_update" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:270
  2017-11-03 14:15:56.844 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Update host state from compute node: ComputeNode(cpu_allocation_ratio=1.0,cpu_info='{"vendor": "Intel", "model": "Haswell-noTSX", "arch": "x86_64", "features": ["pge", "avx", "clflush", "sep", "syscall", "vme", "dtes64", "invpcid", "tsc", "fsgsbase", "xsave", "vmx", "erms", "xtpr", "cmov", "smep", "ssse3", "est", "pat", "monitor", "smx", "pbe", "lm", "msr", "nx", "fxsr", "tm", "sse4.1", "pae", "sse4.2", "pclmuldq", "acpi", "fma", "tsc-deadline", "mmx", "osxsave", "cx8", "mce", "de", "tm2", "ht", "dca", "lahf_lm", "abm", "popcnt", "mca", "pdpe1gb", "apic", "sse", "f16c", "pse", "ds", "invtsc", "pni", "rdtscp", "avx2", "aes", "sse2", "ss", "ds_cpl", "bmi1", "bmi2", "pcid", "fpu", "cx16", "pse36", "mtrr", "movbe", "pdcm", "rdrand", "x2apic"], "topology": {"cores": 12, "cells": 2, "threads": 2, "sockets": 1}}',created_at=2017-10-25T02:48:00Z,current_workload=0,deleted=False,deleted_at=None,disk_allocation_ratio=1.0,disk_available_least=55,free_disk_gb=59,free_ram_mb=110201,host='ctrl3',host_ip=193.168.1.13,hypervisor_hostname='ctrl3',hypervisor_type='QEMU',hypervisor_version=2005000,id=1,local_gb=59,local_gb_used=0,mapped=1,memory_mb=128377,memory_mb_used=18176,metrics='[{"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.user.percent", "value": 0.02, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.kernel.time", "value": 282133380000000, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.kernel.percent", "value": 0.0, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.idle.time", "value": 64710013250000000, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.idle.percent", "value": 0.96, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.iowait.time", "value": 18656250000000, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.percent", "value": 0.03, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.user.time", "value": 806826950000000, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.frequency", "value": 2294, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:22.429278", "name": "cpu.iowait.percent", "value": 0.0, "source": "libvirt.LibvirtDriver"}]',numa_topology='{"nova_object.version": "1.2", "nova_object.changes": ["cells"], "nova_object.name": "NUMATopology", "nova_object.data": {"cells": [{"nova_object.version": "1.2", "nova_object.changes": ["cpu_usage", "memory_usage", "cpuset", "pinned_cpus", "siblings", "memory", "mempages", "id"], "nova_object.name": "NUMACell", "nova_object.data": {"cpu_usage": 6, "memory_usage": 768, "cpuset": [0, 2, 4, 6, 8, 10, 12, 14, 16, 18, 20, 22, 24, 26, 28, 30, 32, 34, 36, 38, 40, 42, 44, 46], "pinned_cpus": [0, 16, 2, 28, 44, 18], "siblings": [[28, 4], [2, 26], [44, 20], [0, 24], [18, 42], [16, 40], [46, 22], [38, 14], [36, 12], [8, 32], [30, 6], [10, 34]], "memory": 65440, "mempages": [{"nova_object.version": "1.1", "nova_object.changes": ["total", "used", "reserved", "size_kb"], "nova_object.name": "NUMAPagesTopology", "nova_object.data": {"used": 0, "total": 16752732, "reserved": 0, "size_kb": 4}, "nova_object.namespace": "nova"}, {"nova_object.version": "1.1", "nova_object.changes": ["total", "used", "reserved", "size_kb"], "nova_object.name": "NUMAPagesTopology", "nova_object.data": {"used": 0, "total": 0, "reserved": 0, "size_kb": 1048576}, "nova_object.namespace": "nova"}], "id": 0}, "nova_object.namespace": "nova"}, {"nova_object.version": "1.2", "nova_object.changes": ["cpu_usage", "memory_usage", "cpuset", "pinned_cpus", "siblings", "memory", "mempages", "id"], "nova_object.name": "NUMACell", "nova_object.data": {"cpu_usage": 0, "memory_usage": 0, "cpuset": [1, 3, 5, 7, 9, 11, 13, 15, 17, 19, 21, 23, 25, 27, 29, 31, 33, 35, 37, 39, 41, 43, 45, 47], "pinned_cpus": [], "siblings": [[21, 45], [31, 7], [39, 15], [35, 11], [17, 41], [27, 3], [13, 37], [9, 33], [47, 23], [43, 19], [5, 29], [1, 25]], "memory": 65536, "mempages": [{"nova_object.version": "1.1", "nova_object.changes": ["total", "used", "reserved", "size_kb"], "nova_object.name": "NUMAPagesTopology", "nova_object.data": {"used": 0, "total": 16777216, "reserved": 0, "size_kb": 4}, "nova_object.namespace": "nova"}, {"nova_object.version": "1.1", "nova_object.changes": ["total", "used", "reserved", "size_kb"], "nova_object.name": "NUMAPagesTopology", "nova_object.data": {"used": 0, "total": 0, "reserved": 0, "size_kb": 1048576}, "nova_object.namespace": "nova"}], "id": 1}, "nova_object.namespace": "nova"}]}, "nova_object.namespace": "nova"}',pci_device_pools=PciDevicePoolList,ram_allocation_ratio=1.0,running_vms=6,service_id=None,stats={io_workload='0',num_instances='6',num_os_type_None='6',num_proj_0c1f9446e0bd4b70bce91cb5a69673f7='6',num_task_None='6',num_vm_active='6'},supported_hv_specs=[HVSpec,HVSpec,HVSpec,HVSpec],updated_at=2017-11-03T06:15:22Z,uuid=ae5d2eae-9f7d-4b23-87fd-2503f9a0fc65,vcpus=48,vcpus_used=6) _locked_update /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:172
  2017-11-03 14:15:56.847 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Update host state with aggregates: [] _locked_update /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:175
  2017-11-03 14:15:56.847 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Update host state with service dict: {'binary': u'nova-compute', 'uuid': '967fe0cc-098d-4d81-be30-94fa95f535f9', 'deleted': False, 'created_at': datetime.datetime(2017, 10, 25, 2, 48, tzinfo=<iso8601.Utc>), 'updated_at': datetime.datetime(2017, 11, 3, 6, 15, 51, tzinfo=<iso8601.Utc>), 'report_count': 78903, 'topic': u'compute', 'host': u'ctrl3', 'version': 22, 'disabled': False, 'forced_down': False, 'last_seen_up': datetime.datetime(2017, 11, 3, 6, 15, 51, tzinfo=<iso8601.Utc>), 'deleted_at': None, 'disabled_reason': None, 'id': 37} _locked_update /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:178
  2017-11-03 14:15:56.848 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Update host state with instances: {'6bdcaa14-e26c-46ee-a43e-82ea503d2ac1': Instance(access_ip_v4=None,access_ip_v6=None,architecture=None,auto_disk_config=False,availability_zone='nova',cell_name=None,cleaned=False,config_drive='',created_at=2017-11-03T05:35:21Z,default_ephemeral_device=None,default_swap_device=None,deleted=False,deleted_at=None,device_metadata=<?>,disable_terminate=False,display_description='hanrong_numa',display_name='hanrong_numa-2',ec2_ids=<?>,ephemeral_gb=0,ephemeral_key_uuid=None,fault=<?>,flavor=<?>,host='ctrl3',hostname='hanrong-numa-2',id=6,image_ref='235166b9-f63c-4bc2-ba73-51a0e47e3b39',info_cache=<?>,instance_type_id=2,kernel_id='',key_data=None,key_name=None,keypairs=<?>,launch_index=1,launched_at=2017-11-03T05:35:33Z,launched_on='ctrl3',locked=False,locked_by=None,memory_mb=128,metadata=<?>,migration_context=<?>,new_flavor=<?>,node='ctrl3',numa_topology=<?>,old_flavor=<?>,os_type=None,pci_devices=<?>,pci_requests=<?>,power_state=1,progress=0,project_id='0c1f9446e0bd4b70bce91cb5a69673f7',ramdisk_id='',reservation_id='r-0u7ay8lb',root_device_name='/dev/vda',root_gb=0,security_groups=<?>,services=<?>,shutdown_terminate=False,system_metadata=<?>,tags=<?>,task_state=None,terminated_at=None,updated_at=2017-11-03T05:35:33Z,user_data=None,user_id='6c493f80a87f4a17be8681f580f2fa48',uuid=6bdcaa14-e26c-46ee-a43e-82ea503d2ac1,vcpu_model=<?>,vcpus=1,vm_mode=None,vm_state='active'), 'e8ab79d5-2832-44d3-ab38-d0463aa3cc4e': Instance(access_ip_v4=None,access_ip_v6=None,architecture=None,auto_disk_config=False,availability_zone='nova',cell_name=None,cleaned=False,config_drive='',created_at=2017-11-03T05:35:21Z,default_ephemeral_device=None,default_swap_device=None,deleted=False,deleted_at=None,device_metadata=<?>,disable_terminate=False,display_description='hanrong_numa',display_name='hanrong_numa-4',ec2_ids=<?>,ephemeral_gb=0,ephemeral_key_uuid=None,fault=<?>,flavor=<?>,host='ctrl3',hostname='hanrong-numa-4',id=10,image_ref='235166b9-f63c-4bc2-ba73-51a0e47e3b39',info_cache=<?>,instance_type_id=2,kernel_id='',key_data=None,key_name=None,keypairs=<?>,launch_index=3,launched_at=2017-11-03T05:35:31Z,launched_on='ctrl3',locked=False,locked_by=None,memory_mb=128,metadata=<?>,migration_context=<?>,new_flavor=<?>,node='ctrl3',numa_topology=<?>,old_flavor=<?>,os_type=None,pci_devices=<?>,pci_requests=<?>,power_state=1,progress=0,project_id='0c1f9446e0bd4b70bce91cb5a69673f7',ramdisk_id='',reservation_id='r-0u7ay8lb',root_device_name='/dev/vda',root_gb=0,security_groups=<?>,services=<?>,shutdown_terminate=False,system_metadata=<?>,tags=<?>,task_state=None,terminated_at=None,updated_at=2017-11-03T05:35:31Z,user_data=None,user_id='6c493f80a87f4a17be8681f580f2fa48',uuid=e8ab79d5-2832-44d3-ab38-d0463aa3cc4e,vcpu_model=<?>,vcpus=1,vm_mode=None,vm_state='active'), '62ad226f-8848-455a-9e24-3b83443fc051': Instance(access_ip_v4=None,access_ip_v6=None,architecture=None,auto_disk_config=False,availability_zone='nova',cell_name=None,cleaned=True,config_drive='',created_at=2017-11-03T05:35:21Z,default_ephemeral_device=None,default_swap_device=None,deleted=False,deleted_at=None,device_metadata=<?>,disable_terminate=False,display_description='hanrong_numa',display_name='hanrong_numa-1',ec2_ids=<?>,ephemeral_gb=0,ephemeral_key_uuid=None,fault=<?>,flavor=<?>,host='ctrl3',hostname='hanrong-numa-1',id=4,image_ref='235166b9-f63c-4bc2-ba73-51a0e47e3b39',info_cache=<?>,instance_type_id=2,kernel_id='',key_data=None,key_name=None,keypairs=<?>,launch_index=0,launched_at=2017-11-03T05:35:43Z,launched_on='ctrl3',locked=False,locked_by=None,memory_mb=128,metadata=<?>,migration_context=<?>,new_flavor=<?>,node='ctrl3',numa_topology=<?>,old_flavor=<?>,os_type=None,pci_devices=<?>,pci_requests=<?>,power_state=1,progress=0,project_id='0c1f9446e0bd4b70bce91cb5a69673f7',ramdisk_id='',reservation_id='r-0u7ay8lb',root_device_name='/dev/vda',root_gb=0,security_groups=<?>,services=<?>,shutdown_terminate=False,system_metadata=<?>,tags=<?>,task_state=None,terminated_at=None,updated_at=2017-11-03T05:54:22Z,user_data=None,user_id='6c493f80a87f4a17be8681f580f2fa48',uuid=62ad226f-8848-455a-9e24-3b83443fc051,vcpu_model=<?>,vcpus=1,vm_mode=None,vm_state='active'), '0416af9a-e552-4d66-b816-8b66433312cd': Instance(access_ip_v4=None,access_ip_v6=None,architecture=None,auto_disk_config=False,availability_zone='nova',cell_name=None,cleaned=True,config_drive='',created_at=2017-11-03T05:35:21Z,default_ephemeral_device=None,default_swap_device=None,deleted=False,deleted_at=None,device_metadata=<?>,disable_terminate=False,display_description='hanrong_numa',display_name='hanrong_numa-3',ec2_ids=<?>,ephemeral_gb=0,ephemeral_key_uuid=None,fault=<?>,flavor=<?>,host='ctrl3',hostname='hanrong-numa-3',id=8,image_ref='235166b9-f63c-4bc2-ba73-51a0e47e3b39',info_cache=<?>,instance_type_id=2,kernel_id='',key_data=None,key_name=None,keypairs=<?>,launch_index=2,launched_at=2017-11-03T05:35:43Z,launched_on='ctrl3',locked=False,locked_by=None,memory_mb=128,metadata=<?>,migration_context=<?>,new_flavor=<?>,node='ctrl3',numa_topology=<?>,old_flavor=<?>,os_type=None,pci_devices=<?>,pci_requests=<?>,power_state=1,progress=0,project_id='0c1f9446e0bd4b70bce91cb5a69673f7',ramdisk_id='',reservation_id='r-0u7ay8lb',root_device_name='/dev/vda',root_gb=0,security_groups=<?>,services=<?>,shutdown_terminate=False,system_metadata=<?>,tags=<?>,task_state=None,terminated_at=None,updated_at=2017-11-03T05:35:43Z,user_data=None,user_id='6c493f80a87f4a17be8681f580f2fa48',uuid=0416af9a-e552-4d66-b816-8b66433312cd,vcpu_model=<?>,vcpus=1,vm_mode=None,vm_state='active'), 'a18ca5aa-177d-4f94-8239-1c6486dbc963': Instance(access_ip_v4=None,access_ip_v6=None,architecture=None,auto_disk_config=False,availability_zone='nova',cell_name=None,cleaned=True,config_drive='',created_at=2017-10-30T09:36:32Z,default_ephemeral_device=None,default_swap_device=None,deleted=False,deleted_at=None,device_metadata=<?>,disable_terminate=False,display_description='hanrong_numa',display_name='hanrong_numa',ec2_ids=<?>,ephemeral_gb=0,ephemeral_key_uuid=None,fault=<?>,flavor=<?>,host='ctrl3',hostname='hanrong-numa',id=2,image_ref='235166b9-f63c-4bc2-ba73-51a0e47e3b39',info_cache=<?>,instance_type_id=2,kernel_id='',key_data=None,key_name=None,keypairs=<?>,launch_index=0,launched_at=2017-10-30T09:36:55Z,launched_on='ctrl3',locked=False,locked_by=None,memory_mb=128,metadata=<?>,migration_context=<?>,new_flavor=<?>,node='ctrl3',numa_topology=<?>,old_flavor=<?>,os_type=None,pci_devices=<?>,pci_requests=<?>,power_state=1,progress=0,project_id='0c1f9446e0bd4b70bce91cb5a69673f7',ramdisk_id='',reservation_id='r-qn2iqs43',root_device_name='/dev/vda',root_gb=0,security_groups=<?>,services=<?>,shutdown_terminate=False,system_metadata=<?>,tags=<?>,task_state=None,terminated_at=None,updated_at=2017-10-30T09:36:55Z,user_data=None,user_id='6c493f80a87f4a17be8681f580f2fa48',uuid=a18ca5aa-177d-4f94-8239-1c6486dbc963,vcpu_model=<?>,vcpus=1,vm_mode=None,vm_state='active'), '034bfaeb-b1a5-4b00-8ce9-1afdc2352501': Instance(access_ip_v4=None,access_ip_v6=None,architecture=None,auto_disk_config=False,availability_zone='nova',cell_name=None,cleaned=True,config_drive='',created_at=2017-11-03T05:35:21Z,default_ephemeral_device=None,default_swap_device=None,deleted=False,deleted_at=None,device_metadata=<?>,disable_terminate=False,display_description='hanrong_numa',display_name='hanrong_numa-5',ec2_ids=<?>,ephemeral_gb=0,ephemeral_key_uuid=None,fault=<?>,flavor=<?>,host='ctrl3',hostname='hanrong-numa-5',id=12,image_ref='235166b9-f63c-4bc2-ba73-51a0e47e3b39',info_cache=<?>,instance_type_id=2,kernel_id='',key_data=None,key_name=None,keypairs=<?>,launch_index=4,launched_at=2017-11-03T05:35:41Z,launched_on='ctrl3',locked=False,locked_by=None,memory_mb=128,metadata=<?>,migration_context=<?>,new_flavor=<?>,node='ctrl3',numa_topology=<?>,old_flavor=<?>,os_type=None,pci_devices=<?>,pci_requests=<?>,power_state=1,progress=0,project_id='0c1f9446e0bd4b70bce91cb5a69673f7',ramdisk_id='',reservation_id='r-0u7ay8lb',root_device_name='/dev/vda',root_gb=0,security_groups=<?>,services=<?>,shutdown_terminate=False,system_metadata=<?>,tags=<?>,task_state=None,terminated_at=None,updated_at=2017-11-03T05:35:41Z,user_data=None,user_id='6c493f80a87f4a17be8681f580f2fa48',uuid=034bfaeb-b1a5-4b00-8ce9-1afdc2352501,vcpu_model=<?>,vcpus=1,vm_mode=None,vm_state='active')} _locked_update /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:181
  2017-11-03 14:15:56.856 131332 DEBUG oslo_concurrency.lockutils [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Lock "(u'ctrl3', u'ctrl3')" released by "nova.scheduler.host_manager._locked_update" :: held 0.013s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:282
  2017-11-03 14:15:56.857 131332 DEBUG oslo_concurrency.lockutils [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Lock "(u'computer1', u'computer1')" acquired by "nova.scheduler.host_manager._locked_update" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:270
  2017-11-03 14:15:56.857 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Update host state from compute node: ComputeNode(cpu_allocation_ratio=1.0,cpu_info='{"vendor": "Intel", "model": "Haswell-noTSX", "arch": "x86_64", "features": ["pge", "avx", "clflush", "sep", "syscall", "vme", "dtes64", "invpcid", "tsc", "fsgsbase", "xsave", "vmx", "erms", "xtpr", "cmov", "smep", "ssse3", "est", "pat", "monitor", "smx", "pbe", "lm", "msr", "nx", "fxsr", "tm", "sse4.1", "pae", "sse4.2", "pclmuldq", "acpi", "fma", "tsc-deadline", "mmx", "osxsave", "cx8", "mce", "de", "tm2", "ht", "dca", "lahf_lm", "abm", "popcnt", "mca", "pdpe1gb", "apic", "sse", "f16c", "pse", "ds", "invtsc", "pni", "rdtscp", "avx2", "aes", "sse2", "ss", "ds_cpl", "bmi1", "bmi2", "pcid", "fpu", "cx16", "pse36", "mtrr", "movbe", "pdcm", "rdrand", "x2apic"], "topology": {"cores": 12, "cells": 2, "threads": 2, "sockets": 1}}',created_at=2017-10-25T02:48:01Z,current_workload=0,deleted=False,deleted_at=None,disk_allocation_ratio=1.0,disk_available_least=85,free_disk_gb=98,free_ram_mb=127865,host='computer1',host_ip=193.168.1.11,hypervisor_hostname='computer1',hypervisor_type='QEMU',hypervisor_version=2005000,id=3,local_gb=98,local_gb_used=0,mapped=1,memory_mb=128377,memory_mb_used=512,metrics='[{"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.user.percent", "value": 0.01, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.kernel.time", "value": 205504520000000, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.kernel.percent", "value": 0.0, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.idle.time", "value": 40833182420000000, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.idle.percent", "value": 0.98, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.iowait.time", "value": 18643690000000, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.percent", "value": 0.01, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.user.time", "value": 362072300000000, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.frequency", "value": 2294, "source": "libvirt.LibvirtDriver"}, {"timestamp": "2017-11-03T06:15:49.567420", "name": "cpu.iowait.percent", "value": 0.0, "source": "libvirt.LibvirtDriver"}]',numa_topology='{"nova_object.version": "1.2", "nova_object.changes": ["cells"], "nova_object.name": "NUMATopology", "nova_object.data": {"cells": [{"nova_object.version": "1.2", "nova_object.changes": ["cpu_usage", "memory_usage", "cpuset", "mempages", "pinned_cpus", "memory", "siblings", "id"], "nova_object.name": "NUMACell", "nova_object.data": {"cpu_usage": 0, "memory_usage": 0, "cpuset": [0, 2, 4, 6, 8, 10, 12, 14, 16, 18, 20, 22, 24, 26, 28, 30, 32, 34, 36, 38, 40, 42, 44, 46], "pinned_cpus": [], "siblings": [[28, 4], [2, 26], [44, 20], [0, 24], [18, 42], [16, 40], [46, 22], [38, 14], [36, 12], [8, 32], [30, 6], [10, 34]], "memory": 65440, "mempages": [{"nova_object.version": "1.1", "nova_object.changes": ["total", "used", "reserved", "size_kb"], "nova_object.name": "NUMAPagesTopology", "nova_object.data": {"used": 0, "total": 16752732, "reserved": 0, "size_kb": 4}, "nova_object.namespace": "nova"}, {"nova_object.version": "1.1", "nova_object.changes": ["total", "used", "reserved", "size_kb"], "nova_object.name": "NUMAPagesTopology", "nova_object.data": {"used": 0, "total": 0, "reserved": 0, "size_kb": 1048576}, "nova_object.namespace": "nova"}], "id": 0}, "nova_object.namespace": "nova"}, {"nova_object.version": "1.2", "nova_object.changes": ["cpu_usage", "memory_usage", "cpuset", "mempages", "pinned_cpus", "memory", "siblings", "id"], "nova_object.name": "NUMACell", "nova_object.data": {"cpu_usage": 0, "memory_usage": 0, "cpuset": [1, 3, 5, 7, 9, 11, 13, 15, 17, 19, 21, 23, 25, 27, 29, 31, 33, 35, 37, 39, 41, 43, 45, 47], "pinned_cpus": [], "siblings": [[21, 45], [31, 7], [39, 15], [35, 11], [17, 41], [27, 3], [13, 37], [9, 33], [47, 23], [43, 19], [5, 29], [1, 25]], "memory": 65536, "mempages": [{"nova_object.version": "1.1", "nova_object.changes": ["total", "used", "reserved", "size_kb"], "nova_object.name": "NUMAPagesTopology", "nova_object.data": {"used": 0, "total": 16777216, "reserved": 0, "size_kb": 4}, "nova_object.namespace": "nova"}, {"nova_object.version": "1.1", "nova_object.changes": ["total", "used", "reserved", "size_kb"], "nova_object.name": "NUMAPagesTopology", "nova_object.data": {"used": 0, "total": 0, "reserved": 0, "size_kb": 1048576}, "nova_object.namespace": "nova"}], "id": 1}, "nova_object.namespace": "nova"}]}, "nova_object.namespace": "nova"}',pci_device_pools=PciDevicePoolList,ram_allocation_ratio=1.0,running_vms=0,service_id=None,stats={},supported_hv_specs=[HVSpec,HVSpec,HVSpec,HVSpec],updated_at=2017-11-03T06:15:49Z,uuid=54cec566-8130-4ca5-b3e9-bbacdc52dd50,vcpus=48,vcpus_used=0) _locked_update /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:172
  2017-11-03 14:15:56.860 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Update host state with aggregates: [] _locked_update /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:175
  2017-11-03 14:15:56.860 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Update host state with service dict: {'binary': u'nova-compute', 'uuid': '9955ccab-5bc6-4153-b73b-9df65bf10df4', 'deleted': False, 'created_at': datetime.datetime(2017, 10, 25, 2, 48, tzinfo=<iso8601.Utc>), 'updated_at': datetime.datetime(2017, 11, 3, 6, 15, 52, tzinfo=<iso8601.Utc>), 'report_count': 78841, 'topic': u'compute', 'host': u'computer1', 'version': 22, 'disabled': False, 'forced_down': False, 'last_seen_up': datetime.datetime(2017, 11, 3, 6, 15, 52, tzinfo=<iso8601.Utc>), 'deleted_at': None, 'disabled_reason': None, 'id': 39} _locked_update /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:178
  2017-11-03 14:15:56.861 131332 DEBUG nova.scheduler.host_manager [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Update host state with instances: {} _locked_update /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:181
  2017-11-03 14:15:56.861 131332 DEBUG oslo_concurrency.lockutils [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Lock "(u'computer1', u'computer1')" released by "nova.scheduler.host_manager._locked_update" :: held 0.004s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:282
  2017-11-03 14:15:56.861 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Starting with 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:70
  2017-11-03 14:15:56.866 131332 DEBUG nova.scheduler.filters.retry_filter [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Re-scheduling is disabled host_passes /usr/lib/python2.7/site-packages/nova/scheduler/filters/retry_filter.py:34
  2017-11-03 14:15:56.866 131332 DEBUG nova.scheduler.filters.retry_filter [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Re-scheduling is disabled host_passes /usr/lib/python2.7/site-packages/nova/scheduler/filters/retry_filter.py:34
  2017-11-03 14:15:56.866 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter RetryFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
  2017-11-03 14:15:56.867 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter AvailabilityZoneFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
  2017-11-03 14:15:56.867 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter ComputeFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
  2017-11-03 14:15:56.868 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter ComputeCapabilitiesFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
  2017-11-03 14:15:56.868 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter ImagePropertiesFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
  2017-11-03 14:15:56.869 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter PciPassthroughFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
  2017-11-03 14:15:56.875 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Attempting to fit instance cell InstanceNUMACell(cpu_pinning_raw=None,cpu_policy='dedicated',cpu_thread_policy=None,cpu_topology=<?>,cpuset=set([0]),cpuset_reserved=None,id=0,memory=128,pagesize=None) on host_cell NUMACell(cpu_usage=6,cpuset=set([0,2,4,6,8,10,12,14,16,18,20,22,24,26,28,30,32,34,36,38,40,42,44,46]),id=0,memory=65440,memory_usage=768,mempages=[NUMAPagesTopology,NUMAPagesTopology],pinned_cpus=set([0,16,2,28,44,18]),siblings=[set([4,28]),set([2,26]),set([20,44]),set([0,24]),set([18,42]),set([16,40]),set([22,46]),set([14,38]),set([12,36]),set([8,32]),set([6,30]),set([10,34])]) _numa_fit_instance_cell /usr/lib/python2.7/site-packages/nova/virt/hardware.py:981
  2017-11-03 14:15:56.876 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Pinning has been requested _numa_fit_instance_cell /usr/lib/python2.7/site-packages/nova/virt/hardware.py:1001
  2017-11-03 14:15:56.877 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Using thread siblings for packing _numa_fit_instance_cell_with_pinning /usr/lib/python2.7/site-packages/nova/virt/hardware.py:937
  2017-11-03 14:15:56.877 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Packing an instance onto a set of siblings:     available_siblings: [CoercedSet([4]), CoercedSet([26]), CoercedSet([20]), CoercedSet([24]), CoercedSet([42]), CoercedSet([40]), CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])]    instance_cell: InstanceNUMACell(cpu_pinning_raw=None,cpu_policy='dedicated',cpu_thread_policy=None,cpu_topology=<?>,cpuset=set([0]),cpuset_reserved=None,id=0,memory=128,pagesize=None)    host_cell_id: 0    threads_per_core: 2 _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:696
  2017-11-03 14:15:56.878 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Built sibling_sets: defaultdict(<type 'list'>, {1: [CoercedSet([4]), CoercedSet([26]), CoercedSet([20]), CoercedSet([24]), CoercedSet([42]), CoercedSet([40]), CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])], 2: [CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])]}) _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:705
  2017-11-03 14:15:56.878 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] User did not specify a thread policy. Using default for 1 cores _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:836
  2017-11-03 14:15:56.879 131332 INFO nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Computed NUMA topology CPU pinning: usable pCPUs: [[46, 22], [38, 14], [36, 12], [8, 32], [30, 6], [10, 34]], vCPUs mapping: [(0, 46)]
  2017-11-03 14:15:56.879 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Selected cores for pinning: [(0, 46)], in cell 0 _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:891
  2017-11-03 14:15:56.886 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Attempting to fit instance cell InstanceNUMACell(cpu_pinning_raw=None,cpu_policy='dedicated',cpu_thread_policy=None,cpu_topology=<?>,cpuset=set([0]),cpuset_reserved=None,id=0,memory=128,pagesize=None) on host_cell NUMACell(cpu_usage=0,cpuset=set([0,2,4,6,8,10,12,14,16,18,20,22,24,26,28,30,32,34,36,38,40,42,44,46]),id=0,memory=65440,memory_usage=0,mempages=[NUMAPagesTopology,NUMAPagesTopology],pinned_cpus=set([]),siblings=[set([4,28]),set([2,26]),set([20,44]),set([0,24]),set([18,42]),set([16,40]),set([22,46]),set([14,38]),set([12,36]),set([8,32]),set([6,30]),set([10,34])]) _numa_fit_instance_cell /usr/lib/python2.7/site-packages/nova/virt/hardware.py:981
  2017-11-03 14:15:56.887 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Pinning has been requested _numa_fit_instance_cell /usr/lib/python2.7/site-packages/nova/virt/hardware.py:1001
  2017-11-03 14:15:56.887 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Using thread siblings for packing _numa_fit_instance_cell_with_pinning /usr/lib/python2.7/site-packages/nova/virt/hardware.py:937
  2017-11-03 14:15:56.888 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Packing an instance onto a set of siblings:     available_siblings: [CoercedSet([28, 4]), CoercedSet([2, 26]), CoercedSet([44, 20]), CoercedSet([0, 24]), CoercedSet([18, 42]), CoercedSet([16, 40]), CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])]    instance_cell: InstanceNUMACell(cpu_pinning_raw=None,cpu_policy='dedicated',cpu_thread_policy=None,cpu_topology=<?>,cpuset=set([0]),cpuset_reserved=None,id=0,memory=128,pagesize=None)    host_cell_id: 0    threads_per_core: 2 _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:696
  2017-11-03 14:15:56.889 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Built sibling_sets: defaultdict(<type 'list'>, {1: [CoercedSet([28, 4]), CoercedSet([2, 26]), CoercedSet([44, 20]), CoercedSet([0, 24]), CoercedSet([18, 42]), CoercedSet([16, 40]), CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])], 2: [CoercedSet([28, 4]), CoercedSet([2, 26]), CoercedSet([44, 20]), CoercedSet([0, 24]), CoercedSet([18, 42]), CoercedSet([16, 40]), CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])]}) _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:705
  2017-11-03 14:15:56.889 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] User did not specify a thread policy. Using default for 1 cores _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:836
  2017-11-03 14:15:56.890 131332 INFO nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Computed NUMA topology CPU pinning: usable pCPUs: [[28, 4], [2, 26], [44, 20], [0, 24], [18, 42], [16, 40], [46, 22], [38, 14], [36, 12], [8, 32], [30, 6], [10, 34]], vCPUs mapping: [(0, 28)]
  2017-11-03 14:15:56.890 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Selected cores for pinning: [(0, 28)], in cell 0 _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:891
  2017-11-03 14:15:56.891 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter NUMATopologyFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
  2017-11-03 14:15:56.891 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter AggregateCoreFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
  2017-11-03 14:15:56.891 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter AggregateDiskFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
  2017-11-03 14:15:56.892 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter AggregateRamFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
  2017-11-03 14:15:56.892 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter ServerGroupAntiAffinityFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
  2017-11-03 14:15:56.893 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter ServerGroupAffinityFilter returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
  2017-11-03 14:15:56.893 131332 DEBUG nova.filters [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filter AggregateMultiTenancyIsolation returned 2 host(s) get_filtered_objects /usr/lib/python2.7/site-packages/nova/filters.py:104
  2017-11-03 14:15:56.894 131332 DEBUG nova.scheduler.filter_scheduler [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Filtered [(ctrl3, ctrl3) ram: 110201MB disk: 56320MB io_ops: 0 instances: 6, (computer1, computer1) ram: 127865MB disk: 87040MB io_ops: 0 instances: 0] _get_sorted_hosts /usr/lib/python2.7/site-packages/nova/scheduler/filter_scheduler.py:298
  2017-11-03 14:15:56.895 131332 DEBUG nova.scheduler.filter_scheduler [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Weighed [(computer1, computer1) ram: 127865MB disk: 87040MB io_ops: 0 instances: 0, (ctrl3, ctrl3) ram: 110201MB disk: 56320MB io_ops: 0 instances: 6] _get_sorted_hosts /usr/lib/python2.7/site-packages/nova/scheduler/filter_scheduler.py:308
  2017-11-03 14:15:56.895 131332 DEBUG nova.scheduler.filter_scheduler [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Attempting to claim resources in the placement API for instance 62ad226f-8848-455a-9e24-3b83443fc051 _claim_resources /usr/lib/python2.7/site-packages/nova/scheduler/filter_scheduler.py:270
  2017-11-03 14:15:57.144 131332 DEBUG nova.scheduler.client.report [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Doubling-up allocation request for move operation. _move_operation_alloc_request /usr/lib/python2.7/site-packages/nova/scheduler/client/report.py:162
  2017-11-03 14:15:57.145 131332 DEBUG nova.scheduler.client.report [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] New allocation request containing both source and destination hosts in move operation: {'allocations': [{'resource_provider': {'uuid': u'54cec566-8130-4ca5-b3e9-bbacdc52dd50'}, 'resources': {u'VCPU': 6, u'MEMORY_MB': 768}}, {'resource_provider': {'uuid': u'ae5d2eae-9f7d-4b23-87fd-2503f9a0fc65'}, 'resources': {u'VCPU': 1, u'MEMORY_MB': 128}}]} _move_operation_alloc_request /usr/lib/python2.7/site-packages/nova/scheduler/client/report.py:202
  2017-11-03 14:15:57.317 131332 DEBUG nova.scheduler.filter_scheduler [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Selected host: (computer1, computer1) ram: 127865MB disk: 87040MB io_ops: 0 instances: 0 _schedule /usr/lib/python2.7/site-packages/nova/scheduler/filter_scheduler.py:227
  2017-11-03 14:15:57.318 131332 DEBUG oslo_concurrency.lockutils [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Lock "(u'computer1', u'computer1')" acquired by "nova.scheduler.host_manager._locked" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:270
  2017-11-03 14:15:57.320 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Attempting to fit instance cell InstanceNUMACell(cpu_pinning_raw=None,cpu_policy='dedicated',cpu_thread_policy=None,cpu_topology=<?>,cpuset=set([0]),cpuset_reserved=None,id=0,memory=128,pagesize=None) on host_cell NUMACell(cpu_usage=0,cpuset=set([0,2,4,6,8,10,12,14,16,18,20,22,24,26,28,30,32,34,36,38,40,42,44,46]),id=0,memory=65440,memory_usage=0,mempages=[NUMAPagesTopology,NUMAPagesTopology],pinned_cpus=set([]),siblings=[set([4,28]),set([2,26]),set([20,44]),set([0,24]),set([18,42]),set([16,40]),set([22,46]),set([14,38]),set([12,36]),set([8,32]),set([6,30]),set([10,34])]) _numa_fit_instance_cell /usr/lib/python2.7/site-packages/nova/virt/hardware.py:981
  2017-11-03 14:15:57.321 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Pinning has been requested _numa_fit_instance_cell /usr/lib/python2.7/site-packages/nova/virt/hardware.py:1001
  2017-11-03 14:15:57.321 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Using thread siblings for packing _numa_fit_instance_cell_with_pinning /usr/lib/python2.7/site-packages/nova/virt/hardware.py:937
  2017-11-03 14:15:57.322 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Packing an instance onto a set of siblings:     available_siblings: [CoercedSet([28, 4]), CoercedSet([2, 26]), CoercedSet([44, 20]), CoercedSet([0, 24]), CoercedSet([18, 42]), CoercedSet([16, 40]), CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])]    instance_cell: InstanceNUMACell(cpu_pinning_raw=None,cpu_policy='dedicated',cpu_thread_policy=None,cpu_topology=<?>,cpuset=set([0]),cpuset_reserved=None,id=0,memory=128,pagesize=None)    host_cell_id: 0    threads_per_core: 2 _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:696
  2017-11-03 14:15:57.323 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Built sibling_sets: defaultdict(<type 'list'>, {1: [CoercedSet([28, 4]), CoercedSet([2, 26]), CoercedSet([44, 20]), CoercedSet([0, 24]), CoercedSet([18, 42]), CoercedSet([16, 40]), CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])], 2: [CoercedSet([28, 4]), CoercedSet([2, 26]), CoercedSet([44, 20]), CoercedSet([0, 24]), CoercedSet([18, 42]), CoercedSet([16, 40]), CoercedSet([46, 22]), CoercedSet([38, 14]), CoercedSet([36, 12]), CoercedSet([8, 32]), CoercedSet([30, 6]), CoercedSet([10, 34])]}) _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:705
  2017-11-03 14:15:57.323 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] User did not specify a thread policy. Using default for 1 cores _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:836
  2017-11-03 14:15:57.324 131332 INFO nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Computed NUMA topology CPU pinning: usable pCPUs: [[28, 4], [2, 26], [44, 20], [0, 24], [18, 42], [16, 40], [46, 22], [38, 14], [36, 12], [8, 32], [30, 6], [10, 34]], vCPUs mapping: [(0, 28)]
  2017-11-03 14:15:57.324 131332 DEBUG nova.virt.hardware [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Selected cores for pinning: [(0, 28)], in cell 0 _pack_instance_onto_cores /usr/lib/python2.7/site-packages/nova/virt/hardware.py:891
  2017-11-03 14:15:57.328 131332 DEBUG oslo_concurrency.lockutils [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] Lock "(u'computer1', u'computer1')" released by "nova.scheduler.host_manager._locked" :: held 0.010s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:282
  2017-11-03 14:15:57.328 131332 DEBUG nova.scheduler.filter_scheduler [req-6ae8da3f-424a-42a8-abc0-296ad831af22 6c493f80a87f4a17be8681f580f2fa48 0c1f9446e0bd4b70bce91cb5a69673f7 - default default] There are 1 hosts available but 5 instances requested to build. select_destinations /usr/lib/python2.7/site-packages/nova/scheduler/filter_scheduler.py:101

To manage notifications about this bug go to:
https://bugs.launchpad.net/nova/+bug/1729780/+subscriptions
Follow ups

[Bug 1729780] Re: migrate/live-migrate instance, no vailid host selected.
From: Matt Riedemann, 2017-11-03