You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@cloudstack.apache.org by Harikrishna Patnala <ha...@citrix.com> on 2013/03/08 14:27:20 UTC
System VMs are not coming up on KVM host
Hello,
I'm trying to add KVM host and added successfully but the system vms are not coming up.
Getting NPE when cs tries to start system vms.
2013-03-08 18:35:29,647 INFO [cloud.secstorage.PremiumSecondaryStorageManagerImpl] (secstorage-1:null) Primary secondary storage is not even started, wait until next turn
2013-03-08 18:35:34,235 DEBUG [cloud.template.TemplateManagerImpl] (consoleproxy-1:null) Downloading 3 via 1
2013-03-08 18:35:34,240 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-149684358: Sending { Cmd , MgmtId: 1, via: 1, Ver: v1, Flags: 100111, [{"storage.PrimaryStorageDownloadCommand":{"localPath":"/mnt/30afb3c3-9602-3e56-b1a8-a8067d54a366","poolUuid":"30afb3c3-9602-3e56-b1a8-a8067d54a366","poolId":200,"secondaryStorageUrl":"nfs://10.147.28.7/export/home/hari/secondary","primaryStorageUrl":"nfs://10.147.28.7/export/home/hari/primary","url":"nfs://10.147.28.7/export/home/hari/secondary/template/tmpl/1/3/","format":"QCOW2","accountId":1,"name":"routing-3","wait":10800}}] }
2013-03-08 18:35:34,480 DEBUG [agent.transport.Request] (AgentManager-Handler-10:null) Seq 1-149684358: Processing: { Ans: , MgmtId: 1, via: 1, Ver: v1, Flags: 110, [{"Answer":{"result":false,"details":"java.lang.NullPointerException\n\tat com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.execute(LibvirtComputingResource.java:2312)\n\tat com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.executeRequest(LibvirtComputingResource.java:1134)\n\tat com.cloud.agent.Agent.processRequest(Agent.java:525)\n\tat com.cloud.agent.Agent$AgentRequestHandler.doTask(Agent.java:852)\n\tat com.cloud.utils.nio.Task.run(Task.java:83)\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)\n\tat java.lang.Thread.run(Thread.java:679)\n","wait":0}}] }
2013-03-08 18:35:34,481 DEBUG [agent.manager.AgentAttache] (AgentManager-Handler-10:null) Seq 1-149684358: No more commands found
2013-03-08 18:35:34,481 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-149684358: Received: { Ans: , MgmtId: 1, via: 1, Ver: v1, Flags: 110, { Answer } }
2013-03-08 18:35:34,481 DEBUG [agent.manager.AgentManagerImpl] (consoleproxy-1:null) Details from executing class com.cloud.agent.api.storage.PrimaryStorageDownloadCommand: java.lang.NullPointerException
at com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.execute(LibvirtComputingResource.java:2312)
at com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.executeRequest(LibvirtComputingResource.java:1134)
at com.cloud.agent.Agent.processRequest(Agent.java:525)
at com.cloud.agent.Agent$AgentRequestHandler.doTask(Agent.java:852)
at com.cloud.utils.nio.Task.run(Task.java:83)
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:679)
2013-03-08 18:35:34,482 ERROR [cloud.vm.VirtualMachineManagerImpl] (consoleproxy-1:null) Failed to start instance VM[ConsoleProxy|v-28-TEST]
java.lang.ClassCastException: com.cloud.agent.api.Answer cannot be cast to com.cloud.agent.api.storage.PrimaryStorageDownloadAnswer
at com.cloud.template.TemplateManagerImpl.prepareTemplateForCreate(TemplateManagerImpl.java:663)
at com.cloud.utils.db.DatabaseCallback.intercept(DatabaseCallback.java:34)
at com.cloud.storage.StorageManagerImpl.createVolume(StorageManagerImpl.java:3448)
at com.cloud.storage.StorageManagerImpl.prepare(StorageManagerImpl.java:3351)
at com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:754)
at com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:472)
at com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:465)
at com.cloud.consoleproxy.ConsoleProxyManagerImpl.startProxy(ConsoleProxyManagerImpl.java:627)
at com.cloud.consoleproxy.ConsoleProxyManagerImpl.allocCapacity(ConsoleProxyManagerImpl.java:1164)
at com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:1981)
at com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:173)
at com.cloud.vm.SystemVmLoadScanner.loadScan(SystemVmLoadScanner.java:113)
at com.cloud.vm.SystemVmLoadScanner.access$100(SystemVmLoadScanner.java:34)
at com.cloud.vm.SystemVmLoadScanner$1.reallyRun(SystemVmLoadScanner.java:83)
at com.cloud.vm.SystemVmLoadScanner$1.run(SystemVmLoadScanner.java:73)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:439)
at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:317)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:150)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:98)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.runPeriodic(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:204)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
at java.lang.Thread.run(Thread.java:680)
2013-03-08 18:35:34,487 DEBUG [cloud.vm.VirtualMachineManagerImpl] (consoleproxy-1:null) Cleaning up resources for the vm VM[ConsoleProxy|v-28-TEST] in Starting state
2013-03-08 18:35:34,489 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-149684359: Sending { Cmd , MgmtId: 1, via: 1, Ver: v1, Flags: 100111, [{"StopCommand":{"isProxy":false,"vmName":"v-28-TEST","wait":0}}] }
2013-03-08 18:35:34,590 DEBUG [agent.transport.Request] (AgentManager-Handler-12:null) Seq 1-149684359: Processing: { Ans: , MgmtId: 1, via: 1, Ver: v1, Flags: 110, [{"StopAnswer":{"vncPort":0,"result":true,"wait":0}}] }
2013-03-08 18:35:34,590 DEBUG [agent.manager.AgentAttache] (AgentManager-Handler-12:null) Seq 1-149684359: No more commands found
Can I get quick help in setting this,
Thanks in advance,
Re: System VMs are not coming up on KVM host
Posted by Harikrishna Patnala <ha...@citrix.com>.
I'm on 4.0
On 08-Mar-2013, at 6:57 PM, Harikrishna Patnala <ha...@citrix.com> wrote:
> Hello,
>
> I'm trying to add KVM host and added successfully but the system vms are not coming up.
>
>
> Getting NPE when cs tries to start system vms.
>
> 2013-03-08 18:35:29,647 INFO [cloud.secstorage.PremiumSecondaryStorageManagerImpl] (secstorage-1:null) Primary secondary storage is not even started, wait until next turn
> 2013-03-08 18:35:34,235 DEBUG [cloud.template.TemplateManagerImpl] (consoleproxy-1:null) Downloading 3 via 1
> 2013-03-08 18:35:34,240 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-149684358: Sending { Cmd , MgmtId: 1, via: 1, Ver: v1, Flags: 100111, [{"storage.PrimaryStorageDownloadCommand":{"localPath":"/mnt/30afb3c3-9602-3e56-b1a8-a8067d54a366","poolUuid":"30afb3c3-9602-3e56-b1a8-a8067d54a366","poolId":200,"secondaryStorageUrl":"nfs://10.147.28.7/export/home/hari/secondary","primaryStorageUrl":"nfs://10.147.28.7/export/home/hari/primary","url":"nfs://10.147.28.7/export/home/hari/secondary/template/tmpl/1/3/","format":"QCOW2","accountId":1,"name":"routing-3","wait":10800}}] }
> 2013-03-08 18:35:34,480 DEBUG [agent.transport.Request] (AgentManager-Handler-10:null) Seq 1-149684358: Processing: { Ans: , MgmtId: 1, via: 1, Ver: v1, Flags: 110, [{"Answer":{"result":false,"details":"java.lang.NullPointerException\n\tat com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.execute(LibvirtComputingResource.java:2312)\n\tat com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.executeRequest(LibvirtComputingResource.java:1134)\n\tat com.cloud.agent.Agent.processRequest(Agent.java:525)\n\tat com.cloud.agent.Agent$AgentRequestHandler.doTask(Agent.java:852)\n\tat com.cloud.utils.nio.Task.run(Task.java:83)\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)\n\tat java.lang.Thread.run(Thread.java:679)\n","wait":0}}] }
> 2013-03-08 18:35:34,481 DEBUG [agent.manager.AgentAttache] (AgentManager-Handler-10:null) Seq 1-149684358: No more commands found
> 2013-03-08 18:35:34,481 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-149684358: Received: { Ans: , MgmtId: 1, via: 1, Ver: v1, Flags: 110, { Answer } }
> 2013-03-08 18:35:34,481 DEBUG [agent.manager.AgentManagerImpl] (consoleproxy-1:null) Details from executing class com.cloud.agent.api.storage.PrimaryStorageDownloadCommand: java.lang.NullPointerException
> at com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.execute(LibvirtComputingResource.java:2312)
> at com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.executeRequest(LibvirtComputingResource.java:1134)
> at com.cloud.agent.Agent.processRequest(Agent.java:525)
> at com.cloud.agent.Agent$AgentRequestHandler.doTask(Agent.java:852)
> at com.cloud.utils.nio.Task.run(Task.java:83)
> 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:679)
>
> 2013-03-08 18:35:34,482 ERROR [cloud.vm.VirtualMachineManagerImpl] (consoleproxy-1:null) Failed to start instance VM[ConsoleProxy|v-28-TEST]
> java.lang.ClassCastException: com.cloud.agent.api.Answer cannot be cast to com.cloud.agent.api.storage.PrimaryStorageDownloadAnswer
> at com.cloud.template.TemplateManagerImpl.prepareTemplateForCreate(TemplateManagerImpl.java:663)
> at com.cloud.utils.db.DatabaseCallback.intercept(DatabaseCallback.java:34)
> at com.cloud.storage.StorageManagerImpl.createVolume(StorageManagerImpl.java:3448)
> at com.cloud.storage.StorageManagerImpl.prepare(StorageManagerImpl.java:3351)
> at com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:754)
> at com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:472)
> at com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:465)
> at com.cloud.consoleproxy.ConsoleProxyManagerImpl.startProxy(ConsoleProxyManagerImpl.java:627)
> at com.cloud.consoleproxy.ConsoleProxyManagerImpl.allocCapacity(ConsoleProxyManagerImpl.java:1164)
> at com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:1981)
> at com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:173)
> at com.cloud.vm.SystemVmLoadScanner.loadScan(SystemVmLoadScanner.java:113)
> at com.cloud.vm.SystemVmLoadScanner.access$100(SystemVmLoadScanner.java:34)
> at com.cloud.vm.SystemVmLoadScanner$1.reallyRun(SystemVmLoadScanner.java:83)
> at com.cloud.vm.SystemVmLoadScanner$1.run(SystemVmLoadScanner.java:73)
> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:439)
> at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:317)
> at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:150)
> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:98)
> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.runPeriodic(ScheduledThreadPoolExecutor.java:180)
> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:204)
> at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
> at java.lang.Thread.run(Thread.java:680)
> 2013-03-08 18:35:34,487 DEBUG [cloud.vm.VirtualMachineManagerImpl] (consoleproxy-1:null) Cleaning up resources for the vm VM[ConsoleProxy|v-28-TEST] in Starting state
> 2013-03-08 18:35:34,489 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-149684359: Sending { Cmd , MgmtId: 1, via: 1, Ver: v1, Flags: 100111, [{"StopCommand":{"isProxy":false,"vmName":"v-28-TEST","wait":0}}] }
> 2013-03-08 18:35:34,590 DEBUG [agent.transport.Request] (AgentManager-Handler-12:null) Seq 1-149684359: Processing: { Ans: , MgmtId: 1, via: 1, Ver: v1, Flags: 110, [{"StopAnswer":{"vncPort":0,"result":true,"wait":0}}] }
> 2013-03-08 18:35:34,590 DEBUG [agent.manager.AgentAttache] (AgentManager-Handler-12:null) Seq 1-149684359: No more commands found
>
>
>
>
> Can I get quick help in setting this,
>
>
>
> Thanks in advance,
>
>