Return-Path: linux-nfs-owner@vger.kernel.org Received: from bombadil.infradead.org ([198.137.202.9]:35719 "EHLO bombadil.infradead.org" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S933186AbaJVNIO (ORCPT ); Wed, 22 Oct 2014 09:08:14 -0400 Date: Wed, 22 Oct 2014 06:08:14 -0700 From: Christoph Hellwig To: Trond Myklebust Cc: linux-nfs@vger.kernel.org Subject: Re: xfstests generic/075 failure on recent Linus' tree Message-ID: <20141022130814.GA26501@infradead.org> References: <20141020173658.GA7552@infradead.org> <20141022114649.GA2567@infradead.org> MIME-Version: 1.0 Content-Type: text/plain; charset=us-ascii In-Reply-To: Sender: linux-nfs-owner@vger.kernel.org List-ID: On Wed, Oct 22, 2014 at 03:00:27PM +0300, Trond Myklebust wrote: > Does the NFS client show a TCP connection to port 2049 on 127.0.0.1? >From netstat -a tcp 0 262352 localhost:nfs localhost:684 ESTABLISHED tcp 0 0 localhost:684 localhost:nfs ESTABLISHED Note that about 1/4 to 1/3 of the hangs show a backtrace like: [ 480.293522] INFO: task fsx:14631 blocked for more than 120 seconds. [ 480.296181] Not tainted 3.18.0-rc1+ #1519 [ 480.299073] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 480.304028] fsx D ffffffff81dcbd90 0 14631 14430 0x00000004 [ 480.307132] ffff88007a457b08 0000000000000046 ffff880072db0b50 0000000000013dc0 [ 480.310401] ffff88007a457fd8 0000000000013dc0 ffff88007d524310 ffff880072db0b50 [ 480.312772] 0000000000000000 0000000000000002 0000000000000001 0000000000000001 [ 480.315200] Call Trace: [ 480.315946] [] ? bit_wait_timeout+0x60/0x60 [ 480.317358] [] ? mark_held_locks+0x6a/0x90 [ 480.318818] [] ? ktime_get+0x105/0x140 [ 480.320167] [] ? kvm_clock_read+0x1f/0x30 [ 480.321537] [] ? kvm_clock_get_cycles+0x9/0x10 [ 480.322871] [] ? ktime_get+0xa5/0x140 [ 480.324360] [] ? __delayacct_blkio_start+0x1e/0x30 [ 480.325829] [] ? bit_wait_timeout+0x60/0x60 [ 480.327252] [] schedule+0x24/0x70 [ 480.328471] [] io_schedule+0x8a/0xd0 [ 480.329683] [] bit_wait_io+0x26/0x40 [ 480.330902] [] __wait_on_bit_lock+0x6e/0xb0 [ 480.332189] [] ? find_get_entries+0x22/0x160 [ 480.336273] [] ? find_get_entry+0x8c/0xc0 [ 480.337719] [] ? find_get_pages_contig+0x1a0/0x1a0 [ 480.339280] [] __lock_page+0x95/0xa0 [ 480.340518] [] ? wake_atomic_t_function+0x30/0x30 [ 480.342066] [] truncate_inode_pages_range+0x3c6/0x710 [ 480.343853] [] truncate_inode_pages+0x10/0x20 [ 480.345306] [] truncate_pagecache+0x46/0x70 [ 480.346481] [] nfs_setattr_update_inode+0x9e/0x120 [ 480.348372] [] nfs4_proc_setattr+0xb8/0x100 [ 480.349751] [] nfs_setattr+0xd6/0x1d0 [ 480.350741] [] notify_change+0x160/0x3c0 [ 480.351748] [] ? fsnotify+0x7b/0x310 [ 480.353260] [] do_truncate+0x61/0xa0 [ 480.354829] [] do_sys_ftruncate.constprop.16+0x104/0x160 [ 480.356754] [] ? trace_hardirqs_on_thunk+0x3a/0x3f [ 480.358561] [] SyS_ftruncate+0x9/0x10 [ 480.360054] [] system_call_fastpath+0x12/0x17 [ 480.361744] 2 locks held by fsx/14631: [ 480.362844] #0: (sb_writers#9){.+.+.+}, at: [] do_sys_ftruncate.constprop.16+0xcf/0x160 [ 480.366248] #1: (&sb->s_type->i_mutex_key#11){+.+.+.}, at: [] do_truncate+0x53/0xa0