Rayees Namathponnan created CLOUDSTACK-5710: -----------------------------------------------
Summary: [Automation] VM migration failed in kvm with NPE Key: CLOUDSTACK-5710 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-5710 Project: CloudStack Issue Type: Bug Security Level: Public (Anyone can view this level - this is the default.) Components: Management Server Affects Versions: 4.3.0 Environment: KVM RHEL 6.3 Reporter: Rayees Namathponnan Priority: Blocker Fix For: 4.3.0 Steps to reproduce Step 1 : Create advanced zone with KVM Step 2 : Add to hosts Step 3 : Deploy VM in host 1 Step 4 : Migrate vm from host 1 to host 2 migration failed with below NPE 2014-01-01 21:37:03,602 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (AsyncJobMgr-Heartbeat-1:ctx-625534e2) Schedule queued job-4429 2014-01-01 21:37:03,648 INFO [o.a.c.f.j.i.AsyncJobMonitor] (Job-Executor-61:ctx-44c473db) Add job-4429 into job monitoring 2014-01-01 21:37:03,649 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Job-Executor-61:ctx-44c473db) Executing AsyncJobVO {id:4429, userId: 2, accountId: 2, instanceType: null, instanceId: null, cmd: com.cloud.vm.VmWorkMigrate, cmdInfo: rO0ABXNyABpjb20uY2xvdWQudm0uVm1Xb3JrTWlncmF0ZRdxQXtPtzYqAgAGSgAJc3JjSG9zdElkTAAJY2x1c3RlcklkdAAQTGphdmEvbGFuZy9Mb25nO0wABmhvc3RJZHEAfgABTAAFcG9kSWRxAH4AAUwAB3N0b3JhZ2V0AA9MamF2YS91dGlsL01hcDtMAAZ6b25lSWRxAH4AAXhyABNjb20uY2xvdWQudm0uVm1Xb3Jrn5m2VvAlZ2sCAARKAAlhY2NvdW50SWRKAAZ1c2VySWRKAAR2bUlkTAALaGFuZGxlck5hbWV0ABJMamF2YS9sYW5nL1N0cmluZzt4cAAAAAAAAAACAAAAAAAAAAIAAAAAAAADU3QAGVZpcnR1YWxNYWNoaW5lTWFuYWdlckltcGwAAAAAAAAAAXNyAA5qYXZhLmxhbmcuTG9uZzuL5JDMjyPfAgABSgAFdmFsdWV4cgAQamF2YS5sYW5nLk51bWJlcoaslR0LlOCLAgAAeHAAAAAAAAAAAXNxAH4ABwAAAAAAAAACcQB-AAlwcQB-AAk, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 29066118877352, completeMsid: null, lastUpdated: null, lastPolled: null, created: Wed Jan 01 21:37:02 PST 2014} 2014-01-01 21:37:03,649 DEBUG [c.c.v.VmWorkJobDispatcher] (Job-Executor-61:ctx-44c473db) Run VM work job: com.cloud.vm.VmWorkMigrate 2014-01-01 21:37:03,665 DEBUG [c.c.v.VmWorkJobHandlerProxy] (Job-Executor-61:ctx-44c473db ctx-f08806b2) Execute VM work job: com.cloud.vm.VmWorkMigrate{"zoneId":1,"podId":1,"clusterId":1,"hostId":2,"srcHostId":1,"userId":2,"accountId":2,"vmId":851,"handlerName":"VirtualMachineManagerImpl"} 2014-01-01 21:37:03,666 ERROR [c.c.v.VmWorkJobHandlerProxy] (Job-Executor-61:ctx-44c473db ctx-f08806b2) Invocation exception, caused by: java.lang.NullPointerException 2014-01-01 21:37:03,667 ERROR [c.c.v.VmWorkJobDispatcher] (Job-Executor-61:ctx-44c473db ctx-f08806b2) Unable to complete AsyncJobVO {id:4429, userId: 2, accountId: 2, instanceType: null, instanceId: null, cmd: com.cloud.vm.VmWorkMigrate, cmdInfo: rO0ABXNyABpjb20uY2xvdWQudm0uVm1Xb3JrTWlncmF0ZRdxQXtPtzYqAgAGSgAJc3JjSG9zdElkTAAJY2x1c3RlcklkdAAQTGphdmEvbGFuZy9Mb25nO0wABmhvc3RJZHEAfgABTAAFcG9kSWRxAH4AAUwAB3N0b3JhZ2V0AA9MamF2YS91dGlsL01hcDtMAAZ6b25lSWRxAH4AAXhyABNjb20uY2xvdWQudm0uVm1Xb3Jrn5m2VvAlZ2sCAARKAAlhY2NvdW50SWRKAAZ1c2VySWRKAAR2bUlkTAALaGFuZGxlck5hbWV0ABJMamF2YS9sYW5nL1N0cmluZzt4cAAAAAAAAAACAAAAAAAAAAIAAAAAAAADU3QAGVZpcnR1YWxNYWNoaW5lTWFuYWdlckltcGwAAAAAAAAAAXNyAA5qYXZhLmxhbmcuTG9uZzuL5JDMjyPfAgABSgAFdmFsdWV4cgAQamF2YS5sYW5nLk51bWJlcoaslR0LlOCLAgAAeHAAAAAAAAAAAXNxAH4ABwAAAAAAAAACcQB-AAlwcQB-AAk, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 29066118877352, completeMsid: null, lastUpdated: null, lastPolled: null, created: Wed Jan 01 21:37:02 PST 2014} java.lang.NullPointerException at com.cloud.vm.VmWorkMigrate.getDeployDestination(VmWorkMigrate.java:60) at com.cloud.vm.VirtualMachineManagerImpl.orchestrateMigrate(VirtualMachineManagerImpl.java:4758) 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:616) at com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107) at com.cloud.vm.VirtualMachineManagerImpl.handleVmWorkJob(VirtualMachineManagerImpl.java:4855) at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:99) at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:522) 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.innerRun(FutureTask.java:334) at java.util.concurrent.FutureTask.run(FutureTask.java:166) 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) 2014-01-01 21:37:03,667 ERROR [o.a.c.f.j.i.AsyncJobManagerImpl] (Job-Executor-61:ctx-44c473db) Unexpected exception java.lang.NullPointerException 2014-01-01 21:37:03,668 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Job-Executor-61:ctx-44c473db) Complete async job-4429, jobStatus: FAILED, resultCode: 530, result: null 2014-01-01 21:37:03,688 DEBUG [o.a.c.f.j.i.SyncQueueManagerImpl] (Job-Executor-61:ctx-44c473db) Sync queue (1148) is currently empty 2014-01-01 21:37:03,690 INFO [o.a.c.f.j.i.AsyncJobMonitor] (Job-Executor-61:ctx-44c473db) Remove job-4429 from job monitoring 2014-01-01 21:37:03,698 INFO [o.a.c.f.j.i.AsyncJobMonitor] (Job-Executor-4:ctx-172cbaa6) Add job-4428 into job monitoring -- This message was sent by Atlassian JIRA (v6.1.5#6160)