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 gy20131128 <gy...@163.com> on 2013/11/28 08:45:03 UTC

建立实例失败,是不是资源不够了

2013-11-28 15:28:21,374 WARN  [apache.cloudstack.alerts] (Job-Executor-1:job-519 = [ ba8d0205-a2e4-4b18-9afb-d7ba576ccbec ])  alertType:: 8 // dataCenterId:: 1 // podId:: null // clusterId:: null // message:: Failed to deploy Vm with Id: 128, on Host with Id: null
2013-11-28 15:28:21,406 INFO  [user.vm.DeployVMCmd] (Job-Executor-1:job-519 = [ ba8d0205-a2e4-4b18-9afb-d7ba576ccbec ]) com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[User|centos-caoyong-11]Scope=interface com.cloud.dc.DataCenter; id=1
2013-11-28 15:28:21,406 INFO  [user.vm.DeployVMCmd] (Job-Executor-1:job-519 = [ ba8d0205-a2e4-4b18-9afb-d7ba576ccbec ]) Unable to create a deployment for VM[User|centos-caoyong-11]
com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[User|centos-caoyong-11]Scope=interface com.cloud.dc.DataCenter; id=1
        at org.apache.cloudstack.engine.cloud.entity.api.VMEntityManagerImpl.reserveVirtualMachine(VMEntityManagerImpl.java:209)
        at org.apache.cloudstack.engine.cloud.entity.api.VirtualMachineEntityImpl.reserve(VirtualMachineEntityImpl.java:198)
        at com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3405)
        at com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:2966)
        at com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:2952)
        at com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
        at org.apache.cloudstack.api.command.user.vm.DeployVMCmd.execute(DeployVMCmd.java:420)
        at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:158)
        at com.cloud.async.AsyncJobManagerImpl$1.run(AsyncJobManagerImpl.java:531)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
        at java.util.concurrent.FutureTask.run(FutureTask.java:166)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
        at java.lang.Thread.run(Thread.java:701)
2013-11-28 15:28:21,410 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-1:job-519 = [ ba8d0205-a2e4-4b18-9afb-d7ba576ccbec ]) Complete async job-519 = [ ba8d0205-a2e4-4b18-9afb-d7ba576ccbec ], jobStatus: 2, resultCode: 530, result: Error Code: 533 Error text: Unable to create a deployment for VM[User|centos-caoyong-11]
2013-11-28 15:28:23,247 DEBUG [cloud.server.StatsCollector] (StatsCollector-3:null) VmStatsCollector is running...
2013-11-28 15:28:23,266 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-71:null) Seq 1-928645138: Executing request
2013-11-28 15:28:23,681 DEBUG [xen.resource.CitrixResourceBase] (DirectAgent-71:null) Vm cpu utilization 0.01296875
2013-11-28 15:28:23,681 DEBUG [xen.resource.CitrixResourceBase] (DirectAgent-71:null) Vm cpu utilization 0.02015625
2013-11-28 15:28:23,817 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-71:null) Seq 1-928645138: Response Received:
2013-11-28 15:28:23,817 DEBUG [agent.transport.Request] (StatsCollector-3:null) Seq 1-928645138: Received:  { Ans: , MgmtId: 345052442326, via: 1, Ver: v1, Flags: 10, { GetVmStatsAnswer } }
2013-11-28 15:28:23,848 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-48:null) Seq 10-1324613650: Executing request
2013-11-28 15:28:24,118 DEBUG [cloud.api.ApiServlet] (catalina-exec-9:null) ===START===  172.20.60.231 -- GET  command=queryAsyncJobResult&jobId=ba8d0205-a2e4-4b18-9afb-d7ba576ccbec&response=json&sessionkey=ntkMKkVSEikbd5lMNAQt8ELhXXY%3D&_=1385623692322
2013-11-28 15:28:24,140 DEBUG [cloud.async.AsyncJobManagerImpl] (catalina-exec-9:null) Async job-519 = [ ba8d0205-a2e4-4b18-9afb-d7ba576ccbec ] completed
2013-11-28 15:28:24,209 DEBUG [cloud.api.ApiServlet] (catalina-exec-9:null) ===END===  172.20.60.231 -- GET  command=queryAsyncJobResult&jobId=ba8d0205-a2e4-4b18-9afb-d7ba576ccbec&response=json&sessionkey=ntkMKkVSEikbd5lMNAQt8ELhXXY%3D&_=1385623692322
2013-11-28 15:28:24,219 DEBUG [xen.resource.CitrixResourceBase] (DirectAgent-48:null) Vm cpu utilization 0.59
2013-11-28 15:28:24,219 DEBUG [xen.resource.CitrixResourceBase] (DirectAgent-48:null) Vm cpu utilization 1.25
2013-11-28 15:28:24,219 DEBUG [xen.resource.CitrixResourceBase] (DirectAgent-48:null) Vm cpu utilization 0.01
2013-11-28 15:28:24,219 DEBUG [xen.resource.CitrixResourceBase] (DirectAgent-48:null) Vm cpu utilization 0.00953125
2013-11-28 15:28:24,219 DEBUG [xen.resource.CitrixResourceBase] (DirectAgent-48:null) Vm cpu utilization 0.009999999999999998
2013-11-28 15:28:24,219 DEBUG [xen.resource.CitrixResourceBase] (DirectAgent-48:null) Vm cpu utilization 0.01
2013-11-28 15:28:24,219 DEBUG [xen.resource.CitrixResourceBase] (DirectAgent-48:null) Vm cpu utilization 0.010468749999999999
2013-11-28 15:28:24,249 DEBUG [cloud.api.ApiServlet] (catalina-exec-8:null) ===START===  172.20.60.231 -- GET  command=listVirtualMachines&id=d6268694-19e3-47b0-8f58-4721ff1b5e3b&response=json&sessionkey=ntkMKkVSEikbd5lMNAQt8ELhXXY%3D&_=1385623692421
2013-11-28 15:28:24,276 DEBUG [cloud.api.ApiServlet] (catalina-exec-8:null) ===END===  172.20.60.231 -- GET  command=listVirtualMachines&id=d6268694-19e3-47b0-8f58-4721ff1b5e3b&response=json&sessionkey=ntkMKkVSEikbd5lMNAQt8ELhXXY%3D&_=1385623692421
2013-11-28 15:28:24,573 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-48:null) Seq 10-1324613650: Response Received:
2013-11-28 15:28:24,574 DEBUG [agent.transport.Request] (StatsCollector-3:null) Seq 10-1324613650: Received:  { Ans: , MgmtId: 345052442326, via: 10, Ver: v1, Flags: 10, { GetVmStatsAnswer } }
2013-11-28 15:28:24,606 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-13:null) Seq 12-996802578: Executing request
2013-11-28 15:28:25,150 DEBUG [xen.resource.CitrixResourceBase] (DirectAgent-13:null) Vm cpu utilization 0.9537500000000001
2013-11-28 15:28:25,150 DEBUG [xen.resource.CitrixResourceBase] (DirectAgent-13:null) Vm cpu utilization 0.0103125
2013-11-28 15:28:25,150 DEBUG [xen.resource.CitrixResourceBase] (DirectAgent-13:null) Vm cpu utilization 0.00984375
2013-11-28 15:28:25,150 DEBUG [xen.resource.CitrixResourceBase] (DirectAgent-13:null) Vm cpu utilization 1.19625
2013-11-28 15:28:25,150 DEBUG [xen.resource.CitrixResourceBase] (DirectAgent-13:null) Vm cpu utilization 1.0875
2013-11-28 15:28:25,150 DEBUG [xen.resource.CitrixResourceBase] (DirectAgent-13:null) Vm cpu utilization 1.7425
2013-11-28 15:28:25,504 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-13:null) Seq 12-996802578: Response Received:
2013-11-28 15:28:25,504 DEBUG [agent.transport.Request] (StatsCollector-3:null) Seq 12-996802578: Received:  { Ans: , MgmtId: 345052442326, via: 12, Ver: v1, Flags: 10, { GetVmStatsAnswer } }
2013-11-28 15:28:25,558 DEBUG [agent.manager.AgentManagerImpl] (AgentManager-Handler-13:null) SeqA 2-263912: Processing Seq 2-263912:  { Cmd , MgmtId: -1, via: 2, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":2,"_loadInfo":"{\n  \"connections\": []\n}","wait":0}}] }
2013-11-28 15:28:25,562 DEBUG [agent.manager.AgentManagerImpl] (AgentManager-Handler-13:null) SeqA 2-263912: Sending Seq 2-263912:  { Ans: , MgmtId: 345052442326, via: 2, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
2013-11-28 15:28:26,523 DEBUG [cloud.server.StatsCollector] (StatsCollector-2:null) StorageCollector is running...
2013-11-28 15:28:26,607 DEBUG [agent.transport.Request] (StatsCollector-2:null) Seq 3-734789643: Received:  { Ans: , MgmtId: 345052442326, via: 3, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
2013-11-28 15:28:26,615 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-46:null) Seq 1-928645139: Executing request
2013-11-28 15:28:27,595 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-46:null) Seq 1-928645139: Response Received:
2013-11-28 15:28:27,595 DEBUG [agent.transport.Request] (StatsCollector-2:null) Seq 1-928645139: Received:  { Ans: , MgmtId: 345052442326, via: 1, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
2013-11-28 15:28:27,601 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-28:null) Seq 10-1324613651: Executing request
2013-11-28 15:28:28,261 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-28:null) Seq 10-1324613651: Response Received:
2013-11-28 15:28:28,261 DEBUG [agent.transport.Request] (StatsCollector-2:null) Seq 10-1324613651: Received:  { Ans: , MgmtId: 345052442326, via: 10, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
2013-11-28 15:28:28,267 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-51:null) Seq 12-996802579: Executing request
2013-11-28 15:28:28,962 DEBUG [storage.secondary.SecondaryStorageManagerImpl] (secstorage-1:null) Zone 1 is ready to launch secondary storage VM
2013-11-28 15:28:29,095 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] (consoleproxy-1:null) Zone 1 is ready to launch console proxy
2013-11-28 15:28:30,001 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-51:null) Seq 12-996802579: Response Received:
2013-11-28 15:28:30,001 DEBUG [agent.transport.Request] (StatsCollector-2:null) Seq 12-996802579: Received:  { Ans: , MgmtId: 345052442326, via: 12, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }