You are viewing a plain text version of this content. The canonical link for it is here.
Posted to users-cn@cloudstack.apache.org by 张秉南 <zb...@gmail.com> on 2013/06/09 11:16:35 UTC

自己生成的模板不能创建虚拟机的问题

2013-06-09 16:33:45,900 DEBUG [cloud.server.StatsCollector]
(StatsCollector-2:null) HostStatsCollector is running...
2013-06-09 16:33:46,569 DEBUG [agent.transport.Request]
(StatsCollector-2:null) Seq 1-862126178: Received:  { Ans: , MgmtId:
42645977839493, via: 1, Ver: v1, Flags: 10, { GetHostStatsAnswer } }
2013-06-09 16:33:47,077 DEBUG
[storage.secondary.SecondaryStorageManagerImpl] (secstorage-1:null) Zone 1
is ready to launch secondary storage VM
2013-06-09 16:33:47,153 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl]
(consoleproxy-1:null) Zone 1 is ready to launch console proxy
2013-06-09 16:33:47,195 DEBUG [agent.transport.Request]
(StatsCollector-2:null) Seq 6-373948592: Received:  { Ans: , MgmtId:
42645977839493, via: 6, Ver: v1, Flags: 10, { GetHostStatsAnswer } }
2013-06-09 16:33:47,384 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 routers.
2013-06-09 16:33:47,859 DEBUG [agent.transport.Request]
(StatsCollector-2:null) Seq 7-1222180958: Received:  { Ans: , MgmtId:
42645977839493, via: 7, Ver: v1, Flags: 10, { GetHostStatsAnswer } }
2013-06-09 16:33:51,384 DEBUG [cloud.server.StatsCollector]
(StatsCollector-2:null) StorageCollector is running...
2013-06-09 16:33:51,445 DEBUG [agent.transport.Request]
(StatsCollector-2:null) Seq 5-2010775630: Received:  { Ans: , MgmtId:
42645977839493, via: 5, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
2013-06-09 16:33:51,729 DEBUG [agent.transport.Request]
(StatsCollector-2:null) Seq 1-862126179: Received:  { Ans: , MgmtId:
42645977839493, via: 1, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
2013-06-09 16:33:55,729 DEBUG [cloud.vm.UserVmManagerImpl]
(catalina-exec-4:null) Allocating in the DB for vm
2013-06-09 16:33:55,729 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(catalina-exec-4:null) Allocating entries for VM: VM[User|web05]
2013-06-09 16:33:55,734 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(catalina-exec-4:null) Allocating nics for VM[User|web05]
2013-06-09 16:33:55,735 DEBUG [cloud.network.NetworkManagerImpl]
(catalina-exec-4:null) Allocating nic for vm VM[User|web05] in network
Ntwk[204|Guest|6] with requested profile NicProfile[0-0-null-null-null
2013-06-09 16:33:55,745 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(catalina-exec-4:null) Allocaing disks for VM[User|web05]
2013-06-09 16:33:55,760 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(catalina-exec-4:null) Allocation completed for VM: VM[User|web05]
2013-06-09 16:33:55,761 DEBUG [cloud.vm.UserVmManagerImpl]
(catalina-exec-4:null) Successfully allocated DB entry for VM[User|web05]
2013-06-09 16:33:55,813 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-4:null) submit async job-34, details: AsyncJobVO {id:34,
userId: 2, accountId: 2, sessionKey: null, instanceType: VirtualMachine,
instanceId: 89, cmd: com.cloud.api.commands.DeployVMCmd, cmdOriginator:
null, cmdInfo:
{"sessionkey":"YUkbfJ3wL9FSaGKqQrXsydfN1Oo\u003d","ctxUserId":"2","serviceOfferingId":"c55c591a-8845-4326-86cb-6873fa3e4df9","zoneId":"72c53a56-728f-424a-a219-97fcbc0efce1","templateId":"40fceb2c-3d6a-42e3-828b-a280278be47c","response":"json","id":"89","hypervisor":"KVM","name":"web05","diskOfferingId":"e5208413-2d37-4f16-a927-adaae90d3805","_":"1370766835511","ctxAccountId":"2","ctxStartEventId":"127","displayname":"web05"},
cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0,
processStatus: 0, resultCode: 0, result: null, initMsid: 42645977839493,
completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
2013-06-09 16:33:55,814 DEBUG [cloud.async.AsyncJobManagerImpl]
(Job-Executor-3:job-34) Executing com.cloud.api.commands.DeployVMCmd for
job-34
2013-06-09 16:33:55,874 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34) VM state transitted from :Stopped to Starting with
event: StartRequestedvm's original host id: null new host id: null host id
before state transition: null
2013-06-09 16:33:55,874 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-3:job-34) Successfully transitioned to start state for
VM[User|web05] reservation id = 7f619259-e242-4020-9271-2dba65d0cdf6
2013-06-09 16:33:55,877 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-3:job-34) Trying to deploy VM, vm has dcId: 1 and podId: null
2013-06-09 16:33:55,877 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-3:job-34) Deploy avoids pods: null, clusters: null, hosts:
null
2013-06-09 16:33:55,880 DEBUG [cloud.deploy.FirstFitPlanner]
(Job-Executor-3:job-34) DeploymentPlanner allocation algorithm: random
2013-06-09 16:33:55,880 DEBUG [cloud.deploy.FirstFitPlanner]
(Job-Executor-3:job-34) Trying to allocate a host and storage pools from
dc:1, pod:null,cluster:null, requested cpu: 8000, requested ram: 12884901888
2013-06-09 16:33:55,880 DEBUG [cloud.deploy.FirstFitPlanner]
(Job-Executor-3:job-34) Is ROOT volume READY (pool already allocated)?: No
2013-06-09 16:33:55,880 DEBUG [cloud.deploy.FirstFitPlanner]
(Job-Executor-3:job-34) Searching all possible resources under this Zone: 1
2013-06-09 16:33:55,882 DEBUG [cloud.deploy.FirstFitPlanner]
(Job-Executor-3:job-34) Listing clusters in order of aggregate capacity,
that have (atleast one host with) enough CPU and RAM capacity under this
Zone: 1
2013-06-09 16:33:55,883 DEBUG [cloud.deploy.FirstFitPlanner]
(Job-Executor-3:job-34) CPUOverprovisioningFactor considered: 4.0
2013-06-09 16:33:55,894 DEBUG [cloud.deploy.FirstFitPlanner]
(Job-Executor-3:job-34) Checking resources in Cluster: 1 under Pod: 1
2013-06-09 16:33:55,894 DEBUG [cloud.deploy.FirstFitPlanner]
(Job-Executor-3:job-34) Calling HostAllocators to find suitable hosts
2013-06-09 16:33:55,894 DEBUG [allocator.impl.FirstFitAllocator]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Looking for hosts in dc: 1
 pod:1  cluster:1
2013-06-09 16:33:55,894 DEBUG [allocator.impl.FirstFitAllocator]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Looking for hosts having
tag specified on SvcOffering:web
2013-06-09 16:33:55,897 DEBUG [allocator.impl.FirstFitAllocator]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Hosts with tag 'web'
are:[Host[-1-Routing], Host[-6-Routing], Host[-7-Routing]]
2013-06-09 16:33:55,897 DEBUG [allocator.impl.FirstFitAllocator]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) FirstFitAllocator has 3
hosts to check for allocation: [Host[-6-Routing], Host[-1-Routing],
Host[-7-Routing]]
2013-06-09 16:33:55,902 DEBUG [allocator.impl.FirstFitAllocator]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Found 3 hosts for
allocation after prioritization: [Host[-6-Routing], Host[-1-Routing],
Host[-7-Routing]]
2013-06-09 16:33:55,902 DEBUG [allocator.impl.FirstFitAllocator]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Looking for speed=8000Mhz,
Ram=12288
2013-06-09 16:33:55,904 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Checking if host: 6 has
enough capacity for requested CPU: 8000 and requested RAM: 12884901888 ,
cpuOverprovisioningFactor: 4.0
2013-06-09 16:33:55,907 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Hosts's actual total CPU:
40416 and CPU after applying overprovisioning: 161664
2013-06-09 16:33:55,907 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Free CPU: 153664 ,
Requested CPU: 8000
2013-06-09 16:33:55,908 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Free RAM: 12300541952 ,
Requested RAM: 12884901888
2013-06-09 16:33:55,908 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Failed to alloc
resource from host: 6 reservedCpu: 0, used cpu: 8000, requested cpu: 8000,
actual total cpu: 40416, total cpu with overprovisioning: 161664,
reservedMem: 0, used Mem: 12884901888, requested mem: 12884901888, total
Mem:25185443840 ,considerReservedCapacity?: true
2013-06-09 16:33:55,908 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Host does not have enough
RAM available, cannot allocate to this host.
2013-06-09 16:33:55,908 DEBUG [allocator.impl.FirstFitAllocator]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Not using host 6;
numCpusGood: true; cpuFreqGood: true, host has capacity?false
2013-06-09 16:33:55,910 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Checking if host: 1 has
enough capacity for requested CPU: 8000 and requested RAM: 12884901888 ,
cpuOverprovisioningFactor: 4.0
2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Hosts's actual total CPU:
64000 and CPU after applying overprovisioning: 256000
2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Free CPU: 254500 ,
Requested CPU: 8000
2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Free RAM: 49085001728 ,
Requested RAM: 12884901888
2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Host has enough CPU and
RAM available
2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Can alloc CPU from
host: 1, used: 1500, reserved: 0, actual total: 64000, total with
overprovisioning: 256000; requested cpu:8000,alloc_from_last_host?:false
,considerReservedCapacity?: true
2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Can alloc MEM from
host: 1, used: 1476395008, reserved: 0, total: 50561396736; requested mem:
12884901888,alloc_from_last_host?:false ,considerReservedCapacity?: true
2013-06-09 16:33:55,914 DEBUG [allocator.impl.FirstFitAllocator]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Not using host 1;
numCpusGood: true; cpuFreqGood: false, host has capacity?true
2013-06-09 16:33:55,916 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Checking if host: 7 has
enough capacity for requested CPU: 8000 and requested RAM: 12884901888 ,
cpuOverprovisioningFactor: 4.0
2013-06-09 16:33:55,918 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Hosts's actual total CPU:
64000 and CPU after applying overprovisioning: 256000
2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Free CPU: 256000 ,
Requested CPU: 8000
2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Free RAM: 50565599232 ,
Requested RAM: 12884901888
2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Host has enough CPU and
RAM available
2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Can alloc CPU from
host: 7, used: 0, reserved: 0, actual total: 64000, total with
overprovisioning: 256000; requested cpu:8000,alloc_from_last_host?:false
,considerReservedCapacity?: true
2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Can alloc MEM from
host: 7, used: 0, reserved: 0, total: 50565599232; requested mem:
12884901888,alloc_from_last_host?:false ,considerReservedCapacity?: true
2013-06-09 16:33:55,919 DEBUG [allocator.impl.FirstFitAllocator]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Not using host 7;
numCpusGood: true; cpuFreqGood: false, host has capacity?true
2013-06-09 16:33:55,919 DEBUG [allocator.impl.FirstFitAllocator]
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Host Allocator returning 0
suitable hosts
2013-06-09 16:33:55,919 DEBUG [cloud.deploy.FirstFitPlanner]
(Job-Executor-3:job-34) No suitable hosts found
2013-06-09 16:33:55,919 DEBUG [cloud.deploy.FirstFitPlanner]
(Job-Executor-3:job-34) No suitable hosts found under this Cluster: 1
2013-06-09 16:33:55,919 DEBUG [cloud.deploy.FirstFitPlanner]
(Job-Executor-3:job-34) Could not find suitable Deployment Destination for
this VM under any clusters, returning.
2013-06-09 16:33:55,924 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34) VM state transitted from :Starting to Stopped with
event: OperationFailedvm's original host id: null new host id: null host id
before state transition: null
2013-06-09 16:33:55,928 DEBUG [cloud.vm.UserVmManagerImpl]
(Job-Executor-3:job-34) Destroying vm VM[User|web05] as it failed to create
2013-06-09 16:33:55,934 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-3:job-34) VM state transitted from :Stopped to Error with
event: OperationFailedToErrorvm's original host id: null new host id: null
host id before state transition: null
2013-06-09 16:33:55,981 INFO  [api.commands.DeployVMCmd]
(Job-Executor-3:job-34)
com.cloud.exception.InsufficientServerCapacityException: Unable to create a
deployment for VM[User|web05]Scope=interface com.cloud.dc.DataCenter; id=1
2013-06-09 16:33:55,982 WARN  [cloud.api.ApiDispatcher]
(Job-Executor-3:job-34) class com.cloud.api.ServerApiException : Unable to
create a deployment for VM[User|web05]
2013-06-09 16:33:55,982 DEBUG [cloud.async.AsyncJobManagerImpl]
(Job-Executor-3:job-34) Complete async job-34, jobStatus: 2, resultCode:
530, result: Error Code: 533 Error text: Unable to create a deployment for
VM[User|web05]
2013-06-09 16:34:00,892 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-6:null) Async job-34 completed
2013-06-09 16:34:00,941 DEBUG [cloud.vm.UserVmManagerImpl]
(catalina-exec-2:null) THE WHERE CLAUSE IS:user_vm.id = ?

Re: 自己生成的模板不能创建虚拟机的问题

Posted by 张秉南 <zb...@gmail.com>.
但问题是我的三台物理host节点,只有一台虚拟机在跑啊,每台物理机都是24G的内存,12核的cpu,完全够使用。
我的模板只需要12G内存和4核的cpu啊,硬盘150G


2013/6/9 哈哈 <ya...@gmail.com>

> 为什么我不能在这里发言?
>
>
> On Sun, Jun 9, 2013 at 5:21 PM, 张晓飞 <zh...@oncloudit.com> wrote:
>
> >  目测是资源不足导致
> >
> > 2013-06-09
> >
> >
> >
> > 张晓飞
> >
> >
> >
> > 发件人:张秉南 <zb...@gmail.com>
> > 发送时间:2013-06-09 17:16
> > 主题:自己生成的模板不能创建虚拟机的问题
> > 收件人:"users-cn"<us...@cloudstack.apache.org>
> > 抄送:
> >
> > 2013-06-09 16:33:45,900 DEBUG [cloud.server.StatsCollector]
> > (StatsCollector-2:null) HostStatsCollector is running...
> > 2013-06-09 16:33:46,569 DEBUG [agent.transport.Request]
> > (StatsCollector-2:null) Seq 1-862126178: Received:  { Ans: , MgmtId:
> > 42645977839493, via: 1, Ver: v1, Flags: 10, { GetHostStatsAnswer } }
> > 2013-06-09 16:33:47,077 DEBUG
> > [storage.secondary.SecondaryStorageManagerImpl] (secstorage-1:null) Zone
> 1
> > is ready to launch secondary storage VM
> > 2013-06-09 16:33:47,153 DEBUG
> [cloud.consoleproxy.ConsoleProxyManagerImpl]
> > (consoleproxy-1:null) Zone 1 is ready to launch console proxy
> > 2013-06-09 16:33:47,195 DEBUG [agent.transport.Request]
> > (StatsCollector-2:null) Seq 6-373948592: Received:  { Ans: , MgmtId:
> > 42645977839493, via: 6, Ver: v1, Flags: 10, { GetHostStatsAnswer } }
> > 2013-06-09 16:33:47,384 DEBUG
> > [network.router.VirtualNetworkApplianceManagerImpl]
> > (RouterStatusMonitor-1:null) Found 0 routers.
> > 2013-06-09 16:33:47,859 DEBUG [agent.transport.Request]
> > (StatsCollector-2:null) Seq 7-1222180958: Received:  { Ans: , MgmtId:
> > 42645977839493, via: 7, Ver: v1, Flags: 10, { GetHostStatsAnswer } }
> > 2013-06-09 16:33:51,384 DEBUG [cloud.server.StatsCollector]
> > (StatsCollector-2:null) StorageCollector is running...
> > 2013-06-09 16:33:51,445 DEBUG [agent.transport.Request]
> > (StatsCollector-2:null) Seq 5-2010775630: Received:  { Ans: , MgmtId:
> > 42645977839493, via: 5, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
> > 2013-06-09 16:33:51,729 DEBUG [agent.transport.Request]
> > (StatsCollector-2:null) Seq 1-862126179: Received:  { Ans: , MgmtId:
> > 42645977839493, via: 1, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
> > 2013-06-09 16:33:55,729 DEBUG [cloud.vm.UserVmManagerImpl]
> > (catalina-exec-4:null) Allocating in the DB for vm
> > 2013-06-09 16:33:55,729 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> > (catalina-exec-4:null) Allocating entries for VM: VM[User|web05]
> > 2013-06-09 16:33:55,734 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> > (catalina-exec-4:null) Allocating nics for VM[User|web05]
> > 2013-06-09 16:33:55,735 DEBUG [cloud.network.NetworkManagerImpl]
> > (catalina-exec-4:null) Allocating nic for vm VM[User|web05] in network
> > Ntwk[204|Guest|6] with requested profile NicProfile[0-0-null-null-null
> > 2013-06-09 16:33:55,745 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> > (catalina-exec-4:null) Allocaing disks for VM[User|web05]
> > 2013-06-09 16:33:55,760 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> > (catalina-exec-4:null) Allocation completed for VM: VM[User|web05]
> > 2013-06-09 16:33:55,761 DEBUG [cloud.vm.UserVmManagerImpl]
> > (catalina-exec-4:null) Successfully allocated DB entry for VM[User|web05]
> > 2013-06-09 16:33:55,813 DEBUG [cloud.async.AsyncJobManagerImpl]
> > (catalina-exec-4:null) submit async job-34, details: AsyncJobVO {id:34,
> > userId: 2, accountId: 2, sessionKey: null, instanceType: VirtualMachine,
> > instanceId: 89, cmd: com.cloud.api.commands.DeployVMCmd, cmdOriginator:
> > null, cmdInfo:
> >
> >
> {"sessionkey":"YUkbfJ3wL9FSaGKqQrXsydfN1Oo\u003d","ctxUserId":"2","serviceOfferingId":"c55c591a-8845-4326-86cb-6873fa3e4df9","zoneId":"72c53a56-728f-424a-a219-97fcbc0efce1","templateId":"40fceb2c-3d6a-42e3-828b-a280278be47c","response":"json","id":"89","hypervisor":"KVM","name":"web05","diskOfferingId":"e5208413-2d37-4f16-a927-adaae90d3805","_":"1370766835511","ctxAccountId":"2","ctxStartEventId":"127","displayname":"web05"},
> > cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0,
> > processStatus: 0, resultCode: 0, result: null, initMsid: 42645977839493,
> > completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
> > 2013-06-09 16:33:55,814 DEBUG [cloud.async.AsyncJobManagerImpl]
> > (Job-Executor-3:job-34) Executing com.cloud.api.commands.DeployVMCmd for
> > job-34
> > 2013-06-09 16:33:55,874 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34) VM state transitted from :Stopped to Starting
> with
> > event: StartRequestedvm's original host id: null new host id: null host
> id
> > before state transition: null
> > 2013-06-09 16:33:55,874 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> > (Job-Executor-3:job-34) Successfully transitioned to start state for
> > VM[User|web05] reservation id = 7f619259-e242-4020-9271-2dba65d0cdf6
> > 2013-06-09 16:33:55,877 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> > (Job-Executor-3:job-34) Trying to deploy VM, vm has dcId: 1 and podId:
> null
> > 2013-06-09 16:33:55,877 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> > (Job-Executor-3:job-34) Deploy avoids pods: null, clusters: null, hosts:
> > null
> > 2013-06-09 16:33:55,880 DEBUG [cloud.deploy.FirstFitPlanner]
> > (Job-Executor-3:job-34) DeploymentPlanner allocation algorithm: random
> > 2013-06-09 16:33:55,880 DEBUG [cloud.deploy.FirstFitPlanner]
> > (Job-Executor-3:job-34) Trying to allocate a host and storage pools from
> > dc:1, pod:null,cluster:null, requested cpu: 8000, requested ram:
> > 12884901888
> > 2013-06-09 16:33:55,880 DEBUG [cloud.deploy.FirstFitPlanner]
> > (Job-Executor-3:job-34) Is ROOT volume READY (pool already allocated)?:
> No
> > 2013-06-09 16:33:55,880 DEBUG [cloud.deploy.FirstFitPlanner]
> > (Job-Executor-3:job-34) Searching all possible resources under this
> Zone: 1
> > 2013-06-09 16:33:55,882 DEBUG [cloud.deploy.FirstFitPlanner]
> > (Job-Executor-3:job-34) Listing clusters in order of aggregate capacity,
> > that have (atleast one host with) enough CPU and RAM capacity under this
> > Zone: 1
> > 2013-06-09 16:33:55,883 DEBUG [cloud.deploy.FirstFitPlanner]
> > (Job-Executor-3:job-34) CPUOverprovisioningFactor considered: 4.0
> > 2013-06-09 16:33:55,894 DEBUG [cloud.deploy.FirstFitPlanner]
> > (Job-Executor-3:job-34) Checking resources in Cluster: 1 under Pod: 1
> > 2013-06-09 16:33:55,894 DEBUG [cloud.deploy.FirstFitPlanner]
> > (Job-Executor-3:job-34) Calling HostAllocators to find suitable hosts
> > 2013-06-09 16:33:55,894 DEBUG [allocator.impl.FirstFitAllocator]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Looking for hosts in
> dc: 1
> >  pod:1  cluster:1
> > 2013-06-09 16:33:55,894 DEBUG [allocator.impl.FirstFitAllocator]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Looking for hosts having
> > tag specified on SvcOffering:web
> > 2013-06-09 16:33:55,897 DEBUG [allocator.impl.FirstFitAllocator]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Hosts with tag 'web'
> > are:[Host[-1-Routing], Host[-6-Routing], Host[-7-Routing]]
> > 2013-06-09 16:33:55,897 DEBUG [allocator.impl.FirstFitAllocator]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) FirstFitAllocator has 3
> > hosts to check for allocation: [Host[-6-Routing], Host[-1-Routing],
> > Host[-7-Routing]]
> > 2013-06-09 16:33:55,902 DEBUG [allocator.impl.FirstFitAllocator]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Found 3 hosts for
> > allocation after prioritization: [Host[-6-Routing], Host[-1-Routing],
> > Host[-7-Routing]]
> > 2013-06-09 16:33:55,902 DEBUG [allocator.impl.FirstFitAllocator]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Looking for
> speed=8000Mhz,
> > Ram=12288
> > 2013-06-09 16:33:55,904 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Checking if host: 6 has
> > enough capacity for requested CPU: 8000 and requested RAM: 12884901888 ,
> > cpuOverprovisioningFactor: 4.0
> > 2013-06-09 16:33:55,907 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Hosts's actual total
> CPU:
> > 40416 and CPU after applying overprovisioning: 161664
> > 2013-06-09 16:33:55,907 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Free CPU: 153664 ,
> > Requested CPU: 8000
> > 2013-06-09 16:33:55,908 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Free RAM: 12300541952 ,
> > Requested RAM: 12884901888
> > 2013-06-09 16:33:55,908 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Failed to alloc
> > resource from host: 6 reservedCpu: 0, used cpu: 8000, requested cpu:
> 8000,
> > actual total cpu: 40416, total cpu with overprovisioning: 161664,
> > reservedMem: 0, used Mem: 12884901888, requested mem: 12884901888, total
> > Mem:25185443840 ,considerReservedCapacity?: true
> > 2013-06-09 16:33:55,908 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Host does not have
> enough
> > RAM available, cannot allocate to this host.
> > 2013-06-09 16:33:55,908 DEBUG [allocator.impl.FirstFitAllocator]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Not using host 6;
> > numCpusGood: true; cpuFreqGood: true, host has capacity?false
> > 2013-06-09 16:33:55,910 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Checking if host: 1 has
> > enough capacity for requested CPU: 8000 and requested RAM: 12884901888 ,
> > cpuOverprovisioningFactor: 4.0
> > 2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Hosts's actual total
> CPU:
> > 64000 and CPU after applying overprovisioning: 256000
> > 2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Free CPU: 254500 ,
> > Requested CPU: 8000
> > 2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Free RAM: 49085001728 ,
> > Requested RAM: 12884901888
> > 2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Host has enough CPU and
> > RAM available
> > 2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Can alloc CPU
> from
> > host: 1, used: 1500, reserved: 0, actual total: 64000, total with
> > overprovisioning: 256000; requested cpu:8000,alloc_from_last_host?:false
> > ,considerReservedCapacity?: true
> > 2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Can alloc MEM
> from
> > host: 1, used: 1476395008, reserved: 0, total: 50561396736; requested
> mem:
> > 12884901888,alloc_from_last_host?:false ,considerReservedCapacity?: true
> > 2013-06-09 16:33:55,914 DEBUG [allocator.impl.FirstFitAllocator]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Not using host 1;
> > numCpusGood: true; cpuFreqGood: false, host has capacity?true
> > 2013-06-09 16:33:55,916 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Checking if host: 7 has
> > enough capacity for requested CPU: 8000 and requested RAM: 12884901888 ,
> > cpuOverprovisioningFactor: 4.0
> > 2013-06-09 16:33:55,918 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Hosts's actual total
> CPU:
> > 64000 and CPU after applying overprovisioning: 256000
> > 2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Free CPU: 256000 ,
> > Requested CPU: 8000
> > 2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Free RAM: 50565599232 ,
> > Requested RAM: 12884901888
> > 2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Host has enough CPU and
> > RAM available
> > 2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Can alloc CPU
> from
> > host: 7, used: 0, reserved: 0, actual total: 64000, total with
> > overprovisioning: 256000; requested cpu:8000,alloc_from_last_host?:false
> > ,considerReservedCapacity?: true
> > 2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Can alloc MEM
> from
> > host: 7, used: 0, reserved: 0, total: 50565599232; requested mem:
> > 12884901888,alloc_from_last_host?:false ,considerReservedCapacity?: true
> > 2013-06-09 16:33:55,919 DEBUG [allocator.impl.FirstFitAllocator]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Not using host 7;
> > numCpusGood: true; cpuFreqGood: false, host has capacity?true
> > 2013-06-09 16:33:55,919 DEBUG [allocator.impl.FirstFitAllocator]
> > (Job-Executor-3:job-34 FirstFitRoutingAllocator) Host Allocator
> returning 0
> > suitable hosts
> > 2013-06-09 16:33:55,919 DEBUG [cloud.deploy.FirstFitPlanner]
> > (Job-Executor-3:job-34) No suitable hosts found
> > 2013-06-09 16:33:55,919 DEBUG [cloud.deploy.FirstFitPlanner]
> > (Job-Executor-3:job-34) No suitable hosts found under this Cluster: 1
> > 2013-06-09 16:33:55,919 DEBUG [cloud.deploy.FirstFitPlanner]
> > (Job-Executor-3:job-34) Could not find suitable Deployment Destination
> for
> > this VM under any clusters, returning.
> > 2013-06-09 16:33:55,924 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34) VM state transitted from :Starting to Stopped
> with
> > event: OperationFailedvm's original host id: null new host id: null host
> id
> > before state transition: null
> > 2013-06-09 16:33:55,928 DEBUG [cloud.vm.UserVmManagerImpl]
> > (Job-Executor-3:job-34) Destroying vm VM[User|web05] as it failed to
> create
> > 2013-06-09 16:33:55,934 DEBUG [cloud.capacity.CapacityManagerImpl]
> > (Job-Executor-3:job-34) VM state transitted from :Stopped to Error with
> > event: OperationFailedToErrorvm's original host id: null new host id:
> null
> > host id before state transition: null
> > 2013-06-09 16:33:55,981 INFO  [api.commands.DeployVMCmd]
> > (Job-Executor-3:job-34)
> > com.cloud.exception.InsufficientServerCapacityException: Unable to
> create a
> > deployment for VM[User|web05]Scope=interface com.cloud.dc.DataCenter;
> id=1
> > 2013-06-09 16:33:55,982 WARN  [cloud.api.ApiDispatcher]
> > (Job-Executor-3:job-34) class com.cloud.api.ServerApiException : Unable
> to
> > create a deployment for VM[User|web05]
> > 2013-06-09 16:33:55,982 DEBUG [cloud.async.AsyncJobManagerImpl]
> > (Job-Executor-3:job-34) Complete async job-34, jobStatus: 2, resultCode:
> > 530, result: Error Code: 533 Error text: Unable to create a deployment
> for
> > VM[User|web05]
> > 2013-06-09 16:34:00,892 DEBUG [cloud.async.AsyncJobManagerImpl]
> > (catalina-exec-6:null) Async job-34 completed
> > 2013-06-09 16:34:00,941 DEBUG [cloud.vm.UserVmManagerImpl]
> > (catalina-exec-2:null) THE WHERE CLAUSE IS:user_vm.id = ?
> >
>

Re: 自己生成的模板不能创建虚拟机的问题

Posted by 哈哈 <ya...@gmail.com>.
为什么我不能在这里发言?


On Sun, Jun 9, 2013 at 5:21 PM, 张晓飞 <zh...@oncloudit.com> wrote:

>  目测是资源不足导致
>
> 2013-06-09
>
>
>
> 张晓飞
>
>
>
> 发件人:张秉南 <zb...@gmail.com>
> 发送时间:2013-06-09 17:16
> 主题:自己生成的模板不能创建虚拟机的问题
> 收件人:"users-cn"<us...@cloudstack.apache.org>
> 抄送:
>
> 2013-06-09 16:33:45,900 DEBUG [cloud.server.StatsCollector]
> (StatsCollector-2:null) HostStatsCollector is running...
> 2013-06-09 16:33:46,569 DEBUG [agent.transport.Request]
> (StatsCollector-2:null) Seq 1-862126178: Received:  { Ans: , MgmtId:
> 42645977839493, via: 1, Ver: v1, Flags: 10, { GetHostStatsAnswer } }
> 2013-06-09 16:33:47,077 DEBUG
> [storage.secondary.SecondaryStorageManagerImpl] (secstorage-1:null) Zone 1
> is ready to launch secondary storage VM
> 2013-06-09 16:33:47,153 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl]
> (consoleproxy-1:null) Zone 1 is ready to launch console proxy
> 2013-06-09 16:33:47,195 DEBUG [agent.transport.Request]
> (StatsCollector-2:null) Seq 6-373948592: Received:  { Ans: , MgmtId:
> 42645977839493, via: 6, Ver: v1, Flags: 10, { GetHostStatsAnswer } }
> 2013-06-09 16:33:47,384 DEBUG
> [network.router.VirtualNetworkApplianceManagerImpl]
> (RouterStatusMonitor-1:null) Found 0 routers.
> 2013-06-09 16:33:47,859 DEBUG [agent.transport.Request]
> (StatsCollector-2:null) Seq 7-1222180958: Received:  { Ans: , MgmtId:
> 42645977839493, via: 7, Ver: v1, Flags: 10, { GetHostStatsAnswer } }
> 2013-06-09 16:33:51,384 DEBUG [cloud.server.StatsCollector]
> (StatsCollector-2:null) StorageCollector is running...
> 2013-06-09 16:33:51,445 DEBUG [agent.transport.Request]
> (StatsCollector-2:null) Seq 5-2010775630: Received:  { Ans: , MgmtId:
> 42645977839493, via: 5, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
> 2013-06-09 16:33:51,729 DEBUG [agent.transport.Request]
> (StatsCollector-2:null) Seq 1-862126179: Received:  { Ans: , MgmtId:
> 42645977839493, via: 1, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
> 2013-06-09 16:33:55,729 DEBUG [cloud.vm.UserVmManagerImpl]
> (catalina-exec-4:null) Allocating in the DB for vm
> 2013-06-09 16:33:55,729 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> (catalina-exec-4:null) Allocating entries for VM: VM[User|web05]
> 2013-06-09 16:33:55,734 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> (catalina-exec-4:null) Allocating nics for VM[User|web05]
> 2013-06-09 16:33:55,735 DEBUG [cloud.network.NetworkManagerImpl]
> (catalina-exec-4:null) Allocating nic for vm VM[User|web05] in network
> Ntwk[204|Guest|6] with requested profile NicProfile[0-0-null-null-null
> 2013-06-09 16:33:55,745 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> (catalina-exec-4:null) Allocaing disks for VM[User|web05]
> 2013-06-09 16:33:55,760 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> (catalina-exec-4:null) Allocation completed for VM: VM[User|web05]
> 2013-06-09 16:33:55,761 DEBUG [cloud.vm.UserVmManagerImpl]
> (catalina-exec-4:null) Successfully allocated DB entry for VM[User|web05]
> 2013-06-09 16:33:55,813 DEBUG [cloud.async.AsyncJobManagerImpl]
> (catalina-exec-4:null) submit async job-34, details: AsyncJobVO {id:34,
> userId: 2, accountId: 2, sessionKey: null, instanceType: VirtualMachine,
> instanceId: 89, cmd: com.cloud.api.commands.DeployVMCmd, cmdOriginator:
> null, cmdInfo:
>
> {"sessionkey":"YUkbfJ3wL9FSaGKqQrXsydfN1Oo\u003d","ctxUserId":"2","serviceOfferingId":"c55c591a-8845-4326-86cb-6873fa3e4df9","zoneId":"72c53a56-728f-424a-a219-97fcbc0efce1","templateId":"40fceb2c-3d6a-42e3-828b-a280278be47c","response":"json","id":"89","hypervisor":"KVM","name":"web05","diskOfferingId":"e5208413-2d37-4f16-a927-adaae90d3805","_":"1370766835511","ctxAccountId":"2","ctxStartEventId":"127","displayname":"web05"},
> cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0,
> processStatus: 0, resultCode: 0, result: null, initMsid: 42645977839493,
> completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
> 2013-06-09 16:33:55,814 DEBUG [cloud.async.AsyncJobManagerImpl]
> (Job-Executor-3:job-34) Executing com.cloud.api.commands.DeployVMCmd for
> job-34
> 2013-06-09 16:33:55,874 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34) VM state transitted from :Stopped to Starting with
> event: StartRequestedvm's original host id: null new host id: null host id
> before state transition: null
> 2013-06-09 16:33:55,874 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> (Job-Executor-3:job-34) Successfully transitioned to start state for
> VM[User|web05] reservation id = 7f619259-e242-4020-9271-2dba65d0cdf6
> 2013-06-09 16:33:55,877 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> (Job-Executor-3:job-34) Trying to deploy VM, vm has dcId: 1 and podId: null
> 2013-06-09 16:33:55,877 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> (Job-Executor-3:job-34) Deploy avoids pods: null, clusters: null, hosts:
> null
> 2013-06-09 16:33:55,880 DEBUG [cloud.deploy.FirstFitPlanner]
> (Job-Executor-3:job-34) DeploymentPlanner allocation algorithm: random
> 2013-06-09 16:33:55,880 DEBUG [cloud.deploy.FirstFitPlanner]
> (Job-Executor-3:job-34) Trying to allocate a host and storage pools from
> dc:1, pod:null,cluster:null, requested cpu: 8000, requested ram:
> 12884901888
> 2013-06-09 16:33:55,880 DEBUG [cloud.deploy.FirstFitPlanner]
> (Job-Executor-3:job-34) Is ROOT volume READY (pool already allocated)?: No
> 2013-06-09 16:33:55,880 DEBUG [cloud.deploy.FirstFitPlanner]
> (Job-Executor-3:job-34) Searching all possible resources under this Zone: 1
> 2013-06-09 16:33:55,882 DEBUG [cloud.deploy.FirstFitPlanner]
> (Job-Executor-3:job-34) Listing clusters in order of aggregate capacity,
> that have (atleast one host with) enough CPU and RAM capacity under this
> Zone: 1
> 2013-06-09 16:33:55,883 DEBUG [cloud.deploy.FirstFitPlanner]
> (Job-Executor-3:job-34) CPUOverprovisioningFactor considered: 4.0
> 2013-06-09 16:33:55,894 DEBUG [cloud.deploy.FirstFitPlanner]
> (Job-Executor-3:job-34) Checking resources in Cluster: 1 under Pod: 1
> 2013-06-09 16:33:55,894 DEBUG [cloud.deploy.FirstFitPlanner]
> (Job-Executor-3:job-34) Calling HostAllocators to find suitable hosts
> 2013-06-09 16:33:55,894 DEBUG [allocator.impl.FirstFitAllocator]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Looking for hosts in dc: 1
>  pod:1  cluster:1
> 2013-06-09 16:33:55,894 DEBUG [allocator.impl.FirstFitAllocator]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Looking for hosts having
> tag specified on SvcOffering:web
> 2013-06-09 16:33:55,897 DEBUG [allocator.impl.FirstFitAllocator]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Hosts with tag 'web'
> are:[Host[-1-Routing], Host[-6-Routing], Host[-7-Routing]]
> 2013-06-09 16:33:55,897 DEBUG [allocator.impl.FirstFitAllocator]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) FirstFitAllocator has 3
> hosts to check for allocation: [Host[-6-Routing], Host[-1-Routing],
> Host[-7-Routing]]
> 2013-06-09 16:33:55,902 DEBUG [allocator.impl.FirstFitAllocator]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Found 3 hosts for
> allocation after prioritization: [Host[-6-Routing], Host[-1-Routing],
> Host[-7-Routing]]
> 2013-06-09 16:33:55,902 DEBUG [allocator.impl.FirstFitAllocator]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Looking for speed=8000Mhz,
> Ram=12288
> 2013-06-09 16:33:55,904 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Checking if host: 6 has
> enough capacity for requested CPU: 8000 and requested RAM: 12884901888 ,
> cpuOverprovisioningFactor: 4.0
> 2013-06-09 16:33:55,907 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Hosts's actual total CPU:
> 40416 and CPU after applying overprovisioning: 161664
> 2013-06-09 16:33:55,907 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Free CPU: 153664 ,
> Requested CPU: 8000
> 2013-06-09 16:33:55,908 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Free RAM: 12300541952 ,
> Requested RAM: 12884901888
> 2013-06-09 16:33:55,908 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Failed to alloc
> resource from host: 6 reservedCpu: 0, used cpu: 8000, requested cpu: 8000,
> actual total cpu: 40416, total cpu with overprovisioning: 161664,
> reservedMem: 0, used Mem: 12884901888, requested mem: 12884901888, total
> Mem:25185443840 ,considerReservedCapacity?: true
> 2013-06-09 16:33:55,908 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Host does not have enough
> RAM available, cannot allocate to this host.
> 2013-06-09 16:33:55,908 DEBUG [allocator.impl.FirstFitAllocator]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Not using host 6;
> numCpusGood: true; cpuFreqGood: true, host has capacity?false
> 2013-06-09 16:33:55,910 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Checking if host: 1 has
> enough capacity for requested CPU: 8000 and requested RAM: 12884901888 ,
> cpuOverprovisioningFactor: 4.0
> 2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Hosts's actual total CPU:
> 64000 and CPU after applying overprovisioning: 256000
> 2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Free CPU: 254500 ,
> Requested CPU: 8000
> 2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Free RAM: 49085001728 ,
> Requested RAM: 12884901888
> 2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Host has enough CPU and
> RAM available
> 2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Can alloc CPU from
> host: 1, used: 1500, reserved: 0, actual total: 64000, total with
> overprovisioning: 256000; requested cpu:8000,alloc_from_last_host?:false
> ,considerReservedCapacity?: true
> 2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Can alloc MEM from
> host: 1, used: 1476395008, reserved: 0, total: 50561396736; requested mem:
> 12884901888,alloc_from_last_host?:false ,considerReservedCapacity?: true
> 2013-06-09 16:33:55,914 DEBUG [allocator.impl.FirstFitAllocator]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Not using host 1;
> numCpusGood: true; cpuFreqGood: false, host has capacity?true
> 2013-06-09 16:33:55,916 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Checking if host: 7 has
> enough capacity for requested CPU: 8000 and requested RAM: 12884901888 ,
> cpuOverprovisioningFactor: 4.0
> 2013-06-09 16:33:55,918 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Hosts's actual total CPU:
> 64000 and CPU after applying overprovisioning: 256000
> 2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Free CPU: 256000 ,
> Requested CPU: 8000
> 2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Free RAM: 50565599232 ,
> Requested RAM: 12884901888
> 2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Host has enough CPU and
> RAM available
> 2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Can alloc CPU from
> host: 7, used: 0, reserved: 0, actual total: 64000, total with
> overprovisioning: 256000; requested cpu:8000,alloc_from_last_host?:false
> ,considerReservedCapacity?: true
> 2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Can alloc MEM from
> host: 7, used: 0, reserved: 0, total: 50565599232; requested mem:
> 12884901888,alloc_from_last_host?:false ,considerReservedCapacity?: true
> 2013-06-09 16:33:55,919 DEBUG [allocator.impl.FirstFitAllocator]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Not using host 7;
> numCpusGood: true; cpuFreqGood: false, host has capacity?true
> 2013-06-09 16:33:55,919 DEBUG [allocator.impl.FirstFitAllocator]
> (Job-Executor-3:job-34 FirstFitRoutingAllocator) Host Allocator returning 0
> suitable hosts
> 2013-06-09 16:33:55,919 DEBUG [cloud.deploy.FirstFitPlanner]
> (Job-Executor-3:job-34) No suitable hosts found
> 2013-06-09 16:33:55,919 DEBUG [cloud.deploy.FirstFitPlanner]
> (Job-Executor-3:job-34) No suitable hosts found under this Cluster: 1
> 2013-06-09 16:33:55,919 DEBUG [cloud.deploy.FirstFitPlanner]
> (Job-Executor-3:job-34) Could not find suitable Deployment Destination for
> this VM under any clusters, returning.
> 2013-06-09 16:33:55,924 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34) VM state transitted from :Starting to Stopped with
> event: OperationFailedvm's original host id: null new host id: null host id
> before state transition: null
> 2013-06-09 16:33:55,928 DEBUG [cloud.vm.UserVmManagerImpl]
> (Job-Executor-3:job-34) Destroying vm VM[User|web05] as it failed to create
> 2013-06-09 16:33:55,934 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-3:job-34) VM state transitted from :Stopped to Error with
> event: OperationFailedToErrorvm's original host id: null new host id: null
> host id before state transition: null
> 2013-06-09 16:33:55,981 INFO  [api.commands.DeployVMCmd]
> (Job-Executor-3:job-34)
> com.cloud.exception.InsufficientServerCapacityException: Unable to create a
> deployment for VM[User|web05]Scope=interface com.cloud.dc.DataCenter; id=1
> 2013-06-09 16:33:55,982 WARN  [cloud.api.ApiDispatcher]
> (Job-Executor-3:job-34) class com.cloud.api.ServerApiException : Unable to
> create a deployment for VM[User|web05]
> 2013-06-09 16:33:55,982 DEBUG [cloud.async.AsyncJobManagerImpl]
> (Job-Executor-3:job-34) Complete async job-34, jobStatus: 2, resultCode:
> 530, result: Error Code: 533 Error text: Unable to create a deployment for
> VM[User|web05]
> 2013-06-09 16:34:00,892 DEBUG [cloud.async.AsyncJobManagerImpl]
> (catalina-exec-6:null) Async job-34 completed
> 2013-06-09 16:34:00,941 DEBUG [cloud.vm.UserVmManagerImpl]
> (catalina-exec-2:null) THE WHERE CLAUSE IS:user_vm.id = ?
>

回复: 自己生成的模板不能创建虚拟机的问题

Posted by 张晓飞 <zh...@oncloudit.com>.
 目测是资源不足导致

2013-06-09



张晓飞



发件人:张秉南 <zb...@gmail.com>
发送时间:2013-06-09 17:16
主题:自己生成的模板不能创建虚拟机的问题
收件人:"users-cn"<us...@cloudstack.apache.org>
抄送:

2013-06-09 16:33:45,900 DEBUG [cloud.server.StatsCollector] 
(StatsCollector-2:null) HostStatsCollector is running... 
2013-06-09 16:33:46,569 DEBUG [agent.transport.Request] 
(StatsCollector-2:null) Seq 1-862126178: Received:  { Ans: , MgmtId: 
42645977839493, via: 1, Ver: v1, Flags: 10, { GetHostStatsAnswer } } 
2013-06-09 16:33:47,077 DEBUG 
[storage.secondary.SecondaryStorageManagerImpl] (secstorage-1:null) Zone 1 
is ready to launch secondary storage VM 
2013-06-09 16:33:47,153 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] 
(consoleproxy-1:null) Zone 1 is ready to launch console proxy 
2013-06-09 16:33:47,195 DEBUG [agent.transport.Request] 
(StatsCollector-2:null) Seq 6-373948592: Received:  { Ans: , MgmtId: 
42645977839493, via: 6, Ver: v1, Flags: 10, { GetHostStatsAnswer } } 
2013-06-09 16:33:47,384 DEBUG 
[network.router.VirtualNetworkApplianceManagerImpl] 
(RouterStatusMonitor-1:null) Found 0 routers. 
2013-06-09 16:33:47,859 DEBUG [agent.transport.Request] 
(StatsCollector-2:null) Seq 7-1222180958: Received:  { Ans: , MgmtId: 
42645977839493, via: 7, Ver: v1, Flags: 10, { GetHostStatsAnswer } } 
2013-06-09 16:33:51,384 DEBUG [cloud.server.StatsCollector] 
(StatsCollector-2:null) StorageCollector is running... 
2013-06-09 16:33:51,445 DEBUG [agent.transport.Request] 
(StatsCollector-2:null) Seq 5-2010775630: Received:  { Ans: , MgmtId: 
42645977839493, via: 5, Ver: v1, Flags: 10, { GetStorageStatsAnswer } } 
2013-06-09 16:33:51,729 DEBUG [agent.transport.Request] 
(StatsCollector-2:null) Seq 1-862126179: Received:  { Ans: , MgmtId: 
42645977839493, via: 1, Ver: v1, Flags: 10, { GetStorageStatsAnswer } } 
2013-06-09 16:33:55,729 DEBUG [cloud.vm.UserVmManagerImpl] 
(catalina-exec-4:null) Allocating in the DB for vm 
2013-06-09 16:33:55,729 DEBUG [cloud.vm.VirtualMachineManagerImpl] 
(catalina-exec-4:null) Allocating entries for VM: VM[User|web05] 
2013-06-09 16:33:55,734 DEBUG [cloud.vm.VirtualMachineManagerImpl] 
(catalina-exec-4:null) Allocating nics for VM[User|web05] 
2013-06-09 16:33:55,735 DEBUG [cloud.network.NetworkManagerImpl] 
(catalina-exec-4:null) Allocating nic for vm VM[User|web05] in network 
Ntwk[204|Guest|6] with requested profile NicProfile[0-0-null-null-null 
2013-06-09 16:33:55,745 DEBUG [cloud.vm.VirtualMachineManagerImpl] 
(catalina-exec-4:null) Allocaing disks for VM[User|web05] 
2013-06-09 16:33:55,760 DEBUG [cloud.vm.VirtualMachineManagerImpl] 
(catalina-exec-4:null) Allocation completed for VM: VM[User|web05] 
2013-06-09 16:33:55,761 DEBUG [cloud.vm.UserVmManagerImpl] 
(catalina-exec-4:null) Successfully allocated DB entry for VM[User|web05] 
2013-06-09 16:33:55,813 DEBUG [cloud.async.AsyncJobManagerImpl] 
(catalina-exec-4:null) submit async job-34, details: AsyncJobVO {id:34, 
userId: 2, accountId: 2, sessionKey: null, instanceType: VirtualMachine, 
instanceId: 89, cmd: com.cloud.api.commands.DeployVMCmd, cmdOriginator: 
null, cmdInfo: 
{"sessionkey":"YUkbfJ3wL9FSaGKqQrXsydfN1Oo\u003d","ctxUserId":"2","serviceOfferingId":"c55c591a-8845-4326-86cb-6873fa3e4df9","zoneId":"72c53a56-728f-424a-a219-97fcbc0efce1","templateId":"40fceb2c-3d6a-42e3-828b-a280278be47c","response":"json","id":"89","hypervisor":"KVM","name":"web05","diskOfferingId":"e5208413-2d37-4f16-a927-adaae90d3805","_":"1370766835511","ctxAccountId":"2","ctxStartEventId":"127","displayname":"web05"}, 
cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0, 
processStatus: 0, resultCode: 0, result: null, initMsid: 42645977839493, 
completeMsid: null, lastUpdated: null, lastPolled: null, created: null} 
2013-06-09 16:33:55,814 DEBUG [cloud.async.AsyncJobManagerImpl] 
(Job-Executor-3:job-34) Executing com.cloud.api.commands.DeployVMCmd for 
job-34 
2013-06-09 16:33:55,874 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34) VM state transitted from :Stopped to Starting with 
event: StartRequestedvm's original host id: null new host id: null host id 
before state transition: null 
2013-06-09 16:33:55,874 DEBUG [cloud.vm.VirtualMachineManagerImpl] 
(Job-Executor-3:job-34) Successfully transitioned to start state for 
VM[User|web05] reservation id = 7f619259-e242-4020-9271-2dba65d0cdf6 
2013-06-09 16:33:55,877 DEBUG [cloud.vm.VirtualMachineManagerImpl] 
(Job-Executor-3:job-34) Trying to deploy VM, vm has dcId: 1 and podId: null 
2013-06-09 16:33:55,877 DEBUG [cloud.vm.VirtualMachineManagerImpl] 
(Job-Executor-3:job-34) Deploy avoids pods: null, clusters: null, hosts: 
null 
2013-06-09 16:33:55,880 DEBUG [cloud.deploy.FirstFitPlanner] 
(Job-Executor-3:job-34) DeploymentPlanner allocation algorithm: random 
2013-06-09 16:33:55,880 DEBUG [cloud.deploy.FirstFitPlanner] 
(Job-Executor-3:job-34) Trying to allocate a host and storage pools from 
dc:1, pod:null,cluster:null, requested cpu: 8000, requested ram: 12884901888 
2013-06-09 16:33:55,880 DEBUG [cloud.deploy.FirstFitPlanner] 
(Job-Executor-3:job-34) Is ROOT volume READY (pool already allocated)?: No 
2013-06-09 16:33:55,880 DEBUG [cloud.deploy.FirstFitPlanner] 
(Job-Executor-3:job-34) Searching all possible resources under this Zone: 1 
2013-06-09 16:33:55,882 DEBUG [cloud.deploy.FirstFitPlanner] 
(Job-Executor-3:job-34) Listing clusters in order of aggregate capacity, 
that have (atleast one host with) enough CPU and RAM capacity under this 
Zone: 1 
2013-06-09 16:33:55,883 DEBUG [cloud.deploy.FirstFitPlanner] 
(Job-Executor-3:job-34) CPUOverprovisioningFactor considered: 4.0 
2013-06-09 16:33:55,894 DEBUG [cloud.deploy.FirstFitPlanner] 
(Job-Executor-3:job-34) Checking resources in Cluster: 1 under Pod: 1 
2013-06-09 16:33:55,894 DEBUG [cloud.deploy.FirstFitPlanner] 
(Job-Executor-3:job-34) Calling HostAllocators to find suitable hosts 
2013-06-09 16:33:55,894 DEBUG [allocator.impl.FirstFitAllocator] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Looking for hosts in dc: 1 
 pod:1  cluster:1 
2013-06-09 16:33:55,894 DEBUG [allocator.impl.FirstFitAllocator] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Looking for hosts having 
tag specified on SvcOffering:web 
2013-06-09 16:33:55,897 DEBUG [allocator.impl.FirstFitAllocator] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Hosts with tag 'web' 
are:[Host[-1-Routing], Host[-6-Routing], Host[-7-Routing]] 
2013-06-09 16:33:55,897 DEBUG [allocator.impl.FirstFitAllocator] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) FirstFitAllocator has 3 
hosts to check for allocation: [Host[-6-Routing], Host[-1-Routing], 
Host[-7-Routing]] 
2013-06-09 16:33:55,902 DEBUG [allocator.impl.FirstFitAllocator] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Found 3 hosts for 
allocation after prioritization: [Host[-6-Routing], Host[-1-Routing], 
Host[-7-Routing]] 
2013-06-09 16:33:55,902 DEBUG [allocator.impl.FirstFitAllocator] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Looking for speed=8000Mhz, 
Ram=12288 
2013-06-09 16:33:55,904 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Checking if host: 6 has 
enough capacity for requested CPU: 8000 and requested RAM: 12884901888 , 
cpuOverprovisioningFactor: 4.0 
2013-06-09 16:33:55,907 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Hosts's actual total CPU: 
40416 and CPU after applying overprovisioning: 161664 
2013-06-09 16:33:55,907 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Free CPU: 153664 , 
Requested CPU: 8000 
2013-06-09 16:33:55,908 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Free RAM: 12300541952 , 
Requested RAM: 12884901888 
2013-06-09 16:33:55,908 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Failed to alloc 
resource from host: 6 reservedCpu: 0, used cpu: 8000, requested cpu: 8000, 
actual total cpu: 40416, total cpu with overprovisioning: 161664, 
reservedMem: 0, used Mem: 12884901888, requested mem: 12884901888, total 
Mem:25185443840 ,considerReservedCapacity?: true 
2013-06-09 16:33:55,908 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Host does not have enough 
RAM available, cannot allocate to this host. 
2013-06-09 16:33:55,908 DEBUG [allocator.impl.FirstFitAllocator] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Not using host 6; 
numCpusGood: true; cpuFreqGood: true, host has capacity?false 
2013-06-09 16:33:55,910 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Checking if host: 1 has 
enough capacity for requested CPU: 8000 and requested RAM: 12884901888 , 
cpuOverprovisioningFactor: 4.0 
2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Hosts's actual total CPU: 
64000 and CPU after applying overprovisioning: 256000 
2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Free CPU: 254500 , 
Requested CPU: 8000 
2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Free RAM: 49085001728 , 
Requested RAM: 12884901888 
2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Host has enough CPU and 
RAM available 
2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Can alloc CPU from 
host: 1, used: 1500, reserved: 0, actual total: 64000, total with 
overprovisioning: 256000; requested cpu:8000,alloc_from_last_host?:false 
,considerReservedCapacity?: true 
2013-06-09 16:33:55,913 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Can alloc MEM from 
host: 1, used: 1476395008, reserved: 0, total: 50561396736; requested mem: 
12884901888,alloc_from_last_host?:false ,considerReservedCapacity?: true 
2013-06-09 16:33:55,914 DEBUG [allocator.impl.FirstFitAllocator] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Not using host 1; 
numCpusGood: true; cpuFreqGood: false, host has capacity?true 
2013-06-09 16:33:55,916 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Checking if host: 7 has 
enough capacity for requested CPU: 8000 and requested RAM: 12884901888 , 
cpuOverprovisioningFactor: 4.0 
2013-06-09 16:33:55,918 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Hosts's actual total CPU: 
64000 and CPU after applying overprovisioning: 256000 
2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Free CPU: 256000 , 
Requested CPU: 8000 
2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Free RAM: 50565599232 , 
Requested RAM: 12884901888 
2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Host has enough CPU and 
RAM available 
2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Can alloc CPU from 
host: 7, used: 0, reserved: 0, actual total: 64000, total with 
overprovisioning: 256000; requested cpu:8000,alloc_from_last_host?:false 
,considerReservedCapacity?: true 
2013-06-09 16:33:55,919 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) STATS: Can alloc MEM from 
host: 7, used: 0, reserved: 0, total: 50565599232; requested mem: 
12884901888,alloc_from_last_host?:false ,considerReservedCapacity?: true 
2013-06-09 16:33:55,919 DEBUG [allocator.impl.FirstFitAllocator] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Not using host 7; 
numCpusGood: true; cpuFreqGood: false, host has capacity?true 
2013-06-09 16:33:55,919 DEBUG [allocator.impl.FirstFitAllocator] 
(Job-Executor-3:job-34 FirstFitRoutingAllocator) Host Allocator returning 0 
suitable hosts 
2013-06-09 16:33:55,919 DEBUG [cloud.deploy.FirstFitPlanner] 
(Job-Executor-3:job-34) No suitable hosts found 
2013-06-09 16:33:55,919 DEBUG [cloud.deploy.FirstFitPlanner] 
(Job-Executor-3:job-34) No suitable hosts found under this Cluster: 1 
2013-06-09 16:33:55,919 DEBUG [cloud.deploy.FirstFitPlanner] 
(Job-Executor-3:job-34) Could not find suitable Deployment Destination for 
this VM under any clusters, returning. 
2013-06-09 16:33:55,924 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34) VM state transitted from :Starting to Stopped with 
event: OperationFailedvm's original host id: null new host id: null host id 
before state transition: null 
2013-06-09 16:33:55,928 DEBUG [cloud.vm.UserVmManagerImpl] 
(Job-Executor-3:job-34) Destroying vm VM[User|web05] as it failed to create 
2013-06-09 16:33:55,934 DEBUG [cloud.capacity.CapacityManagerImpl] 
(Job-Executor-3:job-34) VM state transitted from :Stopped to Error with 
event: OperationFailedToErrorvm's original host id: null new host id: null 
host id before state transition: null 
2013-06-09 16:33:55,981 INFO  [api.commands.DeployVMCmd] 
(Job-Executor-3:job-34) 
com.cloud.exception.InsufficientServerCapacityException: Unable to create a 
deployment for VM[User|web05]Scope=interface com.cloud.dc.DataCenter; id=1 
2013-06-09 16:33:55,982 WARN  [cloud.api.ApiDispatcher] 
(Job-Executor-3:job-34) class com.cloud.api.ServerApiException : Unable to 
create a deployment for VM[User|web05] 
2013-06-09 16:33:55,982 DEBUG [cloud.async.AsyncJobManagerImpl] 
(Job-Executor-3:job-34) Complete async job-34, jobStatus: 2, resultCode: 
530, result: Error Code: 533 Error text: Unable to create a deployment for 
VM[User|web05] 
2013-06-09 16:34:00,892 DEBUG [cloud.async.AsyncJobManagerImpl] 
(catalina-exec-6:null) Async job-34 completed 
2013-06-09 16:34:00,941 DEBUG [cloud.vm.UserVmManagerImpl] 
(catalina-exec-2:null) THE WHERE CLAUSE IS:user_vm.id = ?