请教一下大家：我用cloudstack4.3+kvm搭建的环境，创建区域后两个系统VM一直起不来，不停自动删除重建。请问一下大家问题出在哪里。management和agent日志如下.
agent-log:
2013-11-11 14:01:45,506 WARN [kvm.resource.LibvirtComputingResource]
(agentRequest-Handler-1:null) Timed out:
/usr/share/cloudstack-common/scripts/vm/hypervisor/kvm/patchviasocket.pl -n
v-1-VM -p
%template=domP%type=consoleproxy%host=172.16.0.2%port=8250%name=v-1-VM%zone=1%pod=1%guid=Proxy.1%proxy_vm=1%disable_rp_filter=true%eth2ip=172.16.3.2%eth2mask=255.255.252.0%gateway=172.16.0.1%eth0ip=169.254.3.197%eth0mask=255.255.0.0%eth1ip=172.16.0.17%eth1mask=255.255.252.0%mgmtcidr=172.16.0.0/22%localgw=172.16.0.1%internaldns1=8.8.8.8%dns1=8.8.8.8
. Output is:
2013-11-11 14:01:46,086 WARN [kvm.resource.LibvirtComputingResource]
(Script-6:null) Interrupting script.
management-log：
DEBUG [c.c.v.VirtualMachineManagerImpl] (secstorage-1:ctx-101b3ba7)
Successfully cleanued up resources for the vm VM[SecondaryStorageVm|s-2-VM] in
Starting state
DEBUG [c.c.a.t.Request] (consoleproxy-1:ctx-14751a31) Seq 1-1735065671: Sending
{ Cmd , MgmtId: 52243318339, via: 1(CSHost1), Ver: v1, Flags: 100011,
[{"com.cloud.agent.api.StartCommand":{"vm":{"id":1,"name":"v-1-VM","type":"ConsoleProxy","cpus":1,"minSpeed":500,"maxSpeed":500,"minRam":1073741824,"maxRam":1073741824,"arch":"x86_64","os":"Debian
GNU/Linux 5.0 (64-bit)","bootArgs":" template=domP type=consoleproxy
host=172.16.0.2 port=8250 name=v-1-VM zone=1 pod=1 guid=Proxy.1 proxy_vm=1
disable_rp_filter=true eth2ip=172.16.3.2 eth2mask=255.255.252.0
gateway=172.16.0.1 eth0ip=169.254.3.197 eth0mask=255.255.0.0 eth1ip=172.16.0.17
eth1mask=255.255.252.0 mgmtcidr=172.16.0.0/22 localgw=172.16.0.1
internaldns1=8.8.8.8
dns1=8.8.8.8","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"enableDynamicallyScaleVm":false,"vncPassword":"2cd61bb05ad477f0","params":{},"uuid":"013a3c56-3537-4e29-9bb0-03742241c68d","disks":[{"data":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"a29a816d-d318-4bdd-b407-9ed007817b8f","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"9f2f6ac8-69a1-394b-92c8-4bb82d44882a","id":1,"poolType":"NetworkFilesystem","host":"172.16.0.3","path":"/home/export/primary","port":2049,"url":"NetworkFilesystem://172.16.0.3//home/export/primary/?ROLE=Primary&STOREUUID=9f2f6ac8-69a1-394b-92c8-4bb82d44882a"}},"name":"ROOT-1","size":0,"path":"a29a816d-d318-4bdd-b407-9ed007817b8f","volumeId":1,"vmName":"v-1-VM","accountId":1,"format":"QCOW2","id":1,"deviceId":0,"hypervisorType":"KVM"}},"diskSeq":0,"path":"a29a816d-d318-4bdd-b407-9ed007817b8f","type":"ROOT","_details":{"managed":"false","storagePort":"2049","storageHost":"172.16.0.3","volumeSize":"0"}}],"nics":[{"deviceId":2,"networkRateMbps":-1,"defaultNic":true,"uuid":"7425d417-35ca-42fb-980e-d03150530191","ip":"172.16.3.2","netmask":"255.255.252.0","gateway":"172.16.0.1","mac":"06:72:cc:00:00:0b","dns1":"8.8.8.8","broadcastType":"Vlan","type":"Public","broadcastUri":"vlan://110","isolationUri":"vlan://110","isSecurityGroupEnabled":false},{"deviceId":0,"networkRateMbps":-1,"defaultNic":false,"uuid":"3dfe24af-17c7-42e4-972c-3b5b0258fb10","ip":"169.254.3.197","netmask":"255.255.0.0","gateway":"169.254.0.1","mac":"0e:00:a9:fe:03:c5","broadcastType":"LinkLocal","type":"Control","isSecurityGroupEnabled":false},{"deviceId":1,"networkRateMbps":-1,"defaultNic":false,"uuid":"4d24fd7b-d2f5-46f5-a47e-3f586fb15c3e","ip":"172.16.0.17","netmask":"255.255.252.0","gateway":"172.16.0.1","mac":"06:11:5a:00:00:07","broadcastType":"Native","type":"Management","isSecurityGroupEnabled":false}]},"hostIp":"172.16.0.3","executeInSequence":false,"wait":0}},{"com.cloud.agent.api.check.CheckSshCommand":{"ip":"169.254.3.197","port":3922,"interval":6,"retries":100,"name":"v-1-VM","wait":0}}]
}
DEBUG [c.c.c.CapacityManagerImpl] (secstorage-1:ctx-101b3ba7) 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
DEBUG [c.c.c.CapacityManagerImpl] (secstorage-1:ctx-101b3ba7) Hosts's actual
total CPU: 12372 and CPU after applying overprovisioning: 12372
DEBUG [c.c.c.CapacityManagerImpl] (secstorage-1:ctx-101b3ba7) Hosts's actual
total RAM: 3930034176 and RAM after applying overprovisioning: 3930034176
DEBUG [c.c.c.CapacityManagerImpl] (secstorage-1:ctx-101b3ba7) release cpu from
host: 1, old used: 1000,reserved: 0, actual total: 12372, total with
overprovisioning: 12372; new used: 500,reserved:0; movedfromreserved:
false,moveToReserveredfalse
DEBUG [c.c.c.CapacityManagerImpl] (secstorage-1:ctx-101b3ba7) release mem from
host: 1, old used: 1610612736,reserved: 0, total: 3930034176; new used:
1073741824,reserved:0; movedfromreserved: false,moveToReserveredfalse
WARN [c.c.s.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-101b3ba7)
Exception while trying to start secondary storage vm
com.cloud.exception.AgentUnavailableException: Resource [Host:1] is
unreachable: Host 1: Unable to start instance due to Unable to start
VM[SecondaryStorageVm|s-2-VM] due to error in finalizeStart, not retrying
at
com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:1072)
at
com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:761)
at
com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:745)
at
com.cloud.storage.secondary.SecondaryStorageManagerImpl.startSecStorageVm(SecondaryStorageManagerImpl.java:261)
at
com.cloud.storage.secondary.SecondaryStorageManagerImpl.allocCapacity(SecondaryStorageManagerImpl.java:694)
at
com.cloud.storage.secondary.SecondaryStorageManagerImpl.expandPool(SecondaryStorageManagerImpl.java:1278)
at
com.cloud.secstorage.PremiumSecondaryStorageManagerImpl.scanPool(PremiumSecondaryStorageManagerImpl.java:123)
at
com.cloud.secstorage.PremiumSecondaryStorageManagerImpl.scanPool(PremiumSecondaryStorageManagerImpl.java:50)
at
com.cloud.vm.SystemVmLoadScanner.loadScan(SystemVmLoadScanner.java:111)
at
com.cloud.vm.SystemVmLoadScanner.access$100(SystemVmLoadScanner.java:35)
at
com.cloud.vm.SystemVmLoadScanner$1.reallyRun(SystemVmLoadScanner.java:88)
at
com.cloud.vm.SystemVmLoadScanner$1.runInContext(SystemVmLoadScanner.java:79)
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
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at
java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:351)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:178)
at
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:178)
at
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
at java.lang.Thread.run(Thread.java:722)
Caused by: com.cloud.utils.exception.ExecutionException: Unable to start
VM[SecondaryStorageVm|s-2-VM] due to error in finalizeStart, not retrying
at
com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:1039)
... 24 more
INFO [c.c.s.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-101b3ba7) Unable
to start secondary storage vm for standby capacity, secStorageVm vm Id : 2,
will recycle it and start a new one
