You are viewing a plain text version of this content. The canonical link for it is here.
Posted to users-cn@cloudstack.apache.org by "zb1019095894@163.com" <zb...@163.com> on 2015/04/10 10:08:31 UTC
无法创建存储卷快照
虚拟机关机后在虚拟机的磁盘卷上点击创建快照，然后在web端的快照里看状态是ERROR
2015-04-10 15:58:25,717 DEBUG [c.c.a.ApiServlet] (catalina-exec-8:ctx-fc4949c8) ===START=== 10.0.0.1 -- GET command=listVolumes&response=json&sessionkey=WqleoX9aCHGVUOq3u1DCcYyN7iw%3D&listAll=true&page=1&pagesize=20&virtualMachineId=2f92babd-0b49-4b62-8a0f-77250e4be841&_=1428652698755
2015-04-10 15:58:25,737 DEBUG [c.c.a.ApiServlet] (catalina-exec-8:ctx-fc4949c8 ctx-f5d73711) ===END=== 10.0.0.1 -- GET command=listVolumes&response=json&sessionkey=WqleoX9aCHGVUOq3u1DCcYyN7iw%3D&listAll=true&page=1&pagesize=20&virtualMachineId=2f92babd-0b49-4b62-8a0f-77250e4be841&_=1428652698755
2015-04-10 15:58:26,823 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-5:null) SeqA 4-10743: Processing Seq 4-10743: { Cmd , MgmtId: -1, via: 4, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":1,"_loadInfo":"{\n \"connections\": []\n}","wait":0}}] }
2015-04-10 15:58:26,944 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-5:null) SeqA 4-10743: Sending Seq 4-10743: { Ans: , MgmtId: 161336282284, via: 4, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
2015-04-10 15:58:27,213 DEBUG [c.c.a.ApiServlet] (catalina-exec-12:ctx-d03855e5) ===START=== 10.0.0.1 -- GET command=listVolumes&id=af34691b-fff7-4186-afcf-c021d6d0f4a0&response=json&sessionkey=WqleoX9aCHGVUOq3u1DCcYyN7iw%3D&_=1428652700251
2015-04-10 15:58:27,225 DEBUG [c.c.a.ApiServlet] (catalina-exec-12:ctx-d03855e5 ctx-6e9a5108) ===END=== 10.0.0.1 -- GET command=listVolumes&id=af34691b-fff7-4186-afcf-c021d6d0f4a0&response=json&sessionkey=WqleoX9aCHGVUOq3u1DCcYyN7iw%3D&_=1428652700251
2015-04-10 15:58:29,442 DEBUG [c.c.s.StatsCollector] (StatsCollector-4:ctx-d0f8cb43) AutoScaling Monitor is running...
2015-04-10 15:58:29,887 DEBUG [o.a.c.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-cfc37c76) Zone 1 is ready to launch secondary storage VM
2015-04-10 15:58:30,022 DEBUG [c.c.c.ConsoleProxyManagerImpl] (consoleproxy-1:ctx-b25c8076) Zone 1 is ready to launch console proxy
2015-04-10 15:58:31,785 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-12:null) SeqA 4-10744: Processing Seq 4-10744: { Cmd , MgmtId: -1, via: 4, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":1,"_loadInfo":"{\n \"connections\": []\n}","wait":0}}] }
2015-04-10 15:58:31,935 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-12:null) SeqA 4-10744: Sending Seq 4-10744: { Ans: , MgmtId: 161336282284, via: 4, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
2015-04-10 15:58:34,638 DEBUG [c.c.a.ApiServlet] (catalina-exec-22:ctx-3b75875f) ===START=== 10.0.0.1 -- GET command=createSnapshot&volumeid=af34691b-fff7-4186-afcf-c021d6d0f4a0&quiescevm=false&response=json&sessionkey=WqleoX9aCHGVUOq3u1DCcYyN7iw%3D&_=1428652707676
2015-04-10 15:58:35,004 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (catalina-exec-22:ctx-3b75875f ctx-d513d5a3) submit async job-97, details: AsyncJobVO {id:97, userId: 2, accountId: 2, instanceType: Snapshot, instanceId: 2, cmd: org.apache.cloudstack.api.command.user.snapshot.CreateSnapshotCmd, cmdInfo: {"id":"2","response":"json","sessionkey":"WqleoX9aCHGVUOq3u1DCcYyN7iw\u003d","ctxDetails":"{\"com.cloud.storage.Snapshot\":\"cbef75bf-3838-4b4a-813a-a7707303fe62\",\"com.cloud.storage.Volume\":\"af34691b-fff7-4186-afcf-c021d6d0f4a0\"}","cmdEventType":"SNAPSHOT.CREATE","ctxUserId":"2","httpmethod":"GET","_":"1428652707676","volumeid":"af34691b-fff7-4186-afcf-c021d6d0f4a0","quiescevm":"false","uuid":"cbef75bf-3838-4b4a-813a-a7707303fe62","ctxAccountId":"2","ctxStartEventId":"201"}, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 161336282284, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
2015-04-10 15:58:35,005 DEBUG [c.c.a.ApiServlet] (catalina-exec-22:ctx-3b75875f ctx-d513d5a3) ===END=== 10.0.0.1 -- GET command=createSnapshot&volumeid=af34691b-fff7-4186-afcf-c021d6d0f4a0&quiescevm=false&response=json&sessionkey=WqleoX9aCHGVUOq3u1DCcYyN7iw%3D&_=1428652707676
2015-04-10 15:58:35,005 INFO [o.a.c.f.j.i.AsyncJobMonitor] (API-Job-Executor-32:ctx-997b0944 job-97) Add job-97 into job monitoring
2015-04-10 15:58:35,005 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-32:ctx-997b0944 job-97) Executing AsyncJobVO {id:97, userId: 2, accountId: 2, instanceType: Snapshot, instanceId: 2, cmd: org.apache.cloudstack.api.command.user.snapshot.CreateSnapshotCmd, cmdInfo: {"id":"2","response":"json","sessionkey":"WqleoX9aCHGVUOq3u1DCcYyN7iw\u003d","ctxDetails":"{\"com.cloud.storage.Snapshot\":\"cbef75bf-3838-4b4a-813a-a7707303fe62\",\"com.cloud.storage.Volume\":\"af34691b-fff7-4186-afcf-c021d6d0f4a0\"}","cmdEventType":"SNAPSHOT.CREATE","ctxUserId":"2","httpmethod":"GET","_":"1428652707676","volumeid":"af34691b-fff7-4186-afcf-c021d6d0f4a0","quiescevm":"false","uuid":"cbef75bf-3838-4b4a-813a-a7707303fe62","ctxAccountId":"2","ctxStartEventId":"201"}, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 161336282284, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
2015-04-10 15:58:35,033 INFO [o.a.c.a.c.u.s.CreateSnapshotCmd] (API-Job-Executor-32:ctx-997b0944 job-97 ctx-ccb2c7ea) VOLSS: createSnapshotCmd starts:1428652715033
2015-04-10 15:58:35,045 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-32:ctx-997b0944 job-97 ctx-ccb2c7ea) Sync job-98 execution on object VmWorkJobQueue.9
2015-04-10 15:58:35,047 WARN [c.c.u.d.Merovingian2] (API-Job-Executor-32:ctx-997b0944 job-97 ctx-ccb2c7ea) Was unable to find lock for the key vm_instance9 and thread id 677115361
2015-04-10 15:58:36,457 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (AsyncJobMgr-Heartbeat-1:ctx-2c7a822d) Execute sync-queue item: SyncQueueItemVO {id:35, queueId: 27, contentType: AsyncJob, contentId: 98, lastProcessMsid: null, lastprocessNumber: null, lastProcessTime: null, created: Fri Apr 10 15:58:35 CST 2015}
2015-04-10 15:58:36,458 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (AsyncJobMgr-Heartbeat-1:ctx-2c7a822d) Schedule queued job-98
2015-04-10 15:58:36,596 INFO [o.a.c.f.j.i.AsyncJobMonitor] (Work-Job-Executor-23:ctx-0c35b52c job-97/job-98) Add job-98 into job monitoring
2015-04-10 15:58:36,596 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-23:ctx-0c35b52c job-97/job-98) Executing AsyncJobVO {id:98, userId: 2, accountId: 2, instanceType: null, instanceId: null, cmd: com.cloud.storage.VmWorkTakeVolumeSnapshot, cmdInfo: rO0ABXNyACpjb20uY2xvdWQuc3RvcmFnZS5WbVdvcmtUYWtlVm9sdW1lU25hcHNob3QEvmAbguLVzwIABFoACXF1aWVzY2VWbUwACHBvbGljeUlkdAAQTGphdmEvbGFuZy9Mb25nO0wACnNuYXBzaG90SWRxAH4AAUwACHZvbHVtZUlkcQB-AAF4cgATY29tLmNsb3VkLnZtLlZtV29ya5-ZtlbwJWdrAgAESgAJYWNjb3VudElkSgAGdXNlcklkSgAEdm1JZEwAC2hhbmRsZXJOYW1ldAASTGphdmEvbGFuZy9TdHJpbmc7eHAAAAAAAAAAAgAAAAAAAAACAAAAAAAAAAl0ABRWb2x1bWVBcGlTZXJ2aWNlSW1wbABzcgAOamF2YS5sYW5nLkxvbmc7i-SQzI8j3wIAAUoABXZhbHVleHIAEGphdmEubGFuZy5OdW1iZXKGrJUdC5TgiwIAAHhwAAAAAAAAAABzcQB-AAYAAAAAAAAAAnNxAH4ABgAAAAAAAAAK, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 161336282284, completeMsid: null, lastUpdated: null, lastPolled: null, created: Fri Apr 10 15:58:35 CST 2015}
2015-04-10 15:58:36,597 DEBUG [c.c.v.VmWorkJobDispatcher] (Work-Job-Executor-23:ctx-0c35b52c job-97/job-98) Run VM work job: com.cloud.storage.VmWorkTakeVolumeSnapshot for VM 9, job origin: 97
2015-04-10 15:58:36,598 DEBUG [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-23:ctx-0c35b52c job-97/job-98 ctx-0163f5d0) Execute VM work job: com.cloud.storage.VmWorkTakeVolumeSnapshot{"volumeId":10,"policyId":0,"snapshotId":2,"quiesceVm":false,"userId":2,"accountId":2,"vmId":9,"handlerName":"VolumeApiServiceImpl"}
2015-04-10 15:58:36,918 DEBUG [c.c.a.t.Request] (Work-Job-Executor-23:ctx-0c35b52c job-97/job-98 ctx-0163f5d0) Seq 3-7476256856411737682: Sending { Cmd , MgmtId: 161336282284, via: 3(cloudstack2), Ver: v1, Flags: 100011, [{"org.apache.cloudstack.storage.command.CreateObjectCommand":{"data":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"volume":{"uuid":"af34691b-fff7-4186-afcf-c021d6d0f4a0","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"afa1689b-cb9e-3acd-9f15-b26079003173","id":1,"poolType":"NetworkFilesystem","host":"10.0.0.2","path":"/storage/primary","port":2049,"url":"NetworkFilesystem://10.0.0.2/storage/primary/?ROLE=Primary&STOREUUID=afa1689b-cb9e-3acd-9f15-b26079003173"}},"name":"ROOT-9","size":107374182400,"path":"af34691b-fff7-4186-afcf-c021d6d0f4a0","volumeId":10,"vmName":"i-2-9-VM","accountId":2,"format":"QCOW2","id":10,"deviceId":0,"hypervisorType":"KVM"},"dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"afa1689b-cb9e-3acd-9f15-b26079003173","id":1,"poolType":"NetworkFilesystem","host":"10.0.0.2","path":"/storage/primary","port":2049,"url":"NetworkFilesystem://10.0.0.2/storage/primary/?ROLE=Primary&STOREUUID=afa1689b-cb9e-3acd-9f15-b26079003173"}},"vmName":"i-2-9-VM","name":"testnew_ROOT-9_20150410075834","hypervisorType":"KVM","id":2,"quiescevm":false,"physicalSize":0}},"wait":0}}] }
2015-04-10 15:58:37,545 DEBUG [c.c.a.t.Request] (AgentManager-Handler-15:null) Seq 3-7476256856411737682: Processing: { Ans: , MgmtId: 161336282284, via: 3, Ver: v1, Flags: 10, [{"org.apache.cloudstack.storage.command.CreateObjectAnswer":{"data":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":"/mnt/afa1689b-cb9e-3acd-9f15-b26079003173/af34691b-fff7-4186-afcf-c021d6d0f4a0/6aa74747-7a5b-44b5-9539-2e89a08209fc","id":0,"quiescevm":false,"physicalSize":0}},"result":true,"wait":0}}] }
2015-04-10 15:58:37,546 DEBUG [c.c.a.t.Request] (Work-Job-Executor-23:ctx-0c35b52c job-97/job-98 ctx-0163f5d0) Seq 3-7476256856411737682: Received: { Ans: , MgmtId: 161336282284, via: 3, Ver: v1, Flags: 10, { CreateObjectAnswer } }
2015-04-10 15:58:38,014 DEBUG [c.c.a.ApiServlet] (catalina-exec-25:ctx-bce7c01d) ===START=== 10.0.0.1 -- GET command=queryAsyncJobResult&jobId=d6d36fc4-2aed-42ee-8cc7-0f8cce17c6a9&response=json&sessionkey=WqleoX9aCHGVUOq3u1DCcYyN7iw%3D&_=1428652711049
2015-04-10 15:58:38,130 DEBUG [c.c.a.ApiServlet] (catalina-exec-25:ctx-bce7c01d ctx-74f204ff) ===END=== 10.0.0.1 -- GET command=queryAsyncJobResult&jobId=d6d36fc4-2aed-42ee-8cc7-0f8cce17c6a9&response=json&sessionkey=WqleoX9aCHGVUOq3u1DCcYyN7iw%3D&_=1428652711049
2015-04-10 15:58:38,178 DEBUG [o.a.c.s.m.AncientDataMotionStrategy] (Work-Job-Executor-23:ctx-0c35b52c job-97/job-98 ctx-0163f5d0) copyAsync inspecting src type SNAPSHOT copyAsync inspecting dest type SNAPSHOT
2015-04-10 15:58:38,209 DEBUG [c.c.a.t.Request] (Work-Job-Executor-23:ctx-0c35b52c job-97/job-98 ctx-0163f5d0) Seq 6-5907033861249827055: Sending { Cmd , MgmtId: 161336282284, via: 6(cloudstack3), Ver: v1, Flags: 100011, [{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":"/mnt/afa1689b-cb9e-3acd-9f15-b26079003173/af34691b-fff7-4186-afcf-c021d6d0f4a0/6aa74747-7a5b-44b5-9539-2e89a08209fc","volume":{"uuid":"af34691b-fff7-4186-afcf-c021d6d0f4a0","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"afa1689b-cb9e-3acd-9f15-b26079003173","id":1,"poolType":"NetworkFilesystem","host":"10.0.0.2","path":"/storage/primary","port":2049,"url":"NetworkFilesystem://10.0.0.2/storage/primary/?ROLE=Primary&STOREUUID=afa1689b-cb9e-3acd-9f15-b26079003173"}},"name":"ROOT-9","size":107374182400,"path":"af34691b-fff7-4186-afcf-c021d6d0f4a0","volumeId":10,"vmName":"i-2-9-VM","accountId":2,"format":"QCOW2","id":10,"deviceId":0,"hypervisorType":"KVM"},"dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"afa1689b-cb9e-3acd-9f15-b26079003173","id":1,"poolType":"NetworkFilesystem","host":"10.0.0.2","path":"/storage/primary","port":2049,"url":"NetworkFilesystem://10.0.0.2/storage/primary/?ROLE=Primary&STOREUUID=afa1689b-cb9e-3acd-9f15-b26079003173"}},"vmName":"i-2-9-VM","name":"testnew_ROOT-9_20150410075834","hypervisorType":"KVM","id":2,"quiescevm":false,"physicalSize":0}},"destTO":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":"snapshots/2/10","volume":{"uuid":"af34691b-fff7-4186-afcf-c021d6d0f4a0","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"afa1689b-cb9e-3acd-9f15-b26079003173","id":1,"poolType":"NetworkFilesystem","host":"10.0.0.2","path":"/storage/primary","port":2049,"url":"NetworkFilesystem://10.0.0.2/storage/primary/?ROLE=Primary&STOREUUID=afa1689b-cb9e-3acd-9f15-b26079003173"}},"name":"ROOT-9","size":107374182400,"path":"af34691b-fff7-4186-afcf-c021d6d0f4a0","volumeId":10,"vmName":"i-2-9-VM","accountId":2,"format":"QCOW2","id":10,"deviceId":0,"hypervisorType":"KVM"},"dataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.0.0.2/storage/secondary","_role":"Image"}},"vmName":"i-2-9-VM","name":"testnew_ROOT-9_20150410075834","hypervisorType":"KVM","id":2,"quiescevm":false,"physicalSize":0}},"executeInSequence":false,"options":{"fullSnapshot":"true"},"wait":21600}}] }
2015-04-10 15:58:39,882 DEBUG [c.c.a.t.Request] (AgentManager-Handler-11:null) Seq 6-5907033861249827055: Processing: { Ans: , MgmtId: 161336282284, via: 6, Ver: v1, Flags: 10, [{"org.apache.cloudstack.storage.command.CopyCmdAnswer":{"result":false,"details":"Failed to backup 6aa74747-7a5b-44b5-9539-2e89a08209fc for disk /mnt/afa1689b-cb9e-3acd-9f15-b26079003173/af34691b-fff7-4186-afcf-c021d6d0f4a0 to /mnt/05897534-e242-3bf5-aa5c-7123357709e6/snapshots/2/10","wait":0}}] }
2015-04-10 15:58:39,882 DEBUG [c.c.a.t.Request] (Work-Job-Executor-23:ctx-0c35b52c job-97/job-98 ctx-0163f5d0) Seq 6-5907033861249827055: Received: { Ans: , MgmtId: 161336282284, via: 6, Ver: v1, Flags: 10, { CopyCmdAnswer } }
2015-04-10 15:58:40,088 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-9:null) Ping from 6
2015-04-10 15:58:40,089 DEBUG [c.c.v.VirtualMachinePowerStateSyncImpl] (AgentManager-Handler-9:null) Process host VM state report from ping process. host: 6
2015-04-10 15:58:40,090 INFO [c.c.v.VirtualMachinePowerStateSyncImpl] (AgentManager-Handler-9:null) Unable to find matched VM in CloudStack DB. name: s-23-VM
2015-04-10 15:58:40,091 INFO [c.c.v.VirtualMachinePowerStateSyncImpl] (AgentManager-Handler-9:null) Unable to find matched VM in CloudStack DB. name: v-22-VM
2015-04-10 15:58:40,091 DEBUG [c.c.v.VirtualMachinePowerStateSyncImpl] (AgentManager-Handler-9:null) Process VM state report. host: 6, number of records in report: 0
2015-04-10 15:58:40,092 DEBUG [c.c.v.VirtualMachinePowerStateSyncImpl] (AgentManager-Handler-9:null) Done with process of VM state report. host: 6
2015-04-10 15:58:40,282 DEBUG [c.c.s.s.SnapshotManagerImpl] (Work-Job-Executor-23:ctx-0c35b52c job-97/job-98 ctx-0163f5d0) Failed to create snapshot
com.cloud.utils.exception.CloudRuntimeException: Failed to backup 6aa74747-7a5b-44b5-9539-2e89a08209fc for disk /mnt/afa1689b-cb9e-3acd-9f15-b26079003173/af34691b-fff7-4186-afcf-c021d6d0f4a0 to /mnt/05897534-e242-3bf5-aa5c-7123357709e6/snapshots/2/10
at org.apache.cloudstack.storage.snapshot.SnapshotServiceImpl.backupSnapshot(SnapshotServiceImpl.java:282)
at org.apache.cloudstack.storage.snapshot.XenserverSnapshotStrategy.backupSnapshot(XenserverSnapshotStrategy.java:137)
at org.apache.cloudstack.storage.snapshot.XenserverSnapshotStrategy.takeSnapshot(XenserverSnapshotStrategy.java:300)
at com.cloud.storage.snapshot.SnapshotManagerImpl.takeSnapshot(SnapshotManagerImpl.java:966)
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.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.$Proxy179.takeSnapshot(Unknown Source)
at org.apache.cloudstack.storage.volume.VolumeServiceImpl.takeSnapshot(VolumeServiceImpl.java:1503)
at com.cloud.storage.VolumeApiServiceImpl.orchestrateTakeVolumeSnapshot(VolumeApiServiceImpl.java:1766)
at com.cloud.storage.VolumeApiServiceImpl.orchestrateTakeVolumeSnapshot(VolumeApiServiceImpl.java:2503)
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 com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107)
at com.cloud.storage.VolumeApiServiceImpl.handleVmWorkJob(VolumeApiServiceImpl.java:2511)
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.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.$Proxy183.handleVmWorkJob(Unknown Source)
at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:102)
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)
2015-04-10 15:58:40,400 DEBUG [o.a.c.s.v.VolumeServiceImpl] (Work-Job-Executor-23:ctx-0c35b52c job-97/job-98 ctx-0163f5d0) Take snapshot: 10 failed
com.cloud.utils.exception.CloudRuntimeException: Failed to create snapshot
at com.cloud.storage.snapshot.SnapshotManagerImpl.takeSnapshot(SnapshotManagerImpl.java:983)
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.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.$Proxy179.takeSnapshot(Unknown Source)
at org.apache.cloudstack.storage.volume.VolumeServiceImpl.takeSnapshot(VolumeServiceImpl.java:1503)
at com.cloud.storage.VolumeApiServiceImpl.orchestrateTakeVolumeSnapshot(VolumeApiServiceImpl.java:1766)
at com.cloud.storage.VolumeApiServiceImpl.orchestrateTakeVolumeSnapshot(VolumeApiServiceImpl.java:2503)
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 com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107)
at com.cloud.storage.VolumeApiServiceImpl.handleVmWorkJob(VolumeApiServiceImpl.java:2511)
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.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.$Proxy183.handleVmWorkJob(Unknown Source)
at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:102)
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)
Caused by: com.cloud.utils.exception.CloudRuntimeException: Failed to backup 6aa74747-7a5b-44b5-9539-2e89a08209fc for disk /mnt/afa1689b-cb9e-3acd-9f15-b26079003173/af34691b-fff7-4186-afcf-c021d6d0f4a0 to /mnt/05897534-e242-3bf5-aa5c-7123357709e6/snapshots/2/10
at org.apache.cloudstack.storage.snapshot.SnapshotServiceImpl.backupSnapshot(SnapshotServiceImpl.java:282)
at org.apache.cloudstack.storage.snapshot.XenserverSnapshotStrategy.backupSnapshot(XenserverSnapshotStrategy.java:137)
at org.apache.cloudstack.storage.snapshot.XenserverSnapshotStrategy.takeSnapshot(XenserverSnapshotStrategy.java:300)
at com.cloud.storage.snapshot.SnapshotManagerImpl.takeSnapshot(SnapshotManagerImpl.java:966)
... 44 more
2015-04-10 15:58:40,401 DEBUG [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-23:ctx-0c35b52c job-97/job-98 ctx-0163f5d0) Done executing VM work job: com.cloud.storage.VmWorkTakeVolumeSnapshot{"volumeId":10,"policyId":0,"snapshotId":2,"quiesceVm":false,"userId":2,"accountId":2,"vmId":9,"handlerName":"VolumeApiServiceImpl"}
2015-04-10 15:58:40,401 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-23:ctx-0c35b52c job-97/job-98 ctx-0163f5d0) Complete async job-98, jobStatus: SUCCEEDED, resultCode: 0, result: rO0ABXNyAA5qYXZhLmxhbmcuTG9uZzuL5JDMjyPfAgABSgAFdmFsdWV4cgAQamF2YS5sYW5nLk51bWJlcoaslR0LlOCLAgAAeHAAAAAAAAAAAg
zb1019095894@163.com