2.6 Test 11 Freeze on USB Disconnect

2.6 Test 11 Freeze on USB Disconnect

[Jonathan A. Zdziarski]

[-- Attachment #1: Type: text/plain, Size: 1040 bytes --]

Greetings,

I recently upgraded from 2.4.20-24 to 2.6 Test 11 using a Redhat
distribution.  Got everything up and running great, except the entire
system appears to freeze (requiring a hardware reset) when I disconnect
my bluetooth device.

I am using a Thinkpad T30, which has an integrated USB-based Bluetooth
card with a little power switch to activate/deactivate it.  I can turn
it on and it'll work fine, see devices, etc., but every single time I
turn it off, the laptop freezes.  Did not happen with the 2.4 kernel.

I am using the bluetooth stack provided by the Kernel along with the
configure scripts and such from the Bluez package.  It does not appear
to be a "bluetooth" issue, however - it seems more related to USB to me.

Anyhow I thought I'd fire off an email.  I'd be glad to supply more
specific information - just tell me what you need.  I am able to
reproduce this every time so shouldn't have a problem determining what
might affect the situation in a positive way.

Compressed copy of my .config included


Jonathan


[-- Attachment #2: config.jonz.gz --]
[-- Type: application/x-gzip, Size: 11246 bytes --]

Re: 2.6 Test 11 Freeze on USB Disconnect

[Greg KH]

On Sun, Dec 07, 2003 at 02:35:38PM -0500, Jonathan A. Zdziarski wrote:
> Greetings,
> 
> I recently upgraded from 2.4.20-24 to 2.6 Test 11 using a Redhat
> distribution.  Got everything up and running great, except the entire
> system appears to freeze (requiring a hardware reset) when I disconnect
> my bluetooth device.

Is there any way you can see if an oops happened?  Without that it will
be pretty hard to debug this.

thanks,

greg k-h

Re: 2.6 Test 11 Freeze on USB Disconnect

[Fabio Coatti]

Alle 01:47, lunedì 08 dicembre 2003, Greg KH ha scritto:
> On Sun, Dec 07, 2003 at 02:35:38PM -0500, Jonathan A. Zdziarski wrote:
> > Greetings,
> >
> > I recently upgraded from 2.4.20-24 to 2.6 Test 11 using a Redhat
> > distribution.  Got everything up and running great, except the entire
> > system appears to freeze (requiring a hardware reset) when I disconnect
> > my bluetooth device.
>
> Is there any way you can see if an oops happened?  Without that it will
> be pretty hard to debug this.

This seems the very same problem that I've got some time ago with test9 and 
never fixed (AFAIK). I'll bet that the SCO support is active.

I've captured with serial console the oops and posted here. This is the Oops 
that happens when I disconnect my USB dongle. (the crash happens only if user 
side processes have been launched, like hcid).

I've got several of them, they differs in EIP and process, but the first item 
in call trace is always [<f897c4b9>] uhci_irq+0x67/0x1ca [uhci_hcd]

Unable to handle kernel paging request at virtual address 80000234
*pde = 00000000
Oops: 0002 [#1]
CPU:    0
EIP:    0060:[<f897c3ed>]    Tainted: P
EFLAGS: 00010046
EIP is at uhci_remove_pending_qhs+0x95/0xfa [uhci_hcd]
eax: 80000234   ebx: 00000093   ecx: 80000200   edx: f55aca24
esi: f74d4e0c   edi: f6024000   ebp: f74d4e18   esp: f6025e5c
ds: 007b   es: 007b   ss: 0068
Process hcid (pid: 2434, threadinfo=f6024000 task=f4c25310)
Stack: 00000296 f74d4e0c f74d4c00 00000000 f74d4c00 0000c000 f6025ef8 f897c4b9
       f74d4c00 00000000 f6921780 f74d4c00 00000001 00000000 f6025ef8 c02b9b4e
       f74d4c00 f6025ef8 f7d53c80 04000001 c010b617 00000013 f74d4c00 f6025ef8
Call Trace:
 [<f897c4b9>] uhci_irq+0x67/0x1ca [uhci_hcd]
 [<c02b9b4e>] usb_hcd_irq+0x36/0x5f
 [<c010b617>] handle_IRQ_event+0x3a/0x64
 [<c010b9d8>] do_IRQ+0xb8/0x196
 [<c0109d20>] common_interrupt+0x18/0x20
 [<f8a0e7e1>] hci_sock_release+0x126/0x23e [bluetooth]
 [<c02cd132>] sock_close+0x0/0x4d
 [<c02cc7c4>] sock_release+0x9d/0xfc
 [<c02cd132>] sock_close+0x0/0x4d
 [<c02cd165>] sock_close+0x33/0x4d
 [<c015c957>] __fput+0x12c/0x165
 [<c015ad89>] filp_close+0x59/0x96
 [<c015ae45>] sys_close+0x7f/0xdd
 [<c01093b3>] syscall_call+0x7/0xb

Code: 89 69 34 89 45 04 89 02 89 50 04 8b 54 24 08 c6 82 14 02 00
 <0>Kernel panic: Fatal exception in interrupt
In interrupt handler - not syncing

I've also noticed something strange in hci_usb.c:when the dongle is inserted, 
I get this message on kernel log (BT debug active): (test9-bk24)

Nov 25 21:16:02 kefk kernel: hci_usb_intr_rx_submit: hci0
Nov 25 21:16:02 kefk kernel: hci_usb_bulk_rx_submit: hci0 urb f28f1614
Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: len 490 mtu 49
Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 0 offset 0 len 49
Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 1 offset 49 len 49
Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 2 offset 98 len 49
Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 3 offset 147 len 49
Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 4 offset 196 len 49
Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 5 offset 245 len 49
Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 6 offset 294 len 49
Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 7 offset 343 len 49
Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 8 offset 392 len 49
Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 9 offset 441 len 49
Nov 25 21:16:02 kefk kernel: hci_usb_isoc_rx_submit: hci0 urb f567e414
Nov 25 21:16:02 kefk kernel: hci_usb_isoc_rx_submit: hci0 isoc rx submit 
failed urb f567e414 err -22
Nov 25 21:16:02 kefk kernel: __hci_request: hci0 start

the interesting message seems to be this:
hci_usb_isoc_rx_submit: hci0 isoc rx submit failed urb f567e414 err -22
i've checked and it seems that usb_submit_urb: fails here (line 340 of 
hci_usb.c):

        switch (temp) {
        case PIPE_ISOCHRONOUS:
        case PIPE_INTERRUPT:
                /* too small? */
                if (urb->interval <= 0)
                        return -EINVAL;

maybe urb->interval is not set from calling code:
static int hci_usb_isoc_rx_submit(struct hci_usb *husb)
(line 236 of ./drivers/bluetooth/hci_usb.c)
but i don't know if this can cause harm.

If more information or test are needed, please let me know.

Hope This Helps..

Best regards.

-- 
Fabio Coatti       http://www.ferrara.linux.it/members/cova     
Ferrara Linux Users Group           http://ferrara.linux.it
GnuPG fp:9765 A5B6 6843 17BC A646  BE8C FA56 373A 5374 C703
Old SysOps never die... they simply forget their password.

Re: 2.6 Test 11 Freeze on USB Disconnect

[Greg KH]

On Mon, Dec 08, 2003 at 02:23:54AM +0100, Fabio Coatti wrote:
> Alle 01:47, lunedì 08 dicembre 2003, Greg KH ha scritto:
> > On Sun, Dec 07, 2003 at 02:35:38PM -0500, Jonathan A. Zdziarski wrote:
> > > Greetings,
> > >
> > > I recently upgraded from 2.4.20-24 to 2.6 Test 11 using a Redhat
> > > distribution.  Got everything up and running great, except the entire
> > > system appears to freeze (requiring a hardware reset) when I disconnect
> > > my bluetooth device.
> >
> > Is there any way you can see if an oops happened?  Without that it will
> > be pretty hard to debug this.
> 
> This seems the very same problem that I've got some time ago with test9 and 
> never fixed (AFAIK). I'll bet that the SCO support is active.

Did you let Max know about this?

(I've cced him and left the rest of the oops report below...)

greg k-h



> 
> I've captured with serial console the oops and posted here. This is the Oops 
> that happens when I disconnect my USB dongle. (the crash happens only if user 
> side processes have been launched, like hcid).
> 
> I've got several of them, they differs in EIP and process, but the first item 
> in call trace is always [<f897c4b9>] uhci_irq+0x67/0x1ca [uhci_hcd]
> 
> Unable to handle kernel paging request at virtual address 80000234
> *pde = 00000000
> Oops: 0002 [#1]
> CPU:    0
> EIP:    0060:[<f897c3ed>]    Tainted: P
> EFLAGS: 00010046
> EIP is at uhci_remove_pending_qhs+0x95/0xfa [uhci_hcd]
> eax: 80000234   ebx: 00000093   ecx: 80000200   edx: f55aca24
> esi: f74d4e0c   edi: f6024000   ebp: f74d4e18   esp: f6025e5c
> ds: 007b   es: 007b   ss: 0068
> Process hcid (pid: 2434, threadinfo=f6024000 task=f4c25310)
> Stack: 00000296 f74d4e0c f74d4c00 00000000 f74d4c00 0000c000 f6025ef8 f897c4b9
>        f74d4c00 00000000 f6921780 f74d4c00 00000001 00000000 f6025ef8 c02b9b4e
>        f74d4c00 f6025ef8 f7d53c80 04000001 c010b617 00000013 f74d4c00 f6025ef8
> Call Trace:
>  [<f897c4b9>] uhci_irq+0x67/0x1ca [uhci_hcd]
>  [<c02b9b4e>] usb_hcd_irq+0x36/0x5f
>  [<c010b617>] handle_IRQ_event+0x3a/0x64
>  [<c010b9d8>] do_IRQ+0xb8/0x196
>  [<c0109d20>] common_interrupt+0x18/0x20
>  [<f8a0e7e1>] hci_sock_release+0x126/0x23e [bluetooth]
>  [<c02cd132>] sock_close+0x0/0x4d
>  [<c02cc7c4>] sock_release+0x9d/0xfc
>  [<c02cd132>] sock_close+0x0/0x4d
>  [<c02cd165>] sock_close+0x33/0x4d
>  [<c015c957>] __fput+0x12c/0x165
>  [<c015ad89>] filp_close+0x59/0x96
>  [<c015ae45>] sys_close+0x7f/0xdd
>  [<c01093b3>] syscall_call+0x7/0xb
> 
> Code: 89 69 34 89 45 04 89 02 89 50 04 8b 54 24 08 c6 82 14 02 00
>  <0>Kernel panic: Fatal exception in interrupt
> In interrupt handler - not syncing
> 
> I've also noticed something strange in hci_usb.c:when the dongle is inserted, 
> I get this message on kernel log (BT debug active): (test9-bk24)
> 
> Nov 25 21:16:02 kefk kernel: hci_usb_intr_rx_submit: hci0
> Nov 25 21:16:02 kefk kernel: hci_usb_bulk_rx_submit: hci0 urb f28f1614
> Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: len 490 mtu 49
> Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 0 offset 0 len 49
> Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 1 offset 49 len 49
> Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 2 offset 98 len 49
> Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 3 offset 147 len 49
> Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 4 offset 196 len 49
> Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 5 offset 245 len 49
> Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 6 offset 294 len 49
> Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 7 offset 343 len 49
> Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 8 offset 392 len 49
> Nov 25 21:16:02 kefk kernel: __fill_isoc_desc: desc 9 offset 441 len 49
> Nov 25 21:16:02 kefk kernel: hci_usb_isoc_rx_submit: hci0 urb f567e414
> Nov 25 21:16:02 kefk kernel: hci_usb_isoc_rx_submit: hci0 isoc rx submit 
> failed urb f567e414 err -22
> Nov 25 21:16:02 kefk kernel: __hci_request: hci0 start
> 
> the interesting message seems to be this:
> hci_usb_isoc_rx_submit: hci0 isoc rx submit failed urb f567e414 err -22
> i've checked and it seems that usb_submit_urb: fails here (line 340 of 
> hci_usb.c):
> 
>         switch (temp) {
>         case PIPE_ISOCHRONOUS:
>         case PIPE_INTERRUPT:
>                 /* too small? */
>                 if (urb->interval <= 0)
>                         return -EINVAL;
> 
> maybe urb->interval is not set from calling code:
> static int hci_usb_isoc_rx_submit(struct hci_usb *husb)
> (line 236 of ./drivers/bluetooth/hci_usb.c)
> but i don't know if this can cause harm.
> 
> If more information or test are needed, please let me know.
> 
> Hope This Helps..
> 
> Best regards.
> 
> -- 
> Fabio Coatti       http://www.ferrara.linux.it/members/cova     
> Ferrara Linux Users Group           http://ferrara.linux.it
> GnuPG fp:9765 A5B6 6843 17BC A646  BE8C FA56 373A 5374 C703
> Old SysOps never die... they simply forget their password.

Re: 2.6 Test 11 Freeze on USB Disconnect

[Fabio Coatti]

Alle 08:46, lunedì 08 dicembre 2003, Greg KH ha scritto:

> > >
> > > Is there any way you can see if an oops happened?  Without that it will
> > > be pretty hard to debug this.
> >
> > This seems the very same problem that I've got some time ago with test9
> > and never fixed (AFAIK). I'll bet that the SCO support is active.
>
> Did you let Max know about this?
>
> (I've cced him and left the rest of the oops report below...)
>
> greg k-h

Yes, I've CC'ed him on my original mail. Another thing to note is that the usb 
BT dongle is left plugged the kernel oops occurs at shutdown, probably when 
some module is removed.
I can capture this oopses (by serial link) also, if needed.

-- 
Fabio Coatti       http://www.ferrara.linux.it/members/cova     
Ferrara Linux Users Group           http://ferrara.linux.it
GnuPG fp:9765 A5B6 6843 17BC A646  BE8C FA56 373A 5374 C703
Old SysOps never die... they simply forget their password.

Re: 2.6 Test 11 Freeze on USB Disconnect

[Jonathan A. Zdziarski]

> When the kernel dies, it usually emits a oops.  If you are running X at
> the time, you can't see it.
> 
> Can you try removing the device when at a console screen?

Ah...Linux Bluescreen.  Cool.

I wrote down as much as I could before running out of paper.  Info is
below.  This info isn't available via dmesg or anything is it?

Oops: 0002[#1]
CPU 0
EIP 0060:[<228635f7>] Tained: GF
EFLAGS: 00010002
EIP is at uhci_remove_pending_qhs + 0x7d/0xcc [uhci_hcd]
eax: 2158b938
ebx: 21586938
ecx: 6b6b6b9f
edx: 18fa4000
esi: 6b6b6b6b
ed: 00000083
ebp: 0c36753c
esp: 18fa5f2c

Process klogd:

[Some numbers I didn't have room for]

Code: 89 46 34 89 48 04 89 0b 89 59 04 57 9d 8b 42 08 ff 4a 14 83

Kernel Panic: Fatal Exception in Interrupt

in Interrupt Handler: not_syncing

Another Kernel Oop

[Jonathan A. Zdziarski]

Another kernel oops that occurs when you try to shut down apmd using the
redhat script...I'm wondering if this may be why my thinkpad refuses to
power down or suspend in 2.6 (I've tried real-mode power off and
APM-BIOS Interrupts).

Oops: 0000[#1]
CPU: 0
EIP: 0060:[<229871db>] Tained: GF
EFLAGS: 00010246
EIP is at 0x229871db
eax: 00000000 ebx: 00000000 ecx: 00000000 edx: 02318000
esi: 00000010 edi: 00000000 ebp: 00000000 esp: 02319f9c
ds: 0076 es: 007b ss: 0068

Process Swapper (pid: 0, threadinfo=02318000 task=022aaa60)

Stack 00000005 00000202 02310000 00000000 fffee0db 00000010 00000001
0008e000
      229872c4 00005305 00000000 00000000 02319fd0 00000005 229873a1
02318000
      0001080e 00099800 02107000 0210a3e5 0231a5c6 022aaa60 00000000
0233e0a0

Call Trace

[<02107000>] rest_init+0x0/0x4d
[<0210a3e5>] cpu_idle+0x2c/0x35
[<0231a5cb>] start_kernel+0x15e/0x187

Code: Bad EIP Value
<0>Kernel Panic: Attempted to kill the idle task

In idle task - not syncing

Re: 2.6 Test 11 Freeze on USB Disconnect

[Charles Bueche]

Hi,

similar problem on my Dell I8600 with integrated bluetooth. It happens
at "/etc/init.d/hotplug stop". I think (but am not sure, I would have to
test) that it happens only if hciconfig is up. I haven't created proper
stop scripts so far...

My guess is that some bluez module unload failure cause the oops.

The switch on my I8600 is a hotkey (<ALT><F2>).

Charles

On Sun, 2003-12-07 at 20:35, Jonathan A. Zdziarski wrote:
> Greetings,
> 
> I recently upgraded from 2.4.20-24 to 2.6 Test 11 using a Redhat
> distribution.  Got everything up and running great, except the entire
> system appears to freeze (requiring a hardware reset) when I disconnect
> my bluetooth device.
> 
> I am using a Thinkpad T30, which has an integrated USB-based Bluetooth
> card with a little power switch to activate/deactivate it.  I can turn
> it on and it'll work fine, see devices, etc., but every single time I
> turn it off, the laptop freezes.  Did not happen with the 2.4 kernel.
> 
> I am using the bluetooth stack provided by the Kernel along with the
> configure scripts and such from the Bluez package.  It does not appear
> to be a "bluetooth" issue, however - it seems more related to USB to me.
> 
> Anyhow I thought I'd fire off an email.  I'd be glad to supply more
> specific information - just tell me what you need.  I am able to
> reproduce this every time so shouldn't have a problem determining what
> might affect the situation in a positive way.
> 
> Compressed copy of my .config included
> 
> 
> Jonathan
-- 
Charles Bueche <charles@bueche.ch>
sand, snow, wave, wind and net -surfer