[ 
https://issues.apache.org/jira/browse/CLOUDSTACK-4129?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
 ]

edison su reassigned CLOUDSTACK-4129:
-------------------------------------

    Assignee: edison su
    
> [Object_store_refactor] Template creation from the stopped vm's Root disk 
> failed with NPE
> -----------------------------------------------------------------------------------------
>
>                 Key: CLOUDSTACK-4129
>                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-4129
>             Project: CloudStack
>          Issue Type: Bug
>      Security Level: Public(Anyone can view this level - this is the 
> default.) 
>          Components: Storage Controller, Template, VMware
>    Affects Versions: 4.2.0
>         Environment: Latest build from ACS 4.2 branch
> Storage: S3 for secondary, NFS for staging storage and ISCSI for Primary 
> storage
> Cluster : VMWare
>            Reporter: Sanjeev N
>            Assignee: edison su
>            Priority: Critical
>             Fix For: 4.2.0
>
>         Attachments: cloud.dmp, management-server.rar
>
>
> Failed to create template from the stopped vm's Root disk
> Steps to Reproduce:
> ================
> 1.Bringup CS in with VMWare cluster using S3 for secondary, NFS for staging 
> secondary and ISCSI for primary storage
> 2.Deploy guest vm using the default CentOS template
> 3.Stop the vm
> 4.Try to create template from the root disk of the vm
> Result:
> ======
> Template creation failed with NPE
> Observations:
> ===========
> When createTemplate command executed, copyCommand was executed as part of the 
> process and destination path was mentioned as "volumes/2/15" on staging 
> storage. Looks like wrong path was sent to copyCommand to copy template from 
> primary to staging secondary storage.
> I could see template got copied to volumes directory 2/15 on NFS storage. 
> Also there was an entry made in volume_store_ref table with state as 
> "Creating" and install_path as "volumes/2/15".
>  
> Following is the log snippet:
> 2013-08-07 02:42:40,780 DEBUG [cloud.async.AsyncJobManagerImpl] 
> (catalina-exec-21:null) submit async job-40 = [ 
> 787ffcfe-342c-4948-871b-7e81699868ce ], details: AsyncJobVO {id:40, userId: 
> 2, accountId: 2, sessionKey: null, instanceType: Template, instanceId: 209, 
> cmd: org.apache.cloudstack.api.command.user.template.CreateTemplateCmd, 
> cmdOriginator: null, cmdInfo: 
> {"sessionkey":"cmlJrR7zOuQRRz2h2n5pjU7LMag\u003d","cmdEventType":"TEMPLATE.CREATE","ctxUserId":"2","volumeId":"64cf3aff-3e33-465a-bc71-2d30acab3595","httpmethod":"GET","isPublic":"true","osTypeId":"257e87ce-fe5f-11e2-a4b5-06045a000066","isfeatured":"true","response":"json","isdynamicallyscalable":"false","id":"209","displayText":"fromVM","passwordEnabled":"true","name":"fromVM","_":"1375857746711","ctxAccountId":"2","ctxStartEventId":"161"},
>  cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0, 
> processStatus: 0, resultCode: 0, result: null, initMsid: 6615759585382, 
> completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
> 2013-08-07 02:42:40,783 DEBUG [cloud.api.ApiServlet] (catalina-exec-21:null) 
> ===END===  10.146.0.20 -- GET  
> command=createTemplate&response=json&sessionkey=cmlJrR7zOuQRRz2h2n5pjU7LMag%3D&volumeId=64cf3aff-3e33-465a-bc71-2d30acab3595&name=fromVM&displayText=fromVM&osTypeId=257e87ce-fe5f-11e2-a4b5-06045a000066&isPublic=true&passwordEnabled=true&isdynamicallyscalable=false&isfeatured=true&_=1375857746711
> 2013-08-07 02:42:40,786 DEBUG [cloud.async.AsyncJobManagerImpl] 
> (Job-Executor-41:job-40 = [ 787ffcfe-342c-4948-871b-7e81699868ce ]) Executing 
> org.apache.cloudstack.api.command.user.template.CreateTemplateCmd for job-40 
> = [ 787ffcfe-342c-4948-871b-7e81699868ce ]
> 2013-08-07 02:42:40,833 DEBUG [storage.image.TemplateDataFactoryImpl] 
> (Job-Executor-41:job-40 = [ 787ffcfe-342c-4948-871b-7e81699868ce ]) template 
> 209 is already in store:10, type:Image
> 2013-08-07 02:42:40,847 DEBUG [storage.motion.AncientDataMotionStrategy] 
> (Job-Executor-41:job-40 = [ 787ffcfe-342c-4948-871b-7e81699868ce ]) copyAsync 
> inspecting src type VOLUME copyAsync inspecting dest type TEMPLATE
> 2013-08-07 02:42:40,862 DEBUG [storage.motion.AncientDataMotionStrategy] 
> (Job-Executor-41:job-40 = [ 787ffcfe-342c-4948-871b-7e81699868ce ]) 
> needCacheStorage true, dest at 
> template/tmpl/2/209/23110cadf-74ea-327d-862d-8d49cd55e7c6 dest role 
> ImageROOT-11 src role Primary
> 2013-08-07 02:42:40,894 DEBUG [storage.motion.AncientDataMotionStrategy] 
> (Job-Executor-41:job-40 = [ 787ffcfe-342c-4948-871b-7e81699868ce ]) copyAsync 
> inspecting src type VOLUME copyAsync inspecting dest type VOLUME
> 2013-08-07 02:42:40,935 DEBUG [agent.transport.Request] 
> (Job-Executor-41:job-40 = [ 787ffcfe-342c-4948-871b-7e81699868ce ]) Seq 
> 3-1317535872: Sending  { Cmd , MgmtId: 6615759585382, via: 3, Ver: v1, Flags: 
> 100011, 
> [{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"64cf3aff-3e33-465a-bc71-2d30acab3595","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"b845e7d4-562a-3b2d-8e59-b1df565f99e5","id":1,"poolType":"VMFS","host":"VMFS
>  datastore: 
> /sanjeev/openFiler","path":"/sanjeev/openFiler","port":0}},"name":"ROOT-11","size":459110400,"path":"ROOT-11","volumeId":15,"vmName":"i-2-11-VM","accountId":2,"format":"OVA","id":15,"hypervisorType":"VMware"}},"destTO":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"64cf3aff-3e33-465a-bc71-2d30acab3595","volumeType":"ROOT","dataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.147.28.7/export/home/sanjeev/sec_esx_os","_role":"ImageCache"}},"name":"ROOT-11","size":459110400,"path":"volumes/2/15","volumeId":15,"vmName":"i-2-11-VM","accountId":2,"format":"OVA","id":15,"hypervisorType":"VMware"}},"executeInSequence":false,"wait":10800}}]
>  }
> 2013-08-07 02:44:55,547 DEBUG [agent.transport.Request] 
> (AgentManager-Handler-13:null) Seq 3-1317535872: Processing:  { Ans: , 
> MgmtId: 6615759585382, via: 3, Ver: v1, Flags: 10, 
> [{"org.apache.cloudstack.storage.command.CopyCmdAnswer":{"newData":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"path":"volumes/2/15/8f8453c285cd43918bcde7472bde0889","accountId":0,"id":0}},"result":true,"wait":0}}]
>  }
> 2013-08-07 02:44:55,547 DEBUG [agent.transport.Request] 
> (Job-Executor-41:job-40 = [ 787ffcfe-342c-4948-871b-7e81699868ce ]) Seq 
> 3-1317535872: Received:  { Ans: , MgmtId: 6615759585382, via: 3, Ver: v1, 
> Flags: 10, { CopyCmdAnswer } }
> 2013-08-07 02:44:55,555 DEBUG [storage.motion.AncientDataMotionStrategy] 
> (Job-Executor-41:job-40 = [ 787ffcfe-342c-4948-871b-7e81699868ce ]) copy 
> object failed: java.lang.NullPointerException
> 2013-08-07 02:44:55,556 DEBUG [storage.motion.AncientDataMotionStrategy] 
> (Job-Executor-41:job-40 = [ 787ffcfe-342c-4948-871b-7e81699868ce ]) copy 
> failed
> com.cloud.utils.exception.CloudRuntimeException: 
> java.lang.NullPointerException
>         at 
> org.apache.cloudstack.storage.motion.AncientDataMotionStrategy.copyObject(AncientDataMotionStrategy.java:210)
>         at 
> org.apache.cloudstack.storage.motion.AncientDataMotionStrategy.copyAsync(AncientDataMotionStrategy.java:386)
>         at 
> org.apache.cloudstack.storage.motion.DataMotionServiceImpl.copyAsync(DataMotionServiceImpl.java:55)
>         at 
> org.apache.cloudstack.storage.image.TemplateServiceImpl.copyAsync(TemplateServiceImpl.java:549)
>         at 
> org.apache.cloudstack.storage.image.TemplateServiceImpl.createTemplateFromVolumeAsync(TemplateServiceImpl.java:562)
>         at 
> com.cloud.template.TemplateManagerImpl.createPrivateTemplate(TemplateManagerImpl.java:1367)
>         at 
> com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
>         at 
> org.apache.cloudstack.api.command.user.template.CreateTemplateCmd.execute(CreateTemplateCmd.java:263)
>         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-08-07 02:44:55,569 DEBUG [cloud.template.TemplateManagerImpl] 
> (Job-Executor-41:job-40 = [ 787ffcfe-342c-4948-871b-7e81699868ce ]) Failed to 
> create templatecom.cloud.utils.exception.CloudRuntimeException: 
> java.lang.NullPointerException
> 2013-08-07 02:44:55,583 ERROR [cloud.async.AsyncJobManagerImpl] 
> (Job-Executor-41:job-40 = [ 787ffcfe-342c-4948-871b-7e81699868ce ]) 
> Unexpected exception while executing 
> org.apache.cloudstack.api.command.user.template.CreateTemplateCmd
> com.cloud.utils.exception.CloudRuntimeException: Failed to create 
> templatecom.cloud.utils.exception.CloudRuntimeException: 
> java.lang.NullPointerException
>         at 
> com.cloud.template.TemplateManagerImpl.createPrivateTemplate(TemplateManagerImpl.java:1378)
>         at 
> com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
>         at 
> org.apache.cloudstack.api.command.user.template.CreateTemplateCmd.execute(CreateTemplateCmd.java:263)
>         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-08-07 02:44:55,586 DEBUG [cloud.async.AsyncJobManagerImpl] 
> (Job-Executor-41:job-40 = [ 787ffcfe-342c-4948-871b-7e81699868ce ]) Complete 
> async job-40 = [ 787ffcfe-342c-4948-871b-7e81699868ce ], jobStatus: 2, 
> resultCode: 530, result: Error Code: 530 Error text: Failed to create 
> templatecom.cloud.utils.exception.CloudRuntimeException: 
> java.lang.NullPointerException
> Attaching management server log file and cloud DB.

--
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

Reply via email to