* [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ]
@ 2012-12-22 15:28 Maciej Rutecki
2012-12-23 21:34 ` Christian Kujau
2012-12-26 2:34 ` Shawn Guo
0 siblings, 2 replies; 16+ messages in thread
From: Maciej Rutecki @ 2012-12-22 15:28 UTC (permalink / raw)
To: LKML; +Cc: Cong Wang
Got during suspend to disk:
[ 269.784867] [ INFO: possible circular locking dependency detected ]
[ 269.784869] 3.8.0-rc1 #1 Not tainted
[ 269.784870] -------------------------------------------------------
[ 269.784871] kworker/u:3/56 is trying to acquire lock:
[ 269.784878] ((fb_notifier_list).rwsem){.+.+.+}, at: [<ffffffff81062a1d>]
__blocking_notifier_call_chain+0x49/0x80
[ 269.784879]
[ 269.784879] but task is already holding lock:
[ 269.784884] (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
i915_drm_freeze+0x9e/0xbb
[ 269.784884]
[ 269.784884] which lock already depends on the new lock.
[ 269.784884]
[ 269.784885]
[ 269.784885] the existing dependency chain (in reverse order) is:
[ 269.784887]
[ 269.784887] -> #1 (console_lock){+.+.+.}:
[ 269.784890] [<ffffffff810890e4>] lock_acquire+0x95/0x105
[ 269.784893] [<ffffffff810405a1>] console_lock+0x59/0x5b
[ 269.784897] [<ffffffff812ba125>] register_con_driver+0x36/0x128
[ 269.784899] [<ffffffff812bb27e>] take_over_console+0x1e/0x45
[ 269.784903] [<ffffffff81257a04>] fbcon_takeover+0x56/0x98
[ 269.784906] [<ffffffff8125b857>] fbcon_event_notify+0x2c1/0x5ea
[ 269.784909] [<ffffffff8149a211>] notifier_call_chain+0x67/0x92
[ 269.784911] [<ffffffff81062a33>] __blocking_notifier_call_chain+0x5f/0x80
[ 269.784912] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
[ 269.784915] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
[ 269.784917] [<ffffffff812505d7>] register_framebuffer+0x20a/0x26e
[ 269.784920] [<ffffffff812d3ca0>]
drm_fb_helper_single_fb_probe+0x1ce/0x297
[ 269.784922] [<ffffffff812d3f40>] drm_fb_helper_initial_config+0x1d7/0x1ef
[ 269.784924] [<ffffffff8132cee2>] intel_fbdev_init+0x6f/0x82
[ 269.784927] [<ffffffff812f22f6>] i915_driver_load+0xa9e/0xc78
[ 269.784929] [<ffffffff812e020c>] drm_get_pci_dev+0x165/0x26d
[ 269.784931] [<ffffffff812ee8da>] i915_pci_probe+0x60/0x69
[ 269.784933] [<ffffffff8123fe8e>] local_pci_probe+0x39/0x61
[ 269.784935] [<ffffffff812400f5>] pci_device_probe+0xba/0xe0
[ 269.784938] [<ffffffff8133d3b6>] driver_probe_device+0x99/0x1c4
[ 269.784940] [<ffffffff8133d52f>] __driver_attach+0x4e/0x6f
[ 269.784942] [<ffffffff8133bae1>] bus_for_each_dev+0x52/0x84
[ 269.784944] [<ffffffff8133cec6>] driver_attach+0x19/0x1b
[ 269.784946] [<ffffffff8133cb65>] bus_add_driver+0xdf/0x203
[ 269.784948] [<ffffffff8133dad3>] driver_register+0x8e/0x114
[ 269.784952] [<ffffffff8123f581>] __pci_register_driver+0x5d/0x62
[ 269.784953] [<ffffffff812e0395>] drm_pci_init+0x81/0xe6
[ 269.784957] [<ffffffff81af7612>] i915_init+0x66/0x68
[ 269.784959] [<ffffffff810020b4>] do_one_initcall+0x7a/0x136
[ 269.784962] [<ffffffff8147ceaa>] kernel_init+0x141/0x296
[ 269.784964] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
[ 269.784966]
[ 269.784966] -> #0 ((fb_notifier_list).rwsem){.+.+.+}:
[ 269.784967] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
[ 269.784969] [<ffffffff810890e4>] lock_acquire+0x95/0x105
[ 269.784971] [<ffffffff81495092>] down_read+0x34/0x43
[ 269.784973] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
[ 269.784975] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
[ 269.784977] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
[ 269.784979] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
[ 269.784981] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
[ 269.784983] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
[ 269.784985] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
[ 269.784987] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
[ 269.784990] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
[ 269.784993] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
[ 269.784995] [<ffffffff8134311a>] async_suspend+0x1a/0x58
[ 269.784997] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
[ 269.785000] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
[ 269.785002] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
[ 269.785004] [<ffffffff8105d416>] kthread+0xac/0xb4
[ 269.785006] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
[ 269.785006]
[ 269.785006] other info that might help us debug this:
[ 269.785006]
[ 269.785007] Possible unsafe locking scenario:
[ 269.785007]
[ 269.785008] CPU0 CPU1
[ 269.785008] ---- ----
[ 269.785009] lock(console_lock);
[ 269.785010] lock((fb_notifier_list).rwsem);
[ 269.785012] lock(console_lock);
[ 269.785013] lock((fb_notifier_list).rwsem);
[ 269.785013]
[ 269.785013] *** DEADLOCK ***
[ 269.785013]
[ 269.785014] 4 locks held by kworker/u:3/56:
[ 269.785018] #0: (events_unbound){.+.+.+}, at: [<ffffffff81058d77>]
process_one_work+0x154/0x38e
[ 269.785021] #1: ((&entry->work)){+.+.+.}, at: [<ffffffff81058d77>]
process_one_work+0x154/0x38e
[ 269.785024] #2: (&__lockdep_no_validate__){......}, at: [<ffffffff81342d85>]
device_lock+0xf/0x11
[ 269.785027] #3: (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
i915_drm_freeze+0x9e/0xbb
[ 269.785028]
[ 269.785028] stack backtrace:
[ 269.785029] Pid: 56, comm: kworker/u:3 Not tainted 3.8.0-rc1 #1
[ 269.785030] Call Trace:
[ 269.785035] [<ffffffff8148fcb5>] print_circular_bug+0x1f8/0x209
[ 269.785036] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
[ 269.785038] [<ffffffff810890e4>] lock_acquire+0x95/0x105
[ 269.785040] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
[ 269.785042] [<ffffffff81495092>] down_read+0x34/0x43
[ 269.785044] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
[ 269.785046] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
[ 269.785047] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
[ 269.785050] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
[ 269.785052] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
[ 269.785054] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
[ 269.785055] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
[ 269.785057] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
[ 269.785060] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
[ 269.785062] [<ffffffff8123f6f4>] ? pci_pm_poweroff+0x9c/0x9c
[ 269.785064] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
[ 269.785066] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
[ 269.785068] [<ffffffff81089563>] ? trace_hardirqs_on_caller+0x117/0x173
[ 269.785070] [<ffffffff8134311a>] async_suspend+0x1a/0x58
[ 269.785072] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
[ 269.785074] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
[ 269.785076] [<ffffffff81058d77>] ? process_one_work+0x154/0x38e
[ 269.785078] [<ffffffff810639c7>] ? async_schedule+0x12/0x12
[ 269.785080] [<ffffffff8105679f>] ? spin_lock_irq+0x9/0xb
[ 269.785082] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
[ 269.785084] [<ffffffff81059162>] ? rescuer_thread+0x187/0x187
[ 269.785085] [<ffffffff8105d416>] kthread+0xac/0xb4
[ 269.785088] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
[ 269.785090] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
[ 269.785091] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
Config:
http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/config-3.8.0-rc1
dmesg:
http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/dmesg-3.8.0-rc1.txt
Found similar report:
http://marc.info/?l=linux-kernel&m=135546308908700&w=2
Regards
--
Maciej Rutecki
http://www.mrutecki.pl
^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ]
2012-12-22 15:28 [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ] Maciej Rutecki
@ 2012-12-23 21:34 ` Christian Kujau
2012-12-26 2:34 ` Shawn Guo
1 sibling, 0 replies; 16+ messages in thread
From: Christian Kujau @ 2012-12-23 21:34 UTC (permalink / raw)
To: Maciej Rutecki; +Cc: LKML, Cong Wang, linuxppc-dev, zhong
On Sat, 22 Dec 2012 at 16:28, Maciej Rutecki wrote:
> Got during suspend to disk:
I got a similar message on a powerpc G4 system, right after bootup (no
suspend involved):
http://nerdbynature.de/bits/3.8.0-rc1/
[ 97.803049] ======================================================
[ 97.803051] [ INFO: possible circular locking dependency detected ]
[ 97.803059] 3.8.0-rc1-dirty #2 Not tainted
[ 97.803060] -------------------------------------------------------
[ 97.803066] kworker/0:1/235 is trying to acquire lock:
[ 97.803097] ((fb_notifier_list).rwsem){.+.+.+}, at: [<c00606a0>] __blocking_notifier_call_chain+0x44/0x88
[ 97.803099]
[ 97.803099] but task is already holding lock:
[ 97.803110] (console_lock){+.+.+.}, at: [<c03b9fd0>] console_callback+0x20/0x194
[ 97.803112]
[ 97.803112] which lock already depends on the new lock.
...and on it goes. Please see the URL above for the whole dmesg and
.config.
@Li Zhong: I have applied your fix for the "MAX_STACK_TRACE_ENTRIES too
low" warning[0] to 3.8-rc1 (hence the -dirty flag), but in the
backtrace "ret_from_kernel_thread" shows up again. FWIW, your
patch helped to make the "MAX_STACK_TRACE_ENTRIES too low"
warning go away in 3.7.0-rc7 and it did not re-appear ever
since.
Thanks,
Christian.
[0] http://lkml.indiana.edu/hypermail/linux/kernel/1211.3/01917.html
> [ 269.784867] [ INFO: possible circular locking dependency detected ]
> [ 269.784869] 3.8.0-rc1 #1 Not tainted
> [ 269.784870] -------------------------------------------------------
> [ 269.784871] kworker/u:3/56 is trying to acquire lock:
> [ 269.784878] ((fb_notifier_list).rwsem){.+.+.+}, at: [<ffffffff81062a1d>]
> __blocking_notifier_call_chain+0x49/0x80
> [ 269.784879]
> [ 269.784879] but task is already holding lock:
> [ 269.784884] (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> i915_drm_freeze+0x9e/0xbb
> [ 269.784884]
> [ 269.784884] which lock already depends on the new lock.
> [ 269.784884]
> [ 269.784885]
> [ 269.784885] the existing dependency chain (in reverse order) is:
> [ 269.784887]
> [ 269.784887] -> #1 (console_lock){+.+.+.}:
> [ 269.784890] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> [ 269.784893] [<ffffffff810405a1>] console_lock+0x59/0x5b
> [ 269.784897] [<ffffffff812ba125>] register_con_driver+0x36/0x128
> [ 269.784899] [<ffffffff812bb27e>] take_over_console+0x1e/0x45
> [ 269.784903] [<ffffffff81257a04>] fbcon_takeover+0x56/0x98
> [ 269.784906] [<ffffffff8125b857>] fbcon_event_notify+0x2c1/0x5ea
> [ 269.784909] [<ffffffff8149a211>] notifier_call_chain+0x67/0x92
> [ 269.784911] [<ffffffff81062a33>] __blocking_notifier_call_chain+0x5f/0x80
> [ 269.784912] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> [ 269.784915] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> [ 269.784917] [<ffffffff812505d7>] register_framebuffer+0x20a/0x26e
> [ 269.784920] [<ffffffff812d3ca0>]
> drm_fb_helper_single_fb_probe+0x1ce/0x297
> [ 269.784922] [<ffffffff812d3f40>] drm_fb_helper_initial_config+0x1d7/0x1ef
> [ 269.784924] [<ffffffff8132cee2>] intel_fbdev_init+0x6f/0x82
> [ 269.784927] [<ffffffff812f22f6>] i915_driver_load+0xa9e/0xc78
> [ 269.784929] [<ffffffff812e020c>] drm_get_pci_dev+0x165/0x26d
> [ 269.784931] [<ffffffff812ee8da>] i915_pci_probe+0x60/0x69
> [ 269.784933] [<ffffffff8123fe8e>] local_pci_probe+0x39/0x61
> [ 269.784935] [<ffffffff812400f5>] pci_device_probe+0xba/0xe0
> [ 269.784938] [<ffffffff8133d3b6>] driver_probe_device+0x99/0x1c4
> [ 269.784940] [<ffffffff8133d52f>] __driver_attach+0x4e/0x6f
> [ 269.784942] [<ffffffff8133bae1>] bus_for_each_dev+0x52/0x84
> [ 269.784944] [<ffffffff8133cec6>] driver_attach+0x19/0x1b
> [ 269.784946] [<ffffffff8133cb65>] bus_add_driver+0xdf/0x203
> [ 269.784948] [<ffffffff8133dad3>] driver_register+0x8e/0x114
> [ 269.784952] [<ffffffff8123f581>] __pci_register_driver+0x5d/0x62
> [ 269.784953] [<ffffffff812e0395>] drm_pci_init+0x81/0xe6
> [ 269.784957] [<ffffffff81af7612>] i915_init+0x66/0x68
> [ 269.784959] [<ffffffff810020b4>] do_one_initcall+0x7a/0x136
> [ 269.784962] [<ffffffff8147ceaa>] kernel_init+0x141/0x296
> [ 269.784964] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> [ 269.784966]
> [ 269.784966] -> #0 ((fb_notifier_list).rwsem){.+.+.+}:
> [ 269.784967] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> [ 269.784969] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> [ 269.784971] [<ffffffff81495092>] down_read+0x34/0x43
> [ 269.784973] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> [ 269.784975] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> [ 269.784977] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> [ 269.784979] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> [ 269.784981] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> [ 269.784983] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> [ 269.784985] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> [ 269.784987] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> [ 269.784990] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> [ 269.784993] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> [ 269.784995] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> [ 269.784997] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> [ 269.785000] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> [ 269.785002] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> [ 269.785004] [<ffffffff8105d416>] kthread+0xac/0xb4
> [ 269.785006] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> [ 269.785006]
> [ 269.785006] other info that might help us debug this:
> [ 269.785006]
> [ 269.785007] Possible unsafe locking scenario:
> [ 269.785007]
> [ 269.785008] CPU0 CPU1
> [ 269.785008] ---- ----
> [ 269.785009] lock(console_lock);
> [ 269.785010] lock((fb_notifier_list).rwsem);
> [ 269.785012] lock(console_lock);
> [ 269.785013] lock((fb_notifier_list).rwsem);
> [ 269.785013]
> [ 269.785013] *** DEADLOCK ***
> [ 269.785013]
> [ 269.785014] 4 locks held by kworker/u:3/56:
> [ 269.785018] #0: (events_unbound){.+.+.+}, at: [<ffffffff81058d77>]
> process_one_work+0x154/0x38e
> [ 269.785021] #1: ((&entry->work)){+.+.+.}, at: [<ffffffff81058d77>]
> process_one_work+0x154/0x38e
> [ 269.785024] #2: (&__lockdep_no_validate__){......}, at: [<ffffffff81342d85>]
> device_lock+0xf/0x11
> [ 269.785027] #3: (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> i915_drm_freeze+0x9e/0xbb
> [ 269.785028]
> [ 269.785028] stack backtrace:
> [ 269.785029] Pid: 56, comm: kworker/u:3 Not tainted 3.8.0-rc1 #1
> [ 269.785030] Call Trace:
> [ 269.785035] [<ffffffff8148fcb5>] print_circular_bug+0x1f8/0x209
> [ 269.785036] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> [ 269.785038] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> [ 269.785040] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> [ 269.785042] [<ffffffff81495092>] down_read+0x34/0x43
> [ 269.785044] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> [ 269.785046] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> [ 269.785047] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> [ 269.785050] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> [ 269.785052] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> [ 269.785054] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> [ 269.785055] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> [ 269.785057] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> [ 269.785060] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> [ 269.785062] [<ffffffff8123f6f4>] ? pci_pm_poweroff+0x9c/0x9c
> [ 269.785064] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> [ 269.785066] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> [ 269.785068] [<ffffffff81089563>] ? trace_hardirqs_on_caller+0x117/0x173
> [ 269.785070] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> [ 269.785072] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> [ 269.785074] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> [ 269.785076] [<ffffffff81058d77>] ? process_one_work+0x154/0x38e
> [ 269.785078] [<ffffffff810639c7>] ? async_schedule+0x12/0x12
> [ 269.785080] [<ffffffff8105679f>] ? spin_lock_irq+0x9/0xb
> [ 269.785082] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> [ 269.785084] [<ffffffff81059162>] ? rescuer_thread+0x187/0x187
> [ 269.785085] [<ffffffff8105d416>] kthread+0xac/0xb4
> [ 269.785088] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> [ 269.785090] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> [ 269.785091] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
>
>
> Config:
> http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/config-3.8.0-rc1
>
> dmesg:
> http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/dmesg-3.8.0-rc1.txt
>
>
> Found similar report:
> http://marc.info/?l=linux-kernel&m=135546308908700&w=2
>
> Regards
>
> --
> Maciej Rutecki
> http://www.mrutecki.pl
> --
> To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
> the body of a message to majordomo@vger.kernel.org
> More majordomo info at http://vger.kernel.org/majordomo-info.html
> Please read the FAQ at http://www.tux.org/lkml/
>
--
BOFH excuse #435:
Internet shut down due to maintenance
^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ]
@ 2012-12-23 21:34 ` Christian Kujau
0 siblings, 0 replies; 16+ messages in thread
From: Christian Kujau @ 2012-12-23 21:34 UTC (permalink / raw)
To: Maciej Rutecki; +Cc: Cong Wang, linuxppc-dev, LKML, zhong
On Sat, 22 Dec 2012 at 16:28, Maciej Rutecki wrote:
> Got during suspend to disk:
I got a similar message on a powerpc G4 system, right after bootup (no
suspend involved):
http://nerdbynature.de/bits/3.8.0-rc1/
[ 97.803049] ======================================================
[ 97.803051] [ INFO: possible circular locking dependency detected ]
[ 97.803059] 3.8.0-rc1-dirty #2 Not tainted
[ 97.803060] -------------------------------------------------------
[ 97.803066] kworker/0:1/235 is trying to acquire lock:
[ 97.803097] ((fb_notifier_list).rwsem){.+.+.+}, at: [<c00606a0>] __blocking_notifier_call_chain+0x44/0x88
[ 97.803099]
[ 97.803099] but task is already holding lock:
[ 97.803110] (console_lock){+.+.+.}, at: [<c03b9fd0>] console_callback+0x20/0x194
[ 97.803112]
[ 97.803112] which lock already depends on the new lock.
...and on it goes. Please see the URL above for the whole dmesg and
.config.
@Li Zhong: I have applied your fix for the "MAX_STACK_TRACE_ENTRIES too
low" warning[0] to 3.8-rc1 (hence the -dirty flag), but in the
backtrace "ret_from_kernel_thread" shows up again. FWIW, your
patch helped to make the "MAX_STACK_TRACE_ENTRIES too low"
warning go away in 3.7.0-rc7 and it did not re-appear ever
since.
Thanks,
Christian.
[0] http://lkml.indiana.edu/hypermail/linux/kernel/1211.3/01917.html
> [ 269.784867] [ INFO: possible circular locking dependency detected ]
> [ 269.784869] 3.8.0-rc1 #1 Not tainted
> [ 269.784870] -------------------------------------------------------
> [ 269.784871] kworker/u:3/56 is trying to acquire lock:
> [ 269.784878] ((fb_notifier_list).rwsem){.+.+.+}, at: [<ffffffff81062a1d>]
> __blocking_notifier_call_chain+0x49/0x80
> [ 269.784879]
> [ 269.784879] but task is already holding lock:
> [ 269.784884] (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> i915_drm_freeze+0x9e/0xbb
> [ 269.784884]
> [ 269.784884] which lock already depends on the new lock.
> [ 269.784884]
> [ 269.784885]
> [ 269.784885] the existing dependency chain (in reverse order) is:
> [ 269.784887]
> [ 269.784887] -> #1 (console_lock){+.+.+.}:
> [ 269.784890] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> [ 269.784893] [<ffffffff810405a1>] console_lock+0x59/0x5b
> [ 269.784897] [<ffffffff812ba125>] register_con_driver+0x36/0x128
> [ 269.784899] [<ffffffff812bb27e>] take_over_console+0x1e/0x45
> [ 269.784903] [<ffffffff81257a04>] fbcon_takeover+0x56/0x98
> [ 269.784906] [<ffffffff8125b857>] fbcon_event_notify+0x2c1/0x5ea
> [ 269.784909] [<ffffffff8149a211>] notifier_call_chain+0x67/0x92
> [ 269.784911] [<ffffffff81062a33>] __blocking_notifier_call_chain+0x5f/0x80
> [ 269.784912] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> [ 269.784915] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> [ 269.784917] [<ffffffff812505d7>] register_framebuffer+0x20a/0x26e
> [ 269.784920] [<ffffffff812d3ca0>]
> drm_fb_helper_single_fb_probe+0x1ce/0x297
> [ 269.784922] [<ffffffff812d3f40>] drm_fb_helper_initial_config+0x1d7/0x1ef
> [ 269.784924] [<ffffffff8132cee2>] intel_fbdev_init+0x6f/0x82
> [ 269.784927] [<ffffffff812f22f6>] i915_driver_load+0xa9e/0xc78
> [ 269.784929] [<ffffffff812e020c>] drm_get_pci_dev+0x165/0x26d
> [ 269.784931] [<ffffffff812ee8da>] i915_pci_probe+0x60/0x69
> [ 269.784933] [<ffffffff8123fe8e>] local_pci_probe+0x39/0x61
> [ 269.784935] [<ffffffff812400f5>] pci_device_probe+0xba/0xe0
> [ 269.784938] [<ffffffff8133d3b6>] driver_probe_device+0x99/0x1c4
> [ 269.784940] [<ffffffff8133d52f>] __driver_attach+0x4e/0x6f
> [ 269.784942] [<ffffffff8133bae1>] bus_for_each_dev+0x52/0x84
> [ 269.784944] [<ffffffff8133cec6>] driver_attach+0x19/0x1b
> [ 269.784946] [<ffffffff8133cb65>] bus_add_driver+0xdf/0x203
> [ 269.784948] [<ffffffff8133dad3>] driver_register+0x8e/0x114
> [ 269.784952] [<ffffffff8123f581>] __pci_register_driver+0x5d/0x62
> [ 269.784953] [<ffffffff812e0395>] drm_pci_init+0x81/0xe6
> [ 269.784957] [<ffffffff81af7612>] i915_init+0x66/0x68
> [ 269.784959] [<ffffffff810020b4>] do_one_initcall+0x7a/0x136
> [ 269.784962] [<ffffffff8147ceaa>] kernel_init+0x141/0x296
> [ 269.784964] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> [ 269.784966]
> [ 269.784966] -> #0 ((fb_notifier_list).rwsem){.+.+.+}:
> [ 269.784967] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> [ 269.784969] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> [ 269.784971] [<ffffffff81495092>] down_read+0x34/0x43
> [ 269.784973] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> [ 269.784975] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> [ 269.784977] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> [ 269.784979] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> [ 269.784981] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> [ 269.784983] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> [ 269.784985] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> [ 269.784987] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> [ 269.784990] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> [ 269.784993] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> [ 269.784995] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> [ 269.784997] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> [ 269.785000] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> [ 269.785002] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> [ 269.785004] [<ffffffff8105d416>] kthread+0xac/0xb4
> [ 269.785006] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> [ 269.785006]
> [ 269.785006] other info that might help us debug this:
> [ 269.785006]
> [ 269.785007] Possible unsafe locking scenario:
> [ 269.785007]
> [ 269.785008] CPU0 CPU1
> [ 269.785008] ---- ----
> [ 269.785009] lock(console_lock);
> [ 269.785010] lock((fb_notifier_list).rwsem);
> [ 269.785012] lock(console_lock);
> [ 269.785013] lock((fb_notifier_list).rwsem);
> [ 269.785013]
> [ 269.785013] *** DEADLOCK ***
> [ 269.785013]
> [ 269.785014] 4 locks held by kworker/u:3/56:
> [ 269.785018] #0: (events_unbound){.+.+.+}, at: [<ffffffff81058d77>]
> process_one_work+0x154/0x38e
> [ 269.785021] #1: ((&entry->work)){+.+.+.}, at: [<ffffffff81058d77>]
> process_one_work+0x154/0x38e
> [ 269.785024] #2: (&__lockdep_no_validate__){......}, at: [<ffffffff81342d85>]
> device_lock+0xf/0x11
> [ 269.785027] #3: (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> i915_drm_freeze+0x9e/0xbb
> [ 269.785028]
> [ 269.785028] stack backtrace:
> [ 269.785029] Pid: 56, comm: kworker/u:3 Not tainted 3.8.0-rc1 #1
> [ 269.785030] Call Trace:
> [ 269.785035] [<ffffffff8148fcb5>] print_circular_bug+0x1f8/0x209
> [ 269.785036] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> [ 269.785038] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> [ 269.785040] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> [ 269.785042] [<ffffffff81495092>] down_read+0x34/0x43
> [ 269.785044] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> [ 269.785046] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> [ 269.785047] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> [ 269.785050] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> [ 269.785052] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> [ 269.785054] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> [ 269.785055] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> [ 269.785057] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> [ 269.785060] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> [ 269.785062] [<ffffffff8123f6f4>] ? pci_pm_poweroff+0x9c/0x9c
> [ 269.785064] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> [ 269.785066] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> [ 269.785068] [<ffffffff81089563>] ? trace_hardirqs_on_caller+0x117/0x173
> [ 269.785070] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> [ 269.785072] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> [ 269.785074] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> [ 269.785076] [<ffffffff81058d77>] ? process_one_work+0x154/0x38e
> [ 269.785078] [<ffffffff810639c7>] ? async_schedule+0x12/0x12
> [ 269.785080] [<ffffffff8105679f>] ? spin_lock_irq+0x9/0xb
> [ 269.785082] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> [ 269.785084] [<ffffffff81059162>] ? rescuer_thread+0x187/0x187
> [ 269.785085] [<ffffffff8105d416>] kthread+0xac/0xb4
> [ 269.785088] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> [ 269.785090] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> [ 269.785091] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
>
>
> Config:
> http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/config-3.8.0-rc1
>
> dmesg:
> http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/dmesg-3.8.0-rc1.txt
>
>
> Found similar report:
> http://marc.info/?l=linux-kernel&m=135546308908700&w=2
>
> Regards
>
> --
> Maciej Rutecki
> http://www.mrutecki.pl
> --
> To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
> the body of a message to majordomo@vger.kernel.org
> More majordomo info at http://vger.kernel.org/majordomo-info.html
> Please read the FAQ at http://www.tux.org/lkml/
>
--
BOFH excuse #435:
Internet shut down due to maintenance
^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ]
2012-12-22 15:28 [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ] Maciej Rutecki
@ 2012-12-26 2:34 ` Shawn Guo
2012-12-26 2:34 ` Shawn Guo
1 sibling, 0 replies; 16+ messages in thread
From: Shawn Guo @ 2012-12-26 2:34 UTC (permalink / raw)
To: Maciej Rutecki; +Cc: LKML, Cong Wang, linux-arm-kernel
It seems that I'm running into the same locking issue. My setup is:
- i.MX28 (ARM)
- v3.8-rc1
- mxs_defconfig
Shawn
[ 602.229899] ======================================================
[ 602.229905] [ INFO: possible circular locking dependency detected ]
[ 602.229926] 3.8.0-rc1-00003-gde4ae7f #767 Not tainted
[ 602.229933] -------------------------------------------------------
[ 602.229951] kworker/0:1/21 is trying to acquire lock:
[ 602.230037] ((fb_notifier_list).rwsem){.+.+.+}, at: [<c0041f34>] __blocking_notifier_call_chain+0x2c/0x60
[ 602.230047]
[ 602.230047] but task is already holding lock:
[ 602.230090] (console_lock){+.+.+.}, at: [<c02a1d60>] console_callback+0xc/0x12c
[ 602.230098]
[ 602.230098] which lock already depends on the new lock.
[ 602.230098]
[ 602.230104]
[ 602.230104] the existing dependency chain (in reverse order) is:
[ 602.230126]
[ 602.230126] -> #1 (console_lock){+.+.+.}:
[ 602.230174] [<c005cb20>] lock_acquire+0x9c/0x124
[ 602.230205] [<c001dc78>] console_lock+0x58/0x6c
[ 602.230250] [<c029ea60>] register_con_driver+0x38/0x138
[ 602.230284] [<c02a0018>] take_over_console+0x18/0x44
[ 602.230314] [<c027bc80>] fbcon_takeover+0x64/0xc8
[ 602.230352] [<c0041c94>] notifier_call_chain+0x44/0x80
[ 602.230386] [<c0041f50>] __blocking_notifier_call_chain+0x48/0x60
[ 602.230416] [<c0041f80>] blocking_notifier_call_chain+0x18/0x20
[ 602.230459] [<c0275efc>] register_framebuffer+0x170/0x250
[ 602.230492] [<c02837f4>] mxsfb_probe+0x574/0x738
[ 602.230528] [<c02b276c>] platform_drv_probe+0x14/0x18
[ 602.230556] [<c02b14cc>] driver_probe_device+0x78/0x20c
[ 602.230583] [<c02b16f4>] __driver_attach+0x94/0x98
[ 602.230610] [<c02afdb4>] bus_for_each_dev+0x54/0x7c
[ 602.230636] [<c02b0d14>] bus_add_driver+0x180/0x250
[ 602.230662] [<c02b1bb8>] driver_register+0x78/0x144
[ 602.230690] [<c00087c8>] do_one_initcall+0x30/0x16c
[ 602.230721] [<c0428fcc>] kernel_init+0xf4/0x290
[ 602.230756] [<c000e9c8>] ret_from_fork+0x14/0x2c
[ 602.230781]
[ 602.230781] -> #0 ((fb_notifier_list).rwsem){.+.+.+}:
[ 602.230825] [<c005bfa0>] __lock_acquire+0x1354/0x19b0
[ 602.230854] [<c005cb20>] lock_acquire+0x9c/0x124
[ 602.230895] [<c0430148>] down_read+0x3c/0x4c
[ 602.230933] [<c0041f34>] __blocking_notifier_call_chain+0x2c/0x60
[ 602.230962] [<c0041f80>] blocking_notifier_call_chain+0x18/0x20
[ 602.230997] [<c0274a78>] fb_blank+0x34/0x98
[ 602.231024] [<c027c7b8>] fbcon_blank+0x1dc/0x27c
[ 602.231065] [<c029f194>] do_blank_screen+0x1b0/0x268
[ 602.231093] [<c02a1dbc>] console_callback+0x68/0x12c
[ 602.231121] [<c00368c0>] process_one_work+0x1a8/0x560
[ 602.231145] [<c0036fd8>] worker_thread+0x160/0x480
[ 602.231180] [<c003c040>] kthread+0xa4/0xb0
[ 602.231210] [<c000e9c8>] ret_from_fork+0x14/0x2c
[ 602.231218]
[ 602.231218] other info that might help us debug this:
[ 602.231218]
[ 602.231225] Possible unsafe locking scenario:
[ 602.231225]
[ 602.231230] CPU0 CPU1
[ 602.231235] ---- ----
[ 602.231249] lock(console_lock);
[ 602.231263] lock((fb_notifier_list).rwsem);
[ 602.231275] lock(console_lock);
[ 602.231287] lock((fb_notifier_list).rwsem);
[ 602.231292]
[ 602.231292] *** DEADLOCK ***
[ 602.231292]
[ 602.231305] 3 locks held by kworker/0:1/21:
[ 602.231345] #0: (events){.+.+.+}, at: [<c0036840>] process_one_work+0x128/0x560
[ 602.231388] #1: (console_work){+.+...}, at: [<c0036840>] process_one_work+0x128/0x560
[ 602.231430] #2: (console_lock){+.+.+.}, at: [<c02a1d60>] console_callback+0xc/0x12c
[ 602.231437]
[ 602.231437] stack backtrace:
[ 602.231491] [<c0013e58>] (unwind_backtrace+0x0/0xf0) from [<c042b0e4>] (print_circular_bug+0x254/0x2a0)
[ 602.231547] [<c042b0e4>] (print_circular_bug+0x254/0x2a0) from [<c005bfa0>] (__lock_acquire+0x1354/0x19b0)
[ 602.231596] [<c005bfa0>] (__lock_acquire+0x1354/0x19b0) from [<c005cb20>] (lock_acquire+0x9c/0x124)
[ 602.231640] [<c005cb20>] (lock_acquire+0x9c/0x124) from [<c0430148>] (down_read+0x3c/0x4c)
[ 602.231694] [<c0430148>] (down_read+0x3c/0x4c) from [<c0041f34>] (__blocking_notifier_call_chain+0x2c/0x60)
[ 602.231741] [<c0041f34>] (__blocking_notifier_call_chain+0x2c/0x60) from [<c0041f80>] (blocking_notifier_call_chain+0x18/0x20)
[ 602.231791] [<c0041f80>] (blocking_notifier_call_chain+0x18/0x20) from [<c0274a78>] (fb_blank+0x34/0x98)
[ 602.231836] [<c0274a78>] (fb_blank+0x34/0x98) from [<c027c7b8>] (fbcon_blank+0x1dc/0x27c)
[ 602.231886] [<c027c7b8>] (fbcon_blank+0x1dc/0x27c) from [<c029f194>] (do_blank_screen+0x1b0/0x268)
[ 602.231931] [<c029f194>] (do_blank_screen+0x1b0/0x268) from [<c02a1dbc>] (console_callback+0x68/0x12c)
[ 602.231970] [<c02a1dbc>] (console_callback+0x68/0x12c) from [<c00368c0>] (process_one_work+0x1a8/0x560)
[ 602.232010] [<c00368c0>] (process_one_work+0x1a8/0x560) from [<c0036fd8>] (worker_thread+0x160/0x480)
[ 602.232054] [<c0036fd8>] (worker_thread+0x160/0x480) from [<c003c040>] (kthread+0xa4/0xb0)
[ 602.232100] [<c003c040>] (kthread+0xa4/0xb0) from [<c000e9c8>] (ret_from_fork+0x14/0x2c)
On Sat, Dec 22, 2012 at 04:28:26PM +0100, Maciej Rutecki wrote:
> Got during suspend to disk:
>
> [ 269.784867] [ INFO: possible circular locking dependency detected ]
> [ 269.784869] 3.8.0-rc1 #1 Not tainted
> [ 269.784870] -------------------------------------------------------
> [ 269.784871] kworker/u:3/56 is trying to acquire lock:
> [ 269.784878] ((fb_notifier_list).rwsem){.+.+.+}, at: [<ffffffff81062a1d>]
> __blocking_notifier_call_chain+0x49/0x80
> [ 269.784879]
> [ 269.784879] but task is already holding lock:
> [ 269.784884] (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> i915_drm_freeze+0x9e/0xbb
> [ 269.784884]
> [ 269.784884] which lock already depends on the new lock.
> [ 269.784884]
> [ 269.784885]
> [ 269.784885] the existing dependency chain (in reverse order) is:
> [ 269.784887]
> [ 269.784887] -> #1 (console_lock){+.+.+.}:
> [ 269.784890] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> [ 269.784893] [<ffffffff810405a1>] console_lock+0x59/0x5b
> [ 269.784897] [<ffffffff812ba125>] register_con_driver+0x36/0x128
> [ 269.784899] [<ffffffff812bb27e>] take_over_console+0x1e/0x45
> [ 269.784903] [<ffffffff81257a04>] fbcon_takeover+0x56/0x98
> [ 269.784906] [<ffffffff8125b857>] fbcon_event_notify+0x2c1/0x5ea
> [ 269.784909] [<ffffffff8149a211>] notifier_call_chain+0x67/0x92
> [ 269.784911] [<ffffffff81062a33>] __blocking_notifier_call_chain+0x5f/0x80
> [ 269.784912] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> [ 269.784915] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> [ 269.784917] [<ffffffff812505d7>] register_framebuffer+0x20a/0x26e
> [ 269.784920] [<ffffffff812d3ca0>]
> drm_fb_helper_single_fb_probe+0x1ce/0x297
> [ 269.784922] [<ffffffff812d3f40>] drm_fb_helper_initial_config+0x1d7/0x1ef
> [ 269.784924] [<ffffffff8132cee2>] intel_fbdev_init+0x6f/0x82
> [ 269.784927] [<ffffffff812f22f6>] i915_driver_load+0xa9e/0xc78
> [ 269.784929] [<ffffffff812e020c>] drm_get_pci_dev+0x165/0x26d
> [ 269.784931] [<ffffffff812ee8da>] i915_pci_probe+0x60/0x69
> [ 269.784933] [<ffffffff8123fe8e>] local_pci_probe+0x39/0x61
> [ 269.784935] [<ffffffff812400f5>] pci_device_probe+0xba/0xe0
> [ 269.784938] [<ffffffff8133d3b6>] driver_probe_device+0x99/0x1c4
> [ 269.784940] [<ffffffff8133d52f>] __driver_attach+0x4e/0x6f
> [ 269.784942] [<ffffffff8133bae1>] bus_for_each_dev+0x52/0x84
> [ 269.784944] [<ffffffff8133cec6>] driver_attach+0x19/0x1b
> [ 269.784946] [<ffffffff8133cb65>] bus_add_driver+0xdf/0x203
> [ 269.784948] [<ffffffff8133dad3>] driver_register+0x8e/0x114
> [ 269.784952] [<ffffffff8123f581>] __pci_register_driver+0x5d/0x62
> [ 269.784953] [<ffffffff812e0395>] drm_pci_init+0x81/0xe6
> [ 269.784957] [<ffffffff81af7612>] i915_init+0x66/0x68
> [ 269.784959] [<ffffffff810020b4>] do_one_initcall+0x7a/0x136
> [ 269.784962] [<ffffffff8147ceaa>] kernel_init+0x141/0x296
> [ 269.784964] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> [ 269.784966]
> [ 269.784966] -> #0 ((fb_notifier_list).rwsem){.+.+.+}:
> [ 269.784967] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> [ 269.784969] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> [ 269.784971] [<ffffffff81495092>] down_read+0x34/0x43
> [ 269.784973] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> [ 269.784975] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> [ 269.784977] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> [ 269.784979] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> [ 269.784981] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> [ 269.784983] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> [ 269.784985] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> [ 269.784987] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> [ 269.784990] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> [ 269.784993] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> [ 269.784995] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> [ 269.784997] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> [ 269.785000] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> [ 269.785002] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> [ 269.785004] [<ffffffff8105d416>] kthread+0xac/0xb4
> [ 269.785006] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> [ 269.785006]
> [ 269.785006] other info that might help us debug this:
> [ 269.785006]
> [ 269.785007] Possible unsafe locking scenario:
> [ 269.785007]
> [ 269.785008] CPU0 CPU1
> [ 269.785008] ---- ----
> [ 269.785009] lock(console_lock);
> [ 269.785010] lock((fb_notifier_list).rwsem);
> [ 269.785012] lock(console_lock);
> [ 269.785013] lock((fb_notifier_list).rwsem);
> [ 269.785013]
> [ 269.785013] *** DEADLOCK ***
> [ 269.785013]
> [ 269.785014] 4 locks held by kworker/u:3/56:
> [ 269.785018] #0: (events_unbound){.+.+.+}, at: [<ffffffff81058d77>]
> process_one_work+0x154/0x38e
> [ 269.785021] #1: ((&entry->work)){+.+.+.}, at: [<ffffffff81058d77>]
> process_one_work+0x154/0x38e
> [ 269.785024] #2: (&__lockdep_no_validate__){......}, at: [<ffffffff81342d85>]
> device_lock+0xf/0x11
> [ 269.785027] #3: (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> i915_drm_freeze+0x9e/0xbb
> [ 269.785028]
> [ 269.785028] stack backtrace:
> [ 269.785029] Pid: 56, comm: kworker/u:3 Not tainted 3.8.0-rc1 #1
> [ 269.785030] Call Trace:
> [ 269.785035] [<ffffffff8148fcb5>] print_circular_bug+0x1f8/0x209
> [ 269.785036] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> [ 269.785038] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> [ 269.785040] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> [ 269.785042] [<ffffffff81495092>] down_read+0x34/0x43
> [ 269.785044] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> [ 269.785046] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> [ 269.785047] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> [ 269.785050] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> [ 269.785052] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> [ 269.785054] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> [ 269.785055] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> [ 269.785057] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> [ 269.785060] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> [ 269.785062] [<ffffffff8123f6f4>] ? pci_pm_poweroff+0x9c/0x9c
> [ 269.785064] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> [ 269.785066] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> [ 269.785068] [<ffffffff81089563>] ? trace_hardirqs_on_caller+0x117/0x173
> [ 269.785070] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> [ 269.785072] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> [ 269.785074] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> [ 269.785076] [<ffffffff81058d77>] ? process_one_work+0x154/0x38e
> [ 269.785078] [<ffffffff810639c7>] ? async_schedule+0x12/0x12
> [ 269.785080] [<ffffffff8105679f>] ? spin_lock_irq+0x9/0xb
> [ 269.785082] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> [ 269.785084] [<ffffffff81059162>] ? rescuer_thread+0x187/0x187
> [ 269.785085] [<ffffffff8105d416>] kthread+0xac/0xb4
> [ 269.785088] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> [ 269.785090] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> [ 269.785091] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
>
>
> Config:
> http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/config-3.8.0-rc1
>
> dmesg:
> http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/dmesg-3.8.0-rc1.txt
>
>
> Found similar report:
> http://marc.info/?l=linux-kernel&m=135546308908700&w=2
>
> Regards
>
> --
> Maciej Rutecki
> http://www.mrutecki.pl
> --
> To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
> the body of a message to majordomo@vger.kernel.org
> More majordomo info at http://vger.kernel.org/majordomo-info.html
> Please read the FAQ at http://www.tux.org/lkml/
^ permalink raw reply [flat|nested] 16+ messages in thread
* [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ]
@ 2012-12-26 2:34 ` Shawn Guo
0 siblings, 0 replies; 16+ messages in thread
From: Shawn Guo @ 2012-12-26 2:34 UTC (permalink / raw)
To: linux-arm-kernel
It seems that I'm running into the same locking issue. My setup is:
- i.MX28 (ARM)
- v3.8-rc1
- mxs_defconfig
Shawn
[ 602.229899] ======================================================
[ 602.229905] [ INFO: possible circular locking dependency detected ]
[ 602.229926] 3.8.0-rc1-00003-gde4ae7f #767 Not tainted
[ 602.229933] -------------------------------------------------------
[ 602.229951] kworker/0:1/21 is trying to acquire lock:
[ 602.230037] ((fb_notifier_list).rwsem){.+.+.+}, at: [<c0041f34>] __blocking_notifier_call_chain+0x2c/0x60
[ 602.230047]
[ 602.230047] but task is already holding lock:
[ 602.230090] (console_lock){+.+.+.}, at: [<c02a1d60>] console_callback+0xc/0x12c
[ 602.230098]
[ 602.230098] which lock already depends on the new lock.
[ 602.230098]
[ 602.230104]
[ 602.230104] the existing dependency chain (in reverse order) is:
[ 602.230126]
[ 602.230126] -> #1 (console_lock){+.+.+.}:
[ 602.230174] [<c005cb20>] lock_acquire+0x9c/0x124
[ 602.230205] [<c001dc78>] console_lock+0x58/0x6c
[ 602.230250] [<c029ea60>] register_con_driver+0x38/0x138
[ 602.230284] [<c02a0018>] take_over_console+0x18/0x44
[ 602.230314] [<c027bc80>] fbcon_takeover+0x64/0xc8
[ 602.230352] [<c0041c94>] notifier_call_chain+0x44/0x80
[ 602.230386] [<c0041f50>] __blocking_notifier_call_chain+0x48/0x60
[ 602.230416] [<c0041f80>] blocking_notifier_call_chain+0x18/0x20
[ 602.230459] [<c0275efc>] register_framebuffer+0x170/0x250
[ 602.230492] [<c02837f4>] mxsfb_probe+0x574/0x738
[ 602.230528] [<c02b276c>] platform_drv_probe+0x14/0x18
[ 602.230556] [<c02b14cc>] driver_probe_device+0x78/0x20c
[ 602.230583] [<c02b16f4>] __driver_attach+0x94/0x98
[ 602.230610] [<c02afdb4>] bus_for_each_dev+0x54/0x7c
[ 602.230636] [<c02b0d14>] bus_add_driver+0x180/0x250
[ 602.230662] [<c02b1bb8>] driver_register+0x78/0x144
[ 602.230690] [<c00087c8>] do_one_initcall+0x30/0x16c
[ 602.230721] [<c0428fcc>] kernel_init+0xf4/0x290
[ 602.230756] [<c000e9c8>] ret_from_fork+0x14/0x2c
[ 602.230781]
[ 602.230781] -> #0 ((fb_notifier_list).rwsem){.+.+.+}:
[ 602.230825] [<c005bfa0>] __lock_acquire+0x1354/0x19b0
[ 602.230854] [<c005cb20>] lock_acquire+0x9c/0x124
[ 602.230895] [<c0430148>] down_read+0x3c/0x4c
[ 602.230933] [<c0041f34>] __blocking_notifier_call_chain+0x2c/0x60
[ 602.230962] [<c0041f80>] blocking_notifier_call_chain+0x18/0x20
[ 602.230997] [<c0274a78>] fb_blank+0x34/0x98
[ 602.231024] [<c027c7b8>] fbcon_blank+0x1dc/0x27c
[ 602.231065] [<c029f194>] do_blank_screen+0x1b0/0x268
[ 602.231093] [<c02a1dbc>] console_callback+0x68/0x12c
[ 602.231121] [<c00368c0>] process_one_work+0x1a8/0x560
[ 602.231145] [<c0036fd8>] worker_thread+0x160/0x480
[ 602.231180] [<c003c040>] kthread+0xa4/0xb0
[ 602.231210] [<c000e9c8>] ret_from_fork+0x14/0x2c
[ 602.231218]
[ 602.231218] other info that might help us debug this:
[ 602.231218]
[ 602.231225] Possible unsafe locking scenario:
[ 602.231225]
[ 602.231230] CPU0 CPU1
[ 602.231235] ---- ----
[ 602.231249] lock(console_lock);
[ 602.231263] lock((fb_notifier_list).rwsem);
[ 602.231275] lock(console_lock);
[ 602.231287] lock((fb_notifier_list).rwsem);
[ 602.231292]
[ 602.231292] *** DEADLOCK ***
[ 602.231292]
[ 602.231305] 3 locks held by kworker/0:1/21:
[ 602.231345] #0: (events){.+.+.+}, at: [<c0036840>] process_one_work+0x128/0x560
[ 602.231388] #1: (console_work){+.+...}, at: [<c0036840>] process_one_work+0x128/0x560
[ 602.231430] #2: (console_lock){+.+.+.}, at: [<c02a1d60>] console_callback+0xc/0x12c
[ 602.231437]
[ 602.231437] stack backtrace:
[ 602.231491] [<c0013e58>] (unwind_backtrace+0x0/0xf0) from [<c042b0e4>] (print_circular_bug+0x254/0x2a0)
[ 602.231547] [<c042b0e4>] (print_circular_bug+0x254/0x2a0) from [<c005bfa0>] (__lock_acquire+0x1354/0x19b0)
[ 602.231596] [<c005bfa0>] (__lock_acquire+0x1354/0x19b0) from [<c005cb20>] (lock_acquire+0x9c/0x124)
[ 602.231640] [<c005cb20>] (lock_acquire+0x9c/0x124) from [<c0430148>] (down_read+0x3c/0x4c)
[ 602.231694] [<c0430148>] (down_read+0x3c/0x4c) from [<c0041f34>] (__blocking_notifier_call_chain+0x2c/0x60)
[ 602.231741] [<c0041f34>] (__blocking_notifier_call_chain+0x2c/0x60) from [<c0041f80>] (blocking_notifier_call_chain+0x18/0x20)
[ 602.231791] [<c0041f80>] (blocking_notifier_call_chain+0x18/0x20) from [<c0274a78>] (fb_blank+0x34/0x98)
[ 602.231836] [<c0274a78>] (fb_blank+0x34/0x98) from [<c027c7b8>] (fbcon_blank+0x1dc/0x27c)
[ 602.231886] [<c027c7b8>] (fbcon_blank+0x1dc/0x27c) from [<c029f194>] (do_blank_screen+0x1b0/0x268)
[ 602.231931] [<c029f194>] (do_blank_screen+0x1b0/0x268) from [<c02a1dbc>] (console_callback+0x68/0x12c)
[ 602.231970] [<c02a1dbc>] (console_callback+0x68/0x12c) from [<c00368c0>] (process_one_work+0x1a8/0x560)
[ 602.232010] [<c00368c0>] (process_one_work+0x1a8/0x560) from [<c0036fd8>] (worker_thread+0x160/0x480)
[ 602.232054] [<c0036fd8>] (worker_thread+0x160/0x480) from [<c003c040>] (kthread+0xa4/0xb0)
[ 602.232100] [<c003c040>] (kthread+0xa4/0xb0) from [<c000e9c8>] (ret_from_fork+0x14/0x2c)
On Sat, Dec 22, 2012 at 04:28:26PM +0100, Maciej Rutecki wrote:
> Got during suspend to disk:
>
> [ 269.784867] [ INFO: possible circular locking dependency detected ]
> [ 269.784869] 3.8.0-rc1 #1 Not tainted
> [ 269.784870] -------------------------------------------------------
> [ 269.784871] kworker/u:3/56 is trying to acquire lock:
> [ 269.784878] ((fb_notifier_list).rwsem){.+.+.+}, at: [<ffffffff81062a1d>]
> __blocking_notifier_call_chain+0x49/0x80
> [ 269.784879]
> [ 269.784879] but task is already holding lock:
> [ 269.784884] (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> i915_drm_freeze+0x9e/0xbb
> [ 269.784884]
> [ 269.784884] which lock already depends on the new lock.
> [ 269.784884]
> [ 269.784885]
> [ 269.784885] the existing dependency chain (in reverse order) is:
> [ 269.784887]
> [ 269.784887] -> #1 (console_lock){+.+.+.}:
> [ 269.784890] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> [ 269.784893] [<ffffffff810405a1>] console_lock+0x59/0x5b
> [ 269.784897] [<ffffffff812ba125>] register_con_driver+0x36/0x128
> [ 269.784899] [<ffffffff812bb27e>] take_over_console+0x1e/0x45
> [ 269.784903] [<ffffffff81257a04>] fbcon_takeover+0x56/0x98
> [ 269.784906] [<ffffffff8125b857>] fbcon_event_notify+0x2c1/0x5ea
> [ 269.784909] [<ffffffff8149a211>] notifier_call_chain+0x67/0x92
> [ 269.784911] [<ffffffff81062a33>] __blocking_notifier_call_chain+0x5f/0x80
> [ 269.784912] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> [ 269.784915] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> [ 269.784917] [<ffffffff812505d7>] register_framebuffer+0x20a/0x26e
> [ 269.784920] [<ffffffff812d3ca0>]
> drm_fb_helper_single_fb_probe+0x1ce/0x297
> [ 269.784922] [<ffffffff812d3f40>] drm_fb_helper_initial_config+0x1d7/0x1ef
> [ 269.784924] [<ffffffff8132cee2>] intel_fbdev_init+0x6f/0x82
> [ 269.784927] [<ffffffff812f22f6>] i915_driver_load+0xa9e/0xc78
> [ 269.784929] [<ffffffff812e020c>] drm_get_pci_dev+0x165/0x26d
> [ 269.784931] [<ffffffff812ee8da>] i915_pci_probe+0x60/0x69
> [ 269.784933] [<ffffffff8123fe8e>] local_pci_probe+0x39/0x61
> [ 269.784935] [<ffffffff812400f5>] pci_device_probe+0xba/0xe0
> [ 269.784938] [<ffffffff8133d3b6>] driver_probe_device+0x99/0x1c4
> [ 269.784940] [<ffffffff8133d52f>] __driver_attach+0x4e/0x6f
> [ 269.784942] [<ffffffff8133bae1>] bus_for_each_dev+0x52/0x84
> [ 269.784944] [<ffffffff8133cec6>] driver_attach+0x19/0x1b
> [ 269.784946] [<ffffffff8133cb65>] bus_add_driver+0xdf/0x203
> [ 269.784948] [<ffffffff8133dad3>] driver_register+0x8e/0x114
> [ 269.784952] [<ffffffff8123f581>] __pci_register_driver+0x5d/0x62
> [ 269.784953] [<ffffffff812e0395>] drm_pci_init+0x81/0xe6
> [ 269.784957] [<ffffffff81af7612>] i915_init+0x66/0x68
> [ 269.784959] [<ffffffff810020b4>] do_one_initcall+0x7a/0x136
> [ 269.784962] [<ffffffff8147ceaa>] kernel_init+0x141/0x296
> [ 269.784964] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> [ 269.784966]
> [ 269.784966] -> #0 ((fb_notifier_list).rwsem){.+.+.+}:
> [ 269.784967] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> [ 269.784969] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> [ 269.784971] [<ffffffff81495092>] down_read+0x34/0x43
> [ 269.784973] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> [ 269.784975] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> [ 269.784977] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> [ 269.784979] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> [ 269.784981] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> [ 269.784983] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> [ 269.784985] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> [ 269.784987] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> [ 269.784990] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> [ 269.784993] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> [ 269.784995] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> [ 269.784997] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> [ 269.785000] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> [ 269.785002] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> [ 269.785004] [<ffffffff8105d416>] kthread+0xac/0xb4
> [ 269.785006] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> [ 269.785006]
> [ 269.785006] other info that might help us debug this:
> [ 269.785006]
> [ 269.785007] Possible unsafe locking scenario:
> [ 269.785007]
> [ 269.785008] CPU0 CPU1
> [ 269.785008] ---- ----
> [ 269.785009] lock(console_lock);
> [ 269.785010] lock((fb_notifier_list).rwsem);
> [ 269.785012] lock(console_lock);
> [ 269.785013] lock((fb_notifier_list).rwsem);
> [ 269.785013]
> [ 269.785013] *** DEADLOCK ***
> [ 269.785013]
> [ 269.785014] 4 locks held by kworker/u:3/56:
> [ 269.785018] #0: (events_unbound){.+.+.+}, at: [<ffffffff81058d77>]
> process_one_work+0x154/0x38e
> [ 269.785021] #1: ((&entry->work)){+.+.+.}, at: [<ffffffff81058d77>]
> process_one_work+0x154/0x38e
> [ 269.785024] #2: (&__lockdep_no_validate__){......}, at: [<ffffffff81342d85>]
> device_lock+0xf/0x11
> [ 269.785027] #3: (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> i915_drm_freeze+0x9e/0xbb
> [ 269.785028]
> [ 269.785028] stack backtrace:
> [ 269.785029] Pid: 56, comm: kworker/u:3 Not tainted 3.8.0-rc1 #1
> [ 269.785030] Call Trace:
> [ 269.785035] [<ffffffff8148fcb5>] print_circular_bug+0x1f8/0x209
> [ 269.785036] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> [ 269.785038] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> [ 269.785040] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> [ 269.785042] [<ffffffff81495092>] down_read+0x34/0x43
> [ 269.785044] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> [ 269.785046] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> [ 269.785047] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> [ 269.785050] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> [ 269.785052] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> [ 269.785054] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> [ 269.785055] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> [ 269.785057] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> [ 269.785060] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> [ 269.785062] [<ffffffff8123f6f4>] ? pci_pm_poweroff+0x9c/0x9c
> [ 269.785064] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> [ 269.785066] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> [ 269.785068] [<ffffffff81089563>] ? trace_hardirqs_on_caller+0x117/0x173
> [ 269.785070] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> [ 269.785072] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> [ 269.785074] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> [ 269.785076] [<ffffffff81058d77>] ? process_one_work+0x154/0x38e
> [ 269.785078] [<ffffffff810639c7>] ? async_schedule+0x12/0x12
> [ 269.785080] [<ffffffff8105679f>] ? spin_lock_irq+0x9/0xb
> [ 269.785082] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> [ 269.785084] [<ffffffff81059162>] ? rescuer_thread+0x187/0x187
> [ 269.785085] [<ffffffff8105d416>] kthread+0xac/0xb4
> [ 269.785088] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> [ 269.785090] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> [ 269.785091] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
>
>
> Config:
> http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/config-3.8.0-rc1
>
> dmesg:
> http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/dmesg-3.8.0-rc1.txt
>
>
> Found similar report:
> http://marc.info/?l=linux-kernel&m=135546308908700&w=2
>
> Regards
>
> --
> Maciej Rutecki
> http://www.mrutecki.pl
> --
> To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
> the body of a message to majordomo at vger.kernel.org
> More majordomo info at http://vger.kernel.org/majordomo-info.html
> Please read the FAQ at http://www.tux.org/lkml/
^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ]
2012-12-23 21:34 ` Christian Kujau
@ 2012-12-26 8:18 ` Li Zhong
-1 siblings, 0 replies; 16+ messages in thread
From: Li Zhong @ 2012-12-26 8:18 UTC (permalink / raw)
To: Christian Kujau; +Cc: Maciej Rutecki, LKML, Cong Wang, linuxppc-dev
On Sun, 2012-12-23 at 13:34 -0800, Christian Kujau wrote:
> On Sat, 22 Dec 2012 at 16:28, Maciej Rutecki wrote:
> > Got during suspend to disk:
>
> I got a similar message on a powerpc G4 system, right after bootup (no
> suspend involved):
>
> http://nerdbynature.de/bits/3.8.0-rc1/
>
> [ 97.803049] ======================================================
> [ 97.803051] [ INFO: possible circular locking dependency detected ]
> [ 97.803059] 3.8.0-rc1-dirty #2 Not tainted
> [ 97.803060] -------------------------------------------------------
> [ 97.803066] kworker/0:1/235 is trying to acquire lock:
> [ 97.803097] ((fb_notifier_list).rwsem){.+.+.+}, at: [<c00606a0>] __blocking_notifier_call_chain+0x44/0x88
> [ 97.803099]
> [ 97.803099] but task is already holding lock:
> [ 97.803110] (console_lock){+.+.+.}, at: [<c03b9fd0>] console_callback+0x20/0x194
> [ 97.803112]
> [ 97.803112] which lock already depends on the new lock.
>
> ...and on it goes. Please see the URL above for the whole dmesg and
> .config.
>
> @Li Zhong: I have applied your fix for the "MAX_STACK_TRACE_ENTRIES too
> low" warning[0] to 3.8-rc1 (hence the -dirty flag), but in the
> backtrace "ret_from_kernel_thread" shows up again. FWIW, your
> patch helped to make the "MAX_STACK_TRACE_ENTRIES too low"
> warning go away in 3.7.0-rc7 and it did not re-appear ever
> since.
The patch fixing "MAX_STACK_TRACE_ENTRIES too low" warning clears the
stack back chain at "ret_from_kernel_thread", so I think it's fine to
see it on the top of the stack.
Thank, Zhong
> Thanks,
> Christian.
>
> [0] http://lkml.indiana.edu/hypermail/linux/kernel/1211.3/01917.html
>
> > [ 269.784867] [ INFO: possible circular locking dependency detected ]
> > [ 269.784869] 3.8.0-rc1 #1 Not tainted
> > [ 269.784870] -------------------------------------------------------
> > [ 269.784871] kworker/u:3/56 is trying to acquire lock:
> > [ 269.784878] ((fb_notifier_list).rwsem){.+.+.+}, at: [<ffffffff81062a1d>]
> > __blocking_notifier_call_chain+0x49/0x80
> > [ 269.784879]
> > [ 269.784879] but task is already holding lock:
> > [ 269.784884] (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> > i915_drm_freeze+0x9e/0xbb
> > [ 269.784884]
> > [ 269.784884] which lock already depends on the new lock.
> > [ 269.784884]
> > [ 269.784885]
> > [ 269.784885] the existing dependency chain (in reverse order) is:
> > [ 269.784887]
> > [ 269.784887] -> #1 (console_lock){+.+.+.}:
> > [ 269.784890] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.784893] [<ffffffff810405a1>] console_lock+0x59/0x5b
> > [ 269.784897] [<ffffffff812ba125>] register_con_driver+0x36/0x128
> > [ 269.784899] [<ffffffff812bb27e>] take_over_console+0x1e/0x45
> > [ 269.784903] [<ffffffff81257a04>] fbcon_takeover+0x56/0x98
> > [ 269.784906] [<ffffffff8125b857>] fbcon_event_notify+0x2c1/0x5ea
> > [ 269.784909] [<ffffffff8149a211>] notifier_call_chain+0x67/0x92
> > [ 269.784911] [<ffffffff81062a33>] __blocking_notifier_call_chain+0x5f/0x80
> > [ 269.784912] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.784915] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.784917] [<ffffffff812505d7>] register_framebuffer+0x20a/0x26e
> > [ 269.784920] [<ffffffff812d3ca0>]
> > drm_fb_helper_single_fb_probe+0x1ce/0x297
> > [ 269.784922] [<ffffffff812d3f40>] drm_fb_helper_initial_config+0x1d7/0x1ef
> > [ 269.784924] [<ffffffff8132cee2>] intel_fbdev_init+0x6f/0x82
> > [ 269.784927] [<ffffffff812f22f6>] i915_driver_load+0xa9e/0xc78
> > [ 269.784929] [<ffffffff812e020c>] drm_get_pci_dev+0x165/0x26d
> > [ 269.784931] [<ffffffff812ee8da>] i915_pci_probe+0x60/0x69
> > [ 269.784933] [<ffffffff8123fe8e>] local_pci_probe+0x39/0x61
> > [ 269.784935] [<ffffffff812400f5>] pci_device_probe+0xba/0xe0
> > [ 269.784938] [<ffffffff8133d3b6>] driver_probe_device+0x99/0x1c4
> > [ 269.784940] [<ffffffff8133d52f>] __driver_attach+0x4e/0x6f
> > [ 269.784942] [<ffffffff8133bae1>] bus_for_each_dev+0x52/0x84
> > [ 269.784944] [<ffffffff8133cec6>] driver_attach+0x19/0x1b
> > [ 269.784946] [<ffffffff8133cb65>] bus_add_driver+0xdf/0x203
> > [ 269.784948] [<ffffffff8133dad3>] driver_register+0x8e/0x114
> > [ 269.784952] [<ffffffff8123f581>] __pci_register_driver+0x5d/0x62
> > [ 269.784953] [<ffffffff812e0395>] drm_pci_init+0x81/0xe6
> > [ 269.784957] [<ffffffff81af7612>] i915_init+0x66/0x68
> > [ 269.784959] [<ffffffff810020b4>] do_one_initcall+0x7a/0x136
> > [ 269.784962] [<ffffffff8147ceaa>] kernel_init+0x141/0x296
> > [ 269.784964] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.784966]
> > [ 269.784966] -> #0 ((fb_notifier_list).rwsem){.+.+.+}:
> > [ 269.784967] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> > [ 269.784969] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.784971] [<ffffffff81495092>] down_read+0x34/0x43
> > [ 269.784973] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> > [ 269.784975] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.784977] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.784979] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> > [ 269.784981] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> > [ 269.784983] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> > [ 269.784985] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> > [ 269.784987] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> > [ 269.784990] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> > [ 269.784993] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> > [ 269.784995] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> > [ 269.784997] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> > [ 269.785000] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> > [ 269.785002] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> > [ 269.785004] [<ffffffff8105d416>] kthread+0xac/0xb4
> > [ 269.785006] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.785006]
> > [ 269.785006] other info that might help us debug this:
> > [ 269.785006]
> > [ 269.785007] Possible unsafe locking scenario:
> > [ 269.785007]
> > [ 269.785008] CPU0 CPU1
> > [ 269.785008] ---- ----
> > [ 269.785009] lock(console_lock);
> > [ 269.785010] lock((fb_notifier_list).rwsem);
> > [ 269.785012] lock(console_lock);
> > [ 269.785013] lock((fb_notifier_list).rwsem);
> > [ 269.785013]
> > [ 269.785013] *** DEADLOCK ***
> > [ 269.785013]
> > [ 269.785014] 4 locks held by kworker/u:3/56:
> > [ 269.785018] #0: (events_unbound){.+.+.+}, at: [<ffffffff81058d77>]
> > process_one_work+0x154/0x38e
> > [ 269.785021] #1: ((&entry->work)){+.+.+.}, at: [<ffffffff81058d77>]
> > process_one_work+0x154/0x38e
> > [ 269.785024] #2: (&__lockdep_no_validate__){......}, at: [<ffffffff81342d85>]
> > device_lock+0xf/0x11
> > [ 269.785027] #3: (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> > i915_drm_freeze+0x9e/0xbb
> > [ 269.785028]
> > [ 269.785028] stack backtrace:
> > [ 269.785029] Pid: 56, comm: kworker/u:3 Not tainted 3.8.0-rc1 #1
> > [ 269.785030] Call Trace:
> > [ 269.785035] [<ffffffff8148fcb5>] print_circular_bug+0x1f8/0x209
> > [ 269.785036] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> > [ 269.785038] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.785040] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785042] [<ffffffff81495092>] down_read+0x34/0x43
> > [ 269.785044] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785046] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785047] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.785050] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.785052] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> > [ 269.785054] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> > [ 269.785055] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> > [ 269.785057] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> > [ 269.785060] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> > [ 269.785062] [<ffffffff8123f6f4>] ? pci_pm_poweroff+0x9c/0x9c
> > [ 269.785064] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> > [ 269.785066] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> > [ 269.785068] [<ffffffff81089563>] ? trace_hardirqs_on_caller+0x117/0x173
> > [ 269.785070] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> > [ 269.785072] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> > [ 269.785074] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> > [ 269.785076] [<ffffffff81058d77>] ? process_one_work+0x154/0x38e
> > [ 269.785078] [<ffffffff810639c7>] ? async_schedule+0x12/0x12
> > [ 269.785080] [<ffffffff8105679f>] ? spin_lock_irq+0x9/0xb
> > [ 269.785082] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> > [ 269.785084] [<ffffffff81059162>] ? rescuer_thread+0x187/0x187
> > [ 269.785085] [<ffffffff8105d416>] kthread+0xac/0xb4
> > [ 269.785088] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> > [ 269.785090] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.785091] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> >
> >
> > Config:
> > http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/config-3.8.0-rc1
> >
> > dmesg:
> > http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/dmesg-3.8.0-rc1.txt
> >
> >
> > Found similar report:
> > http://marc.info/?l=linux-kernel&m=135546308908700&w=2
> >
> > Regards
> >
> > --
> > Maciej Rutecki
> > http://www.mrutecki.pl
> > --
> > To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
> > the body of a message to majordomo@vger.kernel.org
> > More majordomo info at http://vger.kernel.org/majordomo-info.html
> > Please read the FAQ at http://www.tux.org/lkml/
> >
>
^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ]
@ 2012-12-26 8:18 ` Li Zhong
0 siblings, 0 replies; 16+ messages in thread
From: Li Zhong @ 2012-12-26 8:18 UTC (permalink / raw)
To: Christian Kujau; +Cc: Cong Wang, linuxppc-dev, LKML, Maciej Rutecki
On Sun, 2012-12-23 at 13:34 -0800, Christian Kujau wrote:
> On Sat, 22 Dec 2012 at 16:28, Maciej Rutecki wrote:
> > Got during suspend to disk:
>
> I got a similar message on a powerpc G4 system, right after bootup (no
> suspend involved):
>
> http://nerdbynature.de/bits/3.8.0-rc1/
>
> [ 97.803049] ======================================================
> [ 97.803051] [ INFO: possible circular locking dependency detected ]
> [ 97.803059] 3.8.0-rc1-dirty #2 Not tainted
> [ 97.803060] -------------------------------------------------------
> [ 97.803066] kworker/0:1/235 is trying to acquire lock:
> [ 97.803097] ((fb_notifier_list).rwsem){.+.+.+}, at: [<c00606a0>] __blocking_notifier_call_chain+0x44/0x88
> [ 97.803099]
> [ 97.803099] but task is already holding lock:
> [ 97.803110] (console_lock){+.+.+.}, at: [<c03b9fd0>] console_callback+0x20/0x194
> [ 97.803112]
> [ 97.803112] which lock already depends on the new lock.
>
> ...and on it goes. Please see the URL above for the whole dmesg and
> .config.
>
> @Li Zhong: I have applied your fix for the "MAX_STACK_TRACE_ENTRIES too
> low" warning[0] to 3.8-rc1 (hence the -dirty flag), but in the
> backtrace "ret_from_kernel_thread" shows up again. FWIW, your
> patch helped to make the "MAX_STACK_TRACE_ENTRIES too low"
> warning go away in 3.7.0-rc7 and it did not re-appear ever
> since.
The patch fixing "MAX_STACK_TRACE_ENTRIES too low" warning clears the
stack back chain at "ret_from_kernel_thread", so I think it's fine to
see it on the top of the stack.
Thank, Zhong
> Thanks,
> Christian.
>
> [0] http://lkml.indiana.edu/hypermail/linux/kernel/1211.3/01917.html
>
> > [ 269.784867] [ INFO: possible circular locking dependency detected ]
> > [ 269.784869] 3.8.0-rc1 #1 Not tainted
> > [ 269.784870] -------------------------------------------------------
> > [ 269.784871] kworker/u:3/56 is trying to acquire lock:
> > [ 269.784878] ((fb_notifier_list).rwsem){.+.+.+}, at: [<ffffffff81062a1d>]
> > __blocking_notifier_call_chain+0x49/0x80
> > [ 269.784879]
> > [ 269.784879] but task is already holding lock:
> > [ 269.784884] (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> > i915_drm_freeze+0x9e/0xbb
> > [ 269.784884]
> > [ 269.784884] which lock already depends on the new lock.
> > [ 269.784884]
> > [ 269.784885]
> > [ 269.784885] the existing dependency chain (in reverse order) is:
> > [ 269.784887]
> > [ 269.784887] -> #1 (console_lock){+.+.+.}:
> > [ 269.784890] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.784893] [<ffffffff810405a1>] console_lock+0x59/0x5b
> > [ 269.784897] [<ffffffff812ba125>] register_con_driver+0x36/0x128
> > [ 269.784899] [<ffffffff812bb27e>] take_over_console+0x1e/0x45
> > [ 269.784903] [<ffffffff81257a04>] fbcon_takeover+0x56/0x98
> > [ 269.784906] [<ffffffff8125b857>] fbcon_event_notify+0x2c1/0x5ea
> > [ 269.784909] [<ffffffff8149a211>] notifier_call_chain+0x67/0x92
> > [ 269.784911] [<ffffffff81062a33>] __blocking_notifier_call_chain+0x5f/0x80
> > [ 269.784912] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.784915] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.784917] [<ffffffff812505d7>] register_framebuffer+0x20a/0x26e
> > [ 269.784920] [<ffffffff812d3ca0>]
> > drm_fb_helper_single_fb_probe+0x1ce/0x297
> > [ 269.784922] [<ffffffff812d3f40>] drm_fb_helper_initial_config+0x1d7/0x1ef
> > [ 269.784924] [<ffffffff8132cee2>] intel_fbdev_init+0x6f/0x82
> > [ 269.784927] [<ffffffff812f22f6>] i915_driver_load+0xa9e/0xc78
> > [ 269.784929] [<ffffffff812e020c>] drm_get_pci_dev+0x165/0x26d
> > [ 269.784931] [<ffffffff812ee8da>] i915_pci_probe+0x60/0x69
> > [ 269.784933] [<ffffffff8123fe8e>] local_pci_probe+0x39/0x61
> > [ 269.784935] [<ffffffff812400f5>] pci_device_probe+0xba/0xe0
> > [ 269.784938] [<ffffffff8133d3b6>] driver_probe_device+0x99/0x1c4
> > [ 269.784940] [<ffffffff8133d52f>] __driver_attach+0x4e/0x6f
> > [ 269.784942] [<ffffffff8133bae1>] bus_for_each_dev+0x52/0x84
> > [ 269.784944] [<ffffffff8133cec6>] driver_attach+0x19/0x1b
> > [ 269.784946] [<ffffffff8133cb65>] bus_add_driver+0xdf/0x203
> > [ 269.784948] [<ffffffff8133dad3>] driver_register+0x8e/0x114
> > [ 269.784952] [<ffffffff8123f581>] __pci_register_driver+0x5d/0x62
> > [ 269.784953] [<ffffffff812e0395>] drm_pci_init+0x81/0xe6
> > [ 269.784957] [<ffffffff81af7612>] i915_init+0x66/0x68
> > [ 269.784959] [<ffffffff810020b4>] do_one_initcall+0x7a/0x136
> > [ 269.784962] [<ffffffff8147ceaa>] kernel_init+0x141/0x296
> > [ 269.784964] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.784966]
> > [ 269.784966] -> #0 ((fb_notifier_list).rwsem){.+.+.+}:
> > [ 269.784967] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> > [ 269.784969] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.784971] [<ffffffff81495092>] down_read+0x34/0x43
> > [ 269.784973] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> > [ 269.784975] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.784977] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.784979] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> > [ 269.784981] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> > [ 269.784983] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> > [ 269.784985] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> > [ 269.784987] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> > [ 269.784990] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> > [ 269.784993] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> > [ 269.784995] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> > [ 269.784997] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> > [ 269.785000] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> > [ 269.785002] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> > [ 269.785004] [<ffffffff8105d416>] kthread+0xac/0xb4
> > [ 269.785006] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.785006]
> > [ 269.785006] other info that might help us debug this:
> > [ 269.785006]
> > [ 269.785007] Possible unsafe locking scenario:
> > [ 269.785007]
> > [ 269.785008] CPU0 CPU1
> > [ 269.785008] ---- ----
> > [ 269.785009] lock(console_lock);
> > [ 269.785010] lock((fb_notifier_list).rwsem);
> > [ 269.785012] lock(console_lock);
> > [ 269.785013] lock((fb_notifier_list).rwsem);
> > [ 269.785013]
> > [ 269.785013] *** DEADLOCK ***
> > [ 269.785013]
> > [ 269.785014] 4 locks held by kworker/u:3/56:
> > [ 269.785018] #0: (events_unbound){.+.+.+}, at: [<ffffffff81058d77>]
> > process_one_work+0x154/0x38e
> > [ 269.785021] #1: ((&entry->work)){+.+.+.}, at: [<ffffffff81058d77>]
> > process_one_work+0x154/0x38e
> > [ 269.785024] #2: (&__lockdep_no_validate__){......}, at: [<ffffffff81342d85>]
> > device_lock+0xf/0x11
> > [ 269.785027] #3: (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> > i915_drm_freeze+0x9e/0xbb
> > [ 269.785028]
> > [ 269.785028] stack backtrace:
> > [ 269.785029] Pid: 56, comm: kworker/u:3 Not tainted 3.8.0-rc1 #1
> > [ 269.785030] Call Trace:
> > [ 269.785035] [<ffffffff8148fcb5>] print_circular_bug+0x1f8/0x209
> > [ 269.785036] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> > [ 269.785038] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.785040] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785042] [<ffffffff81495092>] down_read+0x34/0x43
> > [ 269.785044] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785046] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785047] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.785050] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.785052] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> > [ 269.785054] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> > [ 269.785055] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> > [ 269.785057] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> > [ 269.785060] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> > [ 269.785062] [<ffffffff8123f6f4>] ? pci_pm_poweroff+0x9c/0x9c
> > [ 269.785064] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> > [ 269.785066] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> > [ 269.785068] [<ffffffff81089563>] ? trace_hardirqs_on_caller+0x117/0x173
> > [ 269.785070] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> > [ 269.785072] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> > [ 269.785074] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> > [ 269.785076] [<ffffffff81058d77>] ? process_one_work+0x154/0x38e
> > [ 269.785078] [<ffffffff810639c7>] ? async_schedule+0x12/0x12
> > [ 269.785080] [<ffffffff8105679f>] ? spin_lock_irq+0x9/0xb
> > [ 269.785082] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> > [ 269.785084] [<ffffffff81059162>] ? rescuer_thread+0x187/0x187
> > [ 269.785085] [<ffffffff8105d416>] kthread+0xac/0xb4
> > [ 269.785088] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> > [ 269.785090] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.785091] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> >
> >
> > Config:
> > http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/config-3.8.0-rc1
> >
> > dmesg:
> > http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/dmesg-3.8.0-rc1.txt
> >
> >
> > Found similar report:
> > http://marc.info/?l=linux-kernel&m=135546308908700&w=2
> >
> > Regards
> >
> > --
> > Maciej Rutecki
> > http://www.mrutecki.pl
> > --
> > To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
> > the body of a message to majordomo@vger.kernel.org
> > More majordomo info at http://vger.kernel.org/majordomo-info.html
> > Please read the FAQ at http://www.tux.org/lkml/
> >
>
^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ]
2012-12-26 2:34 ` Shawn Guo
@ 2012-12-27 8:36 ` Shawn Guo
-1 siblings, 0 replies; 16+ messages in thread
From: Shawn Guo @ 2012-12-27 8:36 UTC (permalink / raw)
To: Maciej Rutecki
Cc: LKML, Cong Wang, linux-arm-kernel, Daniel Vetter, Greg Kroah-Hartman
On Wed, Dec 26, 2012 at 10:34:39AM +0800, Shawn Guo wrote:
> It seems that I'm running into the same locking issue. My setup is:
>
> - i.MX28 (ARM)
> - v3.8-rc1
> - mxs_defconfig
- The warning is seen when LCD is blanking
>
The warning disappears after reverting patch daee779 (console: implement
lockdep support for console_lock). Is it suggesting that the mxs
frame buffer driver (drivers/video/mxsfb.c) is doing something bad?
Shawn
>
> [ 602.229899] ======================================================
> [ 602.229905] [ INFO: possible circular locking dependency detected ]
> [ 602.229926] 3.8.0-rc1-00003-gde4ae7f #767 Not tainted
> [ 602.229933] -------------------------------------------------------
> [ 602.229951] kworker/0:1/21 is trying to acquire lock:
> [ 602.230037] ((fb_notifier_list).rwsem){.+.+.+}, at: [<c0041f34>] __blocking_notifier_call_chain+0x2c/0x60
> [ 602.230047]
> [ 602.230047] but task is already holding lock:
> [ 602.230090] (console_lock){+.+.+.}, at: [<c02a1d60>] console_callback+0xc/0x12c
> [ 602.230098]
> [ 602.230098] which lock already depends on the new lock.
> [ 602.230098]
> [ 602.230104]
> [ 602.230104] the existing dependency chain (in reverse order) is:
> [ 602.230126]
> [ 602.230126] -> #1 (console_lock){+.+.+.}:
> [ 602.230174] [<c005cb20>] lock_acquire+0x9c/0x124
> [ 602.230205] [<c001dc78>] console_lock+0x58/0x6c
> [ 602.230250] [<c029ea60>] register_con_driver+0x38/0x138
> [ 602.230284] [<c02a0018>] take_over_console+0x18/0x44
> [ 602.230314] [<c027bc80>] fbcon_takeover+0x64/0xc8
> [ 602.230352] [<c0041c94>] notifier_call_chain+0x44/0x80
> [ 602.230386] [<c0041f50>] __blocking_notifier_call_chain+0x48/0x60
> [ 602.230416] [<c0041f80>] blocking_notifier_call_chain+0x18/0x20
> [ 602.230459] [<c0275efc>] register_framebuffer+0x170/0x250
> [ 602.230492] [<c02837f4>] mxsfb_probe+0x574/0x738
> [ 602.230528] [<c02b276c>] platform_drv_probe+0x14/0x18
> [ 602.230556] [<c02b14cc>] driver_probe_device+0x78/0x20c
> [ 602.230583] [<c02b16f4>] __driver_attach+0x94/0x98
> [ 602.230610] [<c02afdb4>] bus_for_each_dev+0x54/0x7c
> [ 602.230636] [<c02b0d14>] bus_add_driver+0x180/0x250
> [ 602.230662] [<c02b1bb8>] driver_register+0x78/0x144
> [ 602.230690] [<c00087c8>] do_one_initcall+0x30/0x16c
> [ 602.230721] [<c0428fcc>] kernel_init+0xf4/0x290
> [ 602.230756] [<c000e9c8>] ret_from_fork+0x14/0x2c
> [ 602.230781]
> [ 602.230781] -> #0 ((fb_notifier_list).rwsem){.+.+.+}:
> [ 602.230825] [<c005bfa0>] __lock_acquire+0x1354/0x19b0
> [ 602.230854] [<c005cb20>] lock_acquire+0x9c/0x124
> [ 602.230895] [<c0430148>] down_read+0x3c/0x4c
> [ 602.230933] [<c0041f34>] __blocking_notifier_call_chain+0x2c/0x60
> [ 602.230962] [<c0041f80>] blocking_notifier_call_chain+0x18/0x20
> [ 602.230997] [<c0274a78>] fb_blank+0x34/0x98
> [ 602.231024] [<c027c7b8>] fbcon_blank+0x1dc/0x27c
> [ 602.231065] [<c029f194>] do_blank_screen+0x1b0/0x268
> [ 602.231093] [<c02a1dbc>] console_callback+0x68/0x12c
> [ 602.231121] [<c00368c0>] process_one_work+0x1a8/0x560
> [ 602.231145] [<c0036fd8>] worker_thread+0x160/0x480
> [ 602.231180] [<c003c040>] kthread+0xa4/0xb0
> [ 602.231210] [<c000e9c8>] ret_from_fork+0x14/0x2c
> [ 602.231218]
> [ 602.231218] other info that might help us debug this:
> [ 602.231218]
> [ 602.231225] Possible unsafe locking scenario:
> [ 602.231225]
> [ 602.231230] CPU0 CPU1
> [ 602.231235] ---- ----
> [ 602.231249] lock(console_lock);
> [ 602.231263] lock((fb_notifier_list).rwsem);
> [ 602.231275] lock(console_lock);
> [ 602.231287] lock((fb_notifier_list).rwsem);
> [ 602.231292]
> [ 602.231292] *** DEADLOCK ***
> [ 602.231292]
> [ 602.231305] 3 locks held by kworker/0:1/21:
> [ 602.231345] #0: (events){.+.+.+}, at: [<c0036840>] process_one_work+0x128/0x560
> [ 602.231388] #1: (console_work){+.+...}, at: [<c0036840>] process_one_work+0x128/0x560
> [ 602.231430] #2: (console_lock){+.+.+.}, at: [<c02a1d60>] console_callback+0xc/0x12c
> [ 602.231437]
> [ 602.231437] stack backtrace:
> [ 602.231491] [<c0013e58>] (unwind_backtrace+0x0/0xf0) from [<c042b0e4>] (print_circular_bug+0x254/0x2a0)
> [ 602.231547] [<c042b0e4>] (print_circular_bug+0x254/0x2a0) from [<c005bfa0>] (__lock_acquire+0x1354/0x19b0)
> [ 602.231596] [<c005bfa0>] (__lock_acquire+0x1354/0x19b0) from [<c005cb20>] (lock_acquire+0x9c/0x124)
> [ 602.231640] [<c005cb20>] (lock_acquire+0x9c/0x124) from [<c0430148>] (down_read+0x3c/0x4c)
> [ 602.231694] [<c0430148>] (down_read+0x3c/0x4c) from [<c0041f34>] (__blocking_notifier_call_chain+0x2c/0x60)
> [ 602.231741] [<c0041f34>] (__blocking_notifier_call_chain+0x2c/0x60) from [<c0041f80>] (blocking_notifier_call_chain+0x18/0x20)
> [ 602.231791] [<c0041f80>] (blocking_notifier_call_chain+0x18/0x20) from [<c0274a78>] (fb_blank+0x34/0x98)
> [ 602.231836] [<c0274a78>] (fb_blank+0x34/0x98) from [<c027c7b8>] (fbcon_blank+0x1dc/0x27c)
> [ 602.231886] [<c027c7b8>] (fbcon_blank+0x1dc/0x27c) from [<c029f194>] (do_blank_screen+0x1b0/0x268)
> [ 602.231931] [<c029f194>] (do_blank_screen+0x1b0/0x268) from [<c02a1dbc>] (console_callback+0x68/0x12c)
> [ 602.231970] [<c02a1dbc>] (console_callback+0x68/0x12c) from [<c00368c0>] (process_one_work+0x1a8/0x560)
> [ 602.232010] [<c00368c0>] (process_one_work+0x1a8/0x560) from [<c0036fd8>] (worker_thread+0x160/0x480)
> [ 602.232054] [<c0036fd8>] (worker_thread+0x160/0x480) from [<c003c040>] (kthread+0xa4/0xb0)
> [ 602.232100] [<c003c040>] (kthread+0xa4/0xb0) from [<c000e9c8>] (ret_from_fork+0x14/0x2c)
>
>
> On Sat, Dec 22, 2012 at 04:28:26PM +0100, Maciej Rutecki wrote:
> > Got during suspend to disk:
> >
> > [ 269.784867] [ INFO: possible circular locking dependency detected ]
> > [ 269.784869] 3.8.0-rc1 #1 Not tainted
> > [ 269.784870] -------------------------------------------------------
> > [ 269.784871] kworker/u:3/56 is trying to acquire lock:
> > [ 269.784878] ((fb_notifier_list).rwsem){.+.+.+}, at: [<ffffffff81062a1d>]
> > __blocking_notifier_call_chain+0x49/0x80
> > [ 269.784879]
> > [ 269.784879] but task is already holding lock:
> > [ 269.784884] (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> > i915_drm_freeze+0x9e/0xbb
> > [ 269.784884]
> > [ 269.784884] which lock already depends on the new lock.
> > [ 269.784884]
> > [ 269.784885]
> > [ 269.784885] the existing dependency chain (in reverse order) is:
> > [ 269.784887]
> > [ 269.784887] -> #1 (console_lock){+.+.+.}:
> > [ 269.784890] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.784893] [<ffffffff810405a1>] console_lock+0x59/0x5b
> > [ 269.784897] [<ffffffff812ba125>] register_con_driver+0x36/0x128
> > [ 269.784899] [<ffffffff812bb27e>] take_over_console+0x1e/0x45
> > [ 269.784903] [<ffffffff81257a04>] fbcon_takeover+0x56/0x98
> > [ 269.784906] [<ffffffff8125b857>] fbcon_event_notify+0x2c1/0x5ea
> > [ 269.784909] [<ffffffff8149a211>] notifier_call_chain+0x67/0x92
> > [ 269.784911] [<ffffffff81062a33>] __blocking_notifier_call_chain+0x5f/0x80
> > [ 269.784912] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.784915] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.784917] [<ffffffff812505d7>] register_framebuffer+0x20a/0x26e
> > [ 269.784920] [<ffffffff812d3ca0>]
> > drm_fb_helper_single_fb_probe+0x1ce/0x297
> > [ 269.784922] [<ffffffff812d3f40>] drm_fb_helper_initial_config+0x1d7/0x1ef
> > [ 269.784924] [<ffffffff8132cee2>] intel_fbdev_init+0x6f/0x82
> > [ 269.784927] [<ffffffff812f22f6>] i915_driver_load+0xa9e/0xc78
> > [ 269.784929] [<ffffffff812e020c>] drm_get_pci_dev+0x165/0x26d
> > [ 269.784931] [<ffffffff812ee8da>] i915_pci_probe+0x60/0x69
> > [ 269.784933] [<ffffffff8123fe8e>] local_pci_probe+0x39/0x61
> > [ 269.784935] [<ffffffff812400f5>] pci_device_probe+0xba/0xe0
> > [ 269.784938] [<ffffffff8133d3b6>] driver_probe_device+0x99/0x1c4
> > [ 269.784940] [<ffffffff8133d52f>] __driver_attach+0x4e/0x6f
> > [ 269.784942] [<ffffffff8133bae1>] bus_for_each_dev+0x52/0x84
> > [ 269.784944] [<ffffffff8133cec6>] driver_attach+0x19/0x1b
> > [ 269.784946] [<ffffffff8133cb65>] bus_add_driver+0xdf/0x203
> > [ 269.784948] [<ffffffff8133dad3>] driver_register+0x8e/0x114
> > [ 269.784952] [<ffffffff8123f581>] __pci_register_driver+0x5d/0x62
> > [ 269.784953] [<ffffffff812e0395>] drm_pci_init+0x81/0xe6
> > [ 269.784957] [<ffffffff81af7612>] i915_init+0x66/0x68
> > [ 269.784959] [<ffffffff810020b4>] do_one_initcall+0x7a/0x136
> > [ 269.784962] [<ffffffff8147ceaa>] kernel_init+0x141/0x296
> > [ 269.784964] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.784966]
> > [ 269.784966] -> #0 ((fb_notifier_list).rwsem){.+.+.+}:
> > [ 269.784967] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> > [ 269.784969] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.784971] [<ffffffff81495092>] down_read+0x34/0x43
> > [ 269.784973] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> > [ 269.784975] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.784977] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.784979] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> > [ 269.784981] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> > [ 269.784983] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> > [ 269.784985] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> > [ 269.784987] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> > [ 269.784990] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> > [ 269.784993] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> > [ 269.784995] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> > [ 269.784997] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> > [ 269.785000] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> > [ 269.785002] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> > [ 269.785004] [<ffffffff8105d416>] kthread+0xac/0xb4
> > [ 269.785006] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.785006]
> > [ 269.785006] other info that might help us debug this:
> > [ 269.785006]
> > [ 269.785007] Possible unsafe locking scenario:
> > [ 269.785007]
> > [ 269.785008] CPU0 CPU1
> > [ 269.785008] ---- ----
> > [ 269.785009] lock(console_lock);
> > [ 269.785010] lock((fb_notifier_list).rwsem);
> > [ 269.785012] lock(console_lock);
> > [ 269.785013] lock((fb_notifier_list).rwsem);
> > [ 269.785013]
> > [ 269.785013] *** DEADLOCK ***
> > [ 269.785013]
> > [ 269.785014] 4 locks held by kworker/u:3/56:
> > [ 269.785018] #0: (events_unbound){.+.+.+}, at: [<ffffffff81058d77>]
> > process_one_work+0x154/0x38e
> > [ 269.785021] #1: ((&entry->work)){+.+.+.}, at: [<ffffffff81058d77>]
> > process_one_work+0x154/0x38e
> > [ 269.785024] #2: (&__lockdep_no_validate__){......}, at: [<ffffffff81342d85>]
> > device_lock+0xf/0x11
> > [ 269.785027] #3: (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> > i915_drm_freeze+0x9e/0xbb
> > [ 269.785028]
> > [ 269.785028] stack backtrace:
> > [ 269.785029] Pid: 56, comm: kworker/u:3 Not tainted 3.8.0-rc1 #1
> > [ 269.785030] Call Trace:
> > [ 269.785035] [<ffffffff8148fcb5>] print_circular_bug+0x1f8/0x209
> > [ 269.785036] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> > [ 269.785038] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.785040] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785042] [<ffffffff81495092>] down_read+0x34/0x43
> > [ 269.785044] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785046] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785047] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.785050] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.785052] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> > [ 269.785054] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> > [ 269.785055] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> > [ 269.785057] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> > [ 269.785060] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> > [ 269.785062] [<ffffffff8123f6f4>] ? pci_pm_poweroff+0x9c/0x9c
> > [ 269.785064] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> > [ 269.785066] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> > [ 269.785068] [<ffffffff81089563>] ? trace_hardirqs_on_caller+0x117/0x173
> > [ 269.785070] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> > [ 269.785072] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> > [ 269.785074] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> > [ 269.785076] [<ffffffff81058d77>] ? process_one_work+0x154/0x38e
> > [ 269.785078] [<ffffffff810639c7>] ? async_schedule+0x12/0x12
> > [ 269.785080] [<ffffffff8105679f>] ? spin_lock_irq+0x9/0xb
> > [ 269.785082] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> > [ 269.785084] [<ffffffff81059162>] ? rescuer_thread+0x187/0x187
> > [ 269.785085] [<ffffffff8105d416>] kthread+0xac/0xb4
> > [ 269.785088] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> > [ 269.785090] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.785091] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> >
> >
> > Config:
> > http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/config-3.8.0-rc1
> >
> > dmesg:
> > http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/dmesg-3.8.0-rc1.txt
> >
> >
> > Found similar report:
> > http://marc.info/?l=linux-kernel&m=135546308908700&w=2
> >
> > Regards
> >
> > --
> > Maciej Rutecki
> > http://www.mrutecki.pl
> > --
> > To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
> > the body of a message to majordomo@vger.kernel.org
> > More majordomo info at http://vger.kernel.org/majordomo-info.html
> > Please read the FAQ at http://www.tux.org/lkml/
>
> --
> To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
> the body of a message to majordomo@vger.kernel.org
> More majordomo info at http://vger.kernel.org/majordomo-info.html
> Please read the FAQ at http://www.tux.org/lkml/
^ permalink raw reply [flat|nested] 16+ messages in thread
* [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ]
@ 2012-12-27 8:36 ` Shawn Guo
0 siblings, 0 replies; 16+ messages in thread
From: Shawn Guo @ 2012-12-27 8:36 UTC (permalink / raw)
To: linux-arm-kernel
On Wed, Dec 26, 2012 at 10:34:39AM +0800, Shawn Guo wrote:
> It seems that I'm running into the same locking issue. My setup is:
>
> - i.MX28 (ARM)
> - v3.8-rc1
> - mxs_defconfig
- The warning is seen when LCD is blanking
>
The warning disappears after reverting patch daee779 (console: implement
lockdep support for console_lock). Is it suggesting that the mxs
frame buffer driver (drivers/video/mxsfb.c) is doing something bad?
Shawn
>
> [ 602.229899] ======================================================
> [ 602.229905] [ INFO: possible circular locking dependency detected ]
> [ 602.229926] 3.8.0-rc1-00003-gde4ae7f #767 Not tainted
> [ 602.229933] -------------------------------------------------------
> [ 602.229951] kworker/0:1/21 is trying to acquire lock:
> [ 602.230037] ((fb_notifier_list).rwsem){.+.+.+}, at: [<c0041f34>] __blocking_notifier_call_chain+0x2c/0x60
> [ 602.230047]
> [ 602.230047] but task is already holding lock:
> [ 602.230090] (console_lock){+.+.+.}, at: [<c02a1d60>] console_callback+0xc/0x12c
> [ 602.230098]
> [ 602.230098] which lock already depends on the new lock.
> [ 602.230098]
> [ 602.230104]
> [ 602.230104] the existing dependency chain (in reverse order) is:
> [ 602.230126]
> [ 602.230126] -> #1 (console_lock){+.+.+.}:
> [ 602.230174] [<c005cb20>] lock_acquire+0x9c/0x124
> [ 602.230205] [<c001dc78>] console_lock+0x58/0x6c
> [ 602.230250] [<c029ea60>] register_con_driver+0x38/0x138
> [ 602.230284] [<c02a0018>] take_over_console+0x18/0x44
> [ 602.230314] [<c027bc80>] fbcon_takeover+0x64/0xc8
> [ 602.230352] [<c0041c94>] notifier_call_chain+0x44/0x80
> [ 602.230386] [<c0041f50>] __blocking_notifier_call_chain+0x48/0x60
> [ 602.230416] [<c0041f80>] blocking_notifier_call_chain+0x18/0x20
> [ 602.230459] [<c0275efc>] register_framebuffer+0x170/0x250
> [ 602.230492] [<c02837f4>] mxsfb_probe+0x574/0x738
> [ 602.230528] [<c02b276c>] platform_drv_probe+0x14/0x18
> [ 602.230556] [<c02b14cc>] driver_probe_device+0x78/0x20c
> [ 602.230583] [<c02b16f4>] __driver_attach+0x94/0x98
> [ 602.230610] [<c02afdb4>] bus_for_each_dev+0x54/0x7c
> [ 602.230636] [<c02b0d14>] bus_add_driver+0x180/0x250
> [ 602.230662] [<c02b1bb8>] driver_register+0x78/0x144
> [ 602.230690] [<c00087c8>] do_one_initcall+0x30/0x16c
> [ 602.230721] [<c0428fcc>] kernel_init+0xf4/0x290
> [ 602.230756] [<c000e9c8>] ret_from_fork+0x14/0x2c
> [ 602.230781]
> [ 602.230781] -> #0 ((fb_notifier_list).rwsem){.+.+.+}:
> [ 602.230825] [<c005bfa0>] __lock_acquire+0x1354/0x19b0
> [ 602.230854] [<c005cb20>] lock_acquire+0x9c/0x124
> [ 602.230895] [<c0430148>] down_read+0x3c/0x4c
> [ 602.230933] [<c0041f34>] __blocking_notifier_call_chain+0x2c/0x60
> [ 602.230962] [<c0041f80>] blocking_notifier_call_chain+0x18/0x20
> [ 602.230997] [<c0274a78>] fb_blank+0x34/0x98
> [ 602.231024] [<c027c7b8>] fbcon_blank+0x1dc/0x27c
> [ 602.231065] [<c029f194>] do_blank_screen+0x1b0/0x268
> [ 602.231093] [<c02a1dbc>] console_callback+0x68/0x12c
> [ 602.231121] [<c00368c0>] process_one_work+0x1a8/0x560
> [ 602.231145] [<c0036fd8>] worker_thread+0x160/0x480
> [ 602.231180] [<c003c040>] kthread+0xa4/0xb0
> [ 602.231210] [<c000e9c8>] ret_from_fork+0x14/0x2c
> [ 602.231218]
> [ 602.231218] other info that might help us debug this:
> [ 602.231218]
> [ 602.231225] Possible unsafe locking scenario:
> [ 602.231225]
> [ 602.231230] CPU0 CPU1
> [ 602.231235] ---- ----
> [ 602.231249] lock(console_lock);
> [ 602.231263] lock((fb_notifier_list).rwsem);
> [ 602.231275] lock(console_lock);
> [ 602.231287] lock((fb_notifier_list).rwsem);
> [ 602.231292]
> [ 602.231292] *** DEADLOCK ***
> [ 602.231292]
> [ 602.231305] 3 locks held by kworker/0:1/21:
> [ 602.231345] #0: (events){.+.+.+}, at: [<c0036840>] process_one_work+0x128/0x560
> [ 602.231388] #1: (console_work){+.+...}, at: [<c0036840>] process_one_work+0x128/0x560
> [ 602.231430] #2: (console_lock){+.+.+.}, at: [<c02a1d60>] console_callback+0xc/0x12c
> [ 602.231437]
> [ 602.231437] stack backtrace:
> [ 602.231491] [<c0013e58>] (unwind_backtrace+0x0/0xf0) from [<c042b0e4>] (print_circular_bug+0x254/0x2a0)
> [ 602.231547] [<c042b0e4>] (print_circular_bug+0x254/0x2a0) from [<c005bfa0>] (__lock_acquire+0x1354/0x19b0)
> [ 602.231596] [<c005bfa0>] (__lock_acquire+0x1354/0x19b0) from [<c005cb20>] (lock_acquire+0x9c/0x124)
> [ 602.231640] [<c005cb20>] (lock_acquire+0x9c/0x124) from [<c0430148>] (down_read+0x3c/0x4c)
> [ 602.231694] [<c0430148>] (down_read+0x3c/0x4c) from [<c0041f34>] (__blocking_notifier_call_chain+0x2c/0x60)
> [ 602.231741] [<c0041f34>] (__blocking_notifier_call_chain+0x2c/0x60) from [<c0041f80>] (blocking_notifier_call_chain+0x18/0x20)
> [ 602.231791] [<c0041f80>] (blocking_notifier_call_chain+0x18/0x20) from [<c0274a78>] (fb_blank+0x34/0x98)
> [ 602.231836] [<c0274a78>] (fb_blank+0x34/0x98) from [<c027c7b8>] (fbcon_blank+0x1dc/0x27c)
> [ 602.231886] [<c027c7b8>] (fbcon_blank+0x1dc/0x27c) from [<c029f194>] (do_blank_screen+0x1b0/0x268)
> [ 602.231931] [<c029f194>] (do_blank_screen+0x1b0/0x268) from [<c02a1dbc>] (console_callback+0x68/0x12c)
> [ 602.231970] [<c02a1dbc>] (console_callback+0x68/0x12c) from [<c00368c0>] (process_one_work+0x1a8/0x560)
> [ 602.232010] [<c00368c0>] (process_one_work+0x1a8/0x560) from [<c0036fd8>] (worker_thread+0x160/0x480)
> [ 602.232054] [<c0036fd8>] (worker_thread+0x160/0x480) from [<c003c040>] (kthread+0xa4/0xb0)
> [ 602.232100] [<c003c040>] (kthread+0xa4/0xb0) from [<c000e9c8>] (ret_from_fork+0x14/0x2c)
>
>
> On Sat, Dec 22, 2012 at 04:28:26PM +0100, Maciej Rutecki wrote:
> > Got during suspend to disk:
> >
> > [ 269.784867] [ INFO: possible circular locking dependency detected ]
> > [ 269.784869] 3.8.0-rc1 #1 Not tainted
> > [ 269.784870] -------------------------------------------------------
> > [ 269.784871] kworker/u:3/56 is trying to acquire lock:
> > [ 269.784878] ((fb_notifier_list).rwsem){.+.+.+}, at: [<ffffffff81062a1d>]
> > __blocking_notifier_call_chain+0x49/0x80
> > [ 269.784879]
> > [ 269.784879] but task is already holding lock:
> > [ 269.784884] (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> > i915_drm_freeze+0x9e/0xbb
> > [ 269.784884]
> > [ 269.784884] which lock already depends on the new lock.
> > [ 269.784884]
> > [ 269.784885]
> > [ 269.784885] the existing dependency chain (in reverse order) is:
> > [ 269.784887]
> > [ 269.784887] -> #1 (console_lock){+.+.+.}:
> > [ 269.784890] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.784893] [<ffffffff810405a1>] console_lock+0x59/0x5b
> > [ 269.784897] [<ffffffff812ba125>] register_con_driver+0x36/0x128
> > [ 269.784899] [<ffffffff812bb27e>] take_over_console+0x1e/0x45
> > [ 269.784903] [<ffffffff81257a04>] fbcon_takeover+0x56/0x98
> > [ 269.784906] [<ffffffff8125b857>] fbcon_event_notify+0x2c1/0x5ea
> > [ 269.784909] [<ffffffff8149a211>] notifier_call_chain+0x67/0x92
> > [ 269.784911] [<ffffffff81062a33>] __blocking_notifier_call_chain+0x5f/0x80
> > [ 269.784912] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.784915] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.784917] [<ffffffff812505d7>] register_framebuffer+0x20a/0x26e
> > [ 269.784920] [<ffffffff812d3ca0>]
> > drm_fb_helper_single_fb_probe+0x1ce/0x297
> > [ 269.784922] [<ffffffff812d3f40>] drm_fb_helper_initial_config+0x1d7/0x1ef
> > [ 269.784924] [<ffffffff8132cee2>] intel_fbdev_init+0x6f/0x82
> > [ 269.784927] [<ffffffff812f22f6>] i915_driver_load+0xa9e/0xc78
> > [ 269.784929] [<ffffffff812e020c>] drm_get_pci_dev+0x165/0x26d
> > [ 269.784931] [<ffffffff812ee8da>] i915_pci_probe+0x60/0x69
> > [ 269.784933] [<ffffffff8123fe8e>] local_pci_probe+0x39/0x61
> > [ 269.784935] [<ffffffff812400f5>] pci_device_probe+0xba/0xe0
> > [ 269.784938] [<ffffffff8133d3b6>] driver_probe_device+0x99/0x1c4
> > [ 269.784940] [<ffffffff8133d52f>] __driver_attach+0x4e/0x6f
> > [ 269.784942] [<ffffffff8133bae1>] bus_for_each_dev+0x52/0x84
> > [ 269.784944] [<ffffffff8133cec6>] driver_attach+0x19/0x1b
> > [ 269.784946] [<ffffffff8133cb65>] bus_add_driver+0xdf/0x203
> > [ 269.784948] [<ffffffff8133dad3>] driver_register+0x8e/0x114
> > [ 269.784952] [<ffffffff8123f581>] __pci_register_driver+0x5d/0x62
> > [ 269.784953] [<ffffffff812e0395>] drm_pci_init+0x81/0xe6
> > [ 269.784957] [<ffffffff81af7612>] i915_init+0x66/0x68
> > [ 269.784959] [<ffffffff810020b4>] do_one_initcall+0x7a/0x136
> > [ 269.784962] [<ffffffff8147ceaa>] kernel_init+0x141/0x296
> > [ 269.784964] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.784966]
> > [ 269.784966] -> #0 ((fb_notifier_list).rwsem){.+.+.+}:
> > [ 269.784967] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> > [ 269.784969] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.784971] [<ffffffff81495092>] down_read+0x34/0x43
> > [ 269.784973] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> > [ 269.784975] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.784977] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.784979] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> > [ 269.784981] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> > [ 269.784983] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> > [ 269.784985] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> > [ 269.784987] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> > [ 269.784990] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> > [ 269.784993] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> > [ 269.784995] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> > [ 269.784997] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> > [ 269.785000] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> > [ 269.785002] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> > [ 269.785004] [<ffffffff8105d416>] kthread+0xac/0xb4
> > [ 269.785006] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.785006]
> > [ 269.785006] other info that might help us debug this:
> > [ 269.785006]
> > [ 269.785007] Possible unsafe locking scenario:
> > [ 269.785007]
> > [ 269.785008] CPU0 CPU1
> > [ 269.785008] ---- ----
> > [ 269.785009] lock(console_lock);
> > [ 269.785010] lock((fb_notifier_list).rwsem);
> > [ 269.785012] lock(console_lock);
> > [ 269.785013] lock((fb_notifier_list).rwsem);
> > [ 269.785013]
> > [ 269.785013] *** DEADLOCK ***
> > [ 269.785013]
> > [ 269.785014] 4 locks held by kworker/u:3/56:
> > [ 269.785018] #0: (events_unbound){.+.+.+}, at: [<ffffffff81058d77>]
> > process_one_work+0x154/0x38e
> > [ 269.785021] #1: ((&entry->work)){+.+.+.}, at: [<ffffffff81058d77>]
> > process_one_work+0x154/0x38e
> > [ 269.785024] #2: (&__lockdep_no_validate__){......}, at: [<ffffffff81342d85>]
> > device_lock+0xf/0x11
> > [ 269.785027] #3: (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> > i915_drm_freeze+0x9e/0xbb
> > [ 269.785028]
> > [ 269.785028] stack backtrace:
> > [ 269.785029] Pid: 56, comm: kworker/u:3 Not tainted 3.8.0-rc1 #1
> > [ 269.785030] Call Trace:
> > [ 269.785035] [<ffffffff8148fcb5>] print_circular_bug+0x1f8/0x209
> > [ 269.785036] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> > [ 269.785038] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.785040] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785042] [<ffffffff81495092>] down_read+0x34/0x43
> > [ 269.785044] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785046] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785047] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.785050] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.785052] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> > [ 269.785054] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> > [ 269.785055] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> > [ 269.785057] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> > [ 269.785060] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> > [ 269.785062] [<ffffffff8123f6f4>] ? pci_pm_poweroff+0x9c/0x9c
> > [ 269.785064] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> > [ 269.785066] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> > [ 269.785068] [<ffffffff81089563>] ? trace_hardirqs_on_caller+0x117/0x173
> > [ 269.785070] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> > [ 269.785072] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> > [ 269.785074] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> > [ 269.785076] [<ffffffff81058d77>] ? process_one_work+0x154/0x38e
> > [ 269.785078] [<ffffffff810639c7>] ? async_schedule+0x12/0x12
> > [ 269.785080] [<ffffffff8105679f>] ? spin_lock_irq+0x9/0xb
> > [ 269.785082] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> > [ 269.785084] [<ffffffff81059162>] ? rescuer_thread+0x187/0x187
> > [ 269.785085] [<ffffffff8105d416>] kthread+0xac/0xb4
> > [ 269.785088] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> > [ 269.785090] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.785091] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> >
> >
> > Config:
> > http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/config-3.8.0-rc1
> >
> > dmesg:
> > http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/dmesg-3.8.0-rc1.txt
> >
> >
> > Found similar report:
> > http://marc.info/?l=linux-kernel&m=135546308908700&w=2
> >
> > Regards
> >
> > --
> > Maciej Rutecki
> > http://www.mrutecki.pl
> > --
> > To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
> > the body of a message to majordomo at vger.kernel.org
> > More majordomo info at http://vger.kernel.org/majordomo-info.html
> > Please read the FAQ at http://www.tux.org/lkml/
>
> --
> To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
> the body of a message to majordomo at vger.kernel.org
> More majordomo info at http://vger.kernel.org/majordomo-info.html
> Please read the FAQ at http://www.tux.org/lkml/
^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ]
2012-12-27 8:36 ` Shawn Guo
@ 2012-12-27 13:03 ` Peter Hurley
-1 siblings, 0 replies; 16+ messages in thread
From: Peter Hurley @ 2012-12-27 13:03 UTC (permalink / raw)
To: Shawn Guo
Cc: Maciej Rutecki, LKML, Cong Wang, linux-arm-kernel, Daniel Vetter,
Greg Kroah-Hartman
On Thu, 2012-12-27 at 16:36 +0800, Shawn Guo wrote:
> On Wed, Dec 26, 2012 at 10:34:39AM +0800, Shawn Guo wrote:
> > It seems that I'm running into the same locking issue. My setup is:
> >
> > - i.MX28 (ARM)
> > - v3.8-rc1
> > - mxs_defconfig
> - The warning is seen when LCD is blanking
> >
>
> The warning disappears after reverting patch daee779 (console: implement
> lockdep support for console_lock). Is it suggesting that the mxs
> frame buffer driver (drivers/video/mxsfb.c) is doing something bad?
>
> Shawn
>
> >
> > [ 602.229899] ======================================================
> > [ 602.229905] [ INFO: possible circular locking dependency detected ]
> > [ 602.229926] 3.8.0-rc1-00003-gde4ae7f #767 Not tainted
> > [ 602.229933] -------------------------------------------------------
> > [ 602.229951] kworker/0:1/21 is trying to acquire lock:
> > [ 602.230037] ((fb_notifier_list).rwsem){.+.+.+}, at: [<c0041f34>] __blocking_notifier_call_chain+0x2c/0x60
You want this patch https://patchwork.kernel.org/patch/1757061/
^ permalink raw reply [flat|nested] 16+ messages in thread
* [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ]
@ 2012-12-27 13:03 ` Peter Hurley
0 siblings, 0 replies; 16+ messages in thread
From: Peter Hurley @ 2012-12-27 13:03 UTC (permalink / raw)
To: linux-arm-kernel
On Thu, 2012-12-27 at 16:36 +0800, Shawn Guo wrote:
> On Wed, Dec 26, 2012 at 10:34:39AM +0800, Shawn Guo wrote:
> > It seems that I'm running into the same locking issue. My setup is:
> >
> > - i.MX28 (ARM)
> > - v3.8-rc1
> > - mxs_defconfig
> - The warning is seen when LCD is blanking
> >
>
> The warning disappears after reverting patch daee779 (console: implement
> lockdep support for console_lock). Is it suggesting that the mxs
> frame buffer driver (drivers/video/mxsfb.c) is doing something bad?
>
> Shawn
>
> >
> > [ 602.229899] ======================================================
> > [ 602.229905] [ INFO: possible circular locking dependency detected ]
> > [ 602.229926] 3.8.0-rc1-00003-gde4ae7f #767 Not tainted
> > [ 602.229933] -------------------------------------------------------
> > [ 602.229951] kworker/0:1/21 is trying to acquire lock:
> > [ 602.230037] ((fb_notifier_list).rwsem){.+.+.+}, at: [<c0041f34>] __blocking_notifier_call_chain+0x2c/0x60
You want this patch https://patchwork.kernel.org/patch/1757061/
^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ]
2012-12-27 13:03 ` Peter Hurley
@ 2012-12-28 11:45 ` Shawn Guo
-1 siblings, 0 replies; 16+ messages in thread
From: Shawn Guo @ 2012-12-28 11:45 UTC (permalink / raw)
To: Peter Hurley
Cc: Maciej Rutecki, LKML, Cong Wang, linux-arm-kernel, Daniel Vetter,
Greg Kroah-Hartman
On Thu, Dec 27, 2012 at 08:03:24AM -0500, Peter Hurley wrote:
> On Thu, 2012-12-27 at 16:36 +0800, Shawn Guo wrote:
> > On Wed, Dec 26, 2012 at 10:34:39AM +0800, Shawn Guo wrote:
> > > It seems that I'm running into the same locking issue. My setup is:
> > >
> > > - i.MX28 (ARM)
> > > - v3.8-rc1
> > > - mxs_defconfig
> > - The warning is seen when LCD is blanking
> > >
> >
> > The warning disappears after reverting patch daee779 (console: implement
> > lockdep support for console_lock). Is it suggesting that the mxs
> > frame buffer driver (drivers/video/mxsfb.c) is doing something bad?
> >
> > Shawn
> >
> > >
> > > [ 602.229899] ======================================================
> > > [ 602.229905] [ INFO: possible circular locking dependency detected ]
> > > [ 602.229926] 3.8.0-rc1-00003-gde4ae7f #767 Not tainted
> > > [ 602.229933] -------------------------------------------------------
> > > [ 602.229951] kworker/0:1/21 is trying to acquire lock:
> > > [ 602.230037] ((fb_notifier_list).rwsem){.+.+.+}, at: [<c0041f34>] __blocking_notifier_call_chain+0x2c/0x60
>
> You want this patch https://patchwork.kernel.org/patch/1757061/
>
Thanks for the pointer, Peter. It does fix the problem for me.
Shawn
^ permalink raw reply [flat|nested] 16+ messages in thread
* [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ]
@ 2012-12-28 11:45 ` Shawn Guo
0 siblings, 0 replies; 16+ messages in thread
From: Shawn Guo @ 2012-12-28 11:45 UTC (permalink / raw)
To: linux-arm-kernel
On Thu, Dec 27, 2012 at 08:03:24AM -0500, Peter Hurley wrote:
> On Thu, 2012-12-27 at 16:36 +0800, Shawn Guo wrote:
> > On Wed, Dec 26, 2012 at 10:34:39AM +0800, Shawn Guo wrote:
> > > It seems that I'm running into the same locking issue. My setup is:
> > >
> > > - i.MX28 (ARM)
> > > - v3.8-rc1
> > > - mxs_defconfig
> > - The warning is seen when LCD is blanking
> > >
> >
> > The warning disappears after reverting patch daee779 (console: implement
> > lockdep support for console_lock). Is it suggesting that the mxs
> > frame buffer driver (drivers/video/mxsfb.c) is doing something bad?
> >
> > Shawn
> >
> > >
> > > [ 602.229899] ======================================================
> > > [ 602.229905] [ INFO: possible circular locking dependency detected ]
> > > [ 602.229926] 3.8.0-rc1-00003-gde4ae7f #767 Not tainted
> > > [ 602.229933] -------------------------------------------------------
> > > [ 602.229951] kworker/0:1/21 is trying to acquire lock:
> > > [ 602.230037] ((fb_notifier_list).rwsem){.+.+.+}, at: [<c0041f34>] __blocking_notifier_call_chain+0x2c/0x60
>
> You want this patch https://patchwork.kernel.org/patch/1757061/
>
Thanks for the pointer, Peter. It does fix the problem for me.
Shawn
^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ]
2012-12-23 21:34 ` Christian Kujau
@ 2013-01-04 4:31 ` Christian Kujau
-1 siblings, 0 replies; 16+ messages in thread
From: Christian Kujau @ 2013-01-04 4:31 UTC (permalink / raw)
To: Maciej Rutecki; +Cc: LKML, Cong Wang, linuxppc-dev, zhong
On Sun, 23 Dec 2012 at 13:34, Christian Kujau wrote:
> On Sat, 22 Dec 2012 at 16:28, Maciej Rutecki wrote:
> > Got during suspend to disk:
>
> I got a similar message on a powerpc G4 system, right after bootup (no
> suspend involved):
>
> http://nerdbynature.de/bits/3.8.0-rc1/
FWIW, this is still present with 3.8.0-rc2.
C.
> [ 97.803049] ======================================================
> [ 97.803051] [ INFO: possible circular locking dependency detected ]
> [ 97.803059] 3.8.0-rc1-dirty #2 Not tainted
> [ 97.803060] -------------------------------------------------------
> [ 97.803066] kworker/0:1/235 is trying to acquire lock:
> [ 97.803097] ((fb_notifier_list).rwsem){.+.+.+}, at: [<c00606a0>] __blocking_notifier_call_chain+0x44/0x88
> [ 97.803099]
> [ 97.803099] but task is already holding lock:
> [ 97.803110] (console_lock){+.+.+.}, at: [<c03b9fd0>] console_callback+0x20/0x194
> [ 97.803112]
> [ 97.803112] which lock already depends on the new lock.
>
> ...and on it goes. Please see the URL above for the whole dmesg and
> .config.
>
> @Li Zhong: I have applied your fix for the "MAX_STACK_TRACE_ENTRIES too
> low" warning[0] to 3.8-rc1 (hence the -dirty flag), but in the
> backtrace "ret_from_kernel_thread" shows up again. FWIW, your
> patch helped to make the "MAX_STACK_TRACE_ENTRIES too low"
> warning go away in 3.7.0-rc7 and it did not re-appear ever
> since.
>
> Thanks,
> Christian.
>
> [0] http://lkml.indiana.edu/hypermail/linux/kernel/1211.3/01917.html
>
> > [ 269.784867] [ INFO: possible circular locking dependency detected ]
> > [ 269.784869] 3.8.0-rc1 #1 Not tainted
> > [ 269.784870] -------------------------------------------------------
> > [ 269.784871] kworker/u:3/56 is trying to acquire lock:
> > [ 269.784878] ((fb_notifier_list).rwsem){.+.+.+}, at: [<ffffffff81062a1d>]
> > __blocking_notifier_call_chain+0x49/0x80
> > [ 269.784879]
> > [ 269.784879] but task is already holding lock:
> > [ 269.784884] (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> > i915_drm_freeze+0x9e/0xbb
> > [ 269.784884]
> > [ 269.784884] which lock already depends on the new lock.
> > [ 269.784884]
> > [ 269.784885]
> > [ 269.784885] the existing dependency chain (in reverse order) is:
> > [ 269.784887]
> > [ 269.784887] -> #1 (console_lock){+.+.+.}:
> > [ 269.784890] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.784893] [<ffffffff810405a1>] console_lock+0x59/0x5b
> > [ 269.784897] [<ffffffff812ba125>] register_con_driver+0x36/0x128
> > [ 269.784899] [<ffffffff812bb27e>] take_over_console+0x1e/0x45
> > [ 269.784903] [<ffffffff81257a04>] fbcon_takeover+0x56/0x98
> > [ 269.784906] [<ffffffff8125b857>] fbcon_event_notify+0x2c1/0x5ea
> > [ 269.784909] [<ffffffff8149a211>] notifier_call_chain+0x67/0x92
> > [ 269.784911] [<ffffffff81062a33>] __blocking_notifier_call_chain+0x5f/0x80
> > [ 269.784912] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.784915] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.784917] [<ffffffff812505d7>] register_framebuffer+0x20a/0x26e
> > [ 269.784920] [<ffffffff812d3ca0>]
> > drm_fb_helper_single_fb_probe+0x1ce/0x297
> > [ 269.784922] [<ffffffff812d3f40>] drm_fb_helper_initial_config+0x1d7/0x1ef
> > [ 269.784924] [<ffffffff8132cee2>] intel_fbdev_init+0x6f/0x82
> > [ 269.784927] [<ffffffff812f22f6>] i915_driver_load+0xa9e/0xc78
> > [ 269.784929] [<ffffffff812e020c>] drm_get_pci_dev+0x165/0x26d
> > [ 269.784931] [<ffffffff812ee8da>] i915_pci_probe+0x60/0x69
> > [ 269.784933] [<ffffffff8123fe8e>] local_pci_probe+0x39/0x61
> > [ 269.784935] [<ffffffff812400f5>] pci_device_probe+0xba/0xe0
> > [ 269.784938] [<ffffffff8133d3b6>] driver_probe_device+0x99/0x1c4
> > [ 269.784940] [<ffffffff8133d52f>] __driver_attach+0x4e/0x6f
> > [ 269.784942] [<ffffffff8133bae1>] bus_for_each_dev+0x52/0x84
> > [ 269.784944] [<ffffffff8133cec6>] driver_attach+0x19/0x1b
> > [ 269.784946] [<ffffffff8133cb65>] bus_add_driver+0xdf/0x203
> > [ 269.784948] [<ffffffff8133dad3>] driver_register+0x8e/0x114
> > [ 269.784952] [<ffffffff8123f581>] __pci_register_driver+0x5d/0x62
> > [ 269.784953] [<ffffffff812e0395>] drm_pci_init+0x81/0xe6
> > [ 269.784957] [<ffffffff81af7612>] i915_init+0x66/0x68
> > [ 269.784959] [<ffffffff810020b4>] do_one_initcall+0x7a/0x136
> > [ 269.784962] [<ffffffff8147ceaa>] kernel_init+0x141/0x296
> > [ 269.784964] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.784966]
> > [ 269.784966] -> #0 ((fb_notifier_list).rwsem){.+.+.+}:
> > [ 269.784967] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> > [ 269.784969] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.784971] [<ffffffff81495092>] down_read+0x34/0x43
> > [ 269.784973] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> > [ 269.784975] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.784977] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.784979] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> > [ 269.784981] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> > [ 269.784983] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> > [ 269.784985] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> > [ 269.784987] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> > [ 269.784990] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> > [ 269.784993] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> > [ 269.784995] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> > [ 269.784997] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> > [ 269.785000] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> > [ 269.785002] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> > [ 269.785004] [<ffffffff8105d416>] kthread+0xac/0xb4
> > [ 269.785006] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.785006]
> > [ 269.785006] other info that might help us debug this:
> > [ 269.785006]
> > [ 269.785007] Possible unsafe locking scenario:
> > [ 269.785007]
> > [ 269.785008] CPU0 CPU1
> > [ 269.785008] ---- ----
> > [ 269.785009] lock(console_lock);
> > [ 269.785010] lock((fb_notifier_list).rwsem);
> > [ 269.785012] lock(console_lock);
> > [ 269.785013] lock((fb_notifier_list).rwsem);
> > [ 269.785013]
> > [ 269.785013] *** DEADLOCK ***
> > [ 269.785013]
> > [ 269.785014] 4 locks held by kworker/u:3/56:
> > [ 269.785018] #0: (events_unbound){.+.+.+}, at: [<ffffffff81058d77>]
> > process_one_work+0x154/0x38e
> > [ 269.785021] #1: ((&entry->work)){+.+.+.}, at: [<ffffffff81058d77>]
> > process_one_work+0x154/0x38e
> > [ 269.785024] #2: (&__lockdep_no_validate__){......}, at: [<ffffffff81342d85>]
> > device_lock+0xf/0x11
> > [ 269.785027] #3: (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> > i915_drm_freeze+0x9e/0xbb
> > [ 269.785028]
> > [ 269.785028] stack backtrace:
> > [ 269.785029] Pid: 56, comm: kworker/u:3 Not tainted 3.8.0-rc1 #1
> > [ 269.785030] Call Trace:
> > [ 269.785035] [<ffffffff8148fcb5>] print_circular_bug+0x1f8/0x209
> > [ 269.785036] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> > [ 269.785038] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.785040] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785042] [<ffffffff81495092>] down_read+0x34/0x43
> > [ 269.785044] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785046] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785047] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.785050] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.785052] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> > [ 269.785054] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> > [ 269.785055] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> > [ 269.785057] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> > [ 269.785060] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> > [ 269.785062] [<ffffffff8123f6f4>] ? pci_pm_poweroff+0x9c/0x9c
> > [ 269.785064] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> > [ 269.785066] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> > [ 269.785068] [<ffffffff81089563>] ? trace_hardirqs_on_caller+0x117/0x173
> > [ 269.785070] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> > [ 269.785072] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> > [ 269.785074] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> > [ 269.785076] [<ffffffff81058d77>] ? process_one_work+0x154/0x38e
> > [ 269.785078] [<ffffffff810639c7>] ? async_schedule+0x12/0x12
> > [ 269.785080] [<ffffffff8105679f>] ? spin_lock_irq+0x9/0xb
> > [ 269.785082] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> > [ 269.785084] [<ffffffff81059162>] ? rescuer_thread+0x187/0x187
> > [ 269.785085] [<ffffffff8105d416>] kthread+0xac/0xb4
> > [ 269.785088] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> > [ 269.785090] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.785091] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> >
> >
> > Config:
> > http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/config-3.8.0-rc1
> >
> > dmesg:
> > http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/dmesg-3.8.0-rc1.txt
> >
> >
> > Found similar report:
> > http://marc.info/?l=linux-kernel&m=135546308908700&w=2
> >
> > Regards
> >
> > --
> > Maciej Rutecki
> > http://www.mrutecki.pl
> > --
> > To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
> > the body of a message to majordomo@vger.kernel.org
> > More majordomo info at http://vger.kernel.org/majordomo-info.html
> > Please read the FAQ at http://www.tux.org/lkml/
> >
>
> --
> BOFH excuse #435:
>
> Internet shut down due to maintenance
>
--
BOFH excuse #262:
Our POP server was kidnapped by a weasel.
^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ]
@ 2013-01-04 4:31 ` Christian Kujau
0 siblings, 0 replies; 16+ messages in thread
From: Christian Kujau @ 2013-01-04 4:31 UTC (permalink / raw)
To: Maciej Rutecki; +Cc: Cong Wang, linuxppc-dev, LKML, zhong
On Sun, 23 Dec 2012 at 13:34, Christian Kujau wrote:
> On Sat, 22 Dec 2012 at 16:28, Maciej Rutecki wrote:
> > Got during suspend to disk:
>
> I got a similar message on a powerpc G4 system, right after bootup (no
> suspend involved):
>
> http://nerdbynature.de/bits/3.8.0-rc1/
FWIW, this is still present with 3.8.0-rc2.
C.
> [ 97.803049] ======================================================
> [ 97.803051] [ INFO: possible circular locking dependency detected ]
> [ 97.803059] 3.8.0-rc1-dirty #2 Not tainted
> [ 97.803060] -------------------------------------------------------
> [ 97.803066] kworker/0:1/235 is trying to acquire lock:
> [ 97.803097] ((fb_notifier_list).rwsem){.+.+.+}, at: [<c00606a0>] __blocking_notifier_call_chain+0x44/0x88
> [ 97.803099]
> [ 97.803099] but task is already holding lock:
> [ 97.803110] (console_lock){+.+.+.}, at: [<c03b9fd0>] console_callback+0x20/0x194
> [ 97.803112]
> [ 97.803112] which lock already depends on the new lock.
>
> ...and on it goes. Please see the URL above for the whole dmesg and
> .config.
>
> @Li Zhong: I have applied your fix for the "MAX_STACK_TRACE_ENTRIES too
> low" warning[0] to 3.8-rc1 (hence the -dirty flag), but in the
> backtrace "ret_from_kernel_thread" shows up again. FWIW, your
> patch helped to make the "MAX_STACK_TRACE_ENTRIES too low"
> warning go away in 3.7.0-rc7 and it did not re-appear ever
> since.
>
> Thanks,
> Christian.
>
> [0] http://lkml.indiana.edu/hypermail/linux/kernel/1211.3/01917.html
>
> > [ 269.784867] [ INFO: possible circular locking dependency detected ]
> > [ 269.784869] 3.8.0-rc1 #1 Not tainted
> > [ 269.784870] -------------------------------------------------------
> > [ 269.784871] kworker/u:3/56 is trying to acquire lock:
> > [ 269.784878] ((fb_notifier_list).rwsem){.+.+.+}, at: [<ffffffff81062a1d>]
> > __blocking_notifier_call_chain+0x49/0x80
> > [ 269.784879]
> > [ 269.784879] but task is already holding lock:
> > [ 269.784884] (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> > i915_drm_freeze+0x9e/0xbb
> > [ 269.784884]
> > [ 269.784884] which lock already depends on the new lock.
> > [ 269.784884]
> > [ 269.784885]
> > [ 269.784885] the existing dependency chain (in reverse order) is:
> > [ 269.784887]
> > [ 269.784887] -> #1 (console_lock){+.+.+.}:
> > [ 269.784890] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.784893] [<ffffffff810405a1>] console_lock+0x59/0x5b
> > [ 269.784897] [<ffffffff812ba125>] register_con_driver+0x36/0x128
> > [ 269.784899] [<ffffffff812bb27e>] take_over_console+0x1e/0x45
> > [ 269.784903] [<ffffffff81257a04>] fbcon_takeover+0x56/0x98
> > [ 269.784906] [<ffffffff8125b857>] fbcon_event_notify+0x2c1/0x5ea
> > [ 269.784909] [<ffffffff8149a211>] notifier_call_chain+0x67/0x92
> > [ 269.784911] [<ffffffff81062a33>] __blocking_notifier_call_chain+0x5f/0x80
> > [ 269.784912] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.784915] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.784917] [<ffffffff812505d7>] register_framebuffer+0x20a/0x26e
> > [ 269.784920] [<ffffffff812d3ca0>]
> > drm_fb_helper_single_fb_probe+0x1ce/0x297
> > [ 269.784922] [<ffffffff812d3f40>] drm_fb_helper_initial_config+0x1d7/0x1ef
> > [ 269.784924] [<ffffffff8132cee2>] intel_fbdev_init+0x6f/0x82
> > [ 269.784927] [<ffffffff812f22f6>] i915_driver_load+0xa9e/0xc78
> > [ 269.784929] [<ffffffff812e020c>] drm_get_pci_dev+0x165/0x26d
> > [ 269.784931] [<ffffffff812ee8da>] i915_pci_probe+0x60/0x69
> > [ 269.784933] [<ffffffff8123fe8e>] local_pci_probe+0x39/0x61
> > [ 269.784935] [<ffffffff812400f5>] pci_device_probe+0xba/0xe0
> > [ 269.784938] [<ffffffff8133d3b6>] driver_probe_device+0x99/0x1c4
> > [ 269.784940] [<ffffffff8133d52f>] __driver_attach+0x4e/0x6f
> > [ 269.784942] [<ffffffff8133bae1>] bus_for_each_dev+0x52/0x84
> > [ 269.784944] [<ffffffff8133cec6>] driver_attach+0x19/0x1b
> > [ 269.784946] [<ffffffff8133cb65>] bus_add_driver+0xdf/0x203
> > [ 269.784948] [<ffffffff8133dad3>] driver_register+0x8e/0x114
> > [ 269.784952] [<ffffffff8123f581>] __pci_register_driver+0x5d/0x62
> > [ 269.784953] [<ffffffff812e0395>] drm_pci_init+0x81/0xe6
> > [ 269.784957] [<ffffffff81af7612>] i915_init+0x66/0x68
> > [ 269.784959] [<ffffffff810020b4>] do_one_initcall+0x7a/0x136
> > [ 269.784962] [<ffffffff8147ceaa>] kernel_init+0x141/0x296
> > [ 269.784964] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.784966]
> > [ 269.784966] -> #0 ((fb_notifier_list).rwsem){.+.+.+}:
> > [ 269.784967] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> > [ 269.784969] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.784971] [<ffffffff81495092>] down_read+0x34/0x43
> > [ 269.784973] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> > [ 269.784975] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.784977] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.784979] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> > [ 269.784981] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> > [ 269.784983] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> > [ 269.784985] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> > [ 269.784987] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> > [ 269.784990] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> > [ 269.784993] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> > [ 269.784995] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> > [ 269.784997] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> > [ 269.785000] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> > [ 269.785002] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> > [ 269.785004] [<ffffffff8105d416>] kthread+0xac/0xb4
> > [ 269.785006] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.785006]
> > [ 269.785006] other info that might help us debug this:
> > [ 269.785006]
> > [ 269.785007] Possible unsafe locking scenario:
> > [ 269.785007]
> > [ 269.785008] CPU0 CPU1
> > [ 269.785008] ---- ----
> > [ 269.785009] lock(console_lock);
> > [ 269.785010] lock((fb_notifier_list).rwsem);
> > [ 269.785012] lock(console_lock);
> > [ 269.785013] lock((fb_notifier_list).rwsem);
> > [ 269.785013]
> > [ 269.785013] *** DEADLOCK ***
> > [ 269.785013]
> > [ 269.785014] 4 locks held by kworker/u:3/56:
> > [ 269.785018] #0: (events_unbound){.+.+.+}, at: [<ffffffff81058d77>]
> > process_one_work+0x154/0x38e
> > [ 269.785021] #1: ((&entry->work)){+.+.+.}, at: [<ffffffff81058d77>]
> > process_one_work+0x154/0x38e
> > [ 269.785024] #2: (&__lockdep_no_validate__){......}, at: [<ffffffff81342d85>]
> > device_lock+0xf/0x11
> > [ 269.785027] #3: (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> > i915_drm_freeze+0x9e/0xbb
> > [ 269.785028]
> > [ 269.785028] stack backtrace:
> > [ 269.785029] Pid: 56, comm: kworker/u:3 Not tainted 3.8.0-rc1 #1
> > [ 269.785030] Call Trace:
> > [ 269.785035] [<ffffffff8148fcb5>] print_circular_bug+0x1f8/0x209
> > [ 269.785036] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> > [ 269.785038] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.785040] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785042] [<ffffffff81495092>] down_read+0x34/0x43
> > [ 269.785044] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785046] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785047] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.785050] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.785052] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> > [ 269.785054] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> > [ 269.785055] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> > [ 269.785057] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> > [ 269.785060] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> > [ 269.785062] [<ffffffff8123f6f4>] ? pci_pm_poweroff+0x9c/0x9c
> > [ 269.785064] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> > [ 269.785066] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> > [ 269.785068] [<ffffffff81089563>] ? trace_hardirqs_on_caller+0x117/0x173
> > [ 269.785070] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> > [ 269.785072] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> > [ 269.785074] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> > [ 269.785076] [<ffffffff81058d77>] ? process_one_work+0x154/0x38e
> > [ 269.785078] [<ffffffff810639c7>] ? async_schedule+0x12/0x12
> > [ 269.785080] [<ffffffff8105679f>] ? spin_lock_irq+0x9/0xb
> > [ 269.785082] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> > [ 269.785084] [<ffffffff81059162>] ? rescuer_thread+0x187/0x187
> > [ 269.785085] [<ffffffff8105d416>] kthread+0xac/0xb4
> > [ 269.785088] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> > [ 269.785090] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.785091] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> >
> >
> > Config:
> > http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/config-3.8.0-rc1
> >
> > dmesg:
> > http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/dmesg-3.8.0-rc1.txt
> >
> >
> > Found similar report:
> > http://marc.info/?l=linux-kernel&m=135546308908700&w=2
> >
> > Regards
> >
> > --
> > Maciej Rutecki
> > http://www.mrutecki.pl
> > --
> > To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
> > the body of a message to majordomo@vger.kernel.org
> > More majordomo info at http://vger.kernel.org/majordomo-info.html
> > Please read the FAQ at http://www.tux.org/lkml/
> >
>
> --
> BOFH excuse #435:
>
> Internet shut down due to maintenance
>
--
BOFH excuse #262:
Our POP server was kidnapped by a weasel.
^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ]
2012-12-23 21:34 ` Christian Kujau
` (2 preceding siblings ...)
(?)
@ 2013-01-27 23:02 ` Christian Kujau
-1 siblings, 0 replies; 16+ messages in thread
From: Christian Kujau @ 2013-01-27 23:02 UTC (permalink / raw)
To: Maciej Rutecki; +Cc: Cong Wang, linux-fbdev, linuxppc-dev, LKML
On Sun, 23 Dec 2012 at 13:34, Christian Kujau wrote:
> On Sat, 22 Dec 2012 at 16:28, Maciej Rutecki wrote:
> > Got during suspend to disk:
>
> I got a similar message on a powerpc G4 system, right after bootup (no
> suspend involved):
>
> http://nerdbynature.de/bits/3.8.0-rc1/
This is still present in 3.8-rc5, right after bootup. Any thoughts?
Thanks,
C.
>
> [ 97.803049] ======================================================
> [ 97.803051] [ INFO: possible circular locking dependency detected ]
> [ 97.803059] 3.8.0-rc1-dirty #2 Not tainted
> [ 97.803060] -------------------------------------------------------
> [ 97.803066] kworker/0:1/235 is trying to acquire lock:
> [ 97.803097] ((fb_notifier_list).rwsem){.+.+.+}, at: [<c00606a0>] __blocking_notifier_call_chain+0x44/0x88
> [ 97.803099]
> [ 97.803099] but task is already holding lock:
> [ 97.803110] (console_lock){+.+.+.}, at: [<c03b9fd0>] console_callback+0x20/0x194
> [ 97.803112]
> [ 97.803112] which lock already depends on the new lock.
>
> ...and on it goes. Please see the URL above for the whole dmesg and
> .config.
>
> @Li Zhong: I have applied your fix for the "MAX_STACK_TRACE_ENTRIES too
> low" warning[0] to 3.8-rc1 (hence the -dirty flag), but in the
> backtrace "ret_from_kernel_thread" shows up again. FWIW, your
> patch helped to make the "MAX_STACK_TRACE_ENTRIES too low"
> warning go away in 3.7.0-rc7 and it did not re-appear ever
> since.
>
> Thanks,
> Christian.
>
> [0] http://lkml.indiana.edu/hypermail/linux/kernel/1211.3/01917.html
>
> > [ 269.784867] [ INFO: possible circular locking dependency detected ]
> > [ 269.784869] 3.8.0-rc1 #1 Not tainted
> > [ 269.784870] -------------------------------------------------------
> > [ 269.784871] kworker/u:3/56 is trying to acquire lock:
> > [ 269.784878] ((fb_notifier_list).rwsem){.+.+.+}, at: [<ffffffff81062a1d>]
> > __blocking_notifier_call_chain+0x49/0x80
> > [ 269.784879]
> > [ 269.784879] but task is already holding lock:
> > [ 269.784884] (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> > i915_drm_freeze+0x9e/0xbb
> > [ 269.784884]
> > [ 269.784884] which lock already depends on the new lock.
> > [ 269.784884]
> > [ 269.784885]
> > [ 269.784885] the existing dependency chain (in reverse order) is:
> > [ 269.784887]
> > [ 269.784887] -> #1 (console_lock){+.+.+.}:
> > [ 269.784890] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.784893] [<ffffffff810405a1>] console_lock+0x59/0x5b
> > [ 269.784897] [<ffffffff812ba125>] register_con_driver+0x36/0x128
> > [ 269.784899] [<ffffffff812bb27e>] take_over_console+0x1e/0x45
> > [ 269.784903] [<ffffffff81257a04>] fbcon_takeover+0x56/0x98
> > [ 269.784906] [<ffffffff8125b857>] fbcon_event_notify+0x2c1/0x5ea
> > [ 269.784909] [<ffffffff8149a211>] notifier_call_chain+0x67/0x92
> > [ 269.784911] [<ffffffff81062a33>] __blocking_notifier_call_chain+0x5f/0x80
> > [ 269.784912] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.784915] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.784917] [<ffffffff812505d7>] register_framebuffer+0x20a/0x26e
> > [ 269.784920] [<ffffffff812d3ca0>]
> > drm_fb_helper_single_fb_probe+0x1ce/0x297
> > [ 269.784922] [<ffffffff812d3f40>] drm_fb_helper_initial_config+0x1d7/0x1ef
> > [ 269.784924] [<ffffffff8132cee2>] intel_fbdev_init+0x6f/0x82
> > [ 269.784927] [<ffffffff812f22f6>] i915_driver_load+0xa9e/0xc78
> > [ 269.784929] [<ffffffff812e020c>] drm_get_pci_dev+0x165/0x26d
> > [ 269.784931] [<ffffffff812ee8da>] i915_pci_probe+0x60/0x69
> > [ 269.784933] [<ffffffff8123fe8e>] local_pci_probe+0x39/0x61
> > [ 269.784935] [<ffffffff812400f5>] pci_device_probe+0xba/0xe0
> > [ 269.784938] [<ffffffff8133d3b6>] driver_probe_device+0x99/0x1c4
> > [ 269.784940] [<ffffffff8133d52f>] __driver_attach+0x4e/0x6f
> > [ 269.784942] [<ffffffff8133bae1>] bus_for_each_dev+0x52/0x84
> > [ 269.784944] [<ffffffff8133cec6>] driver_attach+0x19/0x1b
> > [ 269.784946] [<ffffffff8133cb65>] bus_add_driver+0xdf/0x203
> > [ 269.784948] [<ffffffff8133dad3>] driver_register+0x8e/0x114
> > [ 269.784952] [<ffffffff8123f581>] __pci_register_driver+0x5d/0x62
> > [ 269.784953] [<ffffffff812e0395>] drm_pci_init+0x81/0xe6
> > [ 269.784957] [<ffffffff81af7612>] i915_init+0x66/0x68
> > [ 269.784959] [<ffffffff810020b4>] do_one_initcall+0x7a/0x136
> > [ 269.784962] [<ffffffff8147ceaa>] kernel_init+0x141/0x296
> > [ 269.784964] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.784966]
> > [ 269.784966] -> #0 ((fb_notifier_list).rwsem){.+.+.+}:
> > [ 269.784967] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> > [ 269.784969] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.784971] [<ffffffff81495092>] down_read+0x34/0x43
> > [ 269.784973] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> > [ 269.784975] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.784977] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.784979] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> > [ 269.784981] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> > [ 269.784983] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> > [ 269.784985] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> > [ 269.784987] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> > [ 269.784990] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> > [ 269.784993] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> > [ 269.784995] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> > [ 269.784997] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> > [ 269.785000] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> > [ 269.785002] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> > [ 269.785004] [<ffffffff8105d416>] kthread+0xac/0xb4
> > [ 269.785006] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.785006]
> > [ 269.785006] other info that might help us debug this:
> > [ 269.785006]
> > [ 269.785007] Possible unsafe locking scenario:
> > [ 269.785007]
> > [ 269.785008] CPU0 CPU1
> > [ 269.785008] ---- ----
> > [ 269.785009] lock(console_lock);
> > [ 269.785010] lock((fb_notifier_list).rwsem);
> > [ 269.785012] lock(console_lock);
> > [ 269.785013] lock((fb_notifier_list).rwsem);
> > [ 269.785013]
> > [ 269.785013] *** DEADLOCK ***
> > [ 269.785013]
> > [ 269.785014] 4 locks held by kworker/u:3/56:
> > [ 269.785018] #0: (events_unbound){.+.+.+}, at: [<ffffffff81058d77>]
> > process_one_work+0x154/0x38e
> > [ 269.785021] #1: ((&entry->work)){+.+.+.}, at: [<ffffffff81058d77>]
> > process_one_work+0x154/0x38e
> > [ 269.785024] #2: (&__lockdep_no_validate__){......}, at: [<ffffffff81342d85>]
> > device_lock+0xf/0x11
> > [ 269.785027] #3: (console_lock){+.+.+.}, at: [<ffffffff812ee4ce>]
> > i915_drm_freeze+0x9e/0xbb
> > [ 269.785028]
> > [ 269.785028] stack backtrace:
> > [ 269.785029] Pid: 56, comm: kworker/u:3 Not tainted 3.8.0-rc1 #1
> > [ 269.785030] Call Trace:
> > [ 269.785035] [<ffffffff8148fcb5>] print_circular_bug+0x1f8/0x209
> > [ 269.785036] [<ffffffff81088955>] __lock_acquire+0xa7e/0xddd
> > [ 269.785038] [<ffffffff810890e4>] lock_acquire+0x95/0x105
> > [ 269.785040] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785042] [<ffffffff81495092>] down_read+0x34/0x43
> > [ 269.785044] [<ffffffff81062a1d>] ? __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785046] [<ffffffff81062a1d>] __blocking_notifier_call_chain+0x49/0x80
> > [ 269.785047] [<ffffffff81062a63>] blocking_notifier_call_chain+0xf/0x11
> > [ 269.785050] [<ffffffff8124e85e>] fb_notifier_call_chain+0x16/0x18
> > [ 269.785052] [<ffffffff8124ec47>] fb_set_suspend+0x22/0x4d
> > [ 269.785054] [<ffffffff8132cfe3>] intel_fbdev_set_suspend+0x20/0x22
> > [ 269.785055] [<ffffffff812ee4db>] i915_drm_freeze+0xab/0xbb
> > [ 269.785057] [<ffffffff812eea82>] i915_pm_freeze+0x3d/0x41
> > [ 269.785060] [<ffffffff8123f759>] pci_pm_freeze+0x65/0x8d
> > [ 269.785062] [<ffffffff8123f6f4>] ? pci_pm_poweroff+0x9c/0x9c
> > [ 269.785064] [<ffffffff81342f20>] dpm_run_callback.isra.3+0x27/0x56
> > [ 269.785066] [<ffffffff81343085>] __device_suspend+0x136/0x1b1
> > [ 269.785068] [<ffffffff81089563>] ? trace_hardirqs_on_caller+0x117/0x173
> > [ 269.785070] [<ffffffff8134311a>] async_suspend+0x1a/0x58
> > [ 269.785072] [<ffffffff81063a6b>] async_run_entry_fn+0xa4/0x17c
> > [ 269.785074] [<ffffffff81058df2>] process_one_work+0x1cf/0x38e
> > [ 269.785076] [<ffffffff81058d77>] ? process_one_work+0x154/0x38e
> > [ 269.785078] [<ffffffff810639c7>] ? async_schedule+0x12/0x12
> > [ 269.785080] [<ffffffff8105679f>] ? spin_lock_irq+0x9/0xb
> > [ 269.785082] [<ffffffff81059290>] worker_thread+0x12e/0x1cc
> > [ 269.785084] [<ffffffff81059162>] ? rescuer_thread+0x187/0x187
> > [ 269.785085] [<ffffffff8105d416>] kthread+0xac/0xb4
> > [ 269.785088] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> > [ 269.785090] [<ffffffff8149c7bc>] ret_from_fork+0x7c/0xb0
> > [ 269.785091] [<ffffffff8105d36a>] ? __kthread_parkme+0x60/0x60
> >
> >
> > Config:
> > http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/config-3.8.0-rc1
> >
> > dmesg:
> > http://mrutecki.pl/download/kernel/3.8.0-rc1/s2disk/dmesg-3.8.0-rc1.txt
> >
> >
> > Found similar report:
> > http://marc.info/?l=linux-kernel&m=135546308908700&w=2
> >
> > Regards
> >
> > --
> > Maciej Rutecki
> > http://www.mrutecki.pl
> > --
> > To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
> > the body of a message to majordomo@vger.kernel.org
> > More majordomo info at http://vger.kernel.org/majordomo-info.html
> > Please read the FAQ at http://www.tux.org/lkml/
> >
>
> --
> BOFH excuse #435:
>
> Internet shut down due to maintenance
>
--
BOFH excuse #238:
You did wha... oh _dear_....
^ permalink raw reply [flat|nested] 16+ messages in thread
end of thread, other threads:[~2013-01-27 23:02 UTC | newest]
Thread overview: 16+ messages (download: mbox.gz / follow: Atom feed)
-- links below jump to the message on this page --
2012-12-22 15:28 [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ] Maciej Rutecki
2012-12-23 21:34 ` Christian Kujau
2012-12-23 21:34 ` Christian Kujau
2012-12-26 8:18 ` Li Zhong
2012-12-26 8:18 ` Li Zhong
2013-01-04 4:31 ` Christian Kujau
2013-01-04 4:31 ` Christian Kujau
2013-01-27 23:02 ` Christian Kujau
2012-12-26 2:34 ` Shawn Guo
2012-12-26 2:34 ` Shawn Guo
2012-12-27 8:36 ` Shawn Guo
2012-12-27 8:36 ` Shawn Guo
2012-12-27 13:03 ` Peter Hurley
2012-12-27 13:03 ` Peter Hurley
2012-12-28 11:45 ` Shawn Guo
2012-12-28 11:45 ` Shawn Guo
This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.