对,检查一下吧,找找原因。
brito.w...@gmail.com
?发件人:?yhz...@pipgame.com发送时间:?2014-03-25?13:47收件人:?cloudstackusers...@cloudstack.apache.org主题:?回复:
回复: 添加实例不成功VR的系统日志么
?
?
?
?
?
赵元海
平台MIS部
9095
yhz...@pipgame.com
*****************************************************
?
发件人: brito.w...@gmail.com
发送时间: 2014-03-25 13:36
收件人: users-cn
抄送:
主题: 回复: 回复: 添加实例不成功
?
我看日志结果是:v-router不能把你的VM的网络规则应用的v-router中,具体是为什么这样会失败,就看不到了。如果可以的话,销毁一下v-router,再让他重建一下试试。如果不可以销毁的话,你去拿一下v-router的日志看看或者可以的话调试一下v-router.
?
brito.w...@gmail.com
?发件人:?yhz...@pipgame.com发送时间:?2014-03-25?13:00收件人:?cloudstackusers...@cloudstack.apache.org主题:?回复:
回复: 添加实例不成功我这是4.2.0的环境。。VR在线上运行着。。新添加实例的时候报的这个错误,主机的资源还很充足
4.2.1有这问题么
?
?
?
?
?
赵元海
平台MIS部
9095
yhz...@pipgame.com
*****************************************************
?
发件人: brito.w...@gmail.com
发送时间: 2014-03-25 12:39
收件人: users-cn
抄送:
主题: 回复: 添加实例不成功
?
?
?
?
?
?
?
我不知道你哪儿是cloudstack几点几的环境,你查看一下是不是v-router启动不起来?我记得cloudstack某一个版本中有关创建系统虚拟机有一个Bug,系统虚拟机在一种特别情况下会尝试在无效的主机或集群上创建,你先检查一下集群和主机的情况,把无效的禁用掉或者删除掉,看看能否把VM创建起来。
?
?
brito.w...@gmail.com
?发件人:?yhz...@pipgame.com发送时间:?2014-03-25?09:47收件人:?cloudstackusers...@cloudstack.apache.org主题:?添加实例不成功HI
大家帮我看一下。。创建实例不成功
?
2014-03-25 09:34:44,843 DEBUG [agent.transport.Request] (Job-Executor-7:job-237
= [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Seq 1-2085489885: Executing:? { Cmd
, MgmtId: 264018885718825, via: 1, Ver: v1, Flags: 100111,
[{"com.cloud.agent.api.routing.SavePasswordCommand":{"password":"fnirq_cnffjbeq","vmIpAddress":"10.10.30.66","vmName":"pipProxy2","executeInSequence":true,"accessDetails":{"router.guest.ip":"10.10.30.1","zone.network.type":"Advanced","router.ip":"169.254.1.159","router.name":"r-4-VM"},"wait":0}},{"com.cloud.agent.api.routing.VmDataCommand":{"vmIpAddress":"10.10.30.66","vmName":"pipProxy2","executeInSequence":true,"accessDetails":{"router.guest.ip":"10.10.30.1","zone.network.type":"Advanced","router.ip":"169.254.1.159","router.name":"r-4-VM"},"wait":0}}]
}
2014-03-25 09:34:44,843 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-330:null) Seq 1-2085489885: Executing request
2014-03-25 09:34:45,658 DEBUG [agent.manager.AgentManagerImpl]
(AgentManager-Handler-13:null) SeqA 2-934780: Processing Seq 2-934780:? { Cmd ,
MgmtId: -1, via: 2, Ver: v1, Flags: 11,
[{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":2,"_loadInfo":"{\n?
\"connections\": []\n}","wait":0}}] }
2014-03-25 09:34:45,661 DEBUG [agent.manager.AgentManagerImpl]
(AgentManager-Handler-13:null) SeqA 2-934780: Sending Seq 2-934780:? { Ans: ,
MgmtId: 264018885718825, via: 2, Ver: v1, Flags: 100010,
[{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
2014-03-25 09:34:46,047 DEBUG [cloud.server.StatsCollector]
(StatsCollector-3:null) HostStatsCollector is running...
2014-03-25 09:34:46,059 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-134:null) Seq 1-2085489886: Executing request
2014-03-25 09:34:46,277 DEBUG [cloud.api.ApiServlet] (catalina-exec-1:null)
===START===? 114.251.179.130 -- GET?
command=queryAsyncJobResult&jobId=05aec4e1-6b33-48f4-94d8-647c3ce1c791&response=json&sessionkey=a%2BkjTa8gW%2FA6qVlgpPRlO%2BFdNMs%3D&_=1395711258453
2014-03-25 09:34:46,299 DEBUG [cloud.api.ApiServlet] (catalina-exec-1:null)
===END===? 114.251.179.130 -- GET?
command=queryAsyncJobResult&jobId=05aec4e1-6b33-48f4-94d8-647c3ce1c791&response=json&sessionkey=a%2BkjTa8gW%2FA6qVlgpPRlO%2BFdNMs%3D&_=1395711258453
2014-03-25 09:34:46,435 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-330:null) Seq 1-2085489885: Response Received:
2014-03-25 09:34:46,436 DEBUG [agent.transport.Request] (DirectAgent-330:null)
Seq 1-2085489885: Processing:? { Ans: , MgmtId: 264018885718825, via: 1, Ver:
v1, Flags: 110,
[{"com.cloud.agent.api.Answer":{"result":true,"wait":0}},{"com.cloud.agent.api.Answer":{"result":false,"details":"vm_data
failed","wait":0}}] }
2014-03-25 09:34:46,436 DEBUG [agent.manager.AgentAttache]
(DirectAgent-330:null) Seq 1-2085489885: No more commands found
2014-03-25 09:34:46,436 DEBUG [agent.transport.Request] (Job-Executor-7:job-237
= [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Seq 1-2085489885: Received:? { Ans:
, MgmtId: 264018885718825, via: 1, Ver: v1, Flags: 110, { Answer, Answer } }
2014-03-25 09:34:46,436 INFO? [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Unable to
contact resource.
com.cloud.exception.ResourceUnavailableException: Resource [DataCenter:1] is
unreachable: Unable to apply userdata and password entry on router
??????? at
com.cloud.network.router.VirtualNetworkApplianceManagerImpl.applyRules(VirtualNetworkApplianceManagerImpl.java:3808)
??????? at
com.cloud.network.router.VirtualNetworkApplianceManagerImpl.applyUserData(VirtualNetworkApplianceManagerImpl.java:2993)
??????? at
com.cloud.network.element.VirtualRouterElement.addPasswordAndUserdata(VirtualRouterElement.java:926)
??????? at
com.cloud.network.NetworkManagerImpl.prepareElement(NetworkManagerImpl.java:2076)
at
com.cloud.network.NetworkManagerImpl.prepareElement(NetworkManagerImpl.java:2076)
??????? at
com.cloud.network.NetworkManagerImpl.prepareNic(NetworkManagerImpl.java:2191)
??????? at
com.cloud.network.NetworkManagerImpl.prepare(NetworkManagerImpl.java:2127)
??????? at
com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:887)
??????? at
com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:578)
??????? at
org.apache.cloudstack.engine.cloud.entity.api.VMEntityManagerImpl.deployVirtualMachine(VMEntityManagerImpl.java:227)
??????? at
org.apache.cloudstack.engine.cloud.entity.api.VirtualMachineEntityImpl.deploy(VirtualMachineEntityImpl.java:209)
??????? at
com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3406)
??????? 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:441)
??????? at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
??????? at java.util.concurrent.FutureTask.run(FutureTask.java:138)
??????? at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
??????? at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
??????? at java.lang.Thread.run(Thread.java:662)
2014-03-25 09:34:46,439 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Cleaning up
resources for the vm VM[User|pipProxy2] in Starting state
2014-03-25 09:34:46,442 DEBUG [agent.transport.Request] (Job-Executor-7:job-237
= [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Seq 1-2085489887: Sending? { Cmd ,
MgmtId: 264018885718825, via: 1, Ver: v1, Flags: 100111,
[{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":true,"vmName":"i-2-34-VM","wait":0}}]
}
2014-03-25 09:34:46,442 DEBUG [agent.transport.Request] (Job-Executor-7:job-237
= [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Seq 1-2085489887: Executing:? { Cmd
, MgmtId: 264018885718825, via: 1, Ver: v1, Flags: 100111,
[{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":true,"vmName":"i-2-34-VM","wait":0}}]
}
2014-03-25 09:34:46,442 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-440:null) Seq 1-2085489887: Executing request
2014-03-25 09:34:46,503 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-134:null) Seq 1-2085489886: Response Received:
2014-03-25 09:34:46,503 DEBUG [agent.transport.Request] (StatsCollector-3:null)
Seq 1-2085489886: Received:? { Ans: , MgmtId: 264018885718825, via: 1, Ver: v1,
Flags: 10, { GetHostStatsAnswer } }
2014-03-25 09:34:46,512 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-376:null) Seq 4-848531297: Executing request
2014-03-25 09:34:46,592 INFO? [xen.resource.CitrixResourceBase]
(DirectAgent-440:null) VM does not exist on
XenServerbafae2c6-3d52-4ea9-a060-2eac3ee641ef
2014-03-25 09:34:46,593 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-440:null) Seq 1-2085489887: Response Received:
2014-03-25 09:34:46,593 DEBUG [agent.transport.Request] (DirectAgent-440:null)
Seq 1-2085489887: Processing:? { Ans: , MgmtId: 264018885718825, via: 1, Ver:
v1, Flags: 110,
[{"com.cloud.agent.api.StopAnswer":{"vncPort":0,"result":true,"details":"VM
does not exist","wait":0}}] }
2014-03-25 09:34:46,593 DEBUG [agent.manager.AgentAttache]
(DirectAgent-440:null) Seq 1-2085489887: No more commands found
2014-03-25 09:34:46,593 DEBUG [agent.transport.Request] (Job-Executor-7:job-237
= [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Seq 1-2085489887: Received:? { Ans:
, MgmtId: 264018885718825, via: 1, Ver: v1, Flags: 110, { StopAnswer } }
2014-03-25 09:34:46,606 DEBUG [cloud.network.NetworkModelImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Service
SecurityGroup is not supported in the network id=204
2014-03-25 09:34:46,611 DEBUG [cloud.network.NetworkManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Changing
active number of nics for network id=204 on -1
2014-03-25 09:34:46,618 DEBUG [cloud.network.NetworkManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Asking
VirtualRouter to release
Nic[40-34-420efca1-3a82-41e9-acc3-08d8309881f2-10.10.30.66]
2014-03-25 09:34:46,618 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ])
Successfully released network resources for the vm VM[User|pipProxy2]
2014-03-25 09:34:46,618 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ])
Successfully cleanued up resources for the vm VM[User|pipProxy2] in Starting
state
2014-03-25 09:34:46,633 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Deploy
avoids pods: [], clusters: [], hosts: [1]
2014-03-25 09:34:46,633 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) DataCenter
id = '1' provided is in avoid set, DeploymentPlanner cannot allocate the VM,
returning.
2014-03-25 09:34:46,640 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) VM state
transitted from :Starting to Stopped with event: OperationFailedvm's original
host id: null new host id: null host id before state transition: 1
2014-03-25 09:34:46,650 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Hosts's
actual total CPU: 52800 and CPU after applying overprovisioning: 52800
2014-03-25 09:34:46,650 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Hosts's
actual total RAM: 198546824448 and RAM after applying overprovisioning:
198546817024
2014-03-25 09:34:46,650 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) release cpu
from host: 1, old used: 25500,reserved: 0, actual total: 52800, total with
overprovisioning: 52800; new used: 17500,reserved:0; movedfromreserved:
false,moveToReserveredfalse
2014-03-25 09:34:46,650 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) release mem
from host: 1, old used: 64390955008,reserved: 0, total: 198546817024; new used:
56002347008,reserved:0; movedfromreserved: false,moveToReserveredfalse
2014-03-25 09:34:46,668 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) 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
2014-03-25 09:34:46,668 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ])
Successfully transitioned to start state for VM[User|pipProxy2] reservation id
= 1d456411-9799-4778-9c1f-a36f6553bfce
2014-03-25 09:34:46,671 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Trying to
deploy VM, vm has dcId: 1 and podId: 1
2014-03-25 09:34:46,671 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Deploy
avoids pods: [], clusters: [], hosts: [1]
[], hosts: [1]
2014-03-25 09:34:46,685 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) DataCenter
id = '1' provided is in avoid set, DeploymentPlanner cannot allocate the VM,
returning.
2014-03-25 09:34:46,692 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) 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
2014-03-25 09:34:46,706 DEBUG [cloud.vm.UserVmManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Destroying
vm VM[User|pipProxy2] as it failed to create on Host with Id:null
2014-03-25 09:34:46,725 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) 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
2014-03-25 09:34:46,738 WARN? [apache.cloudstack.alerts]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ])?
alertType:: 8 // dataCenterId:: 1 // podId:: 1 // clusterId:: null // message::
Failed to deploy Vm with Id: 34, on Host with Id: null
2014-03-25 09:34:46,766 INFO? [user.vm.DeployVMCmd] (Job-Executor-7:job-237 = [
05aec4e1-6b33-48f4-94d8-647c3ce1c791 ])
com.cloud.exception.InsufficientServerCapacityException: Unable to create a
deployment for VM[User|pipProxy2]Scope=interface com.cloud.dc.DataCenter; id=1
2014-03-25 09:34:46,766 INFO? [user.vm.DeployVMCmd] (Job-Executor-7:job-237 = [
05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Unable to create a deployment for
VM[User|pipProxy2]
com.cloud.exception.InsufficientServerCapacityException: Unable to create a
deployment for VM[User|pipProxy2]Scope=interface com.cloud.dc.DataCenter; id=1
??????? at
com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:842)
??????? at
com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:578)
??????? at
org.apache.cloudstack.engine.cloud.entity.api.VMEntityManagerImpl.deployVirtualMachine(VMEntityManagerImpl.java:237)
??????? at
org.apache.cloudstack.engine.cloud.entity.api.VirtualMachineEntityImpl.deploy(VirtualMachineEntityImpl.java:209)
??????? at
com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3406)
??????? 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:441)
??????? at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
??????? at java.util.concurrent.FutureTask.run(FutureTask.java:138)
??????? at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
??????? at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
??????? at java.lang.Thread.run(Thread.java:662)
2014-03-25 09:34:46,768 DEBUG [cloud.async.AsyncJobManagerImpl]
(Job-Executor-7:job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ]) Complete
async job-237 = [ 05aec4e1-6b33-48f4-94d8-647c3ce1c791 ], jobStatus: 2,
resultCode: 530, result: Error Code: 533 Error text: Unable to create a
deployment for VM[User|pipProxy2]
?
?
此致
敬礼!
?
?
?
赵元海
平台MIS部
9095
yhz...@pipgame.com
*****************************************************
北京掌上明珠信息技术有限公司
地址:北京市朝阳区西坝河西里18号正通时代创意中心3号楼
邮编:100028
电话:(8610)59787800-9095
传真:(8610)59787865
P 保护环境,节省纸张。若非必须,请尽量不要打印此邮件或附件内容。
本电子邮件仅为指定收件人使用并可能载有保密内容。非指定收件人请勿使用、打开、转发、复印本电子邮件或依赖本邮件的内容而采取任何行动。若您误收到本电子邮件,请立即回复该电子邮件发送者或致电(8610)5978-7800通知掌上明珠公司,并请立即删除该电子邮件及其附件。谢谢!