Github user nathanejohnson commented on the issue:
https://github.com/apache/cloudstack/pull/1644
Here is a snippet of the logs with storage.snapshot.backup.rightafter set
to false.
```2016-08-17 15:34:38,530 DEBUG [c.c.a.ApiServlet]
(catalina-exec-22:ctx-b9fb719f) (logid:389a008f) ===START=== 10.16.0.21 -- GET
command=createSnapshot&response=json&volumeId=c02b4f35-aed4-4c23-bbc3-b5c36615fa85
&quiescevm=false&name=testsnap&_=1471466078445
2016-08-17 15:34:39,907 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
(catalina-exec-22:ctx-b9fb719f ctx-d879986a) (logid:389a008f) submit async
job-2361, details: AsyncJobVO {id:2361, userId: 2, accountId: 2, instance
Type: Snapshot, instanceId: 21, cmd:
org.apache.cloudstack.api.command.user.snapshot.CreateSnapshotCmd, cmdInfo:
{"id":"21","response":"json","ctxDetails":"{\"interface
com.cloud.storage.Volume\":\"c02b4f35-aed4-
4c23-bbc3-b5c36615fa85\",\"interface
com.cloud.storage.Snapshot\":\"db19bec0-60e0-497b-879e-08ee89c3266a\"}","cmdEventType":"SNAPSHOT.CREATE","ctxUserId":"2","volumeId":"c02b4f35-aed4-4c23-bbc3-b5c36615fa85","nam
e":"testsnap","httpmethod":"GET","quiescevm":"false","_":"1471466078445","uuid":"db19bec0-60e0-497b-879e-08ee89c3266a","ctxAccountId":"2","ctxStartEventId":"5444"},
cmdVersion: 0, status: IN_PROGRESS, processStat
us: 0, resultCode: 0, result: null, initMsid: 52239507206, completeMsid:
null, lastUpdated: null, lastPolled: null, created: null}
2016-08-17 15:34:39,908 INFO [o.a.c.f.j.i.AsyncJobMonitor]
(API-Job-Executor-85:ctx-33ba3569 job-2361) (logid:abb822e7) Add job-2361 into
job monitoring
2016-08-17 15:34:39,911 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
(API-Job-Executor-85:ctx-33ba3569 job-2361) (logid:b56de38a) Executing
AsyncJobVO {id:2361, userId: 2, accountId: 2, instanceType: Snapshot, instanc
eId: 21, cmd:
org.apache.cloudstack.api.command.user.snapshot.CreateSnapshotCmd, cmdInfo:
{"id":"21","response":"json","ctxDetails":"{\"interface
com.cloud.storage.Volume\":\"c02b4f35-aed4-4c23-bbc3-b5c36615fa85\
",\"interface
com.cloud.storage.Snapshot\":\"db19bec0-60e0-497b-879e-08ee89c3266a\"}","cmdEventType":"SNAPSHOT.CREATE","ctxUserId":"2","volumeId":"c02b4f35-aed4-4c23-bbc3-b5c36615fa85","name":"testsnap","httpmeth
od":"GET","quiescevm":"false","_":"1471466078445","uuid":"db19bec0-60e0-497b-879e-08ee89c3266a","ctxAccountId":"2","ctxStartEventId":"5444"},
cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, r
esult: null, initMsid: 52239507206, completeMsid: null, lastUpdated: null,
lastPolled: null, created: null}
2016-08-17 15:34:39,919 DEBUG [c.c.a.ApiServlet]
(catalina-exec-22:ctx-b9fb719f ctx-d879986a) (logid:389a008f) ===END===
10.16.0.21 -- GET
command=createSnapshot&response=json&volumeId=c02b4f35-aed4-4c23-bbc3-b
5c36615fa85&quiescevm=false&name=testsnap&_=1471466078445
2016-08-17 15:34:39,922 INFO [o.a.c.a.c.u.s.CreateSnapshotCmd]
(API-Job-Executor-85:ctx-33ba3569 job-2361 ctx-1d14d077) (logid:b56de38a)
VOLSS: createSnapshotCmd starts:1471466079922
2016-08-17 15:34:39,976 DEBUG [o.a.c.s.d.ObjectInDataStoreManagerImpl]
(API-Job-Executor-85:ctx-33ba3569 job-2361 ctx-1d14d077) (logid:b56de38a) find
inconsistent db for snapshot 20
2016-08-17 15:34:40,017 DEBUG [c.c.h.o.r.Ovm3HypervisorGuru]
(API-Job-Executor-85:ctx-33ba3569 job-2361 ctx-1d14d077) (logid:b56de38a)
getCommandHostDelegation: class org.apache.cloudstack.storage.command.CreateO
bjectCommand
2016-08-17 15:34:40,017 DEBUG [c.c.h.XenServerGuru]
(API-Job-Executor-85:ctx-33ba3569 job-2361 ctx-1d14d077) (logid:b56de38a)
getCommandHostDelegation: class
org.apache.cloudstack.storage.command.CreateObjectComm
and
2016-08-17 15:34:40,019 DEBUG [c.c.a.t.Request]
(API-Job-Executor-85:ctx-33ba3569 job-2361 ctx-1d14d077) (logid:b56de38a) Seq
1-4906671794020407360: Sending { Cmd , MgmtId: 52239507206, via:
1(njcloudhost.dev.en
a.net), Ver: v1, Flags: 100011,
[{"org.apache.cloudstack.storage.command.CreateObjectCommand":{"data":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"volume":{"uuid":"c02b4f35-aed4-4c23-bbc3-b5c36615fa85",
"volumeType":"DATADISK","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"282d5a88-b298-39b9-bd65-aafb088270c2","id":3,"poolType":"RBD","host":"ceph-mon.labs.ena.net","path":"rbdnjcloudh
ost","port":6789,"url":"RBD://ceph-mon.labs.ena.net/rbdnjcloudhost/?ROLE=Primary&STOREUUID=282d5a88-b298-39b9-bd65-aafb088270c2"}},"name":"1111","size":171798691840,"path":"c02b4f35-aed4-4c23-bbc3-b5c36615fa85","
volumeId":187,"accountId":10,"format":"RAW","provisioningType":"THIN","id":187,"bytesReadRate":83886080,"bytesWriteRate":83886080,"iopsReadRate":80,"iopsWriteRate":80,"hypervisorType":"KVM"},"dataStore":{"org.apa
che.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"282d5a88-b298-39b9-bd65-aafb088270c2","id":3,"poolType":"RBD","host":"ceph-mon.labs.e
na.net","path":"rbdnjcloudhost","port":6789,"url":"RBD://ceph-mon.labs.ena.net/rbdnjcloudhost/?ROLE=Primary&STOREUUID=282d5a88-b298-39b9-bd65-aafb088270c2"}},"name":"testsnap","hypervisorType":"KVM","id":21,"quiescevm":false,"physicalSize":0}},"wait":0}}]
}
2016-08-17 15:34:41,187 DEBUG [c.c.a.t.Request]
(AgentManager-Handler-8:null) (logid:) Seq 1-4906671794020407360: Processing:
{ Ans: , MgmtId: 52239507206, via: 1, Ver: v1, Flags: 10,
[{"org.apache.cloudstack.storage.command.CreateObjectAnswer":{"data":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":"rbdnjcloudhost/c02b4f35-aed4-4c23-bbc3-b5c36615fa85/1eb6aeb6-2da2-493d-8f35-d7a442bda780","id":0,"quiescevm":false,"physicalSize":0}},"result":true,"wait":0}}]
}
2016-08-17 15:34:41,187 DEBUG [c.c.a.t.Request]
(API-Job-Executor-85:ctx-33ba3569 job-2361 ctx-1d14d077) (logid:b56de38a) Seq
1-4906671794020407360: Received: { Ans: , MgmtId: 52239507206, via:
1(njcloudhost.dev.ena.net), Ver: v1, Flags: 10, { CreateObjectAnswer } }
2016-08-17 15:34:41,213 DEBUG [o.a.c.s.s.XenserverSnapshotStrategy]
(API-Job-Executor-85:ctx-33ba3569 job-2361 ctx-1d14d077) (logid:b56de38a)
skipping backup of snapshot due to configuration snapshot.backup.rightafter
2016-08-17 15:34:41,244 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
(API-Job-Executor-85:ctx-33ba3569 job-2361 ctx-1d14d077) (logid:b56de38a)
Complete async job-2361, jobStatus: SUCCEEDED, resultCode: 0, result:
org.apache.cloudstack.api.response.SnapshotResponse/snapshot/{"id":"db19bec0-60e0-497b-879e-08ee89c3266a","account":"admin-2177","domainid":"380192f3-c288-47a1-893d-b0e4c6b4a736","domain":"2177","snapshottype":"MANUAL","volumeid":"c02b4f35-aed4-4c23-bbc3-b5c36615fa85","volumename":"1111","volumetype":"DATADISK","created":"2016-08-17T15:34:39-0500","name":"testsnap","intervaltype":"MANUAL","state":"Allocated","physicalsize":0,"zoneid":"4cc0d9dc-0036-4415-b2fd-09bc6abf7966","tags":[],"revertable":false}
2016-08-17 15:34:41,245 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
(API-Job-Executor-85:ctx-33ba3569 job-2361 ctx-1d14d077) (logid:b56de38a)
Publish async job-2361 complete on message bus
2016-08-17 15:34:41,245 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
(API-Job-Executor-85:ctx-33ba3569 job-2361 ctx-1d14d077) (logid:b56de38a) Wake
up jobs related to job-2361
2016-08-17 15:34:41,245 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
(API-Job-Executor-85:ctx-33ba3569 job-2361 ctx-1d14d077) (logid:b56de38a)
Update db status for job-2361
2016-08-17 15:34:41,247 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
(API-Job-Executor-85:ctx-33ba3569 job-2361 ctx-1d14d077) (logid:b56de38a) Wake
up jobs joined with job-2361 and disjoin all subjobs created from job- 2361
2016-08-17 15:34:41,249 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
(API-Job-Executor-85:ctx-33ba3569 job-2361) (logid:b56de38a) Done executing
org.apache.cloudstack.api.command.user.snapshot.CreateSnapshotCmd for
job-2361```
---
If your project is set up for it, you can reply to this email and have your
reply appear on GitHub as well. If your project does not have this feature
enabled and wishes so, or if the feature is enabled but not working, please
contact infrastructure at infrastruct...@apache.org or file a JIRA ticket
with INFRA.
---
