cloudstack-users mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Rakesh v <www.rakeshv....@gmail.com>
Subject Re: snapshot is not working
Date Mon, 09 Nov 2020 16:34:18 GMT
Is the global setting which contains the string "snaphot.to.secondary" is false? If so it's
a known issue and that's why the "path" is missing 

Sent from my iPhone

> On 09-Nov-2020, at 1:22 PM, Piotr Pisz <piotr@piszki.pl> wrote:
> 
> ´╗┐Hello,
> 
> 
> 
> I need help, snapshots are not working (see below), this is a new CS installation on
Ceph RBD. Besides, everything works fine, could you tell us what might be wrong?
> 
> 
> 
> Take snapshot: 544 failed
> 
> com.cloud.utils.exception.CloudRuntimeException: com.cloud.utils.exception.CloudRuntimeException:
org.libvirt.LibvirtException: XML error: missing storage pool source path
> 
> 
> 
> ???
> 
> 
> 
> Best regards,
> 
> Piotr
> 
> 
> 
> 
> 
> 2020-11-09 12:56:46,525 INFO  [o.a.c.f.j.i.AsyncJobMonitor] (API-Job-Executor-35:ctx-326b32af
job-1894) (logid:836f528d) Add job-1894 into job monitoring
> 
> 2020-11-09 12:56:46,528 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (qtp1497845528-1209:ctx-a9fac85e
ctx-7d1c63e1) (logid:a5ddc58d) submit async job-1894, details: AsyncJobVO {id:1894, userId:
2, accountId: 2, instanceType: Snapshot, instanceId: 13, cmd: org.apache.cloudstack.api.command.user.snapshot.CreateSnapshotCmd,
cmdInfo: {"quiescevm":"false","httpmethod":"GET","ctxAccountId":"2","uuid":"82f3faf3-e09c-4eaf-886c-d81bad998b64","cmdEventType":"SNAPSHOT.CREATE","asyncBackup":"false","response":"json","ctxUserId":"2","volumeId":"9945a23b-a376-4f85-b378-9f7da8017dac","name":"test","ctxStartEventId":"4270","id":"13","ctxDetails":"{\"interface
com.cloud.storage.Volume\":\"9945a23b-a376-4f85-b378-9f7da8017dac\",\"interface com.cloud.storage.Snapshot\":\"82f3faf3-e09c-4eaf-886c-d81bad998b64\"}","_":"1604922798590"},
cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid:
176206389407942, completeMsid: null, lastUpdated: null, lastPolled: null, created: null, removed:
null}
> 
> 2020-11-09 12:56:46,528 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-35:ctx-326b32af
job-1894) (logid:db479fbc) Executing AsyncJobVO {id:1894, userId: 2, accountId: 2, instanceType:
Snapshot, instanceId: 13, cmd: org.apache.cloudstack.api.command.user.snapshot.CreateSnapshotCmd,
cmdInfo: {"quiescevm":"false","httpmethod":"GET","ctxAccountId":"2","uuid":"82f3faf3-e09c-4eaf-886c-d81bad998b64","cmdEventType":"SNAPSHOT.CREATE","asyncBackup":"false","response":"json","ctxUserId":"2","volumeId":"9945a23b-a376-4f85-b378-9f7da8017dac","name":"test","ctxStartEventId":"4270","id":"13","ctxDetails":"{\"interface
com.cloud.storage.Volume\":\"9945a23b-a376-4f85-b378-9f7da8017dac\",\"interface com.cloud.storage.Snapshot\":\"82f3faf3-e09c-4eaf-886c-d81bad998b64\"}","_":"1604922798590"},
cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid:
176206389407942, completeMsid: null, lastUpdated: null, lastPolled: null, created: null, removed:
null}
> 
> 2020-11-09 12:56:46,528 DEBUG [c.c.a.ApiServlet] (qtp1497845528-1209:ctx-a9fac85e ctx-7d1c63e1)
(logid:a5ddc58d) ===END===  10.89.11.31 -- GET  command=createSnapshot&response=json&volumeId=9945a23b-a376-4f85-b378-9f7da8017dac&quiescevm=false&asyncBackup=false&name=test&_=1604922798590
> 
> 2020-11-09 12:56:46,549 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-35:ctx-326b32af
job-1894 ctx-f8b08221) (logid:db479fbc) Sync job-1897 execution on object VmWorkJobQueue.183
> 
> 2020-11-09 12:56:46,850 DEBUG [c.c.a.m.ClusteredAgentAttache] (AgentManager-Handler-13:null)
(logid:) Seq 1-8981303556883622697: Routing from 176206389408022
> 
> 2020-11-09 12:56:46,851 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (AgentManager-Handler-6:null)
(logid:) Seq 1-8981303556883622697: MgmtId 176206389408022: Resp: Routing to peer
> 
> 2020-11-09 12:56:47,086 DEBUG [c.c.a.m.ClusteredAgentAttache] (AgentManager-Handler-3:null)
(logid:) Seq 43-2584503236157253953: Routing from 176206389408022
> 
> 2020-11-09 12:56:47,126 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (AgentManager-Handler-14:null)
(logid:) Seq 43-2584503236157253953: MgmtId 176206389408022: Resp: Routing to peer
> 
> 2020-11-09 12:56:47,131 DEBUG [c.c.a.m.ClusteredAgentAttache] (AgentManager-Handler-15:null)
(logid:) Seq 46-3634967849241411607: Routing from 176206389408022
> 
> 2020-11-09 12:56:47,133 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (AgentManager-Handler-10:null)
(logid:) Seq 46-3634967849241411607: MgmtId 176206389408022: Resp: Routing to peer
> 
> 2020-11-09 12:56:47,181 DEBUG [c.c.s.StatsCollector] (StatsCollector-6:ctx-100fc604)
(logid:fde56d09) StorageCollector is running...
> 
> 2020-11-09 12:56:47,184 DEBUG [c.c.h.o.r.Ovm3HypervisorGuru] (StatsCollector-6:ctx-100fc604)
(logid:fde56d09) getCommandHostDelegation: class com.cloud.agent.api.GetStorageStatsCommand
> 
> 2020-11-09 12:56:47,184 DEBUG [c.c.h.XenServerGuru] (StatsCollector-6:ctx-100fc604) (logid:fde56d09)
We are returning the default host to execute commands because the command is not of Copy type.
> 
> 2020-11-09 12:56:47,230 DEBUG [c.c.a.t.Request] (StatsCollector-6:ctx-100fc604) (logid:fde56d09)
Seq 58-4654188739910703033: Received:  { Ans: , MgmtId: 176206389407942, via: 58(s-10-VM),
Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
> 
> 2020-11-09 12:56:47,231 DEBUG [c.c.h.o.r.Ovm3HypervisorGuru] (StatsCollector-6:ctx-100fc604)
(logid:fde56d09) getCommandHostDelegation: class com.cloud.agent.api.GetStorageStatsCommand
> 
> 2020-11-09 12:56:47,231 DEBUG [c.c.h.XenServerGuru] (StatsCollector-6:ctx-100fc604) (logid:fde56d09)
We are returning the default host to execute commands because the command is not of Copy type.
> 
> 2020-11-09 12:56:47,232 DEBUG [c.c.a.m.ClusteredAgentAttache] (StatsCollector-6:ctx-100fc604)
(logid:fde56d09) Seq 37-1383449510532885592: Forwarding null to 176206389407982
> 
> 2020-11-09 12:56:47,406 DEBUG [c.c.a.ApiServlet] (qtp1497845528-1280:ctx-b087af82) (logid:3a8983a6)
===START===  10.89.11.31 -- GET  command=listInfrastructure&response=json&_=1604922838197
> 
> 2020-11-09 12:56:47,410 DEBUG [c.c.a.ApiServer] (qtp1497845528-1280:ctx-b087af82 ctx-052d26fb)
(logid:3a8983a6) CIDRs from which account 'Acct[c3dd8977-12ba-11eb-9854-a0423f44350c-admin]'
is allowed to perform API calls: 0.0.0.0/0,::/0
> 
> 2020-11-09 12:56:47,416 DEBUG [c.c.a.ApiServlet] (qtp1497845528-1280:ctx-b087af82 ctx-052d26fb)
(logid:3a8983a6) ===END===  10.89.11.31 -- GET  command=listInfrastructure&response=json&_=1604922838197
> 
> 2020-11-09 12:56:47,634 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (AsyncJobMgr-Heartbeat-1:ctx-ccb57103)
(logid:56d3b696) Execute sync-queue item: SyncQueueItemVO {id:841, queueId: 601, contentType:
AsyncJob, contentId: 1897, lastProcessMsid: 176206389407942, lastprocessNumber: 5, lastProcessTime:
Mon Nov 09 12:56:47 CET 2020, created: Mon Nov 09 12:56:46 CET 2020}
> 
> 2020-11-09 12:56:47,635 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (AsyncJobMgr-Heartbeat-1:ctx-ccb57103)
(logid:56d3b696) Schedule queued job-1897
> 
> 2020-11-09 12:56:47,637 INFO  [o.a.c.f.j.i.AsyncJobMonitor] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897) (logid:1f589139) Add job-1897 into job monitoring
> 
> 2020-11-09 12:56:47,640 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897) (logid:db479fbc) Executing AsyncJobVO {id:1897, userId: 2, accountId: 2,
instanceType: null, instanceId: null, cmd: com.cloud.vm.VmWorkTakeVolumeSnapshot, cmdInfo:
rO0ABXNyACVjb20uY2xvdWQudm0uVm1Xb3JrVGFrZVZvbHVtZVNuYXBzaG90BL5gG4Li1c8CAAZaAAthc3luY0JhY2t1cFoACXF1aWVzY2VWbUwADGxvY2F0aW9uVHlwZXQAKUxjb20vY2xvdWQvc3RvcmFnZS9TbmFwc2hvdCRMb2NhdGlvblR5cGU7TAAIcG9saWN5SWR0ABBMamF2YS9sYW5nL0xvbmc7TAAKc25hcHNob3RJZHEAfgACTAAIdm9sdW1lSWRxAH4AAnhyABNjb20uY2xvdWQudm0uVm1Xb3Jrn5m2VvAlZ2sCAARKAAlhY2NvdW50SWRKAAZ1c2VySWRKAAR2bUlkTAALaGFuZGxlck5hbWV0ABJMamF2YS9sYW5nL1N0cmluZzt4cAAAAAAAAAACAAAAAAAAAAIAAAAAAAAAt3QAFFZvbHVtZUFwaVNlcnZpY2VJbXBsAABwc3IADmphdmEubGFuZy5Mb25nO4vkkMyPI98CAAFKAAV2YWx1ZXhyABBqYXZhLmxhbmcuTnVtYmVyhqyVHQuU4IsCAAB4cAAAAAAAAAAAc3EAfgAHAAAAAAAAAA1zcQB-AAcAAAAAAAACIA,
cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid:
176206389407942, completeMsid: null, lastUpdated: null, lastPolled: null, created: Mon Nov
09 12:56:46 CET 2020, removed: null}
> 
> 2020-11-09 12:56:47,640 DEBUG [c.c.v.VmWorkJobDispatcher] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897) (logid:db479fbc) Run VM work job: com.cloud.vm.VmWorkTakeVolumeSnapshot
for VM 183, job origin: 1894
> 
> 2020-11-09 12:56:47,642 DEBUG [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897 ctx-5fb6d0f8) (logid:db479fbc) Execute VM work job: com.cloud.vm.VmWorkTakeVolumeSnapshot{"volumeId":544,"policyId":0,"snapshotId":13,"quiesceVm":false,"asyncBackup":false,"userId":2,"accountId":2,"vmId":183,"handlerName":"VolumeApiServiceImpl"}
> 
> 2020-11-09 12:56:47,675 DEBUG [c.c.h.o.r.Ovm3HypervisorGuru] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897 ctx-5fb6d0f8) (logid:db479fbc) getCommandHostDelegation: class org.apache.cloudstack.storage.command.CreateObjectCommand
> 
> 2020-11-09 12:56:47,675 DEBUG [c.c.h.XenServerGuru] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897 ctx-5fb6d0f8) (logid:db479fbc) We are returning the default host to execute
commands because the command is not of Copy type.
> 
> 2020-11-09 12:56:47,676 DEBUG [c.c.a.m.ClusteredAgentAttache] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897 ctx-5fb6d0f8) (logid:db479fbc) Seq 40-1407656358530002013: Forwarding Seq
40-1407656358530002013:  { Cmd , MgmtId: 176206389407942, via: 40(srv-oz-r08-n08.cenagis.local),
Ver: v1, Flags: 100011, [{"org.apache.cloudstack.storage.command.CreateObjectCommand":{"data":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"volume":{"uuid":"9945a23b-a376-4f85-b378-9f7da8017dac","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"22d1051a-86dc-3613-961d-f909245f5477","id":4,"poolType":"RBD","host":"rbd.cenagis.local","path":"rbd","port":6789,"url":"RBD://rbd.cenagis.local/rbd/?ROLE=Primary&STOREUUID=22d1051a-86dc-3613-961d-f909245f5477","isManaged":false}},"name":"ROOT-183","size":107374182400,"path":"9945a23b-a376-4f85-b378-9f7da8017dac","volumeId":544,"vmName":"i-2-183-VM","accountId":2,"format":"RAW","provisioningType":"THIN","id":544,"deviceId":0,"cacheMode":"WRITEBACK","hypervisorType":"KVM","directDownload":false},"dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"22d1051a-86dc-3613-961d-f909245f5477","id":4,"poolType":"RBD","host":"rbd.cenagis.local","path":"rbd","port":6789,"url":"RBD://rbd.cenagis.local/rbd/?ROLE=Primary&STOREUUID=22d1051a-86dc-3613-961d-f909245f5477","isManaged":false}},"vmName":"i-2-183-VM","name":"test","hypervisorType":"KVM","id":13,"quiescevm":false,"physicalSize":0}},"wait":0}}]
} to 176206389407982
> 
> 2020-11-09 12:56:47,976 DEBUG [c.c.a.m.ClusteredAgentAttache] (AgentManager-Handler-1:null)
(logid:) Seq 1-8603282663161211720: Routing from 176206389407982
> 
> 2020-11-09 12:56:47,982 DEBUG [c.c.a.m.ClusteredAgentAttache] (AgentManager-Handler-4:null)
(logid:) Seq 1-8981303556883622698: Routing from 176206389408022
> 
> 2020-11-09 12:56:48,043 DEBUG [c.c.c.ConsoleProxyManagerImpl] (consoleproxy-1:ctx-79a33e59)
(logid:4c5fdc64) Zone 1 is ready to launch console proxy
> 
> 2020-11-09 12:56:48,150 DEBUG [o.a.c.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-c8a78ea1)
(logid:473dea1d) Zone 1 is ready to launch secondary storage VM
> 
> 2020-11-09 12:56:48,190 DEBUG [c.c.a.t.Request] (StatsCollector-5:ctx-e6db6758) (logid:451965d6)
Seq 1-8552617167353293650: Received:  { Ans: , MgmtId: 176206389407942, via: 1(srv-oz-r01-n01.cenagis.local),
Ver: v1, Flags: 10, { GetVmStatsAnswer } }
> 
> 2020-11-09 12:56:48,190 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (AgentManager-Handler-5:null)
(logid:) Seq 1-8603282663161211720: MgmtId 176206389407982: Resp: Routing to peer
> 
> 2020-11-09 12:56:48,198 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (AgentManager-Handler-11:null)
(logid:) Seq 1-8981303556883622698: MgmtId 176206389408022: Resp: Routing to peer
> 
> 2020-11-09 12:56:48,212 DEBUG [c.c.a.t.Request] (AgentManager-Handler-12:null) (logid:)
Seq 40-1407656358530002013: Processing:  { Ans: , MgmtId: 176206389407942, via: 40, Ver: v1,
Flags: 10, [{"org.apache.cloudstack.storage.command.CreateObjectAnswer":{"data":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":"rbd/9945a23b-a376-4f85-b378-9f7da8017dac/f957d3a8-702a-45aa-9e42-5222c223ef19","id":0,"quiescevm":false,"physicalSize":0}},"result":true,"wait":0}}]
}
> 
> 2020-11-09 12:56:48,212 DEBUG [c.c.a.t.Request] (Work-Job-Executor-26:ctx-15ef9a01 job-1894/job-1897
ctx-5fb6d0f8) (logid:db479fbc) Seq 40-1407656358530002013: Received:  { Ans: , MgmtId: 176206389407942,
via: 40(srv-oz-r08-n08.cenagis.local), Ver: v1, Flags: 10, { CreateObjectAnswer } }
> 
> 2020-11-09 12:56:48,226 DEBUG [c.c.a.m.ClusteredAgentAttache] (StatsCollector-5:ctx-e6db6758)
(logid:451965d6) Seq 22-6063533948300963066: Forwarding null to 176206389407982
> 
> 2020-11-09 12:56:48,248 DEBUG [o.a.c.s.m.AncientDataMotionStrategy] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897 ctx-5fb6d0f8) (logid:db479fbc) copyAsync inspecting src type SNAPSHOT copyAsync
inspecting dest type SNAPSHOT
> 
> 2020-11-09 12:56:48,249 DEBUG [c.c.a.ApiServlet] (qtp1497845528-1209:ctx-4e81cf12) (logid:2f3c90fe)
===START===  10.89.11.31 -- GET  command=listHosts&response=json&type=routing&listAll=true&page=1&pagesize=20&_=1604922838198
> 
> 2020-11-09 12:56:48,253 DEBUG [c.c.a.ApiServer] (qtp1497845528-1209:ctx-4e81cf12 ctx-0b68411a)
(logid:2f3c90fe) CIDRs from which account 'Acct[c3dd8977-12ba-11eb-9854-a0423f44350c-admin]'
is allowed to perform API calls: 0.0.0.0/0,::/0
> 
> 2020-11-09 12:56:48,254 WARN  [c.c.a.d.ParamGenericValidationWorker] (qtp1497845528-1209:ctx-4e81cf12
ctx-0b68411a) (logid:2f3c90fe) Received unknown parameters for command listHosts. Unknown
parameters : listall
> 
> 2020-11-09 12:56:48,254 DEBUG [c.c.a.q.QueryManagerImpl] (qtp1497845528-1209:ctx-4e81cf12
ctx-0b68411a) (logid:2f3c90fe) >>>Searching for hosts>>>
> 
> 2020-11-09 12:56:48,259 DEBUG [c.c.a.q.QueryManagerImpl] (qtp1497845528-1209:ctx-4e81cf12
ctx-0b68411a) (logid:2f3c90fe) >>>Generating Response>>>
> 
> 2020-11-09 12:56:48,293 DEBUG [c.c.a.ApiServlet] (qtp1497845528-1209:ctx-4e81cf12 ctx-0b68411a)
(logid:2f3c90fe) ===END===  10.89.11.31 -- GET  command=listHosts&response=json&type=routing&listAll=true&page=1&pagesize=20&_=1604922838198
> 
> 2020-11-09 12:56:48,298 ERROR [o.a.c.s.e.DefaultEndPointSelector] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897 ctx-5fb6d0f8) (logid:db479fbc) IR24 select BACKUPSNAPSHOT from primary to
secondary 13 dest=13
> 
> 2020-11-09 12:56:48,302 DEBUG [c.c.h.o.r.Ovm3HypervisorGuru] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897 ctx-5fb6d0f8) (logid:db479fbc) getCommandHostDelegation: class org.apache.cloudstack.storage.command.CopyCommand
> 
> 2020-11-09 12:56:48,303 DEBUG [c.c.a.m.ClusteredAgentAttache] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897 ctx-5fb6d0f8) (logid:db479fbc) Seq 49-6537256334104996965: Forwarding Seq
49-6537256334104996965:  { Cmd , MgmtId: 176206389407942, via: 49(srv-oz-r11-n11.cenagis.local),
Ver: v1, Flags: 100011, [{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":"rbd/9945a23b-a376-4f85-b378-9f7da8017dac/f957d3a8-702a-45aa-9e42-5222c223ef19","volume":{"uuid":"9945a23b-a376-4f85-b378-9f7da8017dac","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"22d1051a-86dc-3613-961d-f909245f5477","id":4,"poolType":"RBD","host":"rbd.cenagis.local","path":"rbd","port":6789,"url":"RBD://rbd.cenagis.local/rbd/?ROLE=Primary&STOREUUID=22d1051a-86dc-3613-961d-f909245f5477","isManaged":false}},"name":"ROOT-183","size":107374182400,"path":"9945a23b-a376-4f85-b378-9f7da8017dac","volumeId":544,"vmName":"i-2-183-VM","accountId":2,"format":"RAW","provisioningType":"THIN","id":544,"deviceId":0,"cacheMode":"WRITEBACK","hypervisorType":"KVM","directDownload":false},"dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"22d1051a-86dc-3613-961d-f909245f5477","id":4,"poolType":"RBD","host":"rbd.cenagis.local","path":"rbd","port":6789,"url":"RBD://rbd.cenagis.local/rbd/?ROLE=Primary&STOREUUID=22d1051a-86dc-3613-961d-f909245f5477","isManaged":false}},"vmName":"i-2-183-VM","name":"test","hypervisorType":"KVM","id":13,"quiescevm":false,"physicalSize":0}},"destTO":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":"snapshots/2/544","volume":{"uuid":"9945a23b-a376-4f85-b378-9f7da8017dac","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"22d1051a-86dc-3613-961d-f909245f5477","id":4,"poolType":"RBD","host":"rbd.cenagis.local","path":"rbd","port":6789,"url":"RBD://rbd.cenagis.local/rbd/?ROLE=Primary&STOREUUID=22d1051a-86dc-3613-961d-f909245f5477","isManaged":false}},"name":"ROOT-183","size":107374182400,"path":"9945a23b-a376-4f85-b378-9f7da8017dac","volumeId":544,"vmName":"i-2-183-VM","accountId":2,"format":"RAW","provisioningType":"THIN","id":544,"deviceId":0,"cacheMode":"WRITEBACK","hypervisorType":"KVM","directDownload":false},"dataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://sys2.cenagis.local/","_role":"Image"}},"vmName":"i-2-183-VM","name":"test","hypervisorType":"KVM","id":13,"quiescevm":false,"physicalSize":0}},"executeInSequence":false,"options":{"fullSnapshot":"true"},"options2":{},"wait":216000}}]
} to 176206389407982
> 
> 2020-11-09 12:56:48,364 DEBUG [c.c.a.t.Request] (AgentManager-Handler-7:null) (logid:)
Seq 49-6537256334104996965: Processing:  { Ans: , MgmtId: 176206389407942, via: 49, Ver: v1,
Flags: 10, [{"org.apache.cloudstack.storage.command.CopyCmdAnswer":{"result":false,"details":"com.cloud.utils.exception.CloudRuntimeException:
org.libvirt.LibvirtException: XML error: missing storage pool source path","wait":0}}] }
> 
> 2020-11-09 12:56:48,364 DEBUG [c.c.a.t.Request] (Work-Job-Executor-26:ctx-15ef9a01 job-1894/job-1897
ctx-5fb6d0f8) (logid:db479fbc) Seq 49-6537256334104996965: Received:  { Ans: , MgmtId: 176206389407942,
via: 49(srv-oz-r11-n11.cenagis.local), Ver: v1, Flags: 10, { CopyCmdAnswer } }
> 
> 2020-11-09 12:56:48,373 DEBUG [c.c.s.s.SnapshotManagerImpl] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897 ctx-5fb6d0f8) (logid:db479fbc) Failed to create snapshotcom.cloud.utils.exception.CloudRuntimeException:
org.libvirt.LibvirtException: XML error: missing storage pool source path
> 
> 2020-11-09 12:56:48,373 DEBUG [c.c.r.ResourceLimitManagerImpl] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897 ctx-5fb6d0f8) (logid:db479fbc) Updating resource Type = snapshot count for
Account = 2 Operation = decreasing Amount = 1
> 
> 2020-11-09 12:56:48,375 DEBUG [c.c.r.ResourceLimitManagerImpl] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897 ctx-5fb6d0f8) (logid:db479fbc) Updating resource Type = secondary_storage
count for Account = 2 Operation = decreasing Amount = 107374182400
> 
> 2020-11-09 12:56:48,377 ERROR [o.a.c.s.v.VolumeServiceImpl] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897 ctx-5fb6d0f8) (logid:db479fbc) Take snapshot: 544 failed
> 
> com.cloud.utils.exception.CloudRuntimeException: com.cloud.utils.exception.CloudRuntimeException:
org.libvirt.LibvirtException: XML error: missing storage pool source path
> 
>        at org.apache.cloudstack.storage.snapshot.SnapshotServiceImpl.backupSnapshot(SnapshotServiceImpl.java:301)
> 
>        at org.apache.cloudstack.storage.snapshot.DefaultSnapshotStrategy.backupSnapshot(DefaultSnapshotStrategy.java:171)
> 
>        at com.cloud.storage.snapshot.SnapshotManagerImpl.backupSnapshotToSecondary(SnapshotManagerImpl.java:1213)
> 
>        at com.cloud.storage.snapshot.SnapshotManagerImpl.takeSnapshot(SnapshotManagerImpl.java:1164)
> 
>        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> 
>        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> 
>        at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> 
>        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
> 
>        at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:344)
> 
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:198)
> 
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:163)
> 
>        at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:95)
> 
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:186)
> 
>        at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:212)
> 
>        at com.sun.proxy.$Proxy205.takeSnapshot(Unknown Source)
> 
>        at org.apache.cloudstack.storage.volume.VolumeServiceImpl.takeSnapshot(VolumeServiceImpl.java:2073)
> 
>        at com.cloud.storage.VolumeApiServiceImpl.orchestrateTakeVolumeSnapshot(VolumeApiServiceImpl.java:2541)
> 
>        at com.cloud.storage.VolumeApiServiceImpl.orchestrateTakeVolumeSnapshot(VolumeApiServiceImpl.java:3465)
> 
>        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> 
>        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> 
>        at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> 
>        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
> 
>        at com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107)
> 
>        at com.cloud.storage.VolumeApiServiceImpl.handleVmWorkJob(VolumeApiServiceImpl.java:3471)
> 
>        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> 
>        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> 
>        at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> 
>        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
> 
>        at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:344)
> 
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:198)
> 
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:163)
> 
>        at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:95)
> 
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:186)
> 
>        at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:212)
> 
>        at com.sun.proxy.$Proxy212.handleVmWorkJob(Unknown Source)
> 
>        at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:102)
> 
>        at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:603)
> 
>        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:551)
> 
>        at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
> 
>        at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
> 
>        at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
> 
>        at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
> 
>        at java.base/java.lang.Thread.run(Thread.java:834)
> 
> 2020-11-09 12:56:48,378 ERROR [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897 ctx-5fb6d0f8) (logid:db479fbc) Invocation exception, caused by: com.cloud.utils.exception.CloudRuntimeException:
com.cloud.utils.exception.CloudRuntimeException: org.libvirt.LibvirtException: XML error:
missing storage pool source path
> 
> 2020-11-09 12:56:48,378 INFO  [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897 ctx-5fb6d0f8) (logid:db479fbc) Rethrow exception com.cloud.utils.exception.CloudRuntimeException:
com.cloud.utils.exception.CloudRuntimeException: org.libvirt.LibvirtException: XML error:
missing storage pool source path
> 
> 2020-11-09 12:56:48,378 DEBUG [c.c.v.VmWorkJobDispatcher] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897) (logid:db479fbc) Done with run of VM work job: com.cloud.vm.VmWorkTakeVolumeSnapshot
for VM 183, job origin: 1894
> 
> 2020-11-09 12:56:48,378 ERROR [c.c.v.VmWorkJobDispatcher] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897) (logid:db479fbc) Unable to complete AsyncJobVO {id:1897, userId: 2, accountId:
2, instanceType: null, instanceId: null, cmd: com.cloud.vm.VmWorkTakeVolumeSnapshot, cmdInfo:
rO0ABXNyACVjb20uY2xvdWQudm0uVm1Xb3JrVGFrZVZvbHVtZVNuYXBzaG90BL5gG4Li1c8CAAZaAAthc3luY0JhY2t1cFoACXF1aWVzY2VWbUwADGxvY2F0aW9uVHlwZXQAKUxjb20vY2xvdWQvc3RvcmFnZS9TbmFwc2hvdCRMb2NhdGlvblR5cGU7TAAIcG9saWN5SWR0ABBMamF2YS9sYW5nL0xvbmc7TAAKc25hcHNob3RJZHEAfgACTAAIdm9sdW1lSWRxAH4AAnhyABNjb20uY2xvdWQudm0uVm1Xb3Jrn5m2VvAlZ2sCAARKAAlhY2NvdW50SWRKAAZ1c2VySWRKAAR2bUlkTAALaGFuZGxlck5hbWV0ABJMamF2YS9sYW5nL1N0cmluZzt4cAAAAAAAAAACAAAAAAAAAAIAAAAAAAAAt3QAFFZvbHVtZUFwaVNlcnZpY2VJbXBsAABwc3IADmphdmEubGFuZy5Mb25nO4vkkMyPI98CAAFKAAV2YWx1ZXhyABBqYXZhLmxhbmcuTnVtYmVyhqyVHQuU4IsCAAB4cAAAAAAAAAAAc3EAfgAHAAAAAAAAAA1zcQB-AAcAAAAAAAACIA,
cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid:
176206389407942, completeMsid: null, lastUpdated: null, lastPolled: null, created: Mon Nov
09 12:56:46 CET 2020, removed: null}, job origin:1894
> 
> com.cloud.utils.exception.CloudRuntimeException: com.cloud.utils.exception.CloudRuntimeException:
org.libvirt.LibvirtException: XML error: missing storage pool source path
> 
>        at org.apache.cloudstack.storage.snapshot.SnapshotServiceImpl.backupSnapshot(SnapshotServiceImpl.java:301)
> 
>        at org.apache.cloudstack.storage.snapshot.DefaultSnapshotStrategy.backupSnapshot(DefaultSnapshotStrategy.java:171)
> 
>        at com.cloud.storage.snapshot.SnapshotManagerImpl.backupSnapshotToSecondary(SnapshotManagerImpl.java:1213)
> 
>        at com.cloud.storage.snapshot.SnapshotManagerImpl.takeSnapshot(SnapshotManagerImpl.java:1164)
> 
>        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> 
>        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> 
>        at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> 
>        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
> 
>        at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:344)
> 
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:198)
> 
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:163)
> 
>        at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:95)
> 
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:186)
> 
>        at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:212)
> 
>        at com.sun.proxy.$Proxy205.takeSnapshot(Unknown Source)
> 
>        at org.apache.cloudstack.storage.volume.VolumeServiceImpl.takeSnapshot(VolumeServiceImpl.java:2073)
> 
>        at com.cloud.storage.VolumeApiServiceImpl.orchestrateTakeVolumeSnapshot(VolumeApiServiceImpl.java:2541)
> 
>        at com.cloud.storage.VolumeApiServiceImpl.orchestrateTakeVolumeSnapshot(VolumeApiServiceImpl.java:3465)
> 
>        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> 
>        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> 
>        at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> 
>        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
> 
>        at com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107)
> 
>        at com.cloud.storage.VolumeApiServiceImpl.handleVmWorkJob(VolumeApiServiceImpl.java:3471)
> 
>        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> 
>        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> 
>        at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> 
>        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
> 
>        at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:344)
> 
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:198)
> 
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:163)
> 
>        at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:95)
> 
>        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:186)
> 
>        at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:212)
> 
>        at com.sun.proxy.$Proxy212.handleVmWorkJob(Unknown Source)
> 
>        at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:102)
> 
>        at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:603)
> 
>        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:551)
> 
>        at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
> 
>        at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
> 
>        at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
> 
>        at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
> 
>        at java.base/java.lang.Thread.run(Thread.java:834)
> 
> 2020-11-09 12:56:48,380 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897) (logid:db479fbc) Complete async job-1897, jobStatus: FAILED, resultCode:
0, result: rO0ABXNyAC9jb20uY2xvdWQudXRpbHMuZXhjZXB0aW9uLkNsb3VkUnVudGltZUV4Y2VwdGlvbgAAAABWTU9yAwABSQALY3NFcnJvckNvZGV4cgAaamF2YS5sYW5nLlJ1bnRpbWVFeGNlcHRpb26eXwZHCjSD5QIAAHhyABNqYXZhLmxhbmcuRXhjZXB0aW9u0P0fPho7HMQCAAB4cgATamF2YS5sYW5nLlRocm93YWJsZdXGNSc5d7jLAwAETAAFY2F1c2V0ABVMamF2YS9sYW5nL1Rocm93YWJsZTtMAA1kZXRhaWxNZXNzYWdldAASTGphdmEvbGFuZy9TdHJpbmc7WwAKc3RhY2tUcmFjZXQAHltMamF2YS9sYW5nL1N0YWNrVHJhY2VFbGVtZW50O0wAFHN1cHByZXNzZWRFeGNlcHRpb25zdAAQTGphdmEvdXRpbC9MaXN0O3hwcQB-AAh0AHpjb20uY2xvdWQudXRpbHMuZXhjZXB0aW9uLkNsb3VkUnVudGltZUV4Y2VwdGlvbjogb3JnLmxpYnZpcnQuTGlidmlydEV4Y2VwdGlvbjogWE1MIGVycm9yOiBtaXNzaW5nIHN0b3JhZ2UgcG9vbCBzb3VyY2UgcGF0aHVyAB5bTGphdmEubGFuZy5TdGFja1RyYWNlRWxlbWVudDsCRio8PP0iOQIAAHhwAAAAMHNyABtqYXZhLmxhbmcuU3RhY2tUcmFjZUVsZW1lbnRhCcWaJjbdhQIACEIABmZvcm1hdEkACmxpbmVOdW1iZXJMAA9jbGFzc0xvYWRlck5hbWVxAH4ABUwADmRlY2xhcmluZ0NsYXNzcQB-AAVMAAhmaWxlTmFtZXEAfgAFTAAKbWV0aG9kTmFtZXEAfgAFTAAKbW9kdWxlTmFtZXEAfgAFTAANbW9kdWxlVmVyc2lvbnEAfgAFeHABAAABLXQAA2FwcHQAOm9yZy5hcGFjaGUuY2xvdWRzdGFjay5zdG9yYWdlLnNuYXBzaG90LlNuYXBzaG90U2VydmljZUltcGx0ABhTbmFwc2hvdFNlcnZpY2VJbXBsLmphdmF0AA5iYWNrdXBTbmFwc2hvdHBwc3EAfgAMAQAAAKtxAH4ADnQAPm9yZy5hcGFjaGUuY2xvdWRzdGFjay5zdG9yYWdlLnNuYXBzaG90LkRlZmF1bHRTbmFwc2hvdFN0cmF0ZWd5dAAcRGVmYXVsdFNuYXBzaG90U3RyYXRlZ3kuamF2YXEAfgARcHBzcQB-AAwBAAAEvXEAfgAOdAAuY29tLmNsb3VkLnN0b3JhZ2Uuc25hcHNob3QuU25hcHNob3RNYW5hZ2VySW1wbHQAGFNuYXBzaG90TWFuYWdlckltcGwuamF2YXQAGWJhY2t1cFNuYXBzaG90VG9TZWNvbmRhcnlwcHNxAH4ADAEAAASMcQB-AA5xAH4AFnEAfgAXdAAMdGFrZVNuYXBzaG90cHBzcQB-AAwC_____nB0AC1qZGsuaW50ZXJuYWwucmVmbGVjdC5OYXRpdmVNZXRob2RBY2Nlc3NvckltcGx0AB1OYXRpdmVNZXRob2RBY2Nlc3NvckltcGwuamF2YXQAB2ludm9rZTB0AAlqYXZhLmJhc2V0AAYxMS4wLjhzcQB-AAwCAAAAPnBxAH4AHHEAfgAddAAGaW52b2tlcQB-AB9xAH4AIHNxAH4ADAIAAAArcHQAMWpkay5pbnRlcm5hbC5yZWZsZWN0LkRlbGVnYXRpbmdNZXRob2RBY2Nlc3NvckltcGx0ACFEZWxlZ2F0aW5nTWV0aG9kQWNjZXNzb3JJbXBsLmphdmFxAH4AInEAfgAfcQB-ACBzcQB-AAwCAAACNnB0ABhqYXZhLmxhbmcucmVmbGVjdC5NZXRob2R0AAtNZXRob2QuamF2YXEAfgAicQB-AB9xAH4AIHNxAH4ADAEAAAFYcQB-AA50AChvcmcuc3ByaW5nZnJhbWV3b3JrLmFvcC5zdXBwb3J0LkFvcFV0aWxzdAANQW9wVXRpbHMuamF2YXQAHmludm9rZUpvaW5wb2ludFVzaW5nUmVmbGVjdGlvbnBwc3EAfgAMAQAAAMZxAH4ADnQAPG9yZy5zcHJpbmdmcmFtZXdvcmsuYW9wLmZyYW1ld29yay5SZWZsZWN0aXZlTWV0aG9kSW52b2NhdGlvbnQAH1JlZmxlY3RpdmVNZXRob2RJbnZvY2F0aW9uLmphdmF0AA9pbnZva2VKb2lucG9pbnRwcHNxAH4ADAEAAACjcQB-AA5xAH4ALnEAfgAvdAAHcHJvY2VlZHBwc3EAfgAMAQAAAF9xAH4ADnQAP29yZy5zcHJpbmdmcmFtZXdvcmsuYW9wLmludGVyY2VwdG9yLkV4cG9zZUludm9jYXRpb25JbnRlcmNlcHRvcnQAIEV4cG9zZUludm9jYXRpb25JbnRlcmNlcHRvci5qYXZhcQB-ACJwcHNxAH4ADAEAAAC6cQB-AA5xAH4ALnEAfgAvcQB-ADJwcHNxAH4ADAEAAADUcQB-AA50ADRvcmcuc3ByaW5nZnJhbWV3b3JrLmFvcC5mcmFtZXdvcmsuSmRrRHluYW1pY0FvcFByb3h5dAAXSmRrRHluYW1pY0FvcFByb3h5LmphdmFxAH4AInBwc3EAfgAMAP____9wdAAXY29tLnN1bi5wcm94eS4kUHJveHkyMDVwcQB-ABpwcHNxAH4ADAEAAAgZcQB-AA50ADZvcmcuYXBhY2hlLmNsb3Vkc3RhY2suc3RvcmFnZS52b2x1bWUuVm9sdW1lU2VydmljZUltcGx0ABZWb2x1bWVTZXJ2aWNlSW1wbC5qYXZhcQB-ABpwcHNxAH4ADAEAAAntcQB-AA50ACZjb20uY2xvdWQuc3RvcmFnZS5Wb2x1bWVBcGlTZXJ2aWNlSW1wbHQAGVZvbHVtZUFwaVNlcnZpY2VJbXBsLmphdmF0AB1vcmNoZXN0cmF0ZVRha2VWb2x1bWVTbmFwc2hvdHBwc3EAfgAMAQAADYlxAH4ADnEAfgBAcQB-AEFxAH4AQnBwc3EAfgAMAv____5wcQB-ABxxAH4AHXEAfgAecQB-AB9xAH4AIHNxAH4ADAIAAAA-cHEAfgAccQB-AB1xAH4AInEAfgAfcQB-ACBzcQB-AAwCAAAAK3BxAH4AJHEAfgAlcQB-ACJxAH4AH3EAfgAgc3EAfgAMAgAAAjZwcQB-ACdxAH4AKHEAfgAicQB-AB9xAH4AIHNxAH4ADAEAAABrcQB-AA50ACJjb20uY2xvdWQudm0uVm1Xb3JrSm9iSGFuZGxlclByb3h5dAAaVm1Xb3JrSm9iSGFuZGxlclByb3h5LmphdmF0AA9oYW5kbGVWbVdvcmtKb2JwcHNxAH4ADAEAAA2PcQB-AA5xAH4AQHEAfgBBcQB-AEtwcHNxAH4ADAL____-cHEAfgAccQB-AB1xAH4AHnEAfgAfcQB-ACBzcQB-AAwCAAAAPnBxAH4AHHEAfgAdcQB-ACJxAH4AH3EAfgAgc3EAfgAMAgAAACtwcQB-ACRxAH4AJXEAfgAicQB-AB9xAH4AIHNxAH4ADAIAAAI2cHEAfgAncQB-AChxAH4AInEAfgAfcQB-ACBzcQB-AAwBAAABWHEAfgAOcQB-ACpxAH4AK3EAfgAscHBzcQB-AAwBAAAAxnEAfgAOcQB-AC5xAH4AL3EAfgAwcHBzcQB-AAwBAAAAo3EAfgAOcQB-AC5xAH4AL3EAfgAycHBzcQB-AAwBAAAAX3EAfgAOcQB-ADRxAH4ANXEAfgAicHBzcQB-AAwBAAAAunEAfgAOcQB-AC5xAH4AL3EAfgAycHBzcQB-AAwBAAAA1HEAfgAOcQB-ADhxAH4AOXEAfgAicHBzcQB-AAwA_____3B0ABdjb20uc3VuLnByb3h5LiRQcm94eTIxMnBxAH4AS3Bwc3EAfgAMAQAAAGZxAH4ADnQAIGNvbS5jbG91ZC52bS5WbVdvcmtKb2JEaXNwYXRjaGVydAAYVm1Xb3JrSm9iRGlzcGF0Y2hlci5qYXZhdAAGcnVuSm9icHBzcQB-AAwBAAACW3EAfgAOdAA_b3JnLmFwYWNoZS5jbG91ZHN0YWNrLmZyYW1ld29yay5qb2JzLmltcGwuQXN5bmNKb2JNYW5hZ2VySW1wbCQ1dAAYQXN5bmNKb2JNYW5hZ2VySW1wbC5qYXZhdAAMcnVuSW5Db250ZXh0cHBzcQB-AAwBAAAAMXEAfgAOdAA-b3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5NYW5hZ2VkQ29udGV4dFJ1bm5hYmxlJDF0ABtNYW5hZ2VkQ29udGV4dFJ1bm5hYmxlLmphdmF0AANydW5wcHNxAH4ADAEAAAA4cQB-AA50AEJvcmcuYXBhY2hlLmNsb3Vkc3RhY2subWFuYWdlZC5jb250ZXh0LmltcGwuRGVmYXVsdE1hbmFnZWRDb250ZXh0JDF0ABpEZWZhdWx0TWFuYWdlZENvbnRleHQuamF2YXQABGNhbGxwcHNxAH4ADAEAAABncQB-AA50AEBvcmcuYXBhY2hlLmNsb3Vkc3RhY2subWFuYWdlZC5jb250ZXh0LmltcGwuRGVmYXVsdE1hbmFnZWRDb250ZXh0cQB-AGd0AA9jYWxsV2l0aENvbnRleHRwcHNxAH4ADAEAAAA1cQB-AA5xAH4AanEAfgBndAAOcnVuV2l0aENvbnRleHRwcHNxAH4ADAEAAAAucQB-AA50ADxvcmcuYXBhY2hlLmNsb3Vkc3RhY2subWFuYWdlZC5jb250ZXh0Lk1hbmFnZWRDb250ZXh0UnVubmFibGVxAH4AY3EAfgBkcHBzcQB-AAwBAAACJ3EAfgAOcQB-AF5xAH4AX3EAfgBkcHBzcQB-AAwCAAACA3B0AC5qYXZhLnV0aWwuY29uY3VycmVudC5FeGVjdXRvcnMkUnVubmFibGVBZGFwdGVydAAORXhlY3V0b3JzLmphdmFxAH4AaHEAfgAfcQB-ACBzcQB-AAwCAAABCHB0AB9qYXZhLnV0aWwuY29uY3VycmVudC5GdXR1cmVUYXNrdAAPRnV0dXJlVGFzay5qYXZhcQB-AGRxAH4AH3EAfgAgc3EAfgAMAgAABGhwdAAnamF2YS51dGlsLmNvbmN1cnJlbnQuVGhyZWFkUG9vbEV4ZWN1dG9ydAAXVGhyZWFkUG9vbEV4ZWN1dG9yLmphdmF0AAlydW5Xb3JrZXJxAH4AH3EAfgAgc3EAfgAMAgAAAnRwdAAuamF2YS51dGlsLmNvbmN1cnJlbnQuVGhyZWFkUG9vbEV4ZWN1dG9yJFdvcmtlcnEAfgB5cQB-AGRxAH4AH3EAfgAgc3EAfgAMAgAAA0JwdAAQamF2YS5sYW5nLlRocmVhZHQAC1RocmVhZC5qYXZhcQB-AGRxAH4AH3EAfgAgc3IAH2phdmEudXRpbC5Db2xsZWN0aW9ucyRFbXB0eUxpc3R6uBe0PKee3gIAAHhweAAAEJp3CAAAAAAAAAAAeA
> 
> 2020-11-09 12:56:48,380 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897) (logid:db479fbc) Publish async job-1897 complete on message bus
> 
> 2020-11-09 12:56:48,380 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897) (logid:db479fbc) Wake up jobs related to job-1897
> 
> 2020-11-09 12:56:48,380 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897) (logid:db479fbc) Update db status for job-1897
> 
> 2020-11-09 12:56:48,381 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897) (logid:db479fbc) Wake up jobs joined with job-1897 and disjoin all subjobs
created from job- 1897
> 
> 2020-11-09 12:56:48,385 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897) (logid:db479fbc) Done executing com.cloud.vm.VmWorkTakeVolumeSnapshot for
job-1897
> 
> 2020-11-09 12:56:48,385 INFO  [o.a.c.f.j.i.AsyncJobMonitor] (Work-Job-Executor-26:ctx-15ef9a01
job-1894/job-1897) (logid:db479fbc) Remove job-1897 from job monitoring
> 
> 2020-11-09 12:56:48,392 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-35:ctx-326b32af
job-1894) (logid:db479fbc) Complete async job-1894, 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 9945a23b-a376-4f85-b378-9f7da8017dac"}
> 
> 2020-11-09 12:56:48,392 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-35:ctx-326b32af
job-1894) (logid:db479fbc) Publish async job-1894 complete on message bus
> 


Mime
View raw message