From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: MIME-Version: 1.0 In-Reply-To: References: Date: Thu, 24 Sep 2009 15:02:40 -0700 Message-ID: Subject: Re: [ 14.123127] BUG: spinlock bad magic on CPU#0, swapper/0 From: Justin Mattock To: Linux Kernel Mailing List , linux-bluetooth@vger.kernel.org Cc: Marcel Holtmann Content-Type: text/plain; charset=ISO-8859-1 List-ID: On Mon, Sep 21, 2009 at 8:47 PM, Justin Mattock w= rote: > I'm just trying to get the dam* bluetooth mighty mouse to > work. anyways the system barfed up this: > (FWIW: =A0had bluez installed at-least an hour without this > showing up, as soon as I installed libusb > this showed up) > > [ =A0 13.607016] type=3D1400 audit(1253565686.600:3): avc: =A0denied =A0{ > execmem } for =A0pid=3D1759 comm=3D"python" > scontext=3Dsystem_u:system_r:kernel_t > tcontext=3Dsystem_u:system_r:kernel_t tclass=3Dprocess > [ =A0 14.123127] BUG: spinlock bad magic on CPU#0, swapper/0 > [ =A0 14.123322] =A0lock: ffff88002ad28430, .magic: 00000000, .owner: > /-1, .owner_cpu: 0 > [ =A0 14.123598] Pid: 0, comm: swapper Not tainted 2.6.31-05767-gdf58bee = #4 > [ =A0 14.123784] Call Trace: > [ =A0 14.123965] =A0 =A0[] spin_bug+0x9c/0xa3 > [ =A0 14.124256] =A0[] _raw_spin_lock+0x29/0x13c > [ =A0 14.124446] =A0[] _spin_lock_irqsave+0x1f/0x26 > [ =A0 14.124637] =A0[] skb_dequeue+0x1c/0x6b > [ =A0 14.124839] =A0[] ? uhci_urb_enqueue+0x83a/0x853 [= uhci_hcd] > [ =A0 14.125029] =A0[] skb_queue_purge+0x1e/0x28 > [ =A0 14.125224] =A0[] l2cap_recv_frame+0x118d/0x20f4 [= l2cap] > [ =A0 14.125417] =A0[] ? __slab_free+0x2b3/0x2f9 > [ =A0 14.125617] =A0[] ? hci_event_packet+0x2984/0x299f > [bluetooth] > [ =A0 14.125892] =A0[] ? __kfree_skb+0x78/0x7c > [ =A0 14.126079] =A0[] ? kfree_skb+0x65/0x6d > [ =A0 14.126276] =A0[] ? hci_event_packet+0x2984/0x299f > [bluetooth] > [ =A0 14.126552] =A0[] ? usb_submit_urb+0x217/0x22e > [ =A0 14.126745] =A0[] ? btusb_bulk_complete+0x9f/0xd6 = [btusb] > [ =A0 14.126935] =A0[] ? _spin_lock+0x9/0xb > [ =A0 14.127126] =A0[] ? uhci_giveback_urb+0x124/0x1a5 = [uhci_hcd] > [ =A0 14.127322] =A0[] l2cap_recv_acldata+0xc5/0x233 [l= 2cap] > [ =A0 14.127526] =A0[] hci_rx_task+0x155/0x253 [bluetoo= th] > [ =A0 14.127718] =A0[] tasklet_action+0x80/0xdf > [ =A0 14.127906] =A0[] __do_softirq+0xe0/0x1a1 > [ =A0 14.128099] =A0[] call_softirq+0x1c/0x28 > [ =A0 14.128288] =A0[] do_softirq+0x41/0x81 > [ =A0 14.128480] =A0[] irq_exit+0x36/0x78 > [ =A0 14.128671] =A0[] do_IRQ+0xa0/0xb7 > [ =A0 14.128860] =A0[] ret_from_intr+0x0/0x11 > [ =A0 14.129043] =A0 =A0[] ? > acpi_idle_enter_bm+0x2d7/0x30b [processor] > [ =A0 14.129432] =A0[] ? acpi_idle_enter_bm+0x2d0/0x30b > [processor] > [ =A0 14.129709] =A0[] ? cpuidle_idle_call+0x88/0xbf > [ =A0 14.129899] =A0[] ? cpu_idle+0x58/0x93 > [ =A0 14.130086] =A0[] ? rest_init+0x61/0x63 > [ =A0 14.130276] =A0[] ? start_kernel+0x361/0x36c > [ =A0 14.130466] =A0[] ? x86_64_start_reservations+0xac= /0xb0 > [ =A0 14.130656] =A0[] ? x86_64_start_kernel+0xf8/0x107 > [ =A0 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: /-1, .owner_cpu: 0 [ 4400.410314] Pid: 0, comm: swapper Not tainted 2.6.31-05767-gdf58bee #5 [ 4400.410319] Call Trace: [ 4400.410323] [] spin_bug+0x9c/0xa3 [ 4400.410343] [] _raw_spin_lock+0x29/0x13c [ 4400.410352] [] _spin_lock_irqsave+0x1f/0x26 [ 4400.410361] [] skb_dequeue+0x1c/0x6b [ 4400.410382] [] ? uhci_urb_enqueue+0x83a/0x853 [uhci_h= cd] [ 4400.410390] [] skb_queue_purge+0x1e/0x28 [ 4400.410404] [] l2cap_recv_frame+0x118d/0x20f4 [l2cap] [ 4400.410413] [] ? __slab_free+0x2b3/0x2f9 [ 4400.410432] [] ? hci_event_packet+0x2984/0x299f [bluetooth] [ 4400.410439] [] ? __kfree_skb+0x78/0x7c [ 4400.410446] [] ? kfree_skb+0x65/0x6d [ 4400.410463] [] ? hci_event_packet+0x2984/0x299f [bluetooth] [ 4400.410471] [] ? usb_submit_urb+0x217/0x22e [ 4400.410483] [] ? btusb_bulk_complete+0x9f/0xd6 [btusb= ] [ 4400.410491] [] ? _spin_lock+0x9/0xb [ 4400.410501] [] ? uhci_giveback_urb+0x124/0x1a5 [uhci_= hcd] [ 4400.410514] [] l2cap_recv_acldata+0xc5/0x233 [l2cap] [ 4400.410531] [] hci_rx_task+0x155/0x253 [bluetooth] [ 4400.410539] [] tasklet_action+0x80/0xdf [ 4400.410547] [] __do_softirq+0xe0/0x1a1 [ 4400.410556] [] call_softirq+0x1c/0x28 [ 4400.410563] [] do_softirq+0x41/0x81 [ 4400.410570] [] irq_exit+0x36/0x78 [ 4400.410576] [] do_IRQ+0xa0/0xb7 [ 4400.410585] [] ret_from_intr+0x0/0x11 [ 4400.410589] [] ? acpi_idle_enter_bm+0x2d7/0x30b [processor] [ 4400.410619] [] ? acpi_idle_enter_bm+0x2d0/0x30b [processor] [ 4400.410629] [] ? cpuidle_idle_call+0x88/0xbf [ 4400.410637] [] ? cpu_idle+0x58/0x93 [ 4400.410645] [] ? rest_init+0x61/0x63 [ 4400.410654] [] ? start_kernel+0x361/0x36c [ 4400.410662] [] ? x86_64_start_reservations+0xac/0xb0 [ 4400.410670] [] ? x86_64_start_kernel+0xf8/0x107 [ 5158.248934] input: justinmattock=E2s mouse as /devices/pci0000:00/0000:00:1d.3/usb5/5-1/5-1:1.0/bluetooth/hci0/hci0:46/in= put12 [ 5158.249279] generic-bluetooth 0005:0000:0000.0007: input: BLUETOOTH HID v0.00 Mouse [justinmattock=E2s 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. --=20 Justin P. Mattock