From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: Received: from e28smtp04.in.ibm.com (e28smtp04.in.ibm.com [122.248.162.4]) (using TLSv1 with cipher DHE-RSA-AES256-SHA (256/256 bits)) (Client CN "e28smtp04.in.ibm.com", Issuer "GeoTrust SSL CA" (not verified)) by ozlabs.org (Postfix) with ESMTPS id 75C592C00B0 for ; Wed, 26 Dec 2012 19:18:58 +1100 (EST) Received: from /spool/local by e28smtp04.in.ibm.com with IBM ESMTP SMTP Gateway: Authorized Use Only! Violators will be prosecuted for from ; Wed, 26 Dec 2012 13:48:03 +0530 Received: from d28relay05.in.ibm.com (d28relay05.in.ibm.com [9.184.220.62]) by d28dlp02.in.ibm.com (Postfix) with ESMTP id 512AC394004D for ; Wed, 26 Dec 2012 13:48:47 +0530 (IST) Received: from d28av02.in.ibm.com (d28av02.in.ibm.com [9.184.220.64]) by d28relay05.in.ibm.com (8.13.8/8.13.8/NCO v10.0) with ESMTP id qBQ8IjKr41549996 for ; Wed, 26 Dec 2012 13:48:46 +0530 Received: from d28av02.in.ibm.com (loopback [127.0.0.1]) by d28av02.in.ibm.com (8.14.4/8.13.1/NCO v10.0 AVout) with ESMTP id qBQ8Ikvp025636 for ; Wed, 26 Dec 2012 19:18:46 +1100 Message-ID: <1356509923.2710.11.camel@ThinkPad-T5421.cn.ibm.com> Subject: Re: [REGRESSION][3.8.-rc1][ INFO: possible circular locking dependency detected ] From: Li Zhong To: Christian Kujau Date: Wed, 26 Dec 2012 16:18:43 +0800 In-Reply-To: References: <201212221628.26640.maciej.rutecki@gmail.com> Content-Type: text/plain; charset="UTF-8" Mime-Version: 1.0 Cc: Cong Wang , linuxppc-dev@lists.ozlabs.org, LKML , Maciej Rutecki List-Id: Linux on PowerPC Developers Mail List List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , 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: [] __blocking_notifier_call_chain+0x44/0x88 > [ 97.803099] > [ 97.803099] but task is already holding lock: > [ 97.803110] (console_lock){+.+.+.}, at: [] 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: [] > > __blocking_notifier_call_chain+0x49/0x80 > > [ 269.784879] > > [ 269.784879] but task is already holding lock: > > [ 269.784884] (console_lock){+.+.+.}, at: [] > > 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] [] lock_acquire+0x95/0x105 > > [ 269.784893] [] console_lock+0x59/0x5b > > [ 269.784897] [] register_con_driver+0x36/0x128 > > [ 269.784899] [] take_over_console+0x1e/0x45 > > [ 269.784903] [] fbcon_takeover+0x56/0x98 > > [ 269.784906] [] fbcon_event_notify+0x2c1/0x5ea > > [ 269.784909] [] notifier_call_chain+0x67/0x92 > > [ 269.784911] [] __blocking_notifier_call_chain+0x5f/0x80 > > [ 269.784912] [] blocking_notifier_call_chain+0xf/0x11 > > [ 269.784915] [] fb_notifier_call_chain+0x16/0x18 > > [ 269.784917] [] register_framebuffer+0x20a/0x26e > > [ 269.784920] [] > > drm_fb_helper_single_fb_probe+0x1ce/0x297 > > [ 269.784922] [] drm_fb_helper_initial_config+0x1d7/0x1ef > > [ 269.784924] [] intel_fbdev_init+0x6f/0x82 > > [ 269.784927] [] i915_driver_load+0xa9e/0xc78 > > [ 269.784929] [] drm_get_pci_dev+0x165/0x26d > > [ 269.784931] [] i915_pci_probe+0x60/0x69 > > [ 269.784933] [] local_pci_probe+0x39/0x61 > > [ 269.784935] [] pci_device_probe+0xba/0xe0 > > [ 269.784938] [] driver_probe_device+0x99/0x1c4 > > [ 269.784940] [] __driver_attach+0x4e/0x6f > > [ 269.784942] [] bus_for_each_dev+0x52/0x84 > > [ 269.784944] [] driver_attach+0x19/0x1b > > [ 269.784946] [] bus_add_driver+0xdf/0x203 > > [ 269.784948] [] driver_register+0x8e/0x114 > > [ 269.784952] [] __pci_register_driver+0x5d/0x62 > > [ 269.784953] [] drm_pci_init+0x81/0xe6 > > [ 269.784957] [] i915_init+0x66/0x68 > > [ 269.784959] [] do_one_initcall+0x7a/0x136 > > [ 269.784962] [] kernel_init+0x141/0x296 > > [ 269.784964] [] ret_from_fork+0x7c/0xb0 > > [ 269.784966] > > [ 269.784966] -> #0 ((fb_notifier_list).rwsem){.+.+.+}: > > [ 269.784967] [] __lock_acquire+0xa7e/0xddd > > [ 269.784969] [] lock_acquire+0x95/0x105 > > [ 269.784971] [] down_read+0x34/0x43 > > [ 269.784973] [] __blocking_notifier_call_chain+0x49/0x80 > > [ 269.784975] [] blocking_notifier_call_chain+0xf/0x11 > > [ 269.784977] [] fb_notifier_call_chain+0x16/0x18 > > [ 269.784979] [] fb_set_suspend+0x22/0x4d > > [ 269.784981] [] intel_fbdev_set_suspend+0x20/0x22 > > [ 269.784983] [] i915_drm_freeze+0xab/0xbb > > [ 269.784985] [] i915_pm_freeze+0x3d/0x41 > > [ 269.784987] [] pci_pm_freeze+0x65/0x8d > > [ 269.784990] [] dpm_run_callback.isra.3+0x27/0x56 > > [ 269.784993] [] __device_suspend+0x136/0x1b1 > > [ 269.784995] [] async_suspend+0x1a/0x58 > > [ 269.784997] [] async_run_entry_fn+0xa4/0x17c > > [ 269.785000] [] process_one_work+0x1cf/0x38e > > [ 269.785002] [] worker_thread+0x12e/0x1cc > > [ 269.785004] [] kthread+0xac/0xb4 > > [ 269.785006] [] 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: [] > > process_one_work+0x154/0x38e > > [ 269.785021] #1: ((&entry->work)){+.+.+.}, at: [] > > process_one_work+0x154/0x38e > > [ 269.785024] #2: (&__lockdep_no_validate__){......}, at: [] > > device_lock+0xf/0x11 > > [ 269.785027] #3: (console_lock){+.+.+.}, at: [] > > 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] [] print_circular_bug+0x1f8/0x209 > > [ 269.785036] [] __lock_acquire+0xa7e/0xddd > > [ 269.785038] [] lock_acquire+0x95/0x105 > > [ 269.785040] [] ? __blocking_notifier_call_chain+0x49/0x80 > > [ 269.785042] [] down_read+0x34/0x43 > > [ 269.785044] [] ? __blocking_notifier_call_chain+0x49/0x80 > > [ 269.785046] [] __blocking_notifier_call_chain+0x49/0x80 > > [ 269.785047] [] blocking_notifier_call_chain+0xf/0x11 > > [ 269.785050] [] fb_notifier_call_chain+0x16/0x18 > > [ 269.785052] [] fb_set_suspend+0x22/0x4d > > [ 269.785054] [] intel_fbdev_set_suspend+0x20/0x22 > > [ 269.785055] [] i915_drm_freeze+0xab/0xbb > > [ 269.785057] [] i915_pm_freeze+0x3d/0x41 > > [ 269.785060] [] pci_pm_freeze+0x65/0x8d > > [ 269.785062] [] ? pci_pm_poweroff+0x9c/0x9c > > [ 269.785064] [] dpm_run_callback.isra.3+0x27/0x56 > > [ 269.785066] [] __device_suspend+0x136/0x1b1 > > [ 269.785068] [] ? trace_hardirqs_on_caller+0x117/0x173 > > [ 269.785070] [] async_suspend+0x1a/0x58 > > [ 269.785072] [] async_run_entry_fn+0xa4/0x17c > > [ 269.785074] [] process_one_work+0x1cf/0x38e > > [ 269.785076] [] ? process_one_work+0x154/0x38e > > [ 269.785078] [] ? async_schedule+0x12/0x12 > > [ 269.785080] [] ? spin_lock_irq+0x9/0xb > > [ 269.785082] [] worker_thread+0x12e/0x1cc > > [ 269.785084] [] ? rescuer_thread+0x187/0x187 > > [ 269.785085] [] kthread+0xac/0xb4 > > [ 269.785088] [] ? __kthread_parkme+0x60/0x60 > > [ 269.785090] [] ret_from_fork+0x7c/0xb0 > > [ 269.785091] [] ? __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/ > > >