public inbox for linux-kernel@vger.kernel.org
 help / color / mirror / Atom feed
* Re: INFO: possible irq lock inversion dependency detected
@ 2006-07-08 23:00 Arne Ahrend
  0 siblings, 0 replies; 4+ messages in thread
From: Arne Ahrend @ 2006-07-08 23:00 UTC (permalink / raw)
  To: Arjan van de Ven; +Cc: linux-kernel

On Sat, 2006-07-08 at 19:12 +0200, Arjan van de Ven wrote:
> Arne: Can you try this patch and verify it makes the message go away?
> [...]
> --- linux-2.6.17-mm6.orig/include/linux/skbuff.h
> +++ linux-2.6.17-mm6/include/linux/skbuff.h
> @@ -609,7 +609,6 @@ extern struct lock_class_key skb_queue_l
>  static inline void skb_queue_head_init(struct sk_buff_head *list)
>  {
>  	spin_lock_init(&list->lock);
> -	lockdep_set_class(&list->lock, &skb_queue_lock_key);
>  	list->prev = list->next = (struct sk_buff *)list;
>  	list->qlen = 0;
>  }


Yes, this patch removes the message. (And the system continues to work.)

Arne


__________________________________________________________________________
Erweitern Sie FreeMail zu einem noch leistungsstärkeren E-Mail-Postfach!		
Mehr Infos unter http://freemail.web.de/home/landingpad/?mc=021131


^ permalink raw reply	[flat|nested] 4+ messages in thread
* INFO: possible irq lock inversion dependency detected
@ 2014-09-05 16:20 Kari Suvanto
  0 siblings, 0 replies; 4+ messages in thread
From: Kari Suvanto @ 2014-09-05 16:20 UTC (permalink / raw)
  To: linux-kernel@vger.kernel.org

Hello,

I noticed, with next/master tree, this lockdep splat and at least I could not find any discussion about this by googling:
[   33.105722] =========================================================
[   33.105722] [ INFO: possible irq lock inversion dependency detected ]
[   33.105724] 3.17.0-031700rc3-generic #201409031132 Not tainted
[   33.105724] ---------------------------------------------------------
[   33.105725] swapper/0/0 just changed the state of lock:
[   33.105726]  (&(&dev->event_lock)->rlock#2){-.....}, at: [<ffffffff8162f7c5>] input_event+0x45/0x70
[   33.105733] but this lock took another, HARDIRQ-unsafe lock in the past:
[   33.105734]  (&(&p->alloc_lock)->rlock){+.+...}
[   33.105734]
[   33.105734] and interrupts could create inverse lock ordering between them.
[   33.105734]
[   33.105736]
[   33.105736] other info that might help us debug this:
[   33.105737] Chain exists of:
[   33.105737]   &(&dev->event_lock)->rlock#2 --> &(&client->buffer_lock)->rlock --> &(&p->alloc_lock)->rlock
[   33.105737]
[   33.105740]  Possible interrupt unsafe locking scenario:
[   33.105740]
[   33.105740]        CPU0                    CPU1
[   33.105741]        ----                    ----
[   33.105742]   lock(&(&p->alloc_lock)->rlock);
[   33.105743]                                local_irq_disable();
[   33.105743]                                lock(&(&dev->event_lock)->rlock#2);
[   33.105745]                                lock(&(&client->buffer_lock)->rlock);
[   33.105746]   <Interrupt>
[   33.105747]     lock(&(&dev->event_lock)->rlock#2);
[   33.105748]
[   33.105748]  *** DEADLOCK ***
[   33.105748]
[   33.105749] no locks held by swapper/0/0.
[   33.105750]
[   33.105750] the shortest dependencies between 2nd lock and 1st lock:
[   33.105755]      -> (&(&p->alloc_lock)->rlock){+.+...} ops: 30838 {
[   33.105757]         HARDIRQ-ON-W at:
[   33.105758]                               [<ffffffff810d3ae8>] __lock_acquire+0x538/0xb50
[   33.105761]                               [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.105763]                               [<ffffffff818334e9>] _raw_spin_lock+0x39/0x50
[   33.105766]                               [<ffffffff81227f0a>] __set_task_comm+0x2a/0x150
[   33.105769]                               [<ffffffff810a15c0>] kthreadd+0x30/0x220
[   33.105772]                               [<ffffffff818342bc>] ret_from_fork+0x7c/0xb0
[   33.105774]         SOFTIRQ-ON-W at:
[   33.105775]                               [<ffffffff810d38a3>] __lock_acquire+0x2f3/0xb50
[   33.105776]                               [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.105778]                               [<ffffffff818334e9>] _raw_spin_lock+0x39/0x50
[   33.105780]                               [<ffffffff81227f0a>] __set_task_comm+0x2a/0x150
[   33.105782]                               [<ffffffff810a15c0>] kthreadd+0x30/0x220
[   33.105783]                               [<ffffffff818342bc>] ret_from_fork+0x7c/0xb0
[   33.105785]         INITIAL USE at:
[   33.105786]                              [<ffffffff810d38f4>] __lock_acquire+0x344/0xb50
[   33.105787]                              [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.105789]                              [<ffffffff818334e9>] _raw_spin_lock+0x39/0x50
[   33.105791]                              [<ffffffff81227f0a>] __set_task_comm+0x2a/0x150
[   33.105792]                              [<ffffffff810a15c0>] kthreadd+0x30/0x220
[   33.105794]                              [<ffffffff818342bc>] ret_from_fork+0x7c/0xb0
[   33.105796]       }
[   33.105796]       ... key      at: [<ffffffff82119008>] __key.51772+0x0/0x8
[   33.105799]       ... acquired at:
[   33.105799]    [<ffffffff810d39c8>] __lock_acquire+0x418/0xb50
[   33.105801]    [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.105802]    [<ffffffff818334e9>] _raw_spin_lock+0x39/0x50
[   33.105804]    [<ffffffff81093eeb>] do_prlimit+0x9b/0x200
[   33.105806]    [<ffffffff8109407a>] SyS_getrlimit+0x2a/0x70
[   33.105808]    [<ffffffff8183436d>] system_call_fastpath+0x1a/0x1f
[   33.105810]
[   33.105811]     -> (tasklist_lock){.+.+..} ops: 26419 {
[   33.105813]        HARDIRQ-ON-R at:
[   33.105813]                             [<ffffffff810d3881>] __lock_acquire+0x2d1/0xb50
[   33.105815]                             [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.105817]                             [<ffffffff8183382c>] _raw_read_lock+0x3c/0x50
[   33.105818]                             [<ffffffff8107d796>] do_wait+0xb6/0x340
[   33.105820]                             [<ffffffff8107ed54>] SyS_wait4+0x64/0xe0
[   33.105822]                             [<ffffffff8109500b>] wait_for_helper+0x4b/0x70
[   33.105824]                             [<ffffffff818342bc>] ret_from_fork+0x7c/0xb0
[   33.105825]        SOFTIRQ-ON-R at:
[   33.105826]                             [<ffffffff810d38a3>] __lock_acquire+0x2f3/0xb50
[   33.105828]                             [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.105829]                             [<ffffffff8183382c>] _raw_read_lock+0x3c/0x50
[   33.105831]                             [<ffffffff8107d796>] do_wait+0xb6/0x340
[   33.105833]                             [<ffffffff8107ed54>] SyS_wait4+0x64/0xe0
[   33.105834]                             [<ffffffff8109500b>] wait_for_helper+0x4b/0x70
[   33.105836]                             [<ffffffff818342bc>] ret_from_fork+0x7c/0xb0
[   33.105837]        INITIAL USE at:
[   33.105838]                            [<ffffffff810d38f4>] __lock_acquire+0x344/0xb50
[   33.105840]                            [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.105842]                            [<ffffffff81833ba5>] _raw_write_lock_irq+0x45/0x60
[   33.105843]                            [<ffffffff81078861>] copy_process.part.23+0xcf1/0x1e50
[   33.105846]                            [<ffffffff81079b6e>] do_fork+0xce/0x750
[   33.105847]                            [<ffffffff8107a216>] kernel_thread+0x26/0x30
[   33.105849]                            [<ffffffff81817bb3>] rest_init+0x23/0x140
[   33.105851]                            [<ffffffff81f590ee>] start_kernel+0x499/0x4a4
[   33.105853]                            [<ffffffff81f585ee>] x86_64_start_reservations+0x2a/0x2c
[   33.105855]                            [<ffffffff81f58733>] x86_64_start_kernel+0x143/0x152
[   33.105857]      }
[   33.105858]      ... key      at: [<ffffffff81e0f058>] tasklist_lock+0x18/0x40
[   33.105860]      ... acquired at:
[   33.105861]    [<ffffffff810d39c8>] __lock_acquire+0x418/0xb50
[   33.105863]    [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.105864]    [<ffffffff8183382c>] _raw_read_lock+0x3c/0x50
[   33.105866]    [<ffffffff812342d5>] send_sigio+0x55/0x1d0
[   33.105868]    [<ffffffff8123451c>] kill_fasync+0xcc/0x2a0
[   33.105870]    [<ffffffff81633063>] evdev_pass_values+0xf3/0x1c0
[   33.105871]    [<ffffffff81634bd3>] evdev_events+0x1d3/0x2f0
[   33.105873]    [<ffffffff8162ba77>] input_to_handler+0x97/0xf0
[   33.105875]    [<ffffffff8162e9ac>] input_pass_values.part.6+0x2cc/0x370
[   33.105876]    [<ffffffff8162f361>] input_handle_event+0x121/0x540
[   33.105878]    [<ffffffff8162f988>] input_inject_event+0x198/0x230
[   33.105880]    [<ffffffff8163497c>] evdev_write+0x19c/0x220
[   33.105881]    [<ffffffff812208f7>] vfs_write+0xb7/0x1f0
[   33.105883]    [<ffffffff81221359>] SyS_write+0x49/0xb0
[   33.105884]    [<ffffffff8183436d>] system_call_fastpath+0x1a/0x1f
[   33.105886]
[   33.105887]    -> (&f->f_owner.lock){......} ops: 8 {
[   33.105889]       INITIAL USE at:
[   33.105890]                          [<ffffffff810d38f4>] __lock_acquire+0x344/0xb50
[   33.105891]                          [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.105893]                          [<ffffffff81833ba5>] _raw_write_lock_irq+0x45/0x60
[   33.105895]                          [<ffffffff81233687>] __f_setown+0x47/0xe0
[   33.105896]                          [<ffffffff812337bd>] f_setown+0x7d/0x120
[   33.105897]                          [<ffffffff81233f01>] SyS_fcntl+0x341/0x6c0
[   33.105899]                          [<ffffffff8183436d>] system_call_fastpath+0x1a/0x1f
[   33.105901]     }
[   33.105901]     ... key      at: [<ffffffff82e83920>] __key.31233+0x0/0x8
[   33.105905]     ... acquired at:
[   33.105905]    [<ffffffff810d39c8>] __lock_acquire+0x418/0xb50
[   33.105907]    [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.105908]    [<ffffffff8183382c>] _raw_read_lock+0x3c/0x50
[   33.105910]    [<ffffffff812342aa>] send_sigio+0x2a/0x1d0
[   33.105911]    [<ffffffff8123451c>] kill_fasync+0xcc/0x2a0
[   33.105913]    [<ffffffff81633063>] evdev_pass_values+0xf3/0x1c0
[   33.105914]    [<ffffffff81634bd3>] evdev_events+0x1d3/0x2f0
[   33.105916]    [<ffffffff8162ba77>] input_to_handler+0x97/0xf0
[   33.105918]    [<ffffffff8162e9ac>] input_pass_values.part.6+0x2cc/0x370
[   33.105919]    [<ffffffff8162f361>] input_handle_event+0x121/0x540
[   33.105921]    [<ffffffff8162f988>] input_inject_event+0x198/0x230
[   33.105922]    [<ffffffff8163497c>] evdev_write+0x19c/0x220
[   33.105924]    [<ffffffff812208f7>] vfs_write+0xb7/0x1f0
[   33.105925]    [<ffffffff81221359>] SyS_write+0x49/0xb0
[   33.105926]    [<ffffffff8183436d>] system_call_fastpath+0x1a/0x1f
[   33.105928]
[   33.105928]   -> (&(&new->fa_lock)->rlock){......} ops: 1 {
[   33.105930]      INITIAL USE at:
[   33.105931]                        [<ffffffff810d38f4>] __lock_acquire+0x344/0xb50
[   33.105933]                        [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.105934]                        [<ffffffff81833e01>] _raw_spin_lock_irqsave+0x51/0x70
[   33.105936]                        [<ffffffff812344ee>] kill_fasync+0x9e/0x2a0
[   33.105938]                        [<ffffffff81633063>] evdev_pass_values+0xf3/0x1c0
[   33.105939]                        [<ffffffff81634bd3>] evdev_events+0x1d3/0x2f0
[   33.105941]                        [<ffffffff8162ba77>] input_to_handler+0x97/0xf0
[   33.105942]                        [<ffffffff8162e9ac>] input_pass_values.part.6+0x2cc/0x370
[   33.105944]                        [<ffffffff8162f361>] input_handle_event+0x121/0x540
[   33.105946]                        [<ffffffff8162f988>] input_inject_event+0x198/0x230
[   33.105947]                        [<ffffffff8163497c>] evdev_write+0x19c/0x220
[   33.105949]                        [<ffffffff812208f7>] vfs_write+0xb7/0x1f0
[   33.105950]                        [<ffffffff81221359>] SyS_write+0x49/0xb0
[   33.105951]                        [<ffffffff8183436d>] system_call_fastpath+0x1a/0x1f
[   33.105953]    }
[   33.105953]    ... key      at: [<ffffffff82e84274>] __key.36822+0x0/0x8
[   33.105955]    ... acquired at:
[   33.105956]    [<ffffffff810d39c8>] __lock_acquire+0x418/0xb50
[   33.105957]    [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.105959]    [<ffffffff8182ef4b>] mutex_lock_nested+0x6b/0x4e0
[   33.105960]    [<ffffffff812a3f6e>] kernfs_fop_open+0x16e/0x360
[   33.105963]    [<ffffffff8121dcff>] do_dentry_open+0x1ff/0x350
[   33.105965]    [<ffffffff8121e030>] finish_open+0x40/0x50
[   33.105967]    [<ffffffff8123108a>] do_last+0xc0a/0x13c0
[   33.105968]    [<ffffffff812318fb>] path_openat+0xbb/0x680
[   33.105970]    [<ffffffff812326ea>] do_filp_open+0x3a/0x90
[   33.105971]    [<ffffffff8121f8d8>] do_sys_open+0x128/0x220
[   33.105973]    [<ffffffff8121f9ee>] SyS_open+0x1e/0x20
[   33.105974]    [<ffffffff8183436d>] system_call_fastpath+0x1a/0x1f
[   33.105976]
[   33.105977]  -> (&(&client->buffer_lock)->rlock){......} ops: 15 {
[   33.105979]     INITIAL USE at:
[   33.105980]                      [<ffffffff810d38f4>] __lock_acquire+0x344/0xb50
[   33.105981]                      [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.105983]                      [<ffffffff818334e9>] _raw_spin_lock+0x39/0x50
[   33.105984]                      [<ffffffff81632fd3>] evdev_pass_values+0x63/0x1c0
[   33.105986]                      [<ffffffff81634bd3>] evdev_events+0x1d3/0x2f0
[   33.105988]                      [<ffffffff8162ba77>] input_to_handler+0x97/0xf0
[   33.105989]                      [<ffffffff8162e9ac>] input_pass_values.part.6+0x2cc/0x370
[   33.105991]                      [<ffffffff8162f361>] input_handle_event+0x121/0x540
[   33.105992]                      [<ffffffff8162f7d9>] input_event+0x59/0x70
[   33.105994]                      [<ffffffffc0234ef0>] snd_jack_report+0xd0/0xe0 [snd]
[   33.106000]                      [<ffffffffc0393058>] snd_hda_jack_report_sync+0xd8/0xe0 [snd_hda_codec]
[   33.106006]                      [<ffffffffc042ff32>] jack_callback+0x82/0x90 [snd_hda_codec_hdmi]
[   33.106008]                      [<ffffffffc042ffeb>] hdmi_unsol_event+0xab/0x140 [snd_hda_codec_hdmi]
[   33.106010]                      [<ffffffffc0389187>] process_unsol_events+0x67/0x80 [snd_hda_codec]
[   33.106013]                      [<ffffffff8109a5f3>] process_one_work+0x1e3/0x650
[   33.106014]                      [<ffffffff8109ab81>] worker_thread+0x121/0x490
[   33.106015]                      [<ffffffff810a0adc>] kthread+0xfc/0x120
[   33.106017]                      [<ffffffff818342bc>] ret_from_fork+0x7c/0xb0
[   33.106019]   }
[   33.106020]   ... key      at: [<ffffffff82eae118>] __key.29718+0x0/0x8
[   33.106022]   ... acquired at:
[   33.106023]    [<ffffffff810d39c8>] __lock_acquire+0x418/0xb50
[   33.106025]    [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.106026]    [<ffffffff8182ef4b>] mutex_lock_nested+0x6b/0x4e0
[   33.106028]    [<ffffffff812a3f6e>] kernfs_fop_open+0x16e/0x360
[   33.106029]    [<ffffffff8121dcff>] do_dentry_open+0x1ff/0x350
[   33.106031]    [<ffffffff8121e030>] finish_open+0x40/0x50
[   33.106033]    [<ffffffff8123108a>] do_last+0xc0a/0x13c0
[   33.106034]    [<ffffffff812318fb>] path_openat+0xbb/0x680
[   33.106035]    [<ffffffff812326ea>] do_filp_open+0x3a/0x90
[   33.106036]    [<ffffffff8121f8d8>] do_sys_open+0x128/0x220
[   33.106038]    [<ffffffff8121f9ee>] SyS_open+0x1e/0x20
[   33.106040]    [<ffffffff8183436d>] system_call_fastpath+0x1a/0x1f
[   33.106041]
[   33.106042] -> (&(&dev->event_lock)->rlock#2){-.....} ops: 176 {
[   33.106044]    IN-HARDIRQ-W at:
[   33.106045]                     [<ffffffff810d3c1d>] __lock_acquire+0x66d/0xb50
[   33.106047]                     [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.106048]                     [<ffffffff81833e01>] _raw_spin_lock_irqsave+0x51/0x70
[   33.106050]                     [<ffffffff8162f7c5>] input_event+0x45/0x70
[   33.106052]                     [<ffffffffc03cc07f>] hidinput_report_event+0x3f/0x50 [hid]
[   33.106054]                     [<ffffffffc03ca1d8>] hid_report_raw_event+0x148/0x1c0 [hid]
[   33.106057]                     [<ffffffffc03ca362>] hid_input_report+0x112/0x190 [hid]
[   33.106059]                     [<ffffffffc03eac3c>] hid_irq_in+0x8c/0x210 [usbhid]
[   33.106061]                     [<ffffffff815e0a73>] __usb_hcd_giveback_urb+0x83/0x130
[   33.106063]                     [<ffffffff815e0c2f>] usb_hcd_giveback_urb+0x3f/0x140
[   33.106065]                     [<ffffffff816207cf>] handle_tx_event+0x22f/0x12b0
[   33.106068]                     [<ffffffff81621b06>] xhci_irq+0x2b6/0xa60
[   33.106069]                     [<ffffffff816222c1>] xhci_msi_irq+0x11/0x20
[   33.106071]                     [<ffffffff810e7e8e>] handle_irq_event_percpu+0x3e/0x340
[   33.106073]                     [<ffffffff810e81cd>] handle_irq_event+0x3d/0x60
[   33.106075]                     [<ffffffff810eafef>] handle_edge_irq+0x7f/0x120
[   33.106076]                     [<ffffffff8101c85e>] handle_irq+0x1e/0x30
[   33.106079]                     [<ffffffff8183738f>] do_IRQ+0x4f/0xf0
[   33.106081]                     [<ffffffff81835072>] ret_from_intr+0x0/0x1a
[   33.106082]                     [<ffffffff8167c147>] cpuidle_enter+0x17/0x20
[   33.106084]                     [<ffffffff810c7bb1>] cpu_idle_loop+0x401/0x4e0
[   33.106086]                     [<ffffffff810c7ceb>] cpu_startup_entry+0x5b/0x60
[   33.106087]                     [<ffffffff81817cca>] rest_init+0x13a/0x140
[   33.106088]                     [<ffffffff81f590ee>] start_kernel+0x499/0x4a4
[   33.106090]                     [<ffffffff81f585ee>] x86_64_start_reservations+0x2a/0x2c
[   33.106092]                     [<ffffffff81f58733>] x86_64_start_kernel+0x143/0x152
[   33.106094]    INITIAL USE at:
[   33.106094]                    [<ffffffff810d38f4>] __lock_acquire+0x344/0xb50
[   33.106096]                    [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.106098]                    [<ffffffff81833e01>] _raw_spin_lock_irqsave+0x51/0x70
[   33.106099]                    [<ffffffff8162f7c5>] input_event+0x45/0x70
[   33.106101]                    [<ffffffffc0234edb>] snd_jack_report+0xbb/0xe0 [snd]
[   33.106105]                    [<ffffffffc03932f1>] __snd_hda_jack_add_kctl+0x151/0x160 [snd_hda_codec]
[   33.106109]                    [<ffffffffc0393314>] snd_hda_jack_add_kctl+0x14/0x20 [snd_hda_codec]
[   33.106112]                    [<ffffffffc042e6e4>] generic_hdmi_build_jack+0xd4/0x150 [snd_hda_codec_hdmi]
[   33.106114]                    [<ffffffffc04300c6>] generic_hdmi_build_controls+0x46/0x210 [snd_hda_codec_hdmi]
[   33.106116]                    [<ffffffffc03923d5>] snd_hda_codec_build_controls+0x1c5/0x220 [snd_hda_codec]
[   33.106120]                    [<ffffffffc0392473>] snd_hda_build_controls+0x43/0xa0 [snd_hda_codec]
[   33.106123]                    [<ffffffffc03bf365>] azx_mixer_create+0x15/0x20 [snd_hda_controller]
[   33.106125]                    [<ffffffffc03ae751>] azx_probe_continue+0x361/0x710 [snd_hda_intel]
[   33.106127]                    [<ffffffffc03aeb95>] azx_probe_work+0x15/0x20 [snd_hda_intel]
[   33.106129]                    [<ffffffff8109a5f3>] process_one_work+0x1e3/0x650
[   33.106130]                    [<ffffffff8109ab81>] worker_thread+0x121/0x490
[   33.106132]                    [<ffffffff810a0adc>] kthread+0xfc/0x120
[   33.106134]                    [<ffffffff818342bc>] ret_from_fork+0x7c/0xb0
[   33.106135]  }
[   33.106136]  ... key      at: [<ffffffff82eae054>] __key.28093+0x0/0x8
[   33.106138]  ... acquired at:
[   33.106138]    [<ffffffff810d150a>] check_usage_forwards+0x17a/0x180
[   33.106140]    [<ffffffff810d2e71>] mark_lock+0x1a1/0x2a0
[   33.106141]    [<ffffffff810d3c1d>] __lock_acquire+0x66d/0xb50
[   33.106143]    [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.106145]    [<ffffffff81833e01>] _raw_spin_lock_irqsave+0x51/0x70
[   33.106146]    [<ffffffff8162f7c5>] input_event+0x45/0x70
[   33.106148]    [<ffffffffc03cc07f>] hidinput_report_event+0x3f/0x50 [hid]
[   33.106151]    [<ffffffffc03ca1d8>] hid_report_raw_event+0x148/0x1c0 [hid]
[   33.106153]    [<ffffffffc03ca362>] hid_input_report+0x112/0x190 [hid]
[   33.106155]    [<ffffffffc03eac3c>] hid_irq_in+0x8c/0x210 [usbhid]
[   33.106157]    [<ffffffff815e0a73>] __usb_hcd_giveback_urb+0x83/0x130
[   33.106159]    [<ffffffff815e0c2f>] usb_hcd_giveback_urb+0x3f/0x140
[   33.106160]    [<ffffffff816207cf>] handle_tx_event+0x22f/0x12b0
[   33.106162]    [<ffffffff81621b06>] xhci_irq+0x2b6/0xa60
[   33.106164]    [<ffffffff816222c1>] xhci_msi_irq+0x11/0x20
[   33.106165]    [<ffffffff810e7e8e>] handle_irq_event_percpu+0x3e/0x340
[   33.106167]    [<ffffffff810e81cd>] handle_irq_event+0x3d/0x60
[   33.106169]    [<ffffffff810eafef>] handle_edge_irq+0x7f/0x120
[   33.106170]    [<ffffffff8101c85e>] handle_irq+0x1e/0x30
[   33.106172]    [<ffffffff8183738f>] do_IRQ+0x4f/0xf0
[   33.106174]    [<ffffffff81835072>] ret_from_intr+0x0/0x1a
[   33.106175]    [<ffffffff8167c147>] cpuidle_enter+0x17/0x20
[   33.106177]    [<ffffffff810c7bb1>] cpu_idle_loop+0x401/0x4e0
[   33.106178]    [<ffffffff810c7ceb>] cpu_startup_entry+0x5b/0x60
[   33.106179]    [<ffffffff81817cca>] rest_init+0x13a/0x140
[   33.106181]    [<ffffffff81f590ee>] start_kernel+0x499/0x4a4
[   33.106182]    [<ffffffff81f585ee>] x86_64_start_reservations+0x2a/0x2c
[   33.106184]    [<ffffffff81f58733>] x86_64_start_kernel+0x143/0x152
[   33.106185]
[   33.106186]
[   33.106186] stack backtrace:
[   33.106188] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 3.17.0-031700rc3-generic #201409031132
[   33.106189] Hardware name: MSI MS-7924/Z97M-G43(MS-7924), BIOS V1.5 07/22/2014
[   33.106190]  ffffffff81e1d4c0 ffff88041ba03a60 ffffffff81829c6a ffffffff82bd7620
[   33.106192]  ffff88041ba03aa0 ffffffff81822ff3 ffffffff81cbcf5e 0000000000000000
[   33.106193]  ffffffff81e1dd58 ffffffff81e1d4c0 ffffffff81cbcf5e ffffffff82bd7620
[   33.106195] Call Trace:
[   33.106196]  <IRQ>  [<ffffffff81829c6a>] dump_stack+0x4d/0x66
[   33.106200]  [<ffffffff81822ff3>] print_irq_inversion_bug.part.38+0x1ac/0x1b8
[   33.106203]  [<ffffffff810d150a>] check_usage_forwards+0x17a/0x180
[   33.106205]  [<ffffffff8102b0bb>] ? save_stack_trace+0x2b/0x50
[   33.106206]  [<ffffffff810d1390>] ? check_usage_backwards+0x180/0x180
[   33.106208]  [<ffffffff810d2e71>] mark_lock+0x1a1/0x2a0
[   33.106210]  [<ffffffff810d3c1d>] __lock_acquire+0x66d/0xb50
[   33.106212]  [<ffffffffc03edd76>] ? hiddev_send_event.isra.3+0xe6/0x100 [usbhid]
[   33.106214]  [<ffffffff810d48f9>] lock_acquire+0xa9/0x200
[   33.106216]  [<ffffffff8162f7c5>] ? input_event+0x45/0x70
[   33.106218]  [<ffffffff81833e01>] _raw_spin_lock_irqsave+0x51/0x70
[   33.106219]  [<ffffffff8162f7c5>] ? input_event+0x45/0x70
[   33.106221]  [<ffffffff8162f7c5>] input_event+0x45/0x70
[   33.106224]  [<ffffffffc03cc07f>] hidinput_report_event+0x3f/0x50 [hid]
[   33.106226]  [<ffffffffc03ca1d8>] hid_report_raw_event+0x148/0x1c0 [hid]
[   33.106228]  [<ffffffff8183372f>] ? _raw_spin_unlock_irqrestore+0x5f/0x70
[   33.106230]  [<ffffffffc03ca362>] hid_input_report+0x112/0x190 [hid]
[   33.106232]  [<ffffffffc03eac3c>] hid_irq_in+0x8c/0x210 [usbhid]
[   33.106234]  [<ffffffff815e0a73>] __usb_hcd_giveback_urb+0x83/0x130
[   33.106236]  [<ffffffff815e0c2f>] usb_hcd_giveback_urb+0x3f/0x140
[   33.106238]  [<ffffffff816207cf>] handle_tx_event+0x22f/0x12b0
[   33.106240]  [<ffffffff8162187c>] ? xhci_irq+0x2c/0xa60
[   33.106241]  [<ffffffff81621b06>] xhci_irq+0x2b6/0xa60
[   33.106243]  [<ffffffff816222c1>] xhci_msi_irq+0x11/0x20
[   33.106245]  [<ffffffff810e7e8e>] handle_irq_event_percpu+0x3e/0x340
[   33.106247]  [<ffffffff810e81cd>] handle_irq_event+0x3d/0x60
[   33.106249]  [<ffffffff810eafef>] handle_edge_irq+0x7f/0x120
[   33.106251]  [<ffffffff8101c85e>] handle_irq+0x1e/0x30
[   33.106253]  [<ffffffff8183738f>] do_IRQ+0x4f/0xf0
[   33.106254]  [<ffffffff81835072>] common_interrupt+0x72/0x72
[   33.106255]  <EOI>  [<ffffffff8167be05>] ? cpuidle_enter_state+0x75/0x300
[   33.106258]  [<ffffffff8167c147>] cpuidle_enter+0x17/0x20
[   33.106260]  [<ffffffff810c7bb1>] cpu_idle_loop+0x401/0x4e0
[   33.106261]  [<ffffffff810c7ceb>] cpu_startup_entry+0x5b/0x60
[   33.106262]  [<ffffffff81817cca>] rest_init+0x13a/0x140
[   33.106264]  [<ffffffff81817b95>] ? rest_init+0x5/0x140
[   33.106266]  [<ffffffff81f590ee>] start_kernel+0x499/0x4a4
[   33.106267]  [<ffffffff81f58a4e>] ? set_init_arg+0x53/0x53
[   33.106269]  [<ffffffff81f58120>] ? early_idt_handlers+0x120/0x120
[   33.106271]  [<ffffffff81f585ee>] x86_64_start_reservations+0x2a/0x2c
[   33.106272]  [<ffffffff81f58733>] x86_64_start_kernel+0x143/0x152


I have fixed lockdep discussed here: https://lkml.org/lkml/2014/8/25/515 but as I'm not sure if my fix was any good I also tried to revert commit causing that and still I see this.

I have not tried bisecting yet but tried to check if anything has changed around those locks recently but did not spot anything obvious yet.

-Kari

^ permalink raw reply	[flat|nested] 4+ messages in thread
* INFO: possible irq lock inversion dependency detected
@ 2006-07-08 16:25 Arne Ahrend
  2006-07-08 17:12 ` Arjan van de Ven
  0 siblings, 1 reply; 4+ messages in thread
From: Arne Ahrend @ 2006-07-08 16:25 UTC (permalink / raw)
  To: linux-kernel


2.6.17-mm6 produces the following warning, but appears to be working perfectly fine.


Cheers,
Arne

=========================================================
[ INFO: possible irq lock inversion dependency detected ]
---------------------------------------------------------
swapper/0 just changed the state of lock:
 (&bfusb->lock){..?+}, at: [<e28e59e2>] bfusb_rx_complete+0x34/0x468 [bfusb]
but this lock took another, hard-irq-unsafe lock in the past:
 (&skb_queue_lock_key){-+..}

and interrupts could create inverse lock ordering between them.


other info that might help us debug this:
no locks held by swapper/0.

the first lock's dependencies:
-> (&bfusb->lock){..?+} ops: 0 {
   initial-use  at:
                        [<c012a05e>] lock_acquire+0x4f/0x6d
                        [<c0265f0f>] _write_lock_irqsave+0x2d/0x3c
                        [<e28e528d>] bfusb_open+0x27/0x5c [bfusb]
                        [<e291f8b5>] hci_dev_open+0x55/0x1e0 [bluetooth]
                        [<e2922ab2>] hci_sock_ioctl+0xd1/0x229 [bluetooth]
                        [<c02118b8>] sock_ioctl+0x193/0x1b9
                        [<c015d868>] do_ioctl+0x24/0x66
                        [<c015daf4>] vfs_ioctl+0x24a/0x25d
                        [<c015db35>] sys_ioctl+0x2e/0x4d
                        [<c010246b>] syscall_call+0x7/0xb
   in-hardirq-R at:
                        [<c012a05e>] lock_acquire+0x4f/0x6d
                        [<c0265d7e>] _read_lock+0x24/0x32
                        [<e28e59e2>] bfusb_rx_complete+0x34/0x468 [bfusb]
                        [<e2884c0d>] usb_hcd_giveback_urb+0x18/0x46 [usbcore]
                        [<e086c74c>] uhci_giveback_urb+0x120/0x14a [uhci_hcd]
                        [<e086cda9>] uhci_scan_schedule+0x536/0x7a8 [uhci_hcd]
                        [<e086e907>] uhci_irq+0x121/0x137 [uhci_hcd]
                        [<e28857a7>] usb_hcd_irq+0x27/0x58 [usbcore]
                        [<c0132452>] handle_IRQ_event+0x18/0x4a
                        [<c0133349>] handle_fasteoi_irq+0x6d/0xae
                        [<c010490c>] do_IRQ+0xa0/0xc4
   in-softirq-R at:
                        [<c012a05e>] lock_acquire+0x4f/0x6d
                        [<c0265d7e>] _read_lock+0x24/0x32
                        [<e28e6096>] bfusb_send_frame+0x280/0x2b6 [bfusb]
                        [<e291ee60>] hci_send_frame+0x55/0x5d [bluetooth]
                        [<e291f14a>] hci_cmd_task+0x94/0xcd [bluetooth]
                        [<c011786f>] tasklet_action+0x45/0x75
                        [<c0117a76>] __do_softirq+0x45/0x9f
                        [<c010480e>] do_softirq+0x4d/0xab
   hardirq-on-R at:
                        [<c012a05e>] lock_acquire+0x4f/0x6d
                        [<c0265d7e>] _read_lock+0x24/0x32
                        [<e28e6096>] bfusb_send_frame+0x280/0x2b6 [bfusb]
                        [<e291ee60>] hci_send_frame+0x55/0x5d [bluetooth]
                        [<e291f14a>] hci_cmd_task+0x94/0xcd [bluetooth]
                        [<c011786f>] tasklet_action+0x45/0x75
                        [<c0117a76>] __do_softirq+0x45/0x9f
                        [<c010480e>] do_softirq+0x4d/0xab
 }
 ... key      at: [<e28e8284>] __key.23218+0x0/0xffffde58 [bfusb]
  -> (modlist_lock){.+..} ops: 0 {
     initial-use  at:
                      [<c012a05e>] lock_acquire+0x4f/0x6d
                      [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                      [<c012ed3b>] is_module_address+0x12/0x6e
                      [<c0127b3d>] static_obj+0x25/0x2f
                      [<c012861e>] lockdep_init_map+0x6c/0xab
                      [<c01a60c7>] __spin_lock_init+0x25/0x6e
                      [<e0842c6f>] rtl8139_init_one+0x57e/0x81b [8139too]
                      [<c01aa8b0>] pci_device_probe+0x3a/0x61
                      [<c01f0165>] driver_probe_device+0x46/0x9a
                      [<c01f025b>] __driver_attach+0x3b/0x66
                      [<c01efbee>] bus_for_each_dev+0x46/0x6d
                      [<c01f00b4>] driver_attach+0x16/0x1b
                      [<c01ef876>] bus_add_driver+0x6e/0x113
                      [<c01f04fa>] driver_register+0xa3/0xa8
                      [<c01aaa33>] __pci_register_driver+0x55/0x7a
                      [<e080f01c>] ____versions+0x12fc/0xfffffcb8 [firmware_class]
                      [<c01304c8>] sys_init_module+0x13c5/0x1570
                      [<c010246b>] syscall_call+0x7/0xb
     in-softirq-W at:
                      [<c012a05e>] lock_acquire+0x4f/0x6d
                      [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                      [<c012ed3b>] is_module_address+0x12/0x6e
                      [<c0127b3d>] static_obj+0x25/0x2f
                      [<c012861e>] lockdep_init_map+0x6c/0xab
                      [<c01a60c7>] __spin_lock_init+0x25/0x6e
                      [<e28865a0>] usb_init_urb+0x30/0x3a [usbcore]
                      [<e28865e5>] usb_alloc_urb+0x3b/0x46 [usbcore]
                      [<e28e5302>] bfusb_tx_wakeup+0x40/0x160 [bfusb]
                      [<e28e60ad>] bfusb_send_frame+0x297/0x2b6 [bfusb]
                      [<e291ee60>] hci_send_frame+0x55/0x5d [bluetooth]
                      [<e291f14a>] hci_cmd_task+0x94/0xcd [bluetooth]
                      [<c011786f>] tasklet_action+0x45/0x75
                      [<c0117a76>] __do_softirq+0x45/0x9f
                      [<c010480e>] do_softirq+0x4d/0xab
   }
   ... key      at: [<c02b2338>] modlist_lock+0x38/0x60
 ... acquired at:
   [<c012a05e>] lock_acquire+0x4f/0x6d
   [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
   [<c012ed3b>] is_module_address+0x12/0x6e
   [<c0127b3d>] static_obj+0x25/0x2f
   [<c012861e>] lockdep_init_map+0x6c/0xab
   [<c01a60c7>] __spin_lock_init+0x25/0x6e
   [<e28865a0>] usb_init_urb+0x30/0x3a [usbcore]
   [<e28865e5>] usb_alloc_urb+0x3b/0x46 [usbcore]
   [<e28e514e>] bfusb_rx_submit+0x20/0x138 [bfusb]
   [<e28e5299>] bfusb_open+0x33/0x5c [bfusb]
   [<e291f8b5>] hci_dev_open+0x55/0x1e0 [bluetooth]
   [<e2922ab2>] hci_sock_ioctl+0xd1/0x229 [bluetooth]
   [<c02118b8>] sock_ioctl+0x193/0x1b9
   [<c015d868>] do_ioctl+0x24/0x66
   [<c015daf4>] vfs_ioctl+0x24a/0x25d
   [<c015db35>] sys_ioctl+0x2e/0x4d
   [<c010246b>] syscall_call+0x7/0xb

  -> (&parent->list_lock){.+..} ops: 0 {
     initial-use  at:
                      [<c012a05e>] lock_acquire+0x4f/0x6d
                      [<c0265fb1>] _spin_lock+0x24/0x32
                      [<c014b01d>] cache_alloc_refill+0x61/0x48d
                      [<c014b4f8>] kmem_cache_zalloc+0x34/0x78
                      [<c014bb4b>] kmem_cache_create+0x153/0x414
                      [<c033569f>] kmem_cache_init+0x144/0x318
                      [<c0328514>] start_kernel+0x137/0x2be
                      [<c0100199>] 0xc0100199
     in-softirq-W at:
                      [<c012a05e>] lock_acquire+0x4f/0x6d
                      [<c0265fb1>] _spin_lock+0x24/0x32
                      [<c014ac65>] free_block+0xd5/0x10e
                      [<c014aa0e>] __cache_free+0xb1/0xf5
                      [<c014aaa8>] kmem_cache_free+0x56/0x70
                      [<c0111218>] free_task+0x21/0x29
                      [<c0112b4e>] __put_task_struct+0xc3/0xcd
                      [<c01143ec>] delayed_put_task_struct+0x3b/0x43
                      [<c012238e>] __rcu_process_callbacks+0xfc/0x155
                      [<c01223f9>] rcu_process_callbacks+0x12/0x23
                      [<c011786f>] tasklet_action+0x45/0x75
                      [<c0117a76>] __do_softirq+0x45/0x9f
                      [<c010480e>] do_softirq+0x4d/0xab
   }
   ... key      at: [<c04abe0c>] __key.15401+0x0/0x8
 ... acquired at:
   [<c012a05e>] lock_acquire+0x4f/0x6d
   [<c0265fb1>] _spin_lock+0x24/0x32
   [<c014b01d>] cache_alloc_refill+0x61/0x48d
   [<c014b49f>] __kmalloc+0x56/0x7b
   [<c0216ade>] __alloc_skb+0x53/0x101
   [<e28e5168>] bfusb_rx_submit+0x3a/0x138 [bfusb]
   [<e28e5299>] bfusb_open+0x33/0x5c [bfusb]
   [<e291f8b5>] hci_dev_open+0x55/0x1e0 [bluetooth]
   [<e2922ab2>] hci_sock_ioctl+0xd1/0x229 [bluetooth]
   [<c02118b8>] sock_ioctl+0x193/0x1b9
   [<c015d868>] do_ioctl+0x24/0x66
   [<c015daf4>] vfs_ioctl+0x24a/0x25d
   [<c015db35>] sys_ioctl+0x2e/0x4d
   [<c010246b>] syscall_call+0x7/0xb

  -> (&skb_queue_lock_key){-+..} ops: 0 {
     initial-use  at:
                      [<c012a05e>] lock_acquire+0x4f/0x6d
                      [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                      [<c02158f8>] skb_queue_tail+0x16/0x34
                      [<c0225ebe>] netlink_broadcast+0x1ba/0x2ba
                      [<c0197f2d>] kobject_uevent+0x347/0x3be
                      [<c01f09a2>] store_uevent+0x11/0x16
                      [<c01f14cf>] class_device_attr_store+0x1e/0x23
                      [<c017e33c>] sysfs_write_file+0x96/0xbd
                      [<c014e2c7>] vfs_write+0x8e/0x135
                      [<c014e81c>] sys_write+0x3a/0x61
                      [<c010246b>] syscall_call+0x7/0xb
     in-softirq-W at:
                      [<c012a05e>] lock_acquire+0x4f/0x6d
                      [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                      [<c02158f8>] skb_queue_tail+0x16/0x34
                      [<c0215232>] sock_queue_rcv_skb+0xca/0x104
                      [<c02479eb>] udp_queue_rcv_skb+0x1fd/0x222
                      [<c0248f6d>] udp_rcv+0x38c/0x4ae
                      [<c022d568>] ip_local_deliver+0x157/0x1e7
                      [<c022d3e4>] ip_rcv+0x3a6/0x3d3
                      [<c021a5d9>] netif_receive_skb+0x13d/0x1a4
                      [<c021bfb4>] process_backlog+0x7c/0x112
                      [<c021bdbe>] net_rx_action+0x5b/0xed
                      [<c0117a76>] __do_softirq+0x45/0x9f
                      [<c010480e>] do_softirq+0x4d/0xab
     hardirq-on-W at:
                      [<c012a05e>] lock_acquire+0x4f/0x6d
                      [<c0265e29>] _spin_lock_bh+0x29/0x37
                      [<c02480a7>] udp_poll+0x4f/0xc6
                      [<c0211105>] sock_poll+0x17/0x19
                      [<c015e205>] do_sys_poll+0x207/0x3c0
                      [<c015e3ff>] sys_poll+0x41/0x43
                      [<c010246b>] syscall_call+0x7/0xb
   }
   ... key      at: [<c04b41a8>] skb_queue_lock_key+0x0/0x18
 ... acquired at:
   [<c012a05e>] lock_acquire+0x4f/0x6d
   [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
   [<c02158f8>] skb_queue_tail+0x16/0x34
   [<e28e5209>] bfusb_rx_submit+0xdb/0x138 [bfusb]
   [<e28e5299>] bfusb_open+0x33/0x5c [bfusb]
   [<e291f8b5>] hci_dev_open+0x55/0x1e0 [bluetooth]
   [<e2922ab2>] hci_sock_ioctl+0xd1/0x229 [bluetooth]
   [<c02118b8>] sock_ioctl+0x193/0x1b9
   [<c015d868>] do_ioctl+0x24/0x66
   [<c015daf4>] vfs_ioctl+0x24a/0x25d
   [<c015db35>] sys_ioctl+0x2e/0x4d
   [<c010246b>] syscall_call+0x7/0xb

  -> (hcd_data_lock){++..} ops: 0 {
     initial-use  at:
                      [<c012a05e>] lock_acquire+0x4f/0x6d
                      [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                      [<e28859f1>] hcd_submit_urb+0x35/0x823 [usbcore]
                      [<e288650a>] usb_submit_urb+0x1f7/0x21d [usbcore]
                      [<e2886ca4>] usb_start_wait_urb+0x70/0x125 [usbcore]
                      [<e2886f9b>] usb_control_msg+0xd2/0xee [usbcore]
                      [<e2887773>] usb_get_descriptor+0x6d/0xa3 [usbcore]
                      [<e2887a84>] usb_get_device_descriptor+0x43/0x79 [usbcore]
                      [<e288550d>] usb_add_hcd+0x3b6/0x4cd [usbcore]
                      [<e288d245>] usb_hcd_pci_probe+0x1db/0x26a [usbcore]
                      [<c01aa8b0>] pci_device_probe+0x3a/0x61
                      [<c01f0165>] driver_probe_device+0x46/0x9a
                      [<c01f025b>] __driver_attach+0x3b/0x66
                      [<c01efbee>] bus_for_each_dev+0x46/0x6d
                      [<c01f00b4>] driver_attach+0x16/0x1b
                      [<c01ef876>] bus_add_driver+0x6e/0x113
                      [<c01f04fa>] driver_register+0xa3/0xa8
                      [<c01aaa33>] __pci_register_driver+0x55/0x7a
                      [<e080f04e>] ____versions+0x132e/0xfffffcb8 [firmware_class]
                      [<c01304c8>] sys_init_module+0x13c5/0x1570
                      [<c010246b>] syscall_call+0x7/0xb
     in-hardirq-W at:
                      [<c012a05e>] lock_acquire+0x4f/0x6d
                      [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                      [<e2884bce>] urb_unlink+0x35/0x5c [usbcore]
                      [<e2884c03>] usb_hcd_giveback_urb+0xe/0x46 [usbcore]
                      [<e086c74c>] uhci_giveback_urb+0x120/0x14a [uhci_hcd]
                      [<e086cda9>] uhci_scan_schedule+0x536/0x7a8 [uhci_hcd]
                      [<e086e907>] uhci_irq+0x121/0x137 [uhci_hcd]
                      [<e28857a7>] usb_hcd_irq+0x27/0x58 [usbcore]
                      [<c0132452>] handle_IRQ_event+0x18/0x4a
                      [<c0133349>] handle_fasteoi_irq+0x6d/0xae
                      [<c010490c>] do_IRQ+0xa0/0xc4
     in-softirq-W at:
                      [<c012a05e>] lock_acquire+0x4f/0x6d
                      [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                      [<e2884bce>] urb_unlink+0x35/0x5c [usbcore]
                      [<e2884c03>] usb_hcd_giveback_urb+0xe/0x46 [usbcore]
                      [<e288500d>] usb_hcd_poll_rh_status+0x18c/0x19c [usbcore]
                      [<e2885028>] rh_timer_func+0xb/0xe [usbcore]
                      [<c011ac7c>] run_timer_softirq+0xf1/0x14a
                      [<c0117a76>] __do_softirq+0x45/0x9f
                      [<c010480e>] do_softirq+0x4d/0xab
   }
   ... key      at: [<e289d498>] hcd_data_lock+0x38/0xffff1403 [usbcore]
 ... acquired at:
   [<c012a05e>] lock_acquire+0x4f/0x6d
   [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
   [<e28859f1>] hcd_submit_urb+0x35/0x823 [usbcore]
   [<e288650a>] usb_submit_urb+0x1f7/0x21d [usbcore]
   [<e28e5211>] bfusb_rx_submit+0xe3/0x138 [bfusb]
   [<e28e5299>] bfusb_open+0x33/0x5c [bfusb]
   [<e291f8b5>] hci_dev_open+0x55/0x1e0 [bluetooth]
   [<e2922ab2>] hci_sock_ioctl+0xd1/0x229 [bluetooth]
   [<c02118b8>] sock_ioctl+0x193/0x1b9
   [<c015d868>] do_ioctl+0x24/0x66
   [<c015daf4>] vfs_ioctl+0x24a/0x25d
   [<c015db35>] sys_ioctl+0x2e/0x4d
   [<c010246b>] syscall_call+0x7/0xb

  -> (&uhci->lock){++..} ops: 0 {
     initial-use  at:
                      [<c012a05e>] lock_acquire+0x4f/0x6d
                      [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                      [<e086e4fe>] uhci_hub_control+0x64/0x34c [uhci_hcd]
                      [<e2885fe4>] hcd_submit_urb+0x628/0x823 [usbcore]
                      [<e288650a>] usb_submit_urb+0x1f7/0x21d [usbcore]
                      [<e2886ca4>] usb_start_wait_urb+0x70/0x125 [usbcore]
                      [<e2886f9b>] usb_control_msg+0xd2/0xee [usbcore]
                      [<e2883635>] hub_probe+0x1c4/0x5f8 [usbcore]
                      [<e28882db>] usb_probe_interface+0x60/0x95 [usbcore]
                      [<c01f0165>] driver_probe_device+0x46/0x9a
                      [<c01f01c7>] __device_attach+0xe/0x10
                      [<c01efae8>] bus_for_each_drv+0x46/0x77
                      [<c01f020c>] device_attach+0x43/0x57
                      [<c01ef7eb>] bus_attach_device+0x18/0x35
                      [<c01eec1b>] device_add+0x2ef/0x3dc
                      [<e2887694>] usb_set_configuration+0x335/0x3a7 [usbcore]
                      [<e2883224>] usb_new_device+0x2a9/0x301 [usbcore]
                      [<e2885534>] usb_add_hcd+0x3dd/0x4cd [usbcore]
                      [<e288d245>] usb_hcd_pci_probe+0x1db/0x26a [usbcore]
                      [<c01aa8b0>] pci_device_probe+0x3a/0x61
                      [<c01f0165>] driver_probe_device+0x46/0x9a
                      [<c01f025b>] __driver_attach+0x3b/0x66
                      [<c01efbee>] bus_for_each_dev+0x46/0x6d
                      [<c01f00b4>] driver_attach+0x16/0x1b
                      [<c01ef876>] bus_add_driver+0x6e/0x113
                      [<c01f04fa>] driver_register+0xa3/0xa8
                      [<c01aaa33>] __pci_register_driver+0x55/0x7a
                      [<e080f04e>] ____versions+0x132e/0xfffffcb8 [firmware_class]
                      [<c01304c8>] sys_init_module+0x13c5/0x1570
                      [<c010246b>] syscall_call+0x7/0xb
     in-hardirq-W at:
                      [<c012a05e>] lock_acquire+0x4f/0x6d
                      [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                      [<e086e8fb>] uhci_irq+0x115/0x137 [uhci_hcd]
                      [<e28857a7>] usb_hcd_irq+0x27/0x58 [usbcore]
                      [<c0132452>] handle_IRQ_event+0x18/0x4a
                      [<c0133349>] handle_fasteoi_irq+0x6d/0xae
                      [<c010490c>] do_IRQ+0xa0/0xc4
     in-softirq-W at:
                      [<c012a05e>] lock_acquire+0x4f/0x6d
                      [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                      [<e086e0a2>] uhci_hub_status_data+0x22/0x136 [uhci_hcd]
                      [<e2884eb4>] usb_hcd_poll_rh_status+0x33/0x19c [usbcore]
                      [<e2885028>] rh_timer_func+0xb/0xe [usbcore]
                      [<c011ac7c>] run_timer_softirq+0xf1/0x14a
                      [<c0117a76>] __do_softirq+0x45/0x9f
                      [<c010480e>] do_softirq+0x4d/0xab
   }
   ... key      at: [<e0871940>] __key.18912+0x0/0xffffd523 [uhci_hcd]
    -> (&parent->list_lock){.+..} ops: 0 {
       initial-use  at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265fb1>] _spin_lock+0x24/0x32
                       [<c014b01d>] cache_alloc_refill+0x61/0x48d
                       [<c014b4f8>] kmem_cache_zalloc+0x34/0x78
                       [<c014bb4b>] kmem_cache_create+0x153/0x414
                       [<c033569f>] kmem_cache_init+0x144/0x318
                       [<c0328514>] start_kernel+0x137/0x2be
                       [<c0100199>] 0xc0100199
       in-softirq-W at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265fb1>] _spin_lock+0x24/0x32
                       [<c014ac65>] free_block+0xd5/0x10e
                       [<c014aa0e>] __cache_free+0xb1/0xf5
                       [<c014aaa8>] kmem_cache_free+0x56/0x70
                       [<c0111218>] free_task+0x21/0x29
                       [<c0112b4e>] __put_task_struct+0xc3/0xcd
                       [<c01143ec>] delayed_put_task_struct+0x3b/0x43
                       [<c012238e>] __rcu_process_callbacks+0xfc/0x155
                       [<c01223f9>] rcu_process_callbacks+0x12/0x23
                       [<c011786f>] tasklet_action+0x45/0x75
                       [<c0117a76>] __do_softirq+0x45/0x9f
                       [<c010480e>] do_softirq+0x4d/0xab
     }
     ... key      at: [<c04abe0c>] __key.15401+0x0/0x8
   ... acquired at:
   [<c012a05e>] lock_acquire+0x4f/0x6d
   [<c0265fb1>] _spin_lock+0x24/0x32
   [<c014b01d>] cache_alloc_refill+0x61/0x48d
   [<c014af98>] kmem_cache_alloc+0x33/0x57
   [<e086d862>] uhci_urb_enqueue+0x46/0x70e [uhci_hcd]
   [<e288615a>] hcd_submit_urb+0x79e/0x823 [usbcore]
   [<e288650a>] usb_submit_urb+0x1f7/0x21d [usbcore]
   [<e2886ca4>] usb_start_wait_urb+0x70/0x125 [usbcore]
   [<e2886f9b>] usb_control_msg+0xd2/0xee [usbcore]
   [<e28822cc>] hub_port_init+0x1d6/0x45a [usbcore]
   [<e2884035>] hub_thread+0x4bd/0x932 [usbcore]
   [<c01242f2>] kthread+0xb0/0xde
   [<c01006e9>] kernel_thread_helper+0x5/0xb

    -> (&retval->lock){++..} ops: 0 {
       initial-use  at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                       [<c01f22f2>] dma_pool_alloc+0x14/0x189
                       [<e086d373>] uhci_alloc_td+0x14/0x42 [uhci_hcd]
                       [<e086eb62>] uhci_start+0x1b3/0x3a7 [uhci_hcd]
                       [<e288546d>] usb_add_hcd+0x316/0x4cd [usbcore]
                       [<e288d245>] usb_hcd_pci_probe+0x1db/0x26a [usbcore]
                       [<c01aa8b0>] pci_device_probe+0x3a/0x61
                       [<c01f0165>] driver_probe_device+0x46/0x9a
                       [<c01f025b>] __driver_attach+0x3b/0x66
                       [<c01efbee>] bus_for_each_dev+0x46/0x6d
                       [<c01f00b4>] driver_attach+0x16/0x1b
                       [<c01ef876>] bus_add_driver+0x6e/0x113
                       [<c01f04fa>] driver_register+0xa3/0xa8
                       [<c01aaa33>] __pci_register_driver+0x55/0x7a
                       [<e080f04e>] ____versions+0x132e/0xfffffcb8 [firmware_class]
                       [<c01304c8>] sys_init_module+0x13c5/0x1570
                       [<c010246b>] syscall_call+0x7/0xb
       in-hardirq-W at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                       [<c01f21c4>] dma_pool_free+0x14/0x12e
                       [<e086c4cb>] uhci_free_td+0x6a/0x75 [uhci_hcd]
                       [<e086cbc9>] uhci_scan_schedule+0x356/0x7a8 [uhci_hcd]
                       [<e086e907>] uhci_irq+0x121/0x137 [uhci_hcd]
                       [<e28857a7>] usb_hcd_irq+0x27/0x58 [usbcore]
                       [<c0132452>] handle_IRQ_event+0x18/0x4a
                       [<c0133349>] handle_fasteoi_irq+0x6d/0xae
                       [<c010490c>] do_IRQ+0xa0/0xc4
       in-softirq-W at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                       [<c01f21c4>] dma_pool_free+0x14/0x12e
                       [<e086c4cb>] uhci_free_td+0x6a/0x75 [uhci_hcd]
                       [<e086cbc9>] uhci_scan_schedule+0x356/0x7a8 [uhci_hcd]
                       [<e086e0ae>] uhci_hub_status_data+0x2e/0x136 [uhci_hcd]
                       [<e2884eb4>] usb_hcd_poll_rh_status+0x33/0x19c [usbcore]
                       [<e2885028>] rh_timer_func+0xb/0xe [usbcore]
                       [<c011ac7c>] run_timer_softirq+0xf1/0x14a
                       [<c0117a76>] __do_softirq+0x45/0x9f
                       [<c010480e>] do_softirq+0x4d/0xab
     }
     ... key      at: [<c04b3444>] __key.14448+0x0/0x8
   ... acquired at:
   [<c012a05e>] lock_acquire+0x4f/0x6d
   [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
   [<c01f22f2>] dma_pool_alloc+0x14/0x189
   [<e086d6a9>] uhci_alloc_qh+0x21/0xc2 [uhci_hcd]
   [<e086d8b7>] uhci_urb_enqueue+0x9b/0x70e [uhci_hcd]
   [<e288615a>] hcd_submit_urb+0x79e/0x823 [usbcore]
   [<e288650a>] usb_submit_urb+0x1f7/0x21d [usbcore]
   [<e2886ca4>] usb_start_wait_urb+0x70/0x125 [usbcore]
   [<e2886f9b>] usb_control_msg+0xd2/0xee [usbcore]
   [<e28822cc>] hub_port_init+0x1d6/0x45a [usbcore]
   [<e2884035>] hub_thread+0x4bd/0x932 [usbcore]
   [<c01242f2>] kthread+0xb0/0xde
   [<c01006e9>] kernel_thread_helper+0x5/0xb

    -> (&urb->lock){+...} ops: 0 {
       initial-use  at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265fb1>] _spin_lock+0x24/0x32
                       [<e288607f>] hcd_submit_urb+0x6c3/0x823 [usbcore]
                       [<e288650a>] usb_submit_urb+0x1f7/0x21d [usbcore]
                       [<e2886ca4>] usb_start_wait_urb+0x70/0x125 [usbcore]
                       [<e2886f9b>] usb_control_msg+0xd2/0xee [usbcore]
                       [<e2887773>] usb_get_descriptor+0x6d/0xa3 [usbcore]
                       [<e2887a84>] usb_get_device_descriptor+0x43/0x79 [usbcore]
                       [<e288550d>] usb_add_hcd+0x3b6/0x4cd [usbcore]
                       [<e288d245>] usb_hcd_pci_probe+0x1db/0x26a [usbcore]
                       [<c01aa8b0>] pci_device_probe+0x3a/0x61
                       [<c01f0165>] driver_probe_device+0x46/0x9a
                       [<c01f025b>] __driver_attach+0x3b/0x66
                       [<c01efbee>] bus_for_each_dev+0x46/0x6d
                       [<c01f00b4>] driver_attach+0x16/0x1b
                       [<c01ef876>] bus_add_driver+0x6e/0x113
                       [<c01f04fa>] driver_register+0xa3/0xa8
                       [<c01aaa33>] __pci_register_driver+0x55/0x7a
                       [<e080f04e>] ____versions+0x132e/0xfffffcb8 [firmware_class]
                       [<c01304c8>] sys_init_module+0x13c5/0x1570
                       [<c010246b>] syscall_call+0x7/0xb
       in-hardirq-W at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265fb1>] _spin_lock+0x24/0x32
                       [<e086cd45>] uhci_scan_schedule+0x4d2/0x7a8 [uhci_hcd]
                       [<e086e907>] uhci_irq+0x121/0x137 [uhci_hcd]
                       [<e28857a7>] usb_hcd_irq+0x27/0x58 [usbcore]
                       [<c0132452>] handle_IRQ_event+0x18/0x4a
                       [<c0133349>] handle_fasteoi_irq+0x6d/0xae
                       [<c010490c>] do_IRQ+0xa0/0xc4
     }
     ... key      at: [<e289e558>] __key.16238+0x0/0xffff030b [usbcore]
   ... acquired at:
   [<c012a05e>] lock_acquire+0x4f/0x6d
   [<c0265fb1>] _spin_lock+0x24/0x32
   [<e086cd45>] uhci_scan_schedule+0x4d2/0x7a8 [uhci_hcd]
   [<e086e907>] uhci_irq+0x121/0x137 [uhci_hcd]
   [<e28857a7>] usb_hcd_irq+0x27/0x58 [usbcore]
   [<c0132452>] handle_IRQ_event+0x18/0x4a
   [<c0133349>] handle_fasteoi_irq+0x6d/0xae
   [<c010490c>] do_IRQ+0xa0/0xc4

    -> (&waitqueue_lock_key){++..} ops: 0 {
       initial-use  at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265df2>] _spin_lock_irq+0x2a/0x38
                       [<c0263e7f>] wait_for_completion+0x15/0xc1
                       [<c01240e1>] keventd_create_kthread+0x2e/0x5e
                       [<c01241f6>] kthread_create+0xe5/0x131
                       [<c0117675>] cpu_callback+0x4d/0x97
                       [<c033373d>] spawn_ksoftirqd+0x11/0x23
                       [<c0100246>] _stext+0x26/0x1e6
                       [<c01006e9>] kernel_thread_helper+0x5/0xb
       in-hardirq-W at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                       [<c010f489>] complete+0x12/0x3e
                       [<c0200185>] ata_qc_complete_internal+0x11/0x13
                       [<c01fddf7>] __ata_qc_complete+0x1cd/0x1d6
                       [<c01fdf18>] ata_qc_complete+0xa6/0xae
                       [<c01fe57c>] ata_hsm_qc_complete+0x1be/0x1ce
                       [<c01febba>] ata_hsm_move+0x62e/0x644
                       [<c01fec7d>] ata_host_intr+0xad/0xc7
                       [<c0205d07>] pata_via_interrupt+0xd7/0x10a
                       [<c0132452>] handle_IRQ_event+0x18/0x4a
                       [<c0133290>] handle_edge_irq+0xc1/0x10d
                       [<c010490c>] do_IRQ+0xa0/0xc4
       in-softirq-W at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                       [<c010f489>] complete+0x12/0x3e
                       [<c0122155>] wakeme_after_rcu+0xe/0x10
                       [<c012238e>] __rcu_process_callbacks+0xfc/0x155
                       [<c01223f9>] rcu_process_callbacks+0x12/0x23
                       [<c011786f>] tasklet_action+0x45/0x75
                       [<c0117a76>] __do_softirq+0x45/0x9f
                       [<c010480e>] do_softirq+0x4d/0xab
     }
     ... key      at: [<c0375cd4>] waitqueue_lock_key+0x0/0x8
      -> (&rq->rq_lock_key){++..} ops: 0 {
         initial-use  at:
                        [<c012a05e>] lock_acquire+0x4f/0x6d
                        [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                        [<c010f651>] init_idle+0x4b/0x70
                        [<c03331d5>] sched_init+0xb6/0xbf
                        [<c0328437>] start_kernel+0x5a/0x2be
                        [<c0100199>] 0xc0100199
         in-hardirq-W at:
                        [<c012a05e>] lock_acquire+0x4f/0x6d
                        [<c0265fb1>] _spin_lock+0x24/0x32
                        [<c010f71a>] scheduler_tick+0xa4/0x2a1
                        [<c011b7e7>] update_process_times+0x51/0x5f
                        [<c0105810>] timer_interrupt+0x5f/0x9b
                        [<c0132452>] handle_IRQ_event+0x18/0x4a
                        [<c0133655>] handle_level_irq+0x76/0xc5
                        [<c010490c>] do_IRQ+0xa0/0xc4
         in-softirq-W at:
                        [<c012a05e>] lock_acquire+0x4f/0x6d
                        [<c0265fb1>] _spin_lock+0x24/0x32
                        [<c010fb9c>] task_rq_lock+0x17/0x1e
                        [<c010fcc6>] try_to_wake_up+0x18/0xed
                        [<c010fdaf>] default_wake_function+0x14/0x16
                        [<c010f118>] __wake_up_common+0x2b/0x50
                        [<c010f4a2>] complete+0x2b/0x3e
                        [<c0122155>] wakeme_after_rcu+0xe/0x10
                        [<c012238e>] __rcu_process_callbacks+0xfc/0x155
                        [<c01223f9>] rcu_process_callbacks+0x12/0x23
                        [<c011786f>] tasklet_action+0x45/0x75
                        [<c0117a76>] __do_softirq+0x45/0x9f
                        [<c010480e>] do_softirq+0x4d/0xab
       }
       ... key      at: [<c036326c>] per_cpu__runqueues+0x98c/0x994
     ... acquired at:
   [<c012a05e>] lock_acquire+0x4f/0x6d
   [<c0265fb1>] _spin_lock+0x24/0x32
   [<c010fb9c>] task_rq_lock+0x17/0x1e
   [<c010fcc6>] try_to_wake_up+0x18/0xed
   [<c010fdaf>] default_wake_function+0x14/0x16
   [<c010f118>] __wake_up_common+0x2b/0x50
   [<c010f4a2>] complete+0x2b/0x3e
   [<c01242d1>] kthread+0x8f/0xde
   [<c01006e9>] kernel_thread_helper+0x5/0xb

   ... acquired at:
   [<c012a05e>] lock_acquire+0x4f/0x6d
   [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
   [<c010f50e>] __wake_up+0x15/0x3b
   [<e086c816>] uhci_make_qh_idle+0xa0/0xa8 [uhci_hcd]
   [<e086cf54>] uhci_scan_schedule+0x6e1/0x7a8 [uhci_hcd]
   [<e086e907>] uhci_irq+0x121/0x137 [uhci_hcd]
   [<e28857a7>] usb_hcd_irq+0x27/0x58 [usbcore]
   [<c0132452>] handle_IRQ_event+0x18/0x4a
   [<c0133349>] handle_fasteoi_irq+0x6d/0xae
   [<c010490c>] do_IRQ+0xa0/0xc4

    -> (base_lock_keys + cpu){++..} ops: 0 {
       initial-use  at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                       [<c011b5ce>] lock_timer_base+0x18/0x33
                       [<c011b65c>] __mod_timer+0x24/0x96
                       [<c011b738>] mod_timer+0x2d/0x31
                       [<c03398a6>] con_init+0xb5/0x1e5
                       [<c0339369>] console_init+0x20/0x30
                       [<c03284e6>] start_kernel+0x109/0x2be
                       [<c0100199>] 0xc0100199
       in-hardirq-W at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                       [<c011b5ce>] lock_timer_base+0x18/0x33
                       [<c011b605>] del_timer+0x1c/0x4f
                       [<c01f66de>] scsi_delete_timer+0x10/0x23
                       [<c01f41a7>] scsi_done+0xd/0x1e
                       [<c0201f88>] atapi_qc_complete+0x202/0x212
                       [<c01fddf7>] __ata_qc_complete+0x1cd/0x1d6
                       [<c01fdf18>] ata_qc_complete+0xa6/0xae
                       [<c01fe57c>] ata_hsm_qc_complete+0x1be/0x1ce
                       [<c01febba>] ata_hsm_move+0x62e/0x644
                       [<c01fec7d>] ata_host_intr+0xad/0xc7
                       [<c0205d07>] pata_via_interrupt+0xd7/0x10a
                       [<c0132452>] handle_IRQ_event+0x18/0x4a
                       [<c0133290>] handle_edge_irq+0xc1/0x10d
                       [<c010490c>] do_IRQ+0xa0/0xc4
       in-softirq-W at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265df2>] _spin_lock_irq+0x2a/0x38
                       [<c011abb4>] run_timer_softirq+0x29/0x14a
                       [<c0117a76>] __do_softirq+0x45/0x9f
                       [<c010480e>] do_softirq+0x4d/0xab
     }
     ... key      at: [<c0374fa8>] base_lock_keys+0x0/0x18
   ... acquired at:
   [<c012a05e>] lock_acquire+0x4f/0x6d
   [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
   [<c011b5ce>] lock_timer_base+0x18/0x33
   [<c011b65c>] __mod_timer+0x24/0x96
   [<c011b738>] mod_timer+0x2d/0x31
   [<e086cfd5>] uhci_scan_schedule+0x762/0x7a8 [uhci_hcd]
   [<e086e907>] uhci_irq+0x121/0x137 [uhci_hcd]
   [<e28857a7>] usb_hcd_irq+0x27/0x58 [usbcore]
   [<c0132452>] handle_IRQ_event+0x18/0x4a
   [<c0133349>] handle_fasteoi_irq+0x6d/0xae
   [<c010490c>] do_IRQ+0xa0/0xc4

    -> (&urb->lock#3){++..} ops: 0 {
       initial-use  at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265fb1>] _spin_lock+0x24/0x32
                       [<e086cd45>] uhci_scan_schedule+0x4d2/0x7a8 [uhci_hcd]
                       [<e086e907>] uhci_irq+0x121/0x137 [uhci_hcd]
                       [<e28857a7>] usb_hcd_irq+0x27/0x58 [usbcore]
                       [<c0132452>] handle_IRQ_event+0x18/0x4a
                       [<c0133349>] handle_fasteoi_irq+0x6d/0xae
                       [<c010490c>] do_IRQ+0xa0/0xc4
       in-hardirq-W at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265fb1>] _spin_lock+0x24/0x32
                       [<e086cd45>] uhci_scan_schedule+0x4d2/0x7a8 [uhci_hcd]
                       [<e086e907>] uhci_irq+0x121/0x137 [uhci_hcd]
                       [<e28857a7>] usb_hcd_irq+0x27/0x58 [usbcore]
                       [<c0132452>] handle_IRQ_event+0x18/0x4a
                       [<c0133349>] handle_fasteoi_irq+0x6d/0xae
                       [<c010490c>] do_IRQ+0xa0/0xc4
       in-softirq-W at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265fb1>] _spin_lock+0x24/0x32
                       [<e086cd45>] uhci_scan_schedule+0x4d2/0x7a8 [uhci_hcd]
                       [<e086e0ae>] uhci_hub_status_data+0x2e/0x136 [uhci_hcd]
                       [<e2884eb4>] usb_hcd_poll_rh_status+0x33/0x19c [usbcore]
                       [<e2885028>] rh_timer_func+0xb/0xe [usbcore]
                       [<c011ac7c>] run_timer_softirq+0xf1/0x14a
                       [<c0117a76>] __do_softirq+0x45/0x9f
                       [<c010480e>] do_softirq+0x4d/0xab
     }
     ... key      at: [<e289e550>] __key.16249+0x0/0xffff0313 [usbcore]
   ... acquired at:
   [<c012a05e>] lock_acquire+0x4f/0x6d
   [<c0265fb1>] _spin_lock+0x24/0x32
   [<e086cd45>] uhci_scan_schedule+0x4d2/0x7a8 [uhci_hcd]
   [<e086e907>] uhci_irq+0x121/0x137 [uhci_hcd]
   [<e28857a7>] usb_hcd_irq+0x27/0x58 [usbcore]
   [<c0132452>] handle_IRQ_event+0x18/0x4a
   [<c0133349>] handle_fasteoi_irq+0x6d/0xae
   [<c010490c>] do_IRQ+0xa0/0xc4

    -> (&urb->lock#4){+...} ops: 0 {
       initial-use  at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265fb1>] _spin_lock+0x24/0x32
                       [<e086cd45>] uhci_scan_schedule+0x4d2/0x7a8 [uhci_hcd]
                       [<e086e907>] uhci_irq+0x121/0x137 [uhci_hcd]
                       [<e28857a7>] usb_hcd_irq+0x27/0x58 [usbcore]
                       [<c0132452>] handle_IRQ_event+0x18/0x4a
                       [<c0133349>] handle_fasteoi_irq+0x6d/0xae
                       [<c010490c>] do_IRQ+0xa0/0xc4
       in-hardirq-W at:
                       [<c012a05e>] lock_acquire+0x4f/0x6d
                       [<c0265fb1>] _spin_lock+0x24/0x32
                       [<e086cd45>] uhci_scan_schedule+0x4d2/0x7a8 [uhci_hcd]
                       [<e086e907>] uhci_irq+0x121/0x137 [uhci_hcd]
                       [<e28857a7>] usb_hcd_irq+0x27/0x58 [usbcore]
                       [<c0132452>] handle_IRQ_event+0x18/0x4a
                       [<c0133349>] handle_fasteoi_irq+0x6d/0xae
                       [<c010490c>] do_IRQ+0xa0/0xc4
     }
     ... key      at: [<e28e8294>] __key.17448+0x0/0xffffde48 [bfusb]
   ... acquired at:
   [<c012a05e>] lock_acquire+0x4f/0x6d
   [<c0265fb1>] _spin_lock+0x24/0x32
   [<e086cd45>] uhci_scan_schedule+0x4d2/0x7a8 [uhci_hcd]
   [<e086e907>] uhci_irq+0x121/0x137 [uhci_hcd]
   [<e28857a7>] usb_hcd_irq+0x27/0x58 [usbcore]
   [<c0132452>] handle_IRQ_event+0x18/0x4a
   [<c0133349>] handle_fasteoi_irq+0x6d/0xae
   [<c010490c>] do_IRQ+0xa0/0xc4

 ... acquired at:
   [<c012a05e>] lock_acquire+0x4f/0x6d
   [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
   [<e086d83e>] uhci_urb_enqueue+0x22/0x70e [uhci_hcd]
   [<e288615a>] hcd_submit_urb+0x79e/0x823 [usbcore]
   [<e288650a>] usb_submit_urb+0x1f7/0x21d [usbcore]
   [<e28e5211>] bfusb_rx_submit+0xe3/0x138 [bfusb]
   [<e28e5299>] bfusb_open+0x33/0x5c [bfusb]
   [<e291f8b5>] hci_dev_open+0x55/0x1e0 [bluetooth]
   [<e2922ab2>] hci_sock_ioctl+0xd1/0x229 [bluetooth]
   [<c02118b8>] sock_ioctl+0x193/0x1b9
   [<c015d868>] do_ioctl+0x24/0x66
   [<c015daf4>] vfs_ioctl+0x24a/0x25d
   [<c015db35>] sys_ioctl+0x2e/0x4d
   [<c010246b>] syscall_call+0x7/0xb


the second lock's dependencies:
-> (&skb_queue_lock_key){-+..} ops: 0 {
   initial-use  at:
                        [<c012a05e>] lock_acquire+0x4f/0x6d
                        [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                        [<c02158f8>] skb_queue_tail+0x16/0x34
                        [<c0225ebe>] netlink_broadcast+0x1ba/0x2ba
                        [<c0197f2d>] kobject_uevent+0x347/0x3be
                        [<c01f09a2>] store_uevent+0x11/0x16
                        [<c01f14cf>] class_device_attr_store+0x1e/0x23
                        [<c017e33c>] sysfs_write_file+0x96/0xbd
                        [<c014e2c7>] vfs_write+0x8e/0x135
                        [<c014e81c>] sys_write+0x3a/0x61
                        [<c010246b>] syscall_call+0x7/0xb
   in-softirq-W at:
                        [<c012a05e>] lock_acquire+0x4f/0x6d
                        [<c0265db9>] _spin_lock_irqsave+0x2d/0x3c
                        [<c02158f8>] skb_queue_tail+0x16/0x34
                        [<c0215232>] sock_queue_rcv_skb+0xca/0x104
                        [<c02479eb>] udp_queue_rcv_skb+0x1fd/0x222
                        [<c0248f6d>] udp_rcv+0x38c/0x4ae
                        [<c022d568>] ip_local_deliver+0x157/0x1e7
                        [<c022d3e4>] ip_rcv+0x3a6/0x3d3
                        [<c021a5d9>] netif_receive_skb+0x13d/0x1a4
                        [<c021bfb4>] process_backlog+0x7c/0x112
                        [<c021bdbe>] net_rx_action+0x5b/0xed
                        [<c0117a76>] __do_softirq+0x45/0x9f
                        [<c010480e>] do_softirq+0x4d/0xab
   hardirq-on-W at:
                        [<c012a05e>] lock_acquire+0x4f/0x6d
                        [<c0265e29>] _spin_lock_bh+0x29/0x37
                        [<c02480a7>] udp_poll+0x4f/0xc6
                        [<c0211105>] sock_poll+0x17/0x19
                        [<c015e205>] do_sys_poll+0x207/0x3c0
                        [<c015e3ff>] sys_poll+0x41/0x43
                        [<c010246b>] syscall_call+0x7/0xb
 }
 ... key      at: [<c04b41a8>] skb_queue_lock_key+0x0/0x18

stack backtrace:
 [<c0103433>] show_trace+0x16/0x19
 [<c0103913>] dump_stack+0x1a/0x1f
 [<c01285a5>] print_irq_inversion_bug+0xe3/0xf0
 [<c012881d>] check_usage_forwards+0x32/0x3b
 [<c01289d5>] mark_lock+0x1af/0x35a
 [<c0129504>] __lock_acquire+0x328/0x929
 [<c012a05e>] lock_acquire+0x4f/0x6d
 [<c0265d7e>] _read_lock+0x24/0x32
 [<e28e59e2>] bfusb_rx_complete+0x34/0x468 [bfusb]
 [<e2884c0d>] usb_hcd_giveback_urb+0x18/0x46 [usbcore]
 [<e086c74c>] uhci_giveback_urb+0x120/0x14a [uhci_hcd]
 [<e086cda9>] uhci_scan_schedule+0x536/0x7a8 [uhci_hcd]
 [<e086e907>] uhci_irq+0x121/0x137 [uhci_hcd]
 [<e28857a7>] usb_hcd_irq+0x27/0x58 [usbcore]
 [<c0132452>] handle_IRQ_event+0x18/0x4a
 [<c0133349>] handle_fasteoi_irq+0x6d/0xae
 [<c010490c>] do_IRQ+0xa0/0xc4
 =======================
 [<c0102e59>] common_interrupt+0x25/0x2c
 [<c01013de>] cpu_idle+0x3c/0x65
 [<c010043d>] rest_init+0x37/0x3e
 [<c0328699>] start_kernel+0x2bc/0x2be
 [<c0100199>] 0xc0100199


_____________________________________________________________________
Der WEB.DE SmartSurfer hilft bis zu 70% Ihrer Onlinekosten zu sparen!
http://smartsurfer.web.de/?mc=100071&distributionid=000000000071


^ permalink raw reply	[flat|nested] 4+ messages in thread

end of thread, other threads:[~2014-09-05 16:21 UTC | newest]

Thread overview: 4+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2006-07-08 23:00 INFO: possible irq lock inversion dependency detected Arne Ahrend
  -- strict thread matches above, loose matches on Subject: below --
2014-09-05 16:20 Kari Suvanto
2006-07-08 16:25 Arne Ahrend
2006-07-08 17:12 ` Arjan van de Ven

This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox