Bug 1569500

Summary: Guest shutoff after attaching same disk two times then detach the disk
Product: Red Hat Enterprise Linux 7 Reporter: Xiaodai Wang <xiaodwan>
Component: libvirtAssignee: Peter Krempa <pkrempa>
Status: CLOSED DUPLICATE QA Contact: jiyan <jiyan>
Severity: high Docs Contact:
Priority: medium    
Version: 7.5CC: dyuan, juzhou, lmen, mxie, mzhan, pkrempa, rbalakri, tzheng, xiaodwan, xuzhang
Target Milestone: rc   
Target Release: ---   
Hardware: Unspecified   
OS: Unspecified   
Whiteboard:
Fixed In Version: Doc Type: If docs needed, set a value
Doc Text:
Story Points: ---
Clone Of:
: 1584982 (view as bug list) Environment:
Last Closed: 2018-06-01 06:01:01 UTC Type: Bug
Regression: --- Mount Type: ---
Documentation: --- CRM:
Verified Versions: Category: ---
oVirt Team: --- RHEL 7.3 requirements from Atomic Host:
Cloudforms Team: --- Target Upstream Version:
Embargoed:
Bug Depends On:    
Bug Blocks: 1584982    
Attachments:
Description Flags
vm log none

Description Xiaodai Wang 2018-04-19 12:12:48 UTC
Description of problem:
Guest shutoff after attaching same disk two times then detach the disk

Version-Release number of selected component (if applicable):
# rpm -q libvirt qemu-kvm-rhev
libvirt-3.9.0-14.el7_5.3.x86_64
qemu-kvm-rhev-2.10.0-21.el7_5.2.x86_64

How reproducible:
100%

Steps to Reproduce:
1) Hotplug a disk into a running guest.

# virt-xml rhel7.3-1005 --add-device --disk /var/lib/libvirt/images/b.img --update 
Device hotplug successful.
Domain 'rhel7.3-1005' defined successfully.

2) Hotplug same disk to the guest again.
# virt-xml rhel7.3-1005 --add-device --disk /var/lib/libvirt/images/b.img --update --debug
[Thu, 19 Apr 2018 20:04:58 virt-xml 30379] DEBUG (cli:264) Launched with command line: /usr/share/virt-manager/virt-xml rhel7.3-1005 --add-device --disk /var/lib/libvirt/images/b.img --update --debug
[Thu, 19 Apr 2018 20:04:58 virt-xml 30379] DEBUG (cli:278) Requesting libvirt URI default
[Thu, 19 Apr 2018 20:04:58 virt-xml 30379] DEBUG (cli:281) Received libvirt URI qemu:///system
[Thu, 19 Apr 2018 20:04:58 virt-xml 30379] DEBUG (virt-xml:64) XML diff:
--- Original XML
+++ Altered XML
@@ -151,6 +151,11 @@
       <alias name="balloon0"/>
       <address type="pci" domain="0x0000" bus="0x00" slot="0x08" function="0x0"/>
     </memballoon>
+    <disk type="file" device="disk">
+      <driver name="qemu" type="qcow2"/>
+      <source file="/var/lib/libvirt/images/b.img"/>
+      <target dev="vdc"/>
+    </disk>
   </devices>
   <seclabel type="dynamic" model="selinux" relabel="yes">
     <label>system_u:system_r:svirt_t:s0:c95,c361</label>

[Thu, 19 Apr 2018 20:04:58 virt-xml 30379] DEBUG (virt-xml:250) Doing setup for disk=<VirtualDisk disk 140150625953040>
[Thu, 19 Apr 2018 20:04:58 virt-xml 30379] DEBUG (cli:316)   File "/usr/share/virt-manager/virt-xml", line 479, in <module>
    sys.exit(main())
  File "/usr/share/virt-manager/virt-xml", line 463, in main
    update_changes(domain, devs, action, options.confirm)
  File "/usr/share/virt-manager/virt-xml", line 299, in update_changes
    fail(_("Error attempting device %s: %s") % (action, e))
  File "/usr/share/virt-manager/virtinst/cli.py", line 316, in fail
    logging.debug("".join(traceback.format_stack()))

[Thu, 19 Apr 2018 20:04:58 virt-xml 30379] ERROR (cli:317) Error attempting device hotplug: internal error: unable to execute QEMU command '__com.redhat_drive_add': Device 'drive-virtio-disk2' could not be initialized
[Thu, 19 Apr 2018 20:04:58 virt-xml 30379] DEBUG (cli:319) 
Traceback (most recent call last):
  File "/usr/share/virt-manager/virt-xml", line 293, in update_changes
    domain.attachDeviceFlags(xml, libvirt.VIR_DOMAIN_AFFECT_LIVE)
  File "/usr/lib64/python2.7/site-packages/libvirt.py", line 594, in attachDeviceFlags
    if ret == -1: raise libvirtError ('virDomainAttachDeviceFlags() failed', dom=self)
libvirtError: internal error: unable to execute QEMU command '__com.redhat_drive_add': Device 'drive-virtio-disk2' could not be initialized

3) Detach the disk.
# virsh detach-disk rhel7.3-1005 vdb --live
error: Failed to detach disk
error: internal error: End of file from qemu monitor


Actual results:
The guest turns to shutoff state.

Expected results:
The disk should be detached successfully and The guest should still running normally.

Additional info:

Comment 2 Peter Krempa 2018-04-19 12:19:56 UTC
Please attach the VM log file. The VM has crashed so if qemu exited with a core-dump, please include a backtrace too.

Also this is most probably not a libvirt problem.

Comment 3 Xiaodai Wang 2018-04-19 12:24:34 UTC
Created attachment 1424042 [details]
vm log

Comment 4 Peter Krempa 2018-04-19 12:33:54 UTC
So the problem most probably is that libvirt messes up labelling of the disk if the second attaching fails. This means that qemu will not have permission to access the file later.

At any rate, this should not be a reason to abort.

main_channel_handle_message: agent start
Failed to get "write" lock
Unexpected error in raw_apply_lock_bytes() at block/file-posix.c:642:
2018-04-19T12:05:47.871711Z qemu-kvm: Failed to lock byte 100
2018-04-19 12:05:52.848+0000: shutting down, reason=crashed

Comment 5 Xiaodai Wang 2018-04-19 12:39:56 UTC
Do you still need the backtrace? If yes, How and where to get the backtrace? Sorry, i didn't find any coredump file under the directory i ran the command.

Comment 6 Peter Krempa 2018-06-01 06:01:01 UTC
The main problem is that we mess up labelling of the image even when it's used.

This is traced by bug 1524792.

I've also cloned this as https://bugzilla.redhat.com/show_bug.cgi?id=1584982 so that qemu provides a saner behaviour when locking fails.

*** This bug has been marked as a duplicate of bug 1524792 ***