You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@cloudstack.apache.org by "Sailaja Mada (JIRA)" <ji...@apache.org> on 2013/07/19 11:14:48 UTC
[jira] [Closed] (CLOUDSTACK-3554) NPE while attaching VMWARE Tools
ISO to the instance
[ https://issues.apache.org/jira/browse/CLOUDSTACK-3554?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]
Sailaja Mada closed CLOUDSTACK-3554.
------------------------------------
Regressed with latest 4.2 VMWARE setup. This is fixed now.
Hence closing the bug.
> NPE while attaching VMWARE Tools ISO to the instance
> -----------------------------------------------------
>
> Key: CLOUDSTACK-3554
> URL: https://issues.apache.org/jira/browse/CLOUDSTACK-3554
> Project: CloudStack
> Issue Type: Bug
> Security Level: Public(Anyone can view this level - this is the default.)
> Components: Storage Controller
> Affects Versions: 4.2.0
> Reporter: Sailaja Mada
> Assignee: Venkata Siva Vijayendra Bhamidipati
> Priority: Blocker
> Fix For: 4.2.0
>
> Attachments: apilog.log, management-server.log
>
>
> Steps:
> 1. Configure Adv Zone with VMWARE
> 2. Deploy instance with newly added account
> 3. Tried to attach VMWARE tools iso to this instance
> Observation:
> It failed with NPE:
> 2013-07-16 17:22:43,089 DEBUG [cloud.api.ApiServlet] (catalina-exec-18:null) ===START=== 10.144.6.19 -- GET command=attachIso&virtualmachineid=0f7b7a84-2325-4100-817a-e63e216c2b75&id=e09209bc-4731-4aac-b65e-00aed3540993&response=json&sessionkey=5vYbKOzqMAqkmN9vVQ%2F695HcVDs%3D&_=1373975773858
> 2013-07-16 17:22:43,146 DEBUG [cloud.async.AsyncJobManagerImpl] (catalina-exec-18:null) submit async job-77 = [ 24362d6b-4eb7-48d0-893a-2ac61fa84d5e ], details: AsyncJobVO {id:77, userId: 8, accountId: 8, sessionKey: null, instanceType: None, instanceId: null, cmd: org.apache.cloudstack.api.command.user.iso.AttachIsoCmd, cmdOriginator: null, cmdInfo: {"id":"e09209bc-4731-4aac-b65e-00aed3540993","response":"json","sessionkey":"5vYbKOzqMAqkmN9vVQ/695HcVDs\u003d","virtualmachineid":"0f7b7a84-2325-4100-817a-e63e216c2b75","cmdEventType":"ISO.ATTACH","ctxUserId":"8","httpmethod":"GET","_":"1373975773858","ctxAccountId":"8","ctxStartEventId":"299"}, cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0, processStatus: 0, resultCode: 0, result: null, initMsid: 187767034175903, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
> 2013-07-16 17:22:43,149 DEBUG [cloud.api.ApiServlet] (catalina-exec-18:null) ===END=== 10.144.6.19 -- GET command=attachIso&virtualmachineid=0f7b7a84-2325-4100-817a-e63e216c2b75&id=e09209bc-4731-4aac-b65e-00aed3540993&response=json&sessionkey=5vYbKOzqMAqkmN9vVQ%2F695HcVDs%3D&_=1373975773858
> 2013-07-16 17:22:43,152 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-18:job-77 = [ 24362d6b-4eb7-48d0-893a-2ac61fa84d5e ]) Executing org.apache.cloudstack.api.command.user.iso.AttachIsoCmd for job-77 = [ 24362d6b-4eb7-48d0-893a-2ac61fa84d5e ]
> 2013-07-16 17:22:43,186 DEBUG [cloud.user.AccountManagerImpl] (Job-Executor-18:job-77 = [ 24362d6b-4eb7-48d0-893a-2ac61fa84d5e ]) Access to Tmpl[200-ISO-vmware-tools.iso granted to Acct[8-dc2user1] by DomainChecker_EnhancerByCloudStack_1028f2c
> 2013-07-16 17:22:43,188 DEBUG [cloud.user.AccountManagerImpl] (Job-Executor-18:job-77 = [ 24362d6b-4eb7-48d0-893a-2ac61fa84d5e ]) Access to VM[User|dc2user1i1] granted to Acct[8-dc2user1] by DomainChecker_EnhancerByCloudStack_1028f2c
> 2013-07-16 17:22:43,192 DEBUG [cloud.user.AccountManagerImpl] (Job-Executor-18:job-77 = [ 24362d6b-4eb7-48d0-893a-2ac61fa84d5e ]) Access to Tmpl[200-ISO-vmware-tools.iso granted to Acct[8-dc2user1] by DomainChecker_EnhancerByCloudStack_1028f2c
> 2013-07-16 17:22:43,194 DEBUG [cloud.user.AccountManagerImpl] (Job-Executor-18:job-77 = [ 24362d6b-4eb7-48d0-893a-2ac61fa84d5e ]) Access to VM[User|dc2user1i1] granted to Acct[8-dc2user1] by DomainChecker_EnhancerByCloudStack_1028f2c
> 2013-07-16 17:22:43,209 DEBUG [agent.transport.Request] (Job-Executor-18:job-77 = [ 24362d6b-4eb7-48d0-893a-2ac61fa84d5e ]) Seq 4-1669464340: Sending { Cmd , MgmtId: 187767034175903, via: 4, Ver: v1, Flags: 100011, [{"org.apache.cloudstack.storage.command.AttachCommand":{"disk":{"data":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"uuid":"e09209bc-4731-4aac-b65e-00aed3540993","id":200,"format":"ISO","accountId":1,"hvm":true,"displayText":"VMware Tools Installer ISO","name":"vmware-tools.iso"}},"type":"ISO"},"vmName":"i-8-13-VM","_storagePort":0,"_managed":false,"wait":0}}] }
> 2013-07-16 17:22:43,210 DEBUG [agent.transport.Request] (Job-Executor-18:job-77 = [ 24362d6b-4eb7-48d0-893a-2ac61fa84d5e ]) Seq 4-1669464340: Executing: { Cmd , MgmtId: 187767034175903, via: 4, Ver: v1, Flags: 100011, [{"org.apache.cloudstack.storage.command.AttachCommand":{"disk":{"data":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"uuid":"e09209bc-4731-4aac-b65e-00aed3540993","id":200,"format":"ISO","accountId":1,"hvm":true,"displayText":"VMware Tools Installer ISO","name":"vmware-tools.iso"}},"type":"ISO"},"vmName":"i-8-13-VM","_storagePort":0,"_managed":false,"wait":0}}] }
> 2013-07-16 17:22:43,211 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-191:null) Seq 4-1669464340: Executing request
> 2013-07-16 17:22:43,211 DEBUG [vmware.mo.HostMO] (DirectAgent-191:10.102.192.23) find VM i-8-13-VM on host
> 2013-07-16 17:22:43,211 DEBUG [vmware.mo.HostMO] (DirectAgent-191:10.102.192.23) load VM cache on host
> 2013-07-16 17:22:43,221 ERROR [storage.resource.VmwareStorageProcessor] (DirectAgent-191:10.102.192.23) AttachIsoCommand(attach) failed due to Exception: java.lang.NullPointerException
> Message: null
> java.lang.NullPointerException
> at com.cloud.storage.resource.VmwareStorageProcessor.attachIso(VmwareStorageProcessor.java:872)
> at com.cloud.storage.resource.VmwareStorageProcessor.attachIso(VmwareStorageProcessor.java:768)
> at com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.execute(StorageSubsystemCommandHandlerBase.java:125)
> at com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.handleStorageCommands(StorageSubsystemCommandHandlerBase.java:55)
> at com.cloud.hypervisor.vmware.resource.VmwareResource.executeRequest(VmwareResource.java:565)
> at com.cloud.agent.manager.DirectAgentAttache$Task.run(DirectAgentAttache.java:186)
> 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.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:165)
> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:266)
> 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-07-16 17:22:43,222 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-191:null) Seq 4-1669464340: Response Received:
> 2013-07-16 17:22:43,223 DEBUG [agent.transport.Request] (DirectAgent-191:null) Seq 4-1669464340: Processing: { Ans: , MgmtId: 187767034175903, via: 4, Ver: v1, Flags: 10, [{"org.apache.cloudstack.storage.command.AttachAnswer":{"result":false,"details":"AttachIsoCommand(attach) failed due to Exception: java.lang.NullPointerException\nMessage: null\n","wait":0}}] }
> 2013-07-16 17:22:43,223 DEBUG [agent.transport.Request] (Job-Executor-18:job-77 = [ 24362d6b-4eb7-48d0-893a-2ac61fa84d5e ]) Seq 4-1669464340: Received: { Ans: , MgmtId: 187767034175903, via: 4, Ver: v1, Flags: 10, { AttachAnswer } }
> 2013-07-16 17:22:43,223 DEBUG [agent.manager.AgentManagerImpl] (Job-Executor-18:job-77 = [ 24362d6b-4eb7-48d0-893a-2ac61fa84d5e ]) Details from executing class org.apache.cloudstack.storage.command.AttachCommand: AttachIsoCommand(attach) failed due to Exception: java.lang.NullPointerException
> Message: null
> 2013-07-16 17:22:43,232 ERROR [cloud.async.AsyncJobManagerImpl] (Job-Executor-18:job-77 = [ 24362d6b-4eb7-48d0-893a-2ac61fa84d5e ]) Unexpected exception while executing org.apache.cloudstack.api.command.user.iso.AttachIsoCmd
> com.cloud.utils.exception.CloudRuntimeException: Failed to attach iso
> at com.cloud.template.TemplateManagerImpl.attachIso(TemplateManagerImpl.java:969)
> at com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
> at org.apache.cloudstack.api.command.user.iso.AttachIsoCmd.execute(AttachIsoCmd.java:99)
> at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:158)
> at com.cloud.async.AsyncJobManagerImpl$1.run(AsyncJobManagerImpl.java:531)
> 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)
> 2013-07-16 17:22:43,236 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-18:job-77 = [ 24362d6b-4eb7-48d0-893a-2ac61fa84d5e ]) Complete async job-77 = [ 24362d6b-4eb7-48d0-893a-2ac61fa84d5e ], jobStatus: 2, resultCode: 530, result: Error Code: 530 Error text: Failed to attach iso
> 2013-07-16 17:22:43,935 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-187:null) Ping from 1
> 2013-07-16 17:22:46,225 DEBUG [cloud.api.ApiServlet] (catalina-exec-12:null) ===START=== 10.144.6.19 -- GET command=queryAsyncJobResult&jobId=24362d6b-4eb7-48d0-893a-2ac61fa84d5e&response=json&sessionkey=5vYbKOzqMAqkmN9vVQ%2F695HcVDs%3D&_=1373975776961
> 2013-07-16 17:22:46,238 DEBUG [cloud.async.AsyncJobManagerImpl] (catalina-exec-12:null) Async job-77 = [ 24362d6b-4eb7-48d0-893a-2ac61fa84d5e ] completed
> 2013-07-16 17:22:46,243 DEBUG [cloud.api.ApiServlet] (catalina-exec-12:null) ===END=== 10.144.6.19 -- GET command=queryAsyncJobResult&jobId=24362d6b-4eb7-48d0-893a-2ac61fa84d5e&response=json&sessionkey=5vYbKOzqMAqkmN9vVQ%2F695HcVDs%3D&_=1373975776961
> 2013-07-16 17:22:46,745 DEBUG [cloud.server.StatsCollector] (StatsCollector-1:null) StorageCollector is running...
--
This message is automatically generated by JIRA.
If you think it was sent incorrectly, please contact your JIRA administrators
For more information on JIRA, see: http://www.atlassian.com/software/jira