From mboxrd@z Thu Jan 1 00:00:00 1970 From: Wei Yongjun Subject: [BUG]? xfrm: INFO: inconsistent lock state Date: Mon, 01 Feb 2010 18:01:20 +0800 Message-ID: <4B66A670.70503@cn.fujitsu.com> Mime-Version: 1.0 Content-Type: text/plain; charset=GB2312 Content-Transfer-Encoding: 7bit Cc: Herbert Xu To: "netdev@vger.kernel.org" Return-path: Received: from cn.fujitsu.com ([222.73.24.84]:57415 "EHLO song.cn.fujitsu.com" rhost-flags-OK-FAIL-OK-OK) by vger.kernel.org with ESMTP id S1751764Ab0BAJ7v (ORCPT ); Mon, 1 Feb 2010 04:59:51 -0500 Sender: netdev-owner@vger.kernel.org List-ID: I got following lock INFO in my Fedora12 box uner 2.6.33-rc6. Is this a BUG? ================================= [ INFO: inconsistent lock state ] 2.6.33-rc6 #120 --------------------------------- inconsistent {IN-HARDIRQ-W} -> {HARDIRQ-ON-W} usage. swapper/0 [HC0[0]:SC1[1]:HE1:SE0] takes: (&(&x->lock)->rlock){?.-...}, at: [] xfrm_input+0xdf/0x5c0 {IN-HARDIRQ-W} state was registered at: [] __lock_acquire+0xa9c/0x1890 [] lock_acquire+0x7f/0xf0 [] _raw_spin_lock+0x38/0x50 [] xfrm_timer_handler+0x3a/0x260 [] __hrtimer_tasklet_trampoline+0xd/0x10 [] hrtimer_run_queues+0x15e/0x2a0 [] run_local_timers+0xd/0x20 [] update_process_times+0x34/0x70 [] tick_periodic+0x2a/0x80 [] tick_handle_periodic+0x1e/0x90 [] smp_apic_timer_interrupt+0x57/0x8b [] apic_timer_interrupt+0x2f/0x34 [] cpu_idle+0x4b/0x80 [] rest_init+0x67/0x70 [] start_kernel+0x30e/0x314 [] i386_start_kernel+0x9e/0xa5 irq event stamp: 1113374 hardirqs last enabled at (1113374): [] local_bh_enable_ip+0x68/0xd0 hardirqs last disabled at (1113373): [] local_bh_enable_ip+0x28/0xd0 softirqs last enabled at (1113338): [] __do_softirq+0x100/0x1c0 softirqs last disabled at (1113343): [] do_softirq+0x97/0xe0 other info that might help us debug this: 3 locks held by swapper/0: #0: (rcu_read_lock){.+.+..}, at: [] net_rx_action+0xd6/0x230 #1: (rcu_read_lock){.+.+..}, at: [] netif_receive_skb+0x138/0x570 #2: (rcu_read_lock){.+.+..}, at: [] ip6_input_finish+0x0/0x390 [ipv6] stack backtrace: Pid: 0, comm: swapper Not tainted 2.6.33-rc6 #120 Call Trace: [] ? printk+0x1d/0x21 [] print_usage_bug+0x15f/0x1a0 [] mark_lock+0x3ba/0x5c0 [] ? mark_held_locks+0x62/0x90 [] ? check_usage_backwards+0x0/0xd0 [] __lock_acquire+0x9af/0x1890 [] ? trace_hardirqs_on_thunk+0xc/0x10 [] ? restore_all_notrace+0x0/0x18 [] ? mark_held_locks+0x62/0x90 [] lock_acquire+0x7f/0xf0 [] ? xfrm_input+0xdf/0x5c0 [] _raw_spin_lock+0x38/0x50 [] ? xfrm_input+0xdf/0x5c0 [] xfrm_input+0xdf/0x5c0 [] xfrm6_rcv_spi+0x29/0x30 [ipv6] [] xfrm6_rcv+0x1c/0x20 [ipv6] [] ip6_input_finish+0x141/0x390 [ipv6] [] ? ip6_input_finish+0x0/0x390 [ipv6] [] ip6_input+0x5f/0x70 [ipv6] [] ipv6_rcv+0x338/0x440 [ipv6] [] ? ipv6_rcv+0x2e/0x440 [ipv6] [] netif_receive_skb+0x34f/0x570 [] ? netif_receive_skb+0x138/0x570 [] ? __alloc_skb+0x4e/0x130 [] ? nommu_sync_single_for_device+0x0/0x10 [] pcnet32_poll+0x27e/0x7a0 [pcnet32] [] ? run_timer_softirq+0x37/0x2c0 [] ? _raw_spin_unlock_irq+0x27/0x30 [] net_rx_action+0x150/0x230 [] ? net_rx_action+0xd6/0x230 [] ? __do_softirq+0x58/0x1c0 [] __do_softirq+0xa0/0x1c0 [] ? __do_softirq+0x0/0x1c0 [] ? irq_exit+0x45/0x50 [] ? smp_apic_timer_interrupt+0x5c/0x8b [] ? trace_hardirqs_off_thunk+0xc/0x10 [] ? apic_timer_interrupt+0x2f/0x34 [] ? default_idle+0x43/0xa0 [] ? cpu_idle+0x4b/0x80 [] ? rest_init+0x67/0x70 [] ? start_kernel+0x30e/0x314 [] ? unknown_bootoption+0x0/0x1a0 [] ? i386_start_kernel+0x9e/0xa5