You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@cloudstack.apache.org by "Srikanteswararao Talluri (JIRA)" <ji...@apache.org> on 2014/01/03 15:22:04 UTC
[jira] [Created] (CLOUDSTACK-5766) [Automation] NPE while migration
virtual machine
Srikanteswararao Talluri created CLOUDSTACK-5766:
----------------------------------------------------
Summary: [Automation] NPE while migration virtual machine
Key: CLOUDSTACK-5766
URL: https://issues.apache.org/jira/browse/CLOUDSTACK-5766
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: xenserver 6.2
advanced zone
Reporter: Srikanteswararao Talluri
Priority: Blocker
Fix For: 4.3.0
steps to reproduce:
1. migrate a virtual machine to another available host in xenserver pool
===START=== 10.252.192.57 -- GET command=migrateVirtualMachine&hostid=ca564580-b195-4094-8a60-bcbdf28059ed&virtualmachineid=4561434a-7f4e-4e1b-95d9-c820fd566cf2&response=json&sessionkey=7razDgyA%2Ft1Sgdr1XRCXVV1n2RE%3D&_=1388758756482
2014-01-04 01:09:20,327 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (catalina-exec-24:ctx-045cf2c3 ctx-01e7c6a6) submit async job-593, details: AsyncJobVO {id:593, userId: 2, accountId: 2, instanceType: None, instanceId: null, cmd: org.apache.cloudstack.api.command.admin.vm.MigrateVMCmd, cmdInfo: {"response":"json","sessionkey":"7razDgyA/t1Sgdr1XRCXVV1n2RE\u003d","virtualmachineid":"4561434a-7f4e-4e1b-95d9-c820fd566cf2","cmdEventType":"VM.MIGRATE","hostid":"ca564580-b195-4094-8a60-bcbdf28059ed","ctxUserId":"2","httpmethod":"GET","_":"1388758756482","ctxAccountId":"2","ctxStartEventId":"2073"}, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 6631563722783, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
2014-01-04 01:09:20,329 DEBUG [c.c.a.ApiServlet] (catalina-exec-24:ctx-045cf2c3 ctx-01e7c6a6) ===END=== 10.252.192.57 -- GET command=migrateVirtualMachine&hostid=ca564580-b195-4094-8a60-bcbdf28059ed&virtualmachineid=4561434a-7f4e-4e1b-95d9-c820fd566cf2&response=json&sessionkey=7razDgyA%2Ft1Sgdr1XRCXVV1n2RE%3D&_=1388758756482
2014-01-04 01:09:20,336 INFO [o.a.c.f.j.i.AsyncJobMonitor] (Job-Executor-30:ctx-64b33f9f) Add job-593 into job monitoring
2014-01-04 01:09:20,336 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Job-Executor-30:ctx-64b33f9f) Executing AsyncJobVO {id:593, userId: 2, accountId: 2, instanceType: None, instanceId: null, cmd: org.apache.cloudstack.api.command.admin.vm.MigrateVMCmd, cmdInfo: {"response":"json","sessionkey":"7razDgyA/t1Sgdr1XRCXVV1n2RE\u003d","virtualmachineid":"4561434a-7f4e-4e1b-95d9-c820fd566cf2","cmdEventType":"VM.MIGRATE","hostid":"ca564580-b195-4094-8a60-bcbdf28059ed","ctxUserId":"2","httpmethod":"GET","_":"1388758756482","ctxAccountId":"2","ctxStartEventId":"2073"}, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 6631563722783, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
2014-01-04 01:09:20,420 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Job-Executor-30:ctx-64b33f9f ctx-01e7c6a6) Sync job-594 execution on object VmWorkJobQueue.90
2014-01-04 01:09:21,201 DEBUG [c.c.a.ApiServlet] (catalina-exec-13:ctx-8421a3e0) ===START=== 10.147.38.149 -- GET signature=wqgfbCPGPfzFD18638tlhCOrNgY%3D&apiKey=CmB8bjoITlrdKIDjDmEH2AfUefYO-vv5GnylOL4jUfdb3tfNRuRCeQWytcnwxyen1OdeNfa1EPoBOjIuAhV7JA&command=queryAsyncJobResult&response=json&jobid=1a74c10e-6ff3-42cb-9884-edef05dd5e3b
2014-01-04 01:09:21,244 DEBUG [c.c.c.ConsoleProxyManagerImpl] (consoleproxy-1:ctx-fa7a9fd4) Zone 1 is ready to launch console proxy
2014-01-04 01:09:21,250 DEBUG [c.c.a.ApiServlet] (catalina-exec-13:ctx-8421a3e0 ctx-0ff139b2 ctx-7481681b) ===END=== 10.147.38.149 -- GET signature=wqgfbCPGPfzFD18638tlhCOrNgY%3D&apiKey=CmB8bjoITlrdKIDjDmEH2AfUefYO-vv5GnylOL4jUfdb3tfNRuRCeQWytcnwxyen1OdeNfa1EPoBOjIuAhV7JA&command=queryAsyncJobResult&response=json&jobid=1a74c10e-6ff3-42cb-9884-edef05dd5e3b
2014-01-04 01:09:21,270 DEBUG [c.c.c.ConsoleProxyManagerImpl] (consoleproxy-1:ctx-fa7a9fd4) Zone 2 is ready to launch console proxy
2014-01-04 01:09:21,482 DEBUG [c.c.s.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-06667971) Zone 1 is ready to launch secondary storage VM
2014-01-04 01:09:21,520 DEBUG [c.c.s.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-06667971) Zone 2 is ready to launch secondary storage VM
2014-01-04 01:09:22,037 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (AsyncJobMgr-Heartbeat-1:ctx-3e6ab8a9) Execute sync-queue item: SyncQueueItemVO {id:167, queueId: 146, contentType: AsyncJob, contentId: 594, lastProcessMsid: null, lastprocessNumber: null, lastProcessTime: null, created: Sat Jan 04 01:09:20 IST 2014}
2014-01-04 01:09:22,040 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (AsyncJobMgr-Heartbeat-1:ctx-3e6ab8a9) Schedule queued job-594
2014-01-04 01:09:22,048 INFO [o.a.c.f.j.i.AsyncJobMonitor] (Job-Executor-51:ctx-9a705049) Add job-594 into job monitoring
2014-01-04 01:09:22,049 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Job-Executor-51:ctx-9a705049) Executing AsyncJobVO {id:594, userId: 2, accountId: 2, instanceType: null, instanceId: null, cmd: com.cloud.vm.VmWorkMigrate, cmdInfo: rO0ABXNyABpjb20uY2xvdWQudm0uVm1Xb3JrTWlncmF0ZRdxQXtPtzYqAgAGSgAJc3JjSG9zdElkTAAJY2x1c3RlcklkdAAQTGphdmEvbGFuZy9Mb25nO0wABmhvc3RJZHEAfgABTAAFcG9kSWRxAH4AAUwAB3N0b3JhZ2V0AA9MamF2YS91dGlsL01hcDtMAAZ6b25lSWRxAH4AAXhyABNjb20uY2xvdWQudm0uVm1Xb3Jrn5m2VvAlZ2sCAARKAAlhY2NvdW50SWRKAAZ1c2VySWRKAAR2bUlkTAALaGFuZGxlck5hbWV0ABJMamF2YS9sYW5nL1N0cmluZzt4cAAAAAAAAAACAAAAAAAAAAIAAAAAAAAAWnQAGVZpcnR1YWxNYWNoaW5lTWFuYWdlckltcGwAAAAAAAAAAXNyAA5qYXZhLmxhbmcuTG9uZzuL5JDMjyPfAgABSgAFdmFsdWV4cgAQamF2YS5sYW5nLk51bWJlcoaslR0LlOCLAgAAeHAAAAAAAAAAAXNxAH4ABwAAAAAAAAACcQB-AAlwcQB-AAk, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 6631563722783, completeMsid: null, lastUpdated: null, lastPolled: null, created: Sat Jan 04 01:09:20 IST 2014}
2014-01-04 01:09:22,049 DEBUG [c.c.v.VmWorkJobDispatcher] (Job-Executor-51:ctx-9a705049) Run VM work job: com.cloud.vm.VmWorkMigrate
2014-01-04 01:09:22,052 DEBUG [c.c.v.VmWorkJobHandlerProxy] (Job-Executor-51:ctx-9a705049 ctx-01e7c6a6) Execute VM work job: com.cloud.vm.VmWorkMigrate{"zoneId":1,"podId":1,"clusterId":1,"hostId":2,"srcHostId":1,"userId":2,"accountId":2,"vmId":90,"handlerName":"VirtualMachineManagerImpl"}
2014-01-04 01:09:22,059 ERROR [c.c.v.VmWorkJobHandlerProxy] (Job-Executor-51:ctx-9a705049 ctx-01e7c6a6) Invocation exception, caused by: java.lang.NullPointerException
2014-01-04 01:09:22,059 ERROR [c.c.v.VmWorkJobDispatcher] (Job-Executor-51:ctx-9a705049 ctx-01e7c6a6) Unable to complete AsyncJobVO {id:594, userId: 2, accountId: 2, instanceType: null, instanceId: null, cmd: com.cloud.vm.VmWorkMigrate, cmdInfo: rO0ABXNyABpjb20uY2xvdWQudm0uVm1Xb3JrTWlncmF0ZRdxQXtPtzYqAgAGSgAJc3JjSG9zdElkTAAJY2x1c3RlcklkdAAQTGphdmEvbGFuZy9Mb25nO0wABmhvc3RJZHEAfgABTAAFcG9kSWRxAH4AAUwAB3N0b3JhZ2V0AA9MamF2YS91dGlsL01hcDtMAAZ6b25lSWRxAH4AAXhyABNjb20uY2xvdWQudm0uVm1Xb3Jrn5m2VvAlZ2sCAARKAAlhY2NvdW50SWRKAAZ1c2VySWRKAAR2bUlkTAALaGFuZGxlck5hbWV0ABJMamF2YS9sYW5nL1N0cmluZzt4cAAAAAAAAAACAAAAAAAAAAIAAAAAAAAAWnQAGVZpcnR1YWxNYWNoaW5lTWFuYWdlckltcGwAAAAAAAAAAXNyAA5qYXZhLmxhbmcuTG9uZzuL5JDMjyPfAgABSgAFdmFsdWV4cgAQamF2YS5sYW5nLk51bWJlcoaslR0LlOCLAgAAeHAAAAAAAAAAAXNxAH4ABwAAAAAAAAACcQB-AAlwcQB-AAk, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 6631563722783, completeMsid: null, lastUpdated: null, lastPolled: null, created: Sat Jan 04 01:09:20 IST 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:524)
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-04 01:09:22,082 ERROR [o.a.c.f.j.i.AsyncJobManagerImpl] (Job-Executor-51:ctx-9a705049) Unexpected exception
java.lang.NullPointerException
at com.google.gson.JsonPrimitive.isPrimitiveOrString(JsonPrimitive.java:316)
at com.google.gson.JsonPrimitive.setValue(JsonPrimitive.java:97)
at com.google.gson.JsonPrimitive.<init>(JsonPrimitive.java:67)
at org.apache.cloudstack.framework.jobs.impl.JobSerializerHelper$ThrowableTypeAdapter.serialize(JobSerializerHelper.java:195)
at org.apache.cloudstack.framework.jobs.impl.JobSerializerHelper$ThrowableTypeAdapter.serialize(JobSerializerHelper.java:158)
at com.google.gson.JsonSerializationVisitor.findAndInvokeCustomSerializer(JsonSerializationVisitor.java:184)
at com.google.gson.JsonSerializationVisitor.visitFieldUsingCustomHandler(JsonSerializationVisitor.java:204)
at com.google.gson.ReflectingFieldNavigator.visitFieldsReflectively(ReflectingFieldNavigator.java:63)
at com.google.gson.ObjectNavigator.accept(ObjectNavigator.java:120)
at com.google.gson.JsonSerializationContextDefault.serialize(JsonSerializationContextDefault.java:62)
at com.google.gson.JsonSerializationContextDefault.serialize(JsonSerializationContextDefault.java:53)
at com.google.gson.Gson.toJsonTree(Gson.java:220)
at com.google.gson.Gson.toJson(Gson.java:260)
at com.google.gson.Gson.toJson(Gson.java:240)
at org.apache.cloudstack.framework.jobs.impl.JobSerializerHelper.toSerializedString(JobSerializerHelper.java:65)
at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:105)
at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:524)
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-04 01:09:22,086 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Job-Executor-51:ctx-9a705049) Complete async job-594, jobStatus: FAILED, resultCode: 530, result: null
2014-01-04 01:09:22,101 INFO [o.a.c.f.j.i.AsyncJobMonitor] (Job-Executor-60:ctx-2a961988) Add job-593 into job monitoring
2014-01-04 01:09:22,102 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Job-Executor-60:ctx-2a961988) Executing AsyncJobVO {id:593, userId: 2, accountId: 2, instanceType: None, instanceId: null, cmd: org.apache.cloudstack.api.command.admin.vm.MigrateVMCmd, cmdInfo: {"response":"json","sessionkey":"7razDgyA/t1Sgdr1XRCXVV1n2RE\u003d","virtualmachineid":"4561434a-7f4e-4e1b-95d9-c820fd566cf2","cmdEventType":"VM.MIGRATE","hostid":"ca564580-b195-4094-8a60-bcbdf28059ed","ctxUserId":"2","httpmethod":"GET","_":"1388758756482","ctxAccountId":"2","ctxStartEventId":"2073"}, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 6631563722783, completeMsid: null, lastUpdated: null, lastPolled: null, created: Sat Jan 04 01:09:20 IST 2014}
2014-01-04 01:09:22,127 ERROR [o.a.c.f.j.i.AsyncJobManagerImpl] (Job-Executor-60:ctx-2a961988) Unable to find a wakeup dispatcher from the joined job: AsyncJobVO {id:593, userId: 2, accountId: 2, instanceType: None, instanceId: null, cmd: org.apache.cloudstack.api.command.admin.vm.MigrateVMCmd, cmdInfo: {"response":"json","sessionkey":"7razDgyA/t1Sgdr1XRCXVV1n2RE\u003d","virtualmachineid":"4561434a-7f4e-4e1b-95d9-c820fd566cf2","cmdEventType":"VM.MIGRATE","hostid":"ca564580-b195-4094-8a60-bcbdf28059ed","ctxUserId":"2","httpmethod":"GET","_":"1388758756482","ctxAccountId":"2","ctxStartEventId":"2073"}, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 6631563722783, completeMsid: null, lastUpdated: null, lastPolled: null, created: Sat Jan 04 01:09:20 IST 2014}
2014-01-04 01:09:22,154 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Job-Executor-60:ctx-2a961988) Done executing org.apache.cloudstack.api.command.admin.vm.MigrateVMCmd for job-593
2014-01-04 01:09:22,162 INFO [o.a.c.f.j.i.AsyncJobMonitor] (Job-Executor-60:ctx-2a961988) Remove job-593 from job monitoring
2014-01-04 01:09:22,168 DEBUG [o.a.c.f.j.i.SyncQueueManagerImpl] (Job-Executor-51:ctx-9a705049) Sync queue (146) is currently empty
2014-01-04 01:09:22,169 INFO [o.a.c.f.j.i.AsyncJobMonitor] (Job-Executor-51:ctx-9a705049) Remove job-594 from job monitoring
2014-01-04 01:09:22,191 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Job-Executor-30:ctx-64b33f9f ctx-01e7c6a6) Complete async job-593, jobStatus: SUCCEEDED, resultCode: 0, result: org.apache.cloudstack.api.response.UserVmResponse/virtualmachine/{"id":"4561434a-7f4e-4e1b-95d9-c820fd566cf2","name":"t","displayname":"t","account":"admin","domainid":"4508cc0e-7497-11e3-b905-06080800001f","domain":"ROOT","
--
This message was sent by Atlassian JIRA
(v6.1.5#6160)