From mboxrd@z Thu Jan 1 00:00:00 1970 From: Andrew Morton Subject: Re: [Bugme-new] [Bug 10326] New: inconsistent lock state in net_rx_action Date: Tue, 25 Mar 2008 13:43:20 -0700 Message-ID: <20080325134320.21525479.akpm@linux-foundation.org> References: Mime-Version: 1.0 Content-Type: text/plain; charset=US-ASCII Content-Transfer-Encoding: 7bit Cc: bugme-daemon@bugzilla.kernel.org, marcus@better.se, Stephen Hemminger , "Rafael J. Wysocki" To: netdev@vger.kernel.org Return-path: Received: from smtp1.linux-foundation.org ([140.211.169.13]:45877 "EHLO smtp1.linux-foundation.org" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1752277AbYCYUn7 (ORCPT ); Tue, 25 Mar 2008 16:43:59 -0400 In-Reply-To: Sender: netdev-owner@vger.kernel.org List-ID: (switched to email. Please respond via emailed reply-to-all, not via the bugzilla web interface). On Tue, 25 Mar 2008 13:21:23 -0700 (PDT) bugme-daemon@bugzilla.kernel.org wrote: > http://bugzilla.kernel.org/show_bug.cgi?id=10326 > > Summary: inconsistent lock state in net_rx_action > Product: Networking > Version: 2.5 > KernelVersion: 2.6.25-rc6 (git > a4083c9271e0a697278e089f2c0b9a95363ada0a) > Platform: All > OS/Version: Linux > Tree: Mainline > Status: NEW > Severity: normal > Priority: P1 > Component: Other > AssignedTo: acme@ghostprotocols.net > ReportedBy: marcus@better.se > > > Latest working kernel version: 2.6.24 > Earliest failing kernel version: 2.6.25-rc6 (git > a4083c9271e0a697278e089f2c0b9a95363ada0a) A post-2.624 regression. > Distribution: Debian testing/unstable > Hardware Environment: LG LE50 Express laptop, i386 > Software Environment: Debian i386, X.org 7.3, KDE 4 > > Problem Description: > > Got this during bootup, somewhere before launching X. It only happened once, I > have rebooted a few times and didn't reproduce it. > > Mar 25 19:48:46 better kernel: ================================= > Mar 25 19:48:46 better kernel: [ INFO: inconsistent lock state ] > Mar 25 19:48:46 better kernel: 2.6.25-rc6-lg #4 > Mar 25 19:48:46 better kernel: --------------------------------- > Mar 25 19:48:46 better kernel: inconsistent {in-softirq-W} -> {softirq-on-W} > usage. > Mar 25 19:48:46 better kernel: syslogd/2773 [HC0[0]:SC0[0]:HE1:SE1] takes: > Mar 25 19:48:46 better kernel: (&napi->poll_lock){-+..}, at: [] > netpoll_poll+0xbc/0x390 > Mar 25 19:48:46 better kernel: {in-softirq-W} state was registered at: > Mar 25 19:48:46 better kernel: [] __lock_acquire+0x36a/0x1070 > Mar 25 19:48:46 better kernel: [] __lock_acquire+0x18f/0x1070 > Mar 25 19:48:46 better kernel: [] lock_acquire+0x5f/0x80 > Mar 25 19:48:46 better kernel: [] net_rx_action+0xbc/0x1d0 > Mar 25 19:48:46 better kernel: [] _spin_lock+0x34/0x40 > Mar 25 19:48:46 better kernel: [] net_rx_action+0xbc/0x1d0 > Mar 25 19:48:46 better kernel: [] net_rx_action+0xbc/0x1d0 > Mar 25 19:48:46 better kernel: [] net_rx_action+0x60/0x1d0 > Mar 25 19:48:46 better kernel: [] __do_softirq+0x62/0xc0 > Mar 25 19:48:46 better kernel: [] do_softirq+0x45/0x50 > Mar 25 19:48:46 better kernel: [] irq_exit+0x77/0x80 > Mar 25 19:48:46 better kernel: [] > smp_apic_timer_interrupt+0x45/0x80 > Mar 25 19:48:46 better kernel: [] apic_timer_interrupt+0x29/0x38 > Mar 25 19:48:46 better kernel: [] apic_timer_interrupt+0x33/0x38 > Mar 25 19:48:46 better kernel: [] __set_personality+0x2b/0x240 > Mar 25 19:48:46 better kernel: [] release_console_sem+0x191/0x1e0 > Mar 25 19:48:46 better kernel: [] init_netconsole+0x1da/0x1f0 > Mar 25 19:48:46 better kernel: [] kernel_init+0x90/0x270 > Mar 25 19:48:46 better kernel: [] restore_nocheck+0x12/0x15 > Mar 25 19:48:46 better kernel: [] trace_hardirqs_on+0x9c/0x110 > Mar 25 19:48:46 better kernel: [] kernel_init+0x0/0x270 > Mar 25 19:48:46 better kernel: [] kernel_init+0x0/0x270 > Mar 25 19:48:46 better kernel: [] kernel_thread_helper+0x7/0x14 > Mar 25 19:48:46 better kernel: [] 0xffffffff > Mar 25 19:48:46 better kernel: irq event stamp: 174638 > Mar 25 19:48:46 better kernel: hardirqs last enabled at (174637): [] > restore_nocheck+0x12/0x15 > Mar 25 19:48:46 better kernel: hardirqs last disabled at (174638): [] > _spin_lock_irqsave+0x15/0x60 > Mar 25 19:48:46 better kernel: softirqs last enabled at (174636): [] > do_softirq+0x45/0x50 > Mar 25 19:48:46 better kernel: softirqs last disabled at (174629): [] > do_softirq+0x45/0x50 > Mar 25 19:48:46 better kernel: > Mar 25 19:48:46 better kernel: other info that might help us debug this: > Mar 25 19:48:46 better kernel: 3 locks held by syslogd/2773: > Mar 25 19:48:46 better kernel: #0: (&tty->atomic_write_lock){--..}, at: > [] tty_write_lock+0x19/0x50 > Mar 25 19:48:46 better kernel: #1: (target_list_lock){--..}, at: [] > write_msg+0x2d/0xd0 > Mar 25 19:48:46 better kernel: #2: (&napi->poll_lock){-+..}, at: [] > netpoll_poll+0xbc/0x390 > Mar 25 19:48:46 better kernel: > Mar 25 19:48:46 better kernel: stack backtrace: > Mar 25 19:48:46 better kernel: Pid: 2773, comm: syslogd Not tainted > 2.6.25-rc6-lg #4 > Mar 25 19:48:46 better kernel: [] print_usage_bug+0x15f/0x170 > Mar 25 19:48:46 better kernel: [] mark_lock+0x401/0x590 > Mar 25 19:48:46 better kernel: [] mark_held_locks+0x38/0x70 > Mar 25 19:48:46 better kernel: [] sky2_poll+0x7a3/0xad0 > Mar 25 19:48:46 better kernel: [] trace_hardirqs_on+0x9c/0x110 > Mar 25 19:48:46 better kernel: [] sky2_poll+0x7a3/0xad0 > Mar 25 19:48:46 better kernel: [] netpoll_poll+0xbc/0x390 > Mar 25 19:48:46 better kernel: [] _spin_trylock+0x42/0x80 > Mar 25 19:48:46 better kernel: [] netpoll_poll+0x73/0x390 > Mar 25 19:48:46 better kernel: [] netpoll_send_skb+0x12f/0x1d0 > Mar 25 19:48:46 better kernel: [] write_msg+0x9c/0xd0 > Mar 25 19:48:46 better kernel: [] __call_console_drivers+0x54/0x70 > Mar 25 19:48:46 better kernel: [] release_console_sem+0xd0/0x1e0 > Mar 25 19:48:46 better kernel: [] do_con_write+0x189/0x1a80 > Mar 25 19:48:46 better kernel: [] mark_held_locks+0x38/0x70 > Mar 25 19:48:46 better kernel: [] _spin_unlock_irqrestore+0x4c/0x60 > Mar 25 19:48:46 better kernel: [] trace_hardirqs_on+0x9c/0x110 > Mar 25 19:48:46 better kernel: [] _spin_unlock_irqrestore+0x37/0x60 > Mar 25 19:48:46 better kernel: [] con_put_char+0x27/0x30 > Mar 25 19:48:46 better kernel: [] opost+0xad/0x220 > Mar 25 19:48:46 better kernel: [] write_chan+0x1ab/0x350 > Mar 25 19:48:46 better kernel: [] default_wake_function+0x0/0x10 > Mar 25 19:48:46 better kernel: [] tty_write+0x13b/0x1d0 > Mar 25 19:48:47 better kernel: [] write_chan+0x0/0x350 > Mar 25 19:48:47 better kernel: [] do_loop_readv_writev+0x33/0x60 > Mar 25 19:48:47 better kernel: [] do_readv_writev+0x170/0x180 > Mar 25 19:48:47 better kernel: [] tty_write+0x0/0x1d0 > Mar 25 19:48:47 better kernel: [] vfs_writev+0x3c/0x50 > Mar 25 19:48:47 better kernel: [] sys_writev+0x41/0x70 > Mar 25 19:48:47 better kernel: [] sysenter_past_esp+0x5f/0xa5 > Mar 25 19:48:47 better kernel: ======================= >