From mboxrd@z Thu Jan 1 00:00:00 1970 From: Andrew Morton Subject: Re: [Bugme-new] [Bug 11736] New: atl1e: INFO: inconsistent lock state Date: Fri, 10 Oct 2008 14:23:42 -0700 Message-ID: <20081010142342.afe1cbb1.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, netdev@vger.kernel.org, nm127@freemail.hu To: atl1-devel@lists.sourceforge.net Return-path: Received: from smtp1.linux-foundation.org ([140.211.169.13]:34012 "EHLO smtp1.linux-foundation.org" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1759624AbYJJVYJ (ORCPT ); Fri, 10 Oct 2008 17:24:09 -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 Fri, 10 Oct 2008 14:14:12 -0700 (PDT) bugme-daemon@bugzilla.kernel.org wrote: > http://bugzilla.kernel.org/show_bug.cgi?id=11736 > > Summary: atl1e: INFO: inconsistent lock state > Product: Drivers > Version: 2.5 > KernelVersion: 2.6.27 > Platform: All > OS/Version: Linux > Tree: Mainline > Status: NEW > Severity: normal > Priority: P1 > Component: Network > AssignedTo: jgarzik@pobox.com > ReportedBy: nm127@freemail.hu > > > Latest working kernel version: > Earliest failing kernel version: > Distribution: Debian > Hardware Environment: eeePC 901 > Software Environment: > Problem Description: > At boot the following message appears in the dmesg: > > [ 10.926640] ATL1E 0000:04:00.0: PCI INT A -> Link[LNKB] -> GSI 5 (level, > low) -> IRQ 5 > [ 10.941823] ATL1E 0000:04:00.0: setting latency timer to 64 > [ 42.441150] > [ 42.441156] ================================= > [ 42.450029] [ INFO: inconsistent lock state ] > [ 42.450029] 2.6.27 #1 > [ 42.450029] --------------------------------- > [ 42.450029] inconsistent {hardirq-on-W} -> {in-hardirq-W} usage. > [ 42.450029] ifconfig/1315 [HC1[1]:SC0[0]:HE0:SE1] takes: > [ 42.450029] (&adapter->mdio_lock){+-..}, at: [] > atl1e_intr+0x2a9/0x440 [atl1e] > [ 42.450029] {hardirq-on-W} state was registered at: > [ 42.450029] [] mark_lock+0xf4/0x830 > [ 42.450029] [] __lock_acquire+0x2e9/0x1380 > [ 42.450029] [] pci_conf1_read+0xaf/0xf0 > [ 42.450029] [] debug_check_no_locks_freed+0x79/0x130 > [ 42.450029] [] trace_hardirqs_on_caller+0xa4/0xc0 > [ 42.450029] [] lock_acquire+0x5d/0x80 > [ 42.450029] [] atl1e_probe+0x48b/0x6d0 [atl1e] > [ 42.450029] [] _spin_lock+0x30/0x40 > [ 42.450029] [] atl1e_probe+0x48b/0x6d0 [atl1e] > [ 42.450029] [] atl1e_probe+0x48b/0x6d0 [atl1e] > [ 42.450029] [] pci_match_device+0xa8/0xc0 > [ 42.450029] [] pci_device_probe+0x56/0x80 > [ 42.450029] [] driver_probe_device+0x75/0x150 > [ 42.450029] [] trace_hardirqs_on_caller+0xa4/0xc0 > [ 42.450029] [] __driver_attach+0x72/0x80 > [ 42.450029] [] bus_for_each_dev+0x3c/0x60 > [ 42.450029] [] driver_attach+0x16/0x20 > [ 42.450029] [] __driver_attach+0x0/0x80 > [ 42.450029] [] bus_add_driver+0xb2/0x230 > [ 42.450029] [] pci_device_shutdown+0x0/0x20 > [ 42.450029] [] pci_device_remove+0x0/0x40 > [ 42.450029] [] driver_register+0x4d/0x120 > [ 42.450029] [] __spin_lock_init+0x32/0x70 > [ 42.450029] [] snd_mixer_oss_conv+0x0/0x50 [snd_mixer_oss] > [ 42.450029] [] __pci_register_driver+0x58/0xa0 > [ 42.450029] [] snd_mixer_oss_conv+0x0/0x50 [snd_mixer_oss] > [ 42.450029] [] do_one_initcall+0x32/0x160 > [ 42.450029] [] disable_irq+0x0/0x30 > [ 42.450029] [] __mutex_unlock_slowpath+0x95/0xe0 > [ 42.450029] [] sys_init_module+0x89/0x1b0 > [ 42.450029] [] trace_hardirqs_on_caller+0xa4/0xc0 > [ 42.450029] [] trace_hardirqs_on_thunk+0xc/0x10 > [ 42.450029] [] syscall_call+0x7/0xb > [ 42.450029] [] 0xffffffff > [ 42.450029] irq event stamp: 4564 > [ 42.450029] hardirqs last enabled at (4563): [] > kmem_cache_free+0x65/0x90 > [ 42.450029] hardirqs last disabled at (4564): [] > trace_hardirqs_off_thunk+0xc/0x18 > [ 42.450029] softirqs last enabled at (4532): [] > dev_change_flags+0x5c/0x1a0 > [ 42.450029] softirqs last disabled at (4530): [] > _spin_lock_bh+0xb/0x40 > [ 42.450029] > [ 42.450029] other info that might help us debug this: > [ 42.450029] 1 lock held by ifconfig/1315: > [ 42.450029] #0: (rtnl_mutex){--..}, at: [] > devinet_ioctl+0xf1/0x670 > [ 42.450029] > [ 42.450029] stack backtrace: > [ 42.450029] Pid: 1315, comm: ifconfig Not tainted 2.6.27 #1 > [ 42.450029] [] print_usage_bug+0x174/0x190 > [ 42.450029] [] mark_lock+0x755/0x830 > [ 42.450029] [] __lock_acquire+0xb15/0x1380 > [ 42.450029] [] __lock_acquire+0x44e/0x1380 > [ 42.450029] [] __lock_acquire+0x44e/0x1380 > [ 42.450029] [] lock_acquire+0x5d/0x80 > [ 42.450029] [] atl1e_intr+0x2a9/0x440 [atl1e] > [ 42.450029] [] _spin_lock+0x30/0x40 > [ 42.450029] [] atl1e_intr+0x2a9/0x440 [atl1e] > [ 42.450029] [] atl1e_intr+0x2a9/0x440 [atl1e] > [ 42.450029] [] _spin_lock_irqsave+0x46/0x60 > [ 42.450029] [] handle_IRQ_event+0x20/0x60 > [ 42.450029] [] handle_level_irq+0x6d/0xe0 > [ 42.450029] [] do_IRQ+0x53/0xa0 > [ 42.450029] [] common_interrupt+0x28/0x30 > [ 42.450029] [] atl1e_up+0x424/0x4a0 [atl1e] > [ 42.450029] [] atl1e_intr+0x0/0x440 [atl1e] > [ 42.450029] [] request_irq+0xa5/0xc0 > [ 42.450029] [] atl1e_open+0xdd/0x390 [atl1e] > [ 42.450029] [] dev_open+0x54/0xb0 > [ 42.450029] [] dev_change_flags+0x5c/0x1a0 > [ 42.450029] [] local_bh_enable_ip+0x6b/0xb0 > [ 42.450029] [] dev_change_flags+0x7e/0x1a0 > [ 42.450029] [] devinet_ioctl+0x50e/0x670 > [ 42.450029] [] sock_ioctl+0xcf/0x250 > [ 42.450029] [] sock_ioctl+0x0/0x250 > [ 42.450029] [] vfs_ioctl+0x1f/0x70 > [ 42.450029] [] do_page_fault+0xf3/0x680 > [ 42.450029] [] do_vfs_ioctl+0x5c/0x260 > [ 42.450029] [] sys_ioctl+0x3d/0x70 > [ 42.450029] [] syscall_call+0x7/0xb > [ 42.450029] ======================= > [ 42.916493] ATL1E 0000:04:00.0: ATL1E: eth0 NIC Link is Up<100 Mbps Full > Duplex> > > Steps to reproduce: boot the system >