Re: [ 14.123127] BUG: spinlock bad magic on CPU#0, swapper/0

From: Justin Mattock
Date: Thu Sep 24 2009 - 18:02:50 EST


On Mon, Sep 21, 2009 at 8:47 PM, Justin Mattock <justinmattock@xxxxxxxxx> wrote:
> I'm just trying to get the dam* bluetooth mighty mouse to
> work. anyways the system barfed up this:
> (FWIW:  had bluez installed at-least an hour without this
> showing up, as soon as I installed libusb
> this showed up)
>
> [   13.607016] type=1400 audit(1253565686.600:3): avc:  denied  {
> execmem } for  pid=1759 comm="python"
> scontext=system_u:system_r:kernel_t
> tcontext=system_u:system_r:kernel_t tclass=process
> [   14.123127] BUG: spinlock bad magic on CPU#0, swapper/0
> [   14.123322]  lock: ffff88002ad28430, .magic: 00000000, .owner:
> <none>/-1, .owner_cpu: 0
> [   14.123598] Pid: 0, comm: swapper Not tainted 2.6.31-05767-gdf58bee #4
> [   14.123784] Call Trace:
> [   14.123965]  <IRQ>  [<ffffffff811cfd1e>] spin_bug+0x9c/0xa3
> [   14.124256]  [<ffffffff811cfdd9>] _raw_spin_lock+0x29/0x13c
> [   14.124446]  [<ffffffff813bad6c>] _spin_lock_irqsave+0x1f/0x26
> [   14.124637]  [<ffffffff812f99f5>] skb_dequeue+0x1c/0x6b
> [   14.124839]  [<ffffffffa0092c5e>] ? uhci_urb_enqueue+0x83a/0x853 [uhci_hcd]
> [   14.125029]  [<ffffffff812fa571>] skb_queue_purge+0x1e/0x28
> [   14.125224]  [<ffffffffa004d783>] l2cap_recv_frame+0x118d/0x20f4 [l2cap]
> [   14.125417]  [<ffffffff810ddf9c>] ? __slab_free+0x2b3/0x2f9
> [   14.125617]  [<ffffffffa003c8cd>] ? hci_event_packet+0x2984/0x299f
> [bluetooth]
> [   14.125892]  [<ffffffff812fa217>] ? __kfree_skb+0x78/0x7c
> [   14.126079]  [<ffffffff812fa2aa>] ? kfree_skb+0x65/0x6d
> [   14.126276]  [<ffffffffa003c8cd>] ? hci_event_packet+0x2984/0x299f
> [bluetooth]
> [   14.126552]  [<ffffffff81299598>] ? usb_submit_urb+0x217/0x22e
> [   14.126745]  [<ffffffffa006063c>] ? btusb_bulk_complete+0x9f/0xd6 [btusb]
> [   14.126935]  [<ffffffff813bad1d>] ? _spin_lock+0x9/0xb
> [   14.127126]  [<ffffffffa009093d>] ? uhci_giveback_urb+0x124/0x1a5 [uhci_hcd]
> [   14.127322]  [<ffffffffa004e7fe>] l2cap_recv_acldata+0xc5/0x233 [l2cap]
> [   14.127526]  [<ffffffffa003809f>] hci_rx_task+0x155/0x253 [bluetooth]
> [   14.127718]  [<ffffffff81064319>] tasklet_action+0x80/0xdf
> [   14.127906]  [<ffffffff81065ba7>] __do_softirq+0xe0/0x1a1
> [   14.128099]  [<ffffffff8102d9ac>] call_softirq+0x1c/0x28
> [   14.128288]  [<ffffffff8102ee35>] do_softirq+0x41/0x81
> [   14.128480]  [<ffffffff8106597a>] irq_exit+0x36/0x78
> [   14.128671]  [<ffffffff8102e513>] do_IRQ+0xa0/0xb7
> [   14.128860]  [<ffffffff8102d1d3>] ret_from_intr+0x0/0x11
> [   14.129043]  <EOI>  [<ffffffffa0018c88>] ?
> acpi_idle_enter_bm+0x2d7/0x30b [processor]
> [   14.129432]  [<ffffffffa0018c81>] ? acpi_idle_enter_bm+0x2d0/0x30b
> [processor]
> [   14.129709]  [<ffffffff812d65b9>] ? cpuidle_idle_call+0x88/0xbf
> [   14.129899]  [<ffffffff8102bbf7>] ? cpu_idle+0x58/0x93
> [   14.130086]  [<ffffffff813aa2ad>] ? rest_init+0x61/0x63
> [   14.130276]  [<ffffffff8162514e>] ? start_kernel+0x361/0x36c
> [   14.130466]  [<ffffffff81624785>] ? x86_64_start_reservations+0xac/0xb0
> [   14.130656]  [<ffffffff81624881>] ? x86_64_start_kernel+0xf8/0x107
> [   14.642763] applesmc: light sensor data length set to 6
>
> I can try and do a git bisect,
> but might not be right now.
>
> --
> Justin P. Mattock
>

I understand if you have too much time
to deal with things like this.
Anyways posted a few days ago, had no response,
so I decided to post again, except add marcel to the
CC. Anyways I seem to be hitting this during
boot, and once the mouse falls alseep upon
wake up this triggers.(not all the time though)

here's a cutout of upon waking the mouse up
from sleeping(not s2ram)

[ 4400.410296] BUG: spinlock bad magic on CPU#0, swapper/0
[ 4400.410307] lock: ffff8800385a5700, .magic: 00000000, .owner:
<none>/-1, .owner_cpu: 0
[ 4400.410314] Pid: 0, comm: swapper Not tainted 2.6.31-05767-gdf58bee #5
[ 4400.410319] Call Trace:
[ 4400.410323] <IRQ> [<ffffffff811ae39e>] spin_bug+0x9c/0xa3
[ 4400.410343] [<ffffffff811ae459>] _raw_spin_lock+0x29/0x13c
[ 4400.410352] [<ffffffff8139a51c>] _spin_lock_irqsave+0x1f/0x26
[ 4400.410361] [<ffffffff812d91a5>] skb_dequeue+0x1c/0x6b
[ 4400.410382] [<ffffffffa0092c5e>] ? uhci_urb_enqueue+0x83a/0x853 [uhci_hcd]
[ 4400.410390] [<ffffffff812d9d21>] skb_queue_purge+0x1e/0x28
[ 4400.410404] [<ffffffffa004d783>] l2cap_recv_frame+0x118d/0x20f4 [l2cap]
[ 4400.410413] [<ffffffff810bc61c>] ? __slab_free+0x2b3/0x2f9
[ 4400.410432] [<ffffffffa003c8cd>] ? hci_event_packet+0x2984/0x299f
[bluetooth]
[ 4400.410439] [<ffffffff812d99c7>] ? __kfree_skb+0x78/0x7c
[ 4400.410446] [<ffffffff812d9a5a>] ? kfree_skb+0x65/0x6d
[ 4400.410463] [<ffffffffa003c8cd>] ? hci_event_packet+0x2984/0x299f
[bluetooth]
[ 4400.410471] [<ffffffff81277c18>] ? usb_submit_urb+0x217/0x22e
[ 4400.410483] [<ffffffffa006063c>] ? btusb_bulk_complete+0x9f/0xd6 [btusb]
[ 4400.410491] [<ffffffff8139a4cd>] ? _spin_lock+0x9/0xb
[ 4400.410501] [<ffffffffa009093d>] ? uhci_giveback_urb+0x124/0x1a5 [uhci_hcd]
[ 4400.410514] [<ffffffffa004e7fe>] l2cap_recv_acldata+0xc5/0x233 [l2cap]
[ 4400.410531] [<ffffffffa003809f>] hci_rx_task+0x155/0x253 [bluetooth]
[ 4400.410539] [<ffffffff81042999>] tasklet_action+0x80/0xdf
[ 4400.410547] [<ffffffff81044227>] __do_softirq+0xe0/0x1a1
[ 4400.410556] [<ffffffff8100c02c>] call_softirq+0x1c/0x28
[ 4400.410563] [<ffffffff8100d4b5>] do_softirq+0x41/0x81
[ 4400.410570] [<ffffffff81043ffa>] irq_exit+0x36/0x78
[ 4400.410576] [<ffffffff8100cb93>] do_IRQ+0xa0/0xb7
[ 4400.410585] [<ffffffff8100b853>] ret_from_intr+0x0/0x11
[ 4400.410589] <EOI> [<ffffffffa0018c88>] ?
acpi_idle_enter_bm+0x2d7/0x30b [processor]
[ 4400.410619] [<ffffffffa0018c81>] ? acpi_idle_enter_bm+0x2d0/0x30b
[processor]
[ 4400.410629] [<ffffffff812b4c39>] ? cpuidle_idle_call+0x88/0xbf
[ 4400.410637] [<ffffffff8100a277>] ? cpu_idle+0x58/0x93
[ 4400.410645] [<ffffffff81389a5d>] ? rest_init+0x61/0x63
[ 4400.410654] [<ffffffff815f710e>] ? start_kernel+0x361/0x36c
[ 4400.410662] [<ffffffff815f6745>] ? x86_64_start_reservations+0xac/0xb0
[ 4400.410670] [<ffffffff815f6841>] ? x86_64_start_kernel+0xf8/0x107
[ 5158.248934] input: justinmattockâs mouse as
/devices/pci0000:00/0000:00:1d.3/usb5/5-1/5-1:1.0/bluetooth/hci0/hci0:46/input12
[ 5158.249279] generic-bluetooth 0005:0000:0000.0007: input: BLUETOOTH
HID v0.00 Mouse [justinmattockâs mouse] on 00:17:F2:B4:BC:F5

everything seems o.k. after this triggers
mouse reacts as is.
In any case at least you have this info.

--
Justin P. Mattock
--
To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at http://vger.kernel.org/majordomo-info.html
Please read the FAQ at http://www.tux.org/lkml/