[ovirt-users] Re: live merge of snapshots failed

2021-08-10 Thread Nir Soffer 
On Tue, Aug 10, 2021 at 7:33 AM  wrote:
>
> Helo Nir,
> No I do not have libvirt logs enabled.
> I restored the vm from the snapshot and retried. It did boot but at the same 
> time it did not merge again when I tried it. On the other hand when I cloned 
> it and tried to recreate the situation the image did merge.
> Is it possible that the image is corrupted for any reason beyond live merge 
> failure,so the merge fails regardles?
> This is a production vm so I cannot play a lot with it :-(
> I should probably clone it give the clone to production and see if this 
> continues to happen.

I see you are using ovirt 4.3.10 - we fixed some snapshot deletion
issues in 4.4.

For your case I would try to:
1. Clone the VM - can you delete the snapshot in the clone?
2. Shutdown the clone - can delete the snapshot when the clone is shutdown?

Please file a bug and attach vdsm and engine logs showing the
timeframe when you tried
to delete the snapshot.

Nir
___
Users mailing list -- users@ovirt.org
To unsubscribe send an email to users-le...@ovirt.org
Privacy Statement: https://www.ovirt.org/privacy-policy.html
oVirt Code of Conduct: 
https://www.ovirt.org/community/about/community-guidelines/
List Archives: 
https://lists.ovirt.org/archives/list/users@ovirt.org/message/EFRNJLPOFWSDV5SESQ3S2UHTBRQLGKH4/

[ovirt-users] Re: live merge of snapshots failed

2021-08-09 Thread g . vasilopoulos 
Helo Nir, 
No I do not have libvirt logs enabled.
I restored the vm from the snapshot and retried. It did boot but at the same 
time it did not merge again when I tried it. On the other hand when I cloned it 
and tried to recreate the situation the image did merge.
Is it possible that the image is corrupted for any reason beyond live merge 
failure,so the merge fails regardles?
This is a production vm so I cannot play a lot with it :-(
I should probably clone it give the clone to production and see if this 
continues to happen.
Thank you for your help. I ll let you know if I can find out anything new.
___
Users mailing list -- users@ovirt.org
To unsubscribe send an email to users-le...@ovirt.org
Privacy Statement: https://www.ovirt.org/privacy-policy.html
oVirt Code of Conduct: 
https://www.ovirt.org/community/about/community-guidelines/
List Archives: 
https://lists.ovirt.org/archives/list/users@ovirt.org/message/NZS5LVAE6YLN2LLO3EXYUZYIBYWLDVAA/

[ovirt-users] Re: live merge of snapshots failed

2021-08-09 Thread Nir Soffer 
On Fri, Aug 6, 2021 at 1:16 PM  wrote:
>
> I think these are the corresponding logs
> qcow2: Marking image as corrupt: Cluster allocation offset 0x7890c000 
> unaligned (L2 offset: 0x39e0, L2 index: 0); further corruption events 
> will be suppressed

This disk was corrupted by a previous run of the vm.

> main_channel_link: add main channel client
> main_channel_client_handle_pong: net test: latency 12.959000 ms, bitrate 
> 3117199391 bps (2972.792998 Mbps)
> inputs_connect: inputs channel client create
> red_qxl_set_cursor_peer:
> red_channel_client_disconnect: rcc=0x56405bdf69c0 (channel=0x56405ad7c940 
> type=3 id=0)
> red_channel_client_disconnect: rcc=0x56405e78cdd0 (channel=0x56405bb96900 
> type=4 id=0)
> red_channel_client_disconnect: rcc=0x56405e79c5b0 (channel=0x56405ad7c220 
> type=2 id=0)
> red_channel_client_disconnect: rcc=0x56405bdea9f0 (channel=0x56405ad7c150 
> type=1 id=0)
> main_channel_client_on_disconnect: rcc=0x56405bdea9f0
> red_client_destroy: destroy client 0x56405c383110 with #channels=4
> red_qxl_disconnect_cursor_peer:
> red_qxl_disconnect_display_peer:
> 2021-08-03T08:10:50.516974Z qemu-kvm: terminating on signal 15 from pid 6847 
> ()
> 2021-08-03 08:10:50.717+: shutting down, reason=destroyed

Did you replace the corrupted disk before starting the vm again 3 hours later?

> 2021-08-03 11:02:57.502+: starting up libvirt version: 4.5.0, package: 
> 33.el7_8.1 (CentOS BuildSystem , 2020-05-12-16:25:35, 
> x86-01.bsys.centos.org), qemu version: 2.12.0qemu-kvm-ev-2.12.0-44.1.el7_8.1, 
> kernel: 3.10.0-1127.8.2.el7.x86_64, hostname: ovirt3-5.vmmgmt-int.uoc.gr
> LC_ALL=C \
> PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin \
> QEMU_AUDIO_DRV=none \
> /usr/libexec/qemu-kvm \
> -name guest=anova.admin.uoc.gr,debug-threads=on \
> -S \
> -object 
> secret,id=masterKey0,format=raw,file=/var/lib/libvirt/qemu/domain-12-anova.admin.uoc.gr/master-key.aes
>  \
> -machine pc-i440fx-rhel7.6.0,accel=kvm,usb=off,dump-guest-core=off \
> -cpu 
> Westmere,vme=on,pclmuldq=on,x2apic=on,hypervisor=on,arat=on,hv_time,hv_relaxed,hv_vapic,hv_spinlocks=0x1fff,hv_synic,hv_stimer
>  \
> -m size=8388608k,slots=16,maxmem=33554432k \
> -realtime mlock=off \
> -smp 2,maxcpus=16,sockets=16,cores=1,threads=1 \
> -object iothread,id=iothread1 \
> -numa node,nodeid=0,cpus=0-1,mem=8192 \
> -uuid 1c1d20ed-3167-4be7-bff3-29845142fc57 \
> -smbios 'type=1,manufacturer=oVirt,product=oVirt 
> Node,version=7-8.2003.0.el7.centos,serial=4c4c4544-0053-4b10-8059-cac04f475832,uuid=1c1d20ed-3167-4be7-bff3-29845142fc57'
>  \
> -no-user-config \
> -nodefaults \
> -chardev socket,id=charmonitor,fd=33,server,nowait \
> -mon chardev=charmonitor,id=monitor,mode=control \
> -rtc base=2021-08-03T12:02:56,driftfix=slew \
> -global kvm-pit.lost_tick_policy=delay \
> -no-hpet \
> -no-shutdown \
> -global PIIX4_PM.disable_s3=1 \
> -global PIIX4_PM.disable_s4=1 \
> -boot strict=on \
> -device piix3-usb-uhci,id=usb,bus=pci.0,addr=0x1.0x2 \
> -device 
> virtio-scsi-pci,iothread=iothread1,id=ua-90ae154d-56b8-499a-9173-c4cd225ba0c6,bus=pci.0,addr=0x7
>  \
> -device 
> virtio-serial-pci,id=ua-a8dc285c-6fa9-45b2-a4f9-c8862be71342,max_ports=16,bus=pci.0,addr=0x4
>  \
> -drive 
> file=/rhev/data-center/mnt/10.252.80.208:_home_isos/5b1a0f29-8f97-42c3-bea2-39f83bbfbf24/images/----/virtio-win-0.1.185.iso,format=raw,if=none,id=drive-ua-cfb42882-2eba-41b9--43781eeff382,werror=report,rerror=report,readonly=on
>  \
> -device 
> ide-cd,bus=ide.1,unit=0,drive=drive-ua-cfb42882-2eba-41b9--43781eeff382,id=ua-cfb42882-2eba-41b9--43781eeff382,bootindex=2
>  \
> -drive 
> file=/rhev/data-center/mnt/blockSD/a5a492a7-f770-4472-baa3-ac7297a581a9/images/2e6e3cd3-f0cb-47a7-8bda-7738bd7c1fb5/84c005da-cbec-4ace-8619-5a8e2ae5ea75,format=raw,if=none,id=drive-ua-2e6e3cd3-f0cb-47a7-8bda-7738bd7c1fb5,serial=2e6e3cd3-f0cb-47a7-8bda-7738bd7c1fb5,werror=stop,rerror=stop,cache=none,aio=native,throttling.bps-read=157286400,throttling.bps-write=73400320,throttling.iops-read=1200,throttling.iops-write=180
>  \

This log does not show anything except the corruption in the previous run.

What we need is libvirtd.log from /var/log/libvirt/libvirtd.log.

The log usually does not exist since it is too verbose to enable by default.
You can try to enable libvirt logs temporarily, see:
https://libvirt.org/kbase/debuglogs.html

Nir
___
Users mailing list -- users@ovirt.org
To unsubscribe send an email to users-le...@ovirt.org
Privacy Statement: https://www.ovirt.org/privacy-policy.html
oVirt Code of Conduct: 
https://www.ovirt.org/community/about/community-guidelines/
List Archives: 
https://lists.ovirt.org/archives/list/users@ovirt.org/message/IVC4PZXJLYRFSZDFPKIUTVFX7WNEV6Q2/

[ovirt-users] Re: live merge of snapshots failed

2021-08-06 Thread g . vasilopoulos 
I think these are the corresponding logs
qcow2: Marking image as corrupt: Cluster allocation offset 0x7890c000 unaligned 
(L2 offset: 0x39e0, L2 index: 0); further corruption events will be 
suppressed
main_channel_link: add main channel client
main_channel_client_handle_pong: net test: latency 12.959000 ms, bitrate 
3117199391 bps (2972.792998 Mbps)
inputs_connect: inputs channel client create
red_qxl_set_cursor_peer: 
red_channel_client_disconnect: rcc=0x56405bdf69c0 (channel=0x56405ad7c940 
type=3 id=0)
red_channel_client_disconnect: rcc=0x56405e78cdd0 (channel=0x56405bb96900 
type=4 id=0)
red_channel_client_disconnect: rcc=0x56405e79c5b0 (channel=0x56405ad7c220 
type=2 id=0)
red_channel_client_disconnect: rcc=0x56405bdea9f0 (channel=0x56405ad7c150 
type=1 id=0)
main_channel_client_on_disconnect: rcc=0x56405bdea9f0
red_client_destroy: destroy client 0x56405c383110 with #channels=4
red_qxl_disconnect_cursor_peer: 
red_qxl_disconnect_display_peer: 
2021-08-03T08:10:50.516974Z qemu-kvm: terminating on signal 15 from pid 6847 
()
2021-08-03 08:10:50.717+: shutting down, reason=destroyed
2021-08-03 11:02:57.502+: starting up libvirt version: 4.5.0, package: 
33.el7_8.1 (CentOS BuildSystem , 2020-05-12-16:25:35, 
x86-01.bsys.centos.org), qemu version: 2.12.0qemu-kvm-ev-2.12.0-44.1.el7_8.1, 
kernel: 3.10.0-1127.8.2.el7.x86_64, hostname: ovirt3-5.vmmgmt-int.uoc.gr
LC_ALL=C \
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin \
QEMU_AUDIO_DRV=none \
/usr/libexec/qemu-kvm \
-name guest=anova.admin.uoc.gr,debug-threads=on \
-S \
-object 
secret,id=masterKey0,format=raw,file=/var/lib/libvirt/qemu/domain-12-anova.admin.uoc.gr/master-key.aes
 \
-machine pc-i440fx-rhel7.6.0,accel=kvm,usb=off,dump-guest-core=off \
-cpu 
Westmere,vme=on,pclmuldq=on,x2apic=on,hypervisor=on,arat=on,hv_time,hv_relaxed,hv_vapic,hv_spinlocks=0x1fff,hv_synic,hv_stimer
 \
-m size=8388608k,slots=16,maxmem=33554432k \
-realtime mlock=off \
-smp 2,maxcpus=16,sockets=16,cores=1,threads=1 \
-object iothread,id=iothread1 \
-numa node,nodeid=0,cpus=0-1,mem=8192 \
-uuid 1c1d20ed-3167-4be7-bff3-29845142fc57 \
-smbios 'type=1,manufacturer=oVirt,product=oVirt 
Node,version=7-8.2003.0.el7.centos,serial=4c4c4544-0053-4b10-8059-cac04f475832,uuid=1c1d20ed-3167-4be7-bff3-29845142fc57'
 \
-no-user-config \
-nodefaults \
-chardev socket,id=charmonitor,fd=33,server,nowait \
-mon chardev=charmonitor,id=monitor,mode=control \
-rtc base=2021-08-03T12:02:56,driftfix=slew \
-global kvm-pit.lost_tick_policy=delay \
-no-hpet \
-no-shutdown \
-global PIIX4_PM.disable_s3=1 \
-global PIIX4_PM.disable_s4=1 \
-boot strict=on \
-device piix3-usb-uhci,id=usb,bus=pci.0,addr=0x1.0x2 \
-device 
virtio-scsi-pci,iothread=iothread1,id=ua-90ae154d-56b8-499a-9173-c4cd225ba0c6,bus=pci.0,addr=0x7
 \
-device 
virtio-serial-pci,id=ua-a8dc285c-6fa9-45b2-a4f9-c8862be71342,max_ports=16,bus=pci.0,addr=0x4
 \
-drive 
file=/rhev/data-center/mnt/10.252.80.208:_home_isos/5b1a0f29-8f97-42c3-bea2-39f83bbfbf24/images/----/virtio-win-0.1.185.iso,format=raw,if=none,id=drive-ua-cfb42882-2eba-41b9--43781eeff382,werror=report,rerror=report,readonly=on
 \
-device 
ide-cd,bus=ide.1,unit=0,drive=drive-ua-cfb42882-2eba-41b9--43781eeff382,id=ua-cfb42882-2eba-41b9--43781eeff382,bootindex=2
 \
-drive 
file=/rhev/data-center/mnt/blockSD/a5a492a7-f770-4472-baa3-ac7297a581a9/images/2e6e3cd3-f0cb-47a7-8bda-7738bd7c1fb5/84c005da-cbec-4ace-8619-5a8e2ae5ea75,format=raw,if=none,id=drive-ua-2e6e3cd3-f0cb-47a7-8bda-7738bd7c1fb5,serial=2e6e3cd3-f0cb-47a7-8bda-7738bd7c1fb5,werror=stop,rerror=stop,cache=none,aio=native,throttling.bps-read=157286400,throttling.bps-write=73400320,throttling.iops-read=1200,throttling.iops-write=180
 \
___
Users mailing list -- users@ovirt.org
To unsubscribe send an email to users-le...@ovirt.org
Privacy Statement: https://www.ovirt.org/privacy-policy.html
oVirt Code of Conduct: 
https://www.ovirt.org/community/about/community-guidelines/
List Archives: 
https://lists.ovirt.org/archives/list/users@ovirt.org/message/ZHUBVVF5QJC7QBX526R7BXBILTHRGMNP/

[ovirt-users] Re: live merge of snapshots failed

2021-08-06 Thread Benny Zlotnik 
2021-08-03 15:50:59,040+0300 ERROR (libvirt/events) [virt.vm]
(vmId='1c1d20ed-3167-4be7-bff3-29845142fc57') Block job ACTIVE_COMMIT
for drive 
/rhev/data-center/mnt/blockSD/a5a492a7-f770-4472-baa3-ac7297a581a9/images/2e6e3cd3-f0cb-47a7-8bda-7738bd7c1fb5/b43b7c33-5b53-4332-a2e0-f950debb919b
has failed (vm:5847)

Do you have access to libvirtd logs?
Since you're using an outdated version it's possible you've hit an old
bug that's been fixed

On Wed, Aug 4, 2021 at 10:30 AM  wrote:
>
> here os the vdsm.log from the SPM
> there is a report for the second disk of the vm but the first (the one which 
> failes to merge does not seem to be anywhere)
> 2021-08-03 15:51:40,051+0300 INFO  (jsonrpc/7) [vdsm.api] START 
> getVolumeInfo(sdUUID=u'96000ec9-e181-44eb-893f-e0a36e3a6775', 
> spUUID=u'5da76866-7b7d-11eb-9913-00163e1f2643', 
> imgUUID=u'205a30a3-fc06-4ceb-8ef2-018f16d4ccbb', 
> volUUID=u'7611ebcf-5323-45ca-b16c-9302d0bdedc6', options=None) 
> from=:::10.252.80.201,58850, 
> flow_id=3bf9345d-fab2-490f-ba44-6aa014bbb743, 
> task_id=be6c50d9-a8e4-4ef5-85cf-87a00d79d77e (api:48)
> 2021-08-03 15:51:40,052+0300 INFO  (jsonrpc/7) [storage.VolumeManifest] Info 
> request: sdUUID=96000ec9-e181-44eb-893f-e0a36e3a6775 
> imgUUID=205a30a3-fc06-4ceb-8ef2-018f16d4ccbb volUUID = 
> 7611ebcf-5323-45ca-b16c-9302d0bdedc6  (volume:240)
> 2021-08-03 15:51:40,081+0300 INFO  (jsonrpc/7) [storage.VolumeManifest] 
> 96000ec9-e181-44eb-893f-e0a36e3a6775/205a30a3-fc06-4ceb-8ef2-018f16d4ccbb/7611ebcf-5323-45ca-b16c-9302d0bdedc6
>  info is {'status': 'OK', 'domain': '96000ec9-e181-44eb-893f-e0a36e3a6775', 
> 'voltype': 'LEAF', 'description': 
> '{"DiskAlias":"anova.admin.uoc.gr_Disk2","DiskDescription":""}', 'parent': 
> '----', 'format': 'RAW', 'generation': 0, 
> 'image': '205a30a3-fc06-4ceb-8ef2-018f16d4ccbb', 'disktype': 'DATA', 
> 'legality': 'LEGAL', 'mtime': '0', 'apparentsize': '42949672960', 'children': 
> [], 'pool': '', 'ctime': '1625846644', 'capacity': '42949672960', 'uuid': 
> u'7611ebcf-5323-45ca-b16c-9302d0bdedc6', 'truesize': '42949672960', 'type': 
> 'PREALLOCATED', 'lease': {'path': 
> '/dev/96000ec9-e181-44eb-893f-e0a36e3a6775/leases', 'owners': [], 'version': 
> None, 'offset': 105906176}} (volume:279)
> 2021-08-03 15:51:40,081+0300 INFO  (jsonrpc/7) [vdsm.api] FINISH 
> getVolumeInfo return={'info': {'status': 'OK', 'domain': 
> '96000ec9-e181-44eb-893f-e0a36e3a6775', 'voltype': 'LEAF', 'description': 
> '{"DiskAlias":"anova.admin.uoc.gr_Disk2","DiskDescription":""}', 'parent': 
> '----', 'format': 'RAW', 'generation': 0, 
> 'image': '205a30a3-fc06-4ceb-8ef2-018f16d4ccbb', 'disktype': 'DATA', 
> 'legality': 'LEGAL', 'mtime': '0', 'apparentsize': '42949672960', 'children': 
> [], 'pool': '', 'ctime': '1625846644', 'capacity': '42949672960', 'uuid': 
> u'7611ebcf-5323-45ca-b16c-9302d0bdedc6', 'truesize': '42949672960', 'type': 
> 'PREALLOCATED', 'lease': {'path': 
> '/dev/96000ec9-e181-44eb-893f-e0a36e3a6775/leases', 'owners': [], 'version': 
> None, 'offset': 105906176}}} from=:::10.252.80.201,58850, 
> flow_id=3bf9345d-fab2-490f-ba44-6aa014bbb743, 
> task_id=be6c50d9-a8e4-4ef5-85cf-87a00d79d77e (api:54)
> 2021-08-03 15:51:40,083+0300 INFO  (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC 
> call Volume.getInfo succeeded in 0.04 seconds (__init__:312)
>
> last appearance of this drive on the spm vdsm.log is when the snapshot 
> download finishes:
> 2021-08-03 15:34:18,619+0300 INFO  (jsonrpc/6) [vdsm.api] FINISH 
> get_image_ticket return={'result': {u'timeout': 300, u'idle_time': 0, 
> u'uuid': u'5c1943a9-cac4-4398-9ec1-46ab82cacd04', u'ops': [u'read'], u'url': 
> u'file:///rhev/data-center/mnt/blockSD/a5a492a7-f770-4472-baa3-ac7297a581a9/images/2e6e3cd3-f0cb-47a7-8bda-7738bd7c1fb5/84c005da-cbec-4ace-8619-5a8e2ae5ea75',
>  u'expires': 6191177, u'transferred': 150256746496, u'transfer_id': 
> u'7dcb75c0-4373-4986-b25f-5629b1b68f5d', u'sparse': False, u'active': True, 
> u'size': 150323855360}} from=:::10.252.80.201,58850, 
> flow_id=3035db30-8a8c-48a5-b0c6-0781fda6ac2e, 
> task_id=674028a2-e37c-46e4-a463-eeae1b09aef0 (api:54)
> 2021-08-03 15:34:18,620+0300 INFO  (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC 
> call Host.get_image_ticket succeeded in 0.00 seconds (__init__:312)
>
> If I can send any more information or test something please let me know.
> ___
> Users mailing list -- users@ovirt.org
> To unsubscribe send an email to users-le...@ovirt.org
> Privacy Statement: https://www.ovirt.org/privacy-policy.html
> oVirt Code of Conduct: 
> https://www.ovirt.org/community/about/community-guidelines/
> List Archives: 
> https://lists.ovirt.org/archives/list/users@ovirt.org/message/KEJ24BI6PLXYFQHJ6O2AESK3M4SXMUID/
___
Users mailing list -- users@ovirt.org
To unsubscribe send an email to users-le...@ovirt.org
Privacy Statement: https://www.ovirt.org/privacy-policy.html
oV

[ovirt-users] Re: live merge of snapshots failed

2021-08-04 Thread g . vasilopoulos 
here os the vdsm.log from the SPM
there is a report for the second disk of the vm but the first (the one which 
failes to merge does not seem to be anywhere)
2021-08-03 15:51:40,051+0300 INFO  (jsonrpc/7) [vdsm.api] START 
getVolumeInfo(sdUUID=u'96000ec9-e181-44eb-893f-e0a36e3a6775', 
spUUID=u'5da76866-7b7d-11eb-9913-00163e1f2643', 
imgUUID=u'205a30a3-fc06-4ceb-8ef2-018f16d4ccbb', 
volUUID=u'7611ebcf-5323-45ca-b16c-9302d0bdedc6', options=None) 
from=:::10.252.80.201,58850, flow_id=3bf9345d-fab2-490f-ba44-6aa014bbb743, 
task_id=be6c50d9-a8e4-4ef5-85cf-87a00d79d77e (api:48)
2021-08-03 15:51:40,052+0300 INFO  (jsonrpc/7) [storage.VolumeManifest] Info 
request: sdUUID=96000ec9-e181-44eb-893f-e0a36e3a6775 
imgUUID=205a30a3-fc06-4ceb-8ef2-018f16d4ccbb volUUID = 
7611ebcf-5323-45ca-b16c-9302d0bdedc6  (volume:240)
2021-08-03 15:51:40,081+0300 INFO  (jsonrpc/7) [storage.VolumeManifest] 
96000ec9-e181-44eb-893f-e0a36e3a6775/205a30a3-fc06-4ceb-8ef2-018f16d4ccbb/7611ebcf-5323-45ca-b16c-9302d0bdedc6
 info is {'status': 'OK', 'domain': '96000ec9-e181-44eb-893f-e0a36e3a6775', 
'voltype': 'LEAF', 'description': 
'{"DiskAlias":"anova.admin.uoc.gr_Disk2","DiskDescription":""}', 'parent': 
'----', 'format': 'RAW', 'generation': 0, 
'image': '205a30a3-fc06-4ceb-8ef2-018f16d4ccbb', 'disktype': 'DATA', 
'legality': 'LEGAL', 'mtime': '0', 'apparentsize': '42949672960', 'children': 
[], 'pool': '', 'ctime': '1625846644', 'capacity': '42949672960', 'uuid': 
u'7611ebcf-5323-45ca-b16c-9302d0bdedc6', 'truesize': '42949672960', 'type': 
'PREALLOCATED', 'lease': {'path': 
'/dev/96000ec9-e181-44eb-893f-e0a36e3a6775/leases', 'owners': [], 'version': 
None, 'offset': 105906176}} (volume:279)
2021-08-03 15:51:40,081+0300 INFO  (jsonrpc/7) [vdsm.api] FINISH getVolumeInfo 
return={'info': {'status': 'OK', 'domain': 
'96000ec9-e181-44eb-893f-e0a36e3a6775', 'voltype': 'LEAF', 'description': 
'{"DiskAlias":"anova.admin.uoc.gr_Disk2","DiskDescription":""}', 'parent': 
'----', 'format': 'RAW', 'generation': 0, 
'image': '205a30a3-fc06-4ceb-8ef2-018f16d4ccbb', 'disktype': 'DATA', 
'legality': 'LEGAL', 'mtime': '0', 'apparentsize': '42949672960', 'children': 
[], 'pool': '', 'ctime': '1625846644', 'capacity': '42949672960', 'uuid': 
u'7611ebcf-5323-45ca-b16c-9302d0bdedc6', 'truesize': '42949672960', 'type': 
'PREALLOCATED', 'lease': {'path': 
'/dev/96000ec9-e181-44eb-893f-e0a36e3a6775/leases', 'owners': [], 'version': 
None, 'offset': 105906176}}} from=:::10.252.80.201,58850, 
flow_id=3bf9345d-fab2-490f-ba44-6aa014bbb743, 
task_id=be6c50d9-a8e4-4ef5-85cf-87a00d79d77e (api:54)
2021-08-03 15:51:40,083+0300 INFO  (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call 
Volume.getInfo succeeded in 0.04 seconds (__init__:312)

last appearance of this drive on the spm vdsm.log is when the snapshot download 
finishes:
2021-08-03 15:34:18,619+0300 INFO  (jsonrpc/6) [vdsm.api] FINISH 
get_image_ticket return={'result': {u'timeout': 300, u'idle_time': 0, u'uuid': 
u'5c1943a9-cac4-4398-9ec1-46ab82cacd04', u'ops': [u'read'], u'url': 
u'file:///rhev/data-center/mnt/blockSD/a5a492a7-f770-4472-baa3-ac7297a581a9/images/2e6e3cd3-f0cb-47a7-8bda-7738bd7c1fb5/84c005da-cbec-4ace-8619-5a8e2ae5ea75',
 u'expires': 6191177, u'transferred': 150256746496, u'transfer_id': 
u'7dcb75c0-4373-4986-b25f-5629b1b68f5d', u'sparse': False, u'active': True, 
u'size': 150323855360}} from=:::10.252.80.201,58850, 
flow_id=3035db30-8a8c-48a5-b0c6-0781fda6ac2e, 
task_id=674028a2-e37c-46e4-a463-eeae1b09aef0 (api:54)
2021-08-03 15:34:18,620+0300 INFO  (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call 
Host.get_image_ticket succeeded in 0.00 seconds (__init__:312)

If I can send any more information or test something please let me know.
___
Users mailing list -- users@ovirt.org
To unsubscribe send an email to users-le...@ovirt.org
Privacy Statement: https://www.ovirt.org/privacy-policy.html
oVirt Code of Conduct: 
https://www.ovirt.org/community/about/community-guidelines/
List Archives: 
https://lists.ovirt.org/archives/list/users@ovirt.org/message/KEJ24BI6PLXYFQHJ6O2AESK3M4SXMUID/

[ovirt-users] Re: live merge of snapshots failed

2021-08-04 Thread g . vasilopoulos 
hello Benny and thank you for the quick response:
this is the vdsm log:
2021-08-03 15:50:58,655+0300 INFO  (jsonrpc/3) [storage.VolumeManifest] 
96000ec9-e181-44eb-893f-e0a36e3a6775/205a30a3-fc06-4ceb-8ef2-018f16d4ccbb/7611ebcf-5323-45ca-b16c-9302d0bdedc6
 info is {'status': 'OK', 'domain': '96000ec9-e181-44eb-893f-e0a36e3a6775', 
'voltype': 'INTERNAL', 'description': 
'{"DiskAlias":"anova.admin.uoc.gr_Disk2","DiskDescription":""}', 'parent': 
'----', 'format': 'RAW', 'generation': 0, 
'image': '205a30a3-fc06-4ceb-8ef2-018f16d4ccbb', 'disktype': 'DATA', 
'legality': 'LEGAL', 'mtime': '0', 'apparentsize': '42949672960', 'children': 
[], 'pool': '', 'ctime': '1625846644', 'capacity': '42949672960', 'uuid': 
u'7611ebcf-5323-45ca-b16c-9302d0bdedc6', 'truesize': '42949672960', 'type': 
'PREALLOCATED', 'lease': {'path': 
'/dev/96000ec9-e181-44eb-893f-e0a36e3a6775/leases', 'owners': [], 'version': 
None, 'offset': 105906176}} (volume:279)
2021-08-03 15:50:58,655+0300 INFO  (jsonrpc/3) [vdsm.api] FINISH getVolumeInfo 
return={'info': {'status': 'OK', 'domain': 
'96000ec9-e181-44eb-893f-e0a36e3a6775', 'voltype': 'INTERNAL', 'description': 
'{"DiskAlias":"anova.admin.uoc.gr_Disk2","DiskDescription":""}', 'parent': 
'----', 'format': 'RAW', 'generation': 0, 
'image': '205a30a3-fc06-4ceb-8ef2-018f16d4ccbb', 'disktype': 'DATA', 
'legality': 'LEGAL', 'mtime': '0', 'apparentsize': '42949672960', 'children': 
[], 'pool': '', 'ctime': '1625846644', 'capacity': '42949672960', 'uuid': 
u'7611ebcf-5323-45ca-b16c-9302d0bdedc6', 'truesize': '42949672960', 'type': 
'PREALLOCATED', 'lease': {'path': 
'/dev/96000ec9-e181-44eb-893f-e0a36e3a6775/leases', 'owners': [], 'version': 
None, 'offset': 105906176}}} from=:::10.252.80.201,41898, 
flow_id=3bf9345d-fab2-490f-ba44-6aa014bbb743, 
task_id=0b4e6fe7-4345-40b1-9e86-86ec2f662d3f (api:54)
2021-08-03 15:50:58,656+0300 INFO  (jsonrpc/3) [vdsm.api] START 
getVolumeInfo(sdUUID=u'96000ec9-e181-44eb-893f-e0a36e3a6775', 
spUUID='5da76866-7b7d-11eb-9913-00163e1f2643', 
imgUUID=u'205a30a3-fc06-4ceb-8ef2-018f16d4ccbb', 
volUUID=u'17618ba1-4ab8-49eb-a991-fc3d602ced14', options=None) 
from=:::10.252.80.201,41898, flow_id=3bf9345d-fab2-490f-ba44-6aa014bbb743, 
task_id=0c307c2c-9bd3-4d1a-9db8-ec45d822bc71 (api:48)
2021-08-03 15:50:58,657+0300 INFO  (jsonrpc/3) [storage.VolumeManifest] Info 
request: sdUUID=96000ec9-e181-44eb-893f-e0a36e3a6775 
imgUUID=205a30a3-fc06-4ceb-8ef2-018f16d4ccbb volUUID = 
17618ba1-4ab8-49eb-a991-fc3d602ced14  (volume:240)
2021-08-03 15:50:58,681+0300 INFO  (jsonrpc/3) [storage.VolumeManifest] 
96000ec9-e181-44eb-893f-e0a36e3a6775/205a30a3-fc06-4ceb-8ef2-018f16d4ccbb/17618ba1-4ab8-49eb-a991-fc3d602ced14
 info is {'status': 'OK', 'domain': '96000ec9-e181-44eb-893f-e0a36e3a6775', 
'voltype': 'LEAF', 'description': '', 'parent': 
'7611ebcf-5323-45ca-b16c-9302d0bdedc6', 'format': 'COW', 'generation': 0, 
'image': '205a30a3-fc06-4ceb-8ef2-018f16d4ccbb', 'disktype': 'DATA', 
'legality': 'LEGAL', 'mtime': '0', 'apparentsize': '1073741824', 'children': 
[], 'pool': '', 'ctime': '1627991040', 'capacity': '42949672960', 'uuid': 
u'17618ba1-4ab8-49eb-a991-fc3d602ced14', 'truesize': '1073741824', 'type': 
'SPARSE', 'lease': {'path': '/dev/96000ec9-e181-44eb-893f-e0a36e3a6775/leases', 
'owners': [], 'version': None, 'offset': 49056}} (volume:279)
2021-08-03 15:50:58,681+0300 INFO  (jsonrpc/3) [vdsm.api] FINISH getVolumeInfo 
return={'info': {'status': 'OK', 'domain': 
'96000ec9-e181-44eb-893f-e0a36e3a6775', 'voltype': 'LEAF', 'description': '', 
'parent': '7611ebcf-5323-45ca-b16c-9302d0bdedc6', 'format': 'COW', 
'generation': 0, 'image': '205a30a3-fc06-4ceb-8ef2-018f16d4ccbb', 'disktype': 
'DATA', 'legality': 'LEGAL', 'mtime': '0', 'apparentsize': '1073741824', 
'children': [], 'pool': '', 'ctime': '1627991040', 'capacity': '42949672960', 
'uuid': u'17618ba1-4ab8-49eb-a991-fc3d602ced14', 'truesize': '1073741824', 
'type': 'SPARSE', 'lease': {'path': 
'/dev/96000ec9-e181-44eb-893f-e0a36e3a6775/leases', 'owners': [], 'version': 
None, 'offset': 49056}}} from=:::10.252.80.201,41898, 
flow_id=3bf9345d-fab2-490f-ba44-6aa014bbb743, 
task_id=0c307c2c-9bd3-4d1a-9db8-ec45d822bc71 (api:54)
2021-08-03 15:50:58,711+0300 INFO  (jsonrpc/3) [virt.vm] 
(vmId='1c1d20ed-3167-4be7-bff3-29845142fc57') Starting merge with 
jobUUID=u'62bf8c83-cd78-42a5-b57d-d67ddfdee8ee', original 
chain=7611ebcf-5323-45ca-b16c-9302d0bdedc6 < 
17618ba1-4ab8-49eb-a991-fc3d602ced14 (top), disk='sdb', base='sdb[1]', 
top=None, bandwidth=0, flags=12 (vm:5951)
2021-08-03 15:50:58,735+0300 INFO  (jsonrpc/3) [api.virt] FINISH merge 
return={'status': {'message': 'Done', 'code': 0}} 
from=:::10.252.80.201,41898, flow_id=3bf9345d-fab2-490f-ba44-6aa014bbb743, 
vmId=1c1d20ed-3167-4be7-bff3-29845142fc57 (api:54)
2021-08-03 15:50:58,735+0300 INFO  (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call 
VM.merge succeeded in 0.37 seconds (__init__:312)
2021-08-

[ovirt-users] Re: live merge of snapshots failed

2021-08-03 Thread Benny Zlotnik 
2021-08-03 15:51:34,917+03 ERROR
[org.ovirt.engine.core.bll.MergeStatusCommand]
(EE-ManagedThreadFactory-commandCoordinator-Thread-2)
[3bf9345d-fab2-490f-ba44-6aa014bbb743] Failed to live merge. Top
volume b43b7c33-5b53-4332-a2e0-f950debb919b is still in qemu chain
[b43b7c33-5b53-4332-a2e0-f950debb919b,
84c005da-cbec-4ace-8619-5a8e2ae5ea75]

Can you attach vdsm logs (from SPM and the host running the VM) so we
can understand why it failed?

On Tue, Aug 3, 2021 at 6:07 PM  wrote:
>
> Hello
> I have a situation with a vm in which I cannot delete the snapshot.
> The whole thing is quite strange because I can delete the snapshot when I 
> create and delete it from the web interface but when I do it with a python 
> script through the API it failes.
> The script does create snapshot-> download snapshot-> delete snapshot and I 
> used the examples from ovirt python sdk on githab to create it ,in general it 
> works prety well.
>
> But on a specific machine (so far) it cannot delete the live snapshot
> Ovirt is 4.3.10 and the guest is a windows 10 pc. Windows 10 guest has 2 
> disks attached both on different fc domains one on an ssd  emc and the other 
> on an hdd emc. Both disks are prealocated.
> I cannot figure out what the problem is so far
> the related engine log:
>
> 2021-08-03 15:51:00,385+03 INFO  
> [org.ovirt.engine.core.bll.snapshots.RemoveSnapshotSingleDiskLiveCommandCallback]
>  (EE-ManagedThreadFactory-engineScheduled-Thread-61) 
> [3bf9345d-fab2-490f-ba44-6aa014bbb743] Comma
> nd 'RemoveSnapshotSingleDiskLive' (id: 
> '80dc4609-b91f-4e93-bc12-7b2083933e5a') waiting on child command id: 
> '74c83880-581b-4774-ae51-8c4af0c92c53' type:'Merge' to complete
> 2021-08-03 15:51:00,385+03 INFO  
> [org.ovirt.engine.core.bll.MergeCommandCallback] 
> (EE-ManagedThreadFactory-engineScheduled-Thread-61) 
> [3bf9345d-fab2-490f-ba44-6aa014bbb743] Waiting on merge command to complete (
> jobId = 62bf8c83-cd78-42a5-b57d-d67ddfdee8ee)
> 2021-08-03 15:51:00,387+03 INFO  
> [org.ovirt.engine.core.bll.snapshots.RemoveSnapshotSingleDiskLiveCommandCallback]
>  (EE-ManagedThreadFactory-engineScheduled-Thread-61) 
> [3bf9345d-fab2-490f-ba44-6aa014bbb743] Command 'RemoveSnapshotSingleDiskLive' 
> (id: '87bc90c7-2aa5-4a1b-b58c-54296518658a') waiting on child command id: 
> 'ec806ac6-929f-42d9-a86e-98d6a39a4718' type:'Merge' to complete
> 2021-08-03 15:51:01,388+03 INFO  
> [org.ovirt.engine.core.bll.MergeCommandCallback] 
> (EE-ManagedThreadFactory-engineScheduled-Thread-30) 
> [3bf9345d-fab2-490f-ba44-6aa014bbb743] Waiting on merge command to complete 
> (jobId = c57fb3e5-da20-4838-8db3-31655ba76c1f)
> 2021-08-03 15:51:07,491+03 INFO  
> [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback] 
> (EE-ManagedThreadFactory-engineScheduled-Thread-38) 
> [b929fd4a-8ce7-408f-927d-ab0169879c4e] Command 'MoveImageGroup' (id: 
> '1de1b800-873f-405f-805b-f44397740909') waiting on child command id: 
> 'd1136344-2888-4d63-8fe1-b506426bc8aa' type:'CopyImageGroupWithData' to 
> complete
> 2021-08-03 15:51:11,513+03 INFO  
> [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback] 
> (EE-ManagedThreadFactory-engineScheduled-Thread-41) 
> [3bf9345d-fab2-490f-ba44-6aa014bbb743] Command 'RemoveSnapshot' (id: 
> '04e9d61e-28a2-4ab0-9bb7-5c805ee871e9') waiting on child command id: 
> '87bc90c7-2aa5-4a1b-b58c-54296518658a' type:'RemoveSnapshotSingleDiskLive' to 
> complete
> 2021-08-03 15:51:12,522+03 INFO  
> [org.ovirt.engine.core.bll.snapshots.RemoveSnapshotSingleDiskLiveCommandCallback]
>  (EE-ManagedThreadFactory-engineScheduled-Thread-76) 
> [3bf9345d-fab2-490f-ba44-6aa014bbb743] Command 'RemoveSnapshotSingleDiskLive' 
> (id: '80dc4609-b91f-4e93-bc12-7b2083933e5a') waiting on child command id: 
> '74c83880-581b-4774-ae51-8c4af0c92c53' type:'Merge' to complete
> 2021-08-03 15:51:12,523+03 INFO  
> [org.ovirt.engine.core.bll.MergeCommandCallback] 
> (EE-ManagedThreadFactory-engineScheduled-Thread-76) 
> [3bf9345d-fab2-490f-ba44-6aa014bbb743] Waiting on merge command to complete 
> (jobId = 62bf8c83-cd78-42a5-b57d-d67ddfdee8ee)
> 2021-08-03 15:51:12,527+03 INFO  
> [org.ovirt.engine.core.bll.snapshots.RemoveSnapshotSingleDiskLiveCommandCallback]
>  (EE-ManagedThreadFactory-engineScheduled-Thread-76) 
> [3bf9345d-fab2-490f-ba44-6aa014bbb743] Command 'RemoveSnapshotSingleDiskLive' 
> (id: '87bc90c7-2aa5-4a1b-b58c-54296518658a') waiting on child command id: 
> 'ec806ac6-929f-42d9-a86e-98d6a39a4718' type:'Merge' to complete
> 2021-08-03 15:51:13,528+03 INFO  
> [org.ovirt.engine.core.bll.MergeCommandCallback] 
> (EE-ManagedThreadFactory-engineScheduled-Thread-37) 
> [3bf9345d-fab2-490f-ba44-6aa014bbb743] Waiting on merge command to complete 
> (jobId = c57fb3e5-da20-4838-8db3-31655ba76c1f)
> 2021-08-03 15:51:21,635+03 INFO  
> [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback] 
> (EE-ManagedThreadFactory-engineScheduled-Thread-58) 
> [3bf9345d-fab2-490f-ba44-6aa014bbb743] Command 'RemoveSnapshot' (id: