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 "Wwei@landhightech.com" <Ww...@landhightech.com> on 2014/11/18 04:45:52 UTC
hyper-v SSVM和 CPVM 无法启动
大家好，
我配置CloudStack4.4.0+hyperV，遇到 SSVM和 CPVM 无法启动问题，
具体运行环境：
hyperV主机：hyper-V server 2012 r2 ；hyper-v 管理器为Windows server 2012 Datacenter Evaluation；hyper-V添加虚拟交换机；
主存储和二级存储：使用smb存储，存储节点为Windows server 2012 Datacenter Evaluation ,
CloudStack 初始配置：1.使用基本网络（hyperV是否可以使用基本网络进行配置？）；2.选择物理网络时;将管理网络和来宾网络的标签设置为hyper-V添加的虚拟交换机的名字；
启动区域时， SSVM和 CPVM无法正常启动，错误日志如下：
请大家帮忙看看，非常感谢。
主要是这两个错误:
1 ERROR [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Invocation exception, caused by: com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[SecondaryStorageVm|s-2-VM]Scope=interface com.cloud.dc.DataCenter; id=1
2 ERROR [c.c.v.VmWorkJobDispatcher] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Unable to complete AsyncJobVO {id:11, userId: 1, accountId: 1, instanceType: null, instanceId: null, cmd: com.cloud.vm.VmWorkStart, cmdInfo: rO0ABXNyABhjb20uY2xvdWQudm0uVm1Xb3JrU3RhcnR9cMGsvxz73gIAC0oABGRjSWRMAAZhdm9pZHN0ADBMY29tL2Nsb3VkL2RlcGxveS9EZXBsb3ltZW50UGxhbm5lciRFeGNsdWRlTGlzdDtMAAljbHVzdGVySWR0ABBMamF2YS9sYW5nL0xvbmc7TAAGaG9zdElkcQB-AAJMAAtqb3VybmFsTmFtZXQAEkxqYXZhL2xhbmcvU3RyaW5nO0wAEXBoeXNpY2FsTmV0d29ya0lkcQB-AAJMAAdwbGFubmVycQB-AANMAAVwb2RJZHEAfgACTAAGcG9vbElkcQB-AAJMAAlyYXdQYXJhbXN0AA9MamF2YS91dGlsL01hcDtMAA1yZXNlcnZhdGlvbklkcQB-AAN4cgATY29tLmNsb3VkLnZtLlZtV29ya5-ZtlbwJWdrAgAESgAJYWNjb3VudElkSgAGdXNlcklkSgAEdm1JZEwAC2hhbmRsZXJOYW1lcQB-AAN4cAAAAAAAAAABAAAAAAAAAAEAAAAAAAAAAnQAGVZpcnR1YWxNYWNoaW5lTWFuYWdlckltcGwAAAAAAAAAAHBwcHBwcHBwcHA, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 52231492654, completeMsid: null, lastUpdated: null, lastPolled: null, created: Tue Nov 18 09:48:06 CST 2014}, job origin:2
DEBUG [c.c.a.m.a.i.FirstFitAllocator] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a FirstFitRoutingAllocator) Host Allocator returning 0 suitable hosts
2014-11-18 09:48:25,900 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) No suitable hosts found
2014-11-18 09:48:25,900 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) No suitable hosts found under this Cluster: 1
2014-11-18 09:48:25,903 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Could not find suitable Deployment Destination for this VM under any clusters, returning.
2014-11-18 09:48:25,903 DEBUG [c.c.d.FirstFitPlanner] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Searching resources only under specified Cluster: 1
2014-11-18 09:48:25,905 DEBUG [c.c.d.FirstFitPlanner] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) The specified cluster is in avoid set, returning.
2014-11-18 09:48:25,908 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Deploy avoids pods: null, clusters: [1], hosts: [1]
2014-11-18 09:48:25,910 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) DeploymentPlanner allocation algorithm: com.cloud.deploy.FirstFitPlanner@670a0655
2014-11-18 09:48:25,910 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Trying to allocate a host and storage pools from dc:1, pod:null,cluster:null, requested cpu: 500, requested ram: 536870912
2014-11-18 09:48:25,910 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Is ROOT volume READY (pool already allocated)?: No
2014-11-18 09:48:25,911 DEBUG [c.c.d.FirstFitPlanner] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Searching all possible resources under this Zone: 1
2014-11-18 09:48:25,913 DEBUG [c.c.d.FirstFitPlanner] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Listing clusters in order of aggregate capacity, that have (atleast one host with) enough CPU and RAM capacity under this Zone: 1
2014-11-18 09:48:25,918 DEBUG [c.c.d.FirstFitPlanner] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Removing from the clusterId list these clusters from avoid set: [1]
2014-11-18 09:48:25,920 DEBUG [c.c.d.FirstFitPlanner] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) No clusters found after removing disabled clusters and clusters in avoid list, returning.
2014-11-18 09:48:25,933 DEBUG [c.c.c.CapacityManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) 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-11-18 09:48:25,945 DEBUG [c.c.c.CapacityManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Hosts's actual total CPU: 32000 and CPU after applying overprovisioning: 32000
2014-11-18 09:48:25,946 DEBUG [c.c.c.CapacityManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Hosts's actual total RAM: 137357664256 and RAM after applying overprovisioning: 137357664256
2014-11-18 09:48:25,946 DEBUG [c.c.c.CapacityManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) release cpu from host: 1, old used: 500,reserved: 0, actual total: 32000, total with overprovisioning: 32000; new used: 0,reserved:0; movedfromreserved: false,moveToReserveredfalse
2014-11-18 09:48:25,946 DEBUG [c.c.c.CapacityManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) release mem from host: 1, old used: 536870912,reserved: 0, total: 137357664256; new used: 0,reserved:0; movedfromreserved: false,moveToReserveredfalse
2014-11-18 09:48:25,950 ERROR [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Invocation exception, caused by: com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[SecondaryStorageVm|s-2-VM]Scope=interface com.cloud.dc.DataCenter; id=1
2014-11-18 09:48:25,952 INFO [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Rethrow exception com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[SecondaryStorageVm|s-2-VM]Scope=interface com.cloud.dc.DataCenter; id=1
2014-11-18 09:48:25,953 DEBUG [c.c.v.VmWorkJobDispatcher] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Done with run of VM work job: com.cloud.vm.VmWorkStart for VM 2, job origin: 2
2014-11-18 09:48:25,953 ERROR [c.c.v.VmWorkJobDispatcher] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Unable to complete AsyncJobVO {id:11, userId: 1, accountId: 1, instanceType: null, instanceId: null, cmd: com.cloud.vm.VmWorkStart, cmdInfo: rO0ABXNyABhjb20uY2xvdWQudm0uVm1Xb3JrU3RhcnR9cMGsvxz73gIAC0oABGRjSWRMAAZhdm9pZHN0ADBMY29tL2Nsb3VkL2RlcGxveS9EZXBsb3ltZW50UGxhbm5lciRFeGNsdWRlTGlzdDtMAAljbHVzdGVySWR0ABBMamF2YS9sYW5nL0xvbmc7TAAGaG9zdElkcQB-AAJMAAtqb3VybmFsTmFtZXQAEkxqYXZhL2xhbmcvU3RyaW5nO0wAEXBoeXNpY2FsTmV0d29ya0lkcQB-AAJMAAdwbGFubmVycQB-AANMAAVwb2RJZHEAfgACTAAGcG9vbElkcQB-AAJMAAlyYXdQYXJhbXN0AA9MamF2YS91dGlsL01hcDtMAA1yZXNlcnZhdGlvbklkcQB-AAN4cgATY29tLmNsb3VkLnZtLlZtV29ya5-ZtlbwJWdrAgAESgAJYWNjb3VudElkSgAGdXNlcklkSgAEdm1JZEwAC2hhbmRsZXJOYW1lcQB-AAN4cAAAAAAAAAABAAAAAAAAAAEAAAAAAAAAAnQAGVZpcnR1YWxNYWNoaW5lTWFuYWdlckltcGwAAAAAAAAAAHBwcHBwcHBwcHA, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 52231492654, completeMsid: null, lastUpdated: null, lastPolled: null, created: Tue Nov 18 09:48:06 CST 2014}, job origin:2
com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[SecondaryStorageVm|s-2-VM]Scope=interface com.cloud.dc.DataCenter; id=1
at com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:946)
at com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:5190)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107)
at com.cloud.vm.VirtualMachineManagerImpl.handleVmWorkJob(VirtualMachineManagerImpl.java:5335)
at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:102)
at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:503)
at org.apache.cloudstack.managed.context.ManagedContextRunnable$1.run(ManagedContextRunnable.java:49)
at org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(DefaultManagedContext.java:56)
at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithContext(DefaultManagedContext.java:103)
at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithContext(DefaultManagedContext.java:53)
at org.apache.cloudstack.managed.context.ManagedContextRunnable.run(ManagedContextRunnable.java:46)
at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.run(AsyncJobManagerImpl.java:460)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
2014-11-18 09:48:25,957 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Complete async job-11, jobStatus: FAILED, resultCode: 0, result: rO0ABXNyABpqYXZhLmxhbmcuUnVudGltZUV4Y2VwdGlvbp5fBkcKNIPlAgAAeHIAE2phdmEubGFuZy5FeGNlcHRpb27Q_R8-GjscxAIAAHhyABNqYXZhLmxhbmcuVGhyb3dhYmxl1cY1Jzl3uMsDAARMAAVjYXVzZXQAFUxqYXZhL2xhbmcvVGhyb3dhYmxlO0wADWRldGFpbE1lc3NhZ2V0ABJMamF2YS9sYW5nL1N0cmluZztbAApzdGFja1RyYWNldAAeW0xqYXZhL2xhbmcvU3RhY2tUcmFjZUVsZW1lbnQ7TAAUc3VwcHJlc3NlZEV4Y2VwdGlvbnN0ABBMamF2YS91dGlsL0xpc3Q7eHBxAH4AB3QAW0pvYiBmYWlsZWQgZHVlIHRvIGV4Y2VwdGlvbiBVbmFibGUgdG8gY3JlYXRlIGEgZGVwbG95bWVudCBmb3IgVk1bU2Vjb25kYXJ5U3RvcmFnZVZtfHMtMi1WTV11cgAeW0xqYXZhLmxhbmcuU3RhY2tUcmFjZUVsZW1lbnQ7AkYqPDz9IjkCAAB4cAAAAA1zcgAbamF2YS5sYW5nLlN0YWNrVHJhY2VFbGVtZW50YQnFmiY23YUCAARJAApsaW5lTnVtYmVyTAAOZGVjbGFyaW5nQ2xhc3NxAH4ABEwACGZpbGVOYW1lcQB-AARMAAptZXRob2ROYW1lcQB-AAR4cAAAAHJ0ACBjb20uY2xvdWQudm0uVm1Xb3JrSm9iRGlzcGF0Y2hlcnQAGFZtV29ya0pvYkRpc3BhdGNoZXIuamF2YXQABnJ1bkpvYnNxAH4ACwAAAfd0AD9vcmcuYXBhY2hlLmNsb3Vkc3RhY2suZnJhbWV3b3JrLmpvYnMuaW1wbC5Bc3luY0pvYk1hbmFnZXJJbXBsJDV0ABhBc3luY0pvYk1hbmFnZXJJbXBsLmphdmF0AAxydW5JbkNvbnRleHRzcQB-AAsAAAAxdAA-b3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5NYW5hZ2VkQ29udGV4dFJ1bm5hYmxlJDF0ABtNYW5hZ2VkQ29udGV4dFJ1bm5hYmxlLmphdmF0AANydW5zcQB-AAsAAAA4dABCb3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5pbXBsLkRlZmF1bHRNYW5hZ2VkQ29udGV4dCQxdAAaRGVmYXVsdE1hbmFnZWRDb250ZXh0LmphdmF0AARjYWxsc3EAfgALAAAAZ3QAQG9yZy5hcGFjaGUuY2xvdWRzdGFjay5tYW5hZ2VkLmNvbnRleHQuaW1wbC5EZWZhdWx0TWFuYWdlZENvbnRleHRxAH4AGnQAD2NhbGxXaXRoQ29udGV4dHNxAH4ACwAAADVxAH4AHXEAfgAadAAOcnVuV2l0aENvbnRleHRzcQB-AAsAAAAudAA8b3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5NYW5hZ2VkQ29udGV4dFJ1bm5hYmxlcQB-ABZxAH4AF3NxAH4ACwAAAcxxAH4AEXEAfgAScQB-ABdzcQB-AAsAAAHXdAAuamF2YS51dGlsLmNvbmN1cnJlbnQuRXhlY3V0b3JzJFJ1bm5hYmxlQWRhcHRlcnQADkV4ZWN1dG9ycy5qYXZhcQB-ABtzcQB-AAsAAAEGdAAfamF2YS51dGlsLmNvbmN1cnJlbnQuRnV0dXJlVGFza3QAD0Z1dHVyZVRhc2suamF2YXEAfgAXc3EAfgALAAAEeXQAJ2phdmEudXRpbC5jb25jdXJyZW50LlRocmVhZFBvb2xFeGVjdXRvcnQAF1RocmVhZFBvb2xFeGVjdXRvci5qYXZhdAAJcnVuV29ya2Vyc3EAfgALAAACZ3QALmphdmEudXRpbC5jb25jdXJyZW50LlRocmVhZFBvb2xFeGVjdXRvciRXb3JrZXJxAH4ALHEAfgAXc3EAfgALAAAC6XQAEGphdmEubGFuZy5UaHJlYWR0AAtUaHJlYWQuamF2YXEAfgAXc3IAJmphdmEudXRpbC5Db2xsZWN0aW9ucyRVbm1vZGlmaWFibGVMaXN0_A8lMbXsjhACAAFMAARsaXN0cQB-AAZ4cgAsamF2YS51dGlsLkNvbGxlY3Rpb25zJFVubW9kaWZpYWJsZUNvbGxlY3Rpb24ZQgCAy173HgIAAUwAAWN0ABZMamF2YS91dGlsL0NvbGxlY3Rpb247eHBzcgATamF2YS51dGlsLkFycmF5TGlzdHiB0h2Zx2GdAwABSQAEc2l6ZXhwAAAAAHcEAAAAAHhxAH4AOHg
2014-11-18 09:48:25,972 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Done executing com.cloud.vm.VmWorkStart for job-11
2014-11-18 09:48:25,996 WARN [o.a.c.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-a1c90799) Exception while trying to start secondary storage vm
java.lang.RuntimeException: Job failed due to exception Unable to create a deployment for VM[SecondaryStorageVm|s-2-VM]
at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:114)
at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:503)
at org.apache.cloudstack.managed.context.ManagedContextRunnable$1.run(ManagedContextRunnable.java:49)
at org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(DefaultManagedContext.java:56)
at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithContext(DefaultManagedContext.java:103)
at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithContext(DefaultManagedContext.java:53)
at org.apache.cloudstack.managed.context.ManagedContextRunnable.run(ManagedContextRunnable.java:46)
at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.run(AsyncJobManagerImpl.java:460)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
2014-11-18 09:48:26,006 DEBUG [o.a.c.f.j.i.SyncQueueManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Sync queue (2) is currently empty
2014-11-18 09:48:26,008 INFO [o.a.c.f.j.i.AsyncJobMonitor] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Remove job-11 from job monitoring
2014-11-18 09:48:26,009 INFO [o.a.c.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-a1c90799) Unable to start secondary storage vm for standby capacity, secStorageVm vm Id : 2, will recycle it and start a new one
2014-11-18 09:48:26,009 INFO [o.a.c.s.PremiumSecondaryStorageManagerImpl] (secstorage-1:ctx-a1c90799) Primary secondary storage is not even started, wait until next turn
2014-11-18 09:48:27,659 WARN [c.c.u.n.Link] (AgentManager-Selector:null) SSL: Fail to find the generated keystore. Loading fail-safe one to continue.
2014-11-18 09:48:28,330 DEBUG [c.c.a.t.Request] (AgentManager-Handler-7:null) Seq 0-0: Scheduling the first command { Cmd , MgmtId: -1, via: 0, Ver: v1, Flags: 101, [{"com.cloud.agent.api.StartupProxyCommand":{"proxyPort":80,"proxyVmId":250,"type":"ConsoleProxy","dataCenter":"6","pod":"6","guid":"Proxy.250-ConsoleProxyResource","name":"v-250-VM","id":0,"version":"4.4.0-SNAPSHOT","iqn":"NoIqn","publicIpAddress":"192.168.1.208","publicNetmask":"255.255.255.0","publicMacAddress":"06:4d:84:00:00:11","privateIpAddress":"192.168.1.194","privateMacAddress":"06:dd:d4:00:00:03","privateNetmask":"255.255.255.0","storageIpAddress":"192.168.1.194","storageNetmask":"255.255.255.0","storageMacAddress":"06:dd:d4:00:00:03","resourceName":"ConsoleProxyResource","wait":0}}] }
2014-11-18 09:48:28,334 DEBUG [c.c.a.t.Request] (AgentConnectTaskPool-32:ctx-e30396fa) Seq 0-0: Processing the first command { Cmd , MgmtId: -1, via: 0, Ver: v1, Flags: 101, [{"com.cloud.agent.api.StartupProxyCommand":{"proxyPort":80,"proxyVmId":250,"type":"ConsoleProxy","dataCenter":"6","pod":"6","guid":"Proxy.250-ConsoleProxyResource","name":"v-250-VM","id":0,"version":"4.4.0-SNAPSHOT","iqn":"NoIqn","publicIpAddress":"192.168.1.208","publicNetmask":"255.255.255.0","publicMacAddress":"06:4d:84:00:00:11","privateIpAddress":"192.168.1.194","privateMacAddress":"06:dd:d4:00:00:03","privateNetmask":"255.255.255.0","storageIpAddress":"192.168.1.194","storageNetmask":"255.255.255.0","storageMacAddress":"06:dd:d4:00:00:03","resourceName":"ConsoleProxyResource","wait":0}}] }
2014-11-18 09:48:28,340 DEBUG [c.c.a.m.AgentManagerImpl] (AgentConnectTaskPool-32:ctx-e30396fa) Failed to handle host connection: java.lang.IllegalArgumentException: Host 192.168.1.194 sent incorrect data center: 6
2014-11-18 09:48:28,342 WARN [c.c.a.m.AgentManagerImpl] (AgentConnectTaskPool-32:ctx-e30396fa) Unable to create attache for agent: Seq 0-0: { Cmd , MgmtId: -1, via: 0, Ver: v1, Flags: 101, [{"com.cloud.agent.api.StartupProxyCommand":{"proxyPort":80,"proxyVmId":250,"type":"ConsoleProxy","dataCenter":"6","pod":"6","guid":"Proxy.250-ConsoleProxyResource","name":"v-250-VM","id":0,"version":"4.4.0-SNAPSHOT","iqn":"NoIqn","publicIpAddress":"192.168.1.208","publicNetmask":"255.255.255.0","publicMacAddress":"06:4d:84:00:00:11","privateIpAddress":"192.168.1.194","privateMacAddress":"06:dd:d4:00:00:03","privateNetmask":"255.255.255.0","storageIpAddress":"192.168.1.194","storageNetmask":"255.255.255.0","storageMacAddress":"06:dd:d4:00:00:03","resourceName":"ConsoleProxyResource","wait":0}}] }
2014-11-18 09:48:28,437 WARN [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-8:null) Throwing away a request because it came through as the first command on a connect: Seq 0-1: { Cmd , MgmtId: -1, via: 0, Ver: v1, Flags: 11, [{"com.cloud.agent.api.PingCommand":{"hostType":"ConsoleProxy","hostId":0,"wait":0}}] }
2014-11-18 09:48:28,439 WARN [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-9:null) Throwing away a request because it came through as the first command on a connect: Seq 0--1: { Cmd , MgmtId: -1, via: 0, Ver: v1, Flags: 111, [{"com.cloud.agent.api.ShutdownCommand":{"reason":"sig.kill","wait":0}}] }
2014-11-18 09:48:29,412 INFO [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-10:null) Connection from /192.168.1.194 closed but no cleanup was done.
2014-11-18 09:48:29,719 DEBUG [c.c.n.r.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:ctx-a0955777) Found 0 routers to update status.
2014-11-18 09:48:29,723 DEBUG [c.c.n.r.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:ctx-a0955777) Found 0 networks to update RvR status.
Wwei@landhightech.com
Re: Re: hyper-v SSVM和 CPVM 无法启动
Posted by "Wwei@landhightech.com" <Ww...@landhightech.com>.
谢谢您的回复，我使用的 安装CloudStack的rpm包 和 Agentshell.exe 是自己编译的，agent可以正常启动，启动agent使用域账号。
Wwei@landhightech.com
发件人： Darren Tang
发送时间： 2014-11-18 21:39
收件人： users-cn@cloudstack.apache.org
主题： Re: hyper-v SSVM和 CPVM 无法启动
1.第一个报错看不出来问题，日志不全面。
2.你的包是自己编译的吧。agent可以正常启动么？另外agent启动是用哪个账户？
2014-11-18 11:45 GMT+08:00 Wwei@landhightech.com <Ww...@landhightech.com>:
> 大家好，
> 我配置CloudStack4.4.0+hyperV，遇到 SSVM和 CPVM 无法启动问题，
> 具体运行环境：
> hyperV主机：hyper-V server 2012 r2 ；hyper-v 管理器为Windows server 2012
> Datacenter Evaluation；hyper-V添加虚拟交换机；
>
> 主存储和二级存储：使用smb存储，存储节点为Windows server 2012 Datacenter Evaluation ,
>
> CloudStack
> 初始配置：1.使用基本网络（hyperV是否可以使用基本网络进行配置？）；2.选择物理网络时;将管理网络和来宾网络的标签设置为hyper-V添加的虚拟交换机的名字；
>
> 启动区域时， SSVM和 CPVM无法正常启动，错误日志如下：
> 请大家帮忙看看，非常感谢。
>
> 主要是这两个错误:
> 1 ERROR [c.c.v.VmWorkJobHandlerProxy]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Invocation
> exception, caused by:
> com.cloud.exception.InsufficientServerCapacityException: Unable to create a
> deployment for VM[SecondaryStorageVm|s-2-VM]Scope=interface
> com.cloud.dc.DataCenter; id=1
>
> 2 ERROR [c.c.v.VmWorkJobDispatcher] (Work-Job-Executor-2:ctx-dfc4af56
> job-2/job-11) Unable to complete AsyncJobVO {id:11, userId: 1, accountId:
> 1, instanceType: null, instanceId: null, cmd: com.cloud.vm.VmWorkStart,
> cmdInfo:
> rO0ABXNyABhjb20uY2xvdWQudm0uVm1Xb3JrU3RhcnR9cMGsvxz73gIAC0oABGRjSWRMAAZhdm9pZHN0ADBMY29tL2Nsb3VkL2RlcGxveS9EZXBsb3ltZW50UGxhbm5lciRFeGNsdWRlTGlzdDtMAAljbHVzdGVySWR0ABBMamF2YS9sYW5nL0xvbmc7TAAGaG9zdElkcQB-AAJMAAtqb3VybmFsTmFtZXQAEkxqYXZhL2xhbmcvU3RyaW5nO0wAEXBoeXNpY2FsTmV0d29ya0lkcQB-AAJMAAdwbGFubmVycQB-AANMAAVwb2RJZHEAfgACTAAGcG9vbElkcQB-AAJMAAlyYXdQYXJhbXN0AA9MamF2YS91dGlsL01hcDtMAA1yZXNlcnZhdGlvbklkcQB-AAN4cgATY29tLmNsb3VkLnZtLlZtV29ya5-ZtlbwJWdrAgAESgAJYWNjb3VudElkSgAGdXNlcklkSgAEdm1JZEwAC2hhbmRsZXJOYW1lcQB-AAN4cAAAAAAAAAABAAAAAAAAAAEAAAAAAAAAAnQAGVZpcnR1YWxNYWNoaW5lTWFuYWdlckltcGwAAAAAAAAAAHBwcHBwcHBwcHA,
> cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0,
> result: null, initMsid: 52231492654, completeMsid: null, lastUpdated: null,
> lastPolled: null, created: Tue Nov 18 09:48:06 CST 2014}, job origin:2
>
>
>
>
>
> DEBUG [c.c.a.m.a.i.FirstFitAllocator] (Work-Job-Executor-2:ctx-dfc4af56
> job-2/job-11 ctx-6a233a9a FirstFitRoutingAllocator) Host Allocator
> returning 0 suitable hosts
> 2014-11-18 09:48:25,900 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) No suitable
> hosts found
> 2014-11-18 09:48:25,900 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) No suitable
> hosts found under this Cluster: 1
> 2014-11-18 09:48:25,903 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Could not find
> suitable Deployment Destination for this VM under any clusters, returning.
> 2014-11-18 09:48:25,903 DEBUG [c.c.d.FirstFitPlanner]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Searching
> resources only under specified Cluster: 1
> 2014-11-18 09:48:25,905 DEBUG [c.c.d.FirstFitPlanner]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) The specified
> cluster is in avoid set, returning.
> 2014-11-18 09:48:25,908 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Deploy avoids
> pods: null, clusters: [1], hosts: [1]
> 2014-11-18 09:48:25,910 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a)
> DeploymentPlanner allocation algorithm:
> com.cloud.deploy.FirstFitPlanner@670a0655
> 2014-11-18 09:48:25,910 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Trying to
> allocate a host and storage pools from dc:1, pod:null,cluster:null,
> requested cpu: 500, requested ram: 536870912
> 2014-11-18 09:48:25,910 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Is ROOT volume
> READY (pool already allocated)?: No
> 2014-11-18 09:48:25,911 DEBUG [c.c.d.FirstFitPlanner]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Searching all
> possible resources under this Zone: 1
> 2014-11-18 09:48:25,913 DEBUG [c.c.d.FirstFitPlanner]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Listing
> clusters in order of aggregate capacity, that have (atleast one host with)
> enough CPU and RAM capacity under this Zone: 1
> 2014-11-18 09:48:25,918 DEBUG [c.c.d.FirstFitPlanner]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Removing from
> the clusterId list these clusters from avoid set: [1]
> 2014-11-18 09:48:25,920 DEBUG [c.c.d.FirstFitPlanner]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) No clusters
> found after removing disabled clusters and clusters in avoid list,
> returning.
> 2014-11-18 09:48:25,933 DEBUG [c.c.c.CapacityManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) 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-11-18 09:48:25,945 DEBUG [c.c.c.CapacityManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Hosts's actual
> total CPU: 32000 and CPU after applying overprovisioning: 32000
> 2014-11-18 09:48:25,946 DEBUG [c.c.c.CapacityManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Hosts's actual
> total RAM: 137357664256 and RAM after applying overprovisioning:
> 137357664256
> 2014-11-18 09:48:25,946 DEBUG [c.c.c.CapacityManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) release cpu
> from host: 1, old used: 500,reserved: 0, actual total: 32000, total with
> overprovisioning: 32000; new used: 0,reserved:0; movedfromreserved:
> false,moveToReserveredfalse
> 2014-11-18 09:48:25,946 DEBUG [c.c.c.CapacityManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) release mem
> from host: 1, old used: 536870912,reserved: 0, total: 137357664256; new
> used: 0,reserved:0; movedfromreserved: false,moveToReserveredfalse
> 2014-11-18 09:48:25,950 ERROR [c.c.v.VmWorkJobHandlerProxy]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Invocation
> exception, caused by:
> com.cloud.exception.InsufficientServerCapacityException: Unable to create a
> deployment for VM[SecondaryStorageVm|s-2-VM]Scope=interface
> com.cloud.dc.DataCenter; id=1
> 2014-11-18 09:48:25,952 INFO [c.c.v.VmWorkJobHandlerProxy]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Rethrow
> exception com.cloud.exception.InsufficientServerCapacityException: Unable
> to create a deployment for VM[SecondaryStorageVm|s-2-VM]Scope=interface
> com.cloud.dc.DataCenter; id=1
> 2014-11-18 09:48:25,953 DEBUG [c.c.v.VmWorkJobDispatcher]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Done with run of VM work
> job: com.cloud.vm.VmWorkStart for VM 2, job origin: 2
> 2014-11-18 09:48:25,953 ERROR [c.c.v.VmWorkJobDispatcher]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Unable to complete
> AsyncJobVO {id:11, userId: 1, accountId: 1, instanceType: null, instanceId:
> null, cmd: com.cloud.vm.VmWorkStart, cmdInfo:
> rO0ABXNyABhjb20uY2xvdWQudm0uVm1Xb3JrU3RhcnR9cMGsvxz73gIAC0oABGRjSWRMAAZhdm9pZHN0ADBMY29tL2Nsb3VkL2RlcGxveS9EZXBsb3ltZW50UGxhbm5lciRFeGNsdWRlTGlzdDtMAAljbHVzdGVySWR0ABBMamF2YS9sYW5nL0xvbmc7TAAGaG9zdElkcQB-AAJMAAtqb3VybmFsTmFtZXQAEkxqYXZhL2xhbmcvU3RyaW5nO0wAEXBoeXNpY2FsTmV0d29ya0lkcQB-AAJMAAdwbGFubmVycQB-AANMAAVwb2RJZHEAfgACTAAGcG9vbElkcQB-AAJMAAlyYXdQYXJhbXN0AA9MamF2YS91dGlsL01hcDtMAA1yZXNlcnZhdGlvbklkcQB-AAN4cgATY29tLmNsb3VkLnZtLlZtV29ya5-ZtlbwJWdrAgAESgAJYWNjb3VudElkSgAGdXNlcklkSgAEdm1JZEwAC2hhbmRsZXJOYW1lcQB-AAN4cAAAAAAAAAABAAAAAAAAAAEAAAAAAAAAAnQAGVZpcnR1YWxNYWNoaW5lTWFuYWdlckltcGwAAAAAAAAAAHBwcHBwcHBwcHA,
> cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0,
> result: null, initMsid: 52231492654, completeMsid: null, lastUpdated: null,
> lastPolled: null, created: Tue Nov 18 09:48:06 CST 2014}, job origin:2
> com.cloud.exception.InsufficientServerCapacityException: Unable to create
> a deployment for VM[SecondaryStorageVm|s-2-VM]Scope=interface
> com.cloud.dc.DataCenter; id=1
> at
> com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:946)
> at
> com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:5190)
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
> at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java:606)
> at
> com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107)
> at
> com.cloud.vm.VirtualMachineManagerImpl.handleVmWorkJob(VirtualMachineManagerImpl.java:5335)
> at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:102)
> at
> org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:503)
> at
> org.apache.cloudstack.managed.context.ManagedContextRunnable$1.run(ManagedContextRunnable.java:49)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(DefaultManagedContext.java:56)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithContext(DefaultManagedContext.java:103)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithContext(DefaultManagedContext.java:53)
> at
> org.apache.cloudstack.managed.context.ManagedContextRunnable.run(ManagedContextRunnable.java:46)
> at
> org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.run(AsyncJobManagerImpl.java:460)
> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
> at java.util.concurrent.FutureTask.run(FutureTask.java:262)
> at
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:745)
> 2014-11-18 09:48:25,957 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Complete async job-11,
> jobStatus: FAILED, resultCode: 0, result:
> rO0ABXNyABpqYXZhLmxhbmcuUnVudGltZUV4Y2VwdGlvbp5fBkcKNIPlAgAAeHIAE2phdmEubGFuZy5FeGNlcHRpb27Q_R8-GjscxAIAAHhyABNqYXZhLmxhbmcuVGhyb3dhYmxl1cY1Jzl3uMsDAARMAAVjYXVzZXQAFUxqYXZhL2xhbmcvVGhyb3dhYmxlO0wADWRldGFpbE1lc3NhZ2V0ABJMamF2YS9sYW5nL1N0cmluZztbAApzdGFja1RyYWNldAAeW0xqYXZhL2xhbmcvU3RhY2tUcmFjZUVsZW1lbnQ7TAAUc3VwcHJlc3NlZEV4Y2VwdGlvbnN0ABBMamF2YS91dGlsL0xpc3Q7eHBxAH4AB3QAW0pvYiBmYWlsZWQgZHVlIHRvIGV4Y2VwdGlvbiBVbmFibGUgdG8gY3JlYXRlIGEgZGVwbG95bWVudCBmb3IgVk1bU2Vjb25kYXJ5U3RvcmFnZVZtfHMtMi1WTV11cgAeW0xqYXZhLmxhbmcuU3RhY2tUcmFjZUVsZW1lbnQ7AkYqPDz9IjkCAAB4cAAAAA1zcgAbamF2YS5sYW5nLlN0YWNrVHJhY2VFbGVtZW50YQnFmiY23YUCAARJAApsaW5lTnVtYmVyTAAOZGVjbGFyaW5nQ2xhc3NxAH4ABEwACGZpbGVOYW1lcQB-AARMAAptZXRob2ROYW1lcQB-AAR4cAAAAHJ0ACBjb20uY2xvdWQudm0uVm1Xb3JrSm9iRGlzcGF0Y2hlcnQAGFZtV29ya0pvYkRpc3BhdGNoZXIuamF2YXQABnJ1bkpvYnNxAH4ACwAAAfd0AD9vcmcuYXBhY2hlLmNsb3Vkc3RhY2suZnJhbWV3b3JrLmpvYnMuaW1wbC5Bc3luY0pvYk1hbmFnZXJJbXBsJDV0ABhBc3luY0pvYk1hbmFnZXJJbXBsLmphdmF0AAxydW5JbkNvbnRleHRzcQB-AAsAAAAxdAA-b3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5NYW5hZ2VkQ29udGV4dFJ1bm5hYmxlJDF0ABtNYW5hZ2VkQ29udGV4dFJ1bm5hYmxlLmphdmF0AANydW5zcQB-AAsAAAA4dABCb3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5pbXBsLkRlZmF1bHRNYW5hZ2VkQ29udGV4dCQxdAAaRGVmYXVsdE1hbmFnZWRDb250ZXh0LmphdmF0AARjYWxsc3EAfgALAAAAZ3QAQG9yZy5hcGFjaGUuY2xvdWRzdGFjay5tYW5hZ2VkLmNvbnRleHQuaW1wbC5EZWZhdWx0TWFuYWdlZENvbnRleHRxAH4AGnQAD2NhbGxXaXRoQ29udGV4dHNxAH4ACwAAADVxAH4AHXEAfgAadAAOcnVuV2l0aENvbnRleHRzcQB-AAsAAAAudAA8b3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5NYW5hZ2VkQ29udGV4dFJ1bm5hYmxlcQB-ABZxAH4AF3NxAH4ACwAAAcxxAH4AEXEAfgAScQB-ABdzcQB-AAsAAAHXdAAuamF2YS51dGlsLmNvbmN1cnJlbnQuRXhlY3V0b3JzJFJ1bm5hYmxlQWRhcHRlcnQADkV4ZWN1dG9ycy5qYXZhcQB-ABtzcQB-AAsAAAEGdAAfamF2YS51dGlsLmNvbmN1cnJlbnQuRnV0dXJlVGFza3QAD0Z1dHVyZVRhc2suamF2YXEAfgAXc3EAfgALAAAEeXQAJ2phdmEudXRpbC5jb25jdXJyZW50LlRocmVhZFBvb2xFeGVjdXRvcnQAF1RocmVhZFBvb2xFeGVjdXRvci5qYXZhdAAJcnVuV29ya2Vyc3EAfgALAAACZ3QALmphdmEudXRpbC5jb25jdXJyZW50LlRocmVhZFBvb2xFeGVjdXRvciRXb3JrZXJxAH4ALHEAfgAXc3EAfgALAAAC6XQAEGphdmEubGFuZy5UaHJlYWR0AAtUaHJlYWQuamF2YXEAfgAXc3IAJmphdmEudXRpbC5Db2xsZWN0aW9ucyRVbm1vZGlmaWFibGVMaXN0_A8lMbXsjhACAAFMAARsaXN0cQB-AAZ4cgAsamF2YS51dGlsLkNvbGxlY3Rpb25zJFVubW9kaWZpYWJsZUNvbGxlY3Rpb24ZQgCAy173HgIAAUwAAWN0ABZMamF2YS91dGlsL0NvbGxlY3Rpb247eHBzcgATamF2YS51dGlsLkFycmF5TGlzdHiB0h2Zx2GdAwABSQAEc2l6ZXhwAAAAAHcEAAAAAHhxAH4AOHg
> 2014-11-18 09:48:25,972 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Done executing
> com.cloud.vm.VmWorkStart for job-11
> 2014-11-18 09:48:25,996 WARN [o.a.c.s.SecondaryStorageManagerImpl]
> (secstorage-1:ctx-a1c90799) Exception while trying to start secondary
> storage vm
> java.lang.RuntimeException: Job failed due to exception Unable to create a
> deployment for VM[SecondaryStorageVm|s-2-VM]
> at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:114)
> at
> org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:503)
> at
> org.apache.cloudstack.managed.context.ManagedContextRunnable$1.run(ManagedContextRunnable.java:49)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(DefaultManagedContext.java:56)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithContext(DefaultManagedContext.java:103)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithContext(DefaultManagedContext.java:53)
> at
> org.apache.cloudstack.managed.context.ManagedContextRunnable.run(ManagedContextRunnable.java:46)
> at
> org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.run(AsyncJobManagerImpl.java:460)
> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
> at java.util.concurrent.FutureTask.run(FutureTask.java:262)
> at
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:745)
> 2014-11-18 09:48:26,006 DEBUG [o.a.c.f.j.i.SyncQueueManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Sync queue (2) is currently
> empty
> 2014-11-18 09:48:26,008 INFO [o.a.c.f.j.i.AsyncJobMonitor]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Remove job-11 from job
> monitoring
> 2014-11-18 09:48:26,009 INFO [o.a.c.s.SecondaryStorageManagerImpl]
> (secstorage-1:ctx-a1c90799) Unable to start secondary storage vm for
> standby capacity, secStorageVm vm Id : 2, will recycle it and start a new
> one
> 2014-11-18 09:48:26,009 INFO [o.a.c.s.PremiumSecondaryStorageManagerImpl]
> (secstorage-1:ctx-a1c90799) Primary secondary storage is not even started,
> wait until next turn
> 2014-11-18 09:48:27,659 WARN [c.c.u.n.Link] (AgentManager-Selector:null)
> SSL: Fail to find the generated keystore. Loading fail-safe one to continue.
> 2014-11-18 09:48:28,330 DEBUG [c.c.a.t.Request]
> (AgentManager-Handler-7:null) Seq 0-0: Scheduling the first command { Cmd ,
> MgmtId: -1, via: 0, Ver: v1, Flags: 101,
> [{"com.cloud.agent.api.StartupProxyCommand":{"proxyPort":80,"proxyVmId":250,"type":"ConsoleProxy","dataCenter":"6","pod":"6","guid":"Proxy.250-ConsoleProxyResource","name":"v-250-VM","id":0,"version":"4.4.0-SNAPSHOT","iqn":"NoIqn","publicIpAddress":"192.168.1.208","publicNetmask":"255.255.255.0","publicMacAddress":"06:4d:84:00:00:11","privateIpAddress":"192.168.1.194","privateMacAddress":"06:dd:d4:00:00:03","privateNetmask":"255.255.255.0","storageIpAddress":"192.168.1.194","storageNetmask":"255.255.255.0","storageMacAddress":"06:dd:d4:00:00:03","resourceName":"ConsoleProxyResource","wait":0}}]
> }
> 2014-11-18 09:48:28,334 DEBUG [c.c.a.t.Request]
> (AgentConnectTaskPool-32:ctx-e30396fa) Seq 0-0: Processing the first
> command { Cmd , MgmtId: -1, via: 0, Ver: v1, Flags: 101,
> [{"com.cloud.agent.api.StartupProxyCommand":{"proxyPort":80,"proxyVmId":250,"type":"ConsoleProxy","dataCenter":"6","pod":"6","guid":"Proxy.250-ConsoleProxyResource","name":"v-250-VM","id":0,"version":"4.4.0-SNAPSHOT","iqn":"NoIqn","publicIpAddress":"192.168.1.208","publicNetmask":"255.255.255.0","publicMacAddress":"06:4d:84:00:00:11","privateIpAddress":"192.168.1.194","privateMacAddress":"06:dd:d4:00:00:03","privateNetmask":"255.255.255.0","storageIpAddress":"192.168.1.194","storageNetmask":"255.255.255.0","storageMacAddress":"06:dd:d4:00:00:03","resourceName":"ConsoleProxyResource","wait":0}}]
> }
> 2014-11-18 09:48:28,340 DEBUG [c.c.a.m.AgentManagerImpl]
> (AgentConnectTaskPool-32:ctx-e30396fa) Failed to handle host connection:
> java.lang.IllegalArgumentException: Host 192.168.1.194 sent incorrect data
> center: 6
> 2014-11-18 09:48:28,342 WARN [c.c.a.m.AgentManagerImpl]
> (AgentConnectTaskPool-32:ctx-e30396fa) Unable to create attache for agent:
> Seq 0-0: { Cmd , MgmtId: -1, via: 0, Ver: v1, Flags: 101,
> [{"com.cloud.agent.api.StartupProxyCommand":{"proxyPort":80,"proxyVmId":250,"type":"ConsoleProxy","dataCenter":"6","pod":"6","guid":"Proxy.250-ConsoleProxyResource","name":"v-250-VM","id":0,"version":"4.4.0-SNAPSHOT","iqn":"NoIqn","publicIpAddress":"192.168.1.208","publicNetmask":"255.255.255.0","publicMacAddress":"06:4d:84:00:00:11","privateIpAddress":"192.168.1.194","privateMacAddress":"06:dd:d4:00:00:03","privateNetmask":"255.255.255.0","storageIpAddress":"192.168.1.194","storageNetmask":"255.255.255.0","storageMacAddress":"06:dd:d4:00:00:03","resourceName":"ConsoleProxyResource","wait":0}}]
> }
> 2014-11-18 09:48:28,437 WARN [c.c.a.m.AgentManagerImpl]
> (AgentManager-Handler-8:null) Throwing away a request because it came
> through as the first command on a connect: Seq 0-1: { Cmd , MgmtId: -1,
> via: 0, Ver: v1, Flags: 11,
> [{"com.cloud.agent.api.PingCommand":{"hostType":"ConsoleProxy","hostId":0,"wait":0}}]
> }
> 2014-11-18 09:48:28,439 WARN [c.c.a.m.AgentManagerImpl]
> (AgentManager-Handler-9:null) Throwing away a request because it came
> through as the first command on a connect: Seq 0--1: { Cmd , MgmtId: -1,
> via: 0, Ver: v1, Flags: 111,
> [{"com.cloud.agent.api.ShutdownCommand":{"reason":"sig.kill","wait":0}}] }
> 2014-11-18 09:48:29,412 INFO [c.c.a.m.AgentManagerImpl]
> (AgentManager-Handler-10:null) Connection from /192.168.1.194 closed but
> no cleanup was done.
> 2014-11-18 09:48:29,719 DEBUG [c.c.n.r.VirtualNetworkApplianceManagerImpl]
> (RouterStatusMonitor-1:ctx-a0955777) Found 0 routers to update status.
> 2014-11-18 09:48:29,723 DEBUG [c.c.n.r.VirtualNetworkApplianceManagerImpl]
> (RouterStatusMonitor-1:ctx-a0955777) Found 0 networks to update RvR status.
>
>
>
>
> Wwei@landhightech.com
>
Re: hyper-v SSVM和 CPVM 无法启动
Posted by Darren Tang <da...@gmail.com>.
1.第一个报错看不出来问题，日志不全面。
2.你的包是自己编译的吧。agent可以正常启动么？另外agent启动是用哪个账户？
2014-11-18 11:45 GMT+08:00 Wwei@landhightech.com <Ww...@landhightech.com>:
> 大家好，
> 我配置CloudStack4.4.0+hyperV，遇到 SSVM和 CPVM 无法启动问题，
> 具体运行环境：
> hyperV主机：hyper-V server 2012 r2 ；hyper-v 管理器为Windows server 2012
> Datacenter Evaluation；hyper-V添加虚拟交换机；
>
> 主存储和二级存储：使用smb存储，存储节点为Windows server 2012 Datacenter Evaluation ,
>
> CloudStack
> 初始配置：1.使用基本网络（hyperV是否可以使用基本网络进行配置？）；2.选择物理网络时;将管理网络和来宾网络的标签设置为hyper-V添加的虚拟交换机的名字；
>
> 启动区域时， SSVM和 CPVM无法正常启动，错误日志如下：
> 请大家帮忙看看，非常感谢。
>
> 主要是这两个错误:
> 1 ERROR [c.c.v.VmWorkJobHandlerProxy]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Invocation
> exception, caused by:
> com.cloud.exception.InsufficientServerCapacityException: Unable to create a
> deployment for VM[SecondaryStorageVm|s-2-VM]Scope=interface
> com.cloud.dc.DataCenter; id=1
>
> 2 ERROR [c.c.v.VmWorkJobDispatcher] (Work-Job-Executor-2:ctx-dfc4af56
> job-2/job-11) Unable to complete AsyncJobVO {id:11, userId: 1, accountId:
> 1, instanceType: null, instanceId: null, cmd: com.cloud.vm.VmWorkStart,
> cmdInfo:
> rO0ABXNyABhjb20uY2xvdWQudm0uVm1Xb3JrU3RhcnR9cMGsvxz73gIAC0oABGRjSWRMAAZhdm9pZHN0ADBMY29tL2Nsb3VkL2RlcGxveS9EZXBsb3ltZW50UGxhbm5lciRFeGNsdWRlTGlzdDtMAAljbHVzdGVySWR0ABBMamF2YS9sYW5nL0xvbmc7TAAGaG9zdElkcQB-AAJMAAtqb3VybmFsTmFtZXQAEkxqYXZhL2xhbmcvU3RyaW5nO0wAEXBoeXNpY2FsTmV0d29ya0lkcQB-AAJMAAdwbGFubmVycQB-AANMAAVwb2RJZHEAfgACTAAGcG9vbElkcQB-AAJMAAlyYXdQYXJhbXN0AA9MamF2YS91dGlsL01hcDtMAA1yZXNlcnZhdGlvbklkcQB-AAN4cgATY29tLmNsb3VkLnZtLlZtV29ya5-ZtlbwJWdrAgAESgAJYWNjb3VudElkSgAGdXNlcklkSgAEdm1JZEwAC2hhbmRsZXJOYW1lcQB-AAN4cAAAAAAAAAABAAAAAAAAAAEAAAAAAAAAAnQAGVZpcnR1YWxNYWNoaW5lTWFuYWdlckltcGwAAAAAAAAAAHBwcHBwcHBwcHA,
> cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0,
> result: null, initMsid: 52231492654, completeMsid: null, lastUpdated: null,
> lastPolled: null, created: Tue Nov 18 09:48:06 CST 2014}, job origin:2
>
>
>
>
>
> DEBUG [c.c.a.m.a.i.FirstFitAllocator] (Work-Job-Executor-2:ctx-dfc4af56
> job-2/job-11 ctx-6a233a9a FirstFitRoutingAllocator) Host Allocator
> returning 0 suitable hosts
> 2014-11-18 09:48:25,900 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) No suitable
> hosts found
> 2014-11-18 09:48:25,900 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) No suitable
> hosts found under this Cluster: 1
> 2014-11-18 09:48:25,903 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Could not find
> suitable Deployment Destination for this VM under any clusters, returning.
> 2014-11-18 09:48:25,903 DEBUG [c.c.d.FirstFitPlanner]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Searching
> resources only under specified Cluster: 1
> 2014-11-18 09:48:25,905 DEBUG [c.c.d.FirstFitPlanner]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) The specified
> cluster is in avoid set, returning.
> 2014-11-18 09:48:25,908 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Deploy avoids
> pods: null, clusters: [1], hosts: [1]
> 2014-11-18 09:48:25,910 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a)
> DeploymentPlanner allocation algorithm:
> com.cloud.deploy.FirstFitPlanner@670a0655
> 2014-11-18 09:48:25,910 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Trying to
> allocate a host and storage pools from dc:1, pod:null,cluster:null,
> requested cpu: 500, requested ram: 536870912
> 2014-11-18 09:48:25,910 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Is ROOT volume
> READY (pool already allocated)?: No
> 2014-11-18 09:48:25,911 DEBUG [c.c.d.FirstFitPlanner]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Searching all
> possible resources under this Zone: 1
> 2014-11-18 09:48:25,913 DEBUG [c.c.d.FirstFitPlanner]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Listing
> clusters in order of aggregate capacity, that have (atleast one host with)
> enough CPU and RAM capacity under this Zone: 1
> 2014-11-18 09:48:25,918 DEBUG [c.c.d.FirstFitPlanner]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Removing from
> the clusterId list these clusters from avoid set: [1]
> 2014-11-18 09:48:25,920 DEBUG [c.c.d.FirstFitPlanner]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) No clusters
> found after removing disabled clusters and clusters in avoid list,
> returning.
> 2014-11-18 09:48:25,933 DEBUG [c.c.c.CapacityManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) 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-11-18 09:48:25,945 DEBUG [c.c.c.CapacityManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Hosts's actual
> total CPU: 32000 and CPU after applying overprovisioning: 32000
> 2014-11-18 09:48:25,946 DEBUG [c.c.c.CapacityManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Hosts's actual
> total RAM: 137357664256 and RAM after applying overprovisioning:
> 137357664256
> 2014-11-18 09:48:25,946 DEBUG [c.c.c.CapacityManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) release cpu
> from host: 1, old used: 500,reserved: 0, actual total: 32000, total with
> overprovisioning: 32000; new used: 0,reserved:0; movedfromreserved:
> false,moveToReserveredfalse
> 2014-11-18 09:48:25,946 DEBUG [c.c.c.CapacityManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) release mem
> from host: 1, old used: 536870912,reserved: 0, total: 137357664256; new
> used: 0,reserved:0; movedfromreserved: false,moveToReserveredfalse
> 2014-11-18 09:48:25,950 ERROR [c.c.v.VmWorkJobHandlerProxy]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Invocation
> exception, caused by:
> com.cloud.exception.InsufficientServerCapacityException: Unable to create a
> deployment for VM[SecondaryStorageVm|s-2-VM]Scope=interface
> com.cloud.dc.DataCenter; id=1
> 2014-11-18 09:48:25,952 INFO [c.c.v.VmWorkJobHandlerProxy]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Rethrow
> exception com.cloud.exception.InsufficientServerCapacityException: Unable
> to create a deployment for VM[SecondaryStorageVm|s-2-VM]Scope=interface
> com.cloud.dc.DataCenter; id=1
> 2014-11-18 09:48:25,953 DEBUG [c.c.v.VmWorkJobDispatcher]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Done with run of VM work
> job: com.cloud.vm.VmWorkStart for VM 2, job origin: 2
> 2014-11-18 09:48:25,953 ERROR [c.c.v.VmWorkJobDispatcher]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Unable to complete
> AsyncJobVO {id:11, userId: 1, accountId: 1, instanceType: null, instanceId:
> null, cmd: com.cloud.vm.VmWorkStart, cmdInfo:
> rO0ABXNyABhjb20uY2xvdWQudm0uVm1Xb3JrU3RhcnR9cMGsvxz73gIAC0oABGRjSWRMAAZhdm9pZHN0ADBMY29tL2Nsb3VkL2RlcGxveS9EZXBsb3ltZW50UGxhbm5lciRFeGNsdWRlTGlzdDtMAAljbHVzdGVySWR0ABBMamF2YS9sYW5nL0xvbmc7TAAGaG9zdElkcQB-AAJMAAtqb3VybmFsTmFtZXQAEkxqYXZhL2xhbmcvU3RyaW5nO0wAEXBoeXNpY2FsTmV0d29ya0lkcQB-AAJMAAdwbGFubmVycQB-AANMAAVwb2RJZHEAfgACTAAGcG9vbElkcQB-AAJMAAlyYXdQYXJhbXN0AA9MamF2YS91dGlsL01hcDtMAA1yZXNlcnZhdGlvbklkcQB-AAN4cgATY29tLmNsb3VkLnZtLlZtV29ya5-ZtlbwJWdrAgAESgAJYWNjb3VudElkSgAGdXNlcklkSgAEdm1JZEwAC2hhbmRsZXJOYW1lcQB-AAN4cAAAAAAAAAABAAAAAAAAAAEAAAAAAAAAAnQAGVZpcnR1YWxNYWNoaW5lTWFuYWdlckltcGwAAAAAAAAAAHBwcHBwcHBwcHA,
> cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0,
> result: null, initMsid: 52231492654, completeMsid: null, lastUpdated: null,
> lastPolled: null, created: Tue Nov 18 09:48:06 CST 2014}, job origin:2
> com.cloud.exception.InsufficientServerCapacityException: Unable to create
> a deployment for VM[SecondaryStorageVm|s-2-VM]Scope=interface
> com.cloud.dc.DataCenter; id=1
> at
> com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:946)
> at
> com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:5190)
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
> at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java:606)
> at
> com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107)
> at
> com.cloud.vm.VirtualMachineManagerImpl.handleVmWorkJob(VirtualMachineManagerImpl.java:5335)
> at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:102)
> at
> org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:503)
> at
> org.apache.cloudstack.managed.context.ManagedContextRunnable$1.run(ManagedContextRunnable.java:49)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(DefaultManagedContext.java:56)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithContext(DefaultManagedContext.java:103)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithContext(DefaultManagedContext.java:53)
> at
> org.apache.cloudstack.managed.context.ManagedContextRunnable.run(ManagedContextRunnable.java:46)
> at
> org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.run(AsyncJobManagerImpl.java:460)
> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
> at java.util.concurrent.FutureTask.run(FutureTask.java:262)
> at
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:745)
> 2014-11-18 09:48:25,957 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Complete async job-11,
> jobStatus: FAILED, resultCode: 0, result:
> rO0ABXNyABpqYXZhLmxhbmcuUnVudGltZUV4Y2VwdGlvbp5fBkcKNIPlAgAAeHIAE2phdmEubGFuZy5FeGNlcHRpb27Q_R8-GjscxAIAAHhyABNqYXZhLmxhbmcuVGhyb3dhYmxl1cY1Jzl3uMsDAARMAAVjYXVzZXQAFUxqYXZhL2xhbmcvVGhyb3dhYmxlO0wADWRldGFpbE1lc3NhZ2V0ABJMamF2YS9sYW5nL1N0cmluZztbAApzdGFja1RyYWNldAAeW0xqYXZhL2xhbmcvU3RhY2tUcmFjZUVsZW1lbnQ7TAAUc3VwcHJlc3NlZEV4Y2VwdGlvbnN0ABBMamF2YS91dGlsL0xpc3Q7eHBxAH4AB3QAW0pvYiBmYWlsZWQgZHVlIHRvIGV4Y2VwdGlvbiBVbmFibGUgdG8gY3JlYXRlIGEgZGVwbG95bWVudCBmb3IgVk1bU2Vjb25kYXJ5U3RvcmFnZVZtfHMtMi1WTV11cgAeW0xqYXZhLmxhbmcuU3RhY2tUcmFjZUVsZW1lbnQ7AkYqPDz9IjkCAAB4cAAAAA1zcgAbamF2YS5sYW5nLlN0YWNrVHJhY2VFbGVtZW50YQnFmiY23YUCAARJAApsaW5lTnVtYmVyTAAOZGVjbGFyaW5nQ2xhc3NxAH4ABEwACGZpbGVOYW1lcQB-AARMAAptZXRob2ROYW1lcQB-AAR4cAAAAHJ0ACBjb20uY2xvdWQudm0uVm1Xb3JrSm9iRGlzcGF0Y2hlcnQAGFZtV29ya0pvYkRpc3BhdGNoZXIuamF2YXQABnJ1bkpvYnNxAH4ACwAAAfd0AD9vcmcuYXBhY2hlLmNsb3Vkc3RhY2suZnJhbWV3b3JrLmpvYnMuaW1wbC5Bc3luY0pvYk1hbmFnZXJJbXBsJDV0ABhBc3luY0pvYk1hbmFnZXJJbXBsLmphdmF0AAxydW5JbkNvbnRleHRzcQB-AAsAAAAxdAA-b3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5NYW5hZ2VkQ29udGV4dFJ1bm5hYmxlJDF0ABtNYW5hZ2VkQ29udGV4dFJ1bm5hYmxlLmphdmF0AANydW5zcQB-AAsAAAA4dABCb3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5pbXBsLkRlZmF1bHRNYW5hZ2VkQ29udGV4dCQxdAAaRGVmYXVsdE1hbmFnZWRDb250ZXh0LmphdmF0AARjYWxsc3EAfgALAAAAZ3QAQG9yZy5hcGFjaGUuY2xvdWRzdGFjay5tYW5hZ2VkLmNvbnRleHQuaW1wbC5EZWZhdWx0TWFuYWdlZENvbnRleHRxAH4AGnQAD2NhbGxXaXRoQ29udGV4dHNxAH4ACwAAADVxAH4AHXEAfgAadAAOcnVuV2l0aENvbnRleHRzcQB-AAsAAAAudAA8b3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5NYW5hZ2VkQ29udGV4dFJ1bm5hYmxlcQB-ABZxAH4AF3NxAH4ACwAAAcxxAH4AEXEAfgAScQB-ABdzcQB-AAsAAAHXdAAuamF2YS51dGlsLmNvbmN1cnJlbnQuRXhlY3V0b3JzJFJ1bm5hYmxlQWRhcHRlcnQADkV4ZWN1dG9ycy5qYXZhcQB-ABtzcQB-AAsAAAEGdAAfamF2YS51dGlsLmNvbmN1cnJlbnQuRnV0dXJlVGFza3QAD0Z1dHVyZVRhc2suamF2YXEAfgAXc3EAfgALAAAEeXQAJ2phdmEudXRpbC5jb25jdXJyZW50LlRocmVhZFBvb2xFeGVjdXRvcnQAF1RocmVhZFBvb2xFeGVjdXRvci5qYXZhdAAJcnVuV29ya2Vyc3EAfgALAAACZ3QALmphdmEudXRpbC5jb25jdXJyZW50LlRocmVhZFBvb2xFeGVjdXRvciRXb3JrZXJxAH4ALHEAfgAXc3EAfgALAAAC6XQAEGphdmEubGFuZy5UaHJlYWR0AAtUaHJlYWQuamF2YXEAfgAXc3IAJmphdmEudXRpbC5Db2xsZWN0aW9ucyRVbm1vZGlmaWFibGVMaXN0_A8lMbXsjhACAAFMAARsaXN0cQB-AAZ4cgAsamF2YS51dGlsLkNvbGxlY3Rpb25zJFVubW9kaWZpYWJsZUNvbGxlY3Rpb24ZQgCAy173HgIAAUwAAWN0ABZMamF2YS91dGlsL0NvbGxlY3Rpb247eHBzcgATamF2YS51dGlsLkFycmF5TGlzdHiB0h2Zx2GdAwABSQAEc2l6ZXhwAAAAAHcEAAAAAHhxAH4AOHg
> 2014-11-18 09:48:25,972 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Done executing
> com.cloud.vm.VmWorkStart for job-11
> 2014-11-18 09:48:25,996 WARN [o.a.c.s.SecondaryStorageManagerImpl]
> (secstorage-1:ctx-a1c90799) Exception while trying to start secondary
> storage vm
> java.lang.RuntimeException: Job failed due to exception Unable to create a
> deployment for VM[SecondaryStorageVm|s-2-VM]
> at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:114)
> at
> org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:503)
> at
> org.apache.cloudstack.managed.context.ManagedContextRunnable$1.run(ManagedContextRunnable.java:49)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(DefaultManagedContext.java:56)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithContext(DefaultManagedContext.java:103)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithContext(DefaultManagedContext.java:53)
> at
> org.apache.cloudstack.managed.context.ManagedContextRunnable.run(ManagedContextRunnable.java:46)
> at
> org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.run(AsyncJobManagerImpl.java:460)
> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
> at java.util.concurrent.FutureTask.run(FutureTask.java:262)
> at
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:745)
> 2014-11-18 09:48:26,006 DEBUG [o.a.c.f.j.i.SyncQueueManagerImpl]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Sync queue (2) is currently
> empty
> 2014-11-18 09:48:26,008 INFO [o.a.c.f.j.i.AsyncJobMonitor]
> (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Remove job-11 from job
> monitoring
> 2014-11-18 09:48:26,009 INFO [o.a.c.s.SecondaryStorageManagerImpl]
> (secstorage-1:ctx-a1c90799) Unable to start secondary storage vm for
> standby capacity, secStorageVm vm Id : 2, will recycle it and start a new
> one
> 2014-11-18 09:48:26,009 INFO [o.a.c.s.PremiumSecondaryStorageManagerImpl]
> (secstorage-1:ctx-a1c90799) Primary secondary storage is not even started,
> wait until next turn
> 2014-11-18 09:48:27,659 WARN [c.c.u.n.Link] (AgentManager-Selector:null)
> SSL: Fail to find the generated keystore. Loading fail-safe one to continue.
> 2014-11-18 09:48:28,330 DEBUG [c.c.a.t.Request]
> (AgentManager-Handler-7:null) Seq 0-0: Scheduling the first command { Cmd ,
> MgmtId: -1, via: 0, Ver: v1, Flags: 101,
> [{"com.cloud.agent.api.StartupProxyCommand":{"proxyPort":80,"proxyVmId":250,"type":"ConsoleProxy","dataCenter":"6","pod":"6","guid":"Proxy.250-ConsoleProxyResource","name":"v-250-VM","id":0,"version":"4.4.0-SNAPSHOT","iqn":"NoIqn","publicIpAddress":"192.168.1.208","publicNetmask":"255.255.255.0","publicMacAddress":"06:4d:84:00:00:11","privateIpAddress":"192.168.1.194","privateMacAddress":"06:dd:d4:00:00:03","privateNetmask":"255.255.255.0","storageIpAddress":"192.168.1.194","storageNetmask":"255.255.255.0","storageMacAddress":"06:dd:d4:00:00:03","resourceName":"ConsoleProxyResource","wait":0}}]
> }
> 2014-11-18 09:48:28,334 DEBUG [c.c.a.t.Request]
> (AgentConnectTaskPool-32:ctx-e30396fa) Seq 0-0: Processing the first
> command { Cmd , MgmtId: -1, via: 0, Ver: v1, Flags: 101,
> [{"com.cloud.agent.api.StartupProxyCommand":{"proxyPort":80,"proxyVmId":250,"type":"ConsoleProxy","dataCenter":"6","pod":"6","guid":"Proxy.250-ConsoleProxyResource","name":"v-250-VM","id":0,"version":"4.4.0-SNAPSHOT","iqn":"NoIqn","publicIpAddress":"192.168.1.208","publicNetmask":"255.255.255.0","publicMacAddress":"06:4d:84:00:00:11","privateIpAddress":"192.168.1.194","privateMacAddress":"06:dd:d4:00:00:03","privateNetmask":"255.255.255.0","storageIpAddress":"192.168.1.194","storageNetmask":"255.255.255.0","storageMacAddress":"06:dd:d4:00:00:03","resourceName":"ConsoleProxyResource","wait":0}}]
> }
> 2014-11-18 09:48:28,340 DEBUG [c.c.a.m.AgentManagerImpl]
> (AgentConnectTaskPool-32:ctx-e30396fa) Failed to handle host connection:
> java.lang.IllegalArgumentException: Host 192.168.1.194 sent incorrect data
> center: 6
> 2014-11-18 09:48:28,342 WARN [c.c.a.m.AgentManagerImpl]
> (AgentConnectTaskPool-32:ctx-e30396fa) Unable to create attache for agent:
> Seq 0-0: { Cmd , MgmtId: -1, via: 0, Ver: v1, Flags: 101,
> [{"com.cloud.agent.api.StartupProxyCommand":{"proxyPort":80,"proxyVmId":250,"type":"ConsoleProxy","dataCenter":"6","pod":"6","guid":"Proxy.250-ConsoleProxyResource","name":"v-250-VM","id":0,"version":"4.4.0-SNAPSHOT","iqn":"NoIqn","publicIpAddress":"192.168.1.208","publicNetmask":"255.255.255.0","publicMacAddress":"06:4d:84:00:00:11","privateIpAddress":"192.168.1.194","privateMacAddress":"06:dd:d4:00:00:03","privateNetmask":"255.255.255.0","storageIpAddress":"192.168.1.194","storageNetmask":"255.255.255.0","storageMacAddress":"06:dd:d4:00:00:03","resourceName":"ConsoleProxyResource","wait":0}}]
> }
> 2014-11-18 09:48:28,437 WARN [c.c.a.m.AgentManagerImpl]
> (AgentManager-Handler-8:null) Throwing away a request because it came
> through as the first command on a connect: Seq 0-1: { Cmd , MgmtId: -1,
> via: 0, Ver: v1, Flags: 11,
> [{"com.cloud.agent.api.PingCommand":{"hostType":"ConsoleProxy","hostId":0,"wait":0}}]
> }
> 2014-11-18 09:48:28,439 WARN [c.c.a.m.AgentManagerImpl]
> (AgentManager-Handler-9:null) Throwing away a request because it came
> through as the first command on a connect: Seq 0--1: { Cmd , MgmtId: -1,
> via: 0, Ver: v1, Flags: 111,
> [{"com.cloud.agent.api.ShutdownCommand":{"reason":"sig.kill","wait":0}}] }
> 2014-11-18 09:48:29,412 INFO [c.c.a.m.AgentManagerImpl]
> (AgentManager-Handler-10:null) Connection from /192.168.1.194 closed but
> no cleanup was done.
> 2014-11-18 09:48:29,719 DEBUG [c.c.n.r.VirtualNetworkApplianceManagerImpl]
> (RouterStatusMonitor-1:ctx-a0955777) Found 0 routers to update status.
> 2014-11-18 09:48:29,723 DEBUG [c.c.n.r.VirtualNetworkApplianceManagerImpl]
> (RouterStatusMonitor-1:ctx-a0955777) Found 0 networks to update RvR status.
>
>
>
>
> Wwei@landhightech.com
>
通过cloudstack 的IE 仿控制台，访问，出现这样的提示，各位碰到没有。
Posted by cloudstackfqa2013 <cl...@163.com>.
您好：
点击一个VM， 通过功能按钮的 查看控制台，弹出窗口，窗口出来下面的一段文字，请问什么原因？？
Access is denied for the console session. Please close the window and retry again
cloudstackfqa2013
发件人： Wwei@landhightech.com
发送时间： 2014-11-18 11:45
收件人： users-cn
主题： hyper-v SSVM和 CPVM 无法启动
大家好，
我配置CloudStack4.4.0+hyperV，遇到 SSVM和 CPVM 无法启动问题，
具体运行环境：
hyperV主机：hyper-V server 2012 r2 ；hyper-v 管理器为Windows server 2012 Datacenter Evaluation；hyper-V添加虚拟交换机；
主存储和二级存储：使用smb存储，存储节点为Windows server 2012 Datacenter Evaluation ,
CloudStack 初始配置：1.使用基本网络（hyperV是否可以使用基本网络进行配置？）；2.选择物理网络时;将管理网络和来宾网络的标签设置为hyper-V添加的虚拟交换机的名字；
启动区域时， SSVM和 CPVM无法正常启动，错误日志如下：
请大家帮忙看看，非常感谢。
主要是这两个错误:
1 ERROR [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Invocation exception, caused by: com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[SecondaryStorageVm|s-2-VM]Scope=interface com.cloud.dc.DataCenter; id=1
2 ERROR [c.c.v.VmWorkJobDispatcher] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Unable to complete AsyncJobVO {id:11, userId: 1, accountId: 1, instanceType: null, instanceId: null, cmd: com.cloud.vm.VmWorkStart, cmdInfo: rO0ABXNyABhjb20uY2xvdWQudm0uVm1Xb3JrU3RhcnR9cMGsvxz73gIAC0oABGRjSWRMAAZhdm9pZHN0ADBMY29tL2Nsb3VkL2RlcGxveS9EZXBsb3ltZW50UGxhbm5lciRFeGNsdWRlTGlzdDtMAAljbHVzdGVySWR0ABBMamF2YS9sYW5nL0xvbmc7TAAGaG9zdElkcQB-AAJMAAtqb3VybmFsTmFtZXQAEkxqYXZhL2xhbmcvU3RyaW5nO0wAEXBoeXNpY2FsTmV0d29ya0lkcQB-AAJMAAdwbGFubmVycQB-AANMAAVwb2RJZHEAfgACTAAGcG9vbElkcQB-AAJMAAlyYXdQYXJhbXN0AA9MamF2YS91dGlsL01hcDtMAA1yZXNlcnZhdGlvbklkcQB-AAN4cgATY29tLmNsb3VkLnZtLlZtV29ya5-ZtlbwJWdrAgAESgAJYWNjb3VudElkSgAGdXNlcklkSgAEdm1JZEwAC2hhbmRsZXJOYW1lcQB-AAN4cAAAAAAAAAABAAAAAAAAAAEAAAAAAAAAAnQAGVZpcnR1YWxNYWNoaW5lTWFuYWdlckltcGwAAAAAAAAAAHBwcHBwcHBwcHA, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 52231492654, completeMsid: null, lastUpdated: null, lastPolled: null, created: Tue Nov 18 09:48:06 CST 2014}, job origin:2
DEBUG [c.c.a.m.a.i.FirstFitAllocator] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a FirstFitRoutingAllocator) Host Allocator returning 0 suitable hosts
2014-11-18 09:48:25,900 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) No suitable hosts found
2014-11-18 09:48:25,900 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) No suitable hosts found under this Cluster: 1
2014-11-18 09:48:25,903 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Could not find suitable Deployment Destination for this VM under any clusters, returning.
2014-11-18 09:48:25,903 DEBUG [c.c.d.FirstFitPlanner] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Searching resources only under specified Cluster: 1
2014-11-18 09:48:25,905 DEBUG [c.c.d.FirstFitPlanner] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) The specified cluster is in avoid set, returning.
2014-11-18 09:48:25,908 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Deploy avoids pods: null, clusters: [1], hosts: [1]
2014-11-18 09:48:25,910 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) DeploymentPlanner allocation algorithm: com.cloud.deploy.FirstFitPlanner@670a0655
2014-11-18 09:48:25,910 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Trying to allocate a host and storage pools from dc:1, pod:null,cluster:null, requested cpu: 500, requested ram: 536870912
2014-11-18 09:48:25,910 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Is ROOT volume READY (pool already allocated)?: No
2014-11-18 09:48:25,911 DEBUG [c.c.d.FirstFitPlanner] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Searching all possible resources under this Zone: 1
2014-11-18 09:48:25,913 DEBUG [c.c.d.FirstFitPlanner] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Listing clusters in order of aggregate capacity, that have (atleast one host with) enough CPU and RAM capacity under this Zone: 1
2014-11-18 09:48:25,918 DEBUG [c.c.d.FirstFitPlanner] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Removing from the clusterId list these clusters from avoid set: [1]
2014-11-18 09:48:25,920 DEBUG [c.c.d.FirstFitPlanner] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) No clusters found after removing disabled clusters and clusters in avoid list, returning.
2014-11-18 09:48:25,933 DEBUG [c.c.c.CapacityManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) 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-11-18 09:48:25,945 DEBUG [c.c.c.CapacityManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Hosts's actual total CPU: 32000 and CPU after applying overprovisioning: 32000
2014-11-18 09:48:25,946 DEBUG [c.c.c.CapacityManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Hosts's actual total RAM: 137357664256 and RAM after applying overprovisioning: 137357664256
2014-11-18 09:48:25,946 DEBUG [c.c.c.CapacityManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) release cpu from host: 1, old used: 500,reserved: 0, actual total: 32000, total with overprovisioning: 32000; new used: 0,reserved:0; movedfromreserved: false,moveToReserveredfalse
2014-11-18 09:48:25,946 DEBUG [c.c.c.CapacityManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) release mem from host: 1, old used: 536870912,reserved: 0, total: 137357664256; new used: 0,reserved:0; movedfromreserved: false,moveToReserveredfalse
2014-11-18 09:48:25,950 ERROR [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Invocation exception, caused by: com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[SecondaryStorageVm|s-2-VM]Scope=interface com.cloud.dc.DataCenter; id=1
2014-11-18 09:48:25,952 INFO [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11 ctx-6a233a9a) Rethrow exception com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[SecondaryStorageVm|s-2-VM]Scope=interface com.cloud.dc.DataCenter; id=1
2014-11-18 09:48:25,953 DEBUG [c.c.v.VmWorkJobDispatcher] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Done with run of VM work job: com.cloud.vm.VmWorkStart for VM 2, job origin: 2
2014-11-18 09:48:25,953 ERROR [c.c.v.VmWorkJobDispatcher] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Unable to complete AsyncJobVO {id:11, userId: 1, accountId: 1, instanceType: null, instanceId: null, cmd: com.cloud.vm.VmWorkStart, cmdInfo: rO0ABXNyABhjb20uY2xvdWQudm0uVm1Xb3JrU3RhcnR9cMGsvxz73gIAC0oABGRjSWRMAAZhdm9pZHN0ADBMY29tL2Nsb3VkL2RlcGxveS9EZXBsb3ltZW50UGxhbm5lciRFeGNsdWRlTGlzdDtMAAljbHVzdGVySWR0ABBMamF2YS9sYW5nL0xvbmc7TAAGaG9zdElkcQB-AAJMAAtqb3VybmFsTmFtZXQAEkxqYXZhL2xhbmcvU3RyaW5nO0wAEXBoeXNpY2FsTmV0d29ya0lkcQB-AAJMAAdwbGFubmVycQB-AANMAAVwb2RJZHEAfgACTAAGcG9vbElkcQB-AAJMAAlyYXdQYXJhbXN0AA9MamF2YS91dGlsL01hcDtMAA1yZXNlcnZhdGlvbklkcQB-AAN4cgATY29tLmNsb3VkLnZtLlZtV29ya5-ZtlbwJWdrAgAESgAJYWNjb3VudElkSgAGdXNlcklkSgAEdm1JZEwAC2hhbmRsZXJOYW1lcQB-AAN4cAAAAAAAAAABAAAAAAAAAAEAAAAAAAAAAnQAGVZpcnR1YWxNYWNoaW5lTWFuYWdlckltcGwAAAAAAAAAAHBwcHBwcHBwcHA, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 52231492654, completeMsid: null, lastUpdated: null, lastPolled: null, created: Tue Nov 18 09:48:06 CST 2014}, job origin:2
com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[SecondaryStorageVm|s-2-VM]Scope=interface com.cloud.dc.DataCenter; id=1
at com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:946)
at com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:5190)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107)
at com.cloud.vm.VirtualMachineManagerImpl.handleVmWorkJob(VirtualMachineManagerImpl.java:5335)
at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:102)
at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:503)
at org.apache.cloudstack.managed.context.ManagedContextRunnable$1.run(ManagedContextRunnable.java:49)
at org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(DefaultManagedContext.java:56)
at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithContext(DefaultManagedContext.java:103)
at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithContext(DefaultManagedContext.java:53)
at org.apache.cloudstack.managed.context.ManagedContextRunnable.run(ManagedContextRunnable.java:46)
at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.run(AsyncJobManagerImpl.java:460)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
2014-11-18 09:48:25,957 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Complete async job-11, jobStatus: FAILED, resultCode: 0, result: rO0ABXNyABpqYXZhLmxhbmcuUnVudGltZUV4Y2VwdGlvbp5fBkcKNIPlAgAAeHIAE2phdmEubGFuZy5FeGNlcHRpb27Q_R8-GjscxAIAAHhyABNqYXZhLmxhbmcuVGhyb3dhYmxl1cY1Jzl3uMsDAARMAAVjYXVzZXQAFUxqYXZhL2xhbmcvVGhyb3dhYmxlO0wADWRldGFpbE1lc3NhZ2V0ABJMamF2YS9sYW5nL1N0cmluZztbAApzdGFja1RyYWNldAAeW0xqYXZhL2xhbmcvU3RhY2tUcmFjZUVsZW1lbnQ7TAAUc3VwcHJlc3NlZEV4Y2VwdGlvbnN0ABBMamF2YS91dGlsL0xpc3Q7eHBxAH4AB3QAW0pvYiBmYWlsZWQgZHVlIHRvIGV4Y2VwdGlvbiBVbmFibGUgdG8gY3JlYXRlIGEgZGVwbG95bWVudCBmb3IgVk1bU2Vjb25kYXJ5U3RvcmFnZVZtfHMtMi1WTV11cgAeW0xqYXZhLmxhbmcuU3RhY2tUcmFjZUVsZW1lbnQ7AkYqPDz9IjkCAAB4cAAAAA1zcgAbamF2YS5sYW5nLlN0YWNrVHJhY2VFbGVtZW50YQnFmiY23YUCAARJAApsaW5lTnVtYmVyTAAOZGVjbGFyaW5nQ2xhc3NxAH4ABEwACGZpbGVOYW1lcQB-AARMAAptZXRob2ROYW1lcQB-AAR4cAAAAHJ0ACBjb20uY2xvdWQudm0uVm1Xb3JrSm9iRGlzcGF0Y2hlcnQAGFZtV29ya0pvYkRpc3BhdGNoZXIuamF2YXQABnJ1bkpvYnNxAH4ACwAAAfd0AD9vcmcuYXBhY2hlLmNsb3Vkc3RhY2suZnJhbWV3b3JrLmpvYnMuaW1wbC5Bc3luY0pvYk1hbmFnZXJJbXBsJDV0ABhBc3luY0pvYk1hbmFnZXJJbXBsLmphdmF0AAxydW5JbkNvbnRleHRzcQB-AAsAAAAxdAA-b3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5NYW5hZ2VkQ29udGV4dFJ1bm5hYmxlJDF0ABtNYW5hZ2VkQ29udGV4dFJ1bm5hYmxlLmphdmF0AANydW5zcQB-AAsAAAA4dABCb3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5pbXBsLkRlZmF1bHRNYW5hZ2VkQ29udGV4dCQxdAAaRGVmYXVsdE1hbmFnZWRDb250ZXh0LmphdmF0AARjYWxsc3EAfgALAAAAZ3QAQG9yZy5hcGFjaGUuY2xvdWRzdGFjay5tYW5hZ2VkLmNvbnRleHQuaW1wbC5EZWZhdWx0TWFuYWdlZENvbnRleHRxAH4AGnQAD2NhbGxXaXRoQ29udGV4dHNxAH4ACwAAADVxAH4AHXEAfgAadAAOcnVuV2l0aENvbnRleHRzcQB-AAsAAAAudAA8b3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5NYW5hZ2VkQ29udGV4dFJ1bm5hYmxlcQB-ABZxAH4AF3NxAH4ACwAAAcxxAH4AEXEAfgAScQB-ABdzcQB-AAsAAAHXdAAuamF2YS51dGlsLmNvbmN1cnJlbnQuRXhlY3V0b3JzJFJ1bm5hYmxlQWRhcHRlcnQADkV4ZWN1dG9ycy5qYXZhcQB-ABtzcQB-AAsAAAEGdAAfamF2YS51dGlsLmNvbmN1cnJlbnQuRnV0dXJlVGFza3QAD0Z1dHVyZVRhc2suamF2YXEAfgAXc3EAfgALAAAEeXQAJ2phdmEudXRpbC5jb25jdXJyZW50LlRocmVhZFBvb2xFeGVjdXRvcnQAF1RocmVhZFBvb2xFeGVjdXRvci5qYXZhdAAJcnVuV29ya2Vyc3EAfgALAAACZ3QALmphdmEudXRpbC5jb25jdXJyZW50LlRocmVhZFBvb2xFeGVjdXRvciRXb3JrZXJxAH4ALHEAfgAXc3EAfgALAAAC6XQAEGphdmEubGFuZy5UaHJlYWR0AAtUaHJlYWQuamF2YXEAfgAXc3IAJmphdmEudXRpbC5Db2xsZWN0aW9ucyRVbm1vZGlmaWFibGVMaXN0_A8lMbXsjhACAAFMAARsaXN0cQB-AAZ4cgAsamF2YS51dGlsLkNvbGxlY3Rpb25zJFVubW9kaWZpYWJsZUNvbGxlY3Rpb24ZQgCAy173HgIAAUwAAWN0ABZMamF2YS91dGlsL0NvbGxlY3Rpb247eHBzcgATamF2YS51dGlsLkFycmF5TGlzdHiB0h2Zx2GdAwABSQAEc2l6ZXhwAAAAAHcEAAAAAHhxAH4AOHg
2014-11-18 09:48:25,972 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Done executing com.cloud.vm.VmWorkStart for job-11
2014-11-18 09:48:25,996 WARN [o.a.c.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-a1c90799) Exception while trying to start secondary storage vm
java.lang.RuntimeException: Job failed due to exception Unable to create a deployment for VM[SecondaryStorageVm|s-2-VM]
at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:114)
at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:503)
at org.apache.cloudstack.managed.context.ManagedContextRunnable$1.run(ManagedContextRunnable.java:49)
at org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(DefaultManagedContext.java:56)
at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithContext(DefaultManagedContext.java:103)
at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithContext(DefaultManagedContext.java:53)
at org.apache.cloudstack.managed.context.ManagedContextRunnable.run(ManagedContextRunnable.java:46)
at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.run(AsyncJobManagerImpl.java:460)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
2014-11-18 09:48:26,006 DEBUG [o.a.c.f.j.i.SyncQueueManagerImpl] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Sync queue (2) is currently empty
2014-11-18 09:48:26,008 INFO [o.a.c.f.j.i.AsyncJobMonitor] (Work-Job-Executor-2:ctx-dfc4af56 job-2/job-11) Remove job-11 from job monitoring
2014-11-18 09:48:26,009 INFO [o.a.c.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-a1c90799) Unable to start secondary storage vm for standby capacity, secStorageVm vm Id : 2, will recycle it and start a new one
2014-11-18 09:48:26,009 INFO [o.a.c.s.PremiumSecondaryStorageManagerImpl] (secstorage-1:ctx-a1c90799) Primary secondary storage is not even started, wait until next turn
2014-11-18 09:48:27,659 WARN [c.c.u.n.Link] (AgentManager-Selector:null) SSL: Fail to find the generated keystore. Loading fail-safe one to continue.
2014-11-18 09:48:28,330 DEBUG [c.c.a.t.Request] (AgentManager-Handler-7:null) Seq 0-0: Scheduling the first command { Cmd , MgmtId: -1, via: 0, Ver: v1, Flags: 101, [{"com.cloud.agent.api.StartupProxyCommand":{"proxyPort":80,"proxyVmId":250,"type":"ConsoleProxy","dataCenter":"6","pod":"6","guid":"Proxy.250-ConsoleProxyResource","name":"v-250-VM","id":0,"version":"4.4.0-SNAPSHOT","iqn":"NoIqn","publicIpAddress":"192.168.1.208","publicNetmask":"255.255.255.0","publicMacAddress":"06:4d:84:00:00:11","privateIpAddress":"192.168.1.194","privateMacAddress":"06:dd:d4:00:00:03","privateNetmask":"255.255.255.0","storageIpAddress":"192.168.1.194","storageNetmask":"255.255.255.0","storageMacAddress":"06:dd:d4:00:00:03","resourceName":"ConsoleProxyResource","wait":0}}] }
2014-11-18 09:48:28,334 DEBUG [c.c.a.t.Request] (AgentConnectTaskPool-32:ctx-e30396fa) Seq 0-0: Processing the first command { Cmd , MgmtId: -1, via: 0, Ver: v1, Flags: 101, [{"com.cloud.agent.api.StartupProxyCommand":{"proxyPort":80,"proxyVmId":250,"type":"ConsoleProxy","dataCenter":"6","pod":"6","guid":"Proxy.250-ConsoleProxyResource","name":"v-250-VM","id":0,"version":"4.4.0-SNAPSHOT","iqn":"NoIqn","publicIpAddress":"192.168.1.208","publicNetmask":"255.255.255.0","publicMacAddress":"06:4d:84:00:00:11","privateIpAddress":"192.168.1.194","privateMacAddress":"06:dd:d4:00:00:03","privateNetmask":"255.255.255.0","storageIpAddress":"192.168.1.194","storageNetmask":"255.255.255.0","storageMacAddress":"06:dd:d4:00:00:03","resourceName":"ConsoleProxyResource","wait":0}}] }
2014-11-18 09:48:28,340 DEBUG [c.c.a.m.AgentManagerImpl] (AgentConnectTaskPool-32:ctx-e30396fa) Failed to handle host connection: java.lang.IllegalArgumentException: Host 192.168.1.194 sent incorrect data center: 6
2014-11-18 09:48:28,342 WARN [c.c.a.m.AgentManagerImpl] (AgentConnectTaskPool-32:ctx-e30396fa) Unable to create attache for agent: Seq 0-0: { Cmd , MgmtId: -1, via: 0, Ver: v1, Flags: 101, [{"com.cloud.agent.api.StartupProxyCommand":{"proxyPort":80,"proxyVmId":250,"type":"ConsoleProxy","dataCenter":"6","pod":"6","guid":"Proxy.250-ConsoleProxyResource","name":"v-250-VM","id":0,"version":"4.4.0-SNAPSHOT","iqn":"NoIqn","publicIpAddress":"192.168.1.208","publicNetmask":"255.255.255.0","publicMacAddress":"06:4d:84:00:00:11","privateIpAddress":"192.168.1.194","privateMacAddress":"06:dd:d4:00:00:03","privateNetmask":"255.255.255.0","storageIpAddress":"192.168.1.194","storageNetmask":"255.255.255.0","storageMacAddress":"06:dd:d4:00:00:03","resourceName":"ConsoleProxyResource","wait":0}}] }
2014-11-18 09:48:28,437 WARN [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-8:null) Throwing away a request because it came through as the first command on a connect: Seq 0-1: { Cmd , MgmtId: -1, via: 0, Ver: v1, Flags: 11, [{"com.cloud.agent.api.PingCommand":{"hostType":"ConsoleProxy","hostId":0,"wait":0}}] }
2014-11-18 09:48:28,439 WARN [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-9:null) Throwing away a request because it came through as the first command on a connect: Seq 0--1: { Cmd , MgmtId: -1, via: 0, Ver: v1, Flags: 111, [{"com.cloud.agent.api.ShutdownCommand":{"reason":"sig.kill","wait":0}}] }
2014-11-18 09:48:29,412 INFO [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-10:null) Connection from /192.168.1.194 closed but no cleanup was done.
2014-11-18 09:48:29,719 DEBUG [c.c.n.r.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:ctx-a0955777) Found 0 routers to update status.
2014-11-18 09:48:29,723 DEBUG [c.c.n.r.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:ctx-a0955777) Found 0 networks to update RvR status.
Wwei@landhightech.com