[
https://issues.apache.org/jira/browse/CLOUDSTACK-5766?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]
Srikanteswararao Talluri closed CLOUDSTACK-5766.
------------------------------------------------
> [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)
