首先从最简单的开始，新建一个虚拟机（Launch Instance）并查看其日志
1.在网页上登录搭建好的openstack虚机（名称为op1）的dashboard界面
2.远程SSH登录op1的命令行界面
Xshell输入
ssh 192.168.xx.xxssh 后面是你的服务器域名(需要登录一个控制节点，一个计算节点，因为创建虚机的日志有些在控制节点上，有的在计算节点上)
登录完成是这样的：
3.在浏览器界面选择新建虚拟机（填好名称、选好镜像、网络），点击新建（不管成功与否）。
然后在命令行执行tail /opt/stack/logs/nova-api.log查看控制节点nova-api的日志
tail /opt/stack/logs/nova-api.log非devstack自动化部署的日志不在stack底下，在/var/log/模块名/ 这个目录下，比如nova
然后可以tail打开日志，内存大的话也可以直接vim打开（shift+G直接跳到最后）
查看流程如上，然后我们来解决一下查看的实操中的一些问题
1.各个日志大概是干嘛的
2.日志一大堆，怎么获取到当前请求的的日志
打开图形界面，选建的虚拟机点进去，会有一个虚拟机ID，可以根据这个全局定位
复制好这个ID，然后在命令行打开任意一个日志文件（建议使用vim打开或者grep命令直接重定向导出成文件，这样 便于搜索）
//如下是用vim打开，然后输入？和ID，按enter键进行搜索的示例
结果如图
然后我们获取到req ID，就可以用req ID搜索，更好的搜索此条请求的日志
方案一：
cat /var/log/nova/nova-compute.log|grep req-138eaddd-4792-45b2-af9c-313fa4e363cb
这样会打印出nova-compute.log中所有包含此ID的日志，并且将ID标红显示
方案二：
在xhell里面查看日志不方便看，可以重定向到一个新建的文件中，然后拖出来看（下面的栗子是将查询到的id为req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c的日志保存到/home/test文件中）
grep -rn 'req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c' nova-compute.log > /home/test然后将home/test的直接复制到windows本机用本地任意编辑器打开进行分析
3.除了dashboard界面，用命令行怎么建立虚拟机
openStack的发行版更新实在太快了，网上有很多帖子教怎么用命令行进行一些openstack操作，但是就我自己实践而言，好多命令都过时失效openstack不再支持了，但是不方，官网文档你值得拥有https://docs.openstack.org/queens/index.html
//记得切换到自己用的openstack版本（我用的Queens版本），不然默认是最新tiain版本
然后照着文档搞吧（以前老命令是nova list 现在换为 openstack list，部分仍旧兼容比如nova favlor-list）
如果无法识别nova命令，出现这种问题：
这是因为没有加载环境变量，添加上resource资源就好了(本质是把source配置到环境变量中，就像java配置jdk的环境变量一样)
source /root/adminrc 再执行nova flavor-list
另外，也可以用pcs resource可以查看各种服务是否开启
pcs resource
最后我们在任意一个编辑器里查看我们之前重定向出来的日志文件，定位出现的问题
本次示例GUI提示的问题描述如图：
然后进行日志分析
控制节点日志：
/*这是nova-scheduler里面的日志*/
//开始为新建的instance分配节点
2019-12-10 14:59:27.002 16906 DEBUG nova.scheduler.manager [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b
- default default] Starting to schedule for instances: [u'3fb54b39-390a-4dc1-9249-896716edca25'] select_destinations /usr/lib/python2.7/site-packages/nova/scheduler/manager.py:110
/*这是nova-conductor里面的日志*/
//从计算节点更新主机状态
2019-12-10 14:59:28.366 16906 DEBUG nova.scheduler.host_manager [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default] Update host state from compute node: ComputeNode(cpu_allocation_ratio=16 .0,cpu_info='{"vendor": "Intel", "model": "Broadwell", "arch": "x86_64", "features": ["ospke", "pge", "avx", "xsaveopt", "clflush", "pku", "rtm", "tsc_adjust", "tsc-deadline", "avx512dq", "invpcid", "tsc", "fsgsbase", "xsave", "smap", "vmx", "erms", "hle", "cmov" , "avx512bw", "smep", "fpu", "clflushopt", "pat", "arat", "lm", "msr", "adx", "3dnowprefetch", "nx", "fxsr", "syscall", "sse4.1", "pae", "sse4.2", "pclmuldq", "pcid", "fma", "vme", "mmx", "osxsave", "cx8", "mce", "de", "avx512cd", "aes", "clwb", "pse", "lahf_lm", "abm", "rdseed", "popcnt", "mca", "pdpe1gb", "apic", "sse", "f16c", "ds", "mpx", "invtsc", "xsavec", "pni", "avx512f", "avx2", "sse2", "ss", "hypervisor", "xsaves", "bmi1", "bmi2", "ssse3", "cx16", "pse36", "mtrr", "movbe", "rdrand", "avx512vl", "sep", "rdtscp", "x2apic"], "topology": {"cores": 1, "cells": 1, "threads": 1, "sockets": 4}}'
,created_at=2019-09-24T03:02:28Z,current_workload=0,deleted=False,deleted_at=None,disk_allocation_ratio=1.0,disk_available_least=92,free_disk_gb=95,free_ram_mb=15871,host='computer1',host_ip=192.168.10.154,
hypervisor_hostname='computer1',hypervisor_type='QEMU',hypervisor_version=2012000,id=4,local_gb=95,local_gb_used=0,mapped=1,memory_mb=16383,memory_mb_used=512,metrics='[]',
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", "nov a_object.data": {"cpu_usage": 0, "memory_usage": 0, "cpuset": [0, 1, 2, 3], "pinned_cpus": [], "siblings": [], "memory": 16383, "mempages": [{"nova_object.version": "1.1", "nova_object.changes": ["total", "used", "reserved", "size_kb"], "nova_object.name": "NUMAP agesTopology", "nova_object.data": {"used": 0, "total": 4194190, "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": 2048}, "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.namespace": "nova"}',pci_device_pools=PciDevicePoolList,ram_allocation_ratio=1.5,running_vms=0,servic e_id=None,stats={failed_builds='0'},supported_hv_specs=[HVSpec,HVSpec,HVSpec,HVSpec],updated_at=2019-12-10T06:26:27Z,uuid=3b7c7aaa-3d01-47c8-b98d-28dff67a1825,vcpus=4,vcpus_used=0) _locked_update /usr/lib/python2.7/site-packages/nova/scheduler/host_manager.py:173
4398 2019-12-10 14:59:28.367 16906 DEBUG nova.scheduler.host_manager [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
Update host state with aggregates: [] _locked_update /usr/lib/python2.7/ site-packages/nova/scheduler/host_manager.py:176
4399 2019-12-10 14:59:28.368 16906 DEBUG nova.scheduler.host_manager [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
Update host state with service dict: {'binary': u'nova-compute', 'uuid': u'008923ae-5227-449f-898f-885d22ce3cb8', 'deleted': False, 'created_at': datetime.datetime(2019, 9, 24, 3, 2, 28, tzinfo=<iso8601.Utc>), 'updated_at': datetime.datetime(2019, 12, 10, 6, 59, 19, tzinfo=<iso8601.Utc>), 'report_count': 24766, 'topic': u'compute', ' host': u'computer1', 'version': 30, 'disabled': False, 'forced_down': False, 'last_seen_up': datetime.datetime(2019, 12, 10, 6, 59, 19, tzinfo=<iso8601.Utc>), 'deleted_at': None, 'disabled_reason': None, 'id': 73} _locked_update /usr/lib/python2.7/site-packages/n
//获取配额
50502 2019-12-10 14:59:30.942 20327 DEBUG nova.quota [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
Getting quotas for project 4bb33c6ee0d545849578e1d0d76ec99b. Resources: set(['instances' , 'ram', 'cores']) _get_quotas /usr/lib/python2.7/site-packages/nova/quota.py:409 //对project的
50503 2019-12-10 14:59:30.948 20327 DEBUG nova.quota [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
Getting quotas for user eda42ff4a015451a89c74e700323ea34 and project 4bb33c6ee0d545849578e1d0d76ec99b. Resources: set(['instances', 'ram', 'cores']) //对user和project的
_get_quotas /usr/lib/python2.7/site-packages/nova/quota.py:401
//选择了节点1，备选项节点2、3
50504 2019-12-10 14:59:30.963 20327 DEBUG nova.conductor.manager [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
[instance: 3fb54b39-390a-4dc1-9249-896716edca25] //虚机id
Selected host: computer1; Selected node: computer1; Alternates: [(u'computer2', u'computer2')] schedule_and_build_instances /usr/lib/python2.7/site-packages/nova/conductor/manager.py:1262
//创建此ID虚机的块设备映射，包含了创建虚机的资源类型为选择镜像创建source_type='image'、image镜像id为a2931240-e934-4ed3-b6f0-acf6580f9694、destination_type='volume'这个不太懂是啥意思
instance: 3fb54b39-390a-4dc1-9249-896716edca25] block_device_mapping
[Block DeviceMapping(attachment_id=<?>,boot_index=0,connection_info=None,created_at=<?>,delete_on_termination=False,deleted=<?>,deleted_at=<?>,
destination_type='volume',device_name=None,device_type=None,disk_bus=None,guest_format=None,id=<?>,
image_id='a2931240-e934-4ed3-b6f0-acf6580f9694',instance=<?>,instance_uuid=<?>,no_device=False,snapshot_id=None,
source_type='image',tag=None,updated_at=<?>,uuid=<?>,volume_id=None,volume_size=10)] _create_block_device_mapping /usr/lib/python2.7/site-packages/nova/conductor/manager.py:1063
计算节点上的日志：
/*这是nova-compute上的日志*/
//生成并运行虚机
10751:2019-12-10 14:59:31.774 8652 DEBUG nova.compute.manager [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
[instance: 3fb54b39-390a-4dc1-9249-896716edca25] Starting instance... _do_build_and_run_instance /usr/lib/python2.7/site-packages/nova/compute/manager.py:1836
//分配512MB内存给该虚机
10753:2019-12-10 14:59:32.204 8652 DEBUG nova.compute.resource_tracker [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
Memory overhead for 512 MB instance; 0 MB instance_claim /usr/lib/python2.7/site-packages/nova/compute/resource_tracker.py:202
//分配10GB磁盘给该虚机
10754:2019-12-10 14:59:32.205 8652 DEBUG nova.compute.resource_tracker [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
Disk overhead for 10 GB instance; 0 GB instance_claim /usr/lib/python2.7/site-packages/nova/compute/resource_tracker.py:205
//分配1核CPU
10755:2019-12-10 14:59:32.205 8652 DEBUG nova.compute.resource_tracker [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
CPU overhead for 1 vCPUs instance; 0 vCPU(s) instance_claim /usr/lib/python2.7/site-packages/nova/compute/resource_tracker.py:208
//准备就绪，进行配置声明
10756:2019-12-10 14:59:32.228 8652 INFO nova.compute.claims [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default] [instance: 3fb54b39-390a-4dc1-9249-896716edca25]
Attempting claim on node computer1: memory 512 MB, disk 10 GB, vcpus 1 CPU
//全局内存16383MB，使用了512MB，全局磁盘９５GB已使用０，
10757:2019-12-10 14:59:32.229 8652 INFO nova.compute.claims [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default] [instance: 3fb54b39-390a-4dc1-9249-896716edca25]
Total memory: 16383 MB, used: 512.00 MB
10759:2019-12-10 14:59:32.229 8652 INFO nova.compute.claims [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default] [instance: 3fb54b39-390a-4dc1-9249-896716edca25]
Total disk: 95 GB, used: 0.00 GB
//声明成功
10764:2019-12-10 14:59:32.232 8652 INFO nova.compute.claims [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default] [instance: 3fb54b39-390a-4dc1-9249-896716edca25]
Claim successful on node computer1
//开始异步构建网络
10767:2019-12-10 14:59:33.507 8652 DEBUG nova.compute.manager [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default] [instance: 3fb54b39-390a-4dc1-9249-896716edca25]
Start building networks asynchronously for instance. _build_resources /usr/lib/python2.7/site-packages/nova/compute/manager.py:2193
//后台分配ip信息
10768:2019-12-10 14:59:33.684 8652 DEBUG nova.compute.manager [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default] [instance: 3fb54b39-390a-4dc1-9249-896716edca25]
Allocating IP information in the background. _allocate_network_async /usr/lib/python2.7/site-packages/nova/compute/manager.py:1424
//开始创建块设备映射
10771:2019-12-10 14:59:33.909 8652 DEBUG nova.compute.manager [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default] [instance: 3fb54b39-390a-4dc1-9249-896716edca25]
Start building block device mappings for instance. _build_resources /usr/lib/python2.7/site-packages/nova/compute/manager.py:2224
//启动空白卷
10772:2019-12-10 14:59:34.653 8652 INFO nova.virt.block_device [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default] [instance: 3fb54b39-390a-4dc1-9249-896716edca25]
Booting with blank volume at /dev/vda
10773:2019-12-10 14:59:34.932 8652 DEBUG cinderclient.v3.client [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default] REQ:
curl -g -i -X
POST http:\\controller:8776/v3/4bb33c6ee0d545849578e1d0d76ec99b/volumes -H "User-Agent: python-cinderclient" -H "Content-Type: application/json" -H "X-OpenStack-Request-ID: req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c" -H
"Accept: application/json" -H "X-Auth-Token: {SHA1}ae9ca7c5948922b63f7f662628090178886214b8" -d '{"volume": {"status": "creating", "backup_id": null, "user_id": "eda42ff4a015451a89c74e700323ea34",
"name": "", "imageRef": "a2931240-e934-4ed3-b6f0-acf6580f9694", "availability_zone": null, "description": "",
"multiattach": false, "attach_status": "detached", "volume_type": null, "metadata": {}, "consistencygroup_id": null, "source_volid": null,
"snapshot_id": null, "project_id": "4bb33c6ee0d545849578e1d0d76ec99b", "source_replica": null,
"size": 10}}' _http_log_request /usr/lib/python2.7/site-packages/keystoneauth1/session.py:372
//创建端口成功
10774:2019-12-10 14:59:36.539 8652 DEBUG nova.network.neutronv2.api [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default] [instance: 3fb54b39-390a-4dc1-9249-896716edca25]
Successfully created port: 75086d9b-c803-4f50-9c26-06f71048b896 _create_port_minimal /usr/lib/python2.7/site-packages/nova/network/neutronv2/api.py:435
//更新端口
10775:2019-12-10 14:59:39.488 8652 DEBUG nova.network.neutronv2.api [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default] [instance: 3fb54b39-390a-4dc1-9249-896716edca25]
Successfully updated port: 75086d9b-c803-4f50-9c26-06f71048b896 _update_port /usr/lib/python2.7/site-packages/nova/network/neutronv2/api.py:472
10776:2019-12-10 14:59:39.644 8652 DEBUG oslo_concurrency.lockutils [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
Acquired semaphore "refresh_cache-3fb54b39-390a-4dc1-9249-896716edca25" lock /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:212
//调用了获取实例信息这个方法，提供了方法名和这个方法在源码那个py文件里面以及在哪一行,很贴心
10777:2019-12-10 14:59:39.645 8652 DEBUG nova.network.neutronv2.api [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
[instance: 3fb54b39-390a-4dc1-9249-896716edca25] _get_instance_nw_info() _get_instance_nw_info /usr/lib/python2.7/site-packages/nova/network/neutronv2/api.py:1451
//实例缓存缺少网络,GUI中提到过,创这个虚机的时候neutron出了问题。
10778:2019-12-10 14:59:39.754 8652 DEBUG nova.network.neutronv2.api [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default] [instance: 3fb54b39-390a-4dc1-9249-896716edca25]
Instance cache missing network info. _get_preexisting_port_ids /usr/lib/python2.7/site-packages/nova/network/neutronv2/api.py:2369
//报了一个neutron错误,找不到资源，从这里就开始错了
10779:2019-12-10 14:59:39.765 8652 DEBUG neutronclient.v2_0.client [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
Error message: {"NeutronError": {"message": "The resource could not be found.", "type": "HTTPNotFound", "detail": ""}}
_handle_fault_response /usr/lib/python2.7/site-packages/neutronclient/v2_0/client.py:259
//使用网络信息更新实例缓存
10780:2019-12-10 14:59:39.925 8652 DEBUG nova.network.base_api [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default] [instance: 3fb54b39-390a-4dc1-9249-896716edca25]
Updating instance_info_cache with network_info:
[{"profile": {}, "ovs_interfaceid": "75086d9b-c803-4f50-9c26-06f71048b896", "preserve_on_delete": false, "network":
{"bridge": "br-int", "subnets": [{"ips": [{"meta": {}, "version": 4, "type": "fixed", "floating_ips": [], "address": "192.168.20.12"}],
"version": 4, "meta": {"dhcp_server": "192.168.20.1"}, "dns": [], "routes": [], "cidr": "192.168.20.0/24",
"gateway": {"meta": {}, "version": 4, "type": "gateway", "address": "192.168.20.254"}}], "meta": {"injected": false,
"tenant_id": "4bb33c6ee0d545849578e1d0d76ec99b", "mtu": 1500}, "id": "6eeb627c-342b-44dc-8e3e-3283b8987d54", "label": "ext-net"},
"devname": "tap75086d9b-c8", "vnic_type": "normal", "qbh_params": null, "meta": {}, "details": {"port_filter": true,
"datapath_type": "system", "ovs_hybrid_plug": true}, "address": "fa:16:3e:ff:99:d1", "active": false, "type": "ovs",
"id": "75086d9b-c803-4f50-9c26-06f71048b896", "qbg_params": null}]
update_instance_cache_with_nw_info /usr/lib/python2.7/site-packages/nova/network/base_api.py:48
10781:2019-12-10 14:59:39.988 8652 DEBUG oslo_concurrency.lockutils [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
Releasing semaphore "refresh_cache-3fb54b39-390a-4dc1-9249-896716edca25" lock /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:228
//虚机网络信息
10782:2019-12-10 14:59:39.988 8652 DEBUG nova.compute.manager [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default] [instance: 3fb54b39-390a-4dc1-9249-896716edca25]
Instance network_info:
|[{"profile": {}, "ovs_interfaceid": "75086d9b-c803-4f50-9c26-06f71048b896", "preserve_on_delete": false, "network": {"bridge": "br-int", "subnets": [{"ips": [{"meta": {},
"version": 4, "type": "fixed", "floating_ips": [], "address": "192.168.20.12"}], "version": 4, "meta": {"dhcp_server": "192.168.20.1"}, "dns": [], "routes": [], "cidr": "192.168.20.0/24",
"gateway": {"meta": {}, "version": 4, "type": "gateway", "address": "192.168.20.254"}}], "meta": {"injected": false, "tenant_id": "4bb33c6ee0d545849578e1d0d76ec99b", "mtu": 1500},
"id": "6eeb627c-342b-44dc-8e3e-3283b8987d54", "label": "ext-net"}, "devname": "tap75086d9b-c8", "vnic_type": "normal", "qbh_params": null, "meta": {}, "details": {"port_filter": true,
"datapath_type": "system", "ovs_hybrid_plug": true}, "address": "fa:16:3e:ff:99:d1", "active": false, "type": "ovs", "id": "75086d9b-c803-4f50-9c26-06f71048b896",
"qbg_params": null}]| _allocate_network_async /usr/lib/python2.7/site-packages/nova/compute/manager.py:1438
//卷创建完成，但是状态为error
10805:2019-12-10 14:59:41.585 8652 WARNING nova.compute.manager [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
Volume id: f5f10859-f6b0-4f52-a138-158e75d57a43 finished being created but its status is error.
//虚机安装失败，状态为error
10806:2019-12-10 14:59:41.586 8652 ERROR nova.compute.manager [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default] [instance: 3fb54b39-390a-4dc1-9249-896716edca25]
Instance failed block device setup: VolumeNotCreated: Volume f5f10859-f6b0-4f52-a138-158e75d57a43 did not finish being created even after we waited 0 seconds or 1 attempts. And its status is error.
//终止声明
10828:2019-12-10 14:59:41.657 8652 DEBUG nova.compute.claims [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
[instance: 3fb54b39-390a-4dc1-9249-896716edca25] Aborting claim: [Claim: 512 MB memory, 10 GB disk] abort /usr/lib/python2.7/site-packages/nova/compute/claims.py:123
//锁定这个声明获取compute的资源
10829:2019-12-10 14:59:41.657 8652 DEBUG oslo_concurrency.lockutils [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
Lock "compute_resources" acquired by "nova.compute.resource_tracker.abort_instance_claim" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:273
//虚机创建失败，卷状态为error
10831:2019-12-10 14:59:42.826 8652 DEBUG nova.compute.manager [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
[instance: 3fb54b39-390a-4dc1-9249-896716edca25]
Build of instance 3fb54b39-390a-4dc1-9249-896716edca25
aborted: Volume f5f10859-f6b0-4f52-a138-158e75d57a43 did not finish being created even after we waited 0 seconds or 1 attempts. And its status is error.
_build_and_run_instance /usr/lib/python2.7/site-packages/nova/compute/manager.py:2079
10832:2019-12-10 14:59:42.827 8652 DEBUG nova.compute.utils [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
[instance: 3fb54b39-390a-4dc1-9249-896716edca25]
Build of instance 3fb54b39-390a-4dc1-9249-896716edca25 aborted: Volume f5f10859-f6b0-4f52-a138-158e75d57a43 did not finish being created even after we waited 0 seconds or 1 attempts. And its status is error.
notify_about_instance_usage /usr/lib/python2.7/site-packages/nova/compute/utils.py:354
10833:2019-12-10 14:59:42.921 8652 ERROR nova.compute.manager [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
[instance: 3fb54b39-390a-4dc1-9249-896716edca25]
Build of instance 3fb54b39-390a-4dc1-9249-896716edca25 aborted: Volume f5f10859-f6b0-4f52-a138-158e75d57a43 did not finish being created even after we waited 0 seconds or 1 attempts.
And its status is error.:
BuildAbortException:
Build of instance 3fb54b39-390a-4dc1-9249-896716edca25 aborted: Volume f5f10859-f6b0-4f52-a138-158e75d57a43 did not finish being created even after we waited 0 seconds or 1 attempts.
And its status is error.
//取消网络分配
10851:2019-12-10 14:59:42.922 8652 DEBUG nova.compute.manager [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
[instance: 3fb54b39-390a-4dc1-9249-896716edca25] Deallocating network for instance _deallocate_network /usr/lib/python2.7/site-packages/nova/compute/manager.py:1697
10852:2019-12-10 14:59:42.922 8652 DEBUG nova.network.neutronv2.api [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
[instance: 3fb54b39-390a-4dc1-9249-896716edca25] deallocate_for_instance() deallocate_for_instance /usr/lib/python2.7/site-packages/nova/network/neutronv2/api.py:1317
10853:2019-12-10 14:59:44.752 8652 DEBUG nova.network.base_api [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
[instance: 3fb54b39-390a-4dc1-9249-896716edca25] Updating instance_info_cache with network_info: [] update_instance_cache_with_nw_info /usr/lib/python2.7/site-packages/nova/network/base_api.py:48
//释放网络
10854:2019-12-10 14:59:45.004 8652 INFO nova.compute.manager [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
[instance: 3fb54b39-390a-4dc1-9249-896716edca25] Took 2.08 seconds to deallocate network for instance.
//删除分配
10855:2019-12-10 14:59:46.268 8652 INFO nova.scheduler.client.report [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
Deleted allocation for instance 3fb54b39-390a-4dc1-9249-896716edca25
10856:2019-12-10 14:59:46.268 8652 DEBUG oslo_concurrency.lockutils [req-09a61c6f-c4bb-4fbe-a4f8-33bcd12bf21c eda42ff4a015451a89c74e700323ea34 4bb33c6ee0d545849578e1d0d76ec99b - default default]
Lock "3fb54b39-390a-4dc1-9249-896716edca25" released by "nova.compute.manager._locked_do_build_and_run_instance" :: held 14.630s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:285
over