Hi community,
yesterday I noticed that I can’t redirect USB storage devices to my KVM/Qemu VMs. I use virt-manager to manage my VMs, hence I use the menu of the vm console window: VirtualMachine->Redirect USB Device
. Usually that worked, but not anymore. It stopped working for Linux and Windows VMs. I can’t say when it stopped working because I don’t use USB redirection very often.
I found this Arch-Linux Bug (closed): FS#69428 : spice-gtk 0.39-1: USB redirection error
On my Manjaro-Xface laptop is spice-gtk-0.39-3
installed. But I have the problem, which is described in the Arch-Linux bug without the virt-manager gui messages.
Then I ran virt-manager --debug --no-fork
, which resulted in the following console messages while redirecting a USB thumbdrive manually:
[Thu, 22 Apr 2021 11:35:05 virt-manager 4089] DEBUG (connection:706) node device lifecycle event: nodedev=block_sda_SanDisk_Ultra_Fit_0501fbf0674f066bd6df86d83ff2a70885326812affdfafb6a683dcbe0e534dfa0c800000000000000000000766cbf2500070310835581072d287cf7_0_0 state=VIR_NODE_DEVICE_EVENT_DELETED reason=0
[Thu, 22 Apr 2021 11:35:05 virt-manager 4089] DEBUG (connection:706) node device lifecycle event: nodedev=scsi_2_0_0_0 state=VIR_NODE_DEVICE_EVENT_DELETED reason=0
[Thu, 22 Apr 2021 11:35:05 virt-manager 4089] DEBUG (connection:706) node device lifecycle event: nodedev=scsi_target2_0_0 state=VIR_NODE_DEVICE_EVENT_DELETED reason=0
[Thu, 22 Apr 2021 11:35:05 virt-manager 4089] DEBUG (connection:706) node device lifecycle event: nodedev=scsi_host2 state=VIR_NODE_DEVICE_EVENT_DELETED reason=0
[Thu, 22 Apr 2021 11:35:05 virt-manager 4089] DEBUG (connection:1050) nodedev=scsi_host2 removed
[Thu, 22 Apr 2021 11:35:05 virt-manager 4089] DEBUG (connection:1050) nodedev=scsi_target2_0_0 removed
[Thu, 22 Apr 2021 11:35:05 virt-manager 4089] DEBUG (connection:1050) nodedev=scsi_2_0_0_0 removed
[Thu, 22 Apr 2021 11:35:05 virt-manager 4089] DEBUG (connection:1050) nodedev=block_sda_SanDisk_Ultra_Fit_0501fbf0674f066bd6df86d83ff2a70885326812affdfafb6a683dcbe0e534dfa0c800000000000000000000766cbf2500070310835581072d287cf7_0_0 removed
[Thu, 22 Apr 2021 11:35:05 virt-manager 4089] DEBUG (connection:1046) Requested removal of nodedev=scsi_host2, but it's not in our object list.
[Thu, 22 Apr 2021 11:35:05 virt-manager 4089] DEBUG (connection:1046) Requested removal of nodedev=scsi_target2_0_0, but it's not in our object list.
[Thu, 22 Apr 2021 11:35:05 virt-manager 4089] DEBUG (connection:1046) Requested removal of nodedev=scsi_2_0_0_0, but it's not in our object list.
[Thu, 22 Apr 2021 11:35:05 virt-manager 4089] DEBUG (connection:1046) Requested removal of nodedev=block_sda_SanDisk_Ultra_Fit_0501fbf0674f066bd6df86d83ff2a70885326812affdfafb6a683dcbe0e534dfa0c800000000000000000000766cbf2500070310835581072d287cf7_0_0, but it's not in our object list.
In the Linux VM: lsusb shows the device, but it can’t be used neither manually mount nor through the file manager. The command lsblk shows the USB device too, but without any further information.
Redirect the thumb-drive journalctl -xk --follow
message (Debian 10 VM):
Apr 22 19:04:12 u1-pc001 kernel: usb 2-4: new SuperSpeed Gen 1 USB device number 4 using xhci_hcd
Apr 22 19:04:12 u1-pc001 kernel: usb 2-4: New USB device found, idVendor=0781, idProduct=5583, bcdDevice= 1.00
Apr 22 19:04:12 u1-pc001 kernel: usb 2-4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Apr 22 19:04:12 u1-pc001 kernel: usb 2-4: Product: Ultra Fit
Apr 22 19:04:12 u1-pc001 kernel: usb 2-4: Manufacturer: SanDisk
Apr 22 19:04:12 u1-pc001 kernel: usb 2-4: SerialNumber: 0501fbf0674f066bd6df86d83ff2a70885326812affdfafb6a683dcbe0e534dfa0c800000000000000000000766cbf2500070310835581072d287cf7
Apr 22 19:04:12 u1-pc001 kernel: usb-storage 2-4:1.0: USB Mass Storage device detected
Apr 22 19:04:12 u1-pc001 kernel: scsi host8: usb-storage 2-4:1.0
Apr 22 19:04:13 u1-pc001 kernel: scsi 8:0:0:0: Direct-Access SanDisk Ultra Fit 1.00 PQ: 0 ANSI: 6
Apr 22 19:04:13 u1-pc001 kernel: sd 8:0:0:0: Attached scsi generic sg1 type 0
Apr 22 19:04:13 u1-pc001 kernel: sd 8:0:0:0: [sda] 120176640 512-byte logical blocks: (61.5 GB/57.3 GiB)
Apr 22 19:04:13 u1-pc001 kernel: sd 8:0:0:0: [sda] Write Protect is off
Apr 22 19:04:13 u1-pc001 kernel: sd 8:0:0:0: [sda] Mode Sense: 43 00 00 00
Apr 22 19:04:13 u1-pc001 kernel: sd 8:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
Apr 22 19:04:13 u1-pc001 kernel: sda: sda1
Apr 22 19:04:13 u1-pc001 kernel: sd 8:0:0:0: [sda] Attached SCSI removable disk
And these when stopping the redirect:
Apr 22 19:08:58 u1-pc001 kernel: usb 2-4: USB disconnect, device number 4
Apr 22 19:08:58 u1-pc001 kernel: sd 8:0:0:0: [sda] tag#0 FAILED Result: hostbyte=DID_ERROR driverbyte=DRIVER_OK
Apr 22 19:08:58 u1-pc001 kernel: sd 8:0:0:0: [sda] tag#0 CDB: Read(10) 28 00 07 29 be f8 00 00 08 00
Apr 22 19:08:58 u1-pc001 kernel: print_req_error: I/O error, dev sda, sector 120176376
Apr 22 19:08:58 u1-pc001 kernel: print_req_error: I/O error, dev sda, sector 120176376
Apr 22 19:08:58 u1-pc001 kernel: Buffer I/O error on dev sda1, logical block 15021791, async page read
In the Windows VM: It gives the audio notification, but in the file manager the progress bar runs for a very long time and then it asked me to insert a disk in disk-drive D:. So it recognizes an USB thumb-drive as CD-Drive. (latest version of spice-agent and usbdk are installed)
Since I haven’t installed or modified anything, I’m posting this here in hope that someone else experienced this problem too.
Regards.