You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@cloudstack.apache.org by "Rayees Namathponnan (JIRA)" <ji...@apache.org> on 2013/12/29 17:30:51 UTC

[jira] [Closed] (CLOUDSTACK-5334) [Automation] Failed to create template from snapshot while executing copy command, observed NPE In SSVM log

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

Rayees Namathponnan closed CLOUDSTACK-5334.
-------------------------------------------


Verified with latest build

> [Automation] Failed to create template from snapshot while executing copy command, observed NPE In SSVM log
> -----------------------------------------------------------------------------------------------------------
>
>                 Key: CLOUDSTACK-5334
>                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-5334
>             Project: CloudStack
>          Issue Type: Bug
>      Security Level: Public(Anyone can view this level - this is the default.) 
>          Components: Template
>    Affects Versions: 4.3.0
>         Environment: KVM
> Branch 4.3
>            Reporter: Rayees Namathponnan
>            Assignee: edison su
>            Priority: Blocker
>             Fix For: 4.3.0
>
>         Attachments: CLOUDSTACK-5334.rar
>
>
> Steps to reproduce 
> Step 1 : snapshot root volume
> Step 2 : Create template from snapshot 
> Result 
> Failed to create template from snapshot, observed below "copy command failure and NPE" in MS log and SSVM log
> MS log
> 2013-12-02 08:28:49,406 DEBUG [o.a.c.s.m.AncientDataMotionStrategy] (Job-Executor-140:ctx-62f776d6 ctx-120aa5f1) copyAsync inspecting src type SNAPSHOT copy
> Async inspecting dest type TEMPLATE
> 2013-12-02 08:28:49,418 DEBUG [c.c.a.t.Request] (Job-Executor-140:ctx-62f776d6 ctx-120aa5f1) Seq 8-1124074796: Sending  { Cmd , MgmtId: 29066118877352, via:
>  8(s-5-VM), Ver: v1, Flags: 100011, [{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"pa
> th":"snapshots/282/589/d2b20627-b60e-489b-9eee-9f4705331a72","dataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.223.110.232:/export/home/rayees/S
> C_QA_AUTO4/secondary","_role":"Image"}},"name":"VM-f9e129c2-8d62-4b70-8105-abd304bf7605_ROOT-526_20131202080509","hypervisorType":"KVM","id":20,"quiescevm":
> false}},"destTO":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"template/tmpl/282/236","uuid":"1e48c6bf-388e-4184-93f5-28a21b12329c","id":236
> ,"format":"RAW","accountId":282,"hvm":true,"displayText":"raytemp","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.223.110.232:/export/ho
> me/rayees/SC_QA_AUTO4/secondary","_role":"Image"}},"name":"2c497573e-38cc-3f4d-a73a-49c7b63bbb6c","hypervisorType":"KVM"}},"executeInSequence":false,"wait":
> 10800}}] }
> 2013-12-02 08:28:49,655 DEBUG [c.c.a.t.Request] (AgentManager-Handler-14:null) Seq 8-1124074796: Processing:  { Ans: , MgmtId: 29066118877352, via: 8, Ver:
> v1, Flags: 10, [{"com.cloud.agent.api.Answer":{"result":false,"details":"java.lang.NullPointerException\n\tat org.apache.cloudstack.storage.resource.NfsSeco
> ndaryStorageResource.copySnapshotToTemplateFromNfsToNfs(NfsSecondaryStorageResource.java:449)\n\tat org.apache.cloudstack.storage.resource.NfsSecondaryStora
> geResource.createTemplateFromSnapshot(NfsSecondaryStorageResource.java:546)\n\tat org.apache.cloudstack.storage.resource.NfsSecondaryStorageResource.execute
> (NfsSecondaryStorageResource.java:625)\n\tat org.apache.cloudstack.storage.resource.NfsSecondaryStorageResource.executeRequest(NfsSecondaryStorageResource.j
> ava:236)\n\tat com.cloud.storage.resource.PremiumSecondaryStorageResource.defaultAction(PremiumSecondaryStorageResource.java:63)\n\tat com.cloud.storage.res
> ource.PremiumSecondaryStorageResource.executeRequest(PremiumSecondaryStorageResource.java:59)\n\tat com.cloud.agent.Agent.processRequest(Agent.java:498)\n\t
> at com.cloud.agent.Agent$AgentRequestHandler.doTask(Agent.java:806)\n\tat com.cloud.utils.nio.Task.run(Task.java:83)\n\tat java.util.concurrent.ThreadPoolEx
> ecutor.runWorker(ThreadPoolExecutor.java:1146)\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)\n\tat java.lang.Thread.
> run(Thread.java:679)\n","wait":0}}] }
> 2013-12-02 08:28:49,656 DEBUG [c.c.a.t.Request] (Job-Executor-140:ctx-62f776d6 ctx-120aa5f1) Seq 8-1124074796: Received:  { Ans: , MgmtId: 29066118877352, v
> ia: 8, Ver: v1, Flags: 10, { Answer } }
> 2013-12-02 08:28:49,663 DEBUG [c.c.t.TemplateManagerImpl] (Job-Executor-140:ctx-62f776d6 ctx-120aa5f1) Failed to create templatejava.lang.NullPointerExcepti
> on
>         at org.apache.cloudstack.storage.resource.NfsSecondaryStorageResource.copySnapshotToTemplateFromNfsToNfs(NfsSecondaryStorageResource.java:449)
>         at org.apache.cloudstack.storage.resource.NfsSecondaryStorageResource.createTemplateFromSnapshot(NfsSecondaryStorageResource.java:546)
>         at org.apache.cloudstack.storage.resource.NfsSecondaryStorageResource.execute(NfsSecondaryStorageResource.java:625)
>         at org.apache.cloudstack.storage.resource.NfsSecondaryStorageResource.executeRequest(NfsSecondaryStorageResource.java:236)
>         at com.cloud.storage.resource.PremiumSecondaryStorageResource.defaultAction(PremiumSecondaryStorageResource.java:63)
>         at com.cloud.storage.resource.PremiumSecondaryStorageResource.executeRequest(PremiumSecondaryStorageResource.java:59)
>         at com.cloud.agent.Agent.processRequest(Agent.java:498)
>         at com.cloud.agent.Agent$AgentRequestHandler.doTask(Agent.java:806)
>         at com.cloud.utils.nio.Task.run(Task.java:83)
>         at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146)
>         at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
>         at java.lang.Thread.run(Thread.java:679)
> SSVM log
> 2013-12-02 16:28:11,308 DEBUG [cloud.agent.Agent] (UgentTask-5:null) Sending ping: Seq 8-263:  { Cmd , MgmtId: -1, via: 8, Ver: v1, Flags: 11, [{"com.cloud.agen
> t.api.PingStorageCommand":{"changes":{},"hostType":"Storage","hostId":8,"wait":0}}] }
> 2013-12-02 16:28:11,350 DEBUG [cloud.agent.Agent] (Agent-Handler-3:null) Received response: Seq 8-263:  { Ans: , MgmtId: 29066118877352, via: 8, Ver: v1, Flags:
>  100010, [{"com.cloud.agent.api.PingAnswer":{"_command":{"hostType":"Storage","hostId":8,"wait":0},"result":true,"wait":0}}] }
> 2013-12-02 16:28:49,422 DEBUG [cloud.agent.Agent] (agentRequest-Handler-2:null) Request:Seq 8-1124074796:  { Cmd , MgmtId: 29066118877352, via: 8, Ver: v1, Flag
> s: 100011, [{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":"snapshots/282/589/d2b206
> 27-b60e-489b-9eee-9f4705331a72","dataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.223.110.232:/export/home/rayees/SC_QA_AUTO4/secondary","_role":"Im
> age"}},"name":"VM-f9e129c2-8d62-4b70-8105-abd304bf7605_ROOT-526_20131202080509","hypervisorType":"KVM","id":20,"quiescevm":false}},"destTO":{"org.apache.cloudst
> ack.storage.to.TemplateObjectTO":{"path":"template/tmpl/282/236","uuid":"1e48c6bf-388e-4184-93f5-28a21b12329c","id":236,"format":"RAW","accountId":282,"hvm":tru
> e,"displayText":"raytemp","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url"
> :"nfs://10.223.110.232:/export/home/rayees/SC_QA_AUTO4/secondary","_role":"Image"}},"name":"2c497573e-38cc-3f4d-a73a-49c7b63bbb6c","hypervisorType":"KVM"}},"executeInSequence":false,"wait":10800}}] }
> 2013-12-02 16:28:49,422 DEBUG [cloud.agent.Agent] (agentRequest-Handler-2:null) Processing command: org.apache.cloudstack.storage.command.CopyCommand
> 2013-12-02 16:28:49,423 INFO  [storage.resource.NfsSecondaryStorageResource] (agentRequest-Handler-2:null) Determined host 10.223.110.232 corresponds to IP 10.223.110.232
> 2013-12-02 16:28:49,509 INFO  [storage.resource.NfsSecondaryStorageResource] (agentRequest-Handler-2:null) Determined host 10.223.110.232 corresponds to IP 10.223.110.232
> 2013-12-02 16:28:49,581 WARN  [cloud.agent.Agent] (agentRequest-Handler-2:null) Caught:
> java.lang.NullPointerException
>         at org.apache.cloudstack.storage.resource.NfsSecondaryStorageResource.copySnapshotToTemplateFromNfsToNfs(NfsSecondaryStorageResource.java:449)
>         at org.apache.cloudstack.storage.resource.NfsSecondaryStorageResource.createTemplateFromSnapshot(NfsSecondaryStorageResource.java:546)
>         at org.apache.cloudstack.storage.resource.NfsSecondaryStorageResource.execute(NfsSecondaryStorageResource.java:625)
>         at org.apache.cloudstack.storage.resource.NfsSecondaryStorageResource.executeRequest(NfsSecondaryStorageResource.java:236)
>         at com.cloud.storage.resource.PremiumSecondaryStorageResource.defaultAction(PremiumSecondaryStorageResource.java:63)
>         at com.cloud.storage.resource.PremiumSecondaryStorageResource.executeRequest(PremiumSecondaryStorageResource.java:59)
>         at com.cloud.agent.Agent.processRequest(Agent.java:498)
>         at com.cloud.agent.Agent$AgentRequestHandler.doTask(Agent.java:806)
>         at com.cloud.utils.nio.Task.run(Task.java:83)
>         at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146)
>         at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
>         at java.lang.Thread.run(Thread.java:679)
> 2013-12-02 16:28:49,615 DEBUG [cloud.agent.Agent] (agentRequest-Handler-2:null) Seq 8-1124074796:  { Ans: , MgmtId: 29066118877352, via: 8, Ver: v1, Flags: 10, [{"com.cloud.agent.api.Answer":{"result":false,"details":"java.lang.NullPointerException\n\tat org.apache.cloudstack.storage.resource.NfsSecondaryStorageResource.copySnapshotToTemplateFromNfsToNfs(NfsSecondaryStorageResource.java:449)\n\tat org.apache.cloudstack.storage.resource.NfsSecondaryStorageResource.createTemplateFromSnapshot(NfsSecondaryStorageResource.java:546)\n\tat org.apache.cloudstack.storage.resource.NfsSecondaryStorageResource.execute(NfsSecondaryStorageResource.java:625)\n\tat org.apache.cloudstack.storage.resource.NfsSecondaryStorageResource.executeRequest(NfsSecondaryStorageResource.java:236)\n\tat com.cloud.storage.resource.PremiumSecondaryStorageResource.defaultAction(PremiumSecondaryStorageResource.java:63)\n\tat com.cloud.storage.resource.PremiumSecondaryStorageResource.executeRequest(PremiumSecondaryStorageResource.java:59)\n\tat com.cloud.agent.Agent.processRequest(Agent.java:498)\n\tat com.cloud.agent.Agent$AgentRequestHa:



--
This message was sent by Atlassian JIRA
(v6.1.5#6160)