<div dir="ltr">Hi,<div><br></div><div>I have a pb when i try to snapshot a VM.</div><div><br></div><div>Ovirt engine self hosted 3.4. Two node (host01 and host02).</div><div><br></div><div>my engine.log :</div><div><br></div>
<div><div>2014-04-04 12:30:03,013 INFO  [org.ovirt.engine.core.bll.CreateAllSnapshotsFromVmCommand] (org.ovirt.thread.pool-6-thread-24) Ending command successfully: org.ovirt.engine.core.bll.CreateAllSnapshotsFromVmCommand</div>
<div>2014-04-04 12:30:03,028 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SnapshotVDSCommand] (org.ovirt.thread.pool-6-thread-24) START, SnapshotVDSCommand(HostName = host01, HostId = fcb9a5cf-2064-42a5-99fe-dc56ea39ed81, vmId=cb038ccf-6c6f-475c-872f-ea812ff795a1), log id: 36463977</div>
<div>2014-04-04 12:30:03,075 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.SnapshotVDSCommand] (org.ovirt.thread.pool-6-thread-24) Failed in SnapshotVDS method</div><div>2014-04-04 12:30:03,076 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SnapshotVDSCommand] (org.ovirt.thread.pool-6-thread-24) Command org.ovirt.engine.core.vdsbroker.vdsbroker.SnapshotVDSCommand return value</div>
<div> StatusOnlyReturnForXmlRpc [mStatus=StatusForXmlRpc [mCode=48, mMessage=Snapshot failed]]</div><div>2014-04-04 12:30:03,077 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SnapshotVDSCommand] (org.ovirt.thread.pool-6-thread-24) HostName = host01</div>
<div>2014-04-04 12:30:03,078 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.SnapshotVDSCommand] (org.ovirt.thread.pool-6-thread-24) Command SnapshotVDSCommand(HostName = host01, HostId = fcb9a5cf-2064-42a5-99fe-dc56ea39ed81, vmId=cb038ccf-6c6f-475c-872f-ea812ff795a1) execution failed. Exception: VDSErrorException: VDSGenericException: VDSErrorException: Failed to SnapshotVDS, error = Snapshot failed, code = 48</div>
<div>2014-04-04 12:30:03,080 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SnapshotVDSCommand] (org.ovirt.thread.pool-6-thread-24) FINISH, SnapshotVDSCommand, log id: 36463977</div><div>2014-04-04 12:30:03,083 WARN  [org.ovirt.engine.core.bll.CreateAllSnapshotsFromVmCommand] (org.ovirt.thread.pool-6-thread-24) Wasnt able to live snapshot due to error: VdcBLLException: VdcBLLException: org.ovirt.engine.core.vdsbroker.vdsbroker.VDSErrorException: VDSGenericException: VDSErrorException: Failed to SnapshotVDS, error = Snapshot failed, code = 48 (Failed with error SNAPSHOT_FAILED and code 48). VM will still be configured to the new created snapshot</div>
<div>2014-04-04 12:30:03,097 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-6-thread-24) Correlation ID: 5650b99f, Job ID: c1b2d861-2a52-49f1-9eaa-1b63aa8b4fba, Call Stack: org.ovirt.engine.core.common.errors.VdcBLLException: VdcBLLException: org.ovirt.engine.core.vdsbroker.vdsbroker.VDSErrorException: VDSGenericException: VDSErrorException: Failed to SnapshotVDS, error = Snapshot failed, code = 48 (Failed with error SNAPSHOT_FAILED and code 48)</div>
</div><div><br></div><div><br></div><div>My /var/log/messages</div><div><br></div><div><div>Apr  4 12:30:04 host01 vdsm vm.Vm ERROR vmId=`cb038ccf-6c6f-475c-872f-ea812ff795a1`::The base volume doesn&#39;t exist: {&#39;device&#39;: &#39;disk&#39;, &#39;domainID&#39;: &#39;5ae613a4-44e4-42cb-89fc-7b5d34c1f30f&#39;, &#39;volumeID&#39;: &#39;3b6cbb5d-beed-428d-ac66-9db3dd002e2f&#39;, &#39;imageID&#39;: &#39;646df162-5c6d-44b1-bc47-b63c3fdab0e2&#39;}</div>
</div><div><br></div><div>My /var/log/libvirt/libvirt.log</div><div><br></div><div><div>2014-04-04 10:40:13.886+0000: 8234: debug : qemuMonitorIOWrite:462 : QEMU_MONITOR_IO_WRITE: mon=0x7f77ec0ccce0 buf={&quot;execute&quot;:&quot;query-blockstats&quot;,&quot;id&quot;:&quot;libvirt-20842&quot;}</div>
<div> len=53 ret=53 errno=11</div><div>2014-04-04 10:40:13.888+0000: 8234: debug : qemuMonitorIOProcess:354 : QEMU_MONITOR_IO_PROCESS: mon=0x7f77ec0ccce0 buf={&quot;return&quot;: [{&quot;device&quot;: &quot;drive-ide0-1-0&quot;, &quot;parent&quot;: {&quot;stats&quot;: {&quot;flush_total_time_ns&quot;: 0, &quot;wr_highest_offset&quot;: 0, &quot;wr_total_time_ns&quot;: 0, &quot;wr_bytes&quot;: 0, &quot;rd_total_time_ns&quot;: 0, &quot;flush_operations&quot;: 0, &quot;wr_operations&quot;: 0, &quot;rd_bytes&quot;: 0, &quot;rd_operations&quot;: 0}}, &quot;stats&quot;: {&quot;flush_total_time_ns&quot;: 0, &quot;wr_highest_offset&quot;: 0, &quot;wr_total_time_ns&quot;: 0, &quot;wr_bytes&quot;: 0, &quot;rd_total_time_ns&quot;: 11929902, &quot;flush_operations&quot;: 0, &quot;wr_operations&quot;: 0, &quot;rd_bytes&quot;: 135520, &quot;rd_operations&quot;: 46}}, {&quot;device&quot;: &quot;drive-virtio-disk0&quot;, &quot;parent&quot;: {&quot;stats&quot;: {&quot;flush_total_time_ns&quot;: 0, &quot;wr_highest_offset&quot;: 22184332800, &quot;wr_total_time_ns&quot;: 0, &quot;wr_bytes&quot;: 0, &quot;rd_total_time_ns&quot;: 0, &quot;flush_operations&quot;: 0, &quot;wr_operations&quot;: 0, &quot;rd_bytes&quot;: 0, &quot;rd_operations&quot;: 0}}, &quot;stats&quot;: {&quot;flush_total_time_ns&quot;: 34786515034, &quot;wr_highest_offset&quot;: 22184332800, &quot;wr_total_time_ns&quot;: 5131205369094, &quot;wr_bytes&quot;: 5122065408, &quot;rd_total_time_ns&quot;: 12987633373, &quot;flush_operations&quot;: 285398, &quot;wr_operations&quot;: 401232, &quot;rd_bytes&quot;: 392342016, &quot;rd_operations&quot;: 15069}}], &quot;id&quot;: &quot;libvirt-20842&quot;}</div>
<div> len=1021</div><div>2014-04-04 10:40:13.888+0000: 8263: debug : qemuMonitorGetBlockStatsInfo:1478 : mon=0x7f77ec0ccce0 dev=ide0-1-0</div><div>2014-04-04 10:40:13.889+0000: 8263: debug : qemuMonitorSend:904 : QEMU_MONITOR_SEND_MSG: mon=0x7f77ec0ccce0 msg={&quot;execute&quot;:&quot;query-blockstats&quot;,&quot;id&quot;:&quot;libvirt-20843&quot;}</div>
</div><div><br></div><div>/var/log/vdsm/vdsm.log</div><div><div>Thread-4732::DEBUG::2014-04-04 12:43:34,439::BindingXMLRPC::1067::vds::(wrapper) client [192.168.99.104]::call vmSnapshot with (&#39;cb038ccf-6c6f-475c-872f-ea812ff795a1&#39;, [{&#39;baseVolumeID&#39;: &#39;b62232fc-4e02-41ce-ae10-5dff9e2f7bbe&#39;, &#39;domainID&#39;: &#39;5ae613a4-44e4-42cb-89fc-7b5d34c1f30f&#39;, &#39;volumeID&#39;: &#39;f5fc4fed-4acd-46e8-9980-90a9c3985840&#39;, &#39;imageID&#39;: &#39;646df162-5c6d-44b1-bc47-b63c3fdab0e2&#39;}], &#39;5ae613a4-44e4-42cb-89fc-7b5d34c1f30f,00000002-0002-0002-0002-000000000076,4fb31c32-8467-4d4a-b817-977643a462e3,ceb881f3-9a46-4ebc-b82e-c4c91035f807,2c06b4da-2743-4422-ba94-74da2c709188,02804da9-34f8-438f-9e8a-9689bc94790c&#39;) {}</div>
<div>Thread-4732::ERROR::2014-04-04 12:43:34,440::vm::3910::vm.Vm::(snapshot) vmId=`cb038ccf-6c6f-475c-872f-ea812ff795a1`::The base volume doesn&#39;t exist: {&#39;device&#39;: &#39;disk&#39;, &#39;domainID&#39;: &#39;5ae613a4-44e4-42cb-89fc-7b5d34c1f30f&#39;, &#39;volumeID&#39;: &#39;b62232fc-4e02-41ce-ae10-5dff9e2f7bbe&#39;, &#39;imageID&#39;: &#39;646df162-5c6d-44b1-bc47-b63c3fdab0e2&#39;}</div>
<div>Thread-4732::DEBUG::2014-04-04 12:43:34,440::BindingXMLRPC::1074::vds::(wrapper) return vmSnapshot with {&#39;status&#39;: {&#39;message&#39;: &#39;Snapshot failed&#39;, &#39;code&#39;: 48}}</div><div>Thread-299::DEBUG::2014-04-04 12:43:35,423::fileSD::225::Storage.Misc.excCmd::(getReadDelay) &#39;/bin/dd iflag=direct if=/rhev/data-center/mnt/host01.ovirt.lan:_home_export/ff98d346-4515-4349-8437-fb2f5e9eaadf/dom_md/metadata bs=4096 count=1&#39; (cwd None)</div>
</div><div><br></div><div><br></div><div>Thx;)</div><div><br></div></div>