** Also affects: nova/stein Importance: Undecided Status: New ** Also affects: nova/rocky Importance: Undecided Status: New
** Also affects: nova/train Importance: Undecided Status: New ** Changed in: nova/train Status: New => Fix Released ** Changed in: nova/train Importance: Undecided => Low ** Changed in: nova/rocky Status: New => Confirmed ** Changed in: nova/rocky Importance: Undecided => Low ** Changed in: nova/stein Importance: Undecided => Low -- 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/1783565 Title: ServerGroupTestV21.test_evacuate_with_anti_affinity_no_valid_host intermittently fails with "Instance compute service state on host2 expected to be down, but it was up." Status in OpenStack Compute (nova): Fix Released Status in OpenStack Compute (nova) rocky series: Confirmed Status in OpenStack Compute (nova) stein series: New Status in OpenStack Compute (nova) train series: Fix Released Bug description: http://logs.openstack.org/32/584032/5/check/nova-tox-functional- py35/7061ec1/job-output.txt.gz#_2018-07-25_03_16_46_462415 18-07-25 03:16:46.418499 | ubuntu-xenial | {5} nova.tests.functional.test_server_group.ServerGroupTestV21.test_evacuate_with_anti_affinity_no_valid_host [14.070214s] ... FAILED 2018-07-25 03:16:46.418582 | ubuntu-xenial | 2018-07-25 03:16:46.418645 | ubuntu-xenial | Captured traceback: 2018-07-25 03:16:46.418705 | ubuntu-xenial | ~~~~~~~~~~~~~~~~~~~ 2018-07-25 03:16:46.418798 | ubuntu-xenial | b'Traceback (most recent call last):' 2018-07-25 03:16:46.419095 | ubuntu-xenial | b' File "/home/zuul/src/git.openstack.org/openstack/nova/nova/tests/functional/test_server_group.py", line 456, in test_evacuate_with_anti_affinity_no_valid_host' 2018-07-25 03:16:46.419232 | ubuntu-xenial | b" self.admin_api.post_server_action(servers[1]['id'], post)" 2018-07-25 03:16:46.419471 | ubuntu-xenial | b' File "/home/zuul/src/git.openstack.org/openstack/nova/nova/tests/functional/api/client.py", line 294, in post_server_action' 2018-07-25 03:16:46.419602 | ubuntu-xenial | b" '/servers/%s/action' % server_id, data, **kwargs).body" 2018-07-25 03:16:46.419841 | ubuntu-xenial | b' File "/home/zuul/src/git.openstack.org/openstack/nova/nova/tests/functional/api/client.py", line 235, in api_post' 2018-07-25 03:16:46.419975 | ubuntu-xenial | b' return APIResponse(self.api_request(relative_uri, **kwargs))' 2018-07-25 03:16:46.420187 | ubuntu-xenial | b' File "/home/zuul/src/git.openstack.org/openstack/nova/nova/tests/functional/api/client.py", line 213, in api_request' 2018-07-25 03:16:46.420263 | ubuntu-xenial | b' response=response)' 2018-07-25 03:16:46.420545 | ubuntu-xenial | b'nova.tests.functional.api.client.OpenStackApiException: Unexpected status code: {"badRequest": {"message": "Compute service of host2 is still in use.", "code": 400}}' 2018-07-25 03:16:46.420581 | ubuntu-xenial | b'' 2018-07-25 03:16:46.420606 | ubuntu-xenial | 2018-07-25 03:16:46.420654 | ubuntu-xenial | Captured stderr: 2018-07-25 03:16:46.420702 | ubuntu-xenial | ~~~~~~~~~~~~~~~~ 2018-07-25 03:16:46.421102 | ubuntu-xenial | b'/home/zuul/src/git.openstack.org/openstack/nova/.tox/functional-py35/lib/python3.5/site-packages/oslo_db/sqlalchemy/enginefacade.py:350: OsloDBDeprecationWarning: EngineFacade is deprecated; please use oslo_db.sqlalchemy.enginefacade' 2018-07-25 03:16:46.421240 | ubuntu-xenial | b' self._legacy_facade = LegacyEngineFacade(None, _factory=self)' 2018-07-25 03:16:46.421623 | ubuntu-xenial | b'/home/zuul/src/git.openstack.org/openstack/nova/.tox/functional-py35/lib/python3.5/site-packages/oslo_db/sqlalchemy/enginefacade.py:350: OsloDBDeprecationWarning: EngineFacade is deprecated; please use oslo_db.sqlalchemy.enginefacade' 2018-07-25 03:16:46.421751 | ubuntu-xenial | b' self._legacy_facade = LegacyEngineFacade(None, _factory=self)' 2018-07-25 03:16:46.422054 | ubuntu-xenial | b"/home/zuul/src/git.openstack.org/openstack/nova/nova/test.py:323: DeprecationWarning: Using class 'MoxStubout' (either directly or via inheritance) is deprecated in version '3.5.0'" 2018-07-25 03:16:46.422174 | ubuntu-xenial | b' mox_fixture = self.useFixture(moxstubout.MoxStubout())' 2018-07-25 03:16:46.422537 | ubuntu-xenial | b'/home/zuul/src/git.openstack.org/openstack/nova/.tox/functional-py35/lib/python3.5/site-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated. Call .resolve and .require separately.' 2018-07-25 03:16:46.422664 | ubuntu-xenial | b' return pkg_resources.EntryPoint.parse("x=" + s).load(False)' 2018-07-25 03:16:46.422928 | ubuntu-xenial | b"/home/zuul/src/git.openstack.org/openstack/nova/nova/db/sqlalchemy/api.py:205: DeprecationWarning: Property 'async_compat' has moved to 'function.async_'" 2018-07-25 03:16:46.423038 | ubuntu-xenial | b' reader_mode = get_context_manager(context).async' 2018-07-25 03:16:46.423301 | ubuntu-xenial | b"/home/zuul/src/git.openstack.org/openstack/nova/nova/db/sqlalchemy/api.py:205: DeprecationWarning: Property 'async_compat' has moved to 'function.async_'" 2018-07-25 03:16:46.423418 | ubuntu-xenial | b' reader_mode = get_context_manager(context).async' 2018-07-25 03:16:46.423455 | ubuntu-xenial | b'' 2018-07-25 03:16:46.423479 | ubuntu-xenial | 2018-07-25 03:16:46.423537 | ubuntu-xenial | Captured pythonlogging: 2018-07-25 03:16:46.423595 | ubuntu-xenial | ~~~~~~~~~~~~~~~~~~~~~~~ 2018-07-25 03:16:46.430983 | ubuntu-xenial | b"2018-07-25 03:16:32,525 INFO [nova.api.openstack.placement.objects.resource_provider] Synced traits from os_traits into API DB: {'HW_GPU_API_OPENCL_V1_1', 'HW_GPU_API_DIRECTX_V12', 'HW_CPU_X86_AVX512PF', 'HW_GPU_API_DIRECT3D_V11_1', 'HW_CPU_X86_BMI', 'HW_GPU_RESOLUTION_W1280H800', 'HW_GPU_API_CUDA_V2_0', 'HW_GPU_RESOLUTION_W1280H720', 'HW_CPU_X86_MMX', 'COMPUTE_VOLUME_EXTEND', 'HW_GPU_API_CUDA_V1_2', 'HW_NIC_OFFLOAD_FDF', 'HW_CPU_AARCH64_SHA512', 'HW_CPU_AARCH64_ATOMICS', 'HW_GPU_RESOLUTION_W1680H1050', 'HW_GPU_RESOLUTION_W7680H4320', 'HW_NIC_OFFLOAD_LRO', 'HW_CPU_AARCH64_CPUID', 'HW_GPU_API_DIRECT3D_V10_0', 'HW_CPU_X86_FMA3', 'HW_CPU_X86_ASF', 'HW_GPU_API_CUDA_V5_0', 'HW_CPU_X86_AVX', 'COMPUTE_VOLUME_ATTACH_WITH_TAG', 'COMPUTE_NET_ATTACH_INTERFACE_WITH_TAG', 'HW_CPU_X86_AVX2', 'HW_CPU_X86_MPX', 'HW_GPU_API_CUDA_V1_0', 'HW_GPU_RESOLUTION_W1024H768', 'HW_NIC_OFFLOAD_GENEVE', 'HW_GPU_RESOLUTION_W320H240', 'HW_GPU_API_CUDA_V3_0', 'HW_GPU_API_OPENGL_V1_2', 'HW_CPU_X86_AESNI', 'HW_CPU_AARCH64_ASIMDDP', 'HW_GPU_RESOLUTION_W2560H1440', 'HW_CPU_AARCH64_DCPOP', 'HW_GPU_RESOLUTION_W1920H1200', 'HW_GPU_RESOLUTION_W3840H2160', 'HW_CPU_X86_TSX', 'HW_GPU_API_CUDA_V3_5', 'HW_NIC_OFFLOAD_QINQ', 'HW_CPU_X86_BMI2', 'HW_CPU_X86_SGX', 'HW_NIC_OFFLOAD_UCS', 'HW_GPU_API_OPENGL_V3_2', 'HW_CPU_AARCH64_JSCVT', 'HW_GPU_MAX_DISPLAY_HEADS_4', 'HW_CPU_X86_SSE42', 'HW_NIC_ACCEL_DEFLATE', 'HW_GPU_API_OPENGL_V4_5', 'HW_NIC_OFFLOAD_L2CRC', 'HW_NIC_SRIOV_TRUSTED', 'HW_CPU_HYPERTHREADING', 'HW_NIC_SRIOV_MULTIQUEUE', 'HW_GPU_API_DIRECT3D_V11_2', 'HW_GPU_API_OPENGL_V1_5', 'HW_GPU_API_OPENGL_V2_1', 'HW_GPU_API_OPENGL_V1_4', 'HW_CPU_X86_SHA', 'HW_GPU_RESOLUTION_W1280H1024', 'HW_NIC_ACCEL_LZS', 'HW_GPU_RESOLUTION_W1360H768', 'HW_NIC_ACCEL_TLS', 'HW_CPU_AARCH64_SM4', 'HW_GPU_API_OPENCL_V2_2', 'COMPUTE_VOLUME_MULTI_ATTACH', 'HW_GPU_RESOLUTION_W1024H600', 'HW_GPU_API_CUDA_V5_3', 'HW_NIC_OFFLOAD_TSO', 'HW_CPU_AARCH64_SM3', 'HW_CPU_X86_XOP', 'HW_GPU_RESOLUTION_W1152H864', 'HW_NIC_MULTIQUEUE', 'HW_GPU_API_CUDA_V7_0', 'HW_GPU_API_DIRECT3D_V10_1', 'HW_NIC_OFFLOAD_GRE', 'HW_NIC_ACCEL_IPSEC', 'HW_GPU_API_DIRECT3D_V11_3', 'HW_CPU_X86_FMA4', 'HW_NIC_DCB_PFC', 'HW_CPU_X86_AVX512ER', 'HW_NIC_OFFLOAD_TXUDP', 'STORAGE_DISK_SSD', 'HW_NIC_OFFLOAD_RX', 'HW_GPU_API_DIRECT3D_V9_0C', 'HW_CPU_X86_SSE41', 'HW_NIC_OFFLOAD_GSO', 'HW_CPU_AARCH64_FPHP', 'HW_CPU_AARCH64_SHA2', 'HW_NIC_ACCEL_ECC', 'HW_GPU_MAX_DISPLAY_HEADS_6', 'HW_CPU_AARCH64_SVE', 'HW_CPU_AARCH64_AES', 'HW_GPU_RESOLUTION_W1920H1080', 'HW_CPU_X86_SSE4A', 'HW_CPU_X86_SVM', 'HW_GPU_MAX_DISPLAY_HEADS_8', 'HW_CPU_X86_SSE3', 'HW_NIC_OFFLOAD_VXLAN', 'HW_NIC_OFFLOAD_TX', 'HW_CPU_AARCH64_ASIMD', 'HW_NIC_OFFLOAD_TCS', 'HW_GPU_API_CUDA_V6_2', 'HW_GPU_API_DIRECT3D_V9_0L', 'HW_CPU_X86_AVX512VL', 'HW_GPU_API_CUDA_V3_7', 'HW_NIC_DCB_ETS', 'HW_CPU_AARCH64_FCMA', 'HW_GPU_API_CUDA_V6_1', 'HW_GPU_API_DIRECT3D_V6_0', 'HW_GPU_RESOLUTION_W1600H1200', 'HW_NIC_ACCEL_SSL', 'HW_GPU_API_DIRECT3D_V12_0', 'HW_GPU_API_OPENCL_V1_0', 'HW_GPU_API_CUDA_V1_3', 'HW_NIC_SRIOV_QOS_RX', 'HW_GPU_API_DIRECT3D_V9_0B', 'HW_NIC_OFFLOAD_RXHASH', 'COMPUTE_TRUSTED_CERTS', 'HW_GPU_API_CUDA_V7_1', 'HW_GPU_API_CUDA_V1_1', 'HW_GPU_API_DIRECT3D_V9_0', 'HW_GPU_RESOLUTION_W1366H768', 'HW_NIC_ACCEL_DIFFIEH', 'HW_NIC_OFFLOAD_RXVLAN', 'HW_CPU_X86_3DNOW', 'HW_GPU_API_OPENGL_V1_3', 'HW_GPU_RESOLUTION_W1600H900', 'HW_GPU_API_OPENGL_V3_3', 'HW_GPU_API_CUDA_V3_2', 'HW_NIC_DCB_QCN', 'HW_GPU_API_CUDA_V2_1', 'HW_GPU_API_DXVA', 'HW_GPU_API_DIRECTX_V10', 'HW_NIC_OFFLOAD_LSO', 'HW_CPU_AARCH64_PMULL', 'HW_GPU_API_OPENGL_V1_1', 'HW_NIC_OFFLOAD_GRO', 'HW_GPU_API_DIRECT3D_V8_1', 'HW_GPU_API_DIRECT2D', 'HW_GPU_MAX_DISPLAY_HEADS_2', 'HW_GPU_API_OPENGL_V4_2', 'HW_NIC_OFFLOAD_UFO', 'HW_GPU_API_OPENGL_V3_1', 'HW_CPU_AARCH64_LRCPC', 'COMPUTE_DEVICE_TAGGING', 'HW_CPU_AARCH64_EVTSTRM', 'HW_CPU_AARCH64_ASIMDHP', 'HW_GPU_API_DIRECT3D_V7_0', 'HW_CPU_X86_SSSE3', 'HW_CPU_AARCH64_FP', 'HW_GPU_API_OPENGL_V4_4', 'HW_GPU_API_DIRECTX_V11', 'STORAGE_DISK_HDD', 'HW_CPU_AARCH64_ASIMDRDM', 'HW_NIC_OFFLOAD_TXVLAN', 'HW_GPU_API_OPENCL_V1_2', 'HW_GPU_API_OPENCL_V2_0', 'COMPUTE_VOLUME_ATTACH', 'HW_CPU_X86_AVX512DQ', 'HW_NIC_OFFLOAD_SG', 'HW_CPU_X86_SSE', 'HW_NIC_SRIOV', 'COMPUTE_NET_ATTACH_INTERFACE', 'HW_CPU_X86_VMX', 'HW_NIC_OFFLOAD_RDMA', 'HW_GPU_API_OPENGL_V4_0', 'HW_CPU_X86_AVX512BW', 'HW_GPU_API_DIRECT3D_V8_0', 'HW_NIC_VMDQ', 'HW_GPU_RESOLUTION_W1440H900', 'HW_GPU_API_OPENGL_V3_0', 'HW_NIC_SRIOV_QOS_TX', 'HW_NIC_OFFLOAD_SCS', 'HW_CPU_X86_AVX512CD', 'HW_GPU_API_OPENGL_V2_0', 'HW_CPU_X86_ABM', 'HW_CPU_AARCH64_SHA1', 'HW_GPU_API_OPENGL_V4_1', 'HW_GPU_RESOLUTION_W800H600', 'HW_CPU_X86_CLMUL', 'MISC_SHARES_VIA_AGGREGATE', 'HW_GPU_API_OPENCL_V2_1', 'HW_CPU_AARCH64_CRC32', 'HW_GPU_RESOLUTION_W2560H1600', 'HW_CPU_AARCH64_SHA3', 'HW_CPU_X86_AVX512F', 'HW_GPU_API_VULKAN', 'HW_GPU_API_OPENGL_V4_3', 'HW_GPU_RESOLUTION_W640H480', 'HW_NIC_PROGRAMMABLE_PIPELINE', 'HW_GPU_RESOLUTION_W1280H768', 'HW_NIC_OFFLOAD_SWITCHDEV', 'HW_CPU_X86_F16C', 'HW_CPU_X86_SSE2', 'HW_NIC_ACCEL_RSA', 'HW_GPU_API_CUDA_V5_2', 'HW_GPU_API_DIRECT3D_V11_0', 'HW_GPU_API_CUDA_V6_0', 'HW_GPU_MAX_DISPLAY_HEADS_1', 'HW_CPU_X86_TBM'}" 2018-07-25 03:16:46.431146 | ubuntu-xenial | b'2018-07-25 03:16:33,359 INFO [nova.service] Starting conductor node (version 18.0.0)' 2018-07-25 03:16:46.431313 | ubuntu-xenial | b'2018-07-25 03:16:33,375 INFO [nova.service] Starting scheduler node (version 18.0.0)' 2018-07-25 03:16:46.431461 | ubuntu-xenial | b'2018-07-25 03:16:33,395 INFO [nova.service] Starting compute node (version 18.0.0)' 2018-07-25 03:16:46.431777 | ubuntu-xenial | b'2018-07-25 03:16:33,418 WARNING [nova.compute.manager] No compute node record found for host compute. If this is the first time this service is starting on this host, then you can ignore this warning.' 2018-07-25 03:16:46.432052 | ubuntu-xenial | b'2018-07-25 03:16:33,419 WARNING [nova.compute.monitors] Excluding nova.compute.monitors.cpu monitor virt_driver. Not in the list of enabled monitors (CONF.compute_monitors).' 2018-07-25 03:16:46.432239 | ubuntu-xenial | b'2018-07-25 03:16:33,424 WARNING [nova.compute.resource_tracker] No compute node record for compute:compute' 2018-07-25 03:16:46.432494 | ubuntu-xenial | b'2018-07-25 03:16:33,428 INFO [nova.compute.resource_tracker] Compute node record created for compute:compute with uuid: ca8ac9a6-aea5-428c-87cf-a75fc747e966' 2018-07-25 03:16:46.432814 | ubuntu-xenial | b'2018-07-25 03:16:33,449 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers?in_tree=ca8ac9a6-aea5-428c-87cf-a75fc747e966" status: 200 len: 26 microversion: 1.14' 2018-07-25 03:16:46.433066 | ubuntu-xenial | b'2018-07-25 03:16:33,456 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "POST /placement/resource_providers" status: 200 len: 830 microversion: 1.20' 2018-07-25 03:16:46.433428 | ubuntu-xenial | b'2018-07-25 03:16:33,457 INFO [nova.scheduler.client.report] [req-8dc3699e-cff1-4683-b5d3-23ff88893518] Created resource provider record via placement API for resource provider with UUID ca8ac9a6-aea5-428c-87cf-a75fc747e966 and name compute.' 2018-07-25 03:16:46.433738 | ubuntu-xenial | b'2018-07-25 03:16:33,465 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/inventories" status: 200 len: 54 microversion: 1.0' 2018-07-25 03:16:46.434046 | ubuntu-xenial | b'2018-07-25 03:16:33,475 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers?in_tree=ca8ac9a6-aea5-428c-87cf-a75fc747e966" status: 200 len: 856 microversion: 1.14' 2018-07-25 03:16:46.434356 | ubuntu-xenial | b'2018-07-25 03:16:33,483 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/inventories" status: 200 len: 54 microversion: 1.0' 2018-07-25 03:16:46.434666 | ubuntu-xenial | b'2018-07-25 03:16:33,491 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/aggregates" status: 200 len: 53 microversion: 1.19' 2018-07-25 03:16:46.434981 | ubuntu-xenial | b'2018-07-25 03:16:33,500 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/traits" status: 200 len: 49 microversion: 1.6' 2018-07-25 03:16:46.435301 | ubuntu-xenial | b'2018-07-25 03:16:33,508 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/inventories" status: 200 len: 54 microversion: 1.0' 2018-07-25 03:16:46.435615 | ubuntu-xenial | b'2018-07-25 03:16:33,520 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "PUT /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.435933 | ubuntu-xenial | b'2018-07-25 03:16:33,548 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/allocations" status: 200 len: 54 microversion: 1.0' 2018-07-25 03:16:46.436242 | ubuntu-xenial | b'2018-07-25 03:16:33,549 INFO [nova.compute.resource_tracker] Final resource view: name=compute phys_ram=8192MB used_ram=512MB phys_disk=100000GB used_disk=0GB total_vcpus=1000 used_vcpus=0 pci_stats=[]' 2018-07-25 03:16:46.436550 | ubuntu-xenial | b'2018-07-25 03:16:33,565 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers?in_tree=ca8ac9a6-aea5-428c-87cf-a75fc747e966" status: 200 len: 856 microversion: 1.14' 2018-07-25 03:16:46.436875 | ubuntu-xenial | b'2018-07-25 03:16:33,574 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.437189 | ubuntu-xenial | b'2018-07-25 03:16:33,581 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/aggregates" status: 200 len: 53 microversion: 1.19' 2018-07-25 03:16:46.437493 | ubuntu-xenial | b'2018-07-25 03:16:33,589 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/traits" status: 200 len: 49 microversion: 1.6' 2018-07-25 03:16:46.437805 | ubuntu-xenial | b'2018-07-25 03:16:33,597 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.438113 | ubuntu-xenial | b'2018-07-25 03:16:33,606 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers?in_tree=ca8ac9a6-aea5-428c-87cf-a75fc747e966" status: 200 len: 856 microversion: 1.14' 2018-07-25 03:16:46.438424 | ubuntu-xenial | b'2018-07-25 03:16:33,614 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.438734 | ubuntu-xenial | b'2018-07-25 03:16:33,621 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/aggregates" status: 200 len: 53 microversion: 1.19' 2018-07-25 03:16:46.439038 | ubuntu-xenial | b'2018-07-25 03:16:33,629 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/traits" status: 200 len: 49 microversion: 1.6' 2018-07-25 03:16:46.439354 | ubuntu-xenial | b'2018-07-25 03:16:33,637 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.439497 | ubuntu-xenial | b'2018-07-25 03:16:33,644 INFO [nova.service] Starting compute node (version 18.0.0)' 2018-07-25 03:16:46.439820 | ubuntu-xenial | b'2018-07-25 03:16:33,663 WARNING [nova.compute.manager] No compute node record found for host host2. If this is the first time this service is starting on this host, then you can ignore this warning.' 2018-07-25 03:16:46.440083 | ubuntu-xenial | b'2018-07-25 03:16:33,663 WARNING [nova.compute.monitors] Excluding nova.compute.monitors.cpu monitor virt_driver. Not in the list of enabled monitors (CONF.compute_monitors).' 2018-07-25 03:16:46.440256 | ubuntu-xenial | b'2018-07-25 03:16:33,667 WARNING [nova.compute.resource_tracker] No compute node record for host2:host2' 2018-07-25 03:16:46.440490 | ubuntu-xenial | b'2018-07-25 03:16:33,669 INFO [nova.compute.resource_tracker] Compute node record created for host2:host2 with uuid: ce292de2-7246-4887-a977-0fac6035abd3' 2018-07-25 03:16:46.440799 | ubuntu-xenial | b'2018-07-25 03:16:33,687 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers?in_tree=ce292de2-7246-4887-a977-0fac6035abd3" status: 200 len: 26 microversion: 1.14' 2018-07-25 03:16:46.441043 | ubuntu-xenial | b'2018-07-25 03:16:33,693 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "POST /placement/resource_providers" status: 200 len: 828 microversion: 1.20' 2018-07-25 03:16:46.441390 | ubuntu-xenial | b'2018-07-25 03:16:33,694 INFO [nova.scheduler.client.report] [req-aeb70f5b-ad61-4dea-a04e-ba21055db31e] Created resource provider record via placement API for resource provider with UUID ce292de2-7246-4887-a977-0fac6035abd3 and name host2.' 2018-07-25 03:16:46.441691 | ubuntu-xenial | b'2018-07-25 03:16:33,701 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/inventories" status: 200 len: 54 microversion: 1.0' 2018-07-25 03:16:46.441988 | ubuntu-xenial | b'2018-07-25 03:16:33,711 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers?in_tree=ce292de2-7246-4887-a977-0fac6035abd3" status: 200 len: 854 microversion: 1.14' 2018-07-25 03:16:46.442288 | ubuntu-xenial | b'2018-07-25 03:16:33,718 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/inventories" status: 200 len: 54 microversion: 1.0' 2018-07-25 03:16:46.442588 | ubuntu-xenial | b'2018-07-25 03:16:33,725 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/aggregates" status: 200 len: 53 microversion: 1.19' 2018-07-25 03:16:46.442881 | ubuntu-xenial | b'2018-07-25 03:16:33,733 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/traits" status: 200 len: 49 microversion: 1.6' 2018-07-25 03:16:46.443180 | ubuntu-xenial | b'2018-07-25 03:16:33,741 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/inventories" status: 200 len: 54 microversion: 1.0' 2018-07-25 03:16:46.443482 | ubuntu-xenial | b'2018-07-25 03:16:33,751 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "PUT /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.443788 | ubuntu-xenial | b'2018-07-25 03:16:33,775 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/allocations" status: 200 len: 54 microversion: 1.0' 2018-07-25 03:16:46.444086 | ubuntu-xenial | b'2018-07-25 03:16:33,776 INFO [nova.compute.resource_tracker] Final resource view: name=host2 phys_ram=8192MB used_ram=512MB phys_disk=100000GB used_disk=0GB total_vcpus=1000 used_vcpus=0 pci_stats=[]' 2018-07-25 03:16:46.444384 | ubuntu-xenial | b'2018-07-25 03:16:33,790 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers?in_tree=ce292de2-7246-4887-a977-0fac6035abd3" status: 200 len: 854 microversion: 1.14' 2018-07-25 03:16:46.444687 | ubuntu-xenial | b'2018-07-25 03:16:33,798 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.445006 | ubuntu-xenial | b'2018-07-25 03:16:33,805 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/aggregates" status: 200 len: 53 microversion: 1.19' 2018-07-25 03:16:46.445305 | ubuntu-xenial | b'2018-07-25 03:16:33,815 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/traits" status: 200 len: 49 microversion: 1.6' 2018-07-25 03:16:46.445614 | ubuntu-xenial | b'2018-07-25 03:16:33,823 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.445914 | ubuntu-xenial | b'2018-07-25 03:16:33,832 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers?in_tree=ce292de2-7246-4887-a977-0fac6035abd3" status: 200 len: 854 microversion: 1.14' 2018-07-25 03:16:46.446216 | ubuntu-xenial | b'2018-07-25 03:16:33,841 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.446516 | ubuntu-xenial | b'2018-07-25 03:16:33,848 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/aggregates" status: 200 len: 53 microversion: 1.19' 2018-07-25 03:16:46.446810 | ubuntu-xenial | b'2018-07-25 03:16:33,856 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/traits" status: 200 len: 49 microversion: 1.6' 2018-07-25 03:16:46.447112 | ubuntu-xenial | b'2018-07-25 03:16:33,865 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.447319 | ubuntu-xenial | b'2018-07-25 03:16:33,869 INFO [nova.api.openstack.requestlog] 127.0.0.1 "GET /v2.1" status: 204 len: 0 microversion: - time: 0.000340' 2018-07-25 03:16:46.447599 | ubuntu-xenial | b'2018-07-25 03:16:33,918 INFO [nova.api.openstack.requestlog] 127.0.0.1 "POST /v2.1/6f70656e737461636b20342065766572/os-server-groups" status: 200 len: 149 microversion: 2.1 time: 0.046089' 2018-07-25 03:16:46.447905 | ubuntu-xenial | b'2018-07-25 03:16:33,935 INFO [nova.api.openstack.requestlog] 127.0.0.1 "GET /v2.1/6f70656e737461636b20342065766572/flavors/detail" status: 200 len: 2747 microversion: 2.1 time: 0.013285' 2018-07-25 03:16:46.448176 | ubuntu-xenial | b'2018-07-25 03:16:34,087 INFO [nova.api.openstack.requestlog] 127.0.0.1 "POST /v2.1/6f70656e737461636b20342065766572/servers" status: 202 len: 480 microversion: 2.1 time: 0.149513' 2018-07-25 03:16:46.448384 | ubuntu-xenial | b'2018-07-25 03:16:34,091 INFO [nova.api.openstack.requestlog] 127.0.0.1 "GET /v2.1" status: 204 len: 0 microversion: - time: 0.000268' 2018-07-25 03:16:46.448701 | ubuntu-xenial | b'2018-07-25 03:16:34,138 INFO [nova.api.openstack.requestlog] 127.0.0.1 "GET /v2.1/6f70656e737461636b20342065766572/servers/a4ea99d1-9c31-41ab-9ce6-51cc749c0e43" status: 200 len: 1459 microversion: 2.1 time: 0.044532' 2018-07-25 03:16:46.449046 | ubuntu-xenial | b'2018-07-25 03:16:34,205 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/allocation_candidates?limit=1000&resources=DISK_GB%3A20%2CMEMORY_MB%3A2048%2CVCPU%3A1" status: 200 len: 701 microversion: 1.25' 2018-07-25 03:16:46.449326 | ubuntu-xenial | b'2018-07-25 03:16:34,239 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/allocations/a4ea99d1-9c31-41ab-9ce6-51cc749c0e43" status: 200 len: 19 microversion: 1.0' 2018-07-25 03:16:46.449603 | ubuntu-xenial | b'2018-07-25 03:16:34,267 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "PUT /placement/allocations/a4ea99d1-9c31-41ab-9ce6-51cc749c0e43" status: 204 len: 0 microversion: 1.25' 2018-07-25 03:16:46.449800 | ubuntu-xenial | b'2018-07-25 03:16:34,420 INFO [nova.compute.claims] Attempting claim on node compute: memory 2048 MB, disk 20 GB, vcpus 1 CPU' 2018-07-25 03:16:46.449949 | ubuntu-xenial | b'2018-07-25 03:16:34,420 INFO [nova.compute.claims] Total memory: 8192 MB, used: 512.00 MB' 2018-07-25 03:16:46.450115 | ubuntu-xenial | b'2018-07-25 03:16:34,420 INFO [nova.compute.claims] memory limit not specified, defaulting to unlimited' 2018-07-25 03:16:46.450260 | ubuntu-xenial | b'2018-07-25 03:16:34,420 INFO [nova.compute.claims] Total disk: 100000 GB, used: 0.00 GB' 2018-07-25 03:16:46.450423 | ubuntu-xenial | b'2018-07-25 03:16:34,420 INFO [nova.compute.claims] disk limit not specified, defaulting to unlimited' 2018-07-25 03:16:46.450578 | ubuntu-xenial | b'2018-07-25 03:16:34,421 INFO [nova.compute.claims] Total vcpu: 1000 VCPU, used: 0.00 VCPU' 2018-07-25 03:16:46.450743 | ubuntu-xenial | b'2018-07-25 03:16:34,421 INFO [nova.compute.claims] vcpu limit not specified, defaulting to unlimited' 2018-07-25 03:16:46.450884 | ubuntu-xenial | b'2018-07-25 03:16:34,421 INFO [nova.compute.claims] Claim successful on node compute' 2018-07-25 03:16:46.451181 | ubuntu-xenial | b'2018-07-25 03:16:34,491 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers?in_tree=ca8ac9a6-aea5-428c-87cf-a75fc747e966" status: 200 len: 856 microversion: 1.14' 2018-07-25 03:16:46.451482 | ubuntu-xenial | b'2018-07-25 03:16:34,500 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.451802 | ubuntu-xenial | b'2018-07-25 03:16:34,508 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/aggregates" status: 200 len: 53 microversion: 1.19' 2018-07-25 03:16:46.452117 | ubuntu-xenial | b'2018-07-25 03:16:34,517 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/traits" status: 200 len: 49 microversion: 1.6' 2018-07-25 03:16:46.452409 | ubuntu-xenial | b'2018-07-25 03:16:34,525 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.452695 | ubuntu-xenial | b'2018-07-25 03:16:34,534 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers?in_tree=ca8ac9a6-aea5-428c-87cf-a75fc747e966" status: 200 len: 856 microversion: 1.14' 2018-07-25 03:16:46.452998 | ubuntu-xenial | b'2018-07-25 03:16:34,542 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.453292 | ubuntu-xenial | b'2018-07-25 03:16:34,549 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/aggregates" status: 200 len: 53 microversion: 1.19' 2018-07-25 03:16:46.453576 | ubuntu-xenial | b'2018-07-25 03:16:34,557 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/traits" status: 200 len: 49 microversion: 1.6' 2018-07-25 03:16:46.453867 | ubuntu-xenial | b'2018-07-25 03:16:34,565 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ca8ac9a6-aea5-428c-87cf-a75fc747e966/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.454136 | ubuntu-xenial | b'2018-07-25 03:16:34,630 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/allocations/a4ea99d1-9c31-41ab-9ce6-51cc749c0e43" status: 200 len: 231 microversion: 1.28' 2018-07-25 03:16:46.454306 | ubuntu-xenial | b'2018-07-25 03:16:34,678 INFO [nova.compute.manager] Took 0.00 seconds to spawn the instance on the hypervisor.' 2018-07-25 03:16:46.454467 | ubuntu-xenial | b'2018-07-25 03:16:34,763 INFO [nova.compute.manager] Took 0.35 seconds to build instance.' 2018-07-25 03:16:46.454765 | ubuntu-xenial | b'2018-07-25 03:16:34,782 INFO [nova.api.openstack.requestlog] 127.0.0.1 "GET /v2.1/6f70656e737461636b20342065766572/servers/a4ea99d1-9c31-41ab-9ce6-51cc749c0e43" status: 200 len: 1561 microversion: 2.1 time: 0.111480' 2018-07-25 03:16:46.455029 | ubuntu-xenial | b'2018-07-25 03:16:34,801 INFO [nova.api.openstack.requestlog] 127.0.0.1 "GET /v2.1/6f70656e737461636b20342065766572/flavors/detail" status: 200 len: 2747 microversion: 2.1 time: 0.015703' 2018-07-25 03:16:46.455231 | ubuntu-xenial | b"2018-07-25 03:16:34,807 INFO [nova.scheduler.host_manager] Received an update from an unknown host 'compute'. Re-created its InstanceList." 2018-07-25 03:16:46.455494 | ubuntu-xenial | b'2018-07-25 03:16:34,988 INFO [nova.api.openstack.requestlog] 127.0.0.1 "POST /v2.1/6f70656e737461636b20342065766572/servers" status: 202 len: 480 microversion: 2.1 time: 0.183775' 2018-07-25 03:16:46.455828 | ubuntu-xenial | b'2018-07-25 03:16:35,010 INFO [nova.api.openstack.requestlog] 127.0.0.1 "GET /v2.1/6f70656e737461636b20342065766572/servers/18cdaa10-2ded-4f4a-85ba-d2747534dd5f" status: 200 len: 1459 microversion: 2.1 time: 0.019221' 2018-07-25 03:16:46.456146 | ubuntu-xenial | b'2018-07-25 03:16:35,130 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/allocation_candidates?limit=1000&resources=DISK_GB%3A20%2CMEMORY_MB%3A2048%2CVCPU%3A1" status: 200 len: 705 microversion: 1.25' 2018-07-25 03:16:46.456422 | ubuntu-xenial | b'2018-07-25 03:16:35,169 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/allocations/18cdaa10-2ded-4f4a-85ba-d2747534dd5f" status: 200 len: 19 microversion: 1.0' 2018-07-25 03:16:46.456679 | ubuntu-xenial | b'2018-07-25 03:16:35,189 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "PUT /placement/allocations/18cdaa10-2ded-4f4a-85ba-d2747534dd5f" status: 204 len: 0 microversion: 1.25' 2018-07-25 03:16:46.456872 | ubuntu-xenial | b'2018-07-25 03:16:35,339 INFO [nova.compute.claims] Attempting claim on node host2: memory 2048 MB, disk 20 GB, vcpus 1 CPU' 2018-07-25 03:16:46.457015 | ubuntu-xenial | b'2018-07-25 03:16:35,339 INFO [nova.compute.claims] Total memory: 8192 MB, used: 512.00 MB' 2018-07-25 03:16:46.457171 | ubuntu-xenial | b'2018-07-25 03:16:35,339 INFO [nova.compute.claims] memory limit not specified, defaulting to unlimited' 2018-07-25 03:16:46.457308 | ubuntu-xenial | b'2018-07-25 03:16:35,339 INFO [nova.compute.claims] Total disk: 100000 GB, used: 0.00 GB' 2018-07-25 03:16:46.457461 | ubuntu-xenial | b'2018-07-25 03:16:35,339 INFO [nova.compute.claims] disk limit not specified, defaulting to unlimited' 2018-07-25 03:16:46.457612 | ubuntu-xenial | b'2018-07-25 03:16:35,339 INFO [nova.compute.claims] Total vcpu: 1000 VCPU, used: 0.00 VCPU' 2018-07-25 03:16:46.457769 | ubuntu-xenial | b'2018-07-25 03:16:35,340 INFO [nova.compute.claims] vcpu limit not specified, defaulting to unlimited' 2018-07-25 03:16:46.457902 | ubuntu-xenial | b'2018-07-25 03:16:35,340 INFO [nova.compute.claims] Claim successful on node host2' 2018-07-25 03:16:46.458190 | ubuntu-xenial | b'2018-07-25 03:16:35,406 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers?in_tree=ce292de2-7246-4887-a977-0fac6035abd3" status: 200 len: 854 microversion: 1.14' 2018-07-25 03:16:46.458482 | ubuntu-xenial | b'2018-07-25 03:16:35,414 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.458771 | ubuntu-xenial | b'2018-07-25 03:16:35,421 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/aggregates" status: 200 len: 53 microversion: 1.19' 2018-07-25 03:16:46.459055 | ubuntu-xenial | b'2018-07-25 03:16:35,429 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/traits" status: 200 len: 49 microversion: 1.6' 2018-07-25 03:16:46.459346 | ubuntu-xenial | b'2018-07-25 03:16:35,437 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.459634 | ubuntu-xenial | b'2018-07-25 03:16:35,447 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers?in_tree=ce292de2-7246-4887-a977-0fac6035abd3" status: 200 len: 854 microversion: 1.14' 2018-07-25 03:16:46.459931 | ubuntu-xenial | b'2018-07-25 03:16:35,455 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.460223 | ubuntu-xenial | b'2018-07-25 03:16:35,462 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/aggregates" status: 200 len: 53 microversion: 1.19' 2018-07-25 03:16:46.460508 | ubuntu-xenial | b'2018-07-25 03:16:35,470 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/traits" status: 200 len: 49 microversion: 1.6' 2018-07-25 03:16:46.460817 | ubuntu-xenial | b'2018-07-25 03:16:35,478 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/resource_providers/ce292de2-7246-4887-a977-0fac6035abd3/inventories" status: 200 len: 414 microversion: 1.0' 2018-07-25 03:16:46.461090 | ubuntu-xenial | b'2018-07-25 03:16:35,583 INFO [nova.api.openstack.placement.requestlog] 127.0.0.1 "GET /placement/allocations/18cdaa10-2ded-4f4a-85ba-d2747534dd5f" status: 200 len: 231 microversion: 1.28' 2018-07-25 03:16:46.461396 | ubuntu-xenial | b'2018-07-25 03:16:35,631 INFO [nova.api.openstack.requestlog] 127.0.0.1 "GET /v2.1/6f70656e737461636b20342065766572/servers/18cdaa10-2ded-4f4a-85ba-d2747534dd5f" status: 200 len: 1552 microversion: 2.1 time: 0.097564' 2018-07-25 03:16:46.461573 | ubuntu-xenial | b'2018-07-25 03:16:35,635 INFO [nova.compute.manager] Took 0.00 seconds to spawn the instance on the hypervisor.' 2018-07-25 03:16:46.461716 | ubuntu-xenial | b'2018-07-25 03:16:35,686 INFO [nova.compute.manager] Took 0.35 seconds to build instance.' 2018-07-25 03:16:46.461921 | ubuntu-xenial | b"2018-07-25 03:16:35,698 INFO [nova.scheduler.host_manager] Received an update from an unknown host 'host2'. Re-created its InstanceList." 2018-07-25 03:16:46.462226 | ubuntu-xenial | b'2018-07-25 03:16:36,183 INFO [nova.api.openstack.requestlog] 127.0.0.1 "GET /v2.1/6f70656e737461636b20342065766572/servers/18cdaa10-2ded-4f4a-85ba-d2747534dd5f" status: 200 len: 1557 microversion: 2.1 time: 0.047864' 2018-07-25 03:16:46.462415 | ubuntu-xenial | b'2018-07-25 03:16:46,243 ERROR [nova.compute.api] Instance compute service state on host2 expected to be down, but it was up.' 2018-07-25 03:16:46.462598 | ubuntu-xenial | b'2018-07-25 03:16:46,243 INFO [nova.api.openstack.wsgi] HTTP exception thrown: Compute service of host2 is still in use.' 2018-07-25 03:16:46.462911 | ubuntu-xenial | b'2018-07-25 03:16:46,244 INFO [nova.api.openstack.requestlog] 127.0.0.1 "POST /v2.1/6f70656e737461636b20342065766572/servers/18cdaa10-2ded-4f4a-85ba-d2747534dd5f/action" status: 400 len: 85 microversion: 2.1 time: 0.047029' 2018-07-25 03:16:46.462942 | ubuntu-xenial | b'' http://logstash.openstack.org/#dashboard/file/logstash.json?query=message%3A%5C%22Instance%20compute%20service%20state%20on%20host2%20expected%20to%20be%20down%2C%20but%20it%20was%20up.%5C%22%20AND%20tags%3A%5C%22console%5C%22&from=7d 37 hits in 7 days, check and gate, all failures. Looks like it might have started around July 24. To manage notifications about this bug go to: https://bugs.launchpad.net/nova/+bug/1783565/+subscriptions -- Mailing list: https://launchpad.net/~yahoo-eng-team Post to : yahoo-eng-team@lists.launchpad.net Unsubscribe : https://launchpad.net/~yahoo-eng-team More help : https://help.launchpad.net/ListHelp