From mboxrd@z Thu Jan 1 00:00:00 1970 From: Dave Jones Subject: lockdep report from bonding. Date: Wed, 3 Oct 2007 13:05:14 -0400 Message-ID: <20071003170514.GA32239@redhat.com> Mime-Version: 1.0 Content-Type: text/plain; charset=us-ascii To: netdev@vger.kernel.org Return-path: Received: from mx1.redhat.com ([66.187.233.31]:43240 "EHLO mx1.redhat.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1752325AbXJCRFa (ORCPT ); Wed, 3 Oct 2007 13:05:30 -0400 Received: from int-mx1.corp.redhat.com (int-mx1.corp.redhat.com [172.16.52.254]) by mx1.redhat.com (8.13.8/8.13.1) with ESMTP id l93H5TWm006587 for ; Wed, 3 Oct 2007 13:05:29 -0400 Received: from gelk.kernelslacker.org (vpn-14-3.rdu.redhat.com [10.11.14.3]) by int-mx1.corp.redhat.com (8.13.1/8.13.1) with ESMTP id l93H5Rb4017868 for ; Wed, 3 Oct 2007 13:05:29 -0400 Received: from gelk.kernelslacker.org (localhost.localdomain [127.0.0.1]) by gelk.kernelslacker.org (8.14.1/8.13.8) with ESMTP id l93H5KVb004781 for ; Wed, 3 Oct 2007 13:05:20 -0400 Received: (from davej@localhost) by gelk.kernelslacker.org (8.14.1/8.14.1/Submit) id l93H5Eno004779 for netdev@vger.kernel.org; Wed, 3 Oct 2007 13:05:14 -0400 Content-Disposition: inline Sender: netdev-owner@vger.kernel.org List-Id: netdev.vger.kernel.org Reported by a Fedora user this morning. Ethernet Channel Bonding Driver: v3.1.3 (June 13, 2007) bonding: MII link monitoring set to 100 ms ADDRCONF(NETDEV_UP): bond0: link is not ready bonding: bond0: Adding slave eth0. e100: eth0: e100_watchdog: link up, 100Mbps, full-duplex bonding: bond0: making interface eth0 the new active one. bonding: bond0: enslaving eth0 as an active interface with an up link. ================================= [ INFO: inconsistent lock state ] 2.6.23-0.214.rc8.git2.fc8 #1 --------------------------------- inconsistent {softirq-on-W} -> {in-softirq-W} usage. events/1/10 [HC0[0]:SC1[1]:HE1:SE0] takes: (&(bond_info->tx_hashtbl_lock)){-+..}, at: [] tlb_clear_slave+0x1d/0x9a [bonding] {softirq-on-W} state was registered at: [] __lock_acquire+0x4ff/0xc67 [] lock_acquire+0x7b/0x9e [] _spin_lock+0x2e/0x58 [] bond_alb_initialize+0x64/0x18e [bonding] [] bond_open+0x33/0x178 [bonding] [] dev_open+0x31/0x6c [] dev_change_flags+0xa3/0x156 [] devinet_ioctl+0x207/0x50e [] inet_ioctl+0x86/0xa4 [] sock_ioctl+0x1ac/0x1c9 [] do_ioctl+0x22/0x68 [] vfs_ioctl+0x249/0x25c [] sys_ioctl+0x49/0x64 [] syscall_call+0x7/0xb [] 0xffffffff irq event stamp: 40878 hardirqs last enabled at (40878): [] _spin_unlock_irq+0x22/0x2f hardirqs last disabled at (40877): [] _spin_lock_irq+0x19/0x67 softirqs last enabled at (40872): [] rt_run_flush+0x6e/0x97 softirqs last disabled at (40873): [] do_softirq+0x74/0xf7 other info that might help us debug this: 3 locks held by events/1/10: #0: (rtnl_mutex){--..}, at: [] mutex_lock+0x21/0x24 #1: (&bond->lock){-.-+}, at: [] bond_alb_monitor+0x16/0x26e [bonding] #2: (&bond->curr_slave_lock){..-+}, at: [] bond_alb_monitor+0xa9/0x26e [bonding] stack backtrace: [] show_trace_log_lvl+0x1a/0x2f [] show_trace+0x12/0x14 [] dump_stack+0x16/0x18 [] print_usage_bug+0x141/0x14b [] mark_lock+0x12f/0x472 [] __lock_acquire+0x487/0xc67 [] lock_acquire+0x7b/0x9e [] _spin_lock+0x2e/0x58 [] tlb_clear_slave+0x1d/0x9a [bonding] [] bond_alb_monitor+0xc3/0x26e [bonding] [] run_timer_softirq+0x127/0x18f [] __do_softirq+0x78/0xff [] do_softirq+0x74/0xf7 ======================= ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready bonding: bond0: Adding slave eth1. -- http://www.codemonkey.org.uk