[Alsa-user] My USB sound does not work after unplug/replug

SourceForge Headquarters 1320 Columbia Street Suite 310 San Diego, CA 92101 +1 (858) 422-6466

Hello all,

I recently purchased a Line6 Sonic Port VX. This device is able to capture
sound from a guitar via the "line in" port and a voice via the mic. There
is a switch on the side to choose if we want to capture the guitar only,
the voice only or the guitar (left channel) and the voice (right channel).
It supports 24bits acquisition @48000 Hz. Please see the following link for
more details http://line6.com/sonicport-audio-interface/sonicport-vx/

The device works well if I boot my computer with the Sonic Port plugged in
one of my USB port. I can start Jack and use the stream in my MAO
softwares, capture from Audacity, etc ...

But it doesn't work anymore if I decide to unplug/replug it. For instance,
Audacity cannot start a capture : the capture cursor is flickering around
00:00:00 and the VU meter is empty and Jack does not want to start anymore.
It is like if it couldn't get any samples. All I have to do is rebooting.

The device seems to use the snd-usb-audio driver.

I first thought about a card index problem. But the following command
output is similar whether the device is working or not:

$ cat /proc/asound/cards
 0 [Intel          ]: HDA-Intel - HDA Intel
                      HDA Intel at 0xfdff8000 irq 41
 1 [NVidia         ]: HDA-Intel - HDA NVidia
                      HDA NVidia at 0xfcffc000 irq 17
 2 [VX             ]: USB-Audio - Sonic Port VX
                      Line 6 Sonic Port VX at usb-0000:00:1d.2-2, full speed

Below, the content of /proc/asound/card2/stream:

$ cat /proc/asound/card2/stream0
Line 6 Sonic Port VX at usb-0000:00:1d.2-1, full speed : USB Audio

Playback:
  Status: Stop
  Interface 2
    Altset 1
    Format: S32_LE
    Channels: 2
    Endpoint: 6 OUT (SYNC)
    Rates: 48000, 44100
  Interface 2
    Altset 2
    Format: S16_LE
    Channels: 2
    Endpoint: 6 OUT (SYNC)
    Rates: 48000, 44100

Capture:
  Status: Stop
  Interface 1
    Altset 1
    Format: S32_LE
    Channels: 2
    Endpoint: 6 IN (SYNC)
    Rates: 48000, 44100
  Interface 1
    Altset 2
    Format: S16_LE
    Channels: 2
    Endpoint: 6 IN (SYNC)
    Rates: 48000, 44100

Here is a dmesg output when the device is plugged at boot time. I
unplug at 384.316177
and then replug it.

$ dmesg

~~~ Blah blah blah from boot ~~~

[   13.564201] FS-Cache: Netfs 'nfs' registered for caching
[   13.608171] Installing knfsd (copyright (C) 1996 ok...@mo...).
[   18.277096] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[   18.279358] ieee80211 phy0: rt2x00lib_request_firmware: Info -
Loading firmware file 'rt2860.bin'
[   18.280154] e100 0000:02:08.0 eth0: NIC Link is Up 100 Mbps Full Duplex
[   18.308012] rt2800pci 0000:02:04.0: firmware: direct-loading
firmware rt2860.bin
[   18.308024] ieee80211 phy0: rt2x00lib_request_firmware: Info -
Firmware detected - version: 0.34
[   18.348312] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[   18.348332] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   21.628559] nvidia 0000:01:00.0: irq 42 for MSI/MSI-X
[   56.975898] usb 3-2: current rate 48000 is different from the
runtime rate 44100
[   56.977894] usb 3-2: current rate 48000 is different from the
runtime rate 44100
[   56.986894] usb 3-2: current rate 48000 is different from the
runtime rate 44100
[   56.988893] usb 3-2: current rate 48000 is different from the
runtime rate 44100
[   56.993901] usb 3-2: current rate 48000 is different from the
runtime rate 44100
[   56.995894] usb 3-2: current rate 48000 is different from the
runtime rate 44100
[   57.000899] usb 3-2: current rate 48000 is different from the
runtime rate 44100
[   57.002893] usb 3-2: current rate 48000 is different from the
runtime rate 44100
[   57.006895] usb 3-2: current rate 48000 is different from the
runtime rate 44100
[   57.008899] usb 3-2: current rate 48000 is different from the
runtime rate 44100
[  204.500118] usb usb1-port2: disabled by hub (EMI?), re-enabling...
[  204.500131] usb 1-2: USB disconnect, device number 2
[  204.768027] usb 1-2: new low-speed USB device number 3 using uhci_hcd
[  204.967804] usb 1-2: New USB device found, idVendor=04d9, idProduct=0499
[  204.967811] usb 1-2: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[  205.016363] input: HID 04d9:0499 as
/devices/pci0000:00/0000:00:1d.0/usb1/1-2/1-2:1.0/0003:04D9:0499.0002/input/input16
[  205.016633] hid-generic 0003:04D9:0499.0002: input,hidraw0: USB HID
v1.10 Mouse [HID 04d9:0499] on usb-0000:00:1d.0-2/input0
[  216.039137] usb 3-2: current rate 44100 is different from the
runtime rate 48000
[  317.646273] perf interrupt took too long (2522 > 2500), lowering
kernel.perf_event_max_sample_rate to 50000
[  384.316177] usb 3-2: USB disconnect, device number 2
[  441.036023] usb 3-2: new full-speed USB device number 3 using uhci_hcd
[  441.213072] usb 3-2: New USB device found, idVendor=0e41, idProduct=5167
[  441.213080] usb 3-2: New USB device strings: Mfr=2, Product=3, SerialNumber=4
[  441.213084] usb 3-2: Product: Sonic Port VX
[  441.213088] usb 3-2: Manufacturer: Line 6
[  441.213093] usb 3-2: SerialNumber: Serial Number
[  441.228070] usb 3-2: current rate 44100 is different from the
runtime rate 48000
[  441.231065] usb 3-2: current rate 44100 is different from the
runtime rate 48000
[  441.235066] usb 3-2: current rate 44100 is different from the
runtime rate 48000
[  441.238066] usb 3-2: current rate 44100 is different from the
runtime rate 48000

I would like to understand why my device does not work after
unplugging/replugging it.
Please tell me if you need more info/logs. I have some skills in Linux
kernel drivers as well, so do not hesitate to ask me to put some traces,
etc ...

I'm on a Debian Jessie.

Cheers,

Kevin JOLY