cloudstack-issues mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "Kishan Kavala (JIRA)" <j...@apache.org>
Subject [jira] [Updated] (CLOUDSTACK-7403) [LXC] download root volume for stopped VM is failing
Date Mon, 01 Sep 2014 10:44:20 GMT

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

Kishan Kavala updated CLOUDSTACK-7403:
--------------------------------------
    Priority: Major  (was: Critical)

> [LXC] download root volume for stopped VM is failing 
> -----------------------------------------------------
>
>                 Key: CLOUDSTACK-7403
>                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-7403
>             Project: CloudStack
>          Issue Type: Bug
>      Security Level: Public(Anyone can view this level - this is the default.) 
>          Components: KVM, Storage Controller
>    Affects Versions: 4.5.0
>            Reporter: shweta agarwal
>            Assignee: Kishan Kavala
>             Fix For: 4.5.0
>
>
> Repro steps:
> Create a LXC VM
> Stop the VM
> Download root volume of the VM
> Bug:
> it fails with error message Failed to copy the volume from the source primary storage
pool to secondary storage.
> Ms log shows :
> 014-08-22 17:38:22,219 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (catalina-exec-5:ctx-dadec6c2
ctx-4f82d146) submit async job-648, details: AsyncJobVO {id:648, userId: 2, accountId: 2,
instanceType: Volume, instanceId: 80, cmd: org.apache.cloudstack.api.command.user.volume.ExtractVolumeCmd,
cmdInfo: {"id":"1317fed3-0666-45b4-8849-0316206c58e7","response":"json","sessionkey":"BC5+3ivJ/aXytluoUicBfBzviOQ\u003d","ctxDetails":"{\"com.cloud.storage.Volume\":\"1317fed3-0666-45b4-8849-0316206c58e7\",\"com.cloud.dc.DataCenter\":\"b2be995b-c505-4d3c-a1bb-e8b019d5611c\"}","cmdEventType":"VOLUME.EXTRACT","ctxUserId":"2","zoneid":"b2be995b-c505-4d3c-a1bb-e8b019d5611c","httpmethod":"GET","_":"1408709304879","uuid":"1317fed3-0666-45b4-8849-0316206c58e7","ctxAccountId":"2","ctxStartEventId":"1036","mode":"HTTP_DOWNLOAD"},
cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid:
233845178472597, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
> 2014-08-22 17:38:22,219 INFO  [o.a.c.f.j.i.AsyncJobMonitor] (API-Job-Executor-8:ctx-4c88ae36
job-648) Add job-648 into job monitoring
> 2014-08-22 17:38:22,219 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-8:ctx-4c88ae36
job-648) Executing AsyncJobVO {id:648, userId: 2, accountId: 2, instanceType: Volume, instanceId:
80, cmd: org.apache.cloudstack.api.command.user.volume.ExtractVolumeCmd, cmdInfo: {"id":"1317fed3-0666-45b4-8849-0316206c58e7","response":"json","sessionkey":"BC5+3ivJ/aXytluoUicBfBzviOQ\u003d","ctxDetails":"{\"com.cloud.storage.Volume\":\"1317fed3-0666-45b4-8849-0316206c58e7\",\"com.cloud.dc.DataCenter\":\"b2be995b-c505-4d3c-a1bb-e8b019d5611c\"}","cmdEventType":"VOLUME.EXTRACT","ctxUserId":"2","zoneid":"b2be995b-c505-4d3c-a1bb-e8b019d5611c","httpmethod":"GET","_":"1408709304879","uuid":"1317fed3-0666-45b4-8849-0316206c58e7","ctxAccountId":"2","ctxStartEventId":"1036","mode":"HTTP_DOWNLOAD"},
cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid:
233845178472597, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
> 2014-08-22 17:38:22,219 DEBUG [c.c.a.ApiServlet] (catalina-exec-5:ctx-dadec6c2 ctx-4f82d146)
===END===  10.146.0.131 -- GET  command=extractVolume&id=1317fed3-0666-45b4-8849-0316206c58e7&zoneid=b2be995b-c505-4d3c-a1bb-e8b019d5611c&mode=HTTP_DOWNLOAD&response=json&sessionkey=BC5%2B3ivJ%2FaXytluoUicBfBzviOQ%3D&_=1408709304879
> 2014-08-22 17:38:22,318 DEBUG [o.a.c.s.m.AncientDataMotionStrategy] (API-Job-Executor-8:ctx-4c88ae36
job-648 ctx-2287787f) copyAsync inspecting src type VOLUME copyAsync inspecting dest type
VOLUME
> 2014-08-22 17:38:22,327 DEBUG [c.c.a.t.Request] (API-Job-Executor-8:ctx-4c88ae36 job-648
ctx-2287787f) Seq 9-7487234380503450103: Sending  { Cmd , MgmtId: 233845178472597, via: 9(Rack3Pod1Host52),
Ver: v1, Flags: 100011, [{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"1317fed3-0666-45b4-8849-0316206c58e7","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"2a4208e2-8f5e-3b6a-bede-315c90250d0a","id":6,"poolType":"NetworkFilesystem","host":"10.147.28.7","path":"/export/home/shweta/goleta.lxc.primary1","port":2049,"url":"NetworkFilesystem://10.147.28.7/export/home/shweta/goleta.lxc.primary1/?ROLE=Primary&STOREUUID=2a4208e2-8f5e-3b6a-bede-315c90250d0a"}},"name":"ROOT-76","size":550604800,"path":"1317fed3-0666-45b4-8849-0316206c58e7","volumeId":80,"vmName":"i-2-76-VM","accountId":2,"provisioningType":"THIN","id":80,"deviceId":0,"hypervisorType":"LXC"}},"destTO":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"1317fed3-0666-45b4-8849-0316206c58e7","volumeType":"ROOT","dataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.147.28.7/export/home/shweta/goleta.lxc.secondary","_role":"Image"}},"name":"ROOT-76","size":550604800,"path":"volumes/2/80","volumeId":80,"vmName":"i-2-76-VM","accountId":2,"provisioningType":"THIN","id":80,"deviceId":0,"hypervisorType":"LXC"}},"executeInSequence":false,"options":{},"wait":10800}}]
}
> 2014-08-22 17:38:22,370 DEBUG [c.c.a.t.Request] (AgentManager-Handler-8:null) Seq 9-7487234380503450103:
Processing:  { Ans: , MgmtId: 233845178472597, via: 9, Ver: v1, Flags: 10, [{"com.cloud.agent.api.Answer":{"result":false,"details":"java.lang.NullPointerException\n\tat
com.cloud.hypervisor.kvm.storage.KVMStorageProcessor.copyVolumeFromPrimaryToSecondary(KVMStorageProcessor.java:438)\n\tat
com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.execute(StorageSubsystemCommandHandlerBase.java:89)\n\tat
com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.handleStorageCommands(StorageSubsystemCommandHandlerBase.java:53)\n\tat
com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.executeRequest(LibvirtComputingResource.java:1356)\n\tat
com.cloud.agent.Agent.processRequest(Agent.java:503)\n\tat com.cloud.agent.Agent$AgentRequestHandler.doTask(Agent.java:810)\n\tat
com.cloud.utils.nio.Task.run(Task.java:84)\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)\n\tat
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)\n\tat java.lang.Thread.run(Thread.java:745)\n","wait":0}}]
}
> 2014-08-22 17:38:22,370 DEBUG [c.c.a.t.Request] (API-Job-Executor-8:ctx-4c88ae36 job-648
ctx-2287787f) Seq 9-7487234380503450103: Received:  { Ans: , MgmtId: 233845178472597, via:
9, Ver: v1, Flags: 10, { Answer } }
> 2014-08-22 17:38:22,394 WARN  [o.a.c.s.d.ObjectInDataStoreManagerImpl] (API-Job-Executor-8:ctx-4c88ae36
job-648 ctx-2287787f) Unsupported data object (VOLUME, org.apache.cloudstack.storage.datastore.PrimaryDataStoreImpl@600c0823),
no need to delete from object in store ref table
> 2014-08-22 17:38:22,442 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-10:null)
SeqA 3-21864: Processing Seq 3-21864:  { Cmd , MgmtId: -1, via: 3, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":25,"_loadInfo":"{\n
 \"connections\": []\n}","wait":0}}] }
> 2014-08-22 17:38:22,477 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-10:null)
SeqA 3-21864: Sending Seq 3-21864:  { Ans: , MgmtId: 233845178472597, via: 3, Ver: v1, Flags:
100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
> 2014-08-22 17:38:22,477 ERROR [c.c.a.ApiAsyncJobDispatcher] (API-Job-Executor-8:ctx-4c88ae36
job-648) Unexpected exception while executing org.apache.cloudstack.api.command.user.volume.ExtractVolumeCmd
> com.cloud.utils.exception.CloudRuntimeException: Failed to copy the volume from the source
primary storage pool to secondary storage.
>         at com.cloud.storage.VolumeApiServiceImpl.extractVolume(VolumeApiServiceImpl.java:2006)
>         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:606)
>         at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317)
>         at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183)
>         at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150)
>         at org.apache.cloudstack.network.contrail.management.EventUtils$EventInterceptor.invoke(EventUtils.java:106)
>         at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:161)
>         at com.cloud.event.ActionEventInterceptor.invoke(ActionEventInterceptor.java:51)
>         at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:161)
>         at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:91)
>         at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
>         at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204)
>         at com.sun.proxy.$Proxy185.extractVolume(Unknown Source)
>         at org.apache.cloudstack.api.command.user.volume.ExtractVolumeCmd.execute(ExtractVolumeCmd.java:137)
>         at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:141)
> at com.cloud.api.ApiAsyncJobDispatcher.runJob(ApiAsyncJobDispatcher.java:108)
>         at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:503)
>         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 org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.run(AsyncJobManagerImpl.java:460)
>         at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
>         at java.util.concurrent.FutureTask.run(FutureTask.java:262)
>         at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
>         at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
>         at java.lang.Thread.run(Thread.java:745)
> 2014-08-22 17:38:22,478 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-8:ctx-4c88ae36
job-648) Complete async job-648, jobStatus: FAILED, resultCode: 530, result: org.apache.cloudstack.api.response.ExceptionResponse/null/{"uuidList":[],"errorcode":530,"errortext":"Failed
to copy the volume from the source primary storage pool to secondary storage."}
> 2014-08-22 17:38:22,510 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-8:ctx-4c88ae36
job-648) Done executing org.apache.cloudstack.api.command.user.volume.ExtractVolumeCmd for
job-648
> 2014-08-22 17:38:22,511 INFO  [o.a.c.f.j.i.AsyncJobMonitor] (API-Job-Executor-8:ctx-4c88ae36
job-648) Remove job-648 from job monitoring
> 2014-08-22 17:38:22,660 DEBUG [c.c.a.ApiServlet] (catalina-exec-12:ctx-0057a517) ===START===
 10.146.0.131 -- GET  command=queryAsyncJobResult&jobId=5d8be7da-21c5-40a0-90c2-d602df8b0f3e&response=json&sessionkey=BC5%2B3ivJ%2FaXytluoUicBfBzviOQ%3D&_=1408709305509
> 2014-08-22 17:38:22,687 DEBUG [c.c.a.ApiServlet] (catalina-exec-12:ctx-0057a517 ctx-99586e6f)
===END===  10.146.0.131 -- GET  command=queryAsyncJobResult&jobId=5d8be7da-21c5-40a0-90c2-d602df8b0f3e&response=json&sessionkey=BC5%2B3ivJ%2FaXytluoUicBfBzviOQ%3D&_=1408709305509



--
This message was sent by Atlassian JIRA
(v6.3.4#6332)

Mime
View raw message