Hi Peter, On 31.05.19 09:57, Peter Krempa wrote: > On Thu, May 30, 2019 at 22:12:14 +0200, Marcus Hoffmann wrote: >> Hello all, > > Hi, > >> >> I tried following this guide: >> https://wiki.libvirt.org/page/Live-disk-backup-with-active-blockcommit >> >> Unfortunately when I try to do the final virsh blockcommit step I always >> get the following error: >> >> error: internal error: unable to execute QEMU command 'block-commit': >> Could not reopen file: Permission denied >> >> I checked directory und image file permissions, app-armor profiles (set >> to complain mode for now.) and libvirt logs but nothing there gives me >> any hints what might be going wrong. >> >> This is on a debian buster system, using > > I was doing some changes in the blockcommit code recently so I might > have messed something up. Could you please collect debug logs: > > https://wiki.libvirt.org/page/DebugLogs > > when the problem reproduces and also a directory listing of the path > where the image is stored so I can check if the permission code is > working properly. > Logfile attached. ~ # ls -al /var/lib/libvirt/images/ total 1271917588 drwxr-xr-x 2 root root 4096 Mai 29 14:47 . drwxr-xr-x 7 root root 4096 Mai 27 15:55 .. -rw-r--r-- 1 libvirt-qemu libvirt-qemu 214821961728 Mai 29 14:47 drache3.qcow2 -rw-r--r-- 1 libvirt-qemu libvirt-qemu 395671371776 Mai 29 14:47 drache_addon.qcow2 -rw-r--r-- 1 libvirt-qemu libvirt-qemu 90944765952 Mai 31 14:02 drache_overlaya.qcow2 -rw-r--r-- 1 libvirt-qemu libvirt-qemu 115860766720 Mai 31 14:02 drache_overlayb.qcow2 Marcus
~ # tail -f /var/log/libvirt/libvirtd.log
2019-05-31 11:58:55.655+0000: 30902: info : virObjectNew:248 : OBJECT_NEW: obj=0x5574565c8d10 classname=virNetSocket
2019-05-31 11:58:55.655+0000: 30902: info : virObjectNew:248 : OBJECT_NEW: obj=0x5574565b8380 classname=virNetServerClient
2019-05-31 11:58:55.655+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565c8d10
2019-05-31 11:58:55.655+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.655+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565c8d10
2019-05-31 11:58:55.655+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.655+0000: 30902: info : virObjectNew:248 : OBJECT_NEW: obj=0x5574565b2310 classname=virKeepAlive
2019-05-31 11:58:55.655+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.655+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.655+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565c8d10
2019-05-31 11:58:55.655+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x557456599160
2019-05-31 11:58:55.655+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565ade60
2019-05-31 11:58:55.655+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.655+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x557456599160
2019-05-31 11:58:55.656+0000: 30903: info : virObjectNew:248 : OBJECT_NEW: obj=0x7f3b08000e80 classname=virIdentity
2019-05-31 11:58:55.656+0000: 30903: debug : virFileClose:113 : Closed fd 27
2019-05-31 11:58:55.656+0000: 30903: debug : virIdentitySetAttr:241 : ident=0x7f3b08000e80 attribute=0 value=root
2019-05-31 11:58:55.656+0000: 30903: debug : virIdentitySetAttr:241 : ident=0x7f3b08000e80 attribute=1 value=0
2019-05-31 11:58:55.656+0000: 30903: debug : virIdentitySetAttr:241 : ident=0x7f3b08000e80 attribute=2 value=root
2019-05-31 11:58:55.656+0000: 30903: debug : virIdentitySetAttr:241 : ident=0x7f3b08000e80 attribute=3 value=0
2019-05-31 11:58:55.656+0000: 30903: debug : virIdentitySetAttr:241 : ident=0x7f3b08000e80 attribute=4 value=31950
2019-05-31 11:58:55.656+0000: 30903: debug : virIdentitySetAttr:241 : ident=0x7f3b08000e80 attribute=5 value=33496032
2019-05-31 11:58:55.656+0000: 30903: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.656+0000: 30903: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.656+0000: 30903: debug : virThreadJobSet:94 : Thread 30903 (virNetServerHandleJob) is now running job remoteDispatchAuthList
2019-05-31 11:58:55.656+0000: 30903: debug : virFileClose:113 : Closed fd 27
2019-05-31 11:58:55.656+0000: 30903: debug : virThreadJobClear:119 : Thread 30903 (virNetServerHandleJob) finished job remoteDispatchAuthList with ret=0
2019-05-31 11:58:55.656+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.656+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.656+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565ade60
2019-05-31 11:58:55.656+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.656+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x557456599160
2019-05-31 11:58:55.656+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565ade60
2019-05-31 11:58:55.656+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.656+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x557456599160
2019-05-31 11:58:55.656+0000: 30905: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.656+0000: 30905: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.656+0000: 30905: debug : virThreadJobSet:94 : Thread 30905 (virNetServerHandleJob) is now running job remoteDispatchConnectSupportsFeature
2019-05-31 11:58:55.657+0000: 30905: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b2310
2019-05-31 11:58:55.657+0000: 30905: debug : virThreadJobClear:119 : Thread 30905 (virNetServerHandleJob) finished job remoteDispatchConnectSupportsFeature with ret=0
2019-05-31 11:58:55.657+0000: 30905: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.657+0000: 30905: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.657+0000: 30905: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565ade60
2019-05-31 11:58:55.657+0000: 30905: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.657+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x557456599160
2019-05-31 11:58:55.657+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565ade60
2019-05-31 11:58:55.657+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.657+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x557456599160
2019-05-31 11:58:55.657+0000: 30904: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.657+0000: 30904: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.657+0000: 30904: debug : virThreadJobSet:94 : Thread 30904 (virNetServerHandleJob) is now running job remoteDispatchConnectOpen
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpen:1118 : name=
2019-05-31 11:58:55.657+0000: 30904: info : virObjectNew:248 : OBJECT_NEW: obj=0x7f3b00001100 classname=virConnect
2019-05-31 11:58:55.657+0000: 30904: debug : virConfLoadConfig:1572 : Loading config file '/etc/libvirt/libvirt.conf'
2019-05-31 11:58:55.657+0000: 30904: debug : virConfReadFile:748 : filename=/etc/libvirt/libvirt.conf
2019-05-31 11:58:55.657+0000: 30904: debug : virFileClose:113 : Closed fd 27
2019-05-31 11:58:55.657+0000: 30904: debug : virConfGetValueString:893 : Get value string (nil) 0
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:894 : Trying to probe for default URI
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:901 : OPENVZ driver URI probe returned ''
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:901 : xenlight driver URI probe returned ''
2019-05-31 11:58:55.657+0000: 30904: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac8114c20
2019-05-31 11:58:55.657+0000: 30904: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac8114c20
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:901 : QEMU driver URI probe returned 'qemu:///system'
2019-05-31 11:58:55.657+0000: 30904: debug : virConfGetValueStringList:942 : Get value string list (nil) 0
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:939 : Split "qemu:///system" to URI components:
scheme qemu
server <null>
user <null>
port 0
path /system
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:996 : trying driver 0 (Test) ...
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1011 : Checking for supported URI schemes
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1020 : No matching URI scheme
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:996 : trying driver 1 (OPENVZ) ...
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1011 : Checking for supported URI schemes
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1020 : No matching URI scheme
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:996 : trying driver 2 (VMWARE) ...
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1011 : Checking for supported URI schemes
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1020 : No matching URI scheme
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:996 : trying driver 3 (ESX) ...
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1011 : Checking for supported URI schemes
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1020 : No matching URI scheme
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:996 : trying driver 4 (remote) ...
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1024 : Matching any URI scheme for 'qemu'
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1047 : driver 4 remote returned DECLINED
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:996 : trying driver 5 (network) ...
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1011 : Checking for supported URI schemes
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1020 : No matching URI scheme
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:996 : trying driver 6 (interface) ...
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1011 : Checking for supported URI schemes
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1020 : No matching URI scheme
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:996 : trying driver 7 (storage) ...
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1011 : Checking for supported URI schemes
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1020 : No matching URI scheme
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:996 : trying driver 8 (nodedev) ...
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1011 : Checking for supported URI schemes
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1020 : No matching URI scheme
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:996 : trying driver 9 (secret) ...
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1011 : Checking for supported URI schemes
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1020 : No matching URI scheme
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:996 : trying driver 10 (nwfilter) ...
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1011 : Checking for supported URI schemes
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1020 : No matching URI scheme
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:996 : trying driver 11 (xenlight) ...
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1011 : Checking for supported URI schemes
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1020 : No matching URI scheme
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:996 : trying driver 12 (QEMU) ...
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1011 : Checking for supported URI schemes
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1014 : Matched URI scheme 'qemu'
2019-05-31 11:58:55.657+0000: 30904: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac8114c20
2019-05-31 11:58:55.657+0000: 30904: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565983e0
2019-05-31 11:58:55.657+0000: 30904: debug : virAccessManagerCheckConnect:217 : manager=0x5574565983e0(name=stack) driver=QEMU perm=0
2019-05-31 11:58:55.657+0000: 30904: debug : virAccessManagerCheckConnect:217 : manager=0x557456598630(name=none) driver=QEMU perm=0
2019-05-31 11:58:55.657+0000: 30904: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565983e0
2019-05-31 11:58:55.657+0000: 30904: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac8114c20
2019-05-31 11:58:55.657+0000: 30904: debug : virConnectOpenInternal:1047 : driver 12 QEMU returned SUCCESS
2019-05-31 11:58:55.657+0000: 30904: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b00001100
2019-05-31 11:58:55.657+0000: 30904: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b00001100
2019-05-31 11:58:55.657+0000: 30904: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b00001100
2019-05-31 11:58:55.657+0000: 30904: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b00001100
2019-05-31 11:58:55.657+0000: 30904: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b00001100
2019-05-31 11:58:55.657+0000: 30904: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b00001100
2019-05-31 11:58:55.657+0000: 30904: debug : virThreadJobClear:119 : Thread 30904 (virNetServerHandleJob) finished job remoteDispatchConnectOpen with ret=0
2019-05-31 11:58:55.657+0000: 30904: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.657+0000: 30904: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.657+0000: 30904: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565ade60
2019-05-31 11:58:55.657+0000: 30904: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.658+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x557456599160
2019-05-31 11:58:55.658+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565ade60
2019-05-31 11:58:55.658+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.658+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x557456599160
2019-05-31 11:58:55.658+0000: 30906: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.658+0000: 30906: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.658+0000: 30906: debug : virThreadJobSet:94 : Thread 30906 (virNetServerHandleJob) is now running job remoteDispatchConnectGetURI
2019-05-31 11:58:55.658+0000: 30906: debug : virConnectGetURI:255 : conn=0x7f3b00001100
2019-05-31 11:58:55.658+0000: 30906: debug : virThreadJobClear:119 : Thread 30906 (virNetServerHandleJob) finished job remoteDispatchConnectGetURI with ret=0
2019-05-31 11:58:55.658+0000: 30906: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.658+0000: 30906: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.658+0000: 30906: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565ade60
2019-05-31 11:58:55.658+0000: 30906: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.658+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x557456599160
2019-05-31 11:58:55.658+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565ade60
2019-05-31 11:58:55.658+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.658+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x557456599160
2019-05-31 11:58:55.658+0000: 30907: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.658+0000: 30907: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.658+0000: 30907: debug : virThreadJobSet:94 : Thread 30907 (virNetServerHandleJob) is now running job remoteDispatchConnectSupportsFeature
2019-05-31 11:58:55.658+0000: 30907: debug : virThreadJobClear:119 : Thread 30907 (virNetServerHandleJob) finished job remoteDispatchConnectSupportsFeature with ret=0
2019-05-31 11:58:55.658+0000: 30907: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.658+0000: 30907: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.658+0000: 30907: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565ade60
2019-05-31 11:58:55.658+0000: 30907: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.658+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x557456599160
2019-05-31 11:58:55.658+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565ade60
2019-05-31 11:58:55.658+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.658+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x557456599160
2019-05-31 11:58:55.658+0000: 30908: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.658+0000: 30908: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.658+0000: 30908: debug : virThreadJobSet:94 : Thread 30908 (virNetServerHandleJob) is now running job remoteDispatchConnectSupportsFeature
2019-05-31 11:58:55.658+0000: 30908: debug : virThreadJobClear:119 : Thread 30908 (virNetServerHandleJob) finished job remoteDispatchConnectSupportsFeature with ret=0
2019-05-31 11:58:55.658+0000: 30908: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.658+0000: 30908: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.658+0000: 30908: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565ade60
2019-05-31 11:58:55.658+0000: 30908: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.658+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x557456599160
2019-05-31 11:58:55.658+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565ade60
2019-05-31 11:58:55.658+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.658+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x557456599160
2019-05-31 11:58:55.658+0000: 30905: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.658+0000: 30905: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.658+0000: 30905: debug : virThreadJobSet:94 : Thread 30905 (virNetServerHandleJob) is now running job remoteDispatchConnectRegisterCloseCallback
2019-05-31 11:58:55.658+0000: 30905: debug : virConnectRegisterCloseCallback:1375 : conn=0x7f3b00001100
2019-05-31 11:58:55.658+0000: 30905: debug : virThreadJobClear:119 : Thread 30905 (virNetServerHandleJob) finished job remoteDispatchConnectRegisterCloseCallback with ret=0
2019-05-31 11:58:55.658+0000: 30905: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.658+0000: 30905: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.658+0000: 30905: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565ade60
2019-05-31 11:58:55.658+0000: 30905: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.659+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x557456599160
2019-05-31 11:58:55.659+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565ade60
2019-05-31 11:58:55.659+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.659+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x557456599160
2019-05-31 11:58:55.659+0000: 30909: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.659+0000: 30909: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.659+0000: 30909: debug : virThreadJobSet:94 : Thread 30909 (virNetServerHandleJob) is now running job remoteDispatchDomainLookupByName
2019-05-31 11:58:55.659+0000: 30909: debug : virDomainLookupByName:412 : conn=0x7f3b00001100, name=drache
2019-05-31 11:58:55.659+0000: 30909: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac816de60
2019-05-31 11:58:55.659+0000: 30909: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565983e0
2019-05-31 11:58:55.659+0000: 30909: debug : virAccessManagerCheckDomain:233 : manager=0x5574565983e0(name=stack) driver=QEMU domain=0x7f3ac816e560 perm=0
2019-05-31 11:58:55.659+0000: 30909: debug : virAccessManagerCheckDomain:233 : manager=0x557456598630(name=none) driver=QEMU domain=0x7f3ac816e560 perm=0
2019-05-31 11:58:55.659+0000: 30909: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565983e0
2019-05-31 11:58:55.659+0000: 30909: info : virObjectNew:248 : OBJECT_NEW: obj=0x7f3aec0013b0 classname=virDomain
2019-05-31 11:58:55.659+0000: 30909: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b00001100
2019-05-31 11:58:55.659+0000: 30909: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac816de60
2019-05-31 11:58:55.659+0000: 30909: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3aec0013b0
2019-05-31 11:58:55.659+0000: 30909: info : virObjectUnref:346 : OBJECT_DISPOSE: obj=0x7f3aec0013b0
2019-05-31 11:58:55.659+0000: 30909: debug : virDomainDispose:318 : release domain 0x7f3aec0013b0 drache db4e9ace-f27e-3981-1d57-a560bc6c132c
2019-05-31 11:58:55.659+0000: 30909: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b00001100
2019-05-31 11:58:55.659+0000: 30909: debug : virThreadJobClear:119 : Thread 30909 (virNetServerHandleJob) finished job remoteDispatchDomainLookupByName with ret=0
2019-05-31 11:58:55.659+0000: 30909: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.659+0000: 30909: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.659+0000: 30909: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565ade60
2019-05-31 11:58:55.659+0000: 30909: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.659+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x557456599160
2019-05-31 11:58:55.659+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565ade60
2019-05-31 11:58:55.659+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.659+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x557456599160
2019-05-31 11:58:55.659+0000: 30906: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.659+0000: 30906: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.659+0000: 30906: debug : virThreadJobSet:94 : Thread 30906 (virNetServerHandleJob) is now running job remoteDispatchConnectDomainEventCallbackRegisterAny
2019-05-31 11:58:55.659+0000: 30906: info : virObjectNew:248 : OBJECT_NEW: obj=0x7f3afc0015f0 classname=virDomain
2019-05-31 11:58:55.659+0000: 30906: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b00001100
2019-05-31 11:58:55.659+0000: 30906: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.659+0000: 30906: debug : virConnectDomainEventRegisterAny:9266 : dom=0x7f3afc0015f0, (VM: name=drache, uuid=db4e9ace-f27e-3981-1d57-a560bc6c132c), conn=0x7f3b00001100, eventID=8, cb=0x5574560ef7f0, opaque=0x7f3afc0013a0, freecb=0x5574560ea780
2019-05-31 11:58:55.659+0000: 30906: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565983e0
2019-05-31 11:58:55.659+0000: 30906: debug : virAccessManagerCheckConnect:217 : manager=0x5574565983e0(name=stack) driver=QEMU perm=3
2019-05-31 11:58:55.659+0000: 30906: debug : virAccessManagerCheckConnect:217 : manager=0x557456598630(name=none) driver=QEMU perm=3
2019-05-31 11:58:55.659+0000: 30906: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565983e0
2019-05-31 11:58:55.659+0000: 30906: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac8110390
2019-05-31 11:58:55.659+0000: 30906: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b00001100
2019-05-31 11:58:55.659+0000: 30906: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3afc0015f0
2019-05-31 11:58:55.659+0000: 30906: info : virObjectUnref:346 : OBJECT_DISPOSE: obj=0x7f3afc0015f0
2019-05-31 11:58:55.659+0000: 30906: debug : virDomainDispose:318 : release domain 0x7f3afc0015f0 drache db4e9ace-f27e-3981-1d57-a560bc6c132c
2019-05-31 11:58:55.659+0000: 30906: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b00001100
2019-05-31 11:58:55.659+0000: 30906: debug : virThreadJobClear:119 : Thread 30906 (virNetServerHandleJob) finished job remoteDispatchConnectDomainEventCallbackRegisterAny with ret=0
2019-05-31 11:58:55.659+0000: 30906: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.659+0000: 30906: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.659+0000: 30906: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565ade60
2019-05-31 11:58:55.659+0000: 30906: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.659+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x557456599160
2019-05-31 11:58:55.659+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565ade60
2019-05-31 11:58:55.659+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.659+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x557456599160
2019-05-31 11:58:55.659+0000: 30907: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.659+0000: 30907: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.659+0000: 30907: debug : virThreadJobSet:94 : Thread 30907 (virNetServerHandleJob) is now running job remoteDispatchConnectDomainEventCallbackRegisterAny
2019-05-31 11:58:55.659+0000: 30907: info : virObjectNew:248 : OBJECT_NEW: obj=0x7f3ae8001560 classname=virDomain
2019-05-31 11:58:55.659+0000: 30907: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b00001100
2019-05-31 11:58:55.659+0000: 30907: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.659+0000: 30907: debug : virConnectDomainEventRegisterAny:9266 : dom=0x7f3ae8001560, (VM: name=drache, uuid=db4e9ace-f27e-3981-1d57-a560bc6c132c), conn=0x7f3b00001100, eventID=16, cb=0x5574560eeb10, opaque=0x7f3ae8001310, freecb=0x5574560ea780
2019-05-31 11:58:55.659+0000: 30907: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565983e0
2019-05-31 11:58:55.659+0000: 30907: debug : virAccessManagerCheckConnect:217 : manager=0x5574565983e0(name=stack) driver=QEMU perm=3
2019-05-31 11:58:55.659+0000: 30907: debug : virAccessManagerCheckConnect:217 : manager=0x557456598630(name=none) driver=QEMU perm=3
2019-05-31 11:58:55.659+0000: 30907: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565983e0
2019-05-31 11:58:55.659+0000: 30907: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac8110390
2019-05-31 11:58:55.659+0000: 30907: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b00001100
2019-05-31 11:58:55.659+0000: 30907: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ae8001560
2019-05-31 11:58:55.659+0000: 30907: info : virObjectUnref:346 : OBJECT_DISPOSE: obj=0x7f3ae8001560
2019-05-31 11:58:55.659+0000: 30907: debug : virDomainDispose:318 : release domain 0x7f3ae8001560 drache db4e9ace-f27e-3981-1d57-a560bc6c132c
2019-05-31 11:58:55.659+0000: 30907: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b00001100
2019-05-31 11:58:55.659+0000: 30907: debug : virThreadJobClear:119 : Thread 30907 (virNetServerHandleJob) finished job remoteDispatchConnectDomainEventCallbackRegisterAny with ret=0
2019-05-31 11:58:55.659+0000: 30907: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.659+0000: 30907: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.659+0000: 30907: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565ade60
2019-05-31 11:58:55.659+0000: 30907: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.659+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x557456599160
2019-05-31 11:58:55.659+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565ade60
2019-05-31 11:58:55.659+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.659+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x557456599160
2019-05-31 11:58:55.659+0000: 30903: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.659+0000: 30903: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.659+0000: 30903: debug : virThreadJobSet:94 : Thread 30903 (virNetServerHandleJob) is now running job remoteDispatchDomainBlockCommit
2019-05-31 11:58:55.659+0000: 30903: info : virObjectNew:248 : OBJECT_NEW: obj=0x7f3b080037b0 classname=virDomain
2019-05-31 11:58:55.659+0000: 30903: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b00001100
2019-05-31 11:58:55.659+0000: 30903: debug : virDomainBlockCommit:10495 : dom=0x7f3b080037b0, (VM: name=drache, uuid=db4e9ace-f27e-3981-1d57-a560bc6c132c), disk=vda, base=<null>, top=<null>, bandwidth=0, flags=0x4
2019-05-31 11:58:55.659+0000: 30903: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac816de60
2019-05-31 11:58:55.659+0000: 30903: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac8114c20
2019-05-31 11:58:55.659+0000: 30903: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565983e0
2019-05-31 11:58:55.659+0000: 30903: debug : virAccessManagerCheckDomain:233 : manager=0x5574565983e0(name=stack) driver=QEMU domain=0x7f3ac816e560 perm=22
2019-05-31 11:58:55.659+0000: 30903: debug : virAccessManagerCheckDomain:233 : manager=0x557456598630(name=none) driver=QEMU domain=0x7f3ac816e560 perm=22
2019-05-31 11:58:55.659+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565983e0
2019-05-31 11:58:55.659+0000: 30903: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac8114c20
2019-05-31 11:58:55.659+0000: 30903: debug : qemuDomainObjBeginJobInternal:6930 : Starting job: job=modify agentJob=none asyncJob=none (vm=0x7f3ac816de60 name=drache, current job=none agentJob=none async=none)
2019-05-31 11:58:55.659+0000: 30903: debug : qemuDomainObjBeginJobInternal:6979 : Started job: modify (async=none vm=0x7f3ac816de60 name=drache)
2019-05-31 11:58:55.659+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac8114c20
2019-05-31 11:58:55.659+0000: 30903: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac8114c20
2019-05-31 11:58:55.659+0000: 30903: debug : virDomainLockImageAttach:263 : plugin=0x7f3ac812ec30 dom=0x7f3ac816de60 src=0x7f3ac816f7c0
2019-05-31 11:58:55.659+0000: 30903: debug : virDomainLockManagerNew:134 : plugin=0x7f3ac812ec30 dom=0x7f3ac816de60 withResources=0
2019-05-31 11:58:55.659+0000: 30903: debug : virLockManagerPluginGetDriver:280 : plugin=0x7f3ac812ec30
2019-05-31 11:58:55.659+0000: 30903: debug : virLockManagerNew:304 : driver=0x7f3b14fae220 type=0 nparams=5 params=0x7f3b108835e0 flags=0x0
2019-05-31 11:58:55.659+0000: 30903: debug : virLockManagerLogParams:97 : key=uuid type=uuid value=db4e9ace-f27e-3981-1d57-a560bc6c132c
2019-05-31 11:58:55.659+0000: 30903: debug : virLockManagerLogParams:90 : key=name type=string value=drache
2019-05-31 11:58:55.659+0000: 30903: debug : virLockManagerLogParams:78 : key=id type=uint value=5
2019-05-31 11:58:55.659+0000: 30903: debug : virLockManagerLogParams:78 : key=pid type=uint value=23158
2019-05-31 11:58:55.659+0000: 30903: debug : virLockManagerLogParams:93 : key=uri type=cstring value=qemu:///system
2019-05-31 11:58:55.659+0000: 30903: debug : virDomainLockManagerAddImage:90 : Add disk /var/lib/libvirt/images/drache3.qcow2
2019-05-31 11:58:55.659+0000: 30903: debug : virLockManagerAddResource:331 : lock=0x7f3b08003ef0 type=0 name=/var/lib/libvirt/images/drache3.qcow2 nparams=0 params=(nil) flags=0x0
2019-05-31 11:58:55.659+0000: 30903: debug : virLockManagerAcquire:349 : lock=0x7f3b08003ef0 state='<null>' flags=0x0 action=0 fd=(nil)
2019-05-31 11:58:55.659+0000: 30903: debug : virLockManagerFree:386 : lock=0x7f3b08003ef0
2019-05-31 11:58:55.659+0000: 30903: debug : qemuSetupImagePathCgroup:75 : Allow path /var/lib/libvirt/images/drache3.qcow2, perms: rw
2019-05-31 11:58:55.659+0000: 30903: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac813da60
2019-05-31 11:58:55.659+0000: 30903: debug : virFileClose:113 : Closed fd 27
2019-05-31 11:58:55.660+0000: 30903: debug : virFileClose:113 : Closed fd 27
2019-05-31 11:58:55.660+0000: 30903: debug : virCommandRunAsync:2488 : About to run LIBVIRT_LOG_OUTPUTS=3:stderr /usr/lib/libvirt/virt-aa-helper -r -u libvirt-db4e9ace-f27e-3981-1d57-a560bc6c132c -f /var/lib/libvirt/images/drache3.qcow2
2019-05-31 11:58:55.660+0000: 30903: debug : virFileClose:113 : Closed fd 30
2019-05-31 11:58:55.660+0000: 30903: debug : virFileClose:113 : Closed fd 32
2019-05-31 11:58:55.660+0000: 30903: debug : virCommandRunAsync:2491 : Command result 0, with PID 31952
2019-05-31 11:58:55.660+0000: 30903: debug : virFileClose:113 : Closed fd 27
2019-05-31 11:58:55.660+0000: 30903: debug : virFileClose:113 : Closed fd 28
2019-05-31 11:58:55.799+0000: 30903: debug : virCommandRun:2339 : Result status 0, stdout: '' stderr: ''
2019-05-31 11:58:55.799+0000: 30903: debug : virFileClose:113 : Closed fd 29
2019-05-31 11:58:55.799+0000: 30903: debug : virFileClose:113 : Closed fd 31
2019-05-31 11:58:55.800+0000: 30903: debug : virFileClose:113 : Closed fd 28
2019-05-31 11:58:55.801+0000: 30903: debug : virFileClose:113 : Closed fd 27
2019-05-31 11:58:55.801+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac813da60
2019-05-31 11:58:55.801+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac8114c20
2019-05-31 11:58:55.801+0000: 30903: debug : qemuDomainObjEnterMonitorInternal:7371 : Entering monitor (mon=0x7f3ac0104150 vm=0x7f3ac816de60 name=drache)
2019-05-31 11:58:55.801+0000: 30903: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac0104150
2019-05-31 11:58:55.801+0000: 30903: debug : qemuMonitorDiskNameLookup:3333 : mon:0x7f3ac0104150 vm:0x7f3ac816de60 json:1 fd:22
2019-05-31 11:58:55.802+0000: 30903: debug : qemuMonitorJSONCommandWithFd:304 : Send command '{"execute":"query-block","id":"libvirt-14"}' for write with FD -1
2019-05-31 11:58:55.802+0000: 30903: info : qemuMonitorSend:1081 : QEMU_MONITOR_SEND_MSG: mon=0x7f3ac0104150 msg={"execute":"query-block","id":"libvirt-14"}
fd=-1
2019-05-31 11:58:55.802+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac0104150
2019-05-31 11:58:55.802+0000: 30902: info : qemuMonitorIOWrite:549 : QEMU_MONITOR_IO_WRITE: mon=0x7f3ac0104150 buf={"execute":"query-block","id":"libvirt-14"}
len=45 ret=45 errno=0
2019-05-31 11:58:55.802+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac0104150
2019-05-31 11:58:55.803+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac0104150
2019-05-31 11:58:55.803+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac0104150
2019-05-31 11:58:55.803+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac0104150
2019-05-31 11:58:55.803+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac0104150
2019-05-31 11:58:55.803+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac0104150
2019-05-31 11:58:55.803+0000: 30902: debug : qemuMonitorJSONIOProcessLine:196 : Line [{"return": [{"io-status": "ok", "device": "drive-virtio-disk0", "locked": false, "removable": false, "inserted": {"iops_rd": 0, "detect_zeroes": "off", "image": {"backing-image": {"virtual-size": 214748364800, "filename": "/var/lib/libvirt/images/drache3.qcow2", "cluster-size": 65536, "format": "qcow2", "actual-size": 210893295616, "format-specific": {"type": "qcow2", "data": {"compat": "1.1", "lazy-refcounts": false, "refcount-bits": 16, "corrupt": false}}, "dirty-flag": false}, "backing-filename-format": "qcow2", "virtual-size": 214748364800, "filename": "/var/lib/libvirt/images/drache_overlaya.qcow2", "cluster-size": 65536, "format": "qcow2", "actual-size": 90944700416, "format-specific": {"type": "qcow2", "data": {"compat": "1.1", "lazy-refcounts": false, "refcount-bits": 16, "corrupt": false}}, "full-backing-filename": "/var/lib/libvirt/images/drache3.qcow2", "backing-filename": "/var/lib/libvirt/images/drache3.qcow2", "dirty-flag": false}, "iops_wr": 0, "ro": false, "node-name": "#block179", "backing_file_depth": 1, "drv": "qcow2", "iops": 0, "bps_wr": 0, "write_threshold": 0, "backing_file": "/var/lib/libvirt/images/drache3.qcow2", "encrypted": false, "bps": 0, "bps_rd": 0, "cache": {"no-flush": false, "direct": true, "writeback": true}, "file": "/var/lib/libvirt/images/drache_overlaya.qcow2", "encryption_key_missing": false}, "qdev": "/machine/peripheral/virtio-disk0/virtio-backend", "type": "unknown"}, {"io-status": "ok", "device": "drive-virtio-disk1", "locked": false, "removable": false, "inserted": {"iops_rd": 0, "detect_zeroes": "off", "image": {"backing-image": {"virtual-size": 429496729600, "filename": "/var/lib/libvirt/images/drache_addon.qcow2", "cluster-size": 65536, "format": "qcow2", "actual-size": 395671379968, "format-specific": {"type": "qcow2", "data": {"compat": "1.1", "lazy-refcounts": false, "refcount-bits": 16, "corrupt": false}}, "dirty-flag": false}, "backing-filename-format": "qcow2", "virtual-size": 429496729600, "filename": "/var/lib/libvirt/images/drache_overlayb.qcow2", "cluster-size": 65536, "format": "qcow2", "actual-size": 115860705280, "format-specific": {"type": "qcow2", "data": {"compat": "1.1", "lazy-refcounts": false, "refcount-bits": 16, "corrupt": false}}, "full-backing-filename": "/var/lib/libvirt/images/drache_addon.qcow2", "backing-filename": "/var/lib/libvirt/images/drache_addon.qcow2", "dirty-flag": false}, "iops_wr": 0, "ro": false, "node-name": "#block567", "backing_file_depth": 1, "drv": "qcow2", "iops": 0, "bps_wr": 0, "write_threshold": 0, "backing_file": "/var/lib/libvirt/images/drache_addon.qcow2", "encrypted": false, "bps": 0, "bps_rd": 0, "cache": {"no-flush": false, "direct": true, "writeback": true}, "file": "/var/lib/libvirt/images/drache_overlayb.qcow2", "encryption_key_missing": false}, "qdev": "/machine/peripheral/virtio-disk1/virtio-backend", "type": "unknown"}], "id": "libvirt-14"}]
2019-05-31 11:58:55.803+0000: 30902: info : qemuMonitorJSONIOProcessLine:216 : QEMU_MONITOR_RECV_REPLY: mon=0x7f3ac0104150 reply={"return": [{"io-status": "ok", "device": "drive-virtio-disk0", "locked": false, "removable": false, "inserted": {"iops_rd": 0, "detect_zeroes": "off", "image": {"backing-image": {"virtual-size": 214748364800, "filename": "/var/lib/libvirt/images/drache3.qcow2", "cluster-size": 65536, "format": "qcow2", "actual-size": 210893295616, "format-specific": {"type": "qcow2", "data": {"compat": "1.1", "lazy-refcounts": false, "refcount-bits": 16, "corrupt": false}}, "dirty-flag": false}, "backing-filename-format": "qcow2", "virtual-size": 214748364800, "filename": "/var/lib/libvirt/images/drache_overlaya.qcow2", "cluster-size": 65536, "format": "qcow2", "actual-size": 90944700416, "format-specific": {"type": "qcow2", "data": {"compat": "1.1", "lazy-refcounts": false, "refcount-bits": 16, "corrupt": false}}, "full-backing-filename": "/var/lib/libvirt/images/drache3.qcow2", "backing-filename": "/var/lib/libvirt/images/drache3.qcow2", "dirty-flag": false}, "iops_wr": 0, "ro": false, "node-name": "#block179", "backing_file_depth": 1, "drv": "qcow2", "iops": 0, "bps_wr": 0, "write_threshold": 0, "backing_file": "/var/lib/libvirt/images/drache3.qcow2", "encrypted": false, "bps": 0, "bps_rd": 0, "cache": {"no-flush": false, "direct": true, "writeback": true}, "file": "/var/lib/libvirt/images/drache_overlaya.qcow2", "encryption_key_missing": false}, "qdev": "/machine/peripheral/virtio-disk0/virtio-backend", "type": "unknown"}, {"io-status": "ok", "device": "drive-virtio-disk1", "locked": false, "removable": false, "inserted": {"iops_rd": 0, "detect_zeroes": "off", "image": {"backing-image": {"virtual-size": 429496729600, "filename": "/var/lib/libvirt/images/drache_addon.qcow2", "cluster-size": 65536, "format": "qcow2", "actual-size": 395671379968, "format-specific": {"type": "qcow2", "data": {"compat": "1.1", "lazy-refcounts": false, "refcount-bits": 16, "corrupt": false}}, "dirty-flag": false}, "backing-filename-format": "qcow2", "virtual-size": 429496729600, "filename": "/var/lib/libvirt/images/drache_overlayb.qcow2", "cluster-size": 65536, "format": "qcow2", "actual-size": 115860705280, "format-specific": {"type": "qcow2", "data": {"compat": "1.1", "lazy-refcounts": false, "refcount-bits": 16, "corrupt": false}}, "full-backing-filename": "/var/lib/libvirt/images/drache_addon.qcow2", "backing-filename": "/var/lib/libvirt/images/drache_addon.qcow2", "dirty-flag": false}, "iops_wr": 0, "ro": false, "node-name": "#block567", "backing_file_depth": 1, "drv": "qcow2", "iops": 0, "bps_wr": 0, "write_threshold": 0, "backing_file": "/var/lib/libvirt/images/drache_addon.qcow2", "encrypted": false, "bps": 0, "bps_rd": 0, "cache": {"no-flush": false, "direct": true, "writeback": true}, "file": "/var/lib/libvirt/images/drache_overlayb.qcow2", "encryption_key_missing": false}, "qdev": "/machine/peripheral/virtio-disk1/virtio-backend", "type": "unknown"}], "id": "libvirt-14"}
2019-05-31 11:58:55.803+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac0104150
2019-05-31 11:58:55.803+0000: 30903: debug : qemuMonitorJSONCommandWithFd:309 : Receive command reply ret=0 rxObject=0x557456587d10
2019-05-31 11:58:55.803+0000: 30903: debug : qemuMonitorDiskNameLookup:3333 : mon:0x7f3ac0104150 vm:0x7f3ac816de60 json:1 fd:22
2019-05-31 11:58:55.803+0000: 30903: debug : qemuMonitorJSONCommandWithFd:304 : Send command '{"execute":"query-block","id":"libvirt-15"}' for write with FD -1
2019-05-31 11:58:55.803+0000: 30903: info : qemuMonitorSend:1081 : QEMU_MONITOR_SEND_MSG: mon=0x7f3ac0104150 msg={"execute":"query-block","id":"libvirt-15"}
fd=-1
2019-05-31 11:58:55.803+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac0104150
2019-05-31 11:58:55.803+0000: 30902: info : qemuMonitorIOWrite:549 : QEMU_MONITOR_IO_WRITE: mon=0x7f3ac0104150 buf={"execute":"query-block","id":"libvirt-15"}
len=45 ret=45 errno=0
2019-05-31 11:58:55.803+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac0104150
2019-05-31 11:58:55.804+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac0104150
2019-05-31 11:58:55.804+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac0104150
2019-05-31 11:58:55.804+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac0104150
2019-05-31 11:58:55.804+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac0104150
2019-05-31 11:58:55.804+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac0104150
2019-05-31 11:58:55.804+0000: 30902: debug : qemuMonitorJSONIOProcessLine:196 : Line [{"return": [{"io-status": "ok", "device": "drive-virtio-disk0", "locked": false, "removable": false, "inserted": {"iops_rd": 0, "detect_zeroes": "off", "image": {"backing-image": {"virtual-size": 214748364800, "filename": "/var/lib/libvirt/images/drache3.qcow2", "cluster-size": 65536, "format": "qcow2", "actual-size": 210893295616, "format-specific": {"type": "qcow2", "data": {"compat": "1.1", "lazy-refcounts": false, "refcount-bits": 16, "corrupt": false}}, "dirty-flag": false}, "backing-filename-format": "qcow2", "virtual-size": 214748364800, "filename": "/var/lib/libvirt/images/drache_overlaya.qcow2", "cluster-size": 65536, "format": "qcow2", "actual-size": 90944700416, "format-specific": {"type": "qcow2", "data": {"compat": "1.1", "lazy-refcounts": false, "refcount-bits": 16, "corrupt": false}}, "full-backing-filename": "/var/lib/libvirt/images/drache3.qcow2", "backing-filename": "/var/lib/libvirt/images/drache3.qcow2", "dirty-flag": false}, "iops_wr": 0, "ro": false, "node-name": "#block179", "backing_file_depth": 1, "drv": "qcow2", "iops": 0, "bps_wr": 0, "write_threshold": 0, "backing_file": "/var/lib/libvirt/images/drache3.qcow2", "encrypted": false, "bps": 0, "bps_rd": 0, "cache": {"no-flush": false, "direct": true, "writeback": true}, "file": "/var/lib/libvirt/images/drache_overlaya.qcow2", "encryption_key_missing": false}, "qdev": "/machine/peripheral/virtio-disk0/virtio-backend", "type": "unknown"}, {"io-status": "ok", "device": "drive-virtio-disk1", "locked": false, "removable": false, "inserted": {"iops_rd": 0, "detect_zeroes": "off", "image": {"backing-image": {"virtual-size": 429496729600, "filename": "/var/lib/libvirt/images/drache_addon.qcow2", "cluster-size": 65536, "format": "qcow2", "actual-size": 395671379968, "format-specific": {"type": "qcow2", "data": {"compat": "1.1", "lazy-refcounts": false, "refcount-bits": 16, "corrupt": false}}, "dirty-flag": false}, "backing-filename-format": "qcow2", "virtual-size": 429496729600, "filename": "/var/lib/libvirt/images/drache_overlayb.qcow2", "cluster-size": 65536, "format": "qcow2", "actual-size": 115860705280, "format-specific": {"type": "qcow2", "data": {"compat": "1.1", "lazy-refcounts": false, "refcount-bits": 16, "corrupt": false}}, "full-backing-filename": "/var/lib/libvirt/images/drache_addon.qcow2", "backing-filename": "/var/lib/libvirt/images/drache_addon.qcow2", "dirty-flag": false}, "iops_wr": 0, "ro": false, "node-name": "#block567", "backing_file_depth": 1, "drv": "qcow2", "iops": 0, "bps_wr": 0, "write_threshold": 0, "backing_file": "/var/lib/libvirt/images/drache_addon.qcow2", "encrypted": false, "bps": 0, "bps_rd": 0, "cache": {"no-flush": false, "direct": true, "writeback": true}, "file": "/var/lib/libvirt/images/drache_overlayb.qcow2", "encryption_key_missing": false}, "qdev": "/machine/peripheral/virtio-disk1/virtio-backend", "type": "unknown"}], "id": "libvirt-15"}]
2019-05-31 11:58:55.804+0000: 30902: info : qemuMonitorJSONIOProcessLine:216 : QEMU_MONITOR_RECV_REPLY: mon=0x7f3ac0104150 reply={"return": [{"io-status": "ok", "device": "drive-virtio-disk0", "locked": false, "removable": false, "inserted": {"iops_rd": 0, "detect_zeroes": "off", "image": {"backing-image": {"virtual-size": 214748364800, "filename": "/var/lib/libvirt/images/drache3.qcow2", "cluster-size": 65536, "format": "qcow2", "actual-size": 210893295616, "format-specific": {"type": "qcow2", "data": {"compat": "1.1", "lazy-refcounts": false, "refcount-bits": 16, "corrupt": false}}, "dirty-flag": false}, "backing-filename-format": "qcow2", "virtual-size": 214748364800, "filename": "/var/lib/libvirt/images/drache_overlaya.qcow2", "cluster-size": 65536, "format": "qcow2", "actual-size": 90944700416, "format-specific": {"type": "qcow2", "data": {"compat": "1.1", "lazy-refcounts": false, "refcount-bits": 16, "corrupt": false}}, "full-backing-filename": "/var/lib/libvirt/images/drache3.qcow2", "backing-filename": "/var/lib/libvirt/images/drache3.qcow2", "dirty-flag": false}, "iops_wr": 0, "ro": false, "node-name": "#block179", "backing_file_depth": 1, "drv": "qcow2", "iops": 0, "bps_wr": 0, "write_threshold": 0, "backing_file": "/var/lib/libvirt/images/drache3.qcow2", "encrypted": false, "bps": 0, "bps_rd": 0, "cache": {"no-flush": false, "direct": true, "writeback": true}, "file": "/var/lib/libvirt/images/drache_overlaya.qcow2", "encryption_key_missing": false}, "qdev": "/machine/peripheral/virtio-disk0/virtio-backend", "type": "unknown"}, {"io-status": "ok", "device": "drive-virtio-disk1", "locked": false, "removable": false, "inserted": {"iops_rd": 0, "detect_zeroes": "off", "image": {"backing-image": {"virtual-size": 429496729600, "filename": "/var/lib/libvirt/images/drache_addon.qcow2", "cluster-size": 65536, "format": "qcow2", "actual-size": 395671379968, "format-specific": {"type": "qcow2", "data": {"compat": "1.1", "lazy-refcounts": false, "refcount-bits": 16, "corrupt": false}}, "dirty-flag": false}, "backing-filename-format": "qcow2", "virtual-size": 429496729600, "filename": "/var/lib/libvirt/images/drache_overlayb.qcow2", "cluster-size": 65536, "format": "qcow2", "actual-size": 115860705280, "format-specific": {"type": "qcow2", "data": {"compat": "1.1", "lazy-refcounts": false, "refcount-bits": 16, "corrupt": false}}, "full-backing-filename": "/var/lib/libvirt/images/drache_addon.qcow2", "backing-filename": "/var/lib/libvirt/images/drache_addon.qcow2", "dirty-flag": false}, "iops_wr": 0, "ro": false, "node-name": "#block567", "backing_file_depth": 1, "drv": "qcow2", "iops": 0, "bps_wr": 0, "write_threshold": 0, "backing_file": "/var/lib/libvirt/images/drache_addon.qcow2", "encrypted": false, "bps": 0, "bps_rd": 0, "cache": {"no-flush": false, "direct": true, "writeback": true}, "file": "/var/lib/libvirt/images/drache_overlayb.qcow2", "encryption_key_missing": false}, "qdev": "/machine/peripheral/virtio-disk1/virtio-backend", "type": "unknown"}], "id": "libvirt-15"}
2019-05-31 11:58:55.804+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac0104150
2019-05-31 11:58:55.804+0000: 30903: debug : qemuMonitorJSONCommandWithFd:309 : Receive command reply ret=0 rxObject=0x5574565884b0
2019-05-31 11:58:55.804+0000: 30903: debug : qemuMonitorBlockCommit:3305 : device=drive-virtio-disk0, top=/var/lib/libvirt/images/drache_overlaya.qcow2, base=/var/lib/libvirt/images/drache3.qcow2, backingName=<null>, bandwidth=0
2019-05-31 11:58:55.804+0000: 30903: debug : qemuMonitorBlockCommit:3307 : mon:0x7f3ac0104150 vm:0x7f3ac816de60 json:1 fd:22
2019-05-31 11:58:55.804+0000: 30903: debug : qemuMonitorJSONCommandWithFd:304 : Send command '{"execute":"block-commit","arguments":{"device":"drive-virtio-disk0","top":"/var/lib/libvirt/images/drache_overlaya.qcow2","base":"/var/lib/libvirt/images/drache3.qcow2"},"id":"libvirt-16"}' for write with FD -1
2019-05-31 11:58:55.804+0000: 30903: info : qemuMonitorSend:1081 : QEMU_MONITOR_SEND_MSG: mon=0x7f3ac0104150 msg={"execute":"block-commit","arguments":{"device":"drive-virtio-disk0","top":"/var/lib/libvirt/images/drache_overlaya.qcow2","base":"/var/lib/libvirt/images/drache3.qcow2"},"id":"libvirt-16"}
fd=-1
2019-05-31 11:58:55.804+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac0104150
2019-05-31 11:58:55.804+0000: 30902: info : qemuMonitorIOWrite:549 : QEMU_MONITOR_IO_WRITE: mon=0x7f3ac0104150 buf={"execute":"block-commit","arguments":{"device":"drive-virtio-disk0","top":"/var/lib/libvirt/images/drache_overlaya.qcow2","base":"/var/lib/libvirt/images/drache3.qcow2"},"id":"libvirt-16"}
len=191 ret=191 errno=0
2019-05-31 11:58:55.804+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac0104150
2019-05-31 11:58:55.809+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac0104150
2019-05-31 11:58:55.809+0000: 30902: debug : qemuMonitorJSONIOProcessLine:196 : Line [{"id": "libvirt-16", "error": {"class": "GenericError", "desc": "Could not reopen file: Permission denied"}}]
2019-05-31 11:58:55.809+0000: 30902: info : qemuMonitorJSONIOProcessLine:216 : QEMU_MONITOR_RECV_REPLY: mon=0x7f3ac0104150 reply={"id": "libvirt-16", "error": {"class": "GenericError", "desc": "Could not reopen file: Permission denied"}}
2019-05-31 11:58:55.809+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac0104150
2019-05-31 11:58:55.809+0000: 30903: debug : qemuMonitorJSONCommandWithFd:309 : Receive command reply ret=0 rxObject=0x5574565b15a0
2019-05-31 11:58:55.809+0000: 30903: debug : qemuMonitorJSONCheckError:384 : unable to execute QEMU command {"execute":"block-commit","arguments":{"device":"drive-virtio-disk0","top":"/var/lib/libvirt/images/drache_overlaya.qcow2","base":"/var/lib/libvirt/images/drache3.qcow2"},"id":"libvirt-16"}: {"id":"libvirt-16","error":{"class":"GenericError","desc":"Could not reopen file: Permission denied"}}
2019-05-31 11:58:55.809+0000: 30903: error : qemuMonitorJSONCheckError:395 : internal error: unable to execute QEMU command 'block-commit': Could not reopen file: Permission denied
2019-05-31 11:58:55.809+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac0104150
2019-05-31 11:58:55.809+0000: 30903: debug : qemuDomainObjExitMonitorInternal:7394 : Exited monitor (mon=0x7f3ac0104150 vm=0x7f3ac816de60 name=drache)
2019-05-31 11:58:55.809+0000: 30903: debug : virFileMakePathHelper:3038 : path=/var/run/libvirt/qemu mode=0777
2019-05-31 11:58:55.809+0000: 30903: debug : virFileClose:113 : Closed fd 27
2019-05-31 11:58:55.809+0000: 30903: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac8114c20
2019-05-31 11:58:55.809+0000: 30903: debug : virDomainLockImageAttach:263 : plugin=0x7f3ac812ec30 dom=0x7f3ac816de60 src=0x7f3ac816f7c0
2019-05-31 11:58:55.809+0000: 30903: debug : virDomainLockManagerNew:134 : plugin=0x7f3ac812ec30 dom=0x7f3ac816de60 withResources=0
2019-05-31 11:58:55.809+0000: 30903: debug : virLockManagerPluginGetDriver:280 : plugin=0x7f3ac812ec30
2019-05-31 11:58:55.809+0000: 30903: debug : virLockManagerNew:304 : driver=0x7f3b14fae220 type=0 nparams=5 params=0x7f3b108835e0 flags=0x0
2019-05-31 11:58:55.809+0000: 30903: debug : virLockManagerLogParams:97 : key=uuid type=uuid value=db4e9ace-f27e-3981-1d57-a560bc6c132c
2019-05-31 11:58:55.809+0000: 30903: debug : virLockManagerLogParams:90 : key=name type=string value=drache
2019-05-31 11:58:55.809+0000: 30903: debug : virLockManagerLogParams:78 : key=id type=uint value=5
2019-05-31 11:58:55.809+0000: 30903: debug : virLockManagerLogParams:78 : key=pid type=uint value=23158
2019-05-31 11:58:55.809+0000: 30903: debug : virLockManagerLogParams:93 : key=uri type=cstring value=qemu:///system
2019-05-31 11:58:55.809+0000: 30903: debug : virDomainLockManagerAddImage:90 : Add disk /var/lib/libvirt/images/drache3.qcow2
2019-05-31 11:58:55.809+0000: 30903: debug : virLockManagerAddResource:331 : lock=0x7f3b08005e10 type=0 name=/var/lib/libvirt/images/drache3.qcow2 nparams=0 params=(nil) flags=0x1
2019-05-31 11:58:55.809+0000: 30903: debug : virLockManagerAcquire:349 : lock=0x7f3b08005e10 state='<null>' flags=0x0 action=0 fd=(nil)
2019-05-31 11:58:55.809+0000: 30903: debug : virLockManagerFree:386 : lock=0x7f3b08005e10
2019-05-31 11:58:55.809+0000: 30903: debug : qemuSetupImagePathCgroup:75 : Allow path /var/lib/libvirt/images/drache3.qcow2, perms: r
2019-05-31 11:58:55.809+0000: 30903: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3ac813da60
2019-05-31 11:58:55.809+0000: 30903: debug : virFileClose:113 : Closed fd 27
2019-05-31 11:58:55.809+0000: 30903: debug : virFileClose:113 : Closed fd 27
2019-05-31 11:58:55.810+0000: 30903: debug : virCommandRunAsync:2488 : About to run LIBVIRT_LOG_OUTPUTS=3:stderr /usr/lib/libvirt/virt-aa-helper -r -u libvirt-db4e9ace-f27e-3981-1d57-a560bc6c132c -f /var/lib/libvirt/images/drache3.qcow2
2019-05-31 11:58:55.810+0000: 30903: debug : virFileClose:113 : Closed fd 30
2019-05-31 11:58:55.810+0000: 30903: debug : virFileClose:113 : Closed fd 32
2019-05-31 11:58:55.810+0000: 30903: debug : virCommandRunAsync:2491 : Command result 0, with PID 31956
2019-05-31 11:58:55.810+0000: 30903: debug : virFileClose:113 : Closed fd 27
2019-05-31 11:58:55.810+0000: 30903: debug : virFileClose:113 : Closed fd 28
2019-05-31 11:58:55.948+0000: 30903: debug : virCommandRun:2339 : Result status 0, stdout: '' stderr: ''
2019-05-31 11:58:55.948+0000: 30903: debug : virFileClose:113 : Closed fd 29
2019-05-31 11:58:55.948+0000: 30903: debug : virFileClose:113 : Closed fd 31
2019-05-31 11:58:55.949+0000: 30903: debug : virFileClose:113 : Closed fd 28
2019-05-31 11:58:55.951+0000: 30903: debug : virFileClose:113 : Closed fd 27
2019-05-31 11:58:55.951+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac813da60
2019-05-31 11:58:55.951+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac8114c20
2019-05-31 11:58:55.951+0000: 30903: debug : qemuDomainObjEndJob:7255 : Stopping job: modify (async=none vm=0x7f3ac816de60 name=drache)
2019-05-31 11:58:55.951+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac8114c20
2019-05-31 11:58:55.951+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac816de60
2019-05-31 11:58:55.951+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b080037b0
2019-05-31 11:58:55.951+0000: 30903: info : virObjectUnref:346 : OBJECT_DISPOSE: obj=0x7f3b080037b0
2019-05-31 11:58:55.951+0000: 30903: debug : virDomainDispose:318 : release domain 0x7f3b080037b0 drache db4e9ace-f27e-3981-1d57-a560bc6c132c
2019-05-31 11:58:55.951+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b00001100
2019-05-31 11:58:55.951+0000: 30903: debug : virThreadJobClear:119 : Thread 30903 (virNetServerHandleJob) finished job remoteDispatchDomainBlockCommit with ret=-1
2019-05-31 11:58:55.951+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.951+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.951+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565ade60
2019-05-31 11:58:55.951+0000: 30903: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.951+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x557456599160
2019-05-31 11:58:55.951+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565ade60
2019-05-31 11:58:55.951+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.951+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x557456599160
2019-05-31 11:58:55.952+0000: 30912: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.952+0000: 30912: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.952+0000: 30912: debug : virThreadJobSet:94 : Thread 30912 (virNetServerHandleJob) is now running job remoteDispatchConnectDomainEventCallbackDeregisterAny
2019-05-31 11:58:55.952+0000: 30912: debug : virConnectDomainEventDeregisterAny:9319 : conn=0x7f3b00001100, callbackID=0
2019-05-31 11:58:55.952+0000: 30912: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565983e0
2019-05-31 11:58:55.952+0000: 30912: debug : virAccessManagerCheckConnect:217 : manager=0x5574565983e0(name=stack) driver=QEMU perm=1
2019-05-31 11:58:55.952+0000: 30912: debug : virAccessManagerCheckConnect:217 : manager=0x557456598630(name=none) driver=QEMU perm=1
2019-05-31 11:58:55.952+0000: 30912: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565983e0
2019-05-31 11:58:55.952+0000: 30912: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.952+0000: 30912: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b00001100
2019-05-31 11:58:55.952+0000: 30912: debug : virThreadJobClear:119 : Thread 30912 (virNetServerHandleJob) finished job remoteDispatchConnectDomainEventCallbackDeregisterAny with ret=0
2019-05-31 11:58:55.952+0000: 30912: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.952+0000: 30912: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.952+0000: 30912: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565ade60
2019-05-31 11:58:55.952+0000: 30912: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.952+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x557456599160
2019-05-31 11:58:55.952+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565ade60
2019-05-31 11:58:55.952+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.952+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x557456599160
2019-05-31 11:58:55.952+0000: 30904: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.952+0000: 30904: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.952+0000: 30904: debug : virThreadJobSet:94 : Thread 30904 (virNetServerHandleJob) is now running job remoteDispatchConnectDomainEventCallbackDeregisterAny
2019-05-31 11:58:55.952+0000: 30904: debug : virConnectDomainEventDeregisterAny:9319 : conn=0x7f3b00001100, callbackID=1
2019-05-31 11:58:55.952+0000: 30904: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565983e0
2019-05-31 11:58:55.952+0000: 30904: debug : virAccessManagerCheckConnect:217 : manager=0x5574565983e0(name=stack) driver=QEMU perm=1
2019-05-31 11:58:55.952+0000: 30904: debug : virAccessManagerCheckConnect:217 : manager=0x557456598630(name=none) driver=QEMU perm=1
2019-05-31 11:58:55.952+0000: 30904: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565983e0
2019-05-31 11:58:55.952+0000: 30904: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.952+0000: 30904: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b00001100
2019-05-31 11:58:55.952+0000: 30904: debug : virThreadJobClear:119 : Thread 30904 (virNetServerHandleJob) finished job remoteDispatchConnectDomainEventCallbackDeregisterAny with ret=0
2019-05-31 11:58:55.952+0000: 30904: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.952+0000: 30904: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.952+0000: 30904: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565ade60
2019-05-31 11:58:55.952+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3ac8110390
2019-05-31 11:58:55.952+0000: 30904: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.952+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x557456599160
2019-05-31 11:58:55.952+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565ade60
2019-05-31 11:58:55.952+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.952+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x557456599160
2019-05-31 11:58:55.952+0000: 30906: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.952+0000: 30906: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.952+0000: 30906: debug : virThreadJobSet:94 : Thread 30906 (virNetServerHandleJob) is now running job remoteDispatchConnectUnregisterCloseCallback
2019-05-31 11:58:55.952+0000: 30906: debug : virConnectUnregisterCloseCallback:1410 : conn=0x7f3b00001100
2019-05-31 11:58:55.952+0000: 30906: debug : virThreadJobClear:119 : Thread 30906 (virNetServerHandleJob) finished job remoteDispatchConnectUnregisterCloseCallback with ret=0
2019-05-31 11:58:55.952+0000: 30906: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.952+0000: 30906: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.952+0000: 30906: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565ade60
2019-05-31 11:58:55.952+0000: 30906: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.953+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x557456599160
2019-05-31 11:58:55.953+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565ade60
2019-05-31 11:58:55.953+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x557456599160
2019-05-31 11:58:55.953+0000: 30907: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.953+0000: 30907: info : virObjectRef:382 : OBJECT_REF: obj=0x7f3b08000e80
2019-05-31 11:58:55.953+0000: 30907: debug : virThreadJobSet:94 : Thread 30907 (virNetServerHandleJob) is now running job remoteDispatchConnectClose
2019-05-31 11:58:55.953+0000: 30907: debug : virThreadJobClear:119 : Thread 30907 (virNetServerHandleJob) finished job remoteDispatchConnectClose with ret=0
2019-05-31 11:58:55.953+0000: 30907: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.953+0000: 30907: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.953+0000: 30907: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565ade60
2019-05-31 11:58:55.953+0000: 30907: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.953+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b2310
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.953+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565b8380
2019-05-31 11:58:55.953+0000: 30902: debug : daemonRemoveAllClientStreams:502 : stream=(nil)
2019-05-31 11:58:55.953+0000: 30902: info : virObjectNew:248 : OBJECT_NEW: obj=0x5574565c09b0 classname=virIdentity
2019-05-31 11:58:55.953+0000: 30902: debug : virIdentitySetAttr:241 : ident=0x5574565c09b0 attribute=4 value=30902
2019-05-31 11:58:55.953+0000: 30902: debug : virFileClose:113 : Closed fd 27
2019-05-31 11:58:55.953+0000: 30902: debug : virIdentitySetAttr:241 : ident=0x5574565c09b0 attribute=5 value=32893009
2019-05-31 11:58:55.953+0000: 30902: debug : virIdentitySetAttr:241 : ident=0x5574565c09b0 attribute=0 value=root
2019-05-31 11:58:55.953+0000: 30902: debug : virIdentitySetAttr:241 : ident=0x5574565c09b0 attribute=1 value=0
2019-05-31 11:58:55.953+0000: 30902: debug : virIdentitySetAttr:241 : ident=0x5574565c09b0 attribute=2 value=root
2019-05-31 11:58:55.953+0000: 30902: debug : virIdentitySetAttr:241 : ident=0x5574565c09b0 attribute=3 value=0
2019-05-31 11:58:55.953+0000: 30902: info : virObjectRef:382 : OBJECT_REF: obj=0x5574565c09b0
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565c09b0
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565c09b0
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:346 : OBJECT_DISPOSE: obj=0x5574565c09b0
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565c8d10
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b2310
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:346 : OBJECT_DISPOSE: obj=0x5574565b2310
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565b8380
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:346 : OBJECT_DISPOSE: obj=0x5574565b8380
2019-05-31 11:58:55.953+0000: 30902: debug : virConnectClose:1239 : conn=0x7f3b00001100
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b00001100
2019-05-31 11:58:55.953+0000: 30902: debug : virConnectClose:1239 : conn=0x7f3b00001100
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b00001100
2019-05-31 11:58:55.953+0000: 30902: debug : virConnectClose:1239 : conn=0x7f3b00001100
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b00001100
2019-05-31 11:58:55.953+0000: 30902: debug : virConnectClose:1239 : conn=0x7f3b00001100
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b00001100
2019-05-31 11:58:55.953+0000: 30902: debug : virConnectClose:1239 : conn=0x7f3b00001100
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b00001100
2019-05-31 11:58:55.953+0000: 30902: debug : virConnectClose:1239 : conn=0x7f3b00001100
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b00001100
2019-05-31 11:58:55.953+0000: 30902: debug : virConnectClose:1239 : conn=0x7f3b00001100
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b00001100
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:346 : OBJECT_DISPOSE: obj=0x7f3b00001100
2019-05-31 11:58:55.953+0000: 30902: debug : virCloseCallbacksRun:316 : conn=0x7f3b00001100
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x7f3b08000e80
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:346 : OBJECT_DISPOSE: obj=0x7f3b08000e80
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:344 : OBJECT_UNREF: obj=0x5574565c8d10
2019-05-31 11:58:55.953+0000: 30902: info : virObjectUnref:346 : OBJECT_DISPOSE: obj=0x5574565c8d10
2019-05-31 11:58:55.953+0000: 30902: debug : virFileClose:113 : Closed fd 26
Attachment:
signature.asc
Description: OpenPGP digital signature
_______________________________________________ libvirt-users mailing list libvirt-users@xxxxxxxxxx https://www.redhat.com/mailman/listinfo/libvirt-users
