Yuriy Karpel created CLOUDSTACK-9292:
----------------------------------------

             Summary: Failed to create snapshot with Swift on KVM
                 Key: CLOUDSTACK-9292
                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-9292
             Project: CloudStack
          Issue Type: Bug
      Security Level: Public (Anyone can view this level - this is the default.)
          Components: KVM, Secondary Storage, Snapshot
    Affects Versions: 4.7.0
         Environment: CentOS 7, Cloudstack 4.7, Ceph V9.2.0 INFERNALIS.
            Reporter: Yuriy Karpel


Failed to create snapshot with Swift on KVM
Steps to Reproduce:
=================
1.Bring up CS with KVM cluster using Swift(radosgw) for secondary, NFS for 
secondary staging, and rbd for primary
2.Deploy guest vm using default cent os template with both root and data disk
3.Create snapshot on root/data disk
Result:
=====
Snapshot creation failed with CloudRuntimeException: unsupported protocol
============
Snapshot is created on secondary staging storage but failed to copy to 
secondary storage.
Following is the log snippet:


{code}
2016-02-20 10:25:46,977 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(catalina-exec-13:ctx-4728df07 ctx-3a589bea) (logid:e2d53208) submit async 
job-2728, details: AsyncJobVO {id:2728, userId: 10, accountId: 7, instanceType: 
Snapshot, instanceId: 19, cmd: 
org.apache.cloudstack.api.command.user.snapshot.CreateSnapshotCmd, cmdInfo: 
{"quiescevm":"false","httpmethod":"GET","ctxAccountId":"7","uuid":"09a17747-dc55-438f-83b0-49538c1eef78","cmdEventType":"SNAPSHOT.CREATE","response":"json","ctxUserId":"10","volumeId":"9ddc9e9a-e98a-4049-b5e8-59f670e3f077","name":"test","ctxStartEventId":"7582","id":"19","ctxDetails":"{\"interface
 
com.cloud.storage.Snapshot\":\"09a17747-dc55-438f-83b0-49538c1eef78\",\"interface
 
com.cloud.storage.Volume\":\"9ddc9e9a-e98a-4049-b5e8-59f670e3f077\"}","_":"1455953146647"},
 cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: 
null, initMsid: 90212275930085, completeMsid: null, lastUpdated: null, 
lastPolled: null, created: null}
2016-02-20 10:25:46,979 DEBUG [c.c.a.ApiServlet] (catalina-exec-13:ctx-4728df07 
ctx-3a589bea) (logid:e2d53208) ===END===  10.30.10.41 -- GET  
command=createSnapshot&response=json&volumeId=9ddc9e9a-e98a-4049-b5e8-59f670e3f077&quiescevm=false&name=test&_=1455953146647
2016-02-20 10:25:46,982 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(API-Job-Executor-2:ctx-22ae7862 job-2728) (logid:a5032eea) Executing 
AsyncJobVO {id:2728, userId: 10, accountId: 7, instanceType: Snapshot, 
instanceId: 19, cmd: 
org.apache.cloudstack.api.command.user.snapshot.CreateSnapshotCmd, cmdInfo: 
{"quiescevm":"false","httpmethod":"GET","ctxAccountId":"7","uuid":"09a17747-dc55-438f-83b0-49538c1eef78","cmdEventType":"SNAPSHOT.CREATE","response":"json","ctxUserId":"10","volumeId":"9ddc9e9a-e98a-4049-b5e8-59f670e3f077","name":"test","ctxStartEventId":"7582","id":"19","ctxDetails":"{\"interface
 
com.cloud.storage.Snapshot\":\"09a17747-dc55-438f-83b0-49538c1eef78\",\"interface
 
com.cloud.storage.Volume\":\"9ddc9e9a-e98a-4049-b5e8-59f670e3f077\"}","_":"1455953146647"},
 cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: 
null, initMsid: 90212275930085, completeMsid: null, lastUpdated: null, 
lastPolled: null, created: null}
2016-02-20 10:25:48,127 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731) (logid:a5032eea) Executing 
AsyncJobVO {id:2731, userId: 10, accountId: 7, instanceType: null, instanceId: 
null, cmd: com.cloud.vm.VmWorkTakeVolumeSnapshot, cmdInfo: 
rO0ABXNyACVjb20uY2xvdWQudm0uVm1Xb3JrVGFrZVZvbHVtZVNuYXBzaG90BL5gG4Li1c8CAARaAAlxdWllc2NlVm1MAAhwb2xpY3lJZHQAEExqYXZhL2xhbmcvTG9uZztMAApzbmFwc2hvdElkcQB-AAFMAAh2b2x1bWVJZHEAfgABeHIAE2NvbS5jbG91ZC52bS5WbVdvcmufmbZW8CVnawIABEoACWFjY291bnRJZEoABnVzZXJJZEoABHZtSWRMAAtoYW5kbGVyTmFtZXQAEkxqYXZhL2xhbmcvU3RyaW5nO3hwAAAAAAAAAAcAAAAAAAAACgAAAAAAAABpdAAUVm9sdW1lQXBpU2VydmljZUltcGwAc3IADmphdmEubGFuZy5Mb25nO4vkkMyPI98CAAFKAAV2YWx1ZXhyABBqYXZhLmxhbmcuTnVtYmVyhqyVHQuU4IsCAAB4cAAAAAAAAAAAc3EAfgAGAAAAAAAAABNzcQB-AAYAAAAAAAABfg,
 cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: 
null, initMsid: 90212275930085, completeMsid: null, lastUpdated: null, 
lastPolled: null, created: Sat Feb 20 10:25:47 MSK 2016}
2016-02-20 10:25:48,128 DEBUG [c.c.v.VmWorkJobDispatcher] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731) (logid:a5032eea) Run VM 
work job: com.cloud.vm.VmWorkTakeVolumeSnapshot for VM 105, job origin: 2728
2016-02-20 10:25:48,137 DEBUG [c.c.v.VmWorkJobHandlerProxy] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) Execute VM work job: 
com.cloud.vm.VmWorkTakeVolumeSnapshot{"volumeId":382,"policyId":0,"snapshotId":19,"quiesceVm":false,"userId":10,"accountId":7,"vmId":105,"handlerName":"VolumeApiServiceImpl"}
2016-02-20 10:25:48,407 DEBUG [c.c.h.o.r.Ovm3HypervisorGuru] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) getCommandHostDelegation: class 
org.apache.cloudstack.storage.command.CreateObjectCommand
2016-02-20 10:25:48,407 DEBUG [c.c.h.XenServerGuru] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) getCommandHostDelegation: class 
org.apache.cloudstack.storage.command.CreateObjectCommand
2016-02-20 10:25:48,423 DEBUG [c.c.a.t.Request] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) Seq 121-7199004004351743164: Sending  { Cmd , MgmtId: 
90212275930085, via: 121(srv-kvm01.cloud.bstelecom.ru), Ver: v1, Flags: 100011, 
[{"org.apache.cloudstack.storage.command.CreateObjectCommand":{"data":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"volume":{"uuid":"9ddc9e9a-e98a-4049-b5e8-59f670e3f077","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"f5efdbfb-8fe7-3dfd-bc07-5088222d8b84","id":52,"poolType":"RBD","host":"ceph-mon.cloud.bstelecom.ru","path":"rbd-cl","port":6789,"url":"RBD://ceph-mon.cloud.bstelecom.ru/rbd-cl/?ROLE=Primary&STOREUUID=f5efdbfb-8fe7-3dfd-bc07-5088222d8b84"}},"name":"ROOT-105","size":472312242,"path":"9ddc9e9a-e98a-4049-b5e8-59f670e3f077","volumeId":382,"vmName":"i-7-105-VM","accountId":7,"format":"RAW","provisioningType":"THIN","id":382,"deviceId":0,"hypervisorType":"KVM"},"dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"f5efdbfb-8fe7-3dfd-bc07-5088222d8b84","id":52,"poolType":"RBD","host":"ceph-mon.cloud.bstelecom.ru","path":"rbd-cl","port":6789,"url":"RBD://ceph-mon.cloud.bstelecom.ru/rbd-cl/?ROLE=Primary&STOREUUID=f5efdbfb-8fe7-3dfd-bc07-5088222d8b84"}},"vmName":"i-7-105-VM","name":"test","hypervisorType":"KVM","id":19,"quiescevm":false,"physicalSize":0}},"wait":0}}]
 }
2016-02-20 10:25:49,601 DEBUG [c.c.a.t.Request] (AgentManager-Handler-5:null) 
(logid:) Seq 121-7199004004351743164: Processing:  { Ans: , MgmtId: 
90212275930085, via: 121, Ver: v1, Flags: 10, 
[{"org.apache.cloudstack.storage.command.CreateObjectAnswer":{"data":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":"rbd-cl/9ddc9e9a-e98a-4049-b5e8-59f670e3f077/779fb0f9-dcb6-4451-b270-81f01bb7d326","id":0,"quiescevm":false,"physicalSize":0}},"result":true,"wait":0}}]
 }
2016-02-20 10:25:49,601 DEBUG [c.c.a.t.Request] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) Seq 121-7199004004351743164: Received:  { Ans: , MgmtId: 
90212275930085, via: 121(srv-kvm01.cloud.bstelecom.ru), Ver: v1, Flags: 10, { 
CreateObjectAnswer } }
2016-02-20 10:25:49,621 DEBUG [c.c.a.m.AgentManagerImpl] 
(AgentManager-Handler-3:null) (logid:) SeqA 142-21971: Processing Seq 
142-21971:  { Cmd , MgmtId: -1, via: 142, Ver: v1, Flags: 11, 
[{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":104,"_loadInfo":"{\n
  \"connections\": []\n}","wait":0}}] }
2016-02-20 10:25:49,630 DEBUG [c.c.a.m.AgentManagerImpl] 
(AgentManager-Handler-3:null) (logid:) SeqA 142-21971: Sending Seq 142-21971:  
{ Ans: , MgmtId: 90212275930085, via: 142, Ver: v1, Flags: 100010, 
[{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
2016-02-20 10:25:49,794 DEBUG [o.a.c.s.m.AncientDataMotionStrategy] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) copyAsync inspecting src type SNAPSHOT copyAsync inspecting 
dest type SNAPSHOT
2016-02-20 10:25:49,886 DEBUG [o.a.c.s.m.AncientDataMotionStrategy] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) needCacheStorage true, dest at snapshots/7/382 dest role 
Imagerbd-cl/9ddc9e9a-e98a-4049-b5e8-59f670e3f077/779fb0f9-dcb6-4451-b270-81f01bb7d326
 src role Primary
2016-02-20 10:25:50,000 DEBUG [c.c.a.ApiServlet] (catalina-exec-9:ctx-a8490da0) 
(logid:6886e205) ===START===  10.30.10.41 -- GET  
command=queryAsyncJobResult&jobId=a5032eea-7fdc-4f79-a613-1a7822dfabaa&response=json&_=1455953150153
2016-02-20 10:25:50,060 DEBUG [c.c.u.AccountManagerImpl] 
(catalina-exec-9:ctx-a8490da0 ctx-6373cd53) (logid:6886e205) Access to 
Acct[69296515-f19c-407c-859e-42f4599e4653-ykarpel] granted to 
Acct[69296515-f19c-407c-859e-42f4599e4653-ykarpel] by DomainChecker
2016-02-20 10:25:50,086 DEBUG [c.c.h.o.r.Ovm3HypervisorGuru] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) getCommandHostDelegation: class 
org.apache.cloudstack.storage.command.CopyCommand
2016-02-20 10:25:50,086 DEBUG [c.c.h.XenServerGuru] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) getCommandHostDelegation: class 
org.apache.cloudstack.storage.command.CopyCommand
2016-02-20 10:25:50,091 DEBUG [c.c.a.t.Request] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) Seq 121-7199004004351743165: Sending  { Cmd , MgmtId: 
90212275930085, via: 121(srv-kvm01.cloud.bstelecom.ru), Ver: v1, Flags: 100111, 
[{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":"rbd-cl/9ddc9e9a-e98a-4049-b5e8-59f670e3f077/779fb0f9-dcb6-4451-b270-81f01bb7d326","volume":{"uuid":"9ddc9e9a-e98a-4049-b5e8-59f670e3f077","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"f5efdbfb-8fe7-3dfd-bc07-5088222d8b84","id":52,"poolType":"RBD","host":"ceph-mon.cloud.bstelecom.ru","path":"rbd-cl","port":6789,"url":"RBD://ceph-mon.cloud.bstelecom.ru/rbd-cl/?ROLE=Primary&STOREUUID=f5efdbfb-8fe7-3dfd-bc07-5088222d8b84"}},"name":"ROOT-105","size":472312242,"path":"9ddc9e9a-e98a-4049-b5e8-59f670e3f077","volumeId":382,"vmName":"i-7-105-VM","accountId":7,"format":"RAW","provisioningType":"THIN","id":382,"deviceId":0,"hypervisorType":"KVM"},"dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"f5efdbfb-8fe7-3dfd-bc07-5088222d8b84","id":52,"poolType":"RBD","host":"ceph-mon.cloud.bstelecom.ru","path":"rbd-cl","port":6789,"url":"RBD://ceph-mon.cloud.bstelecom.ru/rbd-cl/?ROLE=Primary&STOREUUID=f5efdbfb-8fe7-3dfd-bc07-5088222d8b84"}},"vmName":"i-7-105-VM","name":"test","hypervisorType":"KVM","id":19,"quiescevm":false,"physicalSize":0}},"destTO":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":"snapshots/7/382","volume":{"uuid":"9ddc9e9a-e98a-4049-b5e8-59f670e3f077","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"f5efdbfb-8fe7-3dfd-bc07-5088222d8b84","id":52,"poolType":"RBD","host":"ceph-mon.cloud.bstelecom.ru","path":"rbd-cl","port":6789,"url":"RBD://ceph-mon.cloud.bstelecom.ru/rbd-cl/?ROLE=Primary&STOREUUID=f5efdbfb-8fe7-3dfd-bc07-5088222d8b84"}},"name":"ROOT-105","size":472312242,"path":"9ddc9e9a-e98a-4049-b5e8-59f670e3f077","volumeId":382,"vmName":"i-7-105-VM","accountId":7,"format":"RAW","provisioningType":"THIN","id":382,"deviceId":0,"hypervisorType":"KVM"},"dataStore":{"com.cloud.agent.api.to.SwiftTO":{"id":145,"url":"http://s3.cloud.bstelecom.ru/auth/v1.0/","account":"cloudstack","userName":"swift","key":"VPGpdk5ppNgCepV58NNa1E1x4j5RDP9xyIxB7XMB"}},"vmName":"i-7-105-VM","name":"test","hypervisorType":"KVM","id":19,"quiescevm":false,"physicalSize":0}},"cacheTO":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":"snapshots/7/382","volume":{"uuid":"9ddc9e9a-e98a-4049-b5e8-59f670e3f077","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"f5efdbfb-8fe7-3dfd-bc07-5088222d8b84","id":52,"poolType":"RBD","host":"ceph-mon.cloud.bstelecom.ru","path":"rbd-cl","port":6789,"url":"RBD://ceph-mon.cloud.bstelecom.ru/rbd-cl/?ROLE=Primary&STOREUUID=f5efdbfb-8fe7-3dfd-bc07-5088222d8b84"}},"name":"ROOT-105","size":472312242,"path":"9ddc9e9a-e98a-4049-b5e8-59f670e3f077","volumeId":382,"vmName":"i-7-105-VM","accountId":7,"format":"RAW","provisioningType":"THIN","id":382,"deviceId":0,"hypervisorType":"KVM"},"dataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://srv-nfs.cloud.bstelecom.ru/nfs","_role":"ImageCache"}},"vmName":"i-7-105-VM","name":"test","hypervisorType":"KVM","id":19,"quiescevm":false,"physicalSize":0}},"executeInSequence":true,"options":{"fullSnapshot":"true"},"options2":{},"wait":21600}}]
 }
2016-02-20 10:25:50,102 DEBUG [c.c.a.ApiServlet] (catalina-exec-9:ctx-a8490da0 
ctx-6373cd53) (logid:6886e205) ===END===  10.30.10.41 -- GET  
command=queryAsyncJobResult&jobId=a5032eea-7fdc-4f79-a613-1a7822dfabaa&response=json&_=1455953150153
2016-02-20 10:26:47,877 DEBUG [c.c.a.t.Request] (AgentManager-Handler-10:null) 
(logid:) Seq 121-7199004004351743165: Processing:  { Ans: , MgmtId: 
90212275930085, via: 121, Ver: v1, Flags: 110, 
[{"org.apache.cloudstack.storage.command.CopyCmdAnswer":{"result":false,"details":"Unsupported
 protocol","wait":0}}] }
2016-02-20 10:26:47,877 DEBUG [c.c.a.m.AgentAttache] 
(AgentManager-Handler-10:null) (logid:) Seq 121-7199004004351743165: No more 
commands found
2016-02-20 10:26:47,877 DEBUG [c.c.a.t.Request] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) Seq 121-7199004004351743165: Received:  { Ans: , MgmtId: 
90212275930085, via: 121(srv-kvm01.cloud.bstelecom.ru), Ver: v1, Flags: 110, { 
CopyCmdAnswer } }
2016-02-20 10:26:47,901 DEBUG [c.c.h.o.r.Ovm3HypervisorGuru] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) getCommandHostDelegation: class 
org.apache.cloudstack.storage.command.DeleteCommand
2016-02-20 10:26:47,901 DEBUG [c.c.h.XenServerGuru] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) getCommandHostDelegation: class 
org.apache.cloudstack.storage.command.DeleteCommand
2016-02-20 10:26:47,907 DEBUG [c.c.a.t.Request] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) Seq 139-9216335162437012053: Sending  { Cmd , MgmtId: 
90212275930085, via: 139(s-103-VM), Ver: v1, Flags: 100011, 
[{"org.apache.cloudstack.storage.command.DeleteCommand":{"data":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":"snapshots/7/382","volume":{"uuid":"9ddc9e9a-e98a-4049-b5e8-59f670e3f077","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"f5efdbfb-8fe7-3dfd-bc07-5088222d8b84","id":52,"poolType":"RBD","host":"ceph-mon.cloud.bstelecom.ru","path":"rbd-cl","port":6789,"url":"RBD://ceph-mon.cloud.bstelecom.ru/rbd-cl/?ROLE=Primary&STOREUUID=f5efdbfb-8fe7-3dfd-bc07-5088222d8b84"}},"name":"ROOT-105","size":472312242,"path":"9ddc9e9a-e98a-4049-b5e8-59f670e3f077","volumeId":382,"vmName":"i-7-105-VM","accountId":7,"format":"RAW","provisioningType":"THIN","id":382,"deviceId":0,"hypervisorType":"KVM"},"dataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://srv-nfs.cloud.bstelecom.ru/nfs","_role":"ImageCache"}},"vmName":"i-7-105-VM","name":"test","hypervisorType":"KVM","id":19,"quiescevm":false,"physicalSize":0}},"wait":0}}]
 }
2016-02-20 10:26:47,936 DEBUG [c.c.a.ApiServlet] (catalina-exec-1:ctx-174adeaa) 
(logid:52a3528c) ===START===  10.30.10.41 -- GET  
command=queryAsyncJobResult&jobId=a5032eea-7fdc-4f79-a613-1a7822dfabaa&response=json&_=1455953208093
2016-02-20 10:26:47,996 DEBUG [c.c.u.AccountManagerImpl] 
(catalina-exec-1:ctx-174adeaa ctx-1cbaa0e4) (logid:52a3528c) Access to 
Acct[69296515-f19c-407c-859e-42f4599e4653-ykarpel] granted to 
Acct[69296515-f19c-407c-859e-42f4599e4653-ykarpel] by DomainChecker
2016-02-20 10:26:48,036 DEBUG [c.c.a.ApiServlet] (catalina-exec-1:ctx-174adeaa 
ctx-1cbaa0e4) (logid:52a3528c) ===END===  10.30.10.41 -- GET  
command=queryAsyncJobResult&jobId=a5032eea-7fdc-4f79-a613-1a7822dfabaa&response=json&_=1455953208093
2016-02-20 10:26:48,076 DEBUG [c.c.a.t.Request] (AgentManager-Handler-1:null) 
(logid:) Seq 139-9216335162437012053: Processing:  { Ans: , MgmtId: 
90212275930085, via: 139, Ver: v1, Flags: 10, 
[{"com.cloud.agent.api.Answer":{"result":true,"wait":0}}] }
2016-02-20 10:26:48,076 DEBUG [c.c.a.t.Request] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) Seq 139-9216335162437012053: Received:  { Ans: , MgmtId: 
90212275930085, via: 139(s-103-VM), Ver: v1, Flags: 10, { Answer } }
2016-02-20 10:26:48,187 DEBUG [c.c.s.s.SnapshotManagerImpl] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) Failed to create snapshot
com.cloud.utils.exception.CloudRuntimeException: Unsupported protocol
        at 
org.apache.cloudstack.storage.snapshot.SnapshotServiceImpl.backupSnapshot(SnapshotServiceImpl.java:285)
        at 
org.apache.cloudstack.storage.snapshot.XenserverSnapshotStrategy.backupSnapshot(XenserverSnapshotStrategy.java:155)
        at 
org.apache.cloudstack.storage.snapshot.XenserverSnapshotStrategy.takeSnapshot(XenserverSnapshotStrategy.java:322)
        at 
com.cloud.storage.snapshot.SnapshotManagerImpl.takeSnapshot(SnapshotManagerImpl.java:1007)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        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.$Proxy189.takeSnapshot(Unknown Source)
        at 
org.apache.cloudstack.storage.volume.VolumeServiceImpl.takeSnapshot(VolumeServiceImpl.java:1591)
        at 
com.cloud.storage.VolumeApiServiceImpl.orchestrateTakeVolumeSnapshot(VolumeApiServiceImpl.java:2091)
        at 
com.cloud.storage.VolumeApiServiceImpl.orchestrateTakeVolumeSnapshot(VolumeApiServiceImpl.java:2883)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        at 
com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107)
        at 
com.cloud.storage.VolumeApiServiceImpl.handleVmWorkJob(VolumeApiServiceImpl.java:2891)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        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.$Proxy194.handleVmWorkJob(Unknown Source)
        at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:102)
        at 
org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:554)
        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:502)
        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)
2016-02-20 10:26:48,243 DEBUG [o.a.c.s.v.VolumeServiceImpl] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) Take snapshot: 382 failed
com.cloud.utils.exception.CloudRuntimeException: Failed to create snapshot
        at 
com.cloud.storage.snapshot.SnapshotManagerImpl.takeSnapshot(SnapshotManagerImpl.java:1023)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        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.$Proxy189.takeSnapshot(Unknown Source)
        at 
org.apache.cloudstack.storage.volume.VolumeServiceImpl.takeSnapshot(VolumeServiceImpl.java:1591)
        at 
com.cloud.storage.VolumeApiServiceImpl.orchestrateTakeVolumeSnapshot(VolumeApiServiceImpl.java:2091)
        at 
com.cloud.storage.VolumeApiServiceImpl.orchestrateTakeVolumeSnapshot(VolumeApiServiceImpl.java:2883)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        at 
com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107)
        at 
com.cloud.storage.VolumeApiServiceImpl.handleVmWorkJob(VolumeApiServiceImpl.java:2891)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        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.$Proxy194.handleVmWorkJob(Unknown Source)
        at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:102)
        at 
org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:554)
        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:502)
        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)
Caused by: com.cloud.utils.exception.CloudRuntimeException: Unsupported protocol
        at 
org.apache.cloudstack.storage.snapshot.SnapshotServiceImpl.backupSnapshot(SnapshotServiceImpl.java:285)
        at 
org.apache.cloudstack.storage.snapshot.XenserverSnapshotStrategy.backupSnapshot(XenserverSnapshotStrategy.java:155)
        at 
org.apache.cloudstack.storage.snapshot.XenserverSnapshotStrategy.takeSnapshot(XenserverSnapshotStrategy.java:322)
        ... 45 more
2016-02-20 10:26:48,246 ERROR [c.c.v.VmWorkJobHandlerProxy] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) Invocation exception, caused by: 
com.cloud.utils.exception.CloudRuntimeException: Failed to take snapshot
2016-02-20 10:26:48,247 INFO  [c.c.v.VmWorkJobHandlerProxy] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731 ctx-5ae19c97) 
(logid:a5032eea) Rethrow exception 
com.cloud.utils.exception.CloudRuntimeException: Failed to take snapshot
2016-02-20 10:26:48,247 DEBUG [c.c.v.VmWorkJobDispatcher] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731) (logid:a5032eea) Done with 
run of VM work job: com.cloud.vm.VmWorkTakeVolumeSnapshot for VM 105, job 
origin: 2728
2016-02-20 10:26:48,247 ERROR [c.c.v.VmWorkJobDispatcher] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731) (logid:a5032eea) Unable to 
complete AsyncJobVO {id:2731, userId: 10, accountId: 7, instanceType: null, 
instanceId: null, cmd: com.cloud.vm.VmWorkTakeVolumeSnapshot, cmdInfo: 
rO0ABXNyACVjb20uY2xvdWQudm0uVm1Xb3JrVGFrZVZvbHVtZVNuYXBzaG90BL5gG4Li1c8CAARaAAlxdWllc2NlVm1MAAhwb2xpY3lJZHQAEExqYXZhL2xhbmcvTG9uZztMAApzbmFwc2hvdElkcQB-AAFMAAh2b2x1bWVJZHEAfgABeHIAE2NvbS5jbG91ZC52bS5WbVdvcmufmbZW8CVnawIABEoACWFjY291bnRJZEoABnVzZXJJZEoABHZtSWRMAAtoYW5kbGVyTmFtZXQAEkxqYXZhL2xhbmcvU3RyaW5nO3hwAAAAAAAAAAcAAAAAAAAACgAAAAAAAABpdAAUVm9sdW1lQXBpU2VydmljZUltcGwAc3IADmphdmEubGFuZy5Mb25nO4vkkMyPI98CAAFKAAV2YWx1ZXhyABBqYXZhLmxhbmcuTnVtYmVyhqyVHQuU4IsCAAB4cAAAAAAAAAAAc3EAfgAGAAAAAAAAABNzcQB-AAYAAAAAAAABfg,
 cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: 
null, initMsid: 90212275930085, completeMsid: null, lastUpdated: null, 
lastPolled: null, created: Sat Feb 20 10:25:47 MSK 2016}, job origin:2728
com.cloud.utils.exception.CloudRuntimeException: Failed to take snapshot
        at 
org.apache.cloudstack.storage.volume.VolumeServiceImpl.takeSnapshot(VolumeServiceImpl.java:1594)
        at 
com.cloud.storage.VolumeApiServiceImpl.orchestrateTakeVolumeSnapshot(VolumeApiServiceImpl.java:2091)
        at 
com.cloud.storage.VolumeApiServiceImpl.orchestrateTakeVolumeSnapshot(VolumeApiServiceImpl.java:2883)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        at 
com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107)
        at 
com.cloud.storage.VolumeApiServiceImpl.handleVmWorkJob(VolumeApiServiceImpl.java:2891)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        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.$Proxy194.handleVmWorkJob(Unknown Source)
        at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:102)
        at 
org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:554)
        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:502)
        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)
Caused by: com.cloud.utils.exception.CloudRuntimeException: Failed to create 
snapshot
        at 
com.cloud.storage.snapshot.SnapshotManagerImpl.takeSnapshot(SnapshotManagerImpl.java:1023)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        ... 42 more
Caused by: com.cloud.utils.exception.CloudRuntimeException: Unsupported protocol
        at 
org.apache.cloudstack.storage.snapshot.SnapshotServiceImpl.backupSnapshot(SnapshotServiceImpl.java:285)
        at 
org.apache.cloudstack.storage.snapshot.XenserverSnapshotStrategy.backupSnapshot(XenserverSnapshotStrategy.java:155)
        at 
org.apache.cloudstack.storage.snapshot.XenserverSnapshotStrategy.takeSnapshot(XenserverSnapshotStrategy.java:322)
        ... 45 more
2016-02-20 10:26:48,269 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731) (logid:a5032eea) Complete 
async job-2731, jobStatus: FAILED, resultCode: 0, result: 
rO0ABXNyAC9jb20uY2xvdWQudXRpbHMuZXhjZXB0aW9uLkNsb3VkUnVudGltZUV4Y2VwdGlvbgAAAABWTU9yAwABSQALY3NFcnJvckNvZGV4cgAaamF2YS5sYW5nLlJ1bnRpbWVFeGNlcHRpb26eXwZHCjSD5QIAAHhyABNqYXZhLmxhbmcuRXhjZXB0aW9u0P0fPho7HMQCAAB4cgATamF2YS5sYW5nLlRocm93YWJsZdXGNSc5d7jLAwAETAAFY2F1c2V0ABVMamF2YS9sYW5nL1Rocm93YWJsZTtMAA1kZXRhaWxNZXNzYWdldAASTGphdmEvbGFuZy9TdHJpbmc7WwAKc3RhY2tUcmFjZXQAHltMamF2YS9sYW5nL1N0YWNrVHJhY2VFbGVtZW50O0wAFHN1cHByZXNzZWRFeGNlcHRpb25zdAAQTGphdmEvdXRpbC9MaXN0O3hwc3EAfgAAc3EAfgAAcQB-AAp0ABRVbnN1cHBvcnRlZCBwcm90b2NvbHVyAB5bTGphdmEubGFuZy5TdGFja1RyYWNlRWxlbWVudDsCRio8PP0iOQIAAHhwAAAAMHNyABtqYXZhLmxhbmcuU3RhY2tUcmFjZUVsZW1lbnRhCcWaJjbdhQIABEkACmxpbmVOdW1iZXJMAA5kZWNsYXJpbmdDbGFzc3EAfgAFTAAIZmlsZU5hbWVxAH4ABUwACm1ldGhvZE5hbWVxAH4ABXhwAAABHXQAOm9yZy5hcGFjaGUuY2xvdWRzdGFjay5zdG9yYWdlLnNuYXBzaG90LlNuYXBzaG90U2VydmljZUltcGx0ABhTbmFwc2hvdFNlcnZpY2VJbXBsLmphdmF0AA5iYWNrdXBTbmFwc2hvdHNxAH4ADgAAAJt0AEBvcmcuYXBhY2hlLmNsb3Vkc3RhY2suc3RvcmFnZS5zbmFwc2hvdC5YZW5zZXJ2ZXJTbmFwc2hvdFN0cmF0ZWd5dAAeWGVuc2VydmVyU25hcHNob3RTdHJhdGVneS5qYXZhcQB-ABJzcQB-AA4AAAFCcQB-ABRxAH4AFXQADHRha2VTbmFwc2hvdHNxAH4ADgAAA-90AC5jb20uY2xvdWQuc3RvcmFnZS5zbmFwc2hvdC5TbmFwc2hvdE1hbmFnZXJJbXBsdAAYU25hcHNob3RNYW5hZ2VySW1wbC5qYXZhcQB-ABdzcQB-AA7____-dAAkc3VuLnJlZmxlY3QuTmF0aXZlTWV0aG9kQWNjZXNzb3JJbXBsdAAdTmF0aXZlTWV0aG9kQWNjZXNzb3JJbXBsLmphdmF0AAdpbnZva2Uwc3EAfgAOAAAAPnEAfgAccQB-AB10AAZpbnZva2VzcQB-AA4AAAArdAAoc3VuLnJlZmxlY3QuRGVsZWdhdGluZ01ldGhvZEFjY2Vzc29ySW1wbHQAIURlbGVnYXRpbmdNZXRob2RBY2Nlc3NvckltcGwuamF2YXEAfgAgc3EAfgAOAAAB8XQAGGphdmEubGFuZy5yZWZsZWN0Lk1ldGhvZHQAC01ldGhvZC5qYXZhcQB-ACBzcQB-AA4AAAE9dAAob3JnLnNwcmluZ2ZyYW1ld29yay5hb3Auc3VwcG9ydC5Bb3BVdGlsc3QADUFvcFV0aWxzLmphdmF0AB5pbnZva2VKb2lucG9pbnRVc2luZ1JlZmxlY3Rpb25zcQB-AA4AAAC3dAA8b3JnLnNwcmluZ2ZyYW1ld29yay5hb3AuZnJhbWV3b3JrLlJlZmxlY3RpdmVNZXRob2RJbnZvY2F0aW9udAAfUmVmbGVjdGl2ZU1ldGhvZEludm9jYXRpb24uamF2YXQAD2ludm9rZUpvaW5wb2ludHNxAH4ADgAAAJZxAH4ALHEAfgAtdAAHcHJvY2VlZHNxAH4ADgAAAFt0AD9vcmcuc3ByaW5nZnJhbWV3b3JrLmFvcC5pbnRlcmNlcHRvci5FeHBvc2VJbnZvY2F0aW9uSW50ZXJjZXB0b3J0ACBFeHBvc2VJbnZvY2F0aW9uSW50ZXJjZXB0b3IuamF2YXEAfgAgc3EAfgAOAAAArHEAfgAscQB-AC1xAH4AMHNxAH4ADgAAAMx0ADRvcmcuc3ByaW5nZnJhbWV3b3JrLmFvcC5mcmFtZXdvcmsuSmRrRHluYW1pY0FvcFByb3h5dAAXSmRrRHluYW1pY0FvcFByb3h5LmphdmFxAH4AIHNxAH4ADv____90ABdjb20uc3VuLnByb3h5LiRQcm94eTE4OXBxAH4AF3NxAH4ADgAABjd0ADZvcmcuYXBhY2hlLmNsb3Vkc3RhY2suc3RvcmFnZS52b2x1bWUuVm9sdW1lU2VydmljZUltcGx0ABZWb2x1bWVTZXJ2aWNlSW1wbC5qYXZhcQB-ABdzcQB-AA4AAAgrdAAmY29tLmNsb3VkLnN0b3JhZ2UuVm9sdW1lQXBpU2VydmljZUltcGx0ABlWb2x1bWVBcGlTZXJ2aWNlSW1wbC5qYXZhdAAdb3JjaGVzdHJhdGVUYWtlVm9sdW1lU25hcHNob3RzcQB-AA4AAAtDcQB-AD5xAH4AP3EAfgBAc3EAfgAO_____nEAfgAccQB-AB1xAH4AHnNxAH4ADgAAAD5xAH4AHHEAfgAdcQB-ACBzcQB-AA4AAAArcQB-ACJxAH4AI3EAfgAgc3EAfgAOAAAB8XEAfgAlcQB-ACZxAH4AIHNxAH4ADgAAAGt0ACJjb20uY2xvdWQudm0uVm1Xb3JrSm9iSGFuZGxlclByb3h5dAAaVm1Xb3JrSm9iSGFuZGxlclByb3h5LmphdmF0AA9oYW5kbGVWbVdvcmtKb2JzcQB-AA4AAAtLcQB-AD5xAH4AP3EAfgBJc3EAfgAO_____nEAfgAccQB-AB1xAH4AHnNxAH4ADgAAAD5xAH4AHHEAfgAdcQB-ACBzcQB-AA4AAAArcQB-ACJxAH4AI3EAfgAgc3EAfgAOAAAB8XEAfgAlcQB-ACZxAH4AIHNxAH4ADgAAAT1xAH4AKHEAfgApcQB-ACpzcQB-AA4AAAC3cQB-ACxxAH4ALXEAfgAuc3EAfgAOAAAAlnEAfgAscQB-AC1xAH4AMHNxAH4ADgAAAFtxAH4AMnEAfgAzcQB-ACBzcQB-AA4AAACscQB-ACxxAH4ALXEAfgAwc3EAfgAOAAAAzHEAfgA2cQB-ADdxAH4AIHNxAH4ADv____90ABdjb20uc3VuLnByb3h5LiRQcm94eTE5NHBxAH4ASXNxAH4ADgAAAGZ0ACBjb20uY2xvdWQudm0uVm1Xb3JrSm9iRGlzcGF0Y2hlcnQAGFZtV29ya0pvYkRpc3BhdGNoZXIuamF2YXQABnJ1bkpvYnNxAH4ADgAAAip0AD9vcmcuYXBhY2hlLmNsb3Vkc3RhY2suZnJhbWV3b3JrLmpvYnMuaW1wbC5Bc3luY0pvYk1hbmFnZXJJbXBsJDV0ABhBc3luY0pvYk1hbmFnZXJJbXBsLmphdmF0AAxydW5JbkNvbnRleHRzcQB-AA4AAAAxdAA-b3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5NYW5hZ2VkQ29udGV4dFJ1bm5hYmxlJDF0ABtNYW5hZ2VkQ29udGV4dFJ1bm5hYmxlLmphdmF0AANydW5zcQB-AA4AAAA4dABCb3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5pbXBsLkRlZmF1bHRNYW5hZ2VkQ29udGV4dCQxdAAaRGVmYXVsdE1hbmFnZWRDb250ZXh0LmphdmF0AARjYWxsc3EAfgAOAAAAZ3QAQG9yZy5hcGFjaGUuY2xvdWRzdGFjay5tYW5hZ2VkLmNvbnRleHQuaW1wbC5EZWZhdWx0TWFuYWdlZENvbnRleHRxAH4AZXQAD2NhbGxXaXRoQ29udGV4dHNxAH4ADgAAADVxAH4AaHEAfgBldAAOcnVuV2l0aENvbnRleHRzcQB-AA4AAAAudAA8b3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5NYW5hZ2VkQ29udGV4dFJ1bm5hYmxlcQB-AGFxAH4AYnNxAH4ADgAAAfZxAH4AXHEAfgBdcQB-AGJzcQB-AA4AAAH_dAAuamF2YS51dGlsLmNvbmN1cnJlbnQuRXhlY3V0b3JzJFJ1bm5hYmxlQWRhcHRlcnQADkV4ZWN1dG9ycy5qYXZhcQB-AGZzcQB-AA4AAAEKdAAfamF2YS51dGlsLmNvbmN1cnJlbnQuRnV0dXJlVGFza3QAD0Z1dHVyZVRhc2suamF2YXEAfgBic3EAfgAOAAAEdnQAJ2phdmEudXRpbC5jb25jdXJyZW50LlRocmVhZFBvb2xFeGVjdXRvcnQAF1RocmVhZFBvb2xFeGVjdXRvci5qYXZhdAAJcnVuV29ya2Vyc3EAfgAOAAACaXQALmphdmEudXRpbC5jb25jdXJyZW50LlRocmVhZFBvb2xFeGVjdXRvciRXb3JrZXJxAH4Ad3EAfgBic3EAfgAOAAAC6XQAEGphdmEubGFuZy5UaHJlYWR0AAtUaHJlYWQuamF2YXEAfgBic3IAJmphdmEudXRpbC5Db2xsZWN0aW9ucyRVbm1vZGlmaWFibGVMaXN0_A8lMbXsjhACAAFMAARsaXN0cQB-AAd4cgAsamF2YS51dGlsLkNvbGxlY3Rpb25zJFVubW9kaWZpYWJsZUNvbGxlY3Rpb24ZQgCAy173HgIAAUwAAWN0ABZMamF2YS91dGlsL0NvbGxlY3Rpb247eHBzcgATamF2YS51dGlsLkFycmF5TGlzdHiB0h2Zx2GdAwABSQAEc2l6ZXhwAAAAAHcEAAAAAHhxAH4Ag3gAABCadwgAAAAAAAAAAHh0ABlGYWlsZWQgdG8gY3JlYXRlIHNuYXBzaG90dXEAfgAMAAAALXNxAH4ADgAAA_9xAH4AGXEAfgAacQB-ABdzcQB-AA7____-cQB-ABxxAH4AHXEAfgAec3EAfgAOAAAAPnEAfgAccQB-AB1xAH4AIHNxAH4ADgAAACtxAH4AInEAfgAjcQB-ACBzcQB-AA4AAAHxcQB-ACVxAH4AJnEAfgAgc3EAfgAOAAABPXEAfgAocQB-AClxAH4AKnNxAH4ADgAAALdxAH4ALHEAfgAtcQB-AC5zcQB-AA4AAACWcQB-ACxxAH4ALXEAfgAwc3EAfgAOAAAAW3EAfgAycQB-ADNxAH4AIHNxAH4ADgAAAKxxAH4ALHEAfgAtcQB-ADBzcQB-AA4AAADMcQB-ADZxAH4AN3EAfgAgc3EAfgAO_____3EAfgA5cHEAfgAXc3EAfgAOAAAGN3EAfgA7cQB-ADxxAH4AF3NxAH4ADgAACCtxAH4APnEAfgA_cQB-AEBzcQB-AA4AAAtDcQB-AD5xAH4AP3EAfgBAc3EAfgAO_____nEAfgAccQB-AB1xAH4AHnNxAH4ADgAAAD5xAH4AHHEAfgAdcQB-ACBzcQB-AA4AAAArcQB-ACJxAH4AI3EAfgAgc3EAfgAOAAAB8XEAfgAlcQB-ACZxAH4AIHNxAH4ADgAAAGtxAH4AR3EAfgBIcQB-AElzcQB-AA4AAAtLcQB-AD5xAH4AP3EAfgBJc3EAfgAO_____nEAfgAccQB-AB1xAH4AHnNxAH4ADgAAAD5xAH4AHHEAfgAdcQB-ACBzcQB-AA4AAAArcQB-ACJxAH4AI3EAfgAgc3EAfgAOAAAB8XEAfgAlcQB-ACZxAH4AIHNxAH4ADgAAAT1xAH4AKHEAfgApcQB-ACpzcQB-AA4AAAC3cQB-ACxxAH4ALXEAfgAuc3EAfgAOAAAAlnEAfgAscQB-AC1xAH4AMHNxAH4ADgAAAFtxAH4AMnEAfgAzcQB-ACBzcQB-AA4AAACscQB-ACxxAH4ALXEAfgAwc3EAfgAOAAAAzHEAfgA2cQB-ADdxAH4AIHNxAH4ADv____9xAH4AVnBxAH4ASXNxAH4ADgAAAGZxAH4AWHEAfgBZcQB-AFpzcQB-AA4AAAIqcQB-AFxxAH4AXXEAfgBec3EAfgAOAAAAMXEAfgBgcQB-AGFxAH4AYnNxAH4ADgAAADhxAH4AZHEAfgBlcQB-AGZzcQB-AA4AAABncQB-AGhxAH4AZXEAfgBpc3EAfgAOAAAANXEAfgBocQB-AGVxAH4Aa3NxAH4ADgAAAC5xAH4AbXEAfgBhcQB-AGJzcQB-AA4AAAH2cQB-AFxxAH4AXXEAfgBic3EAfgAOAAAB_3EAfgBwcQB-AHFxAH4AZnNxAH4ADgAAAQpxAH4Ac3EAfgB0cQB-AGJzcQB-AA4AAAR2cQB-AHZxAH4Ad3EAfgB4c3EAfgAOAAACaXEAfgB6cQB-AHdxAH4AYnNxAH4ADgAAAulxAH4AfHEAfgB9cQB-AGJxAH4AgXgAABCadwgAAAAAAAAAAHh0ABdGYWlsZWQgdG8gdGFrZSBzbmFwc2hvdHVxAH4ADAAAACFzcQB-AA4AAAY6cQB-ADtxAH4APHEAfgAXc3EAfgAOAAAIK3EAfgA-cQB-AD9xAH4AQHNxAH4ADgAAC0NxAH4APnEAfgA_cQB-AEBzcQB-AA7____-cQB-ABxxAH4AHXEAfgAec3EAfgAOAAAAPnEAfgAccQB-AB1xAH4AIHNxAH4ADgAAACtxAH4AInEAfgAjcQB-ACBzcQB-AA4AAAHxcQB-ACVxAH4AJnEAfgAgc3EAfgAOAAAAa3EAfgBHcQB-AEhxAH4ASXNxAH4ADgAAC0txAH4APnEAfgA_cQB-AElzcQB-AA7____-cQB-ABxxAH4AHXEAfgAec3EAfgAOAAAAPnEAfgAccQB-AB1xAH4AIHNxAH4ADgAAACtxAH4AInEAfgAjcQB-ACBzcQB-AA4AAAHxcQB-ACVxAH4AJnEAfgAgc3EAfgAOAAABPXEAfgAocQB-AClxAH4AKnNxAH4ADgAAALdxAH4ALHEAfgAtcQB-AC5zcQB-AA4AAACWcQB-ACxxAH4ALXEAfgAwc3EAfgAOAAAAW3EAfgAycQB-ADNxAH4AIHNxAH4ADgAAAKxxAH4ALHEAfgAtcQB-ADBzcQB-AA4AAADMcQB-ADZxAH4AN3EAfgAgc3EAfgAO_____3EAfgBWcHEAfgBJc3EAfgAOAAAAZnEAfgBYcQB-AFlxAH4AWnNxAH4ADgAAAipxAH4AXHEAfgBdcQB-AF5zcQB-AA4AAAAxcQB-AGBxAH4AYXEAfgBic3EAfgAOAAAAOHEAfgBkcQB-AGVxAH4AZnNxAH4ADgAAAGdxAH4AaHEAfgBlcQB-AGlzcQB-AA4AAAA1cQB-AGhxAH4AZXEAfgBrc3EAfgAOAAAALnEAfgBtcQB-AGFxAH4AYnNxAH4ADgAAAfZxAH4AXHEAfgBdcQB-AGJzcQB-AA4AAAH_cQB-AHBxAH4AcXEAfgBmc3EAfgAOAAABCnEAfgBzcQB-AHRxAH4AYnNxAH4ADgAABHZxAH4AdnEAfgB3cQB-AHhzcQB-AA4AAAJpcQB-AHpxAH4Ad3EAfgBic3EAfgAOAAAC6XEAfgB8cQB-AH1xAH4AYnEAfgCBeAAAEJp3CAAAAAAAAAAAeA
2016-02-20 10:26:48,276 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731) (logid:a5032eea) Publish 
async job-2731 complete on message bus
2016-02-20 10:26:48,276 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731) (logid:a5032eea) Wake up 
jobs related to job-2731
2016-02-20 10:26:48,276 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731) (logid:a5032eea) Update db 
status for job-2731
2016-02-20 10:26:48,282 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731) (logid:a5032eea) Wake up 
jobs joined with job-2731 and disjoin all subjobs created from job- 2731
2016-02-20 10:26:48,299 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731) (logid:a5032eea) Done 
executing com.cloud.vm.VmWorkTakeVolumeSnapshot for job-2731
2016-02-20 10:26:48,307 INFO  [o.a.c.f.j.i.AsyncJobMonitor] 
(Work-Job-Executor-2:ctx-6fb5a754 job-2728/job-2731) (logid:a5032eea) Remove 
job-2731 from job monitoring
2016-02-20 10:26:48,365 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(API-Job-Executor-2:ctx-22ae7862 job-2728) (logid:a5032eea) Complete async 
job-2728, jobStatus: FAILED, resultCode: 530, result: 
org.apache.cloudstack.api.response.ExceptionResponse/null/{"uuidList":[],"errorcode":530,"errortext":"Failed
 to create snapshot due to an internal error creating snapshot for volume 382"}
2016-02-20 10:26:48,370 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(API-Job-Executor-2:ctx-22ae7862 job-2728) (logid:a5032eea) Publish async 
job-2728 complete on message bus
2016-02-20 10:26:48,370 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(API-Job-Executor-2:ctx-22ae7862 job-2728) (logid:a5032eea) Wake up jobs 
related to job-2728
2016-02-20 10:26:48,370 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(API-Job-Executor-2:ctx-22ae7862 job-2728) (logid:a5032eea) Update db status 
for job-2728
2016-02-20 10:26:48,375 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(API-Job-Executor-2:ctx-22ae7862 job-2728) (logid:a5032eea) Wake up jobs joined 
with job-2728 and disjoin all subjobs created from job- 2728
2016-02-20 10:26:48,383 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(API-Job-Executor-2:ctx-22ae7862 job-2728) (logid:a5032eea) Done executing 
org.apache.cloudstack.api.command.user.snapshot.CreateSnapshotCmd for job-2728
2016-02-20 10:26:48,383 INFO  [o.a.c.f.j.i.AsyncJobMonitor] 
(API-Job-Executor-2:ctx-22ae7862 job-2728) (logid:a5032eea) Remove job-2728 
from job monitoring
{code}



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

Reply via email to