From mboxrd@z Thu Jan 1 00:00:00 1970 From: Chuck Lever Subject: inconsistent lock state (xfs) Date: Fri, 10 Dec 2010 14:40:06 -0500 Message-ID: <814FDEDC-D26A-4EDB-843C-5C8EDE2A4C61@oracle.com> Mime-Version: 1.0 (Apple Message framework v1082) Content-Type: text/plain; charset=us-ascii Content-Transfer-Encoding: 8BIT To: linux-fsdevel@vger.kernel.org Return-path: Received: from rcsinet10.oracle.com ([148.87.113.121]:26506 "EHLO rcsinet10.oracle.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1756873Ab0LJTko convert rfc822-to-8bit (ORCPT ); Fri, 10 Dec 2010 14:40:44 -0500 Received: from rcsinet13.oracle.com (rcsinet13.oracle.com [148.87.113.125]) by rcsinet10.oracle.com (Switch-3.4.2/Switch-3.4.2) with ESMTP id oBAJehC8020574 (version=TLSv1/SSLv3 cipher=DHE-RSA-AES256-SHA bits=256 verify=OK) for ; Fri, 10 Dec 2010 19:40:44 GMT Received: from acsmt354.oracle.com (acsmt354.oracle.com [141.146.40.154]) by rcsinet13.oracle.com (Switch-3.4.2/Switch-3.4.1) with ESMTP id oBAJC8Ta011222 for ; Fri, 10 Dec 2010 19:40:40 GMT Sender: linux-fsdevel-owner@vger.kernel.org List-ID: Seen during a Linux kernel build (make -s -j3 all) on a two-processor VMware guest. Dec 10 14:28:40 matisse kernel: ================================= Dec 10 14:28:40 matisse kernel: [ INFO: inconsistent lock state ] Dec 10 14:28:40 matisse kernel: 2.6.37-rc5-00052-g7c30118 #2 Dec 10 14:28:40 matisse kernel: --------------------------------- Dec 10 14:28:40 matisse kernel: inconsistent {RECLAIM_FS-ON-W} -> {IN-RECLAIM_FS-W} usage. Dec 10 14:28:40 matisse kernel: kswapd0/26 [HC0[0]:SC0[0]:HE1:SE1] takes: Dec 10 14:28:40 matisse kernel: (&(&ip->i_iolock)->mr_lock#2){++++?+}, at: [] xfs_ilock+0x30/0xb9 [xfs] Dec 10 14:28:40 matisse kernel: {RECLAIM_FS-ON-W} state was registered at: Dec 10 14:28:40 matisse kernel: [] mark_held_locks+0x52/0x70 Dec 10 14:28:40 matisse kernel: [] lockdep_trace_alloc+0x99/0xbb Dec 10 14:28:40 matisse kernel: [] slab_pre_alloc_hook+0x1d/0x40 Dec 10 14:28:40 matisse kernel: [] kmem_cache_alloc+0x28/0x111 Dec 10 14:28:40 matisse kernel: [] kmem_zone_alloc+0x69/0xb1 [xfs] Dec 10 14:28:40 matisse kernel: [] kmem_zone_zalloc+0x14/0x35 [xfs] Dec 10 14:28:40 matisse kernel: [] _xfs_trans_alloc+0x27/0x64 [xfs] Dec 10 14:28:40 matisse kernel: [] xfs_trans_alloc+0x9f/0xac [xfs] Dec 10 14:28:40 matisse kernel: [] xfs_setattr+0x3a0/0x7e7 [xfs] Dec 10 14:28:40 matisse kernel: [] xfs_vn_setattr+0x1b/0x1f [xfs] Dec 10 14:28:40 matisse kernel: [] notify_change+0x1a2/0x29d Dec 10 14:28:40 matisse kernel: [] do_truncate+0x6c/0x89 Dec 10 14:28:40 matisse kernel: [] do_last+0x57e/0x583 Dec 10 14:28:40 matisse kernel: [] do_filp_open+0x215/0x5ae Dec 10 14:28:40 matisse kernel: [] do_sys_open+0x60/0xfd Dec 10 14:28:40 matisse kernel: [] sys_open+0x20/0x22 Dec 10 14:28:40 matisse kernel: [] system_call_fastpath+0x16/0x1b Dec 10 14:28:40 matisse kernel: irq event stamp: 2527153 Dec 10 14:28:40 matisse kernel: hardirqs last enabled at (2527153): [] __call_rcu+0x142/0x155 Dec 10 14:28:40 matisse kernel: hardirqs last disabled at (2527152): [] __call_rcu+0x3a/0x155 Dec 10 14:28:40 matisse kernel: softirqs last enabled at (2527144): [] __do_softirq+0x1c0/0x1e9 Dec 10 14:28:40 matisse kernel: softirqs last disabled at (2527085): [] call_softirq+0x1c/0x30 Dec 10 14:28:40 matisse kernel: Dec 10 14:28:40 matisse kernel: other info that might help us debug this: Dec 10 14:28:40 matisse kernel: 2 locks held by kswapd0/26: Dec 10 14:28:40 matisse kernel: #0: (shrinker_rwsem){++++..}, at: [] shrink_slab+0x3d/0x164 Dec 10 14:28:40 matisse kernel: #1: (&pag->pag_ici_reclaim_lock){+.+...}, at: [] xfs_reclaim_inodes_ag+0x65/0x28e [xfs] Dec 10 14:28:40 matisse kernel: Dec 10 14:28:40 matisse kernel: stack backtrace: Dec 10 14:28:40 matisse kernel: Pid: 26, comm: kswapd0 Not tainted 2.6.37-rc5-00052-g7c30118 #2 Dec 10 14:28:40 matisse kernel: Call Trace: Dec 10 14:28:40 matisse kernel: [] valid_state+0x17f/0x192 Dec 10 14:28:40 matisse kernel: [] ? save_stack_trace+0x2f/0x4c Dec 10 14:28:40 matisse kernel: [] ? check_usage_forwards+0x0/0x87 Dec 10 14:28:40 matisse kernel: [] mark_lock+0x11a/0x235 Dec 10 14:28:40 matisse kernel: [] __lock_acquire+0x37f/0xd0b Dec 10 14:28:40 matisse kernel: [] ? mark_held_locks+0x52/0x70 Dec 10 14:28:40 matisse kernel: [] ? trace_hardirqs_on+0xd/0xf Dec 10 14:28:40 matisse kernel: [] lock_acquire+0xe3/0x110 Dec 10 14:28:40 matisse kernel: [] ? xfs_ilock+0x30/0xb9 [xfs] Dec 10 14:28:40 matisse kernel: [] down_write_nested+0x4f/0x72 Dec 10 14:28:40 matisse kernel: [] ? xfs_ilock+0x30/0xb9 [xfs] Dec 10 14:28:40 matisse kernel: [] xfs_ilock+0x30/0xb9 [xfs] Dec 10 14:28:40 matisse kernel: [] xfs_reclaim_inode+0x1f5/0x241 [xfs] Dec 10 14:28:40 matisse kernel: [] xfs_reclaim_inodes_ag+0x1bc/0x28e [xfs] Dec 10 14:28:40 matisse kernel: [] xfs_reclaim_inode_shrink+0x3c/0x7d [xfs] Dec 10 14:28:40 matisse kernel: [] shrink_slab+0xe0/0x164 Dec 10 14:28:40 matisse kernel: [] balance_pgdat+0x2e8/0x521 Dec 10 14:28:40 matisse kernel: [] kswapd+0x2d7/0x316 Dec 10 14:28:40 matisse kernel: [] ? autoremove_wake_function+0x0/0x39 Dec 10 14:28:40 matisse kernel: [] ? kswapd+0x0/0x316 Dec 10 14:28:40 matisse kernel: [] kthread+0x9d/0xa5 Dec 10 14:28:40 matisse kernel: [] ? trace_hardirqs_on_caller+0x111/0x135 Dec 10 14:28:40 matisse kernel: [] kernel_thread_helper+0x4/0x10 Dec 10 14:28:40 matisse kernel: [] ? restore_args+0x0/0x30 Dec 10 14:28:40 matisse kernel: [] ? kthread+0x0/0xa5 Dec 10 14:28:40 matisse kernel: [] ? kernel_thread_helper+0x0/0x10 -- Chuck Lever chuck[dot]lever[at]oracle[dot]com